[56.711037] Initializing watchdogs [56.711087] /dev/watchdog0 [56.726343] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [56.730196] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.732263] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.735719] [001/156] (960s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [56.841485] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc [56.845582] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [56.948746] [002/156] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [57.028177] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [57.032173] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [57.103140] [003/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen) [57.185810] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen [57.190086] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [57.277690] [004/156] (960s left) prime_busy (hang-wait) [57.338074] Starting subtest: hang-wait [57.340512] Starting dynamic subtest: rcs0 [83.739856] Dynamic subtest rcs0: SUCCESS (26.398s) [83.747062] Starting dynamic subtest: bcs0 [90.891346] Dynamic subtest bcs0: SUCCESS (7.148s) [90.901169] Starting dynamic subtest: vcs0 [97.865250] Dynamic subtest vcs0: SUCCESS (6.975s) [97.873798] Starting dynamic subtest: vcs1 [104.845666] Dynamic subtest vcs1: SUCCESS (6.977s) [104.855548] Starting dynamic subtest: vecs0 [111.878736] Dynamic subtest vecs0: SUCCESS (7.035s) [111.886485] Starting dynamic subtest: ccs0 [125.720068] Dynamic subtest ccs0: SUCCESS (13.837s) [125.722473] Subtest hang-wait: SUCCESS (68.376s) [125.828955] [005/156] (891s left) kms_psr (psr-primary-mmap-cpu) [125.910894] Starting subtest: psr-primary-mmap-cpu [125.913243] Starting dynamic subtest: eDP-1 [127.674086] Dynamic subtest eDP-1: SUCCESS (1.762s) [127.676198] Subtest psr-primary-mmap-cpu: SUCCESS (1.762s) [128.534771] [006/156] (888s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [128.618304] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [128.620765] Starting dynamic subtest: pipe-A-eDP-1 [128.645912] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [128.660824] Starting dynamic subtest: pipe-B-eDP-1 [128.685073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [128.699959] Starting dynamic subtest: pipe-C-eDP-1 [128.722283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [128.738260] Starting dynamic subtest: pipe-D-eDP-1 [128.761427] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [128.765948] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s) [130.917608] [007/156] (886s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-blt) [130.999910] Starting subtest: fbcpsrhdr-rgb101010-draw-blt [131.004196] Subtest fbcpsrhdr-rgb101010-draw-blt: SKIP (0.000s) [131.089904] [008/156] (886s left) kms_vblank (query-busy-hang) [131.160182] Starting subtest: query-busy-hang [131.162569] Starting dynamic subtest: pipe-A-eDP-1 [158.026178] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.864s) [158.045214] Starting dynamic subtest: pipe-D-eDP-1 [183.052628] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s) [183.054661] Subtest query-busy-hang: SUCCESS (51.891s) [183.894564] [009/156] (833s left) gem_mmap_offset (clear) [183.951864] Starting subtest: clear [183.954734] Starting dynamic subtest: smem0 [209.286325] Dynamic subtest smem0: SUCCESS (25.329s) [209.288796] Subtest clear: SUCCESS (25.330s) [209.413788] [010/156] (808s left) fbdev (unaligned-read) [209.503722] Starting subtest: unaligned-read [209.516284] Subtest unaligned-read: SUCCESS (0.015s) [209.568958] [011/156] (808s left) kms_psr (pr-sprite-mmap-gtt) [209.665250] Starting subtest: pr-sprite-mmap-gtt [209.669796] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [209.742546] [012/156] (807s left) sysfs_timeslice_duration (timeout) [209.796822] Starting subtest: timeout [209.799265] Starting dynamic subtest: vecs0 [219.204759] Dynamic subtest vecs0: SUCCESS (9.404s) [219.213593] Starting dynamic subtest: ccs0 [220.487927] Dynamic subtest ccs0: SUCCESS (1.284s) [220.496171] Starting dynamic subtest: vcs0 [230.203872] Dynamic subtest vcs0: SUCCESS (9.713s) [230.215598] Starting dynamic subtest: bcs0 [230.816040] Dynamic subtest bcs0: SUCCESS (0.612s) [230.824820] Starting dynamic subtest: rcs0 [232.041165] Dynamic subtest rcs0: SUCCESS (1.225s) [232.050075] Starting dynamic subtest: vcs1 [241.210319] Dynamic subtest vcs1: SUCCESS (9.165s) [241.213181] Subtest timeout: SUCCESS (31.409s) [241.296396] [013/156] (776s left) gem_exec_reloc (basic-wc-gtt-noreloc) [241.349106] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [241.420388] [014/156] (776s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [241.507679] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [241.511771] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [241.599173] [015/156] (776s left) gen9_exec_parse (bb-start-far) [241.650706] Subtest bb-start-far: SKIP (0.000s) [241.716540] [016/156] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [241.805268] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [249.156695] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.357s) [249.290297] [017/156] (768s left) gem_exec_whisper (basic-forked-all) [249.351500] Starting subtest: basic-forked-all [263.234068] Subtest basic-forked-all: SUCCESS (13.877s) [263.419031] [018/156] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [263.493454] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [263.497760] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [263.595144] [019/156] (754s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [263.685382] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [263.687687] Starting dynamic subtest: pipe-A-eDP-1 [270.408881] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.726s) [270.419552] Starting dynamic subtest: pipe-B-eDP-1 [277.552617] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.145s) [277.554972] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.874s) [278.435897] [020/156] (739s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [278.494273] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [278.496781] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [278.579776] [021/156] (739s left) gem_fenced_exec_thrash (2-spare-fences) [278.636805] Subtest 2-spare-fences: SKIP (0.000s) [278.733264] [022/156] (739s left) api_intel_bb (blit-reloc-keep-cache) [278.793179] Starting subtest: blit-reloc-keep-cache [278.797659] Subtest blit-reloc-keep-cache: SKIP (0.000s) [278.929347] [023/156] (739s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc) [279.005157] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc [279.009425] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [279.114542] [024/156] (739s left) kms_hdr (static-toggle-dpms) [279.194776] Starting subtest: static-toggle-dpms [279.197591] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [279.202171] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [279.211689] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [279.215808] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [279.220111] Subtest static-toggle-dpms: SKIP (0.002s) [279.263953] [025/156] (738s left) kms_prime (basic-crc-hybrid) [279.328798] Subtest basic-crc-hybrid: SKIP (0.000s) [279.454876] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true [279.457691] [026/156] (738s left) api_intel_bb (simple-bb-ctx) [279.509550] Starting subtest: simple-bb-ctx [279.515183] Subtest simple-bb-ctx: SUCCESS (0.008s) [279.640269] [027/156] (738s left) syncobj_wait (multi-wait-signaled) [279.698247] Starting subtest: multi-wait-signaled [279.700092] Subtest multi-wait-signaled: SUCCESS (0.000s) [279.790334] [028/156] (738s left) gem_vm_create (execbuf) [279.840420] Starting subtest: execbuf [279.847717] Subtest execbuf: SUCCESS (0.007s) [279.979915] [029/156] (738s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [280.057147] Starting subtest: crc-primary-basic-y-tiled-ccs [280.059152] Starting dynamic subtest: pipe-A-eDP-1 [280.080077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [280.093387] Starting dynamic subtest: pipe-B-eDP-1 [280.111449] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [280.119982] Starting dynamic subtest: pipe-C-eDP-1 [280.138078] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [280.146705] Starting dynamic subtest: pipe-D-eDP-1 [280.164862] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [280.168368] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s) [282.369963] [030/156] (736s left) kms_frontbuffer_tracking (hdr-suspend) [282.454380] Starting subtest: hdr-suspend [282.458865] Subtest hdr-suspend: SKIP (0.000s) [282.566786] [031/156] (735s left) dmabuf_sync_file (export-multiwait) [282.616209] Starting subtest: export-multiwait [282.618337] Subtest export-multiwait: SUCCESS (0.001s) [282.669746] [032/156] (735s left) gem_exec_balancer (bonded-true-hang) [282.933425] Starting subtest: bonded-true-hang [282.938603] Subtest bonded-true-hang: SKIP (0.000s) [283.053497] [033/156] (735s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [283.114173] Starting subtest: multi-wait-for-submit-available-submitted-signaled [283.116367] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [283.210750] [034/156] (735s left) prime_udl [283.283170] [035/156] (735s left) kms_color (ctm-0-75) [283.366873] Starting subtest: ctm-0-75 [283.369198] Starting dynamic subtest: pipe-A-eDP-1 [288.311347] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.945s) [288.320410] Starting dynamic subtest: pipe-B-eDP-1 [294.052105] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.738s) [294.063108] Starting dynamic subtest: pipe-C-eDP-1 [299.451383] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.398s) [299.462634] Starting dynamic subtest: pipe-D-eDP-1 [304.798077] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.344s) [304.800762] Subtest ctm-0-75: SUCCESS (21.428s) [305.617419] [036/156] (713s left) syncobj_basic (bad-flags-fd-to-handle) [305.665710] Starting subtest: bad-flags-fd-to-handle [305.667993] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [305.763378] [037/156] (712s left) kms_big_fb (4-tiled-32bpp-rotate-90) [305.846419] Starting subtest: 4-tiled-32bpp-rotate-90 [305.867978] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s) [305.976518] [038/156] (712s left) kms_flip (2x-plain-flip) [306.053200] Starting subtest: 2x-plain-flip [306.060080] Subtest 2x-plain-flip: SKIP (0.008s) [306.146874] [039/156] (712s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [306.242860] Starting subtest: psr-modesetfrombusy [312.399188] Subtest psr-modesetfrombusy: SUCCESS (6.164s) [312.525847] [040/156] (706s left) gem_exec_schedule (fifo) [312.597300] Starting subtest: fifo [312.599348] Starting dynamic subtest: rcs0 [312.689450] Dynamic subtest rcs0: SUCCESS (0.099s) [312.700998] Starting dynamic subtest: vcs0 [312.766870] Dynamic subtest vcs0: SUCCESS (0.077s) [312.779781] Starting dynamic subtest: vcs1 [312.840499] Dynamic subtest vcs1: SUCCESS (0.073s) [312.851698] Starting dynamic subtest: vecs0 [312.913055] Dynamic subtest vecs0: SUCCESS (0.071s) [312.925715] Starting dynamic subtest: ccs0 [312.990837] Dynamic subtest ccs0: SUCCESS (0.075s) [312.993303] Subtest fifo: SUCCESS (0.401s) [314.349771] [041/156] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [314.434945] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [317.965433] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.537s) [319.116598] [042/156] (699s left) kms_async_flips (async-flip-dpms) [319.194317] Starting subtest: async-flip-dpms [319.568465] Starting dynamic subtest: pipe-A-eDP-1 [323.519117] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.949s) [323.916969] Starting dynamic subtest: pipe-B-eDP-1 [326.788596] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.879s) [327.165473] Starting dynamic subtest: pipe-C-eDP-1 [330.048901] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.889s) [330.428793] Starting dynamic subtest: pipe-D-eDP-1 [333.224810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.801s) [333.227198] Subtest async-flip-dpms: SUCCESS (14.029s) [334.402038] [043/156] (684s left) gem_workarounds (reset-fd) [334.462416] Starting subtest: reset-fd [334.634167] Subtest reset-fd: SUCCESS (0.175s) [334.759150] [044/156] (684s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [334.827990] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [334.832475] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [334.910135] [045/156] (684s left) kms_chamelium_hpd (dp-hpd) [335.279219] Subtest dp-hpd: SKIP (0.000s) [336.106060] [046/156] (682s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [336.216750] Starting subtest: 2x-long-flip-vs-cursor-atomic [336.221478] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [336.376699] [047/156] (682s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [336.476281] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt [336.480413] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [336.576324] [048/156] (682s left) gem_mmap_gtt (basic-write) [336.627972] Subtest basic-write: SKIP (0.000s) [336.689128] [049/156] (682s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [336.754683] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [336.758716] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [336.825794] [050/156] (682s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [336.927624] Starting subtest: basic-busy-flip-before-cursor-atomic [336.932161] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [337.071339] [051/156] (682s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [337.146263] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu [337.149643] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [337.244786] [052/156] (682s left) kms_big_fb (x-tiled-8bpp-rotate-270) [337.327989] Starting subtest: x-tiled-8bpp-rotate-270 [337.349620] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s) [337.461072] [053/156] (681s left) kms_atomic_interruptible (legacy-pageflip) [337.528272] Starting subtest: legacy-pageflip [337.530285] Starting dynamic subtest: pipe-A-eDP-1 [344.956336] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.427s) [344.958767] Subtest legacy-pageflip: SUCCESS (7.428s) [345.794262] [054/156] (673s left) gem_exec_big (single) [345.855098] Starting subtest: single [346.748418] Subtest single: SUCCESS (0.891s) [346.878754] [055/156] (672s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc) [347.000560] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc [347.004546] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [347.118553] [056/156] (672s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt) [347.189720] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt [347.194159] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [347.291325] [057/156] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [347.365705] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [347.369840] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [347.457990] [058/156] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [347.534510] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [347.538567] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [347.629015] [059/156] (671s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [347.710972] Starting subtest: psr-2p-pri-indfb-multidraw [347.715091] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [347.810010] [060/156] (671s left) kms_debugfs (display-off-read-all) [347.882381] Starting subtest: display-off-read-all [348.174921] Subtest display-off-read-all: SUCCESS (0.292s) [349.036859] [061/156] (670s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [349.122028] Starting subtest: fbcpsr-indfb-scaledprimary [354.879364] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.763s) [355.016880] [062/156] (664s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [355.073293] Starting subtest: invalid-multi-wait-unsubmitted [355.075459] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [355.183309] [063/156] (664s left) kms_flip (flip-vs-dpms-off-vs-modeset) [355.261527] Starting subtest: flip-vs-dpms-off-vs-modeset [355.263848] Starting dynamic subtest: A-eDP1 [358.877703] Dynamic subtest A-eDP1: SUCCESS (3.617s) [358.888417] Starting dynamic subtest: B-eDP1 [362.177047] Dynamic subtest B-eDP1: SUCCESS (3.299s) [362.188201] Starting dynamic subtest: C-eDP1 [365.415473] Dynamic subtest C-eDP1: SUCCESS (3.237s) [365.426046] Starting dynamic subtest: D-eDP1 [368.702287] Dynamic subtest D-eDP1: SUCCESS (3.285s) [368.704576] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.447s) [369.514140] [064/156] (650s left) kms_plane_alpha_blend (alpha-7efc) [369.598337] Starting subtest: alpha-7efc [369.878589] Starting dynamic subtest: pipe-A-eDP-1 [370.488391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s) [370.516830] Starting dynamic subtest: pipe-D-eDP-1 [371.853587] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s) [371.855993] Subtest alpha-7efc: SUCCESS (2.255s) [372.664996] [065/156] (647s left) kms_vrr (lobf) [372.737086] Starting subtest: lobf [372.741591] Subtest lobf: SKIP (0.000s) [372.823058] [066/156] (647s left) gem_exec_schedule (pi-ringfull) [373.006350] Starting subtest: pi-ringfull [373.008736] Starting dynamic subtest: rcs0 [373.032638] Dynamic subtest rcs0: SUCCESS (0.030s) [373.045352] Starting dynamic subtest: bcs0 [373.065250] Dynamic subtest bcs0: SUCCESS (0.032s) [373.077924] Starting dynamic subtest: vcs0 [373.096310] Dynamic subtest vcs0: SUCCESS (0.030s) [373.110261] Starting dynamic subtest: vcs1 [373.124667] Dynamic subtest vcs1: SUCCESS (0.028s) [373.139909] Starting dynamic subtest: vecs0 [373.152573] Dynamic subtest vecs0: SUCCESS (0.027s) [373.167349] Starting dynamic subtest: ccs0 [373.180493] Dynamic subtest ccs0: SUCCESS (0.027s) [373.182712] Subtest pi-ringfull: SUCCESS (0.179s) [373.404866] [067/156] (646s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [373.489561] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [380.588302] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.104s) [381.786423] [068/156] (638s left) kms_flip (2x-flip-vs-dpms-on-nop) [381.854095] Starting subtest: 2x-flip-vs-dpms-on-nop [381.861235] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.007s) [381.969841] [069/156] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [382.050232] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [382.054265] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [382.142815] [070/156] (637s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [382.228426] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [382.232561] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [382.314071] [071/156] (637s left) drm_read (empty-block) [382.447677] Starting subtest: empty-block [383.447558] Subtest empty-block: SUCCESS (1.000s) [383.578182] [072/156] (636s left) kms_prop_blob (invalid-set-prop-any) [383.639335] Starting subtest: invalid-set-prop-any [383.641780] Subtest invalid-set-prop-any: SUCCESS (0.000s) [383.741104] [073/156] (636s left) kms_cursor_edge_walk (64x64-top-bottom) [383.810471] Starting subtest: 64x64-top-bottom [383.812861] Starting dynamic subtest: pipe-A-eDP-1 [387.239633] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s) [387.249740] Starting dynamic subtest: pipe-D-eDP-1 [390.366213] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s) [390.368637] Subtest 64x64-top-bottom: SUCCESS (6.557s) [391.178120] [074/156] (629s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt) [391.265368] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt [391.269698] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [391.371499] [075/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render) [391.460130] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render [391.464885] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [391.561958] [076/156] (628s left) syncobj_timeline (multi-wait-all-available-submitted) [391.629705] Starting subtest: multi-wait-all-available-submitted [391.632133] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [391.753291] [077/156] (628s left) kms_cursor_crc (cursor-onscreen-256x85) [392.000112] Starting subtest: cursor-onscreen-256x85 [392.044964] Subtest cursor-onscreen-256x85: SKIP (0.043s) [392.215124] [078/156] (628s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [392.296105] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [392.299889] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [392.398022] [079/156] (628s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [392.457927] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [392.561836] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s) [392.651212] [080/156] (627s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [392.729322] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [392.733824] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [392.826314] [081/156] (627s left) gem_ctx_bad_destroy (invalid-default-ctx) [392.886994] Starting subtest: invalid-default-ctx [392.889365] Subtest invalid-default-ctx: SUCCESS (0.000s) [392.960058] [082/156] (627s left) kms_getfb (getfb-handle-closed) [393.035796] Starting subtest: getfb-handle-closed [393.038113] Subtest getfb-handle-closed: SUCCESS (0.000s) [393.140931] [083/156] (627s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [393.236683] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc [393.241189] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [393.345556] [084/156] (627s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy) [393.423976] Starting subtest: psrhdr-modesetfrombusy [393.428522] Subtest psrhdr-modesetfrombusy: SKIP (0.000s) [393.531385] [085/156] (627s left) perf (non-sampling-read-error) [393.675977] Starting subtest: non-sampling-read-error [393.684423] Subtest non-sampling-read-error: SUCCESS (0.008s) [393.725951] [086/156] (626s left) gem_exec_flush (basic-uc-ro-default) [393.781835] Starting subtest: basic-uc-ro-default [399.235146] Subtest basic-uc-ro-default: SUCCESS (5.452s) [399.420064] [087/156] (621s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [399.500224] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [400.146576] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s) [400.307522] [088/156] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [400.389650] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [400.393656] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [400.499027] [089/156] (620s left) kms_chamelium_audio (dp-audio-edid) [400.870584] Subtest dp-audio-edid: SKIP (0.000s) [401.683518] [090/156] (619s left) gem_softpin (allocator-nopin-reserve) [401.752873] Starting subtest: allocator-nopin-reserve [401.852285] Subtest allocator-nopin-reserve: SUCCESS (0.099s) [401.977077] [091/156] (618s left) gem_ppgtt (shrink-vs-evict-any) [402.032575] Starting subtest: shrink-vs-evict-any [410.159105] Subtest shrink-vs-evict-any: SUCCESS (8.124s) [410.238136] [092/156] (610s left) gem_exec_schedule (thriceslice) [410.305444] Starting subtest: thriceslice [410.307602] Starting dynamic subtest: rcs0 [410.351719] Dynamic subtest rcs0: SUCCESS (0.055s) [410.363408] Starting dynamic subtest: bcs0 [410.386637] Dynamic subtest bcs0: SUCCESS (0.033s) [410.396833] Starting dynamic subtest: vcs0 [410.441611] Dynamic subtest vcs0: SUCCESS (0.054s) [410.454854] Starting dynamic subtest: vcs1 [410.473021] Dynamic subtest vcs1: SUCCESS (0.030s) [410.484535] Starting dynamic subtest: vecs0 [410.525942] Dynamic subtest vecs0: SUCCESS (0.051s) [410.536866] Starting dynamic subtest: ccs0 [410.559282] Dynamic subtest ccs0: SUCCESS (0.033s) [410.561599] Subtest thriceslice: SUCCESS (0.264s) [412.263774] [093/156] (608s left) i915_drm_fdinfo (busy-hang) [412.302888] Starting subtest: busy-hang [412.305106] Starting dynamic subtest: rcs0 [412.333575] Dynamic subtest rcs0: SKIP (0.029s) [412.345057] Starting dynamic subtest: bcs0 [412.348944] Dynamic subtest bcs0: SKIP (0.001s) [412.358491] Starting dynamic subtest: vcs0 [412.362687] Dynamic subtest vcs0: SKIP (0.001s) [412.372462] Starting dynamic subtest: vcs1 [412.376542] Dynamic subtest vcs1: SKIP (0.001s) [412.385580] Starting dynamic subtest: vecs0 [412.389596] Dynamic subtest vecs0: SKIP (0.001s) [412.398548] Starting dynamic subtest: ccs0 [412.402629] Dynamic subtest ccs0: SKIP (0.001s) [412.406769] Subtest busy-hang: SKIP (0.037s) [412.444395] [094/156] (608s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [412.525111] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [412.527421] Starting dynamic subtest: pipe-A-eDP-1 [412.550211] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [412.560796] Starting dynamic subtest: pipe-B-eDP-1 [412.582366] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [412.591720] Starting dynamic subtest: pipe-C-eDP-1 [412.614030] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [412.624762] Starting dynamic subtest: pipe-D-eDP-1 [412.646740] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [412.650769] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [414.876792] [095/156] (606s left) perf (gen12-mi-rpc) [414.970884] Starting subtest: gen12-mi-rpc [414.973081] Starting dynamic subtest: rcs0 [414.987726] Dynamic subtest rcs0: SUCCESS (0.018s) [414.990083] Subtest gen12-mi-rpc: SUCCESS (0.019s) [415.032285] [096/156] (606s left) kms_joiner (invalid-modeset-ultra-joiner) [415.143772] Starting subtest: invalid-modeset-ultra-joiner [415.147772] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [415.208458] [097/156] (605s left) syncobj_wait (reset-during-wait-for-submit) [415.261479] Starting subtest: reset-during-wait-for-submit [415.363048] Subtest reset-during-wait-for-submit: SUCCESS (0.102s) [415.441175] [098/156] (605s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [415.532501] Starting subtest: yf-tiled-8bpp-rotate-90 [415.537079] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [415.639594] [099/156] (605s left) perf (blocking) [415.725147] Starting subtest: blocking [415.727458] Starting dynamic subtest: 0-rcs0 [425.755458] Dynamic subtest 0-rcs0: SUCCESS (10.028s) [425.767194] Starting dynamic subtest: 1-vecs0 [435.781040] Dynamic subtest 1-vecs0: SUCCESS (10.023s) [435.783610] Subtest blocking: SUCCESS (20.054s) [435.832372] [100/156] (585s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [435.893301] Starting subtest: x-tiled-to-vebox-yf-tiled [435.897971] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [436.079063] [101/156] (585s left) i915_query (query-regions-garbage-items) [436.136456] Starting subtest: query-regions-garbage-items [436.138702] Subtest query-regions-garbage-items: SUCCESS (0.000s) [436.246449] [102/156] (585s left) kms_properties (connector-properties-atomic) [436.323148] Starting subtest: connector-properties-atomic [436.325289] Starting dynamic subtest: pipe-A-eDP-1 [444.332554] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.009s) [444.342440] Starting dynamic subtest: pipe-None-DP-1 [444.346892] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [444.356380] Starting dynamic subtest: pipe-None-DP-2 [444.360956] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [444.369946] Starting dynamic subtest: pipe-None-DP-3 [444.374088] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [444.382944] Starting dynamic subtest: pipe-None-DP-4 [444.387047] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [444.396359] Starting dynamic subtest: pipe-None-DP-5 [444.400920] Dynamic subtest pipe-None-DP-5: SUCCESS (0.001s) [444.403227] Subtest connector-properties-atomic: SUCCESS (8.018s) [445.199281] [103/156] (576s left) kms_flip (2x-flip-vs-wf_vblank) [445.277230] Starting subtest: 2x-flip-vs-wf_vblank [445.284557] Subtest 2x-flip-vs-wf_vblank: SKIP (0.008s) [445.390246] [104/156] (576s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [445.468957] Starting subtest: invalidate-primary-flip-overlay [456.178599] Subtest invalidate-primary-flip-overlay: SUCCESS (10.708s) [456.296039] [105/156] (565s left) gem_lmem_swapping (parallel-random-engines) [456.335217] Subtest parallel-random-engines: SKIP (0.000s) [456.376526] [106/156] (565s left) perf_pmu (semaphore-wait) [456.413674] Starting subtest: semaphore-wait [456.415752] Starting dynamic subtest: rcs0 [456.931260] Dynamic subtest rcs0: SUCCESS (0.515s) [456.943047] Starting dynamic subtest: bcs0 [457.445513] Dynamic subtest bcs0: SUCCESS (0.511s) [457.462077] Starting dynamic subtest: vcs0 [457.960061] Dynamic subtest vcs0: SUCCESS (0.512s) [457.973857] Starting dynamic subtest: vcs1 [458.474024] Dynamic subtest vcs1: SUCCESS (0.511s) [458.485742] Starting dynamic subtest: vecs0 [458.986724] Dynamic subtest vecs0: SUCCESS (0.510s) [458.999659] Starting dynamic subtest: ccs0 [459.500764] Dynamic subtest ccs0: SUCCESS (0.511s) [459.503500] Subtest semaphore-wait: SUCCESS (3.087s) [459.627504] [107/156] (561s left) kms_psr (fbc-psr-cursor-blt) [459.711816] Starting subtest: fbc-psr-cursor-blt [459.714123] Starting dynamic subtest: eDP-1 [459.718382] Dynamic subtest eDP-1: SKIP (0.000s) [459.722709] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [459.789070] [108/156] (561s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite) [459.864622] Starting subtest: fbchdr-rgb101010-draw-pwrite [459.868635] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s) [459.969212] [109/156] (561s left) kms_atomic_transition (plane-all-transition) [460.040400] Starting subtest: plane-all-transition [460.042651] Starting dynamic subtest: pipe-A-eDP-1 [462.534153] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [462.856686] Starting dynamic subtest: pipe-B-eDP-1 [466.139486] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.291s) [466.444223] Subtest plane-all-transition: SUCCESS (6.402s) [467.265392] [110/156] (554s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [467.322865] Starting subtest: multi-wait-all-for-submit-unsubmitted [467.424238] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [467.500945] [111/156] (554s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [467.586959] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [467.591101] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [467.674672] [112/156] (554s left) kms_feature_discovery (psr1) [467.749226] Starting subtest: psr1 [467.751452] Subtest psr1: SUCCESS (0.000s) [467.834391] [113/156] (553s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt) [467.915682] Starting subtest: fbchdr-farfromfence-mmap-gtt [467.920010] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s) [468.004268] [114/156] (553s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [468.103081] Starting subtest: short-flip-before-cursor-atomic-transitions [469.056836] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.954s) [469.917234] [115/156] (551s left) gem_ctx_shared (q-smoketest-all) [469.981430] Starting subtest: Q-smoketest-all [502.368036] Subtest Q-smoketest-all: SUCCESS (32.337s) [504.292486] [116/156] (517s left) kms_content_protection (srm) [504.427737] Starting subtest: srm [504.434826] Subtest srm: SKIP (0.004s) [504.544595] [117/156] (517s left) kms_addfb_basic (bad-pitch-63) [504.594855] Starting subtest: bad-pitch-63 [504.597181] Subtest bad-pitch-63: SUCCESS (0.000s) [504.709302] [118/156] (517s left) gem_mmap_wc (set-cache-level) [504.773487] Subtest set-cache-level: SKIP (0.000s) [504.839574] [119/156] (517s left) kms_pm_dc (dc5-psr) [505.922069] Starting subtest: dc5-psr [508.898533] Subtest dc5-psr: SUCCESS (2.976s) [509.725712] [120/156] (512s left) gem_ctx_param (invalid-set-no-zeromap) [509.797641] Starting subtest: invalid-set-no-zeromap [509.799878] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [509.871936] [121/156] (512s left) i915_hangman (gt-error-state-capture) [509.949100] Starting subtest: gt-error-state-capture [509.951371] Starting dynamic subtest: rcs0 [521.179900] Dynamic subtest rcs0: SUCCESS (11.229s) [521.191341] Starting dynamic subtest: bcs0 [531.163896] Dynamic subtest bcs0: SUCCESS (9.981s) [531.176935] Starting dynamic subtest: vcs0 [541.212238] Dynamic subtest vcs0: SUCCESS (10.045s) [541.226064] Starting dynamic subtest: vcs1 [552.220365] Dynamic subtest vcs1: SUCCESS (11.005s) [552.233879] Starting dynamic subtest: vecs0 [564.203838] Dynamic subtest vecs0: SUCCESS (11.963s) [564.214685] Starting dynamic subtest: ccs0 [576.219461] Dynamic subtest ccs0: SUCCESS (12.031s) [576.222636] Subtest gt-error-state-capture: SUCCESS (66.268s) [576.306602] [122/156] (445s left) gem_mmap_gtt (basic-write-gtt) [576.357517] Subtest basic-write-gtt: SKIP (0.000s) [576.413682] [123/156] (445s left) kms_big_fb (linear-8bpp-rotate-180) [576.495840] Starting subtest: linear-8bpp-rotate-180 [577.753085] Subtest linear-8bpp-rotate-180: SUCCESS (1.257s) [577.875590] [124/156] (444s left) gem_mmap_gtt (fault-concurrent-y) [577.925714] Subtest fault-concurrent-Y: SKIP (0.000s) [577.993536] [125/156] (444s left) i915_pm_rps (engine-order) [578.053051] Starting subtest: engine-order [584.269582] Subtest engine-order: SUCCESS (6.213s) [584.395814] [126/156] (437s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [584.446574] Starting subtest: single-wait-all-for-submit-available-signaled [584.448900] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [584.546576] [127/156] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [584.628551] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [591.920358] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.297s) [592.037087] [128/156] (430s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw) [592.116311] Starting subtest: fbchdr-2p-pri-indfb-multidraw [592.120568] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s) [592.239910] [129/156] (430s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [592.292614] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [592.296956] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [592.480849] [130/156] (430s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt) [592.557644] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt [592.561926] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [592.649819] [131/156] (429s left) gem_ctx_exec (basic-invalid-context) [592.707152] Starting subtest: basic-invalid-context [592.712086] Subtest basic-invalid-context: SUCCESS (0.005s) [592.835729] [132/156] (429s left) gem_exec_fence (syncobj-timeline-repeat) [593.400436] Starting subtest: syncobj-timeline-repeat [593.639639] Subtest syncobj-timeline-repeat: SUCCESS (0.240s) [595.364880] [133/156] (427s left) kms_flip (flip-vs-rmfb) [595.439089] Starting subtest: flip-vs-rmfb [595.441295] Starting dynamic subtest: A-eDP1 [604.112041] Dynamic subtest A-eDP1: SUCCESS (8.674s) [604.121966] Starting dynamic subtest: B-eDP1 [612.755592] Dynamic subtest B-eDP1: SUCCESS (8.642s) [612.765953] Starting dynamic subtest: C-eDP1 [621.391124] Dynamic subtest C-eDP1: SUCCESS (8.634s) [621.402278] Starting dynamic subtest: D-eDP1 [630.019355] Dynamic subtest D-eDP1: SUCCESS (8.626s) [630.023929] Subtest flip-vs-rmfb: SUCCESS (34.584s) [631.209987] [134/156] (391s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [631.296859] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [631.300932] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [631.404221] [135/156] (391s left) kms_atomic_transition (modeset-transition) [631.471449] Starting subtest: modeset-transition [631.473702] Starting dynamic subtest: 1x-outputs [642.532831] Dynamic subtest 1x-outputs: SUCCESS (11.062s) [642.535650] Subtest modeset-transition: SUCCESS (11.063s) [643.414759] [136/156] (379s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [643.504448] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [643.508527] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [643.600261] [137/156] (379s left) kms_psr (fbc-pr-suspend) [643.671114] Starting subtest: fbc-pr-suspend [643.675333] Subtest fbc-pr-suspend: SKIP (0.000s) [643.760205] [138/156] (379s left) kms_big_fb (y-tiled-32bpp-rotate-270) [643.844190] Starting subtest: y-tiled-32bpp-rotate-270 [643.848714] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [643.944785] [139/156] (378s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [644.024690] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [644.026915] Starting dynamic subtest: pipe-A-eDP-1 [644.084462] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [644.095315] Starting dynamic subtest: pipe-B-eDP-1 [644.154101] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [644.165237] Starting dynamic subtest: pipe-C-eDP-1 [644.223457] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [644.234394] Starting dynamic subtest: pipe-D-eDP-1 [644.294074] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [644.298388] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [646.584854] [140/156] (376s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt) [646.672472] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt [646.676715] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [646.766217] [141/156] (376s left) kms_plane_multiple (tiling-yf) [646.829727] Starting subtest: tiling-yf [646.833779] Subtest tiling-yf: SKIP (0.000s) [646.919809] [142/156] (376s left) gem_workarounds (suspend-resume-fd) [646.985663] Starting subtest: suspend-resume-fd [663.451416] Subtest suspend-resume-fd: SUCCESS (2.073s) [663.591395] [143/156] (359s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt) [663.695419] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt [663.700366] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [663.796318] [144/156] (359s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [663.867357] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [663.870128] Starting dynamic subtest: pipe-A [663.992278] Dynamic subtest pipe-A: SKIP (0.118s) [664.003938] Starting dynamic subtest: pipe-B [665.171203] Dynamic subtest pipe-B: SKIP (1.176s) [665.184611] Starting dynamic subtest: pipe-C [666.403699] Dynamic subtest pipe-C: SUCCESS (1.236s) [666.415640] Starting dynamic subtest: pipe-D [667.641143] Dynamic subtest pipe-D: SUCCESS (1.234s) [667.643786] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.767s) [668.843307] [145/156] (354s left) kms_cursor_crc (cursor-sliding-128x42) [669.037459] Starting subtest: cursor-sliding-128x42 [669.087142] Subtest cursor-sliding-128x42: SKIP (0.042s) [669.302513] [146/156] (353s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [669.372829] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [669.375405] Starting dynamic subtest: pipe-A [670.434101] Dynamic subtest pipe-A: SUCCESS (1.061s) [670.444661] Starting dynamic subtest: pipe-B [672.545893] Dynamic subtest pipe-B: SUCCESS (2.108s) [672.556871] Starting dynamic subtest: pipe-C [673.739445] Dynamic subtest pipe-C: SUCCESS (1.191s) [673.752521] Starting dynamic subtest: pipe-D [674.966248] Dynamic subtest pipe-D: SUCCESS (1.224s) [674.968609] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.588s) [676.154553] [147/156] (347s left) gem_tiled_wb [676.287951] [148/156] (347s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [676.374996] Starting subtest: fbcpsrhdr-tiling-linear [676.380345] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [676.464206] [149/156] (346s left) gem_eio (wait-wedge-1us) [676.652503] Starting subtest: wait-wedge-1us [677.681273] Subtest wait-wedge-1us: SUCCESS (1.028s) [677.808783] [150/156] (345s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [677.891477] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc [677.896553] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [677.988187] [151/156] (345s left) kms_addfb_basic (no-handle) [678.044742] Starting subtest: no-handle [678.047549] Subtest no-handle: SUCCESS (0.000s) [678.171268] [152/156] (345s left) gem_ctx_persistence (heartbeat-stop) [678.239386] Starting subtest: heartbeat-stop [678.244571] Subtest heartbeat-stop: SKIP (0.000s) [678.353662] [153/156] (345s left) kms_chamelium_frames (dp-crc-single) [678.723685] Subtest dp-crc-single: SKIP (0.000s) [679.581186] [154/156] (344s left) kms_lease (lease-unleased-crtc) [679.652025] Starting subtest: lease-unleased-crtc [679.654647] Starting dynamic subtest: pipe-A-eDP-1 [679.940389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [679.952685] Starting dynamic subtest: pipe-B-eDP-1 [680.737354] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.794s) [680.749823] Starting dynamic subtest: pipe-C-eDP-1 [680.752671] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [680.763370] Starting dynamic subtest: pipe-D-eDP-1 [680.765648] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [680.767977] Subtest lease-unleased-crtc: SUCCESS (1.098s) [681.122097] [155/156] (342s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [681.176374] Starting subtest: multi-wait-for-submit-unsubmitted [681.283376] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [681.374991] [156/156] (342s left) kms_flip (2x-busy-flip) [681.448482] Starting subtest: 2x-busy-flip [681.457843] Subtest 2x-busy-flip: SKIP (0.007s) [681.568141] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: prime_busy results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_vblank results: parsing output: 8/ for test: gem_mmap_offset results: parsing output: 9/ for test: fbdev results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: sysfs_timeslice_duration results: parsing output: 12/ for test: gem_exec_reloc results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gen9_exec_parse results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_exec_whisper results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: gem_fenced_exec_thrash results: parsing output: 21/ for test: api_intel_bb results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_hdr results: parsing output: 24/ for test: kms_prime results: parsing output: 25/ for test: api_intel_bb results: parsing output: 26/ for test: syncobj_wait results: parsing output: 27/ for test: gem_vm_create results: parsing output: 28/ for test: kms_ccs results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: dmabuf_sync_file results: parsing output: 31/ for test: gem_exec_balancer results: parsing output: 32/ for test: syncobj_timeline results: parsing output: 33/ for test: prime_udl results: parsing output: 34/ for test: kms_color results: parsing output: 35/ for test: syncobj_basic results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_exec_schedule results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_async_flips results: parsing output: 42/ for test: gem_workarounds results: parsing output: 43/ for test: kms_flip_scaled_crc results: parsing output: 44/ for test: kms_chamelium_hpd results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_mmap_gtt results: parsing output: 48/ for test: kms_plane results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: kms_atomic_interruptible results: parsing output: 53/ for test: gem_exec_big results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_debugfs results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_flip results: parsing output: 63/ for test: kms_plane_alpha_blend results: parsing output: 64/ for test: kms_vrr results: parsing output: 65/ for test: gem_exec_schedule results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: drm_read results: parsing output: 71/ for test: kms_prop_blob results: parsing output: 72/ for test: kms_cursor_edge_walk results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_ctx_bad_destroy results: parsing output: 81/ for test: kms_getfb results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: perf results: parsing output: 85/ for test: gem_exec_flush results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_chamelium_audio results: parsing output: 89/ for test: gem_softpin results: parsing output: 90/ for test: gem_ppgtt results: parsing output: 91/ for test: gem_exec_schedule results: parsing output: 92/ for test: i915_drm_fdinfo results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: perf results: parsing output: 95/ for test: kms_joiner results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: perf results: parsing output: 99/ for test: gem_render_copy results: parsing output: 100/ for test: i915_query results: parsing output: 101/ for test: kms_properties results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: kms_psr_stress_test results: parsing output: 104/ for test: gem_lmem_swapping results: parsing output: 105/ for test: perf_pmu results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_atomic_transition results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_feature_discovery results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_ctx_shared results: parsing output: 115/ for test: kms_content_protection results: parsing output: 116/ for test: kms_addfb_basic results: parsing output: 117/ for test: gem_mmap_wc results: parsing output: 118/ for test: kms_pm_dc results: parsing output: 119/ for test: gem_ctx_param results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: i915_pm_rps results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_render_copy results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_ctx_exec results: parsing output: 131/ for test: gem_exec_fence results: parsing output: 132/ for test: kms_flip results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_atomic_transition results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_psr results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: kms_ccs results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_plane_multiple results: parsing output: 141/ for test: gem_workarounds results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_plane_scaling results: parsing output: 144/ for test: kms_cursor_crc results: parsing output: 145/ for test: kms_plane_scaling results: parsing output: 146/ for test: gem_tiled_wb results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: gem_eio results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_addfb_basic results: parsing output: 151/ for test: gem_ctx_persistence results: parsing output: 152/ for test: kms_chamelium_frames results: parsing output: 153/ for test: kms_lease results: parsing output: 154/ for test: syncobj_wait results: parsing output: 155/ for test: kms_flip Done.