[61.252173] Initializing watchdogs [61.252220] /dev/watchdog0 [61.281952] [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.286263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.288447] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.291910] [001/133] (960s left) syncobj_basic (bad-create-flags) [61.362667] Starting subtest: bad-create-flags [61.364809] Subtest bad-create-flags: SUCCESS (0.000s) [61.477897] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [66.510854] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [66.513260] Starting dynamic subtest: pipe-A-eDP-1 [73.341414] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.821s) [73.350730] Starting dynamic subtest: pipe-B-eDP-1 [80.320065] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.974s) [80.322606] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.798s) [81.185733] [003/133] (940s left) gem_ccs (block-copy-compressed) [81.256039] Starting subtest: block-copy-compressed [81.260320] Subtest block-copy-compressed: SKIP (0.000s) [81.421571] [004/133] (940s left) kms_sequence (get-forked-busy) [81.510989] Starting subtest: get-forked-busy [81.512915] Starting dynamic subtest: pipe-A-eDP-1 [83.457539] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s) [83.466642] Starting dynamic subtest: pipe-B-eDP-1 [86.069266] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.611s) [86.079052] Starting dynamic subtest: pipe-C-eDP-1 [88.672408] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s) [88.680796] Starting dynamic subtest: pipe-D-eDP-1 [91.305912] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.632s) [91.308346] Subtest get-forked-busy: SUCCESS (9.794s) [92.120962] [005/133] (929s left) sysfs_preempt_timeout (timeout) [92.193986] Starting subtest: timeout [92.196415] Starting dynamic subtest: vecs0 [101.931218] Dynamic subtest vecs0: SUCCESS (9.736s) [101.941771] Starting dynamic subtest: ccs0 [103.285548] Dynamic subtest ccs0: SUCCESS (1.351s) [103.296378] Starting dynamic subtest: vcs0 [112.915055] Dynamic subtest vcs0: SUCCESS (9.626s) [112.925247] Starting dynamic subtest: bcs0 [114.183076] Dynamic subtest bcs0: SUCCESS (1.268s) [114.193023] Starting dynamic subtest: rcs0 [115.577325] Dynamic subtest rcs0: SUCCESS (1.394s) [115.590698] Starting dynamic subtest: vcs1 [124.896627] Dynamic subtest vcs1: SUCCESS (9.318s) [124.899158] Subtest timeout: SUCCESS (32.699s) [124.994626] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [125.112986] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [125.117580] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [125.247683] [007/133] (896s left) gem_ctx_persistence (legacy-engines-queued) [125.310984] Starting subtest: legacy-engines-queued [125.313312] Starting dynamic subtest: render [125.413828] Dynamic subtest render: SUCCESS (0.105s) [125.424264] Starting dynamic subtest: bsd1 [126.899349] Dynamic subtest bsd1: SUCCESS (1.482s) [126.909976] Starting dynamic subtest: bsd2 [128.884347] Dynamic subtest bsd2: SUCCESS (1.983s) [128.894908] Starting dynamic subtest: blt [128.958882] Dynamic subtest blt: SUCCESS (0.075s) [128.968736] Starting dynamic subtest: vebox [130.868237] Dynamic subtest vebox: SUCCESS (1.906s) [130.871450] Subtest legacy-engines-queued: SUCCESS (5.559s) [130.970474] [008/133] (891s left) drm_read (short-buffer-block) [131.126438] Starting subtest: short-buffer-block [131.128718] Subtest short-buffer-block: SUCCESS (0.000s) [131.277492] [009/133] (890s left) gem_render_copy_redux (normal) [131.348151] Starting subtest: normal [131.612851] Subtest normal: SUCCESS (0.266s) [131.761670] [010/133] (890s left) kms_big_fb (y-tiled-32bpp-rotate-90) [131.870063] Starting subtest: y-tiled-32bpp-rotate-90 [131.873927] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [131.978414] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [132.076688] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [139.485094] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.410s) [139.655876] [012/133] (882s left) gem_exec_suspend (basic) [139.722978] Starting subtest: basic [139.725272] Starting dynamic subtest: smem [140.884580] Dynamic subtest smem: SUCCESS (1.160s) [140.887067] Subtest basic: SUCCESS (1.161s) [141.088266] [013/133] (881s left) kms_hdmi_inject (inject-audio) [141.427302] Starting subtest: inject-audio [141.703301] Subtest inject-audio: SUCCESS (0.278s) [142.324178] [014/133] (879s left) kms_cursor_crc (cursor-sliding-32x10) [142.472813] Starting subtest: cursor-sliding-32x10 [142.532830] Subtest cursor-sliding-32x10: SKIP (0.055s) [142.807699] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [142.902339] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [149.420120] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.521s) [149.582175] [016/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [149.678478] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [149.682615] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [149.814812] [017/133] (872s left) gem_render_copy (y-tiled-ccs-to-linear) [149.877763] Starting subtest: y-tiled-ccs-to-linear [149.882240] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [150.081496] [018/133] (872s left) kms_big_fb (4-tiled-16bpp-rotate-90) [150.190630] Starting subtest: 4-tiled-16bpp-rotate-90 [150.210559] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [150.360151] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [150.422606] Starting subtest: transfer-timeline-point [150.424797] Subtest transfer-timeline-point: SUCCESS (0.001s) [150.545952] [020/133] (871s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [150.606152] Starting subtest: invalid-multi-wait-unsubmitted-submitted [150.608308] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [150.723237] [021/133] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [150.822212] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [150.824519] Starting dynamic subtest: pipe-A-eDP-1 [150.850216] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [150.860939] Starting dynamic subtest: pipe-B-eDP-1 [150.884756] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [150.892078] Starting dynamic subtest: pipe-C-eDP-1 [150.916228] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [150.923364] Starting dynamic subtest: pipe-D-eDP-1 [150.948574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [150.953160] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [153.151776] [022/133] (869s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [155.080072] Starting subtest: dpms-mode-unset-non-lpsp [156.249954] Subtest dpms-mode-unset-non-lpsp: SKIP (1.167s) [156.680564] [023/133] (865s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [156.782532] Starting subtest: psr-rgb565-draw-mmap-wc [163.536186] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.758s) [163.683320] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [164.096187] Subtest vga-edid-read: SKIP (0.000s) [164.895459] [025/133] (857s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [164.961387] Starting subtest: yf-tiled-to-vebox-y-tiled [164.965787] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [165.167320] [026/133] (857s left) kms_flip (dpms-off-confusion) [165.269555] Starting subtest: dpms-off-confusion [165.271974] Starting dynamic subtest: A-eDP1 [173.916151] Dynamic subtest A-eDP1: SUCCESS (8.648s) [173.926691] Starting dynamic subtest: B-eDP1 [182.545309] Dynamic subtest B-eDP1: SUCCESS (8.627s) [182.563621] Starting dynamic subtest: C-eDP1 [191.185911] Dynamic subtest C-eDP1: SUCCESS (8.638s) [191.195181] Starting dynamic subtest: D-eDP1 [199.821548] Dynamic subtest D-eDP1: SUCCESS (8.634s) [199.824233] Subtest dpms-off-confusion: SUCCESS (34.557s) [201.010896] [027/133] (821s left) gem_exec_big (single) [201.078091] Starting subtest: single [203.433538] Subtest single: FAIL (2.293s) [203.484673] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [203.594613] Starting subtest: basic-wb-ro-default [209.063466] Subtest basic-wb-ro-default: SUCCESS (5.469s) [209.272482] [029/133] (813s left) kms_async_flips (async-flip-with-page-flip-events-linear) [209.386965] Starting subtest: async-flip-with-page-flip-events-linear [209.770261] Starting dynamic subtest: pipe-A-eDP-1 [212.574229] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.803s) [212.936714] Starting dynamic subtest: pipe-B-eDP-1 [215.691244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s) [216.051594] Starting dynamic subtest: pipe-C-eDP-1 [218.823629] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.779s) [219.192262] Starting dynamic subtest: pipe-D-eDP-1 [221.955274] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s) [221.957868] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.569s) [223.176749] [030/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [223.276039] Starting subtest: planes-downscale-factor-0-75 [223.278273] Starting dynamic subtest: pipe-A [223.300802] Dynamic subtest pipe-A: SKIP (0.020s) [223.311467] Starting dynamic subtest: pipe-B [223.331839] Dynamic subtest pipe-B: SKIP (0.033s) [223.340550] Starting dynamic subtest: pipe-C [223.366739] Dynamic subtest pipe-C: SKIP (0.032s) [223.375107] Starting dynamic subtest: pipe-D [223.397815] Dynamic subtest pipe-D: SKIP (0.033s) [223.401479] Subtest planes-downscale-factor-0-75: SKIP (0.120s) [223.534343] [031/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [223.634065] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [223.637894] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [223.768499] [032/133] (799s left) kms_properties (colorop-properties-legacy) [223.855803] Starting subtest: colorop-properties-legacy [223.858143] Starting dynamic subtest: pipe-A-eDP-1 [224.217580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s) [224.227354] Starting dynamic subtest: pipe-B-eDP-1 [225.317894] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s) [225.327354] Starting dynamic subtest: pipe-C-eDP-1 [226.355984] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.036s) [226.365105] Starting dynamic subtest: pipe-D-eDP-1 [227.384305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.028s) [227.386462] Subtest colorop-properties-legacy: SUCCESS (3.530s) [228.199114] [033/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [228.309226] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [228.313409] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [228.429366] [034/133] (794s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [228.523144] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [228.525390] Starting dynamic subtest: pipe-A-eDP-1 [228.555038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [228.566753] Starting dynamic subtest: pipe-B-eDP-1 [228.585775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [228.595297] Starting dynamic subtest: pipe-C-eDP-1 [228.614196] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [228.622752] Starting dynamic subtest: pipe-D-eDP-1 [228.641203] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [228.643883] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [230.871241] [035/133] (792s left) gem_wait (wait) [230.946651] Starting subtest: wait [230.948697] Starting dynamic subtest: all-engines [232.916503] Dynamic subtest all-engines: SUCCESS (1.971s) [232.927942] Starting dynamic subtest: rcs0 [233.962299] Dynamic subtest rcs0: SUCCESS (1.045s) [233.973069] Starting dynamic subtest: bcs0 [235.008088] Dynamic subtest bcs0: SUCCESS (1.044s) [235.019297] Starting dynamic subtest: vcs0 [236.053028] Dynamic subtest vcs0: SUCCESS (1.042s) [236.064024] Starting dynamic subtest: vcs1 [237.097989] Dynamic subtest vcs1: SUCCESS (1.043s) [237.108981] Starting dynamic subtest: vecs0 [238.141699] Dynamic subtest vecs0: SUCCESS (1.042s) [238.152529] Starting dynamic subtest: ccs0 [239.187733] Dynamic subtest ccs0: SUCCESS (1.044s) [239.190337] Subtest wait: SUCCESS (8.245s) [239.409378] [036/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [239.514550] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [239.518762] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [239.628960] [037/133] (783s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [239.727861] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [240.762135] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.034s) [240.954139] [038/133] (782s left) gem_exec_reloc (basic-concurrent0) [241.022534] Subtest basic-concurrent0: SKIP (0.000s) [241.101294] [039/133] (782s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [241.227631] Starting subtest: yf-tiled-32bpp-rotate-180 [241.231369] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [241.349309] [040/133] (782s left) kms_lease (cursor-implicit-plane) [241.446597] Starting subtest: cursor-implicit-plane [241.448612] Starting dynamic subtest: pipe-A-eDP-1 [241.937116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.488s) [241.953183] Starting dynamic subtest: pipe-B-eDP-1 [243.069225] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s) [243.077810] Starting dynamic subtest: pipe-C-eDP-1 [244.176156] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s) [244.187390] Starting dynamic subtest: pipe-D-eDP-1 [245.316247] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s) [245.318682] Subtest cursor-implicit-plane: SUCCESS (3.870s) [246.201034] [041/133] (777s left) gem_exec_schedule (u-semaphore-resolve) [246.284604] Starting subtest: u-semaphore-resolve [246.313693] Subtest u-semaphore-resolve: SUCCESS (0.038s) [246.690522] [042/133] (776s left) gem_exec_whisper (basic-fds-priority) [246.767979] Starting subtest: basic-fds-priority [270.390027] Subtest basic-fds-priority: SUCCESS (23.620s) [270.594119] [043/133] (752s left) i915_query (query-topology-known-pci-ids) [270.659495] Starting subtest: query-topology-known-pci-ids [270.663978] Subtest query-topology-known-pci-ids: SKIP (0.000s) [270.801645] [044/133] (752s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [270.913456] Starting subtest: yf-tiled-64bpp-rotate-90 [270.917775] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [271.042945] [045/133] (752s left) perf_pmu (idle) [271.084948] Starting subtest: idle [271.086936] Starting dynamic subtest: rcs0 [271.615898] Dynamic subtest rcs0: SUCCESS (0.530s) [271.627704] Starting dynamic subtest: bcs0 [272.145193] Dynamic subtest bcs0: SUCCESS (0.526s) [272.157023] Starting dynamic subtest: vcs0 [272.667923] Dynamic subtest vcs0: SUCCESS (0.517s) [272.679071] Starting dynamic subtest: vcs1 [273.192676] Dynamic subtest vcs1: SUCCESS (0.527s) [273.204622] Starting dynamic subtest: vecs0 [273.718712] Dynamic subtest vecs0: SUCCESS (0.523s) [273.728205] Starting dynamic subtest: ccs0 [274.240988] Dynamic subtest ccs0: SUCCESS (0.520s) [274.243531] Subtest idle: SUCCESS (3.157s) [274.371108] [046/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [274.473293] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [274.477318] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [274.628411] [047/133] (749s left) gem_exec_flush (basic-uc-pro-default) [274.698058] Starting subtest: basic-uc-pro-default [280.146914] Subtest basic-uc-pro-default: SUCCESS (5.451s) [280.357445] [048/133] (743s left) gem_basic (bad-close) [280.426679] Starting subtest: bad-close [280.431327] Subtest bad-close: SUCCESS (0.000s) [280.571147] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [280.687563] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [280.691979] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [280.819993] [050/133] (742s left) kms_plane (pixel-format) [280.923327] Starting subtest: pixel-format [280.951714] Starting dynamic subtest: pipe-A-plane-0 [285.662547] Dynamic subtest pipe-A-plane-0: SUCCESS (4.711s) [285.671676] Starting dynamic subtest: pipe-A-plane-3 [287.984954] Dynamic subtest pipe-A-plane-3: SUCCESS (2.322s) [287.994442] Starting dynamic subtest: pipe-A-plane-5 [288.196123] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [289.254775] Starting dynamic subtest: pipe-B-plane-0 [294.080385] Dynamic subtest pipe-B-plane-0: SUCCESS (4.833s) [294.089225] Starting dynamic subtest: pipe-B-plane-3 [296.336121] Dynamic subtest pipe-B-plane-3: SUCCESS (2.255s) [296.345909] Starting dynamic subtest: pipe-B-plane-5 [296.547800] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [296.867494] Subtest pixel-format: SUCCESS (15.941s) [297.750140] [051/133] (726s left) kms_psr (fbc-psr2-no-drrs) [297.852954] Starting subtest: fbc-psr2-no-drrs [297.855263] Starting dynamic subtest: eDP-1 [297.859558] Dynamic subtest eDP-1: SKIP (0.000s) [297.863731] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [297.950879] [052/133] (725s left) gem_mmap (bad-size) [298.024949] Subtest bad-size: SKIP (0.000s) [298.094135] [053/133] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [298.200854] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [298.205243] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [298.339154] [054/133] (725s left) api_intel_bb (crc32) [298.404296] Starting subtest: crc32 [298.406227] Starting dynamic subtest: rcs0-smem0 [298.706681] Dynamic subtest rcs0-smem0: SUCCESS (0.302s) [298.718512] Starting dynamic subtest: bcs0-smem0 [299.055224] Dynamic subtest bcs0-smem0: SUCCESS (0.346s) [299.065693] Starting dynamic subtest: vcs0-smem0 [299.394209] Dynamic subtest vcs0-smem0: SUCCESS (0.337s) [299.405216] Starting dynamic subtest: vcs1-smem0 [299.756276] Dynamic subtest vcs1-smem0: SUCCESS (0.359s) [299.768116] Starting dynamic subtest: vecs0-smem0 [300.086393] Dynamic subtest vecs0-smem0: SUCCESS (0.327s) [300.099042] Starting dynamic subtest: ccs0-smem0 [300.427629] Dynamic subtest ccs0-smem0: SUCCESS (0.339s) [300.430560] Subtest crc32: SUCCESS (2.025s) [300.597711] [055/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [300.706407] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [300.710424] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [300.855111] [056/133] (723s left) kms_psr (psr2-cursor-render) [300.962253] Starting subtest: psr2-cursor-render [300.964542] Starting dynamic subtest: eDP-1 [302.692529] Dynamic subtest eDP-1: SUCCESS (1.730s) [302.694461] Subtest psr2-cursor-render: SUCCESS (1.731s) [303.504595] [057/133] (720s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [303.608115] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [303.619684] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [303.718057] [058/133] (720s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [303.808822] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [303.811147] Starting dynamic subtest: pipe-A-eDP-1 [304.298500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s) [304.309779] Starting dynamic subtest: pipe-B-eDP-1 [305.758299] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s) [305.769407] Starting dynamic subtest: pipe-C-eDP-1 [307.097068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.339s) [307.106690] Starting dynamic subtest: pipe-D-eDP-1 [308.422657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s) [308.424602] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.587s) [309.631555] [059/133] (714s left) kms_dp_linktrain_fallback (dp-fallback) [309.735388] Starting subtest: dp-fallback [309.741888] Subtest dp-fallback: SKIP (0.001s) [309.835764] [060/133] (714s left) gem_readwrite (beyond-eob) [309.897806] Subtest beyond-EOB: SKIP (0.000s) [309.986635] [061/133] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [310.097315] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [314.727674] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.633s) [315.940141] [062/133] (708s left) prime_vgem (basic-fence-read) [316.092332] Starting subtest: basic-fence-read [316.101382] Subtest basic-fence-read: SKIP (0.007s) [316.236787] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [316.240211] [063/133] (708s left) perf_pmu (interrupts) [316.284294] Starting subtest: interrupts [317.400012] Subtest interrupts: SUCCESS (1.083s) [317.509725] [064/133] (706s left) i915_pm_rpm (system-suspend-devices) [319.133275] Starting subtest: system-suspend-devices [326.909916] Subtest system-suspend-devices: SUCCESS (7.779s) [332.301699] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [332.430289] Starting subtest: flip-vs-dpms-on-nop-interruptible [332.432681] Starting dynamic subtest: A-eDP1 [334.249061] Dynamic subtest A-eDP1: SUCCESS (1.817s) [334.260786] Starting dynamic subtest: B-eDP1 [336.080298] Dynamic subtest B-eDP1: SUCCESS (1.830s) [336.091970] Starting dynamic subtest: C-eDP1 [337.910464] Dynamic subtest C-eDP1: SUCCESS (1.828s) [337.930292] Starting dynamic subtest: D-eDP1 [339.743037] Dynamic subtest D-eDP1: SUCCESS (1.830s) [339.747970] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.316s) [340.947518] [066/133] (688s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [341.047339] Starting subtest: crc-primary-basic-y-tiled-ccs [341.049694] Starting dynamic subtest: pipe-A-eDP-1 [341.073046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [341.084486] Starting dynamic subtest: pipe-B-eDP-1 [341.106533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [341.117094] Starting dynamic subtest: pipe-C-eDP-1 [341.137777] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [341.148038] Starting dynamic subtest: pipe-D-eDP-1 [341.170419] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [341.174930] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [343.301260] [067/133] (686s left) kms_color (ctm-0-75) [343.401568] Starting subtest: ctm-0-75 [343.403802] Starting dynamic subtest: pipe-A-eDP-1 [348.231307] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.832s) [348.245588] Starting dynamic subtest: pipe-B-eDP-1 [353.996216] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.764s) [354.006553] Starting dynamic subtest: pipe-C-eDP-1 [359.325665] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.328s) [359.336401] Starting dynamic subtest: pipe-D-eDP-1 [364.665799] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.340s) [364.668131] Subtest ctm-0-75: SUCCESS (21.268s) [365.513065] [068/133] (664s left) gem_mmap_offset (partial-mmap) [365.585432] Starting subtest: partial-mmap [365.587375] Starting dynamic subtest: smem0 [365.589697] Dynamic subtest smem0: SUCCESS (0.004s) [365.591952] Subtest partial-mmap: SUCCESS (0.005s) [365.754104] [069/133] (663s left) syncobj_timeline (device-signal-unordered) [365.826610] Starting subtest: device-signal-unordered [365.828978] Subtest device-signal-unordered: SUCCESS (0.000s) [365.967500] [070/133] (663s left) kms_pm_dc (dc6-psr) [367.066825] Starting subtest: dc6-psr [370.047664] Subtest dc6-psr: SUCCESS (2.979s) [370.949527] [071/133] (658s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [371.071622] Starting subtest: cursorB-vs-flipB-varying-size [371.076020] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [371.243465] [072/133] (658s left) kms_addfb_basic (no-handle) [371.306415] Starting subtest: no-handle [371.308340] Subtest no-handle: SUCCESS (0.000s) [371.487378] [073/133] (658s left) gem_pxp (create-regular-buffer) [371.624082] Starting subtest: create-regular-buffer [371.626386] Subtest create-regular-buffer: SUCCESS (0.000s) [371.775080] [074/133] (658s left) kms_flip (2x-dpms-vs-vblank-race) [371.872647] Starting subtest: 2x-dpms-vs-vblank-race [371.884337] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [372.005557] [075/133] (657s left) kms_psr (psr-dpms) [372.109112] Starting subtest: psr-dpms [372.110855] Starting dynamic subtest: eDP-1 [375.075154] Dynamic subtest eDP-1: SUCCESS (2.965s) [375.077474] Subtest psr-dpms: SUCCESS (2.966s) [375.956156] [076/133] (653s left) gem_lmem_swapping (massive-random) [376.003412] Subtest massive-random: SKIP (0.000s) [376.050524] [077/133] (653s left) gen9_exec_parse (bb-secure) [376.111621] Subtest bb-secure: SKIP (0.000s) [376.200336] [078/133] (653s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [376.307862] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [376.312012] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [376.452718] [079/133] (653s left) i915_suspend (fence-restore-untiled) [376.514599] Starting subtest: fence-restore-untiled [376.518693] Subtest fence-restore-untiled: SKIP (0.000s) [376.636182] [080/133] (653s left) syncobj_wait (wait-delayed-signal) [376.692962] Starting subtest: wait-delayed-signal [376.797063] Subtest wait-delayed-signal: SUCCESS (0.103s) [376.903171] [081/133] (653s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [376.992960] Starting subtest: bad-pixel-format-yf-tiled-ccs [376.995232] Starting dynamic subtest: pipe-A-eDP-1 [377.016960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [377.028143] Starting dynamic subtest: pipe-B-eDP-1 [377.049087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [377.058526] Starting dynamic subtest: pipe-C-eDP-1 [377.079059] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [377.088100] Starting dynamic subtest: pipe-D-eDP-1 [377.108882] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [377.113047] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [379.312530] [082/133] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [379.421802] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [379.425779] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [379.565094] [083/133] (650s left) kms_chamelium_hpd (dp-hpd-fast) [379.954751] Subtest dp-hpd-fast: SKIP (0.000s) [380.792128] [084/133] (649s left) gem_exec_balancer (bonded-false-hang) [381.044993] Starting subtest: bonded-false-hang [381.049602] Subtest bonded-false-hang: SKIP (0.000s) [381.195400] [085/133] (649s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [381.301197] Starting subtest: crc-primary-suspend-yf-tiled-ccs [381.303373] Starting dynamic subtest: pipe-A-eDP-1 [381.312324] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [381.323578] Starting dynamic subtest: pipe-B-eDP-1 [381.332178] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [381.342624] Starting dynamic subtest: pipe-C-eDP-1 [381.350800] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [381.360403] Starting dynamic subtest: pipe-D-eDP-1 [381.368296] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [381.372188] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [383.601076] [086/133] (646s left) gem_exec_fence (syncobj-timeline-invalid-flags) [384.139880] Starting subtest: syncobj-timeline-invalid-flags [384.142392] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [386.078961] [087/133] (644s left) kms_plane_cursor (overlay) [386.187951] Starting subtest: overlay [386.192530] Starting dynamic subtest: pipe-A-eDP-1-size-64 [388.711207] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.522s) [388.774797] Starting dynamic subtest: pipe-A-eDP-1-size-128 [391.366171] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.604s) [391.428308] Starting dynamic subtest: pipe-A-eDP-1-size-256 [394.012571] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.593s) [394.361317] Starting dynamic subtest: pipe-B-eDP-1-size-64 [397.726864] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.376s) [397.790313] Starting dynamic subtest: pipe-B-eDP-1-size-128 [400.395058] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.616s) [400.455806] Starting dynamic subtest: pipe-B-eDP-1-size-256 [403.051052] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.603s) [403.407114] Starting dynamic subtest: pipe-C-eDP-1-size-64 [406.314470] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.924s) [406.353273] Starting dynamic subtest: pipe-C-eDP-1-size-128 [408.503162] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s) [408.543170] Starting dynamic subtest: pipe-C-eDP-1-size-256 [410.803044] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.268s) [411.133892] Starting dynamic subtest: pipe-D-eDP-1-size-64 [414.082094] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.960s) [414.121314] Starting dynamic subtest: pipe-D-eDP-1-size-128 [416.305377] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s) [416.343461] Starting dynamic subtest: pipe-D-eDP-1-size-256 [418.539019] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.203s) [418.861647] Subtest overlay: SUCCESS (32.672s) [419.747997] [088/133] (610s left) gem_ctx_param (basic-default) [419.808804] Starting subtest: basic-default [419.811082] Subtest basic-default: SUCCESS (0.000s) [419.910730] [089/133] (610s left) api_intel_allocator (two-level-inception-interruptible) [419.969638] Starting subtest: two-level-inception-interruptible [425.412780] Subtest two-level-inception-interruptible: SUCCESS (5.441s) [425.576028] [090/133] (604s left) kms_dsc (dsc-with-bpc-formats) [425.687635] Starting subtest: dsc-with-bpc-formats [425.795885] Subtest dsc-with-bpc-formats: SKIP (0.003s) [425.842236] [091/133] (604s left) kms_cursor_crc (cursor-alpha-opaque) [425.944133] Starting subtest: cursor-alpha-opaque [425.946288] Starting dynamic subtest: pipe-A-eDP-1 [426.573276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s) [426.583975] Starting dynamic subtest: pipe-D-eDP-1 [427.811867] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s) [427.814226] Subtest cursor-alpha-opaque: SUCCESS (1.869s) [428.718079] [092/133] (601s left) syncobj_timeline (multi-wait-all-signaled) [428.783399] Starting subtest: multi-wait-all-signaled [428.785623] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [428.916475] [093/133] (601s left) i915_drm_fdinfo (isolation) [428.969923] Starting subtest: isolation [428.972044] Starting dynamic subtest: rcs0 [429.010950] Dynamic subtest rcs0: SKIP (0.040s) [429.024953] Starting dynamic subtest: bcs0 [429.029629] Dynamic subtest bcs0: SKIP (0.001s) [429.039425] Starting dynamic subtest: vcs0 [429.043790] Dynamic subtest vcs0: SKIP (0.000s) [429.052867] Starting dynamic subtest: vcs1 [429.056968] Dynamic subtest vcs1: SKIP (0.000s) [429.065986] Starting dynamic subtest: vecs0 [429.070076] Dynamic subtest vecs0: SKIP (0.000s) [429.080166] Starting dynamic subtest: ccs0 [429.084229] Dynamic subtest ccs0: SKIP (0.000s) [429.088211] Subtest isolation: SKIP (0.049s) [429.125589] [094/133] (601s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [429.238085] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [429.240354] Starting dynamic subtest: pipe-A-default-mode [430.352075] Dynamic subtest pipe-A-default-mode: SKIP (1.112s) [430.356453] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.114s) [430.535248] [095/133] (600s left) gem_ctx_isolation (preservation-s3) [430.598287] Starting subtest: preservation-S3 [430.600626] Starting dynamic subtest: rcs0 [446.767007] Dynamic subtest rcs0: SUCCESS (1.764s) [446.782637] Starting dynamic subtest: bcs0 [463.778653] Dynamic subtest bcs0: SUCCESS (1.685s) [463.789419] Starting dynamic subtest: vcs0 [480.782092] Dynamic subtest vcs0: SUCCESS (3.369s) [480.792684] Starting dynamic subtest: vcs1 [498.781898] Dynamic subtest vcs1: SUCCESS (4.966s) [498.793836] Starting dynamic subtest: vecs0 [516.786082] Dynamic subtest vecs0: SUCCESS (4.986s) [516.796751] Starting dynamic subtest: ccs0 [534.781819] Dynamic subtest ccs0: SUCCESS (3.212s) [534.784029] Subtest preservation-S3: SUCCESS (19.990s) [540.062167] [096/133] (495s left) gem_eio (reset-stress) [540.335057] Starting subtest: reset-stress [540.337346] Starting dynamic subtest: render [545.906919] Dynamic subtest render: SUCCESS (5.569s) [545.925078] Starting dynamic subtest: bsd1 [563.679435] Dynamic subtest bsd1: SUCCESS (17.770s) [563.697464] Starting dynamic subtest: bsd2 [581.649463] Dynamic subtest bsd2: SUCCESS (17.816s) [581.666772] Starting dynamic subtest: blt [581.671566] Dynamic subtest blt: SKIP (0.000s) [581.682415] Starting dynamic subtest: vebox [599.644594] Dynamic subtest vebox: SUCCESS (17.943s) [599.646939] Subtest reset-stress: SUCCESS (59.103s) [601.144254] [097/133] (434s left) gem_softpin (evict-snoop-interruptible) [601.222623] Starting subtest: evict-snoop-interruptible [601.227360] Subtest evict-snoop-interruptible: SKIP (0.000s) [601.356989] [098/133] (434s left) i915_module_load (reload-no-display) [601.386764] Starting subtest: reload-no-display [607.772099] Subtest reload-no-display: SUCCESS (6.382s) [607.804920] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [607.805594] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [607.809019] [099/133] (428s left) kms_flip (2x-flip-vs-modeset) [609.451963] Starting subtest: 2x-flip-vs-modeset [609.461872] Subtest 2x-flip-vs-modeset: SKIP (0.012s) [609.598734] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [609.599977] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [609.603535] [100/133] (426s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [609.706027] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [609.708275] Starting dynamic subtest: pipe-A-default-mode [609.997736] Dynamic subtest pipe-A-default-mode: SKIP (0.289s) [610.002347] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.290s) [610.897980] [101/133] (425s left) kms_content_protection (type1) [611.045686] Starting subtest: type1 [611.050251] Subtest type1: SKIP (0.000s) [611.199825] [102/133] (424s left) kms_big_fb (4-tiled-16bpp-rotate-180) [611.302817] Starting subtest: 4-tiled-16bpp-rotate-180 [612.559209] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.256s) [612.746116] [103/133] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [612.850611] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [612.854417] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [612.993397] [104/133] (423s left) gem_ppgtt (flink-and-close-vma-leak) [613.056151] Starting subtest: flink-and-close-vma-leak [613.099229] Subtest flink-and-close-vma-leak: SUCCESS (0.043s) [613.259100] [105/133] (422s left) syncobj_wait (signal) [613.313687] Starting subtest: signal [613.315333] Subtest signal: SUCCESS (0.000s) [613.462693] [106/133] (422s left) kms_cursor_crc (cursor-rapid-movement-128x128) [613.667959] Starting subtest: cursor-rapid-movement-128x128 [613.671989] Starting dynamic subtest: pipe-A-eDP-1 [614.204717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [614.237868] Starting dynamic subtest: pipe-D-eDP-1 [615.388860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.159s) [615.391142] Subtest cursor-rapid-movement-128x128: SUCCESS (1.719s) [616.261449] [107/133] (419s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [621.248005] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [621.250428] Starting dynamic subtest: pipe-A-eDP-1 [622.037661] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s) [622.048076] Starting dynamic subtest: pipe-B-eDP-1 [623.173135] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s) [623.177550] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.922s) [624.390975] [108/133] (411s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [624.501419] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [631.080244] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.577s) [631.254414] [109/133] (405s left) kms_vblank (query-forked-busy) [631.346614] Starting subtest: query-forked-busy [631.348755] Starting dynamic subtest: pipe-A-eDP-1 [633.221673] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s) [633.236088] Starting dynamic subtest: pipe-D-eDP-1 [635.767989] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s) [635.770347] Subtest query-forked-busy: SUCCESS (4.421s) [636.591711] [110/133] (399s left) syncobj_timeline (invalid-transfer-non-existent-point) [636.658557] Starting subtest: invalid-transfer-non-existent-point [636.660944] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [636.800635] [111/133] (399s left) kms_big_fb (x-tiled-16bpp-rotate-0) [636.893718] Starting subtest: x-tiled-16bpp-rotate-0 [638.229135] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.335s) [638.377364] [112/133] (398s left) kms_psr (fbc-psr-primary-blt) [638.477146] Starting subtest: fbc-psr-primary-blt [638.479109] Starting dynamic subtest: eDP-1 [638.482645] Dynamic subtest eDP-1: SKIP (0.000s) [638.486059] Subtest fbc-psr-primary-blt: SKIP (0.001s) [638.575358] [113/133] (397s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [638.637522] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [638.746036] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s) [638.849465] [114/133] (397s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [638.946371] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [638.950896] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [639.065671] [115/133] (397s left) gem_exec_reloc (basic-cpu-active) [639.124358] Subtest basic-cpu-active: SKIP (0.000s) [639.215189] [116/133] (397s left) perf (rc6-disable) [639.358223] Starting subtest: rc6-disable [639.552167] Subtest rc6-disable: SUCCESS (0.193s) [639.602836] [117/133] (397s left) gem_ctx_shared (q-independent) [639.671831] Starting subtest: Q-independent [639.674196] Starting dynamic subtest: rcs0 [639.736085] Dynamic subtest rcs0: SUCCESS (0.063s) [639.748712] Starting dynamic subtest: vcs0 [639.776711] Dynamic subtest vcs0: SUCCESS (0.041s) [639.787337] Starting dynamic subtest: vcs1 [639.813054] Dynamic subtest vcs1: SUCCESS (0.036s) [639.822658] Starting dynamic subtest: vecs0 [639.848505] Dynamic subtest vecs0: SUCCESS (0.035s) [639.858223] Starting dynamic subtest: ccs0 [639.889166] Dynamic subtest ccs0: SUCCESS (0.040s) [639.891105] Subtest Q-independent: SUCCESS (0.218s) [641.214436] [118/133] (395s left) perf (non-zero-reason) [641.322482] Starting subtest: non-zero-reason [641.325009] Starting dynamic subtest: 0-rcs0 [646.707976] Dynamic subtest 0-rcs0: SUCCESS (5.381s) [646.721164] Starting dynamic subtest: 1-vecs0 [650.612723] Dynamic subtest 1-vecs0: SUCCESS (3.901s) [650.615844] Subtest non-zero-reason: SUCCESS (9.285s) [650.663552] [119/133] (386s left) kms_psr (pr-dpms) [650.761712] Starting subtest: pr-dpms [650.765939] Subtest pr-dpms: SKIP (0.000s) [650.862452] [120/133] (385s left) kms_rotation_crc (primary-rotation-180) [650.963945] Starting subtest: primary-rotation-180 [658.064047] Subtest primary-rotation-180: SUCCESS (7.097s) [659.264243] [121/133] (377s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [659.365561] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [666.682759] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.325s) [666.842668] [122/133] (370s left) gem_create (create-size-update) [666.898017] Starting subtest: create-size-update [666.899948] Subtest create-size-update: SUCCESS (0.000s) [667.125069] [123/133] (369s left) prime_vgem (basic-fence-blt) [667.210929] Starting subtest: basic-fence-blt [667.292552] Subtest basic-fence-blt: SUCCESS (0.083s) [667.467804] [124/133] (369s left) kms_getfb (getfb2-into-addfb2) [667.565489] Starting subtest: getfb2-into-addfb2 [667.567683] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [667.713717] [125/133] (369s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [667.844367] Starting subtest: verify-pxp-execution-after-suspend-resume [674.914918] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.074s) [682.093251] [126/133] (361s left) syncobj_basic (bad-pad-fd-to-handle) [682.158245] Starting subtest: bad-pad-fd-to-handle [682.160275] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [682.299115] [127/133] (361s left) dmabuf_sync_file (export-before-signal) [682.348360] Starting subtest: export-before-signal [682.350608] Subtest export-before-signal: SUCCESS (0.001s) [682.431305] [128/133] (361s left) kms_flip (2x-flip-vs-panning-vs-hang) [682.532814] Starting subtest: 2x-flip-vs-panning-vs-hang [682.542476] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [682.681352] [129/133] (361s left) gem_softpin (allocator-nopin-reserve) [682.744532] Starting subtest: allocator-nopin-reserve [682.845930] Subtest allocator-nopin-reserve: SUCCESS (0.101s) [682.985745] [130/133] (361s left) kms_pipe_crc_basic (read-crc-frame-sequence) [683.081797] Starting subtest: read-crc-frame-sequence [683.083716] Starting dynamic subtest: pipe-A-eDP-1 [683.800136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s) [683.810307] Starting dynamic subtest: pipe-B-eDP-1 [685.128419] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.328s) [685.139066] Starting dynamic subtest: pipe-C-eDP-1 [686.435982] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s) [686.446952] Starting dynamic subtest: pipe-D-eDP-1 [687.767797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s) [687.770235] Subtest read-crc-frame-sequence: SUCCESS (4.688s) [688.611155] [131/133] (355s left) kms_frontbuffer_tracking (pipe-fbc-rte) [688.720776] Starting subtest: pipe-fbc-rte [688.727987] Starting dynamic subtest: pipe-B-eDP-1 [694.203696] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.487s) [694.211334] Subtest pipe-fbc-rte: SUCCESS (5.489s) [696.567283] [132/133] (347s left) kms_addfb_basic (too-wide) [696.668675] Starting subtest: too-wide [696.670899] Subtest too-wide: SUCCESS (0.000s) [696.807549] [133/133] (347s left) gem_exec_schedule (pi-shared-iova) [697.008518] Starting subtest: pi-shared-iova [697.010641] Starting dynamic subtest: rcs0 [697.080619] Dynamic subtest rcs0: SUCCESS (0.076s) [697.094796] Starting dynamic subtest: vcs0 [697.135998] Dynamic subtest vcs0: SUCCESS (0.054s) [697.146242] Starting dynamic subtest: vcs1 [697.187273] Dynamic subtest vcs1: SUCCESS (0.050s) [697.200131] Starting dynamic subtest: vecs0 [697.236931] Dynamic subtest vecs0: SUCCESS (0.049s) [697.247558] Starting dynamic subtest: ccs0 [697.292038] Dynamic subtest ccs0: SUCCESS (0.054s) [697.294408] Subtest pi-shared-iova: SUCCESS (0.288s) [699.277885] 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.