[21.393432] Initializing watchdogs
[21.393500]   /dev/watchdog0
[21.398171] [001/136] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[21.505853] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[21.507359] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[21.554889] [002/136] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[21.657444] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[21.658981] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[21.712470] [003/136] (960s left) gem_exec_fence (syncobj-wait)
[22.080235] Starting subtest: syncobj-wait
[22.116042] Subtest syncobj-wait: SUCCESS (0.035s)
[22.411653] [004/136] (959s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[22.525986] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[22.891018] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.365s)
[22.986959] [005/136] (958s left) kms_sequence (get-forked)
[23.094539] Starting subtest: get-forked
[23.095307] Starting dynamic subtest: HDMI-A-1-pipe-A
[24.298979] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (1.204s)
[24.303383] Starting dynamic subtest: HDMI-A-1-pipe-B
[25.497686] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (1.199s)
[25.501540] Starting dynamic subtest: HDMI-A-1-pipe-C
[26.691688] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (1.194s)
[26.695117] Starting dynamic subtest: HDMI-A-1-pipe-D
[27.881828] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (1.190s)
[27.882645] Subtest get-forked: SUCCESS (4.787s)
[27.953585] [006/136] (954s left) gem_mmap_gtt (zero-extend)
[28.005744] Starting subtest: zero-extend
[28.006632] Subtest zero-extend: SUCCESS (0.000s)
[28.048932] [007/136] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[28.156492] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[29.241987] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.087s)
[29.332490] [008/136] (952s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[29.449243] Starting subtest: fbc-shrfb-scaledprimary
[32.159411] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.712s)
[32.238137] [009/136] (949s left) sw_sync (sync_busy_fork_unixsocket)
[32.287520] Starting subtest: sync_busy_fork_unixsocket
[32.296088] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[32.320381] [010/136] (949s left) v3d/v3d_wait_bo (unused-bo-0ns)
[32.392684] Subtest unused-bo-0ns: SKIP (0.000s)
[32.421928] [011/136] (949s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[32.609263] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[32.611043] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[32.689360] [012/136] (949s left) gem_userptr_blits (huge-split)
[32.756697] Starting subtest: huge-split
[32.759611] Subtest huge-split: SUCCESS (0.003s)
[32.836079] [013/136] (949s left) gem_exec_whisper (basic-sync-all)
[32.894848] Starting subtest: basic-sync-all
[36.191542] Subtest basic-sync-all: SUCCESS (3.295s)
[36.344664] [014/136] (945s left) i915_pm_rc6_residency (rc6-accuracy)
[36.573462] Starting subtest: rc6-accuracy
[39.576683] Subtest rc6-accuracy: SUCCESS (3.001s)
[39.601138] [015/136] (942s left) kms_cursor_edge_walk (256x256-left-edge)
[39.707518] Starting subtest: 256x256-left-edge
[39.708318] Starting dynamic subtest: pipe-A-HDMI-A-1
[41.440316] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.733s)
[41.445317] Starting dynamic subtest: pipe-D-HDMI-A-1
[43.110400] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.671s)
[43.111230] Subtest 256x256-left-edge: SUCCESS (3.404s)
[43.187340] [016/136] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[43.293777] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[43.295280] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[43.348136] [017/136] (938s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs)
[43.514954] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs
[43.515863] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[43.602731] [018/136] (938s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[43.705030] Starting subtest: flip-vs-cursor-busy-crc-legacy
[44.132859] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.428s)
[44.240070] [019/136] (937s left) syncobj_wait (wait-all-for-submit-complex)
[44.291552] Starting subtest: wait-all-for-submit-complex
[44.512790] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[44.539841] [020/136] (937s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[44.643775] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[44.645357] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[44.697850] [021/136] (937s left) gem_exec_fence (keep-in-fence)
[44.882789] Starting subtest: keep-in-fence
[44.883913] Starting dynamic subtest: rcs0
[44.906667] Dynamic subtest rcs0: SUCCESS (0.032s)
[44.915641] Starting dynamic subtest: bcs0
[44.931552] Dynamic subtest bcs0: SUCCESS (0.025s)
[44.938562] Starting dynamic subtest: vcs0
[44.954570] Dynamic subtest vcs0: SUCCESS (0.023s)
[44.960991] Starting dynamic subtest: vcs1
[44.987411] Dynamic subtest vcs1: SUCCESS (0.032s)
[44.995822] Starting dynamic subtest: vecs0
[45.010566] Dynamic subtest vecs0: SUCCESS (0.024s)
[45.011706] Subtest keep-in-fence: SUCCESS (0.136s)
[45.437723] [022/136] (936s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[45.500101] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[45.602049] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[45.646791] [023/136] (936s left) gem_ctx_exec (basic-norecovery)
[45.710225] Starting subtest: basic-norecovery
[45.721999] Subtest basic-norecovery: SUCCESS (0.011s)
[45.793668] [024/136] (936s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[45.909446] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[45.911088] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[45.956569] [025/136] (936s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs)
[46.132627] Starting subtest: pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs
[46.134227] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[46.212186] [026/136] (935s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[46.271397] Starting subtest: yf-tiled-to-vebox-y-tiled
[46.272166] Starting dynamic subtest: smem
[46.381141] Dynamic subtest smem: SUCCESS (0.110s)
[46.381894] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.110s)
[46.520874] [027/136] (935s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[46.636717] Starting subtest: extended-pageflip-modeset-hang-oldfb
[46.637550] Starting dynamic subtest: pipe-A
[48.017075] Dynamic subtest pipe-A: SUCCESS (1.380s)
[48.022897] Starting dynamic subtest: pipe-D
[49.383647] Dynamic subtest pipe-D: SUCCESS (1.367s)
[49.384503] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (2.747s)
[49.495669] [028/136] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[49.603809] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[49.605368] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[49.652829] [029/136] (932s left) gem_exec_reloc (basic-gtt-read)
[49.707479] Starting subtest: basic-gtt-read
[49.713079] Subtest basic-gtt-read: SUCCESS (0.006s)
[49.802379] [030/136] (932s left) perf_pmu (busy-accuracy-2)
[49.857522] Starting subtest: busy-accuracy-2
[49.858358] Starting dynamic subtest: rcs0
[52.888759] Dynamic subtest rcs0: SUCCESS (3.027s)
[52.893654] Starting dynamic subtest: bcs0
[55.918086] Dynamic subtest bcs0: SUCCESS (3.031s)
[55.923836] Starting dynamic subtest: vcs0
[58.947729] Dynamic subtest vcs0: SUCCESS (3.029s)
[58.953482] Starting dynamic subtest: vcs1
[61.978131] Dynamic subtest vcs1: SUCCESS (3.030s)
[61.983589] Starting dynamic subtest: vecs0
[65.010976] Dynamic subtest vecs0: SUCCESS (3.032s)
[65.012343] Subtest busy-accuracy-2: SUCCESS (15.149s)
[65.053266] [031/136] (917s left) i915_pm_rpm (modeset-non-lpsp)
[66.578953] Starting subtest: modeset-non-lpsp
[67.994471] Subtest modeset-non-lpsp: SKIP (1.414s)
[68.127219] [032/136] (914s left) syncobj_wait (invalid-wait-zero-handles)
[68.180893] Starting subtest: invalid-wait-zero-handles
[68.181766] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[68.218084] [033/136] (914s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[68.272459] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[68.292742] [034/136] (913s left) gem_exec_capture (capture)
[68.345399] Starting subtest: capture
[68.346275] Starting dynamic subtest: rcs0-smem
[69.627736] Dynamic subtest rcs0-smem: SUCCESS (1.276s)
[69.631742] Starting dynamic subtest: bcs0-smem
[70.899458] Dynamic subtest bcs0-smem: SUCCESS (1.270s)
[70.903491] Starting dynamic subtest: vcs0-smem
[72.171510] Dynamic subtest vcs0-smem: SUCCESS (1.272s)
[72.175622] Starting dynamic subtest: vcs1-smem
[73.443764] Dynamic subtest vcs1-smem: SUCCESS (1.272s)
[73.447711] Starting dynamic subtest: vecs0-smem
[74.715767] Dynamic subtest vecs0-smem: SUCCESS (1.272s)
[74.716492] Subtest capture: SUCCESS (6.362s)
[74.780304] [035/136] (907s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[74.887734] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[74.888607] Starting dynamic subtest: pipe-A-valid-mode
[74.938211] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s)
[74.940047] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.051s)
[75.007873] [036/136] (907s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[75.108759] Starting subtest: cursorB-vs-flipA-atomic-transitions
[75.110432] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[75.142558] [037/136] (907s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs)
[75.319673] Starting subtest: pipe-D-random-ccs-data-y_tiled_ccs
[75.322227] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[75.396748] [038/136] (906s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[75.563440] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[75.568695] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.003s)
[75.655763] [039/136] (906s left) gem_exec_balancer (bonded-semaphore)
[75.718838] Starting subtest: bonded-semaphore
[79.803650] Subtest bonded-semaphore: SUCCESS (4.076s)
[80.045481] [040/136] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[80.153081] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[80.154887] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[80.206392] [041/136] (902s left) gem_exec_flush (basic-batch-kernel-default-wb)
[80.263177] Starting subtest: basic-batch-kernel-default-wb
[85.727284] Subtest basic-batch-kernel-default-wb: SUCCESS (5.464s)
[85.885790] [042/136] (896s left) perf (create-destroy-userspace-config)
[86.000371] Starting subtest: create-destroy-userspace-config
[86.017838] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[86.035657] [043/136] (896s left) gem_ctx_param (invalid-size-set)
[86.084386] Starting subtest: invalid-size-set
[86.085241] Subtest invalid-size-set: SUCCESS (0.000s)
[86.131162] [044/136] (896s left) gem_pxp (reject-modify-context-protection-off-1)
[88.735505] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[88.749475] [045/136] (893s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[88.859931] Starting subtest: 4-tiled-32bpp-rotate-270
[88.861572] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[88.922694] [046/136] (893s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[89.023652] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[89.025211] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[89.081149] [047/136] (893s left) i915_pm_dc (dc3co-vpb-simulation)
[90.185978] Starting subtest: dc3co-vpb-simulation
[90.187443] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[90.223015] [048/136] (892s left) dumb_buffer (create-valid-dumb)
[90.274744] Starting subtest: create-valid-dumb
[90.275484] Subtest create-valid-dumb: SUCCESS (0.000s)
[90.336226] [049/136] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[90.448022] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[90.449441] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[90.506213] [050/136] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[90.607023] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[90.608435] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[90.656140] [051/136] (891s left) gem_exec_schedule (preempt-queue-contexts)
[90.717839] Starting subtest: preempt-queue-contexts
[90.718646] Starting dynamic subtest: rcs0
[90.996509] Dynamic subtest rcs0: SUCCESS (0.270s)
[91.001508] Starting dynamic subtest: bcs0
[91.257430] Dynamic subtest bcs0: SUCCESS (0.261s)
[91.261960] Starting dynamic subtest: vcs0
[91.512949] Dynamic subtest vcs0: SUCCESS (0.255s)
[91.517585] Starting dynamic subtest: vcs1
[91.776422] Dynamic subtest vcs1: SUCCESS (0.263s)
[91.782093] Starting dynamic subtest: vecs0
[92.040976] Dynamic subtest vecs0: SUCCESS (0.264s)
[92.041800] Subtest preempt-queue-contexts: SUCCESS (1.315s)
[92.297562] [052/136] (890s left) gem_exec_schedule (semaphore-noskip)
[92.370173] Starting subtest: semaphore-noskip
[92.686579] Subtest semaphore-noskip: SUCCESS (0.307s)
[92.940638] [053/136] (889s left) gem_mmap_gtt (cpuset-medium-copy)
[93.000134] Starting subtest: cpuset-medium-copy
[99.603774] Subtest cpuset-medium-copy: SUCCESS (6.602s)
[99.642128] [054/136] (882s left) kms_cursor_crc (cursor-onscreen-32x10)
[99.798869] Starting subtest: cursor-onscreen-32x10
[99.883474] Subtest cursor-onscreen-32x10: SKIP (0.083s)
[99.933178] [055/136] (882s left) drm_fdinfo (all-busy-idle-check-all)
[99.987048] Starting subtest: all-busy-idle-check-all
[100.601808] Subtest all-busy-idle-check-all: SUCCESS (0.611s)
[100.633439] [056/136] (881s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[100.732509] Starting subtest: 2x-cursor-vs-flip-atomic
[100.734187] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[100.766713] [057/136] (881s left) kms_chamelium_edid (hdmi-edid-read)
[100.911644] Subtest hdmi-edid-read: SKIP (0.000s)
[100.965286] [058/136] (881s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[101.073191] Starting subtest: yf-tiled-8bpp-rotate-0
[101.074661] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[101.137222] [059/136] (881s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[101.239563] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[103.797559] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (2.559s)
[103.903138] [060/136] (878s left) kms_ccs (pipe-b-random-ccs-data-yf_tiled_ccs)
[104.062021] Starting subtest: pipe-B-random-ccs-data-yf_tiled_ccs
[104.064510] Subtest pipe-B-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[104.153887] [061/136] (878s left) kms_addfb_basic (bad-pitch-128)
[104.206022] Starting subtest: bad-pitch-128
[104.206891] Subtest bad-pitch-128: SUCCESS (0.000s)
[104.411898] [062/136] (878s left) core_setmaster_vs_auth
[104.495046] [063/136] (878s left) gen9_exec_parse (secure-batches)
[104.547561] Subtest secure-batches: SKIP (0.000s)
[104.563346] [064/136] (878s left) kms_plane_scaling (planes-upscale-factor-0-25)
[104.663887] Starting subtest: planes-upscale-factor-0-25
[104.664625] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.831500] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.168s)
[104.835948] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.973671] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.142s)
[104.978492] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.122893] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.149s)
[105.127378] Starting dynamic subtest: pipe-D-HDMI-A-1
[105.263596] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.140s)
[105.264354] Subtest planes-upscale-factor-0-25: SUCCESS (0.600s)
[105.393130] [065/136] (877s left) prime_mmap (test_forked_cpu_write)
[105.444841] Starting subtest: test_forked_cpu_write
[105.445603] Starting dynamic subtest: test_forked_cpu_write-smem
[105.453174] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[105.453950] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[105.508901] [066/136] (877s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[105.609110] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[105.609955] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.650105] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.039s)
[105.654650] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.684447] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.034s)
[105.688932] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.717545] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.034s)
[105.722267] Starting dynamic subtest: pipe-D-HDMI-A-1
[105.751659] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.033s)
[105.753139] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.141s)
[105.809479] [067/136] (876s left) gem_busy (parallel)
[105.978278] Starting subtest: parallel
[105.979086] Starting dynamic subtest: rcs0
[106.013157] Dynamic subtest rcs0: SUCCESS (0.035s)
[106.017824] Starting dynamic subtest: bcs0
[106.028976] Dynamic subtest bcs0: SUCCESS (0.016s)
[106.033917] Starting dynamic subtest: vcs0
[106.048017] Dynamic subtest vcs0: SUCCESS (0.019s)
[106.052615] Starting dynamic subtest: vcs1
[106.069233] Dynamic subtest vcs1: SUCCESS (0.021s)
[106.073668] Starting dynamic subtest: vecs0
[106.094158] Dynamic subtest vecs0: SUCCESS (0.025s)
[106.094890] Subtest parallel: SUCCESS (0.116s)
[106.267987] [068/136] (876s left) kms_content_protection (legacy)
[106.373831] Starting subtest: legacy
[107.164594] Subtest legacy: SKIP (0.789s)
[107.307329] [069/136] (875s left) api_intel_allocator (simple-allocator)
[107.358850] Starting subtest: simple-allocator
[107.359783] Starting dynamic subtest: basic
[107.360563] Dynamic subtest basic: SUCCESS (0.002s)
[107.365816] Starting dynamic subtest: parallel-one
[107.432032] Dynamic subtest parallel-one: SUCCESS (0.072s)
[107.436711] Starting dynamic subtest: print
[107.437444] Dynamic subtest print: SUCCESS (0.000s)
[107.442068] Starting dynamic subtest: reuse
[107.442805] Dynamic subtest reuse: SUCCESS (0.000s)
[107.447358] Starting dynamic subtest: reserve
[107.448100] Dynamic subtest reserve: SUCCESS (0.000s)
[107.452388] Starting dynamic subtest: fork-reopen-allocator
[107.453147] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[107.454014] Subtest simple-allocator: SUCCESS (0.087s)
[107.481696] [070/136] (875s left) kms_chamelium_hpd (common-hpd-after-suspend)
[107.636100] Subtest common-hpd-after-suspend: SKIP (0.000s)
[107.690829] [071/136] (875s left) kms_flip (plain-flip-fb-recreate-interruptible)
[107.775332] Starting subtest: plain-flip-fb-recreate-interruptible
[107.779925] Starting dynamic subtest: A-HDMI-A1
[115.574103] Dynamic subtest A-HDMI-A1: SUCCESS (7.792s)
[115.578871] Starting dynamic subtest: B-HDMI-A1
[123.330928] Dynamic subtest B-HDMI-A1: SUCCESS (7.757s)
[123.339020] Starting dynamic subtest: C-HDMI-A1
[131.093804] Dynamic subtest C-HDMI-A1: SUCCESS (7.763s)
[131.100893] Starting dynamic subtest: D-HDMI-A1
[138.850644] Dynamic subtest D-HDMI-A1: SUCCESS (7.756s)
[138.856243] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.081s)
[138.981971] [072/136] (843s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[139.139117] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[139.142652] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.003s)
[139.239374] [073/136] (843s left) kms_scaling_modes (scaling-mode-center)
[139.357398] Starting subtest: scaling-mode-center
[139.359228] Subtest scaling-mode-center: SKIP (0.000s)
[139.395369] [074/136] (843s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[139.504588] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[139.506131] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[139.545675] [075/136] (843s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[139.629569] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[139.645852] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.016s)
[139.687927] [076/136] (843s left) kms_color (ctm-0-75)
[139.789224] Starting subtest: ctm-0-75
[139.790047] Starting dynamic subtest: pipe-A-HDMI-A-1
[141.680916] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.837s)
[141.686870] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.441362] Dynamic subtest pipe-B-HDMI-A-1: FAIL (1.757s)
[143.446360] Starting dynamic subtest: pipe-C-HDMI-A-1
[145.205436] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.763s)
[145.209913] Starting dynamic subtest: pipe-D-HDMI-A-1
[146.967921] Dynamic subtest pipe-D-HDMI-A-1: FAIL (1.765s)
[146.968781] Subtest ctm-0-75: FAIL (7.127s)
[146.992319] [077/136] (835s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[147.065640] Starting subtest: multi-wait-all-available-submitted-signaled
[147.066488] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[147.105340] [078/136] (835s left) gem_exec_flush (basic-wb-prw-default)
[147.162937] Starting subtest: basic-wb-prw-default
[152.581017] Subtest basic-wb-prw-default: SUCCESS (5.418s)
[152.746914] [079/136] (830s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs)
[152.954922] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs
[152.956654] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[153.040989] [080/136] (829s left) perf (low-oa-exponent-permissions)
[153.130686] Starting subtest: low-oa-exponent-permissions
[153.162714] Subtest low-oa-exponent-permissions: SUCCESS (0.032s)
[153.179275] [081/136] (829s left) kms_vblank (pipe-b-wait-forked)
[153.278645] Starting subtest: pipe-B-wait-forked
[154.529748] Subtest pipe-B-wait-forked: SUCCESS (1.252s)
[154.628394] [082/136] (828s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[154.746059] Starting subtest: psr-rgb565-draw-mmap-cpu
[154.747563] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[154.811305] [083/136] (828s left) core_setmaster (master-drop-set-root)
[155.377472] Starting subtest: master-drop-set-root
[155.381115] Subtest master-drop-set-root: SUCCESS (0.004s)
[155.391601] [084/136] (827s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[155.497565] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[156.615576] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.120s)
[156.709542] [085/136] (826s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[156.816240] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[156.817779] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[156.869894] [086/136] (826s left) gem_ctx_persistence (heartbeat-many)
[156.922615] Starting subtest: heartbeat-many
[157.240443] Subtest heartbeat-many: SUCCESS (0.317s)
[157.283672] [087/136] (825s left) kms_plane_lowres (tiling-4)
[157.390161] Starting subtest: tiling-4
[157.391819] Subtest tiling-4: SKIP (0.000s)
[157.430269] [088/136] (825s left) v3d/v3d_perfmon (get-values-invalid-pad)
[157.507218] Subtest get-values-invalid-pad: SKIP (0.000s)
[157.536336] [089/136] (825s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[157.730728] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[157.732385] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[157.810606] [090/136] (825s left) syncobj_basic (bad-handle-to-fd)
[157.863409] Starting subtest: bad-handle-to-fd
[157.864246] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[157.903745] [091/136] (825s left) gem_userptr_blits (unsync-unmap-after-close)
[157.961878] Subtest unsync-unmap-after-close: SKIP (0.000s)
[158.037771] [092/136] (824s left) gem_vm_create (isolation)
[158.093427] Starting subtest: isolation
[158.096683] Subtest isolation: SUCCESS (0.003s)
[158.178255] [093/136] (824s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[158.289693] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[158.291183] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[158.344365] [094/136] (824s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[158.415029] Subtest bad-multisync-in-sync: SKIP (0.000s)
[158.444767] [095/136] (824s left) kms_psr (sprite_mmap_cpu)
[158.500037] Subtest sprite_mmap_cpu: SKIP (0.000s)
[158.519759] [096/136] (824s left) gen3_render_linear_blits
[158.599592] [097/136] (824s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[158.709356] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[159.881479] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (1.174s)
[159.981234] [098/136] (823s left) syncobj_timeline (reset-multiple-signaled)
[160.042449] Starting subtest: reset-multiple-signaled
[160.043283] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[160.077075] [099/136] (823s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[160.133109] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[160.241530] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[160.285432] [100/136] (822s left) kms_ccs (pipe-a-bad-rotation-90-yf_tiled_ccs)
[160.447141] Starting subtest: pipe-A-bad-rotation-90-yf_tiled_ccs
[160.448753] Subtest pipe-A-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[160.550695] [101/136] (822s left) perf (blocking-parameterized)
[160.635057] Starting subtest: blocking-parameterized
[180.691296] Subtest blocking-parameterized: SUCCESS (20.022s)
[180.711111] [102/136] (802s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[180.850498] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[180.851982] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[180.885937] [103/136] (802s left) kms_legacy_colorkey (invalid-plane)
[180.985796] Starting subtest: invalid-plane
[180.986545] Starting dynamic subtest: zero-id
[180.987317] Dynamic subtest zero-id: SUCCESS (0.000s)
[180.991770] Starting dynamic subtest: outrange-id
[180.992492] Dynamic subtest outrange-id: SUCCESS (0.000s)
[180.993232] Subtest invalid-plane: SUCCESS (0.001s)
[181.018664] [104/136] (802s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[181.069956] Starting subtest: etime-single-wait-for-submit-submitted
[181.177965] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[181.227634] [105/136] (801s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[181.337793] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[181.339236] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[181.385382] [106/136] (801s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[181.493627] Starting subtest: x-tiled-16bpp-rotate-90
[181.541560] Subtest x-tiled-16bpp-rotate-90: SKIP (0.047s)
[181.612172] [107/136] (801s left) gem_ctx_sseu (invalid-sseu)
[181.674490] Subtest invalid-sseu: SKIP (0.000s)
[181.695316] [108/136] (801s left) kms_vblank (pipe-a-wait-forked-hang)
[181.794864] Starting subtest: pipe-A-wait-forked-hang
[195.607335] Subtest pipe-A-wait-forked-hang: SUCCESS (13.812s)
[195.709328] [109/136] (787s left) kms_addfb_basic (bad-pitch-1024)
[195.761123] Starting subtest: bad-pitch-1024
[195.761935] Subtest bad-pitch-1024: SUCCESS (0.000s)
[195.983515] [110/136] (787s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[196.089196] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[196.090647] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[196.149725] [111/136] (787s left) gem_exec_balancer (parallel-out-fence)
[196.423727] Starting subtest: parallel-out-fence
[197.574279] Subtest parallel-out-fence: SUCCESS (1.151s)
[197.607787] [112/136] (785s left) gem_exec_reloc (basic-gtt-cpu-active)
[197.662983] Starting subtest: basic-gtt-cpu-active
[197.792554] Subtest basic-gtt-cpu-active: SUCCESS (0.122s)
[197.883439] [113/136] (785s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[197.984391] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[198.159051] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.175s)
[198.244577] [114/136] (785s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[198.352360] Starting subtest: y-tiled-64bpp-rotate-180
[199.864317] Subtest y-tiled-64bpp-rotate-180: SUCCESS (1.512s)
[199.981534] [115/136] (783s left) prime_vgem (fence-write-hang)
[200.069779] Subtest fence-write-hang: SKIP (0.000s)
[200.135509] [116/136] (783s left) gem_flink_basic (bad-open)
[200.193066] Starting subtest: bad-open
[200.193930] Subtest bad-open: SUCCESS (0.000s)
[200.227129] [117/136] (783s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[200.337066] Starting subtest: plane-all-transition-nonblocking-fencing
[200.337858] Starting dynamic subtest: pipe-A-HDMI-A-1
[202.263650] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.927s)
[202.325729] Starting dynamic subtest: pipe-B-HDMI-A-1
[204.360990] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.039s)
[204.412382] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (4.076s)
[204.525181] [118/136] (778s left) gem_mmap_gtt (medium-copy-xy)
[204.579235] Starting subtest: medium-copy-XY
[209.986750] Subtest medium-copy-XY: SUCCESS (5.408s)
[210.024201] [119/136] (773s left) kms_addfb_basic (addfb25-4-tiled)
[210.264343] Starting subtest: addfb25-4-tiled
[210.265236] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[210.330221] [120/136] (773s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[210.434772] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[210.436275] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[210.496534] [121/136] (772s left) gem_softpin (allocator-fork)
[210.551474] Starting subtest: allocator-fork
[212.773837] Subtest allocator-fork: SUCCESS (2.214s)
[212.848170] [122/136] (770s left) syncobj_timeline (wait-all-complex)
[212.915346] Starting subtest: wait-all-complex
[213.140146] Subtest wait-all-complex: SUCCESS (0.215s)
[213.178789] [123/136] (770s left) i915_pm_rps (engine-order)
[213.240839] Starting subtest: engine-order
[216.975487] Subtest engine-order: SUCCESS (3.726s)
[217.039191] [124/136] (766s left) kms_flip (2x-flip-vs-suspend-interruptible)
[217.133379] Starting subtest: 2x-flip-vs-suspend-interruptible
[217.150673] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.017s)
[217.190776] [125/136] (766s left) gem_exec_params (batch-first)
[217.247342] Starting subtest: batch-first
[217.250056] Subtest batch-first: SUCCESS (0.003s)
[217.319978] [126/136] (766s left) prime_busy (hang-wait)
[217.381659] Starting subtest: hang-wait
[217.382429] Starting dynamic subtest: rcs0
[231.430224] Dynamic subtest rcs0: SUCCESS (14.012s)
[231.440534] Starting dynamic subtest: bcs0
[238.445032] Dynamic subtest bcs0: SUCCESS (7.039s)
[238.454844] Starting dynamic subtest: vcs0
[245.420459] Dynamic subtest vcs0: SUCCESS (6.975s)
[245.428096] Starting dynamic subtest: vcs1
[252.486022] Dynamic subtest vcs1: SUCCESS (7.040s)
[252.493828] Starting dynamic subtest: vecs0
[259.436737] Dynamic subtest vecs0: SUCCESS (6.974s)
[259.438164] Subtest hang-wait: SUCCESS (42.045s)
[259.502368] [127/136] (723s left) v3d/v3d_create_bo (create-bo-0)
[259.582403] Subtest create-bo-0: SKIP (0.000s)
[259.613470] [128/136] (723s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[259.731410] Starting subtest: x-tiled-64bpp-rotate-90
[259.760518] Subtest x-tiled-64bpp-rotate-90: SKIP (0.028s)
[259.829224] [129/136] (723s left) kms_flip (basic-flip-vs-modeset)
[259.911442] Starting subtest: basic-flip-vs-modeset
[259.915422] Starting dynamic subtest: A-HDMI-A1
[260.641535] Dynamic subtest A-HDMI-A1: SUCCESS (0.725s)
[260.647590] Starting dynamic subtest: B-HDMI-A1
[261.279170] Dynamic subtest B-HDMI-A1: SUCCESS (0.638s)
[261.283975] Starting dynamic subtest: C-HDMI-A1
[261.928309] Dynamic subtest C-HDMI-A1: SUCCESS (0.648s)
[261.933247] Starting dynamic subtest: D-HDMI-A1
[262.593902] Dynamic subtest D-HDMI-A1: SUCCESS (0.665s)
[262.596695] Subtest basic-flip-vs-modeset: SUCCESS (2.686s)
[262.701418] [130/136] (720s left) gem_exec_whisper (basic-normal)
[262.763600] Starting subtest: basic-normal
[264.066964] Subtest basic-normal: SUCCESS (1.303s)
[264.206215] [131/136] (719s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-5)
[264.306370] Starting subtest: plane-downscale-with-modifiers-factor-0-5
[264.307221] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.320823] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.014s)
[264.326842] Starting dynamic subtest: pipe-B-HDMI-A-1
[264.354693] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.033s)
[264.360668] Starting dynamic subtest: pipe-C-HDMI-A-1
[264.388809] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.033s)
[264.394706] Starting dynamic subtest: pipe-D-HDMI-A-1
[264.421321] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.033s)
[264.422936] Subtest plane-downscale-with-modifiers-factor-0-5: SKIP (0.115s)
[264.472225] [132/136] (719s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[264.574792] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[265.616493] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.045s)
[265.714422] [133/136] (717s left) vc4/vc4_perfmon (destroy-valid-perfmon)
[265.792577] Subtest destroy-valid-perfmon: SKIP (0.000s)
[265.822445] [134/136] (717s left) kms_invalid_mode (bad-vsync-start)
[265.923470] Starting subtest: bad-vsync-start
[265.924315] Starting dynamic subtest: HDMI-A-1-pipe-A
[265.968480] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.045s)
[265.973361] Starting dynamic subtest: HDMI-A-1-pipe-B
[265.974200] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.001s)
[265.978931] Starting dynamic subtest: HDMI-A-1-pipe-C
[265.979729] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.001s)
[265.984377] Starting dynamic subtest: HDMI-A-1-pipe-D
[265.985199] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.001s)
[265.986031] Subtest bad-vsync-start: SUCCESS (0.050s)
[266.055496] [135/136] (717s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[266.105814] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[266.106657] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[266.140163] [136/136] (717s left) kms_rotation_crc (primary-rotation-90)
[266.238842] Starting subtest: primary-rotation-90
[270.544983] Subtest primary-rotation-90: SUCCESS (4.306s)
[270.697294] Closing watchdogs
Done.