[49.809667] Initializing watchdogs [49.810277] /dev/watchdog0 [49.841476] [001/142] (960s left) gem_sync (basic-each) [50.327367] Starting subtest: basic-each [53.202328] Subtest basic-each: SUCCESS (2.875s) [53.493677] [002/142] (956s left) kms_ccs (pipe-d-crc-primary-basic-yf_tiled_ccs) [55.023488] Starting subtest: pipe-D-crc-primary-basic-yf_tiled_ccs [55.030752] Subtest pipe-D-crc-primary-basic-yf_tiled_ccs: SKIP (0.001s) [55.565848] [003/142] (954s left) syncobj_timeline (invalid-signal-one-illegal-handle) [55.947356] Starting subtest: invalid-signal-one-illegal-handle [55.951266] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.002s) [56.077711] [004/142] (954s left) gem_partial_pwrite_pread (write-uncached) [56.466359] Subtest write-uncached: SKIP (0.000s) [56.590915] [005/142] (954s left) gem_exec_gttfill (engines) [56.916990] Starting subtest: engines [56.920556] Starting dynamic subtest: rcs0 [87.350502] Dynamic subtest rcs0: SUCCESS (30.431s) [87.387299] Starting dynamic subtest: bcs0 [115.928883] Dynamic subtest bcs0: SUCCESS (28.575s) [115.956396] Starting dynamic subtest: vcs0 [145.515107] Dynamic subtest vcs0: SUCCESS (29.584s) [145.542528] Starting dynamic subtest: vcs1 [174.542398] Dynamic subtest vcs1: SUCCESS (29.026s) [174.575541] Starting dynamic subtest: vecs0 [203.502436] Dynamic subtest vecs0: SUCCESS (28.959s) [203.529583] Starting dynamic subtest: ccs0 [231.761434] Dynamic subtest ccs0: SUCCESS (28.257s) [231.764403] Subtest engines: SUCCESS (174.844s) [231.993813] [006/142] (778s left) vc4/vc4_wait_bo (used-bo-1ns) [232.592675] Subtest used-bo-1ns: SKIP (0.000s) [232.704995] [007/142] (778s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [233.807110] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [233.813588] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [234.600180] [008/142] (776s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [235.113051] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [235.120372] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [235.275580] [009/142] (775s left) gem_spin_batch (engines) [235.556927] Starting subtest: engines [235.559951] Starting dynamic subtest: rcs0 [238.806946] Dynamic subtest rcs0: SUCCESS (3.245s) [238.840788] Starting dynamic subtest: bcs0 [242.043543] Dynamic subtest bcs0: SUCCESS (3.233s) [242.075551] Starting dynamic subtest: vcs0 [245.275183] Dynamic subtest vcs0: SUCCESS (3.232s) [245.306708] Starting dynamic subtest: vcs1 [248.508397] Dynamic subtest vcs1: SUCCESS (3.232s) [248.542993] Starting dynamic subtest: vecs0 [251.740044] Dynamic subtest vecs0: SUCCESS (3.231s) [251.758723] Starting dynamic subtest: ccs0 [254.974184] Dynamic subtest ccs0: SUCCESS (3.235s) [254.977217] Subtest engines: SUCCESS (19.414s) [255.268101] [010/142] (755s left) vc4/vc4_perfmon (get-values-invalid-perfmon) [255.720161] Subtest get-values-invalid-perfmon: SKIP (0.000s) [255.850816] [011/142] (755s left) gem_mmap_offset (pf-nonblock) [256.215725] Starting subtest: pf-nonblock [256.247506] Subtest pf-nonblock: SUCCESS (0.031s) [256.453725] [012/142] (754s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [256.955211] Starting subtest: fbcpsr-rgb101010-draw-render [263.550745] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.600s) [263.701039] [013/142] (747s left) perf_pmu (semaphore-wait-idle) [264.089693] Starting subtest: semaphore-wait-idle [264.093234] Starting dynamic subtest: rcs0 [264.620778] Dynamic subtest rcs0: SUCCESS (0.529s) [264.654883] Starting dynamic subtest: bcs0 [265.136341] Dynamic subtest bcs0: SUCCESS (0.515s) [265.169899] Starting dynamic subtest: vcs0 [265.651798] Dynamic subtest vcs0: SUCCESS (0.514s) [265.684683] Starting dynamic subtest: vcs1 [266.167739] Dynamic subtest vcs1: SUCCESS (0.516s) [266.201300] Starting dynamic subtest: vecs0 [266.682435] Dynamic subtest vecs0: SUCCESS (0.515s) [266.717731] Starting dynamic subtest: ccs0 [267.201859] Dynamic subtest ccs0: SUCCESS (0.517s) [267.205644] Subtest semaphore-wait-idle: SUCCESS (3.112s) [268.623815] [014/142] (742s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs) [269.672131] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs [269.678081] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s) [270.956609] [015/142] (740s left) gem_ctx_engines (independent) [271.363318] Starting subtest: independent [271.366294] Starting dynamic subtest: rcs0 [271.801184] Dynamic subtest rcs0: SUCCESS (0.436s) [271.832347] Starting dynamic subtest: bcs0 [272.111598] Dynamic subtest bcs0: SUCCESS (0.310s) [272.132914] Starting dynamic subtest: vcs0 [272.418875] Dynamic subtest vcs0: SUCCESS (0.306s) [272.459177] Starting dynamic subtest: vcs1 [272.936265] Dynamic subtest vcs1: SUCCESS (0.516s) [272.977152] Starting dynamic subtest: vecs0 [273.387445] Dynamic subtest vecs0: SUCCESS (0.451s) [273.427758] Starting dynamic subtest: ccs0 [273.978199] Dynamic subtest ccs0: SUCCESS (0.590s) [274.014927] Starting dynamic subtest: all-engines [274.619983] Dynamic subtest all-engines: SUCCESS (0.640s) [274.623313] Subtest independent: SUCCESS (3.255s) [275.644285] [016/142] (735s left) kms_flip (flip-vs-blocking-wf-vblank) [276.054908] Starting subtest: flip-vs-blocking-wf-vblank [276.081378] Starting dynamic subtest: A-eDP1 [285.841492] Dynamic subtest A-eDP1: SUCCESS (9.760s) [285.874785] Starting dynamic subtest: B-eDP1 [295.147126] Dynamic subtest B-eDP1: SUCCESS (9.303s) [295.175767] Starting dynamic subtest: C-eDP1 [304.462322] Dynamic subtest C-eDP1: SUCCESS (9.314s) [304.491803] Starting dynamic subtest: D-eDP1 [313.790951] Dynamic subtest D-eDP1: SUCCESS (9.326s) [313.814968] Subtest flip-vs-blocking-wf-vblank: SUCCESS (37.763s) [315.343329] [017/142] (696s left) i915_query (hwconfig_table) [315.712816] Starting subtest: hwconfig_table [316.120607] Subtest hwconfig_table: SUCCESS (0.007s) [316.169930] [018/142] (695s left) gen9_exec_parse (secure-batches) [316.556778] Subtest secure-batches: SKIP (0.000s) [316.659264] [019/142] (694s left) kms_psr (psr2_primary_mmap_cpu) [317.131559] Starting subtest: psr2_primary_mmap_cpu [320.128519] Subtest psr2_primary_mmap_cpu: SUCCESS (2.994s) [321.057216] [020/142] (690s left) kms_vblank (pipe-d-query-busy) [321.407842] Starting subtest: pipe-D-query-busy [324.451409] Subtest pipe-D-query-busy: SUCCESS (3.040s) [325.377742] [021/142] (686s left) gem_exec_reloc (basic-cpu-noreloc) [325.780665] Subtest basic-cpu-noreloc: SKIP (0.000s) [325.907111] [022/142] (685s left) perf (gen12-oa-tlb-invalidate) [326.773048] Starting subtest: gen12-oa-tlb-invalidate [326.776362] Starting dynamic subtest: 0-rcs0 [336.881484] Dynamic subtest 0-rcs0: SUCCESS (10.106s) [336.917775] Starting dynamic subtest: 1-vecs0 [346.927523] Dynamic subtest 1-vecs0: SUCCESS (10.047s) [346.930795] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.155s) [347.029749] [023/142] (664s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc) [348.442786] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc [348.446533] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s) [349.294333] [024/142] (662s left) gem_exec_basic (basic) [349.694673] Starting subtest: basic [349.697838] Starting dynamic subtest: rcs0-smem [349.700975] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [349.734332] Starting dynamic subtest: bcs0-smem [349.737675] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [349.773372] Starting dynamic subtest: vcs0-smem [349.776719] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [349.811821] Starting dynamic subtest: vcs1-smem [349.815243] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [349.845150] Starting dynamic subtest: vecs0-smem [349.848102] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [349.885081] Starting dynamic subtest: ccs0-smem [349.888360] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [349.891306] Subtest basic: SUCCESS (0.021s) [351.640640] [025/142] (660s left) syncobj_timeline (single-wait-available-signaled) [352.023649] Starting subtest: single-wait-available-signaled [352.027839] Subtest single-wait-available-signaled: SUCCESS (0.001s) [352.158306] [026/142] (659s left) kms_color (gamma) [352.646637] Starting subtest: gamma [352.649928] Starting dynamic subtest: pipe-A [354.154963] Dynamic subtest pipe-A: SUCCESS (1.507s) [354.188913] Starting dynamic subtest: pipe-B [356.370303] Dynamic subtest pipe-B: SUCCESS (2.215s) [356.404354] Starting dynamic subtest: pipe-C [358.944739] Dynamic subtest pipe-C: SUCCESS (2.575s) [358.979228] Starting dynamic subtest: pipe-D [361.768113] Dynamic subtest pipe-D: SUCCESS (2.819s) [361.771231] Subtest gamma: SUCCESS (9.123s) [362.716255] [027/142] (649s left) gem_exec_await (wide-contexts) [364.549553] Starting subtest: wide-contexts [389.492645] Subtest wide-contexts: SUCCESS (24.947s) [389.805360] [028/142] (622s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [390.514342] Starting subtest: yf-tiled-addfb-size-offset-overflow [390.521113] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [390.678718] [029/142] (621s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [391.232792] Starting subtest: short-flip-after-cursor-toggle [392.767341] Subtest short-flip-after-cursor-toggle: SUCCESS (1.532s) [393.695397] [030/142] (618s left) gem_exec_schedule (semaphore-resolve) [394.146846] Starting subtest: semaphore-resolve [394.281800] Subtest semaphore-resolve: SUCCESS (0.133s) [395.611481] [031/142] (616s left) gem_eio (banned) [397.227956] Starting subtest: banned [400.210783] Subtest banned: SUCCESS (2.984s) [401.635177] [032/142] (610s left) kms_big_fb (x-tiled-8bpp-rotate-90) [402.180497] Starting subtest: x-tiled-8bpp-rotate-90 [402.246732] Subtest x-tiled-8bpp-rotate-90: SKIP (0.060s) [402.426501] [033/142] (610s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [402.940112] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [402.946730] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [403.112568] [034/142] (609s left) kms_atomic_transition (modeset-transition-nonblocking) [403.596387] Starting subtest: modeset-transition-nonblocking [403.599784] Starting dynamic subtest: 1x-outputs [433.699034] Dynamic subtest 1x-outputs: SUCCESS (30.100s) [434.005412] Subtest modeset-transition-nonblocking: SUCCESS (30.409s) [434.987048] [035/142] (577s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [435.395219] Subtest writes-after-reads-snoop: SKIP (0.000s) [435.530821] [036/142] (577s left) dumb_buffer (create-clear) [435.906552] Starting subtest: create-clear [478.482145] Subtest create-clear: SUCCESS (42.571s) [478.706494] [037/142] (534s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [479.195655] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [479.200374] Starting dynamic subtest: pipe-A-default-mode [479.603994] Dynamic subtest pipe-A-default-mode: SKIP (0.396s) [479.611363] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.409s) [480.553342] [038/142] (532s left) gem_eio (context-create) [482.147122] Starting subtest: context-create [484.564927] Subtest context-create: SUCCESS (2.417s) [486.625593] [039/142] (526s left) kms_async_flips (async-flip-with-page-flip-events) [487.091968] Starting subtest: async-flip-with-page-flip-events [489.265395] Starting dynamic subtest: pipe-A-eDP-1-4-MC_CCS [490.416987] Dynamic subtest pipe-A-eDP-1-4-MC_CCS: SKIP (1.147s) [490.461069] Starting dynamic subtest: pipe-A-eDP-1-4-RC_CCS [491.207579] Dynamic subtest pipe-A-eDP-1-4-RC_CCS: SKIP (0.786s) [491.248096] Starting dynamic subtest: pipe-A-eDP-1-4-RC_CCS-CC [492.033400] Dynamic subtest pipe-A-eDP-1-4-RC_CCS-CC: SKIP (0.817s) [492.073844] Starting dynamic subtest: pipe-A-eDP-1-4 [494.725997] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.695s) [494.768992] Starting dynamic subtest: pipe-A-eDP-1-X [497.391085] Dynamic subtest pipe-A-eDP-1-X: SUCCESS (2.660s) [497.433593] Starting dynamic subtest: pipe-A-eDP-1-linear [499.913536] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.518s) [501.041990] Starting dynamic subtest: pipe-B-eDP-1-4-MC_CCS [501.835207] Dynamic subtest pipe-B-eDP-1-4-MC_CCS: SKIP (0.823s) [501.876567] Starting dynamic subtest: pipe-B-eDP-1-4-RC_CCS [502.393915] Dynamic subtest pipe-B-eDP-1-4-RC_CCS: SKIP (0.556s) [502.433886] Starting dynamic subtest: pipe-B-eDP-1-4-RC_CCS-CC [502.937677] Dynamic subtest pipe-B-eDP-1-4-RC_CCS-CC: SKIP (0.544s) [502.979780] Starting dynamic subtest: pipe-B-eDP-1-4 [505.524790] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.588s) [505.550134] Starting dynamic subtest: pipe-B-eDP-1-X [508.046541] Dynamic subtest pipe-B-eDP-1-X: SUCCESS (2.516s) [508.090398] Starting dynamic subtest: pipe-B-eDP-1-linear [510.801236] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.751s) [512.583470] Starting dynamic subtest: pipe-C-eDP-1-4-MC_CCS [513.697144] Dynamic subtest pipe-C-eDP-1-4-MC_CCS: SKIP (1.150s) [513.743284] Starting dynamic subtest: pipe-C-eDP-1-4-RC_CCS [514.480386] Dynamic subtest pipe-C-eDP-1-4-RC_CCS: SKIP (0.775s) [514.519665] Starting dynamic subtest: pipe-C-eDP-1-4-RC_CCS-CC [515.223844] Dynamic subtest pipe-C-eDP-1-4-RC_CCS-CC: SKIP (0.746s) [515.269424] Starting dynamic subtest: pipe-C-eDP-1-4 [517.936757] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.712s) [517.978558] Starting dynamic subtest: pipe-C-eDP-1-X [520.669462] Dynamic subtest pipe-C-eDP-1-X: SUCCESS (2.728s) [520.708849] Starting dynamic subtest: pipe-C-eDP-1-linear [523.382504] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.707s) [524.816189] Starting dynamic subtest: pipe-D-eDP-1-4-MC_CCS [525.959143] Dynamic subtest pipe-D-eDP-1-4-MC_CCS: SKIP (1.184s) [526.001966] Starting dynamic subtest: pipe-D-eDP-1-4-RC_CCS [526.742844] Dynamic subtest pipe-D-eDP-1-4-RC_CCS: SKIP (0.776s) [526.782387] Starting dynamic subtest: pipe-D-eDP-1-4-RC_CCS-CC [527.513634] Dynamic subtest pipe-D-eDP-1-4-RC_CCS-CC: SKIP (0.766s) [527.565317] Starting dynamic subtest: pipe-D-eDP-1-4 [530.076698] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.566s) [530.119108] Starting dynamic subtest: pipe-D-eDP-1-X [532.809393] Dynamic subtest pipe-D-eDP-1-X: SUCCESS (2.729s) [532.853180] Starting dynamic subtest: pipe-D-eDP-1-linear [535.464800] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.650s) [535.468502] Subtest async-flip-with-page-flip-events: SUCCESS (48.376s) [536.856099] [040/142] (476s left) gen7_exec_parse (load-register-reg) [537.249822] Subtest load-register-reg: SKIP (0.000s) [537.376044] [041/142] (476s left) kms_cursor_crc (cursor-sliding-64x21) [538.087566] Starting subtest: cursor-sliding-64x21 [538.119711] Starting dynamic subtest: pipe-A-eDP-1 [544.142132] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.020s) [544.236553] Starting dynamic subtest: pipe-D-eDP-1 [550.310205] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.116s) [550.314152] Subtest cursor-sliding-64x21: SUCCESS (12.221s) [551.504482] [042/142] (461s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs) [552.603466] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs [552.615264] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.013s) [553.939477] [043/142] (459s left) api_intel_bb (render) [554.323301] Starting subtest: render [554.326321] Starting dynamic subtest: render-none-512 [554.675563] Dynamic subtest render-none-512: SUCCESS (0.353s) [554.721322] Starting dynamic subtest: render-none-1024 [555.924657] Dynamic subtest render-none-1024: SUCCESS (1.245s) [555.969170] Starting dynamic subtest: render-x-512 [556.241864] Dynamic subtest render-x-512: SUCCESS (0.313s) [556.284450] Starting dynamic subtest: render-x-1024 [557.468383] Dynamic subtest render-x-1024: SUCCESS (1.222s) [557.510797] Starting dynamic subtest: render-y-512 [557.776061] Dynamic subtest render-y-512: SUCCESS (0.304s) [557.817894] Starting dynamic subtest: render-y-1024 [558.904621] Dynamic subtest render-y-1024: SUCCESS (1.124s) [558.908670] Subtest render: SUCCESS (4.587s) [559.097512] [044/142] (454s left) gem_lmem_swapping (heavy-verify-multi-ccs) [559.495083] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [559.627549] [045/142] (454s left) kms_flip (2x-dpms-vs-vblank-race) [560.022553] Starting subtest: 2x-dpms-vs-vblank-race [560.185730] Subtest 2x-dpms-vs-vblank-race: SKIP (0.162s) [560.388417] [046/142] (453s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs) [561.679228] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs [561.685975] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SKIP (0.000s) [562.760140] [047/142] (451s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [565.668833] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s) [565.829081] [048/142] (448s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs) [566.790917] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs [566.798077] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s) [568.242335] [049/142] (445s left) kms_vblank (pipe-c-query-forked-hang) [568.727247] Starting subtest: pipe-C-query-forked-hang [584.788668] Subtest pipe-C-query-forked-hang: SUCCESS (16.056s) [585.727773] [050/142] (428s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc) [586.217275] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc [586.223875] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [588.114901] [051/142] (426s left) kms_addfb_basic (bo-too-small-due-to-tiling) [588.604311] Starting subtest: bo-too-small-due-to-tiling [588.611330] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [588.773768] [052/142] (425s left) kms_draw_crc (draw-method-pwrite) [589.264823] Starting subtest: draw-method-pwrite [589.268503] Starting dynamic subtest: xrgb8888-untiled [592.370960] Dynamic subtest xrgb8888-untiled: SUCCESS (3.104s) [592.420395] Starting dynamic subtest: rgb565-untiled [595.683329] Dynamic subtest rgb565-untiled: SUCCESS (3.306s) [595.727214] Starting dynamic subtest: xrgb2101010-untiled [599.905717] Dynamic subtest xrgb2101010-untiled: SUCCESS (4.219s) [599.956515] Starting dynamic subtest: xrgb8888-xtiled [611.227384] Dynamic subtest xrgb8888-xtiled: SUCCESS (11.318s) [611.254757] Starting dynamic subtest: rgb565-xtiled [619.895451] Dynamic subtest rgb565-xtiled: SUCCESS (8.662s) [619.942344] Starting dynamic subtest: xrgb2101010-xtiled [626.095182] Dynamic subtest xrgb2101010-xtiled: SUCCESS (6.196s) [626.140466] Starting dynamic subtest: xrgb8888-4tiled [630.539690] Dynamic subtest xrgb8888-4tiled: SUCCESS (4.441s) [630.586654] Starting dynamic subtest: rgb565-4tiled [634.361147] Dynamic subtest rgb565-4tiled: SUCCESS (3.818s) [634.431501] Starting dynamic subtest: xrgb2101010-4tiled [637.309540] Dynamic subtest xrgb2101010-4tiled: SUCCESS (2.939s) [637.312718] Subtest draw-method-pwrite: SUCCESS (48.043s) [637.490972] [053/142] (376s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [637.983758] Starting subtest: yf-tiled-32bpp-rotate-0 [637.990406] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [638.176604] [054/142] (376s left) kms_chamelium_frames (hdmi-crc-single) [639.025286] Subtest hdmi-crc-single: SKIP (0.000s) [639.893884] [055/142] (374s left) vgem_basic (sysfs) [640.269316] Starting subtest: sysfs [640.272784] Subtest sysfs: SUCCESS (0.002s) [640.393104] [056/142] (374s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [640.896957] Starting subtest: basic-flip-before-cursor-atomic [642.175293] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.274s) [643.112438] [057/142] (371s left) i915_hangman (gt-engine-error) [643.542954] Starting subtest: gt-engine-error [643.546818] Starting dynamic subtest: rcs0 [645.463807] Dynamic subtest rcs0: SUCCESS (1.920s) [645.504538] Starting dynamic subtest: bcs0 [647.510449] Dynamic subtest bcs0: SUCCESS (2.042s) [647.554239] Starting dynamic subtest: vcs0 [658.189229] Dynamic subtest vcs0: FAIL (10.577s) [658.232579] Starting dynamic subtest: vcs1 [659.480433] Dynamic subtest vcs1: SUCCESS (1.384s) [659.524839] Starting dynamic subtest: vecs0 [661.462192] Dynamic subtest vecs0: SUCCESS (1.977s) [661.508698] Starting dynamic subtest: ccs0 [664.473478] Dynamic subtest ccs0: SUCCESS (3.006s) [664.477423] Subtest gt-engine-error: FAIL (20.934s) [664.711802] [058/142] (350s left) gem_softpin (allocator-fork) [665.107387] Starting subtest: allocator-fork [667.677663] Subtest allocator-fork: SUCCESS (2.568s) [667.910398] [059/142] (347s left) gem_basic (create-fd-close) [668.301333] Starting subtest: create-fd-close [668.307837] Subtest create-fd-close: SUCCESS (0.001s) [668.494847] [060/142] (346s left) gem_ccs (block-multicopy-compressed) [668.902326] Starting subtest: block-multicopy-compressed [668.909379] Subtest block-multicopy-compressed: SKIP (0.000s) [669.081782] [061/142] (346s left) gem_media_fill (media-fill) [669.476352] Subtest media-fill: SKIP (0.000s) [669.654640] [062/142] (345s left) v3d/v3d_submit_csd (bad-perfmon) [670.163328] Subtest bad-perfmon: SKIP (0.000s) [670.304093] [063/142] (344s left) syncobj_basic (bad-flags-handle-to-fd) [670.682277] Starting subtest: bad-flags-handle-to-fd [670.685880] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [670.861325] [064/142] (344s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [671.387539] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [682.603061] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (11.214s) [682.798232] [065/142] (332s left) i915_pm_rpm (gem-pread) [688.874838] Starting subtest: gem-pread [691.353762] Subtest gem-pread: SUCCESS (2.476s) [691.540793] [066/142] (324s left) kms_plane_scaling (planes-downscale-factor-0-5) [692.007861] Starting subtest: planes-downscale-factor-0-5 [692.012146] Starting dynamic subtest: pipe-A-eDP-1 [692.058430] Dynamic subtest pipe-A-eDP-1: SKIP (0.043s) [692.104941] Starting dynamic subtest: pipe-B-eDP-1 [692.220992] Dynamic subtest pipe-B-eDP-1: SKIP (0.146s) [692.267875] Starting dynamic subtest: pipe-C-eDP-1 [692.388386] Dynamic subtest pipe-C-eDP-1: SKIP (0.158s) [692.440617] Starting dynamic subtest: pipe-D-eDP-1 [692.544273] Dynamic subtest pipe-D-eDP-1: SKIP (0.147s) [692.550939] Subtest planes-downscale-factor-0-5: SKIP (0.539s) [692.718700] [067/142] (322s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [693.212520] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [706.571566] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (13.360s) [706.833860] [068/142] (308s left) gem_eio (in-flight-internal-immediate) [708.358725] Starting subtest: in-flight-internal-immediate [711.086092] Subtest in-flight-internal-immediate: SUCCESS (2.725s) [712.612945] [069/142] (303s left) gem_workarounds (reset-context) [713.054310] Starting subtest: reset-context [714.145658] Subtest reset-context: SUCCESS (1.090s) [714.339632] [070/142] (301s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [714.841250] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [726.222065] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (11.376s) [726.480784] [071/142] (289s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [726.995228] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [739.614869] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (12.619s) [739.853109] [072/142] (276s left) api_intel_bb (bb-with-allocator) [740.214718] Starting subtest: bb-with-allocator [740.227556] Subtest bb-with-allocator: SUCCESS (0.013s) [740.421636] [073/142] (275s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [740.922536] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [740.929123] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [741.098221] [074/142] (275s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_ccs) [742.867397] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_ccs [742.883338] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.013s) [743.464654] [075/142] (272s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc) [744.652600] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc [745.727784] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.074s) [747.321718] [076/142] (269s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [747.841563] Starting subtest: fbc-rgb565-draw-render [756.941078] Subtest fbc-rgb565-draw-render: SUCCESS (9.098s) [757.237366] [077/142] (259s left) kms_vblank (pipe-c-query-forked) [757.722798] Starting subtest: pipe-C-query-forked [761.696901] Subtest pipe-C-query-forked: SUCCESS (3.972s) [762.647965] [078/142] (253s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [763.121600] Starting subtest: primary-x-tiled-reflect-x-180 [778.227870] Subtest primary-x-tiled-reflect-x-180: SUCCESS (15.109s) [779.863933] [079/142] (236s left) kms_plane_lowres (tiling-none) [780.363171] Starting subtest: tiling-none [780.371573] Starting dynamic subtest: pipe-A-eDP-1 [780.378107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [780.824127] Starting dynamic subtest: pipe-B-eDP-1 [780.831302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [780.880198] Starting dynamic subtest: pipe-C-eDP-1 [780.887370] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [780.937849] Starting dynamic subtest: pipe-D-eDP-1 [780.945323] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [780.952646] Subtest tiling-none: SKIP (0.503s) [781.718230] [080/142] (235s left) kms_mmap_write_crc (main) [782.215106] Starting subtest: main [782.223842] Starting dynamic subtest: pipe-A-eDP-1 [791.922127] Dynamic subtest pipe-A-eDP-1: SUCCESS (9.695s) [791.925864] Subtest main: SUCCESS (9.704s) [792.846140] [081/142] (224s left) gem_mmap_wc (write) [793.228751] Subtest write: SKIP (0.000s) [793.354406] [082/142] (223s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [793.758049] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [793.763831] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [794.030668] [083/142] (223s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [794.916854] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [795.774457] [084/142] (221s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [796.261180] Starting subtest: sprite-rotation-90-pos-100-0 [796.273720] Subtest sprite-rotation-90-pos-100-0: SKIP (0.007s) [796.419377] [085/142] (220s left) kms_plane_scaling (invalid-parameters) [796.889706] Starting subtest: invalid-parameters [796.892764] Starting dynamic subtest: less-than-1-height-src [796.973728] Dynamic subtest less-than-1-height-src: SUCCESS (0.083s) [797.023551] Starting dynamic subtest: less-than-1-width-src [797.063345] Dynamic subtest less-than-1-width-src: SUCCESS (0.082s) [797.066813] Subtest invalid-parameters: SUCCESS (0.173s) [797.242408] [086/142] (220s left) gem_ctx_bad_destroy (invalid-pad) [797.618500] Starting subtest: invalid-pad [797.622659] Subtest invalid-pad: SUCCESS (0.000s) [797.763454] [087/142] (219s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs) [799.340990] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs [799.344736] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.001s) [800.134869] [088/142] (217s left) kms_vblank (pipe-a-wait-forked-busy) [800.607624] Starting subtest: pipe-A-wait-forked-busy [803.156460] Subtest pipe-A-wait-forked-busy: SUCCESS (2.553s) [804.090220] [089/142] (213s left) v3d/v3d_submit_csd (multiple-job-submission) [804.551380] Subtest multiple-job-submission: SKIP (0.000s) [804.683329] [090/142] (212s left) gem_exec_balancer (bonded-false-hang) [805.918491] Starting subtest: bonded-false-hang [805.924539] Subtest bonded-false-hang: SKIP (0.000s) [806.088600] [091/142] (211s left) syncobj_timeline (multi-wait-available-submitted) [806.466490] Starting subtest: multi-wait-available-submitted [806.470154] Subtest multi-wait-available-submitted: SUCCESS (0.003s) [806.623967] [092/142] (211s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [807.115965] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [807.126353] Starting dynamic subtest: pipe-A-default-mode [808.596143] Dynamic subtest pipe-A-default-mode: SKIP (1.462s) [808.603088] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.476s) [808.853493] [093/142] (209s left) kms_getfb (getfb-reject-ccs) [809.230728] Starting subtest: getfb-reject-ccs [809.234369] Subtest getfb-reject-ccs: SUCCESS (0.002s) [809.399792] [094/142] (208s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [809.912999] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [809.920177] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [810.085752] [095/142] (208s left) gem_sync (basic-store-each) [810.508999] Starting subtest: basic-store-each [813.457251] Subtest basic-store-each: SUCCESS (2.942s) [813.762743] [096/142] (204s left) drm_fdinfo (virtual-busy-hang) [814.160366] Starting subtest: virtual-busy-hang [814.166645] Subtest virtual-busy-hang: SKIP (0.001s) [814.341234] [097/142] (203s left) kms_vblank (pipe-d-wait-idle) [814.825668] Starting subtest: pipe-D-wait-idle [818.728308] Subtest pipe-D-wait-idle: SUCCESS (3.899s) [819.682536] [098/142] (198s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [820.155552] Starting subtest: primary-yf-tiled-reflect-x-270 [820.167836] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.007s) [820.315551] [099/142] (198s left) syncobj_wait (single-wait-for-submit-submitted) [820.690794] Starting subtest: single-wait-for-submit-submitted [820.797164] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s) [820.953260] [100/142] (197s left) gem_exec_whisper (basic-fds-priority-all) [821.370726] Starting subtest: basic-fds-priority-all [872.293597] Subtest basic-fds-priority-all: SUCCESS (50.917s) [872.585899] [101/142] (146s left) kms_cursor_crc (cursor-sliding-256x256) [888.813890] Starting subtest: cursor-sliding-256x256 [888.838119] Starting dynamic subtest: pipe-A-eDP-1 [894.726643] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.885s) [894.831494] Starting dynamic subtest: pipe-D-eDP-1 [901.136064] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.356s) [901.139158] Subtest cursor-sliding-256x256: SUCCESS (12.324s) [902.102774] [102/142] (116s left) gem_ctx_persistence (legacy-engines-persistence) [902.504941] Starting subtest: legacy-engines-persistence [902.509194] Starting dynamic subtest: render [903.286860] Dynamic subtest render: SUCCESS (0.779s) [903.342751] Starting dynamic subtest: bsd1 [904.046237] Dynamic subtest bsd1: SUCCESS (0.756s) [904.099912] Starting dynamic subtest: bsd2 [904.801823] Dynamic subtest bsd2: SUCCESS (0.751s) [904.863915] Starting dynamic subtest: blt [905.567457] Dynamic subtest blt: SUCCESS (0.761s) [905.624056] Starting dynamic subtest: vebox [906.353383] Dynamic subtest vebox: SUCCESS (0.782s) [906.356970] Subtest legacy-engines-persistence: SUCCESS (3.851s) [906.533658] [103/142] (112s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_ccs) [907.699203] Starting subtest: pipe-B-random-ccs-data-y_tiled_ccs [907.708051] Subtest pipe-B-random-ccs-data-y_tiled_ccs: SKIP (0.000s) [908.727157] [104/142] (110s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [909.231234] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [909.237858] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [909.399715] [105/142] (109s left) i915_pm_freq_api (freq-basic-api) [909.811405] Starting subtest: freq-basic-api [909.815508] Starting dynamic subtest: gt0 [909.830082] Dynamic subtest gt0: SUCCESS (0.016s) [909.889803] Starting dynamic subtest: gt1 [909.893265] Dynamic subtest gt1: SUCCESS (0.008s) [909.896608] Subtest freq-basic-api: SUCCESS (0.035s) [910.007149] [106/142] (109s left) tools_test (tools_test) [910.350732] Starting subtest: tools_test [911.133511] Subtest tools_test: SUCCESS (0.802s) [911.273923] [107/142] (107s left) kms_vblank (pipe-c-ts-continuation-idle) [911.753336] Starting subtest: pipe-C-ts-continuation-idle [913.879505] Subtest pipe-C-ts-continuation-idle: SUCCESS (2.122s) [914.832084] [108/142] (104s left) v3d/v3d_job_submission (threaded-job-submission) [915.307690] Subtest threaded-job-submission: SKIP (0.000s) [915.449182] [109/142] (103s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [915.947831] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [915.954340] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [916.118219] [110/142] (103s left) kms_force_connector_basic (prune-stale-modes) [916.513162] Starting subtest: prune-stale-modes [916.770290] Subtest prune-stale-modes: SKIP (0.261s) [916.900908] [111/142] (102s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [917.023983] Starting subtest: etime-multi-wait-all-submitted-signaled [917.131147] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s) [917.199353] [112/142] (102s left) gem_exec_params (rsvd2-dirt) [917.327872] Starting subtest: rsvd2-dirt [917.332634] Subtest rsvd2-dirt: SKIP (0.000s) [917.416779] [113/142] (102s left) gem_exec_fence (keep-in-fence) [917.653703] Starting subtest: keep-in-fence [917.656048] Starting dynamic subtest: rcs0 [917.703134] Dynamic subtest rcs0: SUCCESS (0.050s) [917.723116] Starting dynamic subtest: bcs0 [917.751655] Dynamic subtest bcs0: SUCCESS (0.049s) [917.770262] Starting dynamic subtest: vcs0 [919.517676] Dynamic subtest vcs0: SUCCESS (1.764s) [919.536255] Starting dynamic subtest: vcs1 [921.510130] Dynamic subtest vcs1: SUCCESS (1.992s) [921.518687] Starting dynamic subtest: vecs0 [923.482428] Dynamic subtest vecs0: SUCCESS (1.971s) [923.490745] Starting dynamic subtest: ccs0 [924.445768] Dynamic subtest ccs0: SUCCESS (0.964s) [924.448244] Subtest keep-in-fence: SUCCESS (6.794s) [926.588053] [114/142] ( 92s left) gem_exec_schedule (preempt-other) [926.667026] Starting subtest: preempt-other [926.669515] Starting dynamic subtest: rcs0 [926.774379] Dynamic subtest rcs0: SUCCESS (0.112s) [926.796311] Starting dynamic subtest: bcs0 [926.883809] Dynamic subtest bcs0: SUCCESS (0.110s) [926.903176] Starting dynamic subtest: vcs0 [926.994174] Dynamic subtest vcs0: SUCCESS (0.110s) [927.014441] Starting dynamic subtest: vcs1 [927.105062] Dynamic subtest vcs1: SUCCESS (0.110s) [927.126465] Starting dynamic subtest: vecs0 [927.213505] Dynamic subtest vecs0: SUCCESS (0.108s) [927.233208] Starting dynamic subtest: ccs0 [927.320165] Dynamic subtest ccs0: SUCCESS (0.106s) [927.322650] Subtest preempt-other: SUCCESS (0.660s) [928.574547] [115/142] ( 91s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [928.665040] Starting subtest: psr-rgb101010-draw-mmap-cpu [934.240373] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (5.576s) [934.490226] [116/142] ( 85s left) gem_madvise (dontneed-before-mmap) [934.845405] Starting subtest: dontneed-before-mmap [934.875279] Subtest dontneed-before-mmap: SUCCESS (0.028s) [935.055461] [117/142] ( 84s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [935.551143] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [953.661830] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (18.114s) [953.841800] [118/142] ( 66s left) gem_mmap_wc (write-cpu-read-wc) [953.994473] Subtest write-cpu-read-wc: SKIP (0.000s) [954.089516] [119/142] ( 65s left) drm_read (short-buffer-nonblock) [954.894051] Starting subtest: short-buffer-nonblock [954.897784] Subtest short-buffer-nonblock: SUCCESS (0.000s) [955.091879] [120/142] ( 64s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs) [956.653250] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs [956.659785] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s) [957.389251] [121/142] ( 62s left) kms_getfb (getfb2-handle-closed) [957.762950] Starting subtest: getfb2-handle-closed [957.767285] Subtest getfb2-handle-closed: SUCCESS (0.000s) [957.944628] [122/142] ( 62s left) kms_big_fb (linear-16bpp-rotate-90) [958.486965] Starting subtest: linear-16bpp-rotate-90 [958.544751] Subtest linear-16bpp-rotate-90: SKIP (0.054s) [958.743630] [123/142] ( 61s left) kms_cdclk (mode-transition-all-outputs) [959.244573] Starting subtest: mode-transition-all-outputs [959.632433] Subtest mode-transition-all-outputs: SKIP (0.386s) [960.584373] [124/142] ( 59s left) kms_flip (flip-vs-panning-interruptible) [961.000230] Starting subtest: flip-vs-panning-interruptible [961.031446] Starting dynamic subtest: A-eDP1 [970.506133] Dynamic subtest A-eDP1: SUCCESS (9.475s) [970.560398] Starting dynamic subtest: B-eDP1 [979.880898] Dynamic subtest B-eDP1: SUCCESS (9.370s) [979.931724] Starting dynamic subtest: C-eDP1 [989.178304] Dynamic subtest C-eDP1: SUCCESS (9.290s) [989.220370] Starting dynamic subtest: D-eDP1 [998.456392] Dynamic subtest D-eDP1: SUCCESS (9.271s) [998.475079] Subtest flip-vs-panning-interruptible: SUCCESS (37.475s) [999.948214] [125/142] ( 20s left) gem_exec_create (forked) [1000.223484] Starting subtest: forked [1000.226698] Starting dynamic subtest: smem [1021.529090] Dynamic subtest smem: SUCCESS (21.302s) [1021.533061] Subtest forked: SUCCESS (21.305s) [1021.818633] Overall timeout time exceeded, stopping. [1021.819881] Closing watchdogs Done.