[62.740240] Initializing watchdogs [62.740287] /dev/watchdog0 [62.755992] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [62.760162] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.762697] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.765968] [001/133] (960s left) kms_cursor_crc (cursor-rapid-movement-64x64) [62.940206] Starting subtest: cursor-rapid-movement-64x64 [62.954556] Starting dynamic subtest: pipe-A-eDP-1 [64.336387] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.383s) [64.369793] Starting dynamic subtest: pipe-D-eDP-1 [65.096072] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.734s) [65.098418] Subtest cursor-rapid-movement-64x64: SUCCESS (2.159s) [65.958901] [002/133] (957s left) kms_psr (fbc-psr2-cursor-plane-onoff) [66.033765] Starting subtest: fbc-psr2-cursor-plane-onoff [66.036120] Starting dynamic subtest: eDP-1 [66.040644] Dynamic subtest eDP-1: SKIP (0.000s) [66.044613] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s) [66.102630] [003/133] (957s left) kms_draw_crc (draw-method-mmap-wc) [66.178398] Starting subtest: draw-method-mmap-wc [66.180684] Starting dynamic subtest: xrgb8888-untiled [66.422401] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s) [66.431252] Starting dynamic subtest: rgb565-untiled [66.654330] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [66.664068] Starting dynamic subtest: xrgb2101010-untiled [66.875756] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [66.884470] Starting dynamic subtest: xbgr16161616f-untiled [67.097548] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [67.106783] Starting dynamic subtest: xrgb8888-xtiled [67.230502] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [67.238796] Starting dynamic subtest: rgb565-xtiled [67.363784] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [67.372728] Starting dynamic subtest: xrgb2101010-xtiled [67.485809] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [67.494808] Starting dynamic subtest: xbgr16161616f-xtiled [67.618927] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [67.627853] Starting dynamic subtest: xrgb8888-4tiled [67.763301] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [67.773184] Starting dynamic subtest: rgb565-4tiled [67.896485] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s) [67.905213] Starting dynamic subtest: xrgb2101010-4tiled [68.052061] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [68.061148] Starting dynamic subtest: xbgr16161616f-4tiled [68.218417] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s) [68.220476] Subtest draw-method-mmap-wc: SUCCESS (2.044s) [68.308112] [004/133] (955s left) gem_partial_pwrite_pread (write-snoop) [68.369825] Subtest write-snoop: SKIP (0.000s) [68.439807] [005/133] (954s left) kms_addfb_basic (no-handle) [68.492360] Starting subtest: no-handle [68.494467] Subtest no-handle: SUCCESS (0.000s) [68.614090] [006/133] (954s left) kms_psr (fbc-psr-primary-blt) [68.686187] Starting subtest: fbc-psr-primary-blt [68.688148] Starting dynamic subtest: eDP-1 [68.691754] Dynamic subtest eDP-1: SKIP (0.000s) [68.695463] Subtest fbc-psr-primary-blt: SKIP (0.000s) [68.756561] [007/133] (954s left) drm_read (short-buffer-nonblock) [68.879789] Starting subtest: short-buffer-nonblock [68.881992] Subtest short-buffer-nonblock: SUCCESS (0.000s) [68.988446] [008/133] (954s left) gem_exec_store (dword) [69.056131] Starting subtest: dword [69.058210] Starting dynamic subtest: rcs0 [69.149992] Dynamic subtest rcs0: SUCCESS (0.095s) [69.160085] Starting dynamic subtest: bcs0 [69.191959] Dynamic subtest bcs0: SUCCESS (0.042s) [69.201104] Starting dynamic subtest: vcs0 [69.232574] Dynamic subtest vcs0: SUCCESS (0.040s) [69.240482] Starting dynamic subtest: vcs1 [69.272994] Dynamic subtest vcs1: SUCCESS (0.040s) [69.282430] Starting dynamic subtest: vecs0 [69.314772] Dynamic subtest vecs0: SUCCESS (0.041s) [69.323158] Starting dynamic subtest: ccs0 [69.356014] Dynamic subtest ccs0: SUCCESS (0.040s) [69.358050] Subtest dword: SUCCESS (0.303s) [69.531596] [009/133] (954s left) kms_plane (pixel-format-yf-tiled-modifier) [69.603352] Starting subtest: pixel-format-yf-tiled-modifier [69.608086] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [69.675843] [010/133] (953s left) kms_atomic_interruptible (legacy-setmode) [69.745745] Starting subtest: legacy-setmode [69.748111] Starting dynamic subtest: pipe-A-eDP-1 [76.646987] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.903s) [76.649050] Subtest legacy-setmode: SUCCESS (6.904s) [77.510689] [011/133] (946s left) gem_ctx_shared (exec-single-timeline) [77.564590] Starting subtest: exec-single-timeline [77.567228] Starting dynamic subtest: rcs0 [78.618062] Dynamic subtest rcs0: SUCCESS (1.052s) [78.629686] Starting dynamic subtest: bcs0 [79.706347] Dynamic subtest bcs0: SUCCESS (1.086s) [79.719961] Starting dynamic subtest: vcs0 [80.814654] Dynamic subtest vcs0: SUCCESS (1.090s) [80.826744] Starting dynamic subtest: vcs1 [81.884580] Dynamic subtest vcs1: SUCCESS (1.087s) [81.894578] Starting dynamic subtest: vecs0 [82.972715] Dynamic subtest vecs0: SUCCESS (1.085s) [82.987182] Starting dynamic subtest: ccs0 [84.059761] Dynamic subtest ccs0: SUCCESS (1.087s) [84.062881] Subtest exec-single-timeline: SUCCESS (6.495s) [84.253188] [012/133] (939s left) gem_mmap_offset (perf) [84.305141] Starting subtest: perf [84.307217] Starting dynamic subtest: smem0 [84.654580] Dynamic subtest smem0: SUCCESS (0.349s) [84.657240] Subtest perf: SUCCESS (0.349s) [84.791117] [013/133] (938s left) kms_color (ctm-signed) [84.863623] Starting subtest: ctm-signed [84.865872] Starting dynamic subtest: pipe-A-eDP-1 [87.029790] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.166s) [87.038779] Starting dynamic subtest: pipe-B-eDP-1 [89.851974] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.823s) [89.860617] Starting dynamic subtest: pipe-C-eDP-1 [92.485857] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.634s) [92.495401] Starting dynamic subtest: pipe-D-eDP-1 [95.140695] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.652s) [95.143058] Subtest ctm-signed: SUCCESS (10.276s) [95.956228] [014/133] (927s left) gem_pwrite (basic-exhaustion) [96.020088] Subtest basic-exhaustion: SKIP (0.000s) [96.077455] [015/133] (927s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [96.153104] Starting subtest: plane-scaler-unity-scaling-with-modifiers [96.155234] Starting dynamic subtest: pipe-A [96.499159] Dynamic subtest pipe-A: SUCCESS (0.350s) [96.507665] Starting dynamic subtest: pipe-B [97.954937] Dynamic subtest pipe-B: SUCCESS (1.455s) [97.965108] Starting dynamic subtest: pipe-C [99.399330] Dynamic subtest pipe-C: SUCCESS (1.444s) [99.409081] Starting dynamic subtest: pipe-D [100.820293] Dynamic subtest pipe-D: SUCCESS (1.420s) [100.822719] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.671s) [101.993458] [016/133] (921s left) gem_lmem_swapping (heavy-multi) [102.033586] Subtest heavy-multi: SKIP (0.000s) [102.076899] [017/133] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [102.162680] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [102.167095] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [102.260227] [018/133] (921s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [102.321383] Starting subtest: mixed-tiled-to-y-tiled-ccs [102.325413] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [102.513025] [019/133] (921s left) gem_exec_flush (basic-batch-kernel-default-uc) [102.575690] Starting subtest: basic-batch-kernel-default-uc [109.632106] Subtest basic-batch-kernel-default-uc: SUCCESS (7.057s) [109.821744] [020/133] (914s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [109.900421] Starting subtest: flip-vs-dpms-on-nop-interruptible [109.902817] Starting dynamic subtest: A-eDP1 [111.777532] Dynamic subtest A-eDP1: SUCCESS (1.876s) [111.786259] Starting dynamic subtest: B-eDP1 [113.613718] Dynamic subtest B-eDP1: SUCCESS (1.832s) [113.622662] Starting dynamic subtest: C-eDP1 [115.422639] Dynamic subtest C-eDP1: SUCCESS (1.809s) [115.433211] Starting dynamic subtest: D-eDP1 [117.249348] Dynamic subtest D-eDP1: SUCCESS (1.826s) [117.254237] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.353s) [118.435590] [021/133] (905s left) kms_pm_rpm (modeset-stress-extra-wait) [120.456647] Starting subtest: modeset-stress-extra-wait [174.760036] Subtest modeset-stress-extra-wait: SUCCESS (54.304s) [174.847363] [022/133] (849s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [174.922049] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [174.924358] Starting dynamic subtest: pipe-A-eDP-1 [174.947777] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [174.958269] Starting dynamic subtest: pipe-B-eDP-1 [174.979897] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [174.987689] Starting dynamic subtest: pipe-C-eDP-1 [175.008879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [175.016435] Starting dynamic subtest: pipe-D-eDP-1 [175.038212] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [175.042625] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [177.167987] [023/133] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [177.244199] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [177.248640] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [177.330707] [024/133] (846s left) gem_userptr_blits (sync-overlap) [177.405162] Starting subtest: sync-overlap [177.407379] Subtest sync-overlap: SUCCESS (0.000s) [177.535843] [025/133] (846s left) kms_chamelium_hpd (hdmi-hpd-storm) [177.894678] Subtest hdmi-hpd-storm: SKIP (0.000s) [178.680389] [026/133] (845s left) gem_ctx_persistence (heartbeat-close) [178.743480] Starting subtest: heartbeat-close [178.748301] Subtest heartbeat-close: SKIP (0.000s) [178.844066] [027/133] (845s left) perf (low-oa-exponent-permissions) [178.976512] Starting subtest: low-oa-exponent-permissions [179.008919] Subtest low-oa-exponent-permissions: SUCCESS (0.034s) [179.055047] [028/133] (845s left) kms_pipe_crc_basic (hang-read-crc) [179.132199] Starting subtest: hang-read-crc [179.134523] Starting dynamic subtest: pipe-A-eDP-1 [181.189092] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.058s) [181.198275] Starting dynamic subtest: pipe-B-eDP-1 [183.864427] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.673s) [183.873576] Starting dynamic subtest: pipe-C-eDP-1 [186.494846] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.630s) [186.506942] Starting dynamic subtest: pipe-D-eDP-1 [189.164642] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.667s) [189.167033] Subtest hang-read-crc: SUCCESS (10.033s) [189.983354] [029/133] (834s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [190.056908] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [190.059348] Starting dynamic subtest: pipe-A-default-mode [191.245810] Dynamic subtest pipe-A-default-mode: SKIP (1.185s) [191.249962] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.187s) [191.374369] [030/133] (832s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [191.422984] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [191.529994] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s) [191.605956] [031/133] (832s left) kms_cursor_crc (cursor-onscreen-128x42) [191.825686] Starting subtest: cursor-onscreen-128x42 [191.874185] Subtest cursor-onscreen-128x42: SKIP (0.043s) [192.075362] [032/133] (832s left) gem_tiled_partial_pwrite_pread (writes) [192.137653] Subtest writes: SKIP (0.000s) [192.211276] [033/133] (832s left) api_intel_bb (object-noreloc-purge-cache-simple) [192.265600] Starting subtest: object-noreloc-purge-cache-simple [192.267895] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s) [192.383835] [034/133] (832s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [192.464232] Starting subtest: fbc-rgb565-draw-mmap-cpu [196.502659] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.041s) [197.622578] [035/133] (826s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [197.702125] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [197.704420] Starting dynamic subtest: pipe-A-eDP-1 [197.727840] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [197.738584] Starting dynamic subtest: pipe-B-eDP-1 [197.760666] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [197.771561] Starting dynamic subtest: pipe-C-eDP-1 [197.792534] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [197.801270] Starting dynamic subtest: pipe-D-eDP-1 [197.824513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [197.828757] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s) [199.900309] [036/133] (824s left) kms_frontbuffer_tracking (fbcpsr-suspend) [199.984477] Starting subtest: fbcpsr-suspend [240.632869] Subtest fbcpsr-suspend: SUCCESS (10.188s) [240.779196] [037/133] (783s left) gem_lmem_swapping (verify) [240.826894] Subtest verify: SKIP (0.000s) [240.873722] [038/133] (783s left) perf_pmu (render-node-busy) [240.942173] Starting subtest: render-node-busy [240.944609] Starting dynamic subtest: rcs0 [241.531895] Dynamic subtest rcs0: SUCCESS (0.593s) [241.544013] Starting dynamic subtest: bcs0 [242.090826] Dynamic subtest bcs0: SUCCESS (0.560s) [242.106930] Starting dynamic subtest: vcs0 [243.727966] Dynamic subtest vcs0: SUCCESS (1.642s) [243.739386] Starting dynamic subtest: vcs1 [245.710620] Dynamic subtest vcs1: SUCCESS (1.990s) [245.721071] Starting dynamic subtest: vecs0 [247.695992] Dynamic subtest vecs0: SUCCESS (1.989s) [247.709122] Starting dynamic subtest: ccs0 [248.268585] Dynamic subtest ccs0: SUCCESS (0.573s) [248.271399] Subtest render-node-busy: SUCCESS (7.364s) [248.349240] [039/133] (776s left) kms_psr2_su (frontbuffer-xrgb8888) [248.407264] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [248.469471] [040/133] (776s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [248.548663] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [248.550585] Starting dynamic subtest: A-eDP1 [252.122919] Dynamic subtest A-eDP1: SUCCESS (3.582s) [252.133056] Starting dynamic subtest: B-eDP1 [255.318526] Dynamic subtest B-eDP1: SUCCESS (3.200s) [255.329466] Starting dynamic subtest: C-eDP1 [258.513426] Dynamic subtest C-eDP1: SUCCESS (3.197s) [258.524432] Starting dynamic subtest: D-eDP1 [261.713002] Dynamic subtest D-eDP1: SUCCESS (3.203s) [261.715307] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.190s) [262.527463] [041/133] (762s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [262.611122] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [263.401134] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s) [263.560693] [042/133] (761s left) gem_exec_balancer (full-pulse) [263.631250] Starting subtest: full-pulse [268.578977] Subtest full-pulse: SUCCESS (4.951s) [268.890976] [043/133] (756s left) kms_chamelium_audio (dp-audio) [269.289860] Subtest dp-audio: SKIP (0.000s) [270.127701] [044/133] (754s left) kms_plane_scaling (planes-downscale-factor-0-75) [270.211250] Starting subtest: planes-downscale-factor-0-75 [270.213450] Starting dynamic subtest: pipe-A [270.237256] Dynamic subtest pipe-A: SKIP (0.020s) [270.248000] Starting dynamic subtest: pipe-B [270.270149] Dynamic subtest pipe-B: SKIP (0.033s) [270.281036] Starting dynamic subtest: pipe-C [270.302951] Dynamic subtest pipe-C: SKIP (0.034s) [270.313302] Starting dynamic subtest: pipe-D [270.336405] Dynamic subtest pipe-D: SKIP (0.033s) [270.340529] Subtest planes-downscale-factor-0-75: SKIP (0.122s) [270.420275] [045/133] (754s left) gem_exec_gttfill (basic) [270.487743] Starting subtest: basic [273.066042] Subtest basic: SUCCESS (2.577s) [273.251825] [046/133] (751s left) gem_exec_parallel (basic) [273.353559] Starting subtest: basic [273.355801] Starting dynamic subtest: rcs0 [274.894809] Dynamic subtest rcs0: SUCCESS (1.543s) [274.906404] Starting dynamic subtest: bcs0 [276.307036] Dynamic subtest bcs0: SUCCESS (1.410s) [276.318125] Starting dynamic subtest: vcs0 [277.749422] Dynamic subtest vcs0: SUCCESS (1.441s) [277.760144] Starting dynamic subtest: vcs1 [279.696571] Dynamic subtest vcs1: SUCCESS (1.942s) [279.711130] Starting dynamic subtest: vecs0 [281.744237] Dynamic subtest vecs0: SUCCESS (2.044s) [281.758041] Starting dynamic subtest: ccs0 [283.241829] Dynamic subtest ccs0: SUCCESS (1.497s) [283.244290] Subtest basic: SUCCESS (9.890s) [283.440553] [047/133] (741s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [283.500618] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [283.503036] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [283.580669] [048/133] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [283.662153] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [283.666626] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [283.752747] [049/133] (741s left) gem_exec_reloc (basic-range-active) [283.810564] Subtest basic-range-active: SKIP (0.000s) [283.882792] [050/133] (741s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [284.246096] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [285.052543] [051/133] (740s left) kms_lease (lease-again) [285.137248] Starting subtest: lease-again [285.139514] Starting dynamic subtest: pipe-A-eDP-1 [285.141789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s) [285.153609] Starting dynamic subtest: pipe-B-eDP-1 [285.155497] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [285.165923] Starting dynamic subtest: pipe-C-eDP-1 [285.167820] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [285.178203] Starting dynamic subtest: pipe-D-eDP-1 [285.180203] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [285.182246] Subtest lease-again: SUCCESS (0.016s) [285.274181] [052/133] (739s left) kms_getfb (getfb2-accept-nv12) [285.341309] Starting subtest: getfb2-accept-nv12 [285.343578] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [285.452789] [053/133] (739s left) syncobj_timeline (single-wait-all-available-signaled) [285.510951] Starting subtest: single-wait-all-available-signaled [285.513370] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [285.608344] [054/133] (739s left) syncobj_wait (single-wait-signaled) [285.671549] Starting subtest: single-wait-signaled [285.673871] Subtest single-wait-signaled: SUCCESS (0.000s) [285.782885] [055/133] (739s left) kms_addfb_basic (basic-x-tiled-legacy) [285.826251] Starting subtest: basic-x-tiled-legacy [285.830512] Subtest basic-x-tiled-legacy: SKIP (0.000s) [285.939302] [056/133] (739s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [286.030821] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [286.032748] Starting dynamic subtest: pipe-A-eDP-1 [286.051216] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [286.062865] Starting dynamic subtest: pipe-B-eDP-1 [286.080127] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [286.090489] Starting dynamic subtest: pipe-C-eDP-1 [286.108374] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [286.118965] Starting dynamic subtest: pipe-D-eDP-1 [286.136240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [286.139483] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [288.326588] [057/133] (737s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [288.418301] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [288.422733] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [288.515567] [058/133] (736s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [288.584763] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [288.587148] Starting dynamic subtest: pipe-A-eDP-1 [288.611303] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [288.622742] Starting dynamic subtest: pipe-B-eDP-1 [288.644456] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [288.654474] Starting dynamic subtest: pipe-C-eDP-1 [288.676154] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [288.686966] Starting dynamic subtest: pipe-D-eDP-1 [288.708692] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [288.713094] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [290.807984] [059/133] (734s left) syncobj_timeline (invalid-query-one-illegal-handle) [290.857918] Starting subtest: invalid-query-one-illegal-handle [290.860379] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [290.959613] [060/133] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [291.033638] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [291.037561] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [291.141558] [061/133] (734s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [291.221915] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [291.226190] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [291.323172] [062/133] (734s left) kms_force_connector_basic (force-edid) [291.385284] Subtest force-edid: SKIP (0.000s) [291.445129] [063/133] (734s left) kms_getfb (getfb-handle-zero) [291.532102] Starting subtest: getfb-handle-zero [291.534278] Subtest getfb-handle-zero: SUCCESS (0.000s) [291.641192] [064/133] (734s left) gem_userptr_blits (invalid-mmap-offset-unsync) [291.707792] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [291.826726] [065/133] (733s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [291.909771] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [295.860458] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.953s) [296.984428] [066/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [297.062218] Starting subtest: fbcpsr-2p-rte [297.066290] Subtest fbcpsr-2p-rte: SKIP (0.000s) [297.152004] [067/133] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [297.226005] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [297.230397] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [297.321380] [068/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [297.406000] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [297.410649] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [297.514700] [069/133] (728s left) gem_create (create-size-update) [297.563969] Starting subtest: create-size-update [297.565995] Subtest create-size-update: SUCCESS (0.000s) [297.778256] [070/133] (728s left) kms_debugfs (display-on-read-all) [297.847825] Starting subtest: display-on-read-all [298.042082] Subtest display-on-read-all: SUCCESS (0.193s) [298.165518] [071/133] (727s left) prime_udl [298.250966] [072/133] (727s left) i915_drm_fdinfo (virtual-idle) [298.287421] Starting subtest: virtual-idle [301.320729] Subtest virtual-idle: SUCCESS (3.034s) [301.396979] [073/133] (724s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [301.480773] Starting subtest: pr-overlay-plane-update-sf-dmg-area [301.484887] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [301.548273] [074/133] (724s left) kms_universal_plane (disable-primary-vs-flip) [301.627503] Starting subtest: disable-primary-vs-flip [301.629754] Starting dynamic subtest: pipe-A-eDP-1 [303.182146] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.554s) [303.193969] Starting dynamic subtest: pipe-B-eDP-1 [305.425783] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.242s) [305.437431] Starting dynamic subtest: pipe-C-eDP-1 [307.660291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s) [307.672253] Starting dynamic subtest: pipe-D-eDP-1 [309.820428] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.161s) [309.822712] Subtest disable-primary-vs-flip: SUCCESS (8.198s) [310.623189] [075/133] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [310.712984] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [310.717472] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [310.810982] [076/133] (715s left) syncobj_basic (test-valid-cycle) [310.864536] Starting subtest: test-valid-cycle [310.866826] Subtest test-valid-cycle: SUCCESS (0.000s) [310.974711] [077/133] (715s left) gem_render_copy_redux (flink-interruptible) [311.027794] Starting subtest: flink-interruptible [311.764405] Subtest flink-interruptible: SUCCESS (0.737s) [311.900797] [078/133] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [311.986373] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [311.989902] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [312.079616] [079/133] (714s left) gem_userptr_blits (process-exit-busy) [312.143252] Starting subtest: process-exit-busy [312.155301] Subtest process-exit-busy: SUCCESS (0.014s) [312.284126] [080/133] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [312.357491] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [312.361052] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [312.456609] [081/133] (713s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [312.529398] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [312.538007] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.007s) [312.644242] [082/133] (713s left) kms_prop_blob (blob-prop-core) [312.697456] Starting subtest: blob-prop-core [312.699400] Subtest blob-prop-core: SUCCESS (0.000s) [312.785493] [083/133] (713s left) kms_vrr (negative-basic) [312.854911] Starting subtest: negative-basic [312.860637] Starting dynamic subtest: pipe-A-eDP-1 [318.274634] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s) [318.579362] Subtest negative-basic: SUCCESS (5.725s) [319.449682] [084/133] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [319.533604] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [319.537924] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [319.628091] [085/133] (706s left) i915_pm_rc6_residency (rc6-idle) [319.687413] Starting subtest: rc6-idle [319.710952] Starting dynamic subtest: gt0-rcs0 [344.091228] Dynamic subtest gt0-rcs0: SUCCESS (24.380s) [344.104445] Starting dynamic subtest: gt0-bcs0 [368.358736] Dynamic subtest gt0-bcs0: SUCCESS (24.261s) [368.369829] Starting dynamic subtest: gt0-ccs0 [392.570624] Dynamic subtest gt0-ccs0: SUCCESS (24.211s) [392.585236] Starting dynamic subtest: gt1-vcs0 [398.744769] Dynamic subtest gt1-vcs0: SUCCESS (6.171s) [398.762891] Starting dynamic subtest: gt1-vecs0 [404.917329] Dynamic subtest gt1-vecs0: SUCCESS (6.171s) [404.920738] Subtest rc6-idle: SUCCESS (85.232s) [404.997544] [086/133] (621s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [405.086877] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [405.091054] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [405.192374] [087/133] (621s left) kms_psr (pr-sprite-plane-onoff) [405.274371] Starting subtest: pr-sprite-plane-onoff [405.278737] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [405.351924] [088/133] (621s left) core_getversion (basic) [405.400403] Starting subtest: basic [405.404674] Subtest basic: SUCCESS (0.000s) [405.480384] [089/133] (621s left) gem_softpin (allocator-nopin-reserve) [405.540270] Starting subtest: allocator-nopin-reserve [405.627960] Subtest allocator-nopin-reserve: SUCCESS (0.088s) [405.750004] [090/133] (621s left) gem_mmap_gtt (basic-copy) [405.807537] Subtest basic-copy: SKIP (0.000s) [405.877925] [091/133] (620s left) kms_properties (crtc-properties-legacy) [405.952678] Starting subtest: crtc-properties-legacy [405.954698] Starting dynamic subtest: pipe-A-eDP-1 [406.389743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s) [406.401235] Starting dynamic subtest: pipe-B-eDP-1 [407.524398] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s) [407.535661] Starting dynamic subtest: pipe-C-eDP-1 [408.647917] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s) [408.659870] Starting dynamic subtest: pipe-D-eDP-1 [409.768510] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s) [409.770843] Subtest crtc-properties-legacy: SUCCESS (3.817s) [410.595736] [092/133] (616s left) gem_exec_schedule (fifo) [410.669637] Starting subtest: fifo [410.671937] Starting dynamic subtest: rcs0 [410.768317] Dynamic subtest rcs0: SUCCESS (0.108s) [410.786241] Starting dynamic subtest: vcs0 [410.844384] Dynamic subtest vcs0: SUCCESS (0.076s) [410.857879] Starting dynamic subtest: vcs1 [410.918194] Dynamic subtest vcs1: SUCCESS (0.073s) [410.932023] Starting dynamic subtest: vecs0 [410.989843] Dynamic subtest vecs0: SUCCESS (0.071s) [411.003413] Starting dynamic subtest: ccs0 [411.067264] Dynamic subtest ccs0: SUCCESS (0.076s) [411.069986] Subtest fifo: SUCCESS (0.409s) [412.785456] [093/133] (614s left) api_intel_allocator (open-vm) [412.848302] Starting subtest: open-vm [412.850521] Subtest open-vm: SUCCESS (0.003s) [412.968902] [094/133] (613s left) gem_ctx_persistence (engines-cleanup) [413.019521] Starting subtest: engines-cleanup [413.022200] Starting dynamic subtest: rcs0 [413.088365] Dynamic subtest rcs0: SUCCESS (0.068s) [413.106152] Starting dynamic subtest: bcs0 [413.124597] Dynamic subtest bcs0: SUCCESS (0.034s) [413.135236] Starting dynamic subtest: vcs0 [413.208270] Dynamic subtest vcs0: SUCCESS (0.081s) [413.221402] Starting dynamic subtest: vcs1 [413.259237] Dynamic subtest vcs1: SUCCESS (0.049s) [413.271703] Starting dynamic subtest: vecs0 [413.310028] Dynamic subtest vecs0: SUCCESS (0.049s) [413.322504] Starting dynamic subtest: ccs0 [413.364051] Dynamic subtest ccs0: SUCCESS (0.052s) [413.366533] Subtest engines-cleanup: SUCCESS (0.346s) [413.445624] [095/133] (613s left) kms_content_protection (dp-mst-type-1) [413.578460] Starting subtest: dp-mst-type-1 [413.583047] Subtest dp-mst-type-1: SKIP (0.000s) [413.692993] [096/133] (613s left) kms_cursor_edge_walk (64x64-top-bottom) [413.763730] Starting subtest: 64x64-top-bottom [413.765772] Starting dynamic subtest: pipe-A-eDP-1 [417.250929] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s) [417.262766] Starting dynamic subtest: pipe-D-eDP-1 [420.361924] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s) [420.364354] Subtest 64x64-top-bottom: SUCCESS (6.599s) [421.186775] [097/133] (605s left) prime_vgem (busy) [421.338157] Starting subtest: busy [421.340509] Starting dynamic subtest: rcs0 [421.378135] Dynamic subtest rcs0: SUCCESS (0.040s) [421.390317] Starting dynamic subtest: bcs0 [421.427122] Dynamic subtest bcs0: SUCCESS (0.048s) [421.438573] Starting dynamic subtest: vcs0 [421.473069] Dynamic subtest vcs0: SUCCESS (0.045s) [421.484419] Starting dynamic subtest: vcs1 [421.518024] Dynamic subtest vcs1: SUCCESS (0.044s) [421.529781] Starting dynamic subtest: vecs0 [421.563148] Dynamic subtest vecs0: SUCCESS (0.045s) [421.574884] Starting dynamic subtest: ccs0 [421.607605] Dynamic subtest ccs0: SUCCESS (0.044s) [421.609950] Subtest busy: SUCCESS (0.271s) [421.723662] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true [421.727180] [098/133] (605s left) gem_exec_schedule (preempt-contexts) [421.799436] Starting subtest: preempt-contexts [421.801657] Starting dynamic subtest: rcs0 [421.842784] Dynamic subtest rcs0: SUCCESS (0.049s) [421.854976] Starting dynamic subtest: bcs0 [421.894209] Dynamic subtest bcs0: SUCCESS (0.050s) [421.906177] Starting dynamic subtest: vcs0 [421.937752] Dynamic subtest vcs0: SUCCESS (0.043s) [421.949101] Starting dynamic subtest: vcs1 [421.984587] Dynamic subtest vcs1: SUCCESS (0.045s) [421.999514] Starting dynamic subtest: vecs0 [422.025223] Dynamic subtest vecs0: SUCCESS (0.040s) [422.038812] Starting dynamic subtest: ccs0 [422.067406] Dynamic subtest ccs0: SUCCESS (0.043s) [422.069743] Subtest preempt-contexts: SUCCESS (0.275s) [423.798780] [099/133] (603s left) gem_exec_fence (basic-busy) [423.982235] Starting subtest: basic-busy [423.985417] Starting dynamic subtest: rcs0 [424.060500] Dynamic subtest rcs0: SUCCESS (0.078s) [424.072400] Starting dynamic subtest: bcs0 [424.127387] Dynamic subtest bcs0: SUCCESS (0.065s) [424.138590] Starting dynamic subtest: vcs0 [424.184421] Dynamic subtest vcs0: SUCCESS (0.055s) [424.195174] Starting dynamic subtest: vcs1 [424.238152] Dynamic subtest vcs1: SUCCESS (0.052s) [424.248901] Starting dynamic subtest: vecs0 [424.294306] Dynamic subtest vecs0: SUCCESS (0.055s) [424.305190] Starting dynamic subtest: ccs0 [424.358260] Dynamic subtest ccs0: SUCCESS (0.062s) [424.360757] Subtest basic-busy: SUCCESS (0.378s) [425.822953] [100/133] (601s left) gem_exec_fence (syncobj-timeline-repeat) [426.369923] Starting subtest: syncobj-timeline-repeat [426.607391] Subtest syncobj-timeline-repeat: SUCCESS (0.237s) [427.805467] [101/133] (599s left) kms_pm_lpsp (screens-disabled) [428.891603] Starting subtest: screens-disabled [428.895975] Subtest screens-disabled: SKIP (0.000s) [428.961926] [102/133] (598s left) gem_exec_suspend (basic-s4-devices) [429.018125] Starting subtest: basic-S4-devices [429.020623] Starting dynamic subtest: smem [440.720692] Dynamic subtest smem: SUCCESS (11.703s) [440.724058] Subtest basic-S4-devices: SUCCESS (11.705s) [446.932016] [103/133] (586s left) i915_query (query-regions-sanity-check) [446.997213] Starting subtest: query-regions-sanity-check [447.011426] Subtest query-regions-sanity-check: SUCCESS (0.015s) [447.123573] [104/133] (586s left) syncobj_basic (create-signaled) [447.177921] Starting subtest: create-signaled [447.180167] Subtest create-signaled: SUCCESS (0.000s) [447.273465] [105/133] (586s left) kms_psr (psr2-cursor-mmap-gtt) [447.342111] Starting subtest: psr2-cursor-mmap-gtt [447.344518] Starting dynamic subtest: eDP-1 [449.060652] Dynamic subtest eDP-1: SUCCESS (1.719s) [449.062893] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.720s) [449.858920] [106/133] (583s left) gen9_exec_parse (bb-start-param) [449.930730] Subtest bb-start-param: SKIP (0.000s) [450.002870] [107/133] (583s left) gem_ctx_param (basic-default) [450.060613] Starting subtest: basic-default [450.062910] Subtest basic-default: SUCCESS (0.000s) [450.137630] [108/133] (583s left) gem_exec_suspend (basic-s3) [450.193383] Starting subtest: basic-S3 [450.195817] Starting dynamic subtest: smem [470.957624] Dynamic subtest smem: SUCCESS (6.539s) [470.960700] Subtest basic-S3: SUCCESS (6.541s) [471.144137] [109/133] (562s left) gem_ccs (ctrl-surf-copy-new-ctx) [471.212520] Starting subtest: ctrl-surf-copy-new-ctx [471.217822] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [471.321887] [110/133] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [471.406586] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [471.411074] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [471.509649] [111/133] (562s left) gem_readwrite (new-obj) [471.563607] Subtest new-obj: SKIP (0.000s) [471.627342] [112/133] (562s left) kms_big_fb (x-tiled-32bpp-rotate-270) [471.714191] Starting subtest: x-tiled-32bpp-rotate-270 [471.733643] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [471.851527] [113/133] (561s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [471.913406] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [471.979232] [114/133] (561s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [472.056436] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [472.841466] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s) [473.008978] [115/133] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [473.091837] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [479.924788] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.866s) [480.040351] [116/133] (553s left) gem_exec_reloc (basic-wc-cpu-noreloc) [480.094654] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [480.180806] [117/133] (553s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [480.236379] Starting subtest: etime-multi-wait-all-submitted-signaled [480.344687] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.109s) [480.422688] [118/133] (553s left) kms_big_fb (4-tiled-8bpp-rotate-0) [480.503996] Starting subtest: 4-tiled-8bpp-rotate-0 [481.703400] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.203s) [481.826193] [119/133] (552s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [481.910662] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [481.915448] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [482.034593] [120/133] (552s left) gem_ctx_param (invalid-size-set) [482.086429] Starting subtest: invalid-size-set [482.088521] Subtest invalid-size-set: SUCCESS (0.001s) [482.181220] [121/133] (551s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [482.235858] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [482.240371] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [482.426358] [122/133] (551s left) kms_psr (psr-sprite-plane-onoff) [482.507803] Starting subtest: psr-sprite-plane-onoff [482.510335] Starting dynamic subtest: eDP-1 [484.308668] Dynamic subtest eDP-1: SUCCESS (1.804s) [484.311657] Subtest psr-sprite-plane-onoff: SUCCESS (1.805s) [485.147094] [123/133] (549s left) i915_drm_fdinfo (basics) [485.189636] Starting subtest: basics [485.192505] Subtest basics: SUCCESS (0.000s) [485.289157] [124/133] (549s left) kms_plane_multiple (2x-tiling-y) [485.360666] Starting subtest: 2x-tiling-y [485.365646] Subtest 2x-tiling-y: SKIP (0.000s) [485.433181] [125/133] (548s left) gem_exec_schedule (u-submit-early-slice) [485.502462] Starting subtest: u-submit-early-slice [485.504497] Starting dynamic subtest: rcs0 [485.541481] Dynamic subtest rcs0: SUCCESS (0.046s) [485.555430] Starting dynamic subtest: bcs0 [485.580664] Dynamic subtest bcs0: SUCCESS (0.039s) [485.592563] Starting dynamic subtest: vcs0 [485.620000] Dynamic subtest vcs0: SUCCESS (0.038s) [485.632155] Starting dynamic subtest: vcs1 [485.653818] Dynamic subtest vcs1: SUCCESS (0.033s) [485.670035] Starting dynamic subtest: vecs0 [485.688877] Dynamic subtest vecs0: SUCCESS (0.035s) [485.702120] Starting dynamic subtest: ccs0 [485.723857] Dynamic subtest ccs0: SUCCESS (0.033s) [485.726863] Subtest u-submit-early-slice: SUCCESS (0.229s) [487.036799] [126/133] (547s left) gem_mmap_wc (coherency) [487.094970] Subtest coherency: SKIP (0.000s) [487.154796] [127/133] (547s left) kms_invalid_mode (bad-vsync-start) [487.233556] Starting subtest: bad-vsync-start [487.235849] Starting dynamic subtest: pipe-A-eDP-1 [487.522342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [487.534516] Starting dynamic subtest: pipe-B-eDP-1 [487.536809] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [487.548034] Starting dynamic subtest: pipe-C-eDP-1 [487.550403] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [487.561456] Starting dynamic subtest: pipe-D-eDP-1 [487.563674] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [487.566086] Subtest bad-vsync-start: SUCCESS (0.296s) [488.399264] [128/133] (546s left) gem_fenced_exec_thrash (2-spare-fences) [488.450675] Subtest 2-spare-fences: SKIP (0.000s) [488.521105] [129/133] (545s left) syncobj_timeline (wait-for-submit-snapshot) [488.568403] Starting subtest: wait-for-submit-snapshot [488.648423] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [488.728393] [130/133] (545s left) kms_vblank (ts-continuation-idle) [488.802672] Starting subtest: ts-continuation-idle [488.805066] Starting dynamic subtest: pipe-A-eDP-1 [489.200171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s) [489.217686] Starting dynamic subtest: pipe-D-eDP-1 [490.260094] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.060s) [490.262675] Subtest ts-continuation-idle: SUCCESS (1.461s) [491.132424] [131/133] (543s left) kms_atomic (plane-invalid-params-fence) [491.207507] Starting subtest: plane-invalid-params-fence [491.210028] Starting dynamic subtest: pipe-A-eDP-1 [491.568674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s) [491.571660] Subtest plane-invalid-params-fence: SUCCESS (0.363s) [492.373174] [132/133] (542s left) syncobj_wait (multi-wait-for-submit-signaled) [492.429795] Starting subtest: multi-wait-for-submit-signaled [492.432801] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [492.523733] [133/133] (542s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [492.599792] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [492.602447] Starting dynamic subtest: A-eDP1 [501.500278] Dynamic subtest A-eDP1: SUCCESS (8.903s) [501.516235] Starting dynamic subtest: B-eDP1 [510.425465] Dynamic subtest B-eDP1: SUCCESS (8.920s) [510.439886] Starting dynamic subtest: C-eDP1 [519.346984] Dynamic subtest C-eDP1: SUCCESS (8.919s) [519.358710] Starting dynamic subtest: D-eDP1 [528.189472] Dynamic subtest D-eDP1: SUCCESS (8.842s) [528.194827] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.597s) [529.422438] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: kms_draw_crc results: parsing output: 3/ for test: gem_partial_pwrite_pread results: parsing output: 4/ for test: kms_addfb_basic results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: drm_read results: parsing output: 7/ for test: gem_exec_store results: parsing output: 8/ for test: kms_plane results: parsing output: 9/ for test: kms_atomic_interruptible results: parsing output: 10/ for test: gem_ctx_shared results: parsing output: 11/ for test: gem_mmap_offset results: parsing output: 12/ for test: kms_color results: parsing output: 13/ for test: gem_pwrite results: parsing output: 14/ for test: kms_plane_scaling results: parsing output: 15/ for test: gem_lmem_swapping results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_render_copy results: parsing output: 18/ for test: gem_exec_flush results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_pm_rpm results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_userptr_blits results: parsing output: 24/ for test: kms_chamelium_hpd results: parsing output: 25/ for test: gem_ctx_persistence results: parsing output: 26/ for test: perf results: parsing output: 27/ for test: kms_pipe_crc_basic results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 32/ for test: api_intel_bb results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_lmem_swapping results: parsing output: 37/ for test: perf_pmu results: parsing output: 38/ for test: kms_psr2_su results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: gem_exec_balancer results: parsing output: 42/ for test: kms_chamelium_audio results: parsing output: 43/ for test: kms_plane_scaling results: parsing output: 44/ for test: gem_exec_gttfill results: parsing output: 45/ for test: gem_exec_parallel results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_exec_reloc results: parsing output: 49/ for test: kms_chamelium_frames results: parsing output: 50/ for test: kms_lease results: parsing output: 51/ for test: kms_getfb results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: syncobj_wait results: parsing output: 54/ for test: kms_addfb_basic results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_force_connector_basic results: parsing output: 62/ for test: kms_getfb results: parsing output: 63/ for test: gem_userptr_blits results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_create results: parsing output: 69/ for test: kms_debugfs results: parsing output: 70/ for test: prime_udl results: parsing output: 71/ for test: i915_drm_fdinfo results: parsing output: 72/ for test: kms_psr2_sf results: parsing output: 73/ for test: kms_universal_plane results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: syncobj_basic results: parsing output: 76/ for test: gem_render_copy_redux results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_userptr_blits results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_prop_blob results: parsing output: 82/ for test: kms_vrr results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: i915_pm_rc6_residency results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: core_getversion results: parsing output: 88/ for test: gem_softpin results: parsing output: 89/ for test: gem_mmap_gtt results: parsing output: 90/ for test: kms_properties results: parsing output: 91/ for test: gem_exec_schedule results: parsing output: 92/ for test: api_intel_allocator results: parsing output: 93/ for test: gem_ctx_persistence results: parsing output: 94/ for test: kms_content_protection results: parsing output: 95/ for test: kms_cursor_edge_walk results: parsing output: 96/ for test: prime_vgem results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: gem_exec_fence results: parsing output: 99/ for test: gem_exec_fence results: parsing output: 100/ for test: kms_pm_lpsp results: parsing output: 101/ for test: gem_exec_suspend results: parsing output: 102/ for test: i915_query results: parsing output: 103/ for test: syncobj_basic results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: gen9_exec_parse results: parsing output: 106/ for test: gem_ctx_param results: parsing output: 107/ for test: gem_exec_suspend results: parsing output: 108/ for test: gem_ccs results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_readwrite results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_exec_reloc results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: gem_ctx_param results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: i915_drm_fdinfo results: parsing output: 123/ for test: kms_plane_multiple results: parsing output: 124/ for test: gem_exec_schedule results: parsing output: 125/ for test: gem_mmap_wc results: parsing output: 126/ for test: kms_invalid_mode results: parsing output: 127/ for test: gem_fenced_exec_thrash results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: kms_vblank results: parsing output: 130/ for test: kms_atomic results: parsing output: 131/ for test: syncobj_wait results: parsing output: 132/ for test: kms_flip Done.