[59.988660] Initializing watchdogs
[59.988705]   /dev/watchdog0
[60.002215] [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.006451] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.008636] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.011842] [001/133] (960s left) syncobj_timeline (invalid-transfer-bad-pad)
[60.104450] Starting subtest: invalid-transfer-bad-pad
[60.106835] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[60.239265] [002/133] (960s left) kms_draw_crc (draw-method-render)
[60.334876] Starting subtest: draw-method-render
[60.336850] Starting dynamic subtest: xrgb8888-untiled
[60.587724] Dynamic subtest xrgb8888-untiled: SUCCESS (0.254s)
[60.595619] Starting dynamic subtest: rgb565-untiled
[60.809682] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[60.816998] Starting dynamic subtest: xrgb2101010-untiled
[61.020980] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[61.028793] Starting dynamic subtest: xbgr16161616f-untiled
[61.265088] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[61.272849] Starting dynamic subtest: xrgb8888-xtiled
[61.398531] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[61.405803] Starting dynamic subtest: rgb565-xtiled
[61.509545] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[61.516601] Starting dynamic subtest: xrgb2101010-xtiled
[61.620986] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[61.628461] Starting dynamic subtest: xbgr16161616f-xtiled
[61.754024] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[61.761099] Starting dynamic subtest: xrgb8888-4tiled
[61.876300] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[61.883838] Starting dynamic subtest: rgb565-4tiled
[61.998450] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[62.007729] Starting dynamic subtest: xrgb2101010-4tiled
[62.110095] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[62.118425] Starting dynamic subtest: xbgr16161616f-4tiled
[62.242984] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[62.244869] Subtest draw-method-render: SUCCESS (1.910s)
[62.393689] [003/133] (958s left) api_intel_allocator (default-alignment)
[62.462820] Starting subtest: default-alignment
[62.465056] Subtest default-alignment: SUCCESS (0.003s)
[62.615215] [004/133] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[62.715565] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[66.626049] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.914s)
[67.820180] [005/133] (952s left) syncobj_timeline (wait-all-for-submit-snapshot)
[67.895196] Starting subtest: wait-all-for-submit-snapshot
[67.976252] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[68.080422] [006/133] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[68.179195] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[68.183276] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[68.295050] [007/133] (952s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[68.384474] Starting subtest: plane-downscale-factor-0-5-with-rotation
[68.386859] Starting dynamic subtest: pipe-A
[68.405066] Dynamic subtest pipe-A: SKIP (0.015s)
[68.413833] Starting dynamic subtest: pipe-B
[68.435405] Dynamic subtest pipe-B: SKIP (0.031s)
[68.442330] Starting dynamic subtest: pipe-C
[68.467171] Dynamic subtest pipe-C: SKIP (0.031s)
[68.474018] Starting dynamic subtest: pipe-D
[68.499977] Dynamic subtest pipe-D: SKIP (0.031s)
[68.503767] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.110s)
[68.610458] [008/133] (952s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[68.723917] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[69.735121] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.011s)
[69.908950] [009/133] (950s left) i915_selftest (live)
[71.703803] Starting subtest: live
[71.706103] Starting dynamic subtest: sanitycheck
[76.142949] Dynamic subtest sanitycheck: SUCCESS (4.439s)
[76.151461] Starting dynamic subtest: uncore
[80.524221] Dynamic subtest uncore: SUCCESS (4.380s)
[80.532540] Starting dynamic subtest: workarounds
[97.967584] Dynamic subtest workarounds: FAIL (16.964s)
[97.975375] Starting dynamic subtest: gt_engines
[100.678323] Dynamic subtest gt_engines: SUCCESS (3.188s)
[100.686872] Starting dynamic subtest: gt_timelines
[118.556901] Dynamic subtest gt_timelines: SUCCESS (17.877s)
[118.565521] Starting dynamic subtest: gt_contexts
[122.999665] Dynamic subtest gt_contexts: SUCCESS (4.442s)
[123.008717] Starting dynamic subtest: gt_lrc
[127.361750] Dynamic subtest gt_lrc: SUCCESS (4.361s)
[127.370070] Starting dynamic subtest: gt_mocs
[132.320732] Dynamic subtest gt_mocs: SUCCESS (4.958s)
[132.335982] Starting dynamic subtest: gt_pm
[139.349795] Dynamic subtest gt_pm: SUCCESS (7.028s)
[139.358224] Starting dynamic subtest: gt_heartbeat
[143.779063] Dynamic subtest gt_heartbeat: SUCCESS (4.427s)
[143.787080] Starting dynamic subtest: gt_tlb
[153.220399] Dynamic subtest gt_tlb: SUCCESS (9.436s)
[153.234406] Starting dynamic subtest: requests
[164.766844] Dynamic subtest requests: SUCCESS (11.542s)
[164.775701] Starting dynamic subtest: migrate
[172.890351] Dynamic subtest migrate: SUCCESS (8.121s)
[172.899613] Starting dynamic subtest: active
[175.713436] Dynamic subtest active: SUCCESS (2.818s)
[175.721739] Starting dynamic subtest: objects
[180.491835] Dynamic subtest objects: SUCCESS (4.780s)
[180.500435] Starting dynamic subtest: mman
[185.572436] Dynamic subtest mman: SUCCESS (5.079s)
[185.581167] Starting dynamic subtest: dmabuf
[188.473741] Dynamic subtest dmabuf: SUCCESS (2.899s)
[188.482375] Starting dynamic subtest: vma
[192.876453] Dynamic subtest vma: SUCCESS (4.401s)
[192.885054] Starting dynamic subtest: coherency
[196.886435] Dynamic subtest coherency: SUCCESS (4.008s)
[196.894955] Starting dynamic subtest: gtt
[208.880974] Dynamic subtest gtt: SUCCESS (11.992s)
[208.889838] Starting dynamic subtest: gem
[216.696391] Dynamic subtest gem: SUCCESS (7.814s)
[216.708155] Starting dynamic subtest: evict
[220.777358] Dynamic subtest evict: SUCCESS (4.079s)
[220.785875] Starting dynamic subtest: hugepages
[231.925674] Dynamic subtest hugepages: SUCCESS (11.146s)
[231.934823] Starting dynamic subtest: gem_contexts
[258.588934] Dynamic subtest gem_contexts: SUCCESS (26.660s)
[258.597792] Starting dynamic subtest: client
[263.033666] Dynamic subtest client: SUCCESS (4.444s)
[263.042607] Starting dynamic subtest: gem_migrate
[267.499279] Dynamic subtest gem_migrate: SUCCESS (4.464s)
[267.508244] Starting dynamic subtest: reset
[270.446712] Dynamic subtest reset: SUCCESS (2.944s)
[270.455279] Starting dynamic subtest: memory_region
[274.854288] Dynamic subtest memory_region: SUCCESS (4.406s)
[274.862760] Starting dynamic subtest: hangcheck
[288.193120] Dynamic subtest hangcheck: SUCCESS (13.337s)
[288.201757] Starting dynamic subtest: execlists
[292.620723] Dynamic subtest execlists: SUCCESS (4.426s)
[292.629574] Starting dynamic subtest: ring_submission
[297.073197] Dynamic subtest ring_submission: SUCCESS (4.451s)
[297.081763] Starting dynamic subtest: perf
[299.901462] Dynamic subtest perf: SUCCESS (2.826s)
[299.910411] Starting dynamic subtest: slpc
[314.056422] Dynamic subtest slpc: SUCCESS (14.153s)
[314.065780] Starting dynamic subtest: guc
[318.136028] Dynamic subtest guc: SUCCESS (4.078s)
[318.144905] Starting dynamic subtest: guc_multi_lrc
[320.926105] Dynamic subtest guc_multi_lrc: SUCCESS (2.787s)
[320.934559] Starting dynamic subtest: guc_hang
[325.982761] Dynamic subtest guc_hang: SUCCESS (5.054s)
[325.991067] Starting dynamic subtest: late_gt_pm
[330.450433] Dynamic subtest late_gt_pm: SUCCESS (4.465s)
[330.453107] Subtest live: FAIL (258.735s)
[330.479177] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[330.482581] [010/133] (690s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[332.044901] Starting subtest: fbc-pr-cursor-plane-update-sf
[332.049434] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[332.141949] [FACT kms_psr2_sf (fbc-pr-cursor-plane-update-sf)] new: kernel.kmod_is_loaded.i915: true
[332.145731] [011/133] (688s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[332.279121] Starting subtest: basic-flip-before-cursor-atomic
[333.220787] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.941s)
[334.120556] [012/133] (686s left) kms_plane_scaling (planes-downscale-factor-0-75)
[334.224988] Starting subtest: planes-downscale-factor-0-75
[334.227297] Starting dynamic subtest: pipe-A
[334.245183] Dynamic subtest pipe-A: SKIP (0.017s)
[334.252670] Starting dynamic subtest: pipe-B
[334.278339] Dynamic subtest pipe-B: SKIP (0.032s)
[334.285437] Starting dynamic subtest: pipe-C
[334.311431] Dynamic subtest pipe-C: SKIP (0.033s)
[334.318268] Starting dynamic subtest: pipe-D
[334.344376] Dynamic subtest pipe-D: SKIP (0.032s)
[334.348725] Subtest planes-downscale-factor-0-75: SKIP (0.117s)
[334.451355] [013/133] (686s left) kms_plane_multiple (tiling-x)
[334.559104] Starting subtest: tiling-x
[334.561376] Starting dynamic subtest: pipe-A-eDP-1
[338.328273] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.770s)
[338.335301] Starting dynamic subtest: pipe-B-eDP-1
[342.815359] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.484s)
[342.823179] Starting dynamic subtest: pipe-C-eDP-1
[347.192585] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.376s)
[347.201762] Starting dynamic subtest: pipe-D-eDP-1
[351.550093] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.356s)
[351.552366] Subtest tiling-x: SUCCESS (16.990s)
[352.364349] [014/133] (668s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[352.423598] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[352.530375] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[352.615624] [015/133] (668s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[352.712886] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[352.716938] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[352.792131] [016/133] (668s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[352.858974] Starting subtest: etime-multi-wait-for-submit-submitted
[352.961703] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[353.049413] [017/133] (668s left) gem_userptr_blits (sd-probe)
[353.108447] Starting subtest: sd-probe
[353.110691] Subtest sd-probe: SUCCESS (0.000s)
[353.269941] [018/133] (667s left) gem_ctx_shared (q-independent)
[353.342771] Starting subtest: Q-independent
[353.345019] Starting dynamic subtest: rcs0
[353.403030] Dynamic subtest rcs0: SUCCESS (0.060s)
[353.413746] Starting dynamic subtest: vcs0
[353.442303] Dynamic subtest vcs0: SUCCESS (0.039s)
[353.451384] Starting dynamic subtest: vcs1
[353.495293] Dynamic subtest vcs1: SUCCESS (0.052s)
[353.505470] Starting dynamic subtest: vecs0
[353.532701] Dynamic subtest vecs0: SUCCESS (0.037s)
[353.541249] Starting dynamic subtest: ccs0
[353.574398] Dynamic subtest ccs0: SUCCESS (0.041s)
[353.576791] Subtest Q-independent: SUCCESS (0.232s)
[354.994640] [019/133] (666s left) kms_frontbuffer_tracking (fbc-suspend)
[355.089333] Starting subtest: fbc-suspend
[393.032148] Subtest fbc-suspend: SUCCESS (7.528s)
[394.244240] [020/133] (626s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[394.359973] Starting subtest: yf-tiled-64bpp-rotate-270
[394.364262] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[394.474655] [021/133] (626s left) gem_ctx_param (non-root-set)
[394.536126] Starting subtest: non-root-set
[394.560466] Subtest non-root-set: SUCCESS (0.024s)
[394.661974] [022/133] (626s left) kms_chamelium_color (ctm-max)
[394.766503] Subtest ctm-max: SKIP (0.000s)
[394.809244] [023/133] (626s left) kms_flip (absolute-wf_vblank-interruptible)
[394.913109] Starting subtest: absolute-wf_vblank-interruptible
[394.915498] Starting dynamic subtest: A-eDP1
[403.594816] Dynamic subtest A-eDP1: SUCCESS (8.671s)
[403.603227] Starting dynamic subtest: B-eDP1
[412.323493] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[412.333662] Starting dynamic subtest: C-eDP1
[421.040069] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[421.049167] Starting dynamic subtest: D-eDP1
[429.769042] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[429.771350] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.843s)
[430.989674] [024/133] (590s left) kms_cursor_edge_walk (256x256-left-edge)
[431.088287] Starting subtest: 256x256-left-edge
[431.090568] Starting dynamic subtest: pipe-A-eDP-1
[434.559575] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[434.568244] Starting dynamic subtest: pipe-D-eDP-1
[437.675978] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[437.678160] Subtest 256x256-left-edge: SUCCESS (6.587s)
[438.499925] [025/133] (582s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[438.599236] Starting subtest: plane-all-transition-nonblocking-fencing
[438.601488] Starting dynamic subtest: pipe-A-eDP-1
[441.092428] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[441.397049] Starting dynamic subtest: pipe-B-eDP-1
[444.618649] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s)
[444.930672] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.330s)
[445.752127] [026/133] (575s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[445.848415] Starting subtest: compare-crc-sanitycheck-nv12
[445.850758] Starting dynamic subtest: pipe-A-eDP-1
[446.475745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[446.484956] Starting dynamic subtest: pipe-B-eDP-1
[447.717781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.242s)
[447.727791] Starting dynamic subtest: pipe-C-eDP-1
[448.884912] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.167s)
[448.894729] Starting dynamic subtest: pipe-D-eDP-1
[450.169201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.283s)
[450.171678] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.322s)
[451.008258] [027/133] (570s left) kms_addfb_basic (bad-pitch-256)
[451.064987] Starting subtest: bad-pitch-256
[451.067495] Subtest bad-pitch-256: SUCCESS (0.000s)
[451.226394] [028/133] (570s left) fbdev (nullptr)
[451.265752] Starting subtest: nullptr
[451.268049] Subtest nullptr: SUCCESS (0.000s)
[451.335041] [029/133] (570s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[451.453818] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[452.441938] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.987s)
[453.247321] [030/133] (568s left) syncobj_wait (invalid-signal-bad-pad)
[453.315887] Starting subtest: invalid-signal-bad-pad
[453.318044] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[453.427803] [031/133] (568s left) gem_spin_batch (spin-all-new)
[453.496374] Starting subtest: spin-all-new
[453.510407] Subtest spin-all-new: SUCCESS (0.013s)
[455.376993] [032/133] (566s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[455.499808] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[456.335604] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[456.514950] [033/133] (565s left) gem_lmem_swapping (heavy-multi)
[456.558109] Subtest heavy-multi: SKIP (0.000s)
[456.628172] [034/133] (565s left) gem_mmap_gtt (isolation)
[456.694434] Subtest isolation: SKIP (0.000s)
[456.753612] [035/133] (565s left) gem_exec_whisper (basic-contexts-forked)
[456.828597] Starting subtest: basic-contexts-forked
[480.910166] Subtest basic-contexts-forked: SUCCESS (24.073s)
[481.109353] [036/133] (540s left) gem_close (basic)
[481.173278] Starting subtest: basic
[481.175645] Subtest basic: SUCCESS (0.000s)
[481.300501] [037/133] (540s left) gen9_exec_parse (bb-start-far)
[481.367388] Subtest bb-start-far: SKIP (0.000s)
[481.447924] [038/133] (540s left) gem_exec_balancer (full-pulse)
[481.525960] Starting subtest: full-pulse
[486.248699] Subtest full-pulse: SUCCESS (4.721s)
[486.586720] [039/133] (535s left) kms_addfb_basic (basic-x-tiled-legacy)
[486.644638] Starting subtest: basic-x-tiled-legacy
[486.649194] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[486.788732] [040/133] (535s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[486.881255] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[486.885686] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[486.966203] [041/133] (535s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[487.067818] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[488.137924] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.070s)
[488.290418] [042/133] (533s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[488.387393] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[488.391619] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[488.504850] [043/133] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[488.600596] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[496.015007] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.418s)
[496.165700] [044/133] (526s left) kms_chamelium_frames (dp-crc-multiple)
[496.561877] Subtest dp-crc-multiple: SKIP (0.000s)
[497.379019] [045/133] (524s left) kms_flip (nonexisting-fb-interruptible)
[497.493478] Starting subtest: nonexisting-fb-interruptible
[497.495891] Starting dynamic subtest: A-eDP1
[498.687232] Dynamic subtest A-eDP1: SUCCESS (1.193s)
[498.700461] Starting dynamic subtest: B-eDP1
[499.815850] Dynamic subtest B-eDP1: SUCCESS (1.126s)
[499.826065] Starting dynamic subtest: C-eDP1
[500.941367] Dynamic subtest C-eDP1: SUCCESS (1.125s)
[500.951518] Starting dynamic subtest: D-eDP1
[502.073272] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[502.075613] Subtest nonexisting-fb-interruptible: SUCCESS (4.584s)
[503.257388] [046/133] (519s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[503.365519] Starting subtest: psr2-cursor-plane-move-continuous-sf
[503.367703] Starting dynamic subtest: pipe-A-eDP-1
[513.702330] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.340s)
[513.712092] Starting dynamic subtest: pipe-B-eDP-1
[524.801786] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.097s)
[524.804017] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.440s)
[525.606335] [047/133] (496s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[525.701383] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[533.061097] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.362s)
[533.231607] [048/133] (489s left) sysfs_timeslice_duration (invalid)
[533.298174] Starting subtest: invalid
[533.300397] Starting dynamic subtest: vecs0
[533.302687] Dynamic subtest vecs0: SUCCESS (0.000s)
[533.313898] Starting dynamic subtest: ccs0
[533.315789] Dynamic subtest ccs0: SUCCESS (0.000s)
[533.323634] Starting dynamic subtest: vcs0
[533.325498] Dynamic subtest vcs0: SUCCESS (0.000s)
[533.333452] Starting dynamic subtest: bcs0
[533.335291] Dynamic subtest bcs0: SUCCESS (0.000s)
[533.343401] Starting dynamic subtest: rcs0
[533.345283] Dynamic subtest rcs0: SUCCESS (0.000s)
[533.353974] Starting dynamic subtest: vcs1
[533.356169] Dynamic subtest vcs1: SUCCESS (0.000s)
[533.358347] Subtest invalid: SUCCESS (0.005s)
[533.425558] [049/133] (488s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[533.537828] Starting subtest: cursorA-vs-flipB-legacy
[533.542418] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[533.697864] [050/133] (488s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[534.075821] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[534.926445] [051/133] (487s left) gem_workarounds (reset-context)
[535.019353] Starting subtest: reset-context
[535.198729] Subtest reset-context: SUCCESS (0.177s)
[535.347395] [052/133] (487s left) kms_setmode (clone-exclusive-crtc)
[535.414097] Starting subtest: clone-exclusive-crtc
[535.420728] Subtest clone-exclusive-crtc: SKIP (0.000s)
[535.537317] [053/133] (487s left) gem_mmap_gtt (fault-concurrent)
[535.600788] Subtest fault-concurrent: SKIP (0.000s)
[535.675528] [054/133] (486s left) gem_ctx_persistence (hang)
[535.731962] Starting subtest: hang
[535.736898] Subtest hang: SKIP (0.000s)
[535.869903] [055/133] (486s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[535.962503] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[535.966168] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[536.093078] [056/133] (486s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[536.200156] Starting subtest: x-tiled-32bpp-rotate-180
[537.723959] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.524s)
[537.902224] [057/133] (484s left) kms_atomic (atomic-plane-damage)
[537.996392] Starting subtest: atomic-plane-damage
[538.045161] Starting dynamic subtest: pipe-A-eDP-1
[538.620135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[538.622429] Subtest atomic-plane-damage: SUCCESS (0.624s)
[539.484303] [058/133] (483s left) gem_create (create-clear)
[539.541528] Starting subtest: create-clear
[539.544079] Starting dynamic subtest: smem0
[572.379588] Dynamic subtest smem0: SUCCESS (32.832s)
[572.381460] Subtest create-clear: SUCCESS (32.833s)
[572.581182] [059/133] (450s left) kms_vblank (wait-busy-hang)
[572.676097] Starting subtest: wait-busy-hang
[572.678299] Starting dynamic subtest: pipe-A-eDP-1
[599.073721] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.388s)
[599.092556] Starting dynamic subtest: pipe-D-eDP-1
[614.041281] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.962s)
[614.043401] Subtest wait-busy-hang: SUCCESS (41.355s)
[614.851810] [060/133] (407s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[614.952216] Starting subtest: flip-primary-invalidate-overlay
[626.544167] Subtest flip-primary-invalidate-overlay: SUCCESS (11.596s)
[626.725702] [061/133] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[626.827655] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[626.831369] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[626.942297] [062/133] (395s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[627.066611] Starting subtest: cursorA-vs-flipB-atomic-transitions
[627.070505] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[627.221716] [063/133] (395s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[627.323550] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[627.325486] Starting dynamic subtest: pipe-A-eDP-1
[627.342348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[627.352150] Starting dynamic subtest: pipe-B-eDP-1
[627.366384] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[627.374702] Starting dynamic subtest: pipe-C-eDP-1
[627.390166] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[627.398085] Starting dynamic subtest: pipe-D-eDP-1
[627.413323] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[627.414851] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[629.521564] [064/133] (393s left) kms_cursor_crc (cursor-sliding-128x128)
[629.729951] Starting subtest: cursor-sliding-128x128
[629.735132] Starting dynamic subtest: pipe-A-eDP-1
[632.946266] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.208s)
[632.969957] Starting dynamic subtest: pipe-D-eDP-1
[636.778066] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.812s)
[636.780522] Subtest cursor-sliding-128x128: SUCCESS (7.046s)
[637.572851] [065/133] (385s left) i915_pm_rpm (debugfs-forcewake-user)
[639.508727] Starting subtest: debugfs-forcewake-user
[650.884456] Subtest debugfs-forcewake-user: SUCCESS (11.380s)
[651.273499] [066/133] (371s left) kms_psr (pr-cursor-mmap-cpu)
[651.370271] Starting subtest: pr-cursor-mmap-cpu
[651.374359] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[651.453314] [067/133] (371s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[651.540585] Starting subtest: plane-lut1d-ctm3x4
[651.558675] Starting dynamic subtest: pipe-A-eDP-1
[652.259043] Dynamic subtest pipe-A-eDP-1: FAIL (0.327s)
[652.922268] Starting dynamic subtest: pipe-B-eDP-1
[653.728958] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[654.265947] Starting dynamic subtest: pipe-C-eDP-1
[655.103839] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[655.584898] Starting dynamic subtest: pipe-D-eDP-1
[656.433340] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[656.435547] Subtest plane-lut1d-ctm3x4: FAIL (4.593s)
[656.977956] [068/133] (366s left) gem_exec_reloc (basic-write-wc)
[657.041934] Subtest basic-write-wc: SKIP (0.000s)
[657.131653] [069/133] (366s left) kms_getfb (getfb2-handle-protection)
[657.225147] Starting subtest: getfb2-handle-protection
[657.245358] Subtest getfb2-handle-protection: SUCCESS (0.020s)
[657.394399] [070/133] (365s left) kms_flip (modeset-vs-vblank-race-interruptible)
[657.492631] Starting subtest: modeset-vs-vblank-race-interruptible
[657.494888] Starting dynamic subtest: A-eDP1
[662.211590] Dynamic subtest A-eDP1: SUCCESS (4.718s)
[662.223381] Starting dynamic subtest: B-eDP1
[666.856076] Dynamic subtest B-eDP1: SUCCESS (4.642s)
[666.872012] Starting dynamic subtest: C-eDP1
[671.357597] Dynamic subtest C-eDP1: SUCCESS (4.499s)
[671.373968] Starting dynamic subtest: D-eDP1
[675.984571] Dynamic subtest D-eDP1: SUCCESS (4.625s)
[675.989503] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.497s)
[677.150473] [071/133] (346s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[677.277763] Starting subtest: protected-encrypted-src-copy-not-readible
[677.389424] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[677.525935] [072/133] (345s left) kms_cursor_crc (cursor-offscreen-256x256)
[677.787356] Starting subtest: cursor-offscreen-256x256
[677.789570] Starting dynamic subtest: pipe-A-eDP-1
[679.718465] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[679.748560] Starting dynamic subtest: pipe-D-eDP-1
[682.343695] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[682.346058] Subtest cursor-offscreen-256x256: SUCCESS (4.557s)
[683.226326] [073/133] (340s left) gem_exec_reloc (basic-cpu-active)
[683.280602] Subtest basic-cpu-active: SKIP (0.000s)
[683.361182] [074/133] (340s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[683.430192] Subtest writes-after-reads: SKIP (0.000s)
[683.511370] [075/133] (339s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[683.566879] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[683.571191] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[683.760202] [076/133] (339s left) gem_exec_balancer (waits)
[683.824476] Starting subtest: waits
[690.276633] Subtest waits: SUCCESS (6.453s)
[690.595237] [077/133] (332s left) gem_partial_pwrite_pread (reads-uncached)
[690.655990] Subtest reads-uncached: SKIP (0.000s)
[690.732893] [078/133] (332s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[690.843220] Starting subtest: y-tiled-32bpp-rotate-270
[690.847365] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[690.938366] [079/133] (332s left) kms_busy (basic-hang)
[691.028341] Starting subtest: basic-hang
[691.030228] Starting dynamic subtest: flip-pipe-A
[691.594994] Dynamic subtest flip-pipe-A: SUCCESS (0.565s)
[691.605772] Starting dynamic subtest: modeset-pipe-A
[695.266501] Dynamic subtest modeset-pipe-A: SUCCESS (3.670s)
[695.275807] Starting dynamic subtest: flip-pipe-D
[696.456968] Dynamic subtest flip-pipe-D: SUCCESS (1.189s)
[696.468386] Starting dynamic subtest: modeset-pipe-D
[699.900719] Dynamic subtest modeset-pipe-D: SUCCESS (3.441s)
[699.903089] Subtest basic-hang: SUCCESS (8.873s)
[700.712286] [080/133] (322s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[700.815590] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[700.819681] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[700.941596] [081/133] (322s left) kms_pm_dc (dc6-dpms)
[702.041139] Starting subtest: dc6-dpms
[704.075090] Subtest dc6-dpms: SUCCESS (2.033s)
[704.163596] [082/133] (319s left) gem_exec_params (rsvd2-dirt)
[704.224224] Starting subtest: rsvd2-dirt
[704.228303] Subtest rsvd2-dirt: SKIP (0.000s)
[704.339350] [083/133] (319s left) kms_vblank (invalid)
[704.434425] Starting subtest: invalid
[704.436697] Starting dynamic subtest: pipe-A-eDP-1
[704.830620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[704.833014] Subtest invalid: SUCCESS (0.396s)
[705.668399] [084/133] (318s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[705.779844] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[728.430393] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.652s)
[728.588394] [085/133] (295s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[728.693233] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[728.696655] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[728.815815] [086/133] (295s left) perf (short-reads)
[728.935067] Starting subtest: short-reads
[728.949743] Subtest short-reads: SUCCESS (0.016s)
[728.989416] [087/133] (294s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[729.071447] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[729.083063] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[729.186561] [088/133] (294s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[729.276402] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[729.279885] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[729.400308] [089/133] (294s left) syncobj_timeline (multi-wait-submitted-signaled)
[729.464806] Starting subtest: multi-wait-submitted-signaled
[729.466786] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[729.575061] [090/133] (294s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[729.634137] Starting subtest: y-tiled-ccs-to-y-tiled
[729.637869] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[729.827672] [091/133] (294s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[729.940077] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[729.942398] Starting dynamic subtest: pipe-A-eDP-1
[730.827884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.880s)
[730.837997] Starting dynamic subtest: pipe-B-eDP-1
[732.364504] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[732.375296] Starting dynamic subtest: pipe-C-eDP-1
[733.876734] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[733.887735] Starting dynamic subtest: pipe-D-eDP-1
[735.401350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[735.403707] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.454s)
[736.598748] [092/133] (287s left) vgem_basic (sysfs)
[736.744667] Starting subtest: sysfs
[736.746748] Subtest sysfs: SUCCESS (0.000s)
[736.818465] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[736.822959] [093/133] (287s left) gem_mmap_gtt (cpuset-big-copy-odd)
[736.881808] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[736.949794] [094/133] (287s left) kms_psr (psr2-sprite-plane-move)
[737.051126] Starting subtest: psr2-sprite-plane-move
[737.053323] Starting dynamic subtest: eDP-1
[738.807614] Dynamic subtest eDP-1: SUCCESS (1.754s)
[738.809770] Subtest psr2-sprite-plane-move: SUCCESS (1.755s)
[739.661260] [095/133] (284s left) kms_psr (fbc-psr-primary-page-flip)
[739.765088] Starting subtest: fbc-psr-primary-page-flip
[739.767302] Starting dynamic subtest: eDP-1
[739.771281] Dynamic subtest eDP-1: SKIP (0.000s)
[739.775262] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[739.851095] [096/133] (284s left) gem_exec_schedule (promotion)
[739.934662] Starting subtest: promotion
[739.936830] Starting dynamic subtest: rcs0
[740.035907] Dynamic subtest rcs0: SUCCESS (0.109s)
[740.048766] Starting dynamic subtest: vcs0
[740.122526] Dynamic subtest vcs0: SUCCESS (0.086s)
[740.134931] Starting dynamic subtest: vcs1
[740.209767] Dynamic subtest vcs1: SUCCESS (0.086s)
[740.222253] Starting dynamic subtest: vecs0
[740.304911] Dynamic subtest vecs0: SUCCESS (0.095s)
[740.317691] Starting dynamic subtest: ccs0
[740.408683] Dynamic subtest ccs0: SUCCESS (0.102s)
[740.411306] Subtest promotion: SUCCESS (0.482s)
[741.466378] [097/133] (282s left) gem_exec_schedule (preempt-queue-contexts)
[741.549431] Subtest preempt-queue-contexts: SKIP (0.000s)
[741.848311] [098/133] (282s left) kms_cursor_legacy (forked-move)
[741.984318] Starting subtest: forked-move
[741.986205] Starting dynamic subtest: pipe-A
[747.433289] Dynamic subtest pipe-A: SUCCESS (5.446s)
[747.450677] Starting dynamic subtest: pipe-B
[752.906996] Dynamic subtest pipe-B: SUCCESS (5.469s)
[752.919176] Starting dynamic subtest: pipe-C
[758.367584] Dynamic subtest pipe-C: SUCCESS (5.459s)
[758.379957] Starting dynamic subtest: pipe-D
[763.845732] Dynamic subtest pipe-D: SUCCESS (5.473s)
[763.858560] Starting dynamic subtest: all-pipes
[769.352332] Dynamic subtest all-pipes: SUCCESS (5.505s)
[769.354789] Subtest forked-move: SUCCESS (27.362s)
[769.525557] [099/133] (254s left) gem_ctx_isolation (preservation)
[769.589897] Starting subtest: preservation
[769.592628] Starting dynamic subtest: rcs0
[769.718914] Dynamic subtest rcs0: SUCCESS (0.128s)
[769.731606] Starting dynamic subtest: bcs0
[769.889725] Dynamic subtest bcs0: SUCCESS (0.169s)
[769.902616] Starting dynamic subtest: vcs0
[770.068428] Dynamic subtest vcs0: SUCCESS (0.178s)
[770.081781] Starting dynamic subtest: vcs1
[771.434075] Dynamic subtest vcs1: SUCCESS (1.365s)
[771.444348] Starting dynamic subtest: vecs0
[773.444345] Dynamic subtest vecs0: SUCCESS (2.009s)
[773.457902] Starting dynamic subtest: ccs0
[775.491740] Dynamic subtest ccs0: SUCCESS (2.045s)
[775.494765] Subtest preservation: SUCCESS (5.901s)
[775.784072] [100/133] (248s left) kms_content_protection (dp-mst-type-1)
[775.941538] Starting subtest: dp-mst-type-1
[775.946210] Subtest dp-mst-type-1: SKIP (0.000s)
[776.093721] [101/133] (248s left) kms_flip (blocking-wf_vblank)
[776.193800] Starting subtest: blocking-wf_vblank
[776.196092] Starting dynamic subtest: A-eDP1
[785.089257] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[785.102217] Starting dynamic subtest: B-eDP1
[794.019649] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[794.029470] Starting dynamic subtest: C-eDP1
[802.945162] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[802.962053] Starting dynamic subtest: D-eDP1
[811.877826] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[811.882870] Subtest blocking-wf_vblank: SUCCESS (35.684s)
[813.133193] [102/133] (211s left) i915_getparams_basic (basic-subslice-total)
[813.193363] Starting subtest: basic-subslice-total
[813.197682] Subtest basic-subslice-total: SUCCESS (0.000s)
[813.305959] [103/133] (211s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[813.390844] Starting subtest: fbc-pr-cursor-mmap-gtt
[813.394982] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[813.491557] [104/133] (211s left) gem_mmap_wc (bad-size)
[813.554006] Subtest bad-size: SKIP (0.000s)
[813.622909] [105/133] (211s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[813.722739] Starting subtest: fbcpsr-tiling-y
[813.726832] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[813.853594] [106/133] (210s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[813.949493] Starting subtest: fbcpsr-indfb-scaledprimary
[819.648500] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.701s)
[819.808554] [107/133] (204s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[819.909445] Starting subtest: invalid-modeset-force-ultra-joiner
[819.913313] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[819.986386] [108/133] (204s left) prime_vgem (basic-fence-blt)
[820.081805] Starting subtest: basic-fence-blt
[820.165149] Subtest basic-fence-blt: SUCCESS (0.083s)
[820.306565] [109/133] (204s left) i915_drm_fdinfo (most-busy-check-all)
[820.355079] Starting subtest: most-busy-check-all
[820.357436] Starting dynamic subtest: rcs0
[820.362215] Dynamic subtest rcs0: SKIP (0.004s)
[820.374410] Starting dynamic subtest: bcs0
[820.378918] Dynamic subtest bcs0: SKIP (0.000s)
[820.388322] Starting dynamic subtest: vcs0
[820.392422] Dynamic subtest vcs0: SKIP (0.000s)
[820.400985] Starting dynamic subtest: vcs1
[820.405144] Dynamic subtest vcs1: SKIP (0.000s)
[820.413618] Starting dynamic subtest: vecs0
[820.417582] Dynamic subtest vecs0: SKIP (0.000s)
[820.426178] Starting dynamic subtest: ccs0
[820.430154] Dynamic subtest ccs0: SKIP (0.000s)
[820.434201] Subtest most-busy-check-all: SKIP (0.009s)
[820.471169] [110/133] (204s left) gem_exec_schedule (fairslice)
[820.580573] Starting subtest: fairslice
[820.582429] Starting dynamic subtest: rcs0
[822.592747] Dynamic subtest rcs0: SUCCESS (2.017s)
[822.603744] Starting dynamic subtest: bcs0
[824.616231] Dynamic subtest bcs0: SUCCESS (2.023s)
[824.625672] Starting dynamic subtest: vcs0
[826.640204] Dynamic subtest vcs0: SUCCESS (2.020s)
[826.656930] Starting dynamic subtest: vcs1
[828.661412] Dynamic subtest vcs1: SUCCESS (2.020s)
[828.672431] Starting dynamic subtest: vecs0
[830.682055] Dynamic subtest vecs0: SUCCESS (2.020s)
[830.692785] Starting dynamic subtest: ccs0
[832.705207] Dynamic subtest ccs0: SUCCESS (2.023s)
[832.707413] Subtest fairslice: SUCCESS (12.129s)
[833.013732] [111/133] (191s left) perf_pmu (event-wait)
[833.055859] Starting subtest: event-wait
[833.057903] Starting dynamic subtest: rcs0
[833.062339] Dynamic subtest rcs0: SKIP (0.000s)
[833.066519] Subtest event-wait: SKIP (0.001s)
[833.177336] [112/133] (191s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[833.279029] Starting subtest: pixel-format-y-tiled-ccs-modifier
[833.291944] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[833.363286] [113/133] (191s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[833.459219] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[833.463107] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[833.576317] [114/133] (191s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[833.680033] Starting subtest: primary-y-tiled-reflect-x-0
[833.741303] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[833.856035] [115/133] (191s left) kms_properties (invalid-properties-atomic)
[833.947679] Starting subtest: invalid-properties-atomic
[834.241704] Subtest invalid-properties-atomic: SUCCESS (0.294s)
[834.327247] [116/133] (190s left) gem_ctx_create (basic)
[834.388027] Starting subtest: basic
[834.390432] Subtest basic: SUCCESS (0.000s)
[834.579983] [117/133] (190s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[834.669838] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[834.674313] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[834.790999] [118/133] (190s left) kms_flip (2x-busy-flip)
[834.883237] Starting subtest: 2x-busy-flip
[834.891895] Subtest 2x-busy-flip: SKIP (0.010s)
[835.022954] [119/133] (190s left) perf (invalid-oa-exponent)
[835.108709] Starting subtest: invalid-oa-exponent
[835.124171] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[835.174202] [120/133] (190s left) kms_vrr (max-min)
[835.272276] Starting subtest: max-min
[835.278854] Subtest max-min: SKIP (0.000s)
[835.358529] [121/133] (189s left) kms_lease (implicit-plane-lease)
[835.466322] Starting subtest: implicit-plane-lease
[835.468601] Subtest implicit-plane-lease: SUCCESS (0.002s)
[835.603807] [122/133] (189s left) kms_pm_rpm (i2c)
[837.524459] Starting subtest: i2c
[842.858336] Subtest i2c: SUCCESS (5.331s)
[842.972579] [123/133] (182s left) core_getversion (all-cards)
[843.014984] Starting subtest: all-cards
[843.019415] Subtest all-cards: SUCCESS (0.010s)
[843.073347] [124/133] (182s left) kms_flip (nonblocking-read)
[843.165136] Starting subtest: nonblocking-read
[843.167627] Subtest nonblocking-read: SUCCESS (0.000s)
[843.289179] [125/133] (182s left) kms_psr (fbc-pr-primary-render)
[843.385725] Starting subtest: fbc-pr-primary-render
[843.389940] Subtest fbc-pr-primary-render: SKIP (0.000s)
[843.470393] [126/133] (182s left) gem_mmap_wc (coherency)
[843.527570] Subtest coherency: SKIP (0.000s)
[843.608092] [127/133] (181s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[843.703481] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[843.708128] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[844.884407] [128/133] (180s left) gem_exec_fence (basic-wait-all)
[844.945067] Starting subtest: basic-wait-all
[845.050589] Subtest basic-wait-all: SUCCESS (0.107s)
[847.460858] [129/133] (178s left) api_intel_bb (full-batch)
[847.526987] Starting subtest: full-batch
[847.532270] Subtest full-batch: SUCCESS (0.008s)
[847.641406] [130/133] (178s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[847.752684] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[847.757066] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[847.866354] [131/133] (177s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[847.953987] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[847.955799] Starting dynamic subtest: pipe-A-eDP-1
[850.181713] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.227s)
[850.193629] Starting dynamic subtest: pipe-B-eDP-1
[852.462112] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.279s)
[852.471471] Starting dynamic subtest: pipe-C-eDP-1
[854.518681] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.052s)
[854.528370] Starting dynamic subtest: pipe-D-eDP-1
[856.598807] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.082s)
[856.600719] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.644s)
[857.800826] [132/133] (167s left) gem_exec_fence (syncobj-signal)
[858.218377] Starting subtest: syncobj-signal
[858.224745] Subtest syncobj-signal: SUCCESS (0.005s)
[859.370005] [133/133] (166s left) syncobj_wait (wait-for-submit-delayed-submit)
[859.423794] Starting subtest: wait-for-submit-delayed-submit
[859.526677] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[859.617085] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_draw_crc
results: parsing output: 2/ for test: api_intel_allocator
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: i915_selftest
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: kms_plane_multiple
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_ctx_shared
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_ctx_param
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_cursor_edge_walk
results: parsing output: 24/ for test: kms_atomic_transition
results: parsing output: 25/ for test: kms_pipe_crc_basic
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: fbdev
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_spin_batch
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: gem_close
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_chamelium_frames
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: sysfs_timeslice_duration
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: gem_workarounds
results: parsing output: 51/ for test: kms_setmode
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: gem_create
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_psr_stress_test
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: i915_pm_rpm
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_color_pipeline
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_getfb
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: gem_partial_pwrite_pread
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_busy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pm_dc
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_ctx_isolation
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: i915_getparams_basic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_joiner
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: gem_ctx_create
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_vrr
results: parsing output: 120/ for test: kms_lease
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: core_getversion
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: syncobj_wait
Done.