[58.508341] Initializing watchdogs
[58.508388]   /dev/watchdog0
[58.522524] [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.526929] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.529132] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.532375] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[58.682321] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[58.686669] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[58.767020] [002/133] (960s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[58.832678] Starting subtest: y-tiled-to-vebox-x-tiled
[58.837388] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[59.013054] [003/133] (960s left) perf (missing-sample-flags)
[59.149363] Starting subtest: missing-sample-flags
[59.151697] Subtest missing-sample-flags: SUCCESS (0.000s)
[59.191914] [004/133] (959s left) kms_psr (psr2-suspend)
[59.292018] Starting subtest: psr2-suspend
[59.294408] Starting dynamic subtest: eDP-1
[76.510748] Dynamic subtest eDP-1: SUCCESS (2.995s)
[76.513213] Subtest psr2-suspend: SUCCESS (2.996s)
[77.329486] [005/133] (941s left) kms_hdmi_inject (inject-4k)
[77.703856] Starting subtest: inject-4k
[78.027005] Subtest inject-4k: SUCCESS (0.315s)
[78.644305] [006/133] (940s left) gem_mmap (bad-object)
[78.717467] Subtest bad-object: SKIP (0.000s)
[78.791303] [007/133] (940s left) kms_plane (pixel-format-y-tiled-modifier)
[78.892333] Starting subtest: pixel-format-y-tiled-modifier
[78.896602] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[78.961318] [008/133] (940s left) syncobj_timeline (wait-for-submit-complex)
[79.021465] Starting subtest: wait-for-submit-complex
[79.084216] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[79.156335] [009/133] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[79.250868] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[79.255030] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[79.352297] [010/133] (940s left) gem_ctx_persistence (legacy-engines-hang)
[79.413760] Starting subtest: legacy-engines-hang
[79.416055] Starting dynamic subtest: render
[79.531019] Dynamic subtest render: SUCCESS (0.114s)
[79.541463] Starting dynamic subtest: bsd1
[79.645718] Dynamic subtest bsd1: SUCCESS (0.111s)
[79.656394] Starting dynamic subtest: bsd2
[79.743069] Dynamic subtest bsd2: SUCCESS (0.093s)
[79.753321] Starting dynamic subtest: blt
[79.838936] Dynamic subtest blt: SUCCESS (0.092s)
[79.848750] Starting dynamic subtest: vebox
[79.929802] Dynamic subtest vebox: SUCCESS (0.087s)
[79.932065] Subtest legacy-engines-hang: SUCCESS (0.506s)
[80.007759] [011/133] (939s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[80.105449] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[80.107235] Starting dynamic subtest: pipe-A-eDP-1
[80.114599] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[80.122993] Starting dynamic subtest: pipe-B-eDP-1
[80.131164] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[80.138782] Starting dynamic subtest: pipe-C-eDP-1
[80.146290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[80.153023] Starting dynamic subtest: pipe-D-eDP-1
[80.160273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[80.163861] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[82.366126] [012/133] (937s left) syncobj_timeline (invalid-signal-illegal-point)
[82.424316] Starting subtest: invalid-signal-illegal-point
[82.426648] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[82.561156] [013/133] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[82.667430] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[89.431327] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.702s)
[89.564108] [014/133] (930s left) i915_selftest (live)
[91.277184] Starting subtest: live
[91.280012] Starting dynamic subtest: sanitycheck
[95.584887] Dynamic subtest sanitycheck: SUCCESS (4.291s)
[95.593131] Starting dynamic subtest: uncore
[99.872256] Dynamic subtest uncore: SUCCESS (4.276s)
[99.881432] Starting dynamic subtest: workarounds
[102.981737] Dynamic subtest workarounds: SUCCESS (3.104s)
[102.990261] Starting dynamic subtest: gt_engines
[107.453735] Dynamic subtest gt_engines: SUCCESS (4.467s)
[107.462261] Starting dynamic subtest: gt_timelines
[123.565415] Dynamic subtest gt_timelines: SUCCESS (16.106s)
[123.574578] Starting dynamic subtest: gt_contexts
[127.880330] Dynamic subtest gt_contexts: SUCCESS (4.312s)
[127.889358] Starting dynamic subtest: gt_lrc
[133.991554] Dynamic subtest gt_lrc: SUCCESS (6.108s)
[133.999607] Starting dynamic subtest: gt_mocs
[136.999957] Dynamic subtest gt_mocs: SUCCESS (2.992s)
[137.009467] Starting dynamic subtest: gt_pm
[143.752118] Dynamic subtest gt_pm: SUCCESS (6.763s)
[143.760805] Starting dynamic subtest: gt_heartbeat
[148.063679] Dynamic subtest gt_heartbeat: SUCCESS (4.308s)
[148.072428] Starting dynamic subtest: gt_tlb
[157.379436] Dynamic subtest gt_tlb: SUCCESS (9.310s)
[157.388649] Starting dynamic subtest: requests
[170.801040] Dynamic subtest requests: SUCCESS (13.414s)
[170.808823] Starting dynamic subtest: migrate
[178.538280] Dynamic subtest migrate: SUCCESS (7.738s)
[178.547137] Starting dynamic subtest: active
[182.853131] Dynamic subtest active: SUCCESS (4.316s)
[182.862291] Starting dynamic subtest: objects
[187.467719] Dynamic subtest objects: SUCCESS (4.614s)
[187.477465] Starting dynamic subtest: mman
[192.355307] Dynamic subtest mman: SUCCESS (4.886s)
[192.363881] Starting dynamic subtest: dmabuf
[196.654287] Dynamic subtest dmabuf: SUCCESS (4.298s)
[196.663130] Starting dynamic subtest: vma
[200.981762] Dynamic subtest vma: SUCCESS (4.326s)
[200.991083] Starting dynamic subtest: coherency
[206.025405] Dynamic subtest coherency: SUCCESS (5.042s)
[206.034763] Starting dynamic subtest: gtt
[216.311773] Dynamic subtest gtt: SUCCESS (10.284s)
[216.320615] Starting dynamic subtest: gem
[223.719150] Dynamic subtest gem: SUCCESS (7.405s)
[223.728256] Starting dynamic subtest: evict
[229.172721] Dynamic subtest evict: SUCCESS (5.451s)
[229.181732] Starting dynamic subtest: hugepages
[237.925314] Dynamic subtest hugepages: SUCCESS (8.750s)
[237.933902] Starting dynamic subtest: gem_contexts
[264.814136] Dynamic subtest gem_contexts: SUCCESS (26.880s)
[264.823462] Starting dynamic subtest: client
[269.134533] Dynamic subtest client: SUCCESS (4.318s)
[269.143656] Starting dynamic subtest: gem_migrate
[271.848274] Dynamic subtest gem_migrate: SUCCESS (2.712s)
[271.858152] Starting dynamic subtest: reset
[274.614682] Dynamic subtest reset: SUCCESS (2.764s)
[274.623406] Starting dynamic subtest: memory_region
[278.968585] Dynamic subtest memory_region: SUCCESS (4.352s)
[278.978087] Starting dynamic subtest: hangcheck
[291.909284] Dynamic subtest hangcheck: SUCCESS (12.933s)
[291.918810] Starting dynamic subtest: execlists
[296.218528] Dynamic subtest execlists: SUCCESS (4.307s)
[296.226051] Starting dynamic subtest: ring_submission
[300.557257] Dynamic subtest ring_submission: SUCCESS (4.335s)
[300.566863] Starting dynamic subtest: perf
[304.898441] Dynamic subtest perf: SUCCESS (4.341s)
[304.907578] Starting dynamic subtest: slpc
[318.932779] Dynamic subtest slpc: SUCCESS (14.037s)
[318.942167] Starting dynamic subtest: guc
[322.834724] Dynamic subtest guc: SUCCESS (3.901s)
[322.844264] Starting dynamic subtest: guc_multi_lrc
[327.184099] Dynamic subtest guc_multi_lrc: SUCCESS (4.349s)
[327.193353] Starting dynamic subtest: guc_hang
[332.176765] Dynamic subtest guc_hang: SUCCESS (4.992s)
[332.186668] Starting dynamic subtest: late_gt_pm
[336.556569] Dynamic subtest late_gt_pm: SUCCESS (4.378s)
[336.559335] Subtest live: SUCCESS (245.204s)
[336.588658] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[336.591803] [015/133] (683s left) gem_softpin (invalid)
[338.135413] Starting subtest: invalid
[338.145537] Subtest invalid: SUCCESS (0.011s)
[338.270580] [FACT gem_softpin (invalid)] new: kernel.kmod_is_loaded.i915: true
[338.274606] [016/133] (681s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[338.376467] Starting subtest: fbc-psr2-sprite-plane-onoff
[338.378779] Starting dynamic subtest: eDP-1
[338.383176] Dynamic subtest eDP-1: SKIP (0.000s)
[338.387605] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[338.458288] [017/133] (681s left) gem_tiled_partial_pwrite_pread (reads)
[338.516937] Subtest reads: SKIP (0.000s)
[338.578111] [018/133] (681s left) kms_getfb (getfb2-handle-zero)
[338.664981] Starting subtest: getfb2-handle-zero
[338.666948] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[338.765923] [019/133] (680s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[338.854546] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[338.856973] Starting dynamic subtest: pipe-A
[338.877419] Dynamic subtest pipe-A: SKIP (0.020s)
[338.886248] Starting dynamic subtest: pipe-B
[338.916160] Dynamic subtest pipe-B: SKIP (0.037s)
[338.924419] Starting dynamic subtest: pipe-C
[338.954409] Dynamic subtest pipe-C: SKIP (0.036s)
[338.962523] Starting dynamic subtest: pipe-D
[338.988452] Dynamic subtest pipe-D: SKIP (0.036s)
[338.991890] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.132s)
[339.067402] [020/133] (680s left) gem_exec_whisper (basic-fds-priority-all)
[339.132027] Starting subtest: basic-fds-priority-all
[361.170571] Subtest basic-fds-priority-all: SUCCESS (22.034s)
[361.359964] [021/133] (658s left) i915_hangman (gt-engine-error)
[361.431038] Starting subtest: gt-engine-error
[361.432872] Starting dynamic subtest: rcs0
[363.064808] Dynamic subtest rcs0: SUCCESS (1.632s)
[363.077106] Starting dynamic subtest: bcs0
[365.046411] Dynamic subtest bcs0: SUCCESS (1.979s)
[365.057585] Starting dynamic subtest: vcs0
[367.092971] Dynamic subtest vcs0: SUCCESS (2.043s)
[367.104068] Starting dynamic subtest: vcs1
[369.080461] Dynamic subtest vcs1: SUCCESS (1.985s)
[369.090911] Starting dynamic subtest: vecs0
[371.061769] Dynamic subtest vecs0: SUCCESS (1.979s)
[371.074420] Starting dynamic subtest: ccs0
[373.108910] Dynamic subtest ccs0: SUCCESS (2.043s)
[373.111729] Subtest gt-engine-error: SUCCESS (11.678s)
[373.219628] [022/133] (646s left) i915_pm_rpm (system-suspend-devices)
[375.290203] Starting subtest: system-suspend-devices
[382.974832] Subtest system-suspend-devices: SUCCESS (7.688s)
[383.396115] [023/133] (636s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[383.521830] Starting subtest: y-tiled-32bpp-rotate-180
[383.525962] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[383.623163] [024/133] (636s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[383.783476] Starting subtest: cursor-rapid-movement-32x10
[383.834321] Subtest cursor-rapid-movement-32x10: SKIP (0.048s)
[384.124627] [025/133] (635s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[384.211661] Starting subtest: primary-4-tiled-reflect-x-180
[391.370342] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.159s)
[392.537979] [026/133] (627s left) kms_psr (fbc-pr-primary-page-flip)
[392.639508] Starting subtest: fbc-pr-primary-page-flip
[392.643918] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[392.710399] [027/133] (627s left) core_getversion (basic)
[392.754609] Starting subtest: basic
[392.758826] Subtest basic: SUCCESS (0.000s)
[392.821488] [028/133] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[392.928736] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[392.933042] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[393.018248] [029/133] (627s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[393.060519] Starting subtest: etime-multi-wait-for-submit-submitted
[393.162309] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[393.234896] [030/133] (626s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[393.296491] Starting subtest: multi-wait-for-submit-available-signaled
[393.298734] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[393.403095] [031/133] (626s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[393.508431] Starting subtest: yf-tiled-addfb-size-offset-overflow
[393.512763] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[393.601242] [032/133] (626s left) kms_cursor_edge_walk (128x128-top-bottom)
[393.694507] Starting subtest: 128x128-top-bottom
[393.696779] Starting dynamic subtest: pipe-A-eDP-1
[397.186149] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[397.198217] Starting dynamic subtest: pipe-D-eDP-1
[400.312008] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[400.314294] Subtest 128x128-top-bottom: SUCCESS (6.618s)
[401.107121] [033/133] (619s left) gem_exec_reloc (basic-active)
[401.163071] Subtest basic-active: SKIP (0.000s)
[401.236011] [034/133] (619s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[401.338201] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[401.340554] Starting dynamic subtest: pipe-A-eDP-1
[412.030214] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.696s)
[412.039550] Starting dynamic subtest: pipe-B-eDP-1
[423.419186] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.386s)
[423.421570] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.085s)
[424.260581] [035/133] (596s left) gem_mmap_wc (write)
[424.315806] Subtest write: SKIP (0.000s)
[424.380902] [036/133] (596s left) kms_pm_backlight (brightness-with-dpms)
[424.463510] Starting subtest: brightness-with-dpms
[424.517374] Starting dynamic subtest: eDP-1
[426.957279] Dynamic subtest eDP-1: SUCCESS (2.439s)
[426.959676] Subtest brightness-with-dpms: SUCCESS (2.493s)
[427.824925] [037/133] (592s left) core_getstats (basic)
[427.885238] Starting subtest: basic
[427.887324] Subtest basic: SUCCESS (0.000s)
[427.999882] [038/133] (592s left) kms_atomic (atomic-plane-damage)
[428.101466] Starting subtest: atomic-plane-damage
[428.152791] Starting dynamic subtest: pipe-A-eDP-1
[428.704496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[428.706788] Subtest atomic-plane-damage: SUCCESS (0.603s)
[429.562122] [039/133] (591s left) kms_flip (basic-flip-vs-dpms)
[429.663277] Starting subtest: basic-flip-vs-dpms
[429.665754] Starting dynamic subtest: A-eDP1
[432.262779] Dynamic subtest A-eDP1: SUCCESS (2.600s)
[432.272508] Starting dynamic subtest: B-eDP1
[434.437752] Dynamic subtest B-eDP1: SUCCESS (2.175s)
[434.450731] Starting dynamic subtest: C-eDP1
[436.530453] Dynamic subtest C-eDP1: SUCCESS (2.088s)
[436.540055] Starting dynamic subtest: D-eDP1
[438.592324] Dynamic subtest D-eDP1: SUCCESS (2.062s)
[438.594747] Subtest basic-flip-vs-dpms: SUCCESS (8.934s)
[439.389085] [040/133] (581s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[439.439622] Starting subtest: invalid-smem-bo-on-discrete
[439.444229] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[439.572614] [041/133] (581s left) gem_eio (wait-wedge-10ms)
[439.819283] Starting subtest: wait-wedge-10ms
[441.187174] Subtest wait-wedge-10ms: SUCCESS (1.366s)
[441.301692] [042/133] (579s left) gem_ctx_persistence (engines-mixed-process)
[441.350284] Starting subtest: engines-mixed-process
[441.352614] Starting dynamic subtest: rcs0
[443.102807] Dynamic subtest rcs0: SUCCESS (1.752s)
[443.114830] Starting dynamic subtest: bcs0
[445.074220] Dynamic subtest bcs0: SUCCESS (1.970s)
[445.084507] Starting dynamic subtest: vcs0
[447.079191] Dynamic subtest vcs0: SUCCESS (2.004s)
[447.089599] Starting dynamic subtest: vcs1
[449.132107] Dynamic subtest vcs1: SUCCESS (2.051s)
[449.143793] Starting dynamic subtest: vecs0
[451.094422] Dynamic subtest vecs0: SUCCESS (1.960s)
[451.105142] Starting dynamic subtest: ccs0
[453.143448] Dynamic subtest ccs0: SUCCESS (2.048s)
[453.145793] Subtest engines-mixed-process: SUCCESS (11.792s)
[453.251899] [043/133] (567s left) gem_exec_reloc (basic-wc)
[453.315872] Subtest basic-wc: SKIP (0.000s)
[453.381572] [044/133] (567s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[453.478703] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[453.483030] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[453.546972] [045/133] (567s left) kms_plane_cursor (viewport)
[453.636046] Starting subtest: viewport
[453.640296] Starting dynamic subtest: pipe-A-eDP-1-size-64
[456.202373] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.566s)
[456.262667] Starting dynamic subtest: pipe-A-eDP-1-size-128
[458.814650] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[458.875188] Starting dynamic subtest: pipe-A-eDP-1-size-256
[461.416318] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[461.784970] Starting dynamic subtest: pipe-B-eDP-1-size-64
[465.053322] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.278s)
[465.121928] Starting dynamic subtest: pipe-B-eDP-1-size-128
[467.699613] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.593s)
[467.759014] Starting dynamic subtest: pipe-B-eDP-1-size-256
[470.256374] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[470.604042] Starting dynamic subtest: pipe-C-eDP-1-size-64
[473.526614] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.933s)
[473.565450] Starting dynamic subtest: pipe-C-eDP-1-size-128
[475.737427] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[475.775199] Starting dynamic subtest: pipe-C-eDP-1-size-256
[478.005383] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s)
[478.334470] Starting dynamic subtest: pipe-D-eDP-1-size-64
[481.298800] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.974s)
[481.336602] Starting dynamic subtest: pipe-D-eDP-1-size-128
[483.542524] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[483.584697] Starting dynamic subtest: pipe-D-eDP-1-size-256
[485.777295] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.202s)
[486.097335] Subtest viewport: SUCCESS (32.457s)
[486.933956] [046/133] (533s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[487.039668] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[487.719711] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[487.868282] [047/133] (533s left) kms_chamelium_frames (dp-crc-multiple)
[488.250698] Subtest dp-crc-multiple: SKIP (0.000s)
[489.021704] [048/133] (531s left) gem_spin_batch (engines)
[489.087844] Starting subtest: engines
[489.090103] Starting dynamic subtest: rcs0
[492.324851] Dynamic subtest rcs0: SUCCESS (3.235s)
[492.337144] Starting dynamic subtest: bcs0
[495.616869] Dynamic subtest bcs0: SUCCESS (3.236s)
[495.628727] Starting dynamic subtest: vcs0
[498.853304] Dynamic subtest vcs0: SUCCESS (3.234s)
[498.865423] Starting dynamic subtest: vcs1
[502.093250] Dynamic subtest vcs1: SUCCESS (3.234s)
[502.107576] Starting dynamic subtest: vecs0
[505.330677] Dynamic subtest vecs0: SUCCESS (3.234s)
[505.342178] Starting dynamic subtest: ccs0
[508.569352] Dynamic subtest ccs0: SUCCESS (3.236s)
[508.572112] Subtest engines: SUCCESS (19.427s)
[508.763011] [049/133] (512s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[508.868692] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[508.871004] Starting dynamic subtest: pipe-A-eDP-1
[508.894168] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[508.906984] Starting dynamic subtest: pipe-B-eDP-1
[508.928342] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[508.937406] Starting dynamic subtest: pipe-C-eDP-1
[508.959441] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[508.971403] Starting dynamic subtest: pipe-D-eDP-1
[508.993542] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[508.997560] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[511.027903] [050/133] (510s left) kms_vblank (wait-busy-hang)
[511.114399] Starting subtest: wait-busy-hang
[511.116639] Starting dynamic subtest: pipe-A-eDP-1
[537.894597] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.774s)
[537.909254] Starting dynamic subtest: pipe-D-eDP-1
[562.920552] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.017s)
[562.922882] Subtest wait-busy-hang: SUCCESS (51.799s)
[563.801751] [051/133] (457s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[563.897935] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[563.902183] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[563.996279] [052/133] (457s left) perf (invalid-remove-userspace-config)
[564.127940] Starting subtest: invalid-remove-userspace-config
[564.136789] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[564.179251] [053/133] (457s left) sw_sync (sync_multi_consumer)
[564.213527] Starting subtest: sync_multi_consumer
[564.651954] Subtest sync_multi_consumer: SUCCESS (0.438s)
[564.725482] [054/133] (456s left) kms_plane (pixel-format-yf-tiled-modifier)
[564.819594] Starting subtest: pixel-format-yf-tiled-modifier
[564.824056] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[564.891098] [055/133] (456s left) prime_busy (after-wait)
[564.944947] Starting subtest: after-wait
[564.950504] Starting dynamic subtest: rcs0
[564.972134] Dynamic subtest rcs0: SUCCESS (0.024s)
[564.984117] Starting dynamic subtest: bcs0
[565.021189] Dynamic subtest bcs0: SUCCESS (0.048s)
[565.032578] Starting dynamic subtest: vcs0
[565.062240] Dynamic subtest vcs0: SUCCESS (0.040s)
[565.071997] Starting dynamic subtest: vcs1
[565.103154] Dynamic subtest vcs1: SUCCESS (0.040s)
[565.113132] Starting dynamic subtest: vecs0
[565.143777] Dynamic subtest vecs0: SUCCESS (0.040s)
[565.153506] Starting dynamic subtest: ccs0
[565.185104] Dynamic subtest ccs0: SUCCESS (0.041s)
[565.294434] Subtest after-wait: SUCCESS (0.347s)
[565.373887] [056/133] (455s left) template (a)
[565.436147] Starting subtest: A
[565.438473] Subtest A: SUCCESS (0.000s)
[565.544001] [057/133] (455s left) gem_exec_schedule (semaphore-codependency)
[565.605254] Starting subtest: semaphore-codependency
[565.615282] Subtest semaphore-codependency: SUCCESS (0.017s)
[565.970547] [058/133] (455s left) kms_chamelium_hpd (vga-hpd)
[566.370036] Subtest vga-hpd: SKIP (0.000s)
[567.212929] [059/133] (454s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[567.309544] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[567.311881] Starting dynamic subtest: pipe-A-default-mode
[568.489274] Dynamic subtest pipe-A-default-mode: SKIP (1.177s)
[568.493673] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.178s)
[568.666775] [060/133] (452s left) gem_mmap_wc (read)
[568.720739] Subtest read: SKIP (0.000s)
[568.782060] [061/133] (452s left) api_intel_allocator (execbuf-with-allocator)
[568.844785] Starting subtest: execbuf-with-allocator
[568.850711] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[568.980953] [062/133] (452s left) gem_cs_tlb (engines)
[569.038241] Starting subtest: engines
[569.040298] Starting dynamic subtest: rcs0
[571.190196] Dynamic subtest rcs0: SUCCESS (2.152s)
[571.202104] Starting dynamic subtest: bcs0
[573.399199] Dynamic subtest bcs0: SUCCESS (2.153s)
[573.411889] Starting dynamic subtest: vcs0
[575.553339] Dynamic subtest vcs0: SUCCESS (2.153s)
[575.565416] Starting dynamic subtest: vcs1
[577.707003] Dynamic subtest vcs1: SUCCESS (2.153s)
[577.719656] Starting dynamic subtest: vecs0
[579.863708] Dynamic subtest vecs0: SUCCESS (2.154s)
[579.875328] Starting dynamic subtest: ccs0
[582.017943] Dynamic subtest ccs0: SUCCESS (2.155s)
[582.020010] Subtest engines: SUCCESS (12.927s)
[582.076014] [063/133] (439s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[582.173005] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[588.956965] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.785s)
[589.077782] [064/133] (432s left) kms_content_protection (atomic-dpms)
[589.228447] Starting subtest: atomic-dpms
[589.233076] Subtest atomic-dpms: SKIP (0.000s)
[589.363977] [065/133] (432s left) kms_big_fb (linear-16bpp-rotate-270)
[589.487413] Starting subtest: linear-16bpp-rotate-270
[589.514078] Subtest linear-16bpp-rotate-270: SKIP (0.027s)
[589.628312] [066/133] (432s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[589.734961] Starting subtest: x-tiled-16bpp-rotate-180
[591.037612] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.300s)
[591.201786] [067/133] (430s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[591.324054] Starting subtest: verify-pxp-key-change-after-suspend-resume
[598.535950] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.212s)
[598.655507] [068/133] (423s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[598.754107] Starting subtest: psr-modesetfrombusy
[604.907269] Subtest psr-modesetfrombusy: SUCCESS (6.156s)
[605.033646] [069/133] (416s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[605.136859] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[606.151450] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.013s)
[606.272348] [070/133] (415s left) gen7_exec_parse (bitmasks)
[606.335933] Subtest bitmasks: SKIP (0.000s)
[606.392671] [071/133] (415s left) gem_exec_flush (basic-uc-set-default)
[606.457876] Starting subtest: basic-uc-set-default
[611.941561] Subtest basic-uc-set-default: SUCCESS (5.455s)
[612.097430] [072/133] (409s left) gem_exec_fence (keep-in-fence)
[612.284430] Starting subtest: keep-in-fence
[612.287112] Starting dynamic subtest: rcs0
[612.344225] Dynamic subtest rcs0: SUCCESS (0.059s)
[612.356453] Starting dynamic subtest: bcs0
[612.399421] Dynamic subtest bcs0: SUCCESS (0.053s)
[612.411496] Starting dynamic subtest: vcs0
[614.104061] Dynamic subtest vcs0: SUCCESS (1.701s)
[614.116024] Starting dynamic subtest: vcs1
[616.203803] Dynamic subtest vcs1: SUCCESS (2.044s)
[616.215898] Starting dynamic subtest: vecs0
[618.135645] Dynamic subtest vecs0: SUCCESS (1.981s)
[618.147677] Starting dynamic subtest: ccs0
[618.371040] Dynamic subtest ccs0: SUCCESS (0.234s)
[618.373831] Subtest keep-in-fence: SUCCESS (6.087s)
[620.146794] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[620.150181] [073/133] (401s left) kms_cursor_crc (cursor-onscreen-32x32)
[620.300933] Starting subtest: cursor-onscreen-32x32
[620.368837] Subtest cursor-onscreen-32x32: SKIP (0.063s)
[620.679650] [074/133] (401s left) gen3_render_tiledy_blits
[620.791612] [075/133] (401s left) gem_exec_schedule (pi-distinct-iova)
[620.971065] Starting subtest: pi-distinct-iova
[620.973195] Starting dynamic subtest: rcs0
[621.059290] Dynamic subtest rcs0: SUCCESS (0.091s)
[621.069399] Starting dynamic subtest: vcs0
[621.127884] Dynamic subtest vcs0: SUCCESS (0.067s)
[621.141109] Starting dynamic subtest: vcs1
[621.186806] Dynamic subtest vcs1: SUCCESS (0.058s)
[621.203989] Starting dynamic subtest: vecs0
[621.246591] Dynamic subtest vecs0: SUCCESS (0.060s)
[621.256410] Starting dynamic subtest: ccs0
[621.312206] Dynamic subtest ccs0: SUCCESS (0.063s)
[621.314786] Subtest pi-distinct-iova: SUCCESS (0.345s)
[623.220824] [076/133] (398s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[623.315438] Starting subtest: bad-pixel-format-y-tiled-ccs
[623.317624] Starting dynamic subtest: pipe-A-eDP-1
[623.340217] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[623.354069] Starting dynamic subtest: pipe-B-eDP-1
[623.374502] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[623.384184] Starting dynamic subtest: pipe-C-eDP-1
[623.404460] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[623.413615] Starting dynamic subtest: pipe-D-eDP-1
[623.434416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[623.438279] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[625.555718] [077/133] (396s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[625.656154] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[625.660588] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[625.747110] [078/133] (396s left) gem_wait (write-busy)
[625.805196] Starting subtest: write-busy
[625.807736] Starting dynamic subtest: all-engines
[626.373637] Dynamic subtest all-engines: SUCCESS (0.567s)
[626.392131] Starting dynamic subtest: rcs0
[626.923838] Dynamic subtest rcs0: SUCCESS (0.549s)
[626.940135] Starting dynamic subtest: bcs0
[627.471010] Dynamic subtest bcs0: SUCCESS (0.547s)
[627.487406] Starting dynamic subtest: vcs0
[629.144728] Dynamic subtest vcs0: SUCCESS (1.671s)
[629.162223] Starting dynamic subtest: vcs1
[631.126666] Dynamic subtest vcs1: SUCCESS (1.979s)
[631.144423] Starting dynamic subtest: vecs0
[633.110685] Dynamic subtest vecs0: SUCCESS (1.981s)
[633.127643] Starting dynamic subtest: ccs0
[633.661553] Dynamic subtest ccs0: SUCCESS (0.550s)
[633.664017] Subtest write-busy: SUCCESS (7.855s)
[633.859173] [079/133] (388s left) gem_ctx_shared (q-out-order)
[633.921721] Starting subtest: Q-out-order
[633.924159] Starting dynamic subtest: rcs0
[634.085910] Dynamic subtest rcs0: SUCCESS (0.162s)
[634.104123] Starting dynamic subtest: vcs0
[634.191254] Dynamic subtest vcs0: SUCCESS (0.104s)
[634.208264] Starting dynamic subtest: vcs1
[634.308439] Dynamic subtest vcs1: SUCCESS (0.116s)
[634.325536] Starting dynamic subtest: vecs0
[634.416237] Dynamic subtest vecs0: SUCCESS (0.107s)
[634.432605] Starting dynamic subtest: ccs0
[634.532436] Dynamic subtest ccs0: SUCCESS (0.116s)
[634.534816] Subtest Q-out-order: SUCCESS (0.611s)
[636.206195] [080/133] (386s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[636.305546] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[636.309989] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[636.385155] [081/133] (386s left) gem_pxp (create-regular-context-1)
[636.451229] Starting subtest: create-regular-context-1
[636.453600] Subtest create-regular-context-1: SUCCESS (0.001s)
[636.564136] [082/133] (385s left) kms_color (gamma)
[636.659321] Starting subtest: gamma
[636.661307] Starting dynamic subtest: pipe-A-eDP-1
[637.384158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[637.394636] Starting dynamic subtest: pipe-B-eDP-1
[638.768526] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[638.778946] Starting dynamic subtest: pipe-C-eDP-1
[640.150579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[640.161096] Starting dynamic subtest: pipe-D-eDP-1
[641.551282] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[641.553632] Subtest gamma: SUCCESS (4.892s)
[642.380448] [083/133] (380s left) kms_addfb_basic (invalid-set-prop)
[642.445899] Starting subtest: invalid-set-prop
[642.447841] Subtest invalid-set-prop: SUCCESS (0.000s)
[642.604152] [084/133] (379s left) syncobj_basic (bad-pad-fd-to-handle)
[642.665050] Starting subtest: bad-pad-fd-to-handle
[642.667415] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[642.781268] [085/133] (379s left) gem_exec_balancer (sliced)
[642.830661] Starting subtest: sliced
[642.835226] Subtest sliced: SKIP (0.000s)
[643.150837] [086/133] (379s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[643.238305] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[643.250174] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[643.326473] [087/133] (379s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[643.426654] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[643.430971] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[643.519299] [088/133] (379s left) kms_chamelium_audio (dp-audio)
[643.899929] Subtest dp-audio: SKIP (0.000s)
[644.699215] [089/133] (378s left) kms_addfb_basic (invalid-get-prop-any)
[644.757445] Starting subtest: invalid-get-prop-any
[644.759890] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[644.902724] [090/133] (377s left) kms_flip (flip-vs-modeset-vs-hang)
[644.999853] Starting subtest: flip-vs-modeset-vs-hang
[645.002227] Starting dynamic subtest: A-eDP1
[684.601969] Dynamic subtest A-eDP1: SUCCESS (39.588s)
[684.612383] Starting dynamic subtest: D-eDP1
[734.585990] Dynamic subtest D-eDP1: SUCCESS (49.973s)
[734.588007] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.565s)
[734.970910] [091/133] (287s left) kms_psr (pr-sprite-mmap-gtt)
[735.081795] Starting subtest: pr-sprite-mmap-gtt
[735.086148] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[735.155258] [092/133] (287s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[735.269949] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[735.274202] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[735.373929] [093/133] (287s left) kms_lease (lease-invalid-connector)
[735.482190] Starting subtest: lease-invalid-connector
[735.484394] Starting dynamic subtest: pipe-A-eDP-1
[735.486744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[735.497294] Starting dynamic subtest: pipe-B-eDP-1
[735.499678] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[735.509639] Starting dynamic subtest: pipe-C-eDP-1
[735.511726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[735.521162] Starting dynamic subtest: pipe-D-eDP-1
[735.523321] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[735.525432] Subtest lease-invalid-connector: SUCCESS (0.004s)
[735.564118] [094/133] (287s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[735.670988] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[740.111113] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.444s)
[741.284281] [095/133] (281s left) gem_caching (read-writes)
[741.351309] Subtest read-writes: SKIP (0.000s)
[741.419027] [096/133] (281s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[741.508077] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[741.510178] Starting dynamic subtest: pipe-A-eDP-1
[741.531724] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[741.542527] Starting dynamic subtest: pipe-B-eDP-1
[741.563100] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[741.572775] Starting dynamic subtest: pipe-C-eDP-1
[741.593172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[741.602585] Starting dynamic subtest: pipe-D-eDP-1
[741.623515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[741.627330] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[743.685168] [097/133] (279s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[743.815861] Starting subtest: cursorB-vs-flipA-atomic
[743.820328] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[743.962404] [098/133] (279s left) gem_mmap_gtt (basic)
[744.013249] Subtest basic: SKIP (0.000s)
[744.070221] [099/133] (279s left) gem_mmap_offset (open-flood)
[744.119013] Starting subtest: open-flood
[765.608641] Subtest open-flood: SUCCESS (21.489s)
[765.714336] [100/133] (257s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[765.817242] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[765.820648] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[765.922561] [101/133] (257s left) kms_pm_rpm (universal-planes)
[767.451883] Starting subtest: universal-planes
[767.454414] Starting dynamic subtest: plane-34
[775.767971] Dynamic subtest plane-34: SUCCESS (8.318s)
[775.780421] Starting dynamic subtest: plane-64
[784.179598] Dynamic subtest plane-64: SUCCESS (8.406s)
[784.192456] Starting dynamic subtest: plane-94
[792.502252] Dynamic subtest plane-94: SUCCESS (8.319s)
[792.515958] Starting dynamic subtest: plane-124
[800.813300] Dynamic subtest plane-124: SUCCESS (8.307s)
[800.825834] Starting dynamic subtest: plane-134
[809.139692] Dynamic subtest plane-134: SUCCESS (8.322s)
[809.152253] Starting dynamic subtest: plane-144
[817.443357] Dynamic subtest plane-144: SUCCESS (8.300s)
[817.446199] Subtest universal-planes: SUCCESS (49.988s)
[817.849094] [102/133] (205s left) kms_flip (2x-flip-vs-dpms)
[817.940125] Starting subtest: 2x-flip-vs-dpms
[817.948722] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[818.034250] [103/133] (205s left) perf (per-context-mode-unprivileged)
[818.131804] Starting subtest: per-context-mode-unprivileged
[818.136459] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[818.185466] [104/133] (205s left) gem_mmap_gtt (basic-small-bo-tiledx)
[818.249024] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[818.311926] [105/133] (205s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[818.433672] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[818.438237] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[818.578402] [106/133] (204s left) prime_udl
[818.665541] [107/133] (204s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[818.786661] Starting subtest: flip-vs-cursor-busy-crc-legacy
[819.622127] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.834s)
[820.456152] [108/133] (203s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[820.582748] Starting subtest: basic-busy-flip-before-cursor-legacy
[820.587461] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[820.743175] [109/133] (202s left) gem_tiled_wb
[820.876338] [110/133] (202s left) kms_pipe_crc_basic (suspend-read-crc)
[820.962982] Starting subtest: suspend-read-crc
[820.964907] Starting dynamic subtest: pipe-A-eDP-1
[839.021991] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.525s)
[839.032504] Starting dynamic subtest: pipe-B-eDP-1
[857.037089] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[857.047576] Starting dynamic subtest: pipe-C-eDP-1
[874.977961] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.018s)
[874.987931] Starting dynamic subtest: pipe-D-eDP-1
[892.992157] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.062s)
[892.994414] Subtest suspend-read-crc: SUCCESS (11.822s)
[893.812507] [111/133] (129s left) gem_exec_balancer (nohangcheck)
[894.078285] Starting subtest: nohangcheck
[894.985488] Subtest nohangcheck: SUCCESS (0.913s)
[895.122914] [112/133] (128s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[895.220687] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[901.939031] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.750s)
[902.063133] [113/133] (121s left) i915_drm_fdinfo (all-busy-check-all)
[902.105055] Starting subtest: all-busy-check-all
[902.111695] Subtest all-busy-check-all: SKIP (0.005s)
[902.191121] [114/133] (121s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[902.314345] Starting subtest: fbc-pr-cursor-mmap-gtt
[902.318955] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[902.390674] [115/133] (121s left) kms_hdr (static-swap)
[902.485642] Starting subtest: static-swap
[902.491837] Subtest static-swap: SKIP (0.000s)
[902.562431] [116/133] (121s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[902.665027] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[907.391128] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.739s)
[908.590770] [117/133] (115s left) gem_exec_whisper (basic-queues-priority-all)
[908.643218] Starting subtest: basic-queues-priority-all
[928.880910] Subtest basic-queues-priority-all: SUCCESS (20.245s)
[929.063248] [118/133] ( 94s left) syncobj_eventfd (invalid-bad-flags)
[929.120366] Starting subtest: invalid-bad-flags
[929.122693] Subtest invalid-bad-flags: SUCCESS (0.000s)
[929.228155] [119/133] ( 94s left) prime_self_import (basic-llseek-bad)
[929.258527] Starting subtest: basic-llseek-bad
[929.284933] Subtest basic-llseek-bad: SUCCESS (0.025s)
[929.375453] [120/133] ( 94s left) syncobj_wait (multi-wait-for-submit-signaled)
[929.427800] Starting subtest: multi-wait-for-submit-signaled
[929.430116] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[929.530735] [121/133] ( 94s left) syncobj_timeline (transfer-timeline-point)
[929.574977] Starting subtest: transfer-timeline-point
[929.577279] Subtest transfer-timeline-point: SUCCESS (0.000s)
[929.678474] [122/133] ( 94s left) perf_pmu (busy-check-all)
[929.714569] Starting subtest: busy-check-all
[929.716673] Starting dynamic subtest: rcs0
[930.266006] Dynamic subtest rcs0: SUCCESS (0.553s)
[930.279066] Starting dynamic subtest: bcs0
[930.819821] Dynamic subtest bcs0: SUCCESS (0.551s)
[930.833508] Starting dynamic subtest: vcs0
[932.435616] Dynamic subtest vcs0: SUCCESS (1.612s)
[932.459339] Starting dynamic subtest: vcs1
[934.418686] Dynamic subtest vcs1: SUCCESS (1.981s)
[934.432586] Starting dynamic subtest: vecs0
[936.403929] Dynamic subtest vecs0: SUCCESS (1.982s)
[936.417604] Starting dynamic subtest: ccs0
[936.962566] Dynamic subtest ccs0: SUCCESS (0.557s)
[936.965146] Subtest busy-check-all: SUCCESS (7.252s)
[937.062049] [123/133] ( 87s left) perf (short-reads)
[937.134461] Starting subtest: short-reads
[937.151633] Subtest short-reads: SUCCESS (0.017s)
[937.194471] [124/133] ( 87s left) perf_pmu (most-busy-check-all)
[937.230672] Starting subtest: most-busy-check-all
[937.232655] Starting dynamic subtest: rcs0
[938.386854] Dynamic subtest rcs0: SUCCESS (1.156s)
[938.400306] Starting dynamic subtest: bcs0
[940.371208] Dynamic subtest bcs0: SUCCESS (1.981s)
[940.383097] Starting dynamic subtest: vcs0
[942.419894] Dynamic subtest vcs0: SUCCESS (2.046s)
[942.432903] Starting dynamic subtest: vcs1
[944.403783] Dynamic subtest vcs1: SUCCESS (1.982s)
[944.418005] Starting dynamic subtest: vecs0
[946.387793] Dynamic subtest vecs0: SUCCESS (1.981s)
[946.400891] Starting dynamic subtest: ccs0
[948.372109] Dynamic subtest ccs0: SUCCESS (1.981s)
[948.375095] Subtest most-busy-check-all: SUCCESS (11.145s)
[948.481678] [125/133] ( 75s left) kms_selftest (drm_dp_mst_helper)
[948.518213] Starting subtest: drm_dp_mst_helper
[948.556630] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[948.647639] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.093s)
[948.659332] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[948.747644] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.096s)
[948.757938] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[948.861133] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.114s)
[948.863342] Subtest drm_dp_mst_helper: SUCCESS (0.342s)
[949.020036] [126/133] ( 75s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[949.137327] Starting subtest: blocking-absolute-wf_vblank-interruptible
[949.139532] Starting dynamic subtest: A-eDP1
[957.853083] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[957.867696] Starting dynamic subtest: B-eDP1
[966.578939] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[966.596106] Starting dynamic subtest: C-eDP1
[975.308741] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[975.320625] Starting dynamic subtest: D-eDP1
[983.989467] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[983.996174] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.870s)
[985.200278] [127/133] ( 39s left) gem_basic (multigpu-create-close)
[985.275915] Starting subtest: multigpu-create-close
[985.280012] Subtest multigpu-create-close: SKIP (0.000s)
[985.390330] [128/133] ( 39s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[985.490172] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[992.829359] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.338s)
[992.954030] [129/133] ( 31s left) gem_mmap (bad-size)
[993.009115] Subtest bad-size: SKIP (0.000s)
[993.075804] [130/133] ( 31s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[993.179611] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[993.184008] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[993.278355] [131/133] ( 31s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[993.379021] Starting subtest: fbcpsr-rgb565-draw-pwrite
[1000.513582] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.135s)
[1000.638193] [132/133] ( 23s left) kms_draw_crc (draw-method-render)
[1000.742382] Starting subtest: draw-method-render
[1000.744543] Starting dynamic subtest: xrgb8888-untiled
[1000.996497] Dynamic subtest xrgb8888-untiled: SUCCESS (0.256s)
[1001.009304] Starting dynamic subtest: rgb565-untiled
[1001.241515] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[1001.251871] Starting dynamic subtest: xrgb2101010-untiled
[1001.473883] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[1001.484254] Starting dynamic subtest: xbgr16161616f-untiled
[1001.719108] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[1001.729614] Starting dynamic subtest: xrgb8888-xtiled
[1001.841317] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[1001.854095] Starting dynamic subtest: rgb565-xtiled
[1001.953128] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[1001.974607] Starting dynamic subtest: xrgb2101010-xtiled
[1002.075088] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[1002.087509] Starting dynamic subtest: xbgr16161616f-xtiled
[1002.207905] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[1002.218230] Starting dynamic subtest: xrgb8888-4tiled
[1002.341390] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[1002.353386] Starting dynamic subtest: rgb565-4tiled
[1002.452410] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[1002.462483] Starting dynamic subtest: xrgb2101010-4tiled
[1002.574785] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[1002.585060] Starting dynamic subtest: xbgr16161616f-4tiled
[1002.708037] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[1002.710143] Subtest draw-method-render: SUCCESS (1.968s)
[1002.826577] [133/133] ( 21s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[1002.924284] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[1002.928084] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[1003.031032] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_hdmi_inject
results: parsing output: 5/ for test: gem_mmap
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: i915_selftest
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: i915_hangman
results: parsing output: 21/ for test: i915_pm_rpm
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: core_getversion
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_cursor_edge_walk
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: core_getstats
results: parsing output: 37/ for test: kms_atomic
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_plane_cursor
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: gem_spin_batch
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: prime_busy
results: parsing output: 55/ for test: template
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: gem_cs_tlb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gen3_render_tiledy_blits
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_wait
results: parsing output: 78/ for test: gem_ctx_shared
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: syncobj_basic
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_chamelium_audio
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_caching
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_mmap_offset
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: prime_udl
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_tiled_wb
results: parsing output: 109/ for test: kms_pipe_crc_basic
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: syncobj_eventfd
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_selftest
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_mmap
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_draw_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.