[59.485347] Initializing watchdogs
[59.485392]   /dev/watchdog0
[59.499860] [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.504505] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.506726] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.510057] [001/132] (960s left) gem_media_vme
[59.656411] [002/132] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[59.756369] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[66.569945] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.816s)
[66.669371] [003/132] (953s left) gem_exec_flush (basic-uc-rw-default)
[66.772707] Starting subtest: basic-uc-rw-default
[72.247339] Subtest basic-uc-rw-default: SUCCESS (5.475s)
[72.445600] [004/132] (947s left) kms_lease (cursor-implicit-plane)
[72.538080] Starting subtest: cursor-implicit-plane
[72.540612] Starting dynamic subtest: pipe-A-eDP-1
[72.995903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[73.006764] Starting dynamic subtest: pipe-B-eDP-1
[74.126478] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.128s)
[74.135972] Starting dynamic subtest: pipe-C-eDP-1
[75.225675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s)
[75.235742] Starting dynamic subtest: pipe-D-eDP-1
[76.357630] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[76.359717] Subtest cursor-implicit-plane: SUCCESS (3.819s)
[77.232384] [005/132] (942s left) kms_flip (dpms-vs-vblank-race)
[77.326116] Starting subtest: dpms-vs-vblank-race
[77.328381] Starting dynamic subtest: A-eDP1
[82.308521] Dynamic subtest A-eDP1: SUCCESS (4.980s)
[82.315918] Starting dynamic subtest: B-eDP1
[86.929773] Dynamic subtest B-eDP1: SUCCESS (4.617s)
[86.941237] Starting dynamic subtest: C-eDP1
[91.552903] Dynamic subtest C-eDP1: SUCCESS (4.622s)
[91.566945] Starting dynamic subtest: D-eDP1
[96.204325] Dynamic subtest D-eDP1: SUCCESS (4.648s)
[96.206687] Subtest dpms-vs-vblank-race: SUCCESS (18.874s)
[97.070815] [006/132] (923s left) gem_ccs (block-copy-uncompressed)
[97.139346] Starting subtest: block-copy-uncompressed
[97.141671] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[97.160792] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[97.170225] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[97.177666] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[97.184799] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[97.194679] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[97.201817] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[97.211555] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[97.213868] Subtest block-copy-uncompressed: SUCCESS (0.073s)
[97.330642] [007/132] (922s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[97.435626] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[97.440158] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[97.549327] [008/132] (922s left) perf (global-sseu-config)
[97.682047] Starting subtest: global-sseu-config
[97.685754] Subtest global-sseu-config: SKIP (0.000s)
[97.722832] [009/132] (922s left) kms_hdmi_inject (inject-4k)
[98.077018] Starting subtest: inject-4k
[98.389675] Subtest inject-4k: SUCCESS (0.315s)
[98.922652] [010/132] (921s left) kms_properties (connector-properties-atomic)
[99.006832] Starting subtest: connector-properties-atomic
[99.009200] Starting dynamic subtest: pipe-A-eDP-1
[107.177635] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.170s)
[107.188744] Starting dynamic subtest: pipe-None-DP-1
[107.193132] Dynamic subtest pipe-None-DP-1: SUCCESS (0.003s)
[107.200408] Starting dynamic subtest: pipe-None-HDMI-A-1
[107.204573] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[107.211541] Starting dynamic subtest: pipe-None-DP-2
[107.216377] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[107.223145] Starting dynamic subtest: pipe-None-HDMI-A-2
[107.227099] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.003s)
[107.233940] Starting dynamic subtest: pipe-None-DP-3
[107.237749] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[107.244873] Starting dynamic subtest: pipe-None-DP-4
[107.249216] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[107.251302] Subtest connector-properties-atomic: SUCCESS (8.192s)
[107.994225] [011/132] (912s left) gem_pipe_control_store_loop (reused-buffer)
[108.059831] Starting subtest: reused-buffer
[110.212747] Subtest reused-buffer: SUCCESS (2.152s)
[110.334221] [012/132] (910s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[110.436073] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[111.216049] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[111.387245] [013/132] (909s left) gem_mmap_gtt (basic-write-gtt)
[111.438767] Subtest basic-write-gtt: SKIP (0.000s)
[111.503723] [014/132] (909s left) kms_atomic (plane-cursor-legacy)
[111.588940] Starting subtest: plane-cursor-legacy
[111.591255] Starting dynamic subtest: pipe-A-eDP-1
[111.983322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[111.985691] Subtest plane-cursor-legacy: SUCCESS (0.397s)
[112.797661] [015/132] (907s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[112.905293] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[119.961081] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.058s)
[121.110062] [016/132] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[121.212765] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[121.216874] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[121.319761] [017/132] (899s left) kms_plane_multiple (2x-tiling-yf)
[121.411317] Starting subtest: 2x-tiling-yf
[121.415861] Subtest 2x-tiling-yf: SKIP (0.000s)
[121.484760] [018/132] (899s left) kms_invalid_mode (bad-htotal)
[121.576250] Starting subtest: bad-htotal
[121.578635] Starting dynamic subtest: pipe-A-eDP-1
[121.861667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[121.870351] Starting dynamic subtest: pipe-B-eDP-1
[121.872615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[121.880076] Starting dynamic subtest: pipe-C-eDP-1
[121.882237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[121.889798] Starting dynamic subtest: pipe-D-eDP-1
[121.893066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[121.895429] Subtest bad-htotal: SUCCESS (0.294s)
[122.716516] [019/132] (897s left) gem_exec_params (batch-first)
[122.780621] Starting subtest: batch-first
[122.785764] Subtest batch-first: SUCCESS (0.005s)
[122.900290] [020/132] (897s left) gem_userptr_blits (unsync-unmap-after-close)
[122.958855] Subtest unsync-unmap-after-close: SKIP (0.000s)
[123.094295] [021/132] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[123.195295] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[130.095743] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.903s)
[130.219086] [022/132] (890s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[130.324731] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[130.327555] Starting dynamic subtest: pipe-A-eDP-1
[130.386680] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[130.396133] Starting dynamic subtest: pipe-B-eDP-1
[130.454106] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[130.463803] Starting dynamic subtest: pipe-C-eDP-1
[130.521295] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[130.530177] Starting dynamic subtest: pipe-D-eDP-1
[130.590508] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[130.595073] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[132.600598] [023/132] (888s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[132.697859] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[139.502455] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.809s)
[139.633390] [024/132] (881s left) kms_cursor_crc (cursor-onscreen-32x10)
[139.797185] Starting subtest: cursor-onscreen-32x10
[139.864378] Subtest cursor-onscreen-32x10: SKIP (0.061s)
[140.131760] [025/132] (880s left) kms_busy (basic-hang)
[140.239056] Starting subtest: basic-hang
[140.240931] Starting dynamic subtest: flip-pipe-A
[140.839377] Dynamic subtest flip-pipe-A: SUCCESS (0.599s)
[140.847260] Starting dynamic subtest: modeset-pipe-A
[144.238868] Dynamic subtest modeset-pipe-A: SUCCESS (3.401s)
[144.247680] Starting dynamic subtest: flip-pipe-D
[145.500385] Dynamic subtest flip-pipe-D: SUCCESS (1.260s)
[145.508482] Starting dynamic subtest: modeset-pipe-D
[148.828255] Dynamic subtest modeset-pipe-D: SUCCESS (3.327s)
[148.830607] Subtest basic-hang: SUCCESS (8.592s)
[149.715908] [026/132] (871s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[149.814181] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[149.816423] Starting dynamic subtest: pipe-A
[149.834069] Dynamic subtest pipe-A: SKIP (0.017s)
[149.842568] Starting dynamic subtest: pipe-B
[149.865689] Dynamic subtest pipe-B: SKIP (0.030s)
[149.873674] Starting dynamic subtest: pipe-C
[149.896745] Dynamic subtest pipe-C: SKIP (0.030s)
[149.904561] Starting dynamic subtest: pipe-D
[149.927669] Dynamic subtest pipe-D: SKIP (0.030s)
[149.931776] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.109s)
[150.034912] [027/132] (870s left) gem_exec_schedule (preempt)
[150.110371] Starting subtest: preempt
[150.112417] Starting dynamic subtest: rcs0
[150.124356] Dynamic subtest rcs0: SUCCESS (0.021s)
[150.133991] Starting dynamic subtest: bcs0
[150.142341] Dynamic subtest bcs0: SUCCESS (0.018s)
[150.149913] Starting dynamic subtest: vcs0
[150.162137] Dynamic subtest vcs0: SUCCESS (0.019s)
[150.169630] Starting dynamic subtest: vcs1
[150.182151] Dynamic subtest vcs1: SUCCESS (0.020s)
[150.189669] Starting dynamic subtest: vecs0
[150.201501] Dynamic subtest vecs0: SUCCESS (0.019s)
[150.209176] Starting dynamic subtest: ccs0
[150.221067] Dynamic subtest ccs0: SUCCESS (0.019s)
[150.223376] Subtest preempt: SUCCESS (0.119s)
[151.977431] [028/132] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[152.102407] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[155.772536] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.672s)
[156.901771] [029/132] (864s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[156.996268] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[156.998630] Starting dynamic subtest: pipe-A-eDP-1
[157.021803] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[157.030394] Starting dynamic subtest: pipe-B-eDP-1
[157.051917] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[157.059036] Starting dynamic subtest: pipe-C-eDP-1
[157.081061] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[157.088087] Starting dynamic subtest: pipe-D-eDP-1
[157.109988] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[157.114423] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[159.194625] [030/132] (861s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[159.285070] Starting subtest: crc-primary-basic-y-tiled-ccs
[159.287227] Starting dynamic subtest: pipe-A-eDP-1
[159.309258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.318728] Starting dynamic subtest: pipe-B-eDP-1
[159.338747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.346334] Starting dynamic subtest: pipe-C-eDP-1
[159.366904] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.374171] Starting dynamic subtest: pipe-D-eDP-1
[159.395942] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.400284] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[161.492366] [031/132] (859s left) gem_exec_schedule (promotion)
[161.559606] Starting subtest: promotion
[161.561799] Starting dynamic subtest: rcs0
[161.660771] Dynamic subtest rcs0: SUCCESS (0.105s)
[161.670972] Starting dynamic subtest: vcs0
[161.746345] Dynamic subtest vcs0: SUCCESS (0.085s)
[161.756128] Starting dynamic subtest: vcs1
[161.828896] Dynamic subtest vcs1: SUCCESS (0.081s)
[161.839704] Starting dynamic subtest: vecs0
[161.905094] Dynamic subtest vecs0: SUCCESS (0.076s)
[161.916071] Starting dynamic subtest: ccs0
[161.997463] Dynamic subtest ccs0: SUCCESS (0.092s)
[161.999942] Subtest promotion: SUCCESS (0.444s)
[162.994367] [032/132] (858s left) syncobj_timeline (signal-array)
[163.052676] Starting subtest: signal-array
[163.055056] Subtest signal-array: SUCCESS (0.000s)
[163.140267] [033/132] (858s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[163.247748] Starting subtest: psr2-cursor-plane-move-continuous-sf
[163.250142] Starting dynamic subtest: pipe-A-eDP-1
[173.592438] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.346s)
[173.602050] Starting dynamic subtest: pipe-B-eDP-1
[184.630151] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.037s)
[184.632527] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.387s)
[185.491316] [034/132] (835s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[185.586862] Starting subtest: fbc-indfb-scaledprimary
[188.518079] Subtest fbc-indfb-scaledprimary: SUCCESS (2.935s)
[189.722510] [035/132] (831s left) gem_exec_balancer (bonded-semaphore)
[189.789682] Starting subtest: bonded-semaphore
[189.794085] Subtest bonded-semaphore: SKIP (0.000s)
[190.100304] [036/132] (831s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[190.172875] Starting subtest: invalid-multi-wait-unsubmitted
[190.175362] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[190.298696] [037/132] (831s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[190.435993] Starting subtest: dp-mst-lic-type-0-hdcp14
[190.440658] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[190.584239] [038/132] (830s left) gem_exec_schedule (implicit-boths)
[190.657765] Starting subtest: implicit-boths
[190.659973] Starting dynamic subtest: rcs0
[190.763800] Dynamic subtest rcs0: SUCCESS (0.114s)
[190.774977] Starting dynamic subtest: vcs0
[190.852497] Dynamic subtest vcs0: SUCCESS (0.089s)
[190.863691] Starting dynamic subtest: vcs1
[190.928925] Dynamic subtest vcs1: SUCCESS (0.075s)
[190.939628] Starting dynamic subtest: vecs0
[191.009738] Dynamic subtest vecs0: SUCCESS (0.081s)
[191.024979] Starting dynamic subtest: ccs0
[191.096964] Dynamic subtest ccs0: SUCCESS (0.085s)
[191.099040] Subtest implicit-boths: SUCCESS (0.450s)
[191.990801] [039/132] (829s left) kms_pm_rpm (cursor)
[194.027762] Starting subtest: cursor
[194.032962] Subtest cursor: SKIP (0.000s)
[194.410922] [040/132] (827s left) gem_ctx_persistence (engines-queued)
[194.483730] Starting subtest: engines-queued
[194.486053] Starting dynamic subtest: rcs0
[194.552667] Dynamic subtest rcs0: SUCCESS (0.071s)
[194.563422] Starting dynamic subtest: bcs0
[194.608822] Dynamic subtest bcs0: SUCCESS (0.054s)
[194.619201] Starting dynamic subtest: vcs0
[195.829085] Dynamic subtest vcs0: SUCCESS (1.216s)
[195.840554] Starting dynamic subtest: vcs1
[196.855065] Dynamic subtest vcs1: SUCCESS (1.021s)
[196.865717] Starting dynamic subtest: vecs0
[198.898178] Dynamic subtest vecs0: SUCCESS (2.042s)
[198.914998] Starting dynamic subtest: ccs0
[199.093791] Dynamic subtest ccs0: SUCCESS (0.195s)
[199.096161] Subtest engines-queued: SUCCESS (4.613s)
[199.196449] [041/132] (822s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[199.301791] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[199.306213] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[199.379386] [042/132] (822s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[199.496240] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[199.500504] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[199.576647] [043/132] (822s left) gem_exec_reloc (basic-write-wc)
[199.639693] Subtest basic-write-wc: SKIP (0.000s)
[199.704805] [044/132] (821s left) gem_ctx_param (set-priority-invalid-size)
[199.760955] Starting subtest: set-priority-invalid-size
[199.763257] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[199.839045] [045/132] (821s left) i915_pm_rpm (reg-read-ioctl)
[202.068255] Starting subtest: reg-read-ioctl
[204.356974] Subtest reg-read-ioctl: SUCCESS (2.292s)
[204.755699] [046/132] (817s left) kms_frontbuffer_tracking (psr-suspend)
[204.861078] Starting subtest: psr-suspend
[243.284324] Subtest psr-suspend: SUCCESS (8.916s)
[243.434195] [047/132] (778s left) kms_psr (fbc-pr-no-drrs)
[243.526469] Starting subtest: fbc-pr-no-drrs
[243.530857] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[243.597910] [048/132] (778s left) gem_exec_fence (syncobj-invalid-wait)
[244.116667] Starting subtest: syncobj-invalid-wait
[244.118532] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[245.393533] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[245.396963] [049/132] (776s left) i915_query (query-topology-garbage-items)
[245.453028] Starting subtest: query-topology-garbage-items
[245.455428] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[245.569780] [050/132] (776s left) core_getclient (basic)
[245.623174] Starting subtest: basic
[245.625544] Subtest basic: SUCCESS (0.000s)
[245.740398] [051/132] (776s left) gem_spin_batch (resubmit-new)
[245.803443] Starting subtest: resubmit-new
[245.805736] Starting dynamic subtest: rcs0
[245.813170] Dynamic subtest rcs0: SUCCESS (0.010s)
[245.824667] Starting dynamic subtest: bcs0
[245.826533] Dynamic subtest bcs0: SUCCESS (0.005s)
[245.835210] Starting dynamic subtest: vcs0
[245.837509] Dynamic subtest vcs0: SUCCESS (0.004s)
[245.846016] Starting dynamic subtest: vcs1
[245.848278] Dynamic subtest vcs1: SUCCESS (0.004s)
[245.856927] Starting dynamic subtest: vecs0
[245.859215] Dynamic subtest vecs0: SUCCESS (0.006s)
[245.867526] Starting dynamic subtest: ccs0
[245.869723] Dynamic subtest ccs0: SUCCESS (0.007s)
[245.871955] Subtest resubmit-new: SUCCESS (0.041s)
[247.506187] [052/132] (774s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[247.616504] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[247.618704] Starting dynamic subtest: pipe-A-eDP-1
[247.641264] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.651530] Starting dynamic subtest: pipe-B-eDP-1
[247.673413] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[247.681708] Starting dynamic subtest: pipe-C-eDP-1
[247.703411] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[247.712030] Starting dynamic subtest: pipe-D-eDP-1
[247.737215] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[247.741113] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[249.882485] [053/132] (772s left) kms_vblank (query-busy-hang)
[249.982963] Starting subtest: query-busy-hang
[249.985179] Starting dynamic subtest: pipe-A-eDP-1
[276.182360] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.181s)
[276.195885] Starting dynamic subtest: pipe-D-eDP-1
[291.171501] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.977s)
[291.173380] Subtest query-busy-hang: SUCCESS (41.162s)
[292.016435] [054/132] (730s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[292.126843] Starting subtest: read-crc-frame-sequence
[292.129369] Starting dynamic subtest: pipe-A-eDP-1
[292.871102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[292.881674] Starting dynamic subtest: pipe-B-eDP-1
[294.251838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[294.262170] Starting dynamic subtest: pipe-C-eDP-1
[295.595885] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[295.605325] Starting dynamic subtest: pipe-D-eDP-1
[296.896525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[296.898714] Subtest read-crc-frame-sequence: SUCCESS (4.768s)
[297.710693] [055/132] (724s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[297.812479] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[297.814678] Starting dynamic subtest: pipe-A-default-mode
[298.947856] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[298.952055] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.135s)
[299.103531] [056/132] (723s left) gem_fenced_exec_thrash (2-spare-fences)
[299.170266] Subtest 2-spare-fences: SKIP (0.000s)
[299.242213] [057/132] (722s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[299.308701] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[299.312958] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[299.488210] [058/132] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[299.588482] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[299.592664] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[299.687211] [059/132] (722s left) gem_close_race (multigpu-basic-process)
[299.751345] Starting subtest: multigpu-basic-process
[299.755937] Subtest multigpu-basic-process: SKIP (0.000s)
[299.998555] [060/132] (722s left) gem_pxp (hw-rejects-pxp-buffer)
[300.124318] Starting subtest: hw-rejects-pxp-buffer
[300.128967] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[300.246707] [061/132] (722s left) gem_exec_reloc (basic-write-wc-active)
[300.297840] Subtest basic-write-wc-active: SKIP (0.000s)
[300.376891] [062/132] (722s left) gem_exec_flush (basic-uc-pro-default)
[300.441383] Starting subtest: basic-uc-pro-default
[305.908903] Subtest basic-uc-pro-default: SUCCESS (5.465s)
[306.098850] [063/132] (716s left) gem_exec_params (invalid-bsd1-flag-on-render)
[306.158678] Starting subtest: invalid-bsd1-flag-on-render
[306.161295] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[306.271401] [064/132] (716s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[306.372771] Starting subtest: fbc-rgb565-draw-mmap-cpu
[310.403015] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.034s)
[311.536655] [065/132] (711s left) gem_mmap_offset (bad-object)
[311.602221] Starting subtest: bad-object
[311.604617] Subtest bad-object: SUCCESS (0.001s)
[311.724516] [066/132] (710s left) kms_feature_discovery (chamelium)
[311.816432] Starting subtest: chamelium
[311.820923] Subtest chamelium: SKIP (0.000s)
[311.890546] [067/132] (710s left) perf_pmu (idle)
[311.929517] Starting subtest: idle
[311.931698] Starting dynamic subtest: rcs0
[312.481086] Dynamic subtest rcs0: SUCCESS (0.550s)
[312.493383] Starting dynamic subtest: bcs0
[313.008203] Dynamic subtest bcs0: SUCCESS (0.524s)
[313.019518] Starting dynamic subtest: vcs0
[313.527830] Dynamic subtest vcs0: SUCCESS (0.517s)
[313.537385] Starting dynamic subtest: vcs1
[314.050581] Dynamic subtest vcs1: SUCCESS (0.519s)
[314.062797] Starting dynamic subtest: vecs0
[314.577367] Dynamic subtest vecs0: SUCCESS (0.524s)
[314.592214] Starting dynamic subtest: ccs0
[315.096702] Dynamic subtest ccs0: SUCCESS (0.516s)
[315.099594] Subtest idle: SUCCESS (3.166s)
[315.217280] [068/132] (707s left) gen9_exec_parse (allowed-all)
[315.277387] Subtest allowed-all: SKIP (0.000s)
[315.353684] [069/132] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[315.446988] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[322.768476] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.320s)
[322.892323] [070/132] (699s left) kms_psr (fbc-psr2-sprite-render)
[322.992346] Starting subtest: fbc-psr2-sprite-render
[322.994548] Starting dynamic subtest: eDP-1
[322.998528] Dynamic subtest eDP-1: SKIP (0.000s)
[323.002517] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[323.064967] [071/132] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[323.161600] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[323.165417] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[323.260242] [072/132] (699s left) gem_eio (in-flight-suspend)
[323.488560] Starting subtest: in-flight-suspend
[367.082355] Subtest in-flight-suspend: SUCCESS (13.941s)
[367.200548] [073/132] (655s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[367.308428] Starting subtest: 4-tiled-16bpp-rotate-90
[367.329748] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[367.444644] [074/132] (655s left) kms_flip (basic-flip-vs-dpms)
[367.545600] Starting subtest: basic-flip-vs-dpms
[367.548642] Starting dynamic subtest: A-eDP1
[370.143372] Dynamic subtest A-eDP1: SUCCESS (2.588s)
[370.154918] Starting dynamic subtest: B-eDP1
[372.316275] Dynamic subtest B-eDP1: SUCCESS (2.167s)
[372.326727] Starting dynamic subtest: C-eDP1
[374.777399] Dynamic subtest C-eDP1: SUCCESS (2.453s)
[374.787820] Starting dynamic subtest: D-eDP1
[376.922193] Dynamic subtest D-eDP1: SUCCESS (2.142s)
[376.924458] Subtest basic-flip-vs-dpms: SUCCESS (9.360s)
[377.785907] [075/132] (645s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[377.919522] Starting subtest: x-tiled-16bpp-rotate-270
[377.938878] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[378.042319] [076/132] (644s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[378.093651] Starting subtest: invalid-multi-wait-unsubmitted
[378.096430] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[378.193031] [077/132] (644s left) kms_vblank (wait-forked-busy-hang)
[378.285277] Starting subtest: wait-forked-busy-hang
[378.287632] Starting dynamic subtest: pipe-A-eDP-1
[380.165140] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[380.181611] Starting dynamic subtest: pipe-D-eDP-1
[382.716385] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s)
[382.719490] Subtest wait-forked-busy-hang: SUCCESS (4.428s)
[383.599772] [078/132] (639s left) kms_dp_link_training (non-uhbr-mst)
[383.685591] Starting subtest: non-uhbr-mst
[383.696116] Subtest non-uhbr-mst: SKIP (0.000s)
[383.763257] [079/132] (639s left) syncobj_eventfd (binary-wait-signaled)
[383.828992] Starting subtest: binary-wait-signaled
[383.831412] Subtest binary-wait-signaled: SUCCESS (0.000s)
[383.924313] [080/132] (639s left) syncobj_wait (invalid-reset-bad-pad)
[383.981941] Starting subtest: invalid-reset-bad-pad
[383.984349] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[384.078544] [081/132] (639s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[384.171228] Starting subtest: fbcpsr-tiling-y
[384.176376] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[384.265036] [082/132] (639s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[384.371300] Starting subtest: 2x-long-flip-vs-cursor-atomic
[384.376293] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[384.528443] [083/132] (638s left) kms_cursor_crc (cursor-sliding-64x21)
[384.719970] Starting subtest: cursor-sliding-64x21
[384.765828] Subtest cursor-sliding-64x21: SKIP (0.040s)
[385.005975] [084/132] (638s left) gem_exec_capture (capture-recoverable)
[385.068847] Starting subtest: capture-recoverable
[385.070936] Subtest capture-recoverable: SUCCESS (0.004s)
[385.184661] [085/132] (638s left) vgem_basic (busy-fence)
[385.236390] Starting subtest: busy-fence
[385.238944] Subtest busy-fence: SUCCESS (0.000s)
[385.290573] [086/132] (638s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[385.389923] Starting subtest: fbc-rgb565-draw-pwrite
[389.856175] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.468s)
[391.016327] [087/132] (632s left) kms_addfb_basic (unused-offsets)
[391.072601] Starting subtest: unused-offsets
[391.074909] Subtest unused-offsets: SUCCESS (0.000s)
[391.201195] [088/132] (632s left) kms_chamelium_color (ctm-limited-range)
[391.284653] Subtest ctm-limited-range: SKIP (0.000s)
[391.334162] [089/132] (632s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[391.455530] Starting subtest: 2x-long-cursor-vs-flip-atomic
[391.460236] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[391.603138] [090/132] (632s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[391.709647] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[391.715199] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[391.798116] [091/132] (631s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[391.894507] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[391.900221] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[391.988496] [092/132] (631s left) core_getversion (basic)
[392.034631] Starting subtest: basic
[392.040068] Subtest basic: SUCCESS (0.000s)
[392.112191] [093/132] (631s left) sriov_basic (bind-unbind-vf)
[392.165244] Starting subtest: bind-unbind-vf
[392.168098] Starting dynamic subtest: vf-1
[392.251509] Dynamic subtest vf-1: FAIL (0.014s)
[392.265065] Starting dynamic subtest: vf-2
[392.352222] Dynamic subtest vf-2: FAIL (0.004s)
[392.362294] Starting dynamic subtest: vf-3
[392.449424] Dynamic subtest vf-3: FAIL (0.004s)
[392.460059] Starting dynamic subtest: vf-4
[392.546406] Dynamic subtest vf-4: FAIL (0.003s)
[392.556464] Starting dynamic subtest: vf-5
[392.644317] Dynamic subtest vf-5: FAIL (0.003s)
[392.654689] Starting dynamic subtest: vf-6
[392.736217] Dynamic subtest vf-6: FAIL (0.003s)
[392.746916] Starting dynamic subtest: vf-7
[392.813969] Dynamic subtest vf-7: FAIL (0.004s)
[392.824410] Starting dynamic subtest: vf-random
[392.885608] Dynamic subtest vf-random: FAIL (0.004s)
[392.897610] Starting dynamic subtest: vf-last
[392.974237] Dynamic subtest vf-last: FAIL (0.585s)
[392.976387] Subtest bind-unbind-vf: FAIL (0.631s)
[393.019933] [094/132] (630s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[393.115108] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[393.119473] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[393.205333] [095/132] (630s left) i915_drm_fdinfo (memory-info-resident)
[393.243895] Starting subtest: memory-info-resident
[393.246268] Starting dynamic subtest: smem0
[395.914173] Dynamic subtest smem0: SUCCESS (2.669s)
[395.916934] Subtest memory-info-resident: SUCCESS (2.670s)
[395.991654] [096/132] (627s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[396.300436] Starting subtest: cursor-rapid-movement-512x512
[396.304863] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[396.464100] [097/132] (627s left) kms_flip (modeset-vs-vblank-race)
[396.548173] Starting subtest: modeset-vs-vblank-race
[396.550226] Starting dynamic subtest: A-eDP1
[401.288013] Dynamic subtest A-eDP1: SUCCESS (4.738s)
[401.301206] Starting dynamic subtest: B-eDP1
[405.991150] Dynamic subtest B-eDP1: SUCCESS (4.700s)
[406.003917] Starting dynamic subtest: C-eDP1
[410.674775] Dynamic subtest C-eDP1: SUCCESS (4.681s)
[410.688974] Starting dynamic subtest: D-eDP1
[415.365840] Dynamic subtest D-eDP1: SUCCESS (4.687s)
[415.371778] Subtest modeset-vs-vblank-race: SUCCESS (18.820s)
[416.603058] [098/132] (607s left) kms_psr (psr-cursor-mmap-cpu)
[416.710121] Starting subtest: psr-cursor-mmap-cpu
[416.712466] Starting dynamic subtest: eDP-1
[418.472311] Dynamic subtest eDP-1: SUCCESS (1.761s)
[418.475157] Subtest psr-cursor-mmap-cpu: SUCCESS (1.762s)
[419.292951] [099/132] (604s left) gem_userptr_blits (unsync-unmap)
[419.364362] Subtest unsync-unmap: SKIP (0.000s)
[419.486919] [100/132] (604s left) gem_exec_whisper (basic-queues)
[419.548307] Starting subtest: basic-queues
[427.022583] Subtest basic-queues: SUCCESS (7.468s)
[427.207110] [101/132] (596s left) gem_ctx_persistence (hang)
[427.271389] Starting subtest: hang
[427.276654] Subtest hang: SKIP (0.000s)
[427.372933] [102/132] (596s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[427.502331] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[427.506718] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[427.654648] [103/132] (596s left) gem_tiled_fence_blits (basic)
[427.720813] Subtest basic: SKIP (0.000s)
[427.791064] [104/132] (596s left) prime_mmap_coherency (ioctl-errors)
[427.847021] Starting subtest: ioctl-errors
[453.016980] Subtest ioctl-errors: SUCCESS (25.160s)
[453.182188] [105/132] (571s left) i915_hangman (gt-engine-error)
[453.294807] Starting subtest: gt-engine-error
[453.297141] Starting dynamic subtest: rcs0
[455.053119] Dynamic subtest rcs0: SUCCESS (1.756s)
[455.069439] Starting dynamic subtest: bcs0
[456.970861] Dynamic subtest bcs0: SUCCESS (1.915s)
[456.985480] Starting dynamic subtest: vcs0
[458.955640] Dynamic subtest vcs0: SUCCESS (1.981s)
[458.969707] Starting dynamic subtest: vcs1
[460.044791] Dynamic subtest vcs1: SUCCESS (1.086s)
[460.059133] Starting dynamic subtest: vecs0
[462.026801] Dynamic subtest vecs0: SUCCESS (1.979s)
[462.041230] Starting dynamic subtest: ccs0
[464.012006] Dynamic subtest ccs0: SUCCESS (1.983s)
[464.014636] Subtest gt-engine-error: SUCCESS (10.716s)
[464.097170] [106/132] (560s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[464.161587] Starting subtest: etime-single-wait-for-submit-unsubmitted
[464.266024] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[464.344204] [107/132] (560s left) kms_chamelium_hpd (hdmi-hpd-storm)
[464.730424] Subtest hdmi-hpd-storm: SKIP (0.000s)
[465.581826] [108/132] (558s left) syncobj_wait (reset-multiple-signaled)
[465.638457] Starting subtest: reset-multiple-signaled
[465.641630] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[465.745245] [109/132] (558s left) kms_chamelium_edid (vga-edid-read)
[466.134935] Subtest vga-edid-read: SKIP (0.000s)
[466.997561] [110/132] (557s left) gem_mmap_gtt (medium-copy)
[467.056587] Subtest medium-copy: SKIP (0.000s)
[467.116732] [111/132] (557s left) gem_lmem_swapping (parallel-random)
[467.161265] Subtest parallel-random: SKIP (0.000s)
[467.206506] [112/132] (557s left) gem_ctx_param (get-priority-new-ctx)
[467.263215] Starting subtest: get-priority-new-ctx
[467.265572] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[467.367030] [113/132] (557s left) perf (non-sampling-read-error)
[467.485480] Starting subtest: non-sampling-read-error
[467.499039] Subtest non-sampling-read-error: SUCCESS (0.011s)
[467.544045] [114/132] (557s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[467.636740] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[467.641870] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[467.708932] [115/132] (557s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[467.812105] Starting subtest: plane-lut1d-post-ctm3x4
[467.945615] Starting dynamic subtest: pipe-A-plane-0
[468.089914] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[468.100350] Starting dynamic subtest: pipe-A-plane-1
[468.234171] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[468.244144] Starting dynamic subtest: pipe-A-plane-2
[468.389986] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[469.613392] Starting dynamic subtest: pipe-B-plane-0
[469.769234] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[469.780652] Starting dynamic subtest: pipe-B-plane-1
[469.913412] Dynamic subtest pipe-B-plane-1: SUCCESS (0.143s)
[469.924608] Starting dynamic subtest: pipe-B-plane-2
[470.047480] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[471.316269] Starting dynamic subtest: pipe-C-plane-0
[471.438470] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[471.451866] Starting dynamic subtest: pipe-C-plane-1
[471.571314] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[471.581630] Starting dynamic subtest: pipe-C-plane-2
[471.726889] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[472.917813] Starting dynamic subtest: pipe-D-plane-0
[473.065215] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[473.076578] Starting dynamic subtest: pipe-D-plane-1
[473.209326] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[473.220377] Starting dynamic subtest: pipe-D-plane-2
[473.376245] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[473.663100] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.855s)
[474.515539] [116/132] (550s left) syncobj_wait (wait-all-for-submit-complex)
[474.568439] Starting subtest: wait-all-for-submit-complex
[474.782945] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[474.864370] [117/132] (549s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[474.929977] Starting subtest: multi-wait-for-submit-submitted-signaled
[474.932415] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[475.042874] [118/132] (549s left) kms_psr (pr-cursor-mmap-gtt)
[475.159244] Starting subtest: pr-cursor-mmap-gtt
[475.164205] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[475.230404] [119/132] (549s left) gem_wait (wait)
[475.298364] Starting subtest: wait
[475.300888] Starting dynamic subtest: all-engines
[477.102065] Dynamic subtest all-engines: SUCCESS (1.802s)
[477.115965] Starting dynamic subtest: rcs0
[478.150432] Dynamic subtest rcs0: SUCCESS (1.047s)
[478.163463] Starting dynamic subtest: bcs0
[479.199264] Dynamic subtest bcs0: SUCCESS (1.047s)
[479.212523] Starting dynamic subtest: vcs0
[480.248620] Dynamic subtest vcs0: SUCCESS (1.047s)
[480.262582] Starting dynamic subtest: vcs1
[481.298130] Dynamic subtest vcs1: SUCCESS (1.047s)
[481.311615] Starting dynamic subtest: vecs0
[482.348832] Dynamic subtest vecs0: SUCCESS (1.047s)
[482.362606] Starting dynamic subtest: ccs0
[483.399603] Dynamic subtest ccs0: SUCCESS (1.049s)
[483.402408] Subtest wait: SUCCESS (8.103s)
[483.627541] [120/132] (541s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[483.742467] Starting subtest: yf-tiled-16bpp-rotate-180
[483.747605] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[483.846571] [121/132] (541s left) kms_addfb_basic (basic-y-tiled-legacy)
[483.900432] Starting subtest: basic-y-tiled-legacy
[483.905310] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[484.040244] [122/132] (541s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[484.141324] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[491.206245] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.067s)
[491.330281] [123/132] (533s left) prime_vgem (fence-read-hang)
[491.402824] Subtest fence-read-hang: SKIP (0.000s)
[491.505976] [124/132] (533s left) kms_rotation_crc (multiplane-rotation)
[491.604242] Starting subtest: multiplane-rotation
[509.185205] Subtest multiplane-rotation: SUCCESS (17.582s)
[509.291259] [125/132] (515s left) kms_feature_discovery (psr2)
[509.387117] Starting subtest: psr2
[509.389347] Subtest psr2: SUCCESS (0.000s)
[509.458014] [126/132] (515s left) gem_mmap_wc (pf-nonblock)
[509.516504] Subtest pf-nonblock: SKIP (0.000s)
[509.580269] [127/132] (515s left) gem_exec_reloc (basic-gtt)
[509.637426] Subtest basic-gtt: SKIP (0.000s)
[509.711164] [128/132] (515s left) kms_flip (2x-nonexisting-fb)
[509.801834] Starting subtest: 2x-nonexisting-fb
[509.810022] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[509.913180] [129/132] (515s left) kms_psr (fbc-pr-suspend)
[510.020811] Starting subtest: fbc-pr-suspend
[510.024997] Subtest fbc-pr-suspend: SKIP (0.000s)
[510.091883] [130/132] (515s left) gem_ctx_shared (q-smoketest)
[510.157431] Starting subtest: Q-smoketest
[510.159821] Starting dynamic subtest: rcs0
[515.742395] Dynamic subtest rcs0: SUCCESS (5.534s)
[515.753624] Starting dynamic subtest: bcs0
[521.261625] Dynamic subtest bcs0: SUCCESS (5.503s)
[521.276908] Starting dynamic subtest: vcs0
[526.748477] Dynamic subtest vcs0: SUCCESS (5.494s)
[526.758998] Starting dynamic subtest: vcs1
[532.256508] Dynamic subtest vcs1: SUCCESS (5.502s)
[532.277430] Starting dynamic subtest: vecs0
[537.774228] Dynamic subtest vecs0: SUCCESS (5.504s)
[537.788164] Starting dynamic subtest: ccs0
[543.292634] Dynamic subtest ccs0: SUCCESS (5.514s)
[543.295644] Subtest Q-smoketest: SUCCESS (33.062s)
[543.468981] [131/132] (482s left) kms_plane (plane-position-hole)
[543.574393] Starting subtest: plane-position-hole
[544.104814] Starting dynamic subtest: pipe-A-plane-1
[545.395627] Dynamic subtest pipe-A-plane-1: SUCCESS (1.292s)
[545.408998] Starting dynamic subtest: pipe-A-plane-2
[546.656546] Dynamic subtest pipe-A-plane-2: SUCCESS (1.257s)
[546.668482] Starting dynamic subtest: pipe-A-plane-3
[547.983395] Dynamic subtest pipe-A-plane-3: SUCCESS (1.328s)
[547.994531] Starting dynamic subtest: pipe-A-plane-4
[549.245620] Dynamic subtest pipe-A-plane-4: SUCCESS (1.260s)
[549.260771] Starting dynamic subtest: pipe-A-plane-5
[549.272755] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[550.447692] Starting dynamic subtest: pipe-B-plane-1
[551.766139] Dynamic subtest pipe-B-plane-1: SUCCESS (1.324s)
[551.777602] Starting dynamic subtest: pipe-B-plane-2
[553.035370] Dynamic subtest pipe-B-plane-2: SUCCESS (1.270s)
[553.050617] Starting dynamic subtest: pipe-B-plane-3
[554.361988] Dynamic subtest pipe-B-plane-3: SUCCESS (1.323s)
[554.374105] Starting dynamic subtest: pipe-B-plane-4
[555.679480] Dynamic subtest pipe-B-plane-4: SUCCESS (1.317s)
[555.694661] Starting dynamic subtest: pipe-B-plane-5
[555.705511] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[555.708386] Subtest plane-position-hole: SUCCESS (12.127s)
[556.502052] [132/132] (469s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[556.603582] Starting subtest: sprite-rotation-90-pos-100-0
[556.608367] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[556.677927] Closing watchdogs
results: parsing output: 0/ for test: gem_media_vme
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_flush
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: gem_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: kms_hdmi_inject
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: gem_pipe_control_store_loop
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_atomic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_invalid_mode
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_busy
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_content_protection
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: i915_pm_rpm
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: i915_query
results: parsing output: 49/ for test: core_getclient
results: parsing output: 50/ for test: gem_spin_batch
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: kms_pipe_crc_basic
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_fenced_exec_thrash
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_close_race
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_mmap_offset
results: parsing output: 65/ for test: kms_feature_discovery
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_dp_link_training
results: parsing output: 78/ for test: syncobj_eventfd
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_exec_capture
results: parsing output: 84/ for test: vgem_basic
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: core_getversion
results: parsing output: 92/ for test: sriov_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: gem_tiled_fence_blits
results: parsing output: 103/ for test: prime_mmap_coherency
results: parsing output: 104/ for test: i915_hangman
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_chamelium_edid
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_lmem_swapping
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_wait
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: prime_vgem
results: parsing output: 123/ for test: kms_rotation_crc
results: parsing output: 124/ for test: kms_feature_discovery
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_ctx_shared
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: kms_rotation_crc
Done.