[57.198571] Initializing watchdogs [57.198616] /dev/watchdog0 [57.213847] [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.217942] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.220086] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.223340] [001/133] (960s left) syncobj_basic (bad-create-flags) [57.300716] Starting subtest: bad-create-flags [57.303234] Subtest bad-create-flags: SUCCESS (0.000s) [57.406355] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [62.850317] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [62.852758] Starting dynamic subtest: pipe-A-eDP-1 [69.634569] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.785s) [69.645506] Starting dynamic subtest: pipe-B-eDP-1 [76.550569] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.917s) [76.552535] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.706s) [77.435305] [003/133] (940s left) gem_ccs (block-copy-compressed) [77.508544] Starting subtest: block-copy-compressed [77.512562] Subtest block-copy-compressed: SKIP (0.000s) [77.646375] [004/133] (940s left) kms_sequence (get-forked-busy) [77.746724] Starting subtest: get-forked-busy [77.748998] Starting dynamic subtest: pipe-A-eDP-1 [79.687618] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s) [79.699041] Starting dynamic subtest: pipe-B-eDP-1 [82.324959] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.636s) [82.332781] Starting dynamic subtest: pipe-C-eDP-1 [84.917422] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.591s) [84.924547] Starting dynamic subtest: pipe-D-eDP-1 [87.467388] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.552s) [87.469778] Subtest get-forked-busy: SUCCESS (9.723s) [88.363201] [005/133] (929s left) sysfs_preempt_timeout (timeout) [88.437436] Starting subtest: timeout [88.439978] Starting dynamic subtest: vecs0 [96.943915] Dynamic subtest vecs0: SUCCESS (8.503s) [96.953865] Starting dynamic subtest: ccs0 [98.292573] Dynamic subtest ccs0: SUCCESS (1.349s) [98.300210] Starting dynamic subtest: vcs0 [107.939058] Dynamic subtest vcs0: SUCCESS (9.644s) [107.949031] Starting dynamic subtest: bcs0 [109.328332] Dynamic subtest bcs0: SUCCESS (1.389s) [109.338843] Starting dynamic subtest: rcs0 [110.660245] Dynamic subtest rcs0: SUCCESS (1.332s) [110.667909] Starting dynamic subtest: vcs1 [119.915574] Dynamic subtest vcs1: SUCCESS (9.254s) [119.918064] Subtest timeout: SUCCESS (31.479s) [120.015951] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [120.121847] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [120.126245] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [120.244643] [007/133] (897s left) gem_ctx_persistence (legacy-engines-queued) [120.308786] Starting subtest: legacy-engines-queued [120.311071] Starting dynamic subtest: render [120.409707] Dynamic subtest render: SUCCESS (0.100s) [120.419228] Starting dynamic subtest: bsd1 [121.908414] Dynamic subtest bsd1: SUCCESS (1.495s) [121.918977] Starting dynamic subtest: bsd2 [123.890749] Dynamic subtest bsd2: SUCCESS (1.979s) [123.901627] Starting dynamic subtest: blt [123.986413] Dynamic subtest blt: SUCCESS (0.095s) [123.996569] Starting dynamic subtest: vebox [125.875363] Dynamic subtest vebox: SUCCESS (1.886s) [125.878638] Subtest legacy-engines-queued: SUCCESS (5.565s) [125.976463] [008/133] (892s left) drm_read (short-buffer-block) [126.148207] Starting subtest: short-buffer-block [126.150562] Subtest short-buffer-block: SUCCESS (0.000s) [126.318956] [009/133] (891s left) gem_render_copy_redux (normal) [126.385198] Starting subtest: normal [126.640944] Subtest normal: SUCCESS (0.255s) [126.800293] [010/133] (891s left) kms_big_fb (y-tiled-32bpp-rotate-90) [126.903055] Starting subtest: y-tiled-32bpp-rotate-90 [126.906814] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [127.012796] [011/133] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [127.120263] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [134.491149] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.372s) [134.635384] [012/133] (883s left) gem_exec_suspend (basic) [134.696840] Starting subtest: basic [134.699292] Starting dynamic subtest: smem [135.892526] Dynamic subtest smem: SUCCESS (1.193s) [135.895138] Subtest basic: SUCCESS (1.195s) [136.094591] [013/133] (882s left) kms_hdmi_inject (inject-audio) [136.442352] Starting subtest: inject-audio [136.721271] Subtest inject-audio: SUCCESS (0.279s) [137.341108] [014/133] (880s left) kms_cursor_crc (cursor-sliding-32x10) [137.509091] Starting subtest: cursor-sliding-32x10 [137.559255] Subtest cursor-sliding-32x10: SKIP (0.046s) [137.819660] [015/133] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [137.925587] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [144.389968] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.467s) [144.534742] [016/133] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [144.627484] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [144.631955] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [144.772242] [017/133] (873s left) gem_render_copy (y-tiled-ccs-to-linear) [144.823281] Starting subtest: y-tiled-ccs-to-linear [144.828377] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [145.026560] [018/133] (873s left) kms_big_fb (4-tiled-16bpp-rotate-90) [145.118215] Starting subtest: 4-tiled-16bpp-rotate-90 [145.138163] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [145.285639] [019/133] (873s left) syncobj_timeline (transfer-timeline-point) [145.349817] Starting subtest: transfer-timeline-point [145.352068] Subtest transfer-timeline-point: SUCCESS (0.000s) [145.470649] [020/133] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [145.528742] Starting subtest: invalid-multi-wait-unsubmitted-submitted [145.530907] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [145.672114] [021/133] (872s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [145.774398] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [145.776821] Starting dynamic subtest: pipe-A-eDP-1 [145.802164] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [145.813994] Starting dynamic subtest: pipe-B-eDP-1 [145.838082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [145.847606] Starting dynamic subtest: pipe-C-eDP-1 [145.872337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [145.881543] Starting dynamic subtest: pipe-D-eDP-1 [145.905736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [145.909768] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [148.007182] [022/133] (870s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [150.036331] Starting subtest: dpms-mode-unset-non-lpsp [151.186817] Subtest dpms-mode-unset-non-lpsp: SKIP (1.150s) [151.593649] [023/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [151.688143] Starting subtest: psr-rgb565-draw-mmap-wc [158.299256] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.615s) [158.454111] [024/133] (860s left) kms_chamelium_edid (vga-edid-read) [158.847881] Subtest vga-edid-read: SKIP (0.000s) [159.662667] [025/133] (858s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [159.735462] Starting subtest: yf-tiled-to-vebox-y-tiled [159.740206] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [159.939374] [026/133] (858s left) kms_flip (dpms-off-confusion) [160.029971] Starting subtest: dpms-off-confusion [160.032349] Starting dynamic subtest: A-eDP1 [168.667515] Dynamic subtest A-eDP1: SUCCESS (8.639s) [168.675843] Starting dynamic subtest: B-eDP1 [177.358297] Dynamic subtest B-eDP1: SUCCESS (8.690s) [177.366416] Starting dynamic subtest: C-eDP1 [186.038429] Dynamic subtest C-eDP1: SUCCESS (8.678s) [186.047317] Starting dynamic subtest: D-eDP1 [194.734680] Dynamic subtest D-eDP1: SUCCESS (8.694s) [194.739594] Subtest dpms-off-confusion: SUCCESS (34.712s) [196.007591] [027/133] (822s left) gem_exec_big (single) [196.072582] Starting subtest: single [198.398440] Subtest single: FAIL (2.262s) [198.441112] [028/133] (820s left) gem_exec_flush (basic-wb-ro-default) [198.531646] Starting subtest: basic-wb-ro-default [203.987541] Subtest basic-wb-ro-default: SUCCESS (5.456s) [204.193069] [029/133] (814s left) kms_async_flips (async-flip-with-page-flip-events-linear) [204.300755] Starting subtest: async-flip-with-page-flip-events-linear [204.693459] Starting dynamic subtest: pipe-A-eDP-1 [207.422094] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.729s) [207.783275] Starting dynamic subtest: pipe-B-eDP-1 [210.519721] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.742s) [210.903754] Starting dynamic subtest: pipe-C-eDP-1 [213.628049] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.729s) [213.990014] Starting dynamic subtest: pipe-D-eDP-1 [216.716729] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.733s) [216.718983] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.417s) [217.900580] [030/133] (800s left) kms_plane_scaling (planes-downscale-factor-0-75) [217.989316] Starting subtest: planes-downscale-factor-0-75 [217.991567] Starting dynamic subtest: pipe-A [218.013475] Dynamic subtest pipe-A: SKIP (0.018s) [218.021768] Starting dynamic subtest: pipe-B [218.044362] Dynamic subtest pipe-B: SKIP (0.032s) [218.052160] Starting dynamic subtest: pipe-C [218.076797] Dynamic subtest pipe-C: SKIP (0.031s) [218.085065] Starting dynamic subtest: pipe-D [218.108203] Dynamic subtest pipe-D: SKIP (0.031s) [218.112594] Subtest planes-downscale-factor-0-75: SKIP (0.114s) [218.240436] [031/133] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [218.341439] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [218.345382] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [218.491325] [032/133] (800s left) kms_properties (colorop-properties-legacy) [218.587150] Starting subtest: colorop-properties-legacy [218.589330] Starting dynamic subtest: pipe-A-eDP-1 [218.971311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.383s) [218.982130] Starting dynamic subtest: pipe-B-eDP-1 [220.044383] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.072s) [220.053395] Starting dynamic subtest: pipe-C-eDP-1 [221.115564] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.069s) [221.124552] Starting dynamic subtest: pipe-D-eDP-1 [222.196382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.079s) [222.198706] Subtest colorop-properties-legacy: SUCCESS (3.609s) [223.091944] [033/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [223.200653] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [223.204978] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [223.313408] [034/133] (795s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [223.419656] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [223.421811] Starting dynamic subtest: pipe-A-eDP-1 [223.442064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [223.452083] Starting dynamic subtest: pipe-B-eDP-1 [223.471969] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [223.481713] Starting dynamic subtest: pipe-C-eDP-1 [223.501203] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [223.509114] Starting dynamic subtest: pipe-D-eDP-1 [223.528644] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [223.530886] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [225.688830] [035/133] (793s left) gem_wait (wait) [225.754579] Starting subtest: wait [225.756998] Starting dynamic subtest: all-engines [226.900627] Dynamic subtest all-engines: SUCCESS (1.143s) [226.910219] Starting dynamic subtest: rcs0 [227.944765] Dynamic subtest rcs0: SUCCESS (1.044s) [227.955265] Starting dynamic subtest: bcs0 [228.992197] Dynamic subtest bcs0: SUCCESS (1.045s) [229.002211] Starting dynamic subtest: vcs0 [230.037313] Dynamic subtest vcs0: SUCCESS (1.043s) [230.047814] Starting dynamic subtest: vcs1 [231.082349] Dynamic subtest vcs1: SUCCESS (1.043s) [231.093199] Starting dynamic subtest: vecs0 [232.127245] Dynamic subtest vecs0: SUCCESS (1.043s) [232.138632] Starting dynamic subtest: ccs0 [233.174277] Dynamic subtest ccs0: SUCCESS (1.045s) [233.176838] Subtest wait: SUCCESS (7.420s) [233.403335] [036/133] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [233.525043] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [233.529459] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [233.640373] [037/133] (785s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [233.743607] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [234.855688] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.112s) [235.012547] [038/133] (784s left) gem_exec_reloc (basic-concurrent0) [235.083121] Subtest basic-concurrent0: SKIP (0.000s) [235.164394] [039/133] (784s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [235.260931] Starting subtest: yf-tiled-32bpp-rotate-180 [235.264694] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [235.392082] [040/133] (783s left) kms_lease (cursor-implicit-plane) [235.489289] Starting subtest: cursor-implicit-plane [235.491176] Starting dynamic subtest: pipe-A-eDP-1 [235.948539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s) [235.957955] Starting dynamic subtest: pipe-B-eDP-1 [237.054445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.104s) [237.063462] Starting dynamic subtest: pipe-C-eDP-1 [238.141666] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.086s) [238.150922] Starting dynamic subtest: pipe-D-eDP-1 [239.259377] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.114s) [239.261738] Subtest cursor-implicit-plane: SUCCESS (3.770s) [240.096017] [041/133] (779s left) gem_exec_schedule (u-semaphore-resolve) [240.174362] Starting subtest: u-semaphore-resolve [240.206341] Subtest u-semaphore-resolve: SUCCESS (0.039s) [240.582903] [042/133] (778s left) gem_exec_whisper (basic-fds-priority) [240.659536] Starting subtest: basic-fds-priority [264.421674] Subtest basic-fds-priority: SUCCESS (23.758s) [264.648699] [043/133] (754s left) i915_query (query-topology-known-pci-ids) [264.709179] Starting subtest: query-topology-known-pci-ids [264.713935] Subtest query-topology-known-pci-ids: SKIP (0.000s) [264.852831] [044/133] (754s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [264.959701] Starting subtest: yf-tiled-64bpp-rotate-90 [264.964124] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [265.097657] [045/133] (754s left) perf_pmu (idle) [265.137503] Starting subtest: idle [265.139797] Starting dynamic subtest: rcs0 [265.678611] Dynamic subtest rcs0: SUCCESS (0.540s) [265.690937] Starting dynamic subtest: bcs0 [266.194936] Dynamic subtest bcs0: SUCCESS (0.513s) [266.206435] Starting dynamic subtest: vcs0 [266.719299] Dynamic subtest vcs0: SUCCESS (0.521s) [266.730937] Starting dynamic subtest: vcs1 [267.246367] Dynamic subtest vcs1: SUCCESS (0.524s) [267.257038] Starting dynamic subtest: vecs0 [267.768473] Dynamic subtest vecs0: SUCCESS (0.519s) [267.778091] Starting dynamic subtest: ccs0 [268.293096] Dynamic subtest ccs0: SUCCESS (0.522s) [268.296401] Subtest idle: SUCCESS (3.157s) [268.404362] [046/133] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [268.502259] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [268.506209] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [268.637589] [047/133] (750s left) gem_exec_flush (basic-uc-pro-default) [268.707819] Starting subtest: basic-uc-pro-default [274.160258] Subtest basic-uc-pro-default: SUCCESS (5.453s) [274.374331] [048/133] (745s left) gem_basic (bad-close) [274.444534] Starting subtest: bad-close [274.449211] Subtest bad-close: SUCCESS (0.000s) [274.579923] [049/133] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [274.674443] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [274.678648] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [274.802492] [050/133] (744s left) kms_plane (pixel-format) [274.905597] Starting subtest: pixel-format [274.932357] Starting dynamic subtest: pipe-A-plane-0 [279.843093] Dynamic subtest pipe-A-plane-0: SUCCESS (4.911s) [279.854355] Starting dynamic subtest: pipe-A-plane-3 [282.109966] Dynamic subtest pipe-A-plane-3: SUCCESS (2.265s) [282.119017] Starting dynamic subtest: pipe-A-plane-5 [282.321090] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [283.440964] Starting dynamic subtest: pipe-B-plane-0 [288.244352] Dynamic subtest pipe-B-plane-0: SUCCESS (4.811s) [288.262803] Starting dynamic subtest: pipe-B-plane-3 [290.665430] Dynamic subtest pipe-B-plane-3: SUCCESS (2.421s) [290.679714] Starting dynamic subtest: pipe-B-plane-5 [290.865254] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s) [291.172535] Subtest pixel-format: SUCCESS (16.268s) [291.991255] [051/133] (727s left) kms_psr (fbc-psr2-no-drrs) [292.098067] Starting subtest: fbc-psr2-no-drrs [292.100309] Starting dynamic subtest: eDP-1 [292.104639] Dynamic subtest eDP-1: SKIP (0.000s) [292.109031] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [292.196064] [052/133] (727s left) gem_mmap (bad-size) [292.260240] Subtest bad-size: SKIP (0.000s) [292.334331] [053/133] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [292.441351] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [292.445303] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [292.578051] [054/133] (727s left) api_intel_bb (crc32) [292.649518] Starting subtest: crc32 [292.651880] Starting dynamic subtest: rcs0-smem0 [292.933411] Dynamic subtest rcs0-smem0: SUCCESS (0.282s) [292.945360] Starting dynamic subtest: bcs0-smem0 [293.268108] Dynamic subtest bcs0-smem0: SUCCESS (0.331s) [293.279944] Starting dynamic subtest: vcs0-smem0 [293.583042] Dynamic subtest vcs0-smem0: SUCCESS (0.313s) [293.595337] Starting dynamic subtest: vcs1-smem0 [293.922386] Dynamic subtest vcs1-smem0: SUCCESS (0.335s) [293.934109] Starting dynamic subtest: vecs0-smem0 [294.260393] Dynamic subtest vecs0-smem0: SUCCESS (0.337s) [294.272089] Starting dynamic subtest: ccs0-smem0 [294.599380] Dynamic subtest ccs0-smem0: SUCCESS (0.336s) [294.602513] Subtest crc32: SUCCESS (1.950s) [294.740994] [055/133] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [294.844130] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [294.848148] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [294.964847] [056/133] (724s left) kms_psr (psr2-cursor-render) [295.062776] Starting subtest: psr2-cursor-render [295.065070] Starting dynamic subtest: eDP-1 [296.725192] Dynamic subtest eDP-1: SUCCESS (1.661s) [296.727065] Subtest psr2-cursor-render: SUCCESS (1.662s) [297.592980] [057/133] (722s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [297.695823] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [297.706381] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [297.854685] [058/133] (722s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [297.955057] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [297.957468] Starting dynamic subtest: pipe-A-eDP-1 [298.419838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s) [298.430917] Starting dynamic subtest: pipe-B-eDP-1 [299.849899] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s) [299.860670] Starting dynamic subtest: pipe-C-eDP-1 [301.220822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s) [301.231804] Starting dynamic subtest: pipe-D-eDP-1 [302.624801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s) [302.627070] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.645s) [303.793258] [059/133] (716s left) kms_dp_linktrain_fallback (dp-fallback) [303.887683] Starting subtest: dp-fallback [303.894181] Subtest dp-fallback: SKIP (0.000s) [303.980854] [060/133] (716s left) gem_readwrite (beyond-eob) [304.034152] Subtest beyond-EOB: SKIP (0.000s) [304.093270] [061/133] (715s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [304.187423] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [308.571332] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.387s) [309.721993] [062/133] (710s left) prime_vgem (basic-fence-read) [309.868234] Starting subtest: basic-fence-read [309.877941] Subtest basic-fence-read: SKIP (0.007s) [310.020168] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [310.023255] [063/133] (710s left) perf_pmu (interrupts) [310.075436] Starting subtest: interrupts [311.171692] Subtest interrupts: SUCCESS (1.101s) [311.321568] [064/133] (708s left) i915_pm_rpm (system-suspend-devices) [313.040405] Starting subtest: system-suspend-devices [320.824181] Subtest system-suspend-devices: SUCCESS (7.785s) [321.212872] [065/133] (699s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [321.327272] Starting subtest: flip-vs-dpms-on-nop-interruptible [321.329528] Starting dynamic subtest: A-eDP1 [323.133974] Dynamic subtest A-eDP1: SUCCESS (1.805s) [323.153461] Starting dynamic subtest: B-eDP1 [324.947527] Dynamic subtest B-eDP1: SUCCESS (1.811s) [324.962838] Starting dynamic subtest: C-eDP1 [326.833427] Dynamic subtest C-eDP1: SUCCESS (1.884s) [326.845246] Starting dynamic subtest: D-eDP1 [328.619279] Dynamic subtest D-eDP1: SUCCESS (1.785s) [328.621781] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.295s) [329.796832] [066/133] (690s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [329.890217] Starting subtest: crc-primary-basic-y-tiled-ccs [329.892538] Starting dynamic subtest: pipe-A-eDP-1 [329.915909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [329.928507] Starting dynamic subtest: pipe-B-eDP-1 [329.950687] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [329.960898] Starting dynamic subtest: pipe-C-eDP-1 [329.981597] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [329.990325] Starting dynamic subtest: pipe-D-eDP-1 [330.011062] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [330.015089] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [332.181036] [067/133] (688s left) kms_color (ctm-0-75) [332.285562] Starting subtest: ctm-0-75 [332.287833] Starting dynamic subtest: pipe-A-eDP-1 [337.217927] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.932s) [337.232045] Starting dynamic subtest: pipe-B-eDP-1 [342.819287] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.602s) [342.830814] Starting dynamic subtest: pipe-C-eDP-1 [348.281282] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.461s) [348.290790] Starting dynamic subtest: pipe-D-eDP-1 [353.570855] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.288s) [353.573310] Subtest ctm-0-75: SUCCESS (21.286s) [354.388049] [068/133] (665s left) gem_mmap_offset (partial-mmap) [354.464802] Starting subtest: partial-mmap [354.467308] Starting dynamic subtest: smem0 [354.472924] Dynamic subtest smem0: SUCCESS (0.006s) [354.474998] Subtest partial-mmap: SUCCESS (0.007s) [354.585985] [069/133] (665s left) syncobj_timeline (device-signal-unordered) [354.650786] Starting subtest: device-signal-unordered [354.653203] Subtest device-signal-unordered: SUCCESS (0.000s) [354.782098] [070/133] (665s left) kms_pm_dc (dc6-psr) [355.882118] Starting subtest: dc6-psr [358.759625] Subtest dc6-psr: SUCCESS (2.877s) [359.599880] [071/133] (660s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [359.717615] Starting subtest: cursorB-vs-flipB-varying-size [359.722261] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [359.887965] [072/133] (660s left) kms_addfb_basic (no-handle) [359.955226] Starting subtest: no-handle [359.957768] Subtest no-handle: SUCCESS (0.000s) [360.126344] [073/133] (660s left) gem_pxp (create-regular-buffer) [360.240939] Starting subtest: create-regular-buffer [360.243314] Subtest create-regular-buffer: SUCCESS (0.000s) [360.390979] [074/133] (660s left) kms_flip (2x-dpms-vs-vblank-race) [360.488145] Starting subtest: 2x-dpms-vs-vblank-race [360.496390] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s) [360.651238] [075/133] (660s left) kms_psr (psr-dpms) [360.754372] Starting subtest: psr-dpms [360.756310] Starting dynamic subtest: eDP-1 [363.733214] Dynamic subtest eDP-1: SUCCESS (2.979s) [363.735623] Subtest psr-dpms: SUCCESS (2.980s) [364.583460] [076/133] (656s left) gem_lmem_swapping (massive-random) [364.628807] Subtest massive-random: SKIP (0.000s) [364.678396] [077/133] (656s left) gen9_exec_parse (bb-secure) [364.734043] Subtest bb-secure: SKIP (0.000s) [364.822614] [078/133] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [364.905912] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [364.910417] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [365.045296] [079/133] (655s left) i915_suspend (fence-restore-untiled) [365.103611] Starting subtest: fence-restore-untiled [365.107947] Subtest fence-restore-untiled: SKIP (0.000s) [365.232230] [080/133] (655s left) syncobj_wait (wait-delayed-signal) [365.286057] Starting subtest: wait-delayed-signal [365.389945] Subtest wait-delayed-signal: SUCCESS (0.103s) [365.492520] [081/133] (655s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [365.582758] Starting subtest: bad-pixel-format-yf-tiled-ccs [365.585019] Starting dynamic subtest: pipe-A-eDP-1 [365.606587] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [365.617673] Starting dynamic subtest: pipe-B-eDP-1 [365.638396] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [365.647133] Starting dynamic subtest: pipe-C-eDP-1 [365.667615] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [365.676327] Starting dynamic subtest: pipe-D-eDP-1 [365.696768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [365.701054] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [367.896228] [082/133] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [368.002782] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [368.007264] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [368.152651] [083/133] (652s left) kms_chamelium_hpd (dp-hpd-fast) [368.530981] Subtest dp-hpd-fast: SKIP (0.000s) [369.346218] [084/133] (651s left) gem_exec_balancer (bonded-false-hang) [369.610754] Starting subtest: bonded-false-hang [369.615998] Subtest bonded-false-hang: SKIP (0.000s) [369.759702] [085/133] (651s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [369.851830] Starting subtest: crc-primary-suspend-yf-tiled-ccs [369.854110] Starting dynamic subtest: pipe-A-eDP-1 [369.863137] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [369.874775] Starting dynamic subtest: pipe-B-eDP-1 [369.883811] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [369.892763] Starting dynamic subtest: pipe-C-eDP-1 [369.901267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [369.909776] Starting dynamic subtest: pipe-D-eDP-1 [369.918277] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [369.922353] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [372.092346] [086/133] (649s left) gem_exec_fence (syncobj-timeline-invalid-flags) [372.635269] Starting subtest: syncobj-timeline-invalid-flags [372.637601] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s) [374.026156] [087/133] (647s left) kms_plane_cursor (overlay) [374.117195] Starting subtest: overlay [374.121697] Starting dynamic subtest: pipe-A-eDP-1-size-64 [376.726293] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.609s) [376.786726] Starting dynamic subtest: pipe-A-eDP-1-size-128 [379.271926] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.492s) [379.333841] Starting dynamic subtest: pipe-A-eDP-1-size-256 [381.873447] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.548s) [382.226547] Starting dynamic subtest: pipe-B-eDP-1-size-64 [385.419224] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.203s) [385.481008] Starting dynamic subtest: pipe-B-eDP-1-size-128 [388.001189] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s) [388.059971] Starting dynamic subtest: pipe-B-eDP-1-size-256 [390.469337] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.418s) [390.814532] Starting dynamic subtest: pipe-C-eDP-1-size-64 [393.645879] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.844s) [393.685589] Starting dynamic subtest: pipe-C-eDP-1-size-128 [395.813785] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s) [395.852208] Starting dynamic subtest: pipe-C-eDP-1-size-256 [397.969515] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.124s) [398.306268] Starting dynamic subtest: pipe-D-eDP-1-size-64 [401.177225] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.880s) [401.217939] Starting dynamic subtest: pipe-D-eDP-1-size-128 [403.330811] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.124s) [403.375013] Starting dynamic subtest: pipe-D-eDP-1-size-256 [405.432084] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.070s) [405.750876] Subtest overlay: SUCCESS (31.632s) [406.583722] [088/133] (614s left) gem_ctx_param (basic-default) [406.644910] Starting subtest: basic-default [406.647281] Subtest basic-default: SUCCESS (0.000s) [406.750250] [089/133] (614s left) api_intel_allocator (two-level-inception-interruptible) [406.811575] Starting subtest: two-level-inception-interruptible [412.215475] Subtest two-level-inception-interruptible: SUCCESS (5.405s) [412.396607] [090/133] (608s left) kms_dsc (dsc-with-bpc-formats) [412.495644] Starting subtest: dsc-with-bpc-formats [412.603062] Subtest dsc-with-bpc-formats: SKIP (0.003s) [412.647656] [091/133] (608s left) kms_cursor_crc (cursor-alpha-opaque) [412.751236] Starting subtest: cursor-alpha-opaque [412.753400] Starting dynamic subtest: pipe-A-eDP-1 [413.394467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s) [413.406332] Starting dynamic subtest: pipe-D-eDP-1 [414.689495] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s) [414.691445] Subtest cursor-alpha-opaque: SUCCESS (1.937s) [415.588993] [092/133] (605s left) syncobj_timeline (multi-wait-all-signaled) [415.650348] Starting subtest: multi-wait-all-signaled [415.652775] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [415.813773] [093/133] (605s left) i915_drm_fdinfo (isolation) [415.858605] Starting subtest: isolation [415.860677] Starting dynamic subtest: rcs0 [415.901349] Dynamic subtest rcs0: SKIP (0.043s) [415.913644] Starting dynamic subtest: bcs0 [415.918019] Dynamic subtest bcs0: SKIP (0.000s) [415.927751] Starting dynamic subtest: vcs0 [415.932490] Dynamic subtest vcs0: SKIP (0.000s) [415.941717] Starting dynamic subtest: vcs1 [415.946018] Dynamic subtest vcs1: SKIP (0.000s) [415.955248] Starting dynamic subtest: vecs0 [415.959338] Dynamic subtest vecs0: SKIP (0.000s) [415.968436] Starting dynamic subtest: ccs0 [415.972579] Dynamic subtest ccs0: SKIP (0.000s) [415.976721] Subtest isolation: SKIP (0.049s) [416.016371] [094/133] (605s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [416.120064] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [416.122324] Starting dynamic subtest: pipe-A-default-mode [417.296279] Dynamic subtest pipe-A-default-mode: SKIP (1.173s) [417.300350] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.175s) [417.507152] [095/133] (604s left) gem_ctx_isolation (preservation-s3) [417.577346] Starting subtest: preservation-S3 [417.579769] Starting dynamic subtest: rcs0 [434.123253] Dynamic subtest rcs0: SUCCESS (1.675s) [434.134127] Starting dynamic subtest: bcs0 [450.098523] Dynamic subtest bcs0: SUCCESS (1.280s) [450.109185] Starting dynamic subtest: vcs0 [466.125294] Dynamic subtest vcs0: SUCCESS (2.419s) [466.136734] Starting dynamic subtest: vcs1 [484.115715] Dynamic subtest vcs1: SUCCESS (5.026s) [484.125737] Starting dynamic subtest: vecs0 [502.145801] Dynamic subtest vecs0: SUCCESS (5.007s) [502.157325] Starting dynamic subtest: ccs0 [520.109594] Dynamic subtest ccs0: SUCCESS (3.205s) [520.112146] Subtest preservation-S3: SUCCESS (18.618s) [520.392216] [096/133] (501s left) gem_eio (reset-stress) [520.632768] Starting subtest: reset-stress [520.635390] Starting dynamic subtest: render [525.886103] Dynamic subtest render: SUCCESS (5.257s) [525.900385] Starting dynamic subtest: bsd1 [544.405870] Dynamic subtest bsd1: SUCCESS (18.532s) [544.423324] Starting dynamic subtest: bsd2 [562.426967] Dynamic subtest bsd2: SUCCESS (18.021s) [562.444148] Starting dynamic subtest: blt [562.448832] Dynamic subtest blt: SKIP (0.000s) [562.459138] Starting dynamic subtest: vebox [580.421998] Dynamic subtest vebox: SUCCESS (17.998s) [580.424204] Subtest reset-stress: SUCCESS (59.812s) [581.877390] [097/133] (439s left) gem_softpin (evict-snoop-interruptible) [581.942895] Starting subtest: evict-snoop-interruptible [581.948103] Subtest evict-snoop-interruptible: SKIP (0.000s) [582.092020] [098/133] (439s left) i915_module_load (reload-no-display) [582.128913] Starting subtest: reload-no-display [588.097623] Subtest reload-no-display: SUCCESS (5.969s) [588.128603] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [588.129282] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [588.132435] [099/133] (433s left) kms_flip (2x-flip-vs-modeset) [591.012234] Starting subtest: 2x-flip-vs-modeset [591.023149] Subtest 2x-flip-vs-modeset: SKIP (0.014s) [591.120601] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [591.121859] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [591.125806] [100/133] (430s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [591.228375] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [591.230571] Starting dynamic subtest: pipe-A-default-mode [591.537943] Dynamic subtest pipe-A-default-mode: SKIP (0.307s) [591.543069] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.308s) [592.359716] [101/133] (429s left) kms_content_protection (type1) [592.501879] Starting subtest: type1 [592.507084] Subtest type1: SKIP (0.000s) [592.646742] [102/133] (429s left) kms_big_fb (4-tiled-16bpp-rotate-180) [592.754107] Starting subtest: 4-tiled-16bpp-rotate-180 [594.063860] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.312s) [594.225300] [103/133] (427s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [594.325895] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [594.330584] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [594.440413] [104/133] (427s left) gem_ppgtt (flink-and-close-vma-leak) [594.512322] Starting subtest: flink-and-close-vma-leak [594.554065] Subtest flink-and-close-vma-leak: SUCCESS (0.042s) [594.714691] [105/133] (427s left) syncobj_wait (signal) [594.774782] Starting subtest: signal [594.776870] Subtest signal: SUCCESS (0.000s) [594.887847] [106/133] (427s left) kms_cursor_crc (cursor-rapid-movement-128x128) [595.086637] Starting subtest: cursor-rapid-movement-128x128 [595.088941] Starting dynamic subtest: pipe-A-eDP-1 [595.622481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s) [595.651419] Starting dynamic subtest: pipe-D-eDP-1 [596.841018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s) [596.844185] Subtest cursor-rapid-movement-128x128: SUCCESS (1.756s) [597.717268] [107/133] (424s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [602.888324] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [602.890912] Starting dynamic subtest: pipe-A-eDP-1 [603.683305] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s) [603.693482] Starting dynamic subtest: pipe-B-eDP-1 [604.820985] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s) [604.826978] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.927s) [606.025702] [108/133] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [606.128648] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [612.625443] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.503s) [612.799642] [109/133] (409s left) kms_vblank (query-forked-busy) [612.895496] Starting subtest: query-forked-busy [612.898121] Starting dynamic subtest: pipe-A-eDP-1 [614.768037] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [614.784382] Starting dynamic subtest: pipe-D-eDP-1 [617.392868] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.619s) [617.395787] Subtest query-forked-busy: SUCCESS (4.498s) [618.215617] [110/133] (403s left) syncobj_timeline (invalid-transfer-non-existent-point) [618.274773] Starting subtest: invalid-transfer-non-existent-point [618.277547] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [618.413140] [111/133] (403s left) kms_big_fb (x-tiled-16bpp-rotate-0) [618.513025] Starting subtest: x-tiled-16bpp-rotate-0 [619.881438] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.367s) [620.014451] [112/133] (402s left) kms_psr (fbc-psr-primary-blt) [620.112362] Starting subtest: fbc-psr-primary-blt [620.114638] Starting dynamic subtest: eDP-1 [620.118901] Dynamic subtest eDP-1: SKIP (0.000s) [620.123175] Subtest fbc-psr-primary-blt: SKIP (0.001s) [620.237727] [113/133] (402s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [620.298322] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [620.398683] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s) [620.500833] [114/133] (401s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [620.611854] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [620.616513] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [620.748620] [115/133] (401s left) gem_exec_reloc (basic-cpu-active) [620.815577] Subtest basic-cpu-active: SKIP (0.000s) [620.904187] [116/133] (401s left) perf (rc6-disable) [621.049335] Starting subtest: rc6-disable [621.230703] Subtest rc6-disable: SUCCESS (0.181s) [621.276454] [117/133] (401s left) gem_ctx_shared (q-independent) [621.340164] Starting subtest: Q-independent [621.342729] Starting dynamic subtest: rcs0 [621.410526] Dynamic subtest rcs0: SUCCESS (0.070s) [621.422771] Starting dynamic subtest: vcs0 [621.453977] Dynamic subtest vcs0: SUCCESS (0.043s) [621.464102] Starting dynamic subtest: vcs1 [621.487575] Dynamic subtest vcs1: SUCCESS (0.033s) [621.496942] Starting dynamic subtest: vecs0 [621.521405] Dynamic subtest vecs0: SUCCESS (0.033s) [621.530730] Starting dynamic subtest: ccs0 [621.559419] Dynamic subtest ccs0: SUCCESS (0.037s) [621.561934] Subtest Q-independent: SUCCESS (0.220s) [623.001526] [118/133] (399s left) perf (non-zero-reason) [623.112979] Starting subtest: non-zero-reason [623.115958] Starting dynamic subtest: 0-rcs0 [628.377903] Dynamic subtest 0-rcs0: SUCCESS (5.262s) [628.392125] Starting dynamic subtest: 1-vcs1 [632.231880] Dynamic subtest 1-vcs1: SUCCESS (3.852s) [632.234903] Subtest non-zero-reason: SUCCESS (9.115s) [632.278972] [119/133] (390s left) kms_psr (pr-dpms) [632.382936] Starting subtest: pr-dpms [632.387979] Subtest pr-dpms: SKIP (0.000s) [632.478449] [120/133] (390s left) kms_rotation_crc (primary-rotation-180) [632.582794] Starting subtest: primary-rotation-180 [639.853542] Subtest primary-rotation-180: SUCCESS (7.272s) [641.111098] [121/133] (381s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [641.235886] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [648.516092] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.282s) [648.676597] [122/133] (374s left) gem_create (create-size-update) [648.742601] Starting subtest: create-size-update [648.745328] Subtest create-size-update: SUCCESS (0.000s) [648.991776] [123/133] (373s left) prime_vgem (basic-fence-blt) [649.076395] Starting subtest: basic-fence-blt [649.172424] Subtest basic-fence-blt: SUCCESS (0.097s) [649.333513] [124/133] (373s left) kms_getfb (getfb2-into-addfb2) [649.426014] Starting subtest: getfb2-into-addfb2 [649.428936] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [649.554548] [125/133] (373s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [649.684788] Starting subtest: verify-pxp-execution-after-suspend-resume [657.436014] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.754s) [657.612762] [126/133] (365s left) syncobj_basic (bad-pad-fd-to-handle) [657.681581] Starting subtest: bad-pad-fd-to-handle [657.684002] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [657.824415] [127/133] (365s left) dmabuf_sync_file (export-before-signal) [657.870551] Starting subtest: export-before-signal [657.873111] Subtest export-before-signal: SUCCESS (0.001s) [657.948372] [128/133] (365s left) kms_flip (2x-flip-vs-panning-vs-hang) [658.048247] Starting subtest: 2x-flip-vs-panning-vs-hang [658.055265] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s) [658.162379] [129/133] (364s left) gem_softpin (allocator-nopin-reserve) [658.224776] Starting subtest: allocator-nopin-reserve [658.331350] Subtest allocator-nopin-reserve: SUCCESS (0.105s) [658.493212] [130/133] (364s left) kms_pipe_crc_basic (read-crc-frame-sequence) [658.593375] Starting subtest: read-crc-frame-sequence [658.595721] Starting dynamic subtest: pipe-A-eDP-1 [659.297274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s) [659.309892] Starting dynamic subtest: pipe-B-eDP-1 [660.652656] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.355s) [660.662961] Starting dynamic subtest: pipe-C-eDP-1 [661.945906] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.291s) [661.957156] Starting dynamic subtest: pipe-D-eDP-1 [663.284993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s) [663.287990] Subtest read-crc-frame-sequence: SUCCESS (4.695s) [664.150097] [131/133] (359s left) kms_frontbuffer_tracking (pipe-fbc-rte) [664.261862] Starting subtest: pipe-fbc-rte [664.269425] Starting dynamic subtest: pipe-B-eDP-1 [669.737314] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.481s) [669.744911] Subtest pipe-fbc-rte: SUCCESS (5.483s) [672.076455] [132/133] (351s left) kms_addfb_basic (too-wide) [672.178559] Starting subtest: too-wide [672.180921] Subtest too-wide: SUCCESS (0.000s) [672.316101] [133/133] (350s left) gem_exec_schedule (pi-shared-iova) [672.504875] Starting subtest: pi-shared-iova [672.507459] Starting dynamic subtest: rcs0 [672.589229] Dynamic subtest rcs0: SUCCESS (0.087s) [672.602234] Starting dynamic subtest: vcs0 [672.646123] Dynamic subtest vcs0: SUCCESS (0.056s) [672.659663] Starting dynamic subtest: vcs1 [672.700868] Dynamic subtest vcs1: SUCCESS (0.053s) [672.712764] Starting dynamic subtest: vecs0 [672.753811] Dynamic subtest vecs0: SUCCESS (0.053s) [672.765658] Starting dynamic subtest: ccs0 [672.811710] Dynamic subtest ccs0: SUCCESS (0.057s) [672.814596] Subtest pi-shared-iova: SUCCESS (0.310s) [673.990606] Closing watchdogs results: parsing output: 0/ for test: syncobj_basic results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: gem_ccs results: parsing output: 3/ for test: kms_sequence results: parsing output: 4/ for test: sysfs_preempt_timeout results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_ctx_persistence results: parsing output: 7/ for test: drm_read results: parsing output: 8/ for test: gem_render_copy_redux results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_suspend results: parsing output: 12/ for test: kms_hdmi_inject results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_pm_rpm results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_chamelium_edid results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_exec_big results: parsing output: 27/ for test: gem_exec_flush results: parsing output: 28/ for test: kms_async_flips results: parsing output: 29/ for test: kms_plane_scaling results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_properties results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_ccs results: parsing output: 34/ for test: gem_wait results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: gem_exec_whisper results: parsing output: 42/ for test: i915_query results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_flush results: parsing output: 47/ for test: gem_basic results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_plane results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_mmap results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: api_intel_bb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_dp_linktrain_fallback results: parsing output: 59/ for test: gem_readwrite results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: prime_vgem results: parsing output: 62/ for test: perf_pmu results: parsing output: 63/ for test: i915_pm_rpm results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: kms_color results: parsing output: 67/ for test: gem_mmap_offset results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_pm_dc results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: gem_pxp results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: gem_lmem_swapping results: parsing output: 76/ for test: gen9_exec_parse results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: i915_suspend results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_chamelium_hpd results: parsing output: 83/ for test: gem_exec_balancer results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_fence results: parsing output: 86/ for test: kms_plane_cursor results: parsing output: 87/ for test: gem_ctx_param results: parsing output: 88/ for test: api_intel_allocator results: parsing output: 89/ for test: kms_dsc results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: i915_drm_fdinfo results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: gem_ctx_isolation results: parsing output: 95/ for test: gem_eio results: parsing output: 96/ for test: gem_softpin results: parsing output: 97/ for test: i915_module_load results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: kms_content_protection results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_ppgtt results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_vblank results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: perf results: parsing output: 116/ for test: gem_ctx_shared results: parsing output: 117/ for test: perf results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_rotation_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_create results: parsing output: 122/ for test: prime_vgem results: parsing output: 123/ for test: kms_getfb results: parsing output: 124/ for test: gem_pxp results: parsing output: 125/ for test: syncobj_basic results: parsing output: 126/ for test: dmabuf_sync_file results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: gem_softpin results: parsing output: 129/ for test: kms_pipe_crc_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_addfb_basic results: parsing output: 132/ for test: gem_exec_schedule Done.