[61.786880] Initializing watchdogs
[61.786941]   /dev/watchdog0
[61.804825] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.814728] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.818191] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.820599] [001/131] (960s left) kms_color (ctm-blue-to-red)
[62.101840] Starting subtest: ctm-blue-to-red
[62.102707] Starting dynamic subtest: pipe-A-DP-4
[62.803987] Dynamic subtest pipe-A-DP-4: SUCCESS (0.704s)
[62.819739] Starting dynamic subtest: pipe-B-DP-4
[63.405466] Dynamic subtest pipe-B-DP-4: SUCCESS (0.604s)
[63.414730] Starting dynamic subtest: pipe-C-DP-4
[63.979888] Dynamic subtest pipe-C-DP-4: SUCCESS (0.577s)
[63.987996] Starting dynamic subtest: pipe-D-DP-4
[64.576519] Dynamic subtest pipe-D-DP-4: SUCCESS (0.598s)
[64.577583] Subtest ctm-blue-to-red: SUCCESS (2.483s)
[64.825902] [002/131] (957s left) gen7_exec_parse (basic-allowed)
[64.909101] Subtest basic-allowed: SKIP (0.000s)
[64.988473] [003/131] (957s left) prime_udl
[65.083037] [004/131] (957s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[65.151468] Starting subtest: single-wait-for-submit-unsubmitted
[65.265674] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[65.364579] [005/131] (957s left) kms_flip (flip-vs-fences-interruptible)
[65.568482] Starting subtest: flip-vs-fences-interruptible
[65.570208] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[65.694132] [006/131] (956s left) kms_hdr (static-toggle-suspend)
[65.892992] Starting subtest: static-toggle-suspend
[69.003545] Starting dynamic subtest: pipe-A-DP-4
[89.591210] Dynamic subtest pipe-A-DP-4: SUCCESS (4.880s)
[89.592236] Subtest static-toggle-suspend: SUCCESS (7.998s)
[93.891977] [007/131] (948s left) perf (gen12-group-exclusive-stream-ctx-handle)
[94.241517] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[94.266579] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[94.317996] [008/131] (948s left) syncobj_timeline (multi-wait-available-submitted)
[94.421035] Starting subtest: multi-wait-available-submitted
[94.421951] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[94.591944] [009/131] (947s left) gem_basic (bad-close)
[94.665580] Starting subtest: bad-close
[94.667738] Subtest bad-close: SUCCESS (0.000s)
[94.827748] [010/131] (947s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[95.045786] Starting subtest: yf-tiled-8bpp-rotate-180
[95.047568] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[95.177716] [011/131] (947s left) kms_psr (fbc-psr-cursor-plane-move)
[95.387803] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[95.445704] [012/131] (947s left) gem_exec_fence (nb-await)
[95.684003] Starting subtest: nb-await
[95.685329] Starting dynamic subtest: rcs0
[95.783231] Dynamic subtest rcs0: SUCCESS (0.100s)
[95.793574] Starting dynamic subtest: bcs0
[95.845448] Dynamic subtest bcs0: SUCCESS (0.062s)
[95.859629] Starting dynamic subtest: vcs0
[95.911482] Dynamic subtest vcs0: SUCCESS (0.064s)
[95.947413] Starting dynamic subtest: vcs1
[95.998294] Dynamic subtest vcs1: SUCCESS (0.086s)
[96.010266] Starting dynamic subtest: vecs0
[96.061883] Dynamic subtest vecs0: SUCCESS (0.064s)
[96.082881] Starting dynamic subtest: vecs1
[96.132811] Dynamic subtest vecs1: SUCCESS (0.070s)
[96.173495] Starting dynamic subtest: ccs0
[96.223217] Dynamic subtest ccs0: SUCCESS (0.090s)
[96.224800] Subtest nb-await: SUCCESS (0.540s)
[96.944951] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[96.946845] [013/131] (945s left) prime_vgem (basic-write)
[97.044908] Starting subtest: basic-write
[97.050060] Subtest basic-write: SKIP (0.005s)
[97.193459] [014/131] (945s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[97.406818] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[97.407752] Starting dynamic subtest: pipe-A
[98.197118] Dynamic subtest pipe-A: SKIP (0.790s)
[98.206260] Starting dynamic subtest: pipe-B
[99.371598] Dynamic subtest pipe-B: SKIP (1.175s)
[99.380409] Starting dynamic subtest: pipe-C
[100.547456] Dynamic subtest pipe-C: SKIP (1.175s)
[100.556407] Starting dynamic subtest: pipe-D
[101.723835] Dynamic subtest pipe-D: SKIP (1.176s)
[101.725260] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (4.317s)
[101.851030] [015/131] (940s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[102.067821] Starting subtest: basic-flip-before-cursor-atomic
[103.058989] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.992s)
[103.279651] [016/131] (939s left) kms_feature_discovery (display)
[103.486970] Starting subtest: display
[103.487830] Subtest display: SUCCESS (0.000s)
[103.579636] [017/131] (939s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[103.662437] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[103.663332] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[103.762217] [018/131] (939s left) kms_setmode (invalid-clone-single-crtc)
[103.837865] Starting subtest: invalid-clone-single-crtc
[103.840558] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[103.976141] [019/131] (939s left) perf_pmu (idle-no-semaphores)
[104.049723] Starting subtest: idle-no-semaphores
[104.050759] Starting dynamic subtest: rcs0
[104.635149] Dynamic subtest rcs0: SUCCESS (0.584s)
[104.649089] Starting dynamic subtest: bcs0
[105.152937] Dynamic subtest bcs0: SUCCESS (0.516s)
[105.168022] Starting dynamic subtest: vcs0
[105.670892] Dynamic subtest vcs0: SUCCESS (0.520s)
[105.684638] Starting dynamic subtest: vcs1
[106.187794] Dynamic subtest vcs1: SUCCESS (0.518s)
[106.201078] Starting dynamic subtest: vecs0
[106.716682] Dynamic subtest vecs0: SUCCESS (0.530s)
[106.730113] Starting dynamic subtest: vecs1
[107.229975] Dynamic subtest vecs1: SUCCESS (0.514s)
[107.243281] Starting dynamic subtest: ccs0
[107.747967] Dynamic subtest ccs0: SUCCESS (0.518s)
[107.749970] Subtest idle-no-semaphores: SUCCESS (3.728s)
[107.875225] [020/131] (935s left) gem_flink_basic (bad-flink)
[107.958785] Starting subtest: bad-flink
[107.960043] Subtest bad-flink: SUCCESS (0.000s)
[108.088561] [021/131] (935s left) kms_psr (fbc-pr-no-drrs)
[108.303964] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[108.359493] [022/131] (934s left) gem_exec_params (larger-than-life-batch)
[108.445127] Starting subtest: larger-than-life-batch
[116.331764] Subtest larger-than-life-batch: SUCCESS (7.926s)
[116.836923] [023/131] (926s left) gem_exec_whisper (basic-fds-forked-all)
[116.973871] Starting subtest: basic-fds-forked-all
[139.537338] Subtest basic-fds-forked-all: SUCCESS (22.588s)
[139.797677] [024/131] (903s left) gem_eio (reset-stress)
[140.078168] Starting subtest: reset-stress
[181.436152] Subtest reset-stress: SUCCESS (41.359s)
[181.776036] [025/131] (861s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[181.993943] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[183.085242] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.090s)
[183.296535] [026/131] (860s left) kms_cursor_crc (cursor-sliding-128x42)
[183.673477] Starting subtest: cursor-sliding-128x42
[183.677898] Starting dynamic subtest: pipe-A-DP-4
[187.915353] Dynamic subtest pipe-A-DP-4: SUCCESS (4.237s)
[187.964287] Starting dynamic subtest: pipe-D-DP-4
[192.115181] Dynamic subtest pipe-D-DP-4: SUCCESS (4.163s)
[192.116286] Subtest cursor-sliding-128x42: SUCCESS (8.445s)
[192.552264] [027/131] (850s left) kms_flip (flip-vs-panning-vs-hang)
[192.776792] Starting subtest: flip-vs-panning-vs-hang
[192.779323] Starting dynamic subtest: A-DP4
[196.086595] Dynamic subtest A-DP4: SUCCESS (3.308s)
[196.099809] Starting dynamic subtest: D-DP4
[199.304528] Dynamic subtest D-DP4: SUCCESS (3.218s)
[199.305580] Subtest flip-vs-panning-vs-hang: SUCCESS (6.532s)
[199.647960] [028/131] (843s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[199.861504] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[202.693750] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.833s)
[202.912602] [029/131] (840s left) kms_vblank (wait-busy-hang)
[203.121861] Starting subtest: wait-busy-hang
[203.122738] Starting dynamic subtest: pipe-A-DP-4
[205.637872] Dynamic subtest pipe-A-DP-4: SUCCESS (2.513s)
[205.651552] Starting dynamic subtest: pipe-D-DP-4
[208.090045] Dynamic subtest pipe-D-DP-4: SUCCESS (2.448s)
[208.090966] Subtest wait-busy-hang: SUCCESS (4.966s)
[208.361652] [030/131] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[208.578707] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[208.580446] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[208.682294] [031/131] (835s left) gem_exec_fence (submit-chain)
[208.895988] Starting subtest: submit-chain
[208.943517] Subtest submit-chain: SUCCESS (0.049s)
[209.682684] [032/131] (834s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[209.762043] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[209.843849] [033/131] (834s left) api_intel_allocator (simple-allocator)
[209.925905] Starting subtest: simple-allocator
[209.926768] Starting dynamic subtest: basic
[209.947950] Dynamic subtest basic: SUCCESS (0.022s)
[209.959748] Starting dynamic subtest: parallel-one
[210.126475] Dynamic subtest parallel-one: SUCCESS (0.177s)
[210.137822] Starting dynamic subtest: print
[210.138732] Dynamic subtest print: SUCCESS (0.000s)
[210.150443] Starting dynamic subtest: reuse
[210.151613] Dynamic subtest reuse: SUCCESS (0.000s)
[210.163115] Starting dynamic subtest: reserve
[210.164011] Dynamic subtest reserve: SUCCESS (0.000s)
[210.175247] Starting dynamic subtest: fork-reopen-allocator
[210.176235] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[210.177370] Subtest simple-allocator: SUCCESS (0.220s)
[210.343264] [034/131] (833s left) syncobj_wait (single-wait-all-for-submit-signaled)
[210.421487] Starting subtest: single-wait-all-for-submit-signaled
[210.422732] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[210.575659] [035/131] (833s left) gem_ctx_shared (exec-single-timeline)
[210.668797] Starting subtest: exec-single-timeline
[210.669804] Starting dynamic subtest: rcs0
[211.740915] Dynamic subtest rcs0: SUCCESS (1.070s)
[211.756486] Starting dynamic subtest: bcs0
[212.764812] Dynamic subtest bcs0: SUCCESS (1.019s)
[212.780128] Starting dynamic subtest: vcs0
[213.788698] Dynamic subtest vcs0: SUCCESS (1.019s)
[213.804050] Starting dynamic subtest: vcs1
[214.812825] Dynamic subtest vcs1: SUCCESS (1.019s)
[214.829020] Starting dynamic subtest: vecs0
[215.836734] Dynamic subtest vecs0: SUCCESS (1.019s)
[215.852112] Starting dynamic subtest: vecs1
[216.860740] Dynamic subtest vecs1: SUCCESS (1.019s)
[216.876283] Starting dynamic subtest: ccs0
[217.884831] Dynamic subtest ccs0: SUCCESS (1.019s)
[217.886871] Subtest exec-single-timeline: SUCCESS (7.215s)
[218.132431] [036/131] (825s left) gem_mmap_wc (copy)
[218.212922] Subtest copy: SKIP (0.000s)
[218.293675] [037/131] (825s left) kms_plane (pixel-format)
[218.503880] Starting subtest: pixel-format
[218.531801] Starting dynamic subtest: pipe-A-plane-0
[226.834966] Dynamic subtest pipe-A-plane-0: SUCCESS (8.300s)
[226.881611] Starting dynamic subtest: pipe-A-plane-3
[230.917838] Dynamic subtest pipe-A-plane-3: SUCCESS (4.079s)
[230.969097] Starting dynamic subtest: pipe-A-plane-5
[231.134434] Dynamic subtest pipe-A-plane-5: SUCCESS (0.213s)
[231.415353] Starting dynamic subtest: pipe-B-plane-0
[238.944956] Dynamic subtest pipe-B-plane-0: SUCCESS (7.550s)
[238.957289] Starting dynamic subtest: pipe-B-plane-3
[242.694982] Dynamic subtest pipe-B-plane-3: SUCCESS (3.749s)
[242.709533] Starting dynamic subtest: pipe-B-plane-5
[242.913174] Dynamic subtest pipe-B-plane-5: SUCCESS (0.216s)
[243.035358] Subtest pixel-format: SUCCESS (24.530s)
[243.352006] [038/131] (800s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[243.570032] Starting subtest: y-tiled-8bpp-rotate-270
[243.571768] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[243.741261] [039/131] (800s left) syncobj_basic (illegal-fd-to-handle)
[243.822025] Starting subtest: illegal-fd-to-handle
[243.822954] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[243.950989] [040/131] (800s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[244.163664] Starting subtest: fbc-rgb565-draw-mmap-wc
[244.165326] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[244.308424] [041/131] (800s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[244.516968] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[244.518673] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[244.806266] [042/131] (799s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[245.018454] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[245.020215] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[245.152649] [043/131] (799s left) gem_exec_schedule (u-fairslice-all)
[245.245583] Starting subtest: u-fairslice-all
[247.355620] Subtest u-fairslice-all: SUCCESS (2.110s)
[247.787434] [044/131] (796s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[248.006192] Starting subtest: x-tiled-64bpp-rotate-180
[249.650473] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.644s)
[249.805460] [045/131] (794s left) kms_selftest (drm_dp_mst_helper)
[249.863765] Starting subtest: drm_dp_mst_helper
[249.886432] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[249.994469] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.109s)
[250.009218] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[250.123296] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.127s)
[250.162018] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[250.238584] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.109s)
[250.239972] Subtest drm_dp_mst_helper: SUCCESS (0.373s)
[250.475649] [046/131] (794s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[252.766626] Starting subtest: modeset-lpsp-stress-no-wait
[252.852078] Subtest modeset-lpsp-stress-no-wait: SKIP (0.090s)
[253.106859] [047/131] (791s left) kms_busy (basic-hang)
[253.354483] Starting subtest: basic-hang
[253.356700] Starting dynamic subtest: flip-pipe-A
[253.980018] Dynamic subtest flip-pipe-A: SUCCESS (0.623s)
[254.006418] Starting dynamic subtest: modeset-pipe-A
[254.970781] Dynamic subtest modeset-pipe-A: SUCCESS (0.989s)
[254.999938] Starting dynamic subtest: flip-pipe-D
[255.541524] Dynamic subtest flip-pipe-D: SUCCESS (0.562s)
[255.561206] Starting dynamic subtest: modeset-pipe-D
[256.469609] Dynamic subtest modeset-pipe-D: SUCCESS (0.927s)
[256.470553] Subtest basic-hang: SUCCESS (3.115s)
[256.769043] [048/131] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[256.983723] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[256.985482] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[257.106365] [049/131] (787s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[257.316820] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[257.318638] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[257.411207] [050/131] (787s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[257.634702] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[259.929735] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.295s)
[260.096859] [051/131] (785s left) gem_exec_nop (basic-parallel)
[260.185758] Starting subtest: basic-parallel
[264.585149] Subtest basic-parallel: SUCCESS (4.400s)
[264.846886] [052/131] (780s left) gem_mmap_offset (bad-flags)
[264.927915] Starting subtest: bad-flags
[264.928829] Subtest bad-flags: SUCCESS (0.000s)
[265.084867] [053/131] (780s left) gem_mmap_gtt (fault-concurrent-y)
[265.164825] Subtest fault-concurrent-Y: SKIP (0.000s)
[265.238157] [054/131] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[265.453977] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[265.455877] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[265.590549] [055/131] (779s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[265.810706] Starting subtest: 4-tiled-8bpp-rotate-0
[267.245739] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.434s)
[267.445419] [056/131] (778s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[267.659471] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[267.660428] Starting dynamic subtest: pipe-A-DP-4
[274.510353] Dynamic subtest pipe-A-DP-4: SUCCESS (6.851s)
[274.530484] Starting dynamic subtest: pipe-B-DP-4
[276.080295] Dynamic subtest pipe-B-DP-4: SUCCESS (1.565s)
[276.126789] Starting dynamic subtest: pipe-C-DP-4
[277.723465] Dynamic subtest pipe-C-DP-4: SUCCESS (1.635s)
[277.771524] Starting dynamic subtest: pipe-D-DP-4
[279.330071] Dynamic subtest pipe-D-DP-4: SUCCESS (1.599s)
[279.336528] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (11.675s)
[279.732961] [057/131] (765s left) kms_prime (basic-crc-hybrid)
[282.640962] Subtest basic-crc-hybrid: SKIP (0.000s)
[282.746892] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.amdgpu: true
[282.747867] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.xe: true
[282.749970] [058/131] (762s left) prime_mmap (test_correct)
[282.836149] Starting subtest: test_correct
[282.837020] Starting dynamic subtest: test_correct-smem
[282.884146] Dynamic subtest test_correct-smem: SUCCESS (0.049s)
[282.896607] Starting dynamic subtest: test_correct-lmem0
[283.089268] Dynamic subtest test_correct-lmem0: SUCCESS (0.204s)
[283.090188] Subtest test_correct: SUCCESS (0.255s)
[283.249824] [059/131] (762s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[283.462604] Starting subtest: fbcpsr-rgb565-draw-render
[283.464426] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[283.595348] [060/131] (762s left) kms_vblank (ts-continuation-modeset-rpm)
[283.806033] Starting subtest: ts-continuation-modeset-rpm
[283.806888] Starting dynamic subtest: pipe-A-DP-4
[285.598006] Dynamic subtest pipe-A-DP-4: SUCCESS (1.790s)
[285.618573] Starting dynamic subtest: pipe-D-DP-4
[286.590534] Dynamic subtest pipe-D-DP-4: SUCCESS (0.986s)
[286.592398] Subtest ts-continuation-modeset-rpm: SUCCESS (2.785s)
[286.804280] [061/131] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[287.058509] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[287.060341] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[287.202897] [062/131] (758s left) syncobj_basic (bad-pad-fd-to-handle)
[287.279934] Starting subtest: bad-pad-fd-to-handle
[287.280988] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[287.453439] [063/131] (758s left) syncobj_wait (invalid-reset-zero-handles)
[287.529502] Starting subtest: invalid-reset-zero-handles
[287.530430] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[287.653609] [064/131] (758s left) kms_chamelium_frames (hdmi-crc-multiple)
[287.959985] Subtest hdmi-crc-multiple: SKIP (0.000s)
[288.119409] [065/131] (757s left) gem_exec_balancer (parallel-balancer)
[288.496054] Starting subtest: parallel-balancer
[289.769598] Subtest parallel-balancer: SUCCESS (1.274s)
[289.898136] [066/131] (756s left) gem_exec_reloc (basic-write-wc-noreloc)
[289.982701] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[290.088889] [067/131] (756s left) gem_eio (in-flight-immediate)
[290.405969] Starting subtest: in-flight-immediate
[295.374005] Subtest in-flight-immediate: SUCCESS (4.970s)
[295.612937] [068/131] (750s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[295.823695] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[295.824686] Starting dynamic subtest: pipe-A-valid-mode
[298.702308] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.875s)
[298.703863] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (2.879s)
[298.964501] [069/131] (747s left) kms_psr (psr-primary-blt)
[299.174894] Subtest psr-primary-blt: SKIP (0.000s)
[299.237303] [070/131] (747s left) gem_busy (close-race)
[299.326639] Starting subtest: close-race
[321.311363] Subtest close-race: SUCCESS (21.990s)
[321.840920] [071/131] (724s left) gen9_exec_parse (basic-rejected)
[321.967709] Subtest basic-rejected: SKIP (0.000s)
[322.036304] [072/131] (724s left) gem_mmap_wc (read-write)
[322.118072] Subtest read-write: SKIP (0.000s)
[322.183400] [073/131] (724s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[322.391836] Starting subtest: psr-dirtyfb-ioctl
[322.396941] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[322.524900] [074/131] (724s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[322.734147] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[322.735039] Starting dynamic subtest: pipe-A-DP-4
[322.756827] Dynamic subtest pipe-A-DP-4: SKIP (0.002s)
[322.769494] Starting dynamic subtest: pipe-B-DP-4
[322.791432] Dynamic subtest pipe-B-DP-4: SKIP (0.002s)
[322.804138] Starting dynamic subtest: pipe-C-DP-4
[322.829485] Dynamic subtest pipe-C-DP-4: SKIP (0.002s)
[322.841980] Starting dynamic subtest: pipe-D-DP-4
[322.862624] Dynamic subtest pipe-D-DP-4: SKIP (0.002s)
[322.864150] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.014s)
[323.197229] [075/131] (723s left) kms_panel_fitting (atomic-fastset)
[323.415308] Starting subtest: atomic-fastset
[323.416977] Subtest atomic-fastset: SKIP (0.000s)
[323.506846] [076/131] (723s left) gem_exec_reloc (basic-cpu-read)
[323.601835] Subtest basic-cpu-read: SKIP (0.000s)
[323.728194] [077/131] (723s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[323.942445] Starting subtest: cursor-vs-flip-toggle
[355.633892] Subtest cursor-vs-flip-toggle: SUCCESS (31.686s)
[355.878726] [078/131] (691s left) kms_invalid_mode (overflow-vrefresh)
[356.087451] Starting subtest: overflow-vrefresh
[356.088439] Starting dynamic subtest: pipe-A-DP-4
[356.166714] Dynamic subtest pipe-A-DP-4: SUCCESS (0.079s)
[356.181994] Starting dynamic subtest: pipe-B-DP-4
[356.183087] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[356.196492] Starting dynamic subtest: pipe-C-DP-4
[356.197453] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[356.210535] Starting dynamic subtest: pipe-D-DP-4
[356.211550] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[356.212511] Subtest overflow-vrefresh: SUCCESS (0.088s)
[356.403876] [079/131] (690s left) kms_atomic_interruptible (universal-setplane-primary)
[356.624700] Starting subtest: universal-setplane-primary
[356.626883] Starting dynamic subtest: pipe-A-DP-4
[362.975026] Dynamic subtest pipe-A-DP-4: SUCCESS (6.348s)
[362.975977] Subtest universal-setplane-primary: SUCCESS (6.350s)
[363.229459] [080/131] (683s left) kms_async_flips (test-time-stamp)
[363.435810] Starting subtest: test-time-stamp
[363.694163] Starting dynamic subtest: pipe-A-DP-4
[363.988978] Dynamic subtest pipe-A-DP-4: SUCCESS (0.292s)
[364.233559] Starting dynamic subtest: pipe-B-DP-4
[364.378857] Dynamic subtest pipe-B-DP-4: SUCCESS (0.157s)
[364.592814] Starting dynamic subtest: pipe-C-DP-4
[364.731271] Dynamic subtest pipe-C-DP-4: SUCCESS (0.148s)
[364.974413] Starting dynamic subtest: pipe-D-DP-4
[365.123189] Dynamic subtest pipe-D-DP-4: SUCCESS (0.160s)
[365.124634] Subtest test-time-stamp: SUCCESS (1.687s)
[365.649084] [081/131] (681s left) kms_plane_scaling (planes-downscale-factor-0-5)
[365.859063] Starting subtest: planes-downscale-factor-0-5
[365.859843] Starting dynamic subtest: pipe-A
[365.961575] Dynamic subtest pipe-A: SUCCESS (0.103s)
[365.976613] Starting dynamic subtest: pipe-B
[366.182465] Dynamic subtest pipe-B: SUCCESS (0.220s)
[366.202658] Starting dynamic subtest: pipe-C
[366.402318] Dynamic subtest pipe-C: SUCCESS (0.218s)
[366.425566] Starting dynamic subtest: pipe-D
[366.640656] Dynamic subtest pipe-D: SUCCESS (0.237s)
[366.641572] Subtest planes-downscale-factor-0-5: SUCCESS (0.783s)
[366.981108] [082/131] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[367.195755] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[367.197672] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[367.321966] [083/131] (680s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[367.538616] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[367.587941] [084/131] (679s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[367.794507] Starting subtest: bad-aux-stride-yf-tiled-ccs
[367.796747] Starting dynamic subtest: pipe-A-DP-4
[367.805157] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[367.817753] Starting dynamic subtest: pipe-B-DP-4
[367.826307] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[367.838740] Starting dynamic subtest: pipe-C-DP-4
[367.847153] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[367.859639] Starting dynamic subtest: pipe-D-DP-4
[367.869514] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[367.871509] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.006s)
[368.255119] [085/131] (679s left) kms_content_protection (legacy)
[368.520753] Starting subtest: legacy
[368.792464] Starting dynamic subtest: pipe-A-DP-4
[493.461514] Dynamic subtest pipe-A-DP-4: FAIL (124.413s)
[493.462560] Subtest legacy: FAIL (124.798s)
[493.582336] [086/131] (553s left) gem_ctx_persistence (hang)
[493.667039] Starting subtest: hang
[493.669140] Subtest hang: SKIP (0.000s)
[493.815290] [087/131] (553s left) kms_big_fb (x-tiled-addfb-size-overflow)
[494.037606] Starting subtest: x-tiled-addfb-size-overflow
[494.038478] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[494.197573] [088/131] (553s left) gem_exec_flush (basic-wb-ro-before-default)
[494.282615] Subtest basic-wb-ro-before-default: SKIP (0.000s)
[494.409795] [089/131] (553s left) gem_spin_batch (legacy)
[494.497690] Starting subtest: legacy
[494.498774] Starting dynamic subtest: default
[497.755425] Dynamic subtest default: SUCCESS (3.254s)
[497.769136] Starting dynamic subtest: render
[500.990870] Dynamic subtest render: SUCCESS (3.231s)
[501.005713] Starting dynamic subtest: bsd
[504.228921] Dynamic subtest bsd: SUCCESS (3.234s)
[504.244113] Starting dynamic subtest: bsd1
[507.466109] Dynamic subtest bsd1: SUCCESS (3.233s)
[507.481754] Starting dynamic subtest: bsd2
[510.702901] Dynamic subtest bsd2: SUCCESS (3.232s)
[510.717957] Starting dynamic subtest: blt
[513.938397] Dynamic subtest blt: SUCCESS (3.231s)
[513.953527] Starting dynamic subtest: vebox
[517.173768] Dynamic subtest vebox: SUCCESS (3.231s)
[517.175850] Subtest legacy: SUCCESS (22.679s)
[517.434559] [090/131] (530s left) kms_cursor_crc (cursor-onscreen-256x256)
[517.811358] Starting subtest: cursor-onscreen-256x256
[517.816729] Starting dynamic subtest: pipe-A-DP-4
[520.140624] Dynamic subtest pipe-A-DP-4: SUCCESS (2.323s)
[520.186669] Starting dynamic subtest: pipe-D-DP-4
[522.802251] Dynamic subtest pipe-D-DP-4: SUCCESS (2.627s)
[522.803263] Subtest cursor-onscreen-256x256: SUCCESS (4.991s)
[523.143995] [091/131] (524s left) drm_fdinfo (busy-idle-check-all)
[523.215179] Starting subtest: busy-idle-check-all
[523.216083] Starting dynamic subtest: rcs0
[523.240489] Dynamic subtest rcs0: SKIP (0.024s)
[523.253709] Starting dynamic subtest: bcs0
[523.255949] Dynamic subtest bcs0: SKIP (0.000s)
[523.268558] Starting dynamic subtest: vcs0
[523.270687] Dynamic subtest vcs0: SKIP (0.000s)
[523.283134] Starting dynamic subtest: vcs1
[523.285101] Dynamic subtest vcs1: SKIP (0.000s)
[523.297560] Starting dynamic subtest: vecs0
[523.299757] Dynamic subtest vecs0: SKIP (0.001s)
[523.312092] Starting dynamic subtest: vecs1
[523.314229] Dynamic subtest vecs1: SKIP (0.000s)
[523.326501] Starting dynamic subtest: ccs0
[523.328655] Dynamic subtest ccs0: SKIP (0.000s)
[523.330681] Subtest busy-idle-check-all: SKIP (0.033s)
[523.374189] [092/131] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[523.652053] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[523.653800] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[523.782837] [093/131] (524s left) kms_chamelium_audio (dp-audio)
[524.076672] Subtest dp-audio: SKIP (0.000s)
[524.234895] [094/131] (523s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[524.445944] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[535.393056] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.949s)
[535.656121] [095/131] (512s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[535.865972] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[535.867679] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[535.955474] [096/131] (512s left) gem_exec_schedule (preempt-queue-chain)
[536.049572] Subtest preempt-queue-chain: SKIP (0.000s)
[536.425218] [097/131] (511s left) perf_pmu (frequency)
[536.497589] Starting subtest: frequency
[536.500888] Starting dynamic subtest: gt0
[538.774253] Dynamic subtest gt0: FAIL (2.185s)
[538.816916] Starting dynamic subtest: idle-gt0
[539.193598] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[539.196961] Subtest frequency: FAIL (2.699s)
[539.334892] [098/131] (508s left) gem_softpin (overlap)
[539.427830] Starting subtest: overlap
[541.828973] Subtest overlap: SUCCESS (2.401s)
[541.990596] [099/131] (506s left) drm_mm (drm_mm)
[542.042717] Starting subtest: drm_mm
[542.074586] Starting dynamic subtest: drm_test_mm_init
[542.200861] Dynamic subtest drm_test_mm_init: SUCCESS (0.125s)
[542.217336] Starting dynamic subtest: drm_test_mm_debug
[542.305182] Dynamic subtest drm_test_mm_debug: SUCCESS (0.100s)
[542.349413] Starting dynamic subtest: drm_test_mm_align32
[542.427538] Dynamic subtest drm_test_mm_align32: SUCCESS (0.119s)
[542.474439] Starting dynamic subtest: drm_test_mm_align64
[542.523768] Dynamic subtest drm_test_mm_align64: SUCCESS (0.093s)
[542.568871] Starting dynamic subtest: drm_test_mm_lowest
[542.630527] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.104s)
[542.676609] Starting dynamic subtest: drm_test_mm_highest
[542.750384] Dynamic subtest drm_test_mm_highest: SUCCESS (0.116s)
[542.752187] Subtest drm_mm: SUCCESS (0.709s)
[542.959526] [100/131] (505s left) gem_render_copy (linear-to-vebox-yf-tiled)
[543.044023] Starting subtest: linear-to-vebox-yf-tiled
[543.045979] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[543.295684] [101/131] (505s left) gem_busy (busy)
[543.387295] Starting subtest: busy
[543.388206] Starting dynamic subtest: all-engines
[543.477193] Dynamic subtest all-engines: SUCCESS (0.089s)
[543.490713] Starting dynamic subtest: rcs0
[543.577346] Dynamic subtest rcs0: SUCCESS (0.099s)
[543.590852] Starting dynamic subtest: bcs0
[543.636948] Dynamic subtest bcs0: SUCCESS (0.057s)
[543.678858] Starting dynamic subtest: vcs0
[543.680116] Dynamic subtest vcs0: SUCCESS (0.040s)
[543.699418] Starting dynamic subtest: vcs1
[543.718838] Dynamic subtest vcs1: SUCCESS (0.039s)
[543.731570] Starting dynamic subtest: vecs0
[543.757990] Dynamic subtest vecs0: SUCCESS (0.038s)
[543.771568] Starting dynamic subtest: vecs1
[543.797063] Dynamic subtest vecs1: SUCCESS (0.038s)
[543.812875] Starting dynamic subtest: ccs0
[543.837198] Dynamic subtest ccs0: SUCCESS (0.040s)
[543.838267] Subtest busy: SUCCESS (0.450s)
[544.255785] [102/131] (504s left) i915_query (query-regions-sanity-check)
[544.336945] Starting subtest: query-regions-sanity-check
[544.362013] Subtest query-regions-sanity-check: SUCCESS (0.026s)
[544.561678] [103/131] (504s left) kms_psr (psr2-primary-mmap-gtt)
[544.771257] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[544.833659] [104/131] (503s left) gem_ctx_bad_destroy (invalid-ctx)
[544.913189] Starting subtest: invalid-ctx
[544.914113] Subtest invalid-ctx: SUCCESS (0.000s)
[545.021614] [105/131] (503s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[545.234396] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[545.285089] [106/131] (503s left) gem_lmem_swapping (parallel-random-engines)
[548.167916] Starting subtest: parallel-random-engines
[548.169000] Starting dynamic subtest: lmem0
[582.784792] Dynamic subtest lmem0: SUCCESS (34.624s)
[582.785909] Subtest parallel-random-engines: SUCCESS (34.625s)
[584.069785] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[584.070882] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[584.073205] [107/131] (464s left) gem_create (create-size-update)
[585.559217] Starting subtest: create-size-update
[585.560111] Subtest create-size-update: SUCCESS (0.000s)
[585.766514] [FACT gem_create (create-size-update)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[585.769796] [FACT gem_create (create-size-update)] new: kernel.kmod_is_loaded.i915: true
[585.773118] [108/131] (463s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[587.842990] Starting subtest: gem-execbuf-stress-pc8
[587.951719] Subtest gem-execbuf-stress-pc8: SKIP (0.108s)
[588.218328] [109/131] (460s left) gem_create (create-invalid-size)
[588.298025] Starting subtest: create-invalid-size
[588.298957] Subtest create-invalid-size: SUCCESS (0.000s)
[588.557290] [110/131] (460s left) kms_chamelium_color (ctm-limited-range)
[588.775133] Subtest ctm-limited-range: SKIP (0.000s)
[588.833907] [111/131] (460s left) syncobj_timeline (single-wait-available-signaled)
[588.913528] Starting subtest: single-wait-available-signaled
[588.914450] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[589.059386] [112/131] (460s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[589.155885] Starting subtest: y-tiled-ccs-to-yf-tiled
[589.158095] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[589.361421] [113/131] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[589.577968] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[589.579700] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[589.710457] [114/131] (459s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[589.794541] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[589.899261] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[590.063690] [115/131] (459s left) sysfs_heartbeat_interval (mixed)
[590.150856] Starting subtest: mixed
[590.151834] Starting dynamic subtest: vecs0
[595.417980] Dynamic subtest vecs0: SUCCESS (5.263s)
[595.436839] Starting dynamic subtest: ccs0
[600.682570] Dynamic subtest ccs0: SUCCESS (5.258s)
[600.702801] Starting dynamic subtest: vcs0
[605.926675] Dynamic subtest vcs0: SUCCESS (5.239s)
[605.938239] Starting dynamic subtest: bcs0
[611.211340] Dynamic subtest bcs0: SUCCESS (5.280s)
[611.251680] Starting dynamic subtest: vecs1
[616.508533] Dynamic subtest vecs1: SUCCESS (5.290s)
[616.523406] Starting dynamic subtest: rcs0
[621.758656] Dynamic subtest rcs0: SUCCESS (5.244s)
[621.778305] Starting dynamic subtest: vcs1
[627.033670] Dynamic subtest vcs1: SUCCESS (5.271s)
[627.034807] Subtest mixed: SUCCESS (36.864s)
[627.198864] [116/131] (422s left) syncobj_eventfd (invalid-bad-flags)
[627.279269] Starting subtest: invalid-bad-flags
[627.280278] Subtest invalid-bad-flags: SUCCESS (0.000s)
[627.458469] [117/131] (422s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[627.672789] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[627.674535] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[627.826020] [118/131] (421s left) perf (mi-rpc)
[628.189830] Starting subtest: mi-rpc
[628.191605] Subtest mi-rpc: SKIP (0.000s)
[628.245268] [119/131] (421s left) i915_pm_rpm (gem-evict-pwrite)
[629.797130] Starting subtest: gem-evict-pwrite
[629.801264] Subtest gem-evict-pwrite: SKIP (0.000s)
[630.153473] [120/131] (419s left) kms_lease (simple-lease)
[630.366181] Starting subtest: simple-lease
[630.367082] Starting dynamic subtest: pipe-A-DP-4
[630.890573] Dynamic subtest pipe-A-DP-4: SUCCESS (0.523s)
[630.911977] Starting dynamic subtest: pipe-B-DP-4
[631.294023] Dynamic subtest pipe-B-DP-4: SUCCESS (0.400s)
[631.307180] Starting dynamic subtest: pipe-C-DP-4
[631.715528] Dynamic subtest pipe-C-DP-4: SUCCESS (0.419s)
[631.729539] Starting dynamic subtest: pipe-D-DP-4
[632.113165] Dynamic subtest pipe-D-DP-4: SUCCESS (0.396s)
[632.115845] Subtest simple-lease: SUCCESS (1.749s)
[632.414411] [121/131] (417s left) gem_pxp (create-regular-context-2)
[635.025481] Starting subtest: create-regular-context-2
[635.027800] Subtest create-regular-context-2: SKIP (0.000s)
[635.137606] [122/131] (414s left) gem_caching (read-writes)
[635.217679] Starting subtest: read-writes
[643.401146] Subtest read-writes: SUCCESS (8.181s)
[643.566439] [123/131] (406s left) kms_psr (fbc-psr-sprite-blt)
[643.776977] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[643.838050] [124/131] (406s left) kms_setmode (basic)
[643.921887] Starting subtest: basic
[644.068178] Starting dynamic subtest: pipe-A-DP-4
[646.232660] Dynamic subtest pipe-A-DP-4: SUCCESS (2.161s)
[646.364903] Starting dynamic subtest: pipe-B-DP-4
[648.514592] Dynamic subtest pipe-B-DP-4: SUCCESS (2.157s)
[648.589775] Subtest basic: SUCCESS (4.666s)
[648.861269] [125/131] (401s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[649.068958] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[649.070706] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[649.179703] [126/131] (401s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[649.260230] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[649.363357] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[649.488955] [127/131] (400s left) kms_plane_lowres (tiling-none)
[649.697083] Starting subtest: tiling-none
[649.698003] Starting dynamic subtest: pipe-A-DP-4
[660.802299] Dynamic subtest pipe-A-DP-4: SUCCESS (11.101s)
[660.905924] Starting dynamic subtest: pipe-B-DP-4
[671.282388] Dynamic subtest pipe-B-DP-4: SUCCESS (10.385s)
[671.399606] Starting dynamic subtest: pipe-C-DP-4
[681.848268] Dynamic subtest pipe-C-DP-4: SUCCESS (10.458s)
[681.967080] Starting dynamic subtest: pipe-D-DP-4
[692.096284] Dynamic subtest pipe-D-DP-4: SUCCESS (10.139s)
[692.186240] Subtest tiling-none: SUCCESS (42.483s)
[692.455365] [128/131] (357s left) gem_exec_balancer (bonded-sync)
[692.548734] Starting subtest: bonded-sync
[692.550980] Subtest bonded-sync: SKIP (0.000s)
[692.916536] [129/131] (357s left) core_setmaster (master-drop-set-user)
[693.031449] Starting subtest: master-drop-set-user
[693.069689] Subtest master-drop-set-user: SUCCESS (0.038s)
[693.118147] [130/131] (357s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[693.331805] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[693.333528] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[693.463297] [131/131] (357s left) prime_mmap (test_refcounting)
[693.542978] Starting subtest: test_refcounting
[693.543978] Starting dynamic subtest: test_refcounting-smem
[693.593619] Dynamic subtest test_refcounting-smem: SUCCESS (0.050s)
[693.605235] Starting dynamic subtest: test_refcounting-lmem0
[693.804918] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.210s)
[693.805795] Subtest test_refcounting: SUCCESS (0.262s)
[693.932321] Closing watchdogs
results: parsing output: 0/ for test: kms_color
results: parsing output: 1/ for test: gen7_exec_parse
results: parsing output: 2/ for test: prime_udl
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_hdr
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_basic
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_feature_discovery
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_setmode
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: gem_flink_basic
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_vblank
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: gem_ctx_shared
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: syncobj_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_selftest
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_busy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_nop
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_prime
results: parsing output: 57/ for test: prime_mmap
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_basic
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_busy
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: gem_mmap_wc
results: parsing output: 72/ for test: kms_dirtyfb
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_panel_fitting
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_invalid_mode
results: parsing output: 78/ for test: kms_atomic_interruptible
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: drm_fdinfo
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_chamelium_audio
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: gem_softpin
results: parsing output: 98/ for test: drm_mm
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: gem_busy
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_ctx_bad_destroy
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: i915_pm_rpm
results: parsing output: 108/ for test: gem_create
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: sysfs_heartbeat_interval
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: gem_pxp
results: parsing output: 121/ for test: gem_caching
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_setmode
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_plane_lowres
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: core_setmaster
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: prime_mmap
Done.