[61.223830] Initializing watchdogs
[61.223874]   /dev/watchdog0
[61.237432] [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]
[61.241852] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.243953] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.247295] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[61.387242] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[61.391185] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[61.527905] [002/133] (960s left) gem_bad_reloc (negative-reloc-bltcopy)
[61.605093] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[61.693633] [003/133] (960s left) gem_exec_params (invalid-fence-in-submit)
[61.759378] Starting subtest: invalid-fence-in-submit
[61.761996] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[61.896750] [004/133] (959s left) kms_plane (pixel-format-linear-modifier)
[61.985271] Starting subtest: pixel-format-linear-modifier
[62.023948] Starting dynamic subtest: pipe-A-plane-0
[65.556859] Dynamic subtest pipe-A-plane-0: SUCCESS (3.533s)
[65.564575] Starting dynamic subtest: pipe-A-plane-3
[67.345673] Dynamic subtest pipe-A-plane-3: SUCCESS (1.788s)
[67.352511] Starting dynamic subtest: pipe-A-plane-5
[67.579264] Dynamic subtest pipe-A-plane-5: SUCCESS (0.232s)
[68.658827] Starting dynamic subtest: pipe-B-plane-0
[72.163898] Dynamic subtest pipe-B-plane-0: SUCCESS (3.511s)
[72.180231] Starting dynamic subtest: pipe-B-plane-3
[73.798646] Dynamic subtest pipe-B-plane-3: SUCCESS (1.632s)
[73.813448] Starting dynamic subtest: pipe-B-plane-5
[74.007566] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[74.322796] Subtest pixel-format-linear-modifier: SUCCESS (12.335s)
[75.138189] [005/133] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[75.240758] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[79.684828] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.448s)
[80.867558] [006/133] (941s left) gem_exec_schedule (pi-shared-iova)
[81.071897] Starting subtest: pi-shared-iova
[81.074343] Starting dynamic subtest: rcs0
[81.142146] Dynamic subtest rcs0: SUCCESS (0.072s)
[81.153857] Starting dynamic subtest: vcs0
[81.188845] Dynamic subtest vcs0: SUCCESS (0.047s)
[81.199785] Starting dynamic subtest: vcs1
[81.236507] Dynamic subtest vcs1: SUCCESS (0.048s)
[81.252149] Starting dynamic subtest: vecs0
[81.284106] Dynamic subtest vecs0: SUCCESS (0.047s)
[81.295186] Starting dynamic subtest: ccs0
[81.337540] Dynamic subtest ccs0: SUCCESS (0.053s)
[81.340067] Subtest pi-shared-iova: SUCCESS (0.268s)
[83.038568] [007/133] (938s left) gem_mmap_gtt (basic-write-read)
[83.103704] Subtest basic-write-read: SKIP (0.000s)
[83.165112] [008/133] (938s left) kms_flip (flip-vs-rmfb)
[83.263481] Starting subtest: flip-vs-rmfb
[83.266266] Starting dynamic subtest: A-eDP1
[91.946783] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[91.955918] Starting dynamic subtest: B-eDP1
[100.572465] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[100.581123] Starting dynamic subtest: C-eDP1
[109.184603] Dynamic subtest C-eDP1: SUCCESS (8.611s)
[109.196094] Starting dynamic subtest: D-eDP1
[117.808202] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[117.812386] Subtest flip-vs-rmfb: SUCCESS (34.552s)
[118.999591] [009/133] (903s left) gem_exec_whisper (basic-contexts-priority)
[119.067770] Starting subtest: basic-contexts-priority
[142.489942] Subtest basic-contexts-priority: SUCCESS (23.421s)
[142.681236] [010/133] (879s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[142.779072] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[142.783333] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[142.889126] [011/133] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[142.972029] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[142.976083] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.090919] [012/133] (879s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[143.152324] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[143.258016] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[143.342546] [013/133] (878s left) kms_content_protection (atomic-hdcp14)
[143.486396] Starting subtest: atomic-hdcp14
[143.491092] Subtest atomic-hdcp14: SKIP (0.000s)
[143.623423] [014/133] (878s left) gem_flink_race (flink_close)
[143.661374] Starting subtest: flink_close
[148.772006] Subtest flink_close: SUCCESS (5.109s)
[148.861279] [015/133] (873s left) tools_test (sysfs_l3_parity)
[148.911316] Starting subtest: sysfs_l3_parity
[148.973571] Subtest sysfs_l3_parity: SKIP (0.073s)
[149.052028] [016/133] (873s left) kms_cdclk (plane-scaling)
[149.147920] Starting subtest: plane-scaling
[149.150145] Starting dynamic subtest: pipe-A-eDP-1
[149.435185] Dynamic subtest pipe-A-eDP-1: SKIP (0.283s)
[149.443316] Starting dynamic subtest: pipe-B-eDP-1
[149.447725] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[149.455607] Starting dynamic subtest: pipe-C-eDP-1
[149.460096] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[149.467710] Starting dynamic subtest: pipe-D-eDP-1
[149.472163] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[149.476500] Subtest plane-scaling: SKIP (0.292s)
[150.311396] [017/133] (872s left) kms_psr (pr-sprite-mmap-cpu)
[150.412428] Starting subtest: pr-sprite-mmap-cpu
[150.417615] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[150.550761] [018/133] (871s left) i915_pm_rpm (system-suspend-devices)
[152.088094] Starting subtest: system-suspend-devices
[159.929065] Subtest system-suspend-devices: SUCCESS (7.840s)
[160.315426] [019/133] (862s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[160.419850] Starting subtest: fbc-rgb565-draw-blt
[164.557668] Subtest fbc-rgb565-draw-blt: SUCCESS (4.141s)
[165.699815] [020/133] (856s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[165.795709] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[169.791216] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.999s)
[171.005138] [021/133] (851s left) kms_cursor_edge_walk (256x256-top-edge)
[171.098203] Starting subtest: 256x256-top-edge
[171.100494] Starting dynamic subtest: pipe-A-eDP-1
[174.552170] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[174.561538] Starting dynamic subtest: pipe-D-eDP-1
[177.660060] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s)
[177.662298] Subtest 256x256-top-edge: SUCCESS (6.564s)
[178.481422] [022/133] (844s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[178.602544] Starting subtest: cursorA-vs-flipB-atomic-transitions
[178.607054] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[178.768780] [023/133] (843s left) gem_ctx_engines (execute-one)
[178.826705] Starting subtest: execute-one
[181.020167] Subtest execute-one: SUCCESS (2.194s)
[181.210799] [024/133] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[181.324651] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[181.328810] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[181.467868] [025/133] (841s left) gem_exec_reloc (basic-wc-read-noreloc)
[181.535586] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[181.616928] [026/133] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[181.721483] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[181.725950] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[181.836321] [027/133] (840s left) kms_plane (plane-panning-bottom-right-suspend)
[181.926069] Starting subtest: plane-panning-bottom-right-suspend
[181.928265] Starting dynamic subtest: pipe-A
[199.781831] Dynamic subtest pipe-A: SUCCESS (2.910s)
[199.790521] Starting dynamic subtest: pipe-B
[217.752112] Dynamic subtest pipe-B: SUCCESS (3.373s)
[217.754385] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.286s)
[218.571828] [028/133] (804s left) kms_big_fb (y-tiled-addfb-size-overflow)
[218.672428] Starting subtest: y-tiled-addfb-size-overflow
[218.676945] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[218.781528] [029/133] (804s left) gem_exec_async (concurrent-writes)
[218.846225] Starting subtest: concurrent-writes
[218.848451] Starting dynamic subtest: rcs0
[218.858913] Dynamic subtest rcs0: SUCCESS (0.015s)
[218.868082] Starting dynamic subtest: bcs0
[218.870353] Dynamic subtest bcs0: SUCCESS (0.008s)
[218.879489] Starting dynamic subtest: vcs0
[218.881712] Dynamic subtest vcs0: SUCCESS (0.005s)
[218.890183] Starting dynamic subtest: vcs1
[218.892380] Dynamic subtest vcs1: SUCCESS (0.005s)
[218.900598] Starting dynamic subtest: vecs0
[218.902517] Dynamic subtest vecs0: SUCCESS (0.006s)
[218.910356] Starting dynamic subtest: ccs0
[218.912266] Dynamic subtest ccs0: SUCCESS (0.005s)
[218.914168] Subtest concurrent-writes: SUCCESS (0.048s)
[219.152713] [030/133] (803s left) kms_addfb_basic (unused-pitches)
[219.211990] Starting subtest: unused-pitches
[219.213962] Subtest unused-pitches: SUCCESS (0.000s)
[219.361864] [031/133] (803s left) api_intel_bb (delta-check)
[219.410642] Starting subtest: delta-check
[219.412842] Subtest delta-check: SUCCESS (0.005s)
[219.524389] [032/133] (803s left) gem_watchdog (default-virtual)
[219.597490] Starting subtest: default-virtual
[225.875517] Subtest default-virtual: SUCCESS (6.275s)
[225.977840] [033/133] (797s left) prime_mmap (test_errors)
[226.039090] Starting subtest: test_errors
[226.041156] Starting dynamic subtest: test_errors-smem
[226.127972] Dynamic subtest test_errors-smem: SUCCESS (0.090s)
[226.130583] Subtest test_errors: SUCCESS (0.091s)
[226.277446] [034/133] (796s left) vgem_basic (bad-handle)
[226.372038] Starting subtest: bad-handle
[226.374339] Subtest bad-handle: SUCCESS (0.000s)
[226.441168] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[226.444331] [035/133] (796s left) kms_plane_lowres (tiling-x)
[226.546249] Starting subtest: tiling-x
[226.548549] Starting dynamic subtest: pipe-A-eDP-1
[226.553130] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[226.837273] Starting dynamic subtest: pipe-B-eDP-1
[226.841746] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[226.850039] Starting dynamic subtest: pipe-C-eDP-1
[226.854521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[226.862614] Starting dynamic subtest: pipe-D-eDP-1
[226.866998] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[226.871245] Subtest tiling-x: SKIP (0.291s)
[227.706312] [036/133] (795s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[227.830792] Starting subtest: flip-vs-cursor-varying-size
[236.297689] Subtest flip-vs-cursor-varying-size: SUCCESS (8.460s)
[237.138957] [037/133] (786s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[237.249051] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[237.251220] Starting dynamic subtest: pipe-A-eDP-1
[243.117661] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.870s)
[243.127155] Starting dynamic subtest: pipe-B-eDP-1
[249.772980] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.653s)
[249.775238] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.526s)
[250.662465] [038/133] (772s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[250.731069] Starting subtest: framebuffer-vs-set-tiling
[250.735536] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[250.878065] [039/133] (772s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[251.004886] Starting subtest: verify-pxp-execution-after-suspend-resume
[258.081836] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.076s)
[258.222089] [040/133] (765s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[258.339314] Starting subtest: x-tiled-64bpp-rotate-180
[259.862195] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.523s)
[260.039560] [041/133] (763s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[260.106880] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[260.211860] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[260.299421] [042/133] (763s left) gem_softpin (allocator-basic)
[260.362787] Starting subtest: allocator-basic
[260.429331] Subtest allocator-basic: SUCCESS (0.065s)
[260.605723] [043/133] (762s left) perf_pmu (render-node-busy-idle)
[260.683333] Starting subtest: render-node-busy-idle
[260.685814] Starting dynamic subtest: rcs0
[261.368523] Dynamic subtest rcs0: SUCCESS (0.684s)
[261.380181] Starting dynamic subtest: bcs0
[262.035180] Dynamic subtest bcs0: SUCCESS (0.665s)
[262.046133] Starting dynamic subtest: vcs0
[263.416563] Dynamic subtest vcs0: SUCCESS (1.378s)
[263.428486] Starting dynamic subtest: vcs1
[265.465348] Dynamic subtest vcs1: SUCCESS (2.046s)
[265.477506] Starting dynamic subtest: vecs0
[267.448700] Dynamic subtest vecs0: SUCCESS (1.980s)
[267.460557] Starting dynamic subtest: ccs0
[268.124567] Dynamic subtest ccs0: SUCCESS (0.675s)
[268.127102] Subtest render-node-busy-idle: SUCCESS (7.443s)
[268.212958] [044/133] (755s left) gem_basic (create-fd-close)
[268.268906] Starting subtest: create-fd-close
[268.273089] Subtest create-fd-close: SUCCESS (0.000s)
[268.401326] [045/133] (755s left) kms_dp_link_training (non-uhbr-sst)
[268.505248] Starting subtest: non-uhbr-sst
[268.513623] Subtest non-uhbr-sst: SKIP (0.000s)
[268.588727] [046/133] (754s left) kms_cursor_crc (cursor-offscreen-64x21)
[268.765768] Starting subtest: cursor-offscreen-64x21
[268.808498] Subtest cursor-offscreen-64x21: SKIP (0.039s)
[269.087220] [047/133] (754s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[269.181132] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[276.317548] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.138s)
[276.452879] [048/133] (747s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[276.557419] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[276.559725] Starting dynamic subtest: pipe-A
[276.577108] Dynamic subtest pipe-A: SKIP (0.016s)
[276.586553] Starting dynamic subtest: pipe-B
[276.606720] Dynamic subtest pipe-B: SKIP (0.028s)
[276.615972] Starting dynamic subtest: pipe-C
[276.636980] Dynamic subtest pipe-C: SKIP (0.029s)
[276.645852] Starting dynamic subtest: pipe-D
[276.665754] Dynamic subtest pipe-D: SKIP (0.029s)
[276.669493] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.105s)
[276.785919] [049/133] (746s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[276.882768] Starting subtest: extended-pageflip-modeset-hang-oldfb
[276.884738] Starting dynamic subtest: pipe-A
[284.807848] Dynamic subtest pipe-A: SUCCESS (7.920s)
[284.816984] Starting dynamic subtest: pipe-D
[293.471645] Dynamic subtest pipe-D: SUCCESS (8.661s)
[293.473874] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.588s)
[294.344565] [050/133] (729s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[294.450679] Starting subtest: fbcpsr-tiling-linear
[301.036700] Subtest fbcpsr-tiling-linear: SUCCESS (6.585s)
[301.217876] [051/133] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[301.331913] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[305.029826] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.703s)
[306.178596] [052/133] (717s left) kms_flip (flip-vs-wf_vblank-interruptible)
[306.278062] Starting subtest: flip-vs-wf_vblank-interruptible
[306.280383] Starting dynamic subtest: A-eDP1
[308.204757] Dynamic subtest A-eDP1: SUCCESS (1.925s)
[308.217403] Starting dynamic subtest: B-eDP1
[310.132409] Dynamic subtest B-eDP1: SUCCESS (1.924s)
[310.149924] Starting dynamic subtest: C-eDP1
[312.049606] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[312.061706] Starting dynamic subtest: D-eDP1
[313.882074] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[313.884470] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.607s)
[315.134849] [053/133] (708s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[315.241721] Starting subtest: yf-tiled-64bpp-rotate-180
[315.246070] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[315.376989] [054/133] (708s left) gem_exec_balancer (nohangcheck)
[315.637770] Starting subtest: nohangcheck
[316.514373] Subtest nohangcheck: SUCCESS (0.878s)
[316.679703] [055/133] (707s left) i915_drm_fdinfo (most-busy-check-all)
[316.719852] Starting subtest: most-busy-check-all
[316.722163] Starting dynamic subtest: rcs0
[316.726807] Dynamic subtest rcs0: SKIP (0.003s)
[316.736785] Starting dynamic subtest: bcs0
[316.741001] Dynamic subtest bcs0: SKIP (0.000s)
[316.750066] Starting dynamic subtest: vcs0
[316.754498] Dynamic subtest vcs0: SKIP (0.000s)
[316.763088] Starting dynamic subtest: vcs1
[316.767128] Dynamic subtest vcs1: SKIP (0.000s)
[316.775721] Starting dynamic subtest: vecs0
[316.779678] Dynamic subtest vecs0: SKIP (0.000s)
[316.787887] Starting dynamic subtest: ccs0
[316.791910] Dynamic subtest ccs0: SKIP (0.000s)
[316.795926] Subtest most-busy-check-all: SKIP (0.008s)
[316.832243] [056/133] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[316.930784] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[339.377730] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.447s)
[339.536252] [057/133] (684s left) kms_plane_cursor (overlay)
[339.639755] Starting subtest: overlay
[339.643341] Starting dynamic subtest: pipe-A-eDP-1-size-64
[342.169134] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.529s)
[342.232198] Starting dynamic subtest: pipe-A-eDP-1-size-128
[344.671749] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.451s)
[344.733850] Starting dynamic subtest: pipe-A-eDP-1-size-256
[347.272885] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[347.633500] Starting dynamic subtest: pipe-B-eDP-1-size-64
[350.886586] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.262s)
[350.947347] Starting dynamic subtest: pipe-B-eDP-1-size-128
[353.423179] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[353.490105] Starting dynamic subtest: pipe-B-eDP-1-size-256
[355.935076] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s)
[356.283554] Starting dynamic subtest: pipe-C-eDP-1-size-64
[359.182529] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.909s)
[359.220518] Starting dynamic subtest: pipe-C-eDP-1-size-128
[361.371537] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s)
[361.410756] Starting dynamic subtest: pipe-C-eDP-1-size-256
[363.495076] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[363.825596] Starting dynamic subtest: pipe-D-eDP-1-size-64
[366.580426] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.764s)
[366.618851] Starting dynamic subtest: pipe-D-eDP-1-size-128
[368.769985] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[368.807647] Starting dynamic subtest: pipe-D-eDP-1-size-256
[370.869961] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.069s)
[371.196649] Subtest overlay: SUCCESS (31.551s)
[372.072934] [058/133] (651s left) gem_render_copy_redux (normal)
[372.149715] Starting subtest: normal
[372.393036] Subtest normal: SUCCESS (0.244s)
[372.545731] [059/133] (651s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[372.642228] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[372.644538] Starting dynamic subtest: pipe-A-default-mode
[375.408925] Dynamic subtest pipe-A-default-mode: SUCCESS (2.764s)
[375.410885] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.766s)
[376.253483] [060/133] (647s left) gem_render_copy (yf-tiled-to-vebox-linear)
[376.316932] Starting subtest: yf-tiled-to-vebox-linear
[376.322343] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[376.521214] [061/133] (647s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[376.594660] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[376.597056] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[376.742890] [062/133] (647s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[376.849789] Starting subtest: psr2-cursor-plane-move-continuous-sf
[376.851997] Starting dynamic subtest: pipe-A-eDP-1
[387.192884] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.345s)
[387.201831] Starting dynamic subtest: pipe-B-eDP-1
[398.297890] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.102s)
[398.300336] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.450s)
[399.121280] [063/133] (625s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[399.221262] Starting subtest: fbc-psr2-sprite-mmap-gtt
[399.223420] Starting dynamic subtest: eDP-1
[399.227387] Dynamic subtest eDP-1: SKIP (0.000s)
[399.231206] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[399.308069] [064/133] (624s left) gem_mmap_wc (bad-size)
[399.364040] Subtest bad-size: SKIP (0.000s)
[399.430066] [065/133] (624s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[399.523743] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[399.527942] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[399.606809] [066/133] (624s left) kms_vblank (ts-continuation-suspend)
[399.700933] Starting subtest: ts-continuation-suspend
[399.703244] Starting dynamic subtest: pipe-A-eDP-1
[416.660548] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.582s)
[416.676113] Starting dynamic subtest: pipe-D-eDP-1
[433.651063] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.183s)
[433.653495] Subtest ts-continuation-suspend: SUCCESS (3.771s)
[434.491516] [067/133] (589s left) kms_addfb_basic (invalid-set-prop)
[434.566263] Starting subtest: invalid-set-prop
[434.568276] Subtest invalid-set-prop: SUCCESS (0.000s)
[434.697523] [068/133] (589s left) kms_psr (psr-sprite-plane-onoff)
[434.795514] Starting subtest: psr-sprite-plane-onoff
[434.797826] Starting dynamic subtest: eDP-1
[436.525487] Dynamic subtest eDP-1: SUCCESS (1.728s)
[436.527758] Subtest psr-sprite-plane-onoff: SUCCESS (1.729s)
[437.367340] [069/133] (587s left) gem_fence_thrash (bo-write-verify-threaded-y)
[437.412256] Starting subtest: bo-write-verify-threaded-y
[437.431873] Subtest bo-write-verify-threaded-y: SKIP (0.020s)
[437.504110] [070/133] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[437.611705] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[437.615766] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[437.748140] [071/133] (586s left) gem_exec_schedule (submit-early-slice)
[437.828949] Starting subtest: submit-early-slice
[437.830923] Starting dynamic subtest: rcs0
[437.862219] Dynamic subtest rcs0: SUCCESS (0.042s)
[437.874082] Starting dynamic subtest: bcs0
[437.898349] Dynamic subtest bcs0: SUCCESS (0.035s)
[437.908241] Starting dynamic subtest: vcs0
[437.935207] Dynamic subtest vcs0: SUCCESS (0.036s)
[437.946593] Starting dynamic subtest: vcs1
[437.973283] Dynamic subtest vcs1: SUCCESS (0.037s)
[437.985048] Starting dynamic subtest: vecs0
[438.007614] Dynamic subtest vecs0: SUCCESS (0.034s)
[438.017343] Starting dynamic subtest: ccs0
[438.044314] Dynamic subtest ccs0: SUCCESS (0.036s)
[438.046521] Subtest submit-early-slice: SUCCESS (0.224s)
[439.750247] [072/133] (584s left) i915_hangman (gt-engine-error)
[439.813493] Starting subtest: gt-engine-error
[439.815761] Starting dynamic subtest: rcs0
[441.590040] Dynamic subtest rcs0: SUCCESS (1.775s)
[441.606096] Starting dynamic subtest: bcs0
[443.572385] Dynamic subtest bcs0: SUCCESS (1.977s)
[443.584168] Starting dynamic subtest: vcs0
[445.620578] Dynamic subtest vcs0: SUCCESS (2.044s)
[445.631935] Starting dynamic subtest: vcs1
[447.605337] Dynamic subtest vcs1: SUCCESS (1.980s)
[447.617834] Starting dynamic subtest: vecs0
[449.588593] Dynamic subtest vecs0: SUCCESS (1.979s)
[449.600892] Starting dynamic subtest: ccs0
[451.573872] Dynamic subtest ccs0: SUCCESS (1.981s)
[451.576801] Subtest gt-engine-error: SUCCESS (11.753s)
[451.665813] [073/133] (572s left) api_intel_allocator (gem-pool)
[451.738757] Starting subtest: gem-pool
[451.750145] Subtest gem-pool: SUCCESS (0.013s)
[451.864289] [074/133] (572s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[451.930832] Starting subtest: multi-wait-for-submit-unsubmitted
[452.035629] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[452.134535] [075/133] (572s left) gem_lmem_swapping (massive)
[452.176299] Subtest massive: SKIP (0.000s)
[452.220276] [076/133] (572s left) kms_big_fb (linear-64bpp-rotate-270)
[452.330042] Starting subtest: linear-64bpp-rotate-270
[452.349998] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[452.501963] [077/133] (572s left) gem_exec_params (rsvd2-dirt)
[452.559294] Starting subtest: rsvd2-dirt
[452.564030] Subtest rsvd2-dirt: SKIP (0.000s)
[452.684332] [078/133] (572s left) kms_pm_dc (dc9-dpms)
[453.781418] Starting subtest: dc9-dpms
[455.195712] Subtest dc9-dpms: SUCCESS (1.412s)
[455.280627] [079/133] (569s left) kms_properties (invalid-properties-atomic)
[455.379883] Starting subtest: invalid-properties-atomic
[455.681906] Subtest invalid-properties-atomic: SUCCESS (0.303s)
[455.766332] [080/133] (569s left) gem_pipe_control_store_loop (fresh-buffer)
[455.829049] Starting subtest: fresh-buffer
[457.983421] Subtest fresh-buffer: SUCCESS (2.153s)
[458.131397] [081/133] (566s left) kms_flip (wf_vblank-ts-check-interruptible)
[458.231489] Starting subtest: wf_vblank-ts-check-interruptible
[458.233797] Starting dynamic subtest: A-eDP1
[467.113984] Dynamic subtest A-eDP1: SUCCESS (8.876s)
[467.125067] Starting dynamic subtest: B-eDP1
[476.041420] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[476.051263] Starting dynamic subtest: C-eDP1
[484.961252] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[484.970124] Starting dynamic subtest: D-eDP1
[493.794283] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[493.800223] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.565s)
[495.035438] [082/133] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[495.148969] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[495.153431] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[495.293936] [083/133] (529s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[495.397627] Starting subtest: crc-primary-suspend-y-tiled-ccs
[495.399939] Starting dynamic subtest: pipe-A-eDP-1
[495.408936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[495.424140] Starting dynamic subtest: pipe-B-eDP-1
[495.434008] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[495.445343] Starting dynamic subtest: pipe-C-eDP-1
[495.454245] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[495.462883] Starting dynamic subtest: pipe-D-eDP-1
[495.471559] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[495.475809] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.009s)
[497.697023] [084/133] (527s left) gem_lmem_swapping (parallel-random-verify-ccs)
[497.744768] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[497.782433] [085/133] (527s left) kms_atomic (plane-primary-legacy)
[497.875478] Starting subtest: plane-primary-legacy
[497.877718] Starting dynamic subtest: pipe-A-eDP-1
[498.321400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[498.323319] Subtest plane-primary-legacy: SUCCESS (0.446s)
[499.129951] [086/133] (526s left) sw_sync (sync_multi_consumer)
[499.175116] Starting subtest: sync_multi_consumer
[499.605540] Subtest sync_multi_consumer: SUCCESS (0.432s)
[499.681290] [087/133] (525s left) intel_hwmon (hwmon-read)
[499.751323] Subtest hwmon-read: SKIP (0.000s)
[499.810276] [088/133] (525s left) kms_cursor_crc (cursor-sliding-128x42)
[500.024099] Starting subtest: cursor-sliding-128x42
[500.068986] Subtest cursor-sliding-128x42: SKIP (0.039s)
[500.318084] [089/133] (524s left) kms_color (gamma)
[500.428512] Starting subtest: gamma
[500.430814] Starting dynamic subtest: pipe-A-eDP-1
[501.112731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[501.123205] Starting dynamic subtest: pipe-B-eDP-1
[502.513466] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[502.523595] Starting dynamic subtest: pipe-C-eDP-1
[503.908715] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[503.918102] Starting dynamic subtest: pipe-D-eDP-1
[505.232433] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[505.234250] Subtest gamma: SUCCESS (4.802s)
[506.077986] [090/133] (519s left) gen9_exec_parse (cmd-crossing-page)
[506.148417] Subtest cmd-crossing-page: SKIP (0.000s)
[506.228553] [091/133] (519s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[506.322441] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[506.324611] Starting dynamic subtest: pipe-A-eDP-1
[506.381599] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[506.392505] Starting dynamic subtest: pipe-B-eDP-1
[506.448803] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[506.459430] Starting dynamic subtest: pipe-C-eDP-1
[506.515088] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[506.525571] Starting dynamic subtest: pipe-D-eDP-1
[506.582736] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[506.586992] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[508.562152] [092/133] (516s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[508.652680] Starting subtest: bad-pixel-format-yf-tiled-ccs
[508.655060] Starting dynamic subtest: pipe-A-eDP-1
[508.678519] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[508.689003] Starting dynamic subtest: pipe-B-eDP-1
[508.710767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[508.719003] Starting dynamic subtest: pipe-C-eDP-1
[508.741112] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[508.751958] Starting dynamic subtest: pipe-D-eDP-1
[508.775137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[508.779603] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[510.840273] [093/133] (514s left) gem_userptr_blits (dmabuf-unsync)
[510.913907] Subtest dmabuf-unsync: SKIP (0.000s)
[511.061730] [094/133] (514s left) gem_exec_params (batch-first)
[511.122278] Starting subtest: batch-first
[511.128280] Subtest batch-first: SUCCESS (0.006s)
[511.286805] [095/133] (514s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[511.677423] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[512.452921] [096/133] (513s left) gem_workarounds (basic-read)
[512.521751] Starting subtest: basic-read
[512.531328] Subtest basic-read: SUCCESS (0.009s)
[512.686708] [097/133] (512s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[512.790621] Starting subtest: 4-tiled-16bpp-rotate-270
[512.809127] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.018s)
[512.972726] [098/133] (512s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[513.039149] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[513.113857] [099/133] (512s left) prime_self_import (basic-with_two_bos)
[513.146029] Starting subtest: basic-with_two_bos
[513.167323] Subtest basic-with_two_bos: SUCCESS (0.026s)
[513.301853] [100/133] (512s left) i915_query (query-topology-coherent-slice-mask)
[513.359293] Starting subtest: query-topology-coherent-slice-mask
[513.363713] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[513.498964] [101/133] (512s left) drm_buddy (drm_buddy)
[513.531228] Starting subtest: drm_buddy
[513.535083] Subtest drm_buddy: SKIP (0.001s)
[513.601057] [102/133] (512s left) kms_draw_crc (draw-method-mmap-wc)
[513.699924] Starting subtest: draw-method-mmap-wc
[513.701489] Starting dynamic subtest: xrgb8888-untiled
[513.908289] Dynamic subtest xrgb8888-untiled: SUCCESS (0.210s)
[513.917435] Starting dynamic subtest: rgb565-untiled
[514.108523] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[514.117336] Starting dynamic subtest: xrgb2101010-untiled
[514.330896] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[514.340249] Starting dynamic subtest: xbgr16161616f-untiled
[514.531104] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[514.539526] Starting dynamic subtest: xrgb8888-xtiled
[514.653340] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[514.662226] Starting dynamic subtest: rgb565-xtiled
[514.786744] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[514.797559] Starting dynamic subtest: xrgb2101010-xtiled
[514.910431] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[514.928541] Starting dynamic subtest: xbgr16161616f-xtiled
[515.044634] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[515.053586] Starting dynamic subtest: xrgb8888-4tiled
[515.220212] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.176s)
[515.230864] Starting dynamic subtest: rgb565-4tiled
[515.353445] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[515.364541] Starting dynamic subtest: xrgb2101010-4tiled
[515.497762] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s)
[515.506329] Starting dynamic subtest: xbgr16161616f-4tiled
[515.676403] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[515.678816] Subtest draw-method-mmap-wc: SUCCESS (1.978s)
[515.806955] [103/133] (510s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[515.874695] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[515.943498] [104/133] (509s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[516.047615] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[516.051428] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[516.185129] [105/133] (509s left) kms_joiner (invalid-modeset-ultra-joiner)
[516.288918] Starting subtest: invalid-modeset-ultra-joiner
[516.292116] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[516.366656] [106/133] (509s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[516.486545] Starting subtest: cursorB-vs-flipA-atomic
[516.490360] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[516.638842] [107/133] (509s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[516.736885] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[517.495168] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.759s)
[517.750024] [108/133] (508s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[517.849671] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[517.851933] Starting dynamic subtest: pipe-A-eDP-1
[517.872505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[517.882486] Starting dynamic subtest: pipe-B-eDP-1
[517.900154] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[517.908487] Starting dynamic subtest: pipe-C-eDP-1
[517.926674] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[517.934974] Starting dynamic subtest: pipe-D-eDP-1
[517.953223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[517.955080] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[520.058763] [109/133] (506s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[520.123123] Starting subtest: single-wait-all-for-submit-available-signaled
[520.125489] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[520.258678] [110/133] (505s left) kms_hdr (bpc-switch-dpms)
[520.355701] Starting subtest: bpc-switch-dpms
[521.430969] Starting dynamic subtest: pipe-A-eDP-1
[525.939529] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.509s)
[525.942023] Subtest bpc-switch-dpms: SUCCESS (5.584s)
[526.093907] [111/133] (500s left) perf (global-sseu-config-invalid)
[526.227469] Starting subtest: global-sseu-config-invalid
[526.231085] Subtest global-sseu-config-invalid: SKIP (0.000s)
[526.271267] [112/133] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[526.375915] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[526.380315] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[526.511588] [113/133] (499s left) i915_pm_rps (thresholds-idle-park)
[526.577030] Starting subtest: thresholds-idle-park
[526.581540] Subtest thresholds-idle-park: SKIP (0.001s)
[526.722663] [114/133] (499s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[527.132135] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[527.907588] [115/133] (498s left) kms_pm_rpm (i2c)
[529.741254] Starting subtest: i2c
[534.817251] Subtest i2c: SUCCESS (5.079s)
[534.925376] [116/133] (491s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[534.988177] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[534.990502] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[535.108798] [117/133] (491s left) gem_eio (wait-wedge-immediate)
[535.327503] Starting subtest: wait-wedge-immediate
[536.668833] Subtest wait-wedge-immediate: SUCCESS (1.342s)
[536.817373] [118/133] (489s left) prime_busy (before)
[536.881537] Starting subtest: before
[536.887599] Starting dynamic subtest: rcs0
[536.938454] Dynamic subtest rcs0: SUCCESS (0.054s)
[536.950092] Starting dynamic subtest: bcs0
[536.983810] Dynamic subtest bcs0: SUCCESS (0.045s)
[536.994280] Starting dynamic subtest: vcs0
[537.025106] Dynamic subtest vcs0: SUCCESS (0.041s)
[537.035184] Starting dynamic subtest: vcs1
[537.065322] Dynamic subtest vcs1: SUCCESS (0.039s)
[537.075962] Starting dynamic subtest: vecs0
[537.104772] Dynamic subtest vecs0: SUCCESS (0.039s)
[537.113952] Starting dynamic subtest: ccs0
[537.145895] Dynamic subtest ccs0: SUCCESS (0.040s)
[537.255052] Subtest before: SUCCESS (0.372s)
[537.353850] [119/133] (489s left) gem_ccs (block-copy-compressed)
[537.425244] Starting subtest: block-copy-compressed
[537.429967] Subtest block-copy-compressed: SKIP (0.000s)
[537.553479] [120/133] (488s left) kms_lease (atomic-implicit-crtc)
[537.655442] Starting subtest: atomic-implicit-crtc
[537.657634] Starting dynamic subtest: pipe-A-eDP-1
[537.668507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[537.679690] Starting dynamic subtest: pipe-B-eDP-1
[537.690335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[537.699970] Starting dynamic subtest: pipe-C-eDP-1
[537.710154] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[537.718753] Starting dynamic subtest: pipe-D-eDP-1
[537.728747] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[537.730613] Subtest atomic-implicit-crtc: SUCCESS (0.041s)
[537.824998] [121/133] (488s left) kms_psr (psr-basic)
[537.919200] Starting subtest: psr-basic
[537.921425] Starting dynamic subtest: eDP-1
[539.590547] Dynamic subtest eDP-1: SUCCESS (1.672s)
[539.592727] Subtest psr-basic: SUCCESS (1.673s)
[540.472456] [122/133] (486s left) kms_psr (fbc-psr2-primary-blt)
[540.578317] Starting subtest: fbc-psr2-primary-blt
[540.580430] Starting dynamic subtest: eDP-1
[540.584272] Dynamic subtest eDP-1: SKIP (0.000s)
[540.588093] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[540.661475] [123/133] (486s left) gem_eio (reset-stress)
[540.878885] Starting subtest: reset-stress
[540.880841] Starting dynamic subtest: render
[546.011586] Dynamic subtest render: SUCCESS (5.132s)
[546.028618] Starting dynamic subtest: bsd1
[564.147223] Dynamic subtest bsd1: SUCCESS (18.135s)
[564.162965] Starting dynamic subtest: bsd2
[582.175000] Dynamic subtest bsd2: SUCCESS (18.025s)
[582.191602] Starting dynamic subtest: blt
[582.195963] Dynamic subtest blt: SKIP (0.000s)
[582.204913] Starting dynamic subtest: vebox
[600.158348] Dynamic subtest vebox: SUCCESS (17.979s)
[600.161104] Subtest reset-stress: SUCCESS (59.276s)
[601.673391] [124/133] (425s left) gem_ctx_persistence (idempotent)
[601.742407] Starting subtest: idempotent
[601.744777] Subtest idempotent: SUCCESS (0.000s)
[601.880555] [125/133] (424s left) gem_exec_params (dr1-dirt)
[601.938642] Starting subtest: DR1-dirt
[601.940924] Subtest DR1-dirt: SUCCESS (0.000s)
[602.062246] [126/133] (424s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[602.183806] Starting subtest: short-flip-before-cursor-toggle
[603.099631] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[603.902493] [127/133] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[603.998421] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[604.000760] Starting dynamic subtest: pipe-A-eDP-1
[604.070706] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[604.080311] Starting dynamic subtest: pipe-B-eDP-1
[605.165028] Dynamic subtest pipe-B-eDP-1: SKIP (1.091s)
[605.169584] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.170s)
[606.463027] [128/133] (420s left) kms_vblank (query-busy-hang)
[606.556755] Starting subtest: query-busy-hang
[606.567545] Starting dynamic subtest: pipe-A-eDP-1
[633.430908] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.862s)
[633.446419] Starting dynamic subtest: pipe-D-eDP-1
[657.376201] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.936s)
[657.378055] Subtest query-busy-hang: SUCCESS (50.804s)
[658.262446] [129/133] (368s left) gem_exec_capture (pi)
[658.320753] Starting subtest: pi
[658.323053] Starting dynamic subtest: rcs0
[662.940208] Dynamic subtest rcs0: SUCCESS (4.619s)
[662.952385] Starting dynamic subtest: bcs0
[667.001439] Dynamic subtest bcs0: SUCCESS (4.061s)
[667.014409] Starting dynamic subtest: vcs0
[671.017419] Dynamic subtest vcs0: SUCCESS (4.015s)
[671.033881] Starting dynamic subtest: vcs1
[675.129541] Dynamic subtest vcs1: SUCCESS (4.110s)
[675.144913] Starting dynamic subtest: vecs0
[679.197204] Dynamic subtest vecs0: SUCCESS (4.067s)
[679.214216] Starting dynamic subtest: ccs0
[683.229432] Dynamic subtest ccs0: SUCCESS (4.030s)
[683.231904] Subtest pi: SUCCESS (24.914s)
[683.326453] [130/133] (343s left) gem_exec_fence (syncobj-signal)
[683.829228] Starting subtest: syncobj-signal
[683.837896] Subtest syncobj-signal: SUCCESS (0.009s)
[685.751688] [131/133] (341s left) gem_ctx_persistence (engines-cleanup)
[685.822972] Starting subtest: engines-cleanup
[685.825232] Starting dynamic subtest: rcs0
[685.942609] Dynamic subtest rcs0: SUCCESS (0.119s)
[685.954398] Starting dynamic subtest: bcs0
[685.975663] Dynamic subtest bcs0: SUCCESS (0.032s)
[685.984700] Starting dynamic subtest: vcs0
[686.094410] Dynamic subtest vcs0: SUCCESS (0.117s)
[686.107662] Starting dynamic subtest: vcs1
[686.149997] Dynamic subtest vcs1: SUCCESS (0.054s)
[686.160617] Starting dynamic subtest: vecs0
[686.223659] Dynamic subtest vecs0: SUCCESS (0.071s)
[686.236078] Starting dynamic subtest: ccs0
[686.280031] Dynamic subtest ccs0: SUCCESS (0.055s)
[686.282470] Subtest engines-cleanup: SUCCESS (0.458s)
[686.373035] [132/133] (340s left) core_auth (basic-auth)
[686.438193] Starting subtest: basic-auth
[686.441062] Subtest basic-auth: SUCCESS (0.001s)
[686.563550] [133/133] (340s left) gem_mmap_gtt (ptrace)
[686.633594] Subtest ptrace: SKIP (0.000s)
[686.701014] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_bad_reloc
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_flink_race
results: parsing output: 14/ for test: tools_test
results: parsing output: 15/ for test: kms_cdclk
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_edge_walk
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_ctx_engines
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_async
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: gem_watchdog
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: vgem_basic
results: parsing output: 34/ for test: kms_plane_lowres
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: gem_basic
results: parsing output: 44/ for test: kms_dp_link_training
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_busy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane_cursor
results: parsing output: 57/ for test: gem_render_copy_redux
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_fence_thrash
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: i915_hangman
results: parsing output: 72/ for test: api_intel_allocator
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_pm_dc
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: gem_pipe_control_store_loop
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: intel_hwmon
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_workarounds
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: prime_self_import
results: parsing output: 99/ for test: i915_query
results: parsing output: 100/ for test: drm_buddy
results: parsing output: 101/ for test: kms_draw_crc
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_joiner
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_hdr
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_pm_rps
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_ccs
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_exec_capture
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: core_auth
results: parsing output: 132/ for test: gem_mmap_gtt
Done.