[65.316968] Initializing watchdogs
[65.317026]   /dev/watchdog0
[65.334114] [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]
[65.338618] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.340870] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.344218] [001/133] (960s left) kms_psr (psr-cursor-mmap-cpu)
[65.487693] Starting subtest: psr-cursor-mmap-cpu
[65.490041] Starting dynamic subtest: eDP-1
[67.262964] Dynamic subtest eDP-1: SUCCESS (1.774s)
[67.265901] Subtest psr-cursor-mmap-cpu: SUCCESS (1.775s)
[68.141199] [002/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[68.245094] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[68.249263] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[68.375133] [003/133] (957s left) prime_vgem (basic-read)
[68.481409] Starting subtest: basic-read
[68.486510] Subtest basic-read: SKIP (0.005s)
[68.608067] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[68.610989] [004/133] (957s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[68.714578] Starting subtest: plane-lut1d-pre-ctm3x4
[68.727585] Starting dynamic subtest: pipe-A-eDP-1
[69.372207] Dynamic subtest pipe-A-eDP-1: FAIL (0.304s)
[70.116892] Starting dynamic subtest: pipe-B-eDP-1
[70.946074] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[71.546632] Starting dynamic subtest: pipe-C-eDP-1
[72.367308] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[72.874327] Starting dynamic subtest: pipe-D-eDP-1
[73.706896] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[73.708952] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.685s)
[74.286236] [005/133] (951s left) gem_create (busy-create)
[74.346529] Starting subtest: busy-create
[74.348955] Starting dynamic subtest: smem0
[107.955997] Dynamic subtest smem0: SUCCESS (33.600s)
[107.959019] Subtest busy-create: SUCCESS (33.601s)
[108.162476] [006/133] (917s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[108.299851] Starting subtest: cursorB-vs-flipA-atomic-transitions
[108.304436] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[108.455815] [007/133] (917s left) gem_mmap_gtt (pf-nonblock)
[108.515089] Subtest pf-nonblock: SKIP (0.000s)
[108.582200] [008/133] (917s left) kms_vblank (ts-continuation-modeset)
[108.681912] Starting subtest: ts-continuation-modeset
[108.684252] Starting dynamic subtest: pipe-A-eDP-1
[110.120242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.439s)
[110.132072] Starting dynamic subtest: pipe-D-eDP-1
[112.299566] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s)
[112.301581] Subtest ts-continuation-modeset: SUCCESS (3.618s)
[113.103974] [009/133] (913s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[113.204144] Starting subtest: pixel-format-y-tiled-ccs-modifier
[113.230052] Starting dynamic subtest: pipe-A-plane-0
[113.234582] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[113.243644] Starting dynamic subtest: pipe-A-plane-3
[113.248286] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[113.255063] Starting dynamic subtest: pipe-A-plane-5
[113.259471] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[114.377513] Starting dynamic subtest: pipe-B-plane-0
[114.381554] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[114.388391] Starting dynamic subtest: pipe-B-plane-3
[114.393028] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[114.399844] Starting dynamic subtest: pipe-B-plane-5
[114.403916] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[114.695744] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (1.491s)
[115.571519] [010/133] (910s left) prime_vgem (sync)
[115.658344] Starting subtest: sync
[115.660720] Starting dynamic subtest: rcs0
[115.723935] Dynamic subtest rcs0: SUCCESS (0.066s)
[115.730830] Starting dynamic subtest: bcs0
[115.815388] Dynamic subtest bcs0: SUCCESS (0.091s)
[115.822034] Starting dynamic subtest: vcs0
[115.863509] Dynamic subtest vcs0: SUCCESS (0.048s)
[115.870448] Starting dynamic subtest: vcs1
[115.909159] Dynamic subtest vcs1: SUCCESS (0.045s)
[115.915874] Starting dynamic subtest: vecs0
[115.954626] Dynamic subtest vecs0: SUCCESS (0.045s)
[115.961428] Starting dynamic subtest: ccs0
[116.000251] Dynamic subtest ccs0: SUCCESS (0.045s)
[116.002580] Subtest sync: SUCCESS (0.342s)
[116.155753] [011/133] (910s left) kms_lease (atomic-implicit-crtc)
[116.260622] Starting subtest: atomic-implicit-crtc
[116.262902] Starting dynamic subtest: pipe-A-eDP-1
[116.274377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[116.283971] Starting dynamic subtest: pipe-B-eDP-1
[116.295580] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[116.302269] Starting dynamic subtest: pipe-C-eDP-1
[116.312672] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[116.319265] Starting dynamic subtest: pipe-D-eDP-1
[116.329876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[116.331781] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[116.457199] [012/133] (909s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[116.549211] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[116.551346] Starting dynamic subtest: pipe-A-eDP-1
[116.570270] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[116.578080] Starting dynamic subtest: pipe-B-eDP-1
[116.594850] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[116.601434] Starting dynamic subtest: pipe-C-eDP-1
[116.618338] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[116.624557] Starting dynamic subtest: pipe-D-eDP-1
[116.642500] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[116.646067] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[118.776722] [013/133] (907s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[118.894370] Starting subtest: 4-tiled-32bpp-rotate-270
[118.913483] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[119.070031] [014/133] (907s left) prime_mmap (test_forked_cpu_write)
[119.138640] Starting subtest: test_forked_cpu_write
[119.140580] Starting dynamic subtest: test_forked_cpu_write-smem
[119.146520] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[119.149013] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[119.289048] [015/133] (907s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[119.693989] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[120.481392] [016/133] (905s left) kms_flip (blocking-wf_vblank)
[120.587185] Starting subtest: blocking-wf_vblank
[120.589489] Starting dynamic subtest: A-eDP1
[129.545268] Dynamic subtest A-eDP1: SUCCESS (8.959s)
[129.555076] Starting dynamic subtest: B-eDP1
[138.471818] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[138.479135] Starting dynamic subtest: C-eDP1
[147.397672] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[147.404871] Starting dynamic subtest: D-eDP1
[156.329195] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[156.331618] Subtest blocking-wf_vblank: SUCCESS (35.746s)
[157.566537] [017/133] (868s left) kms_rotation_crc (primary-rotation-180)
[157.669438] Starting subtest: primary-rotation-180
[164.838363] Subtest primary-rotation-180: SUCCESS (7.169s)
[166.032045] [018/133] (860s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[166.130385] Starting subtest: primary-yf-tiled-reflect-x-270
[166.134949] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[166.212565] [019/133] (860s left) gem_exec_whisper (basic-queues-priority-all)
[166.285241] Starting subtest: basic-queues-priority-all
[188.085263] Subtest basic-queues-priority-all: SUCCESS (21.800s)
[188.280243] [020/133] (838s left) perf_pmu (all-busy-check-all)
[188.320645] Starting subtest: all-busy-check-all
[189.910440] Subtest all-busy-check-all: SUCCESS (1.590s)
[190.032519] [021/133] (836s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[190.154654] Starting subtest: protected-encrypted-src-copy-not-readible
[190.270573] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.117s)
[190.425140] [022/133] (836s left) gem_ctx_persistence (engines-hang)
[190.480431] Starting subtest: engines-hang
[190.482943] Starting dynamic subtest: rcs0
[190.641468] Dynamic subtest rcs0: SUCCESS (0.160s)
[190.651689] Starting dynamic subtest: bcs0
[190.754876] Dynamic subtest bcs0: SUCCESS (0.113s)
[190.765694] Starting dynamic subtest: vcs0
[190.881338] Dynamic subtest vcs0: SUCCESS (0.125s)
[190.892716] Starting dynamic subtest: vcs1
[190.999973] Dynamic subtest vcs1: SUCCESS (0.118s)
[191.010788] Starting dynamic subtest: vecs0
[191.129233] Dynamic subtest vecs0: SUCCESS (0.128s)
[191.140744] Starting dynamic subtest: ccs0
[191.248823] Dynamic subtest ccs0: SUCCESS (0.119s)
[191.251581] Subtest engines-hang: SUCCESS (0.769s)
[191.340399] [023/133] (835s left) kms_flip (2x-dpms-vs-vblank-race)
[191.440310] Starting subtest: 2x-dpms-vs-vblank-race
[191.452469] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[191.582965] [024/133] (835s left) gem_exec_reloc (basic-wc-read-noreloc)
[191.653561] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[191.743536] [025/133] (835s left) perf_pmu (render-node-busy)
[191.816523] Starting subtest: render-node-busy
[191.818354] Starting dynamic subtest: rcs0
[192.429212] Dynamic subtest rcs0: SUCCESS (0.612s)
[192.439906] Starting dynamic subtest: bcs0
[193.000513] Dynamic subtest bcs0: SUCCESS (0.570s)
[193.011846] Starting dynamic subtest: vcs0
[194.902367] Dynamic subtest vcs0: SUCCESS (1.898s)
[194.914282] Starting dynamic subtest: vcs1
[196.886076] Dynamic subtest vcs1: SUCCESS (1.982s)
[196.898069] Starting dynamic subtest: vecs0
[198.934255] Dynamic subtest vecs0: SUCCESS (2.046s)
[198.945930] Starting dynamic subtest: ccs0
[199.507718] Dynamic subtest ccs0: SUCCESS (0.573s)
[199.510324] Subtest render-node-busy: SUCCESS (7.691s)
[199.595316] [026/133] (827s left) kms_cursor_crc (cursor-offscreen-128x42)
[199.821901] Starting subtest: cursor-offscreen-128x42
[199.871625] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[200.115540] [027/133] (826s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[200.225048] Starting subtest: y-tiled-16bpp-rotate-270
[200.229258] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[200.335615] [028/133] (826s left) kms_feature_discovery (display)
[200.432211] Starting subtest: display
[200.434112] Subtest display: SUCCESS (0.000s)
[200.513676] [029/133] (826s left) i915_pm_rps (min-max-config-idle)
[200.579845] Starting subtest: min-max-config-idle
[200.583905] Subtest min-max-config-idle: SKIP (0.001s)
[200.688656] [030/133] (826s left) syncobj_basic (bad-pad-handle-to-fd)
[200.741330] Starting subtest: bad-pad-handle-to-fd
[200.743254] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[200.858801] [031/133] (826s left) kms_psr (fbc-pr-sprite-render)
[200.956353] Starting subtest: fbc-pr-sprite-render
[200.960020] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[201.038449] [032/133] (826s left) kms_psr (fbc-psr-primary-mmap-gtt)
[201.139517] Starting subtest: fbc-psr-primary-mmap-gtt
[201.141197] Starting dynamic subtest: eDP-1
[201.144583] Dynamic subtest eDP-1: SKIP (0.000s)
[201.148043] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[201.221928] [033/133] (825s left) gem_exec_reloc (basic-cpu-gtt-active)
[201.276117] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[201.339266] [034/133] (825s left) kms_cursor_edge_walk (256x256-top-bottom)
[201.426771] Starting subtest: 256x256-top-bottom
[201.428724] Starting dynamic subtest: pipe-A-eDP-1
[204.879250] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s)
[204.888560] Starting dynamic subtest: pipe-D-eDP-1
[208.004211] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[208.006495] Subtest 256x256-top-bottom: SUCCESS (6.576s)
[208.814430] [035/133] (818s left) gem_exec_fence (basic-busy-all)
[208.882044] Starting subtest: basic-busy-all
[208.961993] Subtest basic-busy-all: SUCCESS (0.081s)
[211.036081] [036/133] (816s left) kms_pm_rpm (legacy-planes-dpms)
[213.068133] Starting subtest: legacy-planes-dpms
[213.070224] Starting dynamic subtest: plane-64
[221.366057] Dynamic subtest plane-64: SUCCESS (8.299s)
[221.377652] Starting dynamic subtest: plane-94
[230.192806] Dynamic subtest plane-94: SUCCESS (8.824s)
[230.203818] Starting dynamic subtest: plane-124
[238.777563] Dynamic subtest plane-124: SUCCESS (8.583s)
[238.790337] Starting dynamic subtest: plane-134
[247.107338] Dynamic subtest plane-134: SUCCESS (8.327s)
[247.110273] Subtest legacy-planes-dpms: SUCCESS (34.041s)
[247.500113] [037/133] (779s left) gem_softpin (evict-active-interruptible)
[247.560578] Starting subtest: evict-active-interruptible
[247.566759] Subtest evict-active-interruptible: SUCCESS (0.006s)
[247.708253] [038/133] (779s left) gem_ccs (block-multicopy-inplace)
[247.768870] Starting subtest: block-multicopy-inplace
[247.773015] Subtest block-multicopy-inplace: SKIP (0.000s)
[247.887657] [039/133] (779s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[247.994126] Starting subtest: async-flip-with-page-flip-events-linear
[248.366804] Starting dynamic subtest: pipe-A-eDP-1
[251.153372] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.785s)
[251.519770] Starting dynamic subtest: pipe-B-eDP-1
[254.288091] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[254.655091] Starting dynamic subtest: pipe-C-eDP-1
[257.414301] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[257.776185] Starting dynamic subtest: pipe-D-eDP-1
[260.552525] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[260.555549] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.559s)
[261.760452] [040/133] (765s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[261.862097] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[261.864463] Starting dynamic subtest: pipe-A
[261.880462] Dynamic subtest pipe-A: SKIP (0.016s)
[261.897102] Starting dynamic subtest: pipe-B
[261.911329] Dynamic subtest pipe-B: SKIP (0.029s)
[261.928718] Starting dynamic subtest: pipe-C
[261.943250] Dynamic subtest pipe-C: SKIP (0.029s)
[261.960192] Starting dynamic subtest: pipe-D
[261.974747] Dynamic subtest pipe-D: SKIP (0.029s)
[261.979039] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.107s)
[262.112175] [041/133] (765s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[262.215342] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[262.217606] Starting dynamic subtest: pipe-A-eDP-1
[262.243070] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.252429] Starting dynamic subtest: pipe-B-eDP-1
[262.276737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.284591] Starting dynamic subtest: pipe-C-eDP-1
[262.308417] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.317790] Starting dynamic subtest: pipe-D-eDP-1
[262.341618] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.345976] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[264.502565] [042/133] (762s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[264.595120] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[264.620638] Starting dynamic subtest: pipe-A-plane-0
[264.625273] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[264.635571] Starting dynamic subtest: pipe-A-plane-3
[264.640340] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[264.651862] Starting dynamic subtest: pipe-A-plane-5
[264.656666] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[265.694299] Starting dynamic subtest: pipe-B-plane-0
[265.698264] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[265.706565] Starting dynamic subtest: pipe-B-plane-3
[265.711254] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[265.719424] Starting dynamic subtest: pipe-B-plane-5
[265.724117] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[266.000637] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.403s)
[266.871289] [043/133] (760s left) syncobj_timeline (single-wait-for-submit-signaled)
[266.927335] Starting subtest: single-wait-for-submit-signaled
[266.929738] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[267.067899] [044/133] (760s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[267.170368] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[267.183760] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.012s)
[267.279499] [045/133] (760s left) kms_addfb_basic (bad-pitch-63)
[267.340375] Starting subtest: bad-pitch-63
[267.342750] Subtest bad-pitch-63: SUCCESS (0.000s)
[267.496500] [046/133] (760s left) gem_exec_flush (basic-wb-prw-default)
[267.558409] Starting subtest: basic-wb-prw-default
[273.038772] Subtest basic-wb-prw-default: SUCCESS (5.481s)
[273.241970] [047/133] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[273.343958] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[273.348303] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[273.465334] [048/133] (754s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[273.587757] Starting subtest: basic-flip-after-cursor-legacy
[274.508245] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.918s)
[275.318330] [049/133] (752s left) gem_mmap_gtt (basic-wc)
[275.387665] Subtest basic-wc: SKIP (0.000s)
[275.456896] [050/133] (752s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[275.530563] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[275.597528] [051/133] (752s left) kms_sequence (queue-busy)
[275.690099] Starting subtest: queue-busy
[275.692225] Starting dynamic subtest: pipe-A-eDP-1
[277.628645] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[277.637889] Starting dynamic subtest: pipe-B-eDP-1
[280.212206] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[280.222669] Starting dynamic subtest: pipe-C-eDP-1
[282.800675] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.588s)
[282.809367] Starting dynamic subtest: pipe-D-eDP-1
[285.333348] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[285.335624] Subtest queue-busy: SUCCESS (9.643s)
[286.134923] [052/133] (741s left) kms_vrr (negative-basic)
[286.232041] Starting subtest: negative-basic
[286.238427] Starting dynamic subtest: pipe-A-eDP-1
[291.654957] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s)
[291.935390] Subtest negative-basic: SUCCESS (5.704s)
[292.761241] [053/133] (735s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[292.867196] Starting subtest: x-tiled-32bpp-rotate-90
[292.886495] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[293.035892] [054/133] (734s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[293.148167] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[293.150475] Starting dynamic subtest: pipe-A-eDP-1
[293.232208] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[293.240913] Starting dynamic subtest: pipe-B-eDP-1
[294.327498] Dynamic subtest pipe-B-eDP-1: SKIP (1.093s)
[294.332147] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.184s)
[295.538101] [055/133] (732s left) gem_mmap_gtt (basic-small-copy-odd)
[295.602683] Subtest basic-small-copy-odd: SKIP (0.000s)
[295.666858] [056/133] (732s left) kms_joiner (basic-force-big-joiner)
[295.763156] Starting subtest: basic-force-big-joiner
[295.767307] Subtest basic-force-big-joiner: SKIP (0.000s)
[295.840833] [057/133] (732s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[295.902066] Starting subtest: yf-tiled-to-vebox-y-tiled
[295.906354] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[296.108745] [058/133] (732s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[296.208349] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[296.210700] Starting dynamic subtest: pipe-A-default-mode
[297.373642] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[297.378038] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.166s)
[297.543224] [059/133] (730s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[297.648366] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[298.283481] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[298.503969] [060/133] (729s left) gem_mmap_wc (close)
[298.571931] Subtest close: SKIP (0.000s)
[298.637335] [061/133] (729s left) gen9_exec_parse (shadow-peek)
[298.705825] Subtest shadow-peek: SKIP (0.000s)
[298.764055] [062/133] (729s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[298.868078] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[307.439426] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.574s)
[307.577449] [063/133] (720s left) gem_exec_endless (dispatch)
[307.659478] Starting subtest: dispatch
[307.662074] Starting dynamic subtest: rcs0
[307.666777] Dynamic subtest rcs0: SUCCESS (0.005s)
[307.678229] Starting dynamic subtest: bcs0
[307.682864] Dynamic subtest bcs0: SUCCESS (0.004s)
[307.693254] Starting dynamic subtest: vcs0
[307.697508] Dynamic subtest vcs0: SUCCESS (0.005s)
[307.705435] Starting dynamic subtest: vcs1
[307.709536] Dynamic subtest vcs1: SUCCESS (0.005s)
[307.717517] Starting dynamic subtest: vecs0
[307.721670] Dynamic subtest vecs0: SUCCESS (0.005s)
[307.729521] Starting dynamic subtest: ccs0
[307.733645] Dynamic subtest ccs0: SUCCESS (0.006s)
[307.735548] Subtest dispatch: SUCCESS (0.034s)
[308.937466] [064/133] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[309.033927] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[309.038104] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[309.155164] [065/133] (719s left) vgem_basic (dmabuf-fence)
[309.196428] Starting subtest: dmabuf-fence
[309.198654] Subtest dmabuf-fence: SUCCESS (0.001s)
[309.264702] [066/133] (719s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[309.376429] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[313.385085] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.010s)
[314.522356] [067/133] (713s left) gem_exec_schedule (reorder-wide)
[314.724625] Subtest reorder-wide: SKIP (0.000s)
[314.916152] [068/133] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[315.016689] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[315.021151] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[315.145870] [069/133] (713s left) kms_pm_rpm (basic-pci-d3-state)
[317.067503] Starting subtest: basic-pci-d3-state
[318.554874] Subtest basic-pci-d3-state: SUCCESS (1.491s)
[318.654856] [070/133] (709s left) gem_pipe_control_store_loop (reused-buffer)
[318.713936] Starting subtest: reused-buffer
[320.867195] Subtest reused-buffer: SUCCESS (2.152s)
[321.020233] [071/133] (707s left) gem_workarounds (suspend-resume-fd)
[321.100429] Starting subtest: suspend-resume-fd
[337.125882] Subtest suspend-resume-fd: SUCCESS (1.299s)
[337.288065] [072/133] (691s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[337.874360] Starting subtest: syncobj-stationary-timeline-chain-engines
[337.959902] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.087s)
[339.683235] [073/133] (689s left) gem_ctx_persistence (processes)
[339.763252] Starting subtest: processes
[341.663588] Subtest processes: SUCCESS (1.903s)
[341.759154] [074/133] (687s left) gem_exec_params (cliprects-invalid)
[341.821569] Starting subtest: cliprects-invalid
[341.823975] Subtest cliprects-invalid: SUCCESS (0.000s)
[341.940426] [075/133] (686s left) gem_exec_schedule (u-submit-late-slice)
[342.002921] Starting subtest: u-submit-late-slice
[342.005225] Starting dynamic subtest: rcs0
[342.045647] Dynamic subtest rcs0: SUCCESS (0.051s)
[342.058193] Starting dynamic subtest: bcs0
[342.088470] Dynamic subtest bcs0: SUCCESS (0.042s)
[342.099272] Starting dynamic subtest: vcs0
[342.132050] Dynamic subtest vcs0: SUCCESS (0.043s)
[342.143457] Starting dynamic subtest: vcs1
[342.176519] Dynamic subtest vcs1: SUCCESS (0.044s)
[342.187578] Starting dynamic subtest: vecs0
[342.216596] Dynamic subtest vecs0: SUCCESS (0.039s)
[342.229767] Starting dynamic subtest: ccs0
[342.261025] Dynamic subtest ccs0: SUCCESS (0.044s)
[342.263406] Subtest u-submit-late-slice: SUCCESS (0.268s)
[343.786162] [076/133] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[343.885676] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[343.890287] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[344.014394] [077/133] (684s left) vgem_basic (bad-flag)
[344.066054] Starting subtest: bad-flag
[344.068517] Subtest bad-flag: SUCCESS (0.000s)
[344.123213] [078/133] (684s left) syncobj_timeline (invalid-signal-zero-handles)
[344.182767] Starting subtest: invalid-signal-zero-handles
[344.185102] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[344.328800] [079/133] (684s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[344.447778] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[345.571719] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.123s)
[345.742981] [080/133] (683s left) gen7_exec_parse (basic-offset)
[345.810353] Subtest basic-offset: SKIP (0.000s)
[345.891139] [081/133] (683s left) gem_exec_params (rs-invalid)
[345.953050] Starting subtest: rs-invalid
[345.957574] Subtest rs-invalid: SUCCESS (0.003s)
[346.115341] [082/133] (682s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[346.213908] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[353.987801] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.683s)
[354.182532] [083/133] (674s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[354.257675] Starting subtest: multi-wait-all-for-submit-submitted
[354.366943] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[354.456228] [084/133] (674s left) i915_suspend (fence-restore-untiled)
[354.522437] Starting subtest: fence-restore-untiled
[354.527050] Subtest fence-restore-untiled: SKIP (0.000s)
[354.652928] [085/133] (674s left) kms_dp_linktrain_fallback (dp-fallback)
[354.751853] Starting subtest: dp-fallback
[354.758262] Subtest dp-fallback: SKIP (0.000s)
[354.838561] [086/133] (674s left) kms_async_flips (invalid-async-flip)
[354.937071] Starting subtest: invalid-async-flip
[355.324076] Starting dynamic subtest: pipe-A-eDP-1
[356.166228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[356.528315] Starting dynamic subtest: pipe-B-eDP-1
[357.303762] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[357.666100] Starting dynamic subtest: pipe-C-eDP-1
[358.424738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[358.780739] Starting dynamic subtest: pipe-D-eDP-1
[359.561792] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[359.564244] Subtest invalid-async-flip: SUCCESS (4.598s)
[360.725506] [087/133] (668s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[360.834478] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[367.688044] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.835s)
[367.873268] [088/133] (661s left) kms_chamelium_frames (dp-crc-multiple)
[368.276258] Subtest dp-crc-multiple: SKIP (0.000s)
[369.067250] [089/133] (660s left) gem_mmap_gtt (basic-small-copy-xy)
[369.135832] Subtest basic-small-copy-XY: SKIP (0.000s)
[369.194963] [090/133] (660s left) kms_cdclk (plane-scaling)
[369.290492] Starting subtest: plane-scaling
[369.292901] Starting dynamic subtest: pipe-A-eDP-1
[369.584446] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s)
[369.596214] Starting dynamic subtest: pipe-B-eDP-1
[369.601171] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[369.612292] Starting dynamic subtest: pipe-C-eDP-1
[369.616975] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[369.626271] Starting dynamic subtest: pipe-D-eDP-1
[369.630709] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[369.635115] Subtest plane-scaling: SKIP (0.300s)
[370.419502] [091/133] (659s left) syncobj_timeline (multi-wait-available-submitted)
[370.484716] Starting subtest: multi-wait-available-submitted
[370.487069] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[370.618540] [092/133] (658s left) gem_ctx_shared (q-smoketest-all)
[370.675682] Starting subtest: Q-smoketest-all
[403.071174] Subtest Q-smoketest-all: SUCCESS (32.333s)
[404.704401] [093/133] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[404.815881] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[404.820431] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[404.931492] [094/133] (624s left) kms_psr (pr-basic)
[405.020109] Starting subtest: pr-basic
[405.024202] Subtest pr-basic: SKIP (0.000s)
[405.103912] [095/133] (624s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[405.195458] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[405.200088] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[405.330590] [096/133] (624s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[405.472265] Starting subtest: dp-mst-lic-type-0-hdcp14
[405.476979] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[405.633152] [097/133] (624s left) kms_rotation_crc (multiplane-rotation)
[405.719532] Starting subtest: multiplane-rotation
[423.182632] Subtest multiplane-rotation: SUCCESS (17.460s)
[423.324446] [098/133] (606s left) perf (sysctl-defaults)
[423.416267] Starting subtest: sysctl-defaults
[423.418385] Subtest sysctl-defaults: SUCCESS (0.000s)
[423.506049] [099/133] (606s left) sw_sync (timeline_closed)
[423.543290] Starting subtest: timeline_closed
[423.545035] Subtest timeline_closed: SUCCESS (0.000s)
[423.607468] [100/133] (606s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[423.708151] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[423.709946] Starting dynamic subtest: pipe-A-eDP-1
[423.726304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[423.736304] Starting dynamic subtest: pipe-B-eDP-1
[423.752170] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[423.761357] Starting dynamic subtest: pipe-C-eDP-1
[423.776797] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[423.785647] Starting dynamic subtest: pipe-D-eDP-1
[423.801268] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[423.803033] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[425.976359] [101/133] (603s left) gem_spin_batch (spin-all)
[426.045843] Starting subtest: spin-all
[426.055344] Subtest spin-all: SUCCESS (0.012s)
[427.664866] [102/133] (602s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[427.758131] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[427.762567] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[427.845266] [103/133] (602s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[427.942665] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[428.072988] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s)
[428.218873] [104/133] (601s left) i915_hangman (gt-error-state-capture)
[428.282804] Starting subtest: gt-error-state-capture
[428.285130] Starting dynamic subtest: rcs0
[439.609584] Dynamic subtest rcs0: SUCCESS (11.321s)
[439.623556] Starting dynamic subtest: bcs0
[451.576424] Dynamic subtest bcs0: SUCCESS (11.965s)
[451.589686] Starting dynamic subtest: vcs0
[463.544439] Dynamic subtest vcs0: SUCCESS (11.968s)
[463.557661] Starting dynamic subtest: vcs1
[474.553347] Dynamic subtest vcs1: SUCCESS (11.006s)
[474.565597] Starting dynamic subtest: vecs0
[486.521306] Dynamic subtest vecs0: SUCCESS (11.964s)
[486.533917] Starting dynamic subtest: ccs0
[496.569281] Dynamic subtest ccs0: SUCCESS (10.043s)
[496.572337] Subtest gt-error-state-capture: SUCCESS (68.285s)
[496.727347] [105/133] (533s left) core_setmaster (master-drop-set-root)
[496.804442] Starting subtest: master-drop-set-root
[496.816459] Subtest master-drop-set-root: SUCCESS (0.013s)
[496.865378] [106/133] (533s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[496.969280] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[496.973197] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[497.099916] [107/133] (533s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[497.193494] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[497.197501] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[497.294684] [108/133] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[497.392596] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[497.396616] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[497.524728] [109/133] (532s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[497.646717] Starting subtest: stress-xrgb8888-ytiled
[497.650604] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[497.735252] [110/133] (532s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[497.791759] Starting subtest: multi-wait-for-submit-unsubmitted
[497.895068] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[497.999841] [111/133] (532s left) kms_flip (2x-nonexisting-fb-interruptible)
[498.099177] Starting subtest: 2x-nonexisting-fb-interruptible
[498.111730] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[498.252457] [112/133] (532s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[498.311237] Starting subtest: etime-single-wait-available-unsubmitted
[498.414770] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[498.503765] [113/133] (531s left) syncobj_timeline (device-submit-unordered)
[498.571213] Starting subtest: device-submit-unordered
[498.573802] Subtest device-submit-unordered: SUCCESS (0.000s)
[498.700811] [114/133] (531s left) gem_exec_schedule (manyslice)
[498.783990] Starting subtest: manyslice
[498.786214] Starting dynamic subtest: rcs0
[503.384603] Dynamic subtest rcs0: SUCCESS (4.608s)
[503.399169] Starting dynamic subtest: bcs0
[510.016032] Dynamic subtest bcs0: SUCCESS (6.628s)
[510.028356] Starting dynamic subtest: vcs0
[515.090942] Dynamic subtest vcs0: SUCCESS (5.071s)
[515.106556] Starting dynamic subtest: vcs1
[521.689630] Dynamic subtest vcs1: SUCCESS (6.595s)
[521.704986] Starting dynamic subtest: vecs0
[528.278335] Dynamic subtest vecs0: SUCCESS (6.585s)
[528.294099] Starting dynamic subtest: ccs0
[534.971803] Dynamic subtest ccs0: SUCCESS (6.687s)
[534.974389] Subtest manyslice: SUCCESS (36.186s)
[535.304335] [115/133] (495s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[535.406900] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[535.411292] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[536.510579] [116/133] (494s left) kms_cursor_crc (cursor-size-hints)
[536.641615] Starting subtest: cursor-size-hints
[536.643946] Starting dynamic subtest: pipe-A-eDP-1
[537.254850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[537.264284] Starting dynamic subtest: pipe-D-eDP-1
[538.571764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[538.574202] Subtest cursor-size-hints: SUCCESS (1.930s)
[539.469937] [117/133] (491s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[539.566524] Starting subtest: fbc-1p-pri-indfb-multidraw
[552.778387] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.212s)
[554.184389] [118/133] (476s left) kms_plane_scaling (planes-downscale-factor-0-5)
[554.271359] Starting subtest: planes-downscale-factor-0-5
[554.273749] Starting dynamic subtest: pipe-A
[554.292434] Dynamic subtest pipe-A: SKIP (0.017s)
[554.307911] Starting dynamic subtest: pipe-B
[554.324873] Dynamic subtest pipe-B: SKIP (0.031s)
[554.335639] Starting dynamic subtest: pipe-C
[554.353421] Dynamic subtest pipe-C: SKIP (0.030s)
[554.363231] Starting dynamic subtest: pipe-D
[554.386951] Dynamic subtest pipe-D: SKIP (0.030s)
[554.391040] Subtest planes-downscale-factor-0-5: SKIP (0.111s)
[554.508233] [119/133] (476s left) prime_vgem (basic-fence-read)
[554.602343] Starting subtest: basic-fence-read
[554.619332] Subtest basic-fence-read: SKIP (0.018s)
[554.761450] [120/133] (475s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[554.878128] Starting subtest: psr2-plane-move-sf-dmg-area
[554.880440] Starting dynamic subtest: pipe-A-eDP-1
[559.392479] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.516s)
[559.404444] Starting dynamic subtest: pipe-B-eDP-1
[564.718775] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.324s)
[564.721168] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.843s)
[565.606412] [121/133] (465s left) gem_readwrite (read-write)
[565.685565] Subtest read-write: SKIP (0.000s)
[565.750651] [122/133] (465s left) kms_prop_blob (invalid-set-prop)
[565.810055] Starting subtest: invalid-set-prop
[565.812311] Subtest invalid-set-prop: SUCCESS (0.000s)
[565.925854] [123/133] (464s left) kms_flip (2x-flip-vs-panning-interruptible)
[566.033497] Starting subtest: 2x-flip-vs-panning-interruptible
[566.044815] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[566.172949] [124/133] (464s left) gem_exec_reloc (basic-wc-active)
[566.234861] Subtest basic-wc-active: SKIP (0.000s)
[566.326981] [125/133] (464s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[566.426588] Starting subtest: psr-rgb101010-draw-render
[573.734914] Subtest psr-rgb101010-draw-render: SUCCESS (7.309s)
[573.885470] [126/133] (457s left) gem_exec_flush (basic-wb-ro-before-default)
[573.951488] Starting subtest: basic-wb-ro-before-default
[579.412208] Subtest basic-wb-ro-before-default: SUCCESS (5.463s)
[579.625700] [127/133] (451s left) gem_exec_balancer (bonded-dual)
[579.690353] Starting subtest: bonded-dual
[579.695156] Subtest bonded-dual: SKIP (0.000s)
[580.020375] [128/133] (450s left) gem_wait (wait)
[580.094648] Starting subtest: wait
[580.097233] Starting dynamic subtest: all-engines
[581.594352] Dynamic subtest all-engines: SUCCESS (1.498s)
[581.607199] Starting dynamic subtest: rcs0
[582.641517] Dynamic subtest rcs0: SUCCESS (1.046s)
[582.654057] Starting dynamic subtest: bcs0
[583.689361] Dynamic subtest bcs0: SUCCESS (1.046s)
[583.704332] Starting dynamic subtest: vcs0
[584.734774] Dynamic subtest vcs0: SUCCESS (1.043s)
[584.746283] Starting dynamic subtest: vcs1
[585.778641] Dynamic subtest vcs1: SUCCESS (1.042s)
[585.791208] Starting dynamic subtest: vecs0
[586.823616] Dynamic subtest vecs0: SUCCESS (1.043s)
[586.835919] Starting dynamic subtest: ccs0
[587.870552] Dynamic subtest ccs0: SUCCESS (1.045s)
[587.873064] Subtest wait: SUCCESS (7.779s)
[588.084413] [129/133] (442s left) api_intel_bb (crc32)
[588.149170] Starting subtest: crc32
[588.151420] Starting dynamic subtest: rcs0-smem0
[588.451800] Dynamic subtest rcs0-smem0: SUCCESS (0.302s)
[588.468737] Starting dynamic subtest: bcs0-smem0
[588.771297] Dynamic subtest bcs0-smem0: SUCCESS (0.317s)
[588.782046] Starting dynamic subtest: vcs0-smem0
[589.082877] Dynamic subtest vcs0-smem0: SUCCESS (0.309s)
[589.093862] Starting dynamic subtest: vcs1-smem0
[589.432461] Dynamic subtest vcs1-smem0: SUCCESS (0.349s)
[589.444694] Starting dynamic subtest: vecs0-smem0
[589.760372] Dynamic subtest vecs0-smem0: SUCCESS (0.326s)
[589.772684] Starting dynamic subtest: ccs0-smem0
[590.125626] Dynamic subtest ccs0-smem0: SUCCESS (0.362s)
[590.128585] Subtest crc32: SUCCESS (1.978s)
[590.294253] [130/133] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[590.404710] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[597.812409] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.413s)
[597.981145] [131/133] (433s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[598.088220] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[598.092443] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[598.201259] [132/133] (432s left) api_intel_bb (reset-flags)
[598.249840] Starting subtest: reset-flags
[598.254352] Subtest reset-flags: SUCCESS (0.007s)
[598.398301] [133/133] (432s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[598.499253] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[598.504080] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[598.616353] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: gem_create
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_lease
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: prime_mmap
results: parsing output: 14/ for test: kms_chamelium_hpd
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_rotation_crc
results: parsing output: 18/ for test: gem_exec_whisper
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_feature_discovery
results: parsing output: 28/ for test: i915_pm_rps
results: parsing output: 29/ for test: syncobj_basic
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: gem_ccs
results: parsing output: 38/ for test: kms_async_flips
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_sequence
results: parsing output: 51/ for test: kms_vrr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_joiner
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_endless
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: vgem_basic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_pipe_control_store_loop
results: parsing output: 70/ for test: gem_workarounds
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: vgem_basic
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gen7_exec_parse
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: i915_suspend
results: parsing output: 84/ for test: kms_dp_linktrain_fallback
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_chamelium_frames
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: kms_cdclk
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_ctx_shared
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: i915_hangman
results: parsing output: 104/ for test: core_setmaster
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_pipe_stress
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: gem_readwrite
results: parsing output: 121/ for test: kms_prop_blob
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: gem_wait
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: api_intel_bb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.