[35.025291] Initializing watchdogs [35.025320] /dev/watchdog0 [35.031118] [001/130] (960s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [35.151204] Starting subtest: cursorB-vs-flipB-toggle [35.155845] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [35.246452] [002/130] (960s left) gem_mmap_offset (clear) [35.297314] Starting subtest: clear [35.299653] Starting dynamic subtest: smem0 [60.308570] Dynamic subtest smem0: SUCCESS (25.027s) [60.311563] Subtest clear: SUCCESS (25.027s) [60.458141] [003/130] (935s left) gem_exec_fence (parallel) [60.629257] Starting subtest: parallel [60.632051] Starting dynamic subtest: rcs0 [62.774687] Dynamic subtest rcs0: SUCCESS (2.148s) [62.780088] Starting dynamic subtest: bcs0 [64.922883] Dynamic subtest bcs0: SUCCESS (2.150s) [64.928865] Starting dynamic subtest: vcs0 [67.071192] Dynamic subtest vcs0: SUCCESS (2.150s) [67.078101] Starting dynamic subtest: vcs1 [69.217283] Dynamic subtest vcs1: SUCCESS (2.148s) [69.224083] Starting dynamic subtest: vecs0 [71.364342] Dynamic subtest vecs0: SUCCESS (2.148s) [71.373166] Starting dynamic subtest: ccs0 [73.517123] Dynamic subtest ccs0: SUCCESS (2.154s) [73.519339] Subtest parallel: SUCCESS (12.898s) [74.500652] [004/130] (921s left) gem_render_copy (linear-to-vebox-y-tiled) [74.552049] Starting subtest: linear-to-vebox-y-tiled [74.557513] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [74.708461] [005/130] (920s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [79.867219] Starting subtest: pr-overlay-plane-move-continuous-sf [79.872875] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [80.732846] [006/130] (914s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [80.838660] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [81.484232] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.647s) [81.621247] [007/130] (913s left) kms_pipe_crc_basic (suspend-read-crc) [81.706880] Starting subtest: suspend-read-crc [81.709113] Starting dynamic subtest: pipe-A-eDP-1 [99.633280] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.276s) [99.643201] Starting dynamic subtest: pipe-B-eDP-1 [117.382964] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s) [117.390331] Starting dynamic subtest: pipe-C-eDP-1 [135.301478] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.646s) [135.310381] Starting dynamic subtest: pipe-D-eDP-1 [153.286896] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s) [153.289157] Subtest suspend-read-crc: SUCCESS (10.299s) [154.198894] [008/130] (902s left) gem_exec_reloc (basic-concurrent16) [154.253367] Subtest basic-concurrent16: SKIP (0.000s) [154.295270] [009/130] (902s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [154.382595] Starting subtest: psr-rgb565-draw-mmap-gtt [154.387144] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [154.453937] [010/130] (902s left) drm_fdinfo (virtual-busy) [154.487933] Starting subtest: virtual-busy [154.492121] Subtest virtual-busy: SKIP (0.000s) [154.524553] [011/130] (902s left) gem_tiling_max_stride [154.602799] [012/130] (902s left) gem_exec_params (sol-reset-not-gen7) [154.653420] Starting subtest: sol-reset-not-gen7 [154.658210] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [154.758887] [013/130] (902s left) gem_bad_reloc (negative-reloc-lut) [154.819153] Subtest negative-reloc-lut: SKIP (0.000s) [154.849167] [014/130] (902s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [154.940581] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [154.942898] Starting dynamic subtest: pipe-A-eDP-1 [154.964818] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [154.973006] Starting dynamic subtest: pipe-B-eDP-1 [154.994848] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [155.000528] Starting dynamic subtest: pipe-C-eDP-1 [155.021631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [155.027664] Starting dynamic subtest: pipe-D-eDP-1 [155.050482] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [155.054574] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [157.277904] [015/130] (899s left) syncobj_timeline (etime-multi-wait-submitted) [157.334848] Starting subtest: etime-multi-wait-submitted [157.443995] Subtest etime-multi-wait-submitted: SUCCESS (0.109s) [157.494979] [016/130] (899s left) tools_test (tools_test) [157.545324] Starting subtest: tools_test [157.572398] Subtest tools_test: SUCCESS (0.045s) [157.607128] [017/130] (899s left) kms_plane_lowres (tiling-y) [157.695632] Starting subtest: tiling-y [157.700246] Subtest tiling-y: SKIP (0.000s) [157.742710] [018/130] (899s left) kms_getfb (getfb2-handle-closed) [157.795120] Starting subtest: getfb2-handle-closed [157.797389] Subtest getfb2-handle-closed: SUCCESS (0.000s) [157.883016] [019/130] (899s left) kms_scaling_modes (scaling-mode-none) [157.978653] Starting subtest: scaling-mode-none [157.981049] Starting dynamic subtest: pipe-A-eDP-1 [158.077131] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s) [158.086113] Starting dynamic subtest: pipe-B-eDP-1 [158.110709] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s) [158.117308] Starting dynamic subtest: pipe-C-eDP-1 [158.142071] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s) [158.150549] Starting dynamic subtest: pipe-D-eDP-1 [158.170581] Dynamic subtest pipe-D-eDP-1: SKIP (0.028s) [158.175053] Subtest scaling-mode-none: SKIP (0.190s) [158.274224] [020/130] (898s left) gem_exec_await (wide-contexts) [158.417710] Starting subtest: wide-contexts [181.545227] Subtest wide-contexts: SUCCESS (23.153s) [181.716598] [021/130] (875s left) gem_exec_flush (basic-uc-rw-default) [181.818512] Starting subtest: basic-uc-rw-default [187.263533] Subtest basic-uc-rw-default: SUCCESS (5.445s) [187.426750] [022/130] (869s left) prime_mmap (test_forked) [187.470757] Starting subtest: test_forked [187.473047] Starting dynamic subtest: test_forked-smem [187.500200] Dynamic subtest test_forked-smem: SUCCESS (0.029s) [187.503252] Subtest test_forked: SUCCESS (0.030s) [187.570094] [023/130] (869s left) gem_flink_basic (bad-open) [187.622098] Starting subtest: bad-open [187.624197] Subtest bad-open: SUCCESS (0.000s) [187.691582] [024/130] (869s left) kms_big_fb (4-tiled-16bpp-rotate-90) [187.797008] Starting subtest: 4-tiled-16bpp-rotate-90 [187.815607] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.018s) [187.906547] [025/130] (869s left) syncobj_timeline (multi-wait-signaled) [187.963305] Starting subtest: multi-wait-signaled [187.966275] Subtest multi-wait-signaled: SUCCESS (0.000s) [188.034725] [026/130] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [188.130768] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [191.068182] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.940s) [191.155664] [027/130] (865s left) kms_psr (pr-sprite-blt) [191.249328] Starting subtest: pr-sprite-blt [191.253076] Subtest pr-sprite-blt: SKIP (0.000s) [191.299154] [028/130] (865s left) gem_ctx_param (invalid-size-set) [191.336895] Starting subtest: invalid-size-set [191.338772] Subtest invalid-size-set: SUCCESS (0.001s) [191.402599] [029/130] (865s left) sriov_basic (enable-vfs-autoprobe-off) [191.456889] Subtest enable-vfs-autoprobe-off: SKIP (0.000s) [191.491996] [030/130] (865s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [191.578171] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [192.112442] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.536s) [192.260276] [031/130] (864s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [192.359629] Starting subtest: 2x-flip-vs-cursor-atomic [192.364633] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s) [192.445868] [032/130] (864s left) kms_flip (wf_vblank-ts-check) [192.529952] Starting subtest: wf_vblank-ts-check [192.532258] Starting dynamic subtest: A-eDP1 [201.559904] Dynamic subtest A-eDP1: SUCCESS (9.028s) [201.569685] Starting dynamic subtest: B-eDP1 [210.581390] Dynamic subtest B-eDP1: SUCCESS (9.021s) [210.589440] Starting dynamic subtest: C-eDP1 [219.592539] Dynamic subtest C-eDP1: SUCCESS (9.012s) [219.601927] Starting dynamic subtest: D-eDP1 [228.552372] Dynamic subtest D-eDP1: SUCCESS (8.962s) [228.557545] Subtest wf_vblank-ts-check: SUCCESS (36.032s) [229.785802] [033/130] (827s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [229.872804] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [229.875282] Starting dynamic subtest: pipe-A [229.891287] Dynamic subtest pipe-A: SKIP (0.012s) [229.899017] Starting dynamic subtest: pipe-B [229.911230] Dynamic subtest pipe-B: SKIP (0.021s) [229.917783] Starting dynamic subtest: pipe-C [229.932766] Dynamic subtest pipe-C: SKIP (0.021s) [229.939142] Starting dynamic subtest: pipe-D [229.954043] Dynamic subtest pipe-D: SKIP (0.021s) [229.958477] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.075s) [230.006797] [034/130] (827s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [230.093676] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [230.096018] Starting dynamic subtest: pipe-A-eDP-1 [230.157143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s) [230.165264] Starting dynamic subtest: pipe-B-eDP-1 [230.225180] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.067s) [230.233242] Starting dynamic subtest: pipe-C-eDP-1 [230.293653] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.068s) [230.302034] Starting dynamic subtest: pipe-D-eDP-1 [230.361049] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.067s) [230.363406] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.267s) [232.664586] [035/130] (824s left) i915_pm_rpm (gem-execbuf-stress) [234.881825] Starting subtest: gem-execbuf-stress [234.884642] Starting dynamic subtest: smem0 [247.834009] Dynamic subtest smem0: SUCCESS (12.958s) [247.844317] Starting dynamic subtest: extra-wait-smem0 [309.749812] Dynamic subtest extra-wait-smem0: SUCCESS (61.909s) [309.752704] Subtest gem-execbuf-stress: SUCCESS (74.868s) [310.074465] [036/130] (747s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [310.161678] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [310.164016] Starting dynamic subtest: pipe-A-eDP-1 [310.186495] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [310.194534] Starting dynamic subtest: pipe-B-eDP-1 [310.215917] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [310.223555] Starting dynamic subtest: pipe-C-eDP-1 [310.244938] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [310.252292] Starting dynamic subtest: pipe-D-eDP-1 [310.273727] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [310.278041] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.002s) [312.474468] [037/130] (744s left) kms_pm_rpm (system-suspend-modeset) [313.878507] Starting subtest: system-suspend-modeset [332.928714] Subtest system-suspend-modeset: SUCCESS (4.079s) [333.247354] [038/130] (738s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [333.358099] Starting subtest: 2x-long-cursor-vs-flip-atomic [333.362728] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [333.456737] [039/130] (738s left) syncobj_timeline (single-wait-for-submit-available-submitted) [333.503660] Starting subtest: single-wait-for-submit-available-submitted [333.506182] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [333.554104] [040/130] (738s left) kms_psr (psr2-primary-mmap-gtt) [333.636794] Starting subtest: psr2-primary-mmap-gtt [333.639120] Starting dynamic subtest: eDP-1 [335.136019] Dynamic subtest eDP-1: SKIP (1.498s) [335.141653] Subtest psr2-primary-mmap-gtt: SKIP (1.498s) [335.264208] [041/130] (736s left) gem_exec_reloc (basic-cpu-read) [335.323744] Subtest basic-cpu-read: SKIP (0.000s) [335.370901] [042/130] (736s left) vgem_basic (unload) [335.397253] Starting subtest: unload [364.377861] Subtest unload: SUCCESS (29.010s) [364.453322] [043/130] (707s left) kms_big_fb (y-tiled-addfb) [364.545681] Starting subtest: y-tiled-addfb [364.549845] Subtest y-tiled-addfb: SKIP (0.000s) [364.623738] [044/130] (707s left) kms_joiner (basic-big-joiner) [364.708331] Starting subtest: basic-big-joiner [364.712789] Subtest basic-big-joiner: SKIP (0.000s) [364.748909] [045/130] (707s left) gem_ctx_exec (basic) [364.790657] Starting subtest: basic [364.795238] Subtest basic: SUCCESS (0.006s) [364.892533] [046/130] (707s left) perf_pmu (most-busy-idle-check-all) [364.923640] Starting subtest: most-busy-idle-check-all [364.926023] Starting dynamic subtest: rcs0 [365.627350] Dynamic subtest rcs0: FAIL (0.639s) [365.636356] Starting dynamic subtest: bcs0 [366.713264] Dynamic subtest bcs0: SUCCESS (1.149s) [366.722521] Starting dynamic subtest: vcs0 [368.696862] Dynamic subtest vcs0: SUCCESS (1.982s) [368.707118] Starting dynamic subtest: vcs1 [370.680725] Dynamic subtest vcs1: SUCCESS (1.982s) [370.691017] Starting dynamic subtest: vecs0 [372.665071] Dynamic subtest vecs0: SUCCESS (1.983s) [372.674681] Starting dynamic subtest: ccs0 [374.712651] Dynamic subtest ccs0: SUCCESS (2.047s) [374.715597] Subtest most-busy-idle-check-all: FAIL (9.787s) [374.777121] [047/130] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [374.866986] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [374.871008] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [374.938300] [048/130] (697s left) kms_invalid_mode (uint-max-clock) [375.023194] Starting subtest: uint-max-clock [375.025544] Starting dynamic subtest: pipe-A-eDP-1 [375.303524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s) [375.312815] Starting dynamic subtest: pipe-B-eDP-1 [375.315460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [375.322403] Starting dynamic subtest: pipe-C-eDP-1 [375.325336] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [375.332701] Starting dynamic subtest: pipe-D-eDP-1 [375.335632] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [375.338264] Subtest uint-max-clock: SUCCESS (0.284s) [376.221246] [049/130] (696s left) gem_exec_reloc (basic-cpu-read-noreloc) [376.268319] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [376.311012] [050/130] (696s left) gem_exec_balancer (individual) [376.359537] Starting subtest: individual [377.670327] Subtest individual: SUCCESS (1.309s) [377.925061] [051/130] (694s left) gem_lmem_swapping (parallel-random-verify-ccs) [377.960223] Subtest parallel-random-verify-ccs: SKIP (0.000s) [377.973222] [052/130] (694s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [378.045024] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [378.047557] Starting dynamic subtest: pipe-A-eDP-1 [378.074478] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [378.081095] Starting dynamic subtest: pipe-B-eDP-1 [378.105070] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [378.111172] Starting dynamic subtest: pipe-C-eDP-1 [378.135264] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [378.141867] Starting dynamic subtest: pipe-D-eDP-1 [378.166204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [378.170638] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [380.386427] [053/130] (692s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [380.482744] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [380.487529] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [380.545742] [054/130] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [380.644758] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [380.649246] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [380.718322] [055/130] (691s left) gem_mmap_offset (partial-unmap) [380.763878] Starting subtest: partial-unmap [380.766720] Starting dynamic subtest: smem0 [381.269637] Dynamic subtest smem0: SUCCESS (0.505s) [381.272484] Subtest partial-unmap: SUCCESS (0.505s) [381.336007] [056/130] (691s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [381.434822] Starting subtest: fbc-2p-pri-indfb-multidraw [381.439053] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [381.521873] [057/130] (690s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [381.619854] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [386.701911] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.089s) [386.815221] [058/130] (685s left) gem_exec_schedule (preempt-queue-contexts) [386.880266] Subtest preempt-queue-contexts: SKIP (0.000s) [387.136932] [059/130] (685s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [387.510480] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [388.359248] [060/130] (684s left) gem_exec_schedule (implicit-boths) [388.424826] Starting subtest: implicit-boths [388.426866] Starting dynamic subtest: rcs0 [388.505413] Dynamic subtest rcs0: SUCCESS (0.092s) [388.515303] Starting dynamic subtest: vcs0 [388.589970] Dynamic subtest vcs0: SUCCESS (0.084s) [388.601649] Starting dynamic subtest: vcs1 [388.657605] Dynamic subtest vcs1: SUCCESS (0.068s) [388.671006] Starting dynamic subtest: vecs0 [388.722495] Dynamic subtest vecs0: SUCCESS (0.064s) [388.732656] Starting dynamic subtest: ccs0 [388.790993] Dynamic subtest ccs0: SUCCESS (0.068s) [388.794003] Subtest implicit-boths: SUCCESS (0.378s) [389.776440] [061/130] (682s left) kms_cursor_crc (cursor-random-128x128) [389.931647] Starting subtest: cursor-random-128x128 [389.936349] Starting dynamic subtest: pipe-A-eDP-1 [393.222127] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.286s) [393.245261] Starting dynamic subtest: pipe-D-eDP-1 [397.297785] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.061s) [397.300429] Subtest cursor-random-128x128: SUCCESS (7.366s) [398.165361] [062/130] (674s left) kms_sequence (get-busy) [398.259838] Starting subtest: get-busy [398.262125] Starting dynamic subtest: pipe-A-eDP-1 [400.157988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.896s) [400.167922] Starting dynamic subtest: pipe-B-eDP-1 [402.822986] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.664s) [402.830658] Starting dynamic subtest: pipe-C-eDP-1 [405.506526] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.685s) [405.515262] Starting dynamic subtest: pipe-D-eDP-1 [408.199004] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.691s) [408.201469] Subtest get-busy: SUCCESS (9.939s) [409.114442] [063/130] (663s left) kms_big_fb (x-tiled-8bpp-rotate-90) [409.219755] Starting subtest: x-tiled-8bpp-rotate-90 [409.240171] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s) [409.344412] [064/130] (663s left) gem_create (hog-create) [409.396130] Starting subtest: hog-create [409.398443] Starting dynamic subtest: smem0 [442.702413] Dynamic subtest smem0: SUCCESS (33.305s) [442.704876] Subtest hog-create: SUCCESS (33.306s) [442.868161] [065/130] (629s left) syncobj_wait (invalid-reset-zero-handles) [442.911798] Starting subtest: invalid-reset-zero-handles [442.914008] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [442.978196] [066/130] (629s left) kms_color (ctm-0-50) [443.065754] Starting subtest: ctm-0-50 [443.068064] Starting dynamic subtest: pipe-A-eDP-1 [446.514854] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s) [446.524085] Starting dynamic subtest: pipe-B-eDP-1 [450.721588] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.205s) [450.729005] Starting dynamic subtest: pipe-C-eDP-1 [454.757039] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.037s) [454.766714] Starting dynamic subtest: pipe-D-eDP-1 [458.804214] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.045s) [458.806637] Subtest ctm-0-50: SUCCESS (15.733s) [459.674716] [067/130] (612s left) kms_plane_scaling (invalid-parameters) [459.766010] Starting subtest: invalid-parameters [459.768368] Starting dynamic subtest: less-than-1-height-src [459.773999] Dynamic subtest less-than-1-height-src: SUCCESS (0.008s) [459.782039] Starting dynamic subtest: less-than-1-width-src [459.783984] Dynamic subtest less-than-1-width-src: SUCCESS (0.008s) [459.785967] Subtest invalid-parameters: SUCCESS (0.016s) [459.846290] [068/130] (612s left) api_intel_bb (simple-bb) [459.894860] Starting subtest: simple-bb [459.899396] Subtest simple-bb: SUCCESS (0.005s) [460.001849] [069/130] (612s left) prime_vgem (fence-flip-hang) [460.075208] Subtest fence-flip-hang: SKIP (0.000s) [460.154072] [070/130] (612s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [460.249741] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [465.127922] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.880s) [465.203483] [071/130] (607s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [465.318032] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [465.323247] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [465.407362] [072/130] (607s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [465.774986] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [466.631994] [073/130] (606s left) gem_gtt_cpu_tlb [466.705159] [074/130] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [466.801194] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [466.805531] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [466.867018] [075/130] (605s left) gem_softpin (evict-prime) [466.907138] Starting subtest: evict-prime [466.909375] Starting dynamic subtest: rcs0 [468.071902] Dynamic subtest rcs0: SUCCESS (1.164s) [468.083323] Starting dynamic subtest: bcs0 [469.198163] Dynamic subtest bcs0: SUCCESS (1.125s) [469.209127] Starting dynamic subtest: vcs0 [470.727665] Dynamic subtest vcs0: SUCCESS (1.527s) [470.738409] Starting dynamic subtest: vcs1 [472.718854] Dynamic subtest vcs1: SUCCESS (1.990s) [472.728241] Starting dynamic subtest: vecs0 [474.695222] Dynamic subtest vecs0: SUCCESS (1.976s) [474.704872] Starting dynamic subtest: ccs0 [475.830888] Dynamic subtest ccs0: SUCCESS (1.136s) [475.841563] Starting dynamic subtest: all [477.682670] Dynamic subtest all: SUCCESS (1.849s) [477.685422] Subtest evict-prime: SUCCESS (10.775s) [477.740933] [076/130] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [477.839399] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [477.843871] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [477.907974] [077/130] (594s left) kms_cursor_crc (cursor-offscreen-256x256) [478.097676] Starting subtest: cursor-offscreen-256x256 [478.104909] Starting dynamic subtest: pipe-A-eDP-1 [480.009527] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.905s) [480.027879] Starting dynamic subtest: pipe-D-eDP-1 [482.704927] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.681s) [482.707775] Subtest cursor-offscreen-256x256: SUCCESS (4.605s) [483.566263] [078/130] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [483.661607] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [483.665790] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [483.721587] [079/130] (589s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [483.812216] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [488.555129] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.747s) [488.645530] [080/130] (584s left) gem_exec_whisper (basic-contexts-priority) [488.706304] Starting subtest: basic-contexts-priority [512.041139] Subtest basic-contexts-priority: SUCCESS (23.337s) [512.199931] [081/130] (560s left) dmabuf (all-tests) [512.229592] Starting subtest: all-tests [512.231999] Starting dynamic subtest: sanitycheck [512.352847] Dynamic subtest sanitycheck: SUCCESS (0.125s) [512.363599] Starting dynamic subtest: dma_fence [512.584268] Dynamic subtest dma_fence: SUCCESS (0.230s) [512.594093] Starting dynamic subtest: dma_fence_chain [520.859692] Dynamic subtest dma_fence_chain: SUCCESS (8.276s) [520.869806] Starting dynamic subtest: dma_fence_unwrap [520.924462] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s) [520.934660] Starting dynamic subtest: dma_resv [521.001377] Dynamic subtest dma_resv: SUCCESS (0.076s) [521.004460] Subtest all-tests: SUCCESS (8.776s) [521.046876] [082/130] (551s left) kms_psr (fbc-psr-cursor-mmap-gtt) [521.120914] Starting subtest: fbc-psr-cursor-mmap-gtt [521.123409] Starting dynamic subtest: eDP-1 [521.127862] Dynamic subtest eDP-1: SKIP (0.000s) [521.132086] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [521.168887] [083/130] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [521.222922] Starting subtest: etime-multi-wait-all-for-submit-submitted [521.323739] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s) [521.377455] [084/130] (551s left) gem_ctx_sseu (mmap-args) [521.426978] Subtest mmap-args: SKIP (0.000s) [521.461946] [085/130] (551s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [521.539780] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [521.542153] Starting dynamic subtest: pipe-A-eDP-1 [521.938649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s) [521.947508] Starting dynamic subtest: pipe-B-eDP-1 [523.385652] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s) [523.394474] Starting dynamic subtest: pipe-C-eDP-1 [524.826561] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.438s) [524.835705] Starting dynamic subtest: pipe-D-eDP-1 [526.227168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s) [526.229383] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.659s) [527.449964] [086/130] (545s left) i915_pm_sseu (full-enable) [527.504819] Subtest full-enable: SKIP (0.000s) [527.582656] [087/130] (545s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [527.661873] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [527.664185] Starting dynamic subtest: pipe-A-default-mode [527.948683] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [527.953994] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.283s) [528.863356] [088/130] (544s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [528.918127] Starting subtest: yf-tiled-ccs-to-yf-tiled [528.922792] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [529.075542] [089/130] (543s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [529.173052] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [529.177714] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [529.241278] [090/130] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [529.334521] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [529.339244] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [529.403253] [091/130] (543s left) perf_pmu (busy-accuracy-50) [529.434884] Starting subtest: busy-accuracy-50 [529.437268] Starting dynamic subtest: rcs0 [530.965989] Dynamic subtest rcs0: SUCCESS (1.528s) [530.975927] Starting dynamic subtest: bcs0 [532.498013] Dynamic subtest bcs0: SUCCESS (1.532s) [532.507758] Starting dynamic subtest: vcs0 [534.040849] Dynamic subtest vcs0: SUCCESS (1.542s) [534.049876] Starting dynamic subtest: vcs1 [535.582257] Dynamic subtest vcs1: SUCCESS (1.540s) [535.592054] Starting dynamic subtest: vecs0 [537.122974] Dynamic subtest vecs0: SUCCESS (1.540s) [537.130574] Starting dynamic subtest: ccs0 [538.662602] Dynamic subtest ccs0: SUCCESS (1.539s) [538.664621] Subtest busy-accuracy-50: SUCCESS (9.228s) [538.754134] [092/130] (534s left) kms_cursor_edge_walk (128x128-top-edge) [538.841767] Starting subtest: 128x128-top-edge [538.844164] Starting dynamic subtest: pipe-A-eDP-1 [542.342406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s) [542.352124] Starting dynamic subtest: pipe-D-eDP-1 [545.578037] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.233s) [545.581432] Subtest 128x128-top-edge: SUCCESS (6.735s) [546.460197] [093/130] (526s left) syncobj_wait (multi-wait-for-submit-signaled) [546.506048] Starting subtest: multi-wait-for-submit-signaled [546.508537] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [546.560138] [094/130] (526s left) gem_ctx_persistence (userptr) [546.607859] Starting subtest: userptr [546.748337] Subtest userptr: SUCCESS (0.141s) [546.834500] [095/130] (526s left) gem_exec_fair (basic-pace) [546.903179] Subtest basic-pace: SKIP (0.000s) [546.934989] [096/130] (526s left) gem_ctx_isolation (nonpriv-switch) [546.985697] Starting subtest: nonpriv-switch [546.988192] Starting dynamic subtest: rcs0 [547.193351] Dynamic subtest rcs0: SUCCESS (0.207s) [547.202844] Starting dynamic subtest: bcs0 [547.448890] Dynamic subtest bcs0: SUCCESS (0.256s) [547.458494] Starting dynamic subtest: vcs0 [547.676470] Dynamic subtest vcs0: SUCCESS (0.227s) [547.684519] Starting dynamic subtest: vcs1 [548.844725] Dynamic subtest vcs1: SUCCESS (1.164s) [548.852882] Starting dynamic subtest: vecs0 [550.962875] Dynamic subtest vecs0: SUCCESS (2.121s) [550.971813] Starting dynamic subtest: ccs0 [552.982641] Dynamic subtest ccs0: SUCCESS (2.021s) [552.984820] Subtest nonpriv-switch: SUCCESS (5.999s) [553.203102] [097/130] (519s left) syncobj_basic (illegal-fd-to-handle) [553.265791] Starting subtest: illegal-fd-to-handle [553.268315] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [553.345813] [098/130] (519s left) gen9_exec_parse (basic-rejected) [553.397848] Subtest basic-rejected: SKIP (0.000s) [553.445840] [099/130] (519s left) gen9_exec_parse (bb-start-param) [553.500718] Subtest bb-start-param: SKIP (0.000s) [553.548271] [100/130] (519s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [553.642685] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [553.647213] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [553.713059] [101/130] (519s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render) [553.807982] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render [558.322246] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.518s) [558.433431] [102/130] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [558.524876] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [558.529059] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [558.582795] [103/130] (514s left) vgem_basic (busy-fence) [558.617768] Starting subtest: busy-fence [558.620686] Subtest busy-fence: SUCCESS (0.000s) [558.652186] [104/130] (514s left) gem_exec_whisper (basic-forked) [558.712391] Starting subtest: basic-forked [565.599015] Subtest basic-forked: SUCCESS (6.886s) [565.759581] [105/130] (507s left) kms_psr (fbc-pr-sprite-plane-move) [565.848817] Starting subtest: fbc-pr-sprite-plane-move [565.853256] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [565.901534] [106/130] (507s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [566.000197] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [571.844699] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.845s) [571.958273] [107/130] (501s left) kms_big_fb (y-tiled-32bpp-rotate-270) [572.057933] Starting subtest: y-tiled-32bpp-rotate-270 [572.062158] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [572.120874] [108/130] (501s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [572.210852] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [572.213206] Starting dynamic subtest: pipe-A-default-mode [572.513859] Dynamic subtest pipe-A-default-mode: SKIP (0.299s) [572.518212] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.300s) [573.358098] [109/130] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [573.457473] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [573.461998] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [573.527020] [110/130] (499s left) api_intel_allocator (execbuf-with-allocator) [573.581625] Starting subtest: execbuf-with-allocator [573.583788] Subtest execbuf-with-allocator: SUCCESS (0.005s) [573.675962] [111/130] (499s left) gem_linear_blits (normal) [573.846365] Starting subtest: normal [576.079885] Subtest normal: SUCCESS (2.232s) [576.222327] [112/130] (497s left) gem_eio (in-flight-contexts-10ms) [576.470376] Starting subtest: in-flight-contexts-10ms [589.697408] Subtest in-flight-contexts-10ms: SUCCESS (13.224s) [589.852575] [113/130] (483s left) gem_mmap_gtt (basic-small-copy) [589.909868] Subtest basic-small-copy: SKIP (0.000s) [589.949374] [114/130] (483s left) kms_pm_dc (dc5-psr) [590.035902] Starting subtest: dc5-psr [593.491441] Subtest dc5-psr: SUCCESS (3.452s) [594.397316] [115/130] (479s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [594.500054] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [595.179757] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s) [595.306628] [116/130] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [595.403577] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [595.407714] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [595.465791] [117/130] (477s left) syncobj_timeline (invalid-wait-bad-flags) [595.510803] Starting subtest: invalid-wait-bad-flags [595.513102] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [595.562137] [118/130] (477s left) kms_dp_linktrain_fallback (dp-fallback) [595.647773] Starting subtest: dp-fallback [595.654391] Subtest dp-fallback: SKIP (0.000s) [595.696766] [119/130] (477s left) kms_fbcon_fbt (fbc-suspend) [595.745920] Starting subtest: fbc-suspend [640.505143] Abort requested by /sbin/init [1] via Terminated, terminating children [640.509789] Abort requested by /sbin/init [1] via Hangup, terminating children [640.509827] Exiting gracefully, currently running test will have a 'notrun' result [640.551486] Closing watchdogs Done.