[59.697709] Initializing watchdogs
[59.697754]   /dev/watchdog0
[59.711412] [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.715676] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.718053] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.721440] [001/133] (960s left) syncobj_timeline (invalid-query-illegal-handle)
[59.791824] Starting subtest: invalid-query-illegal-handle
[59.793758] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[59.894180] [002/133] (960s left) gem_lmem_swapping (smem-oom)
[59.932939] Subtest smem-oom: SKIP (0.000s)
[59.978864] [003/133] (960s left) prime_mmap (test_invalid_sync_flags)
[60.038056] Starting subtest: test_invalid_sync_flags
[60.040533] Starting dynamic subtest: test_invalid_sync_flags-smem
[60.042751] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[60.044661] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[60.140638] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[60.246888] Starting subtest: psr-rgb565-draw-blt
[67.429212] Subtest psr-rgb565-draw-blt: SUCCESS (7.187s)
[67.733998] [005/133] (952s left) gem_userptr_blits (probe)
[67.864943] Starting subtest: probe
[67.948915] Subtest probe: SUCCESS (0.084s)
[68.094177] [006/133] (952s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[68.203236] Starting subtest: cursorB-vs-flipA-atomic-transitions
[68.207915] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[68.348201] [007/133] (952s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[68.560839] Starting subtest: cursor-rapid-movement-128x128
[68.565571] Starting dynamic subtest: pipe-A-eDP-1
[69.108216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[69.144084] Starting dynamic subtest: pipe-D-eDP-1
[70.299329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.160s)
[70.301778] Subtest cursor-rapid-movement-128x128: SUCCESS (1.737s)
[71.169634] [008/133] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[71.277738] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[78.334160] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.060s)
[78.435217] [009/133] (942s left) kms_color (invalid-gamma-lut-sizes)
[78.537698] Starting subtest: invalid-gamma-lut-sizes
[78.540071] Starting dynamic subtest: pipe-A
[78.829316] Dynamic subtest pipe-A: SUCCESS (0.291s)
[78.837811] Starting dynamic subtest: pipe-B
[78.840468] Dynamic subtest pipe-B: SUCCESS (0.000s)
[78.847670] Starting dynamic subtest: pipe-C
[78.850098] Dynamic subtest pipe-C: SUCCESS (0.000s)
[78.857241] Starting dynamic subtest: pipe-D
[78.859591] Dynamic subtest pipe-D: SUCCESS (0.000s)
[78.861909] Subtest invalid-gamma-lut-sizes: SUCCESS (0.293s)
[79.619643] [010/133] (940s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[79.715143] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[79.717176] Starting dynamic subtest: pipe-A-eDP-1
[79.862090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[79.872159] Starting dynamic subtest: pipe-B-eDP-1
[79.892435] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[79.907895] Starting dynamic subtest: pipe-C-eDP-1
[79.928148] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[79.937430] Starting dynamic subtest: pipe-D-eDP-1
[79.957066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[79.958987] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.172s)
[82.191941] [011/133] (938s left) perf_pmu (multi-client)
[82.231278] Starting subtest: multi-client
[82.233628] Starting dynamic subtest: rcs0
[83.301252] Dynamic subtest rcs0: SUCCESS (1.069s)
[83.309574] Starting dynamic subtest: bcs0
[84.348859] Dynamic subtest bcs0: SUCCESS (1.047s)
[84.356986] Starting dynamic subtest: vcs0
[85.397258] Dynamic subtest vcs0: SUCCESS (1.047s)
[85.426790] Starting dynamic subtest: vcs1
[86.927525] Dynamic subtest vcs1: SUCCESS (1.530s)
[86.935768] Starting dynamic subtest: vecs0
[88.910808] Dynamic subtest vecs0: SUCCESS (1.980s)
[88.919774] Starting dynamic subtest: ccs0
[90.956207] Dynamic subtest ccs0: SUCCESS (2.046s)
[90.958729] Subtest multi-client: SUCCESS (8.726s)
[91.073520] [012/133] (929s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[91.189888] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[91.192192] Starting dynamic subtest: pipe-A-eDP-1
[91.212355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[91.221720] Starting dynamic subtest: pipe-B-eDP-1
[91.240223] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.247806] Starting dynamic subtest: pipe-C-eDP-1
[91.266576] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[91.274075] Starting dynamic subtest: pipe-D-eDP-1
[91.293065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[91.295229] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[93.457118] [013/133] (927s left) gem_exec_capture (capture)
[93.529653] Starting subtest: capture
[93.532139] Starting dynamic subtest: rcs0-smem
[94.350904] Dynamic subtest rcs0-smem: SUCCESS (0.822s)
[94.358766] Starting dynamic subtest: bcs0-smem
[95.196277] Dynamic subtest bcs0-smem: SUCCESS (0.845s)
[95.205148] Starting dynamic subtest: vcs0-smem
[96.005782] Dynamic subtest vcs0-smem: SUCCESS (0.809s)
[96.014622] Starting dynamic subtest: vcs1-smem
[96.812046] Dynamic subtest vcs1-smem: SUCCESS (0.808s)
[96.822347] Starting dynamic subtest: vecs0-smem
[98.207535] Dynamic subtest vecs0-smem: FAIL (1.338s)
[98.216573] Starting dynamic subtest: ccs0-smem
[99.466623] Dynamic subtest ccs0-smem: SUCCESS (1.314s)
[99.468949] Subtest capture: FAIL (5.937s)
[99.580480] [014/133] (921s left) syncobj_timeline (single-wait-all-available-submitted)
[99.632862] Starting subtest: single-wait-all-available-submitted
[99.635212] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[99.732787] [015/133] (921s left) gem_workarounds (reset-fd)
[99.800781] Starting subtest: reset-fd
[99.945490] Subtest reset-fd: SUCCESS (0.145s)
[100.060425] [016/133] (920s left) gem_busy (extended)
[100.232587] Starting subtest: extended
[100.234857] Starting dynamic subtest: rcs0
[100.328518] Dynamic subtest rcs0: SUCCESS (0.096s)
[100.339880] Starting dynamic subtest: bcs0
[100.375220] Dynamic subtest bcs0: SUCCESS (0.046s)
[100.384938] Starting dynamic subtest: vcs0
[101.910208] Dynamic subtest vcs0: SUCCESS (1.532s)
[101.921534] Starting dynamic subtest: vcs1
[103.893032] Dynamic subtest vcs1: SUCCESS (1.982s)
[103.906050] Starting dynamic subtest: vecs0
[105.876867] Dynamic subtest vecs0: SUCCESS (1.982s)
[105.886166] Starting dynamic subtest: ccs0
[105.923659] Dynamic subtest ccs0: SUCCESS (0.047s)
[105.926494] Subtest extended: SUCCESS (5.691s)
[106.150017] [017/133] (914s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[106.205420] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[106.209848] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[106.398543] [018/133] (914s left) kms_plane_cursor (overlay)
[106.488283] Starting subtest: overlay
[106.492920] Starting dynamic subtest: pipe-A-eDP-1-size-64
[108.929584] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.441s)
[108.989730] Starting dynamic subtest: pipe-A-eDP-1-size-128
[111.464463] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.483s)
[111.523523] Starting dynamic subtest: pipe-A-eDP-1-size-256
[114.065708] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.550s)
[114.412602] Starting dynamic subtest: pipe-B-eDP-1-size-64
[117.634432] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.232s)
[117.693816] Starting dynamic subtest: pipe-B-eDP-1-size-128
[120.101465] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.416s)
[120.161784] Starting dynamic subtest: pipe-B-eDP-1-size-256
[122.591724] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.438s)
[122.957127] Starting dynamic subtest: pipe-C-eDP-1-size-64
[125.778980] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.831s)
[125.816351] Starting dynamic subtest: pipe-C-eDP-1-size-128
[127.912482] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[127.950153] Starting dynamic subtest: pipe-C-eDP-1-size-256
[130.024139] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.081s)
[130.354734] Starting dynamic subtest: pipe-D-eDP-1-size-64
[133.108404] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.768s)
[133.147258] Starting dynamic subtest: pipe-D-eDP-1-size-128
[135.229098] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.092s)
[135.266291] Starting dynamic subtest: pipe-D-eDP-1-size-256
[137.340136] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.081s)
[137.659827] Subtest overlay: SUCCESS (31.171s)
[138.478746] [019/133] (882s left) gem_ctx_exec (basic-norecovery)
[138.555749] Starting subtest: basic-norecovery
[138.908025] Subtest basic-norecovery: SUCCESS (0.350s)
[139.029967] [020/133] (881s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[139.081328] Starting subtest: x-tiled-to-vebox-yf-tiled
[139.085829] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[139.271105] [021/133] (881s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[139.370360] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[139.374753] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[139.441435] [022/133] (881s left) kms_big_fb (linear-32bpp-rotate-90)
[139.536361] Starting subtest: linear-32bpp-rotate-90
[139.556674] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[139.668223] [023/133] (881s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[139.762960] Starting subtest: yf-tiled-16bpp-rotate-270
[139.767185] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[139.854463] [024/133] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[139.984207] Starting subtest: basic-busy-flip-before-cursor-legacy
[139.988548] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[140.126452] [025/133] (881s left) kms_chamelium_color (ctm-blue-to-red)
[140.218785] Subtest ctm-blue-to-red: SKIP (0.000s)
[140.261395] [026/133] (880s left) gem_ctx_shared (q-smoketest)
[140.320797] Starting subtest: Q-smoketest
[140.322922] Starting dynamic subtest: rcs0
[145.880747] Dynamic subtest rcs0: SUCCESS (5.508s)
[145.891261] Starting dynamic subtest: bcs0
[151.393025] Dynamic subtest bcs0: SUCCESS (5.509s)
[151.403299] Starting dynamic subtest: vcs0
[156.868198] Dynamic subtest vcs0: SUCCESS (5.478s)
[156.877324] Starting dynamic subtest: vcs1
[162.355059] Dynamic subtest vcs1: SUCCESS (5.485s)
[162.364744] Starting dynamic subtest: vecs0
[167.844235] Dynamic subtest vecs0: SUCCESS (5.484s)
[167.855500] Starting dynamic subtest: ccs0
[173.355945] Dynamic subtest ccs0: SUCCESS (5.510s)
[173.358388] Subtest Q-smoketest: SUCCESS (32.982s)
[173.540168] [027/133] (847s left) gem_ctx_create (basic)
[173.607612] Starting subtest: basic
[173.610105] Subtest basic: SUCCESS (0.000s)
[173.807658] [028/133] (847s left) kms_psr (psr-suspend)
[173.904027] Starting subtest: psr-suspend
[173.906286] Starting dynamic subtest: eDP-1
[192.152494] Dynamic subtest eDP-1: SUCCESS (3.080s)
[192.155384] Subtest psr-suspend: SUCCESS (3.081s)
[193.009976] [029/133] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[193.135878] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[200.052469] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.916s)
[200.212316] [030/133] (821s left) kms_atomic_interruptible (universal-setplane-primary)
[200.314423] Starting subtest: universal-setplane-primary
[200.317174] Starting dynamic subtest: pipe-A-eDP-1
[207.770381] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.451s)
[207.773331] Subtest universal-setplane-primary: SUCCESS (7.453s)
[208.597026] [031/133] (812s left) gem_exec_schedule (preempt-engines)
[208.675180] Starting subtest: preempt-engines
[208.677492] Starting dynamic subtest: rcs0
[210.952812] Dynamic subtest rcs0: SUCCESS (2.287s)
[210.965292] Starting dynamic subtest: bcs0
[213.203514] Dynamic subtest bcs0: SUCCESS (2.250s)
[213.218395] Starting dynamic subtest: vcs0
[215.545274] Dynamic subtest vcs0: SUCCESS (2.339s)
[215.560099] Starting dynamic subtest: vcs1
[217.879011] Dynamic subtest vcs1: SUCCESS (2.331s)
[217.894807] Starting dynamic subtest: vecs0
[220.196976] Dynamic subtest vecs0: SUCCESS (2.316s)
[220.207574] Starting dynamic subtest: ccs0
[222.588562] Dynamic subtest ccs0: SUCCESS (2.388s)
[222.591418] Subtest preempt-engines: SUCCESS (13.923s)
[222.893462] [032/133] (798s left) perf_pmu (rc6)
[222.931536] Starting subtest: rc6
[222.934111] Starting dynamic subtest: gt0
[229.291052] Dynamic subtest gt0: SUCCESS (6.361s)
[229.301861] Starting dynamic subtest: runtime-pm-gt0
[237.004781] Dynamic subtest runtime-pm-gt0: SUCCESS (7.713s)
[237.016718] Starting dynamic subtest: runtime-pm-long-gt0
[249.452415] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.446s)
[249.464281] Starting dynamic subtest: other-idle-gt0
[255.796576] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[255.809582] Starting dynamic subtest: gt1
[262.138797] Dynamic subtest gt1: SUCCESS (6.340s)
[262.151295] Starting dynamic subtest: runtime-pm-gt1
[269.573570] Dynamic subtest runtime-pm-gt1: SUCCESS (7.432s)
[269.585707] Starting dynamic subtest: runtime-pm-long-gt1
[282.070600] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.493s)
[282.082671] Starting dynamic subtest: other-idle-gt1
[288.413463] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[288.416880] Subtest rc6: SUCCESS (65.485s)
[289.684872] [033/133] (731s left) kms_joiner (invalid-modeset-force-big-joiner)
[289.778639] Starting subtest: invalid-modeset-force-big-joiner
[289.783053] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[289.820612] [034/133] (731s left) perf (global-sseu-config)
[289.912413] Starting subtest: global-sseu-config
[289.915849] Subtest global-sseu-config: SKIP (0.000s)
[289.960846] [035/133] (731s left) gem_mmap_gtt (basic-small-copy-xy)
[290.015350] Subtest basic-small-copy-XY: SKIP (0.000s)
[290.079249] [036/133] (731s left) gem_exec_reloc (basic-write-read)
[290.129271] Subtest basic-write-read: SKIP (0.000s)
[290.196281] [037/133] (731s left) kms_flip (flip-vs-rmfb-interruptible)
[290.287012] Starting subtest: flip-vs-rmfb-interruptible
[290.288699] Starting dynamic subtest: A-eDP1
[298.937988] Dynamic subtest A-eDP1: SUCCESS (8.648s)
[298.947997] Starting dynamic subtest: B-eDP1
[307.570545] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[307.582292] Starting dynamic subtest: C-eDP1
[316.178539] Dynamic subtest C-eDP1: SUCCESS (8.605s)
[316.188339] Starting dynamic subtest: D-eDP1
[324.844981] Dynamic subtest D-eDP1: SUCCESS (8.664s)
[324.850844] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.561s)
[325.971042] [038/133] (695s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[326.024443] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[326.107417] [039/133] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[326.200422] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[326.205219] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[326.268888] [040/133] (695s left) gem_eio (in-flight-internal-1us)
[326.480350] Starting subtest: in-flight-internal-1us
[328.156704] Subtest in-flight-internal-1us: SUCCESS (1.677s)
[328.264845] [041/133] (693s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[328.365448] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[328.368342] Starting dynamic subtest: pipe-A-eDP-1
[328.395003] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[328.404507] Starting dynamic subtest: pipe-B-eDP-1
[328.431609] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.440540] Starting dynamic subtest: pipe-C-eDP-1
[328.466307] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.475329] Starting dynamic subtest: pipe-D-eDP-1
[328.501444] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.506213] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[330.630234] [042/133] (691s left) gem_create (create-ext-cpu-access-sanity-check)
[330.805168] Starting subtest: create-ext-cpu-access-sanity-check
[330.811478] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[330.860262] [043/133] (691s left) gem_ctx_create (basic-files)
[330.921678] Starting subtest: basic-files
[332.931280] Subtest basic-files: SUCCESS (2.009s)
[334.126010] [044/133] (687s left) kms_sequence (queue-idle)
[334.216902] Starting subtest: queue-idle
[334.219339] Starting dynamic subtest: pipe-A-eDP-1
[336.013568] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.793s)
[336.024394] Starting dynamic subtest: pipe-B-eDP-1
[338.523999] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.509s)
[338.534556] Starting dynamic subtest: pipe-C-eDP-1
[340.952142] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.429s)
[340.962468] Starting dynamic subtest: pipe-D-eDP-1
[343.390476] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[343.393462] Subtest queue-idle: SUCCESS (9.173s)
[344.170785] [045/133] (677s left) prime_mmap (test_map_unmap)
[344.225298] Starting subtest: test_map_unmap
[344.227931] Starting dynamic subtest: test_map_unmap-smem
[344.253170] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[344.256146] Subtest test_map_unmap: SUCCESS (0.031s)
[344.333598] [046/133] (677s left) core_setmaster_vs_auth
[344.463900] [047/133] (677s left) dumb_buffer (create-clear)
[344.525119] Starting subtest: create-clear
[378.846560] Subtest create-clear: SUCCESS (34.318s)
[378.919848] [048/133] (643s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[379.018155] Starting subtest: fbc-rgb101010-draw-blt
[383.583135] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.568s)
[384.676582] [049/133] (637s left) gem_exec_whisper (basic-sync-all)
[384.732388] Starting subtest: basic-sync-all
[392.907052] Subtest basic-sync-all: SUCCESS (8.171s)
[393.068035] [050/133] (629s left) syncobj_timeline (wait-for-submit-snapshot)
[393.122711] Starting subtest: wait-for-submit-snapshot
[393.206344] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[393.274203] [051/133] (628s left) kms_psr (fbc-psr-primary-page-flip)
[393.364354] Starting subtest: fbc-psr-primary-page-flip
[393.367181] Starting dynamic subtest: eDP-1
[393.372384] Dynamic subtest eDP-1: SKIP (0.000s)
[393.377535] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[393.416487] [052/133] (628s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[393.979817] Starting subtest: syncobj-timeline-multiple-ext-nodes
[393.982457] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[395.159303] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[395.163304] [053/133] (627s left) gem_render_copy (y-tiled-ccs-to-linear)
[395.232577] Starting subtest: y-tiled-ccs-to-linear
[395.238393] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[395.392477] [054/133] (626s left) gem_exec_reloc (basic-wc-active)
[395.458402] Subtest basic-wc-active: SKIP (0.000s)
[395.520033] [055/133] (626s left) kms_plane (plane-position-hole)
[395.602922] Starting subtest: plane-position-hole
[396.110959] Starting dynamic subtest: pipe-A-plane-1
[397.364818] Dynamic subtest pipe-A-plane-1: SUCCESS (1.256s)
[397.375912] Starting dynamic subtest: pipe-A-plane-2
[398.603471] Dynamic subtest pipe-A-plane-2: SUCCESS (1.235s)
[398.613565] Starting dynamic subtest: pipe-A-plane-3
[399.866578] Dynamic subtest pipe-A-plane-3: SUCCESS (1.263s)
[399.877885] Starting dynamic subtest: pipe-A-plane-4
[401.183571] Dynamic subtest pipe-A-plane-4: SUCCESS (1.316s)
[401.193360] Starting dynamic subtest: pipe-A-plane-5
[401.210334] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[402.437824] Starting dynamic subtest: pipe-B-plane-1
[403.729326] Dynamic subtest pipe-B-plane-1: SUCCESS (1.298s)
[403.739394] Starting dynamic subtest: pipe-B-plane-2
[404.997844] Dynamic subtest pipe-B-plane-2: SUCCESS (1.265s)
[405.009054] Starting dynamic subtest: pipe-B-plane-3
[406.339580] Dynamic subtest pipe-B-plane-3: SUCCESS (1.343s)
[406.349782] Starting dynamic subtest: pipe-B-plane-4
[407.638540] Dynamic subtest pipe-B-plane-4: SUCCESS (1.299s)
[407.649558] Starting dynamic subtest: pipe-B-plane-5
[407.666262] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[407.668834] Subtest plane-position-hole: SUCCESS (12.063s)
[408.423753] [056/133] (614s left) gem_mmap_wc (write)
[408.483091] Subtest write: SKIP (0.000s)
[408.555387] [057/133] (613s left) gem_ctx_persistence (heartbeat-many)
[408.613324] Starting subtest: heartbeat-many
[408.618430] Subtest heartbeat-many: SKIP (0.000s)
[408.691890] [058/133] (613s left) gem_exec_schedule (reorder-wide)
[408.872193] Subtest reorder-wide: SKIP (0.000s)
[409.030053] [059/133] (613s left) i915_query (query-topology-coherent-slice-mask)
[409.090534] Starting subtest: query-topology-coherent-slice-mask
[409.095539] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[409.163848] [060/133] (613s left) kms_lease (lease-get)
[409.253077] Starting subtest: lease-get
[409.255319] Starting dynamic subtest: pipe-A-eDP-1
[409.257803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[409.268584] Starting dynamic subtest: pipe-B-eDP-1
[409.270867] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[409.280125] Starting dynamic subtest: pipe-C-eDP-1
[409.282358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[409.291575] Starting dynamic subtest: pipe-D-eDP-1
[409.293837] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[409.296414] Subtest lease-get: SUCCESS (0.009s)
[409.337537] [061/133] (613s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[409.389378] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[409.457804] [062/133] (613s left) syncobj_eventfd (binary-wait-signaled)
[409.515573] Starting subtest: binary-wait-signaled
[409.518377] Subtest binary-wait-signaled: SUCCESS (0.000s)
[409.587971] [063/133] (613s left) kms_vblank (query-forked-busy-hang)
[409.674293] Starting subtest: query-forked-busy-hang
[409.676721] Starting dynamic subtest: pipe-A-eDP-1
[435.854312] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.176s)
[435.870437] Starting dynamic subtest: pipe-D-eDP-1
[460.902435] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.046s)
[460.905689] Subtest query-forked-busy-hang: SUCCESS (51.229s)
[461.692821] [064/133] (561s left) i915_pm_rps (min-max-config-loaded)
[461.767341] Starting subtest: min-max-config-loaded
[461.772073] Subtest min-max-config-loaded: SKIP (0.001s)
[461.845211] [065/133] (560s left) gem_readwrite (read-bad-handle)
[461.907279] Subtest read-bad-handle: SKIP (0.000s)
[461.971060] [066/133] (560s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[462.096522] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[462.102096] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[462.219437] [067/133] (560s left) kms_addfb_basic (basic)
[462.274571] Starting subtest: basic
[462.277303] Subtest basic: SUCCESS (0.000s)
[462.381995] [068/133] (560s left) kms_cursor_crc (cursor-onscreen-64x21)
[462.596318] Starting subtest: cursor-onscreen-64x21
[462.638099] Subtest cursor-onscreen-64x21: SKIP (0.039s)
[462.851752] [069/133] (560s left) gem_close_race (basic-process)
[462.919312] Starting subtest: basic-process
[462.973582] Subtest basic-process: SUCCESS (0.054s)
[463.135289] [070/133] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[463.227253] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[463.232309] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[463.307725] [071/133] (559s left) gem_mmap_wc (write-wc-read-gtt)
[463.364544] Subtest write-wc-read-gtt: SKIP (0.000s)
[463.429661] [072/133] (559s left) kms_pm_rpm (modeset-pc8-residency-stress)
[465.210715] Starting subtest: modeset-pc8-residency-stress
[465.216453] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[465.721874] [073/133] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[465.825561] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[465.830230] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[465.908126] [074/133] (557s left) i915_query (engine-info-invalid)
[465.966423] Starting subtest: engine-info-invalid
[465.969181] Subtest engine-info-invalid: SUCCESS (0.000s)
[466.036900] [075/133] (557s left) kms_content_protection (srm)
[466.171130] Starting subtest: srm
[466.176534] Subtest srm: SKIP (0.003s)
[466.261114] [076/133] (557s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[466.348475] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[466.374417] Starting dynamic subtest: pipe-A-plane-0
[466.695898] Dynamic subtest pipe-A-plane-0: SUCCESS (0.322s)
[466.705070] Starting dynamic subtest: pipe-A-plane-3
[466.929024] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[466.941025] Starting dynamic subtest: pipe-A-plane-5
[466.945733] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[468.022524] Starting dynamic subtest: pipe-B-plane-0
[468.338911] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[468.348945] Starting dynamic subtest: pipe-B-plane-3
[468.571136] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[468.580894] Starting dynamic subtest: pipe-B-plane-5
[468.585016] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[468.893903] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.545s)
[469.692147] [077/133] (553s left) kms_panel_fitting (legacy)
[469.773418] Starting subtest: legacy
[469.776095] Starting dynamic subtest: pipe-A-eDP-1
[470.337168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[470.366368] Starting dynamic subtest: pipe-B-eDP-1
[471.896260] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.539s)
[471.924333] Starting dynamic subtest: pipe-C-eDP-1
[473.493866] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.576s)
[473.518484] Starting dynamic subtest: pipe-D-eDP-1
[475.002259] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.490s)
[475.005002] Subtest legacy: SUCCESS (5.231s)
[476.208657] [078/133] (547s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[476.297700] Starting subtest: pr-primary-plane-update-sf-dmg-area
[476.303228] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[476.343958] [079/133] (547s left) kms_pm_backlight (bad-brightness)
[476.431981] Starting subtest: bad-brightness
[476.480746] Starting dynamic subtest: eDP-1
[476.799023] Dynamic subtest eDP-1: SUCCESS (0.317s)
[476.801489] Subtest bad-brightness: SUCCESS (0.369s)
[477.637929] [080/133] (545s left) kms_cursor_legacy (forked-bo)
[477.765223] Starting subtest: forked-bo
[477.767697] Starting dynamic subtest: pipe-A
[483.238805] Dynamic subtest pipe-A: SUCCESS (5.472s)
[483.256382] Starting dynamic subtest: pipe-B
[488.704001] Dynamic subtest pipe-B: SUCCESS (5.462s)
[488.717271] Starting dynamic subtest: pipe-C
[494.184561] Dynamic subtest pipe-C: SUCCESS (5.479s)
[494.198104] Starting dynamic subtest: pipe-D
[499.659565] Dynamic subtest pipe-D: SUCCESS (5.473s)
[499.671160] Starting dynamic subtest: all-pipes
[505.137560] Dynamic subtest all-pipes: SUCCESS (5.475s)
[505.140560] Subtest forked-bo: SUCCESS (27.371s)
[505.261139] [081/133] (518s left) kms_flip (dpms-vs-vblank-race)
[505.365244] Starting subtest: dpms-vs-vblank-race
[505.367487] Starting dynamic subtest: A-eDP1
[510.360547] Dynamic subtest A-eDP1: SUCCESS (4.992s)
[510.373456] Starting dynamic subtest: B-eDP1
[514.994553] Dynamic subtest B-eDP1: SUCCESS (4.637s)
[515.004334] Starting dynamic subtest: C-eDP1
[519.622470] Dynamic subtest C-eDP1: SUCCESS (4.624s)
[519.632617] Starting dynamic subtest: D-eDP1
[524.259856] Dynamic subtest D-eDP1: SUCCESS (4.635s)
[524.262468] Subtest dpms-vs-vblank-race: SUCCESS (18.898s)
[525.127274] [082/133] (498s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[525.251210] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[525.256172] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[525.321083] [083/133] (498s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[525.415229] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[525.420333] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[525.492815] [084/133] (498s left) gem_exec_balancer (bonded-false-hang)
[525.746779] Starting subtest: bonded-false-hang
[525.752291] Subtest bonded-false-hang: SKIP (0.000s)
[525.834673] [085/133] (497s left) api_intel_allocator (default-alignment)
[525.898911] Starting subtest: default-alignment
[525.901428] Subtest default-alignment: SUCCESS (0.004s)
[525.987030] [086/133] (497s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[526.076354] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[526.081535] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[526.138470] [087/133] (497s left) gem_exec_params (larger-than-life-batch)
[526.199702] Starting subtest: larger-than-life-batch
[528.451463] Subtest larger-than-life-batch: SUCCESS (2.255s)
[529.082144] [088/133] (494s left) gem_userptr_blits (readonly-unsync)
[529.199066] Subtest readonly-unsync: SKIP (0.000s)
[529.288854] [089/133] (494s left) kms_psr (pr-cursor-plane-onoff)
[529.392555] Starting subtest: pr-cursor-plane-onoff
[529.397732] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[529.441156] [090/133] (494s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[529.557220] Starting subtest: short-flip-after-cursor-atomic-transitions
[530.571495] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.012s)
[531.359155] [091/133] (492s left) i915_fb_tiling (basic-x-tiling)
[531.415372] Subtest basic-x-tiling: SKIP (0.000s)
[531.476958] [092/133] (492s left) kms_chamelium_frames (dp-crc-multiple)
[531.862270] Subtest dp-crc-multiple: SKIP (0.000s)
[532.685785] [093/133] (491s left) gem_mmap_gtt (isolation)
[532.741312] Subtest isolation: SKIP (0.000s)
[532.804964] [094/133] (491s left) gen9_exec_parse (allowed-all)
[532.875411] Subtest allowed-all: SKIP (0.000s)
[532.954786] [095/133] (491s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[533.020341] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[533.023018] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[533.092396] [096/133] (491s left) kms_psr (fbc-psr2-cursor-render)
[533.174726] Starting subtest: fbc-psr2-cursor-render
[533.177308] Starting dynamic subtest: eDP-1
[533.181987] Dynamic subtest eDP-1: SKIP (0.000s)
[533.186308] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[533.224735] [097/133] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[533.325760] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[533.330554] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[533.385440] [098/133] (490s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[533.494050] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[534.151247] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[534.292792] [099/133] (489s left) kms_psr2_su (page_flip-p010)
[534.355308] Subtest page_flip-P010: SKIP (0.000s)
[534.422147] [100/133] (489s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[534.514959] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[538.645617] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.134s)
[539.803047] [101/133] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[539.898429] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[539.904215] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[539.966174] [102/133] (484s left) sw_sync (sync_expired_merge)
[540.003442] Starting subtest: sync_expired_merge
[541.075037] Subtest sync_expired_merge: SUCCESS (1.074s)
[541.116355] [103/133] (483s left) gem_eio (unwedge-stress)
[541.350414] Starting subtest: unwedge-stress
[541.352844] Starting dynamic subtest: render
[546.235439] Dynamic subtest render: SUCCESS (4.881s)
[546.250789] Starting dynamic subtest: bsd1
[572.536453] Dynamic subtest bsd1: SUCCESS (26.299s)
[572.553419] Starting dynamic subtest: bsd2
[594.576749] Dynamic subtest bsd2: SUCCESS (22.037s)
[594.594367] Starting dynamic subtest: blt
[594.599661] Dynamic subtest blt: SKIP (0.000s)
[594.608791] Starting dynamic subtest: vebox
[614.589426] Dynamic subtest vebox: SUCCESS (20.010s)
[614.592361] Subtest unwedge-stress: SUCCESS (73.232s)
[616.105060] [104/133] (408s left) gem_partial_pwrite_pread (write)
[616.169139] Subtest write: SKIP (0.000s)
[616.238659] [105/133] (408s left) gem_spin_batch (resubmit-new-all)
[616.291905] Starting subtest: resubmit-new-all
[616.294382] Starting dynamic subtest: rcs0
[616.305578] Dynamic subtest rcs0: SUCCESS (0.014s)
[616.317014] Starting dynamic subtest: bcs0
[616.327402] Dynamic subtest bcs0: SUCCESS (0.019s)
[616.338055] Starting dynamic subtest: vcs0
[616.346982] Dynamic subtest vcs0: SUCCESS (0.017s)
[616.357566] Starting dynamic subtest: vcs1
[616.366355] Dynamic subtest vcs1: SUCCESS (0.018s)
[616.376212] Starting dynamic subtest: vecs0
[616.387258] Dynamic subtest vecs0: SUCCESS (0.018s)
[616.398095] Starting dynamic subtest: ccs0
[616.404208] Dynamic subtest ccs0: SUCCESS (0.015s)
[616.406704] Subtest resubmit-new-all: SUCCESS (0.113s)
[618.089091] [106/133] (406s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[618.483294] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[619.314031] [107/133] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[619.411703] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[619.417146] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[619.486583] [108/133] (405s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[619.582222] Starting subtest: x-tiled-8bpp-rotate-270
[619.604523] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[619.700425] [109/133] (404s left) gen9_exec_parse (shadow-peek)
[619.752446] Subtest shadow-peek: SKIP (0.000s)
[619.816358] [110/133] (404s left) kms_flip (blocking-absolute-wf_vblank)
[619.910404] Starting subtest: blocking-absolute-wf_vblank
[619.913132] Starting dynamic subtest: A-eDP1
[628.688313] Dynamic subtest A-eDP1: SUCCESS (8.776s)
[628.705263] Starting dynamic subtest: B-eDP1
[637.417247] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[637.427155] Starting dynamic subtest: C-eDP1
[646.136042] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[646.147322] Starting dynamic subtest: D-eDP1
[654.866213] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[654.872326] Subtest blocking-absolute-wf_vblank: SUCCESS (34.960s)
[656.060126] [111/133] (368s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[656.166455] Starting subtest: psr-1p-primscrn-spr-indfb-move
[663.778543] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.617s)
[663.896036] [112/133] (360s left) api_intel_bb (intel-bb-blit-y)
[663.947001] Starting subtest: intel-bb-blit-y
[667.716219] Subtest intel-bb-blit-y: SUCCESS (3.770s)
[667.802415] [113/133] (357s left) kms_force_connector_basic (force-load-detect)
[667.881348] Starting subtest: force-load-detect
[667.887013] Subtest force-load-detect: SKIP (0.000s)
[667.976244] [114/133] (356s left) kms_psr (psr2-primary-render)
[668.079219] Starting subtest: psr2-primary-render
[668.081698] Starting dynamic subtest: eDP-1
[669.799573] Dynamic subtest eDP-1: SUCCESS (1.720s)
[669.802613] Subtest psr2-primary-render: SUCCESS (1.721s)
[670.658703] [115/133] (354s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[670.770756] Starting subtest: stress-xrgb8888-xtiled
[676.649297] Subtest stress-xrgb8888-xtiled: SUCCESS (5.878s)
[676.706556] [116/133] (348s left) kms_prop_blob (invalid-set-prop-any)
[676.765273] Starting subtest: invalid-set-prop-any
[676.767277] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[676.834428] [117/133] (348s left) sriov_basic (bind-unbind-vf)
[676.894591] Starting subtest: bind-unbind-vf
[676.897028] Starting dynamic subtest: vf-1
[676.978137] Dynamic subtest vf-1: FAIL (0.025s)
[676.988539] Starting dynamic subtest: vf-2
[677.064839] Dynamic subtest vf-2: FAIL (0.004s)
[677.075962] Starting dynamic subtest: vf-3
[677.151463] Dynamic subtest vf-3: FAIL (0.003s)
[677.161439] Starting dynamic subtest: vf-4
[677.228221] Dynamic subtest vf-4: FAIL (0.004s)
[677.237406] Starting dynamic subtest: vf-5
[677.298290] Dynamic subtest vf-5: FAIL (0.004s)
[677.307039] Starting dynamic subtest: vf-6
[677.370093] Dynamic subtest vf-6: FAIL (0.003s)
[677.378573] Starting dynamic subtest: vf-7
[677.439302] Dynamic subtest vf-7: FAIL (0.003s)
[677.448338] Starting dynamic subtest: vf-random
[677.514412] Dynamic subtest vf-random: FAIL (0.003s)
[677.526303] Starting dynamic subtest: vf-last
[677.599888] Dynamic subtest vf-last: FAIL (0.480s)
[677.602265] Subtest bind-unbind-vf: FAIL (0.536s)
[677.641790] [118/133] (347s left) kms_pm_backlight (brightness-with-dpms)
[677.735220] Starting subtest: brightness-with-dpms
[677.786438] Starting dynamic subtest: eDP-1
[680.164917] Dynamic subtest eDP-1: SUCCESS (2.377s)
[680.167526] Subtest brightness-with-dpms: SUCCESS (2.430s)
[681.010869] [119/133] (344s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[681.073486] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[681.076395] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[681.146792] [120/133] (343s left) kms_getfb (getfb2-into-addfb2)
[681.237605] Starting subtest: getfb2-into-addfb2
[681.240359] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[681.313792] [121/133] (343s left) gem_exec_whisper (basic-queues)
[681.377396] Starting subtest: basic-queues
[687.685770] Subtest basic-queues: SUCCESS (6.304s)
[687.847440] [122/133] (337s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[687.953303] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[687.958278] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[688.024780] [123/133] (337s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[688.123347] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[688.128189] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[688.191810] [124/133] (337s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[688.286571] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[695.650076] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.366s)
[695.765832] [125/133] (329s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[695.863303] Starting subtest: y-tiled-64bpp-rotate-90
[695.868078] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[695.942833] [126/133] (329s left) kms_fbcon_fbt (psr)
[696.005571] Starting subtest: psr
[703.399138] Subtest psr: SUCCESS (7.392s)
[703.483052] [127/133] (321s left) kms_cursor_crc (cursor-sliding-512x512)
[703.792155] Starting subtest: cursor-sliding-512x512
[703.797001] Subtest cursor-sliding-512x512: SKIP (0.001s)
[703.933822] [128/133] (321s left) kms_draw_crc (draw-method-render)
[704.034098] Starting subtest: draw-method-render
[704.036315] Starting dynamic subtest: xrgb8888-untiled
[704.287554] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[704.298045] Starting dynamic subtest: rgb565-untiled
[704.543048] Dynamic subtest rgb565-untiled: SUCCESS (0.254s)
[704.559595] Starting dynamic subtest: xrgb2101010-untiled
[704.786718] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.242s)
[704.798753] Starting dynamic subtest: xbgr16161616f-untiled
[705.020173] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[705.030183] Starting dynamic subtest: xrgb8888-xtiled
[705.154179] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[705.165209] Starting dynamic subtest: rgb565-xtiled
[705.265202] Dynamic subtest rgb565-xtiled: SUCCESS (0.109s)
[705.275402] Starting dynamic subtest: xrgb2101010-xtiled
[705.376115] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s)
[705.386183] Starting dynamic subtest: xbgr16161616f-xtiled
[705.509926] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[705.522949] Starting dynamic subtest: xrgb8888-4tiled
[705.631894] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[705.642129] Starting dynamic subtest: rgb565-4tiled
[705.742393] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s)
[705.752299] Starting dynamic subtest: xrgb2101010-4tiled
[705.853952] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[705.863717] Starting dynamic subtest: xbgr16161616f-4tiled
[705.976209] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[705.978379] Subtest draw-method-render: SUCCESS (1.945s)
[706.060325] [129/133] (319s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[706.147060] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[706.159133] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[706.213160] [130/133] (319s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[706.298021] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[706.300071] Starting dynamic subtest: pipe-A-default-mode
[707.492995] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[707.498106] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.192s)
[707.615131] [131/133] (317s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[707.713041] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[707.715384] Starting dynamic subtest: pipe-A-eDP-1
[707.962549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.218s)
[707.973281] Starting dynamic subtest: pipe-B-eDP-1
[709.250412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s)
[709.261946] Starting dynamic subtest: pipe-C-eDP-1
[710.438082] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s)
[710.449533] Starting dynamic subtest: pipe-D-eDP-1
[711.666120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[711.668814] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.920s)
[712.766137] [132/133] (312s left) kms_async_flips (test-cursor-atomic)
[712.856964] Starting subtest: test-cursor-atomic
[713.235323] Starting dynamic subtest: pipe-A-eDP-1
[713.990019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[714.388353] Starting dynamic subtest: pipe-B-eDP-1
[715.132326] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[715.501724] Starting dynamic subtest: pipe-C-eDP-1
[716.269292] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[716.644097] Starting dynamic subtest: pipe-D-eDP-1
[717.411475] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[717.414461] Subtest test-cursor-atomic: SUCCESS (4.556s)
[718.562100] [133/133] (307s left) kms_addfb_basic (legacy-format)
[718.624044] Starting subtest: legacy-format
[718.647010] Subtest legacy-format: SUCCESS (0.022s)
[718.753967] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_color
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_exec_capture
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: gem_workarounds
results: parsing output: 15/ for test: gem_busy
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_plane_cursor
results: parsing output: 18/ for test: gem_ctx_exec
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_chamelium_color
results: parsing output: 25/ for test: gem_ctx_shared
results: parsing output: 26/ for test: gem_ctx_create
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_atomic_interruptible
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_joiner
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: gem_ctx_create
results: parsing output: 43/ for test: kms_sequence
results: parsing output: 44/ for test: prime_mmap
results: parsing output: 45/ for test: core_setmaster_vs_auth
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: i915_query
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: syncobj_eventfd
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: i915_pm_rps
results: parsing output: 64/ for test: gem_readwrite
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_close_race
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_panel_fitting
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: i915_fb_tiling
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_psr2_su
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: kms_force_connector_basic
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_pipe_stress
results: parsing output: 115/ for test: kms_prop_blob
results: parsing output: 116/ for test: sriov_basic
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: gem_exec_whisper
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_fbcon_fbt
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_draw_crc
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_addfb_basic
Done.