Attachment 831662 Details for Bug 1165374

syslog-btrfs-suspend.txt

btrfs.txt (text/plain), 22.69 KB, created by Olaf Hering on 2020-03-02 08:01:45 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Olaf Hering

Created: 2020-03-02 08:01:45 UTC

Size: 22.69 KB

patch

obsolete

>Mar 02 07:27:12 latitude systemd[1]: Reached target Sleep.
>Mar 02 07:27:12 latitude systemd[1]: Starting Suspend...
>Mar 02 07:27:12 latitude systemd-sleep[9799]: INFO: Skip running /usr/lib/systemd/system-sleep/grub2.sleep for suspend
>Mar 02 07:27:12 latitude systemd-sleep[9799]: Suspending system...
>Mar 02 07:27:12 latitude kernel: PM: Syncing filesystems ... 
>Mar 02 07:27:12 latitude kernel: done.
>Mar 02 07:27:32 latitude kernel: PM: Preparing system for sleep (mem)
>Mar 02 07:27:32 latitude kernel: Freezing user space processes ... 
>Mar 02 07:27:32 latitude kernel: Freezing of tasks failed after 20.007 seconds (2 tasks refusing to freeze, wq_busy=0):
>Mar 02 07:27:32 latitude kernel: btrfs           D    0   521    502 0x00000004
>Mar 02 07:27:32 latitude kernel: Call Trace:
>Mar 02 07:27:32 latitude kernel:  ? __schedule+0x27f/0x830
>Mar 02 07:27:32 latitude kernel:  schedule+0x28/0x80
>Mar 02 07:27:32 latitude kernel:  __scrub_blocked_if_needed+0x68/0xa0 [btrfs]
>Mar 02 07:27:32 latitude kernel:  ? wait_woken+0x80/0x80
>Mar 02 07:27:32 latitude kernel:  scrub_pause_off+0x21/0x50 [btrfs]
>Mar 02 07:27:32 latitude kernel:  scrub_stripe+0x776/0x1000 [btrfs]
>Mar 02 07:27:32 latitude kernel:  ? sched_clock+0x5/0x10
>Mar 02 07:27:32 latitude kernel:  ? wait_woken+0x80/0x80
>Mar 02 07:27:32 latitude kernel:  ? __schedule+0x287/0x830
>Mar 02 07:27:32 latitude kernel:  ? scrub_chunk+0xff/0x150 [btrfs]
>Mar 02 07:27:32 latitude kernel:  scrub_chunk+0xff/0x150 [btrfs]
>Mar 02 07:27:32 latitude kernel:  scrub_enumerate_chunks+0x27e/0x590 [btrfs]
>Mar 02 07:27:32 latitude kernel:  ? do_wait_intr_irq+0x90/0x90
>Mar 02 07:27:32 latitude kernel:  btrfs_scrub_dev+0x1f3/0x520 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_ioctl+0x188c/0x1e70 [btrfs]
>Mar 02 07:27:32 latitude kernel:  ? do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:32 latitude kernel:  do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:32 latitude kernel:  ? get_task_io_context+0x43/0x80
>Mar 02 07:27:32 latitude kernel:  ? set_task_ioprio+0x84/0x90
>Mar 02 07:27:32 latitude kernel:  SyS_ioctl+0x74/0x80
>Mar 02 07:27:32 latitude kernel:  do_syscall_64+0x7b/0x160
>Mar 02 07:27:32 latitude kernel:  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
>Mar 02 07:27:32 latitude kernel: RIP: 0033:0x7f19b3270587
>Mar 02 07:27:32 latitude kernel: RSP: 002b:00007f19b317fd48 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
>Mar 02 07:27:32 latitude kernel: RAX: ffffffffffffffda RBX: 00005596ba1603e0 RCX: 00007f19b3270587
>Mar 02 07:27:32 latitude kernel: RDX: 00005596ba1603e0 RSI: 00000000c400941b RDI: 0000000000000003
>Mar 02 07:27:32 latitude kernel: RBP: 0000000000000000 R08: 00007f19b3180700 R09: 0000000000000000
>Mar 02 07:27:32 latitude kernel: R10: 00007f19b3180700 R11: 0000000000000246 R12: 00007ffec00bf05e
>Mar 02 07:27:32 latitude kernel: R13: 00007ffec00bf05f R14: 00005596ba1603e0 R15: 00007ffec00bf060
>Mar 02 07:27:32 latitude kernel: btrfs           D    0   583    495 0x00000004
>Mar 02 07:27:32 latitude kernel: Call Trace:
>Mar 02 07:27:32 latitude kernel:  ? __schedule+0x27f/0x830
>Mar 02 07:27:32 latitude kernel:  schedule+0x28/0x80
>Mar 02 07:27:32 latitude kernel:  io_schedule+0x12/0x40
>Mar 02 07:27:32 latitude kernel:  wait_on_page_bit_common+0xe2/0x210
>Mar 02 07:27:32 latitude kernel:  ? page_cache_tree_insert+0xb0/0xb0
>Mar 02 07:27:32 latitude kernel:  __filemap_fdatawait_range+0xd3/0x120
>Mar 02 07:27:32 latitude kernel:  ? __clear_extent_bit+0x242/0x370 [btrfs]
>Mar 02 07:27:32 latitude kernel:  filemap_fdatawait_range+0xe/0x20
>Mar 02 07:27:32 latitude kernel:  __btrfs_wait_marked_extents.isra.18+0xbf/0xe0 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_wait_extents+0x15/0x30 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_write_and_wait_marked_extents.constprop.21+0x56/0x70 [btrfs]
>Mar 02 07:27:32 latitude kernel:  ? btrfs_commit_transaction+0x6d4/0x960 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_commit_transaction+0x6d4/0x960 [btrfs]
>Mar 02 07:27:32 latitude kernel:  ? start_transaction+0xb8/0x430 [btrfs]
>Mar 02 07:27:32 latitude kernel:  prepare_to_relocate+0x102/0x150 [btrfs]
>Mar 02 07:27:32 latitude kernel:  relocate_block_group+0x47/0x710 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_relocate_block_group+0x18e/0x280 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_relocate_chunk+0x50/0x100 [btrfs]
>Mar 02 07:27:32 latitude kernel:  __btrfs_balance+0x8b7/0xbd0 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_balance+0x35c/0x650 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_ioctl_balance+0x312/0x370 [btrfs]
>Mar 02 07:27:32 latitude kernel:  btrfs_ioctl+0xba5/0x1e70 [btrfs]
>Mar 02 07:27:32 latitude kernel:  ? __handle_mm_fault+0x9c6/0x1210
>Mar 02 07:27:32 latitude kernel:  ? do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:32 latitude kernel:  do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:32 latitude kernel:  ? handle_mm_fault+0xa6/0x1d0
>Mar 02 07:27:32 latitude kernel:  ? __do_page_fault+0x256/0x4c0
>Mar 02 07:27:32 latitude kernel:  SyS_ioctl+0x74/0x80
>Mar 02 07:27:32 latitude kernel:  do_syscall_64+0x7b/0x160
>Mar 02 07:27:32 latitude kernel:  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
>Mar 02 07:27:32 latitude kernel: RIP: 0033:0x7f9dbd15a587
>Mar 02 07:27:32 latitude kernel: RSP: 002b:00007fffe9c20988 EFLAGS: 00000206 ORIG_RAX: 0000000000000010
>Mar 02 07:27:32 latitude kernel: RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f9dbd15a587
>Mar 02 07:27:32 latitude kernel: RDX: 00007fffe9c20a20 RSI: 00000000c4009420 RDI: 0000000000000003
>Mar 02 07:27:32 latitude kernel: RBP: 0000000000000003 R08: 0000000000000000 R09: 0000000000000003
>Mar 02 07:27:32 latitude kernel: R10: 000000000000055b R11: 0000000000000206 R12: 00007fffe9c20a20
>Mar 02 07:27:32 latitude kernel: R13: 00007fffe9c20a20 R14: 0000000000000001 R15: 00007fffe9c22f4f
>Mar 02 07:27:32 latitude kernel: OOM killer enabled.
>Mar 02 07:27:32 latitude kernel: Restarting tasks ... done.
>Mar 02 07:27:32 latitude kernel: thermal thermal_zone7: failed to read out thermal zone (-61)
>Mar 02 07:27:32 latitude rtkit-daemon[4155]: The canary thread is apparently starving. Taking action.
>Mar 02 07:27:32 latitude rtkit-daemon[4155]: Demoting known real-time threads.
>Mar 02 07:27:32 latitude rtkit-daemon[4155]: Successfully demoted thread 4370 of process 4151 (/usr/bin/pulseaudio).
>Mar 02 07:27:32 latitude rtkit-daemon[4155]: Successfully demoted thread 4369 of process 4151 (/usr/bin/pulseaudio).
>Mar 02 07:27:32 latitude rtkit-daemon[4155]: Successfully demoted thread 4151 of process 4151 (/usr/bin/pulseaudio).
>Mar 02 07:27:32 latitude rtkit-daemon[4155]: Demoted 3 threads.
>Mar 02 07:27:53 latitude kernel: PM: Syncing filesystems ... done.
>Mar 02 07:27:53 latitude kernel: PM: Preparing system for sleep (freeze)
>Mar 02 07:27:53 latitude kernel: Freezing user space processes ... 
>Mar 02 07:27:53 latitude kernel: Freezing of tasks failed after 20.002 seconds (2 tasks refusing to freeze, wq_busy=0):
>Mar 02 07:27:53 latitude kernel: btrfs           D    0   521    502 0x00000004
>Mar 02 07:27:53 latitude kernel: Call Trace:
>Mar 02 07:27:53 latitude kernel:  ? __schedule+0x27f/0x830
>Mar 02 07:27:53 latitude kernel:  schedule+0x28/0x80
>Mar 02 07:27:53 latitude kernel:  __scrub_blocked_if_needed+0x68/0xa0 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? wait_woken+0x80/0x80
>Mar 02 07:27:53 latitude kernel:  scrub_pause_off+0x21/0x50 [btrfs]
>Mar 02 07:27:53 latitude kernel:  scrub_stripe+0x776/0x1000 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? sched_clock+0x5/0x10
>Mar 02 07:27:53 latitude kernel:  ? wait_woken+0x80/0x80
>Mar 02 07:27:53 latitude kernel:  ? __schedule+0x287/0x830
>Mar 02 07:27:53 latitude kernel:  ? scrub_chunk+0xff/0x150 [btrfs]
>Mar 02 07:27:53 latitude kernel:  scrub_chunk+0xff/0x150 [btrfs]
>Mar 02 07:27:53 latitude kernel:  scrub_enumerate_chunks+0x27e/0x590 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? do_wait_intr_irq+0x90/0x90
>Mar 02 07:27:53 latitude kernel:  btrfs_scrub_dev+0x1f3/0x520 [btrfs]
>Mar 02 07:27:53 latitude kernel:  btrfs_ioctl+0x188c/0x1e70 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:53 latitude kernel:  do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:53 latitude kernel:  ? get_task_io_context+0x43/0x80
>Mar 02 07:27:53 latitude kernel:  ? set_task_ioprio+0x84/0x90
>Mar 02 07:27:53 latitude kernel:  SyS_ioctl+0x74/0x80
>Mar 02 07:27:53 latitude kernel:  do_syscall_64+0x7b/0x160
>Mar 02 07:27:53 latitude kernel:  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
>Mar 02 07:27:53 latitude kernel: RIP: 0033:0x7f19b3270587
>Mar 02 07:27:53 latitude kernel: RSP: 002b:00007f19b317fd48 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
>Mar 02 07:27:53 latitude kernel: RAX: ffffffffffffffda RBX: 00005596ba1603e0 RCX: 00007f19b3270587
>Mar 02 07:27:53 latitude kernel: RDX: 00005596ba1603e0 RSI: 00000000c400941b RDI: 0000000000000003
>Mar 02 07:27:53 latitude kernel: RBP: 0000000000000000 R08: 00007f19b3180700 R09: 0000000000000000
>Mar 02 07:27:53 latitude kernel: R10: 00007f19b3180700 R11: 0000000000000246 R12: 00007ffec00bf05e
>Mar 02 07:27:53 latitude kernel: R13: 00007ffec00bf05f R14: 00005596ba1603e0 R15: 00007ffec00bf060
>Mar 02 07:27:53 latitude kernel: btrfs           R  running task        0   583    495 0x00000004
>Mar 02 07:27:53 latitude kernel: Call Trace:
>Mar 02 07:27:53 latitude kernel:  ? __btrfs_prealloc_file_range+0x10c/0x460 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? cache_save_setup+0x26f/0x3b0 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_setup_space_cache+0x94/0xc0 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? commit_cowonly_roots+0xcc/0x2c0 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_qgroup_account_extents+0xf9/0x230 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_commit_transaction+0x49e/0x960 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? start_transaction+0xb8/0x430 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? relocate_block_group+0x30e/0x710 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_relocate_block_group+0x18e/0x280 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_relocate_chunk+0x50/0x100 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? __btrfs_balance+0x8b7/0xbd0 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_balance+0x35c/0x650 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_ioctl_balance+0x312/0x370 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? btrfs_ioctl+0xba5/0x1e70 [btrfs]
>Mar 02 07:27:53 latitude kernel:  ? __handle_mm_fault+0x9c6/0x1210
>Mar 02 07:27:53 latitude kernel:  ? do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:53 latitude kernel:  ? do_vfs_ioctl+0x90/0x5f0
>Mar 02 07:27:53 latitude kernel:  ? handle_mm_fault+0xa6/0x1d0
>Mar 02 07:27:53 latitude kernel:  ? __do_page_fault+0x256/0x4c0
>Mar 02 07:27:53 latitude kernel:  ? SyS_ioctl+0x74/0x80
>Mar 02 07:27:53 latitude kernel:  ? do_syscall_64+0x7b/0x160
>Mar 02 07:27:53 latitude kernel:  ? entry_SYSCALL_64_after_hwframe+0x3d/0xa2
>Mar 02 07:27:53 latitude kernel: OOM killer enabled.
>Mar 02 07:27:53 latitude kernel: Restarting tasks ... done.
>Mar 02 07:27:53 latitude kernel: thermal thermal_zone7: failed to read out thermal zone (-61)
>Mar 02 07:27:53 latitude rtkit-daemon[4155]: The canary thread is apparently starving. Taking action.
>Mar 02 07:27:53 latitude rtkit-daemon[4155]: Demoting known real-time threads.
>Mar 02 07:27:53 latitude rtkit-daemon[4155]: Successfully demoted thread 4370 of process 4151 (/usr/bin/pulseaudio).
>Mar 02 07:27:53 latitude rtkit-daemon[4155]: Successfully demoted thread 4369 of process 4151 (/usr/bin/pulseaudio).
>Mar 02 07:27:53 latitude rtkit-daemon[4155]: Successfully demoted thread 4151 of process 4151 (/usr/bin/pulseaudio).
>Mar 02 07:27:53 latitude rtkit-daemon[4155]: Demoted 3 threads.
>Mar 02 07:27:53 latitude systemd[1]: systemd-suspend.service: Main process exited, code=exited, status=1/FAILURE
>Mar 02 07:27:53 latitude systemd[1]: Failed to start Suspend.
>Mar 02 07:27:53 latitude systemd[1]: Dependency failed for Suspend.
>Mar 02 07:27:53 latitude systemd-logind[2376]: Operation 'sleep' finished.
>Mar 02 07:27:53 latitude systemd[1]: suspend.target: Job suspend.target/start failed with result 'dependency'.
>Mar 02 07:27:53 latitude systemd[1]: sleep.target: Unit not needed anymore. Stopping.
>Mar 02 07:27:53 latitude systemd[1]: systemd-suspend.service: Unit entered failed state.
>Mar 02 07:27:53 latitude systemd[1]: systemd-suspend.service: Failed with result 'exit-code'.
>Mar 02 07:27:53 latitude systemd[1]: Stopped target Sleep.
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.1491] manager: sleep: wake requested (sleeping: yes  enabled: yes)
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.1491] device (eth0): state change: activated -> unmanaged (reason 'sleeping', sys-iface-state: 'managed')
>Mar 02 07:27:53 latitude kernel: e1000e: eth0 NIC Link is Down
>Mar 02 07:27:53 latitude kernel: br0: port 1(eth0) entered disabled state
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.2508] manager: NetworkManager state is now CONNECTED_GLOBAL
>Mar 02 07:27:53 latitude kernel: device eth0 left promiscuous mode
>Mar 02 07:27:53 latitude kernel: br0: port 1(eth0) entered disabled state
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.2708] device (br0): detached bridge port eth0
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.2708] device (eth0): released from master device br0
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.2711] device (eth0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'managed')
>Mar 02 07:27:53 latitude dbus-daemon[2346]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.4' (uid=0 pid=2380 comm="/usr/sbin/NetworkManager --no-daemon ")
>Mar 02 07:27:53 latitude systemd[1]: Starting Network Manager Script Dispatcher Service...
>Mar 02 07:27:53 latitude kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
>Mar 02 07:27:53 latitude dbus-daemon[2346]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
>Mar 02 07:27:53 latitude systemd[1]: Started Network Manager Script Dispatcher Service.
>Mar 02 07:27:53 latitude nm-dispatcher[9815]: req:1 'down' [eth0]: new request (5 scripts)
>Mar 02 07:27:53 latitude nm-dispatcher[9815]: req:1 'down' [eth0]: start running ordered scripts...
>Mar 02 07:27:53 latitude systemd[1]: Stopping dnsmasq...
>Mar 02 07:27:53 latitude systemd[1]: Stopped dnsmasq.
>Mar 02 07:27:53 latitude systemd[1]: Starting dnsmasq...
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.4887] device (wlan0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'managed')
>Mar 02 07:27:53 latitude kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
>Mar 02 07:27:53 latitude kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.4898] device (wlan0): set-hw-addr: set MAC address to 3A:51:09:B4:78:9E (scanning)
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.4902] device (br0): DHCPv4 lease renewal requested
>Mar 02 07:27:53 latitude chmod[9864]: mode of '/dev/shm/.dnsmasq.d/log.txt' retained as 0644 (rw-r--r--)
>Mar 02 07:27:53 latitude systemd[1]: Started dnsmasq.
>Mar 02 07:27:53 latitude chronyd[2517]: Forward time jump detected!
>Mar 02 07:27:53 latitude chronyd[2517]: Can't synchronise: no selectable sources
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.5233] dhcp4 (br0): canceled DHCP transaction, DHCP client pid 2806
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.5233] dhcp4 (br0): state changed bound -> done
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.5238] dhcp4 (br0): activation: beginning transaction (no timeout)
>Mar 02 07:27:53 latitude NetworkManager[2380]: <info>  [1583130473.5266] dhcp4 (br0): dhclient started with pid 9879
>Mar 02 07:27:55 latitude ModemManager[2377]: <info>  Couldn't check support for device at '/sys/devices/pci0000:00/0000:00:1c.0/0000:01:00.0': not supported by any plugin
>Mar 02 07:27:55 latitude ModemManager[2377]: <info>  Couldn't check support for device at '/sys/devices/pci0000:00/0000:00:1f.6': not supported by any plugin
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9209] device (eth0): carrier: link connected
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9216] device (eth0): state change: unavailable -> disconnected (reason 'carrier-changed', sys-iface-state: 'managed')
>Mar 02 07:27:56 latitude kernel: e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx/Tx
>Mar 02 07:27:56 latitude kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9229] policy: auto-activating connection 'eth'
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9243] device (eth0): Activation: starting connection 'eth' (11111111-1111-1111-1111-111111111111)
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9246] device (eth0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9252] device (eth0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9257] device (eth0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
>Mar 02 07:27:56 latitude kernel: br0: port 1(eth0) entered blocking state
>Mar 02 07:27:56 latitude kernel: br0: port 1(eth0) entered disabled state
>Mar 02 07:27:56 latitude kernel: device eth0 entered promiscuous mode
>Mar 02 07:27:56 latitude kernel: br0: port 1(eth0) entered blocking state
>Mar 02 07:27:56 latitude kernel: br0: port 1(eth0) entered forwarding state
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9272] device (br0): attached bridge port eth0
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9273] device (eth0): Activation: connection 'eth' enslaved, continuing activation
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9274] device (eth0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9284] device (br0): carrier: link connected
>Mar 02 07:27:56 latitude nm-dispatcher[9815]: req:2 'pre-up' [eth0]: new request (1 scripts)
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9284] device (br0): DHCPv4 lease renewal requested
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9608] dhcp4 (br0): canceled DHCP transaction, DHCP client pid 9879
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9609] dhcp4 (br0): state changed unknown -> done
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9633] dhcp4 (br0): activation: beginning transaction (no timeout)
>Mar 02 07:27:56 latitude NetworkManager[2380]: <info>  [1583130476.9724] dhcp4 (br0): dhclient started with pid 9902
>Mar 02 07:28:10 latitude nm-dispatcher[9815]: connect: Network is unreachable
>Mar 02 07:28:10 latitude nm-dispatcher[9815]: connect: Network is unreachable
>Mar 02 07:28:10 latitude nm-dispatcher[9815]: connect: Network is unreachable
>Mar 02 07:28:10 latitude systemd[1]: nas-data.automount: Got invalid poll event 16 on pipe (fd=50)
>Mar 02 07:28:10 latitude systemd[1]: nas-data.automount: Unit entered failed state.
>Mar 02 07:28:10 latitude systemd[1]: nas-dist.automount: Got invalid poll event 16 on pipe (fd=129)
>Mar 02 07:28:10 latitude systemd[1]: nas-dist.automount: Unit entered failed state.
>Mar 02 07:28:10 latitude systemd[1]: nas-private.automount: Got invalid poll event 16 on pipe (fd=53)
>Mar 02 07:28:10 latitude systemd[1]: nas-private.automount: Unit entered failed state.
>Mar 02 07:28:10 latitude nm-dispatcher[9815]: req:2 'pre-up' [eth0]: start running ordered scripts...
>Mar 02 07:28:10 latitude NetworkManager[2380]: <info>  [1583130490.6779] device (eth0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
>Mar 02 07:28:10 latitude NetworkManager[2380]: <info>  [1583130490.6784] device (eth0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
>Mar 02 07:28:10 latitude NetworkManager[2380]: <info>  [1583130490.6793] device (eth0): Activation: successful, device activated.
>Mar 02 07:28:10 latitude nm-dispatcher[9815]: req:3 'up' [eth0]: new request (5 scripts)
>Mar 02 07:28:10 latitude nm-dispatcher[9815]: req:3 'up' [eth0]: start running ordered scripts...
>Mar 02 07:28:10 latitude nm-dispatcher[9815]: /etc/NetworkManager/dispatcher.d/01-dnsmasq-conf.sh eth0 up not handled for DEVICE_IFACE=eth0
>Mar 02 07:28:14 latitude ModemManager[2377]: <info>  Creating modem with plugin 'Generic' and '1' ports
>Mar 02 07:28:14 latitude ModemManager[2377]: <warn>  Could not grab port (tty/ttyS4): 'Cannot add port 'tty/ttyS4', unhandled serial type'
>Mar 02 07:28:14 latitude ModemManager[2377]: <warn>  Couldn't create modem for device at '/sys/devices/pci0000:00/0000:00:16.3': Failed to find primary AT port
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4514] dhcp4 (br0):   address 172.16.0.3
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4529] dhcp4 (br0):   plen 16 (255.255.0.0)
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4531] dhcp4 (br0):   classless static route 192.168.178.0/24 gw 172.16.0.1
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4532] dhcp4 (br0):   gateway 172.16.0.1
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4532] dhcp4 (br0):   lease time 43200
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4533] dhcp4 (br0):   hostname 'latitude'
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4533] dhcp4 (br0):   nameserver '172.16.0.1'
>Mar 02 07:28:16 latitude nm-dispatcher[9815]: req:4 'dhcp4-change' [br0]: new request (5 scripts)
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4533] dhcp4 (br0):   domain name 'ubnt.lan'
>Mar 02 07:28:16 latitude nm-dispatcher[9815]: req:4 'dhcp4-change' [br0]: start running ordered scripts...
>Mar 02 07:28:16 latitude NetworkManager[2380]: <info>  [1583130496.4534] dhcp4 (br0): state changed unknown -> bound
>Mar 02 07:28:16 latitude systemd[1]: Stopping dnsmasq...
>Mar 02 07:28:16 latitude systemd[1]: Stopped dnsmasq.
>Mar 02 07:28:16 latitude systemd[1]: Starting dnsmasq...
>Mar 02 07:28:16 latitude chmod[10020]: mode of '/dev/shm/.dnsmasq.d/log.txt' retained as 0644 (rw-r--r--)
>Mar 02 07:28:16 latitude systemd[1]: Started dnsmasq.
>Mar 02 07:28:42 latitude systemd-logind[2376]: Lid closed.
>Mar 02 07:28:45 latitude kernel: e1000e: eth0 NIC Link is Down
>Mar 02 07:28:45 latitude kernel: br0: port 1(eth0) entered disabled state
>Mar 02 07:28:49 latitude kernel: usb 1-4: USB disconnect, device number 4
>Mar 02 07:28:49 latitude kernel: usb 1-4.1: USB disconnect, device number 6
>Mar 02 07:28:51 latitude kernel: usb 1-3: USB disconnect, device number 3
>Mar 02 07:29:11 latitude nm-openvpn[4678]: [puerta.suse.de] Inactivity timeout (--ping-restart), restarting

Actions: View

Attachments on bug 1165374: 831662