[58.750549] Initializing watchdogs
[58.750594]   /dev/watchdog0
[58.763411] [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]
[58.767684] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.769900] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.773251] [001/131] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[63.832564] Starting subtest: pr-cursor-plane-move-continuous-sf
[63.836957] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[64.687326] [002/131] (954s left) kms_properties (invalid-properties-atomic)
[64.800961] Starting subtest: invalid-properties-atomic
[65.030484] Subtest invalid-properties-atomic: SUCCESS (0.228s)
[65.092618] [003/131] (954s left) api_intel_bb (render-ccs)
[65.154132] Starting subtest: render-ccs
[65.504314] Subtest render-ccs: SUCCESS (0.351s)
[65.621180] [004/131] (953s left) i915_suspend (forcewake)
[65.679634] Starting subtest: forcewake
[98.157797] Subtest forcewake: SUCCESS (2.203s)
[98.222721] [005/131] (951s left) gem_exec_reloc (basic-write-gtt-active)
[98.279887] Subtest basic-write-gtt-active: SKIP (0.000s)
[98.340546] [006/131] (951s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[98.440446] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[98.442946] Starting dynamic subtest: pipe-A-eDP-1
[98.469794] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.481939] Starting dynamic subtest: pipe-B-eDP-1
[98.508355] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.515465] Starting dynamic subtest: pipe-C-eDP-1
[98.541545] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.548376] Starting dynamic subtest: pipe-D-eDP-1
[98.574744] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.579795] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[100.698491] [007/131] (948s left) gem_ctx_isolation (dirty-create)
[100.768890] Starting subtest: dirty-create
[100.771976] Starting dynamic subtest: rcs0
[101.209935] Dynamic subtest rcs0: SUCCESS (0.444s)
[101.216947] Starting dynamic subtest: bcs0
[101.750689] Dynamic subtest bcs0: SUCCESS (0.545s)
[101.760042] Starting dynamic subtest: vcs0
[102.423551] Dynamic subtest vcs0: SUCCESS (0.677s)
[102.433599] Starting dynamic subtest: vcs1
[103.669252] Dynamic subtest vcs1: SUCCESS (1.254s)
[103.678827] Starting dynamic subtest: vecs0
[105.642316] Dynamic subtest vecs0: SUCCESS (1.983s)
[105.651987] Starting dynamic subtest: ccs0
[107.591978] Dynamic subtest ccs0: SUCCESS (1.958s)
[107.594619] Subtest dirty-create: SUCCESS (6.863s)
[107.856156] [008/131] (941s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[107.961485] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[107.963976] Starting dynamic subtest: pipe-A-eDP-1
[107.987860] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.994891] Starting dynamic subtest: pipe-B-eDP-1
[108.020714] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.027482] Starting dynamic subtest: pipe-C-eDP-1
[108.052872] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.059811] Starting dynamic subtest: pipe-D-eDP-1
[108.085841] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.090524] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[110.115502] [009/131] (939s left) kms_psr (fbc-psr-no-drrs)
[110.220812] Starting subtest: fbc-psr-no-drrs
[110.223301] Starting dynamic subtest: eDP-1
[110.228113] Dynamic subtest eDP-1: SKIP (0.000s)
[110.232964] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[110.280977] [010/131] (939s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[110.381014] Starting subtest: yf-tiled-32bpp-rotate-180
[110.386003] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[110.473086] [011/131] (939s left) kms_addfb_basic (invalid-get-prop)
[110.537470] Starting subtest: invalid-get-prop
[110.540303] Subtest invalid-get-prop: SUCCESS (0.000s)
[110.682648] [012/131] (939s left) gem_exec_fence (basic-wait)
[110.860409] Starting subtest: basic-wait
[110.863502] Starting dynamic subtest: rcs0
[110.965880] Dynamic subtest rcs0: SUCCESS (0.106s)
[110.975436] Starting dynamic subtest: bcs0
[111.028341] Dynamic subtest bcs0: SUCCESS (0.062s)
[111.039090] Starting dynamic subtest: vcs0
[111.087750] Dynamic subtest vcs0: SUCCESS (0.060s)
[111.097711] Starting dynamic subtest: vcs1
[111.148941] Dynamic subtest vcs1: SUCCESS (0.061s)
[111.157348] Starting dynamic subtest: vecs0
[111.205658] Dynamic subtest vecs0: SUCCESS (0.057s)
[111.213246] Starting dynamic subtest: ccs0
[111.264959] Dynamic subtest ccs0: SUCCESS (0.059s)
[111.267535] Subtest basic-wait: SUCCESS (0.406s)
[113.271991] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[113.275534] [013/131] (936s left) kms_content_protection (mei-interface)
[113.451841] Starting subtest: mei-interface
[113.456690] Subtest mei-interface: SKIP (0.001s)
[113.562120] [014/131] (936s left) syncobj_timeline (signal-array)
[113.625552] Starting subtest: signal-array
[113.628799] Subtest signal-array: SUCCESS (0.000s)
[113.721030] [015/131] (936s left) gem_exercise_blt (fast-copy-emit)
[113.781553] Starting subtest: fast-copy-emit
[113.784419] Starting dynamic subtest: linear-smem-smem-emit
[113.800887] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[113.809001] Starting dynamic subtest: xmajor-smem-smem-emit
[113.817237] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[113.824940] Starting dynamic subtest: tile4-smem-smem-emit
[113.833935] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[113.841684] Starting dynamic subtest: tile64-smem-smem-emit
[113.850574] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[113.853622] Subtest fast-copy-emit: SUCCESS (0.073s)
[113.956094] [016/131] (935s left) gem_exec_schedule (timeslicing)
[114.034989] Starting subtest: timeslicing
[114.037485] Starting dynamic subtest: rcs0
[114.043846] Dynamic subtest rcs0: SUCCESS (0.022s)
[114.051476] Starting dynamic subtest: bcs0
[114.064985] Dynamic subtest bcs0: SUCCESS (0.021s)
[114.073758] Starting dynamic subtest: vcs0
[114.088966] Dynamic subtest vcs0: SUCCESS (0.024s)
[114.096566] Starting dynamic subtest: vcs1
[114.109397] Dynamic subtest vcs1: SUCCESS (0.020s)
[114.116795] Starting dynamic subtest: vecs0
[114.128670] Dynamic subtest vecs0: SUCCESS (0.020s)
[114.135981] Starting dynamic subtest: ccs0
[114.152683] Dynamic subtest ccs0: SUCCESS (0.023s)
[114.155544] Subtest timeslicing: SUCCESS (0.130s)
[115.223345] [017/131] (934s left) kms_vrr (flip-basic)
[115.321508] Starting subtest: flip-basic
[115.329371] Subtest flip-basic: SKIP (0.000s)
[115.389076] [018/131] (934s left) syncobj_wait (single-wait-for-submit-submitted)
[115.455993] Starting subtest: single-wait-for-submit-submitted
[115.561298] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[115.630109] [019/131] (934s left) gem_create (create-invalid-size)
[115.686027] Starting subtest: create-invalid-size
[115.688686] Subtest create-invalid-size: SUCCESS (0.000s)
[115.866343] [020/131] (934s left) kms_sequence (get-forked)
[115.953279] Starting subtest: get-forked
[115.955727] Starting dynamic subtest: pipe-A-eDP-1
[117.853986] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[117.863756] Starting dynamic subtest: pipe-B-eDP-1
[120.443443] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.592s)
[120.452979] Starting dynamic subtest: pipe-C-eDP-1
[122.961717] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.520s)
[122.970475] Starting dynamic subtest: pipe-D-eDP-1
[125.487962] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[125.490966] Subtest get-forked: SUCCESS (9.542s)
[126.293207] [021/131] (923s left) kms_properties (invalid-properties-legacy)
[126.402765] Starting subtest: invalid-properties-legacy
[126.507783] Subtest invalid-properties-legacy: SUCCESS (0.104s)
[126.576879] [022/131] (923s left) gem_spin_batch (resubmit)
[126.643751] Starting subtest: resubmit
[126.646651] Starting dynamic subtest: rcs0
[126.651854] Dynamic subtest rcs0: SUCCESS (0.007s)
[126.659768] Starting dynamic subtest: bcs0
[126.662383] Dynamic subtest bcs0: SUCCESS (0.002s)
[126.669852] Starting dynamic subtest: vcs0
[126.672470] Dynamic subtest vcs0: SUCCESS (0.002s)
[126.679145] Starting dynamic subtest: vcs1
[126.681411] Dynamic subtest vcs1: SUCCESS (0.002s)
[126.688211] Starting dynamic subtest: vecs0
[126.690324] Dynamic subtest vecs0: SUCCESS (0.004s)
[126.696852] Starting dynamic subtest: ccs0
[126.699340] Dynamic subtest ccs0: SUCCESS (0.003s)
[126.701578] Subtest resubmit: SUCCESS (0.021s)
[126.917827] [023/131] (923s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[126.967335] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[127.073142] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[127.143469] [024/131] (923s left) kms_invalid_mode (zero-clock)
[127.248781] Starting subtest: zero-clock
[127.251403] Starting dynamic subtest: pipe-A-eDP-1
[127.532749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[127.540625] Starting dynamic subtest: pipe-B-eDP-1
[127.543210] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[127.550489] Starting dynamic subtest: pipe-C-eDP-1
[127.553303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[127.562838] Starting dynamic subtest: pipe-D-eDP-1
[127.570404] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[127.573268] Subtest zero-clock: SUCCESS (0.288s)
[128.312829] [025/131] (921s left) prime_busy (hang)
[128.368743] Starting subtest: hang
[128.371880] Starting dynamic subtest: rcs0
[154.699169] Dynamic subtest rcs0: SUCCESS (26.319s)
[154.708977] Starting dynamic subtest: bcs0
[161.854667] Dynamic subtest bcs0: SUCCESS (7.157s)
[161.864685] Starting dynamic subtest: vcs0
[168.894222] Dynamic subtest vcs0: SUCCESS (7.042s)
[168.901742] Starting dynamic subtest: vcs1
[175.872791] Dynamic subtest vcs1: SUCCESS (6.982s)
[175.882478] Starting dynamic subtest: vecs0
[182.840243] Dynamic subtest vecs0: SUCCESS (6.969s)
[182.850313] Starting dynamic subtest: ccs0
[196.742368] Dynamic subtest ccs0: SUCCESS (13.903s)
[196.744956] Subtest hang: SUCCESS (68.375s)
[196.871604] [026/131] (853s left) gem_mmap_gtt (basic-short)
[196.930892] Subtest basic-short: SKIP (0.000s)
[196.981125] [027/131] (853s left) kms_psr2_su (page_flip-xrgb8888)
[197.054942] Subtest page_flip-XRGB8888: SKIP (0.000s)
[197.110529] [028/131] (853s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[197.214993] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[198.190561] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.978s)
[198.317989] [029/131] (852s left) gem_fence_thrash (bo-write-verify-threaded-none)
[198.356688] Starting subtest: bo-write-verify-threaded-none
[198.377967] Subtest bo-write-verify-threaded-none: SKIP (0.020s)
[198.436247] [030/131] (851s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[198.488375] Starting subtest: etime-multi-wait-all-available-unsubmitted
[198.593109] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[198.667285] [031/131] (851s left) kms_addfb_basic (addfb25-modifier-no-flag)
[198.759204] Starting subtest: addfb25-modifier-no-flag
[198.761729] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[198.849986] [032/131] (851s left) kms_pipe_crc_basic (hang-read-crc)
[198.952120] Starting subtest: hang-read-crc
[198.954753] Starting dynamic subtest: pipe-A-eDP-1
[200.980232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.025s)
[200.988952] Starting dynamic subtest: pipe-B-eDP-1
[203.626819] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s)
[203.635520] Starting dynamic subtest: pipe-C-eDP-1
[206.221876] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.593s)
[206.230088] Starting dynamic subtest: pipe-D-eDP-1
[208.877552] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s)
[208.880284] Subtest hang-read-crc: SUCCESS (9.921s)
[209.732809] [033/131] (840s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[209.830813] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[209.833708] Starting dynamic subtest: pipe-A
[210.346704] Dynamic subtest pipe-A: SUCCESS (0.516s)
[210.356938] Starting dynamic subtest: pipe-B
[211.907066] Dynamic subtest pipe-B: SUCCESS (1.560s)
[211.915451] Starting dynamic subtest: pipe-C
[213.526751] Dynamic subtest pipe-C: SUCCESS (1.619s)
[213.536502] Starting dynamic subtest: pipe-D
[215.081734] Dynamic subtest pipe-D: SUCCESS (1.554s)
[215.084304] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (5.251s)
[216.244050] [034/131] (834s left) gem_exec_schedule (deep)
[216.430805] Starting subtest: deep
[216.433727] Starting dynamic subtest: rcs0
[221.432503] Dynamic subtest rcs0: SKIP (4.998s)
[221.440762] Starting dynamic subtest: vcs0
[232.372059] Dynamic subtest vcs0: SUCCESS (10.940s)
[232.384640] Starting dynamic subtest: vcs1
[244.389791] Dynamic subtest vcs1: SUCCESS (12.018s)
[244.400966] Starting dynamic subtest: vecs0
[256.289661] Dynamic subtest vecs0: SUCCESS (11.902s)
[256.299224] Starting dynamic subtest: ccs0
[268.755975] Dynamic subtest ccs0: SUCCESS (12.468s)
[268.758485] Subtest deep: SUCCESS (52.328s)
[269.831554] [035/131] (780s left) kms_tv_load_detect (load-detect)
[269.892958] Subtest load-detect: SKIP (0.000s)
[269.946331] [036/131] (780s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[270.056496] Starting subtest: fbcpsr-tiling-y
[270.061797] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[270.154100] [037/131] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[270.255089] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[270.259851] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[270.363345] [038/131] (780s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[270.472622] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[270.477158] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[270.559548] [039/131] (780s left) api_intel_bb (intel-bb-blit-y)
[270.619090] Starting subtest: intel-bb-blit-y
[274.203841] Subtest intel-bb-blit-y: SUCCESS (3.588s)
[274.305071] [040/131] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[274.406851] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[274.411734] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[274.497381] [041/131] (776s left) gem_pwrite (basic-exhaustion)
[274.555582] Subtest basic-exhaustion: SKIP (0.000s)
[274.610889] [042/131] (776s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[274.700832] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[274.703521] Starting dynamic subtest: pipe-A-eDP-1
[274.728290] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[274.737236] Starting dynamic subtest: pipe-B-eDP-1
[274.762433] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[274.770761] Starting dynamic subtest: pipe-C-eDP-1
[274.796413] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[274.804490] Starting dynamic subtest: pipe-D-eDP-1
[274.830955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[274.835672] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[276.884545] [043/131] (773s left) kms_lease (lease-unleased-crtc)
[276.976383] Starting subtest: lease-unleased-crtc
[276.978798] Starting dynamic subtest: pipe-A-eDP-1
[277.267569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[277.277006] Starting dynamic subtest: pipe-B-eDP-1
[278.031718] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[278.045271] Starting dynamic subtest: pipe-C-eDP-1
[278.048601] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[278.064047] Starting dynamic subtest: pipe-D-eDP-1
[278.066841] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[278.069825] Subtest lease-unleased-crtc: SUCCESS (1.074s)
[278.410112] [044/131] (772s left) gem_ctx_persistence (heartbeat-many)
[278.473976] Starting subtest: heartbeat-many
[278.479086] Subtest heartbeat-many: SKIP (0.000s)
[278.586021] [045/131] (772s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[278.689728] Starting subtest: 4-tiled-16bpp-rotate-180
[280.046553] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.356s)
[280.270232] [046/131] (770s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[280.384187] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[281.630236] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.249s)
[281.828886] [047/131] (769s left) syncobj_timeline (wait-any-snapshot)
[281.887797] Starting subtest: wait-any-snapshot
[281.967963] Subtest wait-any-snapshot: SUCCESS (0.082s)
[282.043627] [048/131] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[282.148778] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[286.644560] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.501s)
[286.773149] [049/131] (764s left) kms_addfb_basic (bad-pitch-1024)
[286.840563] Starting subtest: bad-pitch-1024
[286.843211] Subtest bad-pitch-1024: SUCCESS (0.000s)
[287.003253] [050/131] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[287.100801] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[287.105344] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[287.191710] [051/131] (763s left) sw_sync (sync_merge_same)
[287.229061] Starting subtest: sync_merge_same
[287.231603] Subtest sync_merge_same: SUCCESS (0.000s)
[287.277183] [052/131] (763s left) gem_exec_reloc (basic-wc-read-noreloc)
[287.334522] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[287.394340] [053/131] (763s left) gem_exec_fence (syncobj-timeline-wait)
[287.975379] Starting subtest: syncobj-timeline-wait
[289.245857] Subtest syncobj-timeline-wait: SUCCESS (1.271s)
[291.244430] [054/131] (759s left) gem_exec_balancer (bonded-semaphore)
[291.307613] Starting subtest: bonded-semaphore
[291.312570] Subtest bonded-semaphore: SKIP (0.000s)
[291.578544] [055/131] (759s left) kms_chamelium_color (gamma)
[291.683161] Subtest gamma: SKIP (0.000s)
[291.722277] [056/131] (759s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[291.820828] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[291.825775] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[291.901126] [057/131] (759s left) kms_cursor_crc (cursor-sliding-256x256)
[292.146820] Starting subtest: cursor-sliding-256x256
[292.149451] Starting dynamic subtest: pipe-A-eDP-1
[295.859345] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.708s)
[295.880460] Starting dynamic subtest: pipe-D-eDP-1
[300.218966] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.344s)
[300.221598] Subtest cursor-sliding-256x256: SUCCESS (8.072s)
[301.010164] [058/131] (750s left) gem_exec_whisper (basic-forked)
[301.077789] Starting subtest: basic-forked
[308.572743] Subtest basic-forked: SUCCESS (7.494s)
[308.753870] [059/131] (742s left) i915_pm_rc6_residency (rc6-accuracy)
[308.816818] Starting subtest: rc6-accuracy
[308.819972] Starting dynamic subtest: gt0
[311.987985] Dynamic subtest gt0: SUCCESS (3.170s)
[311.999741] Starting dynamic subtest: gt1
[315.159000] Dynamic subtest gt1: SUCCESS (3.169s)
[315.162111] Subtest rc6-accuracy: SUCCESS (6.342s)
[315.228197] [060/131] (736s left) kms_chamelium_frames (hdmi-frame-dump)
[315.617296] Subtest hdmi-frame-dump: SKIP (0.000s)
[316.404197] [061/131] (735s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[316.462961] Starting subtest: invalid-bsd2-flag-on-blt
[316.465886] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[316.570462] [062/131] (734s left) syncobj_timeline (invalid-transfer-bad-pad)
[316.635262] Starting subtest: invalid-transfer-bad-pad
[316.637884] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[316.738983] [063/131] (734s left) kms_big_fb (linear-64bpp-rotate-0)
[316.846768] Starting subtest: linear-64bpp-rotate-0
[319.239117] Subtest linear-64bpp-rotate-0: SUCCESS (2.394s)
[319.510932] [064/131] (732s left) gem_exec_balancer (parallel-balancer)
[319.755238] Starting subtest: parallel-balancer
[320.471530] Subtest parallel-balancer: SUCCESS (0.716s)
[320.575921] [065/131] (731s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[320.674949] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[320.677478] Starting dynamic subtest: pipe-A
[320.758975] Dynamic subtest pipe-A: SUCCESS (0.083s)
[320.769577] Starting dynamic subtest: pipe-B
[321.951663] Dynamic subtest pipe-B: SUCCESS (1.192s)
[321.959707] Starting dynamic subtest: pipe-C
[323.058891] Dynamic subtest pipe-C: SUCCESS (1.105s)
[323.069672] Starting dynamic subtest: pipe-D
[324.180950] Dynamic subtest pipe-D: SUCCESS (1.121s)
[324.183688] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.504s)
[325.331428] [066/131] (726s left) gem_mmap_wc (bad-object)
[325.385733] Subtest bad-object: SKIP (0.000s)
[325.439147] [067/131] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[325.549324] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[325.553899] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.641625] [068/131] (726s left) gem_linear_blits (normal)
[326.032898] Starting subtest: normal
[330.192413] Subtest normal: SUCCESS (4.157s)
[330.648969] [069/131] (721s left) kms_frontbuffer_tracking (basic)
[330.799974] Starting subtest: basic
[333.935505] Subtest basic: SUCCESS (3.140s)
[334.048613] [070/131] (717s left) kms_flip (wf_vblank-ts-check)
[334.155341] Starting subtest: wf_vblank-ts-check
[334.157602] Starting dynamic subtest: A-eDP1
[343.091366] Dynamic subtest A-eDP1: SUCCESS (8.932s)
[343.102006] Starting dynamic subtest: B-eDP1
[352.024747] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[352.033608] Starting dynamic subtest: C-eDP1
[360.935631] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[360.947151] Starting dynamic subtest: D-eDP1
[369.870426] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[369.873104] Subtest wf_vblank-ts-check: SUCCESS (35.710s)
[371.084422] [071/131] (680s left) kms_addfb_basic (bo-too-small)
[371.183601] Starting subtest: bo-too-small
[371.186104] Subtest bo-too-small: SUCCESS (0.000s)
[371.283994] [072/131] (680s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[371.390787] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[371.396419] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[371.494978] [073/131] (680s left) prime_self_import (basic-with_two_bos)
[371.531673] Starting subtest: basic-with_two_bos
[371.554719] Subtest basic-with_two_bos: SUCCESS (0.022s)
[371.657408] [074/131] (680s left) gem_render_copy (y-tiled)
[371.729439] Starting subtest: y-tiled
[371.734947] Subtest y-tiled: SKIP (0.000s)
[371.913725] [075/131] (680s left) kms_flip (flip-vs-expired-vblank)
[372.006550] Starting subtest: flip-vs-expired-vblank
[372.009192] Starting dynamic subtest: A-eDP1
[380.688881] Dynamic subtest A-eDP1: SUCCESS (8.681s)
[380.703615] Starting dynamic subtest: B-eDP1
[389.409928] Dynamic subtest B-eDP1: SUCCESS (8.718s)
[389.418660] Starting dynamic subtest: C-eDP1
[398.122870] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[398.132766] Starting dynamic subtest: D-eDP1
[406.845529] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[406.851082] Subtest flip-vs-expired-vblank: SUCCESS (34.842s)
[407.999321] [076/131] (643s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[408.067846] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[408.139318] [077/131] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[408.245934] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[410.843839] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.604s)
[410.964734] [078/131] (641s left) gem_mmap_gtt (fault-concurrent-y)
[411.027253] Subtest fault-concurrent-Y: SKIP (0.000s)
[411.084728] [079/131] (641s left) gem_flink_race (flink_close)
[411.120266] Starting subtest: flink_close
[416.214393] Subtest flink_close: SUCCESS (5.097s)
[416.283152] [080/131] (635s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[416.411517] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[417.774712] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.360s)
[418.570279] [081/131] (633s left) prime_mmap_coherency (ioctl-errors)
[418.629420] Starting subtest: ioctl-errors
[443.823273] Subtest ioctl-errors: SUCCESS (25.195s)
[443.988401] [082/131] (608s left) gem_partial_pwrite_pread (write)
[444.083752] Subtest write: SKIP (0.000s)
[444.153101] [083/131] (608s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[444.269364] Starting subtest: plane-primary-toggle-with-vblank-wait
[444.271722] Starting dynamic subtest: pipe-A-eDP-1
[444.454133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.182s)
[444.754452] Starting dynamic subtest: pipe-B-eDP-1
[445.665155] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.920s)
[445.951766] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.682s)
[446.805708] [084/131] (605s left) kms_psr (psr2-no-drrs)
[446.905708] Starting subtest: psr2-no-drrs
[446.908392] Starting dynamic subtest: eDP-1
[448.465519] Dynamic subtest eDP-1: SUCCESS (1.558s)
[448.467955] Subtest psr2-no-drrs: SUCCESS (1.559s)
[449.253271] [085/131] (603s left) kms_cursor_crc (cursor-onscreen-64x21)
[449.439397] Starting subtest: cursor-onscreen-64x21
[449.474316] Subtest cursor-onscreen-64x21: SKIP (0.031s)
[449.710256] [086/131] (602s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[449.830844] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[449.836215] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[449.925403] [087/131] (602s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[449.991768] Starting subtest: saturated-hostile-nopreempt
[449.994817] Starting dynamic subtest: rcs0
[450.089290] Dynamic subtest rcs0: SKIP (0.094s)
[450.099029] Starting dynamic subtest: bcs0
[450.114518] Dynamic subtest bcs0: SKIP (0.024s)
[450.123242] Starting dynamic subtest: vcs0
[450.141646] Dynamic subtest vcs0: SKIP (0.026s)
[450.150607] Starting dynamic subtest: vcs1
[450.167591] Dynamic subtest vcs1: SKIP (0.025s)
[450.179336] Starting dynamic subtest: vecs0
[450.193827] Dynamic subtest vecs0: SKIP (0.025s)
[450.202556] Starting dynamic subtest: ccs0
[450.219776] Dynamic subtest ccs0: SKIP (0.026s)
[450.224981] Subtest saturated-hostile-nopreempt: SKIP (0.227s)
[450.290177] [088/131] (602s left) perf_pmu (busy-hang)
[450.329507] Starting subtest: busy-hang
[450.331826] Starting dynamic subtest: rcs0
[451.621130] Dynamic subtest rcs0: SUCCESS (1.289s)
[451.632989] Starting dynamic subtest: bcs0
[452.857750] Dynamic subtest bcs0: SUCCESS (1.235s)
[452.869226] Starting dynamic subtest: vcs0
[454.720989] Dynamic subtest vcs0: SUCCESS (1.862s)
[454.732501] Starting dynamic subtest: vcs1
[456.698823] Dynamic subtest vcs1: SUCCESS (1.976s)
[456.709580] Starting dynamic subtest: vecs0
[458.743873] Dynamic subtest vecs0: SUCCESS (2.043s)
[458.754381] Starting dynamic subtest: ccs0
[459.986941] Dynamic subtest ccs0: SUCCESS (1.242s)
[459.989988] Subtest busy-hang: SUCCESS (9.657s)
[460.086620] [089/131] (592s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[460.196474] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[464.685667] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.492s)
[464.831242] [090/131] (587s left) kms_atomic (atomic-invalid-params)
[464.940702] Starting subtest: atomic-invalid-params
[464.943353] Starting dynamic subtest: pipe-A-eDP-1
[465.361071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[465.363945] Subtest atomic-invalid-params: SUCCESS (0.418s)
[466.228261] [091/131] (586s left) gen9_exec_parse (bb-start-out)
[466.296805] Subtest bb-start-out: SKIP (0.000s)
[466.380306] [092/131] (586s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[466.443941] Subtest writes-after-reads-uncached: SKIP (0.000s)
[466.504248] [093/131] (586s left) gem_exec_flush (basic-uc-set-default)
[466.571752] Starting subtest: basic-uc-set-default
[472.042383] Subtest basic-uc-set-default: SUCCESS (5.472s)
[472.234077] [094/131] (580s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[472.339823] Starting subtest: psr-rgb565-draw-pwrite
[477.210218] Subtest psr-rgb565-draw-pwrite: SUCCESS (4.874s)
[477.306138] [095/131] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[477.412341] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[477.417625] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[477.490257] [096/131] (575s left) gem_vm_create (invalid-destroy)
[477.545657] Starting subtest: invalid-destroy
[477.548572] Subtest invalid-destroy: SUCCESS (0.002s)
[477.657881] [097/131] (575s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[477.760816] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[477.763489] Starting dynamic subtest: pipe-A
[477.775975] Dynamic subtest pipe-A: SKIP (0.011s)
[477.785416] Starting dynamic subtest: pipe-B
[477.794735] Dynamic subtest pipe-B: SKIP (0.020s)
[477.803539] Starting dynamic subtest: pipe-C
[477.816394] Dynamic subtest pipe-C: SKIP (0.021s)
[477.824944] Starting dynamic subtest: pipe-D
[477.837189] Dynamic subtest pipe-D: SKIP (0.020s)
[477.841929] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.073s)
[477.926646] [098/131] (574s left) kms_psr (fbc-pr-sprite-plane-onoff)
[478.020658] Starting subtest: fbc-pr-sprite-plane-onoff
[478.025051] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[478.085739] [099/131] (574s left) dmabuf_sync_file (import-multiple-read-write)
[478.125768] Starting subtest: import-multiple-read-write
[478.134842] Subtest import-multiple-read-write: SUCCESS (0.014s)
[478.186303] [100/131] (574s left) kms_vblank (wait-busy)
[478.286397] Starting subtest: wait-busy
[478.288943] Starting dynamic subtest: pipe-A-eDP-1
[480.173950] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[480.188637] Starting dynamic subtest: pipe-D-eDP-1
[482.747557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.572s)
[482.749985] Subtest wait-busy: SUCCESS (4.459s)
[483.533583] [101/131] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[483.639653] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[488.447698] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.804s)
[488.609189] [102/131] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[488.792743] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[488.816250] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[488.890036] [103/131] (564s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[489.056228] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[489.087451] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[489.174899] [104/131] (563s left) gem_barrier_race (remote-request)
[489.322621] Starting subtest: remote-request
[489.339315] Starting dynamic subtest: rcs0
[494.526786] Dynamic subtest rcs0: SUCCESS (5.217s)
[494.531316] Subtest remote-request: SUCCESS (5.218s)
[494.662293] [105/131] (558s left) perf_pmu (gt-awake)
[494.702164] Starting subtest: gt-awake
[503.223204] Subtest gt-awake: SUCCESS (8.521s)
[503.324200] [106/131] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[503.432786] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[503.437881] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[503.539754] [107/131] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[503.647535] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[503.652703] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[503.752690] [108/131] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[503.861819] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[503.867007] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[503.967794] [109/131] (549s left) kms_psr (psr-dpms)
[504.057867] Starting subtest: psr-dpms
[504.060620] Starting dynamic subtest: eDP-1
[507.011643] Dynamic subtest eDP-1: SUCCESS (2.952s)
[507.014571] Subtest psr-dpms: SUCCESS (2.953s)
[507.857422] [110/131] (545s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[507.980713] Starting subtest: cursorA-vs-flipB-legacy
[507.985837] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[508.076409] [111/131] (545s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[508.173687] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[508.176417] Starting dynamic subtest: pipe-A-default-mode
[508.465644] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[508.470552] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.289s)
[509.280286] [112/131] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[509.390667] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[509.395697] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[509.480323] [113/131] (543s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[509.602748] Starting subtest: verify-pxp-key-change-after-suspend-resume
[516.685456] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.086s)
[516.813729] [114/131] (536s left) gem_exec_schedule (preemptive-hang)
[516.995281] Starting subtest: preemptive-hang
[516.998374] Starting dynamic subtest: rcs0
[526.298655] Dynamic subtest rcs0: SUCCESS (9.302s)
[526.308020] Starting dynamic subtest: bcs0
[535.322444] Dynamic subtest bcs0: SUCCESS (9.023s)
[535.331865] Starting dynamic subtest: vcs0
[544.347592] Dynamic subtest vcs0: SUCCESS (9.023s)
[544.362988] Starting dynamic subtest: vcs1
[553.306334] Dynamic subtest vcs1: SUCCESS (8.958s)
[553.322987] Starting dynamic subtest: vecs0
[562.328966] Dynamic subtest vecs0: SUCCESS (9.022s)
[562.341458] Starting dynamic subtest: ccs0
[571.354396] Dynamic subtest ccs0: SUCCESS (9.024s)
[571.357318] Subtest preemptive-hang: SUCCESS (54.361s)
[571.600502] [115/131] (481s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[571.701657] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[571.704517] Starting dynamic subtest: pipe-A-eDP-1
[571.730942] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.741567] Starting dynamic subtest: pipe-B-eDP-1
[571.766852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.775624] Starting dynamic subtest: pipe-C-eDP-1
[571.800863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.809290] Starting dynamic subtest: pipe-D-eDP-1
[571.835705] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.840789] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[573.885585] [116/131] (479s left) kms_pm_rpm (modeset-stress-extra-wait)
[575.429109] Starting subtest: modeset-stress-extra-wait
[629.578553] Subtest modeset-stress-extra-wait: SUCCESS (54.151s)
[629.665115] [117/131] (423s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[629.764390] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[629.766594] Starting dynamic subtest: pipe-A-eDP-1
[629.788437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[629.797657] Starting dynamic subtest: pipe-B-eDP-1
[629.821553] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[629.830358] Starting dynamic subtest: pipe-C-eDP-1
[629.853784] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[629.862507] Starting dynamic subtest: pipe-D-eDP-1
[629.886362] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[629.888836] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[631.883285] [118/131] (421s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[631.994828] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[632.000894] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[632.102992] [119/131] (421s left) prime_mmap (test_forked_cpu_write)
[632.166658] Starting subtest: test_forked_cpu_write
[632.168828] Starting dynamic subtest: test_forked_cpu_write-smem
[632.172846] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[632.175808] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[632.284315] [120/131] (421s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[632.359954] Starting subtest: y-tiled-to-vebox-x-tiled
[632.365733] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[632.540165] [121/131] (421s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-different-formats)
[633.002477] Subtest fbc-dirty-rectangle-different-formats: SKIP (0.000s)
[633.050158] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-different-formats)] new: kernel.kmod_is_loaded.xe: true
[633.053787] [122/131] (420s left) kms_pm_dc (dc6-psr)
[634.155309] Starting subtest: dc6-psr
[641.490935] Subtest dc6-psr: FAIL (6.626s)
[641.526242] [123/131] (412s left) kms_color (ctm-negative)
[641.625716] Starting subtest: ctm-negative
[641.628389] Starting dynamic subtest: pipe-A-eDP-1
[642.348163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[642.359541] Starting dynamic subtest: pipe-B-eDP-1
[643.773171] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[643.783963] Starting dynamic subtest: pipe-C-eDP-1
[645.139941] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[645.150642] Starting dynamic subtest: pipe-D-eDP-1
[646.464954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[646.467335] Subtest ctm-negative: SUCCESS (4.837s)
[647.292659] [124/131] (406s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[647.409421] Starting subtest: psr-1p-primscrn-cur-indfb-move
[652.520990] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.115s)
[652.638542] [125/131] (401s left) kms_cursor_edge_walk (256x256-left-edge)
[652.749619] Starting subtest: 256x256-left-edge
[652.752357] Starting dynamic subtest: pipe-A-eDP-1
[656.194253] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[656.204362] Starting dynamic subtest: pipe-D-eDP-1
[659.293578] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.097s)
[659.296543] Subtest 256x256-left-edge: SUCCESS (6.542s)
[660.113281] [126/131] (393s left) kms_psr (pr-cursor-mmap-gtt)
[660.218667] Starting subtest: pr-cursor-mmap-gtt
[660.223834] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[660.286745] [127/131] (393s left) kms_dp_linktrain_fallback (dp-fallback)
[660.384872] Starting subtest: dp-fallback
[660.393109] Subtest dp-fallback: SKIP (0.000s)
[660.455630] [128/131] (393s left) sysfs_timeslice_duration (idempotent)
[660.528937] Starting subtest: idempotent
[660.531660] Starting dynamic subtest: vecs0
[660.534494] Dynamic subtest vecs0: SUCCESS (0.000s)
[660.543805] Starting dynamic subtest: ccs0
[660.546697] Dynamic subtest ccs0: SUCCESS (0.000s)
[660.555782] Starting dynamic subtest: vcs0
[660.558739] Dynamic subtest vcs0: SUCCESS (0.000s)
[660.567777] Starting dynamic subtest: bcs0
[660.570567] Dynamic subtest bcs0: SUCCESS (0.000s)
[660.579314] Starting dynamic subtest: rcs0
[660.581870] Dynamic subtest rcs0: SUCCESS (0.000s)
[660.590961] Starting dynamic subtest: vcs1
[660.593402] Dynamic subtest vcs1: SUCCESS (0.000s)
[660.595946] Subtest idempotent: SUCCESS (0.005s)
[660.636560] [129/131] (393s left) i915_pm_rpm (reg-read-ioctl)
[662.369704] Starting subtest: reg-read-ioctl
[664.663585] Subtest reg-read-ioctl: SUCCESS (2.294s)
[665.010692] [130/131] (388s left) drm_fdinfo (most-busy-idle-check-all)
[665.054457] Starting subtest: most-busy-idle-check-all
[665.056897] Starting dynamic subtest: rcs0
[665.063235] Dynamic subtest rcs0: SKIP (0.004s)
[665.073573] Starting dynamic subtest: bcs0
[665.078231] Dynamic subtest bcs0: SKIP (0.000s)
[665.087988] Starting dynamic subtest: vcs0
[665.093635] Dynamic subtest vcs0: SKIP (0.000s)
[665.102061] Starting dynamic subtest: vcs1
[665.106626] Dynamic subtest vcs1: SKIP (0.000s)
[665.115132] Starting dynamic subtest: vecs0
[665.119592] Dynamic subtest vecs0: SKIP (0.000s)
[665.128177] Starting dynamic subtest: ccs0
[665.132433] Dynamic subtest ccs0: SKIP (0.000s)
[665.137104] Subtest most-busy-idle-check-all: SKIP (0.009s)
[665.168518] [131/131] (388s left) kms_flip (2x-modeset-vs-vblank-race)
[665.308867] Starting subtest: 2x-modeset-vs-vblank-race
[665.319372] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[665.436064] Closing watchdogs
Done.