[196.616300] Initializing watchdogs
[196.616355]   /dev/watchdog0
[196.620556] [001/141] (960s left) kms_addfb_basic (bad-pitch-1024)
[196.670749] Starting subtest: bad-pitch-1024
[196.671465] Subtest bad-pitch-1024: SUCCESS (0.000s)
[196.792478] [002/141] (960s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs)
[197.061717] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[197.145581] [003/141] (960s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[197.194541] Starting subtest: no-spare-fences-busy
[199.390098] Subtest no-spare-fences-busy: SUCCESS (2.195s)
[199.492697] [004/141] (957s left) gem_exec_fence (syncobj-signal)
[199.845411] Starting subtest: syncobj-signal
[199.846878] Subtest syncobj-signal: SUCCESS (0.002s)
[200.123408] [005/141] (957s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[200.211396] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[200.626298] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.415s)
[200.785385] [006/141] (956s left) kms_plane_scaling (plane-scaler-with-modifiers-unity-scaling)
[200.877271] Starting subtest: plane-scaler-with-modifiers-unity-scaling
[200.879137] Starting dynamic subtest: pipe-A-HDMI-A-2
[201.536438] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.658s)
[201.540946] Starting dynamic subtest: pipe-B-HDMI-A-2
[202.167058] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.630s)
[202.167843] Subtest plane-scaler-with-modifiers-unity-scaling: SUCCESS (1.290s)
[202.293813] [007/141] (954s left) perf_pmu (busy-accuracy-98)
[202.338636] Starting subtest: busy-accuracy-98
[202.339308] Starting dynamic subtest: rcs0
[205.360889] Dynamic subtest rcs0: SUCCESS (3.022s)
[205.366226] Starting dynamic subtest: bcs0
[208.384991] Dynamic subtest bcs0: SUCCESS (3.024s)
[208.388301] Starting dynamic subtest: vcs0
[211.405228] Dynamic subtest vcs0: SUCCESS (3.020s)
[211.411270] Starting dynamic subtest: vecs0
[214.427732] Dynamic subtest vecs0: SUCCESS (3.023s)
[214.428411] Subtest busy-accuracy-98: SUCCESS (12.088s)
[214.518786] [008/141] (942s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[214.609634] Starting subtest: 2x-cursor-vs-flip-legacy
[214.612142] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[214.666412] [009/141] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[214.766293] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[214.767643] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[214.872192] [010/141] (942s left) drm_fdinfo (all-busy-check-all)
[214.934911] Starting subtest: all-busy-check-all
[215.467272] Subtest all-busy-check-all: SUCCESS (0.532s)
[215.523594] [011/141] (941s left) gem_eio (in-flight-external)
[215.581411] Starting subtest: in-flight-external
[215.834055] Subtest in-flight-external: SUCCESS (0.251s)
[215.911626] [012/141] (941s left) i915_pm_dc (dc5-psr)
[216.997939] Starting subtest: dc5-psr
[216.999506] Subtest dc5-psr: SKIP (0.000s)
[217.145190] [013/141] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[217.233567] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[217.234931] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[217.339141] [014/141] (939s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[217.604290] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[217.686863] [015/141] (939s left) gem_ctx_shared (disjoint-timelines)
[217.735343] Starting subtest: disjoint-timelines
[217.738587] Subtest disjoint-timelines: SUCCESS (0.003s)
[217.966202] [016/141] (939s left) gem_create (create-clear)
[218.027592] Starting subtest: create-clear
[218.028522] Starting dynamic subtest: smem0
[250.547605] Dynamic subtest smem0: SUCCESS (32.520s)
[250.548382] Subtest create-clear: SUCCESS (32.520s)
[250.736484] [017/141] (906s left) kms_force_connector_basic (force-load-detect)
[250.847689] Starting subtest: force-load-detect
[250.849020] Subtest force-load-detect: SKIP (0.000s)
[251.023289] [018/141] (906s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[251.104021] Starting subtest: fbcpsr-rgb565-draw-render
[251.105374] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[251.187428] [019/141] (906s left) gem_userptr_blits (access-control)
[251.259466] Starting subtest: access-control
[251.260840] Subtest access-control: SKIP (0.000s)
[251.381222] [020/141] (906s left) gem_exec_schedule (manyslice)
[251.447834] Starting subtest: manyslice
[251.448511] Starting dynamic subtest: rcs0
[251.837614] Dynamic subtest rcs0: SUCCESS (0.390s)
[251.841876] Starting dynamic subtest: bcs0
[252.137230] Dynamic subtest bcs0: SUCCESS (0.300s)
[252.142056] Starting dynamic subtest: vcs0
[252.442176] Dynamic subtest vcs0: SUCCESS (0.305s)
[252.447030] Starting dynamic subtest: vecs0
[252.760538] Dynamic subtest vecs0: SUCCESS (0.318s)
[252.761251] Subtest manyslice: SUCCESS (1.313s)
[253.072843] [021/141] (904s left) kms_atomic (plane-invalid-params-fence)
[253.205640] Starting subtest: plane-invalid-params-fence
[253.253428] Subtest plane-invalid-params-fence: SUCCESS (0.047s)
[253.400995] [022/141] (904s left) i915_pm_rpm (reg-read-ioctl)
[254.779471] Starting subtest: reg-read-ioctl
[255.191150] Subtest reg-read-ioctl: SUCCESS (0.413s)
[255.397448] [023/141] (902s left) syncobj_timeline (multi-wait-all-available-signaled)
[255.441610] Starting subtest: multi-wait-all-available-signaled
[255.442305] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[255.522874] [024/141] (901s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[255.658350] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[255.705403] [025/141] (901s left) kms_vblank (pipe-c-wait-busy-hang)
[255.783360] Subtest pipe-C-wait-busy-hang: SKIP (0.000s)
[255.842167] [026/141] (901s left) kms_psr (sprite_blt)
[255.886022] Subtest sprite_blt: SKIP (0.000s)
[255.919929] [027/141] (901s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[256.008524] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[256.009200] Starting dynamic subtest: pipe-A-valid-mode
[256.046844] Dynamic subtest pipe-A-valid-mode: SKIP (0.037s)
[256.048148] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.038s)
[256.130708] [028/141] (901s left) perf_pmu (init-busy)
[256.173919] Starting subtest: init-busy
[256.174619] Starting dynamic subtest: rcs0
[256.175317] Dynamic subtest rcs0: SUCCESS (0.000s)
[256.178972] Starting dynamic subtest: bcs0
[256.179680] Dynamic subtest bcs0: SUCCESS (0.000s)
[256.183354] Starting dynamic subtest: vcs0
[256.184048] Dynamic subtest vcs0: SUCCESS (0.000s)
[256.187525] Starting dynamic subtest: vecs0
[256.188228] Dynamic subtest vecs0: SUCCESS (0.000s)
[256.188894] Subtest init-busy: SUCCESS (0.001s)
[256.260433] [029/141] (901s left) kms_prop_blob (invalid-set-prop)
[256.320391] Starting subtest: invalid-set-prop
[256.321106] Subtest invalid-set-prop: SUCCESS (0.000s)
[256.391074] [030/141] (901s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[256.611919] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[256.613280] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[256.741978] [031/141] (900s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[256.822630] Starting subtest: psr-rgb101010-draw-pwrite
[256.823957] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[256.926326] [032/141] (900s left) kms_frontbuffer_tracking (fbc-suspend)
[257.025564] Starting subtest: fbc-suspend
[294.762281] Subtest fbc-suspend: SUCCESS (37.738s)
[295.923123] [033/141] (862s left) gem_mmap_gtt (ptrace)
[295.989759] Starting subtest: ptrace
[296.090943] Subtest ptrace: SUCCESS (0.101s)
[296.169637] [034/141] (862s left) prime_mmap (test_refcounting)
[296.222392] Starting subtest: test_refcounting
[296.223110] Starting dynamic subtest: test_refcounting-smem
[296.277597] Dynamic subtest test_refcounting-smem: SUCCESS (0.056s)
[296.278305] Subtest test_refcounting: SUCCESS (0.056s)
[296.385388] [035/141] (862s left) kms_lease (atomic_implicit_crtc)
[296.475331] Starting subtest: atomic_implicit_crtc
[296.476078] Starting dynamic subtest: pipe-A-HDMI-A-2
[296.476771] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[296.481037] Starting dynamic subtest: pipe-B-HDMI-A-2
[296.481766] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.003s)
[296.482429] Subtest atomic_implicit_crtc: SUCCESS (0.006s)
[296.537065] [036/141] (862s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[296.584984] Starting subtest: invalid-bsd2-flag-on-vebox
[296.585745] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[296.689174] [037/141] (861s left) gem_ctx_persistence (engines-cleanup)
[296.747112] Starting subtest: engines-cleanup
[296.747827] Starting dynamic subtest: rcs0
[296.789390] Dynamic subtest rcs0: SUCCESS (0.042s)
[296.803675] Starting dynamic subtest: bcs0
[296.828267] Dynamic subtest bcs0: SUCCESS (0.039s)
[296.842368] Starting dynamic subtest: vcs0
[296.866248] Dynamic subtest vcs0: SUCCESS (0.038s)
[296.881131] Starting dynamic subtest: vecs0
[296.906275] Dynamic subtest vecs0: SUCCESS (0.040s)
[296.907420] Subtest engines-cleanup: SUCCESS (0.159s)
[296.993775] [038/141] (861s left) v3d/v3d_submit_csd (bad-perfmon)
[297.077260] Subtest bad-perfmon: SKIP (0.000s)
[297.142292] [039/141] (861s left) kms_cursor_crc (cursor-onscreen-32x32)
[297.230674] Starting subtest: cursor-onscreen-32x32
[297.254777] Subtest cursor-onscreen-32x32: SKIP (0.022s)
[297.334481] [040/141] (861s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs)
[297.487839] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs
[297.489817] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[297.681156] [041/141] (861s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[297.765034] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[298.182375] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.417s)
[298.325996] [042/141] (860s left) prime_self_import (basic-with_two_bos)
[298.386070] Starting subtest: basic-with_two_bos
[298.387414] Subtest basic-with_two_bos: SUCCESS (0.001s)
[298.476410] [043/141] (860s left) gem_ctx_exec (basic-close-race)
[298.531177] Starting subtest: basic-close-race
[303.956733] Subtest basic-close-race: SUCCESS (5.424s)
[306.787464] [044/141] (852s left) kms_psr (psr2_sprite_render)
[306.837864] Subtest psr2_sprite_render: SKIP (0.000s)
[306.858084] [045/141] (851s left) prime_mmap (test_correct_cpu_write)
[306.911788] Starting subtest: test_correct_cpu_write
[306.912518] Starting dynamic subtest: test_correct_cpu_write-smem
[306.913284] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[306.913969] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[307.015108] [046/141] (851s left) gem_userptr_blits (set-cache-level)
[307.062513] Starting subtest: set-cache-level
[307.063200] Subtest set-cache-level: SUCCESS (0.000s)
[307.186117] [047/141] (851s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs)
[307.411641] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs
[307.413865] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[307.535038] [048/141] (851s left) gem_exec_schedule (u-fairslice-all)
[307.584297] Starting subtest: u-fairslice-all
[309.616412] Subtest u-fairslice-all: SUCCESS (2.032s)
[309.927748] [049/141] (848s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[310.021563] Starting subtest: fbc-rgb565-draw-pwrite
[312.589662] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.570s)
[312.728427] [050/141] (846s left) kms_atomic_interruptible (legacy-dpms)
[312.819373] Starting subtest: legacy-dpms
[312.820236] Starting dynamic subtest: HDMI-A-2-pipe-A
[318.979098] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (6.159s)
[318.979772] Subtest legacy-dpms: SUCCESS (6.161s)
[319.087813] [051/141] (839s left) tools_test (sysfs_l3_parity)
[319.133950] Starting subtest: sysfs_l3_parity
[319.190447] Subtest sysfs_l3_parity: SKIP (0.060s)
[319.254876] [052/141] (839s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[319.521959] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[319.605982] [053/141] (839s left) kms_chamelium_frames (hdmi-aspect-ratio)
[319.733803] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[319.782559] [054/141] (839s left) gem_pxp (create-regular-context-2)
[322.333642] Subtest create-regular-context-2: SKIP (0.000s)
[322.392986] [055/141] (836s left) kms_flip (2x-nonexisting-fb-interruptible)
[322.483117] Starting subtest: 2x-nonexisting-fb-interruptible
[322.485521] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.002s)
[322.577278] [056/141] (836s left) feature_discovery (psr1)
[322.668743] Starting subtest: psr1
[322.670079] Subtest psr1: SKIP (0.000s)
[322.737684] [057/141] (836s left) gem_exec_balancer (busy)
[322.798884] Starting subtest: busy
[323.202828] Subtest busy: SUCCESS (0.404s)
[324.200338] [058/141] (834s left) prime_mmap (test_forked)
[324.250135] Starting subtest: test_forked
[324.250823] Starting dynamic subtest: test_forked-smem
[324.312409] Dynamic subtest test_forked-smem: SUCCESS (0.063s)
[324.313115] Subtest test_forked: SUCCESS (0.063s)
[324.394883] [059/141] (834s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs)
[324.479437] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs
[324.480192] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[324.744405] [060/141] (834s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[324.827450] Starting subtest: fbcpsr-badstride
[324.828848] Subtest fbcpsr-badstride: SKIP (0.000s)
[324.953552] [061/141] (834s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[325.097949] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[325.099363] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[325.300555] [062/141] (833s left) kms_lease (multimaster-lease)
[325.379860] Starting subtest: multimaster-lease
[325.380596] Subtest multimaster-lease: SUCCESS (0.001s)
[325.433206] [063/141] (833s left) kms_cursor_crc (cursor-sliding-32x10)
[325.514224] Starting subtest: cursor-sliding-32x10
[325.537819] Subtest cursor-sliding-32x10: SKIP (0.023s)
[325.641991] [064/141] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[325.724931] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[325.726269] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[325.832552] [065/141] (833s left) gen3_render_tiledy_blits
[325.921859] [066/141] (833s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[326.013843] Starting subtest: cursorA-vs-flipB-atomic-transitions
[326.015202] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[326.088978] [067/141] (833s left) vc4/vc4_tiling (get-after-free)
[326.161304] Subtest get-after-free: SKIP (0.000s)
[326.227375] [068/141] (833s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[326.313222] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[335.751464] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.440s)
[335.860163] [069/141] (823s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[335.940738] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[335.942104] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[336.042791] [070/141] (823s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[336.133221] Subtest get-values-invalid-pointer: SKIP (0.000s)
[336.196623] [071/141] (823s left) gem_softpin (noreloc-interruptible)
[336.250257] Starting subtest: noreloc-interruptible
[341.663947] Subtest noreloc-interruptible: SUCCESS (5.413s)
[341.772226] [072/141] (817s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[341.853842] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[341.854528] Starting dynamic subtest: pipe-A-valid-mode
[341.887139] Dynamic subtest pipe-A-valid-mode: SKIP (0.032s)
[341.888497] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.033s)
[341.971614] [073/141] (817s left) gem_exec_whisper (basic-contexts-forked-all)
[342.020510] Starting subtest: basic-contexts-forked-all
[357.753128] Subtest basic-contexts-forked-all: SUCCESS (15.732s)
[357.947268] [074/141] (801s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[358.037806] Starting subtest: flip-vs-cursor-legacy
[365.985562] Subtest flip-vs-cursor-legacy: SUCCESS (7.948s)
[366.098274] [075/141] (793s left) gem_render_tiled_blits (basic)
[366.142206] Starting subtest: basic
[366.160170] Subtest basic: SUCCESS (0.018s)
[366.209148] [076/141] (793s left) i915_pm_rpm (fences)
[367.588091] Starting subtest: fences
[370.352642] Subtest fences: SUCCESS (2.765s)
[370.541740] [077/141] (788s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[370.806137] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[370.891161] [078/141] (788s left) kms_vblank (pipe-d-query-idle-hang)
[370.969134] Subtest pipe-D-query-idle-hang: SKIP (0.000s)
[371.025952] [079/141] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[371.126032] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[373.668738] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.544s)
[373.808990] [080/141] (785s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[373.896754] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[373.898111] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[374.005580] [081/141] (785s left) kms_plane_scaling (2x-scaler-multi-pipe)
[374.088983] Starting subtest: 2x-scaler-multi-pipe
[374.090346] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[374.194238] [082/141] (785s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[374.456930] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[374.540589] [083/141] (784s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs)
[374.741207] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs
[374.742569] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[374.888103] [084/141] (784s left) syncobj_timeline (single-wait-all-available-submitted)
[374.931693] Starting subtest: single-wait-all-available-submitted
[374.932360] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[374.985540] [085/141] (784s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[375.035637] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[375.143555] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[375.225238] [086/141] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[375.310940] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[377.609026] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.299s)
[377.774855] [087/141] (781s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[377.855998] Subtest bad-multisync-out-sync: SKIP (0.000s)
[377.923707] [088/141] (781s left) gem_sync (basic-all)
[377.987166] Starting subtest: basic-all
[380.147795] Subtest basic-all: SUCCESS (2.161s)
[380.324148] [089/141] (779s left) gem_exec_fence (long-history)
[380.658158] Starting subtest: long-history
[386.462721] Subtest long-history: SUCCESS (5.804s)
[386.983549] [090/141] (772s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs)
[387.236341] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[387.321922] [091/141] (772s left) prime_busy (before)
[387.365615] Starting subtest: before
[387.369447] Starting dynamic subtest: rcs0
[387.391982] Dynamic subtest rcs0: SUCCESS (0.023s)
[387.396588] Starting dynamic subtest: bcs0
[387.422458] Dynamic subtest bcs0: SUCCESS (0.030s)
[387.427558] Starting dynamic subtest: vcs0
[387.433030] Dynamic subtest vcs0: SUCCESS (0.011s)
[387.440425] Starting dynamic subtest: vecs0
[387.452808] Dynamic subtest vecs0: SUCCESS (0.019s)
[387.570179] Subtest before: SUCCESS (0.197s)
[387.646354] [092/141] (772s left) kms_scaling_modes (scaling-mode-full-aspect)
[387.737837] Starting subtest: scaling-mode-full-aspect
[387.739430] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[387.797720] [093/141] (771s left) kms_chamelium_edid (dp-edid-resolution-list)
[387.923767] Subtest dp-edid-resolution-list: SKIP (0.000s)
[387.972699] [094/141] (771s left) kms_flip (plain-flip-ts-check)
[388.044444] Starting subtest: plain-flip-ts-check
[388.045121] Starting dynamic subtest: A-HDMI-A2
[403.568261] Dynamic subtest A-HDMI-A2: SUCCESS (15.523s)
[403.576406] Starting dynamic subtest: B-HDMI-A2
[419.038822] Dynamic subtest B-HDMI-A2: SUCCESS (15.469s)
[419.039844] Subtest plain-flip-ts-check: SUCCESS (30.996s)
[419.187804] [095/141] (740s left) kms_content_protection (uevent)
[419.271024] Starting subtest: uevent
[419.411054] Subtest uevent: SKIP (0.138s)
[419.556215] [096/141] (740s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[419.637985] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[419.999675] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.362s)
[420.159048] [097/141] (739s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[420.248757] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[420.250725] Starting dynamic subtest: pipe-A-HDMI-A-2
[420.384118] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.134s)
[420.389210] Starting dynamic subtest: pipe-B-HDMI-A-2
[420.502396] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.117s)
[420.503116] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.254s)
[420.633154] [098/141] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[420.712703] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[420.714054] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[420.818326] [099/141] (738s left) gem_mmap_gtt (cpuset-big-copy-xy)
[420.867779] Starting subtest: cpuset-big-copy-XY
[444.337827] Subtest cpuset-big-copy-XY: SUCCESS (23.470s)
[444.426265] [100/141] (715s left) gem_softpin (evict-prime)
[444.513262] Starting subtest: evict-prime
[444.513994] Starting dynamic subtest: rcs0
[445.659822] Dynamic subtest rcs0: SUCCESS (1.146s)
[445.681390] Starting dynamic subtest: bcs0
[446.776614] Dynamic subtest bcs0: SUCCESS (1.116s)
[446.791980] Starting dynamic subtest: vcs0
[447.887328] Dynamic subtest vcs0: SUCCESS (1.110s)
[447.902756] Starting dynamic subtest: vecs0
[449.004518] Dynamic subtest vecs0: SUCCESS (1.117s)
[449.022492] Starting dynamic subtest: all
[450.121369] Dynamic subtest all: SUCCESS (1.116s)
[450.122419] Subtest evict-prime: SUCCESS (5.608s)
[450.200177] [101/141] (709s left) i915_hangman (detector)
[450.262395] Starting subtest: detector
[450.263127] Starting dynamic subtest: rcs0
[460.296889] Dynamic subtest rcs0: SUCCESS (10.034s)
[460.306268] Starting dynamic subtest: bcs0
[470.353465] Dynamic subtest bcs0: SUCCESS (10.056s)
[470.362618] Starting dynamic subtest: vcs0
[480.325429] Dynamic subtest vcs0: SUCCESS (9.971s)
[480.334556] Starting dynamic subtest: vecs0
[490.322455] Dynamic subtest vecs0: SUCCESS (9.996s)
[490.323625] Subtest detector: SUCCESS (40.060s)
[490.413558] [102/141] (669s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[490.494700] Starting subtest: 2x-flip-vs-modeset-vs-hang
[490.496028] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.001s)
[490.609782] [103/141] (669s left) v3d/v3d_get_param (base-params)
[490.691896] Subtest base-params: SKIP (0.000s)
[490.766442] [104/141] (669s left) syncobj_wait (wait-all-interrupted)
[490.820693] Starting subtest: wait-all-interrupted
[490.922675] Subtest wait-all-interrupted: SUCCESS (0.102s)
[491.010464] [105/141] (668s left) kms_flip (2x-flip-vs-suspend)
[491.088375] Starting subtest: 2x-flip-vs-suspend
[491.091261] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[491.200295] [106/141] (668s left) kms_busy (extended-modeset-hang-oldfb)
[491.293533] Starting subtest: extended-modeset-hang-oldfb
[491.294405] Starting dynamic subtest: pipe-A
[492.857187] Dynamic subtest pipe-A: SUCCESS (1.561s)
[492.863951] Starting dynamic subtest: pipe-B
[494.314802] Dynamic subtest pipe-B: SUCCESS (1.456s)
[494.315549] Subtest extended-modeset-hang-oldfb: SUCCESS (3.021s)
[494.431483] [107/141] (665s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[494.512017] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[494.513511] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[494.601314] [108/141] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[494.681876] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[494.683229] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[494.786059] [109/141] (665s left) gem_exec_reloc (basic-cpu-gtt-active)
[494.842896] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[494.883306] [110/141] (665s left) gem_gtt_cpu_tlb
[495.039572] [111/141] (664s left) syncobj_timeline (invalid-query-illegal-handle)
[495.094893] Starting subtest: invalid-query-illegal-handle
[495.095587] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[495.171728] [112/141] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[495.256015] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[495.257368] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[495.362472] [113/141] (664s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[495.455428] Starting subtest: x-tiled-16bpp-rotate-90
[495.498801] Subtest x-tiled-16bpp-rotate-90: SKIP (0.042s)
[495.607485] [114/141] (664s left) syncobj_timeline (wait-all-complex)
[495.651204] Starting subtest: wait-all-complex
[495.863996] Subtest wait-all-complex: SUCCESS (0.212s)
[495.938299] [115/141] (664s left) kms_getfb (getfb2-accept-ccs)
[495.991697] Starting subtest: getfb2-accept-ccs
[495.992400] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[496.094826] [116/141] (664s left) kms_plane_lowres (tiling-none)
[496.184679] Starting subtest: tiling-none
[496.185393] Starting dynamic subtest: pipe-A-HDMI-A-2
[499.778896] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.585s)
[499.801332] Starting dynamic subtest: pipe-B-HDMI-A-2
[503.112330] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.301s)
[503.140685] Subtest tiling-none: SUCCESS (6.957s)
[503.263505] [117/141] (656s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[503.347234] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[503.348604] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[503.447245] [118/141] (656s left) api_intel_bb (crc32)
[503.501545] Starting subtest: crc32
[503.502921] Subtest crc32: SKIP (0.000s)
[503.604021] [119/141] (656s left) i915_query (query-topology-garbage-items)
[503.654820] Starting subtest: query-topology-garbage-items
[503.655535] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[503.737974] [120/141] (656s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[503.944685] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[503.946108] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[504.084773] [121/141] (656s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[504.166203] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[504.167631] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[504.255129] [122/141] (655s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[504.344103] Starting subtest: cursorA-vs-flipA-legacy
[515.176734] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.833s)
[515.292888] [123/141] (644s left) core_hotunplug (unbind-rebind)
[515.355671] Starting subtest: unbind-rebind
[517.311197] Subtest unbind-rebind: SUCCESS (1.955s)
[517.325996] [124/141] (642s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[517.383961] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[517.384858] Starting dynamic subtest: smem
[517.471821] Dynamic subtest smem: SUCCESS (0.087s)
[517.472545] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.088s)
[517.669668] [125/141] (642s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[517.755282] Starting subtest: y-tiled-16bpp-rotate-270
[519.209138] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.453s)
[519.350648] [126/141] (640s left) gem_lmem_swapping (basic)
[519.405603] Subtest basic: SKIP (0.000s)
[519.429457] [127/141] (640s left) kms_addfb_basic (basic-x-tiled-legacy)
[519.478906] Starting subtest: basic-x-tiled-legacy
[519.479628] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[519.623075] [128/141] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[519.711267] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[519.712635] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[519.813136] [129/141] (640s left) gem_exec_balancer (nop)
[519.870183] Starting subtest: nop
[555.276846] Subtest nop: SUCCESS (35.407s)
[556.231661] [130/141] (604s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[556.308060] Starting subtest: flip-vs-cursor-busy-crc-legacy
[557.128620] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.821s)
[557.243899] [131/141] (603s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[557.291096] Subtest writes-after-reads-uncached: SKIP (0.000s)
[557.341643] [132/141] (603s left) gem_exec_reloc (basic-gtt-read-active)
[557.395551] Subtest basic-gtt-read-active: SKIP (0.000s)
[557.427705] [133/141] (602s left) gem_sync (basic-many-each)
[557.488764] Starting subtest: basic-many-each
[559.694885] Subtest basic-many-each: SUCCESS (2.206s)
[559.910099] [134/141] (600s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[560.200318] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[560.286409] [135/141] (600s left) kms_cursor_edge_walk (64x64-top-bottom)
[560.364946] Starting subtest: 64x64-top-bottom
[560.365703] Starting dynamic subtest: pipe-A-HDMI-A-2
[564.054452] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.688s)
[564.061314] Starting dynamic subtest: pipe-B-HDMI-A-2
[567.668843] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.612s)
[567.669538] Subtest 64x64-top-bottom: SUCCESS (7.305s)
[567.755520] [136/141] (592s left) i915_query (query-topology-known-pci-ids)
[567.801216] Starting subtest: query-topology-known-pci-ids
[567.802672] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[567.889343] [137/141] (592s left) gem_exec_schedule (fairslice)
[567.948290] Starting subtest: fairslice
[567.948994] Starting dynamic subtest: rcs0
[569.958977] Dynamic subtest rcs0: SUCCESS (2.010s)
[569.966591] Starting dynamic subtest: bcs0
[571.967797] Dynamic subtest bcs0: SUCCESS (2.008s)
[571.976128] Starting dynamic subtest: vcs0
[573.975995] Dynamic subtest vcs0: SUCCESS (2.009s)
[573.984277] Starting dynamic subtest: vecs0
[575.985035] Dynamic subtest vecs0: SUCCESS (2.009s)
[575.985718] Subtest fairslice: SUCCESS (8.037s)
[576.288383] [138/141] (584s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[576.379087] Starting subtest: primary-yf-tiled-reflect-x-270
[576.490222] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.111s)
[576.585966] [139/141] (583s left) gem_mmap_gtt (basic-write)
[576.634235] Starting subtest: basic-write
[576.845426] Subtest basic-write: SUCCESS (0.211s)
[576.931840] [140/141] (583s left) gem_vm_create (isolation)
[576.984884] Starting subtest: isolation
[576.987791] Subtest isolation: SUCCESS (0.003s)
[577.092694] [141/141] (583s left) prime_mmap (test_invalid_sync_flags)
[577.145867] Starting subtest: test_invalid_sync_flags
[577.146544] Starting dynamic subtest: test_invalid_sync_flags-smem
[577.147206] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[577.147876] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[577.243428] Closing watchdogs
Done.