[56.935808] Initializing watchdogs [56.935908] /dev/watchdog0 [56.949421] [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] [56.953519] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.955803] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.959115] [001/129] (960s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [57.130941] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [57.133168] Starting dynamic subtest: pipe-A-eDP-1 [57.156431] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [57.165271] Starting dynamic subtest: pipe-B-eDP-1 [57.187261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [57.193748] Starting dynamic subtest: pipe-C-eDP-1 [57.216110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [57.223617] Starting dynamic subtest: pipe-D-eDP-1 [57.246709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [57.251024] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s) [59.264188] [002/129] (958s left) kms_flip (nonexisting-fb-interruptible) [59.367369] Starting subtest: nonexisting-fb-interruptible [59.369627] Starting dynamic subtest: A-eDP1 [60.556677] Dynamic subtest A-eDP1: SUCCESS (1.188s) [60.565126] Starting dynamic subtest: B-eDP1 [61.673390] Dynamic subtest B-eDP1: SUCCESS (1.118s) [61.681562] Starting dynamic subtest: C-eDP1 [62.801941] Dynamic subtest C-eDP1: SUCCESS (1.129s) [62.809913] Starting dynamic subtest: D-eDP1 [63.929967] Dynamic subtest D-eDP1: SUCCESS (1.129s) [63.932541] Subtest nonexisting-fb-interruptible: SUCCESS (4.569s) [65.085544] [003/129] (952s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [65.189628] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [65.202347] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s) [65.308356] [004/129] (952s left) core_getstats [65.456887] [005/129] (952s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [65.564952] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [65.569500] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [65.662737] [006/129] (951s left) kms_hdr (static-swap) [65.764806] Starting subtest: static-swap [65.771203] Subtest static-swap: SKIP (0.000s) [65.828629] [007/129] (951s left) gem_eio (banned) [65.987129] Starting subtest: banned [66.385327] Subtest banned: SUCCESS (0.400s) [66.551743] [008/129] (951s left) gem_exec_balancer (bonded-sync) [66.622093] Starting subtest: bonded-sync [66.626040] Subtest bonded-sync: SKIP (0.000s) [66.917030] [009/129] (950s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [67.010073] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [67.012271] Starting dynamic subtest: pipe-A-eDP-1 [68.330695] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.319s) [68.603186] Starting dynamic subtest: pipe-B-eDP-1 [69.652740] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s) [69.917392] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.908s) [70.752890] [010/129] (946s left) gen9_exec_parse (batch-invalid-length) [70.886713] Subtest batch-invalid-length: SKIP (0.000s) [71.061199] [011/129] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [71.264490] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [71.268901] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [71.488262] [012/129] (946s left) kms_setmode (basic-clone-single-crtc) [71.620502] Starting subtest: basic-clone-single-crtc [71.627869] Subtest basic-clone-single-crtc: SKIP (0.000s) [71.786895] [013/129] (946s left) gem_userptr_blits (relocations) [71.893380] Starting subtest: relocations [71.898459] Subtest relocations: SKIP (0.001s) [72.191173] [014/129] (945s left) kms_feature_discovery (psr2) [72.304027] Starting subtest: psr2 [72.306424] Subtest psr2: SUCCESS (0.000s) [72.366988] [015/129] (945s left) kms_psr (pr-cursor-blt) [72.468077] Starting subtest: pr-cursor-blt [72.472625] Subtest pr-cursor-blt: SKIP (0.000s) [72.533650] [016/129] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [72.638086] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [72.650357] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [72.717106] [017/129] (945s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [72.843237] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [72.847342] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [72.968458] [018/129] (945s left) kms_content_protection (dp-mst-lic-type-1) [73.149664] Starting subtest: dp-mst-lic-type-1 [73.154052] Subtest dp-mst-lic-type-1: SKIP (0.000s) [73.294380] [019/129] (944s left) syncobj_wait (wait-all-snapshot) [73.349184] Starting subtest: wait-all-snapshot [73.431335] Subtest wait-all-snapshot: SUCCESS (0.081s) [73.498441] [020/129] (944s left) gem_close_race (multigpu-basic-threads) [73.564857] Starting subtest: multigpu-basic-threads [73.568463] Subtest multigpu-basic-threads: SKIP (0.000s) [73.791404] [021/129] (944s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [73.888635] Starting subtest: psr-rgb101010-draw-blt [79.037765] Subtest psr-rgb101010-draw-blt: SUCCESS (5.155s) [79.176912] [022/129] (938s left) gem_ctx_isolation (preservation-reset) [79.347767] Starting subtest: preservation-reset [79.350316] Starting dynamic subtest: rcs0 [79.676826] Dynamic subtest rcs0: SUCCESS (0.330s) [79.686408] Starting dynamic subtest: bcs0 [80.090034] Dynamic subtest bcs0: SUCCESS (0.413s) [80.099700] Starting dynamic subtest: vcs0 [80.500770] Dynamic subtest vcs0: SUCCESS (0.411s) [80.510054] Starting dynamic subtest: vcs1 [82.352026] Dynamic subtest vcs1: SUCCESS (1.851s) [82.362734] Starting dynamic subtest: vecs0 [84.325474] Dynamic subtest vecs0: SUCCESS (1.974s) [84.335067] Starting dynamic subtest: ccs0 [86.320459] Dynamic subtest ccs0: SUCCESS (1.995s) [86.322659] Subtest preservation-reset: SUCCESS (6.976s) [86.532177] [023/129] (931s left) kms_cursor_legacy (cursor-vs-flip-toggle) [86.661767] Starting subtest: cursor-vs-flip-toggle [116.941230] Subtest cursor-vs-flip-toggle: SUCCESS (30.283s) [117.812166] [024/129] (900s left) kms_prop_blob (invalid-get-prop) [117.873135] Starting subtest: invalid-get-prop [117.875206] Subtest invalid-get-prop: SUCCESS (0.000s) [117.972899] [025/129] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [118.073541] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [118.077821] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [118.166866] [026/129] (900s left) gem_exec_schedule (timeslicing) [118.242513] Starting subtest: timeslicing [118.244547] Starting dynamic subtest: rcs0 [118.253072] Dynamic subtest rcs0: SUCCESS (0.021s) [118.262510] Starting dynamic subtest: bcs0 [118.274087] Dynamic subtest bcs0: SUCCESS (0.021s) [118.282539] Starting dynamic subtest: vcs0 [118.293869] Dynamic subtest vcs0: SUCCESS (0.020s) [118.300713] Starting dynamic subtest: vcs1 [118.313617] Dynamic subtest vcs1: SUCCESS (0.020s) [118.320239] Starting dynamic subtest: vecs0 [118.333305] Dynamic subtest vecs0: SUCCESS (0.020s) [118.339926] Starting dynamic subtest: ccs0 [118.353500] Dynamic subtest ccs0: SUCCESS (0.020s) [118.355804] Subtest timeslicing: SUCCESS (0.122s) [119.948773] [027/129] (898s left) gem_exec_balancer (invalid-balancer) [120.004602] Starting subtest: invalid-balancer [120.752837] Subtest invalid-balancer: SUCCESS (0.747s) [121.050396] [028/129] (897s left) gem_exec_flush (basic-wb-ro-before-default) [121.120683] Starting subtest: basic-wb-ro-before-default [126.607425] Subtest basic-wb-ro-before-default: SUCCESS (5.487s) [126.785543] [029/129] (891s left) perf_pmu (rc6) [126.822622] Starting subtest: rc6 [126.824624] Starting dynamic subtest: gt0 [133.199670] Dynamic subtest gt0: SUCCESS (6.376s) [133.209662] Starting dynamic subtest: runtime-pm-gt0 [140.918796] Dynamic subtest runtime-pm-gt0: SUCCESS (7.719s) [140.929585] Starting dynamic subtest: runtime-pm-long-gt0 [153.379343] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.460s) [153.389883] Starting dynamic subtest: other-idle-gt0 [159.721651] Dynamic subtest other-idle-gt0: SUCCESS (6.341s) [159.730090] Starting dynamic subtest: gt1 [166.087700] Dynamic subtest gt1: SUCCESS (6.339s) [166.095666] Starting dynamic subtest: runtime-pm-gt1 [173.483459] Dynamic subtest runtime-pm-gt1: SUCCESS (7.422s) [173.493234] Starting dynamic subtest: runtime-pm-long-gt1 [185.905809] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.421s) [185.916161] Starting dynamic subtest: other-idle-gt1 [192.248977] Dynamic subtest other-idle-gt1: SUCCESS (6.342s) [192.251571] Subtest rc6: SUCCESS (65.424s) [193.369249] [030/129] (825s left) syncobj_timeline (wait-for-submit-snapshot) [193.428711] Starting subtest: wait-for-submit-snapshot [193.509903] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [193.555640] [031/129] (824s left) api_intel_allocator (execbuf-with-allocator) [193.613072] Starting subtest: execbuf-with-allocator [193.619031] Subtest execbuf-with-allocator: SUCCESS (0.007s) [193.682243] [032/129] (824s left) kms_big_fb (y-tiled-64bpp-rotate-180) [193.787252] Starting subtest: y-tiled-64bpp-rotate-180 [193.791081] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [193.850140] [033/129] (824s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [193.957931] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [193.961378] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [194.050495] [034/129] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [194.157941] Starting subtest: fbc-shrfb-scaledprimary [198.200338] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.044s) [198.296602] [035/129] (820s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [198.406160] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [198.410469] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [198.477171] [036/129] (820s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [198.532796] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [198.537394] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [198.684337] [037/129] (819s left) gem_exec_fence (keep-in-fence) [198.864892] Starting subtest: keep-in-fence [198.867454] Starting dynamic subtest: rcs0 [198.937998] Dynamic subtest rcs0: SUCCESS (0.073s) [198.946578] Starting dynamic subtest: bcs0 [198.992601] Dynamic subtest bcs0: SUCCESS (0.054s) [199.002235] Starting dynamic subtest: vcs0 [200.939365] Dynamic subtest vcs0: SUCCESS (1.946s) [200.950350] Starting dynamic subtest: vcs1 [202.923444] Dynamic subtest vcs1: SUCCESS (1.983s) [202.933851] Starting dynamic subtest: vecs0 [204.908857] Dynamic subtest vecs0: SUCCESS (1.985s) [204.918901] Starting dynamic subtest: ccs0 [205.150394] Dynamic subtest ccs0: SUCCESS (0.242s) [205.152857] Subtest keep-in-fence: SUCCESS (6.286s) [207.025827] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true [207.028925] [038/129] (811s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [207.133719] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [207.138048] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [207.196464] [039/129] (811s left) gem_pxp (protected-raw-src-copy-not-readible) [207.316301] Starting subtest: protected-raw-src-copy-not-readible [207.374381] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s) [207.485149] [040/129] (811s left) gem_exercise_blt (fast-copy-emit) [207.540596] Starting subtest: fast-copy-emit [207.544563] Starting dynamic subtest: linear-smem-smem-emit [207.563228] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [207.570729] Starting dynamic subtest: xmajor-smem-smem-emit [207.584076] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.020s) [207.594089] Starting dynamic subtest: tile4-smem-smem-emit [207.602346] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s) [207.609914] Starting dynamic subtest: tile64-smem-smem-emit [207.621713] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.019s) [207.623983] Subtest fast-copy-emit: SUCCESS (0.081s) [207.713761] [041/129] (811s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [207.816480] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [207.820631] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [207.894477] [042/129] (810s left) syncobj_wait (invalid-wait-bad-flags) [207.951732] Starting subtest: invalid-wait-bad-flags [207.953863] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [208.043322] [043/129] (810s left) gem_mmap_gtt (ptrace) [208.103502] Subtest ptrace: SKIP (0.000s) [208.174744] [044/129] (810s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [208.284087] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [208.287721] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [208.372811] [045/129] (810s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [208.430270] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [208.432205] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [208.512123] [046/129] (810s left) gem_exec_whisper (basic-normal) [208.569465] Starting subtest: basic-normal [213.343352] Subtest basic-normal: SUCCESS (4.774s) [213.502133] [047/129] (805s left) gem_wait (wait) [213.576266] Starting subtest: wait [213.578660] Starting dynamic subtest: all-engines [214.955321] Dynamic subtest all-engines: SUCCESS (1.377s) [214.966198] Starting dynamic subtest: rcs0 [216.000801] Dynamic subtest rcs0: SUCCESS (1.046s) [216.010720] Starting dynamic subtest: bcs0 [217.047581] Dynamic subtest bcs0: SUCCESS (1.047s) [217.058146] Starting dynamic subtest: vcs0 [218.091538] Dynamic subtest vcs0: SUCCESS (1.043s) [218.102107] Starting dynamic subtest: vcs1 [219.135817] Dynamic subtest vcs1: SUCCESS (1.043s) [219.146393] Starting dynamic subtest: vecs0 [220.179166] Dynamic subtest vecs0: SUCCESS (1.043s) [220.189781] Starting dynamic subtest: ccs0 [221.225930] Dynamic subtest ccs0: SUCCESS (1.047s) [221.228507] Subtest wait: SUCCESS (7.650s) [221.398326] [048/129] (797s left) kms_vblank (query-busy) [221.505699] Starting subtest: query-busy [221.507567] Starting dynamic subtest: pipe-A-eDP-1 [223.390619] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s) [223.405085] Starting dynamic subtest: pipe-D-eDP-1 [225.980178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s) [225.982106] Subtest query-busy: SUCCESS (4.475s) [226.752459] [049/129] (792s left) kms_psr (pr-sprite-plane-move) [226.844149] Starting subtest: pr-sprite-plane-move [226.848700] Subtest pr-sprite-plane-move: SKIP (0.000s) [226.886113] [050/129] (792s left) kms_flip (dpms-vs-vblank-race-interruptible) [226.983722] Starting subtest: dpms-vs-vblank-race-interruptible [226.986063] Starting dynamic subtest: A-eDP1 [231.932823] Dynamic subtest A-eDP1: SUCCESS (4.946s) [231.941856] Starting dynamic subtest: B-eDP1 [236.532211] Dynamic subtest B-eDP1: SUCCESS (4.597s) [236.541147] Starting dynamic subtest: C-eDP1 [241.109552] Dynamic subtest C-eDP1: SUCCESS (4.578s) [241.118251] Starting dynamic subtest: D-eDP1 [245.619712] Dynamic subtest D-eDP1: SUCCESS (4.511s) [245.622333] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.637s) [246.470748] [051/129] (772s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [246.569127] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [246.571483] Starting dynamic subtest: pipe-A-eDP-1 [246.804810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.205s) [246.817843] Starting dynamic subtest: pipe-B-eDP-1 [248.082304] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s) [248.091973] Starting dynamic subtest: pipe-C-eDP-1 [249.378560] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.294s) [249.386232] Starting dynamic subtest: pipe-D-eDP-1 [250.579304] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s) [250.581964] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.976s) [251.673593] [052/129] (767s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render) [251.784801] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render [256.596052] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.814s) [256.706559] [053/129] (762s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [256.814154] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [257.969897] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.156s) [258.098315] [054/129] (761s left) syncobj_eventfd (invalid-illegal-eventfd) [258.164635] Starting subtest: invalid-illegal-eventfd [258.166930] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [258.242615] [055/129] (761s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [258.358834] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [261.115040] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.759s) [261.235472] [056/129] (758s left) gem_mmap_offset (isolation) [261.299690] Starting subtest: isolation [261.315728] Subtest isolation: SUCCESS (0.006s) [261.423946] [057/129] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [261.526749] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [262.749355] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.224s) [262.878341] [058/129] (756s left) api_intel_allocator (reopen) [262.941333] Starting subtest: reopen [262.943682] Subtest reopen: SUCCESS (0.004s) [263.052053] [059/129] (756s left) sw_sync (sync_merge_invalid) [263.091606] Starting subtest: sync_merge_invalid [263.124389] Subtest sync_merge_invalid: SUCCESS (0.033s) [263.206251] [060/129] (756s left) gem_tiled_partial_pwrite_pread (reads) [263.261771] Subtest reads: SKIP (0.000s) [263.340316] [061/129] (756s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [263.731079] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [264.492330] [062/129] (755s left) gem_exec_params (invalid-ring) [264.562926] Starting subtest: invalid-ring [264.565347] Subtest invalid-ring: SUCCESS (0.000s) [264.653629] [063/129] (754s left) kms_big_fb (4-tiled-8bpp-rotate-270) [264.760572] Starting subtest: 4-tiled-8bpp-rotate-270 [264.781391] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [264.881350] [064/129] (754s left) kms_async_flips (crc-atomic) [264.983841] Starting subtest: crc-atomic [265.370548] Starting dynamic subtest: pipe-A-eDP-1 [268.216832] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.845s) [268.578318] Starting dynamic subtest: pipe-B-eDP-1 [271.436070] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.867s) [271.800078] Starting dynamic subtest: pipe-C-eDP-1 [274.646266] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.855s) [275.010187] Starting dynamic subtest: pipe-D-eDP-1 [277.861477] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.862s) [277.863941] Subtest crc-atomic: SUCCESS (12.875s) [279.014141] [065/129] (740s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [279.562374] Starting subtest: syncobj-stationary-timeline-chain-engines [279.682103] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.120s) [280.959064] [066/129] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [281.076581] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [281.080981] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [281.160872] [067/129] (738s left) kms_psr (psr-primary-mmap-gtt) [281.269158] Starting subtest: psr-primary-mmap-gtt [281.271440] Starting dynamic subtest: eDP-1 [282.737105] Dynamic subtest eDP-1: SKIP (1.466s) [282.742196] Subtest psr-primary-mmap-gtt: SKIP (1.467s) [282.875777] [068/129] (736s left) kms_invalid_mode (bad-hsync-start) [282.983227] Starting subtest: bad-hsync-start [282.985547] Starting dynamic subtest: pipe-A-eDP-1 [283.267737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [283.276097] Starting dynamic subtest: pipe-B-eDP-1 [283.278080] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [283.285095] Starting dynamic subtest: pipe-C-eDP-1 [283.287039] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [283.294667] Starting dynamic subtest: pipe-D-eDP-1 [283.296927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [283.299223] Subtest bad-hsync-start: SUCCESS (0.289s) [284.067552] [069/129] (735s left) gem_caching (reads) [284.123305] Subtest reads: SKIP (0.000s) [284.207115] [070/129] (735s left) perf (polling-small-buf) [284.298096] Starting subtest: polling-small-buf [284.394105] Subtest polling-small-buf: SUCCESS (0.096s) [284.434161] [071/129] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [284.545680] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [289.112791] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.568s) [289.241665] [072/129] (730s left) gem_exec_reloc (basic-cpu-noreloc) [289.324302] Subtest basic-cpu-noreloc: SKIP (0.000s) [289.411224] [073/129] (730s left) gem_softpin (full) [289.474428] Starting subtest: full [289.481079] Subtest full: SUCCESS (0.007s) [289.592759] [074/129] (730s left) syncobj_timeline (invalid-wait-illegal-handle) [289.656139] Starting subtest: invalid-wait-illegal-handle [289.658375] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [289.726488] [075/129] (730s left) kms_big_fb (linear-32bpp-rotate-270) [289.835485] Starting subtest: linear-32bpp-rotate-270 [289.855059] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [289.953770] [076/129] (730s left) i915_pm_rps (thresholds-idle) [290.020770] Starting subtest: thresholds-idle [290.025735] Subtest thresholds-idle: SKIP (0.001s) [290.091299] [077/129] (729s left) syncobj_timeline (invalid-query-zero-handles) [290.143048] Starting subtest: invalid-query-zero-handles [290.144665] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [290.224621] [078/129] (729s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [290.285872] Starting subtest: etime-multi-wait-all-for-submit-submitted [290.391668] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s) [290.439305] [079/129] (729s left) gem_sync (basic-many-each) [290.517654] Starting subtest: basic-many-each [292.813360] Subtest basic-many-each: SUCCESS (2.305s) [292.968845] [080/129] (727s left) gem_ctx_engines (independent) [293.023740] Starting subtest: independent [293.026228] Starting dynamic subtest: rcs0 [293.265461] Dynamic subtest rcs0: SUCCESS (0.240s) [293.276419] Starting dynamic subtest: bcs0 [293.513714] Dynamic subtest bcs0: SUCCESS (0.247s) [293.524997] Starting dynamic subtest: vcs0 [293.758976] Dynamic subtest vcs0: SUCCESS (0.245s) [293.770904] Starting dynamic subtest: vcs1 [294.040267] Dynamic subtest vcs1: SUCCESS (0.281s) [294.050673] Starting dynamic subtest: vecs0 [294.319428] Dynamic subtest vecs0: SUCCESS (0.279s) [294.331741] Starting dynamic subtest: ccs0 [294.631451] Dynamic subtest ccs0: SUCCESS (0.311s) [294.639837] Starting dynamic subtest: all-engines [295.814419] Dynamic subtest all-engines: SUCCESS (1.183s) [295.816967] Subtest independent: SUCCESS (2.790s) [296.057804] [081/129] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [296.170570] Starting subtest: psr-2p-primscrn-spr-indfb-move [296.175032] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [296.261055] [082/129] (723s left) gem_exec_create (forked) [296.333409] Starting subtest: forked [296.335736] Starting dynamic subtest: smem [316.907421] Dynamic subtest smem: SUCCESS (20.571s) [316.910314] Subtest forked: SUCCESS (20.573s) [317.064819] [083/129] (703s left) kms_pm_backlight (basic-brightness) [317.166443] Starting subtest: basic-brightness [317.236188] Starting dynamic subtest: eDP-1 [317.734445] Dynamic subtest eDP-1: SUCCESS (0.499s) [317.736892] Subtest basic-brightness: SUCCESS (0.567s) [318.538340] [084/129] (701s left) kms_vrr (seamless-rr-switch-vrr) [318.641087] Starting subtest: seamless-rr-switch-vrr [318.647505] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [318.684725] [085/129] (701s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [318.742935] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [318.745436] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [318.813016] [086/129] (701s left) kms_scaling_modes (scaling-mode-center) [318.905119] Starting subtest: scaling-mode-center [318.907329] Starting dynamic subtest: pipe-A-eDP-1 [319.017591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.112s) [319.028811] Starting dynamic subtest: pipe-B-eDP-1 [320.178871] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s) [320.188420] Starting dynamic subtest: pipe-C-eDP-1 [321.379669] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s) [321.387823] Starting dynamic subtest: pipe-D-eDP-1 [322.504661] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s) [322.507071] Subtest scaling-mode-center: SUCCESS (3.600s) [323.643490] [087/129] (696s left) perf (gen12-group-concurrent-oa-buffer-read) [323.709574] Starting subtest: gen12-group-concurrent-oa-buffer-read [333.742806] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.032s) [333.785652] [088/129] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [333.896868] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [339.179286] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.284s) [339.297690] [089/129] (681s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [339.397113] Starting subtest: plane-downscale-factor-0-25-with-modifiers [339.401576] Starting dynamic subtest: pipe-A [339.413379] Dynamic subtest pipe-A: SKIP (0.011s) [339.421878] Starting dynamic subtest: pipe-B [339.436615] Dynamic subtest pipe-B: SKIP (0.022s) [339.446263] Starting dynamic subtest: pipe-C [339.460846] Dynamic subtest pipe-C: SKIP (0.024s) [339.468654] Starting dynamic subtest: pipe-D [339.482969] Dynamic subtest pipe-D: SKIP (0.021s) [339.486604] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.081s) [339.568164] [090/129] (680s left) gem_ctx_persistence (userptr) [339.627081] Starting subtest: userptr [339.865798] Subtest userptr: SUCCESS (0.238s) [339.917679] [091/129] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [340.032726] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [340.037159] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [340.121318] [092/129] (680s left) kms_psr (fbc-pr-sprite-plane-move) [340.230900] Starting subtest: fbc-pr-sprite-plane-move [340.234852] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [340.272938] [093/129] (680s left) kms_cursor_crc (cursor-sliding-128x42) [340.488831] Starting subtest: cursor-sliding-128x42 [340.527343] Subtest cursor-sliding-128x42: SKIP (0.034s) [340.716725] [094/129] (679s left) gem_exec_reloc (basic-active) [340.772075] Subtest basic-active: SKIP (0.000s) [340.854141] [095/129] (679s left) kms_cursor_crc (cursor-random-256x85) [341.085484] Starting subtest: cursor-random-256x85 [341.128832] Subtest cursor-random-256x85: SKIP (0.039s) [341.270501] [096/129] (679s left) kms_draw_crc (draw-method-mmap-wc) [341.371520] Starting subtest: draw-method-mmap-wc [341.373304] Starting dynamic subtest: xrgb8888-untiled [341.576873] Dynamic subtest xrgb8888-untiled: SUCCESS (0.207s) [341.586184] Starting dynamic subtest: rgb565-untiled [341.776750] Dynamic subtest rgb565-untiled: SUCCESS (0.200s) [341.784812] Starting dynamic subtest: xrgb2101010-untiled [341.976568] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s) [341.985500] Starting dynamic subtest: xbgr16161616f-untiled [342.198825] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [342.206329] Starting dynamic subtest: xrgb8888-xtiled [342.320941] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [342.329994] Starting dynamic subtest: rgb565-xtiled [342.432129] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [342.444151] Starting dynamic subtest: xrgb2101010-xtiled [342.555219] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [342.565507] Starting dynamic subtest: xbgr16161616f-xtiled [342.676981] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [342.684628] Starting dynamic subtest: xrgb8888-4tiled [342.820962] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s) [342.829012] Starting dynamic subtest: rgb565-4tiled [342.943253] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s) [342.950585] Starting dynamic subtest: xrgb2101010-4tiled [343.087912] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s) [343.095587] Starting dynamic subtest: xbgr16161616f-4tiled [343.254233] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s) [343.256180] Subtest draw-method-mmap-wc: SUCCESS (1.886s) [343.353782] [097/129] (677s left) kms_psr (fbc-psr2-sprite-plane-move) [343.459880] Starting subtest: fbc-psr2-sprite-plane-move [343.461873] Starting dynamic subtest: eDP-1 [343.465505] Dynamic subtest eDP-1: SKIP (0.000s) [343.468876] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [343.504419] [098/129] (677s left) gem_mmap (basic) [343.567911] Subtest basic: SKIP (0.000s) [343.632172] [099/129] (677s left) kms_plane_lowres (tiling-4) [343.734810] Starting subtest: tiling-4 [343.736841] Starting dynamic subtest: pipe-A-eDP-1 [343.740793] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [344.028691] Starting dynamic subtest: pipe-B-eDP-1 [344.033099] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [344.040802] Starting dynamic subtest: pipe-C-eDP-1 [344.045314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [344.053985] Starting dynamic subtest: pipe-D-eDP-1 [344.058359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [344.062630] Subtest tiling-4: SKIP (0.291s) [344.804879] [100/129] (675s left) kms_chamelium_color (ctm-0-50) [344.919780] Subtest ctm-0-50: SKIP (0.000s) [344.963516] [101/129] (675s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [345.347625] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [346.122375] [102/129] (674s left) drm_fdinfo (memory-info-active) [346.162729] Starting subtest: memory-info-active [346.165409] Starting dynamic subtest: smem0 [348.918777] Dynamic subtest smem0: SUCCESS (2.758s) [348.921238] Subtest memory-info-active: SUCCESS (2.759s) [348.962636] [103/129] (671s left) prime_mmap (test_forked_cpu_write) [349.022144] Starting subtest: test_forked_cpu_write [349.024544] Starting dynamic subtest: test_forked_cpu_write-smem [349.029421] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.010s) [349.031669] Subtest test_forked_cpu_write: SUCCESS (0.011s) [349.121224] [104/129] (671s left) gem_ctx_param (set-priority-invalid-size) [349.183324] Starting subtest: set-priority-invalid-size [349.185626] Subtest set-priority-invalid-size: SUCCESS (0.000s) [349.228821] [105/129] (671s left) kms_chamelium_hpd (vga-hpd-without-ddc) [349.619516] Subtest vga-hpd-without-ddc: SKIP (0.000s) [350.440106] [106/129] (670s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [350.557984] Starting subtest: cursorA-vs-flipA-varying-size [361.716497] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.160s) [362.570427] [107/129] (658s left) i915_pm_rc6_residency (rc6-fence) [362.639707] Starting subtest: rc6-fence [362.679486] Starting dynamic subtest: gt0 [374.997434] Dynamic subtest gt0: SUCCESS (12.317s) [375.008551] Starting dynamic subtest: gt1 [389.931609] Dynamic subtest gt1: SUCCESS (14.931s) [389.934820] Subtest rc6-fence: SUCCESS (27.293s) [389.978127] [108/129] (631s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [390.081314] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [390.083648] Starting dynamic subtest: pipe-A [390.092895] Dynamic subtest pipe-A: SKIP (0.004s) [390.103123] Starting dynamic subtest: pipe-B [390.112702] Dynamic subtest pipe-B: SKIP (0.016s) [390.122332] Starting dynamic subtest: pipe-C [390.131451] Dynamic subtest pipe-C: SKIP (0.016s) [390.139392] Starting dynamic subtest: pipe-D [390.146935] Dynamic subtest pipe-D: SKIP (0.016s) [390.151086] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.054s) [390.220407] [109/129] (630s left) kms_flip (2x-flip-vs-modeset) [390.324115] Starting subtest: 2x-flip-vs-modeset [390.340895] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [390.411206] [110/129] (630s left) gem_mmap_wc (close) [390.466602] Subtest close: SKIP (0.000s) [390.523551] [111/129] (630s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [390.620330] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [390.622613] Starting dynamic subtest: pipe-A-default-mode [390.907921] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [390.912682] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.284s) [391.689795] [112/129] (629s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [396.662294] Starting subtest: pr-cursor-plane-move-continuous-sf [396.667069] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s) [397.478457] [113/129] (623s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [397.542267] Starting subtest: yf-tiled-ccs-to-x-tiled [397.546762] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [397.701354] [114/129] (623s left) gem_exec_schedule (preemptive-hang) [397.873033] Starting subtest: preemptive-hang [397.875935] Starting dynamic subtest: rcs0 [407.059682] Dynamic subtest rcs0: SUCCESS (9.187s) [407.068613] Starting dynamic subtest: bcs0 [416.019303] Dynamic subtest bcs0: SUCCESS (8.958s) [416.032997] Starting dynamic subtest: vcs0 [425.044657] Dynamic subtest vcs0: SUCCESS (9.024s) [425.054703] Starting dynamic subtest: vcs1 [434.066825] Dynamic subtest vcs1: SUCCESS (9.020s) [434.075113] Starting dynamic subtest: vecs0 [443.023510] Dynamic subtest vecs0: SUCCESS (8.954s) [443.041901] Starting dynamic subtest: ccs0 [452.051517] Dynamic subtest ccs0: SUCCESS (9.030s) [452.053965] Subtest preemptive-hang: SUCCESS (54.180s) [452.285153] [115/129] (569s left) kms_lease (invalid-create-leases) [452.393125] Starting subtest: invalid-create-leases [452.400355] Subtest invalid-create-leases: SUCCESS (0.006s) [452.488394] [116/129] (568s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [452.583214] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [452.585644] Starting dynamic subtest: pipe-A-eDP-1 [452.594977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [452.605021] Starting dynamic subtest: pipe-B-eDP-1 [452.613958] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [452.622072] Starting dynamic subtest: pipe-C-eDP-1 [452.630598] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [452.638529] Starting dynamic subtest: pipe-D-eDP-1 [452.647354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [452.651871] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [454.718740] [117/129] (566s left) kms_addfb_basic (basic-x-tiled-legacy) [454.781871] Starting subtest: basic-x-tiled-legacy [454.786627] Subtest basic-x-tiled-legacy: SKIP (0.000s) [454.911578] [118/129] (566s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [455.013132] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [455.015407] Starting dynamic subtest: pipe-A-eDP-1 [455.037714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [455.048324] Starting dynamic subtest: pipe-B-eDP-1 [455.069502] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [455.076876] Starting dynamic subtest: pipe-C-eDP-1 [455.098411] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [455.105678] Starting dynamic subtest: pipe-D-eDP-1 [455.127444] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [455.131811] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s) [457.172212] [119/129] (564s left) gem_mmap_wc (read-write) [457.239820] Subtest read-write: SKIP (0.000s) [457.304400] [120/129] (564s left) gem_mmap_wc (read-write-distinct) [457.367071] Subtest read-write-distinct: SKIP (0.000s) [457.420682] [121/129] (564s left) api_intel_bb (purge-bb) [457.479339] Starting subtest: purge-bb [457.485047] Subtest purge-bb: SUCCESS (0.005s) [457.590995] [122/129] (563s left) syncobj_wait (single-wait-for-submit-submitted) [457.655569] Starting subtest: single-wait-for-submit-submitted [457.760467] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s) [457.807435] [123/129] (563s left) kms_addfb_basic (bo-too-small-due-to-tiling) [457.901146] Starting subtest: bo-too-small-due-to-tiling [457.905134] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [457.965643] [124/129] (563s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [458.072710] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [462.364379] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.296s) [462.437544] [125/129] (559s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [467.411587] Starting subtest: psr2-overlay-plane-move-continuous-sf [467.413968] Starting dynamic subtest: pipe-A-eDP-1 [474.091841] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.677s) [474.100062] Starting dynamic subtest: pipe-B-eDP-1 [480.723819] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.631s) [480.726556] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.312s) [481.486818] [126/129] (540s left) dumb_buffer (create-clear) [481.543166] Starting subtest: create-clear [523.428333] Subtest create-clear: SUCCESS (41.880s) [523.536135] [127/129] (498s left) kms_rotation_crc (sprite-rotation-180) [523.641096] Starting subtest: sprite-rotation-180 [528.569938] Subtest sprite-rotation-180: SUCCESS (4.931s) [529.742126] [128/129] (492s left) prime_self_import (basic-with_one_bo_two_files) [529.777608] Starting subtest: basic-with_one_bo_two_files [529.799138] Subtest basic-with_one_bo_two_files: SUCCESS (0.025s) [529.877484] [129/129] (491s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [529.996838] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [535.110813] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (5.120s) [535.250614] Closing watchdogs Done.