[39.597906] Initializing watchdogs
[39.598058]   /dev/watchdog0
[39.606109] [001/132] (960s left) gem_softpin (evict-prime)
[39.693198] Starting subtest: evict-prime
[39.695633] Starting dynamic subtest: rcs0
[40.863956] Dynamic subtest rcs0: SUCCESS (1.171s)
[40.879107] Starting dynamic subtest: bcs0
[41.981408] Dynamic subtest bcs0: SUCCESS (1.117s)
[41.993022] Starting dynamic subtest: vcs0
[43.474695] Dynamic subtest vcs0: SUCCESS (1.492s)
[43.486833] Starting dynamic subtest: vcs1
[45.522890] Dynamic subtest vcs1: SUCCESS (2.048s)
[45.534678] Starting dynamic subtest: vecs0
[47.511943] Dynamic subtest vecs0: SUCCESS (1.989s)
[47.523327] Starting dynamic subtest: ccs0
[48.619888] Dynamic subtest ccs0: SUCCESS (1.110s)
[48.629587] Starting dynamic subtest: all
[50.447950] Dynamic subtest all: SUCCESS (1.826s)
[50.450740] Subtest evict-prime: SUCCESS (10.753s)
[50.519538] [002/132] (949s left) kms_psr (psr2-suspend)
[50.611209] Starting subtest: psr2-suspend
[50.613680] Starting dynamic subtest: eDP-1
[68.560726] Dynamic subtest eDP-1: SUCCESS (2.952s)
[68.563539] Subtest psr2-suspend: SUCCESS (2.953s)
[69.477775] [003/132] (945s left) kms_plane (pixel-format)
[69.565316] Starting subtest: pixel-format
[69.567798] Starting dynamic subtest: pipe-A
[79.684330] Dynamic subtest pipe-A: SUCCESS (10.116s)
[79.698678] Starting dynamic subtest: pipe-B
[90.650235] Dynamic subtest pipe-B: SUCCESS (10.964s)
[90.652714] Subtest pixel-format: SUCCESS (21.083s)
[91.551887] [004/132] (923s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[91.629912] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[91.676792] [005/132] (923s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[91.773873] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[91.778473] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.852261] [006/132] (923s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[91.945235] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[91.949836] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[92.029873] [007/132] (923s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[92.098330] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[92.199033] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[92.268305] [008/132] (923s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[92.353441] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[92.357221] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[92.420335] [009/132] (922s left) sw_sync (sync_expired_merge)
[92.454983] Starting subtest: sync_expired_merge
[93.528891] Subtest sync_expired_merge: SUCCESS (1.074s)
[93.586100] [010/132] (921s left) gem_exec_reloc (basic-write-cpu-active)
[93.659421] Subtest basic-write-cpu-active: SKIP (0.000s)
[93.695551] [011/132] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[93.787792] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[99.452085] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (5.669s)
[99.592362] [012/132] (915s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[99.710330] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[100.462676] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.753s)
[100.600877] [013/132] (914s left) kms_pm_dc (dc5-psr)
[101.704671] Starting subtest: dc5-psr
[105.098264] Subtest dc5-psr: SUCCESS (3.394s)
[106.022844] [014/132] (909s left) gem_mmap_gtt (big-copy)
[106.101551] Subtest big-copy: SKIP (0.000s)
[106.147784] [015/132] (909s left) kms_feature_discovery (psr2)
[106.233367] Starting subtest: psr2
[106.235716] Subtest psr2: SUCCESS (0.000s)
[106.296680] [016/132] (909s left) kms_cursor_crc (cursor-sliding-512x512)
[106.565253] Starting subtest: cursor-sliding-512x512
[106.570149] Subtest cursor-sliding-512x512: SKIP (0.001s)
[106.695272] [017/132] (908s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[107.090152] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[107.979938] [018/132] (907s left) i915_pm_rps (thresholds-idle)
[108.052541] Starting subtest: thresholds-idle
[108.055132] Starting dynamic subtest: gt0
[108.064505] Dynamic subtest gt0: SKIP (0.009s)
[108.078033] Starting dynamic subtest: gt1
[108.084046] Dynamic subtest gt1: SKIP (0.001s)
[108.089900] Subtest thresholds-idle: SKIP (0.011s)
[108.134102] [019/132] (907s left) api_intel_allocator (default-alignment)
[108.215520] Starting subtest: default-alignment
[108.222252] Subtest default-alignment: SUCCESS (0.007s)
[108.317368] [020/132] (907s left) gem_pxp (protected-raw-src-copy-not-readible)
[110.970257] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[111.003696] [021/132] (904s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[111.110506] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[111.115229] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[111.209170] [022/132] (904s left) kms_cursor_crc (cursor-offscreen-128x128)
[111.428044] Starting subtest: cursor-offscreen-128x128
[111.433938] Starting dynamic subtest: pipe-A-eDP-1
[113.479527] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.047s)
[113.505608] Starting dynamic subtest: pipe-D-eDP-1
[116.275241] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[116.277310] Subtest cursor-offscreen-128x128: SUCCESS (4.846s)
[117.155795] [023/132] (898s left) gem_fence_thrash (bo-write-verify-x)
[117.206413] Starting subtest: bo-write-verify-x
[117.225527] Subtest bo-write-verify-x: SKIP (0.016s)
[117.259250] [024/132] (898s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[117.348867] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[118.449336] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.104s)
[118.607189] [025/132] (897s left) v3d/v3d_submit_cl (valid-multisync-submission)
[118.667665] Subtest valid-multisync-submission: SKIP (0.000s)
[118.719257] [026/132] (897s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[118.801778] Starting subtest: plane-upscale-20x20-with-modifiers
[118.803824] Starting dynamic subtest: pipe-A-eDP-1
[119.337414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[119.354138] Starting dynamic subtest: pipe-B-eDP-1
[121.008157] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.668s)
[121.023839] Starting dynamic subtest: pipe-C-eDP-1
[122.672132] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.662s)
[122.690394] Starting dynamic subtest: pipe-D-eDP-1
[124.336080] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.661s)
[124.338597] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (5.535s)
[125.620106] [027/132] (890s left) gem_exec_schedule (wide)
[125.830237] Starting subtest: wide
[125.832559] Starting dynamic subtest: rcs0
[135.696546] Dynamic subtest rcs0: SUCCESS (9.814s)
[135.709687] Starting dynamic subtest: vcs0
[145.478263] Dynamic subtest vcs0: SUCCESS (9.830s)
[145.499187] Starting dynamic subtest: vcs1
[156.525000] Dynamic subtest vcs1: SUCCESS (11.050s)
[156.541837] Starting dynamic subtest: vecs0
[166.267153] Dynamic subtest vecs0: SUCCESS (9.741s)
[166.284392] Starting dynamic subtest: ccs0
[178.393402] Dynamic subtest ccs0: SUCCESS (12.125s)
[178.395586] Subtest wide: SUCCESS (52.563s)
[179.127560] [028/132] (836s left) gem_exec_whisper (basic-sync)
[179.203022] Starting subtest: basic-sync
[188.767562] Subtest basic-sync: SUCCESS (9.542s)
[188.930559] [029/132] (826s left) gem_ctx_exec (basic-invalid-context)
[189.003964] Starting subtest: basic-invalid-context
[189.015735] Subtest basic-invalid-context: SUCCESS (0.014s)
[189.100355] [030/132] (826s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[189.173984] Starting subtest: invalid-single-wait-all-unsubmitted
[189.176958] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[189.262360] [031/132] (826s left) gem_ctx_persistence (hostile)
[189.348851] Starting subtest: hostile
[194.516030] Subtest hostile: SUCCESS (5.163s)
[194.615542] [032/132] (821s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[194.687596] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[194.690322] Starting dynamic subtest: pipe-A-eDP-1
[194.734364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.047s)
[194.743646] Starting dynamic subtest: pipe-B-eDP-1
[195.959440] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.224s)
[195.975166] Starting dynamic subtest: pipe-C-eDP-1
[197.177812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[197.195374] Starting dynamic subtest: pipe-D-eDP-1
[198.326511] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[198.329156] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (3.640s)
[199.531299] [033/132] (816s left) kms_flip (plain-flip-fb-recreate)
[199.625295] Starting subtest: plain-flip-fb-recreate
[199.627837] Starting dynamic subtest: A-eDP1
[208.612925] Dynamic subtest A-eDP1: SUCCESS (8.988s)
[208.630135] Starting dynamic subtest: B-eDP1
[217.639540] Dynamic subtest B-eDP1: SUCCESS (9.025s)
[217.655685] Starting dynamic subtest: C-eDP1
[226.650760] Dynamic subtest C-eDP1: SUCCESS (9.010s)
[226.666793] Starting dynamic subtest: D-eDP1
[235.601104] Dynamic subtest D-eDP1: SUCCESS (8.949s)
[235.609486] Subtest plain-flip-fb-recreate: SUCCESS (35.986s)
[236.907177] [034/132] (779s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[236.998228] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[237.001007] Starting dynamic subtest: pipe-A-default-mode
[237.287569] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[237.292776] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.287s)
[238.192330] [035/132] (777s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[238.288229] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[238.291010] Starting dynamic subtest: pipe-A-eDP-1
[238.766950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[238.782013] Starting dynamic subtest: pipe-B-eDP-1
[240.363794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.598s)
[240.380470] Starting dynamic subtest: pipe-C-eDP-1
[242.048063] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.682s)
[242.064930] Starting dynamic subtest: pipe-D-eDP-1
[243.702344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.653s)
[243.705055] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (5.416s)
[244.924562] [036/132] (771s left) kms_vblank (ts-continuation-dpms-suspend)
[244.996761] Starting subtest: ts-continuation-dpms-suspend
[244.999375] Starting dynamic subtest: pipe-A-eDP-1
[261.685844] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.806s)
[261.704568] Starting dynamic subtest: pipe-D-eDP-1
[279.673955] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[279.676870] Subtest ts-continuation-dpms-suspend: SUCCESS (4.365s)
[280.593787] [037/132] (765s left) gen7_exec_parse (bitmasks)
[280.679203] Subtest bitmasks: SKIP (0.000s)
[280.744864] [038/132] (765s left) gem_userptr_blits (dmabuf-unsync)
[280.835455] Subtest dmabuf-unsync: SKIP (0.000s)
[280.958805] [039/132] (765s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[281.067657] Starting subtest: x-tiled-16bpp-rotate-180
[282.436530] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.369s)
[282.581678] [040/132] (763s left) kms_psr (fbc-psr2-dpms)
[282.661041] Starting subtest: fbc-psr2-dpms
[282.663019] Starting dynamic subtest: eDP-1
[282.666874] Dynamic subtest eDP-1: SKIP (0.000s)
[282.670726] Subtest fbc-psr2-dpms: SKIP (0.001s)
[282.730007] [041/132] (763s left) gem_userptr_blits (mmap-offset-banned)
[282.819027] Starting subtest: mmap-offset-banned
[282.821018] Starting dynamic subtest: gtt
[282.824949] Dynamic subtest gtt: SKIP (0.000s)
[282.832380] Starting dynamic subtest: wb
[282.834873] Dynamic subtest wb: SUCCESS (0.000s)
[282.841143] Starting dynamic subtest: wc
[282.842741] Dynamic subtest wc: SUCCESS (0.000s)
[282.848374] Starting dynamic subtest: uc
[282.849887] Dynamic subtest uc: SUCCESS (0.000s)
[282.851418] Subtest mmap-offset-banned: SUCCESS (0.005s)
[282.928422] [042/132] (763s left) gem_exec_flush (basic-uc-pro-default)
[283.003496] Starting subtest: basic-uc-pro-default
[288.467245] Subtest basic-uc-pro-default: SUCCESS (5.464s)
[288.656190] [043/132] (757s left) kms_selftest (drm_framebuffer)
[288.737213] Starting subtest: drm_framebuffer
[288.746884] Starting dynamic subtest: drm_test_framebuffer_create
[288.760223] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.015s)
[288.762165] Subtest drm_framebuffer: SUCCESS (0.023s)
[288.885461] [044/132] (757s left) testdisplay
[289.158655] [045/132] (757s left) kms_addfb_basic (size-max)
[289.272480] Starting subtest: size-max
[289.275099] Subtest size-max: SUCCESS (0.000s)
[289.353235] [046/132] (757s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[289.474815] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[294.306924] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.833s)
[294.413122] [047/132] (752s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[294.511216] Starting subtest: cursorB-vs-flipB-atomic
[294.516719] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[294.610652] [048/132] (752s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[294.712598] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[294.715309] Starting dynamic subtest: pipe-A-default-mode
[295.006017] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[295.011040] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.290s)
[295.881966] [049/132] (750s left) gem_exec_schedule (in-order)
[295.977158] Starting subtest: in-order
[295.979264] Starting dynamic subtest: rcs0
[296.082983] Dynamic subtest rcs0: SUCCESS (0.111s)
[296.100758] Starting dynamic subtest: vcs0
[296.177739] Dynamic subtest vcs0: SUCCESS (0.094s)
[296.190636] Starting dynamic subtest: vcs1
[296.263871] Dynamic subtest vcs1: SUCCESS (0.085s)
[296.275987] Starting dynamic subtest: vecs0
[296.354068] Dynamic subtest vecs0: SUCCESS (0.089s)
[296.368105] Starting dynamic subtest: ccs0
[296.473081] Dynamic subtest ccs0: SUCCESS (0.118s)
[296.475699] Subtest in-order: SUCCESS (0.502s)
[297.909778] [050/132] (748s left) gem_exec_balancer (parallel-keep-submit-fence)
[298.190022] Starting subtest: parallel-keep-submit-fence
[299.172863] Subtest parallel-keep-submit-fence: SUCCESS (0.983s)
[299.256474] [051/132] (747s left) gem_eio (throttle)
[299.518116] Starting subtest: throttle
[299.888828] Subtest throttle: SUCCESS (0.372s)
[299.999238] [052/132] (746s left) gem_reg_read (timestamp-moving)
[300.089560] Starting subtest: timestamp-moving
[301.089738] Subtest timestamp-moving: SUCCESS (1.001s)
[301.163015] [053/132] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[301.251008] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[301.255010] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[301.338223] [054/132] (745s left) gem_mmap_gtt (cpuset-big-copy-xy)
[301.408388] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[301.462237] [055/132] (745s left) drm_fdinfo (virtual-idle)
[301.519659] Starting subtest: virtual-idle
[304.553728] Subtest virtual-idle: SUCCESS (3.032s)
[304.631982] [056/132] (742s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[304.725477] Starting subtest: psr-dirtyfb-ioctl
[304.727888] Starting dynamic subtest: A-eDP-1
[306.442325] Dynamic subtest A-eDP-1: SUCCESS (1.714s)
[306.445374] Subtest psr-dirtyfb-ioctl: SUCCESS (1.715s)
[307.346095] [057/132] (739s left) gem_fenced_exec_thrash (too-many-fences)
[307.436738] Subtest too-many-fences: SKIP (0.000s)
[307.490869] [058/132] (739s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[307.573385] Starting subtest: fbc-rgb101010-draw-mmap-wc
[311.215942] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.644s)
[311.314682] [059/132] (735s left) kms_rotation_crc (cursor-rotation-180)
[311.398850] Starting subtest: cursor-rotation-180
[313.095805] Subtest cursor-rotation-180: SUCCESS (1.698s)
[314.379477] [060/132] (732s left) sw_sync (alloc_merge_fence)
[314.428279] Starting subtest: alloc_merge_fence
[314.431574] Subtest alloc_merge_fence: SUCCESS (0.000s)
[314.470025] [061/132] (732s left) prime_mmap (test_errors)
[314.548923] Starting subtest: test_errors
[314.551865] Starting dynamic subtest: test_errors-smem
[314.633176] Dynamic subtest test_errors-smem: SUCCESS (0.086s)
[314.636477] Subtest test_errors: SUCCESS (0.087s)
[314.726019] [062/132] (732s left) kms_psr (fbc-psr-cursor-plane-onoff)
[314.825791] Starting subtest: fbc-psr-cursor-plane-onoff
[314.828210] Starting dynamic subtest: eDP-1
[314.832705] Dynamic subtest eDP-1: SKIP (0.000s)
[314.837160] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[314.895221] [063/132] (732s left) dmabuf_sync_file (import-multiple-read-write)
[314.970282] Starting subtest: import-multiple-read-write
[314.972896] Subtest import-multiple-read-write: SUCCESS (0.004s)
[315.021514] [064/132] (732s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[315.124984] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[315.129524] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[315.206945] [065/132] (732s left) gem_exec_schedule (u-fairslice)
[315.302908] Starting subtest: u-fairslice
[315.304915] Starting dynamic subtest: rcs0
[317.370230] Dynamic subtest rcs0: SUCCESS (2.025s)
[317.388868] Starting dynamic subtest: bcs0
[319.356977] Dynamic subtest bcs0: SUCCESS (2.034s)
[319.370816] Starting dynamic subtest: vcs0
[321.390257] Dynamic subtest vcs0: SUCCESS (2.034s)
[321.405657] Starting dynamic subtest: vcs1
[323.469459] Dynamic subtest vcs1: SUCCESS (2.030s)
[323.486685] Starting dynamic subtest: vecs0
[325.453084] Dynamic subtest vecs0: SUCCESS (2.029s)
[325.468939] Starting dynamic subtest: ccs0
[327.490777] Dynamic subtest ccs0: SUCCESS (2.035s)
[327.493416] Subtest u-fairslice: SUCCESS (12.193s)
[327.797078] [066/132] (719s left) prime_mmap (test_dup)
[327.867170] Starting subtest: test_dup
[327.869893] Starting dynamic subtest: test_dup-smem
[327.895216] Dynamic subtest test_dup-smem: SUCCESS (0.030s)
[327.898176] Subtest test_dup: SUCCESS (0.031s)
[327.961087] [067/132] (719s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[328.081150] Starting subtest: 2x-cursor-vs-flip-atomic
[328.086677] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[328.226218] [068/132] (719s left) intel_hwmon (hwmon-write)
[328.315632] Subtest hwmon-write: SKIP (0.000s)
[328.370817] [069/132] (719s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[328.447569] Subtest writes-after-reads-uncached: SKIP (0.000s)
[328.519593] [070/132] (718s left) vc4/vc4_mmap (mmap-bad-handle)
[328.589599] Subtest mmap-bad-handle: SKIP (0.000s)
[328.638093] [071/132] (718s left) prime_busy (hang)
[328.705021] Starting subtest: hang
[328.707651] Starting dynamic subtest: rcs0
[342.329660] Dynamic subtest rcs0: SUCCESS (13.622s)
[342.336349] Starting dynamic subtest: bcs0
[349.484806] Dynamic subtest bcs0: SUCCESS (7.154s)
[349.491354] Starting dynamic subtest: vcs0
[356.463383] Dynamic subtest vcs0: SUCCESS (6.981s)
[356.480576] Starting dynamic subtest: vcs1
[363.431669] Dynamic subtest vcs1: SUCCESS (6.967s)
[363.449193] Starting dynamic subtest: vecs0
[370.473049] Dynamic subtest vecs0: SUCCESS (7.038s)
[370.490322] Starting dynamic subtest: ccs0
[384.314928] Dynamic subtest ccs0: SUCCESS (13.842s)
[384.317571] Subtest hang: SUCCESS (55.607s)
[384.416273] [072/132] (663s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[384.474391] Starting subtest: single-wait-for-submit-unsubmitted
[384.573666] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[384.654517] [073/132] (662s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[385.032684] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[385.903094] [074/132] (661s left) kms_invalid_mode (bad-hsync-start)
[386.000413] Starting subtest: bad-hsync-start
[386.003012] Starting dynamic subtest: pipe-A-eDP-1
[386.295183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[386.316941] Starting dynamic subtest: pipe-B-eDP-1
[386.319715] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[386.338771] Starting dynamic subtest: pipe-C-eDP-1
[386.341345] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[386.356468] Starting dynamic subtest: pipe-D-eDP-1
[386.358650] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[386.360885] Subtest bad-hsync-start: SUCCESS (0.306s)
[387.216340] [075/132] (660s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[387.275439] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[387.278028] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[387.358592] [076/132] (660s left) kms_atomic (test-only)
[387.437505] Starting subtest: test-only
[387.488187] Starting dynamic subtest: pipe-A-eDP-1
[390.150588] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.665s)
[390.156570] Subtest test-only: SUCCESS (2.719s)
[391.056010] [077/132] (656s left) core_setmaster (master-drop-set-shared-fd)
[391.706589] Starting subtest: master-drop-set-shared-fd
[391.729063] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[391.757771] [078/132] (655s left) kms_chamelium_color (ctm-0-25)
[391.858404] Subtest ctm-0-25: SKIP (0.000s)
[391.875950] [079/132] (655s left) gem_reg_read (timestamp-monotonic)
[391.945215] Starting subtest: timestamp-monotonic
[396.282644] Subtest timestamp-monotonic: SUCCESS (4.338s)
[396.348396] [080/132] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[396.469617] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[396.474089] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[396.555702] [081/132] (651s left) kms_plane (planar-pixel-format-settings)
[396.616870] Starting subtest: planar-pixel-format-settings
[396.661446] Subtest planar-pixel-format-settings: SUCCESS (0.042s)
[396.756411] [082/132] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[396.856037] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[396.860333] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[396.939443] [083/132] (650s left) perf_pmu (all-busy-check-all)
[397.019053] Starting subtest: all-busy-check-all
[398.802979] Subtest all-busy-check-all: SUCCESS (1.785s)
[398.886502] [084/132] (648s left) perf (blocking-parameterized)
[399.032253] Starting subtest: blocking-parameterized
[419.113316] Subtest blocking-parameterized: SUCCESS (20.029s)
[419.145333] [085/132] (628s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[419.225401] Starting subtest: framebuffer-vs-set-tiling
[419.229564] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[419.332066] [086/132] (628s left) i915_pm_rps (fence-order)
[419.410076] Starting subtest: fence-order
[420.997447] Subtest fence-order: SUCCESS (1.585s)
[421.043668] [087/132] (626s left) gem_basic (create-fd-close)
[421.090095] Starting subtest: create-fd-close
[421.094854] Subtest create-fd-close: SUCCESS (0.000s)
[421.165301] [088/132] (626s left) kms_psr (psr-primary-page-flip)
[421.269648] Starting subtest: psr-primary-page-flip
[421.272103] Starting dynamic subtest: eDP-1
[423.106670] Dynamic subtest eDP-1: SUCCESS (1.839s)
[423.109663] Subtest psr-primary-page-flip: SUCCESS (1.841s)
[424.018086] [089/132] (623s left) gem_busy (extended)
[424.211866] Starting subtest: extended
[424.214882] Starting dynamic subtest: rcs0
[424.292880] Dynamic subtest rcs0: SUCCESS (0.081s)
[424.311893] Starting dynamic subtest: bcs0
[424.337979] Dynamic subtest bcs0: SUCCESS (0.043s)
[424.356258] Starting dynamic subtest: vcs0
[425.746252] Dynamic subtest vcs0: SUCCESS (1.406s)
[425.764887] Starting dynamic subtest: vcs1
[427.795164] Dynamic subtest vcs1: SUCCESS (2.047s)
[427.813584] Starting dynamic subtest: vecs0
[429.778656] Dynamic subtest vecs0: SUCCESS (1.982s)
[429.796752] Starting dynamic subtest: ccs0
[429.828757] Dynamic subtest ccs0: SUCCESS (0.049s)
[429.832173] Subtest extended: SUCCESS (5.617s)
[430.031172] [090/132] (617s left) gem_ctx_persistence (engines-hang)
[430.114421] Starting subtest: engines-hang
[430.117122] Starting dynamic subtest: rcs0
[430.235914] Dynamic subtest rcs0: SUCCESS (0.121s)
[430.253548] Starting dynamic subtest: bcs0
[430.329914] Dynamic subtest bcs0: SUCCESS (0.093s)
[430.348016] Starting dynamic subtest: vcs0
[430.420236] Dynamic subtest vcs0: SUCCESS (0.089s)
[430.438328] Starting dynamic subtest: vcs1
[430.494886] Dynamic subtest vcs1: SUCCESS (0.074s)
[430.512887] Starting dynamic subtest: vecs0
[430.602778] Dynamic subtest vecs0: SUCCESS (0.107s)
[430.620529] Starting dynamic subtest: ccs0
[430.686876] Dynamic subtest ccs0: SUCCESS (0.083s)
[430.689484] Subtest engines-hang: SUCCESS (0.573s)
[430.768274] [091/132] (617s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[430.854747] Starting subtest: yf-tiled-ccs-to-y-tiled
[430.859916] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[431.044320] [092/132] (616s left) v3d/v3d_wait_bo (bad-bo)
[431.127389] Subtest bad-bo: SKIP (0.000s)
[431.179253] [093/132] (616s left) perf_pmu (busy-idle)
[431.250979] Starting subtest: busy-idle
[431.253879] Starting dynamic subtest: rcs0
[431.951773] Dynamic subtest rcs0: SUCCESS (0.702s)
[431.970196] Starting dynamic subtest: bcs0
[432.622630] Dynamic subtest bcs0: SUCCESS (0.669s)
[432.640812] Starting dynamic subtest: vcs0
[433.813510] Dynamic subtest vcs0: SUCCESS (1.185s)
[433.831279] Starting dynamic subtest: vcs1
[435.794669] Dynamic subtest vcs1: SUCCESS (1.982s)
[435.812854] Starting dynamic subtest: vecs0
[437.779043] Dynamic subtest vecs0: SUCCESS (1.982s)
[437.798071] Starting dynamic subtest: ccs0
[438.447920] Dynamic subtest ccs0: SUCCESS (0.668s)
[438.450765] Subtest busy-idle: SUCCESS (7.200s)
[438.535397] [094/132] (609s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[438.627129] Starting subtest: plane-all-modeset-transition-internal-panels
[438.629579] Starting dynamic subtest: pipe-A-eDP-1
[440.339164] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.710s)
[440.670302] Starting dynamic subtest: pipe-B-eDP-1
[442.059734] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[442.368269] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (3.740s)
[443.280731] [095/132] (604s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[443.392969] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[448.362962] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.972s)
[448.459231] [096/132] (599s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[448.536248] Starting subtest: fbc-tiling-linear
[451.229916] Subtest fbc-tiling-linear: SUCCESS (2.698s)
[451.352536] [097/132] (596s left) kms_cursor_crc (cursor-random-256x85)
[451.610396] Starting subtest: cursor-random-256x85
[451.647848] Subtest cursor-random-256x85: SKIP (0.032s)
[451.810221] [098/132] (596s left) kms_psr (pr-primary-blt)
[451.907541] Starting subtest: pr-primary-blt
[451.911601] Subtest pr-primary-blt: SKIP (0.000s)
[451.968151] [099/132] (596s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[452.034874] Starting subtest: basic-max-pipe-crc-check
[452.038361] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[452.064073] [100/132] (596s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[452.118411] Starting subtest: single-wait-for-submit-available-submitted
[452.120768] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[452.192859] [101/132] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[452.276529] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[452.280528] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[452.362001] [102/132] (595s left) syncobj_wait (reset-signaled)
[452.438523] Starting subtest: reset-signaled
[452.440688] Subtest reset-signaled: SUCCESS (0.000s)
[452.529478] [103/132] (595s left) kms_psr2_sf (fbc-cursor-plane-move-continuous-exceed-fully-sf)
[457.827037] Starting subtest: fbc-cursor-plane-move-continuous-exceed-fully-sf
[457.829554] Starting dynamic subtest: psr2-pipe-A-eDP-1
[458.719459] Dynamic subtest psr2-pipe-A-eDP-1: SKIP (0.888s)
[458.737529] Starting dynamic subtest: psr2-pipe-B-eDP-1
[459.939042] Dynamic subtest psr2-pipe-B-eDP-1: SKIP (1.215s)
[459.943871] Subtest fbc-cursor-plane-move-continuous-exceed-fully-sf: SKIP (2.111s)
[461.268985] [104/132] (587s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[461.352228] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[461.354586] Starting dynamic subtest: pipe-A-eDP-1
[463.104926] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[463.112879] Starting dynamic subtest: pipe-B-eDP-1
[466.113323] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.006s)
[466.124647] Starting dynamic subtest: pipe-C-eDP-1
[469.084964] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.973s)
[469.102075] Starting dynamic subtest: pipe-D-eDP-1
[472.058714] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.972s)
[472.060992] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (10.710s)
[473.319883] [105/132] (575s left) gem_exec_reloc (basic-wc-read-noreloc)
[473.407378] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[473.473594] [106/132] (574s left) kms_tv_load_detect (load-detect)
[473.522133] Subtest load-detect: SKIP (0.000s)
[473.563685] [107/132] (574s left) gem_exec_reloc (basic-wc-gtt-active)
[473.645737] Subtest basic-wc-gtt-active: SKIP (0.000s)
[473.699914] [108/132] (574s left) i915_hangman (error-state-basic)
[473.758587] Starting subtest: error-state-basic
[473.933558] Subtest error-state-basic: SUCCESS (0.175s)
[474.009575] [109/132] (574s left) gem_madvise (dontneed-before-mmap)
[474.052065] Starting subtest: dontneed-before-mmap
[474.067360] Subtest dontneed-before-mmap: SUCCESS (0.017s)
[474.163218] [110/132] (574s left) gem_exec_balancer (bonded-dual)
[474.248164] Starting subtest: bonded-dual
[474.252055] Subtest bonded-dual: SKIP (0.000s)
[474.509161] [111/132] (574s left) kms_color (ctm-red-to-blue)
[474.581061] Starting subtest: ctm-red-to-blue
[474.583794] Starting dynamic subtest: pipe-A
[475.314230] Dynamic subtest pipe-A: SUCCESS (0.733s)
[475.332979] Starting dynamic subtest: pipe-B
[476.842880] Dynamic subtest pipe-B: SUCCESS (1.528s)
[476.860773] Starting dynamic subtest: pipe-C
[478.330900] Dynamic subtest pipe-C: SUCCESS (1.488s)
[478.350745] Starting dynamic subtest: pipe-D
[479.827297] Dynamic subtest pipe-D: SUCCESS (1.495s)
[479.829861] Subtest ctm-red-to-blue: SUCCESS (5.248s)
[480.725321] [112/132] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[480.817744] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[485.435542] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.624s)
[485.545408] [113/132] (563s left) gem_lmem_swapping (random-engines)
[485.612104] Subtest random-engines: SKIP (0.000s)
[485.655101] [114/132] (563s left) gem_eio (wait-wedge-immediate)
[485.898517] Starting subtest: wait-wedge-immediate
[487.914399] Subtest wait-wedge-immediate: SUCCESS (2.014s)
[488.026721] [115/132] (560s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[488.128864] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[488.131314] Starting dynamic subtest: pipe-A-eDP-1
[488.133721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[488.150276] Starting dynamic subtest: pipe-B-eDP-1
[488.152740] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[488.163724] Starting dynamic subtest: pipe-C-eDP-1
[488.166245] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[488.175012] Starting dynamic subtest: pipe-D-eDP-1
[488.177477] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[488.180323] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.012s)
[488.226190] [116/132] (560s left) syncobj_timeline (wait-delayed-signal)
[488.297011] Starting subtest: wait-delayed-signal
[488.399375] Subtest wait-delayed-signal: SUCCESS (0.102s)
[488.475180] [117/132] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[488.596952] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[488.601799] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[488.680906] [118/132] (560s left) syncobj_timeline (host-signal-points)
[488.727121] Starting subtest: host-signal-points
[488.729698] Subtest host-signal-points: SUCCESS (0.003s)
[488.810632] [119/132] (560s left) gem_eio (suspend)
[489.063879] Starting subtest: suspend
[501.006712] Subtest suspend: SUCCESS (11.940s)
[501.109530] [120/132] (547s left) gem_exec_fair (basic-none)
[501.206488] Subtest basic-none: SKIP (0.000s)
[501.252087] [121/132] (547s left) kms_properties (crtc-properties-legacy)
[501.341982] Starting subtest: crtc-properties-legacy
[505.503509] Subtest crtc-properties-legacy: SUCCESS (4.162s)
[506.387985] [122/132] (542s left) gem_exec_reloc (basic-write-wc-active)
[506.476819] Subtest basic-write-wc-active: SKIP (0.000s)
[506.521306] [123/132] (542s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[511.755988] Starting subtest: overlay-plane-update-continuous-sf
[511.759047] Starting dynamic subtest: psr2-pipe-A-eDP-1
[513.595258] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (1.837s)
[513.613720] Starting dynamic subtest: psr2-pipe-B-eDP-1
[515.436577] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (1.838s)
[515.439150] Subtest overlay-plane-update-continuous-sf: SUCCESS (3.682s)
[516.372404] [124/132] (532s left) gem_exec_parallel (userptr)
[516.456886] Starting subtest: userptr
[516.459363] Starting dynamic subtest: rcs0
[517.937600] Dynamic subtest rcs0: SUCCESS (1.479s)
[517.955509] Starting dynamic subtest: bcs0
[519.379289] Dynamic subtest bcs0: SUCCESS (1.441s)
[519.397180] Starting dynamic subtest: vcs0
[522.771379] Dynamic subtest vcs0: SUCCESS (3.388s)
[522.790611] Starting dynamic subtest: vcs1
[524.788649] Dynamic subtest vcs1: SUCCESS (2.016s)
[524.804326] Starting dynamic subtest: vecs0
[526.775587] Dynamic subtest vecs0: SUCCESS (1.987s)
[526.796113] Starting dynamic subtest: ccs0
[528.843943] Dynamic subtest ccs0: SUCCESS (2.043s)
[528.847074] Subtest userptr: SUCCESS (12.363s)
[529.015275] [125/132] (520s left) gem_mmap_wc (bad-offset)
[529.092897] Subtest bad-offset: SKIP (0.000s)
[529.148729] [126/132] (519s left) gem_exec_fence (submit)
[529.353056] Starting subtest: submit
[529.358444] Subtest submit: SKIP (0.000s)
[530.845477] [127/132] (518s left) kms_frontbuffer_tracking (psr-1p-rte)
[530.941543] Starting subtest: psr-1p-rte
[534.451256] Subtest psr-1p-rte: SUCCESS (3.517s)
[534.568143] [128/132] (514s left) kms_pm_rpm (modeset-non-lpsp)
[536.099775] Starting subtest: modeset-non-lpsp
[539.927253] Subtest modeset-non-lpsp: SKIP (3.825s)
[540.731537] [129/132] (508s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[540.839687] Starting subtest: psr-shrfb-scaledprimary
[544.654436] Subtest psr-shrfb-scaledprimary: SUCCESS (3.820s)
[544.757974] [130/132] (504s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[544.847539] Starting subtest: invalid-bsd1-flag-on-blt
[544.850562] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[544.945213] [131/132] (504s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[545.043712] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[545.047619] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[545.122088] [132/132] (504s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[545.216032] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[545.220529] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[545.288271] Closing watchdogs
Done.