[37.777580] Initializing watchdogs
[37.777651]   /dev/watchdog0
[37.784259] [001/142] (960s left) gem_gtt_cpu_tlb
[37.874491] [002/142] (960s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[39.887043] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[39.891108] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.003s)
[40.085219] [003/142] (958s left) i915_selftest (live)
[41.388022] Starting subtest: live
[41.389117] Starting dynamic subtest: sanitycheck
[42.243726] Dynamic subtest sanitycheck: SUCCESS (0.856s)
[42.248335] Starting dynamic subtest: uncore
[43.150937] Dynamic subtest uncore: SUCCESS (0.907s)
[43.156908] Starting dynamic subtest: workarounds
[45.582590] Dynamic subtest workarounds: SUCCESS (2.432s)
[45.586938] Starting dynamic subtest: gt_engines
[46.971976] Dynamic subtest gt_engines: SUCCESS (1.389s)
[46.978251] Starting dynamic subtest: gt_timelines
[96.178761] Dynamic subtest gt_timelines: SUCCESS (49.207s)
[96.183894] Starting dynamic subtest: gt_contexts
[97.097770] Dynamic subtest gt_contexts: SUCCESS (0.919s)
[97.102555] Starting dynamic subtest: gt_lrc
[103.193959] Dynamic subtest gt_lrc: SUCCESS (6.096s)
[103.199828] Starting dynamic subtest: gt_mocs
[104.786033] Dynamic subtest gt_mocs: SUCCESS (1.592s)
[104.792176] Starting dynamic subtest: gt_pm
[106.551842] Dynamic subtest gt_pm: SUCCESS (1.766s)
[106.557441] Starting dynamic subtest: gt_heartbeat
[107.539954] Dynamic subtest gt_heartbeat: SUCCESS (0.988s)
[107.546122] Starting dynamic subtest: gt_tlb
[117.804949] Dynamic subtest gt_tlb: SUCCESS (10.265s)
[117.811219] Starting dynamic subtest: requests
[127.991889] Dynamic subtest requests: SUCCESS (10.187s)
[127.997504] Starting dynamic subtest: migrate
[131.991829] Dynamic subtest migrate: SUCCESS (4.000s)
[131.997309] Starting dynamic subtest: active
[132.815900] Dynamic subtest active: SUCCESS (0.824s)
[132.820370] Starting dynamic subtest: objects
[134.794738] Dynamic subtest objects: SUCCESS (1.979s)
[134.799688] Starting dynamic subtest: mman
[138.146651] Dynamic subtest mman: SUCCESS (3.352s)
[138.150949] Starting dynamic subtest: dmabuf
[139.057745] Dynamic subtest dmabuf: SUCCESS (0.911s)
[139.062834] Starting dynamic subtest: vma
[139.908847] Dynamic subtest vma: SUCCESS (0.851s)
[139.914820] Starting dynamic subtest: coherency
[149.196928] Dynamic subtest coherency: SUCCESS (9.288s)
[149.202827] Starting dynamic subtest: gtt
[158.725795] Dynamic subtest gtt: SUCCESS (9.529s)
[158.731223] Starting dynamic subtest: gem
[159.670987] Dynamic subtest gem: SUCCESS (0.945s)
[159.677048] Starting dynamic subtest: evict
[171.574841] Dynamic subtest evict: SUCCESS (11.903s)
[171.579953] Starting dynamic subtest: hugepages
[188.217958] Dynamic subtest hugepages: SUCCESS (16.643s)
[188.224345] Starting dynamic subtest: gem_contexts
[214.715761] Dynamic subtest gem_contexts: SUCCESS (26.497s)
[214.720837] Starting dynamic subtest: client
[215.630950] Dynamic subtest client: SUCCESS (0.915s)
[215.637477] Starting dynamic subtest: gem_migrate
[217.630204] Dynamic subtest gem_migrate: SUCCESS (1.996s)
[217.635299] Starting dynamic subtest: reset
[218.497743] Dynamic subtest reset: SUCCESS (0.870s)
[218.503280] Starting dynamic subtest: memory_region
[220.910864] Dynamic subtest memory_region: SUCCESS (2.413s)
[220.916874] Starting dynamic subtest: hangcheck
[249.961798] Dynamic subtest hangcheck: SUCCESS (29.050s)
[249.967369] Starting dynamic subtest: execlists
[250.804097] Dynamic subtest execlists: SUCCESS (0.841s)
[250.810971] Starting dynamic subtest: ring_submission
[251.664840] Dynamic subtest ring_submission: SUCCESS (0.860s)
[251.670361] Starting dynamic subtest: perf
[252.640846] Dynamic subtest perf: SUCCESS (0.975s)
[252.645990] Starting dynamic subtest: slpc
[257.946851] Dynamic subtest slpc: SUCCESS (5.305s)
[257.952275] Starting dynamic subtest: guc
[260.686734] Dynamic subtest guc: SUCCESS (2.739s)
[260.691855] Starting dynamic subtest: guc_multi_lrc
[261.577854] Dynamic subtest guc_multi_lrc: SUCCESS (0.890s)
[261.585820] Starting dynamic subtest: guc_hang
[263.159882] Dynamic subtest guc_hang: SUCCESS (1.581s)
[263.166421] Starting dynamic subtest: late_gt_pm
[264.056825] Dynamic subtest late_gt_pm: SUCCESS (0.896s)
[264.058058] Subtest live: SUCCESS (222.669s)
[264.175084] [004/142] (734s left) gem_ctx_persistence (engines-persistence)
[265.650349] Starting subtest: engines-persistence
[265.651151] Starting dynamic subtest: rcs0
[266.433935] Dynamic subtest rcs0: SUCCESS (0.783s)
[266.439122] Starting dynamic subtest: bcs0
[267.192227] Dynamic subtest bcs0: SUCCESS (0.757s)
[267.198630] Starting dynamic subtest: vcs0
[267.960705] Dynamic subtest vcs0: SUCCESS (0.766s)
[267.970810] Starting dynamic subtest: vcs1
[268.712612] Dynamic subtest vcs1: SUCCESS (0.748s)
[268.727237] Starting dynamic subtest: vecs0
[269.480680] Dynamic subtest vecs0: SUCCESS (0.764s)
[269.482999] Subtest engines-persistence: SUCCESS (3.831s)
[270.508981] [005/142] (727s left) kms_prop_blob (blob-prop-core)
[270.577364] Starting subtest: blob-prop-core
[270.579777] Subtest blob-prop-core: SUCCESS (0.000s)
[270.698957] [006/142] (727s left) kms_flip (2x-flip-vs-wf_vblank)
[271.721546] Starting subtest: 2x-flip-vs-wf_vblank
[271.746620] Subtest 2x-flip-vs-wf_vblank: SKIP (0.025s)
[271.820854] [007/142] (726s left) kms_atomic (plane-immutable-zpos)
[274.123708] Starting subtest: plane-immutable-zpos
[274.578221] Subtest plane-immutable-zpos: SUCCESS (0.455s)
[274.722662] [008/142] (723s left) gem_exec_schedule (thriceslice)
[274.786034] Starting subtest: thriceslice
[274.786937] Starting dynamic subtest: rcs0
[274.814737] Dynamic subtest rcs0: SUCCESS (0.028s)
[274.820161] Starting dynamic subtest: bcs0
[274.843872] Dynamic subtest bcs0: SUCCESS (0.027s)
[274.874321] Starting dynamic subtest: vcs0
[274.898326] Dynamic subtest vcs0: SUCCESS (0.051s)
[274.914797] Starting dynamic subtest: vcs1
[274.961947] Dynamic subtest vcs1: SUCCESS (0.061s)
[274.973169] Starting dynamic subtest: vecs0
[274.997076] Dynamic subtest vecs0: SUCCESS (0.031s)
[274.999443] Subtest thriceslice: SUCCESS (0.212s)
[275.343812] [009/142] (723s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs)
[277.410938] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs
[277.412930] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[277.564871] [010/142] (720s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[277.624140] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[277.625048] Starting dynamic subtest: smem
[277.719910] Dynamic subtest smem: SUCCESS (0.095s)
[277.726354] Starting dynamic subtest: lmem0
[278.828559] Dynamic subtest lmem0: SUCCESS (1.105s)
[278.829551] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (1.202s)
[279.019347] [011/142] (719s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs)
[280.976691] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs
[280.978809] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[281.246805] [012/142] (717s left) i915_pm_rpm (gem-execbuf-stress)
[285.559953] Starting subtest: gem-execbuf-stress
[285.562328] Starting dynamic subtest: lmem0
[306.390605] Dynamic subtest lmem0: SUCCESS (20.830s)
[306.400035] Starting dynamic subtest: extra-wait-lmem0
[379.348571] Dynamic subtest extra-wait-lmem0: SUCCESS (72.952s)
[379.354347] Starting dynamic subtest: smem0
[405.412456] Dynamic subtest smem0: SUCCESS (26.062s)
[405.446684] Starting dynamic subtest: extra-wait-smem0
[483.264393] Dynamic subtest extra-wait-smem0: SUCCESS (77.848s)
[483.265279] Subtest gem-execbuf-stress: SUCCESS (197.706s)
[483.623985] [013/142] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[485.588739] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[485.590794] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[485.669725] [014/142] (512s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[485.809540] Starting subtest: invalid-single-wait-unsubmitted
[485.810411] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[485.865070] [015/142] (512s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs)
[487.911044] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs
[487.912826] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[488.096215] [016/142] (510s left) kms_plane (plane-panning-top-left)
[490.045717] Starting subtest: plane-panning-top-left
[490.048480] Starting dynamic subtest: pipe-A-planes
[490.699167] Dynamic subtest pipe-A-planes: SUCCESS (0.651s)
[490.706529] Starting dynamic subtest: pipe-B-planes
[491.175426] Dynamic subtest pipe-B-planes: SUCCESS (0.473s)
[491.176492] Subtest plane-panning-top-left: SUCCESS (1.130s)
[491.294750] [017/142] (507s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs)
[493.351471] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs
[493.355551] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.003s)
[493.517243] [018/142] (505s left) gem_mmap (bad-size)
[493.568110] Subtest bad-size: SKIP (0.000s)
[493.594483] [019/142] (505s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[493.654963] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[493.676829] [020/142] (504s left) kms_plane_scaling (plane-scaler-with-modifiers-unity-scaling)
[495.635217] Starting subtest: plane-scaler-with-modifiers-unity-scaling
[495.636211] Starting dynamic subtest: pipe-A-HDMI-A-4
[497.017876] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.382s)
[497.034777] Starting dynamic subtest: pipe-B-HDMI-A-4
[498.257707] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.235s)
[498.278478] Starting dynamic subtest: pipe-C-HDMI-A-4
[499.597748] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.334s)
[499.609479] Starting dynamic subtest: pipe-D-HDMI-A-4
[500.819395] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.218s)
[500.820433] Subtest plane-scaler-with-modifiers-unity-scaling: SUCCESS (5.187s)
[500.989909] [021/142] (497s left) perf_pmu (semaphore-wait-idle)
[501.040852] Starting subtest: semaphore-wait-idle
[501.041957] Starting dynamic subtest: rcs0
[501.567353] Dynamic subtest rcs0: SUCCESS (0.522s)
[501.578671] Starting dynamic subtest: bcs0
[502.084268] Dynamic subtest bcs0: SUCCESS (0.511s)
[502.094140] Starting dynamic subtest: vcs0
[502.601192] Dynamic subtest vcs0: SUCCESS (0.511s)
[502.611190] Starting dynamic subtest: vcs1
[503.118352] Dynamic subtest vcs1: SUCCESS (0.511s)
[503.129283] Starting dynamic subtest: vecs0
[503.635125] Dynamic subtest vecs0: SUCCESS (0.511s)
[503.636179] Subtest semaphore-wait-idle: SUCCESS (2.593s)
[503.742555] [022/142] (494s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[505.699385] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[505.701439] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[505.780621] [023/142] (492s left) kms_big_fb (4-tiled-addfb-size-overflow)
[507.820620] Starting subtest: 4-tiled-addfb-size-overflow
[507.822895] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[507.917189] [024/142] (490s left) vc4/vc4_wait_bo (used-bo-0ns)
[508.091317] Subtest used-bo-0ns: SKIP (0.000s)
[508.140497] [025/142] (490s left) syncobj_wait (single-wait-submitted)
[508.190834] Starting subtest: single-wait-submitted
[508.296375] Subtest single-wait-submitted: SUCCESS (0.101s)
[508.364800] [026/142] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[510.326176] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[510.328257] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[510.413852] [027/142] (488s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[512.461415] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[514.924080] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.464s)
[515.074155] [028/142] (483s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[517.040335] Starting subtest: fbcpsr-suspend
[517.042387] Subtest fbcpsr-suspend: SKIP (0.000s)
[517.131406] [029/142] (481s left) gem_ctx_persistence (userptr)
[517.285195] Starting subtest: userptr
[517.434687] Subtest userptr: SUCCESS (0.148s)
[517.531997] [030/142] (481s left) prime_vgem (basic-fence-read)
[517.645414] Starting subtest: basic-fence-read
[517.652506] Subtest basic-fence-read: SKIP (0.006s)
[517.778163] [031/142] (481s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs)
[519.886967] Starting subtest: pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs
[519.888650] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[520.004792] [032/142] (478s left) api_intel_bb (intel-bb-blit-y)
[520.056699] Starting subtest: intel-bb-blit-y
[521.837057] Subtest intel-bb-blit-y: SUCCESS (1.777s)
[521.966058] [033/142] (476s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[522.039758] Subtest get-values-invalid-pointer: SKIP (0.000s)
[522.089865] [034/142] (476s left) gem_exec_fence (syncobj-timeline-wait)
[522.655431] Starting subtest: syncobj-timeline-wait
[522.726151] Subtest syncobj-timeline-wait: SUCCESS (0.075s)
[522.938648] [035/142] (476s left) kms_cursor_edge_walk (256x256-top-bottom)
[524.891149] Starting subtest: 256x256-top-bottom
[524.894155] Starting dynamic subtest: pipe-A-HDMI-A-4
[528.175784] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.283s)
[528.184071] Starting dynamic subtest: pipe-D-HDMI-A-4
[531.379816] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.201s)
[531.380724] Subtest 256x256-top-bottom: SUCCESS (6.490s)
[531.512201] [036/142] (467s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[531.564073] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[531.615670] [037/142] (467s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs)
[533.665396] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs
[533.667671] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[533.859792] [038/142] (465s left) kms_sequence (get-forked-busy)
[535.814945] Starting subtest: get-forked-busy
[535.817959] Starting dynamic subtest: HDMI-A-4-pipe-A
[538.434627] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (2.614s)
[538.469831] Starting dynamic subtest: HDMI-A-4-pipe-B
[540.943824] Dynamic subtest HDMI-A-4-pipe-B: SUCCESS (2.498s)
[540.966068] Starting dynamic subtest: HDMI-A-4-pipe-C
[543.451407] Dynamic subtest HDMI-A-4-pipe-C: SUCCESS (2.501s)
[543.466365] Starting dynamic subtest: HDMI-A-4-pipe-D
[545.950458] Dynamic subtest HDMI-A-4-pipe-D: SUCCESS (2.493s)
[545.951884] Subtest get-forked-busy: SUCCESS (10.135s)
[546.074714] [039/142] (452s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[548.030286] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[548.033379] Starting dynamic subtest: pipe-A-valid-mode
[548.083100] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s)
[548.084844] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.052s)
[548.170826] [040/142] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[550.146527] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[550.148350] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[550.224424] [041/142] (448s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[552.429528] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[552.433740] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[552.537198] [042/142] (446s left) kms_cursor_legacy (single-bo)
[554.483194] Starting subtest: single-bo
[554.484255] Starting dynamic subtest: pipe-A
[559.868335] Dynamic subtest pipe-A: SUCCESS (5.383s)
[559.875274] Starting dynamic subtest: pipe-B
[565.252027] Dynamic subtest pipe-B: SUCCESS (5.382s)
[565.258801] Starting dynamic subtest: pipe-C
[570.635238] Dynamic subtest pipe-C: SUCCESS (5.382s)
[570.642045] Starting dynamic subtest: pipe-D
[576.018411] Dynamic subtest pipe-D: SUCCESS (5.382s)
[576.025231] Starting dynamic subtest: all-pipes
[581.402226] Dynamic subtest all-pipes: SUCCESS (5.383s)
[581.403121] Subtest single-bo: SUCCESS (26.918s)
[581.468792] [043/142] (417s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs)
[583.538834] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs
[583.540586] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[583.685174] [044/142] (415s left) perf (invalid-remove-userspace-config)
[583.816524] Starting subtest: invalid-remove-userspace-config
[583.830579] Subtest invalid-remove-userspace-config: SUCCESS (0.014s)
[583.850911] [045/142] (415s left) gem_mmap_offset (ptrace)
[583.898725] Starting subtest: ptrace
[583.902241] Starting dynamic subtest: lmem0-fixed
[584.021636] Dynamic subtest lmem0-fixed: SUCCESS (0.116s)
[584.028346] Starting dynamic subtest: smem0-fixed
[584.048897] Dynamic subtest smem0-fixed: SUCCESS (0.026s)
[584.049885] Subtest ptrace: SUCCESS (0.151s)
[584.150140] [046/142] (415s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[586.124338] Starting subtest: yf-tiled-8bpp-rotate-180
[586.126514] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[586.208492] [047/142] (412s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[588.255501] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[590.523764] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (2.270s)
[590.656090] [048/142] (408s left) syncobj_wait (wait-delayed-signal)
[590.705623] Starting subtest: wait-delayed-signal
[590.810952] Subtest wait-delayed-signal: SUCCESS (0.103s)
[590.923834] [049/142] (408s left) kms_lease (multimaster-lease)
[592.888191] Starting subtest: multimaster-lease
[592.891632] Subtest multimaster-lease: SUCCESS (0.003s)
[592.953313] [050/142] (406s left) sysfs_timeslice_duration (duration)
[593.050337] Starting subtest: duration
[593.054620] Starting dynamic subtest: vecs0
[606.200430] Dynamic subtest vecs0: SUCCESS (13.149s)
[606.210048] Starting dynamic subtest: vcs0
[619.360298] Dynamic subtest vcs0: SUCCESS (13.158s)
[619.370100] Starting dynamic subtest: bcs0
[632.520299] Dynamic subtest bcs0: SUCCESS (13.158s)
[632.530929] Starting dynamic subtest: rcs0
[645.652303] Dynamic subtest rcs0: SUCCESS (13.130s)
[645.662341] Starting dynamic subtest: vcs1
[658.806307] Dynamic subtest vcs1: SUCCESS (13.152s)
[658.807309] Subtest duration: SUCCESS (65.757s)
[658.883232] [051/142] (340s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[660.829104] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[660.831890] Starting dynamic subtest: pipe-A-HDMI-A-4
[660.965456] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.135s)
[660.974943] Starting dynamic subtest: pipe-B-HDMI-A-4
[661.104981] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.137s)
[661.113527] Starting dynamic subtest: pipe-C-HDMI-A-4
[661.226818] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.119s)
[661.235310] Starting dynamic subtest: pipe-D-HDMI-A-4
[661.348666] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.119s)
[661.349513] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.521s)
[661.475193] [052/142] (337s left) prime_vgem (coherency-blt)
[661.556144] Starting subtest: coherency-blt
[663.760946] Subtest coherency-blt: SUCCESS (2.202s)
[663.848744] [053/142] (335s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[663.921427] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[663.972133] [054/142] (335s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[666.090345] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[666.092332] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[666.188770] [055/142] (333s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[668.149090] Starting subtest: primary-4-tiled-reflect-x-0
[668.239876] Subtest primary-4-tiled-reflect-x-0: SKIP (0.091s)
[668.385656] [056/142] (331s left) gem_render_copy_redux (flink-interruptible)
[668.493939] Starting subtest: flink-interruptible
[670.283641] Subtest flink-interruptible: SUCCESS (1.790s)
[670.419036] [057/142] (329s left) kms_lease (possible-crtcs-filtering)
[672.397855] Starting subtest: possible-crtcs-filtering
[672.403991] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[672.476050] [058/142] (327s left) gem_exec_fence (submit)
[672.828992] Starting subtest: submit
[672.832032] Subtest submit: SKIP (0.000s)
[673.367507] [059/142] (326s left) gem_wait (wait)
[673.436595] Starting subtest: wait
[673.437544] Starting dynamic subtest: all-engines
[674.513455] Dynamic subtest all-engines: SUCCESS (1.076s)
[674.530073] Starting dynamic subtest: rcs0
[675.570103] Dynamic subtest rcs0: SUCCESS (1.055s)
[675.581617] Starting dynamic subtest: bcs0
[676.625894] Dynamic subtest bcs0: SUCCESS (1.053s)
[676.637141] Starting dynamic subtest: vcs0
[677.684073] Dynamic subtest vcs0: SUCCESS (1.054s)
[677.694705] Starting dynamic subtest: vcs1
[678.740028] Dynamic subtest vcs1: SUCCESS (1.055s)
[678.751223] Starting dynamic subtest: vecs0
[679.798956] Dynamic subtest vecs0: SUCCESS (1.056s)
[679.802128] Subtest wait: SUCCESS (6.364s)
[680.033220] [060/142] (319s left) kms_vblank (pipe-b-query-busy)
[681.986856] Starting subtest: pipe-B-query-busy
[684.513505] Subtest pipe-B-query-busy: SUCCESS (2.527s)
[684.627041] [061/142] (314s left) kms_concurrent (pipe-d)
[686.586942] Starting subtest: pipe-D
[686.588074] Starting dynamic subtest: HDMI-A-4
[686.892204] Dynamic subtest HDMI-A-4: SUCCESS (0.303s)
[686.893231] Subtest pipe-D: SUCCESS (0.306s)
[687.024847] [062/142] (312s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[688.984131] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[688.985986] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[689.063849] [063/142] (310s left) gem_pxp (create-regular-context-1)
[691.706914] Subtest create-regular-context-1: SKIP (0.000s)
[691.791968] [064/142] (307s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[693.751611] Starting subtest: fbc-modesetfrombusy
[695.005587] Subtest fbc-modesetfrombusy: SUCCESS (1.257s)
[695.145734] [065/142] (304s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[697.335822] Starting subtest: cursor-rapid-movement-512x170
[697.339127] Subtest cursor-rapid-movement-512x170: SKIP (0.002s)
[697.501904] [066/142] (302s left) kms_universal_plane (disable-primary-vs-flip-pipe-c)
[699.477065] Starting subtest: disable-primary-vs-flip-pipe-C
[699.912748] Subtest disable-primary-vs-flip-pipe-C: SUCCESS (0.435s)
[700.037170] [067/142] (299s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[702.002738] Starting subtest: x-tiled-16bpp-rotate-90
[702.089928] Subtest x-tiled-16bpp-rotate-90: SKIP (0.086s)
[702.185546] [068/142] (297s left) kms_big_fb (linear-8bpp-rotate-90)
[704.134471] Starting subtest: linear-8bpp-rotate-90
[704.223492] Subtest linear-8bpp-rotate-90: SKIP (0.087s)
[704.318796] [069/142] (295s left) gem_exec_schedule (preempt-user)
[704.386527] Starting subtest: preempt-user
[704.389013] Starting dynamic subtest: rcs0
[704.440268] Dynamic subtest rcs0: SUCCESS (0.053s)
[704.448863] Starting dynamic subtest: bcs0
[704.476713] Dynamic subtest bcs0: SUCCESS (0.035s)
[704.485090] Starting dynamic subtest: vcs0
[704.513399] Dynamic subtest vcs0: SUCCESS (0.036s)
[704.521736] Starting dynamic subtest: vcs1
[704.548759] Dynamic subtest vcs1: SUCCESS (0.034s)
[704.557312] Starting dynamic subtest: vecs0
[704.584947] Dynamic subtest vecs0: SUCCESS (0.035s)
[704.585812] Subtest preempt-user: SUCCESS (0.199s)
[704.998693] [070/142] (294s left) gem_exec_reloc (basic-write-read-active)
[705.048800] Subtest basic-write-read-active: SKIP (0.000s)
[705.094744] [071/142] (294s left) kms_addfb_basic (bo-too-small)
[707.056592] Starting subtest: bo-too-small
[707.057531] Subtest bo-too-small: SUCCESS (0.000s)
[707.141502] [072/142] (292s left) gem_exec_reloc (basic-cpu-wc-active)
[707.281509] Subtest basic-cpu-wc-active: SKIP (0.000s)
[707.372018] [073/142] (292s left) gem_close_race (multigpu-basic-process)
[707.477589] Starting subtest: multigpu-basic-process
[707.479644] Subtest multigpu-basic-process: SKIP (0.000s)
[707.745538] [074/142] (292s left) kms_chamelium_edid (dp-edid-read)
[709.758866] Subtest dp-edid-read: SKIP (0.000s)
[709.813381] [075/142] (290s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_mc_ccs)
[711.883957] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_mc_ccs
[711.886310] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[712.036338] [076/142] (287s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[712.087836] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[712.088710] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[712.167492] [077/142] (287s left) vc4/vc4_create_bo (create-bo-zeroed)
[712.269649] Subtest create-bo-zeroed: SKIP (0.000s)
[712.322832] [078/142] (287s left) gem_ctx_exec (basic-nohangcheck)
[712.382479] Starting subtest: basic-nohangcheck
[712.515506] Subtest basic-nohangcheck: SUCCESS (0.133s)
[712.647348] [079/142] (287s left) gem_exec_params (larger-than-life-batch)
[712.697634] Starting subtest: larger-than-life-batch
[721.764386] Subtest larger-than-life-batch: SUCCESS (9.063s)
[722.399099] [080/142] (277s left) kms_force_connector_basic (prune-stale-modes)
[722.545918] Starting subtest: prune-stale-modes
[722.562909] Subtest prune-stale-modes: SUCCESS (0.017s)
[724.637091] [081/142] (275s left) kms_chamelium_audio (dp-audio-edid)
[726.706636] Subtest dp-audio-edid: SKIP (0.000s)
[726.761582] [082/142] (273s left) kms_big_fb (y-tiled-addfb-size-overflow)
[728.729491] Starting subtest: y-tiled-addfb-size-overflow
[728.730595] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.001s)
[728.885648] [083/142] (271s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[730.910389] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[730.912259] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[731.011154] [084/142] (269s left) kms_psr2_su (page_flip-xrgb8888)
[731.150069] Subtest page_flip-XRGB8888: SKIP (0.000s)
[731.175563] [085/142] (269s left) gem_userptr_blits (forbidden-operations)
[731.229861] Starting subtest: forbidden-operations
[731.231797] Subtest forbidden-operations: SKIP (0.000s)
[731.365496] [086/142] (268s left) gem_exec_whisper (basic-queues-forked)
[731.445017] Starting subtest: basic-queues-forked
[753.661121] Subtest basic-queues-forked: SUCCESS (22.212s)
[753.849212] [087/142] (246s left) gem_tiled_swapping (non-threaded)
[753.905865] Subtest non-threaded: SKIP (0.000s)
[753.939651] [088/142] (246s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[753.998835] Starting subtest: map-fixed-invalidate-overlap-busy
[754.000513] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[754.138975] [089/142] (246s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[756.105688] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[756.107664] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[756.208956] [090/142] (244s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[756.395123] Starting subtest: stress-mm-invalidate-close-overlap
[758.732427] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.334s)
[759.219741] [091/142] (241s left) i915_pm_rps (thresholds-idle)
[759.287594] Starting subtest: thresholds-idle
[759.288496] Starting dynamic subtest: gt0
[759.304055] Dynamic subtest gt0: SKIP (0.015s)
[759.305941] Subtest thresholds-idle: SKIP (0.016s)
[759.410113] [092/142] (240s left) drm_read (short-buffer-wakeup)
[761.513848] Starting subtest: short-buffer-wakeup
[793.728198] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[793.853533] [093/142] (206s left) gem_mmap_wc (write-read-distinct)
[793.925054] Subtest write-read-distinct: SKIP (0.000s)
[793.951811] [094/142] (206s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[795.916762] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[797.012061] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.091s)
[797.133789] [095/142] (203s left) gem_spin_batch (legacy-resubmit-new)
[797.188921] Starting subtest: legacy-resubmit-new
[797.190011] Starting dynamic subtest: default
[797.208441] Dynamic subtest default: SUCCESS (0.019s)
[797.217942] Starting dynamic subtest: render
[797.218920] Dynamic subtest render: SUCCESS (0.004s)
[797.227195] Starting dynamic subtest: bsd
[797.228159] Dynamic subtest bsd: SUCCESS (0.003s)
[797.236187] Starting dynamic subtest: bsd1
[797.237127] Dynamic subtest bsd1: SUCCESS (0.003s)
[797.245063] Starting dynamic subtest: bsd2
[797.245929] Dynamic subtest bsd2: SUCCESS (0.003s)
[797.253660] Starting dynamic subtest: blt
[797.254751] Dynamic subtest blt: SUCCESS (0.004s)
[797.262421] Starting dynamic subtest: vebox
[797.263557] Dynamic subtest vebox: SUCCESS (0.005s)
[797.264607] Subtest legacy-resubmit-new: SUCCESS (0.050s)
[797.540123] [096/142] (202s left) kms_chamelium_hpd (hdmi-hpd)
[799.548289] Subtest hdmi-hpd: SKIP (0.000s)
[799.603153] [097/142] (200s left) kms_addfb_basic (addfb25-modifier-no-flag)
[799.650274] Starting subtest: addfb25-modifier-no-flag
[799.651361] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[801.628036] [098/142] (198s left) v3d/v3d_submit_cl (simple-flush-cache)
[801.789994] Subtest simple-flush-cache: SKIP (0.000s)
[801.839705] [099/142] (198s left) gem_caching (writes)
[801.889907] Starting subtest: writes
[806.045981] Subtest writes: SUCCESS (4.156s)
[806.156500] [100/142] (194s left) gem_exec_balancer (invalid-balancer)
[806.222368] Starting subtest: invalid-balancer
[807.479793] Subtest invalid-balancer: SUCCESS (1.254s)
[807.772691] [101/142] (192s left) kms_feature_discovery (dp-mst)
[809.726235] Starting subtest: dp-mst
[809.728110] Subtest dp-mst: SKIP (0.000s)
[809.792991] [102/142] (190s left) gem_exec_capture (capture-invisible)
[809.897612] Starting subtest: capture-invisible
[809.898958] Starting dynamic subtest: lmem0
[809.901464] Dynamic subtest lmem0: SKIP (0.000s)
[809.912768] Starting dynamic subtest: smem0
[809.915464] Dynamic subtest smem0: SKIP (0.000s)
[809.917966] Subtest capture-invisible: SKIP (0.004s)
[810.021892] [103/142] (190s left) i915_pm_freq_api (freq-reset)
[810.103430] Starting subtest: freq-reset
[810.104592] Starting dynamic subtest: gt0
[810.376837] Dynamic subtest gt0: SUCCESS (0.272s)
[810.377834] Subtest freq-reset: SUCCESS (0.274s)
[810.444152] [104/142] (190s left) gem_userptr_blits (sync-unmap-cycles)
[810.506837] Starting subtest: sync-unmap-cycles
[815.888428] Subtest sync-unmap-cycles: SUCCESS (5.382s)
[816.021893] [105/142] (184s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[816.095397] Starting subtest: multi-wait-available-submitted-signaled
[816.096370] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[816.160983] [106/142] (184s left) gen9_exec_parse (bb-start-out)
[816.214230] Subtest bb-start-out: SKIP (0.000s)
[816.247644] [107/142] (184s left) gem_mmap (basic)
[816.299773] Subtest basic: SKIP (0.000s)
[816.331826] [108/142] (184s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[818.347596] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[818.349760] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[818.555789] [109/142] (182s left) kms_flip (plain-flip-fb-recreate-interruptible)
[819.563053] Starting subtest: plain-flip-fb-recreate-interruptible
[819.574534] Starting dynamic subtest: A-HDMI-A4
[827.576951] Dynamic subtest A-HDMI-A4: SUCCESS (8.001s)
[827.614454] Starting dynamic subtest: B-HDMI-A4
[835.548454] Dynamic subtest B-HDMI-A4: SUCCESS (7.964s)
[835.583014] Starting dynamic subtest: C-HDMI-A4
[843.520087] Dynamic subtest C-HDMI-A4: SUCCESS (7.964s)
[843.551901] Starting dynamic subtest: D-HDMI-A4
[851.491086] Dynamic subtest D-HDMI-A4: SUCCESS (7.964s)
[851.493953] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.930s)
[851.696566] [110/142] (149s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[853.792268] Starting subtest: pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[853.794168] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[853.912067] [111/142] (146s left) gem_media_vme
[853.987885] [112/142] (146s left) kms_color (gamma)
[855.935700] Starting subtest: gamma
[855.936738] Starting dynamic subtest: pipe-A
[856.632892] Dynamic subtest pipe-A: SUCCESS (0.696s)
[856.641370] Starting dynamic subtest: pipe-B
[857.105375] Dynamic subtest pipe-B: SUCCESS (0.472s)
[857.114064] Starting dynamic subtest: pipe-C
[857.565258] Dynamic subtest pipe-C: SUCCESS (0.459s)
[857.573858] Starting dynamic subtest: pipe-D
[858.029584] Dynamic subtest pipe-D: SUCCESS (0.462s)
[858.030497] Subtest gamma: SUCCESS (2.093s)
[858.162815] [113/142] (142s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[860.126110] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[860.127915] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[860.197567] [114/142] (140s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[860.311044] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[860.416813] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[860.527298] [115/142] (140s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[860.594053] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[860.618834] [116/142] (140s left) api_intel_allocator (reopen)
[860.666030] Starting subtest: reopen
[860.678924] Subtest reopen: SUCCESS (0.013s)
[860.807793] [117/142] (140s left) kms_vblank (pipe-b-query-forked-hang)
[862.756903] Starting subtest: pipe-B-query-forked-hang
[876.825579] Subtest pipe-B-query-forked-hang: SUCCESS (14.068s)
[876.945703] [118/142] (124s left) gem_exec_reloc (basic-wc-gtt)
[876.997387] Subtest basic-wc-gtt: SKIP (0.000s)
[877.062594] [119/142] (123s left) kms_hdr (static-toggle-dpms)
[879.052113] Starting subtest: static-toggle-dpms
[879.054327] Subtest static-toggle-dpms: SKIP (0.000s)
[879.114242] [120/142] (121s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[881.120401] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[881.122314] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[881.200635] [121/142] (119s left) gem_userptr_blits (huge-split)
[881.353313] Starting subtest: huge-split
[881.369425] Subtest huge-split: SUCCESS (0.016s)
[881.474383] [122/142] (119s left) vgem_basic (setversion)
[881.561046] Starting subtest: setversion
[881.562972] Subtest setversion: SUCCESS (0.000s)
[881.645114] [123/142] (119s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[883.616170] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[883.618333] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[883.701701] [124/142] (117s left) gem_busy (busy)
[883.847133] Starting subtest: busy
[883.848170] Starting dynamic subtest: all-engines
[883.903989] Dynamic subtest all-engines: SUCCESS (0.056s)
[883.913435] Starting dynamic subtest: rcs0
[883.958902] Dynamic subtest rcs0: SUCCESS (0.054s)
[883.968400] Starting dynamic subtest: bcs0
[883.999059] Dynamic subtest bcs0: SUCCESS (0.038s)
[884.012921] Starting dynamic subtest: vcs0
[884.038271] Dynamic subtest vcs0: SUCCESS (0.038s)
[884.059192] Starting dynamic subtest: vcs1
[884.079608] Dynamic subtest vcs1: SUCCESS (0.039s)
[884.100387] Starting dynamic subtest: vecs0
[884.120682] Dynamic subtest vecs0: SUCCESS (0.039s)
[884.121942] Subtest busy: SUCCESS (0.274s)
[884.482369] [125/142] (116s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[886.440111] Starting subtest: cursorB-vs-flipB-toggle
[886.442099] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s)
[886.516959] [126/142] (114s left) kms_vblank (pipe-a-query-busy)
[888.540911] Starting subtest: pipe-A-query-busy
[891.031145] Subtest pipe-A-query-busy: SUCCESS (2.489s)
[891.128770] [127/142] (110s left) api_intel_bb (reset-flags)
[891.175174] Starting subtest: reset-flags
[891.196126] Subtest reset-flags: SUCCESS (0.021s)
[891.337902] [128/142] (109s left) syncobj_wait (invalid-signal-bad-pad)
[891.392020] Starting subtest: invalid-signal-bad-pad
[891.392886] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[891.484705] [129/142] (109s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[893.470827] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[893.472738] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[893.582578] [130/142] (107s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[895.641042] Starting subtest: yf-tiled-64bpp-rotate-0
[895.643057] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[895.739285] [131/142] (105s left) kms_flip (flip-vs-expired-vblank-interruptible)
[896.869081] Starting subtest: flip-vs-expired-vblank-interruptible
[896.896066] Starting dynamic subtest: A-HDMI-A4
[904.630438] Dynamic subtest A-HDMI-A4: SUCCESS (7.734s)
[904.641948] Starting dynamic subtest: B-HDMI-A4
[912.289916] Dynamic subtest B-HDMI-A4: SUCCESS (7.656s)
[912.302916] Starting dynamic subtest: C-HDMI-A4
[919.946570] Dynamic subtest C-HDMI-A4: SUCCESS (7.651s)
[919.959142] Starting dynamic subtest: D-HDMI-A4
[927.601246] Dynamic subtest D-HDMI-A4: SUCCESS (7.651s)
[927.602154] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.734s)
[927.740820] [132/142] ( 73s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[928.744846] Starting subtest: 2x-plain-flip-ts-check-interruptible
[928.770758] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.025s)
[928.845524] [133/142] ( 72s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[930.884957] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[930.886962] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[930.986285] [134/142] ( 70s left) syncobj_timeline (single-wait-all-available-submitted)
[931.128277] Starting subtest: single-wait-all-available-submitted
[931.129158] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[931.191844] [135/142] ( 70s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[933.231175] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[933.305158] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.072s)
[933.555408] [136/142] ( 67s left) gem_render_copy (linear)
[933.613974] Starting subtest: linear
[933.614883] Starting dynamic subtest: smem
[933.693450] Dynamic subtest smem: SUCCESS (0.079s)
[933.703596] Starting dynamic subtest: lmem0
[933.824770] Dynamic subtest lmem0: SUCCESS (0.127s)
[933.825777] Subtest linear: SUCCESS (0.208s)
[934.049493] [137/142] ( 67s left) kms_content_protection (uevent)
[936.049848] Starting subtest: uevent
[936.321568] Subtest uevent: SKIP (0.270s)
[936.457879] [138/142] ( 65s left) perf_pmu (busy)
[936.509463] Starting subtest: busy
[936.510431] Starting dynamic subtest: rcs0
[937.112037] Dynamic subtest rcs0: SUCCESS (0.602s)
[937.124488] Starting dynamic subtest: bcs0
[937.666023] Dynamic subtest bcs0: SUCCESS (0.552s)
[937.678560] Starting dynamic subtest: vcs0
[938.218985] Dynamic subtest vcs0: SUCCESS (0.551s)
[938.231531] Starting dynamic subtest: vcs1
[938.773855] Dynamic subtest vcs1: SUCCESS (0.552s)
[938.786799] Starting dynamic subtest: vecs0
[939.331807] Dynamic subtest vecs0: SUCCESS (0.552s)
[939.337031] Subtest busy: SUCCESS (2.824s)
[939.453381] [139/142] ( 62s left) gem_softpin (softpin)
[939.516825] Starting subtest: softpin
[971.740737] Subtest softpin: SUCCESS (32.220s)
[971.842942] [140/142] ( 29s left) gem_exec_fence (basic-wait-all)
[971.924834] Starting subtest: basic-wait-all
[972.023749] Subtest basic-wait-all: SUCCESS (0.098s)
[972.733631] [141/142] ( 28s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm)
[974.701986] Starting subtest: pipe-D-ts-continuation-modeset-rpm
[977.247181] Subtest pipe-D-ts-continuation-modeset-rpm: SUCCESS (2.544s)
[977.536660] [142/142] ( 24s left) gem_render_copy_redux (normal)
[977.624977] Starting subtest: normal
[978.420189] Subtest normal: SUCCESS (0.795s)
[978.521973] Closing watchdogs
Done.