[59.839954] Initializing watchdogs
[59.840008]   /dev/watchdog0
[59.853642] [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]
[59.858171] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.860503] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.863642] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[59.990801] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[66.701037] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.740s)
[66.877823] [002/133] (953s left) gem_mmap_offset (mmap-unmap)
[67.196067] Starting subtest: mmap-unmap
[67.198181] Starting dynamic subtest: smem0
[89.764912] Dynamic subtest smem0: SUCCESS (22.582s)
[89.767773] Subtest mmap-unmap: SUCCESS (22.582s)
[89.899490] [003/133] (930s left) fbdev (pan)
[89.936234] Starting subtest: pan
[89.966059] Subtest pan: SUCCESS (0.031s)
[90.058406] [004/133] (930s left) kms_addfb_basic (unused-pitches)
[90.114050] Starting subtest: unused-pitches
[90.116077] Subtest unused-pitches: SUCCESS (0.000s)
[90.274277] [005/133] (930s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[90.363857] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[90.377349] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[90.458550] [006/133] (930s left) kms_cursor_crc (cursor-random-64x21)
[90.651670] Starting subtest: cursor-random-64x21
[90.712894] Subtest cursor-random-64x21: SKIP (0.056s)
[90.980200] [007/133] (929s left) kms_feature_discovery (display-2x)
[91.078313] Starting subtest: display-2x
[91.081903] Subtest display-2x: SKIP (0.000s)
[91.157325] [008/133] (929s left) i915_pm_rpm (gem-idle)
[92.998069] Starting subtest: gem-idle
[99.190084] Subtest gem-idle: SUCCESS (6.193s)
[99.529573] [009/133] (921s left) kms_psr (psr2-sprite-render)
[100.894735] Starting subtest: psr2-sprite-render
[100.896884] Starting dynamic subtest: eDP-1
[102.606479] Dynamic subtest eDP-1: SUCCESS (1.713s)
[102.608847] Subtest psr2-sprite-render: SUCCESS (1.714s)
[103.488067] [010/133] (917s left) gem_lmem_swapping (parallel-random-verify-ccs)
[103.528922] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[103.574980] [011/133] (917s left) kms_addfb_basic (basic-x-tiled-legacy)
[103.637204] Starting subtest: basic-x-tiled-legacy
[103.641749] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[103.791597] [012/133] (916s left) gem_eio (in-flight-suspend)
[103.978069] Starting subtest: in-flight-suspend
[147.163476] Subtest in-flight-suspend: SUCCESS (13.896s)
[147.332452] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[147.335491] [013/133] (873s left) gem_wait (write-wait)
[147.408445] Starting subtest: write-wait
[147.410777] Starting dynamic subtest: all-engines
[148.515876] Dynamic subtest all-engines: SUCCESS (1.144s)
[148.533417] Starting dynamic subtest: rcs0
[149.568856] Dynamic subtest rcs0: SUCCESS (1.082s)
[149.583862] Starting dynamic subtest: bcs0
[150.621269] Dynamic subtest bcs0: SUCCESS (1.078s)
[150.637766] Starting dynamic subtest: vcs0
[151.673444] Dynamic subtest vcs0: SUCCESS (1.074s)
[151.689026] Starting dynamic subtest: vcs1
[152.726531] Dynamic subtest vcs1: SUCCESS (1.072s)
[152.742111] Starting dynamic subtest: vecs0
[153.779595] Dynamic subtest vecs0: SUCCESS (1.069s)
[153.795262] Starting dynamic subtest: ccs0
[154.835454] Dynamic subtest ccs0: SUCCESS (1.070s)
[154.838169] Subtest write-wait: SUCCESS (7.594s)
[155.045804] [014/133] (865s left) kms_plane_scaling (planes-upscale-factor-0-25)
[155.141550] Starting subtest: planes-upscale-factor-0-25
[155.143983] Starting dynamic subtest: pipe-A
[155.200470] Dynamic subtest pipe-A: SUCCESS (0.062s)
[155.210963] Starting dynamic subtest: pipe-B
[156.332463] Dynamic subtest pipe-B: SUCCESS (1.145s)
[156.356502] Starting dynamic subtest: pipe-C
[157.464187] Dynamic subtest pipe-C: SUCCESS (1.142s)
[157.474939] Starting dynamic subtest: pipe-D
[158.595603] Dynamic subtest pipe-D: SUCCESS (1.142s)
[158.598105] Subtest planes-upscale-factor-0-25: SUCCESS (3.492s)
[159.743045] [015/133] (861s left) kms_psr (pr-cursor-render)
[159.839478] Starting subtest: pr-cursor-render
[159.843853] Subtest pr-cursor-render: SKIP (0.000s)
[159.920614] [016/133] (861s left) gem_exec_schedule (fairslice)
[160.001033] Starting subtest: fairslice
[160.002949] Starting dynamic subtest: rcs0
[162.015083] Dynamic subtest rcs0: SUCCESS (2.032s)
[162.024189] Starting dynamic subtest: bcs0
[164.035008] Dynamic subtest bcs0: SUCCESS (2.029s)
[164.043598] Starting dynamic subtest: vcs0
[166.054701] Dynamic subtest vcs0: SUCCESS (2.026s)
[166.063224] Starting dynamic subtest: vcs1
[168.071799] Dynamic subtest vcs1: SUCCESS (2.023s)
[168.082602] Starting dynamic subtest: vecs0
[170.090656] Dynamic subtest vecs0: SUCCESS (2.024s)
[170.103662] Starting dynamic subtest: ccs0
[172.119747] Dynamic subtest ccs0: SUCCESS (2.031s)
[172.121672] Subtest fairslice: SUCCESS (12.168s)
[172.424586] [017/133] (848s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[172.531908] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[172.534285] Starting dynamic subtest: A-eDP1
[176.130506] Dynamic subtest A-eDP1: SUCCESS (3.602s)
[176.141004] Starting dynamic subtest: B-eDP1
[179.339325] Dynamic subtest B-eDP1: SUCCESS (3.211s)
[179.349555] Starting dynamic subtest: C-eDP1
[182.444559] Dynamic subtest C-eDP1: SUCCESS (3.104s)
[182.454778] Starting dynamic subtest: D-eDP1
[185.558792] Dynamic subtest D-eDP1: SUCCESS (3.114s)
[185.561086] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.036s)
[186.375697] [018/133] (834s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[186.476895] Starting subtest: stress-xrgb8888-xtiled
[192.353181] Subtest stress-xrgb8888-xtiled: SUCCESS (5.880s)
[192.403668] [019/133] (828s left) gem_sync (basic-many-each)
[192.478759] Starting subtest: basic-many-each
[194.776696] Subtest basic-many-each: SUCCESS (2.306s)
[194.974160] [020/133] (826s left) syncobj_basic (create-signaled)
[195.040796] Starting subtest: create-signaled
[195.043044] Subtest create-signaled: SUCCESS (0.000s)
[195.158255] [021/133] (825s left) perf_pmu (busy-start)
[195.202326] Starting subtest: busy-start
[195.204516] Starting dynamic subtest: rcs0
[197.755153] Dynamic subtest rcs0: SUCCESS (2.553s)
[197.766835] Starting dynamic subtest: bcs0
[200.303667] Dynamic subtest bcs0: SUCCESS (2.548s)
[200.315754] Starting dynamic subtest: vcs0
[204.220723] Dynamic subtest vcs0: SUCCESS (3.915s)
[204.232702] Starting dynamic subtest: vcs1
[208.188368] Dynamic subtest vcs1: SUCCESS (3.968s)
[208.199518] Starting dynamic subtest: vecs0
[212.221373] Dynamic subtest vecs0: SUCCESS (4.033s)
[212.232624] Starting dynamic subtest: ccs0
[214.769468] Dynamic subtest ccs0: SUCCESS (2.549s)
[214.771842] Subtest busy-start: SUCCESS (19.575s)
[214.894597] [022/133] (806s left) gem_userptr_blits (sync-overlap)
[214.962212] Starting subtest: sync-overlap
[214.964452] Subtest sync-overlap: SUCCESS (0.000s)
[215.128679] [023/133] (806s left) kms_big_fb (linear-64bpp-rotate-180)
[215.232093] Starting subtest: linear-64bpp-rotate-180
[216.970425] Subtest linear-64bpp-rotate-180: SUCCESS (1.739s)
[217.324542] [024/133] (803s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[217.441831] Starting subtest: 2x-cursor-vs-flip-legacy
[217.446354] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[217.594233] [025/133] (803s left) perf_pmu (busy)
[217.641396] Starting subtest: busy
[217.643215] Starting dynamic subtest: rcs0
[218.250899] Dynamic subtest rcs0: SUCCESS (0.612s)
[218.262899] Starting dynamic subtest: bcs0
[218.821174] Dynamic subtest bcs0: SUCCESS (0.569s)
[218.830900] Starting dynamic subtest: vcs0
[220.221354] Dynamic subtest vcs0: SUCCESS (1.397s)
[220.233553] Starting dynamic subtest: vcs1
[222.205026] Dynamic subtest vcs1: SUCCESS (1.982s)
[222.216071] Starting dynamic subtest: vecs0
[224.189003] Dynamic subtest vecs0: SUCCESS (1.983s)
[224.200241] Starting dynamic subtest: ccs0
[224.759181] Dynamic subtest ccs0: SUCCESS (0.569s)
[224.761811] Subtest busy: SUCCESS (7.124s)
[224.889760] [026/133] (796s left) kms_addfb_basic (no-handle)
[224.941499] Starting subtest: no-handle
[224.943714] Subtest no-handle: SUCCESS (0.000s)
[225.100317] [027/133] (796s left) dumb_buffer (map-invalid-size)
[225.158740] Starting subtest: map-invalid-size
[225.160815] Subtest map-invalid-size: SUCCESS (0.000s)
[225.279444] [028/133] (796s left) gem_exec_reloc (basic-gtt-cpu)
[225.334468] Subtest basic-gtt-cpu: SKIP (0.000s)
[225.418675] [029/133] (796s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[225.500166] Starting subtest: primary-x-tiled-reflect-x-180
[232.383098] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.887s)
[233.593533] [030/133] (787s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[233.687171] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[233.691274] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[233.766721] [031/133] (787s left) gem_exec_schedule (preempt-hang)
[233.938330] Starting subtest: preempt-hang
[233.941560] Starting dynamic subtest: rcs0
[234.180200] Dynamic subtest rcs0: SUCCESS (0.242s)
[234.189428] Starting dynamic subtest: bcs0
[234.422324] Dynamic subtest bcs0: SUCCESS (0.240s)
[234.431458] Starting dynamic subtest: vcs0
[234.651159] Dynamic subtest vcs0: SUCCESS (0.227s)
[234.659917] Starting dynamic subtest: vcs1
[234.873230] Dynamic subtest vcs1: SUCCESS (0.222s)
[234.885197] Starting dynamic subtest: vecs0
[235.098759] Dynamic subtest vecs0: SUCCESS (0.225s)
[235.108201] Starting dynamic subtest: ccs0
[235.328325] Dynamic subtest ccs0: SUCCESS (0.228s)
[235.330476] Subtest preempt-hang: SUCCESS (1.390s)
[236.330788] [032/133] (785s left) gem_ctx_persistence (heartbeat-close)
[236.387160] Starting subtest: heartbeat-close
[236.392143] Subtest heartbeat-close: SKIP (0.000s)
[236.511969] [033/133] (785s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[236.603001] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[244.047775] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.448s)
[244.195370] [034/133] (777s left) gen9_exec_parse (bb-chained)
[244.258442] Subtest bb-chained: SKIP (0.000s)
[244.343565] [035/133] (777s left) sysfs_heartbeat_interval (mixed)
[244.394832] Starting subtest: mixed
[244.397149] Starting dynamic subtest: vecs0
[249.661776] Dynamic subtest vecs0: SUCCESS (5.262s)
[249.674294] Starting dynamic subtest: ccs0
[254.874687] Dynamic subtest ccs0: SUCCESS (5.208s)
[254.886081] Starting dynamic subtest: vcs0
[260.084569] Dynamic subtest vcs0: SUCCESS (5.206s)
[260.096675] Starting dynamic subtest: bcs0
[265.318541] Dynamic subtest bcs0: SUCCESS (5.230s)
[265.330180] Starting dynamic subtest: rcs0
[270.566453] Dynamic subtest rcs0: SUCCESS (5.245s)
[270.578362] Starting dynamic subtest: vcs1
[275.781685] Dynamic subtest vcs1: SUCCESS (5.213s)
[275.784114] Subtest mixed: SUCCESS (31.376s)
[275.871293] [036/133] (745s left) kms_content_protection (dp-mst-type-1)
[276.034291] Starting subtest: dp-mst-type-1
[276.039049] Subtest dp-mst-type-1: SKIP (0.000s)
[276.176014] [037/133] (745s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[276.282052] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[276.286682] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[276.415748] [038/133] (745s left) kms_vblank (ts-continuation-dpms-rpm)
[276.510329] Starting subtest: ts-continuation-dpms-rpm
[276.512554] Starting dynamic subtest: pipe-A-eDP-1
[279.035464] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.522s)
[279.054029] Starting dynamic subtest: pipe-D-eDP-1
[281.281835] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.245s)
[281.283659] Subtest ts-continuation-dpms-rpm: SUCCESS (4.771s)
[282.083524] [039/133] (739s left) gem_render_copy (linear-to-vebox-yf-tiled)
[282.150567] Starting subtest: linear-to-vebox-yf-tiled
[282.155250] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[282.362026] [040/133] (739s left) vgem_basic (dmabuf-fence)
[282.401270] Starting subtest: dmabuf-fence
[282.403418] Subtest dmabuf-fence: SUCCESS (0.001s)
[282.467096] [041/133] (739s left) kms_psr (psr-primary-mmap-gtt)
[282.565232] Starting subtest: psr-primary-mmap-gtt
[282.567419] Starting dynamic subtest: eDP-1
[283.966919] Dynamic subtest eDP-1: SKIP (1.399s)
[283.971843] Subtest psr-primary-mmap-gtt: SKIP (1.401s)
[284.194849] [042/133] (737s left) kms_chamelium_color (ctm-green-to-red)
[284.303850] Subtest ctm-green-to-red: SKIP (0.000s)
[284.352138] [043/133] (737s left) kms_color_pipeline (plane-lut1d-lut1d)
[284.463359] Starting subtest: plane-lut1d-lut1d
[284.480266] Starting dynamic subtest: pipe-A-eDP-1
[285.153216] Dynamic subtest pipe-A-eDP-1: FAIL (0.316s)
[285.873994] Starting dynamic subtest: pipe-B-eDP-1
[286.728066] Dynamic subtest pipe-B-eDP-1: FAIL (0.334s)
[287.304488] Starting dynamic subtest: pipe-C-eDP-1
[288.115859] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[288.644014] Starting dynamic subtest: pipe-D-eDP-1
[289.470464] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[289.472503] Subtest plane-lut1d-lut1d: FAIL (4.688s)
[290.038334] [044/133] (732s left) gem_eio (create-ext)
[290.265517] Starting subtest: create-ext
[290.575391] Subtest create-ext: SUCCESS (0.309s)
[290.753172] [045/133] (731s left) prime_busy (hang)
[290.823627] Starting subtest: hang
[290.826033] Starting dynamic subtest: rcs0
[316.695761] Dynamic subtest rcs0: SUCCESS (25.873s)
[316.704033] Starting dynamic subtest: bcs0
[323.850089] Dynamic subtest bcs0: SUCCESS (7.155s)
[323.858991] Starting dynamic subtest: vcs0
[330.820401] Dynamic subtest vcs0: SUCCESS (6.973s)
[330.829467] Starting dynamic subtest: vcs1
[337.859535] Dynamic subtest vcs1: SUCCESS (7.040s)
[337.868374] Starting dynamic subtest: vecs0
[344.838062] Dynamic subtest vecs0: SUCCESS (6.976s)
[344.846608] Starting dynamic subtest: ccs0
[358.742476] Dynamic subtest ccs0: SUCCESS (13.906s)
[358.744988] Subtest hang: SUCCESS (67.929s)
[358.884117] [046/133] (663s left) gem_eio (unwedge-stress)
[359.070584] Starting subtest: unwedge-stress
[359.072571] Starting dynamic subtest: render
[363.377494] Dynamic subtest render: SUCCESS (4.307s)
[363.393777] Starting dynamic subtest: bsd1
[381.592318] Dynamic subtest bsd1: SUCCESS (18.212s)
[381.609111] Starting dynamic subtest: bsd2
[399.606928] Dynamic subtest bsd2: SUCCESS (18.010s)
[399.622545] Starting dynamic subtest: blt
[399.626452] Dynamic subtest blt: SKIP (0.000s)
[399.635355] Starting dynamic subtest: vebox
[417.657471] Dynamic subtest vebox: SUCCESS (18.047s)
[417.659965] Subtest unwedge-stress: SUCCESS (58.579s)
[419.247500] [047/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[419.354568] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[419.358519] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[419.459984] [048/133] (602s left) drm_read (fault-buffer)
[419.608393] Starting subtest: fault-buffer
[419.610842] Subtest fault-buffer: SUCCESS (0.001s)
[419.757594] [049/133] (602s left) gem_exec_balancer (bonded-true-hang)
[420.064533] Starting subtest: bonded-true-hang
[420.069394] Subtest bonded-true-hang: SKIP (0.000s)
[420.172902] [050/133] (602s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[420.274267] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[420.276604] Starting dynamic subtest: pipe-A-eDP-1
[420.298475] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[420.309162] Starting dynamic subtest: pipe-B-eDP-1
[420.330469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[420.339310] Starting dynamic subtest: pipe-C-eDP-1
[420.360522] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[420.369656] Starting dynamic subtest: pipe-D-eDP-1
[420.391549] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[420.395561] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[422.559648] [051/133] (599s left) kms_pm_rpm (modeset-pc8-residency-stress)
[424.389399] Starting subtest: modeset-pc8-residency-stress
[424.393839] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[424.810148] [052/133] (597s left) sw_sync (sync_busy_fork_unixsocket)
[424.854505] Starting subtest: sync_busy_fork_unixsocket
[424.861441] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[424.947150] [053/133] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[425.051862] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[425.055892] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[425.184675] [054/133] (597s left) gem_exec_schedule (semaphore-noskip)
[425.262182] Starting subtest: semaphore-noskip
[425.684152] Subtest semaphore-noskip: SUCCESS (0.428s)
[426.068534] [055/133] (596s left) gem_mmap_wc (bad-size)
[426.125542] Subtest bad-size: SKIP (0.000s)
[426.193537] [056/133] (596s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[426.292522] Starting subtest: fbcpsr-stridechange
[432.726120] Subtest fbcpsr-stridechange: SUCCESS (6.435s)
[432.905803] [057/133] (589s left) kms_chamelium_frames (hdmi-crc-single)
[433.304125] Subtest hdmi-crc-single: SKIP (0.000s)
[434.114925] [058/133] (588s left) syncobj_timeline (multi-wait-for-submit-signaled)
[434.171064] Starting subtest: multi-wait-for-submit-signaled
[434.173463] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[434.281258] [059/133] (588s left) gem_exec_fence (syncobj-invalid-wait)
[434.701844] Starting subtest: syncobj-invalid-wait
[434.704474] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[436.330025] [060/133] (586s left) gem_softpin (allocator-fork)
[436.383218] Starting subtest: allocator-fork
[438.601311] Subtest allocator-fork: SUCCESS (2.217s)
[438.772428] [061/133] (583s left) i915_query (test-query-geometry-subslices)
[438.830697] Starting subtest: test-query-geometry-subslices
[438.833071] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[438.952991] [062/133] (583s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[439.058635] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[439.062608] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[439.140765] [063/133] (583s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[439.238922] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[439.243052] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[439.371819] [064/133] (583s left) i915_drm_fdinfo (memory-info-shared)
[439.409399] Starting subtest: memory-info-shared
[439.411854] Starting dynamic subtest: smem0
[439.453505] Dynamic subtest smem0: SUCCESS (0.047s)
[439.456057] Subtest memory-info-shared: SUCCESS (0.047s)
[439.539324] [065/133] (583s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[439.600586] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[439.605205] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[439.793526] [066/133] (583s left) kms_chamelium_hpd (common-hpd-after-suspend)
[440.187016] Subtest common-hpd-after-suspend: SKIP (0.000s)
[440.965226] [067/133] (582s left) gem_exec_fence (basic-wait)
[441.149523] Starting subtest: basic-wait
[441.151982] Starting dynamic subtest: rcs0
[441.226323] Dynamic subtest rcs0: SUCCESS (0.080s)
[441.238485] Starting dynamic subtest: bcs0
[441.291692] Dynamic subtest bcs0: SUCCESS (0.063s)
[441.303464] Starting dynamic subtest: vcs0
[441.354353] Dynamic subtest vcs0: SUCCESS (0.061s)
[441.365474] Starting dynamic subtest: vcs1
[441.419545] Dynamic subtest vcs1: SUCCESS (0.063s)
[441.431266] Starting dynamic subtest: vecs0
[441.479292] Dynamic subtest vecs0: SUCCESS (0.058s)
[441.490704] Starting dynamic subtest: ccs0
[441.538819] Dynamic subtest ccs0: SUCCESS (0.057s)
[441.541444] Subtest basic-wait: SUCCESS (0.394s)
[443.315955] [068/133] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[443.414131] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[443.418200] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[443.535712] [069/133] (579s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[443.587063] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[443.670458] [070/133] (579s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[443.769766] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[450.786295] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.020s)
[451.991466] [071/133] (571s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[452.092816] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[452.097515] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[453.213974] [072/133] (570s left) template (a)
[453.272072] Starting subtest: A
[453.274171] Subtest A: SUCCESS (0.000s)
[453.379043] [073/133] (569s left) kms_psr (fbc-psr-sprite-plane-onoff)
[453.470526] Starting subtest: fbc-psr-sprite-plane-onoff
[453.472845] Starting dynamic subtest: eDP-1
[453.477246] Dynamic subtest eDP-1: SKIP (0.000s)
[453.481656] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[453.561100] [074/133] (569s left) i915_query (query-topology-matches-eu-total)
[453.618205] Starting subtest: query-topology-matches-eu-total
[453.620507] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[453.746088] [075/133] (569s left) kms_psr (fbc-psr2-primary-blt)
[453.851476] Starting subtest: fbc-psr2-primary-blt
[453.853708] Starting dynamic subtest: eDP-1
[453.857957] Dynamic subtest eDP-1: SKIP (0.000s)
[453.862229] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[453.938482] [076/133] (569s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[454.051543] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[454.055989] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[454.182373] [077/133] (569s left) kms_frontbuffer_tracking (basic)
[454.279441] Starting subtest: basic
[457.458202] Subtest basic: SUCCESS (3.181s)
[457.596622] [078/133] (565s left) kms_cursor_crc (cursor-onscreen-128x42)
[457.838060] Starting subtest: cursor-onscreen-128x42
[457.931590] Subtest cursor-onscreen-128x42: SKIP (0.089s)
[458.270925] [079/133] (565s left) kms_universal_plane (universal-plane-functional)
[458.374889] Starting subtest: universal-plane-functional
[458.376726] Starting dynamic subtest: pipe-A-eDP-1
[462.275427] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.901s)
[462.288062] Starting dynamic subtest: pipe-B-eDP-1
[466.740592] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.462s)
[466.750704] Starting dynamic subtest: pipe-C-eDP-1
[471.058960] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.317s)
[471.069150] Starting dynamic subtest: pipe-D-eDP-1
[475.339663] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.282s)
[475.342045] Subtest universal-plane-functional: SUCCESS (16.968s)
[476.154051] [080/133] (547s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[476.254724] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[476.258970] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[476.376230] [081/133] (547s left) gem_lmem_swapping (massive-random)
[476.417978] Subtest massive-random: SKIP (0.000s)
[476.461613] [082/133] (547s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[476.569025] Starting subtest: psr2-plane-move-sf-dmg-area
[476.571336] Starting dynamic subtest: pipe-A-eDP-1
[481.083234] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.518s)
[481.092923] Starting dynamic subtest: pipe-B-eDP-1
[486.417134] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.333s)
[486.419299] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.854s)
[487.284881] [083/133] (536s left) gem_ctx_persistence (engines-mixed-process)
[487.338804] Starting subtest: engines-mixed-process
[487.341197] Starting dynamic subtest: rcs0
[489.190627] Dynamic subtest rcs0: SUCCESS (1.851s)
[489.202389] Starting dynamic subtest: bcs0
[491.206367] Dynamic subtest bcs0: SUCCESS (2.014s)
[491.218093] Starting dynamic subtest: vcs0
[493.199180] Dynamic subtest vcs0: SUCCESS (1.992s)
[493.210287] Starting dynamic subtest: vcs1
[495.171842] Dynamic subtest vcs1: SUCCESS (1.971s)
[495.183468] Starting dynamic subtest: vecs0
[497.240355] Dynamic subtest vecs0: SUCCESS (2.067s)
[497.252357] Starting dynamic subtest: ccs0
[499.218114] Dynamic subtest ccs0: SUCCESS (1.976s)
[499.221075] Subtest engines-mixed-process: SUCCESS (11.882s)
[499.306005] [084/133] (524s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[499.381013] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[499.489478] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[499.578882] [085/133] (524s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[499.700689] Starting subtest: flip-vs-cursor-busy-crc-atomic
[500.499365] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.796s)
[501.315573] [086/133] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[501.418829] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[501.423333] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[501.526948] [087/133] (522s left) kms_lease (multimaster-lease)
[501.628512] Starting subtest: multimaster-lease
[501.630721] Subtest multimaster-lease: SUCCESS (0.003s)
[501.761889] [088/133] (522s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[501.874446] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[501.876680] Starting dynamic subtest: pipe-A-eDP-1
[501.885722] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[501.895809] Starting dynamic subtest: pipe-B-eDP-1
[501.904651] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[501.913603] Starting dynamic subtest: pipe-C-eDP-1
[501.922588] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.931249] Starting dynamic subtest: pipe-D-eDP-1
[501.939899] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.943673] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.014s)
[504.168910] [089/133] (519s left) kms_async_flips (crc-atomic)
[504.277392] Starting subtest: crc-atomic
[504.662740] Starting dynamic subtest: pipe-A-eDP-1
[507.573801] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.910s)
[507.950300] Starting dynamic subtest: pipe-B-eDP-1
[510.818049] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.877s)
[511.192060] Starting dynamic subtest: pipe-C-eDP-1
[514.038971] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.858s)
[514.402004] Starting dynamic subtest: pipe-D-eDP-1
[517.252470] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.861s)
[517.254803] Subtest crc-atomic: SUCCESS (12.979s)
[518.430065] [090/133] (505s left) i915_hangman (detector)
[518.501364] Starting subtest: detector
[518.503251] Starting dynamic subtest: rcs0
[530.140222] Dynamic subtest rcs0: SUCCESS (11.641s)
[530.155779] Starting dynamic subtest: bcs0
[542.171622] Dynamic subtest bcs0: SUCCESS (12.031s)
[542.184095] Starting dynamic subtest: vcs0
[554.139347] Dynamic subtest vcs0: SUCCESS (11.967s)
[554.151175] Starting dynamic subtest: vcs1
[566.107882] Dynamic subtest vcs1: SUCCESS (11.968s)
[566.120480] Starting dynamic subtest: vecs0
[576.091362] Dynamic subtest vecs0: SUCCESS (9.982s)
[576.103511] Starting dynamic subtest: ccs0
[587.163366] Dynamic subtest ccs0: SUCCESS (11.072s)
[587.166463] Subtest detector: SUCCESS (68.677s)
[587.330051] [091/133] (436s left) kms_plane (pixel-format-4-tiled-modifier)
[587.438325] Starting subtest: pixel-format-4-tiled-modifier
[587.467056] Starting dynamic subtest: pipe-A-plane-0
[588.120076] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[588.130114] Starting dynamic subtest: pipe-A-plane-3
[588.541849] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[588.550578] Starting dynamic subtest: pipe-A-plane-5
[588.553943] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[589.678101] Starting dynamic subtest: pipe-B-plane-0
[590.336334] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[590.345797] Starting dynamic subtest: pipe-B-plane-3
[590.780586] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[590.790351] Starting dynamic subtest: pipe-B-plane-5
[590.793986] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[591.091572] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.653s)
[591.994734] [092/133] (432s left) syncobj_timeline (etime-single-wait-submitted)
[592.080282] Starting subtest: etime-single-wait-submitted
[592.186399] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[592.276775] [093/133] (431s left) gem_cs_tlb (engines)
[592.334838] Starting subtest: engines
[592.337194] Starting dynamic subtest: rcs0
[594.490490] Dynamic subtest rcs0: SUCCESS (2.152s)
[594.502635] Starting dynamic subtest: bcs0
[596.645737] Dynamic subtest bcs0: SUCCESS (2.154s)
[596.657979] Starting dynamic subtest: vcs0
[598.799914] Dynamic subtest vcs0: SUCCESS (2.153s)
[598.809876] Starting dynamic subtest: vcs1
[600.951524] Dynamic subtest vcs1: SUCCESS (2.152s)
[600.963363] Starting dynamic subtest: vecs0
[603.105455] Dynamic subtest vecs0: SUCCESS (2.153s)
[603.117647] Starting dynamic subtest: ccs0
[605.260013] Dynamic subtest ccs0: SUCCESS (2.153s)
[605.262423] Subtest engines: SUCCESS (12.925s)
[605.409263] [094/133] (418s left) syncobj_timeline (invalid-transfer-illegal-handle)
[605.459447] Starting subtest: invalid-transfer-illegal-handle
[605.461729] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[605.581771] [095/133] (418s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[605.683590] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[612.631316] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.951s)
[612.759977] [096/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[612.876338] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[612.880481] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[612.995746] [097/133] (411s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[613.096913] Starting subtest: 2x-flip-vs-modeset-vs-hang
[613.105900] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[613.209004] [098/133] (411s left) syncobj_timeline (single-wait-for-submit-signaled)
[613.271056] Starting subtest: single-wait-for-submit-signaled
[613.272994] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[613.379143] [099/133] (410s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[613.473024] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[614.507439] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.036s)
[614.655980] [100/133] (409s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[614.789727] Starting subtest: fbc-rgb565-draw-blt
[618.986109] Subtest fbc-rgb565-draw-blt: SUCCESS (4.200s)
[620.195736] [101/133] (404s left) gem_mmap_wc (close)
[620.255065] Subtest close: SKIP (0.000s)
[620.324490] [102/133] (404s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[620.437334] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[620.441223] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[620.587628] [103/133] (403s left) gem_exec_store (pages)
[620.655069] Starting subtest: pages
[620.657001] Starting dynamic subtest: rcs0
[620.787911] Dynamic subtest rcs0: SUCCESS (0.134s)
[620.802708] Starting dynamic subtest: bcs0
[620.872580] Dynamic subtest bcs0: SUCCESS (0.082s)
[620.884255] Starting dynamic subtest: vcs0
[620.970010] Dynamic subtest vcs0: SUCCESS (0.096s)
[620.982301] Starting dynamic subtest: vcs1
[621.072446] Dynamic subtest vcs1: SUCCESS (0.101s)
[621.083264] Starting dynamic subtest: vecs0
[621.169879] Dynamic subtest vecs0: SUCCESS (0.096s)
[621.180949] Starting dynamic subtest: ccs0
[621.277083] Dynamic subtest ccs0: SUCCESS (0.105s)
[621.279309] Subtest pages: SUCCESS (0.626s)
[621.489642] [104/133] (403s left) kms_pm_dc (dc6-psr)
[622.591416] Starting subtest: dc6-psr
[625.587106] Subtest dc6-psr: SUCCESS (2.995s)
[626.418366] [105/133] (398s left) gem_fence_thrash (bo-write-verify-none)
[626.458235] Starting subtest: bo-write-verify-none
[626.479081] Subtest bo-write-verify-none: SKIP (0.020s)
[626.553154] [106/133] (398s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[626.679819] Starting subtest: basic-flip-after-cursor-atomic
[627.605208] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.926s)
[628.479875] [107/133] (396s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[628.600903] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[629.563968] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.959s)
[630.405506] [108/133] (394s left) kms_dp_linktrain_fallback (dsc-fallback)
[630.500374] Starting subtest: dsc-fallback
[630.506659] Subtest dsc-fallback: SKIP (0.001s)
[630.592259] [109/133] (394s left) api_intel_bb (blit-reloc-keep-cache)
[630.658646] Starting subtest: blit-reloc-keep-cache
[630.663057] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[630.797819] [110/133] (394s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[630.885282] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[630.887464] Starting dynamic subtest: pipe-A-default-mode
[632.050090] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[632.053905] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.163s)
[632.232995] [111/133] (392s left) gen3_render_tiledx_blits
[632.362089] [112/133] (392s left) gem_softpin (overlap)
[632.434542] Starting subtest: overlap
[633.377853] Subtest overlap: SUCCESS (0.943s)
[633.536551] [113/133] (391s left) syncobj_wait (multi-wait-signaled)
[633.595841] Starting subtest: multi-wait-signaled
[633.598204] Subtest multi-wait-signaled: SUCCESS (0.000s)
[633.730252] [114/133] (391s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[633.833499] Starting subtest: plane-primary-toggle-with-vblank-wait
[633.835792] Starting dynamic subtest: pipe-A-eDP-1
[634.006246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[634.325320] Starting dynamic subtest: pipe-B-eDP-1
[635.224790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.909s)
[635.523155] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.687s)
[636.425536] [115/133] (388s left) template (b)
[636.489228] Starting subtest: B
[636.491260] Subtest B: SUCCESS (0.000s)
[636.614005] [116/133] (388s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[636.725086] Starting subtest: psr-rgb565-draw-mmap-gtt
[636.729230] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[636.862340] [117/133] (388s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[636.954157] Starting subtest: yf-tiled-32bpp-rotate-270
[636.958516] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[637.094765] [118/133] (388s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[637.215887] Starting subtest: flip-vs-cursor-toggle
[645.824811] Subtest flip-vs-cursor-toggle: SUCCESS (8.602s)
[646.628195] [119/133] (378s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[646.727531] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[646.731503] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[646.857394] [120/133] (378s left) gem_userptr_blits (map-fixed-invalidate)
[646.919174] Starting subtest: map-fixed-invalidate
[646.923264] Subtest map-fixed-invalidate: SKIP (0.000s)
[647.078119] [121/133] (378s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[647.183607] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[647.185814] Starting dynamic subtest: pipe-A-eDP-1
[647.205475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[647.216151] Starting dynamic subtest: pipe-B-eDP-1
[647.235534] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[647.245045] Starting dynamic subtest: pipe-C-eDP-1
[647.264493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[647.274890] Starting dynamic subtest: pipe-D-eDP-1
[647.294998] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[647.297094] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[649.598632] [122/133] (375s left) gem_mmap_gtt (basic-small-copy-xy)
[649.667199] Subtest basic-small-copy-XY: SKIP (0.000s)
[649.732548] [123/133] (375s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[649.831567] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[649.833756] Starting dynamic subtest: pipe-A
[649.851497] Dynamic subtest pipe-A: SKIP (0.016s)
[649.863334] Starting dynamic subtest: pipe-B
[649.889322] Dynamic subtest pipe-B: SKIP (0.034s)
[649.900653] Starting dynamic subtest: pipe-C
[649.917160] Dynamic subtest pipe-C: SKIP (0.030s)
[649.927791] Starting dynamic subtest: pipe-D
[649.947787] Dynamic subtest pipe-D: SKIP (0.028s)
[649.951527] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.112s)
[650.079669] [124/133] (375s left) gem_caching (writes)
[650.148039] Subtest writes: SKIP (0.000s)
[650.229173] [125/133] (375s left) kms_invalid_mode (bad-hsync-start)
[650.329535] Starting subtest: bad-hsync-start
[650.331895] Starting dynamic subtest: pipe-A-eDP-1
[650.616759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[650.626667] Starting dynamic subtest: pipe-B-eDP-1
[650.628817] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[650.637911] Starting dynamic subtest: pipe-C-eDP-1
[650.639757] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[650.648242] Starting dynamic subtest: pipe-D-eDP-1
[650.650117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[650.652006] Subtest bad-hsync-start: SUCCESS (0.291s)
[651.431451] [126/133] (374s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[651.542194] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[651.546261] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[651.669569] [127/133] (373s left) kms_busy (extended-modeset-hang-newfb)
[651.781443] Starting subtest: extended-modeset-hang-newfb
[651.783579] Starting dynamic subtest: pipe-A
[686.885166] Dynamic subtest pipe-A: SUCCESS (35.084s)
[686.895863] Starting dynamic subtest: pipe-D
[710.144827] Dynamic subtest pipe-D: SUCCESS (23.252s)
[710.147204] Subtest extended-modeset-hang-newfb: SUCCESS (58.340s)
[710.953237] [128/133] (314s left) gem_userptr_blits (unsync-unmap)
[711.019479] Subtest unsync-unmap: SKIP (0.000s)
[711.165710] [129/133] (314s left) kms_cursor_crc (cursor-sliding-256x85)
[711.441350] Starting subtest: cursor-sliding-256x85
[711.481968] Subtest cursor-sliding-256x85: SKIP (0.039s)
[711.676095] [130/133] (314s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[711.790389] Starting subtest: flip-vs-dpms-on-nop-interruptible
[711.792705] Starting dynamic subtest: A-eDP1
[713.632994] Dynamic subtest A-eDP1: SUCCESS (1.841s)
[713.645833] Starting dynamic subtest: B-eDP1
[715.464969] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[715.478013] Starting dynamic subtest: C-eDP1
[717.287895] Dynamic subtest C-eDP1: SUCCESS (1.820s)
[717.304182] Starting dynamic subtest: D-eDP1
[719.116190] Dynamic subtest D-eDP1: SUCCESS (1.826s)
[719.121468] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.330s)
[720.310484] [131/133] (305s left) api_intel_bb (intel-bb-blit-x)
[720.370928] Starting subtest: intel-bb-blit-x
[723.966500] Subtest intel-bb-blit-x: SUCCESS (3.595s)
[724.211987] [132/133] (301s left) kms_flip (flip-vs-expired-vblank-interruptible)
[724.445417] Starting subtest: flip-vs-expired-vblank-interruptible
[724.447706] Starting dynamic subtest: A-eDP1
[733.095585] Dynamic subtest A-eDP1: SUCCESS (8.648s)
[733.110247] Starting dynamic subtest: B-eDP1
[741.724993] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[741.744179] Starting dynamic subtest: C-eDP1
[750.338640] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[750.348156] Starting dynamic subtest: D-eDP1
[758.971581] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[758.977600] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.527s)
[760.173033] [133/133] (265s left) kms_flip (2x-flip-vs-rmfb)
[760.274021] Starting subtest: 2x-flip-vs-rmfb
[760.281703] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[760.370494] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: fbdev
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: i915_pm_rpm
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_pipe_stress
results: parsing output: 18/ for test: gem_sync
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: dumb_buffer
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: sysfs_heartbeat_interval
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: prime_busy
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: i915_query
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: template
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_universal_plane
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_cs_tlb
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_wc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_store
results: parsing output: 103/ for test: kms_pm_dc
results: parsing output: 104/ for test: gem_fence_thrash
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_dp_linktrain_fallback
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gen3_render_tiledx_blits
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: template
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_busy
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_flip
Done.