[59.620066] Initializing watchdogs
[59.620111]   /dev/watchdog0
[59.634242] [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]
[59.638480] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.640786] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.644966] [001/133] (960s left) vgem_basic (dmabuf-fence)
[59.740989] Starting subtest: dmabuf-fence
[59.743168] Subtest dmabuf-fence: SUCCESS (0.001s)
[59.792257] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[59.795432] [002/133] (960s left) kms_busy (extended-modeset-hang-newfb)
[59.893793] Starting subtest: extended-modeset-hang-newfb
[59.896144] Starting dynamic subtest: pipe-A
[94.803078] Dynamic subtest pipe-A: SUCCESS (34.919s)
[94.811913] Starting dynamic subtest: pipe-D
[117.795828] Dynamic subtest pipe-D: SUCCESS (22.991s)
[117.798306] Subtest extended-modeset-hang-newfb: SUCCESS (57.914s)
[118.602882] [003/133] (901s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[118.704526] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[125.530037] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.828s)
[125.632533] [004/133] (894s left) gem_ctx_persistence (engines-queued)
[125.687107] Starting subtest: engines-queued
[125.689292] Starting dynamic subtest: rcs0
[125.772709] Dynamic subtest rcs0: SUCCESS (0.085s)
[125.782080] Starting dynamic subtest: bcs0
[125.824320] Dynamic subtest bcs0: SUCCESS (0.051s)
[125.835193] Starting dynamic subtest: vcs0
[126.901800] Dynamic subtest vcs0: SUCCESS (1.075s)
[126.910681] Starting dynamic subtest: vcs1
[128.882676] Dynamic subtest vcs1: SUCCESS (1.980s)
[128.890785] Starting dynamic subtest: vecs0
[130.868370] Dynamic subtest vecs0: SUCCESS (1.984s)
[130.877596] Starting dynamic subtest: ccs0
[131.048308] Dynamic subtest ccs0: SUCCESS (0.181s)
[131.050929] Subtest engines-queued: SUCCESS (5.361s)
[131.165758] [005/133] (889s left) kms_prop_blob (invalid-set-prop)
[131.226781] Starting subtest: invalid-set-prop
[131.228655] Subtest invalid-set-prop: SUCCESS (0.000s)
[131.336170] [006/133] (889s left) gem_media_fill (media-fill)
[131.394181] Subtest media-fill: SKIP (0.000s)
[131.504169] [007/133] (888s left) gen9_exec_parse (secure-batches)
[131.559038] Subtest secure-batches: SKIP (0.000s)
[131.634843] [008/133] (888s left) gem_ccs (block-copy-compressed)
[131.687815] Starting subtest: block-copy-compressed
[131.692595] Subtest block-copy-compressed: SKIP (0.000s)
[131.787847] [009/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[131.890949] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[132.679690] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[132.838632] [010/133] (887s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[132.944603] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[132.948862] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[133.048840] [011/133] (887s left) kms_plane_scaling (planes-upscale-20x20)
[133.141824] Starting subtest: planes-upscale-20x20
[133.144612] Starting dynamic subtest: pipe-A
[133.201382] Dynamic subtest pipe-A: SUCCESS (0.062s)
[133.211060] Starting dynamic subtest: pipe-B
[134.327669] Dynamic subtest pipe-B: SUCCESS (1.126s)
[134.337640] Starting dynamic subtest: pipe-C
[135.433267] Dynamic subtest pipe-C: SUCCESS (1.105s)
[135.441129] Starting dynamic subtest: pipe-D
[136.561846] Dynamic subtest pipe-D: SUCCESS (1.129s)
[136.564218] Subtest planes-upscale-20x20: SUCCESS (3.423s)
[137.733086] [012/133] (882s left) gem_exec_balancer (full-pulse)
[137.794077] Starting subtest: full-pulse
[142.800817] Subtest full-pulse: SUCCESS (5.007s)
[143.098539] [013/133] (877s left) gem_exec_suspend (basic-s3-devices)
[143.160993] Starting subtest: basic-S3-devices
[143.163082] Starting dynamic subtest: smem
[154.904952] Dynamic subtest smem: SUCCESS (11.742s)
[154.907891] Subtest basic-S3-devices: SUCCESS (11.744s)
[155.096154] [014/133] (865s left) gem_ppgtt (shrink-vs-evict-pinned)
[155.168605] Starting subtest: shrink-vs-evict-pinned
[160.877931] Subtest shrink-vs-evict-pinned: SUCCESS (5.708s)
[160.985599] [015/133] (859s left) gem_mmap (big-bo)
[161.040790] Subtest big-bo: SKIP (0.000s)
[161.108874] [016/133] (859s left) kms_draw_crc (draw-method-render)
[161.211700] Starting subtest: draw-method-render
[161.213952] Starting dynamic subtest: xrgb8888-untiled
[161.442398] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[161.453388] Starting dynamic subtest: rgb565-untiled
[161.653224] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[161.663134] Starting dynamic subtest: xrgb2101010-untiled
[161.897176] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.244s)
[161.908973] Starting dynamic subtest: xbgr16161616f-untiled
[162.108530] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[162.117374] Starting dynamic subtest: xrgb8888-xtiled
[162.219507] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[162.230414] Starting dynamic subtest: rgb565-xtiled
[162.330815] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[162.338936] Starting dynamic subtest: xrgb2101010-xtiled
[162.454072] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[162.462232] Starting dynamic subtest: xbgr16161616f-xtiled
[162.586389] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[162.596048] Starting dynamic subtest: xrgb8888-4tiled
[162.708687] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[162.717887] Starting dynamic subtest: rgb565-4tiled
[162.819623] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[162.829201] Starting dynamic subtest: xrgb2101010-4tiled
[162.930518] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[162.940509] Starting dynamic subtest: xbgr16161616f-4tiled
[163.053085] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[163.055050] Subtest draw-method-render: SUCCESS (1.845s)
[163.159482] [017/133] (857s left) gem_create (busy-create)
[163.208996] Starting subtest: busy-create
[163.211232] Starting dynamic subtest: smem0
[196.888322] Dynamic subtest smem0: SUCCESS (33.676s)
[196.891072] Subtest busy-create: SUCCESS (33.677s)
[197.089303] [018/133] (823s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[197.209350] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[197.214084] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[197.367225] [019/133] (823s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[197.469429] Starting subtest: async-flip-with-page-flip-events-tiled
[197.848853] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[200.581476] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.730s)
[200.593764] Starting dynamic subtest: pipe-A-eDP-1-4
[202.756650] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.175s)
[202.768030] Starting dynamic subtest: pipe-A-eDP-1-4
[204.766397] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[204.778263] Starting dynamic subtest: pipe-A-eDP-1-x
[206.964948] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[207.324786] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[210.101253] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[210.113115] Starting dynamic subtest: pipe-B-eDP-1-4
[212.287280] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[212.298974] Starting dynamic subtest: pipe-B-eDP-1-4
[214.297677] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[214.309647] Starting dynamic subtest: pipe-B-eDP-1-x
[216.475850] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[216.837789] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[219.620974] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[219.631093] Starting dynamic subtest: pipe-C-eDP-1-4
[221.796885] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[221.808627] Starting dynamic subtest: pipe-C-eDP-1-4
[223.806857] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[223.816022] Starting dynamic subtest: pipe-C-eDP-1-x
[225.985668] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[226.351104] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[229.151488] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[229.163436] Starting dynamic subtest: pipe-D-eDP-1-4
[231.314024] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[231.324601] Starting dynamic subtest: pipe-D-eDP-1-4
[233.325614] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[233.335266] Starting dynamic subtest: pipe-D-eDP-1-x
[235.503567] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[235.506226] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.034s)
[236.747814] [020/133] (784s left) gem_pipe_control_store_loop (reused-buffer)
[236.817701] Starting subtest: reused-buffer
[238.969664] Subtest reused-buffer: SUCCESS (2.151s)
[239.096404] [021/133] (781s left) syncobj_timeline (multi-wait-for-submit-signaled)
[239.149243] Starting subtest: multi-wait-for-submit-signaled
[239.151701] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[239.262881] [022/133] (781s left) gem_exec_reloc (basic-wc-active)
[239.339297] Subtest basic-wc-active: SKIP (0.000s)
[239.410770] [023/133] (781s left) gem_mmap_gtt (zero-extend)
[239.462255] Subtest zero-extend: SKIP (0.000s)
[239.523883] [024/133] (781s left) gem_ctx_persistence (legacy-engines-mixed)
[239.587942] Starting subtest: legacy-engines-mixed
[239.590120] Starting dynamic subtest: render
[239.681618] Dynamic subtest render: SUCCESS (0.093s)
[239.692738] Starting dynamic subtest: bsd1
[239.756654] Dynamic subtest bsd1: SUCCESS (0.073s)
[239.766299] Starting dynamic subtest: bsd2
[239.817048] Dynamic subtest bsd2: SUCCESS (0.058s)
[239.828565] Starting dynamic subtest: blt
[239.853828] Dynamic subtest blt: SUCCESS (0.035s)
[239.862663] Starting dynamic subtest: vebox
[239.930737] Dynamic subtest vebox: SUCCESS (0.076s)
[239.933511] Subtest legacy-engines-mixed: SUCCESS (0.343s)
[240.013383] [025/133] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[240.119809] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[240.123312] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[240.220744] [026/133] (780s left) i915_pm_rpm (debugfs-forcewake-user)
[242.146440] Starting subtest: debugfs-forcewake-user
[253.535054] Subtest debugfs-forcewake-user: SUCCESS (11.389s)
[253.905186] [027/133] (767s left) syncobj_timeline (wait-any-interrupted)
[253.963795] Starting subtest: wait-any-interrupted
[254.066577] Subtest wait-any-interrupted: SUCCESS (0.102s)
[254.140883] [028/133] (767s left) kms_atomic (crtc-invalid-params-fence)
[254.243888] Starting subtest: crtc-invalid-params-fence
[254.246411] Starting dynamic subtest: pipe-A-eDP-1
[254.651983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[254.654104] Subtest crtc-invalid-params-fence: SUCCESS (0.407s)
[255.517796] [029/133] (765s left) core_sysfs (read-all-entries)
[255.571145] Starting subtest: read-all-entries
[255.573620] Subtest read-all-entries: SUCCESS (0.003s)
[255.683854] [030/133] (765s left) kms_plane (plane-panning-bottom-right-suspend)
[255.767730] Starting subtest: plane-panning-bottom-right-suspend
[255.770030] Starting dynamic subtest: pipe-A
[273.472698] Dynamic subtest pipe-A: SUCCESS (2.884s)
[273.482216] Starting dynamic subtest: pipe-B
[292.442219] Dynamic subtest pipe-B: SUCCESS (3.589s)
[292.444544] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.478s)
[293.230849] [031/133] (728s left) kms_flip (2x-flip-vs-fences)
[293.336816] Starting subtest: 2x-flip-vs-fences
[293.341199] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[293.450571] [032/133] (727s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[293.545680] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[293.548023] Starting dynamic subtest: pipe-A-eDP-1
[293.570855] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[293.581794] Starting dynamic subtest: pipe-B-eDP-1
[293.601675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.609999] Starting dynamic subtest: pipe-C-eDP-1
[293.630513] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.638912] Starting dynamic subtest: pipe-D-eDP-1
[293.659343] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.663507] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[295.706357] [033/133] (725s left) prime_busy (after)
[295.764750] Starting subtest: after
[295.769538] Starting dynamic subtest: rcs0
[295.797892] Dynamic subtest rcs0: SUCCESS (0.030s)
[295.808403] Starting dynamic subtest: bcs0
[295.844712] Dynamic subtest bcs0: SUCCESS (0.046s)
[295.854531] Starting dynamic subtest: vcs0
[295.885076] Dynamic subtest vcs0: SUCCESS (0.040s)
[295.894429] Starting dynamic subtest: vcs1
[295.925648] Dynamic subtest vcs1: SUCCESS (0.040s)
[295.934927] Starting dynamic subtest: vecs0
[295.965227] Dynamic subtest vecs0: SUCCESS (0.039s)
[295.974338] Starting dynamic subtest: ccs0
[296.006935] Dynamic subtest ccs0: SUCCESS (0.041s)
[296.115797] Subtest after: SUCCESS (0.351s)
[296.190561] [034/133] (725s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[296.286506] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[296.290579] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[296.358067] [035/133] (725s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[296.657198] Starting subtest: cursor-rapid-movement-max-size
[296.663329] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[296.797840] [036/133] (724s left) gem_eio (wait-immediate)
[297.026822] Starting subtest: wait-immediate
[297.396346] Subtest wait-immediate: SUCCESS (0.372s)
[297.523275] [037/133] (724s left) kms_chamelium_color (ctm-0-75)
[297.623973] Subtest ctm-0-75: SKIP (0.000s)
[297.671458] [038/133] (723s left) kms_big_fb (linear-16bpp-rotate-0)
[297.762707] Starting subtest: linear-16bpp-rotate-0
[299.082029] Subtest linear-16bpp-rotate-0: SUCCESS (1.322s)
[299.204558] [039/133] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[299.293635] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[306.274160] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.995s)
[306.411006] [040/133] (715s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[306.513889] Starting subtest: 4-tiled-8bpp-rotate-90
[306.538717] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[306.650784] [041/133] (715s left) gem_exec_fence (syncobj-timeline-signal)
[307.241426] Starting subtest: syncobj-timeline-signal
[307.247376] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[308.209434] [042/133] (713s left) kms_flip (nonexisting-fb)
[308.308398] Starting subtest: nonexisting-fb
[308.310773] Starting dynamic subtest: A-eDP1
[309.471520] Dynamic subtest A-eDP1: SUCCESS (1.166s)
[309.482277] Starting dynamic subtest: B-eDP1
[310.610045] Dynamic subtest B-eDP1: SUCCESS (1.137s)
[310.621214] Starting dynamic subtest: C-eDP1
[311.747124] Dynamic subtest C-eDP1: SUCCESS (1.136s)
[311.758303] Starting dynamic subtest: D-eDP1
[312.874798] Dynamic subtest D-eDP1: SUCCESS (1.126s)
[312.877380] Subtest nonexisting-fb: SUCCESS (4.576s)
[314.061367] [043/133] (707s left) kms_cursor_crc (cursor-offscreen-64x21)
[314.258508] Starting subtest: cursor-offscreen-64x21
[314.302958] Subtest cursor-offscreen-64x21: SKIP (0.039s)
[314.542801] [044/133] (707s left) kms_invalid_mode (bad-hsync-end)
[314.626508] Starting subtest: bad-hsync-end
[314.628765] Starting dynamic subtest: pipe-A-eDP-1
[314.922429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[314.936321] Starting dynamic subtest: pipe-B-eDP-1
[314.938338] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[314.949031] Starting dynamic subtest: pipe-C-eDP-1
[314.951237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[314.960493] Starting dynamic subtest: pipe-D-eDP-1
[314.962901] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[314.965196] Subtest bad-hsync-end: SUCCESS (0.305s)
[315.794348] [045/133] (706s left) gem_userptr_blits (unsync-overlap)
[315.861171] Subtest unsync-overlap: SKIP (0.000s)
[316.001839] [046/133] (705s left) perf_pmu (most-busy-idle-check-all)
[316.039292] Starting subtest: most-busy-idle-check-all
[316.041484] Starting dynamic subtest: rcs0
[318.114399] Dynamic subtest rcs0: SUCCESS (2.075s)
[318.126834] Starting dynamic subtest: bcs0
[320.097250] Dynamic subtest bcs0: SUCCESS (1.981s)
[320.109852] Starting dynamic subtest: vcs0
[322.144476] Dynamic subtest vcs0: SUCCESS (2.046s)
[322.156823] Starting dynamic subtest: vcs1
[324.129439] Dynamic subtest vcs1: SUCCESS (1.981s)
[324.142359] Starting dynamic subtest: vecs0
[326.113135] Dynamic subtest vecs0: SUCCESS (1.980s)
[326.125561] Starting dynamic subtest: ccs0
[328.096999] Dynamic subtest ccs0: SUCCESS (1.980s)
[328.099699] Subtest most-busy-idle-check-all: SUCCESS (12.059s)
[328.214421] [047/133] (693s left) api_intel_bb (object-reloc-purge-cache)
[328.273696] Starting subtest: object-reloc-purge-cache
[328.279248] Subtest object-reloc-purge-cache: SKIP (0.004s)
[328.371221] [048/133] (693s left) gem_exec_schedule (implicit-write-read)
[328.452957] Starting subtest: implicit-write-read
[328.454961] Starting dynamic subtest: rcs0
[328.610287] Dynamic subtest rcs0: SUCCESS (0.165s)
[328.622536] Starting dynamic subtest: vcs0
[328.720645] Dynamic subtest vcs0: SUCCESS (0.108s)
[328.733492] Starting dynamic subtest: vcs1
[328.831957] Dynamic subtest vcs1: SUCCESS (0.110s)
[328.844825] Starting dynamic subtest: vecs0
[328.981654] Dynamic subtest vecs0: SUCCESS (0.149s)
[328.994449] Starting dynamic subtest: ccs0
[329.120058] Dynamic subtest ccs0: SUCCESS (0.137s)
[329.122218] Subtest implicit-write-read: SUCCESS (0.675s)
[330.174742] [049/133] (691s left) kms_psr (pr-sprite-render)
[330.285641] Starting subtest: pr-sprite-render
[330.290001] Subtest pr-sprite-render: SKIP (0.000s)
[330.372683] [050/133] (691s left) gem_tiled_partial_pwrite_pread (writes)
[330.431085] Subtest writes: SKIP (0.000s)
[330.505894] [051/133] (691s left) gem_lmem_swapping (massive)
[330.548272] Subtest massive: SKIP (0.000s)
[330.594151] [052/133] (691s left) kms_psr (psr-cursor-plane-move)
[330.678300] Starting subtest: psr-cursor-plane-move
[330.680480] Starting dynamic subtest: eDP-1
[332.397456] Dynamic subtest eDP-1: SUCCESS (1.716s)
[332.399448] Subtest psr-cursor-plane-move: SUCCESS (1.717s)
[333.273427] [053/133] (689s left) kms_psr (fbc-psr2-cursor-render)
[333.364731] Starting subtest: fbc-psr2-cursor-render
[333.367032] Starting dynamic subtest: eDP-1
[333.371287] Dynamic subtest eDP-1: SKIP (0.000s)
[333.375548] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[333.440334] [054/133] (688s left) kms_addfb_basic (too-wide)
[333.522587] Starting subtest: too-wide
[333.524887] Subtest too-wide: SUCCESS (0.000s)
[333.625679] [055/133] (688s left) syncobj_wait (multi-wait-for-submit-submitted)
[333.677055] Starting subtest: multi-wait-for-submit-submitted
[333.780728] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[333.856511] [056/133] (688s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[333.955793] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[333.957724] Starting dynamic subtest: pipe-A-eDP-1
[333.978239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[333.989094] Starting dynamic subtest: pipe-B-eDP-1
[334.009334] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[334.018567] Starting dynamic subtest: pipe-C-eDP-1
[334.038377] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[334.047466] Starting dynamic subtest: pipe-D-eDP-1
[334.067889] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[334.069848] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[336.258859] [057/133] (686s left) kms_vblank (ts-continuation-modeset-hang)
[336.359672] Starting subtest: ts-continuation-modeset-hang
[336.361879] Starting dynamic subtest: pipe-A-eDP-1
[362.901041] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.547s)
[362.916388] Starting dynamic subtest: pipe-D-eDP-1
[377.895752] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.996s)
[377.897926] Subtest ts-continuation-modeset-hang: SUCCESS (41.547s)
[378.755556] [058/133] (643s left) gem_userptr_blits (input-checking)
[378.820580] Starting subtest: input-checking
[378.822940] Subtest input-checking: SUCCESS (0.000s)
[378.944827] [059/133] (643s left) gem_mmap_gtt (fault-concurrent)
[378.998868] Subtest fault-concurrent: SKIP (0.000s)
[379.057000] [060/133] (643s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[379.110872] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[379.188903] [061/133] (643s left) gem_spin_batch (resubmit-new-all)
[379.251273] Starting subtest: resubmit-new-all
[379.253999] Starting dynamic subtest: rcs0
[379.268109] Dynamic subtest rcs0: SUCCESS (0.016s)
[379.281065] Starting dynamic subtest: bcs0
[379.283535] Dynamic subtest bcs0: SUCCESS (0.013s)
[379.293855] Starting dynamic subtest: vcs0
[379.295965] Dynamic subtest vcs0: SUCCESS (0.009s)
[379.305500] Starting dynamic subtest: vcs1
[379.307856] Dynamic subtest vcs1: SUCCESS (0.010s)
[379.317269] Starting dynamic subtest: vecs0
[379.319236] Dynamic subtest vecs0: SUCCESS (0.010s)
[379.328822] Starting dynamic subtest: ccs0
[379.331074] Dynamic subtest ccs0: SUCCESS (0.011s)
[379.333377] Subtest resubmit-new-all: SUCCESS (0.073s)
[381.131429] [062/133] (641s left) vgem_basic (sysfs)
[381.171680] Starting subtest: sysfs
[381.174106] Subtest sysfs: SUCCESS (0.000s)
[381.229240] [063/133] (641s left) kms_psr (fbc-pr-dpms)
[381.320491] Starting subtest: fbc-pr-dpms
[381.325091] Subtest fbc-pr-dpms: SKIP (0.000s)
[381.395675] [064/133] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[381.490752] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[381.494948] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[381.591297] [065/133] (641s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[381.710157] Starting subtest: cursor-vs-flip-varying-size
[412.536451] Subtest cursor-vs-flip-varying-size: SUCCESS (30.817s)
[413.391963] [066/133] (609s left) syncobj_timeline (invalid-transfer-illegal-handle)
[413.468415] Starting subtest: invalid-transfer-illegal-handle
[413.470782] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[413.579658] [067/133] (609s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[413.672216] Starting subtest: bad-aux-stride-yf-tiled-ccs
[413.674355] Starting dynamic subtest: pipe-A-eDP-1
[413.696210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.707851] Starting dynamic subtest: pipe-B-eDP-1
[413.728697] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.737404] Starting dynamic subtest: pipe-C-eDP-1
[413.758665] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.767654] Starting dynamic subtest: pipe-D-eDP-1
[413.789359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.793379] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[415.956698] [068/133] (606s left) gem_mmap_wc (write-read-distinct)
[416.020567] Subtest write-read-distinct: SKIP (0.000s)
[416.092617] [069/133] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[416.188812] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[416.192729] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[416.285391] [070/133] (606s left) gem_exec_flush (basic-wb-ro-before-default)
[416.351665] Starting subtest: basic-wb-ro-before-default
[421.809855] Subtest basic-wb-ro-before-default: SUCCESS (5.459s)
[422.013932] [071/133] (601s left) gem_exec_params (rsvd2-dirt)
[422.066117] Starting subtest: rsvd2-dirt
[422.070685] Subtest rsvd2-dirt: SKIP (0.000s)
[422.163710] [072/133] (600s left) kms_flip (2x-nonexisting-fb)
[422.262719] Starting subtest: 2x-nonexisting-fb
[422.271281] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[422.347992] [073/133] (600s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[422.499672] Starting subtest: dp-mst-lic-type-0-hdcp14
[422.504007] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[422.639838] [074/133] (600s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[422.745140] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[422.749132] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[422.850969] [075/133] (600s left) kms_pm_rpm (modeset-non-lpsp-stress)
[424.371470] Starting subtest: modeset-non-lpsp-stress
[425.528837] Subtest modeset-non-lpsp-stress: SKIP (1.152s)
[425.905955] [076/133] (597s left) kms_flip (2x-flip-vs-rmfb)
[425.989979] Starting subtest: 2x-flip-vs-rmfb
[425.998151] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[426.098673] [077/133] (597s left) kms_plane_multiple (tiling-y)
[426.195795] Starting subtest: tiling-y
[426.199911] Subtest tiling-y: SKIP (0.000s)
[426.266655] [078/133] (597s left) syncobj_timeline (host-signal-ordered)
[426.326806] Starting subtest: host-signal-ordered
[426.329123] Subtest host-signal-ordered: SUCCESS (0.000s)
[426.421750] [079/133] (596s left) kms_pm_backlight (fade)
[426.507896] Starting subtest: fade
[426.558185] Starting dynamic subtest: eDP-1
[429.040388] Dynamic subtest eDP-1: SUCCESS (2.483s)
[429.042753] Subtest fade: SUCCESS (2.534s)
[429.913890] [080/133] (593s left) gem_exec_reloc (basic-gtt-active)
[429.988574] Subtest basic-gtt-active: SKIP (0.000s)
[430.057801] [081/133] (593s left) gem_workarounds (suspend-resume)
[430.114504] Starting subtest: suspend-resume
[446.017840] Subtest suspend-resume: SUCCESS (1.146s)
[446.121716] [082/133] (577s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[446.216089] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[446.242689] Starting dynamic subtest: pipe-A-plane-0
[446.519688] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s)
[446.532227] Starting dynamic subtest: pipe-A-plane-3
[446.751819] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[446.762606] Starting dynamic subtest: pipe-A-plane-5
[446.766754] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[447.860520] Starting dynamic subtest: pipe-B-plane-0
[448.140076] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[448.149368] Starting dynamic subtest: pipe-B-plane-3
[448.383958] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[448.393655] Starting dynamic subtest: pipe-B-plane-5
[448.398068] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[448.693407] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.490s)
[449.519950] [083/133] (574s left) kms_chamelium_frames (hdmi-crc-multiple)
[449.919025] Subtest hdmi-crc-multiple: SKIP (0.000s)
[450.720814] [084/133] (572s left) i915_pm_rps (thresholds-park)
[450.784755] Starting subtest: thresholds-park
[450.789459] Subtest thresholds-park: SKIP (0.001s)
[450.899269] [085/133] (572s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[450.950445] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[450.954708] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[451.134586] [086/133] (572s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[451.221666] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[451.225746] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[451.302168] [087/133] (572s left) kms_getfb (getfb2-handle-zero)
[451.403605] Starting subtest: getfb2-handle-zero
[451.405801] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[451.510693] [088/133] (572s left) gem_pxp (hw-rejects-pxp-context)
[451.636046] Starting subtest: hw-rejects-pxp-context
[451.640788] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[451.740539] [089/133] (572s left) gem_exec_fence (syncobj-timeline-export)
[452.296765] Starting subtest: syncobj-timeline-export
[452.302472] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[453.960408] [090/133] (569s left) gem_exec_balancer (waits)
[454.029966] Starting subtest: waits
[460.502776] Subtest waits: SUCCESS (6.486s)
[460.810936] [091/133] (563s left) kms_psr (fbc-psr-cursor-blt)
[460.908287] Starting subtest: fbc-psr-cursor-blt
[460.910640] Starting dynamic subtest: eDP-1
[460.915001] Dynamic subtest eDP-1: SKIP (0.000s)
[460.919437] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[460.984116] [092/133] (562s left) kms_feature_discovery (psr2)
[461.074698] Starting subtest: psr2
[461.076529] Subtest psr2: SUCCESS (0.000s)
[461.162909] [093/133] (562s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[461.227474] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[461.330922] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[461.406458] [094/133] (562s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[461.504658] Starting subtest: y-tiled-32bpp-rotate-90
[461.509140] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[461.590847] [095/133] (562s left) gem_ctx_shared (disjoint-timelines)
[461.660112] Starting subtest: disjoint-timelines
[461.679184] Subtest disjoint-timelines: SUCCESS (0.019s)
[461.922102] [096/133] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[462.010669] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[462.015046] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[462.105444] [097/133] (562s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[462.197500] Starting subtest: yf-tiled-64bpp-rotate-90
[462.201985] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[462.306123] [098/133] (561s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[462.395079] Starting subtest: psr-rgb565-draw-pwrite
[469.452883] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.070s)
[469.566540] [099/133] (554s left) gem_userptr_blits (process-exit)
[469.642107] Starting subtest: process-exit
[469.648293] Subtest process-exit: SUCCESS (0.008s)
[469.783715] [100/133] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[469.879224] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[469.883540] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[469.975519] [101/133] (554s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[470.087920] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[470.092291] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[470.194000] [102/133] (554s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[470.307126] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[470.319782] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[470.403157] [103/133] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[470.495435] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[470.498609] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[470.602831] [104/133] (553s left) i915_drm_fdinfo (busy-hang)
[470.644518] Starting subtest: busy-hang
[470.646425] Starting dynamic subtest: rcs0
[470.664397] Dynamic subtest rcs0: SKIP (0.019s)
[470.675188] Starting dynamic subtest: bcs0
[470.678537] Dynamic subtest bcs0: SKIP (0.001s)
[470.687426] Starting dynamic subtest: vcs0
[470.690811] Dynamic subtest vcs0: SKIP (0.000s)
[470.699502] Starting dynamic subtest: vcs1
[470.702686] Dynamic subtest vcs1: SKIP (0.000s)
[470.711038] Starting dynamic subtest: vecs0
[470.714237] Dynamic subtest vecs0: SKIP (0.000s)
[470.722823] Starting dynamic subtest: ccs0
[470.726059] Dynamic subtest ccs0: SKIP (0.000s)
[470.729290] Subtest busy-hang: SKIP (0.024s)
[470.765128] [105/133] (553s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[470.854615] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[470.856376] Starting dynamic subtest: pipe-A-eDP-1
[470.952553] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[470.967580] Starting dynamic subtest: pipe-B-eDP-1
[472.096119] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s)
[472.100593] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.242s)
[473.289475] [106/133] (551s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[473.393037] Starting subtest: crc-primary-basic-yf-tiled-ccs
[473.395276] Starting dynamic subtest: pipe-A-eDP-1
[473.418859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[473.431178] Starting dynamic subtest: pipe-B-eDP-1
[473.451576] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[473.461161] Starting dynamic subtest: pipe-C-eDP-1
[473.482237] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[473.492071] Starting dynamic subtest: pipe-D-eDP-1
[473.514136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[473.518140] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[475.565285] [107/133] (549s left) kms_vrr (seamless-rr-switch-drrs)
[475.661880] Starting subtest: seamless-rr-switch-drrs
[475.668122] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[475.738176] [108/133] (548s left) i915_pm_freq_api (freq-basic-api)
[475.798827] Starting subtest: freq-basic-api
[475.801192] Starting dynamic subtest: gt0
[475.803439] Dynamic subtest gt0: SUCCESS (0.003s)
[475.816310] Starting dynamic subtest: gt1
[475.818798] Dynamic subtest gt1: SUCCESS (0.003s)
[475.820908] Subtest freq-basic-api: SUCCESS (0.006s)
[475.909870] [109/133] (548s left) gem_userptr_blits (set-cache-level)
[475.965505] Starting subtest: set-cache-level
[475.969545] Subtest set-cache-level: SKIP (0.000s)
[476.098530] [110/133] (548s left) kms_lease (atomic-implicit-crtc)
[476.198444] Starting subtest: atomic-implicit-crtc
[476.200766] Starting dynamic subtest: pipe-A-eDP-1
[476.211607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[476.225790] Starting dynamic subtest: pipe-B-eDP-1
[476.236675] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[476.245958] Starting dynamic subtest: pipe-C-eDP-1
[476.256300] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[476.265407] Starting dynamic subtest: pipe-D-eDP-1
[476.275955] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[476.277854] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[476.344580] [111/133] (548s left) gem_close_race (basic-threads)
[476.404431] Starting subtest: basic-threads
[477.799142] Subtest basic-threads: SUCCESS (1.396s)
[477.993199] [112/133] (546s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[478.099004] Starting subtest: x-tiled-8bpp-rotate-0
[479.282191] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.182s)
[479.405831] [113/133] (545s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[479.786570] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[480.565535] [114/133] (544s left) kms_cursor_edge_walk (256x256-left-edge)
[480.652185] Starting subtest: 256x256-left-edge
[480.654563] Starting dynamic subtest: pipe-A-eDP-1
[484.138424] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[484.148171] Starting dynamic subtest: pipe-D-eDP-1
[487.264518] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[487.266665] Subtest 256x256-left-edge: SUCCESS (6.611s)
[488.096151] [115/133] (536s left) kms_force_connector_basic (force-connector-state)
[488.184402] Starting subtest: force-connector-state
[488.815847] Subtest force-connector-state: SUCCESS (0.631s)
[489.782363] [116/133] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[489.890530] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[489.894694] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[489.984313] [117/133] (535s left) gem_exec_schedule (u-fairslice-all)
[490.048298] Starting subtest: u-fairslice-all
[492.104035] Subtest u-fairslice-all: SUCCESS (2.062s)
[493.902690] [118/133] (531s left) api_intel_allocator (fork-simple-stress)
[493.966939] Starting subtest: fork-simple-stress
[499.361673] Subtest fork-simple-stress: SUCCESS (5.397s)
[499.489868] [119/133] (525s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[499.602463] Starting subtest: basic-max-pipe-crc-check
[499.606939] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[499.653759] [120/133] (525s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[499.713102] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[499.715280] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[499.829989] [121/133] (525s left) gem_sync (basic-store-all)
[499.905396] Starting subtest: basic-store-all
[503.322259] Subtest basic-store-all: SUCCESS (3.427s)
[503.508625] [122/133] (521s left) sysfs_heartbeat_interval (mixed)
[503.559780] Starting subtest: mixed
[503.562214] Starting dynamic subtest: vecs0
[508.782384] Dynamic subtest vecs0: SUCCESS (5.223s)
[508.792529] Starting dynamic subtest: ccs0
[513.959641] Dynamic subtest ccs0: SUCCESS (5.177s)
[513.972411] Starting dynamic subtest: vcs0
[519.220875] Dynamic subtest vcs0: SUCCESS (5.260s)
[519.233183] Starting dynamic subtest: bcs0
[524.404377] Dynamic subtest bcs0: SUCCESS (5.183s)
[524.416655] Starting dynamic subtest: rcs0
[529.608216] Dynamic subtest rcs0: SUCCESS (5.204s)
[529.620698] Starting dynamic subtest: vcs1
[534.810513] Dynamic subtest vcs1: SUCCESS (5.203s)
[534.812971] Subtest mixed: SUCCESS (31.262s)
[534.889677] [123/133] (490s left) kms_properties (get_properties-sanity-atomic)
[534.983156] Starting subtest: get_properties-sanity-atomic
[534.985406] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[535.057442] [124/133] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[535.154232] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[535.158444] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[535.261382] [125/133] (490s left) kms_color (invalid-degamma-lut-sizes)
[535.354976] Starting subtest: invalid-degamma-lut-sizes
[535.357091] Starting dynamic subtest: pipe-A
[535.641291] Dynamic subtest pipe-A: SUCCESS (0.286s)
[535.655886] Starting dynamic subtest: pipe-B
[535.658161] Dynamic subtest pipe-B: SUCCESS (0.000s)
[535.674546] Starting dynamic subtest: pipe-C
[535.676732] Dynamic subtest pipe-C: SUCCESS (0.000s)
[535.686612] Starting dynamic subtest: pipe-D
[535.688838] Dynamic subtest pipe-D: SUCCESS (0.000s)
[535.690963] Subtest invalid-degamma-lut-sizes: SUCCESS (0.290s)
[536.509123] [126/133] (488s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[536.618375] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[536.622507] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[536.721857] [127/133] (488s left) kms_fbcon_fbt (psr-suspend)
[536.779321] Starting subtest: psr-suspend
[586.020261] Subtest psr-suspend: SUCCESS (19.864s)
[586.104868] [128/133] (439s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[586.229313] Starting subtest: flip-vs-cursor-busy-crc-legacy
[587.051192] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.825s)
[587.858986] [129/133] (437s left) kms_tiled_display (basic-test-pattern)
[587.972768] Subtest basic-test-pattern: SKIP (0.000s)
[588.017301] [130/133] (437s left) kms_setmode (basic-clone-single-crtc)
[588.089288] Starting subtest: basic-clone-single-crtc
[588.096134] Subtest basic-clone-single-crtc: SKIP (0.000s)
[588.186172] [131/133] (437s left) gem_exec_reloc (basic-write-cpu)
[588.255565] Subtest basic-write-cpu: SKIP (0.000s)
[588.320961] [132/133] (437s left) gem_exec_schedule (u-submit-late-slice)
[588.392145] Starting subtest: u-submit-late-slice
[588.394187] Starting dynamic subtest: rcs0
[588.417378] Dynamic subtest rcs0: SUCCESS (0.034s)
[588.428779] Starting dynamic subtest: bcs0
[588.443864] Dynamic subtest bcs0: SUCCESS (0.026s)
[588.453887] Starting dynamic subtest: vcs0
[588.483031] Dynamic subtest vcs0: SUCCESS (0.038s)
[588.494421] Starting dynamic subtest: vcs1
[588.515407] Dynamic subtest vcs1: SUCCESS (0.030s)
[588.526647] Starting dynamic subtest: vecs0
[588.543584] Dynamic subtest vecs0: SUCCESS (0.029s)
[588.554714] Starting dynamic subtest: ccs0
[588.585506] Dynamic subtest ccs0: SUCCESS (0.041s)
[588.587829] Subtest u-submit-late-slice: SUCCESS (0.203s)
[590.429091] [133/133] (435s left) kms_psr (psr-primary-mmap-cpu)
[590.539969] Starting subtest: psr-primary-mmap-cpu
[590.542245] Starting dynamic subtest: eDP-1
[592.286944] Dynamic subtest eDP-1: SUCCESS (1.752s)
[592.289374] Subtest psr-primary-mmap-cpu: SUCCESS (1.752s)
[593.137319] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_busy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_prop_blob
results: parsing output: 5/ for test: gem_media_fill
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: gem_ccs
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: gem_exec_suspend
results: parsing output: 13/ for test: gem_ppgtt
results: parsing output: 14/ for test: gem_mmap
results: parsing output: 15/ for test: kms_draw_crc
results: parsing output: 16/ for test: gem_create
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_async_flips
results: parsing output: 19/ for test: gem_pipe_control_store_loop
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: i915_pm_rpm
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_atomic
results: parsing output: 28/ for test: core_sysfs
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: prime_busy
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: api_intel_bb
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_spin_batch
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_plane_multiple
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_workarounds
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: i915_pm_rps
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_feature_discovery
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_ctx_shared
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_vrr
results: parsing output: 107/ for test: i915_pm_freq_api
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_lease
results: parsing output: 110/ for test: gem_close_race
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: kms_force_connector_basic
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: api_intel_allocator
results: parsing output: 118/ for test: kms_multipipe_modeset
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: gem_sync
results: parsing output: 121/ for test: sysfs_heartbeat_interval
results: parsing output: 122/ for test: kms_properties
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_color
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_fbcon_fbt
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_tiled_display
results: parsing output: 129/ for test: kms_setmode
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_psr
Done.