[61.399365] Initializing watchdogs [61.399408] /dev/watchdog0 [61.412932] [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] [61.417120] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.419306] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.422679] [001/133] (960s left) syncobj_basic (bad-create-flags) [61.506805] Starting subtest: bad-create-flags [61.509072] Subtest bad-create-flags: SUCCESS (0.000s) [61.673695] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [66.704903] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [66.706850] Starting dynamic subtest: pipe-A-eDP-1 [73.540459] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.830s) [73.553598] Starting dynamic subtest: pipe-B-eDP-1 [80.312022] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.767s) [80.314301] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.600s) [81.193210] [003/133] (940s left) gem_ccs (block-copy-compressed) [81.263570] Starting subtest: block-copy-compressed [81.267995] Subtest block-copy-compressed: SKIP (0.000s) [81.393971] [004/133] (940s left) kms_sequence (get-forked-busy) [81.499746] Starting subtest: get-forked-busy [81.501767] Starting dynamic subtest: pipe-A-eDP-1 [83.453130] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s) [83.462203] Starting dynamic subtest: pipe-B-eDP-1 [86.080060] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.626s) [86.089064] Starting dynamic subtest: pipe-C-eDP-1 [88.684386] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s) [88.693401] Starting dynamic subtest: pipe-D-eDP-1 [91.234910] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [91.237051] Subtest get-forked-busy: SUCCESS (9.732s) [92.125700] [005/133] (929s left) sysfs_preempt_timeout (timeout) [92.196757] Starting subtest: timeout [92.198865] Starting dynamic subtest: vecs0 [101.907525] Dynamic subtest vecs0: SUCCESS (9.706s) [101.917917] Starting dynamic subtest: ccs0 [103.212638] Dynamic subtest ccs0: SUCCESS (1.306s) [103.220810] Starting dynamic subtest: vcs0 [112.942728] Dynamic subtest vcs0: SUCCESS (9.727s) [112.953742] Starting dynamic subtest: bcs0 [114.262159] Dynamic subtest bcs0: SUCCESS (1.319s) [114.272461] Starting dynamic subtest: rcs0 [115.599902] Dynamic subtest rcs0: SUCCESS (1.338s) [115.609781] Starting dynamic subtest: vcs1 [124.904559] Dynamic subtest vcs1: SUCCESS (9.299s) [124.907118] Subtest timeout: SUCCESS (32.702s) [125.000177] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [125.106754] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [125.110826] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [125.236713] [007/133] (896s left) gem_ctx_persistence (legacy-engines-queued) [125.307228] Starting subtest: legacy-engines-queued [125.309584] Starting dynamic subtest: render [125.428982] Dynamic subtest render: SUCCESS (0.121s) [125.439863] Starting dynamic subtest: bsd1 [126.903044] Dynamic subtest bsd1: SUCCESS (1.470s) [126.913529] Starting dynamic subtest: bsd2 [128.888061] Dynamic subtest bsd2: SUCCESS (1.982s) [128.898718] Starting dynamic subtest: blt [128.973059] Dynamic subtest blt: SUCCESS (0.084s) [128.982766] Starting dynamic subtest: vebox [130.870425] Dynamic subtest vebox: SUCCESS (1.894s) [130.873407] Subtest legacy-engines-queued: SUCCESS (5.562s) [130.970018] [008/133] (891s left) drm_read (short-buffer-block) [131.147965] Starting subtest: short-buffer-block [131.150830] Subtest short-buffer-block: SUCCESS (0.000s) [131.316868] [009/133] (890s left) gem_render_copy_redux (normal) [131.384756] Starting subtest: normal [131.655612] Subtest normal: SUCCESS (0.269s) [131.817189] [010/133] (890s left) kms_big_fb (y-tiled-32bpp-rotate-90) [131.927019] Starting subtest: y-tiled-32bpp-rotate-90 [131.930868] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [132.045288] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [132.136984] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [139.384830] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.249s) [139.538049] [012/133] (882s left) gem_exec_suspend (basic) [139.611606] Starting subtest: basic [139.614020] Starting dynamic subtest: smem [140.887420] Dynamic subtest smem: SUCCESS (1.274s) [140.889910] Subtest basic: SUCCESS (1.274s) [141.091711] [013/133] (881s left) kms_hdmi_inject (inject-audio) [141.432113] Starting subtest: inject-audio [141.708686] Subtest inject-audio: SUCCESS (0.277s) [142.329889] [014/133] (880s left) kms_cursor_crc (cursor-sliding-32x10) [142.490412] Starting subtest: cursor-sliding-32x10 [142.535567] Subtest cursor-sliding-32x10: SKIP (0.040s) [142.836090] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [142.927234] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [149.388075] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.463s) [149.530064] [016/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [149.633177] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [149.637446] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [149.753223] [017/133] (872s left) gem_render_copy (y-tiled-ccs-to-linear) [149.827735] Starting subtest: y-tiled-ccs-to-linear [149.832296] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [150.033672] [018/133] (872s left) kms_big_fb (4-tiled-16bpp-rotate-90) [150.132045] Starting subtest: 4-tiled-16bpp-rotate-90 [150.153877] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.021s) [150.315869] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [150.377327] Starting subtest: transfer-timeline-point [150.379748] Subtest transfer-timeline-point: SUCCESS (0.001s) [150.507884] [020/133] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [150.566708] Starting subtest: invalid-multi-wait-unsubmitted-submitted [150.569105] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [150.694359] [021/133] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [150.781469] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [150.783910] Starting dynamic subtest: pipe-A-eDP-1 [150.809473] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [150.819228] Starting dynamic subtest: pipe-B-eDP-1 [150.842832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [150.850285] Starting dynamic subtest: pipe-C-eDP-1 [150.873971] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [150.881905] Starting dynamic subtest: pipe-D-eDP-1 [150.907196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [150.911394] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [153.001331] [022/133] (869s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [155.038421] Starting subtest: dpms-mode-unset-non-lpsp [156.197237] Subtest dpms-mode-unset-non-lpsp: SKIP (1.156s) [156.582162] [023/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [156.679303] Starting subtest: psr-rgb565-draw-mmap-wc [163.328447] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.651s) [163.502806] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [163.894949] Subtest vga-edid-read: SKIP (0.000s) [164.653619] [025/133] (858s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [164.709858] Starting subtest: yf-tiled-to-vebox-y-tiled [164.714830] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [164.914725] [026/133] (857s left) kms_flip (dpms-off-confusion) [165.007312] Starting subtest: dpms-off-confusion [165.009666] Starting dynamic subtest: A-eDP1 [173.654818] Dynamic subtest A-eDP1: SUCCESS (8.649s) [173.664568] Starting dynamic subtest: B-eDP1 [182.345400] Dynamic subtest B-eDP1: SUCCESS (8.688s) [182.356166] Starting dynamic subtest: C-eDP1 [191.047295] Dynamic subtest C-eDP1: SUCCESS (8.699s) [191.056485] Starting dynamic subtest: D-eDP1 [199.733776] Dynamic subtest D-eDP1: SUCCESS (8.685s) [199.738812] Subtest dpms-off-confusion: SUCCESS (34.733s) [201.004634] [027/133] (821s left) gem_exec_big (single) [201.064668] Starting subtest: single [203.401197] Subtest single: FAIL (2.276s) [203.444389] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [203.563468] Starting subtest: basic-wb-ro-default [209.026864] Subtest basic-wb-ro-default: SUCCESS (5.463s) [209.232522] [029/133] (813s left) kms_async_flips (async-flip-with-page-flip-events-linear) [209.336572] Starting subtest: async-flip-with-page-flip-events-linear [209.712946] Starting dynamic subtest: pipe-A-eDP-1 [212.519676] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.804s) [212.893132] Starting dynamic subtest: pipe-B-eDP-1 [215.625914] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.738s) [215.986961] Starting dynamic subtest: pipe-C-eDP-1 [218.716751] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.735s) [219.075108] Starting dynamic subtest: pipe-D-eDP-1 [221.818798] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.748s) [221.821619] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.482s) [223.000123] [030/133] (800s left) kms_plane_scaling (planes-downscale-factor-0-75) [223.104886] Starting subtest: planes-downscale-factor-0-75 [223.107194] Starting dynamic subtest: pipe-A [223.145939] Dynamic subtest pipe-A: SKIP (0.037s) [223.154453] Starting dynamic subtest: pipe-B [223.196477] Dynamic subtest pipe-B: SKIP (0.049s) [223.204524] Starting dynamic subtest: pipe-C [223.239804] Dynamic subtest pipe-C: SKIP (0.042s) [223.247674] Starting dynamic subtest: pipe-D [223.276148] Dynamic subtest pipe-D: SKIP (0.035s) [223.280067] Subtest planes-downscale-factor-0-75: SKIP (0.168s) [223.385944] [031/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [223.492459] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [223.496548] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [223.625108] [032/133] (799s left) kms_properties (colorop-properties-legacy) [223.721196] Starting subtest: colorop-properties-legacy [223.723457] Starting dynamic subtest: pipe-A-eDP-1 [224.084192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s) [224.093758] Starting dynamic subtest: pipe-B-eDP-1 [225.117901] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.033s) [225.126824] Starting dynamic subtest: pipe-C-eDP-1 [226.199341] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.082s) [226.212148] Starting dynamic subtest: pipe-D-eDP-1 [227.311141] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.109s) [227.313421] Subtest colorop-properties-legacy: SUCCESS (3.591s) [228.187348] [033/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [228.298052] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [228.302655] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [228.435198] [034/133] (794s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [228.539129] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [228.541421] Starting dynamic subtest: pipe-A-eDP-1 [228.562334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [228.572231] Starting dynamic subtest: pipe-B-eDP-1 [228.592369] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [228.600511] Starting dynamic subtest: pipe-C-eDP-1 [228.620666] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [228.628700] Starting dynamic subtest: pipe-D-eDP-1 [228.649121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.003s) [228.651600] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.015s) [230.800051] [035/133] (792s left) gem_wait (wait) [230.866052] Starting subtest: wait [230.868511] Starting dynamic subtest: all-engines [232.919618] Dynamic subtest all-engines: SUCCESS (2.051s) [232.930857] Starting dynamic subtest: rcs0 [233.965816] Dynamic subtest rcs0: SUCCESS (1.045s) [233.976739] Starting dynamic subtest: bcs0 [235.011438] Dynamic subtest bcs0: SUCCESS (1.044s) [235.022241] Starting dynamic subtest: vcs0 [236.057059] Dynamic subtest vcs0: SUCCESS (1.044s) [236.067596] Starting dynamic subtest: vcs1 [237.100909] Dynamic subtest vcs1: SUCCESS (1.041s) [237.111894] Starting dynamic subtest: vecs0 [238.145638] Dynamic subtest vecs0: SUCCESS (1.043s) [238.156939] Starting dynamic subtest: ccs0 [239.192026] Dynamic subtest ccs0: SUCCESS (1.045s) [239.194514] Subtest wait: SUCCESS (8.327s) [239.416249] [036/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [239.532604] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [239.536871] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [239.651100] [037/133] (783s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [239.758343] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [240.858943] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.100s) [241.027521] [038/133] (782s left) gem_exec_reloc (basic-concurrent0) [241.108521] Subtest basic-concurrent0: SKIP (0.000s) [241.191676] [039/133] (782s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [241.308877] Starting subtest: yf-tiled-32bpp-rotate-180 [241.312544] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [241.444731] [040/133] (781s left) kms_lease (cursor-implicit-plane) [241.552232] Starting subtest: cursor-implicit-plane [241.554129] Starting dynamic subtest: pipe-A-eDP-1 [242.013940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s) [242.021852] Starting dynamic subtest: pipe-B-eDP-1 [243.174265] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s) [243.184723] Starting dynamic subtest: pipe-C-eDP-1 [244.248662] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.069s) [244.256764] Starting dynamic subtest: pipe-D-eDP-1 [245.351080] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s) [245.353236] Subtest cursor-implicit-plane: SUCCESS (3.797s) [246.189936] [041/133] (777s left) gem_exec_schedule (u-semaphore-resolve) [246.283292] Starting subtest: u-semaphore-resolve [246.312485] Subtest u-semaphore-resolve: SUCCESS (0.037s) [246.682552] [042/133] (776s left) gem_exec_whisper (basic-fds-priority) [246.745384] Starting subtest: basic-fds-priority [270.579410] Subtest basic-fds-priority: SUCCESS (23.829s) [270.786229] [043/133] (752s left) i915_query (query-topology-known-pci-ids) [270.845083] Starting subtest: query-topology-known-pci-ids [270.849470] Subtest query-topology-known-pci-ids: SKIP (0.000s) [270.976094] [044/133] (752s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [271.081585] Starting subtest: yf-tiled-64bpp-rotate-90 [271.086060] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [271.220394] [045/133] (752s left) perf_pmu (idle) [271.271642] Starting subtest: idle [271.273464] Starting dynamic subtest: rcs0 [271.826204] Dynamic subtest rcs0: SUCCESS (0.555s) [271.838438] Starting dynamic subtest: bcs0 [272.349243] Dynamic subtest bcs0: SUCCESS (0.520s) [272.359179] Starting dynamic subtest: vcs0 [272.879886] Dynamic subtest vcs0: SUCCESS (0.528s) [272.888718] Starting dynamic subtest: vcs1 [273.397229] Dynamic subtest vcs1: SUCCESS (0.515s) [273.409206] Starting dynamic subtest: vecs0 [273.922417] Dynamic subtest vecs0: SUCCESS (0.522s) [273.934217] Starting dynamic subtest: ccs0 [274.437755] Dynamic subtest ccs0: SUCCESS (0.513s) [274.440772] Subtest idle: SUCCESS (3.168s) [274.573506] [046/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [274.673349] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [274.677364] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [274.778568] [047/133] (748s left) gem_exec_flush (basic-uc-pro-default) [274.841823] Starting subtest: basic-uc-pro-default [280.296436] Subtest basic-uc-pro-default: SUCCESS (5.455s) [280.512751] [048/133] (743s left) gem_basic (bad-close) [280.561071] Starting subtest: bad-close [280.565408] Subtest bad-close: SUCCESS (0.000s) [280.703518] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [280.804884] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [280.809344] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [280.931642] [050/133] (742s left) kms_plane (pixel-format) [281.037845] Starting subtest: pixel-format [281.064053] Starting dynamic subtest: pipe-A-plane-0 [285.874644] Dynamic subtest pipe-A-plane-0: SUCCESS (4.811s) [285.883022] Starting dynamic subtest: pipe-A-plane-3 [288.230262] Dynamic subtest pipe-A-plane-3: SUCCESS (2.354s) [288.240977] Starting dynamic subtest: pipe-A-plane-5 [288.441444] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s) [289.522808] Starting dynamic subtest: pipe-B-plane-0 [294.493183] Dynamic subtest pipe-B-plane-0: SUCCESS (4.978s) [294.504608] Starting dynamic subtest: pipe-B-plane-3 [296.726582] Dynamic subtest pipe-B-plane-3: SUCCESS (2.231s) [296.736917] Starting dynamic subtest: pipe-B-plane-5 [296.937756] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [297.249702] Subtest pixel-format: SUCCESS (16.210s) [298.094167] [051/133] (725s left) kms_psr (fbc-psr2-no-drrs) [298.198084] Starting subtest: fbc-psr2-no-drrs [298.200369] Starting dynamic subtest: eDP-1 [298.204814] Dynamic subtest eDP-1: SKIP (0.000s) [298.209252] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [298.292864] [052/133] (725s left) gem_mmap (bad-size) [298.360576] Subtest bad-size: SKIP (0.000s) [298.413948] [053/133] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [298.516349] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [298.520713] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [298.654837] [054/133] (725s left) api_intel_bb (crc32) [298.722450] Starting subtest: crc32 [298.724680] Starting dynamic subtest: rcs0-smem0 [299.014028] Dynamic subtest rcs0-smem0: SUCCESS (0.289s) [299.026389] Starting dynamic subtest: bcs0-smem0 [299.360320] Dynamic subtest bcs0-smem0: SUCCESS (0.344s) [299.371932] Starting dynamic subtest: vcs0-smem0 [299.671968] Dynamic subtest vcs0-smem0: SUCCESS (0.310s) [299.683761] Starting dynamic subtest: vcs1-smem0 [299.978185] Dynamic subtest vcs1-smem0: SUCCESS (0.303s) [299.989344] Starting dynamic subtest: vecs0-smem0 [300.291822] Dynamic subtest vecs0-smem0: SUCCESS (0.312s) [300.303503] Starting dynamic subtest: ccs0-smem0 [300.630776] Dynamic subtest ccs0-smem0: SUCCESS (0.336s) [300.633692] Subtest crc32: SUCCESS (1.908s) [300.794604] [055/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [300.887800] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [300.891974] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [301.010894] [056/133] (723s left) kms_psr (psr2-cursor-render) [301.111266] Starting subtest: psr2-cursor-render [301.113569] Starting dynamic subtest: eDP-1 [302.820629] Dynamic subtest eDP-1: SUCCESS (1.710s) [302.822883] Subtest psr2-cursor-render: SUCCESS (1.711s) [303.695986] [057/133] (720s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [303.796288] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [303.808918] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s) [303.911682] [058/133] (720s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [304.004260] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [304.006917] Starting dynamic subtest: pipe-A-eDP-1 [304.528265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s) [304.537782] Starting dynamic subtest: pipe-B-eDP-1 [305.982863] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s) [306.000528] Starting dynamic subtest: pipe-C-eDP-1 [307.352280] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s) [307.366665] Starting dynamic subtest: pipe-D-eDP-1 [308.720620] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.369s) [308.722955] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.691s) [309.885582] [059/133] (714s left) kms_dp_linktrain_fallback (dp-fallback) [309.987161] Starting subtest: dp-fallback [309.993374] Subtest dp-fallback: SKIP (0.000s) [310.080406] [060/133] (714s left) gem_readwrite (beyond-eob) [310.143130] Subtest beyond-EOB: SKIP (0.000s) [310.217960] [061/133] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [310.325829] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [314.811869] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.489s) [316.003811] [062/133] (708s left) prime_vgem (basic-fence-read) [316.126360] Starting subtest: basic-fence-read [316.134981] Subtest basic-fence-read: SKIP (0.007s) [316.276376] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [316.279456] [063/133] (708s left) perf_pmu (interrupts) [316.322777] Starting subtest: interrupts [317.419103] Subtest interrupts: SUCCESS (1.095s) [317.564326] [064/133] (706s left) i915_pm_rpm (system-suspend-devices) [319.100523] Starting subtest: system-suspend-devices [326.910370] Subtest system-suspend-devices: SUCCESS (7.811s) [327.309338] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [327.438885] Starting subtest: flip-vs-dpms-on-nop-interruptible [327.441205] Starting dynamic subtest: A-eDP1 [329.317777] Dynamic subtest A-eDP1: SUCCESS (1.878s) [329.329551] Starting dynamic subtest: B-eDP1 [331.128905] Dynamic subtest B-eDP1: SUCCESS (1.809s) [331.144428] Starting dynamic subtest: C-eDP1 [332.920291] Dynamic subtest C-eDP1: SUCCESS (1.785s) [332.929565] Starting dynamic subtest: D-eDP1 [334.711583] Dynamic subtest D-eDP1: SUCCESS (1.790s) [334.714093] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.276s) [335.982323] [066/133] (688s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [336.074801] Starting subtest: crc-primary-basic-y-tiled-ccs [336.077157] Starting dynamic subtest: pipe-A-eDP-1 [336.100438] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [336.112217] Starting dynamic subtest: pipe-B-eDP-1 [336.134786] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [336.143477] Starting dynamic subtest: pipe-C-eDP-1 [336.164610] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [336.173333] Starting dynamic subtest: pipe-D-eDP-1 [336.196641] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [336.200894] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.008s) [338.388964] [067/133] (686s left) kms_color (ctm-0-75) [338.490806] Starting subtest: ctm-0-75 [338.493080] Starting dynamic subtest: pipe-A-eDP-1 [343.406814] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.917s) [343.422304] Starting dynamic subtest: pipe-B-eDP-1 [349.007177] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.598s) [349.016701] Starting dynamic subtest: pipe-C-eDP-1 [354.363686] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.356s) [354.374264] Starting dynamic subtest: pipe-D-eDP-1 [359.690418] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.326s) [359.692657] Subtest ctm-0-75: SUCCESS (21.201s) [360.593124] [068/133] (663s left) gem_mmap_offset (partial-mmap) [360.660654] Starting subtest: partial-mmap [360.662831] Starting dynamic subtest: smem0 [360.667725] Dynamic subtest smem0: SUCCESS (0.007s) [360.670077] Subtest partial-mmap: SUCCESS (0.009s) [360.813065] [069/133] (663s left) syncobj_timeline (device-signal-unordered) [360.876763] Starting subtest: device-signal-unordered [360.879163] Subtest device-signal-unordered: SUCCESS (0.000s) [360.999354] [070/133] (663s left) kms_pm_dc (dc6-psr) [362.102232] Starting subtest: dc6-psr [364.988449] Subtest dc6-psr: SUCCESS (2.883s) [365.882453] [071/133] (658s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [365.995474] Starting subtest: cursorB-vs-flipB-varying-size [366.000059] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [366.162776] [072/133] (658s left) kms_addfb_basic (no-handle) [366.221980] Starting subtest: no-handle [366.224385] Subtest no-handle: SUCCESS (0.000s) [366.396061] [073/133] (658s left) gem_pxp (create-regular-buffer) [366.529682] Starting subtest: create-regular-buffer [366.532137] Subtest create-regular-buffer: SUCCESS (0.000s) [366.668920] [074/133] (658s left) kms_flip (2x-dpms-vs-vblank-race) [366.767738] Starting subtest: 2x-dpms-vs-vblank-race [366.777252] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [366.882447] [075/133] (657s left) kms_psr (psr-dpms) [366.991171] Starting subtest: psr-dpms [366.993032] Starting dynamic subtest: eDP-1 [369.932966] Dynamic subtest eDP-1: SUCCESS (2.940s) [369.935283] Subtest psr-dpms: SUCCESS (2.941s) [370.787960] [076/133] (654s left) gem_lmem_swapping (massive-random) [370.829745] Subtest massive-random: SKIP (0.000s) [370.868204] [077/133] (654s left) gen9_exec_parse (bb-secure) [370.940598] Subtest bb-secure: SKIP (0.000s) [371.027743] [078/133] (653s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [371.124116] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [371.128107] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [371.268935] [079/133] (653s left) i915_suspend (fence-restore-untiled) [371.332889] Starting subtest: fence-restore-untiled [371.337453] Subtest fence-restore-untiled: SKIP (0.000s) [371.481848] [080/133] (653s left) syncobj_wait (wait-delayed-signal) [371.542174] Starting subtest: wait-delayed-signal [371.644727] Subtest wait-delayed-signal: SUCCESS (0.103s) [371.746418] [081/133] (653s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [371.847921] Starting subtest: bad-pixel-format-yf-tiled-ccs [371.850157] Starting dynamic subtest: pipe-A-eDP-1 [371.873291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [371.885087] Starting dynamic subtest: pipe-B-eDP-1 [371.906293] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [371.915786] Starting dynamic subtest: pipe-C-eDP-1 [371.937591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [371.948076] Starting dynamic subtest: pipe-D-eDP-1 [371.969906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [371.973929] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [374.092495] [082/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [374.203107] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [374.207184] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [374.321021] [083/133] (650s left) kms_chamelium_hpd (dp-hpd-fast) [374.714186] Subtest dp-hpd-fast: SKIP (0.000s) [375.541502] [084/133] (649s left) gem_exec_balancer (bonded-false-hang) [375.804745] Starting subtest: bonded-false-hang [375.810213] Subtest bonded-false-hang: SKIP (0.000s) [375.951045] [085/133] (649s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [376.044507] Starting subtest: crc-primary-suspend-yf-tiled-ccs [376.046892] Starting dynamic subtest: pipe-A-eDP-1 [376.055961] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [376.066780] Starting dynamic subtest: pipe-B-eDP-1 [376.075779] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [376.085721] Starting dynamic subtest: pipe-C-eDP-1 [376.094297] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [376.103759] Starting dynamic subtest: pipe-D-eDP-1 [376.112474] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [376.116784] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [378.274222] [086/133] (647s left) gem_exec_fence (syncobj-timeline-invalid-flags) [378.818459] Starting subtest: syncobj-timeline-invalid-flags [378.821031] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [380.048333] [087/133] (645s left) kms_plane_cursor (overlay) [380.145700] Starting subtest: overlay [380.150254] Starting dynamic subtest: pipe-A-eDP-1-size-64 [382.687899] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.542s) [382.749169] Starting dynamic subtest: pipe-A-eDP-1-size-128 [385.245074] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.504s) [385.304835] Starting dynamic subtest: pipe-A-eDP-1-size-256 [387.790991] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.495s) [388.140211] Starting dynamic subtest: pipe-B-eDP-1-size-64 [391.265803] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.136s) [391.326900] Starting dynamic subtest: pipe-B-eDP-1-size-128 [393.778939] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.460s) [393.839904] Starting dynamic subtest: pipe-B-eDP-1-size-256 [396.377748] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.548s) [396.727066] Starting dynamic subtest: pipe-C-eDP-1-size-64 [399.581512] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.864s) [399.621702] Starting dynamic subtest: pipe-C-eDP-1-size-128 [401.759385] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.145s) [401.798248] Starting dynamic subtest: pipe-C-eDP-1-size-256 [403.937169] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.146s) [404.283178] Starting dynamic subtest: pipe-D-eDP-1-size-64 [407.150507] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.877s) [407.187962] Starting dynamic subtest: pipe-D-eDP-1-size-128 [409.240040] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s) [409.282587] Starting dynamic subtest: pipe-D-eDP-1-size-256 [411.405387] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s) [411.722837] Subtest overlay: SUCCESS (31.576s) [412.576964] [088/133] (612s left) gem_ctx_param (basic-default) [412.634584] Starting subtest: basic-default [412.637070] Subtest basic-default: SUCCESS (0.000s) [412.733500] [089/133] (612s left) api_intel_allocator (two-level-inception-interruptible) [412.786532] Starting subtest: two-level-inception-interruptible [418.190294] Subtest two-level-inception-interruptible: SUCCESS (5.404s) [418.351238] [090/133] (607s left) kms_dsc (dsc-with-bpc-formats) [418.446938] Starting subtest: dsc-with-bpc-formats [418.557742] Subtest dsc-with-bpc-formats: SKIP (0.003s) [418.598390] [091/133] (606s left) kms_cursor_crc (cursor-alpha-opaque) [418.702924] Starting subtest: cursor-alpha-opaque [418.705136] Starting dynamic subtest: pipe-A-eDP-1 [419.321760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s) [419.332737] Starting dynamic subtest: pipe-D-eDP-1 [420.603849] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s) [420.606306] Subtest cursor-alpha-opaque: SUCCESS (1.900s) [421.490895] [092/133] (604s left) syncobj_timeline (multi-wait-all-signaled) [421.558347] Starting subtest: multi-wait-all-signaled [421.560738] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [421.671041] [093/133] (603s left) i915_drm_fdinfo (isolation) [421.708120] Starting subtest: isolation [421.710423] Starting dynamic subtest: rcs0 [421.747107] Dynamic subtest rcs0: SKIP (0.039s) [421.759327] Starting dynamic subtest: bcs0 [421.763869] Dynamic subtest bcs0: SKIP (0.000s) [421.776069] Starting dynamic subtest: vcs0 [421.780020] Dynamic subtest vcs0: SKIP (0.000s) [421.789184] Starting dynamic subtest: vcs1 [421.793160] Dynamic subtest vcs1: SKIP (0.000s) [421.802287] Starting dynamic subtest: vecs0 [421.806331] Dynamic subtest vecs0: SKIP (0.000s) [421.817369] Starting dynamic subtest: ccs0 [421.821695] Dynamic subtest ccs0: SKIP (0.000s) [421.825917] Subtest isolation: SKIP (0.045s) [421.866375] [094/133] (603s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [421.956949] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [421.959236] Starting dynamic subtest: pipe-A-default-mode [423.087169] Dynamic subtest pipe-A-default-mode: SKIP (1.126s) [423.091265] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.127s) [423.283051] [095/133] (602s left) gem_ctx_isolation (preservation-s3) [423.351730] Starting subtest: preservation-S3 [423.354316] Starting dynamic subtest: rcs0 [439.028464] Dynamic subtest rcs0: SUCCESS (1.324s) [439.041140] Starting dynamic subtest: bcs0 [455.031218] Dynamic subtest bcs0: SUCCESS (1.377s) [455.043693] Starting dynamic subtest: vcs0 [471.048870] Dynamic subtest vcs0: SUCCESS (2.943s) [471.060607] Starting dynamic subtest: vcs1 [489.043438] Dynamic subtest vcs1: SUCCESS (4.856s) [489.060237] Starting dynamic subtest: vecs0 [507.036961] Dynamic subtest vecs0: SUCCESS (4.881s) [507.047503] Starting dynamic subtest: ccs0 [525.049449] Dynamic subtest ccs0: SUCCESS (3.220s) [525.052349] Subtest preservation-S3: SUCCESS (18.608s) [525.335461] [096/133] (500s left) gem_eio (reset-stress) [525.594433] Starting subtest: reset-stress [525.597300] Starting dynamic subtest: render [530.933356] Dynamic subtest render: SUCCESS (5.250s) [530.952166] Starting dynamic subtest: bsd1 [549.230730] Dynamic subtest bsd1: SUCCESS (18.211s) [549.251329] Starting dynamic subtest: bsd2 [567.265136] Dynamic subtest bsd2: SUCCESS (18.029s) [567.280194] Starting dynamic subtest: blt [567.285221] Dynamic subtest blt: SKIP (0.000s) [567.296447] Starting dynamic subtest: vebox [585.246753] Dynamic subtest vebox: SUCCESS (17.977s) [585.249176] Subtest reset-stress: SUCCESS (59.471s) [586.755170] [097/133] (439s left) gem_softpin (evict-snoop-interruptible) [586.817327] Starting subtest: evict-snoop-interruptible [586.822341] Subtest evict-snoop-interruptible: SKIP (0.000s) [586.969768] [098/133] (438s left) i915_module_load (reload-no-display) [587.009337] Starting subtest: reload-no-display [593.882390] Subtest reload-no-display: SUCCESS (6.872s) [593.911452] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [593.912127] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [593.915742] [099/133] (431s left) kms_flip (2x-flip-vs-modeset) [596.740683] Starting subtest: 2x-flip-vs-modeset [596.751389] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [596.860584] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [596.861734] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [596.866328] [100/133] (429s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [596.966921] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [596.969333] Starting dynamic subtest: pipe-A-default-mode [597.258839] Dynamic subtest pipe-A-default-mode: SKIP (0.289s) [597.264424] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.291s) [598.079477] [101/133] (427s left) kms_content_protection (type1) [598.233763] Starting subtest: type1 [598.239241] Subtest type1: SKIP (0.000s) [598.386306] [102/133] (427s left) kms_big_fb (4-tiled-16bpp-rotate-180) [598.489504] Starting subtest: 4-tiled-16bpp-rotate-180 [599.747269] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.257s) [599.903773] [103/133] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [599.997158] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [600.001173] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [600.134254] [104/133] (425s left) gem_ppgtt (flink-and-close-vma-leak) [600.189886] Starting subtest: flink-and-close-vma-leak [600.233430] Subtest flink-and-close-vma-leak: SUCCESS (0.043s) [600.381060] [105/133] (425s left) syncobj_wait (signal) [600.438749] Starting subtest: signal [600.441149] Subtest signal: SUCCESS (0.000s) [600.567359] [106/133] (425s left) kms_cursor_crc (cursor-rapid-movement-128x128) [600.763224] Starting subtest: cursor-rapid-movement-128x128 [600.765500] Starting dynamic subtest: pipe-A-eDP-1 [601.312451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s) [601.349895] Starting dynamic subtest: pipe-D-eDP-1 [602.506108] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s) [602.509281] Subtest cursor-rapid-movement-128x128: SUCCESS (1.744s) [603.377682] [107/133] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [608.428408] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [608.431303] Starting dynamic subtest: pipe-A-eDP-1 [609.215290] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s) [609.224414] Starting dynamic subtest: pipe-B-eDP-1 [610.351913] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s) [610.357335] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.921s) [611.568760] [108/133] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [611.669103] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [618.166792] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.499s) [618.319664] [109/133] (407s left) kms_vblank (query-forked-busy) [618.415567] Starting subtest: query-forked-busy [618.417799] Starting dynamic subtest: pipe-A-eDP-1 [620.291015] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s) [620.305999] Starting dynamic subtest: pipe-D-eDP-1 [622.852766] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s) [622.855405] Subtest query-forked-busy: SUCCESS (4.439s) [623.676665] [110/133] (402s left) syncobj_timeline (invalid-transfer-non-existent-point) [623.733257] Starting subtest: invalid-transfer-non-existent-point [623.736100] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [623.863976] [111/133] (402s left) kms_big_fb (x-tiled-16bpp-rotate-0) [623.965265] Starting subtest: x-tiled-16bpp-rotate-0 [625.231113] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.267s) [625.408817] [112/133] (401s left) kms_psr (fbc-psr-primary-blt) [625.503022] Starting subtest: fbc-psr-primary-blt [625.505197] Starting dynamic subtest: eDP-1 [625.509498] Dynamic subtest eDP-1: SKIP (0.000s) [625.513851] Subtest fbc-psr-primary-blt: SKIP (0.001s) [625.599290] [113/133] (400s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [625.661158] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [625.768904] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s) [625.868485] [114/133] (400s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [625.970021] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [625.975174] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [626.104992] [115/133] (400s left) gem_exec_reloc (basic-cpu-active) [626.169777] Subtest basic-cpu-active: SKIP (0.000s) [626.257651] [116/133] (400s left) perf (rc6-disable) [626.412437] Starting subtest: rc6-disable [626.589046] Subtest rc6-disable: SUCCESS (0.177s) [626.641287] [117/133] (399s left) gem_ctx_shared (q-independent) [626.696847] Starting subtest: Q-independent [626.699254] Starting dynamic subtest: rcs0 [626.765170] Dynamic subtest rcs0: SUCCESS (0.068s) [626.777101] Starting dynamic subtest: vcs0 [626.803697] Dynamic subtest vcs0: SUCCESS (0.038s) [626.814012] Starting dynamic subtest: vcs1 [626.844429] Dynamic subtest vcs1: SUCCESS (0.040s) [626.854689] Starting dynamic subtest: vecs0 [626.881442] Dynamic subtest vecs0: SUCCESS (0.036s) [626.891189] Starting dynamic subtest: ccs0 [626.920636] Dynamic subtest ccs0: SUCCESS (0.039s) [626.923169] Subtest Q-independent: SUCCESS (0.225s) [628.807213] [118/133] (397s left) perf (non-zero-reason) [628.912460] Starting subtest: non-zero-reason [628.915480] Starting dynamic subtest: 0-rcs0 [634.220295] Dynamic subtest 0-rcs0: SUCCESS (5.308s) [634.232553] Starting dynamic subtest: 1-vecs0 [638.077740] Dynamic subtest 1-vecs0: SUCCESS (3.857s) [638.080455] Subtest non-zero-reason: SUCCESS (9.167s) [638.129803] [119/133] (388s left) kms_psr (pr-dpms) [638.223184] Starting subtest: pr-dpms [638.228353] Subtest pr-dpms: SKIP (0.000s) [638.332238] [120/133] (388s left) kms_rotation_crc (primary-rotation-180) [638.425621] Starting subtest: primary-rotation-180 [645.712141] Subtest primary-rotation-180: SUCCESS (7.288s) [646.938903] [121/133] (379s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [647.051720] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [654.248440] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.199s) [654.407811] [122/133] (372s left) gem_create (create-size-update) [654.467022] Starting subtest: create-size-update [654.469408] Subtest create-size-update: SUCCESS (0.000s) [654.702048] [123/133] (372s left) prime_vgem (basic-fence-blt) [654.794046] Starting subtest: basic-fence-blt [654.891722] Subtest basic-fence-blt: SUCCESS (0.100s) [655.061802] [124/133] (371s left) kms_getfb (getfb2-into-addfb2) [655.156339] Starting subtest: getfb2-into-addfb2 [655.159237] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [655.294873] [125/133] (371s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [655.419476] Starting subtest: verify-pxp-execution-after-suspend-resume [662.508729] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.091s) [662.678843] [126/133] (364s left) syncobj_basic (bad-pad-fd-to-handle) [662.764243] Starting subtest: bad-pad-fd-to-handle [662.766957] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [662.880570] [127/133] (364s left) dmabuf_sync_file (export-before-signal) [662.922266] Starting subtest: export-before-signal [662.924885] Subtest export-before-signal: SUCCESS (0.001s) [663.002639] [128/133] (364s left) kms_flip (2x-flip-vs-panning-vs-hang) [663.090842] Starting subtest: 2x-flip-vs-panning-vs-hang [663.101624] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s) [663.205994] [129/133] (363s left) gem_softpin (allocator-nopin-reserve) [663.274215] Starting subtest: allocator-nopin-reserve [663.380932] Subtest allocator-nopin-reserve: SUCCESS (0.106s) [663.542247] [130/133] (363s left) kms_pipe_crc_basic (read-crc-frame-sequence) [663.640765] Starting subtest: read-crc-frame-sequence [663.643058] Starting dynamic subtest: pipe-A-eDP-1 [664.331554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s) [664.343921] Starting dynamic subtest: pipe-B-eDP-1 [665.718298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s) [665.728858] Starting dynamic subtest: pipe-C-eDP-1 [667.004079] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s) [667.016856] Starting dynamic subtest: pipe-D-eDP-1 [668.328050] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [668.330739] Subtest read-crc-frame-sequence: SUCCESS (4.688s) [669.194663] [131/133] (358s left) kms_frontbuffer_tracking (pipe-fbc-rte) [669.295270] Starting subtest: pipe-fbc-rte [669.303434] Starting dynamic subtest: pipe-B-eDP-1 [674.784361] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.492s) [674.792454] Subtest pipe-fbc-rte: SUCCESS (5.494s) [677.126188] [132/133] (350s left) kms_addfb_basic (too-wide) [677.226333] Starting subtest: too-wide [677.228636] Subtest too-wide: SUCCESS (0.000s) [677.342395] [133/133] (349s left) gem_exec_schedule (pi-shared-iova) [677.531295] Starting subtest: pi-shared-iova [677.534159] Starting dynamic subtest: rcs0 [677.618590] Dynamic subtest rcs0: SUCCESS (0.087s) [677.630267] Starting dynamic subtest: vcs0 [677.700279] Dynamic subtest vcs0: SUCCESS (0.079s) [677.713006] Starting dynamic subtest: vcs1 [677.779353] Dynamic subtest vcs1: SUCCESS (0.076s) [677.792826] Starting dynamic subtest: vecs0 [677.846421] Dynamic subtest vecs0: SUCCESS (0.068s) [677.862420] Starting dynamic subtest: ccs0 [677.921420] Dynamic subtest ccs0: SUCCESS (0.073s) [677.924725] Subtest pi-shared-iova: SUCCESS (0.390s) [678.863084] 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.