[30.709376] Initializing watchdogs
[30.709425]   /dev/watchdog0
[30.713578] [001/138] (960s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-mc-ccs)
[30.870571] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[30.974416] [002/138] (960s left) kms_cursor_crc (cursor-onscreen-128x42)
[31.064542] Starting subtest: cursor-onscreen-128x42
[31.067515] Starting dynamic subtest: pipe-A-HDMI-A-1
[33.633437] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.566s)
[33.650933] Starting dynamic subtest: pipe-B-HDMI-A-1
[36.034390] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.386s)
[36.035090] Subtest cursor-onscreen-128x42: SUCCESS (4.969s)
[36.163434] [003/138] (955s left) syncobj_wait (single-wait-all-submitted)
[36.194218] Starting subtest: single-wait-all-submitted
[36.295806] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[36.364422] [004/138] (954s left) api_intel_allocator (two-level-inception-interruptible)
[36.394108] Starting subtest: two-level-inception-interruptible
[41.814667] Subtest two-level-inception-interruptible: SUCCESS (5.412s)
[41.915484] [005/138] (949s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[41.982530] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[41.983227] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[42.046215] [006/138] (949s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation)
[42.141981] Starting subtest: plane-downscale-factor-0-25-with-rotation
[42.148598] Starting dynamic subtest: pipe-A-HDMI-A-1
[42.158511] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.009s)
[42.164566] Starting dynamic subtest: pipe-B-HDMI-A-1
[42.180523] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.018s)
[42.181863] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.039s)
[42.275574] [007/138] (949s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[42.322948] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[42.323693] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[42.389458] [008/138] (948s left) gem_exec_whisper (basic-fds-forked)
[42.444333] Starting subtest: basic-fds-forked
[47.891651] Subtest basic-fds-forked: SUCCESS (5.439s)
[48.082341] [009/138] (943s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[48.174833] Starting subtest: cursor-vs-flip-atomic
[75.994298] Subtest cursor-vs-flip-atomic: SUCCESS (27.819s)
[76.121676] [010/138] (915s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[76.214783] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[76.215743] Starting dynamic subtest: pipe-A-valid-mode
[76.805463] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.589s)
[76.806223] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.590s)
[76.952959] [011/138] (914s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[77.048048] Starting subtest: plane-upscale-factor-0-25-with-rotation
[77.052691] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.116810] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.063s)
[77.124989] Starting dynamic subtest: pipe-B-HDMI-A-1
[77.225188] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.102s)
[77.226620] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (0.177s)
[77.379822] [012/138] (914s left) prime_self_import (basic-with_one_bo)
[77.414506] Starting subtest: basic-with_one_bo
[77.416654] Subtest basic-with_one_bo: SUCCESS (0.002s)
[77.484564] [013/138] (913s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-mc-ccs)
[77.660905] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[77.763483] [014/138] (913s left) gem_exec_balancer (full-late-pulse)
[77.816346] Starting subtest: full-late-pulse
[78.919190] Subtest full-late-pulse: SUCCESS (1.101s)
[79.868558] [015/138] (911s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[80.035759] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[80.134122] [016/138] (911s left) gem_eio (wait-immediate)
[80.185869] Starting subtest: wait-immediate
[80.325857] Subtest wait-immediate: SUCCESS (0.139s)
[80.454088] [017/138] (911s left) i915_pm_rc6_residency (rc6-idle)
[80.500560] Starting subtest: rc6-idle
[80.502219] Starting dynamic subtest: rcs0
[92.727887] Dynamic subtest rcs0: SUCCESS (12.216s)
[92.735832] Starting dynamic subtest: bcs0
[104.938875] Dynamic subtest bcs0: SUCCESS (12.211s)
[104.946690] Starting dynamic subtest: vcs0
[117.161265] Dynamic subtest vcs0: SUCCESS (12.221s)
[117.169647] Starting dynamic subtest: vecs0
[129.377260] Dynamic subtest vecs0: SUCCESS (12.216s)
[129.378374] Subtest rc6-idle: SUCCESS (48.867s)
[129.634756] [018/138] (861s left) kms_feature_discovery (display)
[129.721008] Starting subtest: display
[129.721779] Subtest display: SUCCESS (0.000s)
[129.794052] [019/138] (861s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[129.894974] Starting subtest: y-tiled-16bpp-rotate-270
[131.284086] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.389s)
[131.428318] [020/138] (860s left) gem_userptr_blits (readonly-unsync)
[131.478250] Subtest readonly-unsync: SKIP (0.000s)
[131.597874] [021/138] (860s left) perf_pmu (rc6-suspend)
[131.645307] Starting subtest: rc6-suspend
[154.955927] Subtest rc6-suspend: SUCCESS (23.310s)
[156.293426] [022/138] (836s left) gem_mmap_gtt (hang-user)
[156.340731] Starting subtest: hang-user
[184.264586] Subtest hang-user: SUCCESS (27.924s)
[184.368321] [023/138] (808s left) kms_addfb_basic (too-high)
[184.455670] Starting subtest: too-high
[184.456586] Subtest too-high: SUCCESS (0.001s)
[184.551182] [024/138] (808s left) i915_query (hwconfig_table)
[184.595845] Starting subtest: hwconfig_table
[184.597316] Subtest hwconfig_table: SKIP (0.000s)
[184.684386] [025/138] (808s left) gem_wait (busy)
[184.731765] Starting subtest: busy
[184.732457] Starting dynamic subtest: all-engines
[185.243756] Dynamic subtest all-engines: SUCCESS (0.512s)
[185.248348] Starting dynamic subtest: rcs0
[185.754730] Dynamic subtest rcs0: SUCCESS (0.511s)
[185.759331] Starting dynamic subtest: bcs0
[186.264736] Dynamic subtest bcs0: SUCCESS (0.510s)
[186.269284] Starting dynamic subtest: vcs0
[186.774722] Dynamic subtest vcs0: SUCCESS (0.510s)
[186.779396] Starting dynamic subtest: vecs0
[187.286719] Dynamic subtest vecs0: SUCCESS (0.512s)
[187.287400] Subtest busy: SUCCESS (2.555s)
[187.477878] [026/138] (805s left) gem_exec_schedule (semaphore-user)
[187.530744] Starting subtest: semaphore-user
[187.534165] Subtest semaphore-user: SUCCESS (0.003s)
[187.853890] [027/138] (804s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-ccs)
[188.004055] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.000s)
[188.111114] [028/138] (804s left) gem_exec_flush (basic-wb-rw-default)
[188.164231] Starting subtest: basic-wb-rw-default
[193.591318] Subtest basic-wb-rw-default: SUCCESS (5.427s)
[193.789388] [029/138] (799s left) kms_cursor_crc (cursor-sliding-32x10)
[193.892146] Starting subtest: cursor-sliding-32x10
[193.919692] Subtest cursor-sliding-32x10: SKIP (0.026s)
[194.032343] [030/138] (798s left) gem_ctx_persistence (legacy-engines-mixed-process)
[194.076437] Starting subtest: legacy-engines-mixed-process
[194.077144] Starting dynamic subtest: render
[194.403121] Dynamic subtest render: SUCCESS (0.326s)
[194.409539] Starting dynamic subtest: bsd
[194.714736] Dynamic subtest bsd: SUCCESS (0.311s)
[194.723054] Starting dynamic subtest: blt
[195.040123] Dynamic subtest blt: SUCCESS (0.325s)
[195.046888] Starting dynamic subtest: vebox
[195.374452] Dynamic subtest vebox: SUCCESS (0.334s)
[195.375704] Subtest legacy-engines-mixed-process: SUCCESS (1.298s)
[195.448629] [031/138] (797s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[195.492263] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[195.492995] Starting dynamic subtest: smem
[195.642862] Dynamic subtest smem: SUCCESS (0.150s)
[195.643560] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.150s)
[195.837263] [032/138] (797s left) gem_userptr_blits (dmabuf-sync)
[195.880483] Starting subtest: dmabuf-sync
[195.882699] Subtest dmabuf-sync: SKIP (0.002s)
[195.991547] [033/138] (796s left) gem_close_race (basic-process)
[196.039712] Starting subtest: basic-process
[196.078477] Subtest basic-process: SUCCESS (0.038s)
[196.265063] [034/138] (796s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[196.402366] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[196.403707] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[196.519072] [035/138] (796s left) gen9_exec_parse (cmd-crossing-page)
[196.567770] Subtest cmd-crossing-page: SKIP (0.000s)
[196.603302] [036/138] (796s left) gem_set_tiling_vs_pwrite
[196.683544] [037/138] (796s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[196.857860] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[196.964363] [038/138] (796s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[197.055969] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[198.280850] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.225s)
[198.419690] [039/138] (794s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[198.515782] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[198.517133] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[198.626659] [040/138] (794s left) syncobj_timeline (32bits-limit)
[198.669497] Starting subtest: 32bits-limit
[198.670198] Subtest 32bits-limit: SUCCESS (0.000s)
[198.746740] [041/138] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[198.843061] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[198.845046] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[198.958151] [042/138] (794s left) kms_cursor_legacy (torture-move)
[199.043117] Starting subtest: torture-move
[199.043910] Starting dynamic subtest: pipe-A
[204.529087] Dynamic subtest pipe-A: SUCCESS (5.485s)
[204.534298] Starting dynamic subtest: pipe-B
[210.159785] Dynamic subtest pipe-B: SUCCESS (5.630s)
[210.176267] Starting dynamic subtest: all-pipes
[215.700361] Dynamic subtest all-pipes: SUCCESS (5.540s)
[215.701204] Subtest torture-move: SUCCESS (16.657s)
[215.790704] [043/138] (777s left) gem_unref_active_buffers
[215.984675] [044/138] (777s left) gem_exec_balancer (parallel-keep-submit-fence)
[216.921774] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[216.991578] [045/138] (776s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[217.079483] Starting subtest: psr-rgb101010-draw-mmap-wc
[217.081006] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[217.183608] [046/138] (775s left) syncobj_timeline (host-signal-points)
[217.230479] Starting subtest: host-signal-points
[217.234396] Subtest host-signal-points: SUCCESS (0.004s)
[217.322459] [047/138] (775s left) gem_exec_fence (syncobj-timeline-chain-engines)
[217.777996] Starting subtest: syncobj-timeline-chain-engines
[217.812263] Subtest syncobj-timeline-chain-engines: SUCCESS (0.035s)
[218.039304] [048/138] (775s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[218.123590] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[218.124965] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[218.216867] [049/138] (775s left) kms_prop_blob (basic)
[218.254453] Starting subtest: basic
[218.255160] Subtest basic: SUCCESS (0.000s)
[218.326198] [050/138] (774s left) api_intel_bb (object-noreloc-purge-cache-simple)
[218.363524] Starting subtest: object-noreloc-purge-cache-simple
[218.366247] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.003s)
[218.482890] [051/138] (774s left) gem_softpin (zero)
[218.529794] Starting subtest: zero
[218.531289] Subtest zero: SUCCESS (0.002s)
[218.634295] [052/138] (774s left) gem_ctx_param (vm)
[218.676144] Starting subtest: vm
[218.689556] Subtest vm: SUCCESS (0.014s)
[218.805306] [053/138] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[218.891297] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[221.428716] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.540s)
[221.586489] [054/138] (771s left) syncobj_timeline (signal)
[221.619586] Starting subtest: signal
[221.620309] Subtest signal: SUCCESS (0.000s)
[221.700143] [055/138] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[221.784824] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[221.786248] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[221.872235] [056/138] (771s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[221.961999] Starting subtest: x-tiled-8bpp-rotate-180
[223.307132] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.345s)
[223.453733] [057/138] (769s left) perf_pmu (busy)
[223.494434] Starting subtest: busy
[223.495148] Starting dynamic subtest: rcs0
[224.042356] Dynamic subtest rcs0: SUCCESS (0.547s)
[224.051807] Starting dynamic subtest: bcs0
[224.575307] Dynamic subtest bcs0: SUCCESS (0.533s)
[224.584734] Starting dynamic subtest: vcs0
[225.108264] Dynamic subtest vcs0: SUCCESS (0.533s)
[225.117614] Starting dynamic subtest: vecs0
[225.641254] Dynamic subtest vecs0: SUCCESS (0.533s)
[225.642458] Subtest busy: SUCCESS (2.147s)
[225.722270] [058/138] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[225.807885] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[228.411229] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.605s)
[228.576497] [059/138] (764s left) kms_pm_rpm (i2c)
[229.971922] Starting subtest: i2c
[232.137428] Subtest i2c: SUCCESS (2.165s)
[232.339378] [060/138] (761s left) gem_softpin (noreloc-interruptible)
[232.378139] Starting subtest: noreloc-interruptible
[237.782786] Subtest noreloc-interruptible: SUCCESS (5.404s)
[237.889836] [061/138] (755s left) prime_mmap_kms (buffer-sharing)
[237.969877] Starting subtest: buffer-sharing
[238.221196] Subtest buffer-sharing: SUCCESS (0.251s)
[238.359650] [062/138] (755s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[238.456946] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[238.458289] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[238.574564] [063/138] (754s left) prime_udl
[238.648559] [064/138] (754s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[238.732883] Starting subtest: cursor-rapid-movement-32x32
[238.760387] Subtest cursor-rapid-movement-32x32: SKIP (0.027s)
[238.878972] [065/138] (754s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[238.961069] Subtest mark-purgeable-twice: SKIP (0.000s)
[239.029328] [066/138] (754s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs)
[239.179056] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs
[239.180366] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[239.289960] [067/138] (754s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[239.373718] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[239.375144] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[239.472466] [068/138] (754s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[239.612747] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[239.666941] [069/138] (754s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[239.760812] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[239.762228] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.862413] [070/138] (753s left) gem_exec_reloc (basic-cpu-wc)
[239.902490] Subtest basic-cpu-wc: SKIP (0.000s)
[239.961776] [071/138] (753s left) sysfs_heartbeat_interval (precise)
[240.002510] Starting subtest: precise
[240.003195] Starting dynamic subtest: vecs0
[241.483640] Dynamic subtest vecs0: SUCCESS (1.480s)
[241.491423] Starting dynamic subtest: vcs0
[242.940763] Dynamic subtest vcs0: SUCCESS (1.457s)
[242.948377] Starting dynamic subtest: bcs0
[244.411677] Dynamic subtest bcs0: SUCCESS (1.471s)
[244.420429] Starting dynamic subtest: rcs0
[245.884628] Dynamic subtest rcs0: SUCCESS (1.473s)
[245.885524] Subtest precise: SUCCESS (5.882s)
[245.951042] [072/138] (747s left) gem_exec_schedule (promotion)
[246.000742] Starting subtest: promotion
[246.001429] Starting dynamic subtest: rcs0
[246.046212] Dynamic subtest rcs0: SUCCESS (0.045s)
[246.055216] Starting dynamic subtest: bcs0
[246.094971] Dynamic subtest bcs0: SUCCESS (0.048s)
[246.110937] Starting dynamic subtest: vcs0
[246.152881] Dynamic subtest vcs0: SUCCESS (0.057s)
[246.168761] Starting dynamic subtest: vecs0
[246.212825] Dynamic subtest vecs0: SUCCESS (0.059s)
[246.213929] Subtest promotion: SUCCESS (0.212s)
[246.551435] [073/138] (747s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[246.628105] Starting subtest: basic-flip-after-cursor-varying-size
[247.673652] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.046s)
[247.814762] [074/138] (745s left) tools_test (sysfs_l3_parity)
[247.852921] Starting subtest: sysfs_l3_parity
[247.896200] Subtest sysfs_l3_parity: SKIP (0.047s)
[247.966918] [075/138] (745s left) kms_invalid_mode (bad-vtotal)
[248.050827] Starting subtest: bad-vtotal
[248.051594] Starting dynamic subtest: pipe-A-HDMI-A-1
[248.093102] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.042s)
[248.098218] Starting dynamic subtest: pipe-B-HDMI-A-1
[248.098900] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[248.099569] Subtest bad-vtotal: SUCCESS (0.044s)
[248.244302] [076/138] (745s left) kms_flip (nonblocking-read)
[248.325961] Starting subtest: nonblocking-read
[248.326926] Subtest nonblocking-read: SUCCESS (0.000s)
[248.413555] [077/138] (745s left) kms_getfb (getfb2-into-addfb2)
[248.456158] Starting subtest: getfb2-into-addfb2
[248.456863] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[248.567210] [078/138] (745s left) drm_fdinfo (most-busy-idle-check-all)
[248.609896] Starting subtest: most-busy-idle-check-all
[248.610602] Starting dynamic subtest: rcs0
[249.231290] Dynamic subtest rcs0: SUCCESS (0.621s)
[249.240998] Starting dynamic subtest: bcs0
[249.847322] Dynamic subtest bcs0: SUCCESS (0.615s)
[249.856963] Starting dynamic subtest: vcs0
[250.464247] Dynamic subtest vcs0: SUCCESS (0.616s)
[250.473969] Starting dynamic subtest: vecs0
[251.076243] Dynamic subtest vecs0: SUCCESS (0.611s)
[251.077418] Subtest most-busy-idle-check-all: SUCCESS (2.466s)
[251.155751] [079/138] (742s left) kms_addfb_basic (unused-handle)
[251.190259] Starting subtest: unused-handle
[251.190946] Subtest unused-handle: SUCCESS (0.000s)
[251.356469] [080/138] (742s left) kms_chamelium_frames (dp-crc-multiple)
[251.506136] Subtest dp-crc-multiple: SKIP (0.000s)
[251.561531] [081/138] (742s left) i915_query (query-topology-garbage-items)
[251.595857] Starting subtest: query-topology-garbage-items
[251.596613] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[251.677298] [082/138] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[251.768780] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[251.770170] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[251.861720] [083/138] (742s left) gem_exec_nop (basic-parallel)
[251.908139] Starting subtest: basic-parallel
[254.951939] Subtest basic-parallel: SUCCESS (3.045s)
[255.190638] [084/138] (738s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[255.232680] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[255.259429] [085/138] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[255.347168] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[255.348607] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[255.451339] [086/138] (738s left) kms_content_protection (content-type-change)
[255.546637] Starting subtest: content-type-change
[255.690790] Subtest content-type-change: SKIP (0.141s)
[255.860849] [087/138] (738s left) gem_exec_whisper (basic-sync-all)
[255.907366] Starting subtest: basic-sync-all
[257.419106] Subtest basic-sync-all: SUCCESS (1.512s)
[257.627051] [088/138] (736s left) gem_shrink (reclaim)
[257.670679] Starting subtest: reclaim
[259.995664] Subtest reclaim: SUCCESS (2.325s)
[260.119311] [089/138] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[260.249451] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[260.250797] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[260.359072] [090/138] (733s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-mc-ccs)
[260.499343] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs
[260.500662] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[260.609413] [091/138] (733s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[260.702160] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[260.703499] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[260.808411] [092/138] (733s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[260.892837] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[260.895152] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.001s)
[260.996801] [093/138] (733s left) gem_render_copy_redux (flink)
[261.043560] Starting subtest: flink
[261.777915] Subtest flink: SUCCESS (0.734s)
[261.889989] [094/138] (732s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[261.972808] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[261.974202] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[262.080807] [095/138] (732s left) perf (unprivileged-single-ctx-counters)
[262.206261] Starting subtest: unprivileged-single-ctx-counters
[262.207625] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[262.227188] [096/138] (732s left) gem_mmap_wc (bad-size)
[262.266885] Starting subtest: bad-size
[262.267607] Subtest bad-size: SUCCESS (0.000s)
[262.364454] [097/138] (731s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[262.401314] Starting subtest: invalid-multi-wait-all-unsubmitted
[262.402037] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[262.472876] [098/138] (731s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[262.549072] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[262.549845] Starting dynamic subtest: pipe-A-valid-mode
[263.449445] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.900s)
[263.450131] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.901s)
[263.598439] [099/138] (730s left) gem_busy (semaphore)
[263.773025] Starting subtest: semaphore
[263.773879] Starting dynamic subtest: rcs0
[263.828342] Dynamic subtest rcs0: SUCCESS (0.057s)
[263.838160] Starting dynamic subtest: bcs0
[263.849262] Dynamic subtest bcs0: SUCCESS (0.020s)
[263.862585] Starting dynamic subtest: vcs0
[263.870088] Dynamic subtest vcs0: SUCCESS (0.020s)
[263.879897] Starting dynamic subtest: vecs0
[263.889999] Dynamic subtest vecs0: SUCCESS (0.019s)
[263.890969] Subtest semaphore: SUCCESS (0.120s)
[264.112211] [100/138] (730s left) perf (invalid-remove-userspace-config)
[264.214502] Starting subtest: invalid-remove-userspace-config
[264.222976] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[264.240383] [101/138] (730s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[264.306143] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[264.375881] [102/138] (730s left) gem_exec_schedule (implicit-write-read)
[264.415900] Starting subtest: implicit-write-read
[264.416607] Starting dynamic subtest: rcs0
[264.460618] Dynamic subtest rcs0: SUCCESS (0.044s)
[264.471576] Starting dynamic subtest: bcs0
[264.509533] Dynamic subtest bcs0: SUCCESS (0.048s)
[264.521888] Starting dynamic subtest: vcs0
[264.560980] Dynamic subtest vcs0: SUCCESS (0.051s)
[264.570182] Starting dynamic subtest: vecs0
[264.607951] Dynamic subtest vecs0: SUCCESS (0.046s)
[264.609400] Subtest implicit-write-read: SUCCESS (0.192s)
[264.928110] [103/138] (729s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[264.963372] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[265.000976] [104/138] (729s left) kms_vblank (ts-continuation-idle-hang)
[265.084386] Starting subtest: ts-continuation-idle-hang
[265.085142] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.022331] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.936s)
[279.031087] Starting dynamic subtest: pipe-B-HDMI-A-1
[292.832068] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (13.808s)
[292.832834] Subtest ts-continuation-idle-hang: SUCCESS (27.748s)
[292.983767] [105/138] (701s left) v3d/v3d_submit_cl (single-in-sync)
[293.045734] Subtest single-in-sync: SKIP (0.000s)
[293.114967] [106/138] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[293.203341] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[293.204761] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[293.326661] [107/138] (701s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-mc-ccs)
[293.456515] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs
[293.457908] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[293.587761] [108/138] (700s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[293.732593] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[293.733943] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[293.854066] [109/138] (700s left) gem_userptr_blits (sync-overlap)
[293.902712] Starting subtest: sync-overlap
[293.903383] Subtest sync-overlap: SUCCESS (0.000s)
[294.025737] [110/138] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[294.119973] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[294.121446] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[294.234530] [111/138] (700s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[294.277078] Starting subtest: yf-tiled-to-vebox-x-tiled
[294.277783] Starting dynamic subtest: smem
[294.385908] Dynamic subtest smem: SUCCESS (0.109s)
[294.386593] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.109s)
[294.568973] [112/138] (700s left) syncobj_basic (test-valid-cycle)
[294.601782] Starting subtest: test-valid-cycle
[294.602515] Subtest test-valid-cycle: SUCCESS (0.000s)
[294.687840] [113/138] (699s left) kms_ccs (pipe-a-bad-pixel-format-yf-tiled-ccs)
[294.772266] Starting subtest: pipe-A-bad-pixel-format-yf-tiled-ccs
[294.773742] Subtest pipe-A-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[294.946971] [114/138] (699s left) kms_async_flips (invalid-async-flip)
[295.037056] Starting subtest: invalid-async-flip
[295.203961] Starting dynamic subtest: pipe-A-HDMI-A-1
[295.265678] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.061s)
[295.440186] Starting dynamic subtest: pipe-B-HDMI-A-1
[295.481727] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.046s)
[295.487491] Subtest invalid-async-flip: SUCCESS (0.447s)
[295.726340] [115/138] (699s left) gem_exec_await (wide-all)
[295.784205] Starting subtest: wide-all
[317.792987] Subtest wide-all: SUCCESS (22.008s)
[318.005843] [116/138] (676s left) v3d/v3d_perfmon (create-single-perfmon)
[318.128272] Subtest create-single-perfmon: SKIP (0.000s)
[318.199924] [117/138] (676s left) kms_psr (psr2_sprite_mmap_gtt)
[318.235644] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[318.272428] [118/138] (676s left) syncobj_wait (invalid-signal-illegal-handle)
[318.309577] Starting subtest: invalid-signal-illegal-handle
[318.310297] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[318.387043] [119/138] (676s left) v3d/v3d_submit_csd (valid-submission)
[318.450413] Subtest valid-submission: SKIP (0.000s)
[318.523651] [120/138] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[318.617240] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[318.618700] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.732332] [121/138] (676s left) fbdev (pan)
[318.769108] Starting subtest: pan
[318.829988] Subtest pan: SUCCESS (0.060s)
[318.921407] [122/138] (675s left) i915_query (query-garbage)
[318.961531] Starting subtest: query-garbage
[318.962234] Subtest query-garbage: SUCCESS (0.000s)
[319.053993] [123/138] (675s left) gem_pxp (create-regular-context-2)
[321.603024] Subtest create-regular-context-2: SKIP (0.000s)
[321.683381] [124/138] (673s left) kms_flip (2x-wf_vblank-ts-check)
[321.762602] Starting subtest: 2x-wf_vblank-ts-check
[321.765863] Subtest 2x-wf_vblank-ts-check: SKIP (0.002s)
[321.883259] [125/138] (673s left) kms_plane_alpha_blend (alpha-transparent-fb)
[321.967665] Starting subtest: alpha-transparent-fb
[322.027376] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.537963] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.510s)
[322.544694] Starting dynamic subtest: pipe-B-HDMI-A-1
[323.058528] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.520s)
[323.059229] Subtest alpha-transparent-fb: SUCCESS (1.092s)
[323.203518] [126/138] (671s left) syncobj_timeline (host-signal-ordered)
[323.240214] Starting subtest: host-signal-ordered
[323.240940] Subtest host-signal-ordered: SUCCESS (0.000s)
[323.305865] [127/138] (671s left) kms_busy (extended-modeset-hang-oldfb)
[323.394531] Starting subtest: extended-modeset-hang-oldfb
[323.395341] Starting dynamic subtest: pipe-A
[337.049236] Dynamic subtest pipe-A: SUCCESS (13.653s)
[337.057775] Starting dynamic subtest: pipe-B
[351.314312] Dynamic subtest pipe-B: SUCCESS (14.263s)
[351.315135] Subtest extended-modeset-hang-oldfb: SUCCESS (27.921s)
[351.473552] [128/138] (643s left) kms_flip (2x-flip-vs-panning)
[351.551415] Starting subtest: 2x-flip-vs-panning
[351.554520] Subtest 2x-flip-vs-panning: SKIP (0.003s)
[351.663508] [129/138] (643s left) gem_exec_fence (nb-await)
[351.820196] Starting subtest: nb-await
[351.823395] Starting dynamic subtest: rcs0
[351.883664] Dynamic subtest rcs0: SUCCESS (0.062s)
[351.899870] Starting dynamic subtest: bcs0
[351.946112] Dynamic subtest bcs0: SUCCESS (0.061s)
[351.965769] Starting dynamic subtest: vcs0
[352.010259] Dynamic subtest vcs0: SUCCESS (0.063s)
[352.028064] Starting dynamic subtest: vecs0
[352.071268] Dynamic subtest vecs0: SUCCESS (0.059s)
[352.072441] Subtest nb-await: SUCCESS (0.252s)
[352.529979] [130/138] (642s left) kms_chamelium_color (ctm-0-50)
[352.616240] Subtest ctm-0-50: SKIP (0.000s)
[352.649713] [131/138] (642s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[352.736468] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[381.867529] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (29.131s)
[382.015530] [132/138] (613s left) kms_plane (pixel-format)
[382.101804] Starting subtest: pixel-format
[382.102528] Starting dynamic subtest: pipe-A
[393.364939] Dynamic subtest pipe-A: SUCCESS (11.263s)
[393.375299] Starting dynamic subtest: pipe-B
[404.556629] Dynamic subtest pipe-B: SUCCESS (11.189s)
[404.557344] Subtest pixel-format: SUCCESS (22.456s)
[404.722316] [133/138] (590s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-rc-ccs)
[404.873192] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[404.984328] [134/138] (590s left) gem_ctx_shared (q-smoketest)
[405.025871] Starting subtest: Q-smoketest
[405.026578] Starting dynamic subtest: rcs0
[410.461052] Dynamic subtest rcs0: SUCCESS (5.426s)
[410.467051] Starting dynamic subtest: bcs0
[415.884316] Dynamic subtest bcs0: SUCCESS (5.423s)
[415.890427] Starting dynamic subtest: vcs0
[421.307062] Dynamic subtest vcs0: SUCCESS (5.421s)
[421.313013] Starting dynamic subtest: vecs0
[426.728469] Dynamic subtest vecs0: SUCCESS (5.421s)
[426.729159] Subtest Q-smoketest: SUCCESS (21.694s)
[426.915899] [135/138] (568s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[427.065632] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs
[427.066991] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[427.182858] [136/138] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[427.265736] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[427.267110] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[427.373250] [137/138] (567s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[427.523486] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[427.633567] [138/138] (567s left) kms_tiled_display (basic-test-pattern)
[427.761303] Subtest basic-test-pattern: SKIP (0.000s)
[427.775921] Closing watchdogs
Done.