[52.993885] Initializing watchdogs [52.994239] /dev/watchdog0 [53.011184] [001/141] (960s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled) [53.244562] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled [53.247134] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.002s) [53.336296] [002/141] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [53.666341] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [53.670293] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [53.769246] [003/141] (959s left) kms_prime (basic-crc-hybrid) [55.802959] Subtest basic-crc-hybrid: SKIP (0.000s) [55.989735] [004/141] (957s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [56.308459] Starting subtest: basic-write-cpu-read-gtt [56.355816] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [56.517838] [005/141] (957s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [58.014527] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s) [58.051094] [006/141] (955s left) syncobj_timeline (wait-delayed-signal) [58.261447] Starting subtest: wait-delayed-signal [58.364755] Subtest wait-delayed-signal: SUCCESS (0.104s) [58.450250] [007/141] (955s left) kms_cursor_legacy (flip-vs-cursor-legacy) [58.760237] Starting subtest: flip-vs-cursor-legacy [74.295309] Subtest flip-vs-cursor-legacy: SUCCESS (15.540s) [74.633737] [008/141] (939s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [74.971895] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [74.975933] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [75.081442] [009/141] (938s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [75.560390] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [75.567713] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.005s) [76.115278] [010/141] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [76.431403] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [76.435262] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [76.531863] [011/141] (937s left) perf_pmu (interrupts) [76.755606] Starting subtest: interrupts [77.923579] Subtest interrupts: SUCCESS (1.166s) [78.017681] [012/141] (936s left) gem_lmem_swapping (heavy-verify-multi-ccs) [78.228971] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [78.283082] [013/141] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [78.597614] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [78.601545] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [78.683715] [014/141] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [78.994826] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [78.998861] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [79.084608] [015/141] (935s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [79.418118] Starting subtest: planes-downscale-factor-0-5-unity-scaling [79.420193] Starting dynamic subtest: pipe-A-DP-1 [79.754696] Dynamic subtest pipe-A-DP-1: SUCCESS (0.338s) [79.778676] Starting dynamic subtest: pipe-B-DP-1 [80.141553] Dynamic subtest pipe-B-DP-1: SUCCESS (0.383s) [80.169551] Starting dynamic subtest: pipe-C-DP-1 [80.535111] Dynamic subtest pipe-C-DP-1: SUCCESS (0.388s) [80.537153] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (1.120s) [80.923526] [016/141] (933s left) gem_mmap_offset (bad-object) [81.129597] Starting subtest: bad-object [81.131647] Subtest bad-object: SUCCESS (0.004s) [81.223888] [017/141] (932s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [81.530964] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [81.535125] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [81.623289] [018/141] (932s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [81.949250] Starting subtest: yf-tiled-16bpp-rotate-270 [82.035809] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.083s) [82.155967] [019/141] (932s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc) [82.454911] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc [82.458847] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [83.181874] [020/141] (931s left) kms_chamelium_frames (hdmi-frame-dump) [83.579609] Subtest hdmi-frame-dump: SKIP (0.000s) [83.853419] [021/141] (930s left) gem_exec_fence (basic-busy) [84.214646] Starting subtest: basic-busy [84.216830] Starting dynamic subtest: rcs0 [84.250347] Dynamic subtest rcs0: SUCCESS (0.036s) [84.268813] Starting dynamic subtest: bcs0 [84.278362] Dynamic subtest bcs0: SUCCESS (0.026s) [84.296303] Starting dynamic subtest: vcs0 [84.300545] Dynamic subtest vcs0: SUCCESS (0.022s) [84.317173] Starting dynamic subtest: vecs0 [84.321515] Dynamic subtest vecs0: SUCCESS (0.019s) [84.323557] Subtest basic-busy: SUCCESS (0.105s) [84.999481] [022/141] (929s left) syncobj_wait (wait-for-submit-snapshot) [85.210121] Starting subtest: wait-for-submit-snapshot [85.294317] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [85.382308] [023/141] (929s left) gen7_exec_parse (basic-rejected) [85.601127] Subtest basic-rejected: SKIP (0.000s) [85.647671] [024/141] (928s left) kms_big_fb (y-tiled-8bpp-rotate-270) [85.965119] Starting subtest: y-tiled-8bpp-rotate-270 [86.047849] Subtest y-tiled-8bpp-rotate-270: SKIP (0.080s) [86.149336] [025/141] (928s left) api_intel_allocator (simple-allocator) [86.353228] Starting subtest: simple-allocator [86.355420] Starting dynamic subtest: basic [86.360377] Dynamic subtest basic: SUCCESS (0.006s) [86.376356] Starting dynamic subtest: parallel-one [86.509393] Dynamic subtest parallel-one: SUCCESS (0.149s) [86.525339] Starting dynamic subtest: print [86.527342] Dynamic subtest print: SUCCESS (0.000s) [86.542831] Starting dynamic subtest: reuse [86.544828] Dynamic subtest reuse: SUCCESS (0.001s) [86.561416] Starting dynamic subtest: reserve [86.563421] Dynamic subtest reserve: SUCCESS (0.000s) [86.578484] Starting dynamic subtest: fork-reopen-allocator [86.580393] Dynamic subtest fork-reopen-allocator: SUCCESS (0.042s) [86.582317] Subtest simple-allocator: SUCCESS (0.200s) [86.633676] [026/141] (927s left) gem_exec_balancer (hog) [86.861374] Starting subtest: hog [90.508262] Subtest hog: SUCCESS (3.643s) [94.366977] [027/141] (920s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [94.573917] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [94.576124] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.002s) [94.647451] [028/141] (919s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [95.631188] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s) [95.972246] [029/141] (918s left) gem_ccs (suspend-resume) [96.201031] Subtest suspend-resume: SKIP (0.000s) [96.262115] [030/141] (918s left) gem_ctx_bad_destroy (invalid-pad) [96.479995] Starting subtest: invalid-pad [96.482214] Subtest invalid-pad: SUCCESS (0.000s) [96.562980] [031/141] (918s left) syncobj_wait (invalid-single-wait-unsubmitted) [96.778096] Starting subtest: invalid-single-wait-unsubmitted [96.780215] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [96.861892] [032/141] (917s left) i915_module_load (reload-no-display) [97.057795] Starting subtest: reload-no-display [100.344997] Subtest reload-no-display: SUCCESS (3.287s) [100.374227] [033/141] (914s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [102.869968] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [102.882271] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.005s) [103.018215] [034/141] (911s left) kms_vblank (pipe-d-query-busy) [103.403477] Subtest pipe-D-query-busy: SKIP (0.000s) [103.489524] [035/141] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [103.810836] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [103.814970] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [103.906442] [036/141] (911s left) gem_ctx_persistence (engines-mixed) [104.135860] Starting subtest: engines-mixed [104.138587] Starting dynamic subtest: rcs0 [104.201653] Dynamic subtest rcs0: SUCCESS (0.066s) [104.222764] Starting dynamic subtest: bcs0 [104.254423] Dynamic subtest bcs0: SUCCESS (0.053s) [104.279948] Starting dynamic subtest: vcs0 [104.310801] Dynamic subtest vcs0: SUCCESS (0.056s) [104.337395] Starting dynamic subtest: vecs0 [104.361426] Dynamic subtest vecs0: SUCCESS (0.051s) [104.364155] Subtest engines-mixed: SUCCESS (0.226s) [104.460382] [037/141] (910s left) kms_psr (psr2_sprite_plane_onoff) [104.666668] Subtest psr2_sprite_plane_onoff: SKIP (0.000s) [104.723152] [038/141] (910s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [105.024627] Starting subtest: 2x-cursor-vs-flip-legacy [105.028701] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.005s) [105.107544] [039/141] (909s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [105.420208] Starting subtest: cursor-vs-flip-atomic-transitions [143.463978] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (38.044s) [143.808529] [040/141] (871s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [144.033116] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [144.035135] Starting dynamic subtest: smem [144.468092] Dynamic subtest smem: SUCCESS (0.435s) [144.470143] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.436s) [144.671674] [041/141] (870s left) kms_plane_alpha_blend (constant-alpha-min) [144.985879] Starting subtest: constant-alpha-min [145.289470] Starting dynamic subtest: pipe-A-DP-1 [145.964783] Dynamic subtest pipe-A-DP-1: SUCCESS (0.675s) [145.984736] Starting dynamic subtest: pipe-C-DP-1 [146.910672] Dynamic subtest pipe-C-DP-1: SUCCESS (0.939s) [146.913677] Subtest constant-alpha-min: SUCCESS (1.928s) [147.264159] [042/141] (867s left) kms_cursor_crc (cursor-offscreen-128x128) [147.573792] Starting subtest: cursor-offscreen-128x128 [147.584779] Starting dynamic subtest: pipe-A-DP-1 [150.076409] Dynamic subtest pipe-A-DP-1: SUCCESS (2.490s) [150.151236] Starting dynamic subtest: pipe-C-DP-1 [152.947567] Dynamic subtest pipe-C-DP-1: SUCCESS (2.810s) [152.953688] Subtest cursor-offscreen-128x128: SUCCESS (5.374s) [153.298409] [043/141] (861s left) device_reset (unbind-cold-reset-rebind) [153.541248] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [153.629331] [044/141] (861s left) kms_prop_blob (invalid-set-prop) [153.834957] Starting subtest: invalid-set-prop [153.837180] Subtest invalid-set-prop: SUCCESS (0.000s) [153.911744] [045/141] (861s left) i915_pm_rps (min-max-config-loaded) [154.127852] Starting subtest: min-max-config-loaded [154.502373] Subtest min-max-config-loaded: SUCCESS (0.376s) [154.595183] [046/141] (860s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs) [155.212738] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs [155.216753] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s) [155.630199] [047/141] (859s left) kms_addfb_basic (unused-handle) [155.833741] Starting subtest: unused-handle [155.835960] Subtest unused-handle: SUCCESS (0.000s) [156.031320] [048/141] (859s left) kms_vblank (pipe-c-ts-continuation-modeset-hang) [156.338218] Starting subtest: pipe-C-ts-continuation-modeset-hang [164.019215] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (7.682s) [164.356639] [049/141] (851s left) v3d/v3d_wait_bo (used-bo-0ns) [164.619832] Subtest used-bo-0ns: SKIP (0.000s) [164.689917] [050/141] (850s left) kms_cursor_crc (cursor-random-32x32) [164.993060] Starting subtest: cursor-random-32x32 [165.106153] Subtest cursor-random-32x32: SKIP (0.110s) [165.223899] [051/141] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [165.540355] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [165.544306] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [165.640224] [052/141] (849s left) gem_mmap_gtt (cpuset-medium-copy-xy) [165.850450] Starting subtest: cpuset-medium-copy-XY [179.686747] Subtest cpuset-medium-copy-XY: SUCCESS (13.832s) [179.860150] [053/141] (835s left) kms_vblank (pipe-a-query-forked-busy-hang) [180.294248] Starting subtest: pipe-A-query-forked-busy-hang [187.001564] Subtest pipe-A-query-forked-busy-hang: SUCCESS (6.708s) [187.338384] [054/141] (828s left) perf (oa-exponents) [187.708626] Starting subtest: oa-exponents [187.710990] Starting dynamic subtest: 0-rcs0 [191.767054] Dynamic subtest 0-rcs0: SUCCESS (4.058s) [191.769708] Subtest oa-exponents: SUCCESS (4.061s) [191.820706] [055/141] (823s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [192.128713] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [192.132345] Starting dynamic subtest: pipe-A-valid-mode [192.262176] Dynamic subtest pipe-A-valid-mode: SKIP (0.130s) [192.266037] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.133s) [192.597577] [056/141] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [192.921096] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [192.925182] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [193.015348] [057/141] (822s left) kms_lease (lease_get) [193.318570] Starting subtest: lease_get [193.322433] Starting dynamic subtest: pipe-A-DP-1 [193.325768] Dynamic subtest pipe-A-DP-1: SUCCESS (0.003s) [193.345900] Starting dynamic subtest: pipe-B-DP-1 [193.348959] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s) [193.368810] Starting dynamic subtest: pipe-C-DP-1 [193.370844] Dynamic subtest pipe-C-DP-1: SUCCESS (0.001s) [193.372934] Subtest lease_get: SUCCESS (0.017s) [193.433248] [058/141] (822s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs) [193.992227] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs [194.001325] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [194.520492] [059/141] (821s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [194.746758] Starting subtest: y-tiled-to-vebox-x-tiled [194.750836] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [194.954337] [060/141] (820s left) vc4/vc4_tiling (get-bad-modifier) [195.214853] Subtest get-bad-modifier: SKIP (0.000s) [195.286596] [061/141] (820s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [195.604764] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [198.012123] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.413s) [198.186893] [062/141] (817s left) kms_frontbuffer_tracking (fbc-tiling-y) [198.505594] Starting subtest: fbc-tiling-y [200.712655] Subtest fbc-tiling-y: SUCCESS (2.211s) [200.835452] [063/141] (815s left) kms_rotation_crc (multiplane-rotation) [201.145508] Starting subtest: multiplane-rotation [215.232227] Subtest multiplane-rotation: SUCCESS (14.086s) [215.338234] [064/141] (800s left) kms_flip (2x-plain-flip-ts-check) [215.636585] Starting subtest: 2x-plain-flip-ts-check [215.646636] Subtest 2x-plain-flip-ts-check: SKIP (0.003s) [215.755847] [065/141] (800s left) gem_render_copy_redux (flink) [215.992362] Starting subtest: flink [220.695163] Subtest flink: SUCCESS (4.703s) [220.803540] [066/141] (795s left) drm_fdinfo (virtual-busy) [221.016898] Starting subtest: virtual-busy [223.209258] Subtest virtual-busy: SUCCESS (2.192s) [223.302976] [067/141] (792s left) i915_pm_rpm (pm-tiling) [225.356575] Starting subtest: pm-tiling [227.421116] Subtest pm-tiling: SUCCESS (2.065s) [227.653282] [068/141] (788s left) gem_exec_reloc (basic-cpu-read) [227.873146] Starting subtest: basic-cpu-read [227.895284] Subtest basic-cpu-read: SUCCESS (0.022s) [228.084367] [069/141] (788s left) gem_ctx_engines (independent) [228.315766] Starting subtest: independent [228.317846] Starting dynamic subtest: rcs0 [228.561064] Dynamic subtest rcs0: SUCCESS (0.243s) [228.582071] Starting dynamic subtest: bcs0 [228.839564] Dynamic subtest bcs0: SUCCESS (0.276s) [228.868644] Starting dynamic subtest: vcs0 [229.075292] Dynamic subtest vcs0: SUCCESS (0.234s) [229.096588] Starting dynamic subtest: vecs0 [229.299033] Dynamic subtest vecs0: SUCCESS (0.222s) [229.322802] Starting dynamic subtest: all-engines [229.860557] Dynamic subtest all-engines: SUCCESS (0.560s) [229.862854] Subtest independent: SUCCESS (1.544s) [230.085715] [070/141] (786s left) kms_cursor_crc (cursor-rapid-movement-64x21) [230.401957] Starting subtest: cursor-rapid-movement-64x21 [230.427903] Starting dynamic subtest: pipe-A-DP-1 [230.922607] Dynamic subtest pipe-A-DP-1: SUCCESS (0.511s) [231.013056] Starting dynamic subtest: pipe-C-DP-1 [231.832591] Dynamic subtest pipe-C-DP-1: SUCCESS (0.844s) [231.836870] Subtest cursor-rapid-movement-64x21: SUCCESS (1.432s) [232.190683] [071/141] (784s left) v3d/v3d_perfmon (destroy-valid-perfmon) [232.462496] Subtest destroy-valid-perfmon: SKIP (0.000s) [232.536645] [072/141] (783s left) gem_ctx_param (invalid-size-get) [232.744201] Starting subtest: invalid-size-get [232.746648] Subtest invalid-size-get: SUCCESS (0.000s) [232.836560] [073/141] (783s left) gem_pxp (create-regular-context-2) [235.561175] Subtest create-regular-context-2: SKIP (0.000s) [235.651358] [074/141] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [235.980153] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [235.984364] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [236.088876] [075/141] (780s left) gem_exec_reloc (basic-gtt-cpu-active) [236.304602] Starting subtest: basic-gtt-cpu-active [236.447880] Subtest basic-gtt-cpu-active: SUCCESS (0.142s) [236.637940] [076/141] (779s left) kms_frontbuffer_tracking (fbc-suspend) [236.959517] Starting subtest: fbc-suspend [274.174778] Subtest fbc-suspend: SUCCESS (6.209s) [278.394396] [077/141] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [278.732071] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [278.736023] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [278.839145] [078/141] (772s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [279.146578] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [279.150479] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [279.239418] [079/141] (772s left) v3d/v3d_submit_csd (bad-multisync-pad) [279.510806] Subtest bad-multisync-pad: SKIP (0.000s) [279.588115] [080/141] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [279.900223] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [279.904023] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [280.005002] [081/141] (771s left) sysfs_timeslice_duration (timeout) [280.224585] Starting subtest: timeout [280.228136] Starting dynamic subtest: vecs0 [281.112994] Dynamic subtest vecs0: SUCCESS (0.885s) [281.139144] Starting dynamic subtest: vcs0 [282.015205] Dynamic subtest vcs0: SUCCESS (0.900s) [282.041961] Starting dynamic subtest: bcs0 [282.914073] Dynamic subtest bcs0: SUCCESS (0.895s) [282.939438] Starting dynamic subtest: rcs0 [283.823153] Dynamic subtest rcs0: SUCCESS (0.907s) [283.825482] Subtest timeout: SUCCESS (3.600s) [283.919455] [082/141] (767s left) kms_dsc (dsc-with-output-formats) [284.228343] Subtest dsc-with-output-formats: SKIP (0.000s) [284.287284] [083/141] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [284.596751] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [286.757911] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.165s) [286.920345] [084/141] (764s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted) [287.134867] Starting subtest: invalid-single-wait-all-available-unsubmitted [287.137263] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s) [287.220156] [085/141] (764s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [287.427611] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [287.486821] [086/141] (764s left) gen9_exec_parse (bb-start-param) [287.718341] Starting subtest: bb-start-param [287.723598] Subtest bb-start-param: SUCCESS (0.005s) [287.954090] [087/141] (764s left) kms_flip (2x-flip-vs-wf_vblank) [288.235456] Starting subtest: 2x-flip-vs-wf_vblank [288.239542] Subtest 2x-flip-vs-wf_vblank: SKIP (0.003s) [288.355697] [088/141] (763s left) perf (per-context-mode-unprivileged) [288.662696] Starting subtest: per-context-mode-unprivileged [288.666998] Subtest per-context-mode-unprivileged: SKIP (0.000s) [288.721463] [089/141] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [289.039140] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [289.042982] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [289.138513] [090/141] (763s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [289.446234] Starting subtest: primary-y-tiled-reflect-x-0 [289.450576] Subtest primary-y-tiled-reflect-x-0: SKIP (0.003s) [289.539036] [091/141] (762s left) syncobj_wait (single-wait-all-for-submit-submitted) [289.747100] Starting subtest: single-wait-all-for-submit-submitted [289.854947] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s) [289.954746] [092/141] (762s left) kms_pipe_crc_basic (suspend-read-crc) [290.272180] Starting subtest: suspend-read-crc [290.274280] Starting dynamic subtest: pipe-A-DP-1 [308.337527] Dynamic subtest pipe-A-DP-1: SUCCESS (2.313s) [314.262905] [093/141] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [314.586669] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [314.590559] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [314.696895] [094/141] (758s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [314.999117] Starting subtest: cursorB-vs-flipA-toggle [315.003139] Subtest cursorB-vs-flipA-toggle: SKIP (0.005s) [315.096436] [095/141] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [315.440663] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [317.749461] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.340s) [317.894572] [096/141] (755s left) gem_ctx_persistence (process) [318.113944] Starting subtest: process [318.242764] Subtest process: SUCCESS (0.126s) [318.330732] [097/141] (754s left) gem_ppgtt (blt-vs-render-ctxn) [318.545352] Starting subtest: blt-vs-render-ctxN [351.407514] Subtest blt-vs-render-ctxN: SUCCESS (32.861s) [351.530225] [098/141] (721s left) perf_pmu (busy-accuracy-50) [351.865187] Starting subtest: busy-accuracy-50 [351.867392] Starting dynamic subtest: rcs0 [353.420508] Dynamic subtest rcs0: SUCCESS (1.552s) [353.444968] Starting dynamic subtest: bcs0 [354.976955] Dynamic subtest bcs0: SUCCESS (1.554s) [355.001135] Starting dynamic subtest: vcs0 [356.532066] Dynamic subtest vcs0: SUCCESS (1.553s) [356.556437] Starting dynamic subtest: vecs0 [358.086968] Dynamic subtest vecs0: SUCCESS (1.552s) [358.089166] Subtest busy-accuracy-50: SUCCESS (6.221s) [358.180720] [099/141] (715s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs) [358.929623] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s) [359.256849] [100/141] (714s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [359.974756] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [360.298846] [101/141] (713s left) gem_madvise (dontneed-before-exec) [360.500172] Starting subtest: dontneed-before-exec [360.510203] Subtest dontneed-before-exec: SUCCESS (0.010s) [360.631836] [102/141] (712s left) kms_chamelium_color (ctm-negative) [360.941148] Subtest ctm-negative: SKIP (0.000s) [360.996969] [103/141] (712s left) gem_madvise (dontneed-before-mmap) [361.194013] Starting subtest: dontneed-before-mmap [361.211154] Subtest dontneed-before-mmap: SUCCESS (0.016s) [361.331708] [104/141] (712s left) gem_set_tiling_vs_gtt [361.933087] [105/141] (711s left) i915_pm_rpm (gem-evict-pwrite) [363.915806] Starting subtest: gem-evict-pwrite [365.011918] Subtest gem-evict-pwrite: SUCCESS (1.097s) [365.497530] [106/141] (708s left) gem_exec_fence (syncobj-signal) [366.176304] Starting subtest: syncobj-signal [366.184136] Subtest syncobj-signal: SUCCESS (0.008s) [366.560199] [107/141] (707s left) kms_color (ctm-red-to-blue) [366.866348] Starting subtest: ctm-red-to-blue [366.868533] Starting dynamic subtest: pipe-A [367.396853] Dynamic subtest pipe-A: SUCCESS (0.532s) [367.444342] Starting dynamic subtest: pipe-B [368.225800] Dynamic subtest pipe-B: SUCCESS (0.823s) [368.273126] Starting dynamic subtest: pipe-C [369.161706] Dynamic subtest pipe-C: SUCCESS (0.934s) [369.164301] Subtest ctm-red-to-blue: SUCCESS (2.296s) [369.507216] [108/141] (704s left) prime_self_import (basic-with_one_bo) [369.711135] Starting subtest: basic-with_one_bo [369.720146] Subtest basic-with_one_bo: SUCCESS (0.009s) [369.823087] [109/141] (704s left) gem_exec_parallel (engines) [370.049227] Starting subtest: engines [370.051471] Starting dynamic subtest: basic [373.717925] Dynamic subtest basic: SUCCESS (3.667s) [373.743707] Starting dynamic subtest: contexts [377.662705] Dynamic subtest contexts: SUCCESS (3.942s) [377.688005] Starting dynamic subtest: fds [382.528604] Dynamic subtest fds: SUCCESS (4.864s) [382.556883] Starting dynamic subtest: userptr [386.249926] Dynamic subtest userptr: SUCCESS (3.719s) [386.252155] Subtest engines: SUCCESS (16.202s) [386.461512] [110/141] (687s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [387.062371] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [387.070083] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s) [387.521966] [111/141] (686s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [388.268517] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [388.273716] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.004s) [388.610030] [112/141] (685s left) gem_exec_big (single) [388.829741] Starting subtest: single [427.890219] Subtest single: SUCCESS (39.059s) [433.906292] [113/141] (640s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs) [434.539106] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs [434.543983] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s) [435.130058] [114/141] (638s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [435.434084] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [435.436387] Starting dynamic subtest: pipe-A-valid-mode [435.532518] Dynamic subtest pipe-A-valid-mode: SKIP (0.094s) [435.538137] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.099s) [435.856304] [115/141] (638s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [436.179440] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [436.183553] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [436.289707] [116/141] (637s left) fbdev (unaligned-write) [436.508687] Starting subtest: unaligned-write [436.697152] Subtest unaligned-write: SUCCESS (0.188s) [436.789657] [117/141] (637s left) kms_vrr (flip-dpms) [437.092937] Starting subtest: flip-dpms [437.097104] Subtest flip-dpms: SKIP (0.000s) [437.154583] [118/141] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [437.471427] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [437.475503] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [437.572879] [119/141] (636s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [438.142814] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs [438.147117] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s) [438.613619] [120/141] (635s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs) [439.110705] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs [439.650627] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.540s) [440.313517] [121/141] (634s left) gem_mmap_wc (invalid-flags) [440.526571] Starting subtest: invalid-flags [440.528962] Subtest invalid-flags: SUCCESS (0.000s) [440.645831] [122/141] (633s left) gem_exec_schedule (preempt-other) [440.899417] Starting subtest: preempt-other [440.901619] Starting dynamic subtest: rcs0 [440.974569] Dynamic subtest rcs0: SUCCESS (0.073s) [441.008686] Starting dynamic subtest: bcs0 [441.054916] Dynamic subtest bcs0: SUCCESS (0.077s) [441.094366] Starting dynamic subtest: vcs0 [441.132030] Dynamic subtest vcs0: SUCCESS (0.074s) [441.169074] Starting dynamic subtest: vecs0 [441.211662] Dynamic subtest vecs0: SUCCESS (0.076s) [441.213937] Subtest preempt-other: SUCCESS (0.313s) [441.563399] [123/141] (632s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [441.902783] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [443.612313] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.709s) [443.765872] [124/141] (630s left) gem_userptr_blits (stress-purge) [444.014401] Starting subtest: stress-purge [449.567803] Subtest stress-purge: SUCCESS (5.553s) [449.759441] [125/141] (624s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [450.186476] Starting subtest: nonblocking-modeset-vs-cursor-atomic [451.117711] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.748s) [451.347665] [126/141] (623s left) gem_workarounds (reset) [451.596649] Starting subtest: reset [451.623438] Subtest reset: SUCCESS (0.026s) [451.732802] [127/141] (623s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [451.955689] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [452.061534] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s) [452.165906] [128/141] (622s left) gem_exec_whisper (basic-fds-all) [452.397571] Starting subtest: basic-fds-all [470.134654] Subtest basic-fds-all: SUCCESS (17.735s) [470.349014] [129/141] (604s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [470.678262] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [470.683019] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [470.800979] [130/141] (604s left) gem_exec_schedule (reorder-wide) [471.166211] Starting subtest: reorder-wide [471.168612] Starting dynamic subtest: rcs0 [471.335139] Dynamic subtest rcs0: SUCCESS (0.166s) [471.368584] Starting dynamic subtest: bcs0 [471.689817] Dynamic subtest bcs0: SUCCESS (0.351s) [471.720205] Starting dynamic subtest: vcs0 [471.853112] Dynamic subtest vcs0: SUCCESS (0.161s) [471.884862] Starting dynamic subtest: vecs0 [472.021642] Dynamic subtest vecs0: SUCCESS (0.165s) [472.024107] Subtest reorder-wide: SUCCESS (0.857s) [472.267014] [131/141] (602s left) gem_ctx_param (root-set) [472.474367] Starting subtest: root-set [472.476592] Subtest root-set: SUCCESS (0.000s) [472.564825] [132/141] (602s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc) [473.212993] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc [473.218781] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s) [473.618442] [133/141] (601s left) kms_big_fb (4-tiled-64bpp-rotate-270) [473.953623] Starting subtest: 4-tiled-64bpp-rotate-270 [473.957998] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s) [474.050828] [134/141] (601s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs) [474.355836] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs [474.360006] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s) [475.091702] [135/141] (600s left) kms_cursor_legacy (cursor-vs-flip-toggle) [475.396212] Starting subtest: cursor-vs-flip-toggle [517.089906] Subtest cursor-vs-flip-toggle: SUCCESS (41.696s) [517.448127] [136/141] (557s left) kms_addfb_basic (addfb25-y-tiled-legacy) [517.754126] Starting subtest: addfb25-y-tiled-legacy [517.756677] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [517.878195] [137/141] (557s left) perf (buffer-fill) [518.206868] Starting subtest: buffer-fill [518.209315] Starting dynamic subtest: 0-rcs0 [521.102091] Dynamic subtest 0-rcs0: SUCCESS (2.893s) [521.104263] Subtest buffer-fill: SUCCESS (2.895s) [521.159121] [138/141] (554s left) kms_vblank (pipe-c-wait-busy) [521.479824] Starting subtest: pipe-C-wait-busy [524.474752] Subtest pipe-C-wait-busy: SUCCESS (2.995s) [524.828529] [139/141] (550s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [525.162222] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [526.261035] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.101s) [526.595619] [140/141] (548s left) perf_pmu (render-node-busy) [526.816503] Starting subtest: render-node-busy [526.818886] Starting dynamic subtest: rcs0 [527.347750] Dynamic subtest rcs0: SUCCESS (0.532s) [527.376418] Starting dynamic subtest: bcs0 [527.885801] Dynamic subtest bcs0: SUCCESS (0.535s) [527.913033] Starting dynamic subtest: vcs0 [528.433704] Dynamic subtest vcs0: SUCCESS (0.545s) [528.461158] Starting dynamic subtest: vecs0 [528.977204] Dynamic subtest vecs0: SUCCESS (0.541s) [528.979645] Subtest render-node-busy: SUCCESS (2.164s) [529.076390] [141/141] (546s left) gem_exec_flush (basic-wb-set-default) [529.305412] Starting subtest: basic-wb-set-default [534.772126] Subtest basic-wb-set-default: SUCCESS (5.467s) [534.989283] Closing watchdogs Done.