[60.978606] Initializing watchdogs
[60.978653]   /dev/watchdog0
[60.994184] [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]
[60.998844] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.001556] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.003303] [001/131] (960s left) prime_vgem (basic-read)
[61.104215] Starting subtest: basic-read
[61.110474] Subtest basic-read: SKIP (0.005s)
[61.205117] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[61.206704] [002/131] (960s left) gem_exec_big (single)
[61.259590] Starting subtest: single
[64.766287] Subtest single: FAIL (3.494s)
[64.825995] [003/131] (956s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[64.963903] Starting subtest: plane-downscale-factor-0-75-with-rotation
[64.964756] Starting dynamic subtest: pipe-A
[65.205433] Dynamic subtest pipe-A: SUCCESS (0.243s)
[65.212699] Starting dynamic subtest: pipe-B
[66.481021] Dynamic subtest pipe-B: SUCCESS (1.277s)
[66.488392] Starting dynamic subtest: pipe-C
[67.815701] Dynamic subtest pipe-C: SUCCESS (1.336s)
[67.823370] Starting dynamic subtest: pipe-D
[69.123716] Dynamic subtest pipe-D: SUCCESS (1.309s)
[69.124842] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.167s)
[70.291201] [004/131] (951s left) kms_lease (lease-revoke)
[70.384366] Starting subtest: lease-revoke
[70.385348] Starting dynamic subtest: pipe-A-eDP-1
[70.421565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.037s)
[70.432884] Starting dynamic subtest: pipe-B-eDP-1
[70.448937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[70.457663] Starting dynamic subtest: pipe-C-eDP-1
[70.480722] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.031s)
[70.487073] Starting dynamic subtest: pipe-D-eDP-1
[70.508558] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[70.509759] Subtest lease-revoke: SUCCESS (0.125s)
[70.632261] [005/131] (951s left) gem_mmap_gtt (hang-busy)
[70.684070] Subtest hang-busy: SKIP (0.000s)
[70.735305] [006/131] (950s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[70.833824] Starting subtest: primary-yf-tiled-reflect-x-0
[70.907228] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[70.999694] [007/131] (950s left) syncobj_wait (wait-delayed-signal)
[71.061924] Starting subtest: wait-delayed-signal
[71.164332] Subtest wait-delayed-signal: SUCCESS (0.103s)
[71.246241] [008/131] (950s left) kms_vrr (lobf)
[71.334883] Starting subtest: lobf
[71.336708] Subtest lobf: SKIP (0.000s)
[71.406125] [009/131] (950s left) gem_softpin (allocator-evict)
[71.462194] Starting subtest: allocator-evict
[71.463078] Starting dynamic subtest: rcs0
[94.608204] Dynamic subtest rcs0: SUCCESS (23.150s)
[94.618301] Starting dynamic subtest: bcs0
[119.079520] Dynamic subtest bcs0: SUCCESS (24.469s)
[119.088358] Starting dynamic subtest: vcs0
[143.297613] Dynamic subtest vcs0: SUCCESS (24.218s)
[143.306776] Starting dynamic subtest: vcs1
[167.224105] Dynamic subtest vcs1: SUCCESS (23.924s)
[167.231996] Starting dynamic subtest: vecs0
[190.803894] Dynamic subtest vecs0: SUCCESS (23.578s)
[190.813426] Starting dynamic subtest: ccs0
[214.543319] Dynamic subtest ccs0: SUCCESS (23.738s)
[214.544850] Subtest allocator-evict: SUCCESS (143.082s)
[214.621229] [010/131] (807s left) sysfs_heartbeat_interval (mixed)
[214.713380] Starting subtest: mixed
[214.714388] Starting dynamic subtest: vecs0
[219.918809] Dynamic subtest vecs0: SUCCESS (5.205s)
[219.928799] Starting dynamic subtest: ccs0
[225.123788] Dynamic subtest ccs0: SUCCESS (5.203s)
[225.132383] Starting dynamic subtest: vcs0
[230.334402] Dynamic subtest vcs0: SUCCESS (5.209s)
[230.345047] Starting dynamic subtest: bcs0
[235.495839] Dynamic subtest bcs0: SUCCESS (5.161s)
[235.504538] Starting dynamic subtest: rcs0
[240.681411] Dynamic subtest rcs0: SUCCESS (5.185s)
[240.692251] Starting dynamic subtest: vcs1
[245.899876] Dynamic subtest vcs1: SUCCESS (5.217s)
[245.900956] Subtest mixed: SUCCESS (31.186s)
[245.974617] [011/131] (775s left) prime_vgem (wait)
[246.048947] Starting subtest: wait
[246.049966] Starting dynamic subtest: rcs0
[246.117696] Dynamic subtest rcs0: SUCCESS (0.068s)
[246.126534] Starting dynamic subtest: bcs0
[246.176431] Dynamic subtest bcs0: SUCCESS (0.058s)
[246.182839] Starting dynamic subtest: vcs0
[246.220092] Dynamic subtest vcs0: SUCCESS (0.044s)
[246.226540] Starting dynamic subtest: vcs1
[246.271888] Dynamic subtest vcs1: SUCCESS (0.051s)
[246.278853] Starting dynamic subtest: vecs0
[246.317065] Dynamic subtest vecs0: SUCCESS (0.045s)
[246.323520] Starting dynamic subtest: ccs0
[246.365050] Dynamic subtest ccs0: SUCCESS (0.048s)
[246.365948] Subtest wait: SUCCESS (0.316s)
[246.476955] [012/131] (775s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[246.605247] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[264.259966] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.654s)
[265.140222] [013/131] (756s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[265.239035] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[265.239931] Starting dynamic subtest: pipe-A-eDP-1
[265.340153] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[265.348934] Starting dynamic subtest: pipe-B-eDP-1
[266.511390] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[266.513208] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.273s)
[267.705700] [014/131] (754s left) kms_cursor_crc (cursor-offscreen-512x170)
[268.001834] Starting subtest: cursor-offscreen-512x170
[268.004028] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[268.144378] [015/131] (753s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[268.195565] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[268.297370] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[268.380872] [016/131] (753s left) kms_plane_lowres (tiling-yf)
[268.473181] Starting subtest: tiling-yf
[268.474892] Subtest tiling-yf: SKIP (0.000s)
[268.543473] [017/131] (753s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[268.634520] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[268.636270] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[268.702565] [018/131] (753s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[268.787169] Starting subtest: disable-crc-after-crtc
[268.787996] Starting dynamic subtest: pipe-A-eDP-1
[270.448737] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.661s)
[270.455362] Starting dynamic subtest: pipe-B-eDP-1
[272.807551] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.357s)
[272.821772] Starting dynamic subtest: pipe-C-eDP-1
[275.058456] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s)
[275.064870] Starting dynamic subtest: pipe-D-eDP-1
[277.339475] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.279s)
[277.340293] Subtest disable-crc-after-crtc: SUCCESS (8.552s)
[278.156674] [019/131] (743s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[278.246022] Starting subtest: bo-too-small-due-to-tiling
[278.247632] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[278.345397] [020/131] (743s left) gem_pread (exhaustion)
[278.404285] Subtest exhaustion: SKIP (0.000s)
[278.464610] [021/131] (743s left) i915_drm_fdinfo (all-busy-idle-check-all)
[278.496338] Starting subtest: all-busy-idle-check-all
[278.500338] Subtest all-busy-idle-check-all: SKIP (0.003s)
[278.562282] [022/131] (743s left) core_auth (basic-auth)
[278.633064] Starting subtest: basic-auth
[278.634255] Subtest basic-auth: SUCCESS (0.001s)
[278.737328] [023/131] (743s left) perf (mi-rpc)
[278.876879] Starting subtest: mi-rpc
[278.879207] Subtest mi-rpc: SKIP (0.000s)
[278.913661] [024/131] (743s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[279.019153] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[286.577796] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.558s)
[286.684521] [025/131] (735s left) kms_psr (psr2-no-drrs)
[286.764536] Starting subtest: psr2-no-drrs
[286.765554] Starting dynamic subtest: eDP-1
[288.353973] Dynamic subtest eDP-1: SUCCESS (1.589s)
[288.354892] Subtest psr2-no-drrs: SUCCESS (1.590s)
[289.142275] [026/131] (733s left) gem_ringfill (legacy-basic)
[294.944047] Starting subtest: legacy-basic
[294.945298] Starting dynamic subtest: default
[294.988810] Dynamic subtest default: SUCCESS (0.051s)
[294.998071] Starting dynamic subtest: render
[295.030286] Dynamic subtest render: SUCCESS (0.040s)
[295.039951] Starting dynamic subtest: bsd
[295.073257] Dynamic subtest bsd: SUCCESS (0.041s)
[295.082481] Starting dynamic subtest: bsd1
[295.113841] Dynamic subtest bsd1: SUCCESS (0.039s)
[295.122701] Starting dynamic subtest: bsd2
[295.157029] Dynamic subtest bsd2: SUCCESS (0.041s)
[295.166520] Starting dynamic subtest: blt
[295.199946] Dynamic subtest blt: SUCCESS (0.041s)
[295.211047] Starting dynamic subtest: vebox
[295.241667] Dynamic subtest vebox: SUCCESS (0.040s)
[295.242784] Subtest legacy-basic: SUCCESS (0.306s)
[295.318132] [027/131] (727s left) gen7_exec_parse (batch-without-end)
[295.369886] Subtest batch-without-end: SKIP (0.000s)
[295.438357] [028/131] (726s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[295.523982] Starting subtest: fbc-psr2-primary-mmap-gtt
[295.525167] Starting dynamic subtest: eDP-1
[295.526971] Dynamic subtest eDP-1: SKIP (0.000s)
[295.528828] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[295.590833] [029/131] (726s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[295.677167] Starting subtest: bad-rotation-90-yf-tiled-ccs
[295.678134] Starting dynamic subtest: pipe-A-eDP-1
[295.686618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[295.693422] Starting dynamic subtest: pipe-B-eDP-1
[295.701695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[295.707877] Starting dynamic subtest: pipe-C-eDP-1
[295.716279] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[295.722498] Starting dynamic subtest: pipe-D-eDP-1
[295.731024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[295.732749] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[297.937324] [030/131] (724s left) i915_pm_rpm (gem-pread)
[300.063848] Starting subtest: gem-pread
[302.093386] Subtest gem-pread: SUCCESS (2.032s)
[302.175631] [031/131] (720s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[302.262991] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[302.264835] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[302.400994] [032/131] (720s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[302.498523] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[302.500293] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[302.583411] [033/131] (720s left) gem_vm_create (execbuf)
[302.638508] Starting subtest: execbuf
[302.645930] Subtest execbuf: SUCCESS (0.007s)
[302.756629] [034/131] (719s left) kms_cursor_crc (cursor-random-max-size)
[303.076221] Starting subtest: cursor-random-max-size
[303.079039] Subtest cursor-random-max-size: SKIP (0.000s)
[303.196303] [035/131] (719s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[303.282347] Starting subtest: extended-pageflip-modeset-hang-oldfb
[303.283262] Starting dynamic subtest: pipe-A
[311.184891] Dynamic subtest pipe-A: SUCCESS (7.901s)
[311.193806] Starting dynamic subtest: pipe-D
[319.757142] Dynamic subtest pipe-D: SUCCESS (8.570s)
[319.759478] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.476s)
[320.621606] [036/131] (702s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[320.668436] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[320.669356] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[320.761290] [037/131] (701s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[320.850288] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[320.851973] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[320.942018] [038/131] (701s left) kms_plane (pixel-format-x-tiled-modifier)
[321.029327] Starting subtest: pixel-format-x-tiled-modifier
[321.057586] Starting dynamic subtest: pipe-A-plane-0
[321.724106] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s)
[321.732303] Starting dynamic subtest: pipe-A-plane-3
[322.135197] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[322.143317] Starting dynamic subtest: pipe-A-plane-5
[322.144953] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[323.195191] Starting dynamic subtest: pipe-B-plane-0
[323.842901] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[323.849585] Starting dynamic subtest: pipe-B-plane-3
[324.242942] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[324.249868] Starting dynamic subtest: pipe-B-plane-5
[324.251562] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[324.561211] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.532s)
[325.353567] [039/131] (697s left) kms_flip (nonexisting-fb)
[325.455275] Starting subtest: nonexisting-fb
[325.456193] Starting dynamic subtest: A-eDP1
[326.657588] Dynamic subtest A-eDP1: SUCCESS (1.201s)
[326.667039] Starting dynamic subtest: B-eDP1
[327.785692] Dynamic subtest B-eDP1: SUCCESS (1.127s)
[327.794407] Starting dynamic subtest: C-eDP1
[328.921735] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[328.933045] Starting dynamic subtest: D-eDP1
[330.162069] Dynamic subtest D-eDP1: SUCCESS (1.236s)
[330.164075] Subtest nonexisting-fb: SUCCESS (4.710s)
[331.336237] [040/131] (691s left) fbdev (pan)
[331.370116] Starting subtest: pan
[331.403233] Subtest pan: SUCCESS (0.033s)
[331.469033] [041/131] (691s left) kms_invalid_mode (bad-vsync-end)
[331.570072] Starting subtest: bad-vsync-end
[331.570977] Starting dynamic subtest: pipe-A-eDP-1
[331.856987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[331.865130] Starting dynamic subtest: pipe-B-eDP-1
[331.865986] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[331.872312] Starting dynamic subtest: pipe-C-eDP-1
[331.873167] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[331.879451] Starting dynamic subtest: pipe-D-eDP-1
[331.880355] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[331.881162] Subtest bad-vsync-end: SUCCESS (0.293s)
[332.656424] [042/131] (690s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[332.758502] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[332.759403] Starting dynamic subtest: pipe-A-eDP-1
[332.768075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.774803] Starting dynamic subtest: pipe-B-eDP-1
[332.783520] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.790120] Starting dynamic subtest: pipe-C-eDP-1
[332.798070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.804667] Starting dynamic subtest: pipe-D-eDP-1
[332.812908] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.814523] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[335.005322] [043/131] (687s left) kms_psr (fbc-psr-sprite-plane-move)
[335.087249] Starting subtest: fbc-psr-sprite-plane-move
[335.088057] Starting dynamic subtest: eDP-1
[335.089665] Dynamic subtest eDP-1: SKIP (0.000s)
[335.091369] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[335.159735] [044/131] (687s left) gem_exec_fence (syncobj-channel)
[335.582779] Starting subtest: syncobj-channel
[336.611540] Subtest syncobj-channel: SUCCESS (1.019s)
[336.983766] [045/131] (686s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[337.089954] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[337.461782] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.154s)
[337.490971] [046/131] (685s left) syncobj_wait (wait-for-submit-delayed-submit)
[337.542496] Starting subtest: wait-for-submit-delayed-submit
[337.644957] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[337.734746] [047/131] (685s left) gem_lmem_swapping (random)
[337.770828] Subtest random: SKIP (0.000s)
[337.810385] [048/131] (685s left) perf_pmu (rc6-suspend)
[337.852645] Starting subtest: rc6-suspend
[361.299854] Subtest rc6-suspend: SUCCESS (8.030s)
[370.731915] [049/131] (661s left) kms_draw_crc (draw-method-mmap-wc)
[370.862332] Starting subtest: draw-method-mmap-wc
[370.863164] Starting dynamic subtest: xrgb8888-untiled
[371.204518] Dynamic subtest xrgb8888-untiled: SUCCESS (0.342s)
[371.218007] Starting dynamic subtest: rgb565-untiled
[371.531119] Dynamic subtest rgb565-untiled: SUCCESS (0.329s)
[371.540375] Starting dynamic subtest: xrgb2101010-untiled
[371.836859] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.309s)
[371.846927] Starting dynamic subtest: xbgr16161616f-untiled
[372.055165] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.220s)
[372.070866] Starting dynamic subtest: xrgb8888-xtiled
[372.208112] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.154s)
[372.223762] Starting dynamic subtest: rgb565-xtiled
[372.349861] Dynamic subtest rgb565-xtiled: SUCCESS (0.142s)
[372.359133] Starting dynamic subtest: xrgb2101010-xtiled
[372.469955] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[372.477949] Starting dynamic subtest: xbgr16161616f-xtiled
[372.601893] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[372.617358] Starting dynamic subtest: xrgb8888-4tiled
[372.765227] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.164s)
[372.772892] Starting dynamic subtest: rgb565-4tiled
[372.918294] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[372.926017] Starting dynamic subtest: xrgb2101010-4tiled
[373.060313] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[373.068264] Starting dynamic subtest: xbgr16161616f-4tiled
[373.235427] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[373.236286] Subtest draw-method-mmap-wc: SUCCESS (2.410s)
[373.329342] [050/131] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[373.426216] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[373.428067] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[373.508941] [051/131] (658s left) gem_exec_whisper (basic-queues-priority-all)
[373.575638] Starting subtest: basic-queues-priority-all
[393.623815] Subtest basic-queues-priority-all: SUCCESS (20.145s)
[393.800695] [052/131] (638s left) gem_mmap_gtt (basic-write)
[393.852584] Subtest basic-write: SKIP (0.000s)
[393.915704] [053/131] (638s left) kms_flip (dpms-vs-vblank-race-interruptible)
[394.008479] Starting subtest: dpms-vs-vblank-race-interruptible
[394.009910] Starting dynamic subtest: A-eDP1
[398.960840] Dynamic subtest A-eDP1: SUCCESS (4.955s)
[398.971889] Starting dynamic subtest: B-eDP1
[403.613578] Dynamic subtest B-eDP1: SUCCESS (4.651s)
[403.621775] Starting dynamic subtest: C-eDP1
[408.254163] Dynamic subtest C-eDP1: SUCCESS (4.639s)
[408.262953] Starting dynamic subtest: D-eDP1
[412.891554] Dynamic subtest D-eDP1: SUCCESS (4.636s)
[412.893817] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.891s)
[413.779710] [054/131] (618s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[413.868414] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[413.870353] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[413.962523] [055/131] (618s left) gem_exec_balancer (bonded-dual)
[414.029438] Starting subtest: bonded-dual
[414.031426] Subtest bonded-dual: SKIP (0.000s)
[414.329914] [056/131] (618s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[414.419138] Starting subtest: x-tiled-16bpp-rotate-0
[414.789570] Subtest x-tiled-16bpp-rotate-0: FAIL (0.150s)
[414.819951] [057/131] (617s left) gem_exec_async (forked-writes)
[414.880955] Starting subtest: forked-writes
[414.881884] Starting dynamic subtest: rcs0
[414.907536] Dynamic subtest rcs0: SUCCESS (0.026s)
[414.917862] Starting dynamic subtest: bcs0
[414.930446] Dynamic subtest bcs0: SUCCESS (0.022s)
[414.940712] Starting dynamic subtest: vcs0
[414.954497] Dynamic subtest vcs0: SUCCESS (0.023s)
[414.963198] Starting dynamic subtest: vcs1
[414.976569] Dynamic subtest vcs1: SUCCESS (0.021s)
[414.985296] Starting dynamic subtest: vecs0
[414.998656] Dynamic subtest vecs0: SUCCESS (0.021s)
[415.010233] Starting dynamic subtest: ccs0
[415.024447] Dynamic subtest ccs0: SUCCESS (0.025s)
[415.025726] Subtest forked-writes: SUCCESS (0.144s)
[415.249456] [058/131] (617s left) gem_exec_reloc (basic-wc-cpu-active)
[415.299518] Subtest basic-wc-cpu-active: SKIP (0.000s)
[415.365551] [059/131] (617s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[415.450905] Starting subtest: fbc-dirtyfb-ioctl
[415.451929] Starting dynamic subtest: A-eDP-1
[418.044993] Dynamic subtest A-eDP-1: SUCCESS (2.595s)
[418.045901] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.596s)
[418.851491] [060/131] (613s left) kms_vblank (wait-idle-hang)
[418.941747] Starting subtest: wait-idle-hang
[418.944008] Starting dynamic subtest: pipe-A-eDP-1
[445.125830] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.189s)
[445.135395] Starting dynamic subtest: pipe-D-eDP-1
[460.112734] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.990s)
[460.113482] Subtest wait-idle-hang: SUCCESS (41.184s)
[460.918663] [061/131] (571s left) kms_plane_scaling (planes-downscale-factor-0-5)
[461.011977] Starting subtest: planes-downscale-factor-0-5
[461.012975] Starting dynamic subtest: pipe-A
[461.037206] Dynamic subtest pipe-A: SKIP (0.019s)
[461.051817] Starting dynamic subtest: pipe-B
[461.067003] Dynamic subtest pipe-B: SKIP (0.034s)
[461.075112] Starting dynamic subtest: pipe-C
[461.102289] Dynamic subtest pipe-C: SKIP (0.035s)
[461.115695] Starting dynamic subtest: pipe-D
[461.137009] Dynamic subtest pipe-D: SKIP (0.035s)
[461.138778] Subtest planes-downscale-factor-0-5: SKIP (0.124s)
[461.228799] [062/131] (571s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[461.283209] Starting subtest: single-wait-all-for-submit-available-signaled
[461.284126] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[461.370713] [063/131] (571s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[461.458442] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[461.460153] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[461.527883] [064/131] (571s left) gem_exec_parallel (engines)
[461.596048] Starting subtest: engines
[461.596955] Starting dynamic subtest: basic
[463.309514] Dynamic subtest basic: SUCCESS (1.704s)
[463.320419] Starting dynamic subtest: contexts
[467.641172] Dynamic subtest contexts: SUCCESS (4.328s)
[467.651884] Starting dynamic subtest: fds
[471.434443] Dynamic subtest fds: SUCCESS (3.789s)
[471.446811] Starting dynamic subtest: userptr
[473.293756] Dynamic subtest userptr: SUCCESS (1.856s)
[473.294720] Subtest engines: SUCCESS (11.687s)
[473.482843] [065/131] (559s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[473.573522] Starting subtest: psr2-cursor-plane-update-sf
[473.574396] Starting dynamic subtest: pipe-A-eDP-1
[474.149973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[474.160733] Starting dynamic subtest: pipe-B-eDP-1
[475.420679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[475.421529] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.848s)
[476.290628] [066/131] (556s left) core_getstats (basic)
[476.339336] Starting subtest: basic
[476.340166] Subtest basic: SUCCESS (0.000s)
[476.447903] [067/131] (556s left) gen3_render_tiledx_blits
[476.553693] [068/131] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[476.644644] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[476.646323] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[476.737061] [069/131] (556s left) syncobj_basic (bad-flags-handle-to-fd)
[476.785082] Starting subtest: bad-flags-handle-to-fd
[476.786292] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[476.881421] [070/131] (556s left) gem_ctx_persistence (legacy-engines-hang)
[476.939916] Starting subtest: legacy-engines-hang
[476.940920] Starting dynamic subtest: render
[477.019085] Dynamic subtest render: SUCCESS (0.078s)
[477.030893] Starting dynamic subtest: bsd1
[477.107422] Dynamic subtest bsd1: SUCCESS (0.085s)
[477.119911] Starting dynamic subtest: bsd2
[477.200029] Dynamic subtest bsd2: SUCCESS (0.090s)
[477.212374] Starting dynamic subtest: blt
[477.287976] Dynamic subtest blt: SUCCESS (0.085s)
[477.304193] Starting dynamic subtest: vebox
[477.380052] Dynamic subtest vebox: SUCCESS (0.090s)
[477.381328] Subtest legacy-engines-hang: SUCCESS (0.441s)
[477.468009] [071/131] (555s left) gem_exec_schedule (pi-distinct-iova)
[477.656562] Starting subtest: pi-distinct-iova
[477.657408] Starting dynamic subtest: rcs0
[477.728929] Dynamic subtest rcs0: SUCCESS (0.079s)
[477.741043] Starting dynamic subtest: vcs0
[477.790825] Dynamic subtest vcs0: SUCCESS (0.061s)
[477.802041] Starting dynamic subtest: vcs1
[477.855393] Dynamic subtest vcs1: SUCCESS (0.063s)
[477.868344] Starting dynamic subtest: vecs0
[477.917992] Dynamic subtest vecs0: SUCCESS (0.062s)
[477.929363] Starting dynamic subtest: ccs0
[477.982203] Dynamic subtest ccs0: SUCCESS (0.063s)
[477.983660] Subtest pi-distinct-iova: SUCCESS (0.333s)
[479.415489] [072/131] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[479.506878] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[487.028819] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.521s)
[487.160054] [073/131] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[487.253187] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[494.474405] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.221s)
[494.587475] [074/131] (538s left) kms_psr (pr-cursor-plane-move)
[494.676832] Starting subtest: pr-cursor-plane-move
[494.678641] Subtest pr-cursor-plane-move: SKIP (0.000s)
[494.745251] [075/131] (538s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[494.841667] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[494.843250] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[494.934999] [076/131] (538s left) kms_flip (flip-vs-absolute-wf_vblank)
[495.015440] Starting subtest: flip-vs-absolute-wf_vblank
[495.017575] Starting dynamic subtest: A-eDP1
[503.935126] Dynamic subtest A-eDP1: SUCCESS (8.918s)
[503.946749] Starting dynamic subtest: B-eDP1
[512.871555] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[512.880314] Starting dynamic subtest: C-eDP1
[521.833988] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[521.843680] Starting dynamic subtest: D-eDP1
[530.726131] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[530.730889] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.719s)
[531.942481] [077/131] (501s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[532.334398] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[533.165464] [078/131] (500s left) kms_big_fb (linear-64bpp-rotate-90)
[533.270245] Starting subtest: linear-64bpp-rotate-90
[533.290931] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[533.399385] [079/131] (499s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[533.501441] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[533.503019] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[533.589489] [080/131] (499s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[533.686644] Starting subtest: invalidate-primary-flip-overlay
[544.383882] Subtest invalidate-primary-flip-overlay: SUCCESS (10.699s)
[544.497142] [081/131] (488s left) gem_tiled_wb
[544.592499] [082/131] (488s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[544.685284] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[544.697088] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[544.768342] [083/131] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[544.858911] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[551.620354] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.763s)
[551.766369] [084/131] (481s left) kms_flip (basic-flip-vs-modeset)
[551.869423] Starting subtest: basic-flip-vs-modeset
[551.871563] Starting dynamic subtest: A-eDP1
[554.503384] Dynamic subtest A-eDP1: SUCCESS (2.632s)
[554.511786] Starting dynamic subtest: B-eDP1
[556.669349] Dynamic subtest B-eDP1: SUCCESS (2.165s)
[556.678166] Starting dynamic subtest: C-eDP1
[558.836287] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[558.844580] Starting dynamic subtest: D-eDP1
[561.014423] Dynamic subtest D-eDP1: SUCCESS (2.178s)
[561.016436] Subtest basic-flip-vs-modeset: SUCCESS (9.150s)
[561.813042] [085/131] (471s left) gem_ctx_param (get-priority-new-ctx)
[561.876257] Starting subtest: get-priority-new-ctx
[561.877172] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[561.988127] [086/131] (471s left) i915_suspend (forcewake)
[562.038030] Starting subtest: forcewake
[595.120493] Subtest forcewake: SUCCESS (3.009s)
[602.204440] [087/131] (438s left) api_intel_allocator (reserve-simple)
[602.249728] Starting subtest: reserve-simple
[602.252265] Subtest reserve-simple: SUCCESS (0.004s)
[602.348253] [088/131] (438s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[602.397081] Starting subtest: multi-wait-for-submit-unsubmitted
[602.504573] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[602.576914] [089/131] (438s left) gem_workarounds (basic-read-fd)
[602.638411] Starting subtest: basic-read-fd
[602.659146] Subtest basic-read-fd: SUCCESS (0.021s)
[602.773277] [090/131] (437s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[602.866287] Starting subtest: yf-tiled-64bpp-rotate-270
[602.868412] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[602.951701] [091/131] (437s left) kms_setmode (invalid-clone-single-crtc-stealing)
[603.008299] Starting subtest: invalid-clone-single-crtc-stealing
[603.013579] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[603.101388] [092/131] (437s left) kms_chamelium_edid (dp-mode-timings)
[603.468345] Subtest dp-mode-timings: SKIP (0.000s)
[604.262540] [093/131] (436s left) kms_pipe_crc_basic (bad-source)
[604.360811] Starting subtest: bad-source
[604.361772] Subtest bad-source: SUCCESS (0.000s)
[604.430626] [094/131] (436s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[604.482139] Subtest tiled-to-untiled: SKIP (0.000s)
[604.556983] [095/131] (436s left) kms_content_protection (lic-type-0-hdcp14)
[604.693676] Starting subtest: lic-type-0-hdcp14
[604.696075] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[604.813193] [096/131] (436s left) gem_create (create-clear)
[604.858097] Starting subtest: create-clear
[604.859620] Starting dynamic subtest: smem0
[641.771232] [097/131] (399s left) gem_exec_schedule (timeslicing)
[641.916933] Starting subtest: timeslicing
[641.918292] Starting dynamic subtest: rcs0
[641.949480] Dynamic subtest rcs0: SUCCESS (0.031s)
[641.963591] Starting dynamic subtest: bcs0
[641.977462] Dynamic subtest bcs0: SUCCESS (0.027s)
[641.990321] Starting dynamic subtest: vcs0
[642.004368] Dynamic subtest vcs0: SUCCESS (0.026s)
[642.016416] Starting dynamic subtest: vcs1
[642.028481] Dynamic subtest vcs1: SUCCESS (0.023s)
[642.046693] Starting dynamic subtest: vecs0
[642.056760] Dynamic subtest vecs0: SUCCESS (0.026s)
[642.069492] Starting dynamic subtest: ccs0
[642.086092] Dynamic subtest ccs0: SUCCESS (0.028s)
[642.086994] Subtest timeslicing: SUCCESS (0.170s)
[643.440145] [098/131] (397s left) gem_fence_thrash (bo-write-verify-threaded-none)
[643.480610] Starting subtest: bo-write-verify-threaded-none
[643.504140] Subtest bo-write-verify-threaded-none: SKIP (0.021s)
[643.576317] [099/131] (397s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[643.671101] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[643.673594] Starting dynamic subtest: A-eDP1
[643.735091] Dynamic subtest A-eDP1: FAIL (0.021s)
[643.744833] Starting dynamic subtest: B-eDP1
[643.793206] Dynamic subtest B-eDP1: FAIL (0.010s)
[643.802837] Starting dynamic subtest: C-eDP1
[643.853390] Dynamic subtest C-eDP1: FAIL (0.010s)
[643.863047] Starting dynamic subtest: D-eDP1
[643.905996] Dynamic subtest D-eDP1: FAIL (0.010s)
[643.906816] Subtest flip-vs-dpms-off-vs-modeset-interruptible: FAIL (0.058s)
[643.952136] [100/131] (397s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[644.063664] Starting subtest: basic-flip-after-cursor-varying-size
[644.124285] Subtest basic-flip-after-cursor-varying-size: FAIL (0.012s)
[644.193784] [101/131] (397s left) syncobj_timeline (invalid-wait-illegal-handle)
[644.237849] Starting subtest: invalid-wait-illegal-handle
[644.238824] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[644.311369] [102/131] (396s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[644.412090] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[644.413792] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[644.469001] [103/131] (396s left) gem_mmap_gtt (basic-read-write-distinct)
[644.515013] Subtest basic-read-write-distinct: SKIP (0.000s)
[644.586852] [104/131] (396s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[644.675798] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[644.676741] Starting dynamic subtest: pipe-A-eDP-1
[644.686008] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[644.695297] Starting dynamic subtest: pipe-B-eDP-1
[644.704210] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[644.713817] Starting dynamic subtest: pipe-C-eDP-1
[644.722153] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[644.731045] Starting dynamic subtest: pipe-D-eDP-1
[644.740206] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[644.741994] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[646.903809] [105/131] (394s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[647.015991] Starting subtest: cursorB-vs-flipB-toggle
[647.018005] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[647.133790] [106/131] (394s left) kms_universal_plane (disable-primary-vs-flip)
[647.245087] Starting subtest: disable-primary-vs-flip
[647.246039] Starting dynamic subtest: pipe-A-eDP-1
[647.293006] Dynamic subtest pipe-A-eDP-1: FAIL (0.010s)
[647.303141] Starting dynamic subtest: pipe-B-eDP-1
[647.360671] Dynamic subtest pipe-B-eDP-1: FAIL (0.009s)
[647.369989] Starting dynamic subtest: pipe-C-eDP-1
[647.414781] Dynamic subtest pipe-C-eDP-1: FAIL (0.009s)
[647.424244] Starting dynamic subtest: pipe-D-eDP-1
[647.469421] Dynamic subtest pipe-D-eDP-1: FAIL (0.008s)
[647.470347] Subtest disable-primary-vs-flip: FAIL (0.042s)
[647.502511] [107/131] (393s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[647.599718] Starting subtest: 4-tiled-32bpp-rotate-180
[661.340906] [108/131] (380s left) kms_atomic (atomic-plane-damage)
[661.510874] Starting subtest: atomic-plane-damage
[662.104176] [109/131] (379s left) kms_addfb_basic (bad-pitch-128)
[662.153315] Starting subtest: bad-pitch-128
[662.154479] Subtest bad-pitch-128: SUCCESS (0.000s)
[662.260654] [110/131] (379s left) gem_pxp (verify-pxp-stale-buf-execution)
[662.376422] Starting subtest: verify-pxp-stale-buf-execution
[663.444614] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.067s)
[663.530552] [111/131] (378s left) perf (polling)
[663.613237] Starting subtest: polling
[663.614573] Starting dynamic subtest: 0-rcs0
[663.650066] Dynamic subtest 0-rcs0: FAIL (0.015s)
[663.660921] Starting dynamic subtest: 1-vcs1
[663.688642] Dynamic subtest 1-vcs1: FAIL (0.010s)
[663.689595] Subtest polling: FAIL (0.026s)
[663.723022] [112/131] (377s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[663.813175] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[665.530220] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: FAIL (1.465s)
[666.065590] [113/131] (375s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[666.163357] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[666.165309] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[666.229682] [114/131] (375s left) gem_ctx_isolation (dirty-create)
[666.293718] Starting subtest: dirty-create
[666.295441] Starting dynamic subtest: rcs0
[666.351526] Dynamic subtest rcs0: FAIL (0.034s)
[666.361703] Starting dynamic subtest: bcs0
[666.445246] Dynamic subtest bcs0: FAIL (0.057s)
[666.454675] Starting dynamic subtest: vcs0
[666.508451] Dynamic subtest vcs0: FAIL (0.045s)
[666.537891] Starting dynamic subtest: vcs1
[666.595445] Dynamic subtest vcs1: FAIL (0.028s)
[666.604822] Starting dynamic subtest: vecs0
[666.633384] Dynamic subtest vecs0: FAIL (0.050s)
[666.643288] Starting dynamic subtest: ccs0
[666.674280] Dynamic subtest ccs0: FAIL (0.069s)
[666.675218] Subtest dirty-create: FAIL (0.287s)
[666.799026] [115/131] (374s left) syncobj_eventfd (invalid-illegal-handle)
[666.879159] Starting subtest: invalid-illegal-handle
[666.880499] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[666.944142] [116/131] (374s left) i915_drm_fdinfo (virtual-busy-hang-all)
[666.977615] Starting subtest: virtual-busy-hang-all
[666.980455] Subtest virtual-busy-hang-all: SKIP (0.000s)
[667.021749] [117/131] (374s left) gem_exec_reloc (basic-gtt-cpu-active)
[667.080454] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[667.146017] [118/131] (374s left) kms_pm_rpm (cursor)
[667.364683] Subtest cursor: FAIL (0.000s)
[667.402398] [119/131] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[667.498206] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[667.500196] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[667.559216] [120/131] (374s left) gem_exec_whisper (basic-contexts-priority)
[667.612248] Starting subtest: basic-contexts-priority
[715.939436] [121/131] (334s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[716.160477] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[716.161766] Starting dynamic subtest: pipe-A-eDP-1
[733.409082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.156s)
[733.418964] Starting dynamic subtest: pipe-B-eDP-1
[751.316349] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.861s)
[751.329018] Starting dynamic subtest: pipe-C-eDP-1
[769.286599] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.832s)
[769.296427] Starting dynamic subtest: pipe-D-eDP-1
[787.303940] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.786s)
[787.304785] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.641s)
[793.561387] [122/131] (261s left) kms_cursor_crc (cursor-tearing-position-change)
[793.729342] Starting subtest: cursor-tearing-position-change
[793.730220] Starting dynamic subtest: pipe-A-eDP-1
[794.684339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.949s)
[794.698618] Starting dynamic subtest: pipe-D-eDP-1
[796.183009] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[796.185369] Subtest cursor-tearing-position-change: SUCCESS (2.447s)
[797.034042] [123/131] (258s left) gem_eio (throttle)
[797.327213] Starting subtest: throttle
[797.713048] Subtest throttle: SUCCESS (0.384s)
[797.804512] [124/131] (257s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[797.904475] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[797.906127] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[797.977532] [125/131] (257s left) kms_chamelium_color (ctm-0-25)
[798.071986] Subtest ctm-0-25: SKIP (0.000s)
[798.119687] [126/131] (257s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[798.171252] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[798.264104] [127/131] (257s left) kms_color (ctm-negative)
[798.347942] Starting subtest: ctm-negative
[798.348808] Starting dynamic subtest: pipe-A-eDP-1
[799.326791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.977s)
[799.337824] Starting dynamic subtest: pipe-B-eDP-1
[800.841164] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.508s)
[800.851885] Starting dynamic subtest: pipe-C-eDP-1
[802.326348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[802.338693] Starting dynamic subtest: pipe-D-eDP-1
[803.808151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.478s)
[803.810007] Subtest ctm-negative: SUCCESS (5.451s)
[804.679441] [128/131] (250s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[804.832139] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[810.252231] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (5.416s)
[811.493601] [129/131] (243s left) core_sysfs (read-all-entries)
[811.603539] Starting subtest: read-all-entries
[811.613486] Subtest read-all-entries: SUCCESS (0.011s)
[811.663064] [130/131] (243s left) kms_async_flips (async-flip-hang)
[811.759151] Starting subtest: async-flip-hang
[812.139399] Starting dynamic subtest: pipe-A-eDP-1
[829.350022] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.188s)
[829.783062] Starting dynamic subtest: pipe-B-eDP-1
[845.341745] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.570s)
[845.747398] Starting dynamic subtest: pipe-C-eDP-1
[861.326867] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.586s)
[861.723405] Starting dynamic subtest: pipe-D-eDP-1
[877.360516] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.645s)
[877.363815] Subtest async-flip-hang: SUCCESS (65.600s)
[878.660820] [131/131] (176s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[878.814045] Starting subtest: fbc-rgb101010-draw-mmap-wc
[883.414063] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.599s)
[884.493446] Closing watchdogs
results: parsing output: 0/ for test: prime_vgem
results: parsing output: 1/ for test: gem_exec_big
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_vrr
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: sysfs_heartbeat_interval
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_plane_lowres
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_pipe_crc_basic
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_pread
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: core_auth
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_ringfill
results: parsing output: 26/ for test: gen7_exec_parse
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: i915_pm_rpm
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_vm_create
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: fbdev
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_draw_crc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_whisper
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_async
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_dirtyfb
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: gem_exec_parallel
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: core_getstats
results: parsing output: 66/ for test: gen3_render_tiledx_blits
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_basic
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr_stress_test
results: parsing output: 80/ for test: gem_tiled_wb
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: i915_suspend
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_workarounds
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_setmode
results: parsing output: 91/ for test: kms_chamelium_edid
results: parsing output: 92/ for test: kms_pipe_crc_basic
results: parsing output: 93/ for test: gem_set_tiling_vs_blt
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_universal_plane
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_atomic
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: syncobj_eventfd
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: gem_fenced_exec_thrash
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: core_sysfs
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.