Post new topic   Reply to topic
View previous topic Printable version Log in to check your private messages View next topic
Author Message
alexkOffline
Post subject:   PostPosted: 28.10.2013, 01:25



Joined: 2010-10-01
Posts: 192

Status: Offline
Looking at outputs of "dmesg -dT" after a few boots, there's definitely a timestamp gap of around 30 seconds, here it's 27 s:
      Code:
[Sun Oct 27 16:28:24 2013 {    0.000000}] Initializing cgroup subsys cpuset
[Sun Oct 27 16:28:24 2013 {    0.000000}] Initializing cgroup subsys cpu
[Sun Oct 27 16:28:24 2013 {    0.000000}] Initializing cgroup subsys cpuacct
[Sun Oct 27 16:28:24 2013 {    0.000000}] Linux version 3.11-1.slh.3-aptosid-amd64 (Debian 3.11-7) (s.l-h@gmx.de) (gcc version 4.8.1 (Debian 4.8.1-10) ) #1 SMP PREEMPT Tue Sep 24 22:38:50 UTC 2013
[Sun Oct 27 16:28:24 2013 {    0.000000}] Command line: BOOT_IMAGE=/boot/vmlinuz-3.11-1.slh.3-aptosid-amd64 root=UUID=54d2e561-1007-44ae-9eee-6d54ce1ebd8f ro quiet
[Sun Oct 27 16:28:24 2013 {    0.000000}] e820: BIOS-provided physical RAM map:
...
[Sun Oct 27 16:28:29 2013 {    0.038143}] Bluetooth: Core ver 2.16
[Sun Oct 27 16:28:29 2013 {    0.000012}] NET: Registered protocol family 31
[Sun Oct 27 16:28:29 2013 {    0.000002}] Bluetooth: HCI device and connection manager initialized
[Sun Oct 27 16:28:29 2013 {    0.000014}] Bluetooth: HCI socket layer initialized
[Sun Oct 27 16:28:29 2013 {    0.000002}] Bluetooth: L2CAP socket layer initialized
[Sun Oct 27 16:28:29 2013 {    0.000005}] Bluetooth: SCO socket layer initialized
[Sun Oct 27 16:28:29 2013 {    0.029381}] usb 3-1.4: ath9k_htc: Transferred FW: htc_9271.fw, size: 51272
[Sun Oct 27 16:28:29 2013 {    0.011457}] usbcore: registered new interface driver btusb
[Sun Oct 27 16:28:29 2013 {    0.162736}] [drm] Enabling RC6 states: RC6 on, RC6p off, RC6pp off
[Sun Oct 27 16:28:29 2013 {    0.061513}] ath9k_htc 3-1.4:1.0: ath9k_htc: HTC initialized with 33 credits
[Sun Oct 27 16:28:30 2013 {    0.036745}] snd_hda_intel 0000:00:1b.0: irq 52 for MSI/MSI-X
[Sun Oct 27 16:28:30 2013 {    0.102335}] input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input5
[Sun Oct 27 16:28:30 2013 {    0.000057}] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input6
[Sun Oct 27 16:28:30 2013 {    0.000041}] input: HDA Intel PCH Line Out CLFE as /devices/pci0000:00/0000:00:1b.0/sound/card0/input7
[Sun Oct 27 16:28:30 2013 {    0.000053}] input: HDA Intel PCH Line Out Surround as /devices/pci0000:00/0000:00:1b.0/sound/card0/input8
[Sun Oct 27 16:28:30 2013 {    0.000039}] input: HDA Intel PCH Line Out Front as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9
[Sun Oct 27 16:28:30 2013 {    0.000036}] input: HDA Intel PCH Line as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10
[Sun Oct 27 16:28:30 2013 {    0.000035}] input: HDA Intel PCH Rear Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input11
[Sun Oct 27 16:28:30 2013 {    0.071652}] ath9k_htc 3-1.4:1.0: ath9k_htc: FW Version: 1.3
[Sun Oct 27 16:28:30 2013 {    0.000003}] ath: EEPROM regdomain: 0x809c
[Sun Oct 27 16:28:30 2013 {    0.000001}] ath: EEPROM indicates we should expect a country code
[Sun Oct 27 16:28:30 2013 {    0.000001}] ath: doing EEPROM country-}regdmn map search
[Sun Oct 27 16:28:30 2013 {    0.000000}] ath: country maps to regdmn code: 0x52
[Sun Oct 27 16:28:30 2013 {    0.000001}] ath: Country alpha2 being used: CN
[Sun Oct 27 16:28:30 2013 {    0.000001}] ath: Regpair used: 0x52
[Sun Oct 27 16:28:30 2013 {    0.075705}] ieee80211 phy0: Atheros AR9271 Rev:1
[Sun Oct 27 16:28:31 2013 {    1.125130}] cfg80211: World regulatory domain updated:
[Sun Oct 27 16:28:31 2013 {    0.000004}] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000011}] cfg80211: Calling CRDA for country: CN
[Sun Oct 27 16:28:31 2013 {    0.050785}] cfg80211: Regulatory domain changed to country: CN
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (N/A, 3000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (57240000 KHz - 59400000 KHz @ 2160000 KHz), (N/A, 2800 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (59400000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4400 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (63720000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 2800 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000010}] cfg80211: Calling CRDA for country: US
[Sun Oct 27 16:28:31 2013 {    0.004062}] cfg80211: Regulatory domain changed to country: US
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000003}] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
[Sun Oct 27 16:28:31 2013 {    0.000002}] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
[Sun Oct 27 16:28:58 2013 {   27.379141}] usblp 3-1.2:1.0: usblp0: USB Bidirectional printer dev 3 if 0 alt 0 proto 2 vid 0x03F0 pid 0xBA02
[Sun Oct 27 16:28:58 2013 {    0.000022}] usbcore: registered new interface driver usblp
[Sun Oct 27 16:28:59 2013 {    0.650108}] Adding 16844116k swap on /dev/sda5.  Priority:-1 extents:1 across:16844116k FS
[Sun Oct 27 16:29:00 2013 {    0.832785}] EXT3-fs (sda2): using internal journal
[Sun Oct 27 16:29:01 2013 {    0.723617}] fuse init (API version 7.22)
[Sun Oct 27 16:29:01 2013 {    0.028027}] w83627ehf: Found NCT6775F chip at 0x290
[Sun Oct 27 16:29:02 2013 {    1.278519}] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[Sun Oct 27 16:29:02 2013 {    0.027671}] kjournald starting.  Commit interval 5 seconds
[Sun Oct 27 16:29:02 2013 {    0.000271}] EXT3-fs (sda3): using internal journal
[Sun Oct 27 16:29:02 2013 {    0.000005}] EXT3-fs (sda3): mounted filesystem with writeback data mode
[Sun Oct 27 16:29:03 2013 {    0.902049}] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[Sun Oct 27 16:29:03 2013 {    0.011676}] NET: Registered protocol family 17
[Sun Oct 27 16:29:04 2013 {    0.902154}] wlan0: authenticate with b0:b2:dc:5e:92:4c
[Sun Oct 27 16:29:04 2013 {    0.140106}] wlan0: send auth to b0:b2:dc:5e:92:4c (try 1/3)
[Sun Oct 27 16:29:04 2013 {    0.001778}] wlan0: b0:b2:dc:5e:92:4c denied authentication (status 13)
[Sun Oct 27 16:29:04 2013 {    0.013233}] wlan0: authenticate with b0:b2:dc:5e:92:4c
[Sun Oct 27 16:29:04 2013 {    0.047612}] wlan0: send auth to b0:b2:dc:5e:92:4c (try 1/3)
[Sun Oct 27 16:29:04 2013 {    0.005655}] wlan0: authenticated
[Sun Oct 27 16:29:04 2013 {    0.000136}] ath9k_htc 3-1.4:1.0 wlan0: disabling HT/VHT due to WEP/TKIP use
[Sun Oct 27 16:29:04 2013 {    0.000877}] wlan0: associate with b0:b2:dc:5e:92:4c (try 1/3)
[Sun Oct 27 16:29:04 2013 {    0.002493}] wlan0: RX AssocResp from b0:b2:dc:5e:92:4c (capab=0x411 status=0 aid=2)
[Sun Oct 27 16:29:04 2013 {    0.003476}] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[Sun Oct 27 16:29:04 2013 {    0.000045}] wlan0: associated
[Sun Oct 27 16:29:04 2013 {    0.000024}] cfg80211: Calling CRDA for country: US
[Sun Oct 27 16:29:04 2013 {    0.004278}] cfg80211: Regulatory domain changed to country: US
[Sun Oct 27 16:29:04 2013 {    0.000004}] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[Sun Oct 27 16:29:04 2013 {    0.000003}] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm)
[Sun Oct 27 16:29:04 2013 {    0.000002}] cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm)
[Sun Oct 27 16:29:04 2013 {    0.000002}] cfg80211:   (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:29:04 2013 {    0.000003}] cfg80211:   (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:29:04 2013 {    0.000002}] cfg80211:   (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[Sun Oct 27 16:29:04 2013 {    0.000002}] cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm)
[Sun Oct 27 16:29:04 2013 {    0.000002}] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm)
[Sun Oct 27 16:29:22 2013 {   17.962926}] Bluetooth: RFCOMM TTY layer initialized
[Sun Oct 27 16:29:22 2013 {    0.000013}] Bluetooth: RFCOMM socket layer initialized
[Sun Oct 27 16:29:22 2013 {    0.000002}] Bluetooth: RFCOMM ver 1.11
[Sun Oct 27 16:29:22 2013 {    0.226962}] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[Sun Oct 27 16:29:22 2013 {    0.000004}] Bluetooth: BNEP filters: protocol multicast
[Sun Oct 27 16:29:22 2013 {    0.000007}] Bluetooth: BNEP socket layer initialized
[Sun Oct 27 16:29:23 2013 {    0.436099}] lp: driver loaded but no devices found
[Sun Oct 27 16:29:23 2013 {    0.410809}] ppdev: user-space parallel port driver
[Sun Oct 27 16:29:35 2013 {   11.571209}] ip_tables: (C) 2000-2006 Netfilter Core Team
[Sun Oct 27 16:29:35 2013 {    0.056395}] ip6_tables: (C) 2000-2006 Netfilter Core Team
[Sun Oct 27 16:29:45 2013 {   10.103113}] Bridge firewalling registered
[Sun Oct 27 16:29:46 2013 {    0.883945}] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[Sun Oct 27 16:29:46 2013 {    0.438781}] IPv6: ADDRCONF(NETDEV_UP): virbr0: link is not ready

