[37.432258] Initializing watchdogs [37.432399] /dev/watchdog0 [37.446786] [001/144] (960s left) v3d/v3d_perfmon (create-perfmon-invalid-counters) [37.537722] Subtest create-perfmon-invalid-counters: SKIP (0.000s) [37.586424] [002/144] (960s left) gem_exec_whisper (basic-normal-all) [37.684288] Starting subtest: basic-normal-all [41.614967] Subtest basic-normal-all: SUCCESS (3.929s) [41.793958] [003/144] (956s left) gem_exec_params (invalid-batch-start-offset) [41.882543] Starting subtest: invalid-batch-start-offset [41.888670] Subtest invalid-batch-start-offset: SUCCESS (0.003s) [41.998131] [004/144] (956s left) gem_lmem_swapping (random) [42.085978] Subtest random: SKIP (0.000s) [42.111955] [005/144] (955s left) syncobj_timeline (multi-wait-all-available-signaled) [42.189441] Starting subtest: multi-wait-all-available-signaled [42.192092] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [42.267180] [006/144] (955s left) kms_vblank (wait-idle) [42.353850] Starting subtest: wait-idle [42.356406] Starting dynamic subtest: pipe-A-eDP-1 [44.153136] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s) [44.171088] Starting dynamic subtest: pipe-D-eDP-1 [46.680149] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.518s) [46.682814] Subtest wait-idle: SUCCESS (4.326s) [47.619563] [007/144] (950s left) kms_psr (psr-sprite-plane-onoff) [47.720125] Starting subtest: psr-sprite-plane-onoff [47.722694] Starting dynamic subtest: eDP-1 [49.617379] Dynamic subtest eDP-1: SUCCESS (1.897s) [49.620103] Subtest psr-sprite-plane-onoff: SUCCESS (1.898s) [50.546594] [008/144] (947s left) perf_pmu (init-sema) [50.598503] Starting subtest: init-sema [50.600985] Starting dynamic subtest: rcs0 [50.603473] Dynamic subtest rcs0: SUCCESS (0.001s) [50.608776] Starting dynamic subtest: bcs0 [50.611184] Dynamic subtest bcs0: SUCCESS (0.001s) [50.616470] Starting dynamic subtest: vcs0 [50.618452] Dynamic subtest vcs0: SUCCESS (0.000s) [50.623358] Starting dynamic subtest: vcs1 [50.625339] Dynamic subtest vcs1: SUCCESS (0.001s) [50.638115] Starting dynamic subtest: vecs0 [50.640737] Dynamic subtest vecs0: SUCCESS (0.000s) [50.654649] Starting dynamic subtest: ccs0 [50.657283] Dynamic subtest ccs0: SUCCESS (0.000s) [50.659919] Subtest init-sema: SUCCESS (0.004s) [50.684446] [009/144] (947s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [50.759208] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [50.764579] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [50.940820] [010/144] (947s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [51.042867] Starting subtest: psr-rgb101010-draw-blt [56.270301] Subtest psr-rgb101010-draw-blt: SUCCESS (5.229s) [56.392914] [011/144] (941s left) kms_cursor_crc (cursor-offscreen-128x42) [56.616084] Starting subtest: cursor-offscreen-128x42 [56.650909] Subtest cursor-offscreen-128x42: SKIP (0.026s) [56.817210] [012/144] (941s left) v3d/v3d_job_submission (array-job-submission) [56.898192] Subtest array-job-submission: SKIP (0.000s) [56.944534] [013/144] (941s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf-tiled-ccs) [57.354884] Starting subtest: pipe-B-crc-sprite-planes-basic-yf-tiled-ccs [57.360850] Subtest pipe-B-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.001s) [58.220173] [014/144] (940s left) kms_ccs (pipe-a-missing-ccs-buffer-yf-tiled-ccs) [58.588365] Starting subtest: pipe-A-missing-ccs-buffer-yf-tiled-ccs [58.593395] Subtest pipe-A-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s) [59.510235] [015/144] (938s left) sw_sync (sync_expired_merge) [59.564044] Starting subtest: sync_expired_merge [60.637045] Subtest sync_expired_merge: SUCCESS (1.074s) [60.681546] [016/144] (937s left) vc4/vc4_perfmon (destroy-valid-perfmon) [60.751100] Subtest destroy-valid-perfmon: SKIP (0.000s) [60.797180] [017/144] (937s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-mc-ccs) [61.197290] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs [62.246395] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (1.050s) [63.419578] [018/144] (934s left) vc4/vc4_perfmon (create-perfmon-exceed) [63.519937] Subtest create-perfmon-exceed: SKIP (0.000s) [63.569495] [019/144] (934s left) kms_big_fb (4-tiled-32bpp-rotate-270) [63.665925] Starting subtest: 4-tiled-32bpp-rotate-270 [63.682452] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s) [63.777311] [020/144] (934s left) gem_pwrite (basic-random) [63.859247] Subtest basic-random: SKIP (0.000s) [63.904674] [021/144] (934s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [64.009645] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [64.012292] Starting dynamic subtest: pipe-A-eDP-1 [64.034910] Dynamic subtest pipe-A-eDP-1: SKIP (0.022s) [64.048787] Starting dynamic subtest: pipe-B-eDP-1 [64.053647] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s) [64.065683] Starting dynamic subtest: pipe-C-eDP-1 [64.070512] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s) [64.080728] Starting dynamic subtest: pipe-D-eDP-1 [64.085484] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s) [64.089857] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.076s) [64.141380] [022/144] (934s left) prime_vgem (shrink) [64.255871] Starting subtest: shrink [64.274168] Subtest shrink: SUCCESS (0.016s) [64.355705] [023/144] (934s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [64.456295] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [64.460284] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [64.542416] [024/144] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [64.636212] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [64.639999] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [64.728113] [025/144] (933s left) perf (mi-rpc) [64.891866] Starting subtest: mi-rpc [64.895714] Subtest mi-rpc: SKIP (0.000s) [64.920798] [026/144] (933s left) kms_psr2_sf (fbc-plane-move-sf-dmg-area) [70.227661] Starting subtest: fbc-plane-move-sf-dmg-area [70.233695] Starting dynamic subtest: pipe-A-eDP-1 [71.062078] Dynamic subtest pipe-A-eDP-1: SKIP (0.832s) [71.077354] Starting dynamic subtest: pipe-B-eDP-1 [72.325651] Dynamic subtest pipe-B-eDP-1: SKIP (1.261s) [72.330194] Subtest fbc-plane-move-sf-dmg-area: SKIP (2.098s) [73.603044] [027/144] (925s left) gem_eio (in-flight-suspend) [73.838422] Starting subtest: in-flight-suspend [117.574707] Subtest in-flight-suspend: SUCCESS (14.742s) [117.684209] [028/144] (909s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [117.740339] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [117.742280] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [117.819018] [029/144] (909s left) gem_ctx_exec (basic-close-race) [117.891029] Starting subtest: basic-close-race [123.511936] Subtest basic-close-race: SUCCESS (5.619s) [123.619688] [030/144] (904s left) i915_hangman (gt-engine-error) [123.721810] Starting subtest: gt-engine-error [123.724329] Starting dynamic subtest: rcs0 [125.404275] Dynamic subtest rcs0: SUCCESS (1.681s) [125.423377] Starting dynamic subtest: bcs0 [127.386783] Dynamic subtest bcs0: SUCCESS (1.982s) [127.407150] Starting dynamic subtest: vcs0 [129.435582] Dynamic subtest vcs0: SUCCESS (2.048s) [129.454623] Starting dynamic subtest: vcs1 [131.418108] Dynamic subtest vcs1: SUCCESS (1.982s) [131.438188] Starting dynamic subtest: vecs0 [133.402561] Dynamic subtest vecs0: SUCCESS (1.984s) [133.422545] Starting dynamic subtest: ccs0 [135.450561] Dynamic subtest ccs0: SUCCESS (2.047s) [135.453763] Subtest gt-engine-error: SUCCESS (11.728s) [135.540146] [031/144] (892s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [135.629783] Starting subtest: etime-single-wait-for-submit-submitted [135.736766] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s) [135.808088] [032/144] (891s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [136.197552] Starting subtest: pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc [136.203642] Subtest pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [137.078921] [033/144] (890s left) i915_query (query-topology-garbage-items) [137.164206] Starting subtest: query-topology-garbage-items [137.166881] Subtest query-topology-garbage-items: SUCCESS (0.000s) [137.255719] [034/144] (890s left) syncobj_wait (wait-all-for-submit-snapshot) [137.329835] Starting subtest: wait-all-for-submit-snapshot [137.412193] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [137.490008] [035/144] (890s left) gem_exec_reloc (basic-cpu-read-active) [137.571955] Subtest basic-cpu-read-active: SKIP (0.000s) [137.635438] [036/144] (890s left) gem_exec_fence (keep-in-fence) [137.813933] Starting subtest: keep-in-fence [137.817102] Starting dynamic subtest: rcs0 [137.875490] Dynamic subtest rcs0: SUCCESS (0.063s) [137.894803] Starting dynamic subtest: bcs0 [137.931715] Dynamic subtest bcs0: SUCCESS (0.056s) [137.951669] Starting dynamic subtest: vcs0 [139.453068] Dynamic subtest vcs0: SUCCESS (1.520s) [139.472993] Starting dynamic subtest: vcs1 [141.437059] Dynamic subtest vcs1: SUCCESS (1.983s) [141.456017] Starting dynamic subtest: vecs0 [143.423239] Dynamic subtest vecs0: SUCCESS (1.985s) [143.442018] Starting dynamic subtest: ccs0 [143.733650] Dynamic subtest ccs0: SUCCESS (0.312s) [143.736556] Subtest keep-in-fence: SUCCESS (5.922s) [145.541983] [037/144] (882s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [148.144403] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [148.213168] [038/144] (879s left) gem_exec_balancer (hog) [148.329556] Starting subtest: hog [148.334744] Subtest hog: SKIP (0.000s) [148.586118] [039/144] (879s left) vgem_basic (second-client) [148.658297] Starting subtest: second-client [148.680412] Subtest second-client: SUCCESS (0.022s) [148.740073] [040/144] (879s left) gem_exec_balancer (sequential) [148.825187] Starting subtest: sequential [151.624453] Subtest sequential: SUCCESS (2.799s) [151.882012] [041/144] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [151.969595] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [151.973989] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [152.064783] [042/144] (876s left) kms_fbcon_fbt (fbc) [152.145738] Starting subtest: fbc [157.615892] Subtest fbc: SUCCESS (5.469s) [157.693337] [043/144] (870s left) kms_feature_discovery (display-3x) [157.789998] Starting subtest: display-3x [157.794327] Subtest display-3x: SKIP (0.000s) [157.856901] [044/144] (870s left) i915_pm_rps (engine-order) [157.940195] Starting subtest: engine-order [162.387136] Subtest engine-order: SUCCESS (4.446s) [162.464444] [045/144] (865s left) kms_invalid_mode (bad-vsync-end) [162.581795] Starting subtest: bad-vsync-end [162.584432] Starting dynamic subtest: pipe-A-eDP-1 [162.865650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [162.886023] Starting dynamic subtest: pipe-B-eDP-1 [162.888719] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [162.902611] Starting dynamic subtest: pipe-C-eDP-1 [162.905194] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [162.914880] Starting dynamic subtest: pipe-D-eDP-1 [162.917562] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [162.920163] Subtest bad-vsync-end: SUCCESS (0.297s) [163.787925] [046/144] (864s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [164.226858] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [164.232683] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [165.045345] [047/144] (863s left) gem_ctx_param (root-set) [165.105609] Starting subtest: root-set [165.108246] Subtest root-set: SUCCESS (0.001s) [165.195379] [048/144] (863s left) kms_lease (lease-again) [165.300270] Starting subtest: lease-again [165.302709] Starting dynamic subtest: pipe-A-eDP-1 [165.305152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [165.313268] Starting dynamic subtest: pipe-B-eDP-1 [165.315648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [165.322080] Starting dynamic subtest: pipe-C-eDP-1 [165.323989] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [165.330095] Starting dynamic subtest: pipe-D-eDP-1 [165.331983] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [165.333901] Subtest lease-again: SUCCESS (0.007s) [165.385937] [049/144] (862s left) kms_plane_lowres (tiling-x) [165.481399] Starting subtest: tiling-x [165.483986] Starting dynamic subtest: pipe-A-eDP-1 [165.489009] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [165.780126] Starting dynamic subtest: pipe-B-eDP-1 [165.785242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [165.794967] Starting dynamic subtest: pipe-C-eDP-1 [165.799397] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [165.807137] Starting dynamic subtest: pipe-D-eDP-1 [165.811438] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [165.816228] Subtest tiling-x: SKIP (0.301s) [166.644378] [050/144] (861s left) fbdev (unaligned-read) [166.725888] Starting subtest: unaligned-read [166.741984] Subtest unaligned-read: SUCCESS (0.016s) [166.805629] [051/144] (861s left) gem_ctx_isolation (nonpriv-switch) [166.892427] Starting subtest: nonpriv-switch [166.895262] Starting dynamic subtest: rcs0 [167.122411] Dynamic subtest rcs0: SUCCESS (0.231s) [167.141294] Starting dynamic subtest: bcs0 [167.441314] Dynamic subtest bcs0: SUCCESS (0.318s) [167.460316] Starting dynamic subtest: vcs0 [167.737249] Dynamic subtest vcs0: SUCCESS (0.297s) [167.752358] Starting dynamic subtest: vcs1 [169.787342] Dynamic subtest vcs1: SUCCESS (2.050s) [169.807087] Starting dynamic subtest: vecs0 [171.814308] Dynamic subtest vecs0: SUCCESS (2.027s) [171.827048] Starting dynamic subtest: ccs0 [173.904542] Dynamic subtest ccs0: SUCCESS (2.090s) [173.907621] Subtest nonpriv-switch: SUCCESS (7.013s) [174.143165] [052/144] (854s left) kms_prime (basic-crc-hybrid) [174.723552] Subtest basic-crc-hybrid: SKIP (0.000s) [174.798609] [053/144] (853s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [174.881106] Starting subtest: fbc-psr2-cursor-mmap-cpu [174.883312] Starting dynamic subtest: eDP-1 [174.888341] Dynamic subtest eDP-1: SKIP (0.000s) [174.893321] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [174.985925] [054/144] (853s left) kms_big_fb (y-tiled-16bpp-rotate-270) [175.097195] Starting subtest: y-tiled-16bpp-rotate-270 [175.101314] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [175.190938] [055/144] (853s left) kms_atomic_transition (plane-toggle-modeset-transition) [175.275160] Starting subtest: plane-toggle-modeset-transition [175.277155] Starting dynamic subtest: pipe-A-eDP-1 [189.828318] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.552s) [189.851467] Starting dynamic subtest: pipe-B-eDP-1 [204.050002] Dynamic subtest pipe-B-eDP-1: SUCCESS (14.214s) [204.052703] Subtest plane-toggle-modeset-transition: SUCCESS (28.775s) [204.994170] [056/144] (823s left) kms_pm_dc (dc5-dpms-negative) [206.100993] Starting subtest: dc5-dpms-negative [206.106047] Subtest dc5-dpms-negative: SKIP (0.000s) [206.182495] [057/144] (822s left) kms_properties (connector-properties-atomic) [206.277913] Starting subtest: connector-properties-atomic [206.721268] Subtest connector-properties-atomic: SUCCESS (0.435s) [207.614172] [058/144] (820s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [208.038374] Starting subtest: pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [208.044437] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [208.894938] [059/144] (819s left) perf_pmu (busy-accuracy-50) [208.942864] Starting subtest: busy-accuracy-50 [208.946154] Starting dynamic subtest: rcs0 [210.491326] Dynamic subtest rcs0: SUCCESS (1.547s) [210.510542] Starting dynamic subtest: bcs0 [212.053367] Dynamic subtest bcs0: SUCCESS (1.556s) [212.072896] Starting dynamic subtest: vcs0 [213.611602] Dynamic subtest vcs0: SUCCESS (1.561s) [213.631262] Starting dynamic subtest: vcs1 [215.177740] Dynamic subtest vcs1: SUCCESS (1.565s) [215.196793] Starting dynamic subtest: vecs0 [216.742276] Dynamic subtest vecs0: SUCCESS (1.563s) [216.763232] Starting dynamic subtest: ccs0 [218.310610] Dynamic subtest ccs0: SUCCESS (1.568s) [218.313256] Subtest busy-accuracy-50: SUCCESS (9.367s) [218.434392] [060/144] (810s left) gem_ctx_persistence (saturated-hostile) [218.520287] Starting subtest: saturated-hostile [218.522800] Starting dynamic subtest: rcs0 [218.655296] Dynamic subtest rcs0: SUCCESS (0.133s) [218.678493] Starting dynamic subtest: bcs0 [218.756923] Dynamic subtest bcs0: SUCCESS (0.101s) [218.776797] Starting dynamic subtest: vcs0 [218.871792] Dynamic subtest vcs0: SUCCESS (0.113s) [218.890580] Starting dynamic subtest: vcs1 [218.993976] Dynamic subtest vcs1: SUCCESS (0.121s) [219.012773] Starting dynamic subtest: vecs0 [219.112223] Dynamic subtest vecs0: SUCCESS (0.117s) [219.130689] Starting dynamic subtest: ccs0 [219.211261] Dynamic subtest ccs0: SUCCESS (0.098s) [219.213902] Subtest saturated-hostile: SUCCESS (0.691s) [219.294921] [061/144] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [219.394568] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [219.398104] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [219.478445] [062/144] (809s left) core_setmaster_vs_auth [219.662062] [063/144] (809s left) kms_psr (pr-suspend) [219.723329] Starting subtest: pr-suspend [219.727686] Subtest pr-suspend: SKIP (0.000s) [219.817444] [064/144] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [219.899983] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [219.903803] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [219.980884] [065/144] (808s left) gem_ctx_shared (q-smoketest-all) [220.058941] Starting subtest: Q-smoketest-all [252.457820] Subtest Q-smoketest-all: SUCCESS (32.347s) [253.488194] [066/144] (775s left) gem_spin_batch (resubmit-all) [253.589841] Starting subtest: resubmit-all [253.592474] Starting dynamic subtest: rcs0 [253.625031] Dynamic subtest rcs0: SUCCESS (0.035s) [253.644783] Starting dynamic subtest: bcs0 [253.647224] Dynamic subtest bcs0: SUCCESS (0.002s) [253.662860] Starting dynamic subtest: vcs0 [253.665440] Dynamic subtest vcs0: SUCCESS (0.002s) [253.676358] Starting dynamic subtest: vcs1 [253.678866] Dynamic subtest vcs1: SUCCESS (0.002s) [253.687183] Starting dynamic subtest: vecs0 [253.689406] Dynamic subtest vecs0: SUCCESS (0.002s) [253.696912] Starting dynamic subtest: ccs0 [253.699040] Dynamic subtest ccs0: SUCCESS (0.002s) [253.701167] Subtest resubmit-all: SUCCESS (0.048s) [255.465088] [067/144] (773s left) gem_pipe_control_store_loop (reused-buffer) [255.568338] Starting subtest: reused-buffer [257.730091] Subtest reused-buffer: SUCCESS (2.161s) [257.837668] [068/144] (771s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf-tiled-ccs) [258.280348] Starting subtest: pipe-D-crc-primary-rotation-180-yf-tiled-ccs [258.286698] Subtest pipe-D-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s) [259.135638] [069/144] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [259.224370] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [259.229850] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [259.300919] [070/144] (769s left) gem_exec_reloc (basic-cpu-wc-active) [259.378242] Subtest basic-cpu-wc-active: SKIP (0.000s) [259.433353] [071/144] (769s left) tools_test (sysfs_l3_parity) [259.507234] Starting subtest: sysfs_l3_parity [259.590736] Subtest sysfs_l3_parity: SKIP (0.102s) [259.648178] [072/144] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [259.734560] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [262.697606] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.966s) [262.845947] [073/144] (766s left) kms_getfb (getfb-repeated-different-handles) [262.915907] Starting subtest: getfb-repeated-different-handles [262.918242] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [263.006967] [074/144] (766s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu) [263.093056] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu [267.625617] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.534s) [267.764572] [075/144] (761s left) gem_exec_schedule (lateslice) [267.839730] Starting subtest: lateslice [267.842454] Starting dynamic subtest: rcs0 [267.850046] Dynamic subtest rcs0: SUCCESS (0.023s) [267.868904] Starting dynamic subtest: bcs0 [267.877085] Dynamic subtest bcs0: SUCCESS (0.022s) [267.892006] Starting dynamic subtest: vcs0 [267.894368] Dynamic subtest vcs0: SUCCESS (0.021s) [267.904361] Starting dynamic subtest: vcs1 [267.915593] Dynamic subtest vcs1: SUCCESS (0.021s) [267.927119] Starting dynamic subtest: vecs0 [267.937395] Dynamic subtest vecs0: SUCCESS (0.021s) [267.949848] Starting dynamic subtest: ccs0 [267.958238] Dynamic subtest ccs0: SUCCESS (0.020s) [267.960766] Subtest lateslice: SUCCESS (0.131s) [269.508500] [076/144] (759s left) prime_vgem (basic-gtt) [269.619569] Starting subtest: basic-gtt [269.625058] Subtest basic-gtt: SKIP (0.000s) [269.722079] [077/144] (759s left) kms_cursor_crc (cursor-onscreen-max-size) [270.134484] Starting subtest: cursor-onscreen-max-size [270.141694] Subtest cursor-onscreen-max-size: SKIP (0.000s) [270.237277] [078/144] (758s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [270.340143] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [270.352835] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.013s) [270.424184] [079/144] (758s left) kms_psr (fbc-pr-cursor-mmap-gtt) [270.521765] Starting subtest: fbc-pr-cursor-mmap-gtt [270.525983] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [270.646862] [080/144] (758s left) kms_big_fb (x-tiled-64bpp-rotate-90) [270.760616] Starting subtest: x-tiled-64bpp-rotate-90 [270.782229] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [270.894939] [081/144] (758s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [270.980319] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [270.982491] Starting dynamic subtest: pipe-A-eDP-1 [271.010230] Dynamic subtest pipe-A-eDP-1: SKIP (0.023s) [271.021002] Starting dynamic subtest: pipe-B-eDP-1 [271.039400] Dynamic subtest pipe-B-eDP-1: SKIP (0.029s) [271.049918] Starting dynamic subtest: pipe-C-eDP-1 [271.065845] Dynamic subtest pipe-C-eDP-1: SKIP (0.028s) [271.079342] Starting dynamic subtest: pipe-D-eDP-1 [271.095621] Dynamic subtest pipe-D-eDP-1: SKIP (0.028s) [271.099636] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.112s) [271.194354] [082/144] (758s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [271.298940] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [271.301111] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [272.527071] [083/144] (756s left) gem_fenced_exec_thrash (too-many-fences) [272.593135] Subtest too-many-fences: SKIP (0.000s) [272.668247] [084/144] (756s left) kms_pipe_crc_basic (bad-source) [272.763012] Starting subtest: bad-source [272.765559] Subtest bad-source: SUCCESS (0.000s) [272.830843] [085/144] (756s left) api_intel_bb (misplaced-blitter) [272.915989] Starting subtest: misplaced-blitter [272.931739] Subtest misplaced-blitter: SUCCESS (0.018s) [273.041820] [086/144] (756s left) kms_psr (psr2-primary-page-flip) [273.116458] Starting subtest: psr2-primary-page-flip [273.119161] Starting dynamic subtest: eDP-1 [274.924722] Dynamic subtest eDP-1: SUCCESS (1.810s) [274.927933] Subtest psr2-primary-page-flip: SUCCESS (1.812s) [275.838716] [087/144] (753s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [276.201555] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc [277.063257] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.864s) [278.243381] [088/144] (751s left) syncobj_timeline (single-wait-all-available-submitted) [278.312330] Starting subtest: single-wait-all-available-submitted [278.314870] Subtest single-wait-all-available-submitted: SUCCESS (0.001s) [278.407259] [089/144] (751s left) kms_chamelium_edid (hdmi-edid-read) [278.771042] Subtest hdmi-edid-read: SKIP (0.000s) [279.649149] [090/144] (749s left) gem_unref_active_buffers [279.836346] [091/144] (749s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [279.936584] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [279.939356] Starting dynamic subtest: pipe-A-default-mode [280.239396] Dynamic subtest pipe-A-default-mode: SKIP (0.299s) [280.245147] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.301s) [281.152858] [092/144] (748s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [281.250476] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [281.254890] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [281.325499] [093/144] (748s left) gem_exec_schedule (u-semaphore-resolve) [281.402173] Starting subtest: u-semaphore-resolve [281.458863] Subtest u-semaphore-resolve: SUCCESS (0.063s) [281.796617] [094/144] (747s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [281.860594] Starting subtest: primary-y-tiled-reflect-x-90 [281.867581] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [281.925088] [095/144] (747s left) gem_exec_schedule (semaphore-noskip) [282.004230] Starting subtest: semaphore-noskip [282.551121] Subtest semaphore-noskip: SUCCESS (0.556s) [282.884077] [096/144] (746s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt) [282.968583] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt [282.972792] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [283.028719] [097/144] (746s left) kms_cursor_legacy (torture-bo) [283.130199] Starting subtest: torture-bo [283.133046] Starting dynamic subtest: pipe-A [288.802638] Dynamic subtest pipe-A: SUCCESS (5.672s) [288.826637] Starting dynamic subtest: pipe-B [295.467814] Dynamic subtest pipe-B: SUCCESS (6.664s) [295.490369] Starting dynamic subtest: pipe-C [302.207201] Dynamic subtest pipe-C: SUCCESS (6.737s) [302.226811] Starting dynamic subtest: pipe-D [309.344736] Dynamic subtest pipe-D: SUCCESS (7.136s) [309.366847] Starting dynamic subtest: all-pipes [316.343763] Dynamic subtest all-pipes: SUCCESS (6.997s) [316.346912] Subtest torture-bo: SUCCESS (33.213s) [316.502580] [098/144] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [316.604567] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [316.609061] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [316.690070] [099/144] (713s left) api_intel_allocator (fork-simple-stress-signal) [316.764299] Starting subtest: fork-simple-stress-signal [322.180640] Subtest fork-simple-stress-signal: SUCCESS (5.419s) [322.282288] [100/144] (707s left) vgem_basic (bad-flag) [322.338944] Starting subtest: bad-flag [322.341493] Subtest bad-flag: SUCCESS (0.000s) [322.392151] [101/144] (707s left) kms_ccs (pipe-d-bad-pixel-format-yf-tiled-ccs) [322.792443] Starting subtest: pipe-D-bad-pixel-format-yf-tiled-ccs [322.798413] Subtest pipe-D-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s) [323.645401] [102/144] (706s left) gem_eio (suspend) [323.887700] Starting subtest: suspend [335.902254] Subtest suspend: SUCCESS (12.014s) [336.017317] [103/144] (693s left) drm_mm (drm_mm) [336.079389] Starting subtest: drm_mm [336.224833] Starting dynamic subtest: drm_test_mm_init [336.253211] Dynamic subtest drm_test_mm_init: SUCCESS (0.028s) [336.273187] Starting dynamic subtest: drm_test_mm_debug [336.275933] Dynamic subtest drm_test_mm_debug: SUCCESS (0.001s) [336.301918] Starting dynamic subtest: drm_test_mm_align32 [336.305004] Dynamic subtest drm_test_mm_align32: SUCCESS (0.000s) [336.312973] Starting dynamic subtest: drm_test_mm_align64 [336.316052] Dynamic subtest drm_test_mm_align64: SUCCESS (0.000s) [336.324148] Starting dynamic subtest: drm_test_mm_lowest [336.327226] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.000s) [336.335464] Starting dynamic subtest: drm_test_mm_highest [336.338471] Dynamic subtest drm_test_mm_highest: SUCCESS (0.000s) [336.341335] Subtest drm_mm: SUCCESS (0.182s) [336.479183] [104/144] (693s left) perf_pmu (cpu-hotplug) [336.545791] Starting subtest: cpu-hotplug [336.555147] Subtest cpu-hotplug: SKIP (0.007s) [336.662580] [105/144] (693s left) kms_draw_crc (draw-method-mmap-cpu) [336.752903] Starting subtest: draw-method-mmap-cpu [336.755252] Starting dynamic subtest: xrgb8888-untiled [336.999456] Dynamic subtest xrgb8888-untiled: SUCCESS (0.246s) [337.013129] Starting dynamic subtest: rgb565-untiled [337.253063] Dynamic subtest rgb565-untiled: SUCCESS (0.255s) [337.274489] Starting dynamic subtest: xrgb2101010-untiled [337.488088] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.231s) [337.504922] Starting dynamic subtest: xrgb8888-xtiled [337.597941] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s) [337.615145] Starting dynamic subtest: rgb565-xtiled [337.774685] Dynamic subtest rgb565-xtiled: SUCCESS (0.176s) [337.795486] Starting dynamic subtest: xrgb2101010-xtiled [337.898329] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [337.916925] Starting dynamic subtest: xrgb8888-4tiled [338.074212] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.176s) [338.093271] Starting dynamic subtest: rgb565-4tiled [338.263823] Dynamic subtest rgb565-4tiled: SUCCESS (0.187s) [338.281759] Starting dynamic subtest: xrgb2101010-4tiled [338.385326] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [338.387599] Subtest draw-method-mmap-cpu: SUCCESS (1.635s) [338.481887] [106/144] (691s left) gem_exec_reloc (basic-gtt-cpu-active) [338.569352] Subtest basic-gtt-cpu-active: SKIP (0.000s) [338.637350] [107/144] (691s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [338.732887] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [343.984275] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.252s) [344.079573] [108/144] (686s left) kms_psr (fbc-psr-suspend) [344.161397] Starting subtest: fbc-psr-suspend [344.163989] Starting dynamic subtest: eDP-1 [344.168758] Dynamic subtest eDP-1: SKIP (0.000s) [344.173505] Subtest fbc-psr-suspend: SKIP (0.002s) [344.264288] [109/144] (685s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [344.332426] Starting subtest: yf-tiled-16bpp-rotate-180 [344.337225] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [344.412561] [110/144] (685s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [344.805315] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs [344.811898] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s) [345.727426] [111/144] (684s left) prime_self_import (basic-llseek-bad) [345.784678] Starting subtest: basic-llseek-bad [345.812314] Subtest basic-llseek-bad: SUCCESS (0.026s) [345.915299] [112/144] (684s left) kms_big_fb (linear-8bpp-rotate-180) [346.012992] Starting subtest: linear-8bpp-rotate-180 [347.435003] Subtest linear-8bpp-rotate-180: SUCCESS (1.425s) [347.536000] [113/144] (682s left) gem_mmap_offset (isolation) [347.595743] Starting subtest: isolation [347.616195] Subtest isolation: SUCCESS (0.015s) [347.708357] [114/144] (682s left) gem_exec_reloc (basic-write-gtt) [347.784031] Subtest basic-write-gtt: SKIP (0.000s) [347.851324] [115/144] (682s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [347.930596] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [353.112987] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.186s) [353.235231] [116/144] (677s left) dmabuf_sync_file (import-basic) [353.315802] Starting subtest: import-basic [353.318007] Subtest import-basic: SUCCESS (0.004s) [353.377266] [117/144] (677s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [353.783016] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [356.213726] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (2.431s) [357.441324] [118/144] (673s left) syncobj_wait (invalid-single-wait-unsubmitted) [357.522457] Starting subtest: invalid-single-wait-unsubmitted [357.525567] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [357.611379] [119/144] (672s left) gem_userptr_blits (vma-merge) [357.698013] Starting subtest: vma-merge [377.864804] Subtest vma-merge: FAIL (20.127s) [377.908844] [120/144] (652s left) syncobj_wait (invalid-multi-wait-unsubmitted) [377.990357] Starting subtest: invalid-multi-wait-unsubmitted [377.992902] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [378.087837] [121/144] (652s left) i915_suspend (sysfs-reader) [378.159914] Starting subtest: sysfs-reader [396.182076] Subtest sysfs-reader: SUCCESS (3.107s) [396.221959] [122/144] (649s left) kms_cursor_crc (cursor-random-64x21) [396.383051] Starting subtest: cursor-random-64x21 [396.414591] Subtest cursor-random-64x21: SKIP (0.027s) [396.683009] [123/144] (648s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-mc-ccs) [397.102041] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs [397.107376] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s) [397.958359] [124/144] (647s left) kms_setmode (clone-exclusive-crtc) [398.030072] Starting subtest: clone-exclusive-crtc [398.036917] Subtest clone-exclusive-crtc: SKIP (0.001s) [398.110356] [125/144] (647s left) prime_mmap (test_forked) [398.172611] Starting subtest: test_forked [398.174964] Starting dynamic subtest: test_forked-smem [398.213133] Dynamic subtest test_forked-smem: SUCCESS (0.042s) [398.216018] Subtest test_forked: SUCCESS (0.043s) [398.292751] [126/144] (647s left) kms_pipe_crc_basic (disable-crc-after-crtc) [398.377189] Starting subtest: disable-crc-after-crtc [398.380302] Starting dynamic subtest: pipe-A-eDP-1 [400.139080] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.762s) [400.165993] Starting dynamic subtest: pipe-B-eDP-1 [402.670253] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.524s) [402.686029] Starting dynamic subtest: pipe-C-eDP-1 [405.186563] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.517s) [405.213014] Starting dynamic subtest: pipe-D-eDP-1 [407.617526] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s) [407.620266] Subtest disable-crc-after-crtc: SUCCESS (9.241s) [408.516829] [127/144] (637s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [408.606064] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [408.725536] [128/144] (636s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [408.833526] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [411.611460] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.783s) [411.731175] [129/144] (634s left) kms_getfb (getfb-reject-ccs) [411.787538] Starting subtest: getfb-reject-ccs [411.790477] Subtest getfb-reject-ccs: SUCCESS (0.000s) [411.873504] [130/144] (633s left) kms_tiled_display (basic-test-pattern) [411.970234] Subtest basic-test-pattern: SKIP (0.000s) [412.004065] [131/144] (633s left) gen9_exec_parse (cmd-crossing-page) [412.074419] Subtest cmd-crossing-page: SKIP (0.000s) [412.117013] [132/144] (633s left) syncobj_timeline (wait-any-complex) [412.173085] Starting subtest: wait-any-complex [412.237402] Subtest wait-any-complex: SUCCESS (0.064s) [412.317155] [133/144] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [412.427878] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [412.431928] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [412.528585] [134/144] (633s left) kms_frontbuffer_tracking (psr-2p-rte) [412.610232] Starting subtest: psr-2p-rte [412.614618] Subtest psr-2p-rte: SKIP (0.000s) [412.708130] [135/144] (633s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [412.791242] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [412.793453] Starting dynamic subtest: pipe-A-default-mode [413.081327] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [413.086454] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.290s) [414.017981] [136/144] (631s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [414.098283] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [414.722046] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s) [414.880185] [137/144] (631s left) v3d/v3d_submit_csd (bad-multisync-extension) [414.969537] Subtest bad-multisync-extension: SKIP (0.000s) [415.031062] [138/144] (631s left) gem_exec_reloc (basic-cpu-gtt) [415.099997] Subtest basic-cpu-gtt: SKIP (0.000s) [415.164760] [139/144] (630s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs) [415.583957] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs [415.587024] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [416.452602] [140/144] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [416.565396] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [416.570311] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [416.658407] [141/144] (629s left) kms_chamelium_hpd (dp-hpd-after-suspend) [417.041173] Subtest dp-hpd-after-suspend: SKIP (0.000s) [417.896890] [142/144] (628s left) kms_chamelium_audio (dp-audio-edid) [418.294073] Subtest dp-audio-edid: SKIP (0.000s) [419.173514] [143/144] (627s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [419.227345] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [419.334021] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s) [419.411146] [144/144] (626s left) kms_color (ctm-blue-to-red) [419.510380] Starting subtest: ctm-blue-to-red [419.513058] Starting dynamic subtest: pipe-A [420.291182] Dynamic subtest pipe-A: SUCCESS (0.779s) [420.310552] Starting dynamic subtest: pipe-B [421.772373] Dynamic subtest pipe-B: SUCCESS (1.478s) [421.792598] Starting dynamic subtest: pipe-C [423.199636] Dynamic subtest pipe-C: SUCCESS (1.427s) [423.212542] Starting dynamic subtest: pipe-D [424.706565] Dynamic subtest pipe-D: SUCCESS (1.505s) [424.709256] Subtest ctm-blue-to-red: SUCCESS (5.194s) [425.602165] Closing watchdogs Done.