[52.636958] Initializing watchdogs
[52.637009]   /dev/watchdog0
[52.651153] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[52.655074] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.657031] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.660304] [001/133] (960s left) syncobj_timeline (invalid-transfer-bad-pad)
[52.740963] Starting subtest: invalid-transfer-bad-pad
[52.743443] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[52.860178] [002/133] (960s left) kms_draw_crc (draw-method-render)
[52.946237] Starting subtest: draw-method-render
[52.948160] Starting dynamic subtest: xrgb8888-untiled
[53.199696] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[53.207784] Starting dynamic subtest: rgb565-untiled
[53.433051] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[53.439741] Starting dynamic subtest: xrgb2101010-untiled
[53.643659] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[53.650640] Starting dynamic subtest: xbgr16161616f-untiled
[53.865911] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[53.875048] Starting dynamic subtest: xrgb8888-xtiled
[53.987922] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[53.994613] Starting dynamic subtest: rgb565-xtiled
[54.121461] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[54.128151] Starting dynamic subtest: xrgb2101010-xtiled
[54.243533] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[54.250892] Starting dynamic subtest: xbgr16161616f-xtiled
[54.354769] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[54.361352] Starting dynamic subtest: xrgb8888-4tiled
[54.488070] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[54.494543] Starting dynamic subtest: rgb565-4tiled
[54.610262] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[54.618578] Starting dynamic subtest: xrgb2101010-4tiled
[54.721538] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[54.728756] Starting dynamic subtest: xbgr16161616f-4tiled
[54.855145] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[54.857136] Subtest draw-method-render: SUCCESS (1.911s)
[55.001992] [003/133] (958s left) api_intel_allocator (default-alignment)
[55.061951] Starting subtest: default-alignment
[55.064211] Subtest default-alignment: SUCCESS (0.003s)
[55.217733] [004/133] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[55.306912] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[59.234747] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.932s)
[60.409563] [005/133] (952s left) syncobj_timeline (wait-all-for-submit-snapshot)
[60.472929] Starting subtest: wait-all-for-submit-snapshot
[60.553363] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[60.635644] [006/133] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[60.730647] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[60.734848] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[60.850297] [007/133] (952s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[60.923655] Starting subtest: plane-downscale-factor-0-5-with-rotation
[60.925934] Starting dynamic subtest: pipe-A
[60.942821] Dynamic subtest pipe-A: SKIP (0.015s)
[60.950352] Starting dynamic subtest: pipe-B
[60.975198] Dynamic subtest pipe-B: SKIP (0.032s)
[60.982352] Starting dynamic subtest: pipe-C
[61.007213] Dynamic subtest pipe-C: SKIP (0.032s)
[61.014186] Starting dynamic subtest: pipe-D
[61.039093] Dynamic subtest pipe-D: SKIP (0.032s)
[61.043349] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.111s)
[61.156781] [008/133] (952s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[61.241903] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[62.302704] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.061s)
[62.446096] [009/133] (951s left) i915_selftest (live)
[65.861828] Starting subtest: live
[65.864528] Starting dynamic subtest: sanitycheck
[70.199766] Dynamic subtest sanitycheck: SUCCESS (4.338s)
[70.208033] Starting dynamic subtest: uncore
[74.571616] Dynamic subtest uncore: SUCCESS (4.371s)
[74.580064] Starting dynamic subtest: workarounds
[77.916520] Dynamic subtest workarounds: SUCCESS (3.344s)
[77.925191] Starting dynamic subtest: gt_engines
[82.569047] Dynamic subtest gt_engines: SUCCESS (4.651s)
[82.577605] Starting dynamic subtest: gt_timelines
[99.465447] Dynamic subtest gt_timelines: SUCCESS (16.894s)
[99.474169] Starting dynamic subtest: gt_contexts
[103.856206] Dynamic subtest gt_contexts: SUCCESS (4.389s)
[103.864772] Starting dynamic subtest: gt_lrc
[108.363230] Dynamic subtest gt_lrc: SUCCESS (4.506s)
[108.371985] Starting dynamic subtest: gt_mocs
[111.519069] Dynamic subtest gt_mocs: SUCCESS (3.155s)
[111.527434] Starting dynamic subtest: gt_pm
[118.450166] Dynamic subtest gt_pm: SUCCESS (6.930s)
[118.458862] Starting dynamic subtest: gt_heartbeat
[122.899069] Dynamic subtest gt_heartbeat: SUCCESS (4.448s)
[122.908029] Starting dynamic subtest: gt_tlb
[132.404231] Dynamic subtest gt_tlb: SUCCESS (9.504s)
[132.413099] Starting dynamic subtest: requests
[146.239873] Dynamic subtest requests: SUCCESS (13.833s)
[146.248644] Starting dynamic subtest: migrate
[152.431587] Dynamic subtest migrate: SUCCESS (6.190s)
[152.440554] Starting dynamic subtest: active
[156.897373] Dynamic subtest active: SUCCESS (4.465s)
[156.906429] Starting dynamic subtest: objects
[161.714074] Dynamic subtest objects: SUCCESS (4.814s)
[161.727608] Starting dynamic subtest: mman
[166.810218] Dynamic subtest mman: SUCCESS (5.094s)
[166.819062] Starting dynamic subtest: dmabuf
[171.249334] Dynamic subtest dmabuf: SUCCESS (4.437s)
[171.258158] Starting dynamic subtest: vma
[175.696436] Dynamic subtest vma: SUCCESS (4.445s)
[175.705440] Starting dynamic subtest: coherency
[179.454091] Dynamic subtest coherency: SUCCESS (3.756s)
[179.462991] Starting dynamic subtest: gtt
[190.786862] Dynamic subtest gtt: SUCCESS (11.330s)
[190.795418] Starting dynamic subtest: gem
[198.710665] Dynamic subtest gem: SUCCESS (7.924s)
[198.719757] Starting dynamic subtest: evict
[204.271342] Dynamic subtest evict: SUCCESS (5.558s)
[204.280546] Starting dynamic subtest: hugepages
[213.506665] Dynamic subtest hugepages: SUCCESS (9.233s)
[213.515418] Starting dynamic subtest: gem_contexts
[239.912269] Dynamic subtest gem_contexts: SUCCESS (26.404s)
[239.921525] Starting dynamic subtest: client
[242.874516] Dynamic subtest client: SUCCESS (2.962s)
[242.883395] Starting dynamic subtest: gem_migrate
[245.680479] Dynamic subtest gem_migrate: SUCCESS (2.804s)
[245.689302] Starting dynamic subtest: reset
[248.570831] Dynamic subtest reset: SUCCESS (2.889s)
[248.579858] Starting dynamic subtest: memory_region
[252.920957] Dynamic subtest memory_region: SUCCESS (4.348s)
[252.929527] Starting dynamic subtest: hangcheck
[266.451828] Dynamic subtest hangcheck: SUCCESS (13.528s)
[266.460752] Starting dynamic subtest: execlists
[269.287268] Dynamic subtest execlists: SUCCESS (2.834s)
[269.300652] Starting dynamic subtest: ring_submission
[273.719239] Dynamic subtest ring_submission: SUCCESS (4.430s)
[273.733017] Starting dynamic subtest: perf
[278.157032] Dynamic subtest perf: SUCCESS (4.436s)
[278.165863] Starting dynamic subtest: slpc
[292.365047] Dynamic subtest slpc: SUCCESS (14.206s)
[292.373999] Starting dynamic subtest: guc
[296.450142] Dynamic subtest guc: SUCCESS (4.083s)
[296.456694] Starting dynamic subtest: guc_multi_lrc
[300.928490] Dynamic subtest guc_multi_lrc: SUCCESS (4.476s)
[300.936902] Starting dynamic subtest: guc_hang
[305.948135] Dynamic subtest guc_hang: SUCCESS (5.018s)
[305.959274] Starting dynamic subtest: late_gt_pm
[310.356919] Dynamic subtest late_gt_pm: SUCCESS (4.406s)
[310.359444] Subtest live: SUCCESS (244.490s)
[310.386013] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[310.389246] [010/133] (703s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[311.922183] Starting subtest: fbc-pr-cursor-plane-update-sf
[311.926189] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[312.023237] [FACT kms_psr2_sf (fbc-pr-cursor-plane-update-sf)] new: kernel.kmod_is_loaded.i915: true
[312.026881] [011/133] (701s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[312.122633] Starting subtest: basic-flip-before-cursor-atomic
[313.064929] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.942s)
[313.902311] [012/133] (699s left) kms_plane_scaling (planes-downscale-factor-0-75)
[313.978555] Starting subtest: planes-downscale-factor-0-75
[313.980882] Starting dynamic subtest: pipe-A
[314.003823] Dynamic subtest pipe-A: SKIP (0.018s)
[314.015564] Starting dynamic subtest: pipe-B
[314.034456] Dynamic subtest pipe-B: SKIP (0.033s)
[314.045314] Starting dynamic subtest: pipe-C
[314.068284] Dynamic subtest pipe-C: SKIP (0.032s)
[314.075921] Starting dynamic subtest: pipe-D
[314.100931] Dynamic subtest pipe-D: SKIP (0.033s)
[314.104759] Subtest planes-downscale-factor-0-75: SKIP (0.118s)
[314.224531] [013/133] (699s left) kms_plane_multiple (tiling-x)
[314.304022] Starting subtest: tiling-x
[314.306213] Starting dynamic subtest: pipe-A-eDP-1
[318.021546] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.717s)
[318.029768] Starting dynamic subtest: pipe-B-eDP-1
[322.342557] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.320s)
[322.350261] Starting dynamic subtest: pipe-C-eDP-1
[326.684321] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.340s)
[326.692344] Starting dynamic subtest: pipe-D-eDP-1
[331.047769] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.362s)
[331.049900] Subtest tiling-x: SUCCESS (16.744s)
[331.853656] [014/133] (681s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[331.913920] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[332.021993] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[332.106632] [015/133] (681s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[332.178107] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[332.182688] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[332.278391] [016/133] (681s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[332.339570] Starting subtest: etime-multi-wait-for-submit-submitted
[332.447057] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[332.531417] [017/133] (681s left) gem_userptr_blits (sd-probe)
[332.612813] Starting subtest: sd-probe
[332.614954] Subtest sd-probe: SUCCESS (0.000s)
[332.778745] [018/133] (680s left) gem_ctx_shared (q-independent)
[332.844231] Starting subtest: Q-independent
[332.846624] Starting dynamic subtest: rcs0
[332.913666] Dynamic subtest rcs0: SUCCESS (0.069s)
[332.924033] Starting dynamic subtest: vcs0
[332.958300] Dynamic subtest vcs0: SUCCESS (0.044s)
[332.967866] Starting dynamic subtest: vcs1
[333.003146] Dynamic subtest vcs1: SUCCESS (0.044s)
[333.012446] Starting dynamic subtest: vecs0
[333.041145] Dynamic subtest vecs0: SUCCESS (0.037s)
[333.049880] Starting dynamic subtest: ccs0
[333.082571] Dynamic subtest ccs0: SUCCESS (0.040s)
[333.085065] Subtest Q-independent: SUCCESS (0.238s)
[335.005904] [019/133] (678s left) kms_frontbuffer_tracking (fbc-suspend)
[335.097359] Starting subtest: fbc-suspend
[373.222344] Subtest fbc-suspend: SUCCESS (7.584s)
[374.416594] [020/133] (639s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[374.522811] Starting subtest: yf-tiled-64bpp-rotate-270
[374.527694] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[374.647337] [021/133] (639s left) gem_ctx_param (non-root-set)
[374.722558] Starting subtest: non-root-set
[374.753027] Subtest non-root-set: SUCCESS (0.031s)
[374.854283] [022/133] (639s left) kms_chamelium_color (ctm-max)
[374.934510] Subtest ctm-max: SKIP (0.000s)
[374.976649] [023/133] (639s left) kms_flip (absolute-wf_vblank-interruptible)
[375.060314] Starting subtest: absolute-wf_vblank-interruptible
[375.062728] Starting dynamic subtest: A-eDP1
[383.786942] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[383.796671] Starting dynamic subtest: B-eDP1
[392.516945] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[392.526965] Starting dynamic subtest: C-eDP1
[401.241593] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[401.254979] Starting dynamic subtest: D-eDP1
[409.967399] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[409.973460] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.892s)
[411.194021] [024/133] (602s left) kms_cursor_edge_walk (256x256-left-edge)
[411.281582] Starting subtest: 256x256-left-edge
[411.283962] Starting dynamic subtest: pipe-A-eDP-1
[414.749965] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[414.759524] Starting dynamic subtest: pipe-D-eDP-1
[417.883583] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[417.886238] Subtest 256x256-left-edge: SUCCESS (6.604s)
[418.698232] [025/133] (595s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[418.784396] Starting subtest: plane-all-transition-nonblocking-fencing
[418.786679] Starting dynamic subtest: pipe-A-eDP-1
[421.279752] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[421.587994] Starting dynamic subtest: pipe-B-eDP-1
[424.823607] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.246s)
[425.120945] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.336s)
[425.947739] [026/133] (588s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[426.030966] Starting subtest: compare-crc-sanitycheck-nv12
[426.034016] Starting dynamic subtest: pipe-A-eDP-1
[426.687639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.655s)
[426.696538] Starting dynamic subtest: pipe-B-eDP-1
[427.889975] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.202s)
[427.900004] Starting dynamic subtest: pipe-C-eDP-1
[429.115529] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[429.125341] Starting dynamic subtest: pipe-D-eDP-1
[430.320930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[430.323849] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.291s)
[431.167843] [027/133] (582s left) kms_addfb_basic (bad-pitch-256)
[431.230636] Starting subtest: bad-pitch-256
[431.232929] Subtest bad-pitch-256: SUCCESS (0.000s)
[431.371190] [028/133] (582s left) fbdev (nullptr)
[431.412257] Starting subtest: nullptr
[431.414700] Subtest nullptr: SUCCESS (0.000s)
[431.480352] [029/133] (582s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[431.581667] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[432.558827] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.976s)
[433.398208] [030/133] (580s left) syncobj_wait (invalid-signal-bad-pad)
[433.452774] Starting subtest: invalid-signal-bad-pad
[433.455187] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[433.546180] [031/133] (580s left) gem_spin_batch (spin-all-new)
[433.606983] Starting subtest: spin-all-new
[433.620869] Subtest spin-all-new: SUCCESS (0.016s)
[435.413901] [032/133] (578s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[435.507032] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[436.408671] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.903s)
[436.586991] [033/133] (577s left) gem_lmem_swapping (heavy-multi)
[436.633394] Subtest heavy-multi: SKIP (0.000s)
[436.677719] [034/133] (577s left) gem_mmap_gtt (isolation)
[436.748771] Subtest isolation: SKIP (0.000s)
[436.814338] [035/133] (577s left) gem_exec_whisper (basic-contexts-forked)
[436.887523] Starting subtest: basic-contexts-forked
[461.794273] Subtest basic-contexts-forked: SUCCESS (24.897s)
[461.988959] [036/133] (552s left) gem_close (basic)
[462.056963] Starting subtest: basic
[462.059730] Subtest basic: SUCCESS (0.000s)
[462.166852] [037/133] (552s left) gen9_exec_parse (bb-start-far)
[462.228787] Subtest bb-start-far: SKIP (0.000s)
[462.292051] [038/133] (552s left) gem_exec_balancer (full-pulse)
[462.346559] Starting subtest: full-pulse
[467.231262] Subtest full-pulse: SUCCESS (4.883s)
[467.533388] [039/133] (547s left) kms_addfb_basic (basic-x-tiled-legacy)
[467.610753] Starting subtest: basic-x-tiled-legacy
[467.616488] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[467.744690] [040/133] (546s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[467.824433] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[467.829815] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[467.904332] [041/133] (546s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[467.996745] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[469.007968] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.013s)
[469.173416] [042/133] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[469.263395] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[469.268651] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[469.410243] [043/133] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[469.497773] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[476.895964] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.403s)
[477.042284] [044/133] (537s left) kms_chamelium_frames (dp-crc-multiple)
[477.425432] Subtest dp-crc-multiple: SKIP (0.000s)
[478.217301] [045/133] (536s left) kms_flip (nonexisting-fb-interruptible)
[478.305208] Starting subtest: nonexisting-fb-interruptible
[478.307625] Starting dynamic subtest: A-eDP1
[479.422582] Dynamic subtest A-eDP1: SUCCESS (1.118s)
[479.432124] Starting dynamic subtest: B-eDP1
[480.553740] Dynamic subtest B-eDP1: SUCCESS (1.131s)
[480.566496] Starting dynamic subtest: C-eDP1
[481.676039] Dynamic subtest C-eDP1: SUCCESS (1.121s)
[481.685555] Starting dynamic subtest: D-eDP1
[482.804315] Dynamic subtest D-eDP1: SUCCESS (1.126s)
[482.806940] Subtest nonexisting-fb-interruptible: SUCCESS (4.504s)
[483.981028] [046/133] (530s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[484.089598] Starting subtest: psr2-cursor-plane-move-continuous-sf
[484.092273] Starting dynamic subtest: pipe-A-eDP-1
[494.434587] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.353s)
[494.443935] Starting dynamic subtest: pipe-B-eDP-1
[505.550812] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.113s)
[505.554008] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.469s)
[506.440574] [047/133] (508s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[506.536244] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[513.850735] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.316s)
[514.019245] [048/133] (500s left) sysfs_timeslice_duration (invalid)
[514.082366] Starting subtest: invalid
[514.084881] Starting dynamic subtest: vecs0
[514.087666] Dynamic subtest vecs0: SUCCESS (0.000s)
[514.097878] Starting dynamic subtest: ccs0
[514.100182] Dynamic subtest ccs0: SUCCESS (0.000s)
[514.108610] Starting dynamic subtest: vcs0
[514.110951] Dynamic subtest vcs0: SUCCESS (0.000s)
[514.119340] Starting dynamic subtest: bcs0
[514.121710] Dynamic subtest bcs0: SUCCESS (0.000s)
[514.130742] Starting dynamic subtest: rcs0
[514.133533] Dynamic subtest rcs0: SUCCESS (0.000s)
[514.142440] Starting dynamic subtest: vcs1
[514.144938] Dynamic subtest vcs1: SUCCESS (0.000s)
[514.147533] Subtest invalid: SUCCESS (0.006s)
[514.196986] [049/133] (500s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[514.298113] Starting subtest: cursorA-vs-flipB-legacy
[514.302773] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[514.452987] [050/133] (500s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[514.827097] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[515.655243] [051/133] (499s left) gem_workarounds (reset-context)
[515.717450] Starting subtest: reset-context
[515.895966] Subtest reset-context: SUCCESS (0.178s)
[516.037295] [052/133] (499s left) kms_setmode (clone-exclusive-crtc)
[516.088898] Starting subtest: clone-exclusive-crtc
[516.096800] Subtest clone-exclusive-crtc: SKIP (0.000s)
[516.200674] [053/133] (498s left) gem_mmap_gtt (fault-concurrent)
[516.265110] Subtest fault-concurrent: SKIP (0.000s)
[516.325617] [054/133] (498s left) gem_ctx_persistence (hang)
[516.387738] Starting subtest: hang
[516.393781] Subtest hang: SKIP (0.000s)
[516.514367] [055/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[516.605976] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[516.610508] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[516.711439] [056/133] (498s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[516.791622] Starting subtest: x-tiled-32bpp-rotate-180
[518.316799] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.525s)
[518.468600] [057/133] (496s left) kms_atomic (atomic-plane-damage)
[518.536704] Starting subtest: atomic-plane-damage
[518.589850] Starting dynamic subtest: pipe-A-eDP-1
[519.164753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[519.167253] Subtest atomic-plane-damage: SUCCESS (0.629s)
[520.015443] [058/133] (495s left) gem_create (create-clear)
[520.072548] Starting subtest: create-clear
[520.075231] Starting dynamic subtest: smem0
[552.593997] Dynamic subtest smem0: SUCCESS (32.513s)
[552.596761] Subtest create-clear: SUCCESS (32.514s)
[552.793605] [059/133] (462s left) kms_vblank (wait-busy-hang)
[552.878849] Starting subtest: wait-busy-hang
[552.881502] Starting dynamic subtest: pipe-A-eDP-1
[579.185579] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.299s)
[579.201892] Starting dynamic subtest: pipe-D-eDP-1
[604.198833] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.008s)
[604.201841] Subtest wait-busy-hang: SUCCESS (51.311s)
[605.064862] [060/133] (410s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[605.138971] Starting subtest: flip-primary-invalidate-overlay
[616.862343] Subtest flip-primary-invalidate-overlay: SUCCESS (11.726s)
[617.047727] [061/133] (398s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[617.121840] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[617.126354] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[617.247545] [062/133] (398s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[617.342816] Starting subtest: cursorA-vs-flipB-atomic-transitions
[617.347595] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[617.511703] [063/133] (398s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[617.597897] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[617.600388] Starting dynamic subtest: pipe-A-eDP-1
[617.619782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[617.630602] Starting dynamic subtest: pipe-B-eDP-1
[617.649736] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[617.658930] Starting dynamic subtest: pipe-C-eDP-1
[617.678704] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[617.687952] Starting dynamic subtest: pipe-D-eDP-1
[617.709283] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[617.711302] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[619.847245] [064/133] (395s left) kms_cursor_crc (cursor-sliding-128x128)
[620.059208] Starting subtest: cursor-sliding-128x128
[620.061789] Starting dynamic subtest: pipe-A-eDP-1
[623.314507] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.250s)
[623.340943] Starting dynamic subtest: pipe-D-eDP-1
[627.263499] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.929s)
[627.265860] Subtest cursor-sliding-128x128: SUCCESS (7.203s)
[628.128456] [065/133] (387s left) i915_pm_rpm (debugfs-forcewake-user)
[629.650873] Starting subtest: debugfs-forcewake-user
[641.029676] Subtest debugfs-forcewake-user: SUCCESS (11.382s)
[641.424203] [066/133] (374s left) kms_psr (pr-cursor-mmap-cpu)
[641.511765] Starting subtest: pr-cursor-mmap-cpu
[641.516571] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[641.594423] [067/133] (374s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[641.673238] Starting subtest: plane-lut1d-ctm3x4
[641.686455] Starting dynamic subtest: pipe-A-eDP-1
[642.465700] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[643.084219] Starting dynamic subtest: pipe-B-eDP-1
[644.028962] Dynamic subtest pipe-B-eDP-1: FAIL (0.312s)
[644.410948] Starting dynamic subtest: pipe-C-eDP-1
[645.350756] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[645.736966] Starting dynamic subtest: pipe-D-eDP-1
[646.644932] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[646.647510] Subtest plane-lut1d-ctm3x4: FAIL (4.614s)
[647.131683] [068/133] (368s left) gem_exec_reloc (basic-write-wc)
[647.200260] Subtest basic-write-wc: SKIP (0.000s)
[647.279965] [069/133] (368s left) kms_getfb (getfb2-handle-protection)
[647.351125] Starting subtest: getfb2-handle-protection
[647.378963] Subtest getfb2-handle-protection: SUCCESS (0.028s)
[647.499985] [070/133] (368s left) kms_flip (modeset-vs-vblank-race-interruptible)
[647.578537] Starting subtest: modeset-vs-vblank-race-interruptible
[647.580744] Starting dynamic subtest: A-eDP1
[652.258789] Dynamic subtest A-eDP1: SUCCESS (4.681s)
[652.271737] Starting dynamic subtest: B-eDP1
[656.898916] Dynamic subtest B-eDP1: SUCCESS (4.639s)
[656.911972] Starting dynamic subtest: C-eDP1
[661.519389] Dynamic subtest C-eDP1: SUCCESS (4.618s)
[661.532864] Starting dynamic subtest: D-eDP1
[666.155941] Dynamic subtest D-eDP1: SUCCESS (4.635s)
[666.158566] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.582s)
[667.322416] [071/133] (348s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[667.462003] Starting subtest: protected-encrypted-src-copy-not-readible
[667.606232] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.146s)
[667.743555] [072/133] (348s left) kms_cursor_crc (cursor-offscreen-256x256)
[667.987933] Starting subtest: cursor-offscreen-256x256
[667.990942] Starting dynamic subtest: pipe-A-eDP-1
[669.954725] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s)
[669.982220] Starting dynamic subtest: pipe-D-eDP-1
[672.544739] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s)
[672.547268] Subtest cursor-offscreen-256x256: SUCCESS (4.557s)
[673.391686] [073/133] (342s left) gem_exec_reloc (basic-cpu-active)
[673.449244] Subtest basic-cpu-active: SKIP (0.000s)
[673.526232] [074/133] (342s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[673.581945] Subtest writes-after-reads: SKIP (0.000s)
[673.651553] [075/133] (342s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[673.706245] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[673.711658] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[673.904302] [076/133] (342s left) gem_exec_balancer (waits)
[673.976967] Starting subtest: waits
[680.442817] Subtest waits: SUCCESS (6.463s)
[680.752588] [077/133] (335s left) gem_partial_pwrite_pread (reads-uncached)
[680.810139] Subtest reads-uncached: SKIP (0.000s)
[680.895556] [078/133] (335s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[680.990090] Starting subtest: y-tiled-32bpp-rotate-270
[680.995617] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[681.117499] [079/133] (335s left) kms_busy (basic-hang)
[681.197615] Starting subtest: basic-hang
[681.200362] Starting dynamic subtest: flip-pipe-A
[681.836966] Dynamic subtest flip-pipe-A: SUCCESS (0.635s)
[681.848840] Starting dynamic subtest: modeset-pipe-A
[685.545478] Dynamic subtest modeset-pipe-A: SUCCESS (3.709s)
[685.555940] Starting dynamic subtest: flip-pipe-D
[686.745240] Dynamic subtest flip-pipe-D: SUCCESS (1.196s)
[686.755966] Starting dynamic subtest: modeset-pipe-D
[690.144593] Dynamic subtest modeset-pipe-D: SUCCESS (3.398s)
[690.147318] Subtest basic-hang: SUCCESS (8.946s)
[690.953677] [080/133] (325s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[691.065784] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[691.070727] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[691.183965] [081/133] (325s left) kms_pm_dc (dc6-dpms)
[692.259858] Starting subtest: dc6-dpms
[694.318252] Subtest dc6-dpms: SUCCESS (2.058s)
[694.409019] [082/133] (321s left) gem_exec_params (rsvd2-dirt)
[694.469759] Starting subtest: rsvd2-dirt
[694.475197] Subtest rsvd2-dirt: SKIP (0.000s)
[694.570635] [083/133] (321s left) kms_vblank (invalid)
[694.652801] Starting subtest: invalid
[694.655522] Starting dynamic subtest: pipe-A-eDP-1
[695.061134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[695.063578] Subtest invalid: SUCCESS (0.408s)
[695.923244] [084/133] (320s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[696.003902] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[718.565799] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.562s)
[718.739265] [085/133] (297s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[718.834845] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[718.840776] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[718.960301] [086/133] (297s left) perf (short-reads)
[719.096613] Starting subtest: short-reads
[719.110070] Subtest short-reads: SUCCESS (0.015s)
[719.161382] [087/133] (297s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[719.253642] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[719.262787] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[719.390333] [088/133] (297s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[719.482648] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[719.486732] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[719.612481] [089/133] (297s left) syncobj_timeline (multi-wait-submitted-signaled)
[719.669482] Starting subtest: multi-wait-submitted-signaled
[719.671741] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[719.792448] [090/133] (296s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[719.857731] Starting subtest: y-tiled-ccs-to-y-tiled
[719.862855] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[720.055451] [091/133] (296s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[720.137379] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[720.139875] Starting dynamic subtest: pipe-A-eDP-1
[721.018551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s)
[721.029660] Starting dynamic subtest: pipe-B-eDP-1
[722.628667] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.608s)
[722.640375] Starting dynamic subtest: pipe-C-eDP-1
[724.150508] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.518s)
[724.171809] Starting dynamic subtest: pipe-D-eDP-1
[725.687759] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s)
[725.690535] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.541s)
[726.854959] [092/133] (289s left) vgem_basic (sysfs)
[726.996957] Starting subtest: sysfs
[726.999869] Subtest sysfs: SUCCESS (0.001s)
[727.065744] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[727.069312] [093/133] (289s left) gem_mmap_gtt (cpuset-big-copy-odd)
[727.135749] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[727.209904] [094/133] (289s left) kms_psr (psr2-sprite-plane-move)
[727.295777] Starting subtest: psr2-sprite-plane-move
[727.298661] Starting dynamic subtest: eDP-1
[729.085195] Dynamic subtest eDP-1: SUCCESS (1.792s)
[729.087828] Subtest psr2-sprite-plane-move: SUCCESS (1.793s)
[729.925426] [095/133] (286s left) kms_psr (fbc-psr-primary-page-flip)
[730.009634] Starting subtest: fbc-psr-primary-page-flip
[730.012237] Starting dynamic subtest: eDP-1
[730.016958] Dynamic subtest eDP-1: SKIP (0.000s)
[730.021763] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[730.094299] [096/133] (286s left) gem_exec_schedule (promotion)
[730.181351] Starting subtest: promotion
[730.183722] Starting dynamic subtest: rcs0
[730.279447] Dynamic subtest rcs0: SUCCESS (0.107s)
[730.291422] Starting dynamic subtest: vcs0
[730.364544] Dynamic subtest vcs0: SUCCESS (0.085s)
[730.374975] Starting dynamic subtest: vcs1
[730.451804] Dynamic subtest vcs1: SUCCESS (0.086s)
[730.464823] Starting dynamic subtest: vecs0
[730.536208] Dynamic subtest vecs0: SUCCESS (0.084s)
[730.547441] Starting dynamic subtest: ccs0
[730.637963] Dynamic subtest ccs0: SUCCESS (0.101s)
[730.640899] Subtest promotion: SUCCESS (0.467s)
[731.492799] [097/133] (285s left) gem_exec_schedule (preempt-queue-contexts)
[731.572358] Subtest preempt-queue-contexts: SKIP (0.000s)
[731.869935] [098/133] (285s left) kms_cursor_legacy (forked-move)
[731.970871] Starting subtest: forked-move
[731.973372] Starting dynamic subtest: pipe-A
[737.420753] Dynamic subtest pipe-A: SUCCESS (5.448s)
[737.432821] Starting dynamic subtest: pipe-B
[742.894424] Dynamic subtest pipe-B: SUCCESS (5.471s)
[742.907268] Starting dynamic subtest: pipe-C
[748.373751] Dynamic subtest pipe-C: SUCCESS (5.476s)
[748.385476] Starting dynamic subtest: pipe-D
[753.851307] Dynamic subtest pipe-D: SUCCESS (5.475s)
[753.864034] Starting dynamic subtest: all-pipes
[759.350812] Dynamic subtest all-pipes: SUCCESS (5.497s)
[759.355887] Subtest forked-move: SUCCESS (27.376s)
[759.578620] [099/133] (257s left) gem_ctx_isolation (preservation)
[759.671336] Starting subtest: preservation
[759.674259] Starting dynamic subtest: rcs0
[759.825388] Dynamic subtest rcs0: SUCCESS (0.153s)
[759.838545] Starting dynamic subtest: bcs0
[760.011082] Dynamic subtest bcs0: SUCCESS (0.184s)
[760.024832] Starting dynamic subtest: vcs0
[760.200608] Dynamic subtest vcs0: SUCCESS (0.189s)
[760.211978] Starting dynamic subtest: vcs1
[761.504561] Dynamic subtest vcs1: SUCCESS (1.303s)
[761.517694] Starting dynamic subtest: vecs0
[763.512984] Dynamic subtest vecs0: SUCCESS (2.007s)
[763.530479] Starting dynamic subtest: ccs0
[765.572603] Dynamic subtest ccs0: SUCCESS (2.059s)
[765.576500] Subtest preservation: SUCCESS (5.900s)
[765.804571] [100/133] (251s left) kms_content_protection (dp-mst-type-1)
[765.953388] Starting subtest: dp-mst-type-1
[765.958894] Subtest dp-mst-type-1: SKIP (0.000s)
[766.120557] [101/133] (251s left) kms_flip (blocking-wf_vblank)
[766.208396] Starting subtest: blocking-wf_vblank
[766.210943] Starting dynamic subtest: A-eDP1
[775.172868] Dynamic subtest A-eDP1: SUCCESS (8.965s)
[775.201632] Starting dynamic subtest: B-eDP1
[784.106728] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[784.116999] Starting dynamic subtest: C-eDP1
[793.017734] Dynamic subtest C-eDP1: SUCCESS (8.905s)
[793.029337] Starting dynamic subtest: D-eDP1
[801.940572] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[801.945946] Subtest blocking-wf_vblank: SUCCESS (35.735s)
[803.206950] [102/133] (214s left) i915_getparams_basic (basic-subslice-total)
[803.276222] Starting subtest: basic-subslice-total
[803.281459] Subtest basic-subslice-total: SUCCESS (0.000s)
[803.387320] [103/133] (213s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[803.472848] Starting subtest: fbc-pr-cursor-mmap-gtt
[803.477853] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[803.607106] [104/133] (213s left) gem_mmap_wc (bad-size)
[803.672792] Subtest bad-size: SKIP (0.000s)
[803.758985] [105/133] (213s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[803.837965] Starting subtest: fbcpsr-tiling-y
[803.843376] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[803.958939] [106/133] (213s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[804.047290] Starting subtest: fbcpsr-indfb-scaledprimary
[809.809760] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.763s)
[809.983322] [107/133] (207s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[810.074246] Starting subtest: invalid-modeset-force-ultra-joiner
[810.079099] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[810.151672] [108/133] (207s left) prime_vgem (basic-fence-blt)
[810.236858] Starting subtest: basic-fence-blt
[810.334975] Subtest basic-fence-blt: SUCCESS (0.098s)
[810.470752] [109/133] (207s left) i915_drm_fdinfo (most-busy-check-all)
[810.512865] Starting subtest: most-busy-check-all
[810.515823] Starting dynamic subtest: rcs0
[810.521490] Dynamic subtest rcs0: SKIP (0.004s)
[810.533772] Starting dynamic subtest: bcs0
[810.538946] Dynamic subtest bcs0: SKIP (0.000s)
[810.549579] Starting dynamic subtest: vcs0
[810.554688] Dynamic subtest vcs0: SKIP (0.000s)
[810.564667] Starting dynamic subtest: vcs1
[810.569453] Dynamic subtest vcs1: SKIP (0.001s)
[810.578502] Starting dynamic subtest: vecs0
[810.583186] Dynamic subtest vecs0: SKIP (0.000s)
[810.592463] Starting dynamic subtest: ccs0
[810.596955] Dynamic subtest ccs0: SKIP (0.000s)
[810.601693] Subtest most-busy-check-all: SKIP (0.010s)
[810.638983] [110/133] (206s left) gem_exec_schedule (fairslice)
[810.736635] Starting subtest: fairslice
[810.739135] Starting dynamic subtest: rcs0
[812.747717] Dynamic subtest rcs0: SUCCESS (2.019s)
[812.759226] Starting dynamic subtest: bcs0
[814.773771] Dynamic subtest bcs0: SUCCESS (2.023s)
[814.784558] Starting dynamic subtest: vcs0
[816.790157] Dynamic subtest vcs0: SUCCESS (2.018s)
[816.801965] Starting dynamic subtest: vcs1
[818.814366] Dynamic subtest vcs1: SUCCESS (2.018s)
[818.825816] Starting dynamic subtest: vecs0
[820.836610] Dynamic subtest vecs0: SUCCESS (2.023s)
[820.848463] Starting dynamic subtest: ccs0
[822.863865] Dynamic subtest ccs0: SUCCESS (2.027s)
[822.866831] Subtest fairslice: SUCCESS (12.134s)
[823.170397] [111/133] (194s left) perf_pmu (event-wait)
[823.223166] Starting subtest: event-wait
[823.225666] Starting dynamic subtest: rcs0
[823.230589] Dynamic subtest rcs0: SKIP (0.000s)
[823.235257] Subtest event-wait: SKIP (0.001s)
[823.367734] [112/133] (194s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[823.457826] Starting subtest: pixel-format-y-tiled-ccs-modifier
[823.473453] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[823.548435] [113/133] (194s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[823.642856] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[823.647768] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[823.752713] [114/133] (193s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[823.846433] Starting subtest: primary-y-tiled-reflect-x-0
[823.906843] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[824.022049] [115/133] (193s left) kms_properties (invalid-properties-atomic)
[824.112814] Starting subtest: invalid-properties-atomic
[824.382902] Subtest invalid-properties-atomic: SUCCESS (0.269s)
[824.467245] [116/133] (193s left) gem_ctx_create (basic)
[824.535035] Starting subtest: basic
[824.537781] Subtest basic: SUCCESS (0.000s)
[824.728484] [117/133] (193s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[824.816768] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[824.821096] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[824.942292] [118/133] (192s left) kms_flip (2x-busy-flip)
[825.017370] Starting subtest: 2x-busy-flip
[825.025516] Subtest 2x-busy-flip: SKIP (0.007s)
[825.161781] [119/133] (192s left) perf (invalid-oa-exponent)
[825.260500] Starting subtest: invalid-oa-exponent
[825.274725] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[825.313738] [120/133] (192s left) kms_vrr (max-min)
[825.389902] Starting subtest: max-min
[825.398762] Subtest max-min: SKIP (0.000s)
[825.474403] [121/133] (192s left) kms_lease (implicit-plane-lease)
[825.558849] Starting subtest: implicit-plane-lease
[825.561716] Subtest implicit-plane-lease: SUCCESS (0.003s)
[825.693995] [122/133] (192s left) kms_pm_rpm (i2c)
[827.498367] Starting subtest: i2c
[832.806824] Subtest i2c: SUCCESS (5.306s)
[832.904842] [123/133] (185s left) core_getversion (all-cards)
[832.959850] Starting subtest: all-cards
[832.973886] Subtest all-cards: SUCCESS (0.018s)
[833.018855] [124/133] (185s left) kms_flip (nonblocking-read)
[833.101266] Starting subtest: nonblocking-read
[833.103411] Subtest nonblocking-read: SUCCESS (0.000s)
[833.236305] [125/133] (184s left) kms_psr (fbc-pr-primary-render)
[833.316080] Starting subtest: fbc-pr-primary-render
[833.320961] Subtest fbc-pr-primary-render: SKIP (0.000s)
[833.452160] [126/133] (184s left) gem_mmap_wc (coherency)
[833.529866] Subtest coherency: SKIP (0.000s)
[833.604089] [127/133] (184s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[833.687704] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[833.692591] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[834.802444] [128/133] (183s left) gem_exec_fence (basic-wait-all)
[834.868584] Starting subtest: basic-wait-all
[834.991978] Subtest basic-wait-all: SUCCESS (0.125s)
[836.483057] [129/133] (181s left) api_intel_bb (full-batch)
[836.542960] Starting subtest: full-batch
[836.548345] Subtest full-batch: SUCCESS (0.006s)
[836.663391] [130/133] (181s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[836.752715] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[836.757940] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[836.894955] [131/133] (181s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[836.981588] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[836.983811] Starting dynamic subtest: pipe-A-eDP-1
[839.081338] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s)
[839.091526] Starting dynamic subtest: pipe-B-eDP-1
[841.261945] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.179s)
[841.272181] Starting dynamic subtest: pipe-C-eDP-1
[843.356672] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.092s)
[843.367167] Starting dynamic subtest: pipe-D-eDP-1
[845.402694] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.043s)
[845.405530] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.420s)
[846.649135] [132/133] (171s left) gem_exec_fence (syncobj-signal)
[847.080303] Starting subtest: syncobj-signal
[847.086742] Subtest syncobj-signal: SUCCESS (0.006s)
[848.457086] [133/133] (170s left) syncobj_wait (wait-for-submit-delayed-submit)
[848.518526] Starting subtest: wait-for-submit-delayed-submit
[848.618973] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[848.724997] 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.