I replaced the arrow brackets in the output with {} because I don't know how to escape them.

What's more annoying than the boot delay, is that this issue is somehow interfering with USB bluetooth initialization, so that the USB bluetooth dongle is no longer making an automatic connection to an external bluetooth device upon boot. I've had this bluetooth issue since I first reported this black screen issue and it went away every time that I went back to the 3.13.4-1+b1 version of hplip (which I can't easily do any more because it's no longer in the standard repositories).

I currently have gone back to kernel 3.11-1.slh.3-aptosid-amd64 because of a separate issue with a bluetooth error filling up my logs and using up all the space on the partition, that I'll report about in another thread.
 
 View user's profile Send private message Yahoo Messenger  
Reply with quote Back to top
vinurOffline
Post subject:   PostPosted: 28.10.2013, 19:32



Joined: 2010-09-11
Posts: 61
Location: Lake Oswego
Status: Offline
Hello slh and alexk,
just as a note, I have been doing some upgrades and I put hplip in and purged it a few times a while back... this was before and after a full DU several times and different days and any hangs always returned when it was "in"... independent of kernel version.
until I settled it permanently a week ago.
It is the hplip, I am certain of it.
My cure as it were, was to buy an epson printer Smile
info bash of a minute ago reads:
Host/Kernel/OS "Eyland0" running Linux 3.11-4.slh.2-aptosid-amd64 x86_64 [ aptosid 2013-01 Ἑσπερίδες - kde-lite - (201305050307) ]
CPU Info 8x AMD FX-8120 Eight-Core 2048 KB cache flags( sse3 ht nx lm svm ) clocked at [ 1400.000 MHz ]
Videocard NVIDIA G86 [GeForce 8500 GT] X.Org 1.14.3 [ 1920x1080@60.0hz ]
Network cards D-Link System Inc DGE-560T PCI Express Gigabit
Processes 195 | Uptime 5:17 | Memory 841.4/7973.6MB | HDD ST3500418AS,WDC WD6000HLHX-0,AS2105 Size 1484GB (3%used) | GLX Renderer Gallium 0.4 on NV86 | GLX Version Yes | Client Shell | Infobash v3.46
michael@Eyland0:~$
Since the installation of the drivers for the printer EPSON Workforce WF 7510 there has not been any hangs at all. Yes, the printer works and they (epson) even have a .deb repository were I installed the driver. That worked too. Remove the repository post install, its just better that way.
I have DU twice now and no hangs... no problems
I am quite sure that the issue was the hplip at least as far as my situation was.
All is well here.
 
 View user's profile Send private message Visit poster's website  
