[60.801164] Initializing watchdogs [60.801209] /dev/watchdog0 [60.816063] [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] [60.820683] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.823042] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.826331] [001/133] (960s left) syncobj_basic (bad-create-flags) [60.901736] Starting subtest: bad-create-flags [60.904181] Subtest bad-create-flags: SUCCESS (0.000s) [61.035244] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [66.150222] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [66.152571] Starting dynamic subtest: pipe-A-eDP-1 [72.992401] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.828s) [73.001447] Starting dynamic subtest: pipe-B-eDP-1 [79.996700] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.941s) [79.998746] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.772s) [80.816021] [003/133] (940s left) gem_ccs (block-copy-compressed) [80.892387] Starting subtest: block-copy-compressed [80.897167] Subtest block-copy-compressed: SKIP (0.000s) [81.026855] [004/133] (940s left) kms_sequence (get-forked-busy) [81.122093] Starting subtest: get-forked-busy [81.124335] Starting dynamic subtest: pipe-A-eDP-1 [83.059298] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [83.071787] Starting dynamic subtest: pipe-B-eDP-1 [85.701338] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.639s) [85.710697] Starting dynamic subtest: pipe-C-eDP-1 [88.331313] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.629s) [88.341668] Starting dynamic subtest: pipe-D-eDP-1 [90.964658] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s) [90.966644] Subtest get-forked-busy: SUCCESS (9.836s) [91.860485] [005/133] (929s left) sysfs_preempt_timeout (timeout) [91.925746] Starting subtest: timeout [91.928153] Starting dynamic subtest: vecs0 [101.927025] Dynamic subtest vecs0: SUCCESS (9.994s) [101.936364] Starting dynamic subtest: ccs0 [103.318883] Dynamic subtest ccs0: SUCCESS (1.393s) [103.329329] Starting dynamic subtest: vcs0 [112.931987] Dynamic subtest vcs0: SUCCESS (9.609s) [112.941884] Starting dynamic subtest: bcs0 [114.285805] Dynamic subtest bcs0: SUCCESS (1.350s) [114.297963] Starting dynamic subtest: rcs0 [115.614623] Dynamic subtest rcs0: SUCCESS (1.328s) [115.623981] Starting dynamic subtest: vcs1 [124.883537] Dynamic subtest vcs1: SUCCESS (9.265s) [124.886063] Subtest timeout: SUCCESS (32.946s) [124.979183] [006/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [125.090145] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [125.094195] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [125.226366] [007/133] (896s left) gem_ctx_persistence (legacy-engines-queued) [125.277506] Starting subtest: legacy-engines-queued [125.279769] Starting dynamic subtest: render [125.386078] Dynamic subtest render: SUCCESS (0.108s) [125.396295] Starting dynamic subtest: bsd1 [126.900660] Dynamic subtest bsd1: SUCCESS (1.511s) [126.911120] Starting dynamic subtest: bsd2 [128.885402] Dynamic subtest bsd2: SUCCESS (1.982s) [128.896721] Starting dynamic subtest: blt [128.969047] Dynamic subtest blt: SUCCESS (0.083s) [128.979575] Starting dynamic subtest: vebox [130.867859] Dynamic subtest vebox: SUCCESS (1.895s) [130.871019] Subtest legacy-engines-queued: SUCCESS (5.588s) [130.969789] [008/133] (890s left) drm_read (short-buffer-block) [131.159898] Starting subtest: short-buffer-block [131.162332] Subtest short-buffer-block: SUCCESS (0.000s) [131.330282] [009/133] (890s left) gem_render_copy_redux (normal) [131.387331] Starting subtest: normal [131.653659] Subtest normal: SUCCESS (0.267s) [131.815217] [010/133] (889s left) kms_big_fb (y-tiled-32bpp-rotate-90) [131.919053] Starting subtest: y-tiled-32bpp-rotate-90 [131.922928] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [132.045934] [011/133] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [132.152820] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [139.518110] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.377s) [139.699742] [012/133] (882s left) gem_exec_suspend (basic) [139.772581] Starting subtest: basic [139.774973] Starting dynamic subtest: smem [141.910199] Dynamic subtest smem: SUCCESS (2.135s) [141.912938] Subtest basic: SUCCESS (2.136s) [142.120095] [013/133] (879s left) kms_hdmi_inject (inject-audio) [142.467835] Starting subtest: inject-audio [142.743596] Subtest inject-audio: SUCCESS (0.277s) [143.359239] [014/133] (878s left) kms_cursor_crc (cursor-sliding-32x10) [143.525741] Starting subtest: cursor-sliding-32x10 [143.571752] Subtest cursor-sliding-32x10: SKIP (0.042s) [143.864641] [015/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [143.965874] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [150.464082] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.503s) [150.623559] [016/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [150.729678] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [150.733977] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [150.857708] [017/133] (871s left) gem_render_copy (y-tiled-ccs-to-linear) [150.928090] Starting subtest: y-tiled-ccs-to-linear [150.932291] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [151.132051] [018/133] (870s left) kms_big_fb (4-tiled-16bpp-rotate-90) [151.236639] Starting subtest: 4-tiled-16bpp-rotate-90 [151.255479] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [151.426199] [019/133] (870s left) syncobj_timeline (transfer-timeline-point) [151.485021] Starting subtest: transfer-timeline-point [151.487347] Subtest transfer-timeline-point: SUCCESS (0.000s) [151.613670] [020/133] (870s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [151.678064] Starting subtest: invalid-multi-wait-unsubmitted-submitted [151.680271] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [151.813956] [021/133] (870s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [151.910770] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [151.913061] Starting dynamic subtest: pipe-A-eDP-1 [151.936894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [151.946790] Starting dynamic subtest: pipe-B-eDP-1 [151.969120] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [151.976994] Starting dynamic subtest: pipe-C-eDP-1 [151.999631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [152.007190] Starting dynamic subtest: pipe-D-eDP-1 [152.030984] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [152.035057] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [154.208761] [022/133] (867s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [156.041228] Starting subtest: dpms-mode-unset-non-lpsp [157.207533] Subtest dpms-mode-unset-non-lpsp: SKIP (1.165s) [157.607888] [023/133] (864s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [157.717091] Starting subtest: psr-rgb565-draw-mmap-wc [164.441332] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.729s) [164.587771] [024/133] (857s left) kms_chamelium_edid (vga-edid-read) [164.971068] Subtest vga-edid-read: SKIP (0.000s) [165.816513] [025/133] (856s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [165.892998] Starting subtest: yf-tiled-to-vebox-y-tiled [165.897149] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [166.096400] [026/133] (856s left) kms_flip (dpms-off-confusion) [166.192519] Starting subtest: dpms-off-confusion [166.194748] Starting dynamic subtest: A-eDP1 [174.857629] Dynamic subtest A-eDP1: SUCCESS (8.666s) [174.867330] Starting dynamic subtest: B-eDP1 [183.559792] Dynamic subtest B-eDP1: SUCCESS (8.701s) [183.569516] Starting dynamic subtest: C-eDP1 [192.246137] Dynamic subtest C-eDP1: SUCCESS (8.685s) [192.255500] Starting dynamic subtest: D-eDP1 [200.950330] Dynamic subtest D-eDP1: SUCCESS (8.702s) [200.955033] Subtest dpms-off-confusion: SUCCESS (34.764s) [202.211169] [027/133] (820s left) gem_exec_big (single) [202.285738] Starting subtest: single [204.607985] Subtest single: SUCCESS (2.321s) [204.833990] [028/133] (817s left) gem_exec_flush (basic-wb-ro-default) [204.947359] Starting subtest: basic-wb-ro-default [210.417362] Subtest basic-wb-ro-default: SUCCESS (5.469s) [210.628128] [029/133] (811s left) kms_async_flips (async-flip-with-page-flip-events-linear) [210.738248] Starting subtest: async-flip-with-page-flip-events-linear [211.109093] Starting dynamic subtest: pipe-A-eDP-1 [213.837281] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.727s) [214.210044] Starting dynamic subtest: pipe-B-eDP-1 [216.932879] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.728s) [217.291205] Starting dynamic subtest: pipe-C-eDP-1 [220.032574] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.746s) [220.392890] Starting dynamic subtest: pipe-D-eDP-1 [223.125971] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.738s) [223.128112] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.389s) [224.314227] [030/133] (798s left) kms_plane_scaling (planes-downscale-factor-0-75) [224.408139] Starting subtest: planes-downscale-factor-0-75 [224.410360] Starting dynamic subtest: pipe-A [224.430369] Dynamic subtest pipe-A: SKIP (0.019s) [224.438798] Starting dynamic subtest: pipe-B [224.464069] Dynamic subtest pipe-B: SKIP (0.033s) [224.472301] Starting dynamic subtest: pipe-C [224.497230] Dynamic subtest pipe-C: SKIP (0.033s) [224.505351] Starting dynamic subtest: pipe-D [224.530753] Dynamic subtest pipe-D: SKIP (0.032s) [224.535090] Subtest planes-downscale-factor-0-75: SKIP (0.119s) [224.659494] [031/133] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [224.767070] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [224.770971] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [224.908329] [032/133] (797s left) kms_properties (colorop-properties-legacy) [225.006076] Starting subtest: colorop-properties-legacy [225.007904] Starting dynamic subtest: pipe-A-eDP-1 [225.366772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s) [225.376177] Starting dynamic subtest: pipe-B-eDP-1 [226.407408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.037s) [226.415972] Starting dynamic subtest: pipe-C-eDP-1 [227.523954] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s) [227.532141] Starting dynamic subtest: pipe-D-eDP-1 [228.620119] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s) [228.622548] Subtest colorop-properties-legacy: SUCCESS (3.614s) [229.505110] [033/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [229.615705] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [229.619828] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [229.736418] [034/133] (792s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [229.833874] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [229.836025] Starting dynamic subtest: pipe-A-eDP-1 [229.855893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [229.864507] Starting dynamic subtest: pipe-B-eDP-1 [229.883086] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [229.890927] Starting dynamic subtest: pipe-C-eDP-1 [229.909309] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [229.917155] Starting dynamic subtest: pipe-D-eDP-1 [229.935768] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [229.937960] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [232.103669] [035/133] (790s left) gem_wait (wait) [232.174768] Starting subtest: wait [232.177192] Starting dynamic subtest: all-engines [233.877632] Dynamic subtest all-engines: SUCCESS (1.700s) [233.888220] Starting dynamic subtest: rcs0 [234.922334] Dynamic subtest rcs0: SUCCESS (1.044s) [234.933710] Starting dynamic subtest: bcs0 [235.969402] Dynamic subtest bcs0: SUCCESS (1.045s) [235.980379] Starting dynamic subtest: vcs0 [237.013146] Dynamic subtest vcs0: SUCCESS (1.042s) [237.024072] Starting dynamic subtest: vcs1 [238.058518] Dynamic subtest vcs1: SUCCESS (1.042s) [238.072125] Starting dynamic subtest: vecs0 [239.102592] Dynamic subtest vecs0: SUCCESS (1.043s) [239.113176] Starting dynamic subtest: ccs0 [240.149682] Dynamic subtest ccs0: SUCCESS (1.045s) [240.152244] Subtest wait: SUCCESS (7.975s) [240.374945] [036/133] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [240.473230] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [240.477183] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [240.592853] [037/133] (782s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [240.695828] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [241.687088] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.990s) [241.850681] [038/133] (780s left) gem_exec_reloc (basic-concurrent0) [241.922043] Subtest basic-concurrent0: SKIP (0.000s) [242.003710] [039/133] (780s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [242.111700] Starting subtest: yf-tiled-32bpp-rotate-180 [242.115501] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [242.244116] [040/133] (780s left) kms_lease (cursor-implicit-plane) [242.347388] Starting subtest: cursor-implicit-plane [242.349219] Starting dynamic subtest: pipe-A-eDP-1 [242.805610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s) [242.814881] Starting dynamic subtest: pipe-B-eDP-1 [243.970911] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s) [243.981888] Starting dynamic subtest: pipe-C-eDP-1 [245.057889] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.088s) [245.066380] Starting dynamic subtest: pipe-D-eDP-1 [246.154989] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s) [246.157314] Subtest cursor-implicit-plane: SUCCESS (3.808s) [247.008422] [041/133] (775s left) gem_exec_schedule (u-semaphore-resolve) [247.096409] Starting subtest: u-semaphore-resolve [247.124619] Subtest u-semaphore-resolve: SUCCESS (0.037s) [247.498500] [042/133] (775s left) gem_exec_whisper (basic-fds-priority) [247.554532] Starting subtest: basic-fds-priority [271.346852] Subtest basic-fds-priority: SUCCESS (23.785s) [271.547442] [043/133] (751s left) i915_query (query-topology-known-pci-ids) [271.613591] Starting subtest: query-topology-known-pci-ids [271.618110] Subtest query-topology-known-pci-ids: SKIP (0.000s) [271.753832] [044/133] (751s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [271.863130] Starting subtest: yf-tiled-64bpp-rotate-90 [271.867519] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [271.991418] [045/133] (751s left) perf_pmu (idle) [272.029711] Starting subtest: idle [272.032075] Starting dynamic subtest: rcs0 [272.602746] Dynamic subtest rcs0: SUCCESS (0.571s) [272.614531] Starting dynamic subtest: bcs0 [273.129905] Dynamic subtest bcs0: SUCCESS (0.525s) [273.141532] Starting dynamic subtest: vcs0 [273.657963] Dynamic subtest vcs0: SUCCESS (0.525s) [273.670078] Starting dynamic subtest: vcs1 [274.184466] Dynamic subtest vcs1: SUCCESS (0.524s) [274.196808] Starting dynamic subtest: vecs0 [274.716523] Dynamic subtest vecs0: SUCCESS (0.525s) [274.727487] Starting dynamic subtest: ccs0 [275.240813] Dynamic subtest ccs0: SUCCESS (0.526s) [275.272213] Subtest idle: SUCCESS (3.210s) [275.391366] [046/133] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [275.503250] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [275.507462] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [275.669858] [047/133] (747s left) gem_exec_flush (basic-uc-pro-default) [275.746746] Starting subtest: basic-uc-pro-default [281.236661] Subtest basic-uc-pro-default: SUCCESS (5.490s) [281.448218] [048/133] (741s left) gem_basic (bad-close) [281.503645] Starting subtest: bad-close [281.507958] Subtest bad-close: SUCCESS (0.000s) [281.653902] [049/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [281.747406] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [281.751274] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [281.862747] [050/133] (741s left) kms_plane (pixel-format) [281.960216] Starting subtest: pixel-format [281.989270] Starting dynamic subtest: pipe-A-plane-0 [286.788467] Dynamic subtest pipe-A-plane-0: SUCCESS (4.800s) [286.797337] Starting dynamic subtest: pipe-A-plane-3 [289.122126] Dynamic subtest pipe-A-plane-3: SUCCESS (2.333s) [289.138123] Starting dynamic subtest: pipe-A-plane-5 [289.333155] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s) [290.434520] Starting dynamic subtest: pipe-B-plane-0 [295.115530] Dynamic subtest pipe-B-plane-0: SUCCESS (4.689s) [295.124905] Starting dynamic subtest: pipe-B-plane-3 [297.415314] Dynamic subtest pipe-B-plane-3: SUCCESS (2.299s) [297.424971] Starting dynamic subtest: pipe-B-plane-5 [297.627028] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [297.935698] Subtest pixel-format: SUCCESS (15.978s) [298.810059] [051/133] (724s left) kms_psr (fbc-psr2-no-drrs) [298.909118] Starting subtest: fbc-psr2-no-drrs [298.911440] Starting dynamic subtest: eDP-1 [298.915725] Dynamic subtest eDP-1: SKIP (0.000s) [298.920092] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [299.007294] [052/133] (724s left) gem_mmap (bad-size) [299.062164] Subtest bad-size: SKIP (0.000s) [299.134121] [053/133] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [299.239691] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [299.243635] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [299.383228] [054/133] (724s left) api_intel_bb (crc32) [299.446587] Starting subtest: crc32 [299.448542] Starting dynamic subtest: rcs0-smem0 [299.750346] Dynamic subtest rcs0-smem0: SUCCESS (0.303s) [299.762353] Starting dynamic subtest: bcs0-smem0 [300.079743] Dynamic subtest bcs0-smem0: SUCCESS (0.328s) [300.090872] Starting dynamic subtest: vcs0-smem0 [300.446438] Dynamic subtest vcs0-smem0: SUCCESS (0.364s) [300.459095] Starting dynamic subtest: vcs1-smem0 [300.850655] Dynamic subtest vcs1-smem0: SUCCESS (0.401s) [300.863797] Starting dynamic subtest: vecs0-smem0 [301.208287] Dynamic subtest vecs0-smem0: SUCCESS (0.355s) [301.220244] Starting dynamic subtest: ccs0-smem0 [301.562948] Dynamic subtest ccs0-smem0: SUCCESS (0.352s) [301.565711] Subtest crc32: SUCCESS (2.119s) [301.714365] [055/133] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [301.815630] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [301.819598] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [301.946657] [056/133] (721s left) kms_psr (psr2-cursor-render) [302.041113] Starting subtest: psr2-cursor-render [302.043368] Starting dynamic subtest: eDP-1 [303.728565] Dynamic subtest eDP-1: SUCCESS (1.689s) [303.730971] Subtest psr2-cursor-render: SUCCESS (1.690s) [304.604761] [057/133] (719s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [304.698370] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [304.709885] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [304.806142] [058/133] (718s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [304.904959] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [304.907213] Starting dynamic subtest: pipe-A-eDP-1 [305.425436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s) [305.434675] Starting dynamic subtest: pipe-B-eDP-1 [306.938495] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.510s) [306.950059] Starting dynamic subtest: pipe-C-eDP-1 [308.369819] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.432s) [308.378943] Starting dynamic subtest: pipe-D-eDP-1 [309.758586] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.389s) [309.760765] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.828s) [310.912040] [059/133] (712s left) kms_dp_linktrain_fallback (dp-fallback) [311.014064] Starting subtest: dp-fallback [311.020513] Subtest dp-fallback: SKIP (0.000s) [311.110834] [060/133] (712s left) gem_readwrite (beyond-eob) [311.175423] Subtest beyond-EOB: SKIP (0.000s) [311.237879] [061/133] (712s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [311.336138] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [315.892884] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.561s) [317.111024] [062/133] (706s left) prime_vgem (basic-fence-read) [317.285672] Starting subtest: basic-fence-read [317.291956] Subtest basic-fence-read: SKIP (0.007s) [317.443802] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [317.446974] [063/133] (706s left) perf_pmu (interrupts) [317.488760] Starting subtest: interrupts [318.585398] Subtest interrupts: SUCCESS (1.096s) [318.734821] [064/133] (705s left) i915_pm_rpm (system-suspend-devices) [321.081376] Starting subtest: system-suspend-devices [328.891311] Subtest system-suspend-devices: SUCCESS (7.813s) [338.293834] [065/133] (694s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [338.425203] Starting subtest: flip-vs-dpms-on-nop-interruptible [338.427550] Starting dynamic subtest: A-eDP1 [340.246450] Dynamic subtest A-eDP1: SUCCESS (1.819s) [340.259078] Starting dynamic subtest: B-eDP1 [342.043190] Dynamic subtest B-eDP1: SUCCESS (1.796s) [342.057465] Starting dynamic subtest: C-eDP1 [343.925838] Dynamic subtest C-eDP1: SUCCESS (1.881s) [343.945294] Starting dynamic subtest: D-eDP1 [345.725928] Dynamic subtest D-eDP1: SUCCESS (1.797s) [345.731403] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.306s) [346.995846] [066/133] (685s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [347.099592] Starting subtest: crc-primary-basic-y-tiled-ccs [347.101995] Starting dynamic subtest: pipe-A-eDP-1 [347.125635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [347.137919] Starting dynamic subtest: pipe-B-eDP-1 [347.159381] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [347.168845] Starting dynamic subtest: pipe-C-eDP-1 [347.189981] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [347.199122] Starting dynamic subtest: pipe-D-eDP-1 [347.221165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [347.225550] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [349.400107] [067/133] (683s left) kms_color (ctm-0-75) [349.487071] Starting subtest: ctm-0-75 [349.489184] Starting dynamic subtest: pipe-A-eDP-1 [354.443171] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.948s) [354.456587] Starting dynamic subtest: pipe-B-eDP-1 [360.026380] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.590s) [360.036284] Starting dynamic subtest: pipe-C-eDP-1 [365.406457] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.379s) [365.417015] Starting dynamic subtest: pipe-D-eDP-1 [370.782799] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.376s) [370.785256] Subtest ctm-0-75: SUCCESS (21.297s) [371.606790] [068/133] (661s left) gem_mmap_offset (partial-mmap) [371.679463] Starting subtest: partial-mmap [371.681686] Starting dynamic subtest: smem0 [371.684377] Dynamic subtest smem0: SUCCESS (0.004s) [371.686825] Subtest partial-mmap: SUCCESS (0.005s) [371.844746] [069/133] (661s left) syncobj_timeline (device-signal-unordered) [371.908794] Starting subtest: device-signal-unordered [371.911099] Subtest device-signal-unordered: SUCCESS (0.001s) [372.047446] [070/133] (661s left) kms_pm_dc (dc6-psr) [373.139964] Starting subtest: dc6-psr [376.006291] Subtest dc6-psr: SUCCESS (2.866s) [376.893086] [071/133] (656s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [377.024317] Starting subtest: cursorB-vs-flipB-varying-size [377.028707] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [377.193455] [072/133] (656s left) kms_addfb_basic (no-handle) [377.255654] Starting subtest: no-handle [377.257976] Subtest no-handle: SUCCESS (0.000s) [377.436617] [073/133] (655s left) gem_pxp (create-regular-buffer) [377.561630] Starting subtest: create-regular-buffer [377.563970] Subtest create-regular-buffer: SUCCESS (0.000s) [377.709916] [074/133] (655s left) kms_flip (2x-dpms-vs-vblank-race) [377.803558] Starting subtest: 2x-dpms-vs-vblank-race [377.815200] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [377.919649] [075/133] (655s left) kms_psr (psr-dpms) [378.006711] Starting subtest: psr-dpms [378.008644] Starting dynamic subtest: eDP-1 [380.939427] Dynamic subtest eDP-1: SUCCESS (2.932s) [380.941678] Subtest psr-dpms: SUCCESS (2.933s) [381.792407] [076/133] (651s left) gem_lmem_swapping (massive-random) [381.834859] Subtest massive-random: SKIP (0.000s) [381.874376] [077/133] (651s left) gen9_exec_parse (bb-secure) [381.945105] Subtest bb-secure: SKIP (0.000s) [382.028362] [078/133] (651s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [382.132509] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [382.136631] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [382.280601] [079/133] (651s left) i915_suspend (fence-restore-untiled) [382.351530] Starting subtest: fence-restore-untiled [382.355905] Subtest fence-restore-untiled: SKIP (0.000s) [382.494382] [080/133] (651s left) syncobj_wait (wait-delayed-signal) [382.550668] Starting subtest: wait-delayed-signal [382.653285] Subtest wait-delayed-signal: SUCCESS (0.103s) [382.758968] [081/133] (650s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [382.858355] Starting subtest: bad-pixel-format-yf-tiled-ccs [382.860760] Starting dynamic subtest: pipe-A-eDP-1 [382.884093] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [382.895968] Starting dynamic subtest: pipe-B-eDP-1 [382.917298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [382.926609] Starting dynamic subtest: pipe-C-eDP-1 [382.947440] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [382.956638] Starting dynamic subtest: pipe-D-eDP-1 [382.977709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [382.981802] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [385.103334] [082/133] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [385.210679] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [385.215088] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [385.345986] [083/133] (648s left) kms_chamelium_hpd (dp-hpd-fast) [385.735588] Subtest dp-hpd-fast: SKIP (0.000s) [386.551786] [084/133] (647s left) gem_exec_balancer (bonded-false-hang) [386.829917] Starting subtest: bonded-false-hang [386.835115] Subtest bonded-false-hang: SKIP (0.000s) [386.979184] [085/133] (646s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [387.068087] Starting subtest: crc-primary-suspend-yf-tiled-ccs [387.070348] Starting dynamic subtest: pipe-A-eDP-1 [387.079453] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [387.091257] Starting dynamic subtest: pipe-B-eDP-1 [387.100597] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [387.112482] Starting dynamic subtest: pipe-C-eDP-1 [387.121163] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [387.130704] Starting dynamic subtest: pipe-D-eDP-1 [387.139346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [387.144047] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [389.309191] [086/133] (644s left) gem_exec_fence (syncobj-timeline-invalid-flags) [389.846792] Starting subtest: syncobj-timeline-invalid-flags [389.849062] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [391.067081] [087/133] (642s left) kms_plane_cursor (overlay) [391.163388] Starting subtest: overlay [391.167918] Starting dynamic subtest: pipe-A-eDP-1-size-64 [393.703969] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.542s) [393.766820] Starting dynamic subtest: pipe-A-eDP-1-size-128 [396.307066] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s) [396.367536] Starting dynamic subtest: pipe-A-eDP-1-size-256 [398.885753] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.526s) [399.247841] Starting dynamic subtest: pipe-B-eDP-1-size-64 [402.470481] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.232s) [402.532472] Starting dynamic subtest: pipe-B-eDP-1-size-128 [405.127683] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s) [405.188579] Starting dynamic subtest: pipe-B-eDP-1-size-256 [407.705041] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.526s) [408.067581] Starting dynamic subtest: pipe-C-eDP-1-size-64 [410.962198] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.905s) [411.001061] Starting dynamic subtest: pipe-C-eDP-1-size-128 [413.184371] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s) [413.222878] Starting dynamic subtest: pipe-C-eDP-1-size-256 [415.407339] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s) [415.736716] Starting dynamic subtest: pipe-D-eDP-1-size-64 [418.642086] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.916s) [418.680881] Starting dynamic subtest: pipe-D-eDP-1-size-128 [420.875311] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.202s) [420.914899] Starting dynamic subtest: pipe-D-eDP-1-size-256 [423.120659] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.213s) [423.440565] Subtest overlay: SUCCESS (32.275s) [424.288472] [088/133] (609s left) gem_ctx_param (basic-default) [424.340863] Starting subtest: basic-default [424.343089] Subtest basic-default: SUCCESS (0.000s) [424.441597] [089/133] (609s left) api_intel_allocator (two-level-inception-interruptible) [424.494456] Starting subtest: two-level-inception-interruptible [429.902529] Subtest two-level-inception-interruptible: SUCCESS (5.407s) [430.041140] [090/133] (603s left) kms_dsc (dsc-with-bpc-formats) [430.138118] Starting subtest: dsc-with-bpc-formats [430.250607] Subtest dsc-with-bpc-formats: SKIP (0.003s) [430.294955] [091/133] (603s left) kms_cursor_crc (cursor-alpha-opaque) [430.393150] Starting subtest: cursor-alpha-opaque [430.395098] Starting dynamic subtest: pipe-A-eDP-1 [431.012236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s) [431.023467] Starting dynamic subtest: pipe-D-eDP-1 [432.316096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [432.317980] Subtest cursor-alpha-opaque: SUCCESS (1.924s) [433.194959] [092/133] (600s left) syncobj_timeline (multi-wait-all-signaled) [433.261685] Starting subtest: multi-wait-all-signaled [433.264094] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [433.396345] [093/133] (600s left) i915_drm_fdinfo (isolation) [433.437337] Starting subtest: isolation [433.440520] Starting dynamic subtest: rcs0 [433.457454] Dynamic subtest rcs0: SKIP (0.019s) [433.467987] Starting dynamic subtest: bcs0 [433.472520] Dynamic subtest bcs0: SKIP (0.012s) [433.482365] Starting dynamic subtest: vcs0 [433.486664] Dynamic subtest vcs0: SKIP (0.000s) [433.498813] Starting dynamic subtest: vcs1 [433.502924] Dynamic subtest vcs1: SKIP (0.000s) [433.512369] Starting dynamic subtest: vecs0 [433.516416] Dynamic subtest vecs0: SKIP (0.000s) [433.525778] Starting dynamic subtest: ccs0 [433.529851] Dynamic subtest ccs0: SKIP (0.000s) [433.533946] Subtest isolation: SKIP (0.036s) [433.572876] [094/133] (600s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [433.661237] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [433.663388] Starting dynamic subtest: pipe-A-default-mode [434.799281] Dynamic subtest pipe-A-default-mode: SKIP (1.134s) [434.803421] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.136s) [434.973463] [095/133] (599s left) gem_ctx_isolation (preservation-s3) [435.042234] Starting subtest: preservation-S3 [435.044180] Starting dynamic subtest: rcs0 [451.603105] Dynamic subtest rcs0: SUCCESS (1.747s) [451.614123] Starting dynamic subtest: bcs0 [468.601428] Dynamic subtest bcs0: SUCCESS (1.717s) [468.614413] Starting dynamic subtest: vcs0 [485.593842] Dynamic subtest vcs0: SUCCESS (2.857s) [485.604656] Starting dynamic subtest: vcs1 [503.609177] Dynamic subtest vcs1: SUCCESS (5.007s) [503.619456] Starting dynamic subtest: vecs0 [521.612053] Dynamic subtest vecs0: SUCCESS (5.071s) [521.622850] Starting dynamic subtest: ccs0 [539.603465] Dynamic subtest ccs0: SUCCESS (3.209s) [539.605727] Subtest preservation-S3: SUCCESS (19.613s) [549.903929] [096/133] (494s left) gem_eio (reset-stress) [550.160081] Starting subtest: reset-stress [550.162359] Starting dynamic subtest: render [555.713716] Dynamic subtest render: SUCCESS (5.388s) [555.731519] Starting dynamic subtest: bsd1 [573.449743] Dynamic subtest bsd1: SUCCESS (17.574s) [573.467699] Starting dynamic subtest: bsd2 [591.370882] Dynamic subtest bsd2: SUCCESS (17.900s) [591.387704] Starting dynamic subtest: blt [591.392301] Dynamic subtest blt: SKIP (0.000s) [591.402237] Starting dynamic subtest: vebox [609.475530] Dynamic subtest vebox: SUCCESS (18.095s) [609.477928] Subtest reset-stress: SUCCESS (58.963s) [610.924362] [097/133] (433s left) gem_softpin (evict-snoop-interruptible) [610.988535] Starting subtest: evict-snoop-interruptible [610.992808] Subtest evict-snoop-interruptible: SKIP (0.000s) [611.150288] [098/133] (433s left) i915_module_load (reload-no-display) [611.187582] Starting subtest: reload-no-display [617.443527] Subtest reload-no-display: SUCCESS (6.257s) [617.473264] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [617.473935] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [617.477021] [099/133] (426s left) kms_flip (2x-flip-vs-modeset) [619.130069] Starting subtest: 2x-flip-vs-modeset [619.140339] Subtest 2x-flip-vs-modeset: SKIP (0.012s) [619.256287] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [619.257514] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [619.261184] [100/133] (425s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [619.368451] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [619.370744] Starting dynamic subtest: pipe-A-default-mode [619.656710] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [619.661394] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.288s) [620.494680] [101/133] (424s left) kms_content_protection (type1) [620.654902] Starting subtest: type1 [620.659590] Subtest type1: SKIP (0.000s) [620.810122] [102/133] (423s left) kms_big_fb (4-tiled-16bpp-rotate-180) [620.908746] Starting subtest: 4-tiled-16bpp-rotate-180 [622.174638] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.267s) [622.347774] [103/133] (422s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [622.454151] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [622.457481] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [622.572391] [104/133] (422s left) gem_ppgtt (flink-and-close-vma-leak) [622.629767] Starting subtest: flink-and-close-vma-leak [622.669569] Subtest flink-and-close-vma-leak: SUCCESS (0.043s) [622.847903] [105/133] (421s left) syncobj_wait (signal) [622.916106] Starting subtest: signal [622.918019] Subtest signal: SUCCESS (0.000s) [623.049071] [106/133] (421s left) kms_cursor_crc (cursor-rapid-movement-128x128) [623.255460] Starting subtest: cursor-rapid-movement-128x128 [623.259626] Starting dynamic subtest: pipe-A-eDP-1 [623.802482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s) [623.842656] Starting dynamic subtest: pipe-D-eDP-1 [624.976173] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.148s) [624.978314] Subtest cursor-rapid-movement-128x128: SUCCESS (1.719s) [625.850267] [107/133] (418s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [630.915026] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [630.917325] Starting dynamic subtest: pipe-A-eDP-1 [631.705274] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s) [631.715995] Starting dynamic subtest: pipe-B-eDP-1 [632.842769] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [632.847021] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.925s) [634.065020] [108/133] (410s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [634.170542] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [640.977894] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.807s) [641.144201] [109/133] (403s left) kms_vblank (query-forked-busy) [641.246964] Starting subtest: query-forked-busy [641.249191] Starting dynamic subtest: pipe-A-eDP-1 [643.122599] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s) [643.137919] Starting dynamic subtest: pipe-D-eDP-1 [645.649120] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.522s) [645.651562] Subtest query-forked-busy: SUCCESS (4.401s) [646.480992] [110/133] (398s left) syncobj_timeline (invalid-transfer-non-existent-point) [646.548848] Starting subtest: invalid-transfer-non-existent-point [646.551238] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [646.693533] [111/133] (398s left) kms_big_fb (x-tiled-16bpp-rotate-0) [646.809806] Starting subtest: x-tiled-16bpp-rotate-0 [648.165935] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.356s) [648.314870] [112/133] (396s left) kms_psr (fbc-psr-primary-blt) [648.405359] Starting subtest: fbc-psr-primary-blt [648.407226] Starting dynamic subtest: eDP-1 [648.410960] Dynamic subtest eDP-1: SKIP (0.000s) [648.414560] Subtest fbc-psr-primary-blt: SKIP (0.001s) [648.502833] [113/133] (396s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [648.567991] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [648.670947] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s) [648.774946] [114/133] (396s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [648.875473] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [648.879465] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [649.023348] [115/133] (396s left) gem_exec_reloc (basic-cpu-active) [649.093169] Subtest basic-cpu-active: SKIP (0.000s) [649.176880] [116/133] (395s left) perf (rc6-disable) [649.342437] Starting subtest: rc6-disable [649.523411] Subtest rc6-disable: SUCCESS (0.181s) [649.568163] [117/133] (395s left) gem_ctx_shared (q-independent) [649.633030] Starting subtest: Q-independent [649.635291] Starting dynamic subtest: rcs0 [649.694721] Dynamic subtest rcs0: SUCCESS (0.062s) [649.704632] Starting dynamic subtest: vcs0 [649.736889] Dynamic subtest vcs0: SUCCESS (0.041s) [649.747415] Starting dynamic subtest: vcs1 [649.783345] Dynamic subtest vcs1: SUCCESS (0.046s) [649.795651] Starting dynamic subtest: vecs0 [649.820153] Dynamic subtest vecs0: SUCCESS (0.036s) [649.829932] Starting dynamic subtest: ccs0 [649.861028] Dynamic subtest ccs0: SUCCESS (0.039s) [649.862952] Subtest Q-independent: SUCCESS (0.229s) [651.002783] [118/133] (394s left) perf (non-zero-reason) [651.146519] Starting subtest: non-zero-reason [651.149152] Starting dynamic subtest: 0-rcs0 [656.512519] Dynamic subtest 0-rcs0: SUCCESS (5.366s) [656.526598] Starting dynamic subtest: 1-vcs0 [660.411755] Dynamic subtest 1-vcs0: SUCCESS (3.899s) [660.414672] Subtest non-zero-reason: SUCCESS (9.267s) [660.468717] [119/133] (384s left) kms_psr (pr-dpms) [660.572596] Starting subtest: pr-dpms [660.577004] Subtest pr-dpms: SKIP (0.000s) [660.670893] [120/133] (384s left) kms_rotation_crc (primary-rotation-180) [660.756996] Starting subtest: primary-rotation-180 [667.794536] Subtest primary-rotation-180: SUCCESS (7.040s) [669.026553] [121/133] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [669.136995] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [676.497647] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.364s) [676.650019] [122/133] (368s left) gem_create (create-size-update) [676.709371] Starting subtest: create-size-update [676.711312] Subtest create-size-update: SUCCESS (0.000s) [676.957801] [123/133] (368s left) prime_vgem (basic-fence-blt) [677.061719] Starting subtest: basic-fence-blt [677.145937] Subtest basic-fence-blt: SUCCESS (0.086s) [677.333153] [124/133] (368s left) kms_getfb (getfb2-into-addfb2) [677.438995] Starting subtest: getfb2-into-addfb2 [677.440854] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [677.593388] [125/133] (367s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [677.704770] Starting subtest: verify-pxp-execution-after-suspend-resume [684.758204] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.055s) [691.945328] [126/133] (360s left) syncobj_basic (bad-pad-fd-to-handle) [692.025394] Starting subtest: bad-pad-fd-to-handle [692.027771] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [692.171504] [127/133] (360s left) dmabuf_sync_file (export-before-signal) [692.209788] Starting subtest: export-before-signal [692.212185] Subtest export-before-signal: SUCCESS (0.001s) [692.292025] [128/133] (360s left) kms_flip (2x-flip-vs-panning-vs-hang) [692.409793] Starting subtest: 2x-flip-vs-panning-vs-hang [692.419085] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [692.527115] [129/133] (360s left) gem_softpin (allocator-nopin-reserve) [692.596322] Starting subtest: allocator-nopin-reserve [692.691286] Subtest allocator-nopin-reserve: SUCCESS (0.095s) [692.871701] [130/133] (359s left) kms_pipe_crc_basic (read-crc-frame-sequence) [692.965442] Starting subtest: read-crc-frame-sequence [692.967125] Starting dynamic subtest: pipe-A-eDP-1 [693.677639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [693.688771] Starting dynamic subtest: pipe-B-eDP-1 [695.074561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s) [695.087598] Starting dynamic subtest: pipe-C-eDP-1 [696.360908] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s) [696.373211] Starting dynamic subtest: pipe-D-eDP-1 [697.690415] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [697.692842] Subtest read-crc-frame-sequence: SUCCESS (4.726s) [698.550535] [131/133] (354s left) kms_frontbuffer_tracking (pipe-fbc-rte) [698.639613] Starting subtest: pipe-fbc-rte [698.646508] Starting dynamic subtest: pipe-B-eDP-1 [704.110523] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.474s) [704.118464] Subtest pipe-fbc-rte: SUCCESS (5.477s) [706.374165] [132/133] (346s left) kms_addfb_basic (too-wide) [706.481224] Starting subtest: too-wide [706.483158] Subtest too-wide: SUCCESS (0.000s) [706.617063] [133/133] (346s left) gem_exec_schedule (pi-shared-iova) [706.800595] Starting subtest: pi-shared-iova [706.802725] Starting dynamic subtest: rcs0 [706.876526] Dynamic subtest rcs0: SUCCESS (0.078s) [706.891155] Starting dynamic subtest: vcs0 [706.926511] Dynamic subtest vcs0: SUCCESS (0.050s) [706.936644] Starting dynamic subtest: vcs1 [706.973690] Dynamic subtest vcs1: SUCCESS (0.046s) [706.986947] Starting dynamic subtest: vecs0 [707.021686] Dynamic subtest vecs0: SUCCESS (0.048s) [707.038524] Starting dynamic subtest: ccs0 [707.073929] Dynamic subtest ccs0: SUCCESS (0.051s) [707.076445] Subtest pi-shared-iova: SUCCESS (0.277s) [708.973959] 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.