[38.898638] Initializing watchdogs
[38.898950]   /dev/watchdog0
[38.914608] [001/142] (960s left) fbdev (eof)
[39.157950] Starting subtest: eof
[39.159526] Subtest eof: SUCCESS (0.002s)
[39.224119] [002/142] (960s left) kms_chamelium_hpd (vga-hpd)
[39.626890] Subtest vga-hpd: SKIP (0.000s)
[39.921934] [003/142] (959s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs)
[40.317114] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs
[40.319743] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[40.889650] [004/142] (958s left) gem_exec_params (sol-reset-invalid)
[41.114401] Starting subtest: sol-reset-invalid
[41.127713] Subtest sol-reset-invalid: SUCCESS (0.012s)
[41.239601] [005/142] (958s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[41.931416] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[42.252068] [006/142] (957s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs)
[42.900262] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs
[42.905309] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[43.289142] [007/142] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[43.613396] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[43.616031] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[43.722249] [008/142] (955s left) kms_flip (flip-vs-absolute-wf_vblank)
[44.013193] Starting subtest: flip-vs-absolute-wf_vblank
[44.014513] Starting dynamic subtest: A-DP1
[55.100689] Dynamic subtest A-DP1: SUCCESS (11.086s)
[55.115516] Starting dynamic subtest: B-DP1
[65.874542] Dynamic subtest B-DP1: SUCCESS (10.773s)
[65.888444] Starting dynamic subtest: C-DP1
[76.627357] Dynamic subtest C-DP1: SUCCESS (10.752s)
[76.628569] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.618s)
[77.028944] [009/142] (922s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[77.358116] Starting subtest: fbc-1p-pri-indfb-multidraw
[92.626029] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (15.270s)
[92.742426] [010/142] (906s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[93.010981] Subtest bad-multisync-out-sync: SKIP (0.000s)
[93.075298] [011/142] (906s left) gem_mmap_gtt (basic-read-write-distinct)
[93.280993] Starting subtest: basic-read-write-distinct
[93.312968] Subtest basic-read-write-distinct: SUCCESS (0.033s)
[93.423715] [012/142] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[93.735603] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[93.738210] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[93.826458] [013/142] (905s left) gem_exec_whisper (basic-contexts-forked)
[94.057202] Starting subtest: basic-contexts-forked
[108.984293] Subtest basic-contexts-forked: SUCCESS (14.925s)
[109.178402] [014/142] (890s left) perf (invalid-create-userspace-config)
[109.525893] Starting subtest: invalid-create-userspace-config
[109.531250] Subtest invalid-create-userspace-config: SUCCESS (0.007s)
[109.577594] [015/142] (890s left) sw_sync (sync_multi_producer_single_consumer)
[109.781870] Starting subtest: sync_multi_producer_single_consumer
[110.863449] Subtest sync_multi_producer_single_consumer: SUCCESS (1.081s)
[110.931596] [016/142] (888s left) dmabuf_sync_file (import-multiple-read-only)
[111.210856] Starting subtest: import-multiple-read-only
[111.221622] Subtest import-multiple-read-only: SUCCESS (0.012s)
[111.296430] [017/142] (888s left) kms_big_fb (linear-64bpp-rotate-90)
[111.624394] Starting subtest: linear-64bpp-rotate-90
[111.721434] Subtest linear-64bpp-rotate-90: SKIP (0.095s)
[111.829189] [018/142] (888s left) gem_mmap_gtt (hang-user)
[112.033464] Starting subtest: hang-user
[127.207395] Subtest hang-user: SUCCESS (15.170s)
[127.314637] [019/142] (872s left) gem_fenced_exec_thrash (no-spare-fences)
[127.530492] Starting subtest: no-spare-fences
[129.692105] Subtest no-spare-fences: SUCCESS (2.160s)
[129.848546] [020/142] (870s left) v3d/v3d_get_param (get-bad-flags)
[130.110889] Subtest get-bad-flags: SKIP (0.000s)
[130.180526] [021/142] (869s left) gem_exec_balancer (bonded-dual)
[130.409719] Starting subtest: bonded-dual
[134.164249] Subtest bonded-dual: SUCCESS (3.753s)
[138.100760] [022/142] (862s left) api_intel_bb (blit-reloc-purge-cache)
[138.308080] Starting subtest: blit-reloc-purge-cache
[138.329244] Subtest blit-reloc-purge-cache: SUCCESS (0.022s)
[138.428685] [023/142] (861s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[139.023673] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[139.026430] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[139.415624] [024/142] (860s left) gem_spin_batch (user-each)
[139.644721] Starting subtest: user-each
[143.058400] Subtest user-each: SUCCESS (3.414s)
[143.299788] [025/142] (856s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[143.506420] Starting subtest: multi-wait-all-for-submit-signaled
[143.508187] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[143.599771] [026/142] (856s left) kms_flip (dpms-vs-vblank-race)
[143.894240] Starting subtest: dpms-vs-vblank-race
[143.895480] Starting dynamic subtest: A-DP1
[148.251554] Dynamic subtest A-DP1: SUCCESS (4.358s)
[148.269951] Starting dynamic subtest: B-DP1
[152.561548] Dynamic subtest B-DP1: SUCCESS (4.307s)
[152.580126] Starting dynamic subtest: C-DP1
[156.797859] Dynamic subtest C-DP1: SUCCESS (4.235s)
[156.799210] Subtest dpms-vs-vblank-race: SUCCESS (12.908s)
[157.171678] [027/142] (843s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[157.479443] Starting subtest: primary-yf-tiled-reflect-x-270
[157.481963] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.003s)
[157.568575] [028/142] (842s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[158.217560] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[158.222899] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.004s)
[158.547128] [029/142] (841s left) i915_suspend (fence-restore-untiled)
[158.748759] Starting subtest: fence-restore-untiled
[178.611058] Subtest fence-restore-untiled: SUCCESS (4.191s)
[182.740569] [030/142] (837s left) gem_exec_flush (basic-wb-pro-default)
[182.978710] Starting subtest: basic-wb-pro-default
[188.463580] Subtest basic-wb-pro-default: SUCCESS (5.485s)
[188.669577] [031/142] (831s left) vc4/vc4_mmap (mmap-bo)
[188.926442] Subtest mmap-bo: SKIP (0.000s)
[189.000478] [032/142] (831s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[189.219802] Starting subtest: yf-tiled-ccs-to-x-tiled
[189.221322] Starting dynamic subtest: smem
[189.530534] Dynamic subtest smem: SUCCESS (0.309s)
[189.531843] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.310s)
[189.735962] [033/142] (830s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[190.033420] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[190.034806] Starting dynamic subtest: pipe-A-DP-1
[191.157637] Dynamic subtest pipe-A-DP-1: SUCCESS (1.124s)
[191.183924] Starting dynamic subtest: pipe-B-DP-1
[192.644122] Dynamic subtest pipe-B-DP-1: SUCCESS (1.483s)
[192.668856] Starting dynamic subtest: pipe-C-DP-1
[193.698550] Dynamic subtest pipe-C-DP-1: SUCCESS (1.050s)
[193.699871] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.668s)
[194.112108] [034/142] (826s left) gem_render_tiled_blits (basic)
[194.327752] Starting subtest: basic
[194.435485] Subtest basic: SUCCESS (0.107s)
[194.494347] [035/142] (825s left) kms_addfb_basic (unused-pitches)
[194.695580] Starting subtest: unused-pitches
[194.696874] Subtest unused-pitches: SUCCESS (0.000s)
[194.894978] [036/142] (825s left) kms_prop_blob (blob-prop-core)
[195.097494] Starting subtest: blob-prop-core
[195.099156] Subtest blob-prop-core: SUCCESS (0.000s)
[195.194398] [037/142] (825s left) kms_vblank (pipe-b-wait-busy-hang)
[195.495577] Starting subtest: pipe-B-wait-busy-hang
[202.669309] Subtest pipe-B-wait-busy-hang: SUCCESS (7.171s)
[203.012789] [038/142] (817s left) i915_pm_rpm (fences)
[204.819086] Starting subtest: fences
[207.714686] Subtest fences: SUCCESS (2.895s)
[207.936635] [039/142] (812s left) gem_blits (basic)
[208.151633] Starting subtest: basic
[221.956517] Subtest basic: SUCCESS (13.803s)
[222.067541] [040/142] (798s left) prime_busy (after)
[222.279308] Starting subtest: after
[222.295947] Starting dynamic subtest: rcs0
[222.306558] Dynamic subtest rcs0: SUCCESS (0.011s)
[222.334419] Starting dynamic subtest: bcs0
[222.335865] Dynamic subtest bcs0: SUCCESS (0.017s)
[222.358976] Starting dynamic subtest: vcs0
[222.360495] Dynamic subtest vcs0: SUCCESS (0.014s)
[222.381699] Starting dynamic subtest: vecs0
[222.383026] Dynamic subtest vecs0: SUCCESS (0.020s)
[222.478734] Subtest after: SUCCESS (0.199s)
[222.569587] [041/142] (798s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a)
[222.870536] Starting subtest: universal-plane-pageflip-windowed-pipe-A
[223.272763] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.403s)
[223.599581] [042/142] (797s left) kms_psr (psr2_primary_blt)
[223.805609] Subtest psr2_primary_blt: SKIP (0.000s)
[223.865943] [043/142] (796s left) vc4/vc4_wait_bo (unused-bo-1ns)
[224.125608] Subtest unused-bo-1ns: SKIP (0.000s)
[224.199299] [044/142] (796s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[224.525553] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[224.528299] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[224.633899] [045/142] (796s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[224.934237] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[224.935516] Starting dynamic subtest: pipe-A-valid-mode
[225.628769] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.693s)
[225.630117] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.696s)
[225.971327] [046/142] (794s left) kms_invalid_mode (bad-vsync-end)
[226.285625] Starting subtest: bad-vsync-end
[226.287017] Starting dynamic subtest: DP-1-pipe-A
[226.385425] Dynamic subtest DP-1-pipe-A: SUCCESS (0.101s)
[226.417029] Starting dynamic subtest: DP-1-pipe-B
[226.418888] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[226.441575] Starting dynamic subtest: DP-1-pipe-C
[226.443504] Dynamic subtest DP-1-pipe-C: SUCCESS (0.015s)
[226.445417] Subtest bad-vsync-end: SUCCESS (0.141s)
[226.762374] [047/142] (794s left) syncobj_timeline (wait-all-snapshot)
[226.967866] Starting subtest: wait-all-snapshot
[227.051377] Subtest wait-all-snapshot: SUCCESS (0.083s)
[227.144349] [048/142] (793s left) kms_vblank (pipe-a-ts-continuation-dpms-rpm)
[227.449065] Starting subtest: pipe-A-ts-continuation-dpms-rpm
[229.323661] Subtest pipe-A-ts-continuation-dpms-rpm: SUCCESS (1.872s)
[229.763424] [049/142] (791s left) sysfs_timeslice_duration (invalid)
[229.976412] Starting subtest: invalid
[229.980246] Starting dynamic subtest: vecs0
[229.981767] Dynamic subtest vecs0: SUCCESS (0.001s)
[230.006277] Starting dynamic subtest: vcs0
[230.007501] Dynamic subtest vcs0: SUCCESS (0.001s)
[230.029401] Starting dynamic subtest: bcs0
[230.030704] Dynamic subtest bcs0: SUCCESS (0.001s)
[230.052725] Starting dynamic subtest: rcs0
[230.054085] Dynamic subtest rcs0: SUCCESS (0.001s)
[230.055461] Subtest invalid: SUCCESS (0.016s)
[230.086435] [050/142] (790s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[230.391534] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[230.394333] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.496841] [051/142] (790s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[231.156066] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[231.474047] [052/142] (789s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[232.191759] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[232.523865] [053/142] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[232.848038] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[235.228782] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.383s)
[235.360714] [054/142] (785s left) gem_ctx_bad_destroy (double-destroy)
[235.566418] Starting subtest: double-destroy
[235.568120] Subtest double-destroy: SUCCESS (0.000s)
[235.656546] [055/142] (785s left) debugfs_test (sysfs)
[235.865320] Starting subtest: sysfs
[236.148541] Subtest sysfs: SUCCESS (0.283s)
[236.340983] [056/142] (784s left) gem_exec_reloc (basic-cpu-gtt-active)
[236.556882] Starting subtest: basic-cpu-gtt-active
[236.705598] Subtest basic-cpu-gtt-active: SUCCESS (0.148s)
[236.891366] [057/142] (784s left) kms_color (legacy-gamma-reset)
[237.199542] Starting subtest: legacy-gamma-reset
[237.200844] Starting dynamic subtest: pipe-A
[237.674749] Dynamic subtest pipe-A: SUCCESS (0.473s)
[237.702745] Starting dynamic subtest: pipe-B
[238.051559] Dynamic subtest pipe-B: SUCCESS (0.377s)
[238.091463] Starting dynamic subtest: pipe-C
[238.434493] Dynamic subtest pipe-C: SUCCESS (0.383s)
[238.435864] Subtest legacy-gamma-reset: SUCCESS (1.239s)
[238.744126] [058/142] (782s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[239.058987] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[239.060389] Starting dynamic subtest: pipe-A-valid-mode
[239.735306] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.675s)
[239.736967] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.679s)
[240.089676] [059/142] (781s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[240.406412] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[242.460328] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.057s)
[242.589108] [060/142] (778s left) perf_pmu (faulting-read)
[242.803287] Starting subtest: faulting-read
[242.804723] Starting dynamic subtest: gtt
[242.809435] Dynamic subtest gtt: SUCCESS (0.005s)
[242.833817] Starting dynamic subtest: wb
[242.835086] Dynamic subtest wb: SUCCESS (0.003s)
[242.856989] Starting dynamic subtest: wc
[242.858290] Dynamic subtest wc: SUCCESS (0.001s)
[242.880136] Starting dynamic subtest: uc
[242.881479] Dynamic subtest uc: SUCCESS (0.001s)
[242.882676] Subtest faulting-read: SUCCESS (0.019s)
[242.922603] [061/142] (778s left) gem_mmap_gtt (hang)
[243.127167] Starting subtest: hang
[248.627878] Subtest hang: SUCCESS (5.503s)
[248.745175] [062/142] (772s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[248.972788] Starting subtest: writes-after-reads-snoop
[270.112773] Subtest writes-after-reads-snoop: SUCCESS (21.139s)
[270.222587] [063/142] (751s left) gem_exec_capture (userptr)
[270.438986] Starting subtest: userptr
[271.732039] Subtest userptr: SUCCESS (1.294s)
[271.822807] [064/142] (749s left) kms_fence_pin_leak
[276.132296] [065/142] (745s left) kms_big_fb (x-tiled-addfb)
[276.449902] Starting subtest: x-tiled-addfb
[276.451464] Subtest x-tiled-addfb: SUCCESS (0.000s)
[276.564977] [066/142] (745s left) gem_ctx_persistence (engines-cleanup)
[276.777708] Starting subtest: engines-cleanup
[276.779307] Starting dynamic subtest: rcs0
[276.815964] Dynamic subtest rcs0: SUCCESS (0.038s)
[276.847148] Starting dynamic subtest: bcs0
[276.856105] Dynamic subtest bcs0: SUCCESS (0.037s)
[276.885507] Starting dynamic subtest: vcs0
[276.893328] Dynamic subtest vcs0: SUCCESS (0.032s)
[276.916848] Starting dynamic subtest: vecs0
[276.932014] Dynamic subtest vecs0: SUCCESS (0.038s)
[276.933831] Subtest engines-cleanup: SUCCESS (0.156s)
[277.032048] [067/142] (744s left) kms_atomic (plane-immutable-zpos)
[277.458028] Starting subtest: plane-immutable-zpos
[277.684833] Subtest plane-immutable-zpos: SUCCESS (0.227s)
[278.126482] [068/142] (743s left) gem_exec_reloc (basic-cpu-noreloc)
[278.343705] Starting subtest: basic-cpu-noreloc
[278.351585] Subtest basic-cpu-noreloc: SUCCESS (0.010s)
[278.560743] [069/142] (743s left) kms_frontbuffer_tracking (basic)
[278.876110] Starting subtest: basic
[281.747431] Subtest basic: SUCCESS (2.874s)
[281.877291] [070/142] (739s left) i915_pm_rps (thresholds-park)
[282.090826] Starting subtest: thresholds-park
[282.092413] Starting dynamic subtest: gt0
[282.099019] Dynamic subtest gt0: SKIP (0.005s)
[282.102179] Subtest thresholds-park: SKIP (0.007s)
[282.210133] [071/142] (739s left) syncobj_wait (invalid-reset-one-illegal-handle)
[282.419005] Starting subtest: invalid-reset-one-illegal-handle
[282.420593] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[282.509780] [072/142] (739s left) kms_cursor_crc (cursor-onscreen-32x32)
[282.814310] Starting subtest: cursor-onscreen-32x32
[282.937531] Subtest cursor-onscreen-32x32: SKIP (0.121s)
[283.061328] [073/142] (738s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[283.370171] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[283.372881] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[283.478001] [074/142] (738s left) gem_mmap_offset (pf-nonblock)
[283.681905] Starting subtest: pf-nonblock
[283.696468] Subtest pf-nonblock: SUCCESS (0.015s)
[283.811239] [075/142] (738s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[284.109830] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[284.113684] Starting dynamic subtest: pipe-A-DP-1
[284.197382] Dynamic subtest pipe-A-DP-1: SUCCESS (0.085s)
[284.224516] Starting dynamic subtest: pipe-B-DP-1
[284.587615] Dynamic subtest pipe-B-DP-1: SUCCESS (0.385s)
[284.649382] Starting dynamic subtest: pipe-C-DP-1
[284.689241] Dynamic subtest pipe-C-DP-1: SKIP (0.092s)
[284.690769] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.578s)
[285.110716] [076/142] (736s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[285.415262] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[285.420405] Starting dynamic subtest: A-DP1
[286.679717] Dynamic subtest A-DP1: SUCCESS (1.251s)
[286.704907] Starting dynamic subtest: B-DP1
[287.738186] Dynamic subtest B-DP1: SUCCESS (1.062s)
[287.761827] Starting dynamic subtest: C-DP1
[288.799527] Dynamic subtest C-DP1: SUCCESS (1.059s)
[288.807844] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.387s)
[289.145478] [077/142] (733s left) gem_exec_schedule (preempt-queue-contexts-chain)
[289.385318] Starting subtest: preempt-queue-contexts-chain
[289.389664] Starting dynamic subtest: rcs0
[290.496675] Dynamic subtest rcs0: SUCCESS (1.107s)
[290.524689] Starting dynamic subtest: bcs0
[291.568741] Dynamic subtest bcs0: SUCCESS (1.070s)
[291.597492] Starting dynamic subtest: vcs0
[292.670771] Dynamic subtest vcs0: SUCCESS (1.100s)
[292.709668] Starting dynamic subtest: vecs0
[293.719623] Dynamic subtest vecs0: SUCCESS (1.045s)
[293.721123] Subtest preempt-queue-contexts-chain: SUCCESS (4.334s)
[294.077743] [078/142] (728s left) gem_ctx_isolation (preservation-s3)
[294.305846] Starting subtest: preservation-S3
[294.307428] Starting dynamic subtest: rcs0
[313.353480] Dynamic subtest rcs0: SUCCESS (2.339s)
[313.382181] Starting dynamic subtest: bcs0
[332.388497] Dynamic subtest bcs0: SUCCESS (2.675s)
[332.418711] Starting dynamic subtest: vcs0
[351.284958] Dynamic subtest vcs0: SUCCESS (2.223s)
[351.312537] Starting dynamic subtest: vecs0
[370.282722] Dynamic subtest vecs0: SUCCESS (2.319s)
[370.284306] Subtest preservation-S3: SUCCESS (9.570s)
[374.583690] [079/142] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[374.897250] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[374.899761] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[375.011331] [080/142] (717s left) kms_getfb (getfb2-handle-zero)
[375.215012] Starting subtest: getfb2-handle-zero
[375.216691] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[375.325777] [081/142] (717s left) kms_addfb_basic (basic)
[375.524593] Starting subtest: basic
[375.526279] Subtest basic: SUCCESS (0.000s)
[375.742749] [082/142] (717s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[376.272562] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[376.275195] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[376.729759] [083/142] (716s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[379.447447] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[379.545982] [084/142] (713s left) gem_exec_reloc (basic-range)
[379.755453] Starting subtest: basic-range
[379.842160] Subtest basic-range: SUCCESS (0.085s)
[380.030402] [085/142] (712s left) prime_self_import (basic-llseek-bad)
[380.223896] Starting subtest: basic-llseek-bad
[380.230349] Subtest basic-llseek-bad: SUCCESS (0.005s)
[380.329246] [086/142] (712s left) kms_busy (basic-hang)
[380.634803] Starting subtest: basic-hang
[380.639140] Starting dynamic subtest: flip-pipe-A
[381.365751] Dynamic subtest flip-pipe-A: SUCCESS (0.726s)
[381.393053] Starting dynamic subtest: modeset-pipe-A
[382.979802] Dynamic subtest modeset-pipe-A: SUCCESS (1.611s)
[383.015313] Starting dynamic subtest: flip-pipe-C
[383.819214] Dynamic subtest flip-pipe-C: SUCCESS (0.829s)
[383.846330] Starting dynamic subtest: modeset-pipe-C
[385.421364] Dynamic subtest modeset-pipe-C: SUCCESS (1.605s)
[385.422673] Subtest basic-hang: SUCCESS (4.790s)
[385.795781] [087/142] (707s left) gem_exec_fence (syncobj-timeline-chain-engines)
[386.604651] Starting subtest: syncobj-timeline-chain-engines
[386.740182] Subtest syncobj-timeline-chain-engines: SUCCESS (0.135s)
[386.978236] [088/142] (706s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[387.301000] Starting subtest: yf-tiled-16bpp-rotate-90
[387.406199] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.102s)
[387.526630] [089/142] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[387.834318] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[387.836976] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[387.944147] [090/142] (705s left) kms_psr (dpms)
[388.144601] Subtest dpms: SKIP (0.000s)
[388.209599] [091/142] (705s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[388.531254] Starting subtest: y-tiled-addfb-size-offset-overflow
[388.534155] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[388.644995] [092/142] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[388.955640] Starting subtest: fbc-rgb101010-draw-render
[391.595847] Subtest fbc-rgb101010-draw-render: SUCCESS (2.643s)
[391.729178] [093/142] (701s left) i915_hangman (gt-engine-error)
[391.953573] Starting subtest: gt-engine-error
[391.955308] Starting dynamic subtest: rcs0
[392.034687] Dynamic subtest rcs0: SUCCESS (0.080s)
[392.074407] Starting dynamic subtest: bcs0
[392.077240] Dynamic subtest bcs0: SKIP (0.002s)
[392.107895] Starting dynamic subtest: vcs0
[392.120568] Dynamic subtest vcs0: SUCCESS (0.078s)
[392.150517] Starting dynamic subtest: vecs0
[392.205625] Dynamic subtest vecs0: SUCCESS (0.082s)
[392.207097] Subtest gt-engine-error: SUCCESS (0.254s)
[392.326534] [094/142] (701s left) gem_pread (uncached)
[392.530922] Starting subtest: uncached
[397.224171] Subtest uncached: SUCCESS (4.693s)
[397.329588] [095/142] (696s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[397.631921] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[397.713500] [096/142] (695s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[397.953005] Starting subtest: y-tiled-to-vebox-x-tiled
[397.955986] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[398.162244] [097/142] (695s left) gem_workarounds (basic-read-context)
[398.405748] Starting subtest: basic-read-context
[398.435602] Subtest basic-read-context: SUCCESS (0.030s)
[398.565291] [098/142] (695s left) gem_ctx_shared (detached-shared-gtt)
[398.808632] Starting subtest: detached-shared-gtt
[400.963002] Subtest detached-shared-gtt: SUCCESS (2.152s)
[401.177663] [099/142] (692s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[401.389980] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[401.495859] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[401.592813] [100/142] (692s left) syncobj_timeline (etime-single-wait-submitted)
[401.803961] Starting subtest: etime-single-wait-submitted
[401.912710] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[402.010086] [101/142] (691s left) kms_cursor_edge_walk (128x128-top-edge)
[402.318189] Starting subtest: 128x128-top-edge
[402.319595] Starting dynamic subtest: pipe-A-DP-1
[405.949681] Dynamic subtest pipe-A-DP-1: SUCCESS (3.631s)
[405.980339] Starting dynamic subtest: pipe-C-DP-1
[409.438352] Dynamic subtest pipe-C-DP-1: SUCCESS (3.483s)
[409.439599] Subtest 128x128-top-edge: SUCCESS (7.124s)
[409.766940] [102/142] (683s left) kms_addfb_basic (size-max)
[410.074579] Starting subtest: size-max
[410.076132] Subtest size-max: SUCCESS (0.000s)
[410.180809] [103/142] (683s left) gen7_exec_parse (basic-offset)
[410.392654] Subtest basic-offset: SKIP (0.000s)
[410.463125] [104/142] (683s left) kms_chamelium_frames (hdmi-crc-single)
[410.870964] Subtest hdmi-crc-single: SKIP (0.000s)
[411.149210] [105/142] (682s left) kms_dp_aux_dev
[411.894363] [106/142] (682s left) i915_pm_rpm (modeset-non-lpsp-stress)
[413.695587] Starting subtest: modeset-non-lpsp-stress
[420.852084] Subtest modeset-non-lpsp-stress: SUCCESS (7.155s)
[421.045077] [107/142] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[421.356081] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[421.358768] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[421.476357] [108/142] (672s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_mc_ccs)
[422.150109] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[422.472387] [109/142] (671s left) kms_vblank (pipe-a-wait-forked-busy)
[422.771574] Starting subtest: pipe-A-wait-forked-busy
[425.239602] Subtest pipe-A-wait-forked-busy: SUCCESS (2.469s)
[425.583246] [110/142] (668s left) kms_lease (lease-uevent)
[425.882807] Starting subtest: lease-uevent
[426.900423] Subtest lease-uevent: SUCCESS (1.020s)
[426.999424] [111/142] (667s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs)
[427.436888] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs
[427.440947] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[428.041299] [112/142] (666s left) kms_vblank (pipe-a-ts-continuation-modeset)
[428.341297] Starting subtest: pipe-A-ts-continuation-modeset
[428.955398] Subtest pipe-A-ts-continuation-modeset: SUCCESS (0.618s)
[429.297812] [113/142] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[429.609560] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[429.612731] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[429.715259] [114/142] (664s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[430.031536] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[430.034388] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[430.148526] [115/142] (664s left) syncobj_timeline (multi-wait-all-available-submitted)
[430.354546] Starting subtest: multi-wait-all-available-submitted
[430.359146] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s)
[430.447681] [116/142] (663s left) syncobj_timeline (invalid-query-illegal-handle)
[430.656427] Starting subtest: invalid-query-illegal-handle
[430.658041] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[430.748278] [117/142] (663s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[431.061399] Starting subtest: psr-indfb-scaledprimary
[431.066539] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[431.181185] [118/142] (663s left) prime_vgem (busy)
[431.398129] Starting subtest: busy
[431.400095] Starting dynamic subtest: rcs0
[431.423781] Dynamic subtest rcs0: SUCCESS (0.024s)
[431.453397] Starting dynamic subtest: vcs0
[431.454667] Dynamic subtest vcs0: SUCCESS (0.017s)
[431.486371] Starting dynamic subtest: vecs0
[431.487739] Dynamic subtest vecs0: SUCCESS (0.021s)
[431.488938] Subtest busy: SUCCESS (0.070s)
[431.599031] [119/142] (662s left) kms_scaling_modes (scaling-mode-full)
[431.906763] Starting subtest: scaling-mode-full
[431.910110] Subtest scaling-mode-full: SKIP (0.001s)
[431.998137] [120/142] (662s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[432.318410] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[432.321628] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[432.414683] [121/142] (662s left) gem_exec_schedule (implicit-read-write)
[432.652160] Starting subtest: implicit-read-write
[432.657380] Starting dynamic subtest: rcs0
[432.795168] Dynamic subtest rcs0: SUCCESS (0.140s)
[432.828067] Starting dynamic subtest: bcs0
[432.941307] Dynamic subtest bcs0: SUCCESS (0.138s)
[432.973270] Starting dynamic subtest: vcs0
[433.071285] Dynamic subtest vcs0: SUCCESS (0.127s)
[433.100976] Starting dynamic subtest: vecs0
[433.203441] Dynamic subtest vecs0: SUCCESS (0.129s)
[433.206357] Subtest implicit-read-write: SUCCESS (0.550s)
[433.565667] [122/142] (661s left) i915_getparams_basic (basic-eu-total)
[433.770019] Starting subtest: basic-eu-total
[433.773122] Subtest basic-eu-total: SUCCESS (0.000s)
[433.864714] [123/142] (660s left) kms_force_connector_basic (force-edid)
[434.070403] Subtest force-edid: SKIP (0.000s)
[434.129544] [124/142] (660s left) gem_lmem_swapping (massive)
[434.341216] Subtest massive: SKIP (0.000s)
[434.396132] [125/142] (660s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_mc_ccs)
[434.907348] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs
[434.912568] Subtest pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[435.397191] [126/142] (659s left) kms_plane_alpha_blend (constant-alpha-max)
[435.709994] Starting subtest: constant-alpha-max
[436.014776] Starting dynamic subtest: pipe-A-DP-1
[436.772360] Dynamic subtest pipe-A-DP-1: FAIL (0.411s)
[436.796289] Starting dynamic subtest: pipe-C-DP-1
[437.437358] Dynamic subtest pipe-C-DP-1: FAIL (0.653s)
[437.438652] Subtest constant-alpha-max: FAIL (1.380s)
[437.546705] [127/142] (657s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[438.206870] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[438.209533] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[438.571560] [128/142] (656s left) kms_vblank (pipe-d-ts-continuation-suspend)
[438.875494] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[438.971308] [129/142] (656s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[439.433895] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[439.436561] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[440.029166] [130/142] (655s left) kms_vblank (pipe-a-query-forked-busy-hang)
[440.333256] Starting subtest: pipe-A-query-forked-busy-hang
[447.048577] Subtest pipe-A-query-forked-busy-hang: SUCCESS (6.713s)
[447.398494] [131/142] (647s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[447.810451] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[447.814538] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[448.382682] [132/142] (646s left) gem_exec_fair (basic-none-vip)
[448.618387] Starting subtest: basic-none-vip
[448.622905] Starting dynamic subtest: rcs0
[454.495630] Dynamic subtest rcs0: SUCCESS (5.874s)
[454.497158] Subtest basic-none-vip: SUCCESS (5.877s)
[454.699517] [133/142] (640s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[455.266362] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[455.272753] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[455.709155] [134/142] (639s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[456.020220] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[470.712578] Subtest flip-vs-cursor-atomic-transitions-varying-size: FAIL (14.373s)
[470.748935] [135/142] (624s left) gem_exec_basic (basic)
[470.972599] Starting subtest: basic
[470.974261] Starting dynamic subtest: rcs0-smem
[470.978567] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[471.007691] Starting dynamic subtest: bcs0-smem
[471.009001] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[471.032625] Starting dynamic subtest: vcs0-smem
[471.034005] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[471.057669] Starting dynamic subtest: vecs0-smem
[471.058977] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[471.060166] Subtest basic: SUCCESS (0.020s)
[471.225782] [136/142] (624s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[471.538131] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[471.541069] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[471.642704] [137/142] (623s left) kms_atomic_transition (plane-all-modeset-transition)
[471.955930] Starting subtest: plane-all-modeset-transition
[471.960145] Starting dynamic subtest: pipe-A-DP-1
[530.039477] Dynamic subtest pipe-A-DP-1: SUCCESS (58.082s)
[530.188368] Starting dynamic subtest: pipe-B-DP-1
[588.061229] Dynamic subtest pipe-B-DP-1: SUCCESS (57.919s)
[588.160632] Subtest plane-all-modeset-transition: SUCCESS (116.206s)
[588.506400] [138/142] (506s left) gem_exec_schedule (u-submit-late-slice)
[588.751633] Starting subtest: u-submit-late-slice
[588.753191] Starting dynamic subtest: rcs0
[588.810459] Dynamic subtest rcs0: SUCCESS (0.057s)
[588.841376] Starting dynamic subtest: bcs0
[588.868209] Dynamic subtest bcs0: SUCCESS (0.055s)
[588.898038] Starting dynamic subtest: vcs0
[588.924050] Dynamic subtest vcs0: SUCCESS (0.053s)
[588.953961] Starting dynamic subtest: vecs0
[588.977753] Dynamic subtest vecs0: SUCCESS (0.050s)
[588.979588] Subtest u-submit-late-slice: SUCCESS (0.227s)
[589.340326] [139/142] (506s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[589.653681] Starting subtest: cursor-rapid-movement-32x32
[589.775410] Subtest cursor-rapid-movement-32x32: SKIP (0.120s)
[589.906061] [140/142] (505s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[590.223682] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[592.607706] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.386s)
[592.757249] [141/142] (502s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[593.068597] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[593.071573] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[593.173175] [142/142] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[593.492251] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[593.495271] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[593.601953] Closing watchdogs
Done.