Reply with quote Back to top
broweOffline
Post subject:   PostPosted: 29.10.2013, 02:44



Joined: 2010-09-12
Posts: 155
Location: Canada
Status: Offline
Can't tell from the information you posted, but I suspect its a video driver issue. I see you're using nouveau on an old 8500 GT card (same card as I'm using). First try a reinstall of the video driver and see if that helps. Video drivers are fickle things.
 
 View user's profile Send private message  
Reply with quote Back to top
vinurOffline
Post subject: video driver? I don't think that is it, 8500 GT, OK here  PostPosted: 29.10.2013, 10:01



Joined: 2010-09-11
Posts: 61
Location: Lake Oswego
Status: Offline
[quote="browe"] Hello Browe, not sure if you were addressing me as I too am running an 8500 GT video card. I am not having any black screens,
The absence of the printer drivers from hp was the only thing in the system causing a delay which seemed to be long ( as much as a minute) and when the hang ended there was an indication in the message that implicated the printer... I admit by circumstantial issues... sorry to say It went by so fast I could not read it enough to be sure... And now since removing the hplip the booting sequence seems very normal... but the card is old as you say... I suspect it is having to work hard to render Google Earth 7 in its better modes and I would like to get that better, I am using its "3D" capabilities with GE 7, However, it does work... Different subject
The way I deleted the printer was as slh suggested. In case you don't own a HP printer, it might be easier to purge hplip alltogether (apt-get purge hplip hplip-data libhpmud0 printer-driver-hpcups) - and reboot.
 
 View user's profile Send private message Visit poster's website  
Reply with quote Back to top
alexkOffline
Post subject: RE: video driver? I don  PostPosted: 29.10.2013, 14:46



Joined: 2010-10-01
Posts: 192

Status: Offline
      vinur wrote:
And now since removing the hplip the booting sequence seems very normal...

This experience jives with mine, that this issue disappears if one downgrades or removes the hplip packages. I have Intel graphics as reported in the first post. I am still troubleshooting this and will probably report a bug against hplip. I'm seeing a clear timestamp gap in dmesg, separate from the shorter one where my network adapter gets an IP address from the router. I have two HP printers, one a multi-function that's also my scanner, they've been working very well for years and I'd rather not get rid of them right now, though when I do, I'll consider Epsons among others.
 
 View user's profile Send private message Yahoo Messenger  
Reply with quote Back to top
Display posts from previous:     
Jump to:  
All times are GMT - 12 Hours
Post new topic   Reply to topic
View previous topic Printable version Log in to check your private messages View next topic
Powered by Zafenio