[58.703698] Initializing watchdogs
[58.703748]   /dev/watchdog0
[58.720792] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.725402] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.727753] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.730306] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[58.830544] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[65.983607] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.103s)
[66.101215] [002/133] (953s left) gem_exec_params (rsvd2-dirt)
[66.162892] Starting subtest: rsvd2-dirt
[66.164735] Subtest rsvd2-dirt: SKIP (0.000s)
[66.260615] [003/133] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[66.344219] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[73.451746] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.088s)
[73.681966] [004/133] (945s left) gem_mmap_gtt (big-bo-tiledy)
[73.732364] Subtest big-bo-tiledY: SKIP (0.000s)
[73.792274] [005/133] (945s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[73.884461] Starting subtest: fbc-pr-cursor-mmap-cpu
[73.886462] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[73.951690] [006/133] (945s left) api_intel_bb (intel-bb-blit-none)
[74.005944] Starting subtest: intel-bb-blit-none
[78.208312] Subtest intel-bb-blit-none: SUCCESS (4.188s)
[78.301378] [007/133] (941s left) gem_mmap_gtt (basic-write-read)
[78.349991] Subtest basic-write-read: SKIP (0.000s)
[78.402898] [008/133] (941s left) kms_lease (simple-lease)
[78.486789] Starting subtest: simple-lease
[78.487891] Starting dynamic subtest: pipe-A-eDP-1
[79.010584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.522s)
[79.021372] Starting dynamic subtest: pipe-B-eDP-1
[80.475176] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.461s)
[80.482628] Starting dynamic subtest: pipe-C-eDP-1
[81.871603] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[81.881340] Starting dynamic subtest: pipe-D-eDP-1
[83.293261] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.420s)
[83.294448] Subtest simple-lease: SUCCESS (4.804s)
[84.087787] [009/133] (935s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[84.189601] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[85.037898] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s)
[85.194835] [010/133] (934s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[85.453200] Starting subtest: cursor-rapid-movement-256x85
[85.496412] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[85.660626] [011/133] (933s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[85.739962] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[85.740937] Starting dynamic subtest: pipe-A-eDP-1
[85.751280] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.761708] Starting dynamic subtest: pipe-B-eDP-1
[85.771392] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.779845] Starting dynamic subtest: pipe-C-eDP-1
[85.787768] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.794101] Starting dynamic subtest: pipe-D-eDP-1
[85.802505] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.804142] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[87.962078] [012/133] (931s left) kms_psr (pr-primary-blt)
[88.038414] Starting subtest: pr-primary-blt
[88.040328] Subtest pr-primary-blt: SKIP (0.000s)
[88.100675] [013/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[88.192791] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[88.194398] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[88.277931] [014/133] (931s left) gem_ppgtt (blt-vs-render-ctx0)
[88.334545] Starting subtest: blt-vs-render-ctx0
[121.217308] Subtest blt-vs-render-ctx0: SUCCESS (32.866s)
[121.316661] [015/133] (898s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[121.458076] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[121.459882] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[121.525539] [016/133] (898s left) i915_drm_fdinfo (all-busy-idle-check-all)
[121.563936] Starting subtest: all-busy-idle-check-all
[121.568491] Subtest all-busy-idle-check-all: SKIP (0.004s)
[121.622874] [017/133] (898s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[121.714081] Starting subtest: bad-pixel-format-y-tiled-ccs
[121.714981] Starting dynamic subtest: pipe-A-eDP-1
[121.723421] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[121.732893] Starting dynamic subtest: pipe-B-eDP-1
[121.741429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[121.748417] Starting dynamic subtest: pipe-C-eDP-1
[121.756110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[121.762900] Starting dynamic subtest: pipe-D-eDP-1
[121.771102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[121.773176] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[124.026571] [018/133] (895s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[124.126486] Starting subtest: 4-tiled-8bpp-rotate-270
[124.149752] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.023s)
[124.272725] [019/133] (895s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[124.337249] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[124.441987] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[124.516468] [020/133] (895s left) gem_spin_batch (resubmit)
[124.585404] Starting subtest: resubmit
[124.586378] Starting dynamic subtest: rcs0
[124.591460] Dynamic subtest rcs0: SUCCESS (0.006s)
[124.601020] Starting dynamic subtest: bcs0
[124.601983] Dynamic subtest bcs0: SUCCESS (0.002s)
[124.608657] Starting dynamic subtest: vcs0
[124.609522] Dynamic subtest vcs0: SUCCESS (0.003s)
[124.616625] Starting dynamic subtest: vcs1
[124.617546] Dynamic subtest vcs1: SUCCESS (0.002s)
[124.624434] Starting dynamic subtest: vecs0
[124.625335] Dynamic subtest vecs0: SUCCESS (0.003s)
[124.631912] Starting dynamic subtest: ccs0
[124.632806] Dynamic subtest ccs0: SUCCESS (0.004s)
[124.633706] Subtest resubmit: SUCCESS (0.022s)
[124.840212] [021/133] (895s left) gem_mmap_offset (basic-uaf)
[124.898116] Starting subtest: basic-uaf
[124.899599] Subtest basic-uaf: SUCCESS (0.002s)
[124.997410] [022/133] (894s left) kms_rotation_crc (primary-rotation-270)
[125.084021] Starting subtest: primary-rotation-270
[125.086413] Subtest primary-rotation-270: SKIP (0.001s)
[125.176158] [023/133] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[125.271142] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[125.272979] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[125.355983] [024/133] (894s left) kms_vrr (seamless-rr-switch-drrs)
[125.442853] Starting subtest: seamless-rr-switch-drrs
[125.445225] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[125.506844] [025/133] (894s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[125.591980] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[125.593627] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[125.676279] [026/133] (894s left) syncobj_wait (reset-unsignaled)
[125.724236] Starting subtest: reset-unsignaled
[125.725125] Subtest reset-unsignaled: SUCCESS (0.000s)
[125.835226] [027/133] (894s left) gem_shrink (reclaim)
[125.884252] Starting subtest: reclaim
[128.319247] Subtest reclaim: SUCCESS (2.419s)
[128.413204] [028/133] (891s left) gem_pread (exhaustion)
[128.466086] Subtest exhaustion: SKIP (0.000s)
[128.520556] [029/133] (891s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[128.572484] Starting subtest: etime-single-wait-available-unsubmitted
[128.692092] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[128.750425] [030/133] (891s left) prime_busy (before)
[128.803645] Starting subtest: before
[128.807378] Starting dynamic subtest: rcs0
[128.838924] Dynamic subtest rcs0: SUCCESS (0.032s)
[128.848352] Starting dynamic subtest: bcs0
[128.900553] Dynamic subtest bcs0: SUCCESS (0.060s)
[128.909561] Starting dynamic subtest: vcs0
[128.941900] Dynamic subtest vcs0: SUCCESS (0.041s)
[128.949844] Starting dynamic subtest: vcs1
[128.983746] Dynamic subtest vcs1: SUCCESS (0.042s)
[128.991754] Starting dynamic subtest: vecs0
[129.025573] Dynamic subtest vecs0: SUCCESS (0.041s)
[129.033546] Starting dynamic subtest: ccs0
[129.070363] Dynamic subtest ccs0: SUCCESS (0.044s)
[129.179341] Subtest before: SUCCESS (0.374s)
[129.247146] [031/133] (890s left) gem_exec_schedule (submit-golden-slice)
[129.299360] Starting subtest: submit-golden-slice
[129.300305] Starting dynamic subtest: rcs0
[129.360049] Dynamic subtest rcs0: SUCCESS (0.060s)
[129.369802] Starting dynamic subtest: bcs0
[129.415694] Dynamic subtest bcs0: SUCCESS (0.055s)
[129.424928] Starting dynamic subtest: vcs0
[129.472100] Dynamic subtest vcs0: SUCCESS (0.056s)
[129.480873] Starting dynamic subtest: vcs1
[129.522732] Dynamic subtest vcs1: SUCCESS (0.050s)
[129.530711] Starting dynamic subtest: vecs0
[129.568164] Dynamic subtest vecs0: SUCCESS (0.045s)
[129.576490] Starting dynamic subtest: ccs0
[129.611701] Dynamic subtest ccs0: SUCCESS (0.043s)
[129.613069] Subtest submit-golden-slice: SUCCESS (0.313s)
[131.459397] [032/133] (888s left) syncobj_wait (single-wait-submitted)
[131.505843] Starting subtest: single-wait-submitted
[131.608905] Subtest single-wait-submitted: SUCCESS (0.102s)
[131.683140] [033/133] (888s left) gem_basic (bad-close)
[131.725993] Starting subtest: bad-close
[131.727672] Subtest bad-close: SUCCESS (0.000s)
[131.809336] [034/133] (888s left) kms_frontbuffer_tracking (psr-slowdraw)
[131.898909] Starting subtest: psr-slowdraw
[157.230693] Subtest psr-slowdraw: SUCCESS (25.330s)
[157.353094] [035/133] (863s left) kms_psr (psr2-sprite-blt)
[157.437364] Starting subtest: psr2-sprite-blt
[157.438276] Starting dynamic subtest: eDP-1
[159.166731] Dynamic subtest eDP-1: SUCCESS (1.729s)
[159.167656] Subtest psr2-sprite-blt: SUCCESS (1.730s)
[160.049698] [036/133] (860s left) i915_query (engine-info-invalid)
[160.093740] Starting subtest: engine-info-invalid
[160.094706] Subtest engine-info-invalid: SUCCESS (0.000s)
[160.182675] [037/133] (860s left) kms_psr (fbc-pr-sprite-render)
[160.276270] Starting subtest: fbc-pr-sprite-render
[160.278138] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[160.349368] [038/133] (860s left) syncobj_timeline (single-wait-all-signaled)
[160.393633] Starting subtest: single-wait-all-signaled
[160.394671] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[160.476400] [039/133] (860s left) kms_color (ctm-max)
[160.570925] Starting subtest: ctm-max
[160.571741] Starting dynamic subtest: pipe-A-eDP-1
[161.291810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[161.299048] Starting dynamic subtest: pipe-B-eDP-1
[162.753417] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s)
[162.764457] Starting dynamic subtest: pipe-C-eDP-1
[164.121663] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[164.129635] Starting dynamic subtest: pipe-D-eDP-1
[165.454621] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[165.455596] Subtest ctm-max: SUCCESS (4.883s)
[166.250303] [040/133] (854s left) kms_draw_crc (draw-method-mmap-cpu)
[166.334424] Starting subtest: draw-method-mmap-cpu
[166.335244] Starting dynamic subtest: xrgb8888-untiled
[166.566849] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[166.576073] Starting dynamic subtest: rgb565-untiled
[166.766611] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[166.773628] Starting dynamic subtest: xrgb2101010-untiled
[166.978092] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[166.985270] Starting dynamic subtest: xbgr16161616f-untiled
[167.188970] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[167.196257] Starting dynamic subtest: xrgb8888-xtiled
[167.311271] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[167.319785] Starting dynamic subtest: rgb565-xtiled
[167.444624] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[167.455451] Starting dynamic subtest: xrgb2101010-xtiled
[167.555785] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[167.564047] Starting dynamic subtest: xbgr16161616f-xtiled
[167.689021] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[167.699113] Starting dynamic subtest: xrgb8888-4tiled
[167.833379] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[167.840784] Starting dynamic subtest: rgb565-4tiled
[167.978514] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[167.986603] Starting dynamic subtest: xrgb2101010-4tiled
[168.111271] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[168.119565] Starting dynamic subtest: xbgr16161616f-4tiled
[168.255863] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[168.257666] Subtest draw-method-mmap-cpu: SUCCESS (1.923s)
[168.343357] [041/133] (852s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[168.435689] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[168.437400] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[168.512444] [042/133] (852s left) gem_eio (wait-10ms)
[168.758476] Starting subtest: wait-10ms
[169.140405] Subtest wait-10ms: SUCCESS (0.383s)
[169.265378] [043/133] (851s left) kms_plane_multiple (2x-tiling-y)
[169.352238] Starting subtest: 2x-tiling-y
[169.353779] Subtest 2x-tiling-y: SKIP (0.000s)
[169.420085] [044/133] (851s left) gem_exec_params (invalid-fence-in)
[169.476445] Starting subtest: invalid-fence-in
[169.477307] Subtest invalid-fence-in: SUCCESS (0.000s)
[169.574717] [045/133] (851s left) kms_vblank (wait-idle-hang)
[169.663898] Starting subtest: wait-idle-hang
[169.665536] Starting dynamic subtest: pipe-A-eDP-1
[196.125202] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.458s)
[196.134184] Starting dynamic subtest: pipe-D-eDP-1
[211.102063] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[211.102900] Subtest wait-idle-hang: SUCCESS (41.436s)
[211.896332] [046/133] (808s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[212.022825] Starting subtest: 2x-cursor-vs-flip-atomic
[212.025592] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[212.163546] [047/133] (808s left) gem_exec_schedule (pi-common)
[212.354876] Starting subtest: pi-common
[212.356064] Starting dynamic subtest: rcs0
[212.463230] Dynamic subtest rcs0: SUCCESS (0.108s)
[212.472117] Starting dynamic subtest: bcs0
[212.491172] Dynamic subtest bcs0: SUCCESS (0.027s)
[212.504511] Starting dynamic subtest: vcs0
[212.519164] Dynamic subtest vcs0: SUCCESS (0.027s)
[212.535416] Starting dynamic subtest: vcs1
[212.544686] Dynamic subtest vcs1: SUCCESS (0.025s)
[212.561371] Starting dynamic subtest: vecs0
[212.570395] Dynamic subtest vecs0: SUCCESS (0.025s)
[212.577761] Starting dynamic subtest: ccs0
[212.597124] Dynamic subtest ccs0: SUCCESS (0.026s)
[212.597916] Subtest pi-common: SUCCESS (0.243s)
[212.816547] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[212.818566] [048/133] (807s left) gem_exec_flush (basic-wb-ro-before-default)
[212.879442] Starting subtest: basic-wb-ro-before-default
[218.337315] Subtest basic-wb-ro-before-default: SUCCESS (5.458s)
[218.516700] [049/133] (802s left) kms_universal_plane (universal-plane-pageflip-windowed)
[218.614935] Starting subtest: universal-plane-pageflip-windowed
[218.615842] Starting dynamic subtest: pipe-A-eDP-1
[219.209602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[219.217372] Starting dynamic subtest: pipe-B-eDP-1
[220.438286] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s)
[220.446834] Starting dynamic subtest: pipe-C-eDP-1
[221.651986] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[221.660082] Starting dynamic subtest: pipe-D-eDP-1
[222.890713] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[222.891506] Subtest universal-plane-pageflip-windowed: SUCCESS (4.276s)
[223.747813] [050/133] (797s left) kms_content_protection (type1)
[223.875312] Starting subtest: type1
[223.877203] Subtest type1: SKIP (0.000s)
[223.977124] [051/133] (796s left) prime_mmap (test_forked_cpu_write)
[224.019796] Starting subtest: test_forked_cpu_write
[224.020755] Starting dynamic subtest: test_forked_cpu_write-smem
[224.026951] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[224.027929] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[224.116813] [052/133] (796s left) gem_exec_fence (syncobj-timeline-signal)
[224.660232] Starting subtest: syncobj-timeline-signal
[224.661339] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[226.411277] [053/133] (794s left) gem_lmem_swapping (heavy-multi)
[226.448710] Subtest heavy-multi: SKIP (0.000s)
[226.485691] [054/133] (794s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[226.576585] Starting subtest: stress-xrgb8888-xtiled
[232.586496] Subtest stress-xrgb8888-xtiled: SUCCESS (6.010s)
[232.632619] [055/133] (788s left) gem_exec_balancer (persistence)
[232.928054] Starting subtest: persistence
[233.923972] Subtest persistence: SUCCESS (1.017s)
[234.015304] [056/133] (787s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[234.111518] Starting subtest: x-tiled-64bpp-rotate-90
[234.131613] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[234.240503] [057/133] (786s left) perf (polling)
[234.376377] Starting subtest: polling
[234.377484] Starting dynamic subtest: 0-rcs0
[244.458459] Dynamic subtest 0-rcs0: SUCCESS (10.036s)
[244.468407] Starting dynamic subtest: 1-vecs0
[254.479209] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[254.480399] Subtest polling: SUCCESS (20.057s)
[254.513748] [058/133] (766s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[254.625359] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[254.626831] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[254.722594] [059/133] (766s left) kms_chamelium_edid (dp-mode-timings)
[255.110612] Subtest dp-mode-timings: SKIP (0.000s)
[255.940974] [060/133] (765s left) kms_pm_rpm (modeset-pc8-residency-stress)
[257.480420] Starting subtest: modeset-pc8-residency-stress
[257.482866] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[258.209524] [061/133] (763s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[258.310474] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[258.312230] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[258.404850] [062/133] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[258.510162] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[258.511857] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[258.608537] [063/133] (762s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[258.699614] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[258.700507] Starting dynamic subtest: pipe-A
[258.763967] Dynamic subtest pipe-A: SUCCESS (0.065s)
[258.780213] Starting dynamic subtest: pipe-B
[259.941614] Dynamic subtest pipe-B: SUCCESS (1.176s)
[259.953654] Starting dynamic subtest: pipe-C
[261.063264] Dynamic subtest pipe-C: SUCCESS (1.120s)
[261.072151] Starting dynamic subtest: pipe-D
[262.185428] Dynamic subtest pipe-D: SUCCESS (1.121s)
[262.186346] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.487s)
[263.330822] [064/133] (757s left) kms_flip (busy-flip)
[263.426545] Starting subtest: busy-flip
[263.430885] Starting dynamic subtest: A-eDP1
[265.159517] Dynamic subtest A-eDP1: SUCCESS (1.728s)
[265.169285] Starting dynamic subtest: B-eDP1
[266.885504] Dynamic subtest B-eDP1: SUCCESS (1.724s)
[266.899910] Starting dynamic subtest: C-eDP1
[268.608262] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[268.619707] Starting dynamic subtest: D-eDP1
[270.254844] Dynamic subtest D-eDP1: SUCCESS (1.644s)
[270.257569] Subtest busy-flip: SUCCESS (6.831s)
[271.419679] [065/133] (749s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[271.508843] Starting subtest: fbc-rgb565-draw-mmap-cpu
[275.598188] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.089s)
[276.740926] [066/133] (744s left) kms_flip (flip-vs-blocking-wf-vblank)
[276.824832] Starting subtest: flip-vs-blocking-wf-vblank
[276.826912] Starting dynamic subtest: A-eDP1
[285.755440] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[285.766430] Starting dynamic subtest: B-eDP1
[294.685948] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[294.695121] Starting dynamic subtest: C-eDP1
[303.653330] Dynamic subtest C-eDP1: SUCCESS (8.928s)
[303.661246] Starting dynamic subtest: D-eDP1
[312.544638] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[312.548120] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.723s)
[313.764945] [067/133] (707s left) core_getversion (all-cards)
[313.801349] Starting subtest: all-cards
[313.810201] Subtest all-cards: SUCCESS (0.011s)
[313.864293] [068/133] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[313.948579] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[313.950243] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[314.049555] [069/133] (707s left) perf_pmu (rc6-suspend)
[314.084808] Starting subtest: rc6-suspend
[337.036491] Subtest rc6-suspend: SUCCESS (8.837s)
[339.384482] [070/133] (684s left) kms_prop_blob (blob-multiple)
[339.441359] Starting subtest: blob-multiple
[339.443855] Subtest blob-multiple: SUCCESS (0.002s)
[339.537513] [071/133] (684s left) kms_scaling_modes (scaling-mode-full-aspect)
[339.624356] Starting subtest: scaling-mode-full-aspect
[339.625305] Starting dynamic subtest: pipe-A-eDP-1
[339.717921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[339.728606] Starting dynamic subtest: pipe-B-eDP-1
[340.888905] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s)
[340.902269] Starting dynamic subtest: pipe-C-eDP-1
[342.040043] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[342.051933] Starting dynamic subtest: pipe-D-eDP-1
[343.200922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[343.201934] Subtest scaling-mode-full-aspect: SUCCESS (3.493s)
[344.382898] [072/133] (679s left) gem_ringfill (engines-basic)
[350.400744] Starting subtest: engines-basic
[350.401863] Starting dynamic subtest: rcs0
[350.446290] Dynamic subtest rcs0: SUCCESS (0.051s)
[350.460676] Starting dynamic subtest: bcs0
[350.493692] Dynamic subtest bcs0: SUCCESS (0.045s)
[350.507921] Starting dynamic subtest: vcs0
[350.537655] Dynamic subtest vcs0: SUCCESS (0.042s)
[350.549517] Starting dynamic subtest: vcs1
[350.583005] Dynamic subtest vcs1: SUCCESS (0.043s)
[350.594415] Starting dynamic subtest: vecs0
[350.627597] Dynamic subtest vecs0: SUCCESS (0.043s)
[350.638613] Starting dynamic subtest: ccs0
[350.673543] Dynamic subtest ccs0: SUCCESS (0.044s)
[350.676185] Subtest engines-basic: SUCCESS (0.280s)
[350.752651] [073/133] (672s left) kms_big_fb (linear-32bpp-rotate-180)
[350.849833] Starting subtest: linear-32bpp-rotate-180
[352.428700] Subtest linear-32bpp-rotate-180: SUCCESS (1.568s)
[352.589208] [074/133] (671s left) syncobj_basic (bad-pad-fd-to-handle)
[352.650631] Starting subtest: bad-pad-fd-to-handle
[352.651731] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[352.733899] [075/133] (671s left) kms_addfb_basic (unused-offsets)
[352.792972] Starting subtest: unused-offsets
[352.794306] Subtest unused-offsets: SUCCESS (0.000s)
[352.910556] [076/133] (670s left) kms_chamelium_audio (hdmi-audio)
[353.293495] Subtest hdmi-audio: SKIP (0.000s)
[354.090834] [077/133] (669s left) kms_plane (planar-pixel-format-settings)
[354.181465] Starting subtest: planar-pixel-format-settings
[354.249420] Subtest planar-pixel-format-settings: SUCCESS (0.068s)
[354.352272] [078/133] (669s left) i915_drm_fdinfo (virtual-busy-idle-all)
[354.390591] Starting subtest: virtual-busy-idle-all
[354.392277] Subtest virtual-busy-idle-all: SKIP (0.000s)
[354.450284] [079/133] (669s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[354.538728] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[362.012216] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.449s)
[362.121014] [080/133] (661s left) gem_partial_pwrite_pread (reads-snoop)
[362.175742] Subtest reads-snoop: SKIP (0.000s)
[362.237705] [081/133] (661s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[362.322909] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[369.753518] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.420s)
[369.872586] [082/133] (654s left) gen9_exec_parse (basic-rejected-ctx-param)
[369.930837] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[369.989449] [083/133] (654s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[370.089833] Starting subtest: psr2-cursor-plane-move-continuous-sf
[370.090847] Starting dynamic subtest: pipe-A-eDP-1
[380.439586] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.348s)
[380.448820] Starting dynamic subtest: pipe-B-eDP-1
[391.509456] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.066s)
[391.510282] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.417s)
[392.382853] [084/133] (631s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[392.482350] Starting subtest: fbc-rgb565-draw-mmap-wc
[396.571945] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.089s)
[397.695897] [085/133] (626s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[397.788189] Starting subtest: extended-pageflip-modeset-hang-oldfb
[397.788940] Starting dynamic subtest: pipe-A
[405.711331] Dynamic subtest pipe-A: SUCCESS (7.919s)
[405.728894] Starting dynamic subtest: pipe-D
[414.291394] Dynamic subtest pipe-D: SUCCESS (8.572s)
[414.292269] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.497s)
[415.149164] [086/133] (608s left) i915_pm_rps (min-max-config-idle)
[415.198829] Starting subtest: min-max-config-idle
[415.200718] Subtest min-max-config-idle: SKIP (0.001s)
[415.287636] [087/133] (608s left) sysfs_preempt_timeout (timeout)
[415.349351] Starting subtest: timeout
[415.350240] Starting dynamic subtest: vecs0
[425.461622] Dynamic subtest vecs0: SUCCESS (10.097s)
[425.480455] Starting dynamic subtest: ccs0
[426.682653] Dynamic subtest ccs0: SUCCESS (1.228s)
[426.695005] Starting dynamic subtest: vcs0
[436.414320] Dynamic subtest vcs0: SUCCESS (9.717s)
[436.425601] Starting dynamic subtest: bcs0
[437.623176] Dynamic subtest bcs0: SUCCESS (1.217s)
[437.633752] Starting dynamic subtest: rcs0
[438.813100] Dynamic subtest rcs0: SUCCESS (1.188s)
[438.824848] Starting dynamic subtest: vcs1
[448.438555] Dynamic subtest vcs1: SUCCESS (9.620s)
[448.439551] Subtest timeout: SUCCESS (33.079s)
[448.520589] [088/133] (575s left) gem_exec_balancer (indices)
[448.584018] Starting subtest: indices
[451.420538] Subtest indices: SUCCESS (2.829s)
[451.729366] [089/133] (572s left) kms_getfb (getfb-handle-valid)
[451.813326] Starting subtest: getfb-handle-valid
[451.814178] Subtest getfb-handle-valid: SUCCESS (0.000s)
[451.913509] [090/133] (572s left) gem_ctx_persistence (engines-persistence)
[451.970695] Starting subtest: engines-persistence
[451.971557] Starting dynamic subtest: rcs0
[452.786823] Dynamic subtest rcs0: SUCCESS (0.817s)
[452.800536] Starting dynamic subtest: bcs0
[453.540043] Dynamic subtest bcs0: SUCCESS (0.751s)
[453.552745] Starting dynamic subtest: vcs0
[454.321747] Dynamic subtest vcs0: SUCCESS (0.780s)
[454.335283] Starting dynamic subtest: vcs1
[455.095796] Dynamic subtest vcs1: SUCCESS (0.772s)
[455.109744] Starting dynamic subtest: vecs0
[455.858520] Dynamic subtest vecs0: SUCCESS (0.761s)
[455.871552] Starting dynamic subtest: ccs0
[456.607144] Dynamic subtest ccs0: SUCCESS (0.743s)
[456.608706] Subtest engines-persistence: SUCCESS (4.637s)
[456.736869] [091/133] (567s left) kms_atomic (test-only)
[456.834264] Starting subtest: test-only
[456.883861] Starting dynamic subtest: pipe-A-eDP-1
[459.391280] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.508s)
[459.392182] Subtest test-only: SUCCESS (2.557s)
[460.267140] [092/133] (564s left) gem_wait (busy)
[460.319976] Starting subtest: busy
[460.321035] Starting dynamic subtest: all-engines
[461.438093] Dynamic subtest all-engines: SUCCESS (1.109s)
[461.449549] Starting dynamic subtest: rcs0
[461.970134] Dynamic subtest rcs0: SUCCESS (0.539s)
[461.981580] Starting dynamic subtest: bcs0
[462.508402] Dynamic subtest bcs0: SUCCESS (0.537s)
[462.520433] Starting dynamic subtest: vcs0
[464.445812] Dynamic subtest vcs0: SUCCESS (1.927s)
[464.456514] Starting dynamic subtest: vcs1
[466.429582] Dynamic subtest vcs1: SUCCESS (1.981s)
[466.441145] Starting dynamic subtest: vecs0
[468.414077] Dynamic subtest vecs0: SUCCESS (1.982s)
[468.425655] Starting dynamic subtest: ccs0
[468.948038] Dynamic subtest ccs0: SUCCESS (0.541s)
[468.949221] Subtest busy: SUCCESS (8.628s)
[469.151231] [093/133] (555s left) api_intel_allocator (open-vm)
[469.207672] Starting subtest: open-vm
[469.211960] Subtest open-vm: SUCCESS (0.005s)
[469.311977] [094/133] (555s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[469.441479] Starting subtest: flip-vs-cursor-busy-crc-legacy
[470.260628] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.817s)
[471.098563] [095/133] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[471.196872] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[475.505043] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.308s)
[476.697435] [096/133] (547s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[476.784492] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[476.785377] Starting dynamic subtest: pipe-A-eDP-1
[476.793700] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[476.808836] Starting dynamic subtest: pipe-B-eDP-1
[476.816871] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[476.826346] Starting dynamic subtest: pipe-C-eDP-1
[476.834791] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[476.850911] Starting dynamic subtest: pipe-D-eDP-1
[476.858853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[476.860355] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[479.056313] [097/133] (545s left) gem_exec_reloc (basic-cpu-active)
[479.122587] Subtest basic-cpu-active: SKIP (0.000s)
[479.194513] [098/133] (545s left) syncobj_wait (wait-all-delayed-signal)
[479.242463] Starting subtest: wait-all-delayed-signal
[479.346181] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[479.436543] [099/133] (545s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[479.530561] Starting subtest: y-tiled-addfb-size-offset-overflow
[479.532335] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[479.622169] [100/133] (545s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[479.721300] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[479.722260] Starting dynamic subtest: pipe-A-eDP-1
[479.725812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[479.736348] Starting dynamic subtest: pipe-B-eDP-1
[479.739664] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[479.749336] Starting dynamic subtest: pipe-C-eDP-1
[479.752763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[479.761687] Starting dynamic subtest: pipe-D-eDP-1
[479.765049] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[479.766782] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[481.950520] [101/133] (542s left) kms_getfb (getfb2-accept-nv12)
[482.038336] Starting subtest: getfb2-accept-nv12
[482.039171] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[482.145227] [102/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[482.246682] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[488.871094] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.624s)
[489.001122] [103/133] (535s left) gem_exec_fence (syncobj-import)
[489.424659] Starting subtest: syncobj-import
[489.431949] Subtest syncobj-import: SUCCESS (0.007s)
[490.506988] [104/133] (534s left) gem_basic (create-close)
[490.563673] Starting subtest: create-close
[490.565792] Subtest create-close: SUCCESS (0.000s)
[490.668900] [105/133] (534s left) syncobj_timeline (multi-wait-for-submit-signaled)
[490.727158] Starting subtest: multi-wait-for-submit-signaled
[490.728313] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[490.830241] [106/133] (534s left) kms_psr (fbc-psr2-sprite-render)
[490.922506] Starting subtest: fbc-psr2-sprite-render
[490.923399] Starting dynamic subtest: eDP-1
[490.925016] Dynamic subtest eDP-1: SKIP (0.000s)
[490.926632] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[490.992728] [107/133] (533s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[491.086601] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[491.114142] Starting dynamic subtest: pipe-A-plane-0
[491.403150] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[491.420292] Starting dynamic subtest: pipe-A-plane-3
[491.636069] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[492.767237] Starting dynamic subtest: pipe-B-plane-0
[493.058093] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[493.068865] Starting dynamic subtest: pipe-B-plane-3
[493.291247] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[493.605579] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.519s)
[494.452675] [108/133] (530s left) gem_exec_whisper (basic-normal-all)
[494.518334] Starting subtest: basic-normal-all
[496.791078] Subtest basic-normal-all: SUCCESS (2.273s)
[496.972336] [109/133] (528s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[497.352658] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[498.153535] [110/133] (526s left) gem_render_copy (yf-tiled-ccs-to-linear)
[498.210392] Starting subtest: yf-tiled-ccs-to-linear
[498.212078] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[498.401930] [111/133] (526s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[498.513029] Starting subtest: cursorA-vs-flipA-toggle
[509.651270] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.135s)
[510.513436] [112/133] (514s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[510.571061] Starting subtest: saturated-hostile-nopreempt
[510.571999] Starting dynamic subtest: rcs0
[510.622259] Dynamic subtest rcs0: SKIP (0.050s)
[510.634550] Starting dynamic subtest: bcs0
[510.636258] Dynamic subtest bcs0: SKIP (0.011s)
[510.644943] Starting dynamic subtest: vcs0
[510.648281] Dynamic subtest vcs0: SKIP (0.012s)
[510.659318] Starting dynamic subtest: vcs1
[510.663138] Dynamic subtest vcs1: SKIP (0.014s)
[510.672334] Starting dynamic subtest: vecs0
[510.675250] Dynamic subtest vecs0: SKIP (0.011s)
[510.685106] Starting dynamic subtest: ccs0
[510.688887] Dynamic subtest ccs0: SKIP (0.013s)
[510.690651] Subtest saturated-hostile-nopreempt: SKIP (0.117s)
[510.766389] [113/133] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[510.859319] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[510.861020] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[510.950330] [114/133] (514s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[511.038889] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[511.040342] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[511.134729] [115/133] (514s left) kms_cursor_crc (cursor-offscreen-128x42)
[511.355793] Starting subtest: cursor-offscreen-128x42
[511.403353] Subtest cursor-offscreen-128x42: SKIP (0.046s)
[511.597483] [116/133] (513s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[511.705952] Starting subtest: modeset-atomic-cursor-hotspot
[511.707734] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[511.847988] [117/133] (513s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[511.892685] Starting subtest: invalid-single-wait-all-unsubmitted
[511.893716] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[511.990325] [118/133] (513s left) sw_sync (timeline_closed_signaled)
[512.026960] Starting subtest: timeline_closed_signaled
[512.028170] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[512.087500] [119/133] (513s left) kms_addfb_basic (basic-y-tiled-legacy)
[512.139648] Starting subtest: basic-y-tiled-legacy
[512.141671] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[512.266561] [120/133] (513s left) kms_flip (2x-nonexisting-fb-interruptible)
[512.350660] Starting subtest: 2x-nonexisting-fb-interruptible
[512.362417] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[512.455288] [121/133] (512s left) kms_pm_backlight (fade-with-suspend)
[512.539508] Starting subtest: fade-with-suspend
[528.834356] Starting dynamic subtest: eDP-1
[531.846358] Dynamic subtest eDP-1: SUCCESS (3.014s)
[531.847258] Subtest fade-with-suspend: SUCCESS (4.603s)
[536.663934] [122/133] (492s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[536.753836] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[536.754586] Starting dynamic subtest: pipe-A-default-mode
[539.557550] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[539.558392] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.734s)
[540.427244] [123/133] (489s left) fbdev (read)
[540.465718] Starting subtest: read
[541.018006] Subtest read: SUCCESS (0.533s)
[541.074989] [124/133] (488s left) gem_media_fill (media-fill)
[541.127898] Subtest media-fill: SKIP (0.000s)
[541.253809] [125/133] (488s left) gem_ctx_shared (exec-shared-gtt)
[541.309870] Starting subtest: exec-shared-gtt
[541.310944] Starting dynamic subtest: rcs0
[541.319835] Dynamic subtest rcs0: SUCCESS (0.009s)
[541.329580] Starting dynamic subtest: bcs0
[541.330376] Dynamic subtest bcs0: SUCCESS (0.005s)
[541.340577] Starting dynamic subtest: vcs0
[541.341459] Dynamic subtest vcs0: SUCCESS (0.006s)
[541.351379] Starting dynamic subtest: vcs1
[541.352510] Dynamic subtest vcs1: SUCCESS (0.007s)
[541.362702] Starting dynamic subtest: vecs0
[541.363631] Dynamic subtest vecs0: SUCCESS (0.005s)
[541.372749] Starting dynamic subtest: ccs0
[541.373589] Dynamic subtest ccs0: SUCCESS (0.005s)
[541.374513] Subtest exec-shared-gtt: SUCCESS (0.042s)
[541.535334] [126/133] (488s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[541.629519] Starting subtest: fbcpsr-modesetfrombusy
[547.905994] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.203s)
[548.031374] [127/133] (481s left) kms_setmode (basic-clone-single-crtc)
[548.083053] Starting subtest: basic-clone-single-crtc
[548.085859] Subtest basic-clone-single-crtc: SKIP (0.000s)
[548.189386] [128/133] (481s left) gem_create (hog-create)
[548.245312] Starting subtest: hog-create
[548.246350] Starting dynamic subtest: smem0
[581.163918] Dynamic subtest smem0: SUCCESS (32.845s)
[581.165365] Subtest hog-create: SUCCESS (32.846s)
[581.343331] [129/133] (448s left) gem_userptr_blits (usage-restrictions)
[581.397540] Starting subtest: usage-restrictions
[581.398533] Subtest usage-restrictions: SUCCESS (0.000s)
[581.533771] [130/133] (448s left) kms_cursor_crc (cursor-sliding-256x256)
[581.778956] Starting subtest: cursor-sliding-256x256
[581.782412] Starting dynamic subtest: pipe-A-eDP-1
[585.004861] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.221s)
[585.036062] Starting dynamic subtest: pipe-D-eDP-1
[588.929965] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.901s)
[588.930797] Subtest cursor-sliding-256x256: SUCCESS (7.148s)
[589.799845] [131/133] (440s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[589.851070] Starting subtest: invalid-bsd2-flag-on-vebox
[589.852071] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[589.947506] [132/133] (439s left) kms_invalid_mode (int-max-clock)
[590.036689] Starting subtest: int-max-clock
[590.037740] Starting dynamic subtest: pipe-A-eDP-1
[590.344497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.307s)
[590.355220] Starting dynamic subtest: pipe-B-eDP-1
[590.356100] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[590.365226] Starting dynamic subtest: pipe-C-eDP-1
[590.366140] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[590.375520] Starting dynamic subtest: pipe-D-eDP-1
[590.376601] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[590.377495] Subtest int-max-clock: SUCCESS (0.313s)
[591.143078] [133/133] (438s left) gem_exec_parallel (fds)
[591.215007] Starting subtest: fds
[591.216075] Starting dynamic subtest: rcs0
[593.574316] Dynamic subtest rcs0: SUCCESS (2.349s)
[593.583779] Starting dynamic subtest: bcs0
[596.799300] Dynamic subtest bcs0: SUCCESS (3.223s)
[596.808711] Starting dynamic subtest: vcs0
[600.413107] Dynamic subtest vcs0: SUCCESS (3.609s)
[600.425470] Starting dynamic subtest: vcs1
[604.382503] Dynamic subtest vcs1: SUCCESS (3.966s)
[604.394429] Starting dynamic subtest: vecs0
[608.390040] Dynamic subtest vecs0: SUCCESS (4.003s)
[608.402350] Starting dynamic subtest: ccs0
[611.920071] Dynamic subtest ccs0: SUCCESS (3.526s)
[611.921693] Subtest fds: SUCCESS (20.687s)
[612.112275] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_ppgtt
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_vrr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_shrink
results: parsing output: 27/ for test: gem_pread
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: prime_busy
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: gem_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: i915_query
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: kms_draw_crc
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_eio
results: parsing output: 42/ for test: kms_plane_multiple
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_exec_flush
results: parsing output: 48/ for test: kms_universal_plane
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: kms_pipe_stress
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_chamelium_edid
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: core_getversion
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_scaling_modes
results: parsing output: 71/ for test: gem_ringfill
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: syncobj_basic
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_chamelium_audio
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: i915_drm_fdinfo
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_partial_pwrite_pread
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_busy
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: sysfs_preempt_timeout
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: gem_wait
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_getfb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_basic
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: sw_sync
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_pm_backlight
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: fbdev
results: parsing output: 123/ for test: gem_media_fill
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_setmode
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: kms_invalid_mode
results: parsing output: 132/ for test: gem_exec_parallel
Done.