after upgrade shutdown/reboot hangs

This forum is for discussion about general software issues.

after upgrade shutdown/reboot hangs

Postby vide » Thu Jun 01, 2017 8:39 pm

After a fresh setup of a beaglebone black/green things are fine. But after
`pacman -Syu` shutdown and reboot hangs with periodical messages.

After upgrade:

$this->bbcode_second_pass_code('', '[root@alarm ~]# uname -a
Linux alarm 4.11.3-1-ARCH #1 Sat May 27 01:02:14 UTC 2017 armv7l GNU/Linux')

Pacman log:

$this->bbcode_second_pass_code('', '[2017-06-01 18:55] [PACMAN] Running 'pacman -Syu'
[2017-06-01 18:55] [PACMAN] synchronizing package lists
[2017-06-01 18:55] [PACMAN] starting full system upgrade
[2017-06-01 18:57] [ALPM] transaction started
[2017-06-01 18:57] [ALPM] upgraded iana-etc (20170303-1 -> 20170512-1)
[2017-06-01 18:57] [ALPM] upgraded glibc (2.25-1 -> 2.25-2)
[2017-06-01 18:57] [ALPM-SCRIPTLET] Generating locales...
[2017-06-01 18:57] [ALPM-SCRIPTLET] Generation complete.
[2017-06-01 18:58] [ALPM] upgraded gcc-libs (6.3.1-2 -> 7.1.1-2)
[2017-06-01 18:58] [ALPM] upgraded ncurses (6.0+20170401-1 -> 6.0+20170429-1)
[2017-06-01 18:58] [ALPM] upgraded openssl (1.1.0.e-1 -> 1.1.0.f-1)
[2017-06-01 18:58] [ALPM] upgraded krb5 (1.15-1 -> 1.15.1-1)
[2017-06-01 18:58] [ALPM] installed libnghttp2 (1.22.0-1)
[2017-06-01 18:58] [ALPM] upgraded curl (7.54.0-2 -> 7.54.0-3)
[2017-06-01 18:58] [ALPM] upgraded hwids (20161103-1 -> 20170328-1)
[2017-06-01 18:58] [ALPM] upgraded libtirpc (1.0.1-2 -> 1.0.1-3)
[2017-06-01 18:58] [ALPM] upgraded device-mapper (2.02.170-1 -> 2.02.171-1)
[2017-06-01 18:58] [ALPM] upgraded glib2 (2.52.1+4+g2eddcef1e-1 -> 2.52.2+1+gb8bd46bc8-1)
[2017-06-01 18:58] [ALPM] upgraded npth (1.3-1 -> 1.4-1)
[2017-06-01 18:58] [ALPM] upgraded gnutls (3.5.11-1 -> 3.5.12-1)
[2017-06-01 18:58] [ALPM] upgraded gnupg (2.1.20-1 -> 2.1.21-1)
[2017-06-01 18:58] [ALPM] upgraded iproute2 (4.10.0-3 -> 4.11.0-1)
[2017-06-01 18:58] [ALPM] upgraded licenses (20140629-1 -> 20140629-2)
[2017-06-01 19:01] [ALPM] upgraded linux-firmware (20170309.695f2d6-1 -> 20170422.ade8332-1)
[2017-06-01 19:02] [ALPM] upgraded linux-am33x (4.10.13-1 -> 4.11.3-1)
[2017-06-01 19:02] [ALPM-SCRIPTLET] >>> Updating module dependencies. Please wait ...
[2017-06-01 19:02] [ALPM] upgraded logrotate (3.12.1-1 -> 3.12.2-1)
[2017-06-01 19:02] [ALPM] upgraded lvm2 (2.02.170-1 -> 2.02.171-1)
[2017-06-01 19:02] [ALPM] upgraded man-pages (4.10-3 -> 4.11-1)
[2017-06-01 19:02] [ALPM] upgraded nano (2.8.1-1 -> 2.8.2-1)
[2017-06-01 19:02] [ALPM] upgraded pacman-mirrorlist (20170327-1 -> 20170512-1)
[2017-06-01 19:02] [ALPM] upgraded xfsprogs (4.10.0-1 -> 4.11.0-1)
[2017-06-01 19:02] [ALPM] transaction completed
[2017-06-01 19:02] [ALPM] running 'systemd-tmpfiles.hook'...
[2017-06-01 19:02] [ALPM] running 'systemd-update.hook'...
[2017-06-01 19:02] [ALPM] running 'texinfo-install.hook'...')

Shutdown messages:

$this->bbcode_second_pass_code('', '
[root@alarm ~]# shutdown now
[ OK ] Stopped target Sound Card.
[ OK ] Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
[ OK ] Stopped target Timers.
[ O Stopping Session c1 of user root.
Stopping User Manager for UID 0...
[ OK ] Stopped target Graphical Interface.
Starting Generate shutdown-ramfs...
[ OK ] Stopped target Multi-User System.
Stopping Entropy Harvesting Daemon...
[ OK ] Stopped Daily man-db cache update.
Stopping Network Name Resolution...
[ OK ] Stopped target Login Prompts.
Stopping Serial Getty on ttyS0...
Stopping Getty on tty1...
[ OK ] Stopped Daily verification of password and group files.
[ OK ] Stopped target System Time Synchronized.
[ OK ] Stopped Daily Cleanup of Temporary Directories.
Stopping OpenSSH Daemon...
[ OK ] Stopped Entropy Harvesting Daemon.
[ OK ] Stopped Network Name Resolution.
[ OK ] Stopped OpenSSH Daemon.
[ OK ] Stopped Getty on tty1.
[ OK ] Stopped Serial Getty on ttyS0.
[ OK ] Stopped User Manager for UID 0.
[ OK ] Stopped Session c1 of user root.
[ OK ] Removed slice User Slice of root.
Stopping Login Service...
[ OK ] Removed slice system-serial\x2dgetty.slice.
[ OK ] Removed slice system-getty.slice.
Stopping Permit User Sessions...
[ OK ] Stopped Login Service.
[ OK ] Stopped Permit User Sessions.
[ OK ] Stopped target Network.
Stopping Network Service...
[ OK ] Stopped target Remote File Systems.
[ OK ] Stopped Network Service.
Stopping D-Bus System Message Bus...
[ OK ] Stopped D-Bus System Message Bus.
[ OK ] Stopped target Basic System.
[ OK ] Stopped target Paths.
[ OK ] Stopped target Slices.
[ OK ] Removed slice User and Session Slice.
[ OK ] Stopped target Sockets.
[ OK ] Closed D-Bus System Message Bus Socket.
[ OK ] Stopped target System Initialization.
Stopping Load/Save Random Seed...
Stopping Update UTMP about System Boot/Shutdown...
Stopping Network Time Synchronization...
[ OK ] Stopped Apply Kernel Variables.
[ OK ] Stopped target Encrypted Volumes.
[ OK ] Stopped Dispatch Password Requests to Console Directory Watch.
[ OK ] Stopped Forward Password Requests to Wall Directory Watch.
[ OK ] Stopped Network Time Synchronization.
[ OK ] Stopped Load/Save Random Seed.
[ OK ] Stopped Update UTMP about System Boot/Shutdown.
[ OK ] Stopped Create Volatile Files and Directories.
[ OK ] Stopped target Local File Systems.
Unmounting Temporary Directory...
Unmounting /run/user/0...
[ OK ] Unmounted Temporary Directory.
[ OK ] Stopped target Swap.
[ OK ] Unmounted /run/user/0.
[ OK ] Reached target Unmount All Filesystems.
[ OK ] Stopped target Local File Systems (Pre).
[ OK ] Stopped Create Static Device Nodes in /dev.
[ OK ] Stopped Remount Root and Kernel File Systems.
[ OK ] Started Generate shutdown-ramfs.
[ OK ] Reached target Shutdown.
[ 139.351794] systemd-shutdow: 36 output lines suppressed due to ratelimiting
[ 140.544416] systemd-shutdown[1]: Sending SIGTERM to remaining processes...
[ 140.570100] systemd-journald[97]: Received SIGTERM from PID 1 (systemd-shutdow).
[ 171.420616] systemd-udevd[123]: giving up waiting for workers to finish
[ 171.427420] systemd-udevd[123]: event loop failed: Connection timed out
[ 230.583761] systemd-shutdown[1]: Sending SIGKILL to remaining processes...
[ 230.600640] systemd-shutdown[1]: Sending SIGKILL to PID 132 (systemd-udevd).
[ 242.721690] INFO: task kworker/0:2:60 blocked for more than 120 seconds.
[ 242.728453] Not tainted 4.11.3-1-ARCH #1
[ 242.732927] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.740804] kworker/0:2 D 0 60 2 0x00000000
[ 242.746358] Workqueue: events_power_efficient power_supply_deferred_register_work
[ 242.753916] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 242.761021] [<c07e415d>] (schedule) from [<c07e42cb>] (schedule_preempt_disabled+0xf/0x10)
[ 242.769347] [<c07e42cb>] (schedule_preempt_disabled) from [<c07e5183>] (__mutex_lock.constprop.4+0xdf/0x284)
[ 242.779251] [<c07e5183>] (__mutex_lock.constprop.4) from [<c0685e77>] (power_supply_deferred_register_work+0x17/0x2c)
[ 242.789942] [<c0685e77>] (power_supply_deferred_register_work) from [<c013594b>] (process_one_work+0xef/0x2a8)
[ 242.800012] [<c013594b>] (process_one_work) from [<c0135be5>] (worker_thread+0xe1/0x3c0)
[ 242.808161] [<c0135be5>] (worker_thread) from [<c0139cfb>] (kthread+0xdb/0x100)
[ 242.815531] [<c0139cfb>] (kthread) from [<c0106871>] (ret_from_fork+0x11/0x20)
[ 242.822815] INFO: task systemd-udevd:132 blocked for more than 120 seconds.
[ 242.829824] Not tainted 4.11.3-1-ARCH #1
[ 242.834296] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.842171] systemd-udevd D 0 132 1 0x00000081
[ 242.847709] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 242.854811] [<c07e415d>] (schedule) from [<c07e63b3>] (schedule_timeout+0x1ab/0x240)
[ 242.862611] [<c07e63b3>] (schedule_timeout) from [<c07e48e5>] (wait_for_common+0xa5/0x114)
[ 242.870934] [<c07e48e5>] (wait_for_common) from [<c0134901>] (flush_work+0xa1/0x118)
[ 242.878735] [<c0134901>] (flush_work) from [<c01357b1>] (__cancel_work_timer+0xad/0x140)
[ 242.886882] [<c01357b1>] (__cancel_work_timer) from [<c0685f9f>] (power_supply_unregister+0x37/0x94)
[ 242.896087] [<c0685f9f>] (power_supply_unregister) from [<c056cea5>] (release_nodes+0x125/0x1c4)
[ 242.904937] [<c056cea5>] (release_nodes) from [<c056a15f>] (driver_probe_device+0x10b/0x2e0)
[ 242.913432] [<c056a15f>] (driver_probe_device) from [<c056a3cd>] (__driver_attach+0x99/0xa4)
[ 242.921927] [<c056a3cd>] (__driver_attach) from [<c0568a41>] (bus_for_each_dev+0x49/0x74)
[ 242.930162] [<c0568a41>] (bus_for_each_dev) from [<c05698b9>] (bus_add_driver+0xe9/0x1a0)
[ 242.938398] [<c05698b9>] (bus_add_driver) from [<c056ab09>] (driver_register+0x39/0x8c)
[ 242.946482] [<c056ab09>] (driver_register) from [<bf8fe017>] (tps65217_charger_driver_init+0x16/0xfff [tps65217_charger])
[ 242.957528] [<bf8fe017>] (tps65217_charger_driver_init [tps65217_charger]) from [<c01015b7>] (do_one_initcall+0x43/0x128)
[ 242.968566] [<c01015b7>] (do_one_initcall) from [<c01c717d>] (do_init_module+0x4d/0x340)
[ 242.976723] [<c01c717d>] (do_init_module) from [<c01757c9>] (load_module+0x16d9/0x1b70)
[ 242.984788] [<c01757c9>] (load_module) from [<c0175d53>] (SyS_init_module+0xf3/0x13c)
[ 242.992674] [<c0175d53>] (SyS_init_module) from [<c0106941>] (__sys_trace_return+0x1/0xc)
[ 320.611203] systemd-shutdown[1]: Unmounting file systems.
[ 320.617933] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[ 320.698458] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=ordered
[ 320.709948] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[ 320.719196] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=ordered
[ 320.725211] systemd-shutdown[1]: All filesystems unmounted.
[ 320.730859] systemd-shutdown[1]: Deactivating swaps.
[ 320.736161] systemd-shutdown[1]: All swaps deactivated.
[ 320.741468] systemd-shutdown[1]: Detaching loop devices.
[ 320.752431] systemd-shutdown[1]: All loop devices detached.
[ 320.758124] systemd-shutdown[1]: Detaching DM devices.
[ 320.763967] systemd-shutdown[1]: All DM devices detached.
[ 320.870376] shutdown: 2 output lines suppressed due to ratelimiting
[ 320.901900] shutdown[1]: Sending SIGTERM to remaining processes...
[ 363.555038] INFO: task kworker/0:2:60 blocked for more than 120 seconds.
[ 363.561807] Not tainted 4.11.3-1-ARCH #1
[ 363.566282] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 363.574158] kworker/0:2 D 0 60 2 0x00000000
[ 363.579714] Workqueue: events_power_efficient power_supply_deferred_register_work
[ 363.587270] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 363.594372] [<c07e415d>] (schedule) from [<c07e42cb>] (schedule_preempt_disabled+0xf/0x10)
[ 363.602696] [<c07e42cb>] (schedule_preempt_disabled) from [<c07e5183>] (__mutex_lock.constprop.4+0xdf/0x284)
[ 363.612590] [<c07e5183>] (__mutex_lock.constprop.4) from [<c0685e77>] (power_supply_deferred_register_work+0x17/0x2c)
[ 363.623277] [<c0685e77>] (power_supply_deferred_register_work) from [<c013594b>] (process_one_work+0xef/0x2a8)
[ 363.633347] [<c013594b>] (process_one_work) from [<c0135be5>] (worker_thread+0xe1/0x3c0)
[ 363.641498] [<c0135be5>] (worker_thread) from [<c0139cfb>] (kthread+0xdb/0x100)
[ 363.648869] [<c0139cfb>] (kthread) from [<c0106871>] (ret_from_fork+0x11/0x20)
[ 363.656155] INFO: task systemd-udevd:132 blocked for more than 120 seconds.
[ 363.663160] Not tainted 4.11.3-1-ARCH #1
[ 363.667632] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 363.675504] systemd-udevd D 0 132 1 0x00000081
[ 363.681042] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 363.688143] [<c07e415d>] (schedule) from [<c07e63b3>] (schedule_timeout+0x1ab/0x240)
[ 363.695942] [<c07e63b3>] (schedule_timeout) from [<c07e48e5>] (wait_for_common+0xa5/0x114)
[ 363.704264] [<c07e48e5>] (wait_for_common) from [<c0134901>] (flush_work+0xa1/0x118)
[ 363.712062] [<c0134901>] (flush_work) from [<c01357b1>] (__cancel_work_timer+0xad/0x140)
[ 363.720213] [<c01357b1>] (__cancel_work_timer) from [<c0685f9f>] (power_supply_unregister+0x37/0x94)
[ 363.729421] [<c0685f9f>] (power_supply_unregister) from [<c056cea5>] (release_nodes+0x125/0x1c4)
[ 363.738268] [<c056cea5>] (release_nodes) from [<c056a15f>] (driver_probe_device+0x10b/0x2e0)
[ 363.746764] [<c056a15f>] (driver_probe_device) from [<c056a3cd>] (__driver_attach+0x99/0xa4)
[ 363.755269] [<c056a3cd>] (__driver_attach) from [<c0568a41>] (bus_for_each_dev+0x49/0x74)
[ 363.763507] [<c0568a41>] (bus_for_each_dev) from [<c05698b9>] (bus_add_driver+0xe9/0x1a0)
[ 363.771742] [<c05698b9>] (bus_add_driver) from [<c056ab09>] (driver_register+0x39/0x8c)
[ 363.779827] [<c056ab09>] (driver_register) from [<bf8fe017>] (tps65217_charger_driver_init+0x16/0xfff [tps65217_charger])
[ 363.790864] [<bf8fe017>] (tps65217_charger_driver_init [tps65217_charger]) from [<c01015b7>] (do_one_initcall+0x43/0x128)
[ 363.801903] [<c01015b7>] (do_one_initcall) from [<c01c717d>] (do_init_module+0x4d/0x340)
[ 363.810060] [<c01c717d>] (do_init_module) from [<c01757c9>] (load_module+0x16d9/0x1b70)
[ 363.818123] [<c01757c9>] (load_module) from [<c0175d53>] (SyS_init_module+0xf3/0x13c)
[ 363.826010] [<c0175d53>] (SyS_init_module) from [<c0106941>] (__sys_trace_return+0x1/0xc)
[ 410.919910] shutdown[1]: Sending SIGKILL to remaining processes...
[ 410.935774] shutdown[1]: Sending SIGKILL to PID 132 (systemd-udevd).
[ 484.388141] INFO: task kworker/0:2:60 blocked for more than 120 seconds.
[ 484.394906] Not tainted 4.11.3-1-ARCH #1
[ 484.399380] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.407256] kworker/0:2 D 0 60 2 0x00000000
[ 484.412811] Workqueue: events_power_efficient power_supply_deferred_register_work
[ 484.420371] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 484.427474] [<c07e415d>] (schedule) from [<c07e42cb>] (schedule_preempt_disabled+0xf/0x10)
[ 484.435799] [<c07e42cb>] (schedule_preempt_disabled) from [<c07e5183>] (__mutex_lock.constprop.4+0xdf/0x284)
[ 484.445692] [<c07e5183>] (__mutex_lock.constprop.4) from [<c0685e77>] (power_supply_deferred_register_work+0x17/0x2c)
[ 484.456380] [<c0685e77>] (power_supply_deferred_register_work) from [<c013594b>] (process_one_work+0xef/0x2a8)
[ 484.466450] [<c013594b>] (process_one_work) from [<c0135be5>] (worker_thread+0xe1/0x3c0)
[ 484.474598] [<c0135be5>] (worker_thread) from [<c0139cfb>] (kthread+0xdb/0x100)
[ 484.481966] [<c0139cfb>] (kthread) from [<c0106871>] (ret_from_fork+0x11/0x20)
[ 484.489251] INFO: task systemd-udevd:132 blocked for more than 120 seconds.
[ 484.496256] Not tainted 4.11.3-1-ARCH #1
[ 484.500728] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.508601] systemd-udevd D 0 132 1 0x00000081
[ 484.514139] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 484.521241] [<c07e415d>] (schedule) from [<c07e63b3>] (schedule_timeout+0x1ab/0x240)
[ 484.529052] [<c07e63b3>] (schedule_timeout) from [<c07e48e5>] (wait_for_common+0xa5/0x114)
[ 484.537377] [<c07e48e5>] (wait_for_common) from [<c0134901>] (flush_work+0xa1/0x118)
[ 484.545177] [<c0134901>] (flush_work) from [<c01357b1>] (__cancel_work_timer+0xad/0x140)
[ 484.553326] [<c01357b1>] (__cancel_work_timer) from [<c0685f9f>] (power_supply_unregister+0x37/0x94)
[ 484.562531] [<c0685f9f>] (power_supply_unregister) from [<c056cea5>] (release_nodes+0x125/0x1c4)
[ 484.571381] [<c056cea5>] (release_nodes) from [<c056a15f>] (driver_probe_device+0x10b/0x2e0)
[ 484.579876] [<c056a15f>] (driver_probe_device) from [<c056a3cd>] (__driver_attach+0x99/0xa4)
[ 484.588370] [<c056a3cd>] (__driver_attach) from [<c0568a41>] (bus_for_each_dev+0x49/0x74)
[ 484.596605] [<c0568a41>] (bus_for_each_dev) from [<c05698b9>] (bus_add_driver+0xe9/0x1a0)
[ 484.604838] [<c05698b9>] (bus_add_driver) from [<c056ab09>] (driver_register+0x39/0x8c)
[ 484.612921] [<c056ab09>] (driver_register) from [<bf8fe017>] (tps65217_charger_driver_init+0x16/0xfff [tps65217_charger])
[ 484.623957] [<bf8fe017>] (tps65217_charger_driver_init [tps65217_charger]) from [<c01015b7>] (do_one_initcall+0x43/0x128)
[ 484.634997] [<c01015b7>] (do_one_initcall) from [<c01c717d>] (do_init_module+0x4d/0x340)
[ 484.643152] [<c01c717d>] (do_init_module) from [<c01757c9>] (load_module+0x16d9/0x1b70)
[ 484.651213] [<c01757c9>] (load_module) from [<c0175d53>] (SyS_init_module+0xf3/0x13c)
[ 484.659098] [<c0175d53>] (SyS_init_module) from [<c0106941>] (__sys_trace_return+0x1/0xc)
[ 500.944137] shutdown[1]: Unmounting file systems.
[ 500.950387] shutdown[1]: Remounting '/' read-only with options 'mode=755'.
[ 500.958518] shutdown[1]: Remounting '/oldroot/sys/kernel/debug' read-only with options ''.
[ 500.968004] shutdown[1]: Unmounting /oldroot/sys/kernel/debug.
[ 500.973974] shutdown[1]: Remounting '/oldroot/sys/fs/fuse/connections' read-only with options ''.
[ 500.984053] shutdown[1]: Unmounting /oldroot/sys/fs/fuse/connections.
[ 500.990606] shutdown[1]: Remounting '/oldroot/sys/kernel/config' read-only with options ''.
[ 501.000147] shutdown[1]: Unmounting /oldroot/sys/kernel/config.
[ 501.006171] shutdown[1]: Remounting '/oldroot/dev/mqueue' read-only with options ''.
[ 501.015100] shutdown[1]: Unmounting /oldroot/dev/mqueue.
[ 501.059380] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=ordered
[ 501.069009] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=ordered
[ 501.078549] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=ordered
[ 501.090188] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=ordered
[ 501.100408] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=ordered
[ 605.221219] INFO: task kworker/0:2:60 blocked for more than 120 seconds.
[ 605.227986] Not tainted 4.11.3-1-ARCH #1
[ 605.232460] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 605.240337] kworker/0:2 D 0 60 2 0x00000000
[ 605.245895] Workqueue: events_power_efficient power_supply_deferred_register_work
[ 605.253454] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 605.260556] [<c07e415d>] (schedule) from [<c07e42cb>] (schedule_preempt_disabled+0xf/0x10)
[ 605.268881] [<c07e42cb>] (schedule_preempt_disabled) from [<c07e5183>] (__mutex_lock.constprop.4+0xdf/0x284)
[ 605.278775] [<c07e5183>] (__mutex_lock.constprop.4) from [<c0685e77>] (power_supply_deferred_register_work+0x17/0x2c)
[ 605.289462] [<c0685e77>] (power_supply_deferred_register_work) from [<c013594b>] (process_one_work+0xef/0x2a8)
[ 605.299540] [<c013594b>] (process_one_work) from [<c0135be5>] (worker_thread+0xe1/0x3c0)
[ 605.307696] [<c0135be5>] (worker_thread) from [<c0139cfb>] (kthread+0xdb/0x100)
[ 605.315067] [<c0139cfb>] (kthread) from [<c0106871>] (ret_from_fork+0x11/0x20)
[ 605.322358] INFO: task systemd-udevd:132 blocked for more than 120 seconds.
[ 605.329363] Not tainted 4.11.3-1-ARCH #1
[ 605.333836] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 605.341710] systemd-udevd D 0 132 1 0x00000081
[ 605.347248] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 605.354352] [<c07e415d>] (schedule) from [<c07e63b3>] (schedule_timeout+0x1ab/0x240)
[ 605.362151] [<c07e63b3>] (schedule_timeout) from [<c07e48e5>] (wait_for_common+0xa5/0x114)
[ 605.370473] [<c07e48e5>] (wait_for_common) from [<c0134901>] (flush_work+0xa1/0x118)
[ 605.378271] [<c0134901>] (flush_work) from [<c01357b1>] (__cancel_work_timer+0xad/0x140)
[ 605.386420] [<c01357b1>] (__cancel_work_timer) from [<c0685f9f>] (power_supply_unregister+0x37/0x94)
[ 605.395625] [<c0685f9f>] (power_supply_unregister) from [<c056cea5>] (release_nodes+0x125/0x1c4)
[ 605.404474] [<c056cea5>] (release_nodes) from [<c056a15f>] (driver_probe_device+0x10b/0x2e0)
[ 605.412969] [<c056a15f>] (driver_probe_device) from [<c056a3cd>] (__driver_attach+0x99/0xa4)
[ 605.421463] [<c056a3cd>] (__driver_attach) from [<c0568a41>] (bus_for_each_dev+0x49/0x74)
[ 605.429697] [<c0568a41>] (bus_for_each_dev) from [<c05698b9>] (bus_add_driver+0xe9/0x1a0)
[ 605.437930] [<c05698b9>] (bus_add_driver) from [<c056ab09>] (driver_register+0x39/0x8c)
[ 605.446013] [<c056ab09>] (driver_register) from [<bf8fe017>] (tps65217_charger_driver_init+0x16/0xfff [tps65217_charger])
[ 605.457048] [<bf8fe017>] (tps65217_charger_driver_init [tps65217_charger]) from [<c01015b7>] (do_one_initcall+0x43/0x128)
[ 605.468088] [<c01015b7>] (do_one_initcall) from [<c01c717d>] (do_init_module+0x4d/0x340)
[ 605.476242] [<c01c717d>] (do_init_module) from [<c01757c9>] (load_module+0x16d9/0x1b70)
[ 605.484303] [<c01757c9>] (load_module) from [<c0175d53>] (SyS_init_module+0xf3/0x13c)
[ 605.492193] [<c0175d53>] (SyS_init_module) from [<c0106941>] (__sys_trace_return+0x1/0xc)
[ 726.054239] INFO: task shutdown:1 blocked for more than 120 seconds.
[ 726.060650] Not tainted 4.11.3-1-ARCH #1
[ 726.065125] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 726.073000] shutdown D 0 1 0 0x00000000
[ 726.078554] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 726.085656] [<c07e415d>] (schedule) from [<c07e42cb>] (schedule_preempt_disabled+0xf/0x10)
[ 726.093978] [<c07e42cb>] (schedule_preempt_disabled) from [<c07e5183>] (__mutex_lock.constprop.4+0xdf/0x284)
[ 726.103870] [<c07e5183>] (__mutex_lock.constprop.4) from [<c05687c3>] (device_shutdown+0x6b/0x110)
[ 726.112900] [<c05687c3>] (device_shutdown) from [<c013bdd3>] (kernel_power_off+0x2f/0x60)
[ 726.121137] [<c013bdd3>] (kernel_power_off) from [<c013bf97>] (SyS_reboot+0x14f/0x198)
[ 726.129113] [<c013bf97>] (SyS_reboot) from [<c01067a1>] (ret_fast_syscall+0x1/0x4c)
[ 726.136844] INFO: task kworker/0:2:60 blocked for more than 120 seconds.
[ 726.143587] Not tainted 4.11.3-1-ARCH #1
[ 726.148060] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 726.155933] kworker/0:2 D 0 60 2 0x00000000
[ 726.161471] Workqueue: events_power_efficient power_supply_deferred_register_work
[ 726.169013] [<c07e3d19>] (__schedule) from [<c07e415d>] (schedule+0x31/0x64)
[ 726.176113] [<c07e415d>] (schedule) from [<c07e42cb>] (schedule_preempt_disabled+0xf/0x10)
[ 726.184435] [<c07e42cb>] (schedule_preempt_disabled) from [<c07e5183>] (__mutex_lock.constprop.4+0xdf/0x284)
[ 726.194327] [<c07e5183>] (__mutex_lock.constprop.4) from [<c0685e77>] (power_supply_deferred_register_work+0x17/0x2c)
[ 726.205009] [<c0685e77>] (power_supply_deferred_register_work) from [<c013594b>] (process_one_work+0xef/0x2a8)
[ 726.215076] [<c013594b>] (process_one_work) from [<c0135be5>] (worker_thread+0xe1/0x3c0)
[ 726.223221] [<c0135be5>] (worker_thread) from [<c0139cfb>] (kthread+0xdb/0x100)
[ 726.230582] [<c0139cfb>] (kthread) from [<c0106871>] (ret_from_fork+0x11/0x20)')

EDIT:
Downgrading the kernel to `linux-am33x-4.10.9-1` solves the problem while downgrading to `linux-am33x-4.11.0-1` does not. So the issue is with 4.11.
vide
 
Posts: 1
Joined: Sat May 24, 2014 11:10 am

Re: after upgrade shutdown/reboot hangs

Postby bulletmark » Mon Jun 19, 2017 11:06 pm

Thanks for this post. I discovered it after posting at viewtopic.php?f=48&t=11797.

Today's update of linux-am33x to 4.11.5-2 doesn't fix the problem (edit: nor 4.11.6-1). Where would we search for or report this bug?
bulletmark
 
Posts: 98
Joined: Tue Oct 13, 2015 10:17 pm

Re: after upgrade shutdown/reboot hangs

Postby bulletmark » Wed Aug 16, 2017 10:53 pm

bulletmark
 
Posts: 98
Joined: Tue Oct 13, 2015 10:17 pm


Return to General

Who is online

Users browsing this forum: Google [Bot] and 6 guests