[32.473356] Initializing watchdogs
[32.473423]   /dev/watchdog0
[32.479975] [001/138] (960s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[34.573565] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[34.576390] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[34.700871] [002/138] (958s left) i915_module_load (reload)
[34.752211] Starting subtest: reload
[39.398404] Subtest reload: SUCCESS (4.647s)
[39.409955] [003/138] (953s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[41.438983] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[41.489989] [004/138] (951s left) gem_lmem_swapping (heavy-verify-random-ccs)
[44.914215] Starting subtest: heavy-verify-random-ccs
[44.915164] Starting dynamic subtest: lmem0
[44.916987] Dynamic subtest lmem0: SKIP (0.000s)
[44.918778] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[46.841698] [005/138] (946s left) gem_fenced_exec_thrash (too-many-fences)
[49.299897] Subtest too-many-fences: SKIP (0.000s)
[50.239471] [006/138] (942s left) kms_atomic_interruptible (universal-setplane-cursor)
[52.197992] Starting subtest: universal-setplane-cursor
[52.199124] Starting dynamic subtest: pipe-A-HDMI-A-4
[58.381715] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.182s)
[58.382667] Subtest universal-setplane-cursor: SUCCESS (6.184s)
[58.482634] [007/138] (934s left) kms_cursor_crc (cursor-sliding-512x170)
[60.668117] Starting subtest: cursor-sliding-512x170
[60.670990] Subtest cursor-sliding-512x170: SKIP (0.002s)
[60.850130] [008/138] (932s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[62.864563] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[62.865724] Starting dynamic subtest: pipe-A-valid-mode
[63.823440] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.958s)
[63.824440] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.960s)
[63.949233] [009/138] (929s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[66.035223] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs
[66.037032] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[66.165851] [010/138] (926s left) kms_properties (get_properties-sanity-non-atomic)
[68.119417] Starting subtest: get_properties-sanity-non-atomic
[68.124228] Subtest get_properties-sanity-non-atomic: SUCCESS (0.005s)
[68.184571] [011/138] (924s left) kms_fence_pin_leak
[68.335728] [012/138] (924s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[70.364428] Starting subtest: cursor-rapid-movement-32x32
[70.406372] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[70.737874] [013/138] (922s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[72.761522] Starting subtest: fbcpsr-indfb-scaledprimary
[72.765856] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[72.871920] [014/138] (920s left) api_intel_bb (intel-bb-blit-none)
[72.987190] Starting subtest: intel-bb-blit-none
[73.766296] Subtest intel-bb-blit-none: SUCCESS (0.779s)
[73.855540] [015/138] (919s left) kms_ccs (pipe-c-random-ccs-data-y-tiled-gen12-rc-ccs)
[75.925062] Starting subtest: pipe-C-random-ccs-data-y-tiled-gen12-rc-ccs
[76.033300] Subtest pipe-C-random-ccs-data-y-tiled-gen12-rc-ccs: SUCCESS (0.108s)
[76.207788] [016/138] (917s left) kms_chamelium_hpd (dp-hpd-storm)
[78.201301] Subtest dp-hpd-storm: SKIP (0.000s)
[78.253504] [017/138] (915s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[80.217438] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[80.219705] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[80.316079] [018/138] (912s left) kms_psr (sprite_blt)
[80.396420] Subtest sprite_blt: SKIP (0.000s)
[80.421975] [019/138] (912s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf)
[80.498334] Subtest overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[80.518761] [020/138] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[82.475555] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[82.477427] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[82.565392] [021/138] (910s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[84.657420] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[84.659141] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[84.874139] [022/138] (908s left) kms_color (deep-color)
[86.833281] Starting subtest: deep-color
[86.840138] Subtest deep-color: SKIP (0.005s)
[86.891583] [023/138] (906s left) gem_spin_batch (spin-all-new)
[86.995652] Starting subtest: spin-all-new
[87.057288] Subtest spin-all-new: SUCCESS (0.063s)
[87.361546] [024/138] (906s left) gem_eio (reset-stress)
[87.598719] Starting subtest: reset-stress
[127.063935] Subtest reset-stress: SUCCESS (39.465s)
[129.062109] [025/138] (864s left) gem_exec_balancer (bonded-semaphore)
[129.206191] Starting subtest: bonded-semaphore
[129.208143] Subtest bonded-semaphore: SKIP (0.000s)
[129.553385] [026/138] (863s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[131.505756] Starting subtest: fb-8bpc-vs-panel-6bpc
[131.507842] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.000s)
[131.577585] [027/138] (861s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[133.612136] Starting subtest: addfb25-y-tiled-small-legacy
[133.613028] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[133.688989] [028/138] (859s left) fbdev (unaligned-read)
[133.804982] Starting subtest: unaligned-read
[133.822618] Subtest unaligned-read: SUCCESS (0.018s)
[133.882817] [029/138] (859s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[135.865768] Starting subtest: 2x-long-cursor-vs-flip-legacy
[135.870317] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.004s)
[135.938115] [030/138] (857s left) gem_exec_fair (basic-pace-solo)
[136.047123] Subtest basic-pace-solo: SKIP (0.000s)
[136.130903] [031/138] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[138.116122] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[138.118093] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[138.189108] [032/138] (855s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[140.201618] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[140.203466] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[140.271453] [033/138] (853s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-ccs)
[142.378020] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-ccs
[142.380052] Subtest pipe-B-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[142.551282] [034/138] (851s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[142.608745] Starting subtest: x-tiled-to-vebox-yf-tiled
[142.609817] Starting dynamic subtest: smem
[142.694773] Dynamic subtest smem: SUCCESS (0.086s)
[142.701350] Starting dynamic subtest: lmem0
[143.453692] Dynamic subtest lmem0: SUCCESS (0.756s)
[143.454826] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.842s)
[143.655990] [035/138] (850s left) kms_lease (multimaster-lease)
[145.607792] Starting subtest: multimaster-lease
[145.611109] Subtest multimaster-lease: SUCCESS (0.003s)
[145.669119] [036/138] (848s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[147.806706] Starting subtest: pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[147.808381] Subtest pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[147.915169] [037/138] (845s left) syncobj_timeline (wait-all-delayed-signal)
[147.965169] Starting subtest: wait-all-delayed-signal
[148.070291] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[148.144419] [038/138] (845s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[150.102105] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[150.104102] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[150.188823] [039/138] (843s left) gem_set_tiling_vs_gtt
[150.358080] [040/138] (843s left) kms_lease (lease-uevent)
[152.308390] Starting subtest: lease-uevent
[153.324601] Subtest lease-uevent: SUCCESS (1.013s)
[153.430344] [041/138] (840s left) gem_softpin (noreloc)
[153.483140] Starting subtest: noreloc
[158.872042] Subtest noreloc: SUCCESS (5.386s)
[158.953017] [042/138] (834s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[159.242530] Starting subtest: parallel-dmabuf-import-out-fence
[160.808570] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.566s)
[160.864732] [043/138] (832s left) perf_pmu (most-busy-check-all)
[160.913219] Starting subtest: most-busy-check-all
[160.914192] Starting dynamic subtest: rcs0
[161.476455] Dynamic subtest rcs0: SUCCESS (0.563s)
[161.485519] Starting dynamic subtest: bcs0
[162.022176] Dynamic subtest bcs0: SUCCESS (0.545s)
[162.030867] Starting dynamic subtest: vcs0
[162.567118] Dynamic subtest vcs0: SUCCESS (0.544s)
[162.575057] Starting dynamic subtest: vcs1
[163.112182] Dynamic subtest vcs1: SUCCESS (0.544s)
[163.120767] Starting dynamic subtest: vecs0
[163.658205] Dynamic subtest vecs0: SUCCESS (0.545s)
[163.659341] Subtest most-busy-check-all: SUCCESS (2.745s)
[163.721214] [044/138] (830s left) i915_pm_rpm (reg-read-ioctl)
[168.423955] Starting subtest: reg-read-ioctl
[178.409482] Subtest reg-read-ioctl: SUCCESS (9.984s)
[180.503221] [045/138] (813s left) kms_sequence (queue-idle)
[182.519448] Starting subtest: queue-idle
[182.520436] Starting dynamic subtest: pipe-A-HDMI-A-4
[184.891246] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.370s)
[184.898438] Starting dynamic subtest: pipe-B-HDMI-A-4
[187.089634] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.197s)
[187.098473] Starting dynamic subtest: pipe-C-HDMI-A-4
[189.273171] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.181s)
[189.281342] Starting dynamic subtest: pipe-D-HDMI-A-4
[191.460911] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.186s)
[191.461868] Subtest queue-idle: SUCCESS (8.942s)
[191.581034] [046/138] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[193.543126] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[193.545230] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[193.619132] [047/138] (800s left) gem_mmap_gtt (basic-read-write-distinct)
[193.736156] Subtest basic-read-write-distinct: SKIP (0.000s)
[193.772921] [048/138] (800s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-rc-ccs)
[195.769606] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs
[195.877593] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs: SUCCESS (0.107s)
[196.152576] [049/138] (797s left) kms_cursor_crc (cursor-alpha-opaque)
[198.109408] Starting subtest: cursor-alpha-opaque
[198.112036] Starting dynamic subtest: pipe-A-HDMI-A-4
[198.710288] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.598s)
[198.719036] Starting dynamic subtest: pipe-D-HDMI-A-4
[199.126985] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.415s)
[199.128284] Subtest cursor-alpha-opaque: SUCCESS (1.018s)
[199.658335] [050/138] (794s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-ccs)
[201.800722] Starting subtest: pipe-D-bad-rotation-90-y-tiled-ccs
[201.802460] Subtest pipe-D-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[201.915345] [051/138] (792s left) gem_vm_create (invalid-destroy)
[201.970804] Starting subtest: invalid-destroy
[201.972932] Subtest invalid-destroy: SUCCESS (0.002s)
[202.102335] [052/138] (791s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[204.224510] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[204.226536] Subtest pipe-D-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[204.331120] [053/138] (789s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[206.281672] Starting subtest: cursorA-vs-flipB-varying-size
[206.285999] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[206.349747] [054/138] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[208.371112] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[208.373093] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[208.452373] [055/138] (785s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[210.513955] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[210.515887] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[210.604700] [056/138] (783s left) gem_ctx_engines (execute-oneforall)
[210.747465] Starting subtest: execute-oneforall
[211.224078] Subtest execute-oneforall: SUCCESS (0.476s)
[211.600457] [057/138] (782s left) gem_ringfill (legacy-basic)
[212.019347] Starting subtest: legacy-basic
[212.020943] Starting dynamic subtest: default
[212.095958] Dynamic subtest default: SUCCESS (0.076s)
[212.105177] Starting dynamic subtest: render
[212.138057] Dynamic subtest render: SUCCESS (0.040s)
[212.174562] Starting dynamic subtest: bsd
[212.192567] Dynamic subtest bsd: SUCCESS (0.052s)
[212.205694] Starting dynamic subtest: bsd1
[212.238036] Dynamic subtest bsd1: SUCCESS (0.043s)
[212.248906] Starting dynamic subtest: bsd2
[212.279686] Dynamic subtest bsd2: SUCCESS (0.040s)
[212.314902] Starting dynamic subtest: blt
[212.331547] Dynamic subtest blt: SUCCESS (0.049s)
[212.351692] Starting dynamic subtest: vebox
[212.377231] Dynamic subtest vebox: SUCCESS (0.044s)
[212.378564] Subtest legacy-basic: SUCCESS (0.359s)
[212.509537] [058/138] (781s left) gem_exec_schedule (semaphore-user)
[212.598733] Starting subtest: semaphore-user
[212.622445] Subtest semaphore-user: SUCCESS (0.024s)
[212.950062] [059/138] (781s left) gem_mmap_gtt (isolation)
[213.007454] Subtest isolation: SKIP (0.000s)
[213.039429] [060/138] (781s left) v3d/v3d_submit_cl (bad-perfmon)
[213.147947] Subtest bad-perfmon: SKIP (0.000s)
[213.198305] [061/138] (780s left) kms_atomic (atomic-invalid-params)
[215.146683] Starting subtest: atomic-invalid-params
[215.149531] Starting dynamic subtest: pipe-A-HDMI-A-4
[215.535506] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.387s)
[215.536405] Subtest atomic-invalid-params: SUCCESS (0.390s)
[215.652787] [062/138] (778s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[217.607787] Starting subtest: x-tiled-8bpp-rotate-270
[217.691128] Subtest x-tiled-8bpp-rotate-270: SKIP (0.080s)
[217.786619] [063/138] (776s left) kms_psr (psr2_sprite_render)
[217.844830] Subtest psr2_sprite_render: SKIP (0.000s)
[217.861330] [064/138] (776s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[219.817758] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[221.924121] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (2.108s)
[222.061652] [065/138] (772s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs)
[224.070050] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs
[224.073135] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[224.284819] [066/138] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[226.241993] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[229.102551] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.862s)
[229.251767] [067/138] (765s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[231.210110] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[231.212031] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[231.310905] [068/138] (763s left) kms_vrr (flip-basic)
[233.347658] Starting subtest: flip-basic
[233.349524] Subtest flip-basic: SKIP (0.000s)
[233.420205] [069/138] (760s left) gem_exec_gttfill (all-engines)
[233.541835] Starting subtest: all-engines
[260.482371] Subtest all-engines: SUCCESS (26.938s)
[260.781329] [070/138] (733s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[260.874594] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[260.982088] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[261.046170] [071/138] (733s left) gem_mmap_wc (write-wc-read-gtt)
[261.096056] Subtest write-wc-read-gtt: SKIP (0.000s)
[261.123149] [072/138] (733s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-rc-ccs)
[263.156179] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs
[263.375212] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs: SUCCESS (0.219s)
[263.617237] [073/138] (730s left) gem_bad_reloc (negative-reloc-bltcopy)
[263.673313] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[263.709230] [074/138] (730s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[265.667162] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[268.233730] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.568s)
[268.385438] [075/138] (726s left) v3d/v3d_wait_bo (bad-pad)
[268.466629] Subtest bad-pad: SKIP (0.000s)
[268.525361] [076/138] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[270.507470] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[270.509591] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[270.588380] [077/138] (723s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[271.672743] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[271.699544] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.026s)
[271.768884] [078/138] (722s left) kms_pm_rpm (legacy-planes)
[276.422632] Starting subtest: legacy-planes
[276.423841] Starting dynamic subtest: plane-40
[305.398894] Dynamic subtest plane-40: SUCCESS (28.976s)
[305.406667] Starting dynamic subtest: plane-49
[326.719042] Dynamic subtest plane-49: SUCCESS (21.319s)
[326.737717] Starting dynamic subtest: plane-58
[349.108189] Dynamic subtest plane-58: SUCCESS (22.387s)
[349.118235] Starting dynamic subtest: plane-67
[373.644479] Dynamic subtest plane-67: FAIL (24.512s)
[373.652023] Starting dynamic subtest: plane-76
[390.239215] Dynamic subtest plane-76: SUCCESS (16.615s)
[390.258738] Starting dynamic subtest: plane-85
[406.191401] Dynamic subtest plane-85: SUCCESS (15.948s)
[406.193317] Subtest legacy-planes: FAIL (129.767s)
[407.363864] [079/138] (587s left) gem_ctx_bad_destroy (invalid-pad)
[407.431220] Starting subtest: invalid-pad
[407.432323] Subtest invalid-pad: SUCCESS (0.000s)
[407.506124] [080/138] (587s left) debugfs_test (read_all_entries)
[407.581303] Starting subtest: read_all_entries
[408.016116] Subtest read_all_entries: SUCCESS (0.434s)
[409.979694] [081/138] (584s left) v3d/v3d_perfmon (create-perfmon-exceed)
[410.112352] Subtest create-perfmon-exceed: SKIP (0.000s)
[410.167969] [082/138] (584s left) vc4/vc4_label_bo (set-label)
[410.262370] Subtest set-label: SKIP (0.000s)
[410.314184] [083/138] (584s left) gem_mmap_gtt (big-copy)
[410.376512] Subtest big-copy: SKIP (0.000s)
[410.404365] [084/138] (584s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[410.455631] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[410.456838] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[410.521865] [085/138] (584s left) kms_ccs (pipe-a-bad-pixel-format-y-tiled-gen12-rc-ccs)
[412.493906] Starting subtest: pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs
[412.494985] Subtest pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.000s)
[412.761373] [086/138] (581s left) kms_fb_coherency (memset-crc)
[414.716452] Starting subtest: memset-crc
[414.717557] Starting dynamic subtest: mmap-offset-fixed
[415.278776] Dynamic subtest mmap-offset-fixed: SUCCESS (0.562s)
[415.331589] Subtest memset-crc: SUCCESS (0.616s)
[415.455265] [087/138] (579s left) gen9_exec_parse (unaligned-access)
[415.507961] Subtest unaligned-access: SKIP (0.000s)
[415.530875] [088/138] (579s left) kms_writeback (writeback-check-output)
[419.387361] Subtest writeback-check-output: SKIP (0.000s)
[419.414325] [089/138] (575s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[421.380180] Starting subtest: 4-tiled-64bpp-rotate-270
[421.382097] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[421.483368] [090/138] (573s left) syncobj_wait (invalid-signal-one-illegal-handle)
[421.631482] Starting subtest: invalid-signal-one-illegal-handle
[421.632735] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[421.697160] [091/138] (573s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[423.659202] Starting subtest: flip-vs-cursor-crc-legacy
[424.192276] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.532s)
[424.317811] [092/138] (570s left) kms_hdr (static-toggle-dpms)
[426.270879] Starting subtest: static-toggle-dpms
[426.272967] Subtest static-toggle-dpms: SKIP (0.000s)
[426.335771] [093/138] (568s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[426.907460] Starting subtest: syncobj-stationary-timeline-chain-engines
[427.007583] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.103s)
[427.284409] [094/138] (567s left) api_intel_bb (misplaced-blitter)
[427.331887] Starting subtest: misplaced-blitter
[427.347959] Subtest misplaced-blitter: SUCCESS (0.017s)
[427.491129] [095/138] (567s left) syncobj_timeline (invalid-transfer-non-existent-point)
[427.566522] Starting subtest: invalid-transfer-non-existent-point
[427.567515] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[427.634560] [096/138] (567s left) vc4/vc4_tiling (set-bad-flags)
[427.699860] Subtest set-bad-flags: SKIP (0.000s)
[427.751104] [097/138] (567s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[427.805732] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[427.806697] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[427.888523] [098/138] (567s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-rc-ccs)
[429.973210] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs
[429.975232] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[430.132101] [099/138] (564s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[432.702210] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[432.781197] [100/138] (562s left) kms_plane_scaling (planes-upscale-20x20)
[434.734123] Starting subtest: planes-upscale-20x20
[434.737183] Starting dynamic subtest: pipe-A-HDMI-A-4
[434.830525] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.095s)
[434.839983] Starting dynamic subtest: pipe-B-HDMI-A-4
[434.952881] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.120s)
[434.964775] Starting dynamic subtest: pipe-C-HDMI-A-4
[435.075628] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.120s)
[435.085136] Starting dynamic subtest: pipe-D-HDMI-A-4
[435.198858] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.121s)
[435.199922] Subtest planes-upscale-20x20: SUCCESS (0.466s)
[435.325069] [101/138] (559s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[437.285751] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[437.287841] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[437.382828] [102/138] (557s left) gem_workarounds (reset-fd)
[437.535735] Starting subtest: reset-fd
[437.694543] Subtest reset-fd: SUCCESS (0.156s)
[437.815468] [103/138] (557s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[439.808503] Starting subtest: y-tiled-32bpp-rotate-90
[441.641419] Subtest y-tiled-32bpp-rotate-90: SUCCESS (1.829s)
[441.780776] [104/138] (553s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[443.765804] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[443.772762] Starting dynamic subtest: pipe-A-HDMI-A-4
[443.815761] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.040s)
[443.827948] Starting dynamic subtest: pipe-B-HDMI-A-4
[443.849331] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.031s)
[443.857488] Starting dynamic subtest: pipe-C-HDMI-A-4
[443.874717] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.023s)
[443.882516] Starting dynamic subtest: pipe-D-HDMI-A-4
[443.899829] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.023s)
[443.901767] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.139s)
[443.971769] [105/138] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[445.926417] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[445.928400] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[446.010560] [106/138] (549s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[446.141897] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[446.180474] [107/138] (549s left) kms_chamelium_color (ctm-blue-to-red)
[448.134438] Subtest ctm-blue-to-red: SKIP (0.000s)
[448.163166] [108/138] (547s left) gem_create (create-ext-cpu-access-sanity-check)
[448.347198] Starting subtest: create-ext-cpu-access-sanity-check
[448.380163] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.036s)
[448.504843] [109/138] (546s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[448.583274] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[448.695648] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[448.765092] [110/138] (546s left) syncobj_basic (create-signaled)
[448.836265] Starting subtest: create-signaled
[448.837188] Subtest create-signaled: SUCCESS (0.000s)
[448.905026] [111/138] (546s left) dmabuf_sync_file (import-multiple-read-only)
[448.953246] Starting subtest: import-multiple-read-only
[448.957312] Subtest import-multiple-read-only: SUCCESS (0.004s)
[449.013400] [112/138] (546s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-rc-ccs)
[451.120793] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs
[451.486283] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (0.364s)
[451.782555] [113/138] (543s left) syncobj_timeline (signal-point-0)
[451.829884] Starting subtest: signal-point-0
[451.830792] Subtest signal-point-0: SUCCESS (0.000s)
[451.911192] [114/138] (543s left) gem_fenced_exec_thrash (2-spare-fences)
[451.987110] Subtest 2-spare-fences: SKIP (0.000s)
[452.025014] [115/138] (543s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[453.983142] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[453.985247] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[454.075864] [116/138] (541s left) kms_busy (extended-pageflip-hang-oldfb)
[456.123877] Starting subtest: extended-pageflip-hang-oldfb
[456.126723] Starting dynamic subtest: pipe-A
[456.403935] Dynamic subtest pipe-A: SUCCESS (0.278s)
[456.418989] Starting dynamic subtest: pipe-D
[456.562394] Dynamic subtest pipe-D: SUCCESS (0.150s)
[456.563226] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.439s)
[456.679870] [117/138] (538s left) prime_busy (hang)
[456.732143] Starting subtest: hang
[456.734344] Starting dynamic subtest: rcs0
[470.860416] Dynamic subtest rcs0: SUCCESS (14.126s)
[470.868409] Starting dynamic subtest: bcs0
[477.940988] Dynamic subtest bcs0: SUCCESS (7.081s)
[477.950366] Starting dynamic subtest: vcs0
[484.979831] Dynamic subtest vcs0: SUCCESS (7.037s)
[484.989635] Starting dynamic subtest: vcs1
[491.955836] Dynamic subtest vcs1: SUCCESS (6.975s)
[491.965725] Starting dynamic subtest: vecs0
[498.997505] Dynamic subtest vecs0: SUCCESS (7.039s)
[498.998471] Subtest hang: SUCCESS (42.265s)
[499.095774] [118/138] (496s left) gem_exec_whisper (basic-contexts-priority-all)
[499.152996] Starting subtest: basic-contexts-priority-all
[522.927665] Subtest basic-contexts-priority-all: SUCCESS (23.771s)
[523.106066] [119/138] (472s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[523.165185] Starting subtest: saturated-hostile-nopreempt
[523.166083] Starting dynamic subtest: rcs0
[523.262147] Dynamic subtest rcs0: SUCCESS (0.096s)
[523.282543] Starting dynamic subtest: bcs0
[523.352085] Dynamic subtest bcs0: SUCCESS (0.087s)
[523.390887] Starting dynamic subtest: vcs0
[523.453100] Dynamic subtest vcs0: SUCCESS (0.096s)
[523.491076] Starting dynamic subtest: vcs1
[523.542033] Dynamic subtest vcs1: SUCCESS (0.085s)
[523.571700] Starting dynamic subtest: vecs0
[523.634749] Dynamic subtest vecs0: SUCCESS (0.089s)
[523.640650] Subtest saturated-hostile-nopreempt: SUCCESS (0.471s)
[523.781020] [120/138] (471s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[525.773740] Starting subtest: primary-y-tiled-reflect-x-270
[536.313717] Subtest primary-y-tiled-reflect-x-270: SUCCESS (10.540s)
[536.528771] [121/138] (458s left) kms_flip (2x-absolute-wf_vblank)
[537.534250] Starting subtest: 2x-absolute-wf_vblank
[537.559375] Subtest 2x-absolute-wf_vblank: SKIP (0.025s)
[537.631365] [122/138] (457s left) gem_unfence_active_buffers
[537.805674] [123/138] (457s left) kms_pm_dc (dc6-dpms)
[540.763307] Starting subtest: dc6-dpms
[540.766359] Subtest dc6-dpms: SKIP (0.000s)
[541.082484] [124/138] (454s left) prime_self_import (basic-llseek-bad)
[541.164964] Starting subtest: basic-llseek-bad
[541.166876] Subtest basic-llseek-bad: SUCCESS (0.002s)
[541.262513] [125/138] (454s left) kms_addfb_basic (addfb25-bad-modifier)
[541.320729] Starting subtest: addfb25-bad-modifier
[541.321559] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[543.320068] [126/138] (452s left) gem_ctx_bad_destroy (invalid-default-ctx)
[543.456121] Starting subtest: invalid-default-ctx
[543.457057] Subtest invalid-default-ctx: SUCCESS (0.000s)
[543.534296] [127/138] (452s left) gem_exec_flush (basic-wb-set-default)
[543.598488] Subtest basic-wb-set-default: SKIP (0.000s)
[543.638484] [128/138] (452s left) gem_ctx_persistence (engines-hostile)
[543.692821] Starting subtest: engines-hostile
[543.693637] Starting dynamic subtest: rcs0
[543.808795] Dynamic subtest rcs0: SUCCESS (0.114s)
[543.849937] Starting dynamic subtest: bcs0
[543.851137] Dynamic subtest bcs0: SUCCESS (0.034s)
[543.864994] Starting dynamic subtest: vcs0
[543.946725] Dynamic subtest vcs0: SUCCESS (0.095s)
[543.988555] Starting dynamic subtest: vcs1
[543.999355] Dynamic subtest vcs1: SUCCESS (0.048s)
[544.014797] Starting dynamic subtest: vecs0
[544.020142] Dynamic subtest vecs0: SUCCESS (0.019s)
[544.021037] Subtest engines-hostile: SUCCESS (0.328s)
[544.162369] [129/138] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[546.135326] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[546.137598] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[546.245266] [130/138] (449s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[548.301146] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[548.303122] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[548.384744] [131/138] (447s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[550.396093] Starting subtest: plane-all-transition-nonblocking-fencing
[550.399242] Starting dynamic subtest: pipe-A-HDMI-A-4
[554.226117] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.828s)
[554.290210] Starting dynamic subtest: pipe-B-HDMI-A-4
[558.165064] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.882s)
[558.220444] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.825s)
[558.326406] [132/138] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[560.317921] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[560.319959] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[560.398531] [133/138] (435s left) gem_exec_reloc (basic-gtt-cpu-active)
[560.526589] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[560.583818] [134/138] (435s left) gem_exec_schedule (preempt-engines)
[560.647565] Starting subtest: preempt-engines
[560.648452] Starting dynamic subtest: rcs0
[562.898242] Dynamic subtest rcs0: SUCCESS (2.246s)
[562.912141] Starting dynamic subtest: bcs0
[565.080487] Dynamic subtest bcs0: SUCCESS (2.176s)
[565.089117] Starting dynamic subtest: vcs0
[567.318430] Dynamic subtest vcs0: SUCCESS (2.235s)
[567.326998] Starting dynamic subtest: vcs1
[569.555657] Dynamic subtest vcs1: SUCCESS (2.234s)
[569.569091] Starting dynamic subtest: vecs0
[571.782475] Dynamic subtest vecs0: SUCCESS (2.221s)
[571.783416] Subtest preempt-engines: SUCCESS (11.134s)
[572.121693] [135/138] (423s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[574.085816] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[574.622882] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.536s)
[574.788596] [136/138] (421s left) kms_plane (plane-position-hole)
[576.784013] Starting subtest: plane-position-hole
[576.787106] Starting dynamic subtest: pipe-A
[579.307316] Dynamic subtest pipe-A: SUCCESS (2.521s)
[579.317362] Starting dynamic subtest: pipe-B
[581.711675] Dynamic subtest pipe-B: SUCCESS (2.399s)
[581.712509] Subtest plane-position-hole: SUCCESS (4.927s)
[581.845958] [137/138] (414s left) core_getstats
[581.976134] [138/138] (414s left) gem_exec_params (no-vebox)
[582.053197] Starting subtest: no-vebox
[582.055489] Subtest no-vebox: SUCCESS (0.001s)
[582.164899] Closing watchdogs
Done.