[60.725551] Initializing watchdogs
[60.725600]   /dev/watchdog0
[60.739448] [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]
[60.743884] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.746612] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.750130] [001/131] (960s left) i915_selftest (live)
[64.021567] Starting subtest: live
[64.023806] Starting dynamic subtest: sanitycheck
[68.341294] Dynamic subtest sanitycheck: SUCCESS (4.319s)
[68.349624] Starting dynamic subtest: uncore
[72.626883] Dynamic subtest uncore: SUCCESS (4.284s)
[72.633149] Starting dynamic subtest: workarounds
[75.635592] Dynamic subtest workarounds: SUCCESS (3.007s)
[75.643633] Starting dynamic subtest: gt_engines
[78.644037] Dynamic subtest gt_engines: SUCCESS (3.007s)
[78.652236] Starting dynamic subtest: gt_timelines
[94.470999] Dynamic subtest gt_timelines: SUCCESS (15.825s)
[94.479584] Starting dynamic subtest: gt_contexts
[98.731226] Dynamic subtest gt_contexts: SUCCESS (4.260s)
[98.739909] Starting dynamic subtest: gt_lrc
[104.673237] Dynamic subtest gt_lrc: SUCCESS (5.941s)
[104.681434] Starting dynamic subtest: gt_mocs
[107.537041] Dynamic subtest gt_mocs: SUCCESS (2.863s)
[107.545244] Starting dynamic subtest: gt_pm
[114.212636] Dynamic subtest gt_pm: SUCCESS (6.675s)
[114.221607] Starting dynamic subtest: gt_heartbeat
[118.481823] Dynamic subtest gt_heartbeat: SUCCESS (4.267s)
[118.490702] Starting dynamic subtest: gt_tlb
[127.731865] Dynamic subtest gt_tlb: SUCCESS (9.249s)
[127.740340] Starting dynamic subtest: requests
[139.080856] Dynamic subtest requests: SUCCESS (11.347s)
[139.089676] Starting dynamic subtest: migrate
[146.788804] Dynamic subtest migrate: SUCCESS (7.707s)
[146.797355] Starting dynamic subtest: active
[149.420800] Dynamic subtest active: SUCCESS (2.631s)
[149.429683] Starting dynamic subtest: objects
[154.043769] Dynamic subtest objects: SUCCESS (4.622s)
[154.052725] Starting dynamic subtest: mman
[158.849910] Dynamic subtest mman: SUCCESS (4.805s)
[158.858260] Starting dynamic subtest: dmabuf
[161.503771] Dynamic subtest dmabuf: SUCCESS (2.653s)
[161.512162] Starting dynamic subtest: vma
[164.382836] Dynamic subtest vma: SUCCESS (2.878s)
[164.393657] Starting dynamic subtest: coherency
[169.350838] Dynamic subtest coherency: SUCCESS (4.966s)
[169.359518] Starting dynamic subtest: gtt
[181.057059] Dynamic subtest gtt: SUCCESS (11.705s)
[181.065659] Starting dynamic subtest: gem
[186.595535] Dynamic subtest gem: SUCCESS (5.537s)
[186.604061] Starting dynamic subtest: evict
[190.547485] Dynamic subtest evict: SUCCESS (3.951s)
[190.556851] Starting dynamic subtest: hugepages
[201.300963] Dynamic subtest hugepages: SUCCESS (10.752s)
[201.309749] Starting dynamic subtest: gem_contexts
[229.848251] Dynamic subtest gem_contexts: SUCCESS (28.546s)
[229.856878] Starting dynamic subtest: client
[232.602238] Dynamic subtest client: SUCCESS (2.754s)
[232.611126] Starting dynamic subtest: gem_migrate
[236.941564] Dynamic subtest gem_migrate: SUCCESS (4.338s)
[236.950655] Starting dynamic subtest: reset
[239.669693] Dynamic subtest reset: SUCCESS (2.727s)
[239.678413] Starting dynamic subtest: memory_region
[243.969055] Dynamic subtest memory_region: SUCCESS (4.298s)
[243.978020] Starting dynamic subtest: hangcheck
[257.067879] Dynamic subtest hangcheck: SUCCESS (13.096s)
[257.076928] Starting dynamic subtest: execlists
[261.361040] Dynamic subtest execlists: SUCCESS (4.291s)
[261.370072] Starting dynamic subtest: ring_submission
[264.078477] Dynamic subtest ring_submission: SUCCESS (2.717s)
[264.087552] Starting dynamic subtest: perf
[268.364954] Dynamic subtest perf: SUCCESS (4.284s)
[268.373543] Starting dynamic subtest: slpc
[282.443506] Dynamic subtest slpc: SUCCESS (14.077s)
[282.451656] Starting dynamic subtest: guc
[286.338356] Dynamic subtest guc: SUCCESS (3.893s)
[286.347052] Starting dynamic subtest: guc_multi_lrc
[288.995972] Dynamic subtest guc_multi_lrc: SUCCESS (2.657s)
[289.004267] Starting dynamic subtest: guc_hang
[293.878388] Dynamic subtest guc_hang: SUCCESS (4.880s)
[293.887659] Starting dynamic subtest: late_gt_pm
[298.165829] Dynamic subtest late_gt_pm: SUCCESS (4.286s)
[298.168570] Subtest live: SUCCESS (234.132s)
[298.194362] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[298.197377] [002/131] (723s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[299.740293] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[299.742604] Starting dynamic subtest: pipe-A-eDP-1
[299.765123] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[299.773527] Starting dynamic subtest: pipe-B-eDP-1
[299.795752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.802981] Starting dynamic subtest: pipe-C-eDP-1
[299.824213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.830740] Starting dynamic subtest: pipe-D-eDP-1
[299.852294] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.856681] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[302.035161] [FACT kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)] new: kernel.kmod_is_loaded.i915: true
[302.038712] [003/131] (719s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[302.162016] Starting subtest: basic-flip-before-cursor-atomic
[303.108204] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.945s)
[303.942549] [004/131] (717s left) syncobj_timeline (invalid-signal-zero-handles)
[304.006938] Starting subtest: invalid-signal-zero-handles
[304.009427] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[304.108278] [005/131] (717s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[304.198657] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[304.202616] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[304.297812] [006/131] (717s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[304.373370] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[304.377724] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[304.551515] [007/131] (716s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[304.609096] Starting subtest: single-wait-for-submit-unsubmitted
[304.712789] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[304.783957] [008/131] (716s left) kms_cursor_crc (cursor-offscreen-64x64)
[304.965588] Starting subtest: cursor-offscreen-64x64
[304.970475] Starting dynamic subtest: pipe-A-eDP-1
[306.908683] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[306.936092] Starting dynamic subtest: pipe-D-eDP-1
[309.564664] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.632s)
[309.566652] Subtest cursor-offscreen-64x64: SUCCESS (4.596s)
[310.436553] [009/131] (711s left) kms_psr (psr2-cursor-plane-move)
[310.550019] Starting subtest: psr2-cursor-plane-move
[310.552151] Starting dynamic subtest: eDP-1
[312.237942] Dynamic subtest eDP-1: SUCCESS (1.685s)
[312.240140] Subtest psr2-cursor-plane-move: SUCCESS (1.686s)
[313.030000] [010/131] (708s left) gem_softpin (evict-active-interruptible)
[313.097257] Starting subtest: evict-active-interruptible
[313.103740] Subtest evict-active-interruptible: SUCCESS (0.007s)
[313.209781] [011/131] (708s left) kms_async_flips (test-time-stamp)
[313.308452] Starting subtest: test-time-stamp
[313.700550] Starting dynamic subtest: pipe-A-eDP-1
[314.459269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s)
[314.838499] Starting dynamic subtest: pipe-B-eDP-1
[315.596067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[315.990433] Starting dynamic subtest: pipe-C-eDP-1
[316.736530] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.752s)
[317.098701] Starting dynamic subtest: pipe-D-eDP-1
[317.870136] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[317.872638] Subtest test-time-stamp: SUCCESS (4.562s)
[319.018444] [012/131] (702s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[319.080521] Subtest tiled-to-tiled: SKIP (0.000s)
[319.146773] [013/131] (702s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[319.242737] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[320.345712] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.103s)
[320.454416] [014/131] (701s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[320.555540] Starting subtest: y-tiled-8bpp-rotate-90
[320.559204] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[320.650715] [015/131] (701s left) kms_psr (psr2-cursor-blt)
[320.749558] Starting subtest: psr2-cursor-blt
[320.751500] Starting dynamic subtest: eDP-1
[322.512390] Dynamic subtest eDP-1: SUCCESS (1.763s)
[322.514679] Subtest psr2-cursor-blt: SUCCESS (1.764s)
[323.391304] [016/131] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[323.492943] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[323.497292] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[323.604134] [017/131] (698s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[323.710385] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[324.557199] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[324.710689] [018/131] (697s left) kms_properties (colorop-properties-legacy)
[324.810872] Starting subtest: colorop-properties-legacy
[324.813186] Starting dynamic subtest: pipe-A-eDP-1
[325.177436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[325.189804] Starting dynamic subtest: pipe-B-eDP-1
[326.268166] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[326.276750] Starting dynamic subtest: pipe-C-eDP-1
[327.306303] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.036s)
[327.314925] Starting dynamic subtest: pipe-D-eDP-1
[328.338839] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.033s)
[328.341299] Subtest colorop-properties-legacy: SUCCESS (3.529s)
[329.129460] [019/131] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[329.216873] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[336.648503] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.435s)
[336.779123] [020/131] (685s left) gem_exec_reloc (basic-cpu)
[336.847369] Subtest basic-cpu: SKIP (0.000s)
[336.918430] [021/131] (685s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[336.980667] Starting subtest: etime-single-wait-available-unsubmitted
[337.089394] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[337.174563] [022/131] (684s left) core_sysfs (read-all-entries)
[337.234825] Starting subtest: read-all-entries
[337.237258] Subtest read-all-entries: SUCCESS (0.003s)
[337.357234] [023/131] (684s left) kms_force_connector_basic (prune-stale-modes)
[337.437461] Starting subtest: prune-stale-modes
[337.877836] Subtest prune-stale-modes: SUCCESS (0.440s)
[338.014090] [024/131] (684s left) perf_pmu (init-busy)
[338.057497] Starting subtest: init-busy
[338.059689] Starting dynamic subtest: rcs0
[338.061901] Dynamic subtest rcs0: SUCCESS (0.001s)
[338.070245] Starting dynamic subtest: bcs0
[338.072388] Dynamic subtest bcs0: SUCCESS (0.000s)
[338.080127] Starting dynamic subtest: vcs0
[338.082348] Dynamic subtest vcs0: SUCCESS (0.001s)
[338.089623] Starting dynamic subtest: vcs1
[338.091551] Dynamic subtest vcs1: SUCCESS (0.001s)
[338.098203] Starting dynamic subtest: vecs0
[338.100185] Dynamic subtest vecs0: SUCCESS (0.001s)
[338.107290] Starting dynamic subtest: ccs0
[338.109184] Dynamic subtest ccs0: SUCCESS (0.000s)
[338.111102] Subtest init-busy: SUCCESS (0.008s)
[338.154637] [025/131] (684s left) syncobj_wait (invalid-signal-one-illegal-handle)
[338.217803] Starting subtest: invalid-signal-one-illegal-handle
[338.219798] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[338.324789] [026/131] (683s left) kms_flip (flip-vs-expired-vblank)
[338.416571] Starting subtest: flip-vs-expired-vblank
[338.418448] Starting dynamic subtest: A-eDP1
[347.064829] Dynamic subtest A-eDP1: SUCCESS (8.649s)
[347.075895] Starting dynamic subtest: B-eDP1
[355.735548] Dynamic subtest B-eDP1: SUCCESS (8.670s)
[355.744551] Starting dynamic subtest: C-eDP1
[364.425171] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[364.437093] Starting dynamic subtest: D-eDP1
[373.129592] Dynamic subtest D-eDP1: SUCCESS (8.701s)
[373.135637] Subtest flip-vs-expired-vblank: SUCCESS (34.720s)
[374.376797] [027/131] (647s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[374.472125] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[374.474254] Starting dynamic subtest: pipe-A
[374.535267] Dynamic subtest pipe-A: SUCCESS (0.065s)
[374.545040] Starting dynamic subtest: pipe-B
[375.655602] Dynamic subtest pipe-B: SUCCESS (1.119s)
[375.665783] Starting dynamic subtest: pipe-C
[376.736220] Dynamic subtest pipe-C: SUCCESS (1.079s)
[376.744621] Starting dynamic subtest: pipe-D
[377.845937] Dynamic subtest pipe-D: SUCCESS (1.109s)
[377.848567] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.376s)
[378.962542] [028/131] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[379.021421] Starting subtest: etime-multi-wait-all-available-unsubmitted
[379.129062] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[379.223596] [029/131] (643s left) gem_exec_fence (basic-wait)
[379.401542] Starting subtest: basic-wait
[379.403990] Starting dynamic subtest: rcs0
[379.474737] Dynamic subtest rcs0: SUCCESS (0.073s)
[379.484910] Starting dynamic subtest: bcs0
[379.529273] Dynamic subtest bcs0: SUCCESS (0.053s)
[379.538785] Starting dynamic subtest: vcs0
[379.581672] Dynamic subtest vcs0: SUCCESS (0.051s)
[379.591123] Starting dynamic subtest: vcs1
[379.632172] Dynamic subtest vcs1: SUCCESS (0.048s)
[379.641416] Starting dynamic subtest: vecs0
[379.679996] Dynamic subtest vecs0: SUCCESS (0.046s)
[379.688956] Starting dynamic subtest: ccs0
[379.736862] Dynamic subtest ccs0: SUCCESS (0.055s)
[379.739826] Subtest basic-wait: SUCCESS (0.337s)
[381.960712] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[381.964541] [030/131] (640s left) sysfs_timeslice_duration (duration)
[382.037465] Starting subtest: duration
[382.039765] Starting dynamic subtest: vecs0
[395.828763] Dynamic subtest vecs0: SUCCESS (13.788s)
[395.839553] Starting dynamic subtest: ccs0
[408.968112] Dynamic subtest ccs0: SUCCESS (13.138s)
[408.981071] Starting dynamic subtest: vcs0
[422.834996] Dynamic subtest vcs0: SUCCESS (13.863s)
[422.848135] Starting dynamic subtest: bcs0
[435.968053] Dynamic subtest bcs0: SUCCESS (13.131s)
[435.978589] Starting dynamic subtest: rcs0
[449.113954] Dynamic subtest rcs0: SUCCESS (13.143s)
[449.125279] Starting dynamic subtest: vcs1
[462.835971] Dynamic subtest vcs1: SUCCESS (13.717s)
[462.838879] Subtest duration: SUCCESS (80.796s)
[462.911321] [031/131] (559s left) gem_ctx_param (get-priority-new-ctx)
[462.970400] Starting subtest: get-priority-new-ctx
[462.972849] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[463.066456] [032/131] (559s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[463.168964] Starting subtest: primary-yf-tiled-reflect-x-0
[463.228914] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[463.334209] [033/131] (559s left) i915_pm_freq_mult (media-freq)
[463.387957] Starting subtest: media-freq
[463.390320] Starting dynamic subtest: gt0
[463.394876] Dynamic subtest gt0: SKIP (0.000s)
[463.405940] Starting dynamic subtest: gt1
[463.410732] Dynamic subtest gt1: SKIP (0.000s)
[463.415157] Subtest media-freq: SKIP (0.001s)
[463.477310] [034/131] (559s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[463.569344] Starting subtest: primary-4-tiled-reflect-x-180
[470.595120] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.028s)
[471.756306] [035/131] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[471.850861] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[477.113227] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.266s)
[478.277888] [036/131] (544s left) kms_plane_lowres (tiling-y)
[478.365956] Starting subtest: tiling-y
[478.370192] Subtest tiling-y: SKIP (0.000s)
[478.459286] [037/131] (544s left) gem_exec_params (invalid-flag)
[478.510372] Starting subtest: invalid-flag
[478.512796] Subtest invalid-flag: SUCCESS (0.000s)
[478.633088] [038/131] (544s left) kms_pm_dc (dc6-dpms)
[479.730080] Starting subtest: dc6-dpms
[481.805423] Subtest dc6-dpms: SUCCESS (2.074s)
[481.886042] [039/131] (540s left) gem_userptr_blits (map-fixed-invalidate-busy)
[481.958713] Starting subtest: map-fixed-invalidate-busy
[481.962837] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[482.063919] [040/131] (540s left) kms_psr (fbc-pr-no-drrs)
[482.168148] Starting subtest: fbc-pr-no-drrs
[482.172322] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[482.255465] [041/131] (540s left) i915_drm_fdinfo (virtual-busy-hang)
[482.297025] Starting subtest: virtual-busy-hang
[482.301362] Subtest virtual-busy-hang: SKIP (0.000s)
[482.364332] [042/131] (540s left) kms_invalid_mode (bad-vsync-start)
[482.467346] Starting subtest: bad-vsync-start
[482.469559] Starting dynamic subtest: pipe-A-eDP-1
[482.754342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[482.762829] Starting dynamic subtest: pipe-B-eDP-1
[482.764796] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[482.772473] Starting dynamic subtest: pipe-C-eDP-1
[482.774396] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[482.782209] Starting dynamic subtest: pipe-D-eDP-1
[482.784372] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[482.786605] Subtest bad-vsync-start: SUCCESS (0.297s)
[483.558649] [043/131] (539s left) kms_chamelium_color (ctm-0-75)
[483.654256] Subtest ctm-0-75: SKIP (0.000s)
[483.698468] [044/131] (539s left) kms_content_protection (legacy)
[483.841313] Starting subtest: legacy
[483.846045] Subtest legacy: SKIP (0.000s)
[483.951467] [045/131] (539s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[484.057803] Starting subtest: fbc-rgb565-draw-blt
[488.177593] Subtest fbc-rgb565-draw-blt: SUCCESS (4.123s)
[489.368274] [046/131] (533s left) gem_eio (wait-1us)
[489.606077] Starting subtest: wait-1us
[489.951093] Subtest wait-1us: SUCCESS (0.346s)
[490.094412] [047/131] (532s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[490.194851] Starting subtest: blocking-absolute-wf_vblank-interruptible
[490.196666] Starting dynamic subtest: A-eDP1
[498.877262] Dynamic subtest A-eDP1: SUCCESS (8.680s)
[498.887352] Starting dynamic subtest: B-eDP1
[507.578025] Dynamic subtest B-eDP1: SUCCESS (8.699s)
[507.590822] Starting dynamic subtest: C-eDP1
[516.266042] Dynamic subtest C-eDP1: SUCCESS (8.685s)
[516.277345] Starting dynamic subtest: D-eDP1
[524.970720] Dynamic subtest D-eDP1: SUCCESS (8.702s)
[524.976091] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.778s)
[526.159896] [048/131] (496s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[526.263772] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[526.267902] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[526.374097] [049/131] (496s left) kms_psr (fbc-psr-no-drrs)
[526.474320] Starting subtest: fbc-psr-no-drrs
[526.476559] Starting dynamic subtest: eDP-1
[526.480948] Dynamic subtest eDP-1: SKIP (0.000s)
[526.485362] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[526.545454] [050/131] (496s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[526.638809] Starting subtest: fbc-rgb101010-draw-pwrite
[532.012444] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.376s)
[533.159146] [051/131] (490s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[533.215119] Starting subtest: multi-wait-available-submitted-signaled
[533.217432] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[533.317491] [052/131] (489s left) gem_exec_fence (long-history)
[533.768851] Starting subtest: long-history
[540.678833] Subtest long-history: SUCCESS (6.910s)
[541.220251] [053/131] (482s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[541.329638] Starting subtest: x-tiled-64bpp-rotate-270
[541.353663] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[541.477257] [054/131] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[541.579635] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[541.583709] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[541.669055] [055/131] (481s left) kms_psr (fbc-psr2-sprite-blt)
[541.753929] Starting subtest: fbc-psr2-sprite-blt
[541.756444] Starting dynamic subtest: eDP-1
[541.760582] Dynamic subtest eDP-1: SKIP (0.000s)
[541.764623] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[541.827872] [056/131] (481s left) gem_exec_flush (basic-wb-set-default)
[541.892547] Starting subtest: basic-wb-set-default
[547.350867] Subtest basic-wb-set-default: SUCCESS (5.459s)
[547.551911] [057/131] (475s left) gem_lmem_swapping (random-engines)
[547.593248] Subtest random-engines: SKIP (0.000s)
[547.633504] [058/131] (475s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[547.734067] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[547.738554] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[548.854593] [059/131] (474s left) gen9_exec_parse (batch-without-end)
[548.908849] Subtest batch-without-end: SKIP (0.000s)
[548.982287] [060/131] (474s left) kms_flip (flip-vs-dpms-on-nop)
[549.077515] Starting subtest: flip-vs-dpms-on-nop
[549.079395] Starting dynamic subtest: A-eDP1
[550.913699] Dynamic subtest A-eDP1: SUCCESS (1.838s)
[550.924902] Starting dynamic subtest: B-eDP1
[552.807098] Dynamic subtest B-eDP1: SUCCESS (1.891s)
[552.817064] Starting dynamic subtest: C-eDP1
[554.697596] Dynamic subtest C-eDP1: SUCCESS (1.888s)
[554.706972] Starting dynamic subtest: D-eDP1
[556.504458] Dynamic subtest D-eDP1: SUCCESS (1.806s)
[556.509552] Subtest flip-vs-dpms-on-nop: SUCCESS (7.433s)
[557.650647] [061/131] (465s left) kms_addfb_basic (unused-pitches)
[557.717634] Starting subtest: unused-pitches
[557.719630] Subtest unused-pitches: SUCCESS (0.000s)
[557.865682] [062/131] (465s left) kms_dsc (dsc-with-output-formats)
[557.973092] Starting subtest: dsc-with-output-formats
[557.994591] Subtest dsc-with-output-formats: SKIP (0.001s)
[558.043824] [063/131] (465s left) gem_exec_params (mmapped)
[558.104194] Starting subtest: mmapped
[558.108976] Subtest mmapped: SUCCESS (0.002s)
[558.213196] [064/131] (465s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[558.306233] Starting subtest: pr-cursor-plane-update-sf
[558.310521] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[558.372310] [065/131] (465s left) gem_exec_schedule (u-lateslice)
[558.448355] Starting subtest: u-lateslice
[558.450638] Starting dynamic subtest: rcs0
[558.457576] Dynamic subtest rcs0: SUCCESS (0.019s)
[558.468816] Starting dynamic subtest: bcs0
[558.474461] Dynamic subtest bcs0: SUCCESS (0.016s)
[558.483158] Starting dynamic subtest: vcs0
[558.492590] Dynamic subtest vcs0: SUCCESS (0.018s)
[558.501120] Starting dynamic subtest: vcs1
[558.511312] Dynamic subtest vcs1: SUCCESS (0.018s)
[558.520281] Starting dynamic subtest: vecs0
[558.530196] Dynamic subtest vecs0: SUCCESS (0.018s)
[558.543823] Starting dynamic subtest: ccs0
[558.555129] Dynamic subtest ccs0: SUCCESS (0.024s)
[558.557444] Subtest u-lateslice: SUCCESS (0.118s)
[559.968209] [066/131] (463s left) gem_wait (busy)
[560.037173] Starting subtest: busy
[560.039299] Starting dynamic subtest: all-engines
[561.876073] Dynamic subtest all-engines: SUCCESS (1.840s)
[561.888022] Starting dynamic subtest: rcs0
[562.418121] Dynamic subtest rcs0: SUCCESS (0.541s)
[562.429388] Starting dynamic subtest: bcs0
[562.959130] Dynamic subtest bcs0: SUCCESS (0.540s)
[562.969569] Starting dynamic subtest: vcs0
[564.884171] Dynamic subtest vcs0: SUCCESS (1.923s)
[564.899699] Starting dynamic subtest: vcs1
[566.932225] Dynamic subtest vcs1: SUCCESS (2.045s)
[566.944212] Starting dynamic subtest: vecs0
[568.916789] Dynamic subtest vecs0: SUCCESS (1.981s)
[568.929227] Starting dynamic subtest: ccs0
[569.459137] Dynamic subtest ccs0: SUCCESS (0.541s)
[569.461793] Subtest busy: SUCCESS (9.424s)
[569.659501] [067/131] (454s left) gem_exercise_blt (fast-copy-emit)
[569.722578] Starting subtest: fast-copy-emit
[569.724916] Starting dynamic subtest: linear-smem-smem-emit
[569.751879] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.029s)
[569.762649] Starting dynamic subtest: xmajor-smem-smem-emit
[569.770985] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s)
[569.779837] Starting dynamic subtest: tile4-smem-smem-emit
[569.790880] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s)
[569.799529] Starting dynamic subtest: tile64-smem-smem-emit
[569.815219] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.024s)
[569.817700] Subtest fast-copy-emit: SUCCESS (0.093s)
[569.960896] [068/131] (453s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[570.063380] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[570.092167] Starting dynamic subtest: pipe-A-plane-0
[570.524525] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[570.533497] Starting dynamic subtest: pipe-A-plane-3
[570.791401] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[571.907433] Starting dynamic subtest: pipe-B-plane-0
[572.333035] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[572.342060] Starting dynamic subtest: pipe-B-plane-3
[572.588638] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[572.900362] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.838s)
[573.740247] [069/131] (450s left) i915_drm_fdinfo (virtual-busy-idle)
[573.788358] Starting subtest: virtual-busy-idle
[573.792431] Subtest virtual-busy-idle: SKIP (0.000s)
[573.854965] [070/131] (450s left) kms_addfb_basic (unused-offsets)
[573.914119] Starting subtest: unused-offsets
[573.916525] Subtest unused-offsets: SUCCESS (0.000s)
[574.057843] [071/131] (449s left) gem_exec_whisper (basic-contexts)
[574.134513] Starting subtest: basic-contexts
[581.062668] Subtest basic-contexts: SUCCESS (6.924s)
[581.250475] [072/131] (442s left) gem_exec_balancer (busy)
[581.312188] Starting subtest: busy
[582.927778] Subtest busy: SUCCESS (1.613s)
[583.274828] [073/131] (440s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[583.373300] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[583.377582] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[583.483441] [074/131] (440s left) kms_pm_rpm (i2c)
[585.020985] Starting subtest: i2c
[590.674137] Subtest i2c: SUCCESS (5.651s)
[590.765757] [075/131] (433s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[590.865593] Starting subtest: fbc-modesetfrombusy
[594.737153] Subtest fbc-modesetfrombusy: SUCCESS (3.874s)
[595.910636] [076/131] (428s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[596.010110] Starting subtest: extended-modeset-hang-newfb-with-reset
[596.012464] Starting dynamic subtest: pipe-A
[610.344102] Dynamic subtest pipe-A: SUCCESS (14.331s)
[610.353730] Starting dynamic subtest: pipe-D
[625.833622] Dynamic subtest pipe-D: SUCCESS (15.483s)
[625.835660] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.820s)
[626.646945] [077/131] (397s left) kms_color (ctm-0-50)
[626.749701] Starting subtest: ctm-0-50
[626.751646] Starting dynamic subtest: pipe-A-eDP-1
[630.208125] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[630.218596] Starting dynamic subtest: pipe-B-eDP-1
[634.437769] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.228s)
[634.447979] Starting dynamic subtest: pipe-C-eDP-1
[638.426959] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.990s)
[638.437463] Starting dynamic subtest: pipe-D-eDP-1
[642.424087] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.996s)
[642.426483] Subtest ctm-0-50: SUCCESS (15.674s)
[643.301559] [078/131] (381s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[643.423869] Starting subtest: short-busy-flip-before-cursor-toggle
[643.428657] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[643.570419] [079/131] (380s left) gem_exec_schedule (implicit-read-write)
[643.644716] Starting subtest: implicit-read-write
[643.647339] Starting dynamic subtest: rcs0
[643.752826] Dynamic subtest rcs0: SUCCESS (0.118s)
[643.766305] Starting dynamic subtest: vcs0
[643.836145] Dynamic subtest vcs0: SUCCESS (0.082s)
[643.848923] Starting dynamic subtest: vcs1
[643.915253] Dynamic subtest vcs1: SUCCESS (0.078s)
[643.926869] Starting dynamic subtest: vecs0
[644.005955] Dynamic subtest vecs0: SUCCESS (0.090s)
[644.018649] Starting dynamic subtest: ccs0
[644.112056] Dynamic subtest ccs0: SUCCESS (0.105s)
[644.114748] Subtest implicit-read-write: SUCCESS (0.478s)
[644.988570] [080/131] (379s left) gem_ctx_persistence (engines-mixed-process)
[645.049240] Starting subtest: engines-mixed-process
[645.051579] Starting dynamic subtest: rcs0
[646.872870] Dynamic subtest rcs0: SUCCESS (1.823s)
[646.884654] Starting dynamic subtest: bcs0
[648.838720] Dynamic subtest bcs0: SUCCESS (1.962s)
[648.849352] Starting dynamic subtest: vcs0
[650.921029] Dynamic subtest vcs0: SUCCESS (2.084s)
[650.932501] Starting dynamic subtest: vcs1
[652.891865] Dynamic subtest vcs1: SUCCESS (1.969s)
[652.902899] Starting dynamic subtest: vecs0
[654.893932] Dynamic subtest vecs0: SUCCESS (2.000s)
[654.905391] Starting dynamic subtest: ccs0
[656.860857] Dynamic subtest ccs0: SUCCESS (1.965s)
[656.863676] Subtest engines-mixed-process: SUCCESS (11.812s)
[656.940537] [081/131] (367s left) kms_flip (2x-flip-vs-fences-interruptible)
[657.044055] Starting subtest: 2x-flip-vs-fences-interruptible
[657.048519] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[657.116807] [082/131] (367s left) syncobj_wait (wait-any-interrupted)
[657.174526] Starting subtest: wait-any-interrupted
[657.276589] Subtest wait-any-interrupted: SUCCESS (0.102s)
[657.353825] [083/131] (367s left) gem_spin_batch (resubmit-new-all)
[657.408527] Starting subtest: resubmit-new-all
[657.410855] Starting dynamic subtest: rcs0
[657.426935] Dynamic subtest rcs0: SUCCESS (0.018s)
[657.435928] Starting dynamic subtest: bcs0
[657.440415] Dynamic subtest bcs0: SUCCESS (0.011s)
[657.449436] Starting dynamic subtest: vcs0
[657.451738] Dynamic subtest vcs0: SUCCESS (0.009s)
[657.460665] Starting dynamic subtest: vcs1
[657.462591] Dynamic subtest vcs1: SUCCESS (0.009s)
[657.471477] Starting dynamic subtest: vecs0
[657.473645] Dynamic subtest vecs0: SUCCESS (0.009s)
[657.482545] Starting dynamic subtest: ccs0
[657.484436] Dynamic subtest ccs0: SUCCESS (0.010s)
[657.486273] Subtest resubmit-new-all: SUCCESS (0.071s)
[658.890182] [084/131] (365s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[658.979960] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[658.984232] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[659.075279] [085/131] (365s left) gem_busy (busy)
[659.131402] Starting subtest: busy
[659.133697] Starting dynamic subtest: all-engines
[659.190895] Dynamic subtest all-engines: SUCCESS (0.059s)
[659.200843] Starting dynamic subtest: rcs0
[660.891989] Dynamic subtest rcs0: SUCCESS (1.698s)
[660.903382] Starting dynamic subtest: bcs0
[660.932944] Dynamic subtest bcs0: SUCCESS (0.037s)
[660.943502] Starting dynamic subtest: vcs0
[660.970197] Dynamic subtest vcs0: SUCCESS (0.037s)
[660.979445] Starting dynamic subtest: vcs1
[662.940541] Dynamic subtest vcs1: SUCCESS (1.966s)
[662.952045] Starting dynamic subtest: vecs0
[664.923259] Dynamic subtest vecs0: SUCCESS (1.981s)
[664.934808] Starting dynamic subtest: ccs0
[666.907315] Dynamic subtest ccs0: SUCCESS (1.983s)
[666.909906] Subtest busy: SUCCESS (7.773s)
[667.235562] [086/131] (357s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[667.323901] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[667.326153] Starting dynamic subtest: pipe-A-eDP-1
[667.349299] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[667.359093] Starting dynamic subtest: pipe-B-eDP-1
[667.380700] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[667.390506] Starting dynamic subtest: pipe-C-eDP-1
[667.412036] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[667.420882] Starting dynamic subtest: pipe-D-eDP-1
[667.443366] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[667.447418] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[669.542760] [087/131] (355s left) gem_ctx_engines (independent)
[669.604996] Starting subtest: independent
[669.607671] Starting dynamic subtest: rcs0
[669.751615] Dynamic subtest rcs0: SUCCESS (0.145s)
[669.762140] Starting dynamic subtest: bcs0
[669.896176] Dynamic subtest bcs0: SUCCESS (0.144s)
[669.905365] Starting dynamic subtest: vcs0
[670.043883] Dynamic subtest vcs0: SUCCESS (0.147s)
[670.054545] Starting dynamic subtest: vcs1
[670.219638] Dynamic subtest vcs1: SUCCESS (0.175s)
[670.230384] Starting dynamic subtest: vecs0
[670.389308] Dynamic subtest vecs0: SUCCESS (0.168s)
[670.399237] Starting dynamic subtest: ccs0
[670.574371] Dynamic subtest ccs0: SUCCESS (0.184s)
[670.583769] Starting dynamic subtest: all-engines
[671.221499] Dynamic subtest all-engines: SUCCESS (0.646s)
[671.223943] Subtest independent: SUCCESS (1.616s)
[672.033579] [088/131] (352s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[672.137579] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[679.162789] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.029s)
[679.261891] [089/131] (345s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[679.357077] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[679.359392] Starting dynamic subtest: pipe-A-eDP-1
[679.368540] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[679.378062] Starting dynamic subtest: pipe-B-eDP-1
[679.387337] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[679.400286] Starting dynamic subtest: pipe-C-eDP-1
[679.409037] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[679.417801] Starting dynamic subtest: pipe-D-eDP-1
[679.426179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[679.430186] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[681.541927] [090/131] (343s left) perf_pmu (semaphore-wait-idle)
[681.580100] Starting subtest: semaphore-wait-idle
[681.582504] Starting dynamic subtest: rcs0
[682.093767] Dynamic subtest rcs0: SUCCESS (0.512s)
[682.106785] Starting dynamic subtest: bcs0
[682.607323] Dynamic subtest bcs0: SUCCESS (0.510s)
[682.617731] Starting dynamic subtest: vcs0
[683.123046] Dynamic subtest vcs0: SUCCESS (0.513s)
[683.135679] Starting dynamic subtest: vcs1
[683.636713] Dynamic subtest vcs1: SUCCESS (0.511s)
[683.649464] Starting dynamic subtest: vecs0
[684.150366] Dynamic subtest vecs0: SUCCESS (0.510s)
[684.163858] Starting dynamic subtest: ccs0
[684.666445] Dynamic subtest ccs0: SUCCESS (0.513s)
[684.669543] Subtest semaphore-wait-idle: SUCCESS (3.087s)
[685.922058] [091/131] (338s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[686.303720] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[687.131979] [092/131] (337s left) gem_ctx_persistence (hang)
[687.199675] Starting subtest: hang
[687.204501] Subtest hang: SKIP (0.000s)
[687.299893] [093/131] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[687.399427] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[687.403494] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[687.496756] [094/131] (337s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[687.556869] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[687.614468] [095/131] (337s left) kms_cursor_crc (cursor-sliding-256x256)
[687.864773] Starting subtest: cursor-sliding-256x256
[687.872191] Starting dynamic subtest: pipe-A-eDP-1
[691.142053] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.267s)
[691.169303] Starting dynamic subtest: pipe-D-eDP-1
[695.185011] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.023s)
[695.187373] Subtest cursor-sliding-256x256: SUCCESS (7.318s)
[696.014087] [096/131] (329s left) vgem_basic (mmap)
[696.068724] Starting subtest: mmap
[696.088841] Subtest mmap: SUCCESS (0.025s)
[696.146351] [097/131] (328s left) kms_cursor_crc (cursor-random-512x170)
[696.441901] Starting subtest: cursor-random-512x170
[696.446305] Subtest cursor-random-512x170: SKIP (0.001s)
[696.573871] [098/131] (328s left) api_intel_allocator (reopen-fork)
[696.618982] Starting subtest: reopen-fork
[700.102091] Subtest reopen-fork: SUCCESS (3.484s)
[700.194244] [099/131] (324s left) kms_sequence (get-busy)
[700.282977] Starting subtest: get-busy
[700.285222] Starting dynamic subtest: pipe-A-eDP-1
[702.228491] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[702.238316] Starting dynamic subtest: pipe-B-eDP-1
[704.826278] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.596s)
[704.839058] Starting dynamic subtest: pipe-C-eDP-1
[707.428773] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.600s)
[707.439473] Starting dynamic subtest: pipe-D-eDP-1
[709.980574] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[709.982612] Subtest get-busy: SUCCESS (9.697s)
[710.784096] [100/131] (314s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[710.876247] Starting subtest: compare-crc-sanitycheck-nv12
[710.878644] Starting dynamic subtest: pipe-A-eDP-1
[711.549519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s)
[711.561683] Starting dynamic subtest: pipe-B-eDP-1
[712.835547] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[712.846500] Starting dynamic subtest: pipe-C-eDP-1
[714.026250] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.190s)
[714.036364] Starting dynamic subtest: pipe-D-eDP-1
[715.268249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[715.270137] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.392s)
[716.110371] [101/131] (309s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[716.196666] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[716.200717] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[716.277777] [102/131] (309s left) kms_flip (nonexisting-fb-interruptible)
[716.362317] Starting subtest: nonexisting-fb-interruptible
[716.364576] Starting dynamic subtest: A-eDP1
[717.501655] Dynamic subtest A-eDP1: SUCCESS (1.138s)
[717.513877] Starting dynamic subtest: B-eDP1
[718.635042] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[718.647360] Starting dynamic subtest: C-eDP1
[719.768540] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[719.780965] Starting dynamic subtest: D-eDP1
[720.893059] Dynamic subtest D-eDP1: SUCCESS (1.122s)
[720.897899] Subtest nonexisting-fb-interruptible: SUCCESS (4.536s)
[722.073393] [103/131] (303s left) gem_workarounds (reset)
[722.136366] Starting subtest: reset
[722.313236] Subtest reset: SUCCESS (0.177s)
[722.445640] [104/131] (302s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[722.548255] Starting subtest: psr-farfromfence-mmap-gtt
[722.552653] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[722.655208] [105/131] (302s left) kms_big_fb (linear-8bpp-rotate-90)
[722.750391] Starting subtest: linear-8bpp-rotate-90
[722.771141] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[722.884369] [106/131] (302s left) gem_mmap_gtt (zero-extend)
[722.940606] Subtest zero-extend: SKIP (0.000s)
[723.007474] [107/131] (302s left) kms_vblank (ts-continuation-idle-hang)
[723.109951] Starting subtest: ts-continuation-idle-hang
[723.111917] Starting dynamic subtest: pipe-A-eDP-1
[749.667409] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.553s)
[749.682411] Starting dynamic subtest: pipe-D-eDP-1
[774.683889] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.013s)
[774.686124] Subtest ts-continuation-idle-hang: SUCCESS (51.571s)
[775.515231] [108/131] (250s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[775.639570] Starting subtest: verify-pxp-execution-after-suspend-resume
[782.788870] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.151s)
[782.929257] [109/131] (242s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[783.033081] Starting subtest: yf-tiled-64bpp-rotate-180
[783.037650] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[783.128091] [110/131] (242s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[783.230871] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[783.235143] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[783.323887] [111/131] (242s left) kms_vrr (max-min)
[783.418406] Starting subtest: max-min
[783.424759] Subtest max-min: SKIP (0.000s)
[783.493137] [112/131] (242s left) gem_pxp (display-protected-crc)
[783.554263] Starting subtest: display-protected-crc
[785.160854] Subtest display-protected-crc: SUCCESS (1.607s)
[785.293835] [113/131] (240s left) kms_lease (lease-invalid-plane)
[785.390314] Starting subtest: lease-invalid-plane
[785.392597] Starting dynamic subtest: pipe-A-eDP-1
[785.394971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[785.405326] Starting dynamic subtest: pipe-B-eDP-1
[785.407220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[785.416910] Starting dynamic subtest: pipe-C-eDP-1
[785.419323] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[785.428394] Starting dynamic subtest: pipe-D-eDP-1
[785.430305] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[785.432228] Subtest lease-invalid-plane: SUCCESS (0.004s)
[785.471658] [114/131] (240s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[785.563280] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[785.567594] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[785.636766] [115/131] (240s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[785.723264] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[785.727274] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[785.798660] [116/131] (240s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[785.895296] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[792.519756] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.626s)
[792.661167] [117/131] (233s left) syncobj_timeline (signal-array)
[792.709668] Starting subtest: signal-array
[792.711992] Subtest signal-array: SUCCESS (0.000s)
[792.801530] [118/131] (233s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[793.178495] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[793.959387] [119/131] (232s left) sw_sync (timeline_closed)
[793.995435] Starting subtest: timeline_closed
[793.997851] Subtest timeline_closed: SUCCESS (0.000s)
[794.054053] [120/131] (232s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[794.140065] Starting subtest: plane-all-modeset-transition-fencing
[794.144643] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[794.213471] [121/131] (231s left) kms_addfb_basic (unused-modifier)
[794.251805] Starting subtest: unused-modifier
[794.254087] Subtest unused-modifier: SUCCESS (0.000s)
[794.383383] [122/131] (231s left) gem_userptr_blits (stress-mm-invalidate-close)
[794.449128] Starting subtest: stress-mm-invalidate-close
[796.596044] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[796.714877] [123/131] (229s left) kms_3d (basic)
[796.771313] Starting subtest: basic
[798.739173] Subtest basic: SUCCESS (1.969s)
[799.221026] [124/131] (227s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[799.320835] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[799.325386] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[799.422363] [125/131] (226s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[799.526249] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[799.530416] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[799.651169] [126/131] (226s left) syncobj_basic (bad-pad-fd-to-handle)
[799.705411] Starting subtest: bad-pad-fd-to-handle
[799.707805] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[799.825766] [127/131] (226s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[799.952141] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[799.956725] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[800.102094] [128/131] (226s left) gem_mmap_gtt (hang)
[800.162658] Subtest hang: SKIP (0.000s)
[800.224554] [129/131] (226s left) kms_rotation_crc (exhaust-fences)
[800.309483] Starting subtest: exhaust-fences
[800.312909] Subtest exhaust-fences: SKIP (0.000s)
[800.381930] [130/131] (226s left) perf_pmu (all-busy-check-all)
[800.422126] Starting subtest: all-busy-check-all
[801.940504] Subtest all-busy-check-all: SUCCESS (1.517s)
[802.055535] [131/131] (224s left) api_intel_bb (misplaced-blitter)
[802.122077] Starting subtest: misplaced-blitter
[802.127557] Subtest misplaced-blitter: SUCCESS (0.006s)
[802.252735] Closing watchdogs
results: parsing output: 0/ for test: i915_selftest
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: gem_set_tiling_vs_blt
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_properties
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: core_sysfs
results: parsing output: 22/ for test: kms_force_connector_basic
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: sysfs_timeslice_duration
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: i915_pm_freq_mult
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane_lowres
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_pm_dc
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: i915_drm_fdinfo
results: parsing output: 41/ for test: kms_invalid_mode
results: parsing output: 42/ for test: kms_chamelium_color
results: parsing output: 43/ for test: kms_content_protection
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_dsc
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_wait
results: parsing output: 66/ for test: gem_exercise_blt
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_busy
results: parsing output: 76/ for test: kms_color
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_spin_batch
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_busy
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_ctx_engines
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_chamelium_hpd
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: kms_sequence
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_workarounds
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_vrr
results: parsing output: 111/ for test: gem_pxp
results: parsing output: 112/ for test: kms_lease
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_chamelium_edid
results: parsing output: 118/ for test: sw_sync
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: kms_3d
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_basic
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: api_intel_bb
Done.