# tracer: nop # # entries-in-buffer/entries-written: 39908/39908 #P:4 # # _-----=> irqs-off # / _----=> need-resched # | / _---=> hardirq/softirq # || / _--=> preempt-depth # ||| / delay # TASK-PID CPU# |||| TIMESTAMP FUNCTION # | | | |||| | | mmcqd/0-89 [000] ...1 1384.282406: mmc_request_start: mmc0: start struct mmc_request[c669d954]: cmd_opcode=25 cmd_arg=0x480dc0 cmd_flags=0xb5 cmd_retries=0 stop_opcode=12 stop_arg=0x0 stop_flags=0x49d stop_retries=0 sbc_opcode=23 sbc_arg=0x80000008 sbc_flags=0x15 sbc_retires=0 blocks=8 block_size=512 data_flags=0x100 can_retune=0 doing_retune=0 retune_now=0 need_retune=0 hold_retune=1 retune_period=0 mmcqd/0-89 [000] d..3 1384.282424: sched_stat_runtime: comm=mmcqd/0 pid=89 runtime=53666 [ns] vruntime=40997151704 [ns] mmcqd/0-89 [000] d..3 1384.282432: sched_switch: prev_comm=mmcqd/0 prev_pid=89 prev_prio=120 prev_state=S ==> next_comm=swapper/0 next_pid=0 next_prio=120 -0 [001] d.s3 1384.306588: workqueue_queue_work: work struct=c61ac608 function=thermal_zone_device_check workqueue=c60a8000 req_cpu=1 cpu=1 -0 [001] d.s3 1384.306591: workqueue_activate_work: work struct c61ac608 -0 [001] dns5 1384.306598: sched_wakeup: comm=kworker/1:2 pid=1582 prio=120 success=1 target_cpu=001 -0 [001] d..3 1384.306615: sched_switch: prev_comm=swapper/1 prev_pid=0 prev_prio=120 prev_state=R ==> next_comm=kworker/1:2 next_pid=1582 next_prio=120 kworker/1:2-1582 [001] ...1 1384.306620: workqueue_execute_start: work struct c61ac608: function thermal_zone_device_check kworker/1:2-1582 [001] ...1 1384.306643: workqueue_execute_end: work struct c61ac608 kworker/1:2-1582 [001] d..3 1384.306650: sched_stat_runtime: comm=kworker/1:2 pid=1582 runtime=54000 [ns] vruntime=31675404660 [ns] kworker/1:2-1582 [001] d..3 1384.306653: sched_switch: prev_comm=kworker/1:2 prev_pid=1582 prev_prio=120 prev_state=S ==> next_comm=swapper/1 next_pid=0 next_prio=120 -0 [003] dnh6 1384.441908: sched_wakeup: comm=systemd pid=1 prio=120 success=1 target_cpu=003 -0 [003] d..3 1384.441924: sched_switch: prev_comm=swapper/3 prev_pid=0 prev_prio=120 prev_state=R ==> next_comm=systemd next_pid=1 next_prio=120 systemd-1 [003] d..3 1384.442047: sched_stat_runtime: comm=systemd pid=1 runtime=140334 [ns] vruntime=30781676775 [ns] systemd-1 [003] d..3 1384.442053: sched_switch: prev_comm=systemd prev_pid=1 prev_prio=120 prev_state=S ==> next_comm=swapper/3 next_pid=0 next_prio=120 -0 [000] d.s3 1384.466583: workqueue_queue_work: work struct=c63c21ac function=fb_flashcursor workqueue=c60a8100 req_cpu=4 cpu=0 -0 [000] d.s3 1384.466585: workqueue_activate_work: work struct c63c21ac -0 [000] dns5 1384.466592: sched_wakeup: comm=kworker/0:1 pid=1572 prio=120 success=1 target_cpu=000 -0 [000] d..3 1384.466612: sched_switch: prev_comm=swapper/0 prev_pid=0 prev_prio=120 prev_state=R ==> next_comm=kworker/0:1 next_pid=1572 next_prio=120 kworker/0:1-1572 [000] ...1 1384.466616: workqueue_execute_start: work struct c63c21ac: function fb_flashcursor kworker/0:1-1572 [000] ...1 1384.466621: workqueue_execute_end: work struct c63c21ac kworker/0:1-1572 [000] d..3 1384.466626: sched_stat_runtime: comm=kworker/0:1 pid=1572 runtime=36000 [ns] vruntime=40988187704 [ns] kworker/0:1-1572 [000] d..3 1384.466630: sched_switch: prev_comm=kworker/0:1 prev_pid=1572 prev_prio=120 prev_state=S ==> next_comm=swapper/0 next_pid=0 next_prio=120 -0 [000] d.s3 1384.506577: workqueue_queue_work: work struct=c64cf1f8 function=phy_state_machine workqueue=c60a8100 req_cpu=0 cpu=0 -0 [000] d.s3 1384.506580: workqueue_activate_work: work struct c64cf1f8 -0 [000] dns5 1384.506585: sched_wakeup: comm=kworker/0:1 pid=1572 prio=120 success=1 target_cpu=000 -0 [000] d..3 1384.506602: sched_switch: prev_comm=swapper/0 prev_pid=0 prev_prio=120 prev_state=R ==> next_comm=kworker/0:1 next_pid=1572 next_prio=120 kworker/0:1-1572 [000] ...1 1384.506606: workqueue_execute_start: work struct c64cf1f8: function phy_state_machine kworker/0:1-1572 [000] ...1 1384.506610: workqueue_execute_end: work struct c64cf1f8 kworker/0:1-1572 [000] d..3 1384.506614: sched_stat_runtime: comm=kworker/0:1 pid=1572 runtime=31333 [ns] vruntime=40988219037 [ns] kworker/0:1-1572 [000] d..3 1384.506618: sched_switch: prev_comm=kworker/0:1 prev_pid=1572 prev_prio=120 prev_state=S ==> next_comm=swapper/0 next_pid=0 next_prio=120 -0 [000] ..s2 1384.550637: mmc_request_done: mmc0: end struct mmc_request[c669d954]: cmd_opcode=25 cmd_err=0 cmd_resp=0x900 0xc7a4023c 0x0 0x0 cmd_retries=0 stop_opcode=12 stop_err=0 stop_resp=0x0 0x0 0x0 0x0 stop_retries=0 sbc_opcode=23 sbc_err=0 sbc_resp=0x0 0x0 0x0 0x0 sbc_retries=0 bytes_xfered=4096 data_err=0 can_retune=0 doing_retune=0 retune_now=0 need_retune=0 hold_retune=1 retune_period=0 -0 [000] dns5 1384.550644: sched_wakeup: comm=mmcqd/0 pid=89 prio=120 success=1 target_cpu=000 -0 [000] d..3 1384.550657: sched_switch: prev_comm=swapper/0 prev_pid=0 prev_prio=120 prev_state=R ==> next_comm=mmcqd/0 next_pid=89 next_prio=120