[56.860937] Initializing watchdogs
[56.860988]   /dev/watchdog0
[56.874114] [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]
[56.878281] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.880462] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.883848] [001/133] (960s left) kms_psr (psr-cursor-mmap-cpu)
[57.012854] Starting subtest: psr-cursor-mmap-cpu
[57.015244] Starting dynamic subtest: eDP-1
[58.707676] Dynamic subtest eDP-1: SUCCESS (1.697s)
[58.709749] Subtest psr-cursor-mmap-cpu: SUCCESS (1.697s)
[59.583335] [002/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[59.686562] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[59.691039] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[59.810569] [003/133] (957s left) prime_vgem (basic-read)
[59.921564] Starting subtest: basic-read
[59.928700] Subtest basic-read: SKIP (0.005s)
[60.039613] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[60.042668] [004/133] (957s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[60.146098] Starting subtest: plane-lut1d-pre-ctm3x4
[60.158597] Starting dynamic subtest: pipe-A-eDP-1
[60.803788] Dynamic subtest pipe-A-eDP-1: FAIL (0.311s)
[61.551635] Starting dynamic subtest: pipe-B-eDP-1
[62.392116] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[62.974462] Starting dynamic subtest: pipe-C-eDP-1
[63.793099] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[64.309982] Starting dynamic subtest: pipe-D-eDP-1
[65.193185] Dynamic subtest pipe-D-eDP-1: FAIL (0.290s)
[65.195242] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.731s)
[65.703520] [005/133] (951s left) gem_create (busy-create)
[65.760342] Starting subtest: busy-create
[65.762759] Starting dynamic subtest: smem0
[98.846739] Dynamic subtest smem0: SUCCESS (33.088s)
[98.849422] Subtest busy-create: SUCCESS (33.089s)
[99.042330] [006/133] (918s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[99.162308] Starting subtest: cursorB-vs-flipA-atomic-transitions
[99.166916] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[99.328060] [007/133] (918s left) gem_mmap_gtt (pf-nonblock)
[99.394286] Subtest pf-nonblock: SKIP (0.000s)
[99.447557] [008/133] (918s left) kms_vblank (ts-continuation-modeset)
[99.555404] Starting subtest: ts-continuation-modeset
[99.557710] Starting dynamic subtest: pipe-A-eDP-1
[101.039670] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.483s)
[101.053261] Starting dynamic subtest: pipe-D-eDP-1
[103.201741] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s)
[103.203798] Subtest ts-continuation-modeset: SUCCESS (3.645s)
[104.013205] [009/133] (913s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[104.114262] Starting subtest: pixel-format-y-tiled-ccs-modifier
[104.140352] Starting dynamic subtest: pipe-A-plane-0
[104.145032] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[104.154202] Starting dynamic subtest: pipe-A-plane-3
[104.158769] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[104.165572] Starting dynamic subtest: pipe-A-plane-5
[104.170163] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[105.291379] Starting dynamic subtest: pipe-B-plane-0
[105.295542] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[105.303989] Starting dynamic subtest: pipe-B-plane-3
[105.308603] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[105.315703] Starting dynamic subtest: pipe-B-plane-5
[105.320338] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[105.605058] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (1.490s)
[106.470902] [010/133] (911s left) prime_vgem (sync)
[106.546081] Starting subtest: sync
[106.548402] Starting dynamic subtest: rcs0
[106.595575] Dynamic subtest rcs0: SUCCESS (0.050s)
[106.603028] Starting dynamic subtest: bcs0
[106.666781] Dynamic subtest bcs0: SUCCESS (0.071s)
[106.673645] Starting dynamic subtest: vcs0
[106.715296] Dynamic subtest vcs0: SUCCESS (0.048s)
[106.722015] Starting dynamic subtest: vcs1
[106.760254] Dynamic subtest vcs1: SUCCESS (0.044s)
[106.766927] Starting dynamic subtest: vecs0
[106.807766] Dynamic subtest vecs0: SUCCESS (0.047s)
[106.814713] Starting dynamic subtest: ccs0
[106.852931] Dynamic subtest ccs0: SUCCESS (0.045s)
[106.855240] Subtest sync: SUCCESS (0.307s)
[106.986509] [011/133] (910s left) kms_lease (atomic-implicit-crtc)
[107.086088] Starting subtest: atomic-implicit-crtc
[107.088382] Starting dynamic subtest: pipe-A-eDP-1
[107.099741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[107.106678] Starting dynamic subtest: pipe-B-eDP-1
[107.118174] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[107.124751] Starting dynamic subtest: pipe-C-eDP-1
[107.135865] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[107.142415] Starting dynamic subtest: pipe-D-eDP-1
[107.153311] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[107.155492] Subtest atomic-implicit-crtc: SUCCESS (0.038s)
[107.255226] [012/133] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[107.345209] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[107.347429] Starting dynamic subtest: pipe-A-eDP-1
[107.369791] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.377293] Starting dynamic subtest: pipe-B-eDP-1
[107.397511] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.403578] Starting dynamic subtest: pipe-C-eDP-1
[107.420904] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.427216] Starting dynamic subtest: pipe-D-eDP-1
[107.444871] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.448231] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[109.557959] [013/133] (908s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[109.685963] Starting subtest: 4-tiled-32bpp-rotate-270
[109.714657] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.028s)
[109.848603] [014/133] (908s left) prime_mmap (test_forked_cpu_write)
[109.910989] Starting subtest: test_forked_cpu_write
[109.912896] Starting dynamic subtest: test_forked_cpu_write-smem
[109.917281] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[109.919629] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[110.032827] [015/133] (907s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[110.418773] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[111.240323] [016/133] (906s left) kms_flip (blocking-wf_vblank)
[111.345440] Starting subtest: blocking-wf_vblank
[111.347748] Starting dynamic subtest: A-eDP1
[120.293950] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[120.300785] Starting dynamic subtest: B-eDP1
[129.226379] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[129.241893] Starting dynamic subtest: C-eDP1
[138.150673] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[138.160148] Starting dynamic subtest: D-eDP1
[147.080547] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[147.086064] Subtest blocking-wf_vblank: SUCCESS (35.743s)
[148.315847] [017/133] (869s left) kms_rotation_crc (primary-rotation-180)
[148.414897] Starting subtest: primary-rotation-180
[155.489137] Subtest primary-rotation-180: SUCCESS (7.075s)
[156.674008] [018/133] (861s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[156.781101] Starting subtest: primary-yf-tiled-reflect-x-270
[156.785374] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[156.869262] [019/133] (861s left) gem_exec_whisper (basic-queues-priority-all)
[156.942862] Starting subtest: basic-queues-priority-all
[179.119170] Subtest basic-queues-priority-all: SUCCESS (22.171s)
[179.312163] [020/133] (838s left) perf_pmu (all-busy-check-all)
[179.349318] Starting subtest: all-busy-check-all
[180.885826] Subtest all-busy-check-all: SUCCESS (1.534s)
[181.008955] [021/133] (837s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[181.122617] Starting subtest: protected-encrypted-src-copy-not-readible
[181.237423] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.117s)
[181.395467] [022/133] (836s left) gem_ctx_persistence (engines-hang)
[181.455802] Starting subtest: engines-hang
[181.458205] Starting dynamic subtest: rcs0
[181.556360] Dynamic subtest rcs0: SUCCESS (0.100s)
[181.566757] Starting dynamic subtest: bcs0
[181.674655] Dynamic subtest bcs0: SUCCESS (0.117s)
[181.685079] Starting dynamic subtest: vcs0
[181.756794] Dynamic subtest vcs0: SUCCESS (0.081s)
[181.767170] Starting dynamic subtest: vcs1
[181.916814] Dynamic subtest vcs1: SUCCESS (0.159s)
[181.927170] Starting dynamic subtest: vecs0
[182.018497] Dynamic subtest vecs0: SUCCESS (0.101s)
[182.028233] Starting dynamic subtest: ccs0
[182.126414] Dynamic subtest ccs0: SUCCESS (0.107s)
[182.128707] Subtest engines-hang: SUCCESS (0.671s)
[182.221970] [023/133] (836s left) kms_flip (2x-dpms-vs-vblank-race)
[182.321967] Starting subtest: 2x-dpms-vs-vblank-race
[182.331088] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[182.463998] [024/133] (835s left) gem_exec_reloc (basic-wc-read-noreloc)
[182.528825] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[182.591409] [025/133] (835s left) perf_pmu (render-node-busy)
[182.670111] Starting subtest: render-node-busy
[182.672208] Starting dynamic subtest: rcs0
[183.236474] Dynamic subtest rcs0: SUCCESS (0.565s)
[183.246813] Starting dynamic subtest: bcs0
[183.809765] Dynamic subtest bcs0: SUCCESS (0.572s)
[183.820496] Starting dynamic subtest: vcs0
[184.915479] Dynamic subtest vcs0: SUCCESS (1.104s)
[184.926908] Starting dynamic subtest: vcs1
[186.900986] Dynamic subtest vcs1: SUCCESS (1.983s)
[186.912419] Starting dynamic subtest: vecs0
[188.884150] Dynamic subtest vecs0: SUCCESS (1.981s)
[188.894406] Starting dynamic subtest: ccs0
[189.449470] Dynamic subtest ccs0: SUCCESS (0.565s)
[189.452081] Subtest render-node-busy: SUCCESS (6.779s)
[189.535916] [026/133] (828s left) kms_cursor_crc (cursor-offscreen-128x42)
[189.749192] Starting subtest: cursor-offscreen-128x42
[189.803159] Subtest cursor-offscreen-128x42: SKIP (0.048s)
[190.032851] [027/133] (828s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[190.145730] Starting subtest: y-tiled-16bpp-rotate-270
[190.150088] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[190.295884] [028/133] (828s left) kms_feature_discovery (display)
[190.391736] Starting subtest: display
[190.393964] Subtest display: SUCCESS (0.000s)
[190.473282] [029/133] (827s left) i915_pm_rps (min-max-config-idle)
[190.521872] Starting subtest: min-max-config-idle
[190.525942] Subtest min-max-config-idle: SKIP (0.000s)
[190.629418] [030/133] (827s left) syncobj_basic (bad-pad-handle-to-fd)
[190.687985] Starting subtest: bad-pad-handle-to-fd
[190.689975] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[190.777114] [031/133] (827s left) kms_psr (fbc-pr-sprite-render)
[190.871647] Starting subtest: fbc-pr-sprite-render
[190.875504] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[190.976478] [032/133] (827s left) kms_psr (fbc-psr-primary-mmap-gtt)
[191.071712] Starting subtest: fbc-psr-primary-mmap-gtt
[191.073764] Starting dynamic subtest: eDP-1
[191.077351] Dynamic subtest eDP-1: SKIP (0.000s)
[191.080889] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[191.166645] [033/133] (827s left) gem_exec_reloc (basic-cpu-gtt-active)
[191.220971] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[191.304468] [034/133] (827s left) kms_cursor_edge_walk (256x256-top-bottom)
[191.406516] Starting subtest: 256x256-top-bottom
[191.408499] Starting dynamic subtest: pipe-A-eDP-1
[194.820806] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[194.830180] Starting dynamic subtest: pipe-D-eDP-1
[197.929917] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[197.932264] Subtest 256x256-top-bottom: SUCCESS (6.524s)
[198.753498] [035/133] (819s left) gem_exec_fence (basic-busy-all)
[198.825404] Starting subtest: basic-busy-all
[198.943405] Subtest basic-busy-all: SUCCESS (0.119s)
[201.014882] [036/133] (817s left) kms_pm_rpm (legacy-planes-dpms)
[203.044036] Starting subtest: legacy-planes-dpms
[203.046489] Starting dynamic subtest: plane-64
[211.663818] Dynamic subtest plane-64: SUCCESS (8.623s)
[211.674171] Starting dynamic subtest: plane-94
[219.968818] Dynamic subtest plane-94: SUCCESS (8.302s)
[219.980023] Starting dynamic subtest: plane-124
[228.280455] Dynamic subtest plane-124: SUCCESS (8.309s)
[228.292631] Starting dynamic subtest: plane-134
[236.562061] Dynamic subtest plane-134: SUCCESS (8.280s)
[236.564596] Subtest legacy-planes-dpms: SUCCESS (33.523s)
[236.944135] [037/133] (781s left) gem_softpin (evict-active-interruptible)
[237.014751] Starting subtest: evict-active-interruptible
[237.018869] Subtest evict-active-interruptible: SUCCESS (0.006s)
[237.161764] [038/133] (781s left) gem_ccs (block-multicopy-inplace)
[237.223725] Starting subtest: block-multicopy-inplace
[237.228041] Subtest block-multicopy-inplace: SKIP (0.000s)
[237.349811] [039/133] (781s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[237.452019] Starting subtest: async-flip-with-page-flip-events-linear
[237.839774] Starting dynamic subtest: pipe-A-eDP-1
[240.603787] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.763s)
[240.978744] Starting dynamic subtest: pipe-B-eDP-1
[243.725992] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[244.097851] Starting dynamic subtest: pipe-C-eDP-1
[246.854866] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[247.215223] Starting dynamic subtest: pipe-D-eDP-1
[249.988707] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[249.991401] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.538s)
[251.192207] [040/133] (767s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[251.297987] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[251.300323] Starting dynamic subtest: pipe-A
[251.317953] Dynamic subtest pipe-A: SKIP (0.015s)
[251.326918] Starting dynamic subtest: pipe-B
[251.344271] Dynamic subtest pipe-B: SKIP (0.027s)
[251.352340] Starting dynamic subtest: pipe-C
[251.372478] Dynamic subtest pipe-C: SKIP (0.027s)
[251.380513] Starting dynamic subtest: pipe-D
[251.401348] Dynamic subtest pipe-D: SKIP (0.027s)
[251.405758] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.099s)
[251.525286] [041/133] (767s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[251.624105] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[251.626405] Starting dynamic subtest: pipe-A-eDP-1
[251.651558] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.661915] Starting dynamic subtest: pipe-B-eDP-1
[251.685660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.693456] Starting dynamic subtest: pipe-C-eDP-1
[251.717045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.724972] Starting dynamic subtest: pipe-D-eDP-1
[251.748880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.752959] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[253.868964] [042/133] (765s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[253.973271] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[253.998802] Starting dynamic subtest: pipe-A-plane-0
[254.003380] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[254.013373] Starting dynamic subtest: pipe-A-plane-3
[254.017934] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[254.025842] Starting dynamic subtest: pipe-A-plane-5
[254.030329] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[255.136532] Starting dynamic subtest: pipe-B-plane-0
[255.140881] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[255.149047] Starting dynamic subtest: pipe-B-plane-3
[255.153526] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[255.161479] Starting dynamic subtest: pipe-B-plane-5
[255.165969] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[255.457693] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.474s)
[256.348233] [043/133] (762s left) syncobj_timeline (single-wait-for-submit-signaled)
[256.401374] Starting subtest: single-wait-for-submit-signaled
[256.403873] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[256.533412] [044/133] (762s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[256.636319] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[256.647873] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[256.773159] [045/133] (762s left) kms_addfb_basic (bad-pitch-63)
[256.833682] Starting subtest: bad-pitch-63
[256.836051] Subtest bad-pitch-63: SUCCESS (0.000s)
[257.009076] [046/133] (762s left) gem_exec_flush (basic-wb-prw-default)
[257.071526] Starting subtest: basic-wb-prw-default
[262.545781] Subtest basic-wb-prw-default: SUCCESS (5.475s)
[262.741734] [047/133] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[262.846666] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[262.851106] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[262.965229] [048/133] (756s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[263.088321] Starting subtest: basic-flip-after-cursor-legacy
[264.004056] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.916s)
[264.853936] [049/133] (754s left) gem_mmap_gtt (basic-wc)
[264.920072] Subtest basic-wc: SKIP (0.000s)
[264.972786] [050/133] (754s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[265.032087] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[265.095381] [051/133] (754s left) kms_sequence (queue-busy)
[265.189076] Starting subtest: queue-busy
[265.191418] Starting dynamic subtest: pipe-A-eDP-1
[267.120877] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[267.131935] Starting dynamic subtest: pipe-B-eDP-1
[269.745018] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s)
[269.754684] Starting dynamic subtest: pipe-C-eDP-1
[272.327635] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.584s)
[272.337521] Starting dynamic subtest: pipe-D-eDP-1
[274.864356] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[274.866661] Subtest queue-busy: SUCCESS (9.676s)
[275.658728] [052/133] (743s left) kms_vrr (negative-basic)
[275.749008] Starting subtest: negative-basic
[275.755399] Starting dynamic subtest: pipe-A-eDP-1
[281.175064] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.417s)
[281.464536] Subtest negative-basic: SUCCESS (5.714s)
[282.291997] [053/133] (737s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[282.390248] Starting subtest: x-tiled-32bpp-rotate-90
[282.409406] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[282.567055] [054/133] (736s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[282.664615] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[282.666973] Starting dynamic subtest: pipe-A-eDP-1
[282.761775] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[282.771854] Starting dynamic subtest: pipe-B-eDP-1
[283.859352] Dynamic subtest pipe-B-eDP-1: SKIP (1.095s)
[283.863836] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.196s)
[285.158146] [055/133] (734s left) gem_mmap_gtt (basic-small-copy-odd)
[285.221904] Subtest basic-small-copy-odd: SKIP (0.000s)
[285.286551] [056/133] (734s left) kms_joiner (basic-force-big-joiner)
[285.377345] Starting subtest: basic-force-big-joiner
[285.381542] Subtest basic-force-big-joiner: SKIP (0.000s)
[285.472852] [057/133] (734s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[285.539153] Starting subtest: yf-tiled-to-vebox-y-tiled
[285.543472] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[285.741520] [058/133] (733s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[285.835900] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[285.838184] Starting dynamic subtest: pipe-A-default-mode
[287.007127] Dynamic subtest pipe-A-default-mode: SKIP (1.169s)
[287.011665] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.171s)
[287.181561] [059/133] (732s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[287.294831] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[287.929690] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.636s)
[288.113922] [060/133] (731s left) gem_mmap_wc (close)
[288.172540] Subtest close: SKIP (0.000s)
[288.234884] [061/133] (731s left) gen9_exec_parse (shadow-peek)
[288.291409] Subtest shadow-peek: SKIP (0.000s)
[288.375572] [062/133] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[288.474382] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[297.015528] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.542s)
[297.149293] [063/133] (722s left) gem_exec_endless (dispatch)
[297.224662] Starting subtest: dispatch
[297.226652] Starting dynamic subtest: rcs0
[297.232188] Dynamic subtest rcs0: SUCCESS (0.009s)
[297.245716] Starting dynamic subtest: bcs0
[297.250576] Dynamic subtest bcs0: SUCCESS (0.008s)
[297.263894] Starting dynamic subtest: vcs0
[297.268683] Dynamic subtest vcs0: SUCCESS (0.007s)
[297.278914] Starting dynamic subtest: vcs1
[297.283374] Dynamic subtest vcs1: SUCCESS (0.005s)
[297.291776] Starting dynamic subtest: vecs0
[297.296202] Dynamic subtest vecs0: SUCCESS (0.005s)
[297.303770] Starting dynamic subtest: ccs0
[297.308201] Dynamic subtest ccs0: SUCCESS (0.004s)
[297.310352] Subtest dispatch: SUCCESS (0.045s)
[298.951431] [064/133] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[299.060517] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[299.064813] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[299.180019] [065/133] (720s left) vgem_basic (dmabuf-fence)
[299.220130] Starting subtest: dmabuf-fence
[299.222374] Subtest dmabuf-fence: SUCCESS (0.000s)
[299.286591] [066/133] (720s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[299.386355] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[303.500934] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.119s)
[304.626736] [067/133] (715s left) gem_exec_schedule (reorder-wide)
[304.818280] Subtest reorder-wide: SKIP (0.000s)
[305.006366] [068/133] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[305.115398] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[305.119414] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[305.233993] [069/133] (714s left) kms_pm_rpm (basic-pci-d3-state)
[307.060927] Starting subtest: basic-pci-d3-state
[308.527571] Subtest basic-pci-d3-state: SUCCESS (1.470s)
[308.635184] [070/133] (711s left) gem_pipe_control_store_loop (reused-buffer)
[308.695168] Starting subtest: reused-buffer
[310.850557] Subtest reused-buffer: SUCCESS (2.153s)
[311.025096] [071/133] (709s left) gem_workarounds (suspend-resume-fd)
[311.094686] Starting subtest: suspend-resume-fd
[327.240430] Subtest suspend-resume-fd: SUCCESS (1.350s)
[328.394625] [072/133] (692s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[328.971101] Starting subtest: syncobj-stationary-timeline-chain-engines
[329.053459] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.083s)
[330.850526] [073/133] (690s left) gem_ctx_persistence (processes)
[330.919658] Starting subtest: processes
[332.728537] Subtest processes: SUCCESS (1.817s)
[332.818707] [074/133] (688s left) gem_exec_params (cliprects-invalid)
[332.885465] Starting subtest: cliprects-invalid
[332.887756] Subtest cliprects-invalid: SUCCESS (0.000s)
[333.017083] [075/133] (688s left) gem_exec_schedule (u-submit-late-slice)
[333.093582] Starting subtest: u-submit-late-slice
[333.095906] Starting dynamic subtest: rcs0
[333.141706] Dynamic subtest rcs0: SUCCESS (0.055s)
[333.153595] Starting dynamic subtest: bcs0
[333.180343] Dynamic subtest bcs0: SUCCESS (0.038s)
[333.190346] Starting dynamic subtest: vcs0
[333.235591] Dynamic subtest vcs0: SUCCESS (0.054s)
[333.250164] Starting dynamic subtest: vcs1
[333.284514] Dynamic subtest vcs1: SUCCESS (0.048s)
[333.297594] Starting dynamic subtest: vecs0
[333.330973] Dynamic subtest vecs0: SUCCESS (0.046s)
[333.340157] Starting dynamic subtest: ccs0
[333.416836] Dynamic subtest ccs0: SUCCESS (0.084s)
[333.419888] Subtest u-submit-late-slice: SUCCESS (0.332s)
[334.816414] [076/133] (686s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[334.921280] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[334.925650] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[335.027281] [077/133] (686s left) vgem_basic (bad-flag)
[335.071983] Starting subtest: bad-flag
[335.074180] Subtest bad-flag: SUCCESS (0.000s)
[335.141566] [078/133] (686s left) syncobj_timeline (invalid-signal-zero-handles)
[335.208628] Starting subtest: invalid-signal-zero-handles
[335.210962] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[335.325834] [079/133] (686s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[335.426870] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[336.513262] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.091s)
[336.655650] [080/133] (684s left) gen7_exec_parse (basic-offset)
[336.728152] Subtest basic-offset: SKIP (0.000s)
[336.798270] [081/133] (684s left) gem_exec_params (rs-invalid)
[336.849553] Starting subtest: rs-invalid
[336.853612] Subtest rs-invalid: SUCCESS (0.003s)
[337.006803] [082/133] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[337.115538] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[344.494157] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.396s)
[344.664981] [083/133] (676s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[344.724395] Starting subtest: multi-wait-all-for-submit-submitted
[344.829115] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[344.918298] [084/133] (676s left) i915_suspend (fence-restore-untiled)
[344.973892] Starting subtest: fence-restore-untiled
[344.978363] Subtest fence-restore-untiled: SKIP (0.000s)
[345.075018] [085/133] (676s left) kms_dp_linktrain_fallback (dp-fallback)
[345.173131] Starting subtest: dp-fallback
[345.179524] Subtest dp-fallback: SKIP (0.000s)
[345.255749] [086/133] (676s left) kms_async_flips (invalid-async-flip)
[345.355605] Starting subtest: invalid-async-flip
[345.729911] Starting dynamic subtest: pipe-A-eDP-1
[346.580270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[346.937681] Starting dynamic subtest: pipe-B-eDP-1
[347.711619] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[348.066540] Starting dynamic subtest: pipe-C-eDP-1
[348.825298] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[349.177460] Starting dynamic subtest: pipe-D-eDP-1
[349.957237] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.788s)
[349.959555] Subtest invalid-async-flip: SUCCESS (4.609s)
[351.129312] [087/133] (670s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[351.221683] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[357.996789] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.782s)
[358.145662] [088/133] (663s left) kms_chamelium_frames (dp-crc-multiple)
[358.537747] Subtest dp-crc-multiple: SKIP (0.000s)
[359.327001] [089/133] (662s left) gem_mmap_gtt (basic-small-copy-xy)
[359.381668] Subtest basic-small-copy-XY: SKIP (0.000s)
[359.452902] [090/133] (662s left) kms_cdclk (plane-scaling)
[359.543019] Starting subtest: plane-scaling
[359.545237] Starting dynamic subtest: pipe-A-eDP-1
[359.830055] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[359.839903] Starting dynamic subtest: pipe-B-eDP-1
[359.844127] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[359.853306] Starting dynamic subtest: pipe-C-eDP-1
[359.857679] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[359.867038] Starting dynamic subtest: pipe-D-eDP-1
[359.871306] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[359.875478] Subtest plane-scaling: SKIP (0.293s)
[360.684204] [091/133] (661s left) syncobj_timeline (multi-wait-available-submitted)
[360.756415] Starting subtest: multi-wait-available-submitted
[360.758695] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[360.876311] [092/133] (661s left) gem_ctx_shared (q-smoketest-all)
[360.944139] Starting subtest: Q-smoketest-all
[393.327844] Subtest Q-smoketest-all: SUCCESS (32.339s)
[394.777514] [093/133] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[394.878956] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[394.883024] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[394.987265] [094/133] (627s left) kms_psr (pr-basic)
[395.089549] Starting subtest: pr-basic
[395.093759] Subtest pr-basic: SKIP (0.000s)
[395.184216] [095/133] (626s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[395.288790] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[395.293166] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[395.429313] [096/133] (626s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[395.581844] Starting subtest: dp-mst-lic-type-0-hdcp14
[395.586281] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[395.755203] [097/133] (626s left) kms_rotation_crc (multiplane-rotation)
[395.848107] Starting subtest: multiplane-rotation
[413.245453] Subtest multiplane-rotation: SUCCESS (17.404s)
[413.379339] [098/133] (608s left) perf (sysctl-defaults)
[413.466586] Starting subtest: sysctl-defaults
[413.468596] Subtest sysctl-defaults: SUCCESS (0.000s)
[413.557424] [099/133] (608s left) sw_sync (timeline_closed)
[413.592015] Starting subtest: timeline_closed
[413.593968] Subtest timeline_closed: SUCCESS (0.000s)
[413.657326] [100/133] (608s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[413.758920] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[413.760725] Starting dynamic subtest: pipe-A-eDP-1
[413.777300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[413.787849] Starting dynamic subtest: pipe-B-eDP-1
[413.803784] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[413.812876] Starting dynamic subtest: pipe-C-eDP-1
[413.828119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[413.836979] Starting dynamic subtest: pipe-D-eDP-1
[413.852469] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[413.854235] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[415.941158] [101/133] (606s left) gem_spin_batch (spin-all)
[416.007641] Starting subtest: spin-all
[416.019568] Subtest spin-all: SUCCESS (0.011s)
[417.750958] [102/133] (604s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[417.838082] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[417.842389] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[417.928544] [103/133] (604s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[418.039687] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[418.169317] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.131s)
[418.326128] [104/133] (604s left) i915_hangman (gt-error-state-capture)
[418.385990] Starting subtest: gt-error-state-capture
[418.388447] Starting dynamic subtest: rcs0
[429.695838] Dynamic subtest rcs0: SUCCESS (11.308s)
[429.708828] Starting dynamic subtest: bcs0
[441.663257] Dynamic subtest bcs0: SUCCESS (11.961s)
[441.675844] Starting dynamic subtest: vcs0
[453.630041] Dynamic subtest vcs0: SUCCESS (11.963s)
[453.647587] Starting dynamic subtest: vcs1
[464.640474] Dynamic subtest vcs1: SUCCESS (11.007s)
[464.653057] Starting dynamic subtest: vecs0
[476.607530] Dynamic subtest vecs0: SUCCESS (11.965s)
[476.619846] Starting dynamic subtest: ccs0
[487.678186] Dynamic subtest ccs0: SUCCESS (11.070s)
[487.680953] Subtest gt-error-state-capture: SUCCESS (69.290s)
[487.797464] [105/133] (534s left) core_setmaster (master-drop-set-root)
[487.884606] Starting subtest: master-drop-set-root
[487.896463] Subtest master-drop-set-root: SUCCESS (0.013s)
[487.944069] [106/133] (534s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[488.044306] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[488.048409] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[488.160049] [107/133] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[488.273544] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[488.278262] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[488.406630] [108/133] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[488.510753] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[488.515044] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.637381] [109/133] (534s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[488.749625] Starting subtest: stress-xrgb8888-ytiled
[488.753382] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[488.842715] [110/133] (533s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[488.886958] Starting subtest: multi-wait-for-submit-unsubmitted
[488.996367] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[489.084331] [111/133] (533s left) kms_flip (2x-nonexisting-fb-interruptible)
[489.183049] Starting subtest: 2x-nonexisting-fb-interruptible
[489.194309] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[489.312471] [112/133] (533s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[489.375640] Starting subtest: etime-single-wait-available-unsubmitted
[489.476963] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s)
[489.569848] [113/133] (533s left) syncobj_timeline (device-submit-unordered)
[489.630432] Starting subtest: device-submit-unordered
[489.632837] Subtest device-submit-unordered: SUCCESS (0.000s)
[489.751353] [114/133] (533s left) gem_exec_schedule (manyslice)
[489.824091] Starting subtest: manyslice
[489.826425] Starting dynamic subtest: rcs0
[494.926081] Dynamic subtest rcs0: SUCCESS (5.112s)
[494.945251] Starting dynamic subtest: bcs0
[501.562971] Dynamic subtest bcs0: SUCCESS (6.636s)
[501.574462] Starting dynamic subtest: vcs0
[507.141213] Dynamic subtest vcs0: SUCCESS (5.578s)
[507.152496] Starting dynamic subtest: vcs1
[512.203063] Dynamic subtest vcs1: SUCCESS (5.063s)
[512.215306] Starting dynamic subtest: vecs0
[518.275932] Dynamic subtest vecs0: SUCCESS (6.073s)
[518.289375] Starting dynamic subtest: ccs0
[524.442325] Dynamic subtest ccs0: SUCCESS (6.167s)
[524.445023] Subtest manyslice: SUCCESS (34.638s)
[524.755175] [115/133] (498s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[524.863536] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[524.868014] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[525.964615] [116/133] (497s left) kms_cursor_crc (cursor-size-hints)
[526.092468] Starting subtest: cursor-size-hints
[526.094735] Starting dynamic subtest: pipe-A-eDP-1
[526.718768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[526.728639] Starting dynamic subtest: pipe-D-eDP-1
[528.004540] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[528.006812] Subtest cursor-size-hints: SUCCESS (1.913s)
[528.829668] [117/133] (494s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[528.925187] Starting subtest: fbc-1p-pri-indfb-multidraw
[541.934907] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.017s)
[543.336026] [118/133] (479s left) kms_plane_scaling (planes-downscale-factor-0-5)
[543.441844] Starting subtest: planes-downscale-factor-0-5
[543.444061] Starting dynamic subtest: pipe-A
[543.461663] Dynamic subtest pipe-A: SKIP (0.017s)
[543.472049] Starting dynamic subtest: pipe-B
[543.492404] Dynamic subtest pipe-B: SKIP (0.029s)
[543.502080] Starting dynamic subtest: pipe-C
[543.519600] Dynamic subtest pipe-C: SKIP (0.029s)
[543.529102] Starting dynamic subtest: pipe-D
[543.548919] Dynamic subtest pipe-D: SKIP (0.029s)
[543.553272] Subtest planes-downscale-factor-0-5: SKIP (0.105s)
[543.684080] [119/133] (479s left) prime_vgem (basic-fence-read)
[543.769997] Starting subtest: basic-fence-read
[543.789644] Subtest basic-fence-read: SKIP (0.017s)
[543.930503] [120/133] (479s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[544.033604] Starting subtest: psr2-plane-move-sf-dmg-area
[544.035944] Starting dynamic subtest: pipe-A-eDP-1
[548.551498] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.523s)
[548.562110] Starting dynamic subtest: pipe-B-eDP-1
[553.854318] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.300s)
[553.856599] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.826s)
[554.759152] [121/133] (468s left) gem_readwrite (read-write)
[554.829638] Subtest read-write: SKIP (0.000s)
[554.900112] [122/133] (468s left) kms_prop_blob (invalid-set-prop)
[554.959487] Starting subtest: invalid-set-prop
[554.961847] Subtest invalid-set-prop: SUCCESS (0.000s)
[555.068001] [123/133] (468s left) kms_flip (2x-flip-vs-panning-interruptible)
[555.176985] Starting subtest: 2x-flip-vs-panning-interruptible
[555.188465] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[555.321251] [124/133] (468s left) gem_exec_reloc (basic-wc-active)
[555.384334] Subtest basic-wc-active: SKIP (0.000s)
[555.451504] [125/133] (467s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[555.549119] Starting subtest: psr-rgb101010-draw-render
[562.769996] Subtest psr-rgb101010-draw-render: SUCCESS (7.221s)
[562.903263] [126/133] (460s left) gem_exec_flush (basic-wb-ro-before-default)
[562.966117] Starting subtest: basic-wb-ro-before-default
[568.423313] Subtest basic-wb-ro-before-default: SUCCESS (5.454s)
[568.617804] [127/133] (454s left) gem_exec_balancer (bonded-dual)
[568.683752] Starting subtest: bonded-dual
[568.688500] Subtest bonded-dual: SKIP (0.000s)
[569.029117] [128/133] (454s left) gem_wait (wait)
[569.094225] Starting subtest: wait
[569.096719] Starting dynamic subtest: all-engines
[570.720407] Dynamic subtest all-engines: SUCCESS (1.623s)
[570.733578] Starting dynamic subtest: rcs0
[571.766410] Dynamic subtest rcs0: SUCCESS (1.045s)
[571.779424] Starting dynamic subtest: bcs0
[572.813161] Dynamic subtest bcs0: SUCCESS (1.044s)
[572.825353] Starting dynamic subtest: vcs0
[573.858118] Dynamic subtest vcs0: SUCCESS (1.042s)
[573.871179] Starting dynamic subtest: vcs1
[574.901872] Dynamic subtest vcs1: SUCCESS (1.041s)
[574.914695] Starting dynamic subtest: vecs0
[575.946240] Dynamic subtest vecs0: SUCCESS (1.042s)
[575.958903] Starting dynamic subtest: ccs0
[576.994458] Dynamic subtest ccs0: SUCCESS (1.046s)
[576.997123] Subtest wait: SUCCESS (7.899s)
[577.210773] [129/133] (446s left) api_intel_bb (crc32)
[577.270793] Starting subtest: crc32
[577.273099] Starting dynamic subtest: rcs0-smem0
[577.546499] Dynamic subtest rcs0-smem0: SUCCESS (0.274s)
[577.560598] Starting dynamic subtest: bcs0-smem0
[577.868317] Dynamic subtest bcs0-smem0: SUCCESS (0.320s)
[577.882046] Starting dynamic subtest: vcs0-smem0
[578.216901] Dynamic subtest vcs0-smem0: SUCCESS (0.347s)
[578.234339] Starting dynamic subtest: vcs1-smem0
[578.513964] Dynamic subtest vcs1-smem0: SUCCESS (0.294s)
[578.526518] Starting dynamic subtest: vecs0-smem0
[578.784953] Dynamic subtest vecs0-smem0: SUCCESS (0.269s)
[578.797945] Starting dynamic subtest: ccs0-smem0
[579.096368] Dynamic subtest ccs0-smem0: SUCCESS (0.308s)
[579.099004] Subtest crc32: SUCCESS (1.825s)
[579.243062] [130/133] (444s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[579.355481] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[586.677665] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.322s)
[586.834265] [131/133] (436s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[586.940582] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[586.944557] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[587.040452] [132/133] (436s left) api_intel_bb (reset-flags)
[587.089204] Starting subtest: reset-flags
[587.093792] Subtest reset-flags: SUCCESS (0.007s)
[587.244566] [133/133] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[587.353594] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[587.357695] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[587.457208] 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.