[59.280999] Initializing watchdogs
[59.281371]   /dev/watchdog0
[59.297125] [001/137] (960s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[59.625511] Starting subtest: primary-4-tiled-reflect-x-180
[59.628358] Subtest primary-4-tiled-reflect-x-180: SKIP (0.004s)
[59.706304] [002/137] (960s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[60.013439] Starting subtest: basic-flip-before-cursor-varying-size
[61.306146] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.291s)
[61.634605] [003/137] (958s left) gem_set_tiling_vs_pwrite
[61.967557] [004/137] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[62.274321] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[62.276817] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[62.367347] [005/137] (957s left) kms_flip (2x-nonexisting-fb)
[62.656385] Starting subtest: 2x-nonexisting-fb
[62.658993] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[62.768558] [006/137] (957s left) gem_exec_balancer (hang)
[66.806580] Starting subtest: hang
[70.388768] Subtest hang: SUCCESS (3.582s)
[70.483900] [007/137] (949s left) gem_ctx_shared (exec-single-timeline)
[70.711271] Starting subtest: exec-single-timeline
[70.712971] Starting dynamic subtest: rcs0
[71.821759] Dynamic subtest rcs0: SUCCESS (1.110s)
[71.841704] Starting dynamic subtest: bcs0
[72.910272] Dynamic subtest bcs0: SUCCESS (1.087s)
[72.931850] Starting dynamic subtest: vcs0
[73.996623] Dynamic subtest vcs0: SUCCESS (1.086s)
[74.014480] Starting dynamic subtest: vecs0
[75.083918] Dynamic subtest vecs0: SUCCESS (1.087s)
[75.085237] Subtest exec-single-timeline: SUCCESS (4.372s)
[75.300737] [008/137] (944s left) gem_exec_params (invalid-fence-in-submit)
[75.510760] Starting subtest: invalid-fence-in-submit
[75.518679] Subtest invalid-fence-in-submit: SUCCESS (0.006s)
[75.618742] [009/137] (944s left) gem_softpin (evict-prime)
[75.828114] Starting subtest: evict-prime
[75.829475] Starting dynamic subtest: rcs0
[76.954722] Dynamic subtest rcs0: SUCCESS (1.126s)
[76.984225] Starting dynamic subtest: bcs0
[78.082134] Dynamic subtest bcs0: SUCCESS (1.127s)
[78.104541] Starting dynamic subtest: vcs0
[79.196981] Dynamic subtest vcs0: SUCCESS (1.115s)
[79.215389] Starting dynamic subtest: vecs0
[80.320188] Dynamic subtest vecs0: SUCCESS (1.122s)
[80.337470] Starting dynamic subtest: all
[81.440118] Dynamic subtest all: SUCCESS (1.120s)
[81.441460] Subtest evict-prime: SUCCESS (5.612s)
[81.518451] [010/137] (938s left) gem_mmap (bad-size)
[81.721679] Starting subtest: bad-size
[81.722946] Subtest bad-size: SUCCESS (0.001s)
[81.817761] [011/137] (938s left) gem_exec_whisper (basic-fds-forked-all)
[82.043462] Starting subtest: basic-fds-forked-all
[105.989473] Subtest basic-fds-forked-all: SUCCESS (23.944s)
[106.188711] [012/137] (913s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[106.501885] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[109.466088] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (2.968s)
[109.602949] [013/137] (910s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[109.913058] Starting subtest: psr-rgb101010-draw-mmap-wc
[109.915486] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[110.003619] [014/137] (910s left) kms_plane_scaling (intel-max-src-size)
[110.296388] Starting subtest: intel-max-src-size
[110.297730] Starting dynamic subtest: pipe-A-DP-1
[110.337638] Dynamic subtest pipe-A-DP-1: SUCCESS (0.045s)
[110.338823] Subtest intel-max-src-size: SUCCESS (0.045s)
[110.436829] [015/137] (909s left) i915_module_load (reload-no-display)
[110.637509] Starting subtest: reload-no-display
[114.368869] Subtest reload-no-display: SUCCESS (3.730s)
[114.399147] [016/137] (905s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[116.100577] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[116.103229] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[116.276329] [017/137] (904s left) api_intel_allocator (open-vm)
[116.505107] Starting subtest: open-vm
[116.519765] Subtest open-vm: SUCCESS (0.015s)
[116.626778] [018/137] (903s left) kms_chamelium_hpd (hdmi-hpd-storm)
[117.007768] Subtest hdmi-hpd-storm: SKIP (0.000s)
[117.300218] [019/137] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[117.609167] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[117.611690] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[117.712365] [020/137] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[118.019725] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[118.022286] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[118.111994] [021/137] (902s left) gem_pwrite (basic-exhaustion)
[118.311296] Starting subtest: basic-exhaustion
[139.674224] Subtest basic-exhaustion: SUCCESS (21.362s)
[139.784168] [022/137] (880s left) kms_chamelium_frames (dp-crc-single)
[140.177890] Subtest dp-crc-single: SKIP (0.000s)
[140.474040] [023/137] (880s left) gem_spin_batch (legacy)
[140.705071] Starting subtest: legacy
[140.706462] Starting dynamic subtest: default
[144.035418] Dynamic subtest default: SUCCESS (3.327s)
[144.054590] Starting dynamic subtest: render
[147.357953] Dynamic subtest render: SUCCESS (3.322s)
[147.375296] Starting dynamic subtest: bsd
[150.681398] Dynamic subtest bsd: SUCCESS (3.322s)
[150.698154] Starting dynamic subtest: bsd1
[154.001957] Dynamic subtest bsd1: SUCCESS (3.321s)
[154.019676] Starting dynamic subtest: blt
[157.327783] Dynamic subtest blt: SUCCESS (3.325s)
[157.344085] Starting dynamic subtest: vebox
[160.649621] Dynamic subtest vebox: SUCCESS (3.321s)
[160.651123] Subtest legacy: SUCCESS (19.945s)
[160.853343] [024/137] (859s left) kms_flip (2x-flip-vs-panning-interruptible)
[161.148280] Starting subtest: 2x-flip-vs-panning-interruptible
[161.152809] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.003s)
[161.253410] [025/137] (859s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[161.547764] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[161.549223] Starting dynamic subtest: pipe-A-valid-mode
[162.241630] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.691s)
[162.242938] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (0.694s)
[162.579878] [026/137] (858s left) kms_content_protection (dp-mst-lic-type-0)
[162.906978] Starting subtest: dp-mst-lic-type-0
[162.909599] Subtest dp-mst-lic-type-0: SKIP (0.001s)
[163.012606] [027/137] (857s left) syncobj_timeline (invalid-signal-bad-pad)
[163.217923] Starting subtest: invalid-signal-bad-pad
[163.219733] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[163.298241] [028/137] (857s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[163.596575] Starting subtest: fbc-rgb101010-draw-mmap-wc
[166.245465] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.648s)
[166.362622] [029/137] (854s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[166.662103] Starting subtest: plane-upscale-with-rotation-factor-0-25
[166.663556] Starting dynamic subtest: pipe-A-DP-1
[166.712978] Dynamic subtest pipe-A-DP-1: SKIP (0.049s)
[166.731567] Starting dynamic subtest: pipe-B-DP-1
[167.069384] Dynamic subtest pipe-B-DP-1: SKIP (0.351s)
[167.093943] Starting dynamic subtest: pipe-C-DP-1
[167.429284] Dynamic subtest pipe-C-DP-1: SKIP (0.355s)
[167.431760] Subtest plane-upscale-with-rotation-factor-0-25: SKIP (0.767s)
[167.814300] [030/137] (852s left) gem_exec_fair (basic-none)
[168.044679] Starting subtest: basic-none
[168.046275] Starting dynamic subtest: rcs0
[173.689419] Dynamic subtest rcs0: SUCCESS (5.643s)
[173.708649] Starting dynamic subtest: bcs0
[173.711496] Dynamic subtest bcs0: SKIP (0.009s)
[173.729993] Starting dynamic subtest: vcs0
[179.756388] Dynamic subtest vcs0: SUCCESS (6.057s)
[179.774765] Starting dynamic subtest: vecs0
[185.832201] Dynamic subtest vecs0: SUCCESS (6.076s)
[185.833661] Subtest basic-none: SUCCESS (17.787s)
[186.031518] [031/137] (834s left) vc4/vc4_label_bo (set-label)
[186.296832] Subtest set-label: SKIP (0.000s)
[186.364359] [032/137] (834s left) gem_mmap_offset (perf)
[186.562900] Starting subtest: perf
[186.564263] Starting dynamic subtest: smem0
[186.862334] Dynamic subtest smem0: SUCCESS (0.297s)
[186.863558] Subtest perf: SUCCESS (0.298s)
[186.965747] [033/137] (833s left) gem_exec_fence (syncobj-timeline-unused-fence)
[187.762967] Starting subtest: syncobj-timeline-unused-fence
[187.768308] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[187.983140] [034/137] (832s left) vc4/vc4_tiling (set-bad-flags)
[188.245964] Subtest set-bad-flags: SKIP (0.000s)
[188.313960] [035/137] (832s left) gem_bad_reloc (negative-reloc-lut)
[188.522595] Starting subtest: negative-reloc-lut
[188.529907] Subtest negative-reloc-lut: SUCCESS (0.002s)
[188.632142] [036/137] (832s left) gem_mmap (basic)
[188.827144] Starting subtest: basic
[188.833613] Subtest basic: SUCCESS (0.001s)
[188.931850] [037/137] (832s left) kms_cursor_crc (cursor-sliding-64x21)
[189.241781] Starting subtest: cursor-sliding-64x21
[189.253933] Starting dynamic subtest: pipe-A-DP-1
[192.923807] Dynamic subtest pipe-A-DP-1: SUCCESS (3.670s)
[193.002472] Starting dynamic subtest: pipe-C-DP-1
[196.961090] Dynamic subtest pipe-C-DP-1: SUCCESS (3.977s)
[196.962397] Subtest cursor-sliding-64x21: SUCCESS (7.719s)
[197.320355] [038/137] (823s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[197.539265] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[197.540697] Starting dynamic subtest: smem
[197.872142] Dynamic subtest smem: SUCCESS (0.332s)
[197.873431] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.333s)
[198.068845] [039/137] (823s left) gem_lmem_swapping (massive-random)
[198.275621] Subtest massive-random: SKIP (0.000s)
[198.336960] [040/137] (822s left) perf (create-destroy-userspace-config)
[198.665536] Starting subtest: create-destroy-userspace-config
[198.750459] Subtest create-destroy-userspace-config: SUCCESS (0.086s)
[198.799671] [041/137] (822s left) gem_exec_schedule (u-submit-golden-slice)
[199.034764] Starting subtest: u-submit-golden-slice
[199.036487] Starting dynamic subtest: rcs0
[199.095439] Dynamic subtest rcs0: SUCCESS (0.060s)
[199.118886] Starting dynamic subtest: bcs0
[199.144229] Dynamic subtest bcs0: SUCCESS (0.048s)
[199.166639] Starting dynamic subtest: vcs0
[199.194803] Dynamic subtest vcs0: SUCCESS (0.049s)
[199.216408] Starting dynamic subtest: vecs0
[199.241528] Dynamic subtest vecs0: SUCCESS (0.047s)
[199.243082] Subtest u-submit-golden-slice: SUCCESS (0.207s)
[199.603233] [042/137] (821s left) syncobj_timeline (transfer-timeline-point)
[199.802306] Starting subtest: transfer-timeline-point
[199.804396] Subtest transfer-timeline-point: SUCCESS (0.002s)
[199.884116] [043/137] (821s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[200.148154] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[200.218182] [044/137] (821s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[200.637611] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[200.640203] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[201.246755] [045/137] (820s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[201.543172] Starting subtest: basic-busy-flip-before-cursor-varying-size
[201.545979] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[201.630784] [046/137] (819s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[202.155793] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[202.158616] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[202.659692] [047/137] (818s left) gem_tiling_max_stride
[203.010880] [048/137] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[203.315059] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[203.317590] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[203.409524] [049/137] (818s left) device_reset (cold-reset-bound)
[203.646545] Subtest cold-reset-bound: SKIP (0.000s)
[203.726605] [050/137] (817s left) sysfs_defaults (readonly)
[203.930518] Starting subtest: readonly
[203.932391] Starting dynamic subtest: vecs0
[203.933836] Dynamic subtest vecs0: SUCCESS (0.001s)
[203.953794] Starting dynamic subtest: vcs0
[203.955189] Dynamic subtest vcs0: SUCCESS (0.001s)
[203.973342] Starting dynamic subtest: bcs0
[203.974657] Dynamic subtest bcs0: SUCCESS (0.001s)
[203.992944] Starting dynamic subtest: rcs0
[203.994227] Dynamic subtest rcs0: SUCCESS (0.002s)
[203.995468] Subtest readonly: SUCCESS (0.009s)
[204.043501] [051/137] (817s left) dmabuf_sync_file (import-multiple-read-only)
[204.254920] Starting subtest: import-multiple-read-only
[204.267979] Subtest import-multiple-read-only: SUCCESS (0.013s)
[204.344442] [052/137] (817s left) perf_pmu (module-unload)
[204.571306] Starting subtest: module-unload
[241.928480] Subtest module-unload: SUCCESS (37.357s)
[241.961127] [053/137] (779s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[243.663913] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[243.668709] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[243.818974] [054/137] (777s left) kms_addfb_basic (bad-pitch-999)
[244.107451] Starting subtest: bad-pitch-999
[244.108702] Subtest bad-pitch-999: SUCCESS (0.000s)
[244.323838] [055/137] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[244.643706] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[244.646738] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[244.735046] [056/137] (777s left) gem_exec_reloc (basic-softpin)
[244.980652] Starting subtest: basic-softpin
[244.990402] Subtest basic-softpin: SUCCESS (0.010s)
[245.187448] [057/137] (776s left) gem_readwrite (beyond-eob)
[245.390354] Starting subtest: beyond-EOB
[245.393216] Subtest beyond-EOB: SUCCESS (0.000s)
[245.487807] [058/137] (776s left) kms_fbcon_fbt (fbc)
[245.698684] Starting subtest: fbc
[249.602957] Subtest fbc: SUCCESS (3.903s)
[249.652881] [059/137] (772s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[249.867352] Starting subtest: untiled-to-tiled
[249.990817] Subtest untiled-to-tiled: SUCCESS (0.123s)
[250.090709] [060/137] (771s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[250.407925] Starting subtest: yf-tiled-16bpp-rotate-180
[254.269980] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.861s)
[254.591798] [061/137] (767s left) kms_lease (setcrtc_implicit_plane)
[254.900170] Starting subtest: setcrtc_implicit_plane
[254.901758] Starting dynamic subtest: pipe-A-DP-1
[255.204956] Dynamic subtest pipe-A-DP-1: SUCCESS (0.305s)
[255.230779] Starting dynamic subtest: pipe-B-DP-1
[255.782375] Dynamic subtest pipe-B-DP-1: SUCCESS (0.569s)
[255.801678] Starting dynamic subtest: pipe-C-DP-1
[256.499420] Dynamic subtest pipe-C-DP-1: SUCCESS (0.713s)
[256.500716] Subtest setcrtc_implicit_plane: SUCCESS (1.599s)
[256.831095] [062/137] (765s left) gem_softpin (noreloc-s3)
[257.041392] Starting subtest: noreloc-S3
[277.058331] Subtest noreloc-S3: SUCCESS (5.483s)
[279.176401] [063/137] (759s left) gem_ctx_exec (basic-norecovery)
[279.381910] Starting subtest: basic-norecovery
[279.420973] Subtest basic-norecovery: SUCCESS (0.040s)
[279.523452] [064/137] (759s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[279.818786] Starting subtest: basic-busy-flip-before-cursor-legacy
[279.821297] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[279.905627] [065/137] (758s left) kms_chamelium_color (ctm-0-50)
[280.205838] Subtest ctm-0-50: SKIP (0.000s)
[280.255491] [066/137] (758s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[280.554053] Starting subtest: compare-crc-sanitycheck
[280.555421] Starting dynamic subtest: pipe-A-DP-1
[280.980316] Dynamic subtest pipe-A-DP-1: SUCCESS (0.425s)
[281.005876] Starting dynamic subtest: pipe-B-DP-1
[281.701765] Dynamic subtest pipe-B-DP-1: SUCCESS (0.716s)
[281.728803] Starting dynamic subtest: pipe-C-DP-1
[282.544235] Dynamic subtest pipe-C-DP-1: SUCCESS (0.837s)
[282.545531] Subtest compare-crc-sanitycheck: SUCCESS (1.993s)
[282.880459] [067/137] (755s left) perf_pmu (busy-check-all)
[283.086589] Starting subtest: busy-check-all
[283.088276] Starting dynamic subtest: rcs0
[283.621312] Dynamic subtest rcs0: SUCCESS (0.534s)
[283.646105] Starting dynamic subtest: bcs0
[284.151351] Dynamic subtest bcs0: SUCCESS (0.529s)
[284.175889] Starting dynamic subtest: vcs0
[284.683248] Dynamic subtest vcs0: SUCCESS (0.531s)
[284.706431] Starting dynamic subtest: vecs0
[285.215021] Dynamic subtest vecs0: SUCCESS (0.530s)
[285.216423] Subtest busy-check-all: SUCCESS (2.128s)
[285.313554] [068/137] (753s left) kms_getfb (getfb2-into-addfb2)
[285.516098] Starting subtest: getfb2-into-addfb2
[285.517760] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[285.613419] [069/137] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[285.929087] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[285.931760] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[286.030555] [070/137] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[286.347116] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[286.349908] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[286.447627] [071/137] (752s left) i915_suspend (forcewake)
[286.647109] Starting subtest: forcewake
[322.595001] Subtest forcewake: SUCCESS (2.812s)
[328.364526] [072/137] (749s left) kms_vrr (flip-dpms)
[328.668794] Starting subtest: flip-dpms
[328.671597] Subtest flip-dpms: SKIP (0.000s)
[328.729582] [073/137] (749s left) kms_content_protection (srm)
[329.060819] Starting subtest: srm
[329.090109] Starting dynamic subtest: pipe-A-DP-1
[450.076796] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[450.808630] Closing watchdogs
[450.814210] Initializing watchdogs
[450.814386]   /dev/watchdog0
[450.840010] [074/137] (626s left) gen9_exec_parse (allowed-all)
[451.071603] Starting subtest: allowed-all
[451.075621] Subtest allowed-all: SUCCESS (0.003s)
[451.298178] [075/137] (626s left) kms_flip (2x-flip-vs-wf_vblank)
[451.586855] Starting subtest: 2x-flip-vs-wf_vblank
[451.589426] Subtest 2x-flip-vs-wf_vblank: SKIP (0.003s)
[451.698131] [076/137] (626s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-5)
[451.998957] Starting subtest: plane-downscale-with-pixel-format-factor-0-5
[452.000369] Starting dynamic subtest: pipe-A-DP-1
[454.568342] Dynamic subtest pipe-A-DP-1: SUCCESS (2.568s)
[454.596615] Starting dynamic subtest: pipe-B-DP-1
[457.196589] Dynamic subtest pipe-B-DP-1: SUCCESS (2.625s)
[457.220930] Starting dynamic subtest: pipe-C-DP-1
[457.569138] Dynamic subtest pipe-C-DP-1: SUCCESS (0.369s)
[457.570398] Subtest plane-downscale-with-pixel-format-factor-0-5: SUCCESS (5.574s)
[457.972110] [077/137] (619s left) gem_busy (semaphore)
[458.338665] Starting subtest: semaphore
[458.340185] Starting dynamic subtest: rcs0
[458.382790] Dynamic subtest rcs0: SUCCESS (0.044s)
[458.414231] Starting dynamic subtest: bcs0
[458.415804] Dynamic subtest bcs0: SUCCESS (0.030s)
[458.442604] Starting dynamic subtest: vcs0
[458.444311] Dynamic subtest vcs0: SUCCESS (0.029s)
[458.467926] Starting dynamic subtest: vecs0
[458.474539] Dynamic subtest vecs0: SUCCESS (0.030s)
[458.475790] Subtest semaphore: SUCCESS (0.138s)
[458.703187] [078/137] (619s left) syncobj_wait (reset-during-wait-for-submit)
[458.906090] Starting subtest: reset-during-wait-for-submit
[459.009738] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[459.103598] [079/137] (618s left) i915_pm_rpm (dpms-non-lpsp)
[460.995551] Starting subtest: dpms-non-lpsp
[461.267026] Subtest dpms-non-lpsp: SUCCESS (0.269s)
[461.486786] [080/137] (616s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[461.803551] Starting subtest: extended-pageflip-modeset-hang-oldfb
[461.808491] Starting dynamic subtest: pipe-A
[463.306591] Dynamic subtest pipe-A: SUCCESS (1.495s)
[463.334642] Starting dynamic subtest: pipe-C
[464.944343] Dynamic subtest pipe-C: SUCCESS (1.629s)
[464.946041] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (3.136s)
[465.301989] [081/137] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[465.605834] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[465.608657] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[465.714284] [082/137] (612s left) syncobj_basic (bad-pad-fd-to-handle)
[465.916271] Starting subtest: bad-pad-fd-to-handle
[465.917660] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[465.998382] [083/137] (612s left) kms_vblank (pipe-c-query-busy)
[466.299804] Starting subtest: pipe-C-query-busy
[469.343115] Subtest pipe-C-query-busy: SUCCESS (3.045s)
[469.682386] [084/137] (608s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[469.886352] Subtest overlay-plane-update-continuous-sf: SKIP (0.000s)
[469.948328] [085/137] (608s left) kms_flip (flip-vs-panning-interruptible)
[470.250313] Starting subtest: flip-vs-panning-interruptible
[470.256784] Starting dynamic subtest: A-DP1
[480.802812] Dynamic subtest A-DP1: SUCCESS (10.548s)
[480.827064] Starting dynamic subtest: B-DP1
[491.318633] Dynamic subtest B-DP1: SUCCESS (10.513s)
[491.342468] Starting dynamic subtest: C-DP1
[501.824558] Dynamic subtest C-DP1: SUCCESS (10.504s)
[501.826843] Subtest flip-vs-panning-interruptible: SUCCESS (31.576s)
[502.262589] [086/137] (576s left) perf (invalid-remove-userspace-config)
[502.569794] Starting subtest: invalid-remove-userspace-config
[502.608695] Subtest invalid-remove-userspace-config: SUCCESS (0.038s)
[502.661966] [087/137] (575s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[502.962776] Starting subtest: fbc-indfb-scaledprimary
[506.119759] Subtest fbc-indfb-scaledprimary: SUCCESS (3.155s)
[506.244176] [088/137] (572s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[506.969850] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[507.271850] [089/137] (571s left) kms_vblank (pipe-c-query-forked-busy)
[507.584007] Starting subtest: pipe-C-query-forked-busy
[510.521394] Subtest pipe-C-query-forked-busy: SUCCESS (2.942s)
[510.854069] [090/137] (567s left) kms_big_fb (linear-8bpp-rotate-270)
[511.182060] Starting subtest: linear-8bpp-rotate-270
[511.264119] Subtest linear-8bpp-rotate-270: SKIP (0.080s)
[511.385808] [091/137] (567s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[511.832179] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[511.834743] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[512.413456] [092/137] (566s left) gem_exec_balancer (parallel-keep-in-fence)
[516.391758] Subtest parallel-keep-in-fence: SKIP (0.000s)
[516.497524] [093/137] (562s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[516.799807] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[516.802454] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[516.913405] [094/137] (561s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[517.223172] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[517.224593] Starting dynamic subtest: pipe-A-valid-mode
[517.318351] Dynamic subtest pipe-A-valid-mode: SKIP (0.093s)
[517.321099] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.097s)
[517.635991] [095/137] (561s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[518.364458] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[518.370421] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.005s)
[518.716024] [096/137] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[519.026041] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[519.029777] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[519.132538] [097/137] (559s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs)
[519.857445] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[520.174316] [098/137] (558s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend)
[520.468466] Starting subtest: pipe-A-ts-continuation-dpms-suspend
[539.208604] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (2.214s)
[544.805150] [099/137] (555s left) perf (invalid-oa-metric-set-id)
[545.110066] Starting subtest: invalid-oa-metric-set-id
[545.169875] Subtest invalid-oa-metric-set-id: SUCCESS (0.059s)
[545.235091] [100/137] (555s left) i915_pm_rpm (i2c)
[547.016557] Starting subtest: i2c
[548.872873] Subtest i2c: SUCCESS (1.855s)
[549.061918] [101/137] (551s left) vgem_basic (dmabuf-fence-before)
[549.266674] Starting subtest: dmabuf-fence-before
[549.268377] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[549.343896] [102/137] (551s left) gen9_exec_parse (bb-start-cmd)
[549.567972] Starting subtest: bb-start-cmd
[549.572446] Subtest bb-start-cmd: SUCCESS (0.005s)
[549.795402] [103/137] (550s left) kms_vblank (pipe-c-query-forked-busy-hang)
[550.094094] Starting subtest: pipe-C-query-forked-busy-hang
[557.174095] Subtest pipe-C-query-forked-busy-hang: SUCCESS (7.081s)
[557.512080] [104/137] (543s left) kms_scaling_modes (scaling-mode-full)
[557.822104] Starting subtest: scaling-mode-full
[557.824776] Subtest scaling-mode-full: SKIP (0.001s)
[557.911612] [105/137] (542s left) i915_pm_rps (fence-order)
[558.123175] Starting subtest: fence-order
[561.240516] Subtest fence-order: SUCCESS (3.115s)
[561.493951] [106/137] (539s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[561.787707] Starting subtest: universal-plane-pipe-B-sanity
[562.604374] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.817s)
[562.931813] [107/137] (537s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[563.249886] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[563.273725] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.025s)
[563.383360] [108/137] (537s left) kms_ccs (pipe-c-ccs-on-another-bo-yf_tiled_ccs)
[564.075451] Starting subtest: pipe-C-ccs-on-another-bo-yf_tiled_ccs
[564.078171] Subtest pipe-C-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[564.419862] [109/137] (536s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[564.623617] Starting subtest: multi-wait-all-for-submit-signaled
[564.624977] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s)
[564.719529] [110/137] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[565.038048] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[565.040736] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[565.136176] [111/137] (535s left) syncobj_basic (create-signaled)
[565.336501] Starting subtest: create-signaled
[565.338491] Subtest create-signaled: SUCCESS (0.001s)
[565.419656] [112/137] (535s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[565.724743] Starting subtest: cursorB-vs-flipB-legacy
[565.727246] Subtest cursorB-vs-flipB-legacy: SKIP (0.003s)
[565.819633] [113/137] (535s left) syncobj_timeline (host-signal-ordered)
[566.022056] Starting subtest: host-signal-ordered
[566.023789] Subtest host-signal-ordered: SUCCESS (0.001s)
[566.119627] [114/137] (534s left) kms_atomic_transition (modeset-transition-nonblocking)
[566.419589] Starting subtest: modeset-transition-nonblocking
[566.421090] Starting dynamic subtest: 1x-outputs
[571.334135] Dynamic subtest 1x-outputs: SUCCESS (4.918s)
[571.423996] Subtest modeset-transition-nonblocking: SUCCESS (5.008s)
[571.757956] [115/137] (529s left) gem_eio (in-flight-internal-immediate)
[571.992884] Starting subtest: in-flight-internal-immediate
[572.082032] Subtest in-flight-internal-immediate: SUCCESS (0.087s)
[572.257005] [116/137] (528s left) kms_cursor_crc (cursor-onscreen-32x32)
[572.557549] Starting subtest: cursor-onscreen-32x32
[572.666581] Subtest cursor-onscreen-32x32: SKIP (0.107s)
[572.789964] [117/137] (528s left) sw_sync (sync_busy_fork)
[572.991637] Starting subtest: sync_busy_fork
[574.026151] Subtest sync_busy_fork: SUCCESS (1.034s)
[574.107380] [118/137] (527s left) gem_exec_flush (basic-uc-pro-default)
[574.332404] Starting subtest: basic-uc-pro-default
[579.820384] Subtest basic-uc-pro-default: SUCCESS (5.485s)
[580.023932] [119/137] (521s left) api_intel_bb (add-remove-objects)
[580.227947] Starting subtest: add-remove-objects
[580.245269] Subtest add-remove-objects: SUCCESS (0.016s)
[580.356619] [120/137] (520s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm)
[580.660778] Starting subtest: pipe-C-ts-continuation-dpms-rpm
[582.915617] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (2.251s)
[583.393332] [121/137] (517s left) kms_psr (primary_mmap_gtt)
[583.597304] Subtest primary_mmap_gtt: SKIP (0.000s)
[583.659496] [122/137] (517s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[583.961332] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[583.964077] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[584.076367] [123/137] (517s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[584.618455] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[584.620987] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[585.107307] [124/137] (516s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[585.414120] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[587.212835] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (1.801s)
[587.341594] [125/137] (514s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[587.918051] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[587.922357] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SUCCESS (0.003s)
[588.406065] [126/137] (513s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[588.723760] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[590.075050] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.352s)
[590.224356] [127/137] (511s left) gem_exec_reloc (basic-gtt-noreloc)
[590.434942] Starting subtest: basic-gtt-noreloc
[590.447493] Subtest basic-gtt-noreloc: SUCCESS (0.013s)
[590.639007] [128/137] (511s left) gem_render_tiled_blits (basic)
[590.855027] Starting subtest: basic
[590.960799] Subtest basic: SUCCESS (0.106s)
[591.037920] [129/137] (510s left) prime_vgem (busy)
[591.268144] Starting subtest: busy
[591.270176] Starting dynamic subtest: rcs0
[591.284322] Dynamic subtest rcs0: SUCCESS (0.015s)
[591.313262] Starting dynamic subtest: vcs0
[591.314575] Dynamic subtest vcs0: SUCCESS (0.020s)
[591.344661] Starting dynamic subtest: vecs0
[591.345922] Dynamic subtest vecs0: SUCCESS (0.026s)
[591.347170] Subtest busy: SUCCESS (0.065s)
[591.456035] [130/137] (510s left) kms_rotation_crc (sprite-rotation-180)
[591.754891] Starting subtest: sprite-rotation-180
[596.124112] Subtest sprite-rotation-180: SUCCESS (4.372s)
[596.554948] [131/137] (505s left) gem_ctx_persistence (heartbeat-hang)
[596.766372] Starting subtest: heartbeat-hang
[597.948882] Subtest heartbeat-hang: SUCCESS (1.183s)
[598.037808] [132/137] (503s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[598.349966] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[598.352542] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[598.454815] [133/137] (503s left) v3d/v3d_submit_csd (bad-multisync-pad)
[598.709667] Subtest bad-multisync-pad: SKIP (0.000s)
[598.787995] [134/137] (503s left) v3d/v3d_perfmon (create-two-perfmon)
[599.042936] Subtest create-two-perfmon: SKIP (0.000s)
[599.120934] [135/137] (502s left) gem_exec_schedule (pi-common)
[599.480758] Starting subtest: pi-common
[599.482116] Starting dynamic subtest: rcs0
[599.578168] Dynamic subtest rcs0: SUCCESS (0.096s)
[599.607046] Starting dynamic subtest: bcs0
[599.671169] Dynamic subtest bcs0: SUCCESS (0.092s)
[599.699983] Starting dynamic subtest: vcs0
[599.761720] Dynamic subtest vcs0: SUCCESS (0.089s)
[599.788497] Starting dynamic subtest: vecs0
[599.851984] Dynamic subtest vecs0: SUCCESS (0.089s)
[599.853233] Subtest pi-common: SUCCESS (0.371s)
[600.052818] [136/137] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[600.368536] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[600.371228] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[600.472055] [137/137] (501s left) kms_flip (absolute-wf_vblank)
[600.760817] Starting subtest: absolute-wf_vblank
[600.762353] Starting dynamic subtest: A-DP1
[611.286761] Dynamic subtest A-DP1: SUCCESS (10.525s)
[611.311582] Starting dynamic subtest: B-DP1
[621.749494] Dynamic subtest B-DP1: SUCCESS (10.460s)
[621.774458] Starting dynamic subtest: C-DP1
[632.198387] Dynamic subtest C-DP1: SUCCESS (10.447s)
[632.200391] Subtest absolute-wf_vblank: SUCCESS (31.443s)
[632.605678] Closing watchdogs
Done.