[43.645865] Initializing watchdogs [43.645978] /dev/watchdog0 [43.657987] [001/133] (960s left) kms_flip (flip-vs-suspend) [43.771243] Starting subtest: flip-vs-suspend [43.773678] Starting dynamic subtest: A-eDP1 [93.959551] Dynamic subtest A-eDP1: SUCCESS (4.883s) [93.973367] Starting dynamic subtest: B-eDP1 [142.956396] Dynamic subtest B-eDP1: SUCCESS (4.733s) [142.967664] Starting dynamic subtest: C-eDP1 [191.975157] Dynamic subtest C-eDP1: SUCCESS (4.649s) [191.987630] Starting dynamic subtest: D-eDP1 [240.969363] Dynamic subtest D-eDP1: SUCCESS (4.744s) [240.977803] Subtest flip-vs-suspend: SUCCESS (19.023s) [242.231427] [002/133] (940s left) prime_vgem (basic-blt) [242.378720] Starting subtest: basic-blt [242.403913] Subtest basic-blt: SUCCESS (0.025s) [242.522838] [003/133] (939s left) gem_ccs (block-copy-uncompressed) [242.595387] Starting subtest: block-copy-uncompressed [242.597941] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [242.621860] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.024s) [242.627767] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [242.649833] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.029s) [242.658222] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [242.669822] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s) [242.679053] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [242.687140] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [242.689806] Subtest block-copy-uncompressed: SUCCESS (0.091s) [242.794474] [004/133] (939s left) kms_big_fb (x-tiled-16bpp-rotate-270) [242.900906] Starting subtest: x-tiled-16bpp-rotate-270 [242.925705] Subtest x-tiled-16bpp-rotate-270: SKIP (0.025s) [243.026334] [005/133] (939s left) i915_hangman (hangcheck-unterminated) [243.098210] Starting subtest: hangcheck-unterminated [254.621616] Subtest hangcheck-unterminated: SUCCESS (11.524s) [254.741371] [006/133] (927s left) kms_chamelium_hpd (dp-hpd) [255.156461] Subtest dp-hpd: SKIP (0.000s) [256.025125] [007/133] (926s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [256.437962] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [257.299005] [008/133] (925s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [257.415052] Starting subtest: fbcpsr-rgb565-draw-blt [262.350460] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (4.939s) [262.463349] [009/133] (920s left) kms_ccs (random-ccs-data-4-tiled-xe2-ccs) [262.588017] Starting subtest: random-ccs-data-4-tiled-xe2-ccs [262.592796] Subtest random-ccs-data-4-tiled-xe2-ccs: SKIP (0.000s) [262.642777] [010/133] (919s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [262.736005] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [265.674069] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.942s) [265.791217] [011/133] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [265.919901] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [270.764619] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.848s) [270.896156] [012/133] (911s left) gem_ctx_persistence (legacy-engines-mixed) [270.954697] Starting subtest: legacy-engines-mixed [270.957110] Starting dynamic subtest: render [271.053220] Dynamic subtest render: SUCCESS (0.096s) [271.069028] Starting dynamic subtest: bsd1 [271.103625] Dynamic subtest bsd1: SUCCESS (0.050s) [271.119465] Starting dynamic subtest: bsd2 [271.173858] Dynamic subtest bsd2: SUCCESS (0.069s) [271.189354] Starting dynamic subtest: blt [271.245054] Dynamic subtest blt: SUCCESS (0.070s) [271.260350] Starting dynamic subtest: vebox [271.319831] Dynamic subtest vebox: SUCCESS (0.074s) [271.323128] Subtest legacy-engines-mixed: SUCCESS (0.365s) [271.390069] [013/133] (911s left) gem_pread (self) [271.441614] Subtest self: SKIP (0.000s) [271.479100] [014/133] (911s left) syncobj_eventfd (invalid-bad-flags) [271.538559] Starting subtest: invalid-bad-flags [271.540797] Subtest invalid-bad-flags: SUCCESS (0.000s) [271.616867] [015/133] (911s left) vgem_basic (busy-fence) [271.681793] Starting subtest: busy-fence [271.684397] Subtest busy-fence: SUCCESS (0.000s) [271.723990] [016/133] (910s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [271.857877] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [271.861784] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [271.941979] [017/133] (910s left) syncobj_timeline (wait-all-for-submit-complex) [272.006727] Starting subtest: wait-all-for-submit-complex [272.222400] Subtest wait-all-for-submit-complex: SUCCESS (0.215s) [272.291108] [018/133] (910s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [272.364944] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [272.405479] [019/133] (910s left) gem_lmem_swapping (parallel-random-engines) [272.467576] Subtest parallel-random-engines: SKIP (0.000s) [272.493688] [020/133] (910s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [272.554354] Starting subtest: single-wait-all-for-submit-unsubmitted [272.657035] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [272.725288] [021/133] (910s left) kms_draw_crc (fill-fb) [272.826112] Starting subtest: fill-fb [273.277199] Subtest fill-fb: SUCCESS (0.454s) [273.351205] [022/133] (909s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [273.455326] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [273.459638] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [273.530709] [023/133] (909s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [273.621557] Starting subtest: x-tiled-to-vebox-yf-tiled [273.626981] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [273.799840] [024/133] (909s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [273.901267] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [279.044283] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.147s) [279.172411] [025/133] (903s left) kms_properties (get_properties-sanity-non-atomic) [279.295362] Starting subtest: get_properties-sanity-non-atomic [279.297816] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [279.360792] [026/133] (903s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [279.439027] Starting subtest: etime-multi-wait-for-submit-submitted [279.545961] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s) [279.606271] [027/133] (903s left) gem_basic (create-fd-close) [279.682526] Starting subtest: create-fd-close [279.687272] Subtest create-fd-close: SUCCESS (0.000s) [279.782584] [028/133] (903s left) kms_vblank (ts-continuation-idle) [279.893460] Starting subtest: ts-continuation-idle [279.896631] Starting dynamic subtest: pipe-A-eDP-1 [280.320261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s) [280.335105] Starting dynamic subtest: pipe-D-eDP-1 [281.485410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.165s) [281.488043] Subtest ts-continuation-idle: SUCCESS (1.593s) [282.418716] [029/133] (900s left) v3d/v3d_submit_cl (multi-and-single-sync) [282.513178] Subtest multi-and-single-sync: SKIP (0.000s) [282.560081] [030/133] (900s left) gem_exec_balancer (bonded-pair) [282.656006] Starting subtest: bonded-pair [282.660833] Subtest bonded-pair: SKIP (0.000s) [282.915298] [031/133] (900s left) kms_cursor_crc (cursor-sliding-128x42) [283.138071] Starting subtest: cursor-sliding-128x42 [283.173822] Subtest cursor-sliding-128x42: SKIP (0.028s) [283.354287] [032/133] (899s left) gem_mmap_gtt (flink-race) [283.417603] Subtest flink-race: SKIP (0.000s) [283.461824] [033/133] (899s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [283.563415] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [283.565960] Starting dynamic subtest: pipe-A-eDP-1 [283.568384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [283.582570] Starting dynamic subtest: pipe-B-eDP-1 [283.585236] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [283.595022] Starting dynamic subtest: pipe-C-eDP-1 [283.597577] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [283.607377] Starting dynamic subtest: pipe-D-eDP-1 [283.610375] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [283.613203] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.003s) [283.647037] [034/133] (899s left) v3d/v3d_submit_csd (multi-and-single-sync) [283.724735] Subtest multi-and-single-sync: SKIP (0.000s) [283.769769] [035/133] (899s left) gem_tiled_blits (normal) [283.826072] Subtest normal: SKIP (0.000s) [283.873394] [036/133] (899s left) dmabuf_sync_file (export-basic) [283.936407] Starting subtest: export-basic [283.938910] Subtest export-basic: SUCCESS (0.001s) [283.984402] [037/133] (899s left) kms_plane (planar-pixel-format-settings) [284.084074] Starting subtest: planar-pixel-format-settings [284.108625] Subtest planar-pixel-format-settings: SUCCESS (0.022s) [284.165906] [038/133] (899s left) kms_prop_blob (invalid-set-prop-any) [284.218969] Starting subtest: invalid-set-prop-any [284.220959] Subtest invalid-set-prop-any: SUCCESS (0.000s) [284.284887] [039/133] (898s left) kms_invalid_mode (bad-hsync-end) [284.372056] Starting subtest: bad-hsync-end [284.374226] Starting dynamic subtest: pipe-A-eDP-1 [284.666952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [284.678215] Starting dynamic subtest: pipe-B-eDP-1 [284.680525] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [284.687740] Starting dynamic subtest: pipe-C-eDP-1 [284.690151] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [284.696215] Starting dynamic subtest: pipe-D-eDP-1 [284.698209] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [284.700177] Subtest bad-hsync-end: SUCCESS (0.301s) [285.556906] [040/133] (897s left) kms_lease (lease-invalid-crtc) [285.688699] Starting subtest: lease-invalid-crtc [285.691352] Starting dynamic subtest: pipe-A-eDP-1 [285.693988] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [285.705996] Starting dynamic subtest: pipe-B-eDP-1 [285.708255] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [285.714336] Starting dynamic subtest: pipe-C-eDP-1 [285.716731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [285.722238] Starting dynamic subtest: pipe-D-eDP-1 [285.724248] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [285.726500] Subtest lease-invalid-crtc: SUCCESS (0.003s) [285.742278] [041/133] (897s left) gem_exec_reloc (basic-write-read) [285.812586] Subtest basic-write-read: SKIP (0.000s) [285.867018] [042/133] (897s left) gem_ctx_param (set-priority-not-supported) [285.936241] Starting subtest: set-priority-not-supported [285.940990] Subtest set-priority-not-supported: SKIP (0.000s) [286.003059] [043/133] (897s left) kms_big_fb (4-tiled-8bpp-rotate-270) [286.136116] Starting subtest: 4-tiled-8bpp-rotate-270 [286.155126] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.019s) [286.271829] [044/133] (897s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [286.395527] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [286.399219] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [286.484436] [045/133] (896s left) gem_mmap_wc (coherency) [286.558217] Subtest coherency: SKIP (0.000s) [286.609282] [046/133] (896s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [286.731374] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [286.733716] Starting dynamic subtest: pipe-A-default-mode [287.024739] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [287.029712] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.288s) [287.924447] [047/133] (895s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [288.035019] Starting subtest: yf-tiled-addfb-size-offset-overflow [288.039916] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [288.111482] [048/133] (895s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [288.344024] Starting subtest: parallel-dmabuf-import-out-fence [289.204449] Subtest parallel-dmabuf-import-out-fence: SUCCESS (0.860s) [289.285421] [049/133] (894s left) kms_psr (psr2-sprite-plane-move) [289.405138] Starting subtest: psr2-sprite-plane-move [289.407580] Starting dynamic subtest: eDP-1 [291.246111] Dynamic subtest eDP-1: SUCCESS (1.840s) [291.249124] Subtest psr2-sprite-plane-move: SUCCESS (1.840s) [292.150865] [050/133] (891s left) kms_big_fb (x-tiled-8bpp-rotate-0) [292.281117] Starting subtest: x-tiled-8bpp-rotate-0 [293.504948] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.224s) [293.640877] [051/133] (889s left) gem_exec_schedule (timeslicing) [293.729000] Starting subtest: timeslicing [293.731063] Starting dynamic subtest: rcs0 [293.740652] Dynamic subtest rcs0: SUCCESS (0.020s) [293.756294] Starting dynamic subtest: bcs0 [293.761881] Dynamic subtest bcs0: SUCCESS (0.020s) [293.777580] Starting dynamic subtest: vcs0 [293.784049] Dynamic subtest vcs0: SUCCESS (0.021s) [293.798543] Starting dynamic subtest: vcs1 [293.807036] Dynamic subtest vcs1: SUCCESS (0.022s) [293.818868] Starting dynamic subtest: vecs0 [293.830709] Dynamic subtest vecs0: SUCCESS (0.023s) [293.842580] Starting dynamic subtest: ccs0 [293.853048] Dynamic subtest ccs0: SUCCESS (0.022s) [293.855093] Subtest timeslicing: SUCCESS (0.134s) [295.647167] [052/133] (887s left) gem_softpin (allocator-evict) [295.723133] Starting subtest: allocator-evict [295.725673] Starting dynamic subtest: rcs0 [319.288230] Dynamic subtest rcs0: SUCCESS (23.565s) [319.305099] Starting dynamic subtest: bcs0 [343.569825] Dynamic subtest bcs0: SUCCESS (24.279s) [343.578108] Starting dynamic subtest: vcs0 [367.418719] Dynamic subtest vcs0: SUCCESS (23.849s) [367.426906] Starting dynamic subtest: vcs1 [391.043657] Dynamic subtest vcs1: SUCCESS (23.624s) [391.050461] Starting dynamic subtest: vecs0 [414.576590] Dynamic subtest vecs0: SUCCESS (23.533s) [414.589912] Starting dynamic subtest: ccs0 [438.301039] Dynamic subtest ccs0: SUCCESS (23.723s) [438.304179] Subtest allocator-evict: SUCCESS (142.578s) [438.376278] [053/133] (745s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [438.539397] Starting subtest: missing-ccs-buffer-y-tiled-ccs [438.541840] Starting dynamic subtest: pipe-A-eDP-1 [438.546513] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [438.561107] Starting dynamic subtest: pipe-B-eDP-1 [438.565887] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [438.573685] Starting dynamic subtest: pipe-C-eDP-1 [438.578662] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [438.585150] Starting dynamic subtest: pipe-D-eDP-1 [438.589682] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [438.594157] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s) [438.615213] [054/133] (745s left) gem_unref_active_buffers [438.824998] [055/133] (744s left) sw_sync (sync_merge_same) [438.886655] Starting subtest: sync_merge_same [438.889285] Subtest sync_merge_same: SUCCESS (0.000s) [438.941320] [056/133] (744s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [439.046502] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [439.048945] Starting dynamic subtest: A-eDP1 [442.992406] Dynamic subtest A-eDP1: SUCCESS (3.942s) [443.005543] Starting dynamic subtest: B-eDP1 [446.433712] Dynamic subtest B-eDP1: SUCCESS (3.440s) [446.450003] Starting dynamic subtest: C-eDP1 [449.901267] Dynamic subtest C-eDP1: SUCCESS (3.468s) [449.916742] Starting dynamic subtest: D-eDP1 [453.358871] Dynamic subtest D-eDP1: SUCCESS (3.457s) [453.366318] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.319s) [454.237886] [057/133] (729s left) kms_frontbuffer_tracking (fbc-stridechange) [454.380568] Starting subtest: fbc-stridechange [456.687642] Subtest fbc-stridechange: SUCCESS (2.307s) [456.794816] [058/133] (726s left) kms_psr (psr-dpms) [456.906770] Starting subtest: psr-dpms [456.909518] Starting dynamic subtest: eDP-1 [460.009466] Dynamic subtest eDP-1: SUCCESS (3.102s) [460.012958] Subtest psr-dpms: SUCCESS (3.103s) [460.925001] [059/133] (722s left) kms_busy (extended-modeset-hang-oldfb) [461.058548] Starting subtest: extended-modeset-hang-oldfb [461.061034] Starting dynamic subtest: pipe-A [472.895560] Dynamic subtest pipe-A: SUCCESS (11.833s) [472.912012] Starting dynamic subtest: pipe-D [485.444633] Dynamic subtest pipe-D: SUCCESS (12.542s) [485.447826] Subtest extended-modeset-hang-oldfb: SUCCESS (24.385s) [486.326641] [060/133] (697s left) i915_pm_rps (basic-api) [486.397948] Starting subtest: basic-api [486.403238] Subtest basic-api: SKIP (0.001s) [486.461150] [061/133] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [486.583188] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [486.587546] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [486.666562] [062/133] (697s left) kms_psr (fbc-psr2-primary-mmap-gtt) [486.783635] Starting subtest: fbc-psr2-primary-mmap-gtt [486.786010] Starting dynamic subtest: eDP-1 [486.790688] Dynamic subtest eDP-1: SKIP (0.000s) [486.795268] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.002s) [486.852207] [063/133] (697s left) kms_plane_scaling (planes-scaler-unity-scaling) [486.961449] Starting subtest: planes-scaler-unity-scaling [486.963941] Starting dynamic subtest: pipe-A-eDP-1 [487.029075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s) [487.047123] Starting dynamic subtest: pipe-B-eDP-1 [488.249015] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s) [488.267619] Starting dynamic subtest: pipe-C-eDP-1 [489.455330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s) [489.473033] Starting dynamic subtest: pipe-D-eDP-1 [490.671435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s) [490.674658] Subtest planes-scaler-unity-scaling: SUCCESS (3.710s) [491.961956] [064/133] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [492.084848] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [492.089309] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [492.178867] [065/133] (691s left) kms_cursor_crc (cursor-rapid-movement-512x170) [492.480992] Starting subtest: cursor-rapid-movement-512x170 [492.485799] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [492.635046] [066/133] (691s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [492.768524] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [492.784644] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.015s) [492.853829] [067/133] (691s left) gem_caching (writes) [492.922568] Subtest writes: SKIP (0.000s) [492.964119] [068/133] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [493.084378] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [497.917660] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.835s) [498.055297] [069/133] (685s left) kms_getfb (getfb2-handle-zero) [498.129528] Starting subtest: getfb2-handle-zero [498.132175] Subtest getfb2-handle-zero: SUCCESS (0.000s) [498.225229] [070/133] (685s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [498.368074] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [498.372896] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [498.456664] [071/133] (685s left) gem_ctx_create (basic) [498.526002] Starting subtest: basic [498.528750] Subtest basic: SUCCESS (0.000s) [498.704771] [072/133] (685s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [498.783539] Starting subtest: y-tiled-ccs-to-y-tiled [498.788706] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [498.961069] [073/133] (685s left) kms_atomic_transition (modeset-transition-nonblocking) [499.082461] Starting subtest: modeset-transition-nonblocking [499.084913] Starting dynamic subtest: 1x-outputs [511.069233] Dynamic subtest 1x-outputs: SUCCESS (11.986s) [511.369813] Subtest modeset-transition-nonblocking: SUCCESS (12.285s) [512.244434] [074/133] (671s left) vgem_basic (dmabuf-export) [512.296415] Starting subtest: dmabuf-export [512.323168] Subtest dmabuf-export: SUCCESS (0.029s) [512.437023] [075/133] (671s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [512.567890] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [512.576446] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s) [512.699112] [076/133] (671s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [512.788284] Starting subtest: y-tiled-ccs-to-yf-tiled [512.792973] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [512.967011] [077/133] (671s left) gem_userptr_blits (access-control) [513.058992] Starting subtest: access-control [513.064482] Subtest access-control: SKIP (0.000s) [513.187383] [078/133] (671s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [513.308394] Starting subtest: psr-rgb101010-draw-mmap-wc [518.158015] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.852s) [518.273890] [079/133] (665s left) kms_scaling_modes (scaling-mode-none) [518.386993] Starting subtest: scaling-mode-none [518.389730] Starting dynamic subtest: pipe-A-eDP-1 [518.521895] Dynamic subtest pipe-A-eDP-1: SKIP (0.131s) [518.538576] Starting dynamic subtest: pipe-B-eDP-1 [518.577177] Dynamic subtest pipe-B-eDP-1: SKIP (0.053s) [518.591329] Starting dynamic subtest: pipe-C-eDP-1 [518.603871] Dynamic subtest pipe-C-eDP-1: SKIP (0.026s) [518.615396] Starting dynamic subtest: pipe-D-eDP-1 [518.630701] Dynamic subtest pipe-D-eDP-1: SKIP (0.026s) [518.634972] Subtest scaling-mode-none: SKIP (0.242s) [518.739437] [080/133] (665s left) gem_exec_fence (syncobj-timeline-export) [519.327652] Starting subtest: syncobj-timeline-export [519.335768] Subtest syncobj-timeline-export: SUCCESS (0.009s) [520.715590] [081/133] (663s left) kms_cursor_crc (cursor-alpha-transparent) [520.825241] Starting subtest: cursor-alpha-transparent [520.827856] Starting dynamic subtest: pipe-A-eDP-1 [521.459655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s) [521.476103] Starting dynamic subtest: pipe-D-eDP-1 [522.817223] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.355s) [522.819725] Subtest cursor-alpha-transparent: SUCCESS (1.991s) [523.697152] [082/133] (660s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [523.757058] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [523.759480] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [523.857324] [083/133] (660s left) gem_exec_fair (basic-pace-share) [523.957064] Subtest basic-pace-share: SKIP (0.000s) [524.013903] [084/133] (660s left) kms_content_protection (dp-mst-lic-type-0) [524.177284] Starting subtest: dp-mst-lic-type-0 [524.182685] Subtest dp-mst-lic-type-0: SKIP (0.000s) [524.283949] [085/133] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [524.407654] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [524.412462] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [524.489904] [086/133] (659s left) drm_fdinfo (memory-info-shared) [524.550105] Starting subtest: memory-info-shared [524.553317] Starting dynamic subtest: smem0 [524.588365] Dynamic subtest smem0: SUCCESS (0.039s) [524.591534] Subtest memory-info-shared: SUCCESS (0.041s) [524.657134] [087/133] (659s left) kms_psr (fbc-psr-no-drrs) [524.766799] Starting subtest: fbc-psr-no-drrs [524.769048] Starting dynamic subtest: eDP-1 [524.773049] Dynamic subtest eDP-1: SKIP (0.000s) [524.777361] Subtest fbc-psr-no-drrs: SKIP (0.001s) [524.828179] [088/133] (659s left) kms_plane_alpha_blend (coverage-7efc) [524.927106] Starting subtest: coverage-7efc [525.190841] Starting dynamic subtest: pipe-A-eDP-1 [525.755788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s) [525.785381] Starting dynamic subtest: pipe-D-eDP-1 [527.152238] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.380s) [527.154932] Subtest coverage-7efc: SUCCESS (2.224s) [528.028957] [089/133] (656s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [528.146937] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [528.149712] Starting dynamic subtest: pipe-A-eDP-1 [528.394475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.244s) [528.406941] Starting dynamic subtest: pipe-B-eDP-1 [529.761701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.366s) [529.770439] Starting dynamic subtest: pipe-C-eDP-1 [531.147009] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s) [531.157749] Starting dynamic subtest: pipe-D-eDP-1 [532.599481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.450s) [532.602072] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.452s) [533.877355] [090/133] (650s left) kms_async_flips (async-flip-with-page-flip-events) [533.985720] Starting subtest: async-flip-with-page-flip-events [534.354482] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs [535.186550] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.830s) [535.200712] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [535.326446] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SKIP (0.136s) [535.344904] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc [535.478800] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.155s) [535.494345] Starting dynamic subtest: pipe-A-eDP-1-4 [537.679941] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.150s) [537.697911] Starting dynamic subtest: pipe-A-eDP-1-x [539.846043] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.167s) [539.864310] Starting dynamic subtest: pipe-A-eDP-1-linear [542.023351] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.176s) [542.353813] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs [543.174839] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.828s) [543.188870] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [543.328702] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SKIP (0.154s) [543.338775] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc [543.480378] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.151s) [543.505646] Starting dynamic subtest: pipe-B-eDP-1-4 [545.634953] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.156s) [545.653035] Starting dynamic subtest: pipe-B-eDP-1-x [547.864985] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.177s) [547.879126] Starting dynamic subtest: pipe-B-eDP-1-linear [549.991221] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.177s) [550.370118] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs [551.188927] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.830s) [551.202070] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [551.325821] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SKIP (0.135s) [551.338531] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc [551.458448] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.134s) [551.473829] Starting dynamic subtest: pipe-C-eDP-1-4 [553.668942] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.161s) [553.684611] Starting dynamic subtest: pipe-C-eDP-1-x [555.749647] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.132s) [555.758213] Starting dynamic subtest: pipe-C-eDP-1-linear [557.979935] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.177s) [558.286429] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs [559.113351] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.830s) [559.123413] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [559.249163] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SKIP (0.137s) [559.260533] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc [559.425514] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.177s) [559.438262] Starting dynamic subtest: pipe-D-eDP-1-4 [561.597223] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [561.610692] Starting dynamic subtest: pipe-D-eDP-1-x [563.804550] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.154s) [563.812963] Starting dynamic subtest: pipe-D-eDP-1-linear [565.919512] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.166s) [565.922054] Subtest async-flip-with-page-flip-events: SUCCESS (31.932s) [567.223003] [091/133] (617s left) gem_ctx_param (invalid-set-ringsize) [567.296359] Starting subtest: invalid-set-ringsize [567.299406] Subtest invalid-set-ringsize: SUCCESS (0.000s) [567.359052] [092/133] (617s left) kms_big_fb (y-tiled-32bpp-rotate-0) [567.476101] Starting subtest: y-tiled-32bpp-rotate-0 [567.481040] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [567.547167] [093/133] (617s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [567.669980] Starting subtest: plane-all-modeset-transition-internal-panels [567.672519] Starting dynamic subtest: pipe-A-eDP-1 [569.277422] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.606s) [569.604621] Starting dynamic subtest: pipe-B-eDP-1 [570.998702] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s) [571.289733] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (3.619s) [572.209213] [094/133] (612s left) kms_flip (dpms-off-confusion) [572.336358] Starting subtest: dpms-off-confusion [572.338953] Starting dynamic subtest: A-eDP1 [581.138403] Dynamic subtest A-eDP1: SUCCESS (8.763s) [581.149614] Starting dynamic subtest: B-eDP1 [589.870143] Dynamic subtest B-eDP1: SUCCESS (8.765s) [589.880040] Starting dynamic subtest: C-eDP1 [598.629297] Dynamic subtest C-eDP1: SUCCESS (8.758s) [598.643612] Starting dynamic subtest: D-eDP1 [607.444922] Dynamic subtest D-eDP1: SUCCESS (8.767s) [607.447791] Subtest dpms-off-confusion: SUCCESS (35.074s) [608.692804] [095/133] (575s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [608.826559] Starting subtest: basic-flip-before-cursor-legacy [609.743734] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.915s) [610.623632] [096/133] (574s left) gem_mmap_gtt (coherency) [610.701963] Subtest coherency: SKIP (0.000s) [610.753456] [097/133] (573s left) v3d/v3d_perfmon (destroy-valid-perfmon) [610.819944] Subtest destroy-valid-perfmon: SKIP (0.000s) [610.859300] [098/133] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [610.983124] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [610.987523] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [611.065058] [099/133] (573s left) gem_exec_whisper (basic-fds-forked) [611.131738] Starting subtest: basic-fds-forked [637.923392] Subtest basic-fds-forked: SUCCESS (26.789s) [638.106905] [100/133] (546s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [638.272690] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [638.277702] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s) [638.392654] [101/133] (546s left) perf_pmu (busy-accuracy-50) [638.448402] Starting subtest: busy-accuracy-50 [638.450983] Starting dynamic subtest: rcs0 [639.995693] Dynamic subtest rcs0: SUCCESS (1.543s) [640.015686] Starting dynamic subtest: bcs0 [641.547757] Dynamic subtest bcs0: SUCCESS (1.551s) [641.565412] Starting dynamic subtest: vcs0 [643.099329] Dynamic subtest vcs0: SUCCESS (1.551s) [643.116319] Starting dynamic subtest: vcs1 [644.655167] Dynamic subtest vcs1: SUCCESS (1.554s) [644.673404] Starting dynamic subtest: vecs0 [646.207827] Dynamic subtest vecs0: SUCCESS (1.550s) [646.226778] Starting dynamic subtest: ccs0 [647.765700] Dynamic subtest ccs0: SUCCESS (1.556s) [647.768255] Subtest busy-accuracy-50: SUCCESS (9.315s) [647.874215] [102/133] (536s left) api_intel_bb (lot-of-buffers) [647.957418] Starting subtest: lot-of-buffers [649.800941] Subtest lot-of-buffers: SUCCESS (1.844s) [650.660095] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1849 [max: 8192] direct dependencies: 20178 [max: 32768] indirect dependencies: 173268 all direct dependencies: 421229 dependency chains: 30843 [max: 131072] dependency chain hlocks used: 136063 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 354 in-softirq chains: 745 in-process chains: 29744 stack-trace entries: 190857 [max: 1048576] number of stack traces: 9500 number of stack hash chains: 7211 combined max dependencies: 3582401054 hardirq-safe locks: 118 hardirq-unsafe locks: 1081 softirq-safe locks: 233 softirq-unsafe locks: 985 irq-safe locks: 253 irq-unsafe locks: 1081 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 339 softirq-read-safe locks: 8 softirq-read-unsafe locks: 334 irq-read-safe locks: 8 irq-read-unsafe locks: 339 uncategorized locks: 297 unused locks: 1 max locking depth: 16 max bfs queue depth: 455 max lock class index: 1848 chain lookup misses: 31400 chain lookup hits: 535532115 cyclic checks: 31948 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5605 find-mask backwards checks: 2741 hardirq on events: 302623077 hardirq off events: 302623056 redundant hardirq ons: 120 redundant hardirq offs: 37 softirq on events: 1136818 softirq off events: 1136818 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 97 large chain blocks: 1 [650.662788] Closing watchdogs Done.