[57.365234] Initializing watchdogs [57.365325] /dev/watchdog0 [57.378725] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.383037] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.385206] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.388521] [001/133] (960s left) gen9_exec_parse (bb-start-out) [57.475199] Subtest bb-start-out: SKIP (0.000s) [57.535228] [002/133] (960s left) i915_pm_rps (min-max-config-loaded) [57.600900] Starting subtest: min-max-config-loaded [57.605681] Subtest min-max-config-loaded: SKIP (0.002s) [57.673350] [003/133] (960s left) kms_sequence (get-busy) [57.770848] Starting subtest: get-busy [57.773242] Starting dynamic subtest: pipe-A-eDP-1 [59.731049] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.958s) [59.738740] Starting dynamic subtest: pipe-B-eDP-1 [62.370073] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.639s) [62.378085] Starting dynamic subtest: pipe-C-eDP-1 [64.997617] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.627s) [65.005571] Starting dynamic subtest: pipe-D-eDP-1 [67.611371] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s) [67.613924] Subtest get-busy: SUCCESS (9.841s) [68.403687] [004/133] (949s left) kms_cursor_crc (cursor-suspend) [68.535062] Starting subtest: cursor-suspend [68.537513] Starting dynamic subtest: pipe-A-eDP-1 [101.848070] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.244s) [101.857685] Starting dynamic subtest: pipe-D-eDP-1 [135.845753] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.717s) [135.848322] Subtest cursor-suspend: SUCCESS (6.963s) [136.680383] [005/133] (881s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [136.790588] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [137.614917] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s) [137.805930] [006/133] (880s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [137.913117] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [138.869571] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.957s) [138.990477] [007/133] (879s left) kms_color (ctm-green-to-red) [139.081402] Starting subtest: ctm-green-to-red [139.083345] Starting dynamic subtest: pipe-A-eDP-1 [139.758865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.677s) [139.768139] Starting dynamic subtest: pipe-B-eDP-1 [141.174207] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s) [141.182066] Starting dynamic subtest: pipe-C-eDP-1 [142.527903] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s) [142.536446] Starting dynamic subtest: pipe-D-eDP-1 [143.869772] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s) [143.872404] Subtest ctm-green-to-red: SUCCESS (4.788s) [144.692564] [008/133] (873s left) gem_tiled_pread_basic (basic) [144.751653] Subtest basic: SKIP (0.000s) [144.809306] [009/133] (873s left) kms_flip (flip-vs-rmfb) [144.906555] Starting subtest: flip-vs-rmfb [144.908746] Starting dynamic subtest: A-eDP1 [153.583781] Dynamic subtest A-eDP1: SUCCESS (8.679s) [153.593084] Starting dynamic subtest: B-eDP1 [162.215353] Dynamic subtest B-eDP1: SUCCESS (8.629s) [162.228665] Starting dynamic subtest: C-eDP1 [170.878914] Dynamic subtest C-eDP1: SUCCESS (8.661s) [170.891760] Starting dynamic subtest: D-eDP1 [179.611025] Dynamic subtest D-eDP1: SUCCESS (8.729s) [179.615732] Subtest flip-vs-rmfb: SUCCESS (34.713s) [180.783597] [010/133] (837s left) kms_pm_dc (dc5-psr) [181.880397] Starting subtest: dc5-psr [184.765762] Subtest dc5-psr: SUCCESS (2.885s) [185.594857] [011/133] (832s left) gem_exec_flush (basic-batch-kernel-default-cmd) [185.654151] Starting subtest: basic-batch-kernel-default-cmd [185.658728] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [185.833113] [012/133] (832s left) gem_tiled_pread_pwrite [185.963363] [013/133] (832s left) kms_flip (plain-flip-fb-recreate) [186.059583] Starting subtest: plain-flip-fb-recreate [186.061898] Starting dynamic subtest: A-eDP1 [194.888236] Dynamic subtest A-eDP1: SUCCESS (8.831s) [194.899878] Starting dynamic subtest: B-eDP1 [203.722404] Dynamic subtest B-eDP1: SUCCESS (8.832s) [203.733959] Starting dynamic subtest: C-eDP1 [212.552729] Dynamic subtest C-eDP1: SUCCESS (8.828s) [212.563397] Starting dynamic subtest: D-eDP1 [221.388218] Dynamic subtest D-eDP1: SUCCESS (8.833s) [221.392346] Subtest plain-flip-fb-recreate: SUCCESS (35.336s) [222.578748] [014/133] (795s left) vgem_basic (unload) [222.616050] Starting subtest: unload [251.693735] Subtest unload: SUCCESS (29.079s) [251.789613] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true [251.793190] [015/133] (766s left) kms_plane (plane-panning-bottom-right) [251.900174] Starting subtest: plane-panning-bottom-right [251.902408] Starting dynamic subtest: pipe-A [253.570431] Dynamic subtest pipe-A: SUCCESS (1.668s) [253.578878] Starting dynamic subtest: pipe-B [255.910800] Dynamic subtest pipe-B: SUCCESS (2.339s) [255.913034] Subtest plane-panning-bottom-right: SUCCESS (4.010s) [256.725285] [016/133] (761s left) kms_setmode (invalid-clone-single-crtc) [256.779955] Starting subtest: invalid-clone-single-crtc [256.786379] Subtest invalid-clone-single-crtc: SKIP (0.000s) [256.875922] [017/133] (761s left) gem_render_copy (y-tiled-ccs-to-linear) [256.932035] Starting subtest: y-tiled-ccs-to-linear [256.936491] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [257.117857] [018/133] (761s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [257.211587] Starting subtest: fbc-rgb565-draw-blt [261.399505] Subtest fbc-rgb565-draw-blt: SUCCESS (4.192s) [262.542091] [019/133] (756s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [262.636870] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [262.639105] Starting dynamic subtest: pipe-A-eDP-1 [262.695013] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [262.702412] Starting dynamic subtest: pipe-B-eDP-1 [262.756758] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [262.764741] Starting dynamic subtest: pipe-C-eDP-1 [262.818685] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [262.826392] Starting dynamic subtest: pipe-D-eDP-1 [262.882421] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [262.887052] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [264.902933] [020/133] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [265.002355] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [265.006546] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [265.100521] [021/133] (753s left) kms_vblank (query-idle-hang) [265.192687] Starting subtest: query-idle-hang [265.194829] Starting dynamic subtest: pipe-A-eDP-1 [293.006910] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.811s) [293.020538] Starting dynamic subtest: pipe-D-eDP-1 [307.979767] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s) [307.982071] Subtest query-idle-hang: SUCCESS (42.789s) [308.855133] [022/133] (709s left) kms_plane_lowres (tiling-yf) [308.950551] Starting subtest: tiling-yf [308.954525] Subtest tiling-yf: SKIP (0.000s) [309.023675] [023/133] (709s left) gem_pxp (hw-rejects-pxp-buffer) [309.148029] Starting subtest: hw-rejects-pxp-buffer [309.152765] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [309.274404] [024/133] (709s left) syncobj_wait (reset-multiple-signaled) [309.329919] Starting subtest: reset-multiple-signaled [309.332345] Subtest reset-multiple-signaled: SUCCESS (0.000s) [309.448562] [025/133] (709s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [309.500247] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [309.605793] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s) [309.714543] [026/133] (709s left) kms_flip (2x-nonexisting-fb) [309.826678] Starting subtest: 2x-nonexisting-fb [309.837681] Subtest 2x-nonexisting-fb: SKIP (0.010s) [309.917409] [027/133] (709s left) gem_exec_reloc (basic-range) [309.972611] Subtest basic-range: SKIP (0.000s) [310.037035] [028/133] (708s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [310.119439] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [310.123447] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [310.203550] [029/133] (708s left) kms_hdr (brightness-with-hdr) [310.283742] Starting subtest: brightness-with-hdr [310.290436] Subtest brightness-with-hdr: SKIP (0.000s) [310.358420] [030/133] (708s left) gem_mmap_gtt (close-race) [310.424684] Subtest close-race: SKIP (0.000s) [310.492099] [031/133] (708s left) gem_exec_flush (basic-batch-kernel-default-uc) [310.559042] Starting subtest: basic-batch-kernel-default-uc [317.756374] Subtest basic-batch-kernel-default-uc: SUCCESS (7.198s) [317.957061] [032/133] (701s left) perf_pmu (gt-awake) [318.000370] Starting subtest: gt-awake [326.291791] Subtest gt-awake: SUCCESS (8.290s) [326.400869] [033/133] (692s left) perf_pmu (busy-check-all) [326.450203] Starting subtest: busy-check-all [326.452200] Starting dynamic subtest: rcs0 [327.014928] Dynamic subtest rcs0: SUCCESS (0.567s) [327.025547] Starting dynamic subtest: bcs0 [327.567588] Dynamic subtest bcs0: SUCCESS (0.550s) [327.578768] Starting dynamic subtest: vcs0 [329.233958] Dynamic subtest vcs0: SUCCESS (1.662s) [329.245456] Starting dynamic subtest: vcs1 [331.281726] Dynamic subtest vcs1: SUCCESS (2.045s) [331.293202] Starting dynamic subtest: vecs0 [333.265873] Dynamic subtest vecs0: SUCCESS (1.981s) [333.277311] Starting dynamic subtest: ccs0 [333.820517] Dynamic subtest ccs0: SUCCESS (0.554s) [333.823075] Subtest busy-check-all: SUCCESS (7.374s) [333.913092] [034/133] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [334.010390] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [334.014551] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [334.106355] [035/133] (685s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [334.197327] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [334.201675] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s) [334.272835] [036/133] (685s left) gem_mmap_offset (perf) [334.329425] Starting subtest: perf [334.331575] Starting dynamic subtest: smem0 [334.690821] Dynamic subtest smem0: SUCCESS (0.361s) [334.692938] Subtest perf: SUCCESS (0.361s) [334.795604] [037/133] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [334.880393] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [342.164709] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.286s) [342.289094] [038/133] (677s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [342.345806] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [342.348179] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [342.455547] [039/133] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [342.570205] Starting subtest: fbc-1p-primscrn-cur-indfb-move [346.651005] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.081s) [347.838050] [040/133] (671s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [347.922212] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [347.924697] Starting dynamic subtest: pipe-A-eDP-1 [347.951179] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [347.962125] Starting dynamic subtest: pipe-B-eDP-1 [347.986635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [347.996024] Starting dynamic subtest: pipe-C-eDP-1 [348.020052] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [348.028504] Starting dynamic subtest: pipe-D-eDP-1 [348.053438] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [348.057475] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [350.182641] [041/133] (669s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [350.279428] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [351.379620] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.100s) [351.501344] [042/133] (668s left) kms_properties (get_properties-sanity-atomic) [351.593819] Starting subtest: get_properties-sanity-atomic [351.598298] Subtest get_properties-sanity-atomic: SUCCESS (0.006s) [351.681322] [043/133] (667s left) kms_chamelium_hpd (hdmi-hpd) [352.072458] Subtest hdmi-hpd: SKIP (0.000s) [352.888303] [044/133] (666s left) kms_psr (fbc-pr-sprite-render) [352.991524] Starting subtest: fbc-pr-sprite-render [352.996036] Subtest fbc-pr-sprite-render: SKIP (0.000s) [353.064181] [045/133] (666s left) gem_gpgpu_fill (offset-16x16) [353.132472] Starting subtest: offset-16x16 [353.138014] Subtest offset-16x16: SUCCESS (0.007s) [353.284055] [046/133] (666s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [353.383564] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [353.387749] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [353.478455] [047/133] (666s left) gem_ctx_persistence (process) [353.538629] Starting subtest: process [353.715224] Subtest process: SUCCESS (0.176s) [353.795389] [048/133] (665s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [353.907763] Starting subtest: cursorB-vs-flipB-atomic [353.911487] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [354.050169] [049/133] (665s left) kms_content_protection (atomic-hdcp14) [354.193847] Starting subtest: atomic-hdcp14 [354.197630] Subtest atomic-hdcp14: SKIP (0.000s) [354.326099] [050/133] (665s left) syncobj_timeline (invalid-wait-bad-flags) [354.383279] Starting subtest: invalid-wait-bad-flags [354.385337] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [354.479307] [051/133] (665s left) perf (invalid-oa-metric-set-id) [354.606889] Starting subtest: invalid-oa-metric-set-id [354.623593] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s) [354.661203] [052/133] (665s left) gem_exec_schedule (preemptive-hang) [354.844905] Starting subtest: preemptive-hang [354.847195] Starting dynamic subtest: rcs0 [364.347216] Dynamic subtest rcs0: SUCCESS (9.499s) [364.363779] Starting dynamic subtest: bcs0 [373.369705] Dynamic subtest bcs0: SUCCESS (9.023s) [373.380193] Starting dynamic subtest: vcs0 [382.398023] Dynamic subtest vcs0: SUCCESS (9.025s) [382.412589] Starting dynamic subtest: vcs1 [391.357150] Dynamic subtest vcs1: SUCCESS (8.958s) [391.365408] Starting dynamic subtest: vecs0 [400.373101] Dynamic subtest vecs0: SUCCESS (9.013s) [400.381319] Starting dynamic subtest: ccs0 [409.405082] Dynamic subtest ccs0: SUCCESS (9.030s) [409.407578] Subtest preemptive-hang: SUCCESS (54.557s) [409.638120] [053/133] (610s left) gem_exec_parallel (basic) [409.709035] Starting subtest: basic [409.711329] Starting dynamic subtest: rcs0 [411.227115] Dynamic subtest rcs0: SUCCESS (1.518s) [411.236543] Starting dynamic subtest: bcs0 [412.725066] Dynamic subtest bcs0: SUCCESS (1.496s) [412.734928] Starting dynamic subtest: vcs0 [414.252456] Dynamic subtest vcs0: SUCCESS (1.524s) [414.260848] Starting dynamic subtest: vcs1 [416.208726] Dynamic subtest vcs1: SUCCESS (1.953s) [416.218385] Starting dynamic subtest: vecs0 [418.255919] Dynamic subtest vecs0: SUCCESS (2.045s) [418.267592] Starting dynamic subtest: ccs0 [419.734069] Dynamic subtest ccs0: SUCCESS (1.477s) [419.736484] Subtest basic: SUCCESS (10.025s) [419.933680] [054/133] (600s left) gem_exec_params (invalid-fence-in-submit) [419.999928] Starting subtest: invalid-fence-in-submit [420.007777] Subtest invalid-fence-in-submit: SUCCESS (0.008s) [420.125386] [055/133] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [420.216555] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [420.220400] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [420.319763] [056/133] (599s left) gem_fenced_exec_thrash (too-many-fences) [420.380229] Subtest too-many-fences: SKIP (0.000s) [420.455752] [057/133] (599s left) core_hotunplug (unbind-rebind) [420.541042] Starting subtest: unbind-rebind [426.520438] Subtest unbind-rebind: SUCCESS (5.980s) [426.558346] [058/133] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [428.262549] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [428.266921] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [428.377417] [059/133] (591s left) gem_exec_params (cliprects-invalid) [428.441648] Starting subtest: cliprects-invalid [428.443956] Subtest cliprects-invalid: SUCCESS (0.000s) [428.542619] [060/133] (591s left) gem_exec_schedule (preempt-self) [428.616656] Starting subtest: preempt-self [428.618473] Starting dynamic subtest: rcs0 [428.630117] Dynamic subtest rcs0: SUCCESS (0.020s) [428.642344] Starting dynamic subtest: bcs0 [428.647226] Dynamic subtest bcs0: SUCCESS (0.015s) [428.656841] Starting dynamic subtest: vcs0 [428.662367] Dynamic subtest vcs0: SUCCESS (0.016s) [428.671502] Starting dynamic subtest: vcs1 [428.677716] Dynamic subtest vcs1: SUCCESS (0.015s) [428.686622] Starting dynamic subtest: vecs0 [428.701173] Dynamic subtest vecs0: SUCCESS (0.022s) [428.710887] Starting dynamic subtest: ccs0 [428.722786] Dynamic subtest ccs0: SUCCESS (0.021s) [428.725130] Subtest preempt-self: SUCCESS (0.113s) [430.386206] [061/133] (589s left) kms_scaling_modes (scaling-mode-full-aspect) [430.468731] Starting subtest: scaling-mode-full-aspect [430.470787] Starting dynamic subtest: pipe-A-eDP-1 [430.583758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.117s) [430.595662] Starting dynamic subtest: pipe-B-eDP-1 [431.717760] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.132s) [431.726873] Starting dynamic subtest: pipe-C-eDP-1 [432.838179] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s) [432.847059] Starting dynamic subtest: pipe-D-eDP-1 [433.985612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s) [433.987760] Subtest scaling-mode-full-aspect: SUCCESS (3.520s) [435.135421] [062/133] (585s left) gem_ctx_shared (exec-single-timeline) [435.195404] Starting subtest: exec-single-timeline [435.197551] Starting dynamic subtest: rcs0 [436.269997] Dynamic subtest rcs0: SUCCESS (1.072s) [436.282333] Starting dynamic subtest: bcs0 [437.293151] Dynamic subtest bcs0: SUCCESS (1.020s) [437.306878] Starting dynamic subtest: vcs0 [438.320480] Dynamic subtest vcs0: SUCCESS (1.025s) [438.334152] Starting dynamic subtest: vcs1 [439.405854] Dynamic subtest vcs1: SUCCESS (1.082s) [439.417342] Starting dynamic subtest: vecs0 [440.494506] Dynamic subtest vecs0: SUCCESS (1.085s) [440.507250] Starting dynamic subtest: ccs0 [441.582751] Dynamic subtest ccs0: SUCCESS (1.084s) [441.585677] Subtest exec-single-timeline: SUCCESS (6.386s) [441.793727] [063/133] (578s left) kms_invalid_mode (zero-clock) [441.894695] Starting subtest: zero-clock [441.896891] Starting dynamic subtest: pipe-A-eDP-1 [442.175761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [442.185686] Starting dynamic subtest: pipe-B-eDP-1 [442.187904] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [442.199001] Starting dynamic subtest: pipe-C-eDP-1 [442.200946] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [442.209397] Starting dynamic subtest: pipe-D-eDP-1 [442.211336] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [442.213211] Subtest zero-clock: SUCCESS (0.290s) [442.979334] [064/133] (577s left) kms_prop_blob (blob-prop-core) [443.034489] Starting subtest: blob-prop-core [443.036423] Subtest blob-prop-core: SUCCESS (0.000s) [443.148576] [065/133] (577s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [443.207345] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [443.211379] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [443.398878] [066/133] (577s left) kms_psr (fbc-pr-primary-blt) [443.491387] Starting subtest: fbc-pr-primary-blt [443.495678] Subtest fbc-pr-primary-blt: SKIP (0.000s) [443.581467] [067/133] (576s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [443.671482] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [443.675397] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [443.776584] [068/133] (576s left) kms_flip (2x-flip-vs-rmfb-interruptible) [443.867321] Starting subtest: 2x-flip-vs-rmfb-interruptible [443.878207] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s) [443.967716] [069/133] (576s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [444.066942] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [451.177757] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.114s) [451.291747] [070/133] (569s left) syncobj_wait (reset-unsignaled) [451.353262] Starting subtest: reset-unsignaled [451.355537] Subtest reset-unsignaled: SUCCESS (0.000s) [451.464113] [071/133] (569s left) kms_psr (pr-cursor-mmap-gtt) [451.548305] Starting subtest: pr-cursor-mmap-gtt [451.552512] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [451.622443] [072/133] (569s left) kms_async_flips (test-time-stamp-atomic) [451.706438] Starting subtest: test-time-stamp-atomic [452.085362] Starting dynamic subtest: pipe-A-eDP-1 [452.908588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s) [453.289740] Starting dynamic subtest: pipe-B-eDP-1 [454.041210] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s) [454.432020] Starting dynamic subtest: pipe-C-eDP-1 [455.192629] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s) [455.557226] Starting dynamic subtest: pipe-D-eDP-1 [456.329381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s) [456.331680] Subtest test-time-stamp-atomic: SUCCESS (4.623s) [457.499353] [073/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [457.603985] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [457.608072] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [457.696718] [074/133] (563s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [457.786618] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [464.639251] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.856s) [464.742833] [075/133] (556s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [464.843227] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [464.847578] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [464.942287] [076/133] (556s left) kms_hdmi_inject (inject-4k) [465.282012] Starting subtest: inject-4k [465.597831] Subtest inject-4k: SUCCESS (0.318s) [466.203837] [077/133] (554s left) gem_eio (in-flight-10ms) [466.427419] Starting subtest: in-flight-10ms [474.968721] Subtest in-flight-10ms: SUCCESS (8.542s) [475.134216] [078/133] (545s left) gem_exec_fence (syncobj-export) [475.545105] Starting subtest: syncobj-export [475.547772] Subtest syncobj-export: SUCCESS (0.004s) [477.379780] [079/133] (543s left) gem_mmap_gtt (basic-read-write) [477.424695] Subtest basic-read-write: SKIP (0.000s) [477.486123] [080/133] (543s left) gem_fenced_exec_thrash (no-spare-fences) [477.546476] Subtest no-spare-fences: SKIP (0.000s) [477.616183] [081/133] (543s left) syncobj_wait (single-wait-all-for-submit-signaled) [477.669098] Starting subtest: single-wait-all-for-submit-signaled [477.671427] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [477.762287] [082/133] (543s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [477.854371] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [477.858509] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [477.941079] [083/133] (543s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [478.003661] Starting subtest: multi-wait-all-for-submit-signaled [478.005996] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [478.118068] [084/133] (543s left) gem_pxp (create-regular-context-1) [478.241734] Starting subtest: create-regular-context-1 [478.244061] Subtest create-regular-context-1: SUCCESS (0.002s) [478.343658] [085/133] (542s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [478.441303] Starting subtest: psr-rgb565-draw-render [485.422039] Subtest psr-rgb565-draw-render: SUCCESS (6.981s) [485.532245] [086/133] (535s left) kms_big_fb (y-tiled-32bpp-rotate-270) [485.643356] Starting subtest: y-tiled-32bpp-rotate-270 [485.647603] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [485.752441] [087/133] (535s left) i915_hangman (gt-engine-hang) [485.829991] Starting subtest: gt-engine-hang [485.831872] Starting dynamic subtest: rcs0 [487.216907] Dynamic subtest rcs0: SUCCESS (1.386s) [487.232147] Starting dynamic subtest: bcs0 [489.199067] Dynamic subtest bcs0: SUCCESS (1.979s) [489.211099] Starting dynamic subtest: vcs0 [491.247577] Dynamic subtest vcs0: SUCCESS (2.045s) [491.259901] Starting dynamic subtest: vcs1 [493.231266] Dynamic subtest vcs1: SUCCESS (1.981s) [493.246799] Starting dynamic subtest: vecs0 [495.151519] Dynamic subtest vecs0: SUCCESS (1.917s) [495.164418] Starting dynamic subtest: ccs0 [497.199602] Dynamic subtest ccs0: SUCCESS (2.045s) [497.202523] Subtest gt-engine-hang: SUCCESS (11.371s) [497.321710] [088/133] (524s left) syncobj_timeline (single-wait-all-available-submitted) [497.387275] Starting subtest: single-wait-all-available-submitted [497.389647] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [497.510284] [089/133] (523s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [497.608087] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [497.610368] Starting dynamic subtest: pipe-A-eDP-1 [497.632350] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [497.642629] Starting dynamic subtest: pipe-B-eDP-1 [497.662941] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [497.671573] Starting dynamic subtest: pipe-C-eDP-1 [497.692193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [497.701070] Starting dynamic subtest: pipe-D-eDP-1 [497.721791] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [497.726236] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s) [499.869881] [090/133] (521s left) sysfs_heartbeat_interval (idempotent) [499.928854] Starting subtest: idempotent [499.931136] Starting dynamic subtest: vecs0 [499.933363] Dynamic subtest vecs0: SUCCESS (0.001s) [499.944310] Starting dynamic subtest: ccs0 [499.946403] Dynamic subtest ccs0: SUCCESS (0.001s) [499.955338] Starting dynamic subtest: vcs0 [499.957494] Dynamic subtest vcs0: SUCCESS (0.000s) [499.967791] Starting dynamic subtest: bcs0 [499.969907] Dynamic subtest bcs0: SUCCESS (0.001s) [499.979291] Starting dynamic subtest: rcs0 [499.981166] Dynamic subtest rcs0: SUCCESS (0.000s) [499.989887] Starting dynamic subtest: vcs1 [499.991976] Dynamic subtest vcs1: SUCCESS (0.001s) [499.994054] Subtest idempotent: SUCCESS (0.008s) [500.078975] [091/133] (521s left) gem_softpin (allocator-basic-reserve) [500.139872] Starting subtest: allocator-basic-reserve [500.207084] Subtest allocator-basic-reserve: SUCCESS (0.068s) [500.321947] [092/133] (521s left) kms_cursor_crc (cursor-rapid-movement-512x170) [500.628527] Starting subtest: cursor-rapid-movement-512x170 [500.632917] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [500.784713] [093/133] (520s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [500.873358] Starting subtest: fbc-psr2-sprite-mmap-gtt [500.874958] Starting dynamic subtest: eDP-1 [500.878421] Dynamic subtest eDP-1: SKIP (0.000s) [500.881806] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s) [500.942766] [094/133] (520s left) gem_readwrite (read-write) [500.997762] Subtest read-write: SKIP (0.000s) [501.065755] [095/133] (520s left) gem_exec_reloc (basic-write-cpu-noreloc) [501.119895] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [501.176825] [096/133] (520s left) gem_exec_balancer (fairslice) [501.237346] Starting subtest: fairslice [504.155640] Subtest fairslice: SUCCESS (2.916s) [504.470417] [097/133] (517s left) api_intel_bb (object-reloc-keep-cache) [504.534768] Starting subtest: object-reloc-keep-cache [504.544650] Subtest object-reloc-keep-cache: SKIP (0.008s) [504.687459] [098/133] (517s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [504.797045] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [511.424687] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.629s) [511.553559] [099/133] (510s left) i915_pm_rps (thresholds-idle-park) [511.631785] Starting subtest: thresholds-idle-park [511.636351] Subtest thresholds-idle-park: SKIP (0.000s) [511.756760] [100/133] (510s left) gen9_exec_parse (unaligned-jump) [511.826603] Subtest unaligned-jump: SKIP (0.000s) [511.882810] [101/133] (510s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [511.977386] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [511.981454] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [512.054399] [102/133] (509s left) kms_flip (nonexisting-fb-interruptible) [512.158323] Starting subtest: nonexisting-fb-interruptible [512.160431] Starting dynamic subtest: A-eDP1 [513.316568] Dynamic subtest A-eDP1: SUCCESS (1.156s) [513.332863] Starting dynamic subtest: B-eDP1 [514.427486] Dynamic subtest B-eDP1: SUCCESS (1.108s) [514.447843] Starting dynamic subtest: C-eDP1 [515.610523] Dynamic subtest C-eDP1: SUCCESS (1.180s) [515.620425] Starting dynamic subtest: D-eDP1 [516.706963] Dynamic subtest D-eDP1: SUCCESS (1.095s) [516.712854] Subtest nonexisting-fb-interruptible: SUCCESS (4.555s) [517.968046] [103/133] (504s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [518.074452] Starting subtest: psr-rgb101010-draw-mmap-wc [524.997511] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.926s) [525.097978] [104/133] (497s left) gem_exec_balancer (parallel-out-fence) [525.360072] Starting subtest: parallel-out-fence [526.570568] Subtest parallel-out-fence: SUCCESS (1.213s) [526.671049] [105/133] (495s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [526.758448] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [526.760656] Starting dynamic subtest: pipe-A-eDP-1 [526.783555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [526.795374] Starting dynamic subtest: pipe-B-eDP-1 [526.816470] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [526.825904] Starting dynamic subtest: pipe-C-eDP-1 [526.847350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [526.858164] Starting dynamic subtest: pipe-D-eDP-1 [526.879947] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [526.883980] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [528.963061] [106/133] (493s left) gem_exec_params (invalid-bsd2-flag-on-render) [529.017495] Starting subtest: invalid-bsd2-flag-on-render [529.019734] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [529.113964] [107/133] (493s left) kms_pm_rpm (universal-planes-dpms) [531.459475] Starting subtest: universal-planes-dpms [531.462019] Starting dynamic subtest: plane-34 [539.799654] Dynamic subtest plane-34: SUCCESS (8.342s) [539.812523] Starting dynamic subtest: plane-64 [548.082044] Dynamic subtest plane-64: SUCCESS (8.279s) [548.095348] Starting dynamic subtest: plane-94 [556.381059] Dynamic subtest plane-94: SUCCESS (8.296s) [556.393710] Starting dynamic subtest: plane-124 [564.702239] Dynamic subtest plane-124: SUCCESS (8.318s) [564.714533] Starting dynamic subtest: plane-134 [572.978979] Dynamic subtest plane-134: SUCCESS (8.274s) [572.992117] Starting dynamic subtest: plane-144 [581.596007] Dynamic subtest plane-144: SUCCESS (8.614s) [581.598591] Subtest universal-planes-dpms: SUCCESS (50.140s) [581.956810] [108/133] (440s left) gem_exec_create (madvise) [582.014580] Starting subtest: madvise [582.016807] Starting dynamic subtest: smem [603.342875] Dynamic subtest smem: SUCCESS (21.323s) [603.346299] Subtest madvise: SUCCESS (21.324s) [604.175149] [109/133] (418s left) kms_psr (psr-basic) [604.269322] Starting subtest: psr-basic [604.271709] Starting dynamic subtest: eDP-1 [605.898793] Dynamic subtest eDP-1: SUCCESS (1.629s) [605.901102] Subtest psr-basic: SUCCESS (1.630s) [606.745231] [110/133] (415s left) kms_async_flips (alternate-sync-async-flip-atomic) [606.854451] Starting subtest: alternate-sync-async-flip-atomic [607.232008] Starting dynamic subtest: pipe-A-eDP-1 [610.008330] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.776s) [610.398673] Starting dynamic subtest: pipe-B-eDP-1 [613.195334] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.804s) [613.572797] Starting dynamic subtest: pipe-C-eDP-1 [616.406898] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.842s) [616.772594] Starting dynamic subtest: pipe-D-eDP-1 [619.608934] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.846s) [619.610932] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.757s) [620.848358] [111/133] (401s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [620.953569] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [620.955819] Starting dynamic subtest: pipe-A-eDP-1 [620.965092] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [620.979558] Starting dynamic subtest: pipe-B-eDP-1 [620.988172] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [620.997346] Starting dynamic subtest: pipe-C-eDP-1 [621.005892] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [621.014488] Starting dynamic subtest: pipe-D-eDP-1 [621.022837] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [621.026871] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s) [623.250441] [112/133] (399s left) kms_cursor_crc (cursor-onscreen-64x64) [623.462014] Starting subtest: cursor-onscreen-64x64 [623.467048] Starting dynamic subtest: pipe-A-eDP-1 [625.605822] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.139s) [625.634188] Starting dynamic subtest: pipe-D-eDP-1 [628.363937] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.738s) [628.366195] Subtest cursor-onscreen-64x64: SUCCESS (4.902s) [629.247397] [113/133] (393s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [629.346796] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [629.350991] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [629.448936] [114/133] (393s left) kms_chamelium_color (ctm-red-to-blue) [629.540332] Subtest ctm-red-to-blue: SKIP (0.000s) [629.585036] [115/133] (393s left) gem_workarounds (suspend-resume) [629.646642] Starting subtest: suspend-resume [645.366379] Subtest suspend-resume: SUCCESS (1.147s) [645.497920] [116/133] (377s left) kms_dp_link_training (non-uhbr-mst) [645.599824] Starting subtest: non-uhbr-mst [645.608635] Subtest non-uhbr-mst: SKIP (0.000s) [645.673570] [117/133] (376s left) syncobj_basic (bad-fd-to-handle) [645.735625] Starting subtest: bad-fd-to-handle [645.737926] Subtest bad-fd-to-handle: SUCCESS (0.000s) [645.839582] [118/133] (376s left) vgem_basic (setversion) [645.884285] Starting subtest: setversion [645.888803] Subtest setversion: SUCCESS (0.000s) [645.943951] [119/133] (376s left) kms_dsc (dsc-basic) [646.036275] Starting subtest: dsc-basic [646.049156] Subtest dsc-basic: SKIP (0.000s) [646.111610] [120/133] (376s left) kms_pipe_stress (stress-xrgb8888-4tiled) [646.202664] Starting subtest: stress-xrgb8888-4tiled [652.070973] Subtest stress-xrgb8888-4tiled: SUCCESS (5.863s) [652.126821] [121/133] (370s left) gem_ccs (block-copy-compressed) [652.184804] Starting subtest: block-copy-compressed [652.188248] Subtest block-copy-compressed: SKIP (0.000s) [652.280800] [122/133] (370s left) perf_pmu (semaphore-wait) [652.320383] Starting subtest: semaphore-wait [652.322360] Starting dynamic subtest: rcs0 [652.835112] Dynamic subtest rcs0: SUCCESS (0.513s) [652.848272] Starting dynamic subtest: bcs0 [653.347168] Dynamic subtest bcs0: SUCCESS (0.510s) [653.357809] Starting dynamic subtest: vcs0 [653.861968] Dynamic subtest vcs0: SUCCESS (0.511s) [653.873515] Starting dynamic subtest: vcs1 [654.375799] Dynamic subtest vcs1: SUCCESS (0.511s) [654.387101] Starting dynamic subtest: vecs0 [654.889706] Dynamic subtest vecs0: SUCCESS (0.511s) [654.902801] Starting dynamic subtest: ccs0 [655.406146] Dynamic subtest ccs0: SUCCESS (0.513s) [655.408984] Subtest semaphore-wait: SUCCESS (3.084s) [656.838190] [123/133] (366s left) sw_sync (sync_random_merge) [656.880444] Starting subtest: sync_random_merge [656.920378] Subtest sync_random_merge: SUCCESS (0.042s) [656.988577] [124/133] (365s left) kms_lease (cursor-implicit-plane) [657.085193] Starting subtest: cursor-implicit-plane [657.087412] Starting dynamic subtest: pipe-A-eDP-1 [657.543528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s) [657.553075] Starting dynamic subtest: pipe-B-eDP-1 [658.638011] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.093s) [658.648085] Starting dynamic subtest: pipe-C-eDP-1 [659.717172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.079s) [659.726469] Starting dynamic subtest: pipe-D-eDP-1 [660.803845] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.084s) [660.806083] Subtest cursor-implicit-plane: SUCCESS (3.718s) [661.639452] [125/133] (361s left) gem_ccs (large-ctrl-surf-copy) [661.696238] Starting subtest: large-ctrl-surf-copy [661.700303] Subtest large-ctrl-surf-copy: SKIP (0.000s) [661.790424] [126/133] (361s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [661.886243] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [661.888465] Starting dynamic subtest: pipe-A-eDP-1 [661.970863] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s) [661.980514] Starting dynamic subtest: pipe-B-eDP-1 [663.087111] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s) [663.091574] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.204s) [664.246461] [127/133] (358s left) kms_plane_scaling (planes-scaler-unity-scaling) [664.345256] Starting subtest: planes-scaler-unity-scaling [664.347498] Starting dynamic subtest: pipe-A [664.406889] Dynamic subtest pipe-A: SUCCESS (0.064s) [664.416558] Starting dynamic subtest: pipe-B [665.528352] Dynamic subtest pipe-B: SUCCESS (1.119s) [665.539205] Starting dynamic subtest: pipe-C [666.618164] Dynamic subtest pipe-C: SUCCESS (1.087s) [666.627455] Starting dynamic subtest: pipe-D [667.716017] Dynamic subtest pipe-D: SUCCESS (1.097s) [667.718388] Subtest planes-scaler-unity-scaling: SUCCESS (3.372s) [668.857256] [128/133] (354s left) gem_exec_whisper (basic-queues) [668.929115] Starting subtest: basic-queues [674.782825] Subtest basic-queues: SUCCESS (5.848s) [674.973184] [129/133] (348s left) kms_addfb_basic (no-handle) [675.018004] Starting subtest: no-handle [675.020224] Subtest no-handle: SUCCESS (0.000s) [675.153096] [130/133] (348s left) gem_ctx_isolation (preservation-s3) [675.215487] Starting subtest: preservation-S3 [675.217699] Starting dynamic subtest: rcs0 [691.416904] Dynamic subtest rcs0: SUCCESS (1.279s) [691.432657] Starting dynamic subtest: bcs0 [707.421534] Dynamic subtest bcs0: SUCCESS (1.317s) [707.431933] Starting dynamic subtest: vcs0 [723.414579] Dynamic subtest vcs0: SUCCESS (3.052s) [723.428340] Starting dynamic subtest: vcs1 [741.410216] Dynamic subtest vcs1: SUCCESS (5.062s) [741.419733] Starting dynamic subtest: vecs0 [759.409602] Dynamic subtest vecs0: SUCCESS (4.946s) [759.420938] Starting dynamic subtest: ccs0 [777.432894] Dynamic subtest ccs0: SUCCESS (3.177s) [777.435930] Subtest preservation-S3: SUCCESS (18.840s) [777.659814] [131/133] (245s left) api_intel_allocator (fork-simple-stress) [777.719085] Starting subtest: fork-simple-stress [783.121897] Subtest fork-simple-stress: SUCCESS (5.394s) [783.234745] [132/133] (240s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [783.336916] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [783.341717] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [783.452058] [133/133] (239s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [783.559831] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [783.564485] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [783.664323] Closing watchdogs results: parsing output: 0/ for test: gen9_exec_parse results: parsing output: 1/ for test: i915_pm_rps results: parsing output: 2/ for test: kms_sequence results: parsing output: 3/ for test: kms_cursor_crc results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_color results: parsing output: 7/ for test: gem_tiled_pread_basic results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: kms_pm_dc results: parsing output: 10/ for test: gem_exec_flush results: parsing output: 11/ for test: gem_tiled_pread_pwrite results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: vgem_basic results: parsing output: 14/ for test: kms_plane results: parsing output: 15/ for test: kms_setmode results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_ccs results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_vblank results: parsing output: 21/ for test: kms_plane_lowres results: parsing output: 22/ for test: gem_pxp results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: kms_plane results: parsing output: 28/ for test: kms_hdr results: parsing output: 29/ for test: gem_mmap_gtt results: parsing output: 30/ for test: gem_exec_flush results: parsing output: 31/ for test: perf_pmu results: parsing output: 32/ for test: perf_pmu results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_flip_scaled_crc results: parsing output: 35/ for test: gem_mmap_offset results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_ccs results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_properties results: parsing output: 42/ for test: kms_chamelium_hpd results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: gem_gpgpu_fill results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: gem_ctx_persistence results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_content_protection results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: gem_exec_schedule results: parsing output: 52/ for test: gem_exec_parallel results: parsing output: 53/ for test: gem_exec_params results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_fenced_exec_thrash results: parsing output: 56/ for test: core_hotunplug results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_exec_params results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: kms_scaling_modes results: parsing output: 61/ for test: gem_ctx_shared results: parsing output: 62/ for test: kms_invalid_mode results: parsing output: 63/ for test: kms_prop_blob results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_async_flips results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_hdmi_inject results: parsing output: 76/ for test: gem_eio results: parsing output: 77/ for test: gem_exec_fence results: parsing output: 78/ for test: gem_mmap_gtt results: parsing output: 79/ for test: gem_fenced_exec_thrash results: parsing output: 80/ for test: syncobj_wait results: parsing output: 81/ for test: kms_flip_scaled_crc results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_pxp results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: i915_hangman results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: sysfs_heartbeat_interval results: parsing output: 90/ for test: gem_softpin results: parsing output: 91/ for test: kms_cursor_crc results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: gem_readwrite results: parsing output: 94/ for test: gem_exec_reloc results: parsing output: 95/ for test: gem_exec_balancer results: parsing output: 96/ for test: api_intel_bb results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: i915_pm_rps results: parsing output: 99/ for test: gen9_exec_parse results: parsing output: 100/ for test: kms_flip_scaled_crc results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_exec_balancer results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: gem_exec_params results: parsing output: 106/ for test: kms_pm_rpm results: parsing output: 107/ for test: gem_exec_create results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: kms_async_flips results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: kms_cursor_crc results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_chamelium_color results: parsing output: 114/ for test: gem_workarounds results: parsing output: 115/ for test: kms_dp_link_training results: parsing output: 116/ for test: syncobj_basic results: parsing output: 117/ for test: vgem_basic results: parsing output: 118/ for test: kms_dsc results: parsing output: 119/ for test: kms_pipe_stress results: parsing output: 120/ for test: gem_ccs results: parsing output: 121/ for test: perf_pmu results: parsing output: 122/ for test: sw_sync results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: gem_ccs results: parsing output: 125/ for test: kms_psr2_sf results: parsing output: 126/ for test: kms_plane_scaling results: parsing output: 127/ for test: gem_exec_whisper results: parsing output: 128/ for test: kms_addfb_basic results: parsing output: 129/ for test: gem_ctx_isolation results: parsing output: 130/ for test: api_intel_allocator results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.