[95.549691] Initializing watchdogs
[95.549745]   /dev/watchdog0
[95.554025] [001/137] (960s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[95.602266] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[95.602959] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[95.675753] [002/137] (960s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[95.887410] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[95.888781] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[96.024463] [003/137] (960s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[96.069237] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[96.069933] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[96.120668] [004/137] (959s left) vc4/vc4_wait_bo (bad-pad)
[96.204987] Subtest bad-pad: SKIP (0.000s)
[96.265746] [005/137] (959s left) syncobj_timeline (multi-wait-all-signaled)
[96.327303] Starting subtest: multi-wait-all-signaled
[96.328005] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[96.395689] [006/137] (959s left) kms_concurrent (pipe-d)
[96.489691] Subtest pipe-D: SKIP (0.000s)
[96.570418] [007/137] (959s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[96.837339] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[96.920226] [008/137] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[97.006195] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[97.007569] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[97.106065] [009/137] (959s left) gem_exec_gttfill (all-engines)
[97.175580] Starting subtest: all-engines
[120.200578] Subtest all-engines: SUCCESS (23.025s)
[120.385246] [010/137] (935s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[120.522978] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[120.524372] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[120.614200] [011/137] (935s left) gem_ringfill (legacy-basic)
[120.837521] Starting subtest: legacy-basic
[120.838696] Starting dynamic subtest: default
[120.881434] Dynamic subtest default: SUCCESS (0.044s)
[120.893395] Starting dynamic subtest: render
[120.903374] Dynamic subtest render: SUCCESS (0.022s)
[120.915428] Starting dynamic subtest: bsd
[120.925866] Dynamic subtest bsd: SUCCESS (0.022s)
[120.936218] Starting dynamic subtest: bsd1
[120.941327] Dynamic subtest bsd1: SUCCESS (0.015s)
[120.949263] Starting dynamic subtest: blt
[120.959201] Dynamic subtest blt: SUCCESS (0.018s)
[120.968261] Starting dynamic subtest: vebox
[120.977166] Dynamic subtest vebox: SUCCESS (0.018s)
[120.978396] Subtest legacy-basic: SUCCESS (0.141s)
[121.055256] [012/137] (935s left) gem_exec_capture (pi)
[121.116056] Starting subtest: pi
[121.116747] Starting dynamic subtest: rcs0
[133.067920] Dynamic subtest rcs0: SUCCESS (11.952s)
[133.075509] Starting dynamic subtest: bcs0
[144.985903] Dynamic subtest bcs0: SUCCESS (11.918s)
[144.992201] Starting dynamic subtest: vcs0
[156.901804] Dynamic subtest vcs0: SUCCESS (11.916s)
[156.905413] Starting dynamic subtest: vecs0
[171.235878] Dynamic subtest vecs0: SUCCESS (14.334s)
[171.236596] Subtest pi: SUCCESS (50.120s)
[171.307337] [013/137] (884s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[171.436349] Starting subtest: cursor-rapid-movement-128x128
[171.438695] Starting dynamic subtest: pipe-A-HDMI-A-2
[171.880341] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.442s)
[171.898294] Starting dynamic subtest: pipe-B-HDMI-A-2
[172.374026] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.479s)
[172.374732] Subtest cursor-rapid-movement-128x128: SUCCESS (0.938s)
[172.484432] [014/137] (883s left) kms_cursor_crc (cursor-sliding-max-size)
[172.564274] Starting subtest: cursor-sliding-max-size
[172.566252] Subtest cursor-sliding-max-size: SKIP (0.000s)
[172.654436] [015/137] (883s left) gem_mmap_gtt (fault-concurrent-y)
[172.696464] Starting subtest: fault-concurrent-Y
[174.901058] Subtest fault-concurrent-Y: SUCCESS (2.204s)
[175.009264] [016/137] (881s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[175.308152] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[175.389608] [017/137] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[175.467753] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[175.469190] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[175.570905] [018/137] (880s left) gem_exec_schedule (pi-distinct-iova)
[175.758753] Starting subtest: pi-distinct-iova
[175.759975] Starting dynamic subtest: rcs0
[175.779483] Dynamic subtest rcs0: SUCCESS (0.021s)
[175.783328] Starting dynamic subtest: bcs0
[175.792612] Dynamic subtest bcs0: SUCCESS (0.013s)
[175.796334] Starting dynamic subtest: vcs0
[175.804714] Dynamic subtest vcs0: SUCCESS (0.012s)
[175.808443] Starting dynamic subtest: vecs0
[175.816418] Dynamic subtest vecs0: SUCCESS (0.012s)
[175.817112] Subtest pi-distinct-iova: SUCCESS (0.058s)
[176.010976] [019/137] (880s left) vc4/vc4_mmap (mmap-bo)
[176.081847] Subtest mmap-bo: SKIP (0.000s)
[176.143819] [020/137] (880s left) kms_getfb (getfb2-handle-not-fb)
[176.204075] Starting subtest: getfb2-handle-not-fb
[176.237847] Subtest getfb2-handle-not-fb: SUCCESS (0.033s)
[176.337041] [021/137] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[176.433213] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[176.434521] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[176.526222] [022/137] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[176.622083] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[176.623379] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[176.733257] [023/137] (879s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[176.826431] Starting subtest: primary-yf-tiled-reflect-x-90
[176.936636] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.109s)
[177.025568] [024/137] (879s left) gem_exec_balancer (bonded-true-hang)
[178.028353] Starting subtest: bonded-true-hang
[178.759305] Subtest bonded-true-hang: SUCCESS (0.732s)
[178.835072] [025/137] (877s left) kms_async_flips (alternate-sync-async-flip)
[178.925178] Starting subtest: alternate-sync-async-flip
[178.925946] Starting dynamic subtest: pipe-A-HDMI-A-2
[181.610029] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.684s)
[181.618584] Starting dynamic subtest: pipe-B-HDMI-A-2
[184.271487] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.659s)
[184.272843] Subtest alternate-sync-async-flip: SUCCESS (5.346s)
[184.746203] [026/137] (871s left) kms_chamelium_hpd (vga-hpd)
[184.854942] Subtest vga-hpd: SKIP (0.000s)
[184.901324] [027/137] (871s left) kms_plane_alpha_blend (constant-alpha-mid)
[184.976441] Starting subtest: constant-alpha-mid
[185.038586] Starting dynamic subtest: pipe-A-HDMI-A-2
[185.773068] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.734s)
[185.778630] Starting dynamic subtest: pipe-B-HDMI-A-2
[186.499094] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.723s)
[186.500175] Subtest constant-alpha-mid: SUCCESS (1.523s)
[186.613481] [028/137] (869s left) gem_spin_batch (spin-all)
[186.660626] Starting subtest: spin-all
[186.665432] Subtest spin-all: SUCCESS (0.004s)
[186.858574] [029/137] (869s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[186.988394] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[187.035470] [030/137] (869s left) gem_exec_whisper (basic-queues-priority)
[187.083116] Starting subtest: basic-queues-priority
[191.790763] Subtest basic-queues-priority: SUCCESS (4.707s)
[191.962295] [031/137] (864s left) kms_psr2_sf (cursor-plane-update-sf)
[192.006732] Subtest cursor-plane-update-sf: SKIP (0.000s)
[192.023391] [032/137] (864s left) kms_plane_multiple (tiling-x)
[192.101238] Starting subtest: tiling-x
[192.102014] Starting dynamic subtest: pipe-A-HDMI-A-2
[192.648663] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.548s)
[192.654186] Starting dynamic subtest: pipe-B-HDMI-A-2
[193.140391] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.489s)
[193.141080] Subtest tiling-x: SUCCESS (1.040s)
[193.249189] [033/137] (863s left) gem_pxp (create-regular-context-2)
[195.800241] Subtest create-regular-context-2: SKIP (0.000s)
[195.874039] [034/137] (860s left) gem_exec_params (sol-reset-invalid)
[195.928783] Starting subtest: sol-reset-invalid
[195.929460] Subtest sol-reset-invalid: SUCCESS (0.001s)
[196.039170] [035/137] (860s left) perf (global-sseu-config)
[196.168203] Starting subtest: global-sseu-config
[196.168903] Starting dynamic subtest: 0-rcs0
[196.188345] Dynamic subtest 0-rcs0: SUCCESS (0.021s)
[196.189035] Subtest global-sseu-config: SUCCESS (0.021s)
[196.211393] [036/137] (860s left) kms_flip (2x-busy-flip)
[196.296167] Starting subtest: 2x-busy-flip
[196.297488] Subtest 2x-busy-flip: SKIP (0.001s)
[196.401951] [037/137] (860s left) kms_vblank (pipe-d-ts-continuation-idle)
[196.500415] Subtest pipe-D-ts-continuation-idle: SKIP (0.000s)
[196.551471] [038/137] (860s left) drm_fdinfo (idle)
[196.602621] Starting subtest: idle
[196.603316] Starting dynamic subtest: rcs0
[197.135065] Dynamic subtest rcs0: FAIL (0.523s)
[197.143026] Starting dynamic subtest: bcs0
[197.628502] Dynamic subtest bcs0: SUCCESS (0.501s)
[197.635301] Starting dynamic subtest: vcs0
[198.130655] Dynamic subtest vcs0: SUCCESS (0.502s)
[198.138094] Starting dynamic subtest: vecs0
[198.632861] Dynamic subtest vecs0: SUCCESS (0.502s)
[198.634155] Subtest idle: FAIL (2.030s)
[198.702508] [039/137] (857s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[198.960923] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[199.044652] [040/137] (857s left) perf (rc6-disable)
[199.122382] Starting subtest: rc6-disable
[199.304645] Subtest rc6-disable: SUCCESS (0.182s)
[199.349760] [041/137] (857s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[199.617333] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[199.700052] [042/137] (856s left) kms_dp_aux_dev
[200.702845] [043/137] (856s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[200.830310] Starting subtest: y-tiled-64bpp-rotate-180
[202.953540] Subtest y-tiled-64bpp-rotate-180: SUCCESS (2.123s)
[203.078017] [044/137] (853s left) gem_flink_basic (double-flink)
[203.120125] Starting subtest: double-flink
[203.120878] Subtest double-flink: SUCCESS (0.000s)
[203.209504] [045/137] (853s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[203.298204] Starting subtest: x-tiled-8bpp-rotate-270
[203.349709] Subtest x-tiled-8bpp-rotate-270: SKIP (0.051s)
[203.439220] [046/137] (853s left) kms_vblank (pipe-b-query-idle-hang)
[203.518710] Starting subtest: pipe-B-query-idle-hang
[218.075700] Subtest pipe-B-query-idle-hang: SUCCESS (14.558s)
[218.204174] [047/137] (838s left) v3d/v3d_job_submission (array-job-submission)
[218.289198] Subtest array-job-submission: SKIP (0.000s)
[218.350266] [048/137] (838s left) gem_exec_params (secure-non-master)
[218.398505] Starting subtest: secure-non-master
[218.399860] Subtest secure-non-master: SKIP (0.000s)
[218.508758] [049/137] (838s left) perf_pmu (most-busy-idle-check-all)
[218.566386] Starting subtest: most-busy-idle-check-all
[218.567109] Starting dynamic subtest: rcs0
[219.182505] Dynamic subtest rcs0: SUCCESS (0.616s)
[219.189600] Starting dynamic subtest: bcs0
[219.800275] Dynamic subtest bcs0: SUCCESS (0.617s)
[219.807646] Starting dynamic subtest: vcs0
[220.417364] Dynamic subtest vcs0: SUCCESS (0.617s)
[220.424540] Starting dynamic subtest: vecs0
[221.034342] Dynamic subtest vecs0: SUCCESS (0.617s)
[221.035560] Subtest most-busy-idle-check-all: SUCCESS (2.468s)
[221.122269] [050/137] (835s left) kms_rotation_crc (primary-rotation-180)
[221.204544] Starting subtest: primary-rotation-180
[229.070166] Subtest primary-rotation-180: SUCCESS (7.865s)
[229.217650] [051/137] (827s left) i915_pm_rpm (pc8-residency)
[230.594844] Starting subtest: pc8-residency
[230.597124] Subtest pc8-residency: SKIP (0.000s)
[230.802862] [052/137] (826s left) gem_mmap_gtt (fault-concurrent)
[230.844516] Starting subtest: fault-concurrent
[233.074338] Subtest fault-concurrent: SUCCESS (2.230s)
[233.198081] [053/137] (823s left) gem_exec_params (dr4-dirt)
[233.288415] Starting subtest: DR4-dirt
[233.289132] Subtest DR4-dirt: SUCCESS (0.000s)
[233.377482] [054/137] (823s left) sw_sync (sync_merge_invalid)
[233.423563] Starting subtest: sync_merge_invalid
[233.425203] Subtest sync_merge_invalid: SUCCESS (0.002s)
[233.462766] [055/137] (823s left) kms_flip (2x-modeset-vs-vblank-race)
[233.546346] Starting subtest: 2x-modeset-vs-vblank-race
[233.547655] Subtest 2x-modeset-vs-vblank-race: SKIP (0.001s)
[233.624106] [056/137] (823s left) gem_userptr_blits (create-destroy-unsync)
[233.682914] Subtest create-destroy-unsync: SKIP (0.000s)
[233.801260] [057/137] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[233.889809] Starting subtest: fbcpsr-2p-rte
[233.891277] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[233.986670] [058/137] (822s left) api_intel_bb (render)
[234.041733] Starting subtest: render
[234.042467] Starting dynamic subtest: render-none-512
[234.110144] Dynamic subtest render-none-512: SUCCESS (0.068s)
[234.114396] Starting dynamic subtest: render-none-1024
[234.394230] Dynamic subtest render-none-1024: SUCCESS (0.284s)
[234.398437] Starting dynamic subtest: render-x-512
[234.454316] Dynamic subtest render-x-512: SUCCESS (0.060s)
[234.458561] Starting dynamic subtest: render-x-1024
[234.712221] Dynamic subtest render-x-1024: SUCCESS (0.258s)
[234.716475] Starting dynamic subtest: render-y-512
[234.772982] Dynamic subtest render-y-512: SUCCESS (0.061s)
[234.777193] Starting dynamic subtest: render-y-1024
[235.030633] Dynamic subtest render-y-1024: SUCCESS (0.257s)
[235.031336] Subtest render: SUCCESS (0.989s)
[235.122892] [059/137] (821s left) gem_close_race (basic-process)
[235.180213] Starting subtest: basic-process
[235.204951] Subtest basic-process: SUCCESS (0.025s)
[235.396402] [060/137] (821s left) template (a)
[235.452978] Starting subtest: A
[235.453737] Subtest A: SUCCESS (0.000s)
[235.524295] [061/137] (821s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[235.582963] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[235.583689] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[235.657957] [062/137] (821s left) kms_atomic_interruptible (legacy-cursor)
[235.745978] Starting subtest: legacy-cursor
[235.746700] Starting dynamic subtest: HDMI-A-2-pipe-A
[241.901710] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (6.155s)
[241.902393] Subtest legacy-cursor: SUCCESS (6.156s)
[242.013115] [063/137] (815s left) gem_softpin (noreloc-interruptible)
[242.056398] Starting subtest: noreloc-interruptible
[247.449974] Subtest noreloc-interruptible: SUCCESS (5.393s)
[247.564713] [064/137] (809s left) kms_vblank (pipe-a-wait-forked-busy-hang)
[247.644786] Starting subtest: pipe-A-wait-forked-busy-hang
[262.119305] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (14.475s)
[262.230924] [065/137] (794s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[262.311744] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[264.650090] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (2.340s)
[264.787111] [066/137] (792s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[264.917261] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[265.250124] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SUCCESS (0.332s)
[265.485939] [067/137] (791s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[265.602515] Starting subtest: plane-primary-overlay-mutable-zpos
[265.604504] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.000s)
[265.750277] [068/137] (791s left) kms_chamelium_color (gamma)
[265.826639] Subtest gamma: SKIP (0.000s)
[265.838656] [069/137] (791s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs)
[265.913910] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs
[265.915258] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[266.169873] [070/137] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[266.250060] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[266.251392] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[266.332817] [071/137] (790s left) i915_pm_backlight (bad-brightness)
[266.426970] Subtest bad-brightness: SKIP (0.000s)
[266.448742] [072/137] (790s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[269.000961] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[269.060100] [073/137] (788s left) gem_render_copy (linear)
[269.118064] Starting subtest: linear
[269.118746] Starting dynamic subtest: smem
[269.182865] Dynamic subtest smem: SUCCESS (0.065s)
[269.183542] Subtest linear: SUCCESS (0.065s)
[269.378939] [074/137] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[269.470286] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[269.471580] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[269.587357] [075/137] (787s left) syncobj_timeline (wait-all-delayed-signal)
[269.644145] Starting subtest: wait-all-delayed-signal
[269.746932] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[269.828653] [076/137] (787s left) gem_mmap_wc (bad-object)
[269.883078] Starting subtest: bad-object
[269.883762] Subtest bad-object: SUCCESS (0.000s)
[269.984686] [077/137] (787s left) gem_ccs (ctrl-surf-copy)
[270.041709] Starting subtest: ctrl-surf-copy
[270.043043] Subtest ctrl-surf-copy: SKIP (0.000s)
[270.113885] [078/137] (787s left) syncobj_wait (multi-wait-all-submitted-signaled)
[270.171182] Starting subtest: multi-wait-all-submitted-signaled
[270.274557] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[270.365612] [079/137] (786s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[270.449398] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[270.450720] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[270.554797] [080/137] (786s left) kms_psr (sprite_plane_onoff)
[270.607441] Subtest sprite_plane_onoff: SKIP (0.000s)
[270.622985] [081/137] (786s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[270.704935] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[270.705612] Starting dynamic subtest: pipe-A-HDMI-A-2
[270.830731] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.126s)
[270.835429] Starting dynamic subtest: pipe-B-HDMI-A-2
[270.949615] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.118s)
[270.950299] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.246s)
[271.058362] [082/137] (786s left) perf_pmu (invalid-init)
[271.100890] Starting subtest: invalid-init
[271.101569] Subtest invalid-init: SUCCESS (0.000s)
[271.153094] [083/137] (786s left) i915_pm_dc (dc6-psr)
[272.235393] Starting subtest: dc6-psr
[272.236993] Subtest dc6-psr: SKIP (0.000s)
[272.382708] [084/137] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[272.467631] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[272.468970] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[272.558045] [085/137] (784s left) syncobj_wait (wait-for-submit-delayed-submit)
[272.615565] Starting subtest: wait-for-submit-delayed-submit
[272.717953] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[272.808713] [086/137] (784s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[272.863381] Subtest writes-after-reads-snoop: SKIP (0.000s)
[272.924674] [087/137] (784s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[273.014576] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[273.015892] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[273.102953] [088/137] (784s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[273.197414] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[275.261344] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.065s)
[275.405308] [089/137] (782s left) vc4/vc4_create_bo (create-bo-4096)
[275.487965] Subtest create-bo-4096: SKIP (0.000s)
[275.555153] [090/137] (781s left) gem_exec_balancer (smoke)
[275.606128] Starting subtest: smoke
[276.358762] Subtest smoke: SUCCESS (0.752s)
[277.333096] [091/137] (780s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[277.415068] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[278.637146] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.222s)
[278.777620] [092/137] (778s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[278.864842] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[278.865529] Starting dynamic subtest: pipe-A-valid-mode
[278.908329] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s)
[278.909713] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.044s)
[278.991958] [093/137] (778s left) kms_atomic_transition (plane-all-transition-fencing)
[279.067851] Starting subtest: plane-all-transition-fencing
[279.068532] Starting dynamic subtest: pipe-A-HDMI-A-2
[283.307345] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.239s)
[283.374678] Starting dynamic subtest: pipe-B-HDMI-A-2
[287.662931] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.291s)
[287.707859] Subtest plane-all-transition-fencing: SUCCESS (8.641s)
[287.832831] [094/137] (769s left) sysfs_timeslice_duration (duration)
[287.878200] Starting subtest: duration
[287.878905] Starting dynamic subtest: vecs0
[287.928606] Dynamic subtest vecs0: SUCCESS (0.049s)
[287.939687] Starting dynamic subtest: vcs0
[287.982663] Dynamic subtest vcs0: SUCCESS (0.053s)
[287.993590] Starting dynamic subtest: bcs0
[288.040528] Dynamic subtest bcs0: SUCCESS (0.057s)
[288.052076] Starting dynamic subtest: rcs0
[288.100602] Dynamic subtest rcs0: SUCCESS (0.059s)
[288.101867] Subtest duration: SUCCESS (0.222s)
[288.175918] [095/137] (769s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[288.260367] Starting subtest: psr-rgb101010-draw-pwrite
[288.261826] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[288.385454] [096/137] (769s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[288.574458] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[288.575243] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[288.729705] [097/137] (768s left) prime_busy (hang)
[288.776408] Starting subtest: hang
[288.777157] Starting dynamic subtest: rcs0
[303.035399] Dynamic subtest rcs0: SUCCESS (14.258s)
[303.039720] Starting dynamic subtest: bcs0
[309.883454] Dynamic subtest bcs0: SUCCESS (6.847s)
[309.887719] Starting dynamic subtest: vcs0
[316.923456] Dynamic subtest vcs0: SUCCESS (7.040s)
[316.927797] Starting dynamic subtest: vecs0
[323.899421] Dynamic subtest vecs0: SUCCESS (6.976s)
[323.900093] Subtest hang: SUCCESS (35.122s)
[323.994911] [098/137] (733s left) gem_exec_schedule (u-fairslice)
[324.048183] Starting subtest: u-fairslice
[324.048874] Starting dynamic subtest: rcs0
[326.059705] Dynamic subtest rcs0: SUCCESS (2.011s)
[326.065993] Starting dynamic subtest: bcs0
[328.068861] Dynamic subtest bcs0: SUCCESS (2.009s)
[328.075235] Starting dynamic subtest: vcs0
[330.080875] Dynamic subtest vcs0: SUCCESS (2.008s)
[330.085676] Starting dynamic subtest: vecs0
[332.090079] Dynamic subtest vecs0: SUCCESS (2.012s)
[332.091185] Subtest u-fairslice: SUCCESS (8.042s)
[332.401796] [099/137] (725s left) gem_ctx_persistence (legacy-engines-queued)
[332.463393] Starting subtest: legacy-engines-queued
[332.464092] Starting dynamic subtest: render
[332.505269] Dynamic subtest render: SUCCESS (0.041s)
[332.519054] Starting dynamic subtest: bsd
[332.549211] Dynamic subtest bsd: SUCCESS (0.043s)
[332.562810] Starting dynamic subtest: blt
[332.593231] Dynamic subtest blt: SUCCESS (0.043s)
[332.606371] Starting dynamic subtest: vebox
[332.639237] Dynamic subtest vebox: SUCCESS (0.045s)
[332.640381] Subtest legacy-engines-queued: SUCCESS (0.175s)
[332.729901] [100/137] (724s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[332.779425] Starting subtest: legacy-engines-hostile-preempt
[332.780134] Starting dynamic subtest: render
[332.861343] Dynamic subtest render: SUCCESS (0.081s)
[332.868829] Starting dynamic subtest: bsd
[332.952287] Dynamic subtest bsd: SUCCESS (0.090s)
[332.967422] Starting dynamic subtest: blt
[333.036283] Dynamic subtest blt: SUCCESS (0.083s)
[333.051120] Starting dynamic subtest: vebox
[333.124273] Dynamic subtest vebox: SUCCESS (0.087s)
[333.125427] Subtest legacy-engines-hostile-preempt: SUCCESS (0.344s)
[333.204785] [101/137] (724s left) kms_psr (psr2_primary_render)
[333.260720] Subtest psr2_primary_render: SKIP (0.000s)
[333.272597] [102/137] (724s left) kms_chamelium_audio (hdmi-audio-edid)
[333.387508] Subtest hdmi-audio-edid: SKIP (0.000s)
[333.437540] [103/137] (724s left) kms_flip (flip-vs-blocking-wf-vblank)
[333.511322] Starting subtest: flip-vs-blocking-wf-vblank
[333.512062] Starting dynamic subtest: A-HDMI-A2
[349.203370] Dynamic subtest A-HDMI-A2: SUCCESS (15.692s)
[349.211457] Starting dynamic subtest: B-HDMI-A2
[364.843400] Dynamic subtest B-HDMI-A2: SUCCESS (15.639s)
[364.844328] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.334s)
[364.971789] [104/137] (692s left) gem_vm_create (invalid-create)
[365.015604] Starting subtest: invalid-create
[365.016320] Subtest invalid-create: SUCCESS (0.000s)
[365.117556] [105/137] (692s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[365.194965] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[365.195679] Starting dynamic subtest: pipe-A-HDMI-A-2
[365.301034] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.105s)
[365.305795] Starting dynamic subtest: pipe-B-HDMI-A-2
[365.419664] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.118s)
[365.420338] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.226s)
[365.529930] [106/137] (692s left) kms_properties (get_properties-sanity-non-atomic)
[365.607045] Starting subtest: get_properties-sanity-non-atomic
[365.607755] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[365.662676] [107/137] (692s left) i915_suspend (basic-s2idle-without-i915)
[365.708419] Starting subtest: basic-s2idle-without-i915
[385.476283] Subtest basic-s2idle-without-i915: SUCCESS (19.768s)
[386.559040] [108/137] (672s left) kms_flip (2x-plain-flip)
[386.637638] Starting subtest: 2x-plain-flip
[386.638979] Subtest 2x-plain-flip: SKIP (0.001s)
[386.751055] [109/137] (672s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[386.799529] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[386.906492] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[386.998096] [110/137] (671s left) kms_invalid_mode (uint-max-clock)
[387.088744] Starting subtest: uint-max-clock
[387.089414] Starting dynamic subtest: HDMI-A-2-pipe-A
[387.120698] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (0.032s)
[387.124865] Starting dynamic subtest: HDMI-A-2-pipe-B
[387.125538] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (0.000s)
[387.126213] Subtest uint-max-clock: SUCCESS (0.034s)
[387.226888] [111/137] (671s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[387.309096] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[387.311336] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[387.396738] [112/137] (671s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[387.490535] Starting subtest: x-tiled-16bpp-rotate-0
[388.961567] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.471s)
[389.139524] [113/137] (669s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[389.226276] Starting subtest: yf-tiled-64bpp-rotate-0
[389.227619] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[389.336342] [114/137] (669s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[389.421553] Starting subtest: fbcpsr-stridechange
[389.422994] Subtest fbcpsr-stridechange: SKIP (0.000s)
[389.521533] [115/137] (669s left) gem_exec_fence (syncobj-channel)
[389.841244] Starting subtest: syncobj-channel
[390.856692] Subtest syncobj-channel: SUCCESS (1.015s)
[391.168125] [116/137] (667s left) gen9_exec_parse (batch-invalid-length)
[391.214551] Subtest batch-invalid-length: SKIP (0.000s)
[391.247186] [117/137] (667s left) gem_ctx_exec (basic-invalid-context)
[391.303789] Starting subtest: basic-invalid-context
[391.305385] Subtest basic-invalid-context: SUCCESS (0.001s)
[391.407392] [118/137] (667s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[391.491207] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[391.492521] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[391.594218] [119/137] (667s left) gem_linear_blits (basic)
[391.842090] Starting subtest: basic
[391.845301] Subtest basic: SUCCESS (0.003s)
[391.961221] [120/137] (667s left) fbdev (info)
[392.048791] Starting subtest: info
[392.049478] Subtest info: SUCCESS (0.000s)
[392.119630] [121/137] (666s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[392.215577] Starting subtest: fbc-farfromfence-mmap-gtt
[394.938336] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (2.724s)
[395.040496] [122/137] (664s left) kms_vblank (pipe-a-query-forked-busy)
[395.129027] Starting subtest: pipe-A-query-forked-busy
[397.893186] Subtest pipe-A-query-forked-busy: SUCCESS (2.764s)
[398.009699] [123/137] (661s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[398.086175] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[398.086866] Starting dynamic subtest: pipe-A-valid-mode
[399.387511] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.300s)
[399.388209] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (1.301s)
[399.494779] [124/137] (659s left) api_intel_allocator (simple-allocator)
[399.537093] Starting subtest: simple-allocator
[399.537783] Starting dynamic subtest: basic
[399.539574] Dynamic subtest basic: SUCCESS (0.001s)
[399.544394] Starting dynamic subtest: parallel-one
[399.606554] Dynamic subtest parallel-one: SUCCESS (0.067s)
[399.615524] Starting dynamic subtest: print
[399.616264] Dynamic subtest print: SUCCESS (0.000s)
[399.621041] Starting dynamic subtest: reuse
[399.621756] Dynamic subtest reuse: SUCCESS (0.000s)
[399.626482] Starting dynamic subtest: reserve
[399.627198] Dynamic subtest reserve: SUCCESS (0.000s)
[399.631672] Starting dynamic subtest: fork-reopen-allocator
[399.632382] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[399.633091] Subtest simple-allocator: SUCCESS (0.085s)
[399.705440] [125/137] (659s left) gem_userptr_blits (unsync-unmap-after-close)
[399.761311] Subtest unsync-unmap-after-close: SKIP (0.000s)
[399.876912] [126/137] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[399.964904] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[399.966240] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[400.087143] [127/137] (659s left) gem_eio (in-flight-contexts-1us)
[400.147878] Starting subtest: in-flight-contexts-1us
[411.208604] Subtest in-flight-contexts-1us: SUCCESS (11.061s)
[411.272248] [128/137] (647s left) gem_exec_store (dword)
[411.319156] Starting subtest: dword
[411.319862] Starting dynamic subtest: rcs0
[411.355456] Dynamic subtest rcs0: SUCCESS (0.036s)
[411.364821] Starting dynamic subtest: bcs0
[411.370401] Dynamic subtest bcs0: SUCCESS (0.014s)
[411.381235] Starting dynamic subtest: vcs0
[411.390047] Dynamic subtest vcs0: SUCCESS (0.019s)
[411.399555] Starting dynamic subtest: vecs0
[411.406971] Dynamic subtest vecs0: SUCCESS (0.016s)
[411.407807] Subtest dword: SUCCESS (0.088s)
[411.604096] [129/137] (647s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[411.695899] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[411.697261] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[411.812527] [130/137] (647s left) kms_cursor_crc (cursor-offscreen-32x10)
[411.900156] Starting subtest: cursor-offscreen-32x10
[411.925702] Subtest cursor-offscreen-32x10: SKIP (0.024s)
[412.017738] [131/137] (647s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[412.154774] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[412.156109] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[412.370315] [132/137] (646s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[412.450018] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[412.451371] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[412.542911] [133/137] (646s left) syncobj_wait (invalid-reset-illegal-handle)
[412.601588] Starting subtest: invalid-reset-illegal-handle
[412.602303] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[412.669131] [134/137] (646s left) kms_scaling_modes (scaling-mode-none)
[412.753172] Starting subtest: scaling-mode-none
[412.754559] Subtest scaling-mode-none: SKIP (0.000s)
[412.808144] [135/137] (646s left) v3d/v3d_submit_cl (bad-multisync-pad)
[412.890706] Subtest bad-multisync-pad: SKIP (0.000s)
[412.959965] [136/137] (646s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs)
[413.221025] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[413.307294] [137/137] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[413.387103] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[415.856966] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.472s)
[415.995596] Closing watchdogs
Done.