[56.185454] Initializing watchdogs
[56.185925]   /dev/watchdog0
[56.219323] [001/141] (960s left) gen7_exec_parse (oacontrol-tracking)
[56.664917] Subtest oacontrol-tracking: SKIP (0.000s)
[56.789951] [002/141] (959s left) gem_ccs (suspend-resume)
[57.185756] Starting subtest: suspend-resume
[57.192800] Subtest suspend-resume: SKIP (0.000s)
[57.373751] [003/141] (959s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[57.858856] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[57.978786] [004/141] (958s left) kms_addfb_basic (tile-pitch-mismatch)
[58.349190] Starting subtest: tile-pitch-mismatch
[58.354888] Subtest tile-pitch-mismatch: SKIP (0.000s)
[58.618507] [005/141] (958s left) kms_big_fb (linear-32bpp-rotate-0)
[59.162436] Starting subtest: linear-32bpp-rotate-0
[64.669817] Subtest linear-32bpp-rotate-0: SUCCESS (5.506s)
[65.120737] [006/141] (951s left) gem_fenced_exec_thrash (2-spare-fences)
[65.514180] Subtest 2-spare-fences: SKIP (0.000s)
[65.612642] [007/141] (951s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[65.986509] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[66.090580] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[66.218339] [008/141] (950s left) prime_busy (hang)
[66.596983] Starting subtest: hang
[66.602961] Starting dynamic subtest: rcs0
[80.401766] Dynamic subtest rcs0: SUCCESS (13.798s)
[80.432221] Starting dynamic subtest: bcs0
[87.258680] Dynamic subtest bcs0: SUCCESS (6.852s)
[87.289209] Starting dynamic subtest: vcs0
[94.580898] Dynamic subtest vcs0: SUCCESS (7.323s)
[94.611909] Starting dynamic subtest: vcs1
[101.569110] Dynamic subtest vcs1: SUCCESS (6.987s)
[101.599621] Starting dynamic subtest: vecs0
[108.497828] Dynamic subtest vecs0: SUCCESS (6.929s)
[108.531599] Starting dynamic subtest: ccs0
[122.380994] Dynamic subtest ccs0: SUCCESS (13.883s)
[122.384747] Subtest hang: SUCCESS (55.779s)
[122.574859] [009/141] (894s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[123.883903] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[123.891194] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[124.413875] [010/141] (892s left) kms_properties (get_properties-sanity-non-atomic)
[124.898278] Starting subtest: get_properties-sanity-non-atomic
[124.913387] Subtest get_properties-sanity-non-atomic: SUCCESS (0.018s)
[125.044654] [011/141] (892s left) api_intel_allocator (fork-simple-stress)
[125.414470] Starting subtest: fork-simple-stress
[131.030718] Subtest fork-simple-stress: SUCCESS (5.617s)
[131.191578] [012/141] (886s left) kms_selftest (drm_format)
[131.560706] Starting subtest: drm_format
[131.573325] Subtest drm_format: SKIP (0.007s)
[131.705656] [013/141] (885s left) gem_exec_fair (basic-sync)
[132.113574] Subtest basic-sync: SKIP (0.000s)
[132.249963] [014/141] (885s left) kms_fence_pin_leak
[132.765859] [015/141] (884s left) kms_mmap_write_crc (main)
[133.276299] Starting subtest: main
[133.283356] Starting dynamic subtest: pipe-A-eDP-1
[143.138044] Dynamic subtest pipe-A-eDP-1: SUCCESS (9.855s)
[143.141505] Subtest main: SUCCESS (9.862s)
[144.094214] [016/141] (873s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[144.582642] Starting subtest: coverage-vs-premult-vs-constant
[146.322867] Starting dynamic subtest: pipe-A-eDP-1
[147.407339] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.081s)
[147.440224] Starting dynamic subtest: pipe-D-eDP-1
[149.205539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.790s)
[149.209866] Subtest coverage-vs-premult-vs-constant: SUCCESS (4.624s)
[150.138718] [017/141] (867s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[150.619381] Starting subtest: FB-8BPC-Vs-Panel-6BPC
[150.623395] Starting dynamic subtest: pipe-A-eDP-1
[152.388536] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.766s)
[152.392130] Subtest FB-8BPC-Vs-Panel-6BPC: SUCCESS (1.768s)
[153.322437] [018/141] (864s left) kms_chamelium_color (ctm-0-75)
[153.798576] Subtest ctm-0-75: SKIP (0.000s)
[153.898511] [019/141] (864s left) prime_vgem (fence-wait)
[154.431203] Starting subtest: fence-wait
[154.434924] Starting dynamic subtest: rcs0
[155.510540] Dynamic subtest rcs0: SUCCESS (1.077s)
[155.542496] Starting dynamic subtest: bcs0
[156.582186] Dynamic subtest bcs0: SUCCESS (1.072s)
[156.614899] Starting dynamic subtest: vcs0
[157.653857] Dynamic subtest vcs0: SUCCESS (1.071s)
[157.685848] Starting dynamic subtest: vcs1
[159.541731] Dynamic subtest vcs1: SUCCESS (1.887s)
[159.574468] Starting dynamic subtest: vecs0
[161.523578] Dynamic subtest vecs0: SUCCESS (1.981s)
[161.555496] Starting dynamic subtest: ccs0
[163.573536] Dynamic subtest ccs0: SUCCESS (2.049s)
[163.577793] Subtest fence-wait: SUCCESS (9.141s)
[163.776993] [020/141] (854s left) dmabuf_sync_file (import-multiple-read-only)
[164.157679] Starting subtest: import-multiple-read-only
[164.175200] Subtest import-multiple-read-only: SUCCESS (0.022s)
[164.305134] [021/141] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[164.821754] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[164.828122] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[164.982852] [022/141] (853s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[165.856669] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[166.739543] [023/141] (851s left) gem_exec_balancer (full-late)
[167.161534] Starting subtest: full-late
[175.002036] Subtest full-late: SUCCESS (7.842s)
[176.044655] [024/141] (842s left) gem_spin_batch (legacy-resubmit)
[176.472784] Starting subtest: legacy-resubmit
[176.475687] Starting dynamic subtest: default
[176.490209] Dynamic subtest default: SUCCESS (0.016s)
[176.525436] Starting dynamic subtest: render
[176.529041] Dynamic subtest render: SUCCESS (0.010s)
[176.563594] Starting dynamic subtest: bsd
[176.567087] Dynamic subtest bsd: SUCCESS (0.007s)
[176.599186] Starting dynamic subtest: bsd1
[176.602584] Dynamic subtest bsd1: SUCCESS (0.005s)
[176.634257] Starting dynamic subtest: bsd2
[176.637608] Dynamic subtest bsd2: SUCCESS (0.007s)
[176.670203] Starting dynamic subtest: blt
[176.673565] Dynamic subtest blt: SUCCESS (0.009s)
[176.706976] Starting dynamic subtest: vebox
[176.710054] Dynamic subtest vebox: SUCCESS (0.008s)
[176.712884] Subtest legacy-resubmit: SUCCESS (0.072s)
[178.701739] [025/141] (839s left) kms_rmfb (rmfb-ioctl)
[179.182771] Starting subtest: rmfb-ioctl
[179.191090] Starting dynamic subtest: pipe-A-eDP-1
[179.511317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.322s)
[179.550078] Starting dynamic subtest: pipe-B-eDP-1
[181.209077] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.692s)
[181.248236] Starting dynamic subtest: pipe-C-eDP-1
[182.850496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.635s)
[182.889592] Starting dynamic subtest: pipe-D-eDP-1
[184.516459] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.659s)
[184.520637] Subtest rmfb-ioctl: SUCCESS (5.334s)
[186.029964] [026/141] (832s left) v3d/v3d_wait_bo (bad-bo)
[186.501407] Subtest bad-bo: SKIP (0.000s)
[186.620277] [027/141] (831s left) gem_exec_schedule (u-fairslice)
[187.043588] Starting subtest: u-fairslice
[187.047137] Starting dynamic subtest: rcs0
[189.119697] Dynamic subtest rcs0: SUCCESS (2.071s)
[189.162806] Starting dynamic subtest: bcs0
[191.170116] Dynamic subtest bcs0: SUCCESS (2.049s)
[191.205322] Starting dynamic subtest: vcs0
[193.217271] Dynamic subtest vcs0: SUCCESS (2.046s)
[193.251695] Starting dynamic subtest: vcs1
[195.264372] Dynamic subtest vcs1: SUCCESS (2.046s)
[195.303979] Starting dynamic subtest: vecs0
[197.315467] Dynamic subtest vecs0: SUCCESS (2.050s)
[197.351512] Starting dynamic subtest: ccs0
[199.368865] Dynamic subtest ccs0: SUCCESS (2.052s)
[199.372743] Subtest u-fairslice: SUCCESS (12.323s)
[199.852680] [028/141] (818s left) gem_softpin (32b-excludes-last-page)
[200.249246] Starting subtest: 32b-excludes-last-page
[200.264544] Subtest 32b-excludes-last-page: SUCCESS (0.016s)
[200.460292] [029/141] (818s left) gem_eio (hibernate)
[202.216454] Starting subtest: hibernate
[226.895439] Subtest hibernate: SUCCESS (24.681s)
[230.599684] [030/141] (790s left) gem_exec_fence (syncobj-timeline-repeat)
[233.048681] Starting subtest: syncobj-timeline-repeat
[234.794847] Subtest syncobj-timeline-repeat: SUCCESS (1.752s)
[235.093689] [031/141] (785s left) gem_exec_params (secure-non-root)
[235.489848] Starting subtest: secure-non-root
[235.497984] Subtest secure-non-root: SKIP (0.000s)
[235.684616] [032/141] (785s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[236.867213] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[238.028431] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.159s)
[239.531872] [033/141] (781s left) gem_ctx_persistence (hang)
[239.839158] Starting subtest: hang
[239.845880] Subtest hang: SKIP (0.001s)
[240.016863] [034/141] (781s left) gem_exec_schedule (noreorder-priority)
[240.591840] Starting subtest: noreorder-priority
[240.595300] Starting dynamic subtest: rcs0
[241.753703] Dynamic subtest rcs0: SUCCESS (1.162s)
[241.797667] Starting dynamic subtest: bcs0
[242.907581] Dynamic subtest bcs0: SUCCESS (1.152s)
[242.947836] Starting dynamic subtest: vcs0
[244.534605] Dynamic subtest vcs0: SUCCESS (1.622s)
[244.579803] Starting dynamic subtest: vcs1
[246.533977] Dynamic subtest vcs1: SUCCESS (1.999s)
[246.575332] Starting dynamic subtest: vecs0
[248.517085] Dynamic subtest vecs0: SUCCESS (1.981s)
[248.561622] Starting dynamic subtest: ccs0
[249.671433] Dynamic subtest ccs0: SUCCESS (1.154s)
[249.674812] Subtest noreorder-priority: SUCCESS (9.081s)
[249.978191] [035/141] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[250.485532] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[250.492108] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[250.650831] [036/141] (770s left) gem_userptr_blits (stress-mm)
[251.102152] Starting subtest: stress-mm
[256.469653] Subtest stress-mm: SUCCESS (5.371s)
[256.680765] [037/141] (764s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[257.187575] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[268.397641] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (11.217s)
[268.676881] [038/141] (752s left) kms_addfb_basic (master-rmfb)
[269.014760] Starting subtest: master-rmfb
[269.018103] Subtest master-rmfb: SUCCESS (0.003s)
[269.235254] [039/141] (752s left) gem_exec_reloc (basic-cpu-wc-active)
[269.421105] Subtest basic-cpu-wc-active: SKIP (0.000s)
[269.504921] [040/141] (752s left) kms_vblank (pipe-d-accuracy-idle)
[269.684365] Starting subtest: pipe-D-accuracy-idle
[272.856440] Subtest pipe-D-accuracy-idle: SUCCESS (3.166s)
[273.765144] [041/141] (747s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[274.092363] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[274.099219] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[274.267838] [042/141] (747s left) perf_pmu (busy-idle-no-semaphores)
[274.656670] Starting subtest: busy-idle-no-semaphores
[274.661141] Starting dynamic subtest: rcs0
[275.341455] Dynamic subtest rcs0: SUCCESS (0.683s)
[275.388459] Starting dynamic subtest: bcs0
[276.019886] Dynamic subtest bcs0: SUCCESS (0.676s)
[276.064549] Starting dynamic subtest: vcs0
[276.694561] Dynamic subtest vcs0: SUCCESS (0.673s)
[276.739789] Starting dynamic subtest: vcs1
[278.180862] Dynamic subtest vcs1: SUCCESS (1.483s)
[278.223882] Starting dynamic subtest: vecs0
[280.163168] Dynamic subtest vecs0: SUCCESS (1.981s)
[280.206051] Starting dynamic subtest: ccs0
[282.150189] Dynamic subtest ccs0: SUCCESS (1.985s)
[282.153828] Subtest busy-idle-no-semaphores: SUCCESS (7.495s)
[282.373786] [043/141] (739s left) kms_addfb_basic (bad-pitch-128)
[282.745402] Starting subtest: bad-pitch-128
[282.748772] Subtest bad-pitch-128: SUCCESS (0.000s)
[283.048366] [044/141] (738s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[284.723336] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[285.708497] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.982s)
[287.116893] [045/141] (734s left) prime_mmap_coherency (ioctl-errors)
[287.512418] Starting subtest: ioctl-errors
[298.017664] Subtest ioctl-errors: SUCCESS (10.504s)
[298.234322] [046/141] (723s left) i915_selftest (live)
[302.435263] Starting subtest: live
[302.439306] Starting dynamic subtest: sanitycheck
[307.526418] Dynamic subtest sanitycheck: SUCCESS (5.089s)
[307.559186] Starting dynamic subtest: uncore
[311.734987] Dynamic subtest uncore: SUCCESS (4.206s)
[311.767967] Starting dynamic subtest: workarounds
[328.365920] Dynamic subtest workarounds: FAIL (15.810s)
[328.401096] Starting dynamic subtest: gt_engines
[331.836591] Dynamic subtest gt_engines: SUCCESS (4.286s)
[331.869375] Starting dynamic subtest: gt_timelines
[350.461575] Dynamic subtest gt_timelines: SUCCESS (18.622s)
[350.494623] Starting dynamic subtest: gt_contexts
[353.963811] Dynamic subtest gt_contexts: SUCCESS (3.500s)
[353.997596] Starting dynamic subtest: gt_lrc
[360.107766] Dynamic subtest gt_lrc: SUCCESS (6.141s)
[360.141923] Starting dynamic subtest: gt_mocs
[375.925407] Dynamic subtest gt_mocs: FAIL (15.036s)
[375.957812] Starting dynamic subtest: gt_pm
[380.009992] Dynamic subtest gt_pm: SUCCESS (4.859s)
[380.043979] Starting dynamic subtest: gt_heartbeat
[384.163965] Dynamic subtest gt_heartbeat: SUCCESS (4.151s)
[384.196809] Starting dynamic subtest: gt_tlb
[390.140820] Dynamic subtest gt_tlb: SUCCESS (5.973s)
[390.174341] Starting dynamic subtest: requests
[406.947474] Dynamic subtest requests: SUCCESS (16.803s)
[406.980859] Starting dynamic subtest: migrate
[417.246862] Dynamic subtest migrate: FAIL (9.485s)
[417.280351] Starting dynamic subtest: active
[420.937690] Dynamic subtest active: SUCCESS (3.903s)
[420.971060] Starting dynamic subtest: objects
[429.433398] Dynamic subtest objects: SUCCESS (8.492s)
[429.467969] Starting dynamic subtest: mman
[435.378466] Dynamic subtest mman: SUCCESS (5.941s)
[435.412061] Starting dynamic subtest: dmabuf
[439.525691] Dynamic subtest dmabuf: SUCCESS (4.144s)
[439.560062] Starting dynamic subtest: vma
[443.597404] Dynamic subtest vma: SUCCESS (4.067s)
[443.632887] Starting dynamic subtest: coherency
[450.074946] Dynamic subtest coherency: SUCCESS (6.473s)
[450.109451] Starting dynamic subtest: gtt
[465.722202] Dynamic subtest gtt: SUCCESS (15.643s)
[465.756235] Starting dynamic subtest: gem
[473.117365] Dynamic subtest gem: SUCCESS (7.391s)
[473.151572] Starting dynamic subtest: evict
[479.746993] Dynamic subtest evict: SUCCESS (6.626s)
[479.786442] Starting dynamic subtest: hugepages
[489.833727] Dynamic subtest hugepages: SUCCESS (10.081s)
[489.869101] Starting dynamic subtest: gem_contexts
[531.660241] Dynamic subtest gem_contexts: SUCCESS (41.822s)
[531.696359] Starting dynamic subtest: client
[535.697867] Dynamic subtest client: SUCCESS (4.032s)
[535.741465] Starting dynamic subtest: gem_migrate
[539.610931] Dynamic subtest gem_migrate: SUCCESS (3.908s)
[539.645567] Starting dynamic subtest: reset
[543.684591] Dynamic subtest reset: SUCCESS (4.071s)
[543.720594] Starting dynamic subtest: memory_region
[547.671496] Dynamic subtest memory_region: SUCCESS (3.984s)
[547.704541] Starting dynamic subtest: hangcheck
[565.303404] Dynamic subtest hangcheck: SUCCESS (17.627s)
[565.339856] Starting dynamic subtest: execlists
[569.090448] Dynamic subtest execlists: SUCCESS (3.783s)
[569.127228] Starting dynamic subtest: ring_submission
[572.775479] Dynamic subtest ring_submission: SUCCESS (3.680s)
[572.815118] Starting dynamic subtest: perf
[576.867923] Dynamic subtest perf: SUCCESS (4.088s)
[576.903577] Starting dynamic subtest: slpc
[592.216125] Dynamic subtest slpc: SUCCESS (15.344s)
[592.250763] Starting dynamic subtest: guc
[598.211247] Dynamic subtest guc: SUCCESS (5.991s)
[598.246276] Starting dynamic subtest: guc_multi_lrc
[602.123348] Dynamic subtest guc_multi_lrc: SUCCESS (3.907s)
[602.157849] Starting dynamic subtest: guc_hang
[607.040918] Dynamic subtest guc_hang: SUCCESS (4.914s)
[607.076308] Starting dynamic subtest: late_gt_pm
[611.153297] Dynamic subtest late_gt_pm: SUCCESS (4.109s)
[611.157551] Subtest live: FAIL (308.720s)
[611.436537] [047/141] (410s left) gem_exec_whisper (basic-forked-all)
[614.620369] Starting subtest: basic-forked-all
[663.285999] Subtest basic-forked-all: FAIL (48.582s)
[663.526928] [048/141] (358s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[664.105377] Starting subtest: x-tiled-8bpp-rotate-270
[664.239452] Subtest x-tiled-8bpp-rotate-270: SKIP (0.129s)
[664.453955] [049/141] (357s left) kms_atomic (crtc-invalid-params-fence)
[665.130717] Starting subtest: crtc-invalid-params-fence
[665.351887] Subtest crtc-invalid-params-fence: SUCCESS (0.221s)
[666.659669] [050/141] (355s left) v3d/v3d_submit_csd (bad-in-sync)
[667.131501] Subtest bad-in-sync: SKIP (0.000s)
[667.270983] [051/141] (355s left) gem_ctx_shared (single-timeline)
[667.702105] Starting subtest: single-timeline
[667.744801] Subtest single-timeline: SUCCESS (0.037s)
[668.063983] [052/141] (354s left) kms_draw_crc (fill-fb)
[668.551344] Starting subtest: fill-fb
[669.833388] Subtest fill-fb: SUCCESS (1.281s)
[669.987491] [053/141] (352s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[670.503321] Starting subtest: fbcpsr-rgb101010-draw-blt
[678.600737] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (8.098s)
[678.869708] [054/141] (343s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[679.282776] Starting subtest: yf-tiled-to-vebox-yf-tiled
[679.289486] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[679.560530] [055/141] (343s left) gem_close_race (basic-threads)
[679.992508] Starting subtest: basic-threads
[681.457249] Subtest basic-threads: SUCCESS (1.464s)
[681.731895] [056/141] (341s left) gem_ppgtt (shrink-vs-evict-any)
[682.118757] Starting subtest: shrink-vs-evict-any
[687.652417] Subtest shrink-vs-evict-any: SUCCESS (5.530s)
[687.826549] [057/141] (335s left) syncobj_timeline (multi-wait-available-submitted)
[688.202873] Starting subtest: multi-wait-available-submitted
[688.206492] Subtest multi-wait-available-submitted: SUCCESS (0.003s)
[688.386158] [058/141] (334s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[688.763973] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[688.767538] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.002s)
[688.945992] [059/141] (334s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[696.062359] Starting subtest: overlay-plane-update-continuous-sf
[696.071055] Starting dynamic subtest: pipe-A-eDP-1
[698.349128] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.275s)
[698.404966] Starting dynamic subtest: pipe-B-eDP-1
[700.565667] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.207s)
[700.569938] Subtest overlay-plane-update-continuous-sf: SUCCESS (4.502s)
[701.515142] [060/141] (321s left) v3d/v3d_get_param (base-params)
[701.997431] Subtest base-params: SKIP (0.000s)
[702.138692] [061/141] (321s left) gem_tiled_wc
[702.630487] [062/141] (320s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_mc_ccs)
[704.223443] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs
[707.262818] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (3.032s)
[708.687950] [063/141] (314s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[709.189902] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[723.950985] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (14.765s)
[724.222324] [064/141] (299s left) kms_color (ctm-0-50)
[724.702579] Starting subtest: ctm-0-50
[724.706121] Starting dynamic subtest: pipe-A
[729.710323] Dynamic subtest pipe-A: SUCCESS (5.006s)
[729.757231] Starting dynamic subtest: pipe-B
[735.421741] Dynamic subtest pipe-B: SUCCESS (5.706s)
[735.479593] Starting dynamic subtest: pipe-C
[740.373920] Dynamic subtest pipe-C: SUCCESS (4.948s)
[740.436179] Starting dynamic subtest: pipe-D
[745.680329] Dynamic subtest pipe-D: SUCCESS (5.303s)
[745.684445] Subtest ctm-0-50: SUCCESS (20.979s)
[746.601331] [065/141] (277s left) gem_exec_create (madvise)
[747.009694] Starting subtest: madvise
[747.013366] Starting dynamic subtest: smem
[768.571215] Dynamic subtest smem: SUCCESS (21.558s)
[768.575047] Subtest madvise: SUCCESS (21.564s)
[769.497889] [066/141] (254s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[770.039354] Starting subtest: y-tiled-64bpp-rotate-270
[770.045969] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[770.231780] [067/141] (253s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[770.754971] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[770.761878] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[770.939641] [068/141] (252s left) gem_exec_suspend (basic-s4-devices)
[771.377299] Starting subtest: basic-S4-devices
[771.381573] Starting dynamic subtest: smem
[794.540523] Dynamic subtest smem: SUCCESS (23.160s)
[794.544397] Subtest basic-S4-devices: SUCCESS (23.164s)
[794.853839] [069/141] (229s left) feature_discovery (psr2)
[795.351777] Starting subtest: psr2
[795.355465] Subtest psr2: SUCCESS (0.000s)
[795.512460] [070/141] (228s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[796.348821] Starting subtest: cursor-rapid-movement-128x128
[796.377535] Starting dynamic subtest: pipe-A-eDP-1
[797.610273] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.230s)
[797.764409] Starting dynamic subtest: pipe-D-eDP-1
[799.818911] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.102s)
[799.822567] Subtest cursor-rapid-movement-128x128: SUCCESS (3.468s)
[800.901266] [071/141] (223s left) vc4/vc4_tiling (get-bad-modifier)
[801.365601] Subtest get-bad-modifier: SKIP (0.000s)
[801.510097] [072/141] (222s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-5)
[801.989314] Starting subtest: plane-downscale-with-pixel-format-factor-0-5
[802.001547] Starting dynamic subtest: pipe-A-eDP-1
[802.119222] Dynamic subtest pipe-A-eDP-1: SKIP (0.112s)
[802.166846] Starting dynamic subtest: pipe-B-eDP-1
[802.315519] Dynamic subtest pipe-B-eDP-1: SKIP (0.183s)
[802.362867] Starting dynamic subtest: pipe-C-eDP-1
[802.523875] Dynamic subtest pipe-C-eDP-1: SKIP (0.195s)
[802.569909] Starting dynamic subtest: pipe-D-eDP-1
[802.704562] Dynamic subtest pipe-D-eDP-1: SKIP (0.174s)
[802.711980] Subtest plane-downscale-with-pixel-format-factor-0-5: SKIP (0.712s)
[802.894694] [073/141] (221s left) sw_sync (alloc_timeline)
[803.257837] Starting subtest: alloc_timeline
[803.261393] Subtest alloc_timeline: SUCCESS (0.000s)
[803.396188] [074/141] (221s left) gem_lmem_evict (dontneed-evict-race)
[803.784452] Subtest dontneed-evict-race: SKIP (0.000s)
[803.917533] [075/141] (220s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[804.323765] Subtest tiled-to-untiled: SKIP (0.000s)
[804.459743] [076/141] (220s left) gem_exec_parallel (userptr)
[804.877388] Starting subtest: userptr
[804.880467] Starting dynamic subtest: rcs0
[809.318346] Dynamic subtest rcs0: SUCCESS (4.439s)
[809.374930] Starting dynamic subtest: bcs0
[813.357422] Dynamic subtest bcs0: SUCCESS (4.033s)
[813.416532] Starting dynamic subtest: vcs0
[816.506209] Dynamic subtest vcs0: SUCCESS (3.141s)
[816.558911] Starting dynamic subtest: vcs1
[819.445098] Dynamic subtest vcs1: SUCCESS (2.935s)
[819.503786] Starting dynamic subtest: vecs0
[822.521903] Dynamic subtest vecs0: SUCCESS (3.071s)
[822.574150] Starting dynamic subtest: ccs0
[826.903366] Dynamic subtest ccs0: SUCCESS (4.378s)
[826.906861] Subtest userptr: SUCCESS (22.028s)
[827.252326] [077/141] (197s left) kms_cursor_crc (cursor-onscreen-32x10)
[827.940325] Starting subtest: cursor-onscreen-32x10
[828.243596] Subtest cursor-onscreen-32x10: SKIP (0.296s)
[829.102449] [078/141] (195s left) gem_partial_pwrite_pread (writes-after-reads)
[829.516055] Subtest writes-after-reads: SKIP (0.000s)
[829.674663] [079/141] (195s left) i915_pm_rpm (i2c)
[835.758362] Starting subtest: i2c
[842.187105] Subtest i2c: SUCCESS (6.425s)
[842.400443] [080/141] (182s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[842.779833] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[842.783360] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[842.938945] [081/141] (182s left) gem_exec_params (dr4-dirt)
[843.330842] Starting subtest: DR4-dirt
[843.334495] Subtest DR4-dirt: SUCCESS (0.001s)
[843.510886] [082/141] (181s left) kms_invalid_mode (clock-too-high)
[843.983840] Starting subtest: clock-too-high
[843.987379] Starting dynamic subtest: eDP-1-pipe-A
[843.993607] Dynamic subtest eDP-1-pipe-A: SKIP (0.001s)
[844.049662] Starting dynamic subtest: eDP-1-pipe-B
[844.056790] Dynamic subtest eDP-1-pipe-B: SKIP (0.001s)
[844.107200] Starting dynamic subtest: eDP-1-pipe-C
[844.113400] Dynamic subtest eDP-1-pipe-C: SKIP (0.001s)
[844.164818] Starting dynamic subtest: eDP-1-pipe-D
[844.171570] Dynamic subtest eDP-1-pipe-D: SKIP (0.001s)
[844.177303] Subtest clock-too-high: SKIP (0.039s)
[844.252542] [083/141] (181s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[844.743242] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[844.751188] Starting dynamic subtest: pipe-A-default-mode
[846.372520] Dynamic subtest pipe-A-default-mode: SKIP (1.614s)
[846.379645] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.628s)
[846.676600] [084/141] (178s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[847.153842] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[847.164198] Starting dynamic subtest: pipe-A-default-mode
[848.773632] Dynamic subtest pipe-A-default-mode: SKIP (1.600s)
[848.780672] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.614s)
[849.067260] [085/141] (176s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[849.606882] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[849.613748] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[849.784317] [086/141] (175s left) gem_ctx_param (basic)
[850.164746] Starting subtest: basic
[850.168983] Subtest basic: SUCCESS (0.002s)
[850.325549] [087/141] (175s left) kms_getfb (getfb-repeated-different-handles)
[850.696747] Starting subtest: getfb-repeated-different-handles
[850.700994] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[850.885367] [088/141] (174s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[851.776253] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[851.782839] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[853.302737] [089/141] (172s left) kms_color (invalid-degamma-lut-sizes)
[853.773728] Starting subtest: invalid-degamma-lut-sizes
[853.776811] Starting dynamic subtest: pipe-A
[854.172652] Dynamic subtest pipe-A: SUCCESS (0.397s)
[854.225947] Starting dynamic subtest: pipe-B
[854.229727] Dynamic subtest pipe-B: SUCCESS (0.015s)
[854.285722] Starting dynamic subtest: pipe-C
[854.290360] Dynamic subtest pipe-C: SUCCESS (0.014s)
[854.345171] Starting dynamic subtest: pipe-D
[854.348894] Dynamic subtest pipe-D: SUCCESS (0.014s)
[854.352775] Subtest invalid-degamma-lut-sizes: SUCCESS (0.456s)
[855.117583] [090/141] (170s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[856.397459] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[856.404142] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[857.541215] [091/141] (168s left) i915_hangman (engine-engine-hang)
[857.966504] Starting subtest: engine-engine-hang
[857.970091] Starting dynamic subtest: rcs0
[859.501960] Dynamic subtest rcs0: SUCCESS (1.532s)
[859.553440] Starting dynamic subtest: bcs0
[862.508649] Dynamic subtest bcs0: SUCCESS (3.002s)
[862.561142] Starting dynamic subtest: vcs0
[873.129592] Dynamic subtest vcs0: FAIL (10.520s)
[873.184939] Starting dynamic subtest: vcs1
[874.476682] Dynamic subtest vcs1: SUCCESS (1.439s)
[874.534930] Starting dynamic subtest: vecs0
[876.524353] Dynamic subtest vecs0: SUCCESS (2.043s)
[876.584781] Starting dynamic subtest: ccs0
[879.534317] Dynamic subtest ccs0: SUCCESS (3.003s)
[879.538385] Subtest engine-engine-hang: FAIL (21.568s)
[879.781707] [092/141] (146s left) kms_vblank (pipe-a-wait-busy)
[880.277220] Starting subtest: pipe-A-wait-busy
[882.340237] Subtest pipe-A-wait-busy: SUCCESS (2.063s)
[883.304591] [093/141] (142s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[883.811804] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[883.818738] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[883.996990] [094/141] (142s left) i915_pm_rpm (cursor)
[886.725615] Starting subtest: cursor
[918.667365] Subtest cursor: SUCCESS (31.942s)
[919.599381] [095/141] (106s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[920.971627] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[921.438223] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.462s)
[922.772107] [096/141] (103s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[923.306316] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[923.313286] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[923.485395] [097/141] (103s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[924.559098] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[927.981963] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.423s)
[929.773503] [098/141] ( 96s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[930.279936] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[941.836534] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (11.564s)
[942.127092] [099/141] ( 84s left) gem_userptr_blits (sync-unmap-after-close)
[942.590160] Starting subtest: sync-unmap-after-close
[942.644084] Subtest sync-unmap-after-close: SUCCESS (0.059s)
[942.894606] [100/141] ( 84s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[943.401191] Starting subtest: psr-rgb101010-draw-mmap-wc
[955.433589] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (12.035s)
[955.713416] [101/141] ( 71s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[956.287848] Starting subtest: cursorB-vs-flipA-varying-size
[956.304962] Subtest cursorB-vs-flipA-varying-size: SKIP (0.016s)
[956.644638] [102/141] ( 70s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[957.144186] Starting subtest: fbc-rgb565-draw-mmap-gtt
[957.151308] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[957.324589] [103/141] ( 69s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[957.879331] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[960.830651] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (2.949s)
[961.154917] [104/141] ( 66s left) kms_addfb_basic (small-bo)
[961.626615] Starting subtest: small-bo
[961.630343] Subtest small-bo: SUCCESS (0.000s)
[961.807157] [105/141] ( 65s left) gem_exec_balancer (parallel-bb-first)
[963.040893] Starting subtest: parallel-bb-first
[967.612340] Subtest parallel-bb-first: SUCCESS (4.573s)
[967.795945] [106/141] ( 59s left) gem_readwrite (new-obj)
[968.183260] Subtest new-obj: SKIP (0.000s)
[968.340555] [107/141] ( 59s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[968.856367] Starting subtest: psr-1p-primscrn-spr-indfb-move
[980.791525] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (11.940s)
[981.090274] [108/141] ( 46s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_mc_ccs)
[982.759825] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs
[982.768532] Subtest pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[983.456479] [109/141] ( 44s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[983.932199] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[983.937982] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[985.866293] [110/141] ( 42s left) kms_psr (cursor_plane_onoff)
[986.337550] Starting subtest: cursor_plane_onoff
[989.570839] Subtest cursor_plane_onoff: SUCCESS (3.232s)
[990.521292] [111/141] ( 37s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[991.031692] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[991.038235] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[991.222196] [112/141] ( 36s left) kms_plane_scaling (plane-upscale-with-rotation-20x20)
[991.691542] Starting subtest: plane-upscale-with-rotation-20x20
[991.696801] Starting dynamic subtest: pipe-A-eDP-1
[992.504133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.807s)
[992.572256] Starting dynamic subtest: pipe-B-eDP-1
[994.690246] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.175s)
[994.756574] Starting dynamic subtest: pipe-C-eDP-1
[996.854775] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.153s)
[996.926145] Starting dynamic subtest: pipe-D-eDP-1
[998.977135] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.108s)
[998.980807] Subtest plane-upscale-with-rotation-20x20: SUCCESS (7.290s)
[1000.505608] [113/141] ( 27s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[1001.849744] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[1001.856356] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.002s)
[1002.633159] [114/141] ( 25s left) api_intel_bb (intel-bb-blit-y)
[1003.013135] Starting subtest: intel-bb-blit-y
[1014.410697] Subtest intel-bb-blit-y: SUCCESS (11.401s)
[1014.632545] [115/141] ( 13s left) gen3_mixed_blits
[1015.154704] [116/141] ( 13s left) kms_flip (flip-vs-modeset-vs-hang)
[1015.562818] Starting subtest: flip-vs-modeset-vs-hang
[1015.578901] Starting dynamic subtest: A-eDP1
[1043.414256] Dynamic subtest A-eDP1: SUCCESS (27.833s)
[1043.465531] Starting dynamic subtest: D-eDP1
[1083.424397] Dynamic subtest D-eDP1: SUCCESS (40.006s)
[1083.434726] Subtest flip-vs-modeset-vs-hang: SUCCESS (67.878s)
[1084.103130] Overall timeout time exceeded, stopping.
[1084.104377] Closing watchdogs
Done.