[59.198146] Initializing watchdogs
[59.198241]   /dev/watchdog0
[59.212965] [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.217199] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.219393] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.222643] [001/133] (960s left) syncobj_timeline (invalid-query-illegal-handle)
[59.312976] Starting subtest: invalid-query-illegal-handle
[59.315454] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[59.420371] [002/133] (960s left) gem_lmem_swapping (smem-oom)
[59.463454] Subtest smem-oom: SKIP (0.000s)
[59.503030] [003/133] (960s left) prime_mmap (test_invalid_sync_flags)
[59.550637] Starting subtest: test_invalid_sync_flags
[59.552989] Starting dynamic subtest: test_invalid_sync_flags-smem
[59.555235] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[59.557352] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[59.648779] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[59.743324] Starting subtest: psr-rgb565-draw-blt
[66.758836] Subtest psr-rgb565-draw-blt: SUCCESS (7.019s)
[66.864411] [005/133] (953s left) gem_userptr_blits (probe)
[67.108254] Starting subtest: probe
[67.281965] Subtest probe: SUCCESS (0.175s)
[67.496474] [006/133] (952s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[67.734634] Starting subtest: cursorB-vs-flipA-atomic-transitions
[67.739571] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[67.885328] [007/133] (952s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[68.142563] Starting subtest: cursor-rapid-movement-128x128
[68.147497] Starting dynamic subtest: pipe-A-eDP-1
[68.699988] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[68.730757] Starting dynamic subtest: pipe-D-eDP-1
[69.913926] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.188s)
[69.916254] Subtest cursor-rapid-movement-128x128: SUCCESS (1.771s)
[70.775566] [008/133] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[70.888028] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[77.934797] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.051s)
[78.033879] [009/133] (942s left) kms_color (invalid-gamma-lut-sizes)
[78.131881] Starting subtest: invalid-gamma-lut-sizes
[78.134406] Starting dynamic subtest: pipe-A
[78.418864] Dynamic subtest pipe-A: SUCCESS (0.289s)
[78.427628] Starting dynamic subtest: pipe-B
[78.429770] Dynamic subtest pipe-B: SUCCESS (0.000s)
[78.437049] Starting dynamic subtest: pipe-C
[78.439256] Dynamic subtest pipe-C: SUCCESS (0.000s)
[78.446602] Starting dynamic subtest: pipe-D
[78.448856] Dynamic subtest pipe-D: SUCCESS (0.000s)
[78.451186] Subtest invalid-gamma-lut-sizes: SUCCESS (0.291s)
[79.219804] [010/133] (940s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[79.316995] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[79.319153] Starting dynamic subtest: pipe-A-eDP-1
[79.467848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[79.477744] Starting dynamic subtest: pipe-B-eDP-1
[79.497889] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[79.505735] Starting dynamic subtest: pipe-C-eDP-1
[79.524593] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[79.531846] Starting dynamic subtest: pipe-D-eDP-1
[79.550542] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[79.552427] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s)
[81.771554] [011/133] (938s left) perf_pmu (multi-client)
[81.822809] Starting subtest: multi-client
[81.825173] Starting dynamic subtest: rcs0
[82.883712] Dynamic subtest rcs0: SUCCESS (1.059s)
[82.894334] Starting dynamic subtest: bcs0
[83.930798] Dynamic subtest bcs0: SUCCESS (1.048s)
[83.940550] Starting dynamic subtest: vcs0
[84.983438] Dynamic subtest vcs0: SUCCESS (1.048s)
[84.993951] Starting dynamic subtest: vcs1
[86.925786] Dynamic subtest vcs1: SUCCESS (1.943s)
[86.937929] Starting dynamic subtest: vecs0
[88.911767] Dynamic subtest vecs0: SUCCESS (1.985s)
[88.923805] Starting dynamic subtest: ccs0
[90.892975] Dynamic subtest ccs0: SUCCESS (1.980s)
[90.895951] Subtest multi-client: SUCCESS (9.070s)
[91.012659] [012/133] (929s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[91.110921] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[91.113265] Starting dynamic subtest: pipe-A-eDP-1
[91.134639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[91.144889] Starting dynamic subtest: pipe-B-eDP-1
[91.164104] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.171321] Starting dynamic subtest: pipe-C-eDP-1
[91.190391] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[91.198833] Starting dynamic subtest: pipe-D-eDP-1
[91.217482] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[91.219385] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[93.267077] [013/133] (926s left) gem_exec_capture (capture)
[93.320989] Starting subtest: capture
[93.323650] Starting dynamic subtest: rcs0-smem
[94.134281] Dynamic subtest rcs0-smem: SUCCESS (0.812s)
[94.143995] Starting dynamic subtest: bcs0-smem
[94.938052] Dynamic subtest bcs0-smem: SUCCESS (0.804s)
[94.948527] Starting dynamic subtest: vcs0-smem
[95.752418] Dynamic subtest vcs0-smem: SUCCESS (0.811s)
[95.765786] Starting dynamic subtest: vcs1-smem
[96.559745] Dynamic subtest vcs1-smem: SUCCESS (0.809s)
[96.570514] Starting dynamic subtest: vecs0-smem
[97.951949] Dynamic subtest vecs0-smem: FAIL (1.330s)
[97.961793] Starting dynamic subtest: ccs0-smem
[99.211390] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[99.213771] Subtest capture: FAIL (5.888s)
[99.356915] [014/133] (920s left) syncobj_timeline (single-wait-all-available-submitted)
[99.411937] Starting subtest: single-wait-all-available-submitted
[99.414249] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[99.517531] [015/133] (920s left) gem_workarounds (reset-fd)
[99.601059] Starting subtest: reset-fd
[99.744701] Subtest reset-fd: SUCCESS (0.146s)
[99.882049] [016/133] (920s left) gem_busy (extended)
[100.080086] Starting subtest: extended
[100.082574] Starting dynamic subtest: rcs0
[100.168980] Dynamic subtest rcs0: SUCCESS (0.090s)
[100.180529] Starting dynamic subtest: bcs0
[100.213612] Dynamic subtest bcs0: SUCCESS (0.043s)
[100.225073] Starting dynamic subtest: vcs0
[101.910550] Dynamic subtest vcs0: SUCCESS (1.694s)
[101.921942] Starting dynamic subtest: vcs1
[103.948387] Dynamic subtest vcs1: SUCCESS (1.982s)
[103.961811] Starting dynamic subtest: vecs0
[105.878515] Dynamic subtest vecs0: SUCCESS (1.983s)
[105.889347] Starting dynamic subtest: ccs0
[105.926600] Dynamic subtest ccs0: SUCCESS (0.048s)
[105.929274] Subtest extended: SUCCESS (5.848s)
[106.164242] [017/133] (914s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[106.227631] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[106.232121] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[106.410809] [018/133] (913s left) kms_plane_cursor (overlay)
[106.500704] Starting subtest: overlay
[106.504914] Starting dynamic subtest: pipe-A-eDP-1-size-64
[109.007736] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.508s)
[109.067997] Starting dynamic subtest: pipe-A-eDP-1-size-128
[111.453554] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.394s)
[111.513664] Starting dynamic subtest: pipe-A-eDP-1-size-256
[113.989255] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.483s)
[114.342758] Starting dynamic subtest: pipe-B-eDP-1-size-64
[117.565742] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.238s)
[117.624954] Starting dynamic subtest: pipe-B-eDP-1-size-128
[120.055571] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.438s)
[120.114922] Starting dynamic subtest: pipe-B-eDP-1-size-256
[122.523279] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.416s)
[122.877150] Starting dynamic subtest: pipe-C-eDP-1-size-64
[125.706441] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.846s)
[125.746762] Starting dynamic subtest: pipe-C-eDP-1-size-128
[127.826448] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[127.863317] Starting dynamic subtest: pipe-C-eDP-1-size-256
[129.905402] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.047s)
[130.232668] Starting dynamic subtest: pipe-D-eDP-1-size-64
[133.085630] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.861s)
[133.121579] Starting dynamic subtest: pipe-D-eDP-1-size-128
[135.217356] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.103s)
[135.254873] Starting dynamic subtest: pipe-D-eDP-1-size-256
[137.335607] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s)
[137.655874] Subtest overlay: SUCCESS (31.154s)
[138.496552] [019/133] (881s left) gem_ctx_exec (basic-norecovery)
[138.553730] Starting subtest: basic-norecovery
[138.895837] Subtest basic-norecovery: SUCCESS (0.341s)
[139.019650] [020/133] (881s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[139.073767] Starting subtest: x-tiled-to-vebox-yf-tiled
[139.078259] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[139.266526] [021/133] (881s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[139.355245] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[139.359222] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[139.438717] [022/133] (881s left) kms_big_fb (linear-32bpp-rotate-90)
[139.537838] Starting subtest: linear-32bpp-rotate-90
[139.558056] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[139.662695] [023/133] (880s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[139.756099] Starting subtest: yf-tiled-16bpp-rotate-270
[139.760393] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[139.848237] [024/133] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[139.965304] Starting subtest: basic-busy-flip-before-cursor-legacy
[139.969927] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[140.105879] [025/133] (880s left) kms_chamelium_color (ctm-blue-to-red)
[140.199436] Subtest ctm-blue-to-red: SKIP (0.000s)
[140.243414] [026/133] (880s left) gem_ctx_shared (q-smoketest)
[140.300986] Starting subtest: Q-smoketest
[140.302908] Starting dynamic subtest: rcs0
[145.915854] Dynamic subtest rcs0: SUCCESS (5.509s)
[145.926637] Starting dynamic subtest: bcs0
[151.421006] Dynamic subtest bcs0: SUCCESS (5.505s)
[151.432148] Starting dynamic subtest: vcs0
[156.886775] Dynamic subtest vcs0: SUCCESS (5.464s)
[156.897270] Starting dynamic subtest: vcs1
[162.381383] Dynamic subtest vcs1: SUCCESS (5.489s)
[162.392260] Starting dynamic subtest: vecs0
[167.875690] Dynamic subtest vecs0: SUCCESS (5.497s)
[167.886588] Starting dynamic subtest: ccs0
[173.310397] Dynamic subtest ccs0: SUCCESS (5.486s)
[173.312902] Subtest Q-smoketest: SUCCESS (32.958s)
[173.522343] [027/133] (847s left) gem_ctx_create (basic)
[173.597514] Starting subtest: basic
[173.599926] Subtest basic: SUCCESS (0.000s)
[173.796807] [028/133] (846s left) kms_psr (psr-suspend)
[173.898909] Starting subtest: psr-suspend
[173.901218] Starting dynamic subtest: eDP-1
[192.290086] Dynamic subtest eDP-1: SUCCESS (3.204s)
[192.292409] Subtest psr-suspend: SUCCESS (3.205s)
[193.183344] [029/133] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[193.301596] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[200.211013] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.906s)
[200.356431] [030/133] (820s left) kms_atomic_interruptible (universal-setplane-primary)
[200.462468] Starting subtest: universal-setplane-primary
[200.464552] Starting dynamic subtest: pipe-A-eDP-1
[207.927703] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.461s)
[207.929607] Subtest universal-setplane-primary: SUCCESS (7.462s)
[208.769298] [031/133] (812s left) gem_exec_schedule (preempt-engines)
[208.841105] Starting subtest: preempt-engines
[208.843069] Starting dynamic subtest: rcs0
[211.140011] Dynamic subtest rcs0: SUCCESS (2.250s)
[211.152932] Starting dynamic subtest: bcs0
[213.364611] Dynamic subtest bcs0: SUCCESS (2.223s)
[213.375780] Starting dynamic subtest: vcs0
[215.843684] Dynamic subtest vcs0: SUCCESS (2.476s)
[215.856340] Starting dynamic subtest: vcs1
[218.125873] Dynamic subtest vcs1: SUCCESS (2.280s)
[218.138339] Starting dynamic subtest: vecs0
[220.384933] Dynamic subtest vecs0: SUCCESS (2.256s)
[220.397535] Starting dynamic subtest: ccs0
[222.814732] Dynamic subtest ccs0: SUCCESS (2.428s)
[222.817513] Subtest preempt-engines: SUCCESS (13.927s)
[223.068338] [032/133] (797s left) perf_pmu (rc6)
[223.120004] Starting subtest: rc6
[223.121927] Starting dynamic subtest: gt0
[229.542765] Dynamic subtest gt0: SUCCESS (6.372s)
[229.555390] Starting dynamic subtest: runtime-pm-gt0
[237.267233] Dynamic subtest runtime-pm-gt0: SUCCESS (7.779s)
[237.279360] Starting dynamic subtest: runtime-pm-long-gt0
[249.764515] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.498s)
[249.776546] Starting dynamic subtest: other-idle-gt0
[256.160715] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[256.173619] Starting dynamic subtest: gt1
[262.451915] Dynamic subtest gt1: SUCCESS (6.341s)
[262.464347] Starting dynamic subtest: runtime-pm-gt1
[269.930557] Dynamic subtest runtime-pm-gt1: SUCCESS (7.477s)
[269.942658] Starting dynamic subtest: runtime-pm-long-gt1
[282.382005] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.448s)
[282.394353] Starting dynamic subtest: other-idle-gt1
[288.782638] Dynamic subtest other-idle-gt1: SUCCESS (6.346s)
[288.785377] Subtest rc6: SUCCESS (65.621s)
[289.860169] [033/133] (731s left) kms_joiner (invalid-modeset-force-big-joiner)
[289.959282] Starting subtest: invalid-modeset-force-big-joiner
[289.963357] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[289.998502] [034/133] (731s left) perf (global-sseu-config)
[290.085344] Starting subtest: global-sseu-config
[290.088863] Subtest global-sseu-config: SKIP (0.000s)
[290.127418] [035/133] (730s left) gem_mmap_gtt (basic-small-copy-xy)
[290.188791] Subtest basic-small-copy-XY: SKIP (0.000s)
[290.256884] [036/133] (730s left) gem_exec_reloc (basic-write-read)
[290.318107] Subtest basic-write-read: SKIP (0.000s)
[290.389916] [037/133] (730s left) kms_flip (flip-vs-rmfb-interruptible)
[290.480720] Starting subtest: flip-vs-rmfb-interruptible
[290.482379] Starting dynamic subtest: A-eDP1
[299.165585] Dynamic subtest A-eDP1: SUCCESS (8.683s)
[299.184698] Starting dynamic subtest: B-eDP1
[307.789484] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[307.800625] Starting dynamic subtest: C-eDP1
[316.406659] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[316.419526] Starting dynamic subtest: D-eDP1
[325.035304] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[325.039475] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.557s)
[326.202977] [038/133] (694s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[326.270033] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[326.369264] [039/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[326.467610] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[326.471537] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[326.544419] [040/133] (694s left) gem_eio (in-flight-internal-1us)
[326.755524] Starting subtest: in-flight-internal-1us
[328.168403] Subtest in-flight-internal-1us: SUCCESS (1.412s)
[328.283766] [041/133] (693s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[328.386401] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[328.388574] Starting dynamic subtest: pipe-A-eDP-1
[328.411555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.423624] Starting dynamic subtest: pipe-B-eDP-1
[328.444644] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.453385] Starting dynamic subtest: pipe-C-eDP-1
[328.474952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.485823] Starting dynamic subtest: pipe-D-eDP-1
[328.507742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.511799] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[330.608448] [042/133] (690s left) gem_create (create-ext-cpu-access-sanity-check)
[330.784393] Starting subtest: create-ext-cpu-access-sanity-check
[330.788639] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[330.828596] [043/133] (690s left) gem_ctx_create (basic-files)
[330.881929] Starting subtest: basic-files
[332.889988] Subtest basic-files: SUCCESS (2.008s)
[334.207241] [044/133] (687s left) kms_sequence (queue-idle)
[334.307287] Starting subtest: queue-idle
[334.309479] Starting dynamic subtest: pipe-A-eDP-1
[336.122929] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[336.133067] Starting dynamic subtest: pipe-B-eDP-1
[338.576495] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s)
[338.588161] Starting dynamic subtest: pipe-C-eDP-1
[341.023240] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.444s)
[341.033028] Starting dynamic subtest: pipe-D-eDP-1
[343.436685] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.414s)
[343.439134] Subtest queue-idle: SUCCESS (9.130s)
[344.234639] [045/133] (677s left) prime_mmap (test_map_unmap)
[344.285679] Starting subtest: test_map_unmap
[344.288086] Starting dynamic subtest: test_map_unmap-smem
[344.326347] Dynamic subtest test_map_unmap-smem: SUCCESS (0.041s)
[344.328777] Subtest test_map_unmap: SUCCESS (0.042s)
[344.389061] [046/133] (677s left) core_setmaster_vs_auth
[344.540648] [047/133] (676s left) dumb_buffer (create-clear)
[344.595830] Starting subtest: create-clear
[378.890275] Subtest create-clear: SUCCESS (34.240s)
[378.936489] [048/133] (642s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[379.042966] Starting subtest: fbc-rgb101010-draw-blt
[383.651519] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.610s)
[384.743629] [049/133] (636s left) gem_exec_whisper (basic-sync-all)
[384.813041] Starting subtest: basic-sync-all
[392.062710] Subtest basic-sync-all: SUCCESS (7.247s)
[392.243307] [050/133] (629s left) syncobj_timeline (wait-for-submit-snapshot)
[392.294036] Starting subtest: wait-for-submit-snapshot
[392.375074] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[392.429971] [051/133] (629s left) kms_psr (fbc-psr-primary-page-flip)
[392.521548] Starting subtest: fbc-psr-primary-page-flip
[392.523782] Starting dynamic subtest: eDP-1
[392.527854] Dynamic subtest eDP-1: SKIP (0.000s)
[392.531953] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[392.570508] [052/133] (629s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[393.141693] Starting subtest: syncobj-timeline-multiple-ext-nodes
[393.144668] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[394.140281] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[394.144488] [053/133] (627s left) gem_render_copy (y-tiled-ccs-to-linear)
[394.208823] Starting subtest: y-tiled-ccs-to-linear
[394.213659] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[394.375248] [054/133] (627s left) gem_exec_reloc (basic-wc-active)
[394.439953] Subtest basic-wc-active: SKIP (0.000s)
[394.519753] [055/133] (627s left) kms_plane (plane-position-hole)
[394.610438] Starting subtest: plane-position-hole
[395.135484] Starting dynamic subtest: pipe-A-plane-1
[396.468138] Dynamic subtest pipe-A-plane-1: SUCCESS (1.332s)
[396.477802] Starting dynamic subtest: pipe-A-plane-2
[397.728025] Dynamic subtest pipe-A-plane-2: SUCCESS (1.259s)
[397.737467] Starting dynamic subtest: pipe-A-plane-3
[398.965832] Dynamic subtest pipe-A-plane-3: SUCCESS (1.237s)
[398.976363] Starting dynamic subtest: pipe-A-plane-4
[400.215341] Dynamic subtest pipe-A-plane-4: SUCCESS (1.247s)
[400.226079] Starting dynamic subtest: pipe-A-plane-5
[400.241171] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[401.353366] Starting dynamic subtest: pipe-B-plane-1
[402.597079] Dynamic subtest pipe-B-plane-1: SUCCESS (1.252s)
[402.618119] Starting dynamic subtest: pipe-B-plane-2
[403.885296] Dynamic subtest pipe-B-plane-2: SUCCESS (1.287s)
[403.896286] Starting dynamic subtest: pipe-B-plane-3
[405.123885] Dynamic subtest pipe-B-plane-3: SUCCESS (1.238s)
[405.135100] Starting dynamic subtest: pipe-B-plane-4
[406.399268] Dynamic subtest pipe-B-plane-4: SUCCESS (1.274s)
[406.409456] Starting dynamic subtest: pipe-B-plane-5
[406.425794] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[406.428109] Subtest plane-position-hole: SUCCESS (11.815s)
[407.244760] [056/133] (614s left) gem_mmap_wc (write)
[407.307548] Subtest write: SKIP (0.000s)
[407.367364] [057/133] (614s left) gem_ctx_persistence (heartbeat-many)
[407.422779] Starting subtest: heartbeat-many
[407.427289] Subtest heartbeat-many: SKIP (0.000s)
[407.500633] [058/133] (614s left) gem_exec_schedule (reorder-wide)
[407.687315] Subtest reorder-wide: SKIP (0.000s)
[407.844178] [059/133] (614s left) i915_query (query-topology-coherent-slice-mask)
[407.896086] Starting subtest: query-topology-coherent-slice-mask
[407.900414] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[407.971517] [060/133] (614s left) kms_lease (lease-get)
[408.062501] Starting subtest: lease-get
[408.064762] Starting dynamic subtest: pipe-A-eDP-1
[408.067034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[408.079028] Starting dynamic subtest: pipe-B-eDP-1
[408.080908] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[408.089522] Starting dynamic subtest: pipe-C-eDP-1
[408.091364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[408.099921] Starting dynamic subtest: pipe-D-eDP-1
[408.101821] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[408.103631] Subtest lease-get: SUCCESS (0.010s)
[408.150395] [061/133] (613s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[408.205665] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[408.279775] [062/133] (613s left) syncobj_eventfd (binary-wait-signaled)
[408.343211] Starting subtest: binary-wait-signaled
[408.345515] Subtest binary-wait-signaled: SUCCESS (0.000s)
[408.408494] [063/133] (613s left) kms_vblank (query-forked-busy-hang)
[408.501766] Starting subtest: query-forked-busy-hang
[408.504025] Starting dynamic subtest: pipe-A-eDP-1
[434.858218] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.351s)
[434.873880] Starting dynamic subtest: pipe-D-eDP-1
[460.846848] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.984s)
[460.849316] Subtest query-forked-busy-hang: SUCCESS (52.339s)
[461.671530] [064/133] (560s left) i915_pm_rps (min-max-config-loaded)
[461.736004] Starting subtest: min-max-config-loaded
[461.740538] Subtest min-max-config-loaded: SKIP (0.001s)
[461.818248] [065/133] (560s left) gem_readwrite (read-bad-handle)
[461.872414] Subtest read-bad-handle: SKIP (0.000s)
[461.936378] [066/133] (560s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[462.060419] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[462.064953] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[462.180508] [067/133] (560s left) kms_addfb_basic (basic)
[462.236072] Starting subtest: basic
[462.238492] Subtest basic: SUCCESS (0.000s)
[462.355965] [068/133] (560s left) kms_cursor_crc (cursor-onscreen-64x21)
[462.539369] Starting subtest: cursor-onscreen-64x21
[462.613050] Subtest cursor-onscreen-64x21: SKIP (0.070s)
[462.830280] [069/133] (559s left) gem_close_race (basic-process)
[462.889801] Starting subtest: basic-process
[462.943853] Subtest basic-process: SUCCESS (0.054s)
[463.106616] [070/133] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[463.205261] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[463.209483] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[463.279538] [071/133] (559s left) gem_mmap_wc (write-wc-read-gtt)
[463.332964] Subtest write-wc-read-gtt: SKIP (0.000s)
[463.394053] [072/133] (559s left) kms_pm_rpm (modeset-pc8-residency-stress)
[465.321871] Starting subtest: modeset-pc8-residency-stress
[465.326947] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[465.664244] [073/133] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[465.760901] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[465.765027] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[465.823635] [074/133] (556s left) i915_query (engine-info-invalid)
[465.884452] Starting subtest: engine-info-invalid
[465.886313] Subtest engine-info-invalid: SUCCESS (0.000s)
[465.955095] [075/133] (556s left) kms_content_protection (srm)
[466.085180] Starting subtest: srm
[466.090362] Subtest srm: SKIP (0.003s)
[466.187120] [076/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[466.287832] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[466.313125] Starting dynamic subtest: pipe-A-plane-0
[466.601559] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[466.612804] Starting dynamic subtest: pipe-A-plane-3
[466.845726] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[466.854595] Starting dynamic subtest: pipe-A-plane-5
[466.858129] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[467.969873] Starting dynamic subtest: pipe-B-plane-0
[468.261902] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[468.271187] Starting dynamic subtest: pipe-B-plane-3
[468.505857] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[468.517502] Starting dynamic subtest: pipe-B-plane-5
[468.521850] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[468.816301] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.528s)
[469.618949] [077/133] (553s left) kms_panel_fitting (legacy)
[469.727529] Starting subtest: legacy
[469.729845] Starting dynamic subtest: pipe-A-eDP-1
[470.310914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[470.339615] Starting dynamic subtest: pipe-B-eDP-1
[471.905868] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.574s)
[471.932390] Starting dynamic subtest: pipe-C-eDP-1
[473.398054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.472s)
[473.425059] Starting dynamic subtest: pipe-D-eDP-1
[474.949821] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[474.952107] Subtest legacy: SUCCESS (5.225s)
[476.157665] [078/133] (546s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[476.257503] Starting subtest: pr-primary-plane-update-sf-dmg-area
[476.261773] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[476.303698] [079/133] (546s left) kms_pm_backlight (bad-brightness)
[476.394718] Starting subtest: bad-brightness
[476.443048] Starting dynamic subtest: eDP-1
[476.750868] Dynamic subtest eDP-1: SUCCESS (0.307s)
[476.753292] Subtest bad-brightness: SUCCESS (0.359s)
[477.586151] [080/133] (545s left) kms_cursor_legacy (forked-bo)
[477.698863] Starting subtest: forked-bo
[477.701177] Starting dynamic subtest: pipe-A
[483.232272] Dynamic subtest pipe-A: SUCCESS (5.475s)
[483.246647] Starting dynamic subtest: pipe-B
[488.705683] Dynamic subtest pipe-B: SUCCESS (5.472s)
[488.718411] Starting dynamic subtest: pipe-C
[494.191132] Dynamic subtest pipe-C: SUCCESS (5.483s)
[494.203832] Starting dynamic subtest: pipe-D
[499.655886] Dynamic subtest pipe-D: SUCCESS (5.462s)
[499.672253] Starting dynamic subtest: all-pipes
[505.141737] Dynamic subtest all-pipes: SUCCESS (5.483s)
[505.144213] Subtest forked-bo: SUCCESS (27.387s)
[505.214928] [081/133] (517s left) kms_flip (dpms-vs-vblank-race)
[505.300981] Starting subtest: dpms-vs-vblank-race
[505.303329] Starting dynamic subtest: A-eDP1
[509.187492] Dynamic subtest A-eDP1: SUCCESS (3.887s)
[509.197242] Starting dynamic subtest: B-eDP1
[512.689095] Dynamic subtest B-eDP1: SUCCESS (3.500s)
[512.700031] Starting dynamic subtest: C-eDP1
[516.213441] Dynamic subtest C-eDP1: SUCCESS (3.522s)
[516.223809] Starting dynamic subtest: D-eDP1
[520.824686] Dynamic subtest D-eDP1: SUCCESS (4.607s)
[520.826683] Subtest dpms-vs-vblank-race: SUCCESS (15.526s)
[521.686045] [082/133] (501s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[521.796845] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[521.801383] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[521.877899] [083/133] (501s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[521.979709] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[521.983775] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[522.048749] [084/133] (501s left) gem_exec_balancer (bonded-false-hang)
[522.305582] Starting subtest: bonded-false-hang
[522.310655] Subtest bonded-false-hang: SKIP (0.000s)
[522.405230] [085/133] (500s left) api_intel_allocator (default-alignment)
[522.465859] Starting subtest: default-alignment
[522.468252] Subtest default-alignment: SUCCESS (0.003s)
[522.571455] [086/133] (500s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[522.670930] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[522.675029] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[522.741801] [087/133] (500s left) gem_exec_params (larger-than-life-batch)
[522.803890] Starting subtest: larger-than-life-batch
[525.107578] Subtest larger-than-life-batch: SUCCESS (2.304s)
[526.170803] [088/133] (497s left) gem_userptr_blits (readonly-unsync)
[526.303981] Subtest readonly-unsync: SKIP (0.000s)
[526.415513] [089/133] (496s left) kms_psr (pr-cursor-plane-onoff)
[526.517313] Starting subtest: pr-cursor-plane-onoff
[526.521473] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[526.566706] [090/133] (496s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[526.693202] Starting subtest: short-flip-after-cursor-atomic-transitions
[527.678101] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.986s)
[528.514810] [091/133] (494s left) i915_fb_tiling (basic-x-tiling)
[528.575732] Subtest basic-x-tiling: SKIP (0.000s)
[528.648715] [092/133] (494s left) kms_chamelium_frames (dp-crc-multiple)
[529.031315] Subtest dp-crc-multiple: SKIP (0.000s)
[529.861111] [093/133] (493s left) gem_mmap_gtt (isolation)
[529.917837] Subtest isolation: SKIP (0.000s)
[529.997727] [094/133] (493s left) gen9_exec_parse (allowed-all)
[530.081581] Subtest allowed-all: SKIP (0.000s)
[530.183565] [095/133] (493s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[530.242612] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[530.244977] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[530.328567] [096/133] (493s left) kms_psr (fbc-psr2-cursor-render)
[530.426376] Starting subtest: fbc-psr2-cursor-render
[530.428640] Starting dynamic subtest: eDP-1
[530.432979] Dynamic subtest eDP-1: SKIP (0.000s)
[530.437374] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[530.477854] [097/133] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[530.565399] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[530.569399] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[530.634601] [098/133] (493s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[530.730926] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[531.387934] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[531.540289] [099/133] (492s left) kms_psr2_su (page_flip-p010)
[531.606913] Subtest page_flip-P010: SKIP (0.000s)
[531.680681] [100/133] (492s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[531.783214] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[535.921196] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.141s)
[537.055182] [101/133] (486s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[537.152380] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[537.156792] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[537.230225] [102/133] (486s left) sw_sync (sync_expired_merge)
[537.264960] Starting subtest: sync_expired_merge
[538.338414] Subtest sync_expired_merge: SUCCESS (1.074s)
[538.377699] [103/133] (485s left) gem_eio (unwedge-stress)
[538.627852] Starting subtest: unwedge-stress
[538.630044] Starting dynamic subtest: render
[543.534693] Dynamic subtest render: SUCCESS (4.904s)
[543.551700] Starting dynamic subtest: bsd1
[567.145555] Dynamic subtest bsd1: SUCCESS (23.608s)
[567.162845] Starting dynamic subtest: bsd2
[587.612268] Dynamic subtest bsd2: SUCCESS (20.464s)
[587.628744] Starting dynamic subtest: blt
[587.633223] Dynamic subtest blt: SKIP (0.000s)
[587.642609] Starting dynamic subtest: vebox
[605.584173] Dynamic subtest vebox: SUCCESS (17.969s)
[605.586438] Subtest unwedge-stress: SUCCESS (66.949s)
[607.099395] [104/133] (416s left) gem_partial_pwrite_pread (write)
[607.161969] Subtest write: SKIP (0.000s)
[607.229981] [105/133] (416s left) gem_spin_batch (resubmit-new-all)
[607.305673] Starting subtest: resubmit-new-all
[607.308025] Starting dynamic subtest: rcs0
[607.319950] Dynamic subtest rcs0: SUCCESS (0.014s)
[607.331832] Starting dynamic subtest: bcs0
[607.334545] Dynamic subtest bcs0: SUCCESS (0.010s)
[607.344419] Starting dynamic subtest: vcs0
[607.346214] Dynamic subtest vcs0: SUCCESS (0.010s)
[607.355920] Starting dynamic subtest: vcs1
[607.358022] Dynamic subtest vcs1: SUCCESS (0.009s)
[607.367824] Starting dynamic subtest: vecs0
[607.369723] Dynamic subtest vecs0: SUCCESS (0.008s)
[607.379188] Starting dynamic subtest: ccs0
[607.381386] Dynamic subtest ccs0: SUCCESS (0.012s)
[607.383467] Subtest resubmit-new-all: SUCCESS (0.070s)
[609.084840] [106/133] (415s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[609.468303] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[610.264557] [107/133] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[610.369363] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[610.373933] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[610.444762] [108/133] (413s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[610.563397] Starting subtest: x-tiled-8bpp-rotate-270
[610.585753] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[610.683219] [109/133] (413s left) gen9_exec_parse (shadow-peek)
[610.737773] Subtest shadow-peek: SKIP (0.000s)
[610.826113] [110/133] (413s left) kms_flip (blocking-absolute-wf_vblank)
[610.918807] Starting subtest: blocking-absolute-wf_vblank
[610.921200] Starting dynamic subtest: A-eDP1
[619.672788] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[619.685150] Starting dynamic subtest: B-eDP1
[628.402657] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[628.412605] Starting dynamic subtest: C-eDP1
[637.137527] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[637.148254] Starting dynamic subtest: D-eDP1
[645.861779] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[645.864192] Subtest blocking-absolute-wf_vblank: SUCCESS (34.897s)
[647.014030] [111/133] (377s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[647.111942] Starting subtest: psr-1p-primscrn-spr-indfb-move
[654.675639] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.566s)
[654.783076] [112/133] (369s left) api_intel_bb (intel-bb-blit-y)
[654.853751] Starting subtest: intel-bb-blit-y
[658.497825] Subtest intel-bb-blit-y: SUCCESS (3.642s)
[658.595884] [113/133] (365s left) kms_force_connector_basic (force-load-detect)
[658.677685] Starting subtest: force-load-detect
[658.682354] Subtest force-load-detect: SKIP (0.000s)
[658.770095] [114/133] (365s left) kms_psr (psr2-primary-render)
[658.876608] Starting subtest: psr2-primary-render
[658.878965] Starting dynamic subtest: eDP-1
[660.564930] Dynamic subtest eDP-1: SUCCESS (1.687s)
[660.567154] Subtest psr2-primary-render: SUCCESS (1.688s)
[661.428617] [115/133] (363s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[661.524213] Starting subtest: stress-xrgb8888-xtiled
[667.436285] Subtest stress-xrgb8888-xtiled: SUCCESS (5.912s)
[667.490611] [116/133] (357s left) kms_prop_blob (invalid-set-prop-any)
[667.542658] Starting subtest: invalid-set-prop-any
[667.544471] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[667.630198] [117/133] (356s left) sriov_basic (bind-unbind-vf)
[667.691235] Starting subtest: bind-unbind-vf
[667.693392] Starting dynamic subtest: vf-1
[667.763584] Dynamic subtest vf-1: FAIL (0.029s)
[667.774379] Starting dynamic subtest: vf-2
[667.834349] Dynamic subtest vf-2: FAIL (0.003s)
[667.844858] Starting dynamic subtest: vf-3
[667.903760] Dynamic subtest vf-3: FAIL (0.003s)
[667.914568] Starting dynamic subtest: vf-4
[667.974354] Dynamic subtest vf-4: FAIL (0.003s)
[667.984817] Starting dynamic subtest: vf-5
[668.046962] Dynamic subtest vf-5: FAIL (0.003s)
[668.057685] Starting dynamic subtest: vf-6
[668.118476] Dynamic subtest vf-6: FAIL (0.003s)
[668.128986] Starting dynamic subtest: vf-7
[668.189773] Dynamic subtest vf-7: FAIL (0.003s)
[668.199986] Starting dynamic subtest: vf-random
[668.258631] Dynamic subtest vf-random: FAIL (0.003s)
[668.269234] Starting dynamic subtest: vf-last
[668.329418] Dynamic subtest vf-last: FAIL (0.004s)
[668.331362] Subtest bind-unbind-vf: FAIL (0.063s)
[668.369900] [118/133] (356s left) kms_pm_backlight (brightness-with-dpms)
[668.466831] Starting subtest: brightness-with-dpms
[668.525914] Starting dynamic subtest: eDP-1
[670.948054] Dynamic subtest eDP-1: SUCCESS (2.419s)
[670.950908] Subtest brightness-with-dpms: SUCCESS (2.481s)
[671.798613] [119/133] (352s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[671.851263] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[671.853540] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[671.927293] [120/133] (352s left) kms_getfb (getfb2-into-addfb2)
[672.026416] Starting subtest: getfb2-into-addfb2
[672.028613] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[672.112773] [121/133] (352s left) gem_exec_whisper (basic-queues)
[672.178572] Starting subtest: basic-queues
[678.793201] Subtest basic-queues: SUCCESS (6.613s)
[678.953314] [122/133] (345s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[679.055619] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[679.059948] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[679.137589] [123/133] (345s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[679.231583] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[679.235407] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[679.291402] [124/133] (345s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[679.397516] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[686.775837] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.383s)
[686.891682] [125/133] (338s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[686.991767] Starting subtest: y-tiled-64bpp-rotate-90
[686.996094] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[687.068314] [126/133] (337s left) kms_fbcon_fbt (psr)
[687.123913] Starting subtest: psr
[694.451654] Subtest psr: SUCCESS (7.326s)
[694.528842] [127/133] (330s left) kms_cursor_crc (cursor-sliding-512x512)
[694.838385] Starting subtest: cursor-sliding-512x512
[694.842725] Subtest cursor-sliding-512x512: SKIP (0.001s)
[694.984113] [128/133] (330s left) kms_draw_crc (draw-method-render)
[695.079684] Starting subtest: draw-method-render
[695.081644] Starting dynamic subtest: xrgb8888-untiled
[695.311733] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[695.323446] Starting dynamic subtest: rgb565-untiled
[695.544392] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[695.555838] Starting dynamic subtest: xrgb2101010-untiled
[695.777794] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[695.787616] Starting dynamic subtest: xbgr16161616f-untiled
[696.022281] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[696.039235] Starting dynamic subtest: xrgb8888-xtiled
[696.155453] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[696.165342] Starting dynamic subtest: rgb565-xtiled
[696.277632] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[696.289549] Starting dynamic subtest: xrgb2101010-xtiled
[696.377974] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[696.388372] Starting dynamic subtest: xbgr16161616f-xtiled
[696.511439] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[696.523599] Starting dynamic subtest: xrgb8888-4tiled
[696.633431] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[696.645840] Starting dynamic subtest: rgb565-4tiled
[696.755769] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s)
[696.766285] Starting dynamic subtest: xrgb2101010-4tiled
[696.877857] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[696.889652] Starting dynamic subtest: xbgr16161616f-4tiled
[697.012212] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[697.014117] Subtest draw-method-render: SUCCESS (1.936s)
[697.095226] [129/133] (327s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[697.186547] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[697.198384] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[697.251701] [130/133] (327s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[697.341372] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[697.343279] Starting dynamic subtest: pipe-A-default-mode
[698.537664] Dynamic subtest pipe-A-default-mode: SKIP (1.192s)
[698.541640] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.194s)
[698.686394] [131/133] (326s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[698.773781] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[698.776165] Starting dynamic subtest: pipe-A-eDP-1
[699.010031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.207s)
[699.022633] Starting dynamic subtest: pipe-B-eDP-1
[700.271526] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[700.284418] Starting dynamic subtest: pipe-C-eDP-1
[701.470043] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[701.481992] Starting dynamic subtest: pipe-D-eDP-1
[702.695170] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[702.697394] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.895s)
[703.808567] [132/133] (321s left) kms_async_flips (test-cursor-atomic)
[703.901870] Starting subtest: test-cursor-atomic
[704.277248] Starting dynamic subtest: pipe-A-eDP-1
[705.016327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[705.408613] Starting dynamic subtest: pipe-B-eDP-1
[706.148453] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.749s)
[706.533034] Starting dynamic subtest: pipe-C-eDP-1
[707.284152] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[707.653035] Starting dynamic subtest: pipe-D-eDP-1
[708.407441] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[708.409977] Subtest test-cursor-atomic: SUCCESS (4.508s)
[709.561860] [133/133] (315s left) kms_addfb_basic (legacy-format)
[709.690701] Starting subtest: legacy-format
[709.735042] Subtest legacy-format: SUCCESS (0.037s)
[709.846929] 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.