Attachment 949440 Details for Bug 1152662 – ipheth connection timed out

ipheth connection timed out

log.txt (text/plain), 8.92 KB, created by Yao Wei Tjong on 2014-10-22 15:40:17 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Yao Wei Tjong

Created: 2014-10-22 15:40:17 UTC

Size: 8.92 KB

patch

obsolete

>Oct 22 22:43:10 xxxxx kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> (eth0): link connected
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> (eth0): device state change: unavailable -> disconnected (reason 'carrier-changed') [20 30 40]
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Auto-activating connection 'Wired connection 3'.
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) starting connection 'Wired connection 3'
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> (eth0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started...
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting...
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> (eth0): device state change: prepare -> config (reason 'none') [40 50 0]
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful.
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete.
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> (eth0): device state change: config -> ip-config (reason 'none') [50 70 0]
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Beginning DHCPv4 transaction (timeout in 45 seconds)
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> dhclient started with pid 3090
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: nm_utils_get_ip_config_method: assertion 's_ip6 != NULL' failed
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
>Oct 22 22:43:10 xxxxx dhclient[3090]: Internet Systems Consortium DHCP Client 4.2.7
>Oct 22 22:43:10 xxxxx dhclient[3090]: Copyright 2004-2014 Internet Systems Consortium.
>Oct 22 22:43:10 xxxxx dhclient[3090]: All rights reserved.
>Oct 22 22:43:10 xxxxx dhclient[3090]: For info, please visit https://www.isc.org/software/dhcp/
>Oct 22 22:43:10 xxxxx dhclient[3090]: 
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: Internet Systems Consortium DHCP Client 4.2.7
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: Copyright 2004-2014 Internet Systems Consortium.
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: All rights reserved.
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: For info, please visit https://www.isc.org/software/dhcp/
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: <info> (eth0): DHCPv4 state changed nbi -> preinit
>Oct 22 22:43:10 xxxxx dhclient[3090]: Listening on LPF/eth0/xx:xx:xx:xx:xx:xx
>Oct 22 22:43:10 xxxxx dhclient[3090]: Sending on   LPF/eth0/xx:xx:xx:xx:xx:xx
>Oct 22 22:43:10 xxxxx dhclient[3090]: Sending on   Socket/fallback
>Oct 22 22:43:10 xxxxx dhclient[3090]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 8 (xid=0x673bb7a2)
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: Listening on LPF/eth0/xx:xx:xx:xx:xx:xx
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: Sending on   LPF/eth0/xx:xx:xx:xx:xx:xx
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: Sending on   Socket/fallback
>Oct 22 22:43:10 xxxxx NetworkManager[1209]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 8 (xid=0x673bb7a2)
>Oct 22 22:43:12 xxxxx avahi-daemon[1066]: Registering new address record for xxxx::xxxx:xxxx:xxxx:xxxx on eth0.*.
>Oct 22 22:43:12 xxxxx NetworkManager[1209]: nm_utils_get_ip_config_method: assertion 's_ip6 != NULL' failed
>Oct 22 22:43:15 xxxxx kernel: ------------[ cut here ]------------
>Oct 22 22:43:15 xxxxx kernel: WARNING: CPU: 0 PID: 0 at net/sched/sch_generic.c:264 dev_watchdog+0x266/0x270()
>Oct 22 22:43:15 xxxxx kernel: NETDEV WATCHDOG: eth0 (ipheth): transmit queue 0 timed out
>Oct 22 22:43:15 xxxxx kernel: Modules linked in: rfcomm fuse ipt_MASQUERADE xt_CHECKSUM tun ip6t_rpfilter ip6t_REJECT xt_conntrack cfg80211 ebtable_nat ebtable_broute bridge stp 
>Oct 22 22:43:15 xxxxx kernel:  crc32_pclmul crc32c_intel btusb ghash_clmulni_intel bluetooth snd_hda_intel microcode rfkill snd_hda_controller serio_raw snd_hda_codec i2c_i801 r8
>Oct 22 22:43:15 xxxxx kernel: CPU: 0 PID: 0 Comm: swapper/0 Tainted: P           OE 3.16.6-200.fc20.x86_64 #1
>Oct 22 22:43:15 xxxxx kernel: Hardware name: System manufacturer System Product Name/P8Z68 DELUXE, BIOS 3603 11/09/2012
>Oct 22 22:43:15 xxxxx kernel:  0000000000000000 f3d189b4b42a6e4b ffff88021ec03da0 ffffffff81707d45
>Oct 22 22:43:15 xxxxx kernel:  ffff88021ec03de8 ffff88021ec03dd8 ffffffff8108d0bd 0000000000000000
>Oct 22 22:43:15 xxxxx kernel:  ffff880212c36000 0000000000000001 0000000000000000 ffff880212c36000
>Oct 22 22:43:15 xxxxx kernel: Call Trace:
>Oct 22 22:43:15 xxxxx kernel:  <IRQ>  [<ffffffff81707d45>] dump_stack+0x45/0x56
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8108d0bd>] warn_slowpath_common+0x7d/0xa0
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8108d13c>] warn_slowpath_fmt+0x5c/0x80
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8161d126>] dev_watchdog+0x266/0x270
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8161cec0>] ? dev_graft_qdisc+0x80/0x80
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff81098e16>] call_timer_fn+0x36/0x100
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8161cec0>] ? dev_graft_qdisc+0x80/0x80
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8109a832>] run_timer_softirq+0x212/0x2f0
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff810924e5>] __do_softirq+0xf5/0x2a0
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff810928fd>] irq_exit+0xbd/0xd0
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff817121a5>] smp_apic_timer_interrupt+0x45/0x60
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8171029d>] apic_timer_interrupt+0x6d/0x80
>Oct 22 22:43:15 xxxxx kernel:  <EOI>  [<ffffffff8159f85f>] ? cpuidle_enter_state+0x4f/0xc0
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff8159f987>] cpuidle_enter+0x17/0x20
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff810d4be5>] cpu_startup_entry+0x315/0x440
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff816f9dd7>] rest_init+0x77/0x80
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff81d330ec>] start_kernel+0x470/0x491
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff81d32a85>] ? set_init_arg+0x53/0x53
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff81d32120>] ? early_idt_handlers+0x120/0x120
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff81d325ee>] x86_64_start_reservations+0x2a/0x2c
>Oct 22 22:43:15 xxxxx kernel:  [<ffffffff81d3273d>] x86_64_start_kernel+0x14d/0x170
>Oct 22 22:43:15 xxxxx kernel: ---[ end trace e2d74d9aa03df0cf ]---
>Oct 22 22:43:15 xxxxx kernel: ipheth 2-1.2.1.2.1.4:4.2: ipheth_tx_timeout: TX timeout
>Oct 22 22:43:16 xxxxx sh[1082]: abrt-dump-oops: Found oopses: 1
>Oct 22 22:43:16 xxxxx sh[1082]: abrt-dump-oops: Creating problem directories
>Oct 22 22:43:16 xxxxx abrt-server[3103]: Duplicate: core backtrace
>Oct 22 22:43:16 xxxxx abrt-server[3103]: DUP_OF_DIR: /var/tmp/abrt/oops-2014-08-28-06:37:41-1326-0
>Oct 22 22:43:16 xxxxx abrt-server[3103]: Deleting problem directory oops-2014-10-22-22:43:16-3102-0 (dup of oops-2014-08-28-06:37:41-1326-0)
>Oct 22 22:43:16 xxxxx abrt-server[3103]: No actions are found for event 'notify-dup'
>Oct 22 22:43:17 xxxxx abrt-dump-oops[3102]: Reported 1 kernel oopses to Abrt
>Oct 22 22:43:18 xxxxx dhclient[3090]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 11 (xid=0x673bb7a2)
>Oct 22 22:43:18 xxxxx NetworkManager[1209]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 11 (xid=0x673bb7a2)
>Oct 22 22:43:20 xxxxx systemd-logind[1095]: Removed session c1.
>Oct 22 22:43:20 xxxxx systemd[1]: Starting Stop Read-Ahead Data Collection...
>Oct 22 22:43:20 xxxxx systemd[1]: Started Stop Read-Ahead Data Collection.
>Oct 22 22:43:23 xxxxx fprintd[2052]: ** Message: No devices in use, exit
>Oct 22 22:43:25 xxxxx kernel: ipheth 2-1.2.1.2.1.4:4.2: ipheth_tx_timeout: TX timeout
>Oct 22 22:43:27 xxxxx NetworkManager[1209]: <info> (eth0): link disconnected (deferring action for 4 seconds)
>Oct 22 22:43:29 xxxxx dhclient[3090]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 11 (xid=0x673bb7a2)
>Oct 22 22:43:29 xxxxx NetworkManager[1209]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 11 (xid=0x673bb7a2)
>Oct 22 22:43:31 xxxxx NetworkManager[1209]: <info> (eth0): link disconnected (calling deferred action)
>Oct 22 22:43:31 xxxxx NetworkManager[1209]: <info> (eth0): device state change: ip-config -> unavailable (reason 'carrier-changed') [70 20 40]
>Oct 22 22:43:31 xxxxx NetworkManager[1209]: <info> (eth0): deactivating device (reason 'carrier-changed') [40]
>Oct 22 22:43:32 xxxxx NetworkManager[1209]: <info> (eth0): canceled DHCP transaction, DHCP client pid 3090
>

Actions: View

Attachments on bug 1152662: 949440 | 951989 | 953089 | 955648