[105.701974] Initializing watchdogs
[105.702043]   /dev/watchdog0
[105.717455] [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]
[105.722205] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[105.725134] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[105.727035] [001/132] (960s left) gem_exec_params (rel-constants-invalid-ring)
[105.796051] Starting subtest: rel-constants-invalid-ring
[105.797076] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[105.885194] [002/132] (960s left) i915_selftest (perf)
[109.089137] Starting subtest: perf
[109.090294] Starting dynamic subtest: engine_cs
[113.415902] Dynamic subtest engine_cs: SUCCESS (4.327s)
[113.424060] Starting dynamic subtest: request
[118.676378] Dynamic subtest request: SUCCESS (5.259s)
[118.683349] Starting dynamic subtest: migrate
[123.001895] Dynamic subtest migrate: SUCCESS (4.324s)
[123.009899] Starting dynamic subtest: region
[128.610983] Dynamic subtest region: SUCCESS (5.609s)
[128.612386] Subtest perf: SUCCESS (19.522s)
[128.631426] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[128.632975] [003/132] (937s left) gen9_exec_parse (unaligned-access)
[130.180816] Subtest unaligned-access: SKIP (0.000s)
[130.262259] [FACT gen9_exec_parse (unaligned-access)] new: kernel.kmod_is_loaded.i915: true
[130.264222] [004/132] (936s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[130.417815] Starting subtest: dp-mst-type-0-suspend-resume
[130.419318] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[130.532237] [005/132] (935s left) kms_pm_rpm (system-suspend-idle)
[132.063925] Starting subtest: system-suspend-idle
[152.320996] Subtest system-suspend-idle: SUCCESS (5.151s)
[155.740524] [006/132] (913s left) kms_psr (psr2-cursor-plane-onoff)
[155.830407] Starting subtest: psr2-cursor-plane-onoff
[155.831264] Starting dynamic subtest: eDP-1
[157.562085] Dynamic subtest eDP-1: SUCCESS (1.750s)
[157.562961] Subtest psr2-cursor-plane-onoff: SUCCESS (1.751s)
[158.414746] [007/132] (911s left) perf_pmu (render-node-busy-idle)
[158.479007] Starting subtest: render-node-busy-idle
[158.480101] Starting dynamic subtest: rcs0
[159.168326] Dynamic subtest rcs0: SUCCESS (0.703s)
[159.178109] Starting dynamic subtest: bcs0
[159.829644] Dynamic subtest bcs0: SUCCESS (0.673s)
[159.838705] Starting dynamic subtest: vcs0
[160.983920] Dynamic subtest vcs0: SUCCESS (1.172s)
[160.992965] Starting dynamic subtest: vcs1
[163.040004] Dynamic subtest vcs1: SUCCESS (2.073s)
[163.049927] Starting dynamic subtest: vecs0
[165.023993] Dynamic subtest vecs0: SUCCESS (2.003s)
[165.033736] Starting dynamic subtest: ccs0
[165.677214] Dynamic subtest ccs0: SUCCESS (0.667s)
[165.678368] Subtest render-node-busy-idle: SUCCESS (7.298s)
[165.758961] [008/132] (903s left) gem_mmap_gtt (basic)
[165.812471] Subtest basic: SKIP (0.000s)
[165.864408] [009/132] (903s left) gem_reg_read (timestamp-monotonic)
[165.912825] Starting subtest: timestamp-monotonic
[170.848705] Subtest timestamp-monotonic: SUCCESS (4.919s)
[170.880116] [010/132] (898s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[170.971536] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[170.972460] Starting dynamic subtest: pipe-A-default-mode
[172.139827] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[172.141958] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.172s)
[172.289723] [011/132] (897s left) gem_ctx_shared (create-shared-gtt)
[172.360963] Starting subtest: create-shared-gtt
[174.551686] Subtest create-shared-gtt: SUCCESS (2.151s)
[174.872983] [012/132] (894s left) gem_exec_fence (invalid-fence-array)
[175.351348] Starting subtest: invalid-fence-array
[175.355823] Subtest invalid-fence-array: SUCCESS (0.003s)
[177.073218] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[177.076026] [013/132] (892s left) kms_psr (fbc-pr-primary-render)
[177.161698] Starting subtest: fbc-pr-primary-render
[177.163671] Subtest fbc-pr-primary-render: SKIP (0.000s)
[177.226699] [014/132] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[177.316215] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[177.317987] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[177.411128] [015/132] (892s left) gem_exec_suspend (basic-s0)
[177.479460] Starting subtest: basic-S0
[177.480450] Starting dynamic subtest: smem
[198.289050] Dynamic subtest smem: SUCCESS (6.554s)
[198.290358] Subtest basic-S0: SUCCESS (6.555s)
[203.518452] [016/132] (871s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[203.619577] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[203.629249] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.722855] [017/132] (871s left) device_reset (unbind-reset-rebind)
[203.769169] Starting subtest: unbind-reset-rebind
[208.604991] Subtest unbind-reset-rebind: SUCCESS (4.897s)
[208.654221] [018/132] (866s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[208.742955] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[208.744652] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[208.807112] [019/132] (866s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[208.888697] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[208.889683] Starting dynamic subtest: pipe-A-eDP-1
[209.013485] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[209.022041] Starting dynamic subtest: pipe-B-eDP-1
[210.178179] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[210.180087] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.307s)
[211.352254] [020/132] (863s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[211.457744] Starting subtest: x-tiled-addfb-size-offset-overflow
[211.458575] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[211.549408] [021/132] (863s left) gem_ctx_shared (q-in-order)
[211.608669] Starting subtest: Q-in-order
[211.609892] Starting dynamic subtest: rcs0
[211.703623] Dynamic subtest rcs0: SUCCESS (0.095s)
[211.718641] Starting dynamic subtest: vcs0
[211.785116] Dynamic subtest vcs0: SUCCESS (0.082s)
[211.800526] Starting dynamic subtest: vcs1
[211.855085] Dynamic subtest vcs1: SUCCESS (0.070s)
[211.870720] Starting dynamic subtest: vecs0
[211.923994] Dynamic subtest vecs0: SUCCESS (0.070s)
[211.939216] Starting dynamic subtest: ccs0
[212.001760] Dynamic subtest ccs0: SUCCESS (0.078s)
[212.003096] Subtest Q-in-order: SUCCESS (0.398s)
[213.346891] [022/132] (861s left) gen9_exec_parse (allowed-single)
[213.397753] Subtest allowed-single: SKIP (0.000s)
[213.460374] [023/132] (861s left) kms_flip (flip-vs-modeset-vs-hang)
[213.544247] Starting subtest: flip-vs-modeset-vs-hang
[213.545286] Starting dynamic subtest: A-eDP1
[265.758837] Dynamic subtest A-eDP1: SUCCESS (52.272s)
[265.770421] Starting dynamic subtest: D-eDP1
[315.814284] Dynamic subtest D-eDP1: SUCCESS (50.061s)
[315.817730] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.338s)
[316.198363] [024/132] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[316.284101] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[324.006729] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.721s)
[324.113947] [025/132] (751s left) kms_flip (absolute-wf_vblank)
[324.208423] Starting subtest: absolute-wf_vblank
[324.210732] Starting dynamic subtest: A-eDP1
[332.946469] Dynamic subtest A-eDP1: SUCCESS (8.708s)
[332.956841] Starting dynamic subtest: B-eDP1
[341.680540] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[341.691609] Starting dynamic subtest: C-eDP1
[350.411440] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[350.422321] Starting dynamic subtest: D-eDP1
[359.138580] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[359.139567] Subtest absolute-wf_vblank: SUCCESS (34.898s)
[360.309469] [026/132] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[360.397777] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[367.768600] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.373s)
[367.879185] [027/132] (707s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[367.930796] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[367.986080] [028/132] (707s left) kms_setmode (basic)
[368.032066] Starting subtest: basic
[368.356334] Starting dynamic subtest: pipe-A-eDP-1
[370.462884] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[370.814824] Starting dynamic subtest: pipe-B-eDP-1
[372.900026] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.083s)
[373.198426] Subtest basic: SUCCESS (5.167s)
[374.021453] [029/132] (701s left) gem_readwrite (read-bad-handle)
[374.082178] Subtest read-bad-handle: SKIP (0.000s)
[374.145732] [030/132] (701s left) i915_pm_rps (basic-api)
[374.205381] Starting subtest: basic-api
[374.207204] Subtest basic-api: SKIP (0.001s)
[374.298840] [031/132] (701s left) kms_chamelium_hpd (hdmi-hpd)
[374.673438] Subtest hdmi-hpd: SKIP (0.000s)
[375.444618] [032/132] (699s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[375.538369] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[375.540066] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[375.624594] [033/132] (699s left) gem_exec_reloc (basic-write-gtt)
[375.678881] Subtest basic-write-gtt: SKIP (0.000s)
[375.740985] [034/132] (699s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[375.839172] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[375.840087] Starting dynamic subtest: pipe-A
[375.948350] Dynamic subtest pipe-A: SKIP (0.108s)
[375.956511] Starting dynamic subtest: pipe-B
[377.140390] Dynamic subtest pipe-B: SKIP (1.191s)
[377.149170] Starting dynamic subtest: pipe-C
[378.370003] Dynamic subtest pipe-C: SUCCESS (1.232s)
[378.384946] Starting dynamic subtest: pipe-D
[379.607814] Dynamic subtest pipe-D: SUCCESS (1.237s)
[379.608807] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.771s)
[380.794510] [035/132] (694s left) gem_exec_gttfill (all-engines)
[380.852423] Starting subtest: all-engines
[405.265750] Subtest all-engines: SUCCESS (24.407s)
[405.467518] [036/132] (670s left) gem_close (basic)
[405.566626] Starting subtest: basic
[405.567556] Subtest basic: SUCCESS (0.000s)
[405.685749] [037/132] (669s left) syncobj_timeline (invalid-query-one-illegal-handle)
[405.743061] Starting subtest: invalid-query-one-illegal-handle
[405.743978] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[405.829280] [038/132] (669s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[405.924069] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[407.136462] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.213s)
[407.258977] [039/132] (668s left) gem_mmap_wc (write-cpu-read-wc)
[407.306664] Subtest write-cpu-read-wc: SKIP (0.000s)
[407.404483] [040/132] (668s left) gem_exec_balancer (full)
[407.467100] Starting subtest: full
[412.179537] Subtest full: SUCCESS (4.713s)
[412.497495] [041/132] (663s left) syncobj_timeline (host-signal-ordered)
[412.545351] Starting subtest: host-signal-ordered
[412.546362] Subtest host-signal-ordered: SUCCESS (0.000s)
[412.640794] [042/132] (663s left) gem_exec_big (single)
[412.691417] Starting subtest: single
[416.054292] Subtest single: FAIL (3.341s)
[416.111388] [043/132] (659s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[416.243842] Starting subtest: primary-x-tiled-reflect-x-0
[423.167223] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.925s)
[424.352220] [044/132] (651s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[424.416548] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[424.417728] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[424.488579] [045/132] (651s left) gem_ctx_engines (execute-oneforall)
[424.552744] Starting subtest: execute-oneforall
[425.076982] Subtest execute-oneforall: SUCCESS (0.525s)
[426.359223] [046/132] (649s left) fbdev (unaligned-read)
[426.401560] Starting subtest: unaligned-read
[426.417977] Subtest unaligned-read: SUCCESS (0.016s)
[426.466860] [047/132] (649s left) gem_busy (close-race)
[426.522887] Starting subtest: close-race
[450.255320] Subtest close-race: SUCCESS (23.715s)
[450.608502] [048/132] (625s left) gem_mmap_wc (invalid-flags)
[450.699733] Subtest invalid-flags: SKIP (0.000s)
[450.765247] [049/132] (625s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[450.870959] Starting subtest: crc-primary-basic-y-tiled-ccs
[450.871801] Starting dynamic subtest: pipe-A-eDP-1
[450.879983] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[450.889461] Starting dynamic subtest: pipe-B-eDP-1
[450.898079] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[450.907037] Starting dynamic subtest: pipe-C-eDP-1
[450.915250] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[450.923591] Starting dynamic subtest: pipe-D-eDP-1
[450.931579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[450.933131] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[453.131946] [050/132] (622s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[453.229207] Starting subtest: psr-rgb565-draw-mmap-gtt
[453.231049] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[453.331439] [051/132] (622s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[453.388107] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[453.397975] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[453.579789] [052/132] (622s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[453.658046] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[453.659752] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[453.741822] [053/132] (622s left) gem_exec_suspend (basic-s3-devices)
[453.796311] Starting subtest: basic-S3-devices
[453.797339] Starting dynamic subtest: smem
[465.231001] Dynamic subtest smem: SUCCESS (11.422s)
[465.232429] Subtest basic-S3-devices: SUCCESS (11.424s)
[473.427396] [054/132] (610s left) gen3_mixed_blits
[473.547662] [055/132] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[473.635792] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[473.637911] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[473.734406] [056/132] (610s left) kms_psr (pr-sprite-blt)
[473.825044] Starting subtest: pr-sprite-blt
[473.826793] Subtest pr-sprite-blt: SKIP (0.000s)
[473.907619] [057/132] (610s left) kms_chamelium_frames (dp-crc-fast)
[474.280336] Subtest dp-crc-fast: SKIP (0.000s)
[475.131147] [058/132] (609s left) syncobj_timeline (multi-wait-available-signaled)
[475.189920] Starting subtest: multi-wait-available-signaled
[475.190915] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[475.295628] [059/132] (609s left) kms_pipe_crc_basic (bad-source)
[475.391099] Starting subtest: bad-source
[475.391974] Subtest bad-source: SUCCESS (0.000s)
[475.459492] [060/132] (609s left) kms_atomic (plane-invalid-params)
[475.546239] Starting subtest: plane-invalid-params
[475.547276] Starting dynamic subtest: pipe-A-eDP-1
[475.981852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[475.982613] Subtest plane-invalid-params: SUCCESS (0.437s)
[476.789236] [061/132] (607s left) gem_pxp (create-regular-buffer)
[476.910311] Starting subtest: create-regular-buffer
[476.911441] Subtest create-regular-buffer: SUCCESS (0.000s)
[477.051303] [062/132] (607s left) gem_exec_schedule (preempt)
[477.116217] Starting subtest: preempt
[477.117242] Starting dynamic subtest: rcs0
[477.136309] Dynamic subtest rcs0: SUCCESS (0.021s)
[477.146087] Starting dynamic subtest: bcs0
[477.153864] Dynamic subtest bcs0: SUCCESS (0.017s)
[477.163092] Starting dynamic subtest: vcs0
[477.172596] Dynamic subtest vcs0: SUCCESS (0.018s)
[477.182162] Starting dynamic subtest: vcs1
[477.192991] Dynamic subtest vcs1: SUCCESS (0.020s)
[477.201865] Starting dynamic subtest: vecs0
[477.211199] Dynamic subtest vecs0: SUCCESS (0.018s)
[477.220108] Starting dynamic subtest: ccs0
[477.232219] Dynamic subtest ccs0: SUCCESS (0.020s)
[477.234519] Subtest preempt: SUCCESS (0.119s)
[478.345268] [063/132] (606s left) gem_partial_pwrite_pread (reads)
[478.403805] Subtest reads: SKIP (0.000s)
[478.510365] [064/132] (606s left) vgem_basic (bad-handle)
[478.563002] Starting subtest: bad-handle
[478.564036] Subtest bad-handle: SUCCESS (0.000s)
[478.621364] [065/132] (606s left) kms_cursor_legacy (forked-move)
[478.754564] Starting subtest: forked-move
[478.755505] Starting dynamic subtest: pipe-A
[484.265218] Dynamic subtest pipe-A: SUCCESS (5.465s)
[484.277871] Starting dynamic subtest: pipe-B
[489.734157] Dynamic subtest pipe-B: SUCCESS (5.466s)
[489.746863] Starting dynamic subtest: pipe-C
[495.238997] Dynamic subtest pipe-C: SUCCESS (5.502s)
[495.254601] Starting dynamic subtest: pipe-D
[500.720872] Dynamic subtest pipe-D: SUCCESS (5.480s)
[500.742639] Starting dynamic subtest: all-pipes
[506.226389] Dynamic subtest all-pipes: SUCCESS (5.503s)
[506.227681] Subtest forked-move: SUCCESS (27.428s)
[506.333940] [066/132] (578s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[506.428063] Starting subtest: 4-tiled-32bpp-rotate-90
[506.447468] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[506.560311] [067/132] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[506.657551] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[506.659434] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[506.749303] [068/132] (578s left) gem_exec_schedule (u-lateslice)
[506.807572] Starting subtest: u-lateslice
[506.808416] Starting dynamic subtest: rcs0
[506.826265] Dynamic subtest rcs0: SUCCESS (0.020s)
[506.836144] Starting dynamic subtest: bcs0
[506.842915] Dynamic subtest bcs0: SUCCESS (0.016s)
[506.851881] Starting dynamic subtest: vcs0
[506.859929] Dynamic subtest vcs0: SUCCESS (0.016s)
[506.870806] Starting dynamic subtest: vcs1
[506.875956] Dynamic subtest vcs1: SUCCESS (0.016s)
[506.885151] Starting dynamic subtest: vecs0
[506.897553] Dynamic subtest vecs0: SUCCESS (0.021s)
[506.911141] Starting dynamic subtest: ccs0
[506.915632] Dynamic subtest ccs0: SUCCESS (0.017s)
[506.917065] Subtest u-lateslice: SUCCESS (0.110s)
[508.368821] [069/132] (576s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[508.466096] Starting subtest: invalidate-primary-flip-overlay
[519.182112] Subtest invalidate-primary-flip-overlay: SUCCESS (10.717s)
[519.284806] [070/132] (565s left) kms_sequence (get-forked)
[519.372060] Starting subtest: get-forked
[519.373035] Starting dynamic subtest: pipe-A-eDP-1
[521.249571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[521.258877] Starting dynamic subtest: pipe-B-eDP-1
[523.846437] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.596s)
[523.856216] Starting dynamic subtest: pipe-C-eDP-1
[526.327076] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.480s)
[526.337566] Starting dynamic subtest: pipe-D-eDP-1
[528.878842] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[528.879646] Subtest get-forked: SUCCESS (9.509s)
[529.697404] [071/132] (555s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[529.784929] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[529.812085] Starting dynamic subtest: pipe-A-plane-0
[530.111784] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[530.122190] Starting dynamic subtest: pipe-A-plane-3
[530.345204] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[531.491175] Starting dynamic subtest: pipe-B-plane-0
[531.782329] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[531.791509] Starting dynamic subtest: pipe-B-plane-3
[532.026531] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[532.343331] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.559s)
[533.173680] [072/132] (551s left) syncobj_eventfd (invalid-illegal-handle)
[533.240525] Starting subtest: invalid-illegal-handle
[533.241515] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[533.346565] [073/132] (551s left) kms_invalid_mode (bad-hsync-end)
[533.433029] Starting subtest: bad-hsync-end
[533.433930] Starting dynamic subtest: pipe-A-eDP-1
[533.717417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[533.726404] Starting dynamic subtest: pipe-B-eDP-1
[533.727407] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[533.735935] Starting dynamic subtest: pipe-C-eDP-1
[533.736904] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[533.745488] Starting dynamic subtest: pipe-D-eDP-1
[533.746520] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[533.747630] Subtest bad-hsync-end: SUCCESS (0.290s)
[534.594121] [074/132] (550s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[534.654471] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[534.655480] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[534.759655] [075/132] (550s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[534.853895] Starting subtest: plane-lut1d-pre-ctm3x4
[535.002689] Starting dynamic subtest: pipe-A-plane-0
[535.201353] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[535.211131] Starting dynamic subtest: pipe-A-plane-1
[535.357059] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[535.366650] Starting dynamic subtest: pipe-A-plane-2
[535.512404] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[536.707379] Starting dynamic subtest: pipe-B-plane-0
[536.875994] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[536.885340] Starting dynamic subtest: pipe-B-plane-1
[537.064646] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[537.076769] Starting dynamic subtest: pipe-B-plane-2
[537.231355] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[538.429812] Starting dynamic subtest: pipe-C-plane-0
[538.564569] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[538.573945] Starting dynamic subtest: pipe-C-plane-1
[538.719583] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[538.729229] Starting dynamic subtest: pipe-C-plane-2
[538.864108] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[540.068885] Starting dynamic subtest: pipe-D-plane-0
[540.226515] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[540.236129] Starting dynamic subtest: pipe-D-plane-1
[540.382183] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[540.391524] Starting dynamic subtest: pipe-D-plane-2
[540.548708] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[540.837895] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.984s)
[541.629673] [076/132] (543s left) gem_lmem_evict (dontneed-evict-race)
[541.672828] Subtest dontneed-evict-race: SKIP (0.000s)
[541.717516] [077/132] (543s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[541.805093] Starting subtest: fbc-psr2-sprite-plane-onoff
[541.806039] Starting dynamic subtest: eDP-1
[541.807767] Dynamic subtest eDP-1: SKIP (0.000s)
[541.809458] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[541.874022] [078/132] (543s left) kms_hdr (bpc-switch-dpms)
[541.978849] Starting subtest: bpc-switch-dpms
[543.007517] Starting dynamic subtest: pipe-A-eDP-1
[547.554558] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.549s)
[547.555528] Subtest bpc-switch-dpms: SUCCESS (5.578s)
[547.656845] [079/132] (537s left) syncobj_timeline (single-wait-available-signaled)
[547.705042] Starting subtest: single-wait-available-signaled
[547.705955] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[547.790771] [080/132] (537s left) kms_cursor_crc (cursor-onscreen-512x512)
[548.061268] Starting subtest: cursor-onscreen-512x512
[548.063208] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[548.218535] [081/132] (537s left) gem_ctx_exec (basic-nohangcheck)
[548.265777] Starting subtest: basic-nohangcheck
[548.507503] Subtest basic-nohangcheck: SUCCESS (0.242s)
[548.627749] [082/132] (536s left) api_intel_bb (bb-with-allocator)
[548.683011] Starting subtest: bb-with-allocator
[548.687586] Subtest bb-with-allocator: SUCCESS (0.006s)
[548.810352] [083/132] (536s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[548.900561] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[548.902366] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[548.984786] [084/132] (536s left) syncobj_wait (reset-unsignaled)
[549.030644] Starting subtest: reset-unsignaled
[549.031660] Subtest reset-unsignaled: SUCCESS (0.000s)
[549.120871] [085/132] (536s left) perf (blocking)
[549.252923] Starting subtest: blocking
[549.253784] Starting dynamic subtest: 0-rcs0
[559.311176] Dynamic subtest 0-rcs0: SUCCESS (10.013s)
[559.323435] Starting dynamic subtest: 1-vcs0
[569.295328] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[569.296472] Subtest blocking: SUCCESS (20.036s)
[569.334780] [086/132] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[569.438290] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[569.440052] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[569.529246] [087/132] (515s left) gem_lmem_swapping (verify-random)
[569.573546] Subtest verify-random: SKIP (0.000s)
[569.612497] [088/132] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[569.698018] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[569.700057] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[569.800197] [089/132] (515s left) kms_pm_lpsp (kms-lpsp)
[570.889640] Starting subtest: kms-lpsp
[570.890761] Starting dynamic subtest: pipe-A-eDP-1
[571.039119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[571.338450] Subtest kms-lpsp: SUCCESS (0.449s)
[572.125799] [090/132] (513s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[572.170587] Starting subtest: multi-wait-all-for-submit-signaled
[572.171952] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[572.279460] [091/132] (513s left) kms_cursor_crc (cursor-random-32x10)
[572.443871] Starting subtest: cursor-random-32x10
[572.491363] Subtest cursor-random-32x10: SKIP (0.046s)
[572.764174] [092/132] (512s left) gem_exec_reloc (basic-gtt-noreloc)
[572.831835] Subtest basic-gtt-noreloc: SKIP (0.000s)
[572.899595] [093/132] (512s left) kms_atomic_interruptible (legacy-setmode)
[572.981150] Starting subtest: legacy-setmode
[572.982044] Starting dynamic subtest: pipe-A-eDP-1
[579.894425] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.913s)
[579.895380] Subtest legacy-setmode: SUCCESS (6.914s)
[580.752947] [094/132] (505s left) gem_workarounds (basic-read)
[580.818355] Starting subtest: basic-read
[580.828963] Subtest basic-read: SUCCESS (0.011s)
[580.944005] [095/132] (504s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[581.032038] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[581.032904] Starting dynamic subtest: pipe-A
[581.068296] Dynamic subtest pipe-A: SKIP (0.034s)
[581.080884] Starting dynamic subtest: pipe-B
[581.112925] Dynamic subtest pipe-B: SKIP (0.043s)
[581.122219] Starting dynamic subtest: pipe-C
[581.147578] Dynamic subtest pipe-C: SKIP (0.034s)
[581.156805] Starting dynamic subtest: pipe-D
[581.183164] Dynamic subtest pipe-D: SKIP (0.035s)
[581.184741] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.149s)
[581.282955] [096/132] (504s left) api_intel_bb (simple-bb)
[581.334934] Starting subtest: simple-bb
[581.339744] Subtest simple-bb: SUCCESS (0.005s)
[581.445008] [097/132] (504s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[581.545264] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[581.546771] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[581.650573] [098/132] (504s left) perf_pmu (busy-double-start)
[581.685529] Starting subtest: busy-double-start
[581.687562] Starting dynamic subtest: rcs0
[585.290328] Dynamic subtest rcs0: FAIL (3.585s)
[585.299414] Starting dynamic subtest: bcs0
[588.841437] Dynamic subtest bcs0: SUCCESS (3.568s)
[588.852968] Starting dynamic subtest: vcs0
[592.798991] Dynamic subtest vcs0: SUCCESS (3.959s)
[592.812194] Starting dynamic subtest: vcs1
[596.806665] Dynamic subtest vcs1: SUCCESS (4.005s)
[596.819639] Starting dynamic subtest: vecs0
[600.806903] Dynamic subtest vecs0: SUCCESS (3.999s)
[600.821877] Starting dynamic subtest: ccs0
[604.406613] Dynamic subtest ccs0: FAIL (3.566s)
[604.407472] Subtest busy-double-start: FAIL (22.692s)
[604.472922] [099/132] (481s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[604.579677] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[604.581686] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[604.700649] [100/132] (481s left) gem_softpin (allocator-evict)
[604.749010] Starting subtest: allocator-evict
[604.750027] Starting dynamic subtest: rcs0
[627.696862] Dynamic subtest rcs0: SUCCESS (22.949s)
[627.708997] Starting dynamic subtest: bcs0
[651.408043] Dynamic subtest bcs0: SUCCESS (23.713s)
[651.421336] Starting dynamic subtest: vcs0
[675.176171] Dynamic subtest vcs0: SUCCESS (23.768s)
[675.189778] Starting dynamic subtest: vcs1
[699.060703] Dynamic subtest vcs1: SUCCESS (23.885s)
[699.073306] Starting dynamic subtest: vecs0
[723.034208] Dynamic subtest vecs0: SUCCESS (23.974s)
[723.046489] Starting dynamic subtest: ccs0
[747.400752] Dynamic subtest ccs0: SUCCESS (24.369s)
[747.401973] Subtest allocator-evict: SUCCESS (142.669s)
[747.498981] [101/132] (338s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[747.646571] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[747.647430] Starting dynamic subtest: pipe-A-eDP-1
[748.575249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.925s)
[748.584736] Starting dynamic subtest: pipe-B-eDP-1
[750.243452] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.667s)
[750.253245] Starting dynamic subtest: pipe-C-eDP-1
[751.738356] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s)
[751.747752] Starting dynamic subtest: pipe-D-eDP-1
[753.283974] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.544s)
[753.284863] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.636s)
[754.456882] [102/132] (331s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[754.551558] Starting subtest: addfb25-y-tiled-small-legacy
[754.553370] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[754.659509] [103/132] (331s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[754.753888] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[761.957937] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.205s)
[762.074906] [104/132] (324s left) kms_feature_discovery (chamelium)
[762.161874] Starting subtest: chamelium
[762.163667] Subtest chamelium: SKIP (0.000s)
[762.248759] [105/132] (323s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[762.302574] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[762.304299] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[762.488962] [106/132] (323s left) gem_userptr_blits (stress-purge)
[762.549091] Starting subtest: stress-purge
[767.970308] Subtest stress-purge: SUCCESS (5.422s)
[768.107257] [107/132] (318s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[768.242798] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[768.243648] Starting dynamic subtest: pipe-A-eDP-1
[768.747675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.494s)
[768.759738] Starting dynamic subtest: pipe-B-eDP-1
[770.222014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.473s)
[770.236490] Starting dynamic subtest: pipe-C-eDP-1
[771.598740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[771.608173] Starting dynamic subtest: pipe-D-eDP-1
[773.026967] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.427s)
[773.027770] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.776s)
[774.217166] [108/132] (312s left) gem_wait (invalid-buf)
[774.274773] Starting subtest: invalid-buf
[774.275689] Subtest invalid-buf: SUCCESS (0.000s)
[774.475401] [109/132] (311s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[774.561181] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[774.562081] Starting dynamic subtest: pipe-A-eDP-1
[774.570616] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[774.580265] Starting dynamic subtest: pipe-B-eDP-1
[774.588524] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[774.598072] Starting dynamic subtest: pipe-C-eDP-1
[774.606308] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[774.615551] Starting dynamic subtest: pipe-D-eDP-1
[774.624027] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[774.625546] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[776.893425] [110/132] (309s left) i915_hangman (gt-engine-hang)
[776.963090] Starting subtest: gt-engine-hang
[776.964035] Starting dynamic subtest: rcs0
[778.222625] Dynamic subtest rcs0: SUCCESS (1.250s)
[778.235059] Starting dynamic subtest: bcs0
[780.269217] Dynamic subtest bcs0: SUCCESS (2.044s)
[780.290932] Starting dynamic subtest: vcs0
[782.253055] Dynamic subtest vcs0: SUCCESS (1.981s)
[782.265151] Starting dynamic subtest: vcs1
[784.237652] Dynamic subtest vcs1: SUCCESS (1.982s)
[784.249394] Starting dynamic subtest: vecs0
[786.222261] Dynamic subtest vecs0: SUCCESS (1.982s)
[786.234308] Starting dynamic subtest: ccs0
[788.269382] Dynamic subtest ccs0: SUCCESS (2.044s)
[788.270646] Subtest gt-engine-hang: SUCCESS (11.301s)
[788.385108] [111/132] (298s left) kms_cursor_edge_walk (256x256-right-edge)
[788.483723] Starting subtest: 256x256-right-edge
[788.484615] Starting dynamic subtest: pipe-A-eDP-1
[791.963180] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[791.978758] Starting dynamic subtest: pipe-D-eDP-1
[795.077810] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[795.080395] Subtest 256x256-right-edge: SUCCESS (6.596s)
[795.889983] [112/132] (290s left) kms_chamelium_color (ctm-max)
[795.975281] Subtest ctm-max: SKIP (0.000s)
[796.018446] [113/132] (290s left) gem_exec_reloc (basic-cpu-wc-active)
[796.073936] Subtest basic-cpu-wc-active: SKIP (0.000s)
[796.150154] [114/132] (290s left) kms_psr2_su (frontbuffer-xrgb8888)
[796.195758] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[796.254724] [115/132] (290s left) kms_lease (cursor-implicit-plane)
[796.348082] Starting subtest: cursor-implicit-plane
[796.349000] Starting dynamic subtest: pipe-A-eDP-1
[796.807248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[796.816650] Starting dynamic subtest: pipe-B-eDP-1
[797.908494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s)
[797.918175] Starting dynamic subtest: pipe-C-eDP-1
[799.028704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[799.040233] Starting dynamic subtest: pipe-D-eDP-1
[800.153317] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[800.154317] Subtest cursor-implicit-plane: SUCCESS (3.806s)
[801.021820] [116/132] (285s left) gem_mmap_offset (perf)
[801.070839] Starting subtest: perf
[801.071769] Starting dynamic subtest: smem0
[801.438417] Dynamic subtest smem0: SUCCESS (0.365s)
[801.439619] Subtest perf: SUCCESS (0.366s)
[801.543479] [117/132] (285s left) syncobj_wait (wait-all-snapshot)
[801.602214] Starting subtest: wait-all-snapshot
[801.682749] Subtest wait-all-snapshot: SUCCESS (0.081s)
[801.755707] [118/132] (284s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[801.849223] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[801.851064] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[801.937385] [119/132] (284s left) gem_eio (in-flight-suspend)
[802.147344] Starting subtest: in-flight-suspend
[846.017056] Subtest in-flight-suspend: SUCCESS (14.525s)
[852.225189] [120/132] (240s left) syncobj_wait (single-wait-all-for-submit-signaled)
[852.283497] Starting subtest: single-wait-all-for-submit-signaled
[852.284362] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[852.389883] [121/132] (240s left) prime_self_import (basic-llseek-bad)
[852.421643] Starting subtest: basic-llseek-bad
[852.435225] Subtest basic-llseek-bad: SUCCESS (0.014s)
[852.531787] [122/132] (240s left) kms_plane_alpha_blend (alpha-basic)
[852.634208] Starting subtest: alpha-basic
[852.931010] Starting dynamic subtest: pipe-A-eDP-1
[854.866905] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[854.902043] Starting dynamic subtest: pipe-D-eDP-1
[857.581124] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[857.581933] Subtest alpha-basic: SUCCESS (4.948s)
[858.387389] [123/132] (234s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[858.492191] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[858.494085] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[858.588371] [124/132] (234s left) kms_feature_discovery (psr2)
[858.680136] Starting subtest: psr2
[858.681271] Subtest psr2: SUCCESS (0.000s)
[858.755410] [125/132] (234s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[858.847962] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[858.849754] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[858.951342] [126/132] (234s left) perf (polling)
[859.045741] Starting subtest: polling
[859.046821] Starting dynamic subtest: 0-rcs0
[869.074283] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[869.086792] Starting dynamic subtest: 1-vcs0
[879.131789] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[879.132896] Subtest polling: SUCCESS (20.045s)
[879.167790] [127/132] (213s left) kms_big_fb (linear-16bpp-rotate-180)
[879.264153] Starting subtest: linear-16bpp-rotate-180
[880.643858] Subtest linear-16bpp-rotate-180: SUCCESS (1.380s)
[880.767200] [128/132] (212s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[880.864788] Starting subtest: fbcpsr-rgb565-draw-blt
[888.015739] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.152s)
[888.149069] [129/132] (205s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[888.262060] Starting subtest: short-flip-after-cursor-atomic-transitions
[889.209599] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.946s)
[890.042405] [130/132] (203s left) perf_pmu (semaphore-wait)
[890.080463] Starting subtest: semaphore-wait
[890.081366] Starting dynamic subtest: rcs0
[890.603773] Dynamic subtest rcs0: SUCCESS (0.513s)
[890.615765] Starting dynamic subtest: bcs0
[891.117340] Dynamic subtest bcs0: SUCCESS (0.511s)
[891.129375] Starting dynamic subtest: vcs0
[891.630656] Dynamic subtest vcs0: SUCCESS (0.510s)
[891.643684] Starting dynamic subtest: vcs1
[892.142431] Dynamic subtest vcs1: SUCCESS (0.509s)
[892.152765] Starting dynamic subtest: vecs0
[892.645939] Dynamic subtest vecs0: SUCCESS (0.510s)
[892.661262] Starting dynamic subtest: ccs0
[893.172917] Dynamic subtest ccs0: SUCCESS (0.516s)
[893.174223] Subtest semaphore-wait: SUCCESS (3.085s)
[894.709602] [131/132] (198s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[894.793578] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[894.795427] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[894.888890] [132/132] (198s left) kms_vrr (flip-basic-fastset)
[894.975208] Starting subtest: flip-basic-fastset
[894.977821] Subtest flip-basic-fastset: SKIP (0.000s)
[895.045343] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: i915_selftest
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: gem_reg_read
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_suspend
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: device_reset
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_ctx_shared
results: parsing output: 21/ for test: gen9_exec_parse
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: kms_setmode
results: parsing output: 28/ for test: gem_readwrite
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: gem_exec_gttfill
results: parsing output: 35/ for test: gem_close
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_exec_big
results: parsing output: 42/ for test: kms_rotation_crc
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_ctx_engines
results: parsing output: 45/ for test: fbdev
results: parsing output: 46/ for test: gem_busy
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: gem_exec_suspend
results: parsing output: 53/ for test: gen3_mixed_blits
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_pipe_crc_basic
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: vgem_basic
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_psr_stress_test
results: parsing output: 69/ for test: kms_sequence
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: syncobj_eventfd
results: parsing output: 72/ for test: kms_invalid_mode
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_color_pipeline
results: parsing output: 75/ for test: gem_lmem_evict
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_hdr
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: gem_ctx_exec
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: perf
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_pm_lpsp
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_atomic_interruptible
results: parsing output: 93/ for test: gem_workarounds
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_softpin
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_feature_discovery
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: gem_wait
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: i915_hangman
results: parsing output: 110/ for test: kms_cursor_edge_walk
results: parsing output: 111/ for test: kms_chamelium_color
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_psr2_su
results: parsing output: 114/ for test: kms_lease
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: prime_self_import
results: parsing output: 121/ for test: kms_plane_alpha_blend
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_feature_discovery
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_vrr
Done.