[58.290779] Initializing watchdogs [58.290824] /dev/watchdog0 [58.299267] [001/130] (960s left) kms_cursor_crc (cursor-offscreen-32x32) [58.448681] Starting subtest: cursor-offscreen-32x32 [58.493363] Subtest cursor-offscreen-32x32: SKIP (0.039s) [58.751319] [002/130] (960s left) gem_exec_reloc (basic-cpu-noreloc) [58.818503] Subtest basic-cpu-noreloc: SKIP (0.000s) [58.880914] [003/130] (959s left) gem_ctx_isolation (dirty-switch) [58.943271] Starting subtest: dirty-switch [58.945286] Starting dynamic subtest: rcs0 [59.136798] Dynamic subtest rcs0: SUCCESS (0.192s) [59.143153] Starting dynamic subtest: bcs0 [59.346312] Dynamic subtest bcs0: SUCCESS (0.208s) [59.352305] Starting dynamic subtest: vcs0 [59.567576] Dynamic subtest vcs0: SUCCESS (0.220s) [59.575987] Starting dynamic subtest: vcs1 [61.129789] Dynamic subtest vcs1: SUCCESS (1.555s) [61.138376] Starting dynamic subtest: vecs0 [63.189729] Dynamic subtest vecs0: SUCCESS (2.052s) [63.195537] Starting dynamic subtest: ccs0 [65.172806] Dynamic subtest ccs0: SUCCESS (1.979s) [65.175255] Subtest dirty-switch: SUCCESS (6.207s) [65.401228] [004/130] (953s left) gem_render_copy (x-tiled) [65.455906] Starting subtest: x-tiled [65.458365] Starting dynamic subtest: smem [65.501075] Dynamic subtest smem: SUCCESS (0.045s) [65.503944] Subtest x-tiled: SUCCESS (0.045s) [65.703121] [005/130] (953s left) kms_big_fb (4-tiled-16bpp-rotate-90) [65.815792] Starting subtest: 4-tiled-16bpp-rotate-90 [65.844305] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.027s) [65.931938] [006/130] (952s left) kms_flip (absolute-wf_vblank) [66.036224] Starting subtest: absolute-wf_vblank [66.038610] Starting dynamic subtest: A-eDP1 [74.818090] Dynamic subtest A-eDP1: SUCCESS (8.771s) [74.826485] Starting dynamic subtest: B-eDP1 [83.551191] Dynamic subtest B-eDP1: SUCCESS (8.729s) [83.560298] Starting dynamic subtest: C-eDP1 [92.263910] Dynamic subtest C-eDP1: SUCCESS (8.710s) [92.272136] Starting dynamic subtest: D-eDP1 [100.987621] Dynamic subtest D-eDP1: SUCCESS (8.722s) [100.989912] Subtest absolute-wf_vblank: SUCCESS (34.938s) [102.181228] [007/130] (916s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [102.568382] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [103.383194] [008/130] (915s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [103.488042] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [106.561605] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (3.076s) [106.653717] [009/130] (912s left) kms_pm_rpm (universal-planes-dpms) [108.176426] Starting subtest: universal-planes-dpms [108.179588] Starting dynamic subtest: plane-32 [116.751073] Dynamic subtest plane-32: SUCCESS (8.573s) [116.760950] Starting dynamic subtest: plane-41 [125.002780] Dynamic subtest plane-41: SUCCESS (8.251s) [125.010608] Starting dynamic subtest: plane-50 [133.576370] Dynamic subtest plane-50: SUCCESS (8.573s) [133.586040] Starting dynamic subtest: plane-59 [141.879671] Dynamic subtest plane-59: SUCCESS (8.303s) [141.891698] Starting dynamic subtest: plane-68 [150.446017] Dynamic subtest plane-68: SUCCESS (8.566s) [150.455024] Starting dynamic subtest: plane-77 [158.713160] Dynamic subtest plane-77: SUCCESS (8.266s) [158.715972] Subtest universal-planes-dpms: SUCCESS (50.534s) [159.040867] [010/130] (859s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [159.151541] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [160.018653] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.867s) [160.152912] [011/130] (858s left) gem_readwrite (new-obj) [160.215324] Subtest new-obj: SKIP (0.000s) [160.273454] [012/130] (858s left) gem_mmap_gtt (big-copy) [160.341860] Subtest big-copy: SKIP (0.000s) [160.386814] [013/130] (858s left) gem_wait (await) [160.457444] Starting subtest: await [160.459566] Starting dynamic subtest: all-engines [161.613995] Dynamic subtest all-engines: SUCCESS (1.155s) [161.628724] Starting dynamic subtest: rcs0 [162.670283] Dynamic subtest rcs0: SUCCESS (1.056s) [162.682517] Starting dynamic subtest: bcs0 [163.725815] Dynamic subtest bcs0: SUCCESS (1.055s) [163.737921] Starting dynamic subtest: vcs0 [164.776183] Dynamic subtest vcs0: SUCCESS (1.050s) [164.789775] Starting dynamic subtest: vcs1 [165.828308] Dynamic subtest vcs1: SUCCESS (1.052s) [165.842395] Starting dynamic subtest: vecs0 [166.881596] Dynamic subtest vecs0: SUCCESS (1.053s) [166.894289] Starting dynamic subtest: ccs0 [167.939365] Dynamic subtest ccs0: SUCCESS (1.058s) [167.941949] Subtest await: SUCCESS (7.481s) [168.118148] [014/130] (850s left) kms_prop_blob (invalid-get-prop-any) [168.176090] Starting subtest: invalid-get-prop-any [168.178140] Subtest invalid-get-prop-any: SUCCESS (0.000s) [168.253837] [015/130] (850s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [168.349975] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [168.352384] Starting dynamic subtest: pipe-A-eDP-1 [169.166132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.807s) [169.172554] Starting dynamic subtest: pipe-B-eDP-1 [170.691897] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s) [170.698415] Starting dynamic subtest: pipe-C-eDP-1 [172.149197] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s) [172.156755] Starting dynamic subtest: pipe-D-eDP-1 [173.596372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.447s) [173.598313] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.236s) [174.744820] [016/130] (844s left) gem_ctx_isolation (nonpriv) [174.812691] Starting subtest: nonpriv [174.815224] Starting dynamic subtest: rcs0 [175.045264] Dynamic subtest rcs0: SUCCESS (0.233s) [175.052608] Starting dynamic subtest: bcs0 [175.305867] Dynamic subtest bcs0: SUCCESS (0.260s) [175.312935] Starting dynamic subtest: vcs0 [175.521819] Dynamic subtest vcs0: SUCCESS (0.216s) [175.531031] Starting dynamic subtest: vcs1 [177.155060] Dynamic subtest vcs1: SUCCESS (1.632s) [177.164265] Starting dynamic subtest: vecs0 [179.184905] Dynamic subtest vecs0: SUCCESS (2.030s) [179.192665] Starting dynamic subtest: ccs0 [181.184784] Dynamic subtest ccs0: SUCCESS (1.999s) [181.187267] Subtest nonpriv: SUCCESS (6.372s) [181.416691] [017/130] (837s left) kms_plane_multiple (tiling-yf) [181.521100] Starting subtest: tiling-yf [181.525797] Subtest tiling-yf: SKIP (0.000s) [181.573078] [018/130] (837s left) kms_vblank (wait-busy) [181.661974] Starting subtest: wait-busy [181.664531] Starting dynamic subtest: pipe-A-eDP-1 [183.549568] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s) [183.563856] Starting dynamic subtest: pipe-D-eDP-1 [186.118597] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s) [186.120912] Subtest wait-busy: SUCCESS (4.454s) [186.889836] [019/130] (832s left) gem_softpin (noreloc-interruptible) [186.955972] Starting subtest: noreloc-interruptible [192.376044] Subtest noreloc-interruptible: SUCCESS (5.418s) [192.488244] [020/130] (826s left) i915_pm_freq_api (freq-suspend) [192.561649] Starting subtest: freq-suspend [192.563977] Starting dynamic subtest: gt0 [209.073546] Dynamic subtest gt0: SUCCESS (1.258s) [209.083800] Starting dynamic subtest: gt1 [224.975951] Dynamic subtest gt1: SUCCESS (1.107s) [224.988598] Subtest freq-suspend: SUCCESS (2.366s) [226.040279] [021/130] (824s left) gem_eio (in-flight-10ms) [226.263459] Starting subtest: in-flight-10ms [234.722292] Subtest in-flight-10ms: SUCCESS (8.380s) [234.864951] [022/130] (815s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [234.978180] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [234.982125] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [235.071376] [023/130] (815s left) syncobj_wait (multi-wait-all-signaled) [235.133554] Starting subtest: multi-wait-all-signaled [235.135743] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [235.212469] [024/130] (815s left) gem_exec_schedule (u-semaphore-user) [235.282912] Starting subtest: u-semaphore-user [235.334287] Subtest u-semaphore-user: SUCCESS (0.056s) [237.018613] [025/130] (813s left) gem_exec_schedule (preempt-contexts) [237.096424] Starting subtest: preempt-contexts [237.098636] Starting dynamic subtest: rcs0 [237.139518] Dynamic subtest rcs0: SUCCESS (0.050s) [237.148397] Starting dynamic subtest: bcs0 [237.189696] Dynamic subtest bcs0: SUCCESS (0.050s) [237.200371] Starting dynamic subtest: vcs0 [237.232722] Dynamic subtest vcs0: SUCCESS (0.041s) [237.240642] Starting dynamic subtest: vcs1 [237.277084] Dynamic subtest vcs1: SUCCESS (0.046s) [237.284766] Starting dynamic subtest: vecs0 [237.324318] Dynamic subtest vecs0: SUCCESS (0.044s) [237.332629] Starting dynamic subtest: ccs0 [237.375658] Dynamic subtest ccs0: SUCCESS (0.053s) [237.377960] Subtest preempt-contexts: SUCCESS (0.286s) [239.086253] [026/130] (811s left) kms_psr (psr2-sprite-plane-move) [239.201986] Starting subtest: psr2-sprite-plane-move [239.204231] Starting dynamic subtest: eDP-1 [240.917784] Dynamic subtest eDP-1: SUCCESS (1.708s) [240.920007] Subtest psr2-sprite-plane-move: SUCCESS (1.708s) [241.732561] [027/130] (808s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [246.709432] Starting subtest: pr-cursor-plane-move-continuous-sf [246.714211] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [247.530712] [028/130] (802s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [247.628974] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [247.631255] Starting dynamic subtest: pipe-A-default-mode [247.924458] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [247.929226] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.285s) [248.755681] [029/130] (801s left) kms_cursor_crc (cursor-dpms) [248.871412] Starting subtest: cursor-dpms [248.873976] Starting dynamic subtest: pipe-A-eDP-1 [251.723827] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.848s) [251.733219] Starting dynamic subtest: pipe-D-eDP-1 [255.268175] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.540s) [255.270427] Subtest cursor-dpms: SUCCESS (6.390s) [256.095934] [030/130] (794s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [256.211966] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [256.216183] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [256.299984] [031/130] (794s left) sysfs_defaults (readonly) [256.365798] Starting subtest: readonly [256.368408] Starting dynamic subtest: vecs0 [256.370835] Dynamic subtest vecs0: SUCCESS (0.000s) [256.380273] Starting dynamic subtest: ccs0 [256.382143] Dynamic subtest ccs0: SUCCESS (0.000s) [256.389238] Starting dynamic subtest: vcs0 [256.391136] Dynamic subtest vcs0: SUCCESS (0.000s) [256.398849] Starting dynamic subtest: bcs0 [256.401293] Dynamic subtest bcs0: SUCCESS (0.000s) [256.415208] Starting dynamic subtest: rcs0 [256.417594] Dynamic subtest rcs0: SUCCESS (0.000s) [256.426915] Starting dynamic subtest: vcs1 [256.428800] Dynamic subtest vcs1: SUCCESS (0.000s) [256.430715] Subtest readonly: SUCCESS (0.003s) [256.446971] [032/130] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [256.552444] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [261.013391] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.465s) [261.154369] [033/130] (789s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [261.265127] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [261.269206] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [261.350844] [034/130] (789s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [261.448787] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [261.453264] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [261.540659] [035/130] (789s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [261.641918] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [261.644170] Starting dynamic subtest: pipe-A [261.659442] Dynamic subtest pipe-A: SKIP (0.011s) [261.668504] Starting dynamic subtest: pipe-B [261.682117] Dynamic subtest pipe-B: SKIP (0.020s) [261.690650] Starting dynamic subtest: pipe-C [261.701063] Dynamic subtest pipe-C: SKIP (0.020s) [261.709043] Starting dynamic subtest: pipe-D [261.722125] Dynamic subtest pipe-D: SKIP (0.020s) [261.726595] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.073s) [261.785568] [036/130] (788s left) kms_busy (extended-modeset-hang-oldfb) [261.888008] Starting subtest: extended-modeset-hang-oldfb [261.890351] Starting dynamic subtest: pipe-A [273.749619] Dynamic subtest pipe-A: SUCCESS (11.855s) [273.760064] Starting dynamic subtest: pipe-D [285.996637] Dynamic subtest pipe-D: SUCCESS (12.241s) [285.999051] Subtest extended-modeset-hang-oldfb: SUCCESS (24.102s) [286.763000] [037/130] (763s left) kms_chamelium_color (degamma) [286.857132] Subtest degamma: SKIP (0.000s) [286.881891] [038/130] (763s left) dumb_buffer (create-clear) [286.941109] Starting subtest: create-clear [321.112574] Subtest create-clear: SUCCESS (34.156s) [321.210863] [039/130] (729s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [321.320713] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [324.161147] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.846s) [324.265345] [040/130] (726s left) kms_flip (2x-busy-flip) [324.373009] Starting subtest: 2x-busy-flip [324.385016] Subtest 2x-busy-flip: SKIP (0.011s) [324.444557] [041/130] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [324.544273] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [324.547704] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [324.638902] [042/130] (726s left) kms_rotation_crc (bad-pixel-format) [324.738552] Starting subtest: bad-pixel-format [324.742313] Subtest bad-pixel-format: SKIP (0.001s) [324.795034] [043/130] (726s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [324.919156] Starting subtest: basic-busy-flip-before-cursor-atomic [324.922919] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [324.996806] [044/130] (725s left) i915_pm_rpm (debugfs-forcewake-user) [327.119423] Starting subtest: debugfs-forcewake-user [338.509779] Subtest debugfs-forcewake-user: SUCCESS (11.393s) [338.841652] [045/130] (712s left) gem_exec_whisper (basic-normal) [338.903467] Starting subtest: basic-normal [343.401452] Subtest basic-normal: SUCCESS (4.496s) [343.568934] [046/130] (707s left) kms_psr (fbc-pr-primary-mmap-cpu) [343.666238] Starting subtest: fbc-pr-primary-mmap-cpu [343.670656] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [343.719616] [047/130] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [343.830560] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [343.835234] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [343.918179] [048/130] (707s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [344.015986] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [347.129937] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (3.118s) [347.278620] [049/130] (703s left) syncobj_timeline (device-submit-unordered) [347.339916] Starting subtest: device-submit-unordered [347.342168] Subtest device-submit-unordered: SUCCESS (0.000s) [347.434900] [050/130] (703s left) kms_psr (psr-cursor-render) [347.533939] Starting subtest: psr-cursor-render [347.536019] Starting dynamic subtest: eDP-1 [349.259135] Dynamic subtest eDP-1: SUCCESS (1.723s) [349.261397] Subtest psr-cursor-render: SUCCESS (1.724s) [350.105718] [051/130] (700s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [350.208519] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [354.646330] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.440s) [354.740608] [052/130] (696s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [354.800869] Starting subtest: multi-wait-for-submit-submitted-signaled [354.803294] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [354.888294] [053/130] (696s left) kms_busy (basic-hang) [354.986003] Starting subtest: basic-hang [354.988300] Starting dynamic subtest: flip-pipe-A [355.588750] Dynamic subtest flip-pipe-A: SUCCESS (0.600s) [355.597990] Starting dynamic subtest: modeset-pipe-A [358.988608] Dynamic subtest modeset-pipe-A: SUCCESS (3.398s) [358.998031] Starting dynamic subtest: flip-pipe-D [360.175732] Dynamic subtest flip-pipe-D: SUCCESS (1.186s) [360.185454] Starting dynamic subtest: modeset-pipe-D [363.614541] Dynamic subtest modeset-pipe-D: SUCCESS (3.437s) [363.617051] Subtest basic-hang: SUCCESS (8.626s) [364.388235] [054/130] (686s left) gem_render_linear_blits (basic) [364.452054] Starting subtest: basic [364.473034] Subtest basic: SUCCESS (0.020s) [364.536556] [055/130] (686s left) kms_sequence (queue-idle) [364.634883] Starting subtest: queue-idle [364.637083] Starting dynamic subtest: pipe-A-eDP-1 [366.433628] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.799s) [366.443546] Starting dynamic subtest: pipe-B-eDP-1 [368.858728] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.424s) [368.868601] Starting dynamic subtest: pipe-C-eDP-1 [371.270405] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.411s) [371.281736] Starting dynamic subtest: pipe-D-eDP-1 [373.704850] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s) [373.707192] Subtest queue-idle: SUCCESS (9.071s) [374.487223] [056/130] (676s left) kms_dsc (dsc-with-bpc) [374.577167] Starting subtest: dsc-with-bpc [374.608159] Subtest dsc-with-bpc: SKIP (0.001s) [374.630135] [057/130] (676s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [374.722763] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [374.725132] Starting dynamic subtest: pipe-A-eDP-1 [374.782346] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [374.790433] Starting dynamic subtest: pipe-B-eDP-1 [374.848546] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [374.859407] Starting dynamic subtest: pipe-C-eDP-1 [374.916893] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [374.925482] Starting dynamic subtest: pipe-D-eDP-1 [374.982424] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [374.986619] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s) [376.836728] [058/130] (674s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [376.934039] Starting subtest: sprite-rotation-90-pos-100-0 [376.938821] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [376.988332] [059/130] (674s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [377.090704] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [382.215239] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.127s) [382.318739] [060/130] (668s left) syncobj_basic (bad-pad-handle-to-fd) [382.388515] Starting subtest: bad-pad-handle-to-fd [382.390666] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [382.482351] [061/130] (668s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [382.586209] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [385.420697] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.837s) [385.528365] [062/130] (665s left) kms_flip (plain-flip-fb-recreate-interruptible) [385.620038] Starting subtest: plain-flip-fb-recreate-interruptible [385.624537] Starting dynamic subtest: A-eDP1 [394.423415] Dynamic subtest A-eDP1: SUCCESS (8.799s) [394.435115] Starting dynamic subtest: B-eDP1 [403.242770] Dynamic subtest B-eDP1: SUCCESS (8.815s) [403.253863] Starting dynamic subtest: C-eDP1 [412.058321] Dynamic subtest C-eDP1: SUCCESS (8.811s) [412.067843] Starting dynamic subtest: D-eDP1 [420.883969] Dynamic subtest D-eDP1: SUCCESS (8.822s) [420.886148] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.256s) [422.034018] [063/130] (629s left) syncobj_wait (wait-any-complex) [422.097361] Starting subtest: wait-any-complex [422.160238] Subtest wait-any-complex: SUCCESS (0.062s) [422.216362] [064/130] (629s left) gem_userptr_blits (unsync-overlap) [422.283603] Subtest unsync-overlap: SKIP (0.000s) [422.409021] [065/130] (628s left) dmabuf_sync_file (import-multiple-read-write) [422.447431] Starting subtest: import-multiple-read-write [422.449768] Subtest import-multiple-read-write: SUCCESS (0.003s) [422.485026] [066/130] (628s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [422.583840] Starting subtest: primary-yf-tiled-reflect-x-90 [422.588476] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [422.639740] [067/130] (628s left) gen9_exec_parse (bb-start-out) [422.710326] Subtest bb-start-out: SKIP (0.000s) [422.775034] [068/130] (628s left) perf_pmu (all-busy-check-all) [422.819229] Starting subtest: all-busy-check-all [423.942335] Subtest all-busy-check-all: SUCCESS (1.122s) [424.039077] [069/130] (627s left) perf_pmu (idle-no-semaphores) [424.082721] Starting subtest: idle-no-semaphores [424.085037] Starting dynamic subtest: rcs0 [424.636237] Dynamic subtest rcs0: SUCCESS (0.555s) [424.648251] Starting dynamic subtest: bcs0 [425.151030] Dynamic subtest bcs0: SUCCESS (0.514s) [425.162213] Starting dynamic subtest: vcs0 [425.676392] Dynamic subtest vcs0: SUCCESS (0.521s) [425.688711] Starting dynamic subtest: vcs1 [426.194244] Dynamic subtest vcs1: SUCCESS (0.515s) [426.206131] Starting dynamic subtest: vecs0 [426.711526] Dynamic subtest vecs0: SUCCESS (0.514s) [426.721600] Starting dynamic subtest: ccs0 [427.228695] Dynamic subtest ccs0: SUCCESS (0.515s) [427.231622] Subtest idle-no-semaphores: SUCCESS (3.148s) [427.324091] [070/130] (624s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [427.377362] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [427.379855] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [427.468855] [071/130] (623s left) prime_self_import (basic-with_one_bo) [427.506818] Starting subtest: basic-with_one_bo [427.520976] Subtest basic-with_one_bo: SUCCESS (0.022s) [427.605344] [072/130] (623s left) kms_lease (implicit-plane-lease) [427.709017] Starting subtest: implicit-plane-lease [427.713927] Subtest implicit-plane-lease: SUCCESS (0.003s) [427.794755] [073/130] (623s left) gem_userptr_blits (stress-mm) [427.867909] Starting subtest: stress-mm [433.239871] Subtest stress-mm: SUCCESS (5.369s) [433.349330] [074/130] (618s left) gem_exec_reloc (basic-write-cpu) [433.405348] Subtest basic-write-cpu: SKIP (0.000s) [433.455832] [075/130] (618s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [433.551778] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [433.554206] Starting dynamic subtest: pipe-A-default-mode [433.836406] Dynamic subtest pipe-A-default-mode: SKIP (0.280s) [433.841102] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.282s) [434.657563] [076/130] (616s left) gem_exec_reloc (basic-write-wc-active) [434.717138] Subtest basic-write-wc-active: SKIP (0.000s) [434.777951] [077/130] (616s left) gem_userptr_blits (input-checking) [434.849458] Starting subtest: input-checking [434.851597] Subtest input-checking: SUCCESS (0.000s) [434.961036] [078/130] (616s left) kms_async_flips (test-time-stamp) [435.048091] Starting subtest: test-time-stamp [435.407771] Starting dynamic subtest: pipe-A-eDP-1 [436.172359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s) [436.535202] Starting dynamic subtest: pipe-B-eDP-1 [437.295081] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s) [437.656676] Starting dynamic subtest: pipe-C-eDP-1 [438.421026] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s) [438.783368] Starting dynamic subtest: pipe-D-eDP-1 [439.542714] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s) [439.545354] Subtest test-time-stamp: SUCCESS (4.491s) [440.676812] [079/130] (610s left) gem_spin_batch (resubmit) [440.742555] Starting subtest: resubmit [440.744919] Starting dynamic subtest: rcs0 [440.749657] Dynamic subtest rcs0: SUCCESS (0.005s) [440.758783] Starting dynamic subtest: bcs0 [440.761333] Dynamic subtest bcs0: SUCCESS (0.002s) [440.772231] Starting dynamic subtest: vcs0 [440.774099] Dynamic subtest vcs0: SUCCESS (0.003s) [440.781920] Starting dynamic subtest: vcs1 [440.783814] Dynamic subtest vcs1: SUCCESS (0.002s) [440.791536] Starting dynamic subtest: vecs0 [440.793432] Dynamic subtest vecs0: SUCCESS (0.002s) [440.801092] Starting dynamic subtest: ccs0 [440.803019] Dynamic subtest ccs0: SUCCESS (0.002s) [440.804935] Subtest resubmit: SUCCESS (0.019s) [440.983233] [080/130] (610s left) gem_exec_balancer (parallel-keep-in-fence) [441.218957] Starting subtest: parallel-keep-in-fence [442.227978] Subtest parallel-keep-in-fence: SUCCESS (1.009s) [442.305683] [081/130] (609s left) kms_psr (fbc-psr-cursor-mmap-gtt) [442.409790] Starting subtest: fbc-psr-cursor-mmap-gtt [442.412111] Starting dynamic subtest: eDP-1 [442.416154] Dynamic subtest eDP-1: SKIP (0.000s) [442.420142] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [442.461390] [082/130] (609s left) kms_cursor_legacy (forked-move) [442.591577] Starting subtest: forked-move [442.593895] Starting dynamic subtest: pipe-A [448.075549] Dynamic subtest pipe-A: SUCCESS (5.480s) [448.090252] Starting dynamic subtest: pipe-B [453.573875] Dynamic subtest pipe-B: SUCCESS (5.498s) [453.585514] Starting dynamic subtest: pipe-C [459.062819] Dynamic subtest pipe-C: SUCCESS (5.489s) [459.071484] Starting dynamic subtest: pipe-D [464.568859] Dynamic subtest pipe-D: SUCCESS (5.505s) [464.578440] Starting dynamic subtest: all-pipes [470.105797] Dynamic subtest all-pipes: SUCCESS (5.536s) [470.108438] Subtest forked-move: SUCCESS (27.516s) [470.236345] [083/130] (581s left) i915_suspend (debugfs-reader) [470.302696] Starting subtest: debugfs-reader [488.044004] Subtest debugfs-reader: SUCCESS (3.117s) [488.103351] [084/130] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [488.211775] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [488.216155] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [488.304219] [085/130] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [488.402944] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [488.408487] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [488.472553] [086/130] (577s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [488.560021] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [488.562787] Starting dynamic subtest: pipe-A-eDP-1 [488.588612] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [488.598483] Starting dynamic subtest: pipe-B-eDP-1 [488.624254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [488.632798] Starting dynamic subtest: pipe-C-eDP-1 [488.659243] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [488.667827] Starting dynamic subtest: pipe-D-eDP-1 [488.694944] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [488.700105] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [490.677968] [087/130] (575s left) gem_close_race (multigpu-basic-process) [490.756167] Starting subtest: multigpu-basic-process [490.761899] Subtest multigpu-basic-process: SKIP (0.000s) [490.988995] [088/130] (575s left) api_intel_bb (intel-bb-blit-x) [491.047216] Starting subtest: intel-bb-blit-x [494.595210] Subtest intel-bb-blit-x: SUCCESS (3.519s) [494.705336] [089/130] (571s left) gem_ctx_param (invalid-ctx-set) [494.767874] Starting subtest: invalid-ctx-set [494.770838] Subtest invalid-ctx-set: SUCCESS (0.001s) [494.863245] [090/130] (571s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [494.921042] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [494.926047] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [495.090466] [091/130] (571s left) gem_exec_fence (basic-wait) [495.282005] Starting subtest: basic-wait [495.284879] Starting dynamic subtest: rcs0 [495.347156] Dynamic subtest rcs0: SUCCESS (0.065s) [495.357947] Starting dynamic subtest: bcs0 [495.408148] Dynamic subtest bcs0: SUCCESS (0.059s) [495.418284] Starting dynamic subtest: vcs0 [495.461904] Dynamic subtest vcs0: SUCCESS (0.052s) [495.470465] Starting dynamic subtest: vcs1 [495.523203] Dynamic subtest vcs1: SUCCESS (0.059s) [495.532981] Starting dynamic subtest: vecs0 [495.586125] Dynamic subtest vecs0: SUCCESS (0.062s) [495.596115] Starting dynamic subtest: ccs0 [495.642065] Dynamic subtest ccs0: SUCCESS (0.054s) [495.644874] Subtest basic-wait: SUCCESS (0.359s) [497.628498] [092/130] (568s left) kms_plane (planar-pixel-format-settings) [497.739013] Starting subtest: planar-pixel-format-settings [497.764146] Subtest planar-pixel-format-settings: SUCCESS (0.025s) [497.846840] [093/130] (568s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [497.910041] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [498.010228] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s) [498.065992] [094/130] (568s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [498.176054] Starting subtest: yf-tiled-8bpp-rotate-90 [498.181588] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [498.238241] [095/130] (568s left) kms_lease (lease-unleased-crtc) [498.339027] Starting subtest: lease-unleased-crtc [498.341644] Starting dynamic subtest: pipe-A-eDP-1 [498.630013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [498.640246] Starting dynamic subtest: pipe-B-eDP-1 [499.404109] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.772s) [499.418501] Starting dynamic subtest: pipe-C-eDP-1 [499.421297] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [499.429815] Starting dynamic subtest: pipe-D-eDP-1 [499.432088] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s) [499.434592] Subtest lease-unleased-crtc: SUCCESS (1.076s) [499.757520] [096/130] (566s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [499.822129] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [499.828028] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [499.987554] [097/130] (566s left) gem_exec_balancer (bonded-semaphore) [500.060188] Starting subtest: bonded-semaphore [500.066101] Subtest bonded-semaphore: SKIP (0.000s) [500.314218] [098/130] (566s left) kms_frontbuffer_tracking (psr-2p-rte) [500.423066] Starting subtest: psr-2p-rte [500.428475] Subtest psr-2p-rte: SKIP (0.000s) [500.510126] [099/130] (566s left) gem_ctx_bad_destroy (double-destroy) [500.581827] Starting subtest: double-destroy [500.584823] Subtest double-destroy: SUCCESS (0.000s) [500.637368] [100/130] (566s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [500.740257] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [501.321087] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.581s) [501.485740] [101/130] (565s left) gem_exec_flush (basic-uc-ro-default) [501.563063] Starting subtest: basic-uc-ro-default [507.049001] Subtest basic-uc-ro-default: SUCCESS (5.476s) [507.226160] [102/130] (559s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [507.279907] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [507.326553] [103/130] (559s left) kms_flip (dpms-vs-vblank-race) [507.418985] Starting subtest: dpms-vs-vblank-race [507.421645] Starting dynamic subtest: A-eDP1 [512.350199] Dynamic subtest A-eDP1: SUCCESS (4.922s) [512.361021] Starting dynamic subtest: B-eDP1 [516.942593] Dynamic subtest B-eDP1: SUCCESS (4.587s) [516.953488] Starting dynamic subtest: C-eDP1 [521.444007] Dynamic subtest C-eDP1: SUCCESS (4.499s) [521.455203] Starting dynamic subtest: D-eDP1 [525.945209] Dynamic subtest D-eDP1: SUCCESS (4.501s) [525.947746] Subtest dpms-vs-vblank-race: SUCCESS (18.516s) [526.712584] [104/130] (540s left) kms_big_fb (x-tiled-16bpp-rotate-180) [526.816167] Starting subtest: x-tiled-16bpp-rotate-180 [527.903002] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.088s) [528.007413] [105/130] (538s left) gem_ctx_shared (q-independent) [528.071204] Starting subtest: Q-independent [528.074151] Starting dynamic subtest: rcs0 [528.142797] Dynamic subtest rcs0: SUCCESS (0.071s) [528.154833] Starting dynamic subtest: vcs0 [528.183542] Dynamic subtest vcs0: SUCCESS (0.041s) [528.192771] Starting dynamic subtest: vcs1 [528.215668] Dynamic subtest vcs1: SUCCESS (0.032s) [528.224086] Starting dynamic subtest: vecs0 [528.250736] Dynamic subtest vecs0: SUCCESS (0.035s) [528.259451] Starting dynamic subtest: ccs0 [528.290682] Dynamic subtest ccs0: SUCCESS (0.039s) [528.293038] Subtest Q-independent: SUCCESS (0.220s) [529.666861] [106/130] (537s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [529.775462] Starting subtest: fbc-rgb101010-draw-mmap-cpu [533.290018] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.519s) [533.395872] [107/130] (533s left) kms_feature_discovery (psr1) [533.502857] Starting subtest: psr1 [533.505402] Subtest psr1: SUCCESS (0.000s) [533.553693] [108/130] (533s left) kms_pm_backlight (brightness-with-dpms) [533.641100] Starting subtest: brightness-with-dpms [533.691091] Starting dynamic subtest: eDP-1 [536.380678] Dynamic subtest eDP-1: SUCCESS (2.686s) [536.383359] Subtest brightness-with-dpms: SUCCESS (2.736s) [537.223483] [109/130] (529s left) kms_cursor_crc (cursor-rapid-movement-32x10) [537.376229] Starting subtest: cursor-rapid-movement-32x10 [537.414203] Subtest cursor-rapid-movement-32x10: SKIP (0.032s) [537.647294] [110/130] (529s left) gem_lmem_swapping (verify) [537.689047] Subtest verify: SKIP (0.000s) [537.712573] [111/130] (529s left) gem_exec_reloc (basic-concurrent16) [537.775158] Subtest basic-concurrent16: SKIP (0.000s) [537.836825] [112/130] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [537.936998] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [542.410629] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.475s) [542.527514] [113/130] (524s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [547.445400] Starting subtest: psr2-overlay-plane-update-continuous-sf [547.448225] Starting dynamic subtest: pipe-A-eDP-1 [549.214476] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s) [549.224739] Starting dynamic subtest: pipe-B-eDP-1 [550.949858] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.731s) [550.952360] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.503s) [551.729554] [114/130] (515s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [551.783217] Starting subtest: invalid-single-wait-all-unsubmitted [551.785935] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [551.864205] [115/130] (515s left) kms_cdclk (plane-scaling) [551.964237] Starting subtest: plane-scaling [551.967105] Starting dynamic subtest: pipe-A-eDP-1 [552.253597] Dynamic subtest pipe-A-eDP-1: SKIP (0.284s) [552.264134] Starting dynamic subtest: pipe-B-eDP-1 [552.269886] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [552.279239] Starting dynamic subtest: pipe-C-eDP-1 [552.284964] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [552.293781] Starting dynamic subtest: pipe-D-eDP-1 [552.299138] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [552.304208] Subtest plane-scaling: SKIP (0.290s) [553.050454] [116/130] (514s left) gem_pxp (protected-encrypted-src-copy-not-readible) [553.179916] Starting subtest: protected-encrypted-src-copy-not-readible [553.286230] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s) [554.444580] [117/130] (512s left) gem_exec_capture (userptr) [554.509252] Starting subtest: userptr [555.340624] Subtest userptr: SUCCESS (0.832s) [555.462666] [118/130] (511s left) syncobj_wait (single-wait-signaled) [555.512225] Starting subtest: single-wait-signaled [555.514716] Subtest single-wait-signaled: SUCCESS (0.000s) [555.586018] [119/130] (511s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [555.707834] Starting subtest: cursorB-vs-flipA-toggle [555.712857] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [555.796739] [120/130] (511s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [556.188026] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [556.956887] [121/130] (510s left) kms_psr (pr-cursor-mmap-gtt) [557.058675] Starting subtest: pr-cursor-mmap-gtt [557.063956] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [557.115862] [122/130] (510s left) perf (polling-parameterized) [557.231182] Starting subtest: polling-parameterized [577.255343] Subtest polling-parameterized: SUCCESS (20.016s) [577.286305] [123/130] (489s left) kms_frontbuffer_tracking (fbc-tiling-linear) [577.393781] Starting subtest: fbc-tiling-linear [580.095739] Subtest fbc-tiling-linear: SUCCESS (2.706s) [580.234158] [124/130] (487s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [580.341750] Starting subtest: psr-rgb565-draw-mmap-wc [584.877968] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.536s) [584.960306] [125/130] (482s left) api_intel_bb (object-reloc-purge-cache) [585.019668] Starting subtest: object-reloc-purge-cache [585.025123] Subtest object-reloc-purge-cache: SKIP (0.002s) [585.083415] [126/130] (482s left) gem_exec_fence (syncobj-timeline-invalid-wait) [585.632768] Starting subtest: syncobj-timeline-invalid-wait [585.635716] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [586.637449] [127/130] (480s left) gem_mmap_offset (partial-unmap) [586.700207] Starting subtest: partial-unmap [586.702970] Starting dynamic subtest: smem0 [587.167167] Dynamic subtest smem0: SUCCESS (0.468s) [587.170406] Subtest partial-unmap: SUCCESS (0.469s) [587.285328] [128/130] (480s left) gem_exec_reloc (basic-range) [587.338447] Subtest basic-range: SKIP (0.000s) [587.376412] [129/130] (479s left) kms_flip (flip-vs-modeset-vs-hang) [587.476239] Starting subtest: flip-vs-modeset-vs-hang [587.478927] Starting dynamic subtest: A-eDP1 [626.096634] Dynamic subtest A-eDP1: SUCCESS (38.623s) [626.107244] Starting dynamic subtest: D-eDP1 [676.085780] Dynamic subtest D-eDP1: SUCCESS (49.974s) [676.088013] Subtest flip-vs-modeset-vs-hang: SUCCESS (88.602s) [676.430539] [130/130] (390s left) kms_writeback (writeback-check-output-xrgb2101010) [676.533043] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s) [676.556290] Closing watchdogs Done.