[65.674154] Initializing watchdogs [65.674202] /dev/watchdog0 [65.688367] [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] [65.692729] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [65.694814] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.696737] [001/133] (960s left) syncobj_basic (bad-create-flags) [65.758829] Starting subtest: bad-create-flags [65.759820] Subtest bad-create-flags: SUCCESS (0.000s) [65.890541] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [70.925625] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [70.926525] Starting dynamic subtest: pipe-A-eDP-1 [77.904914] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.982s) [77.911680] Starting dynamic subtest: pipe-B-eDP-1 [84.948510] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.041s) [84.949485] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.027s) [85.820423] [003/133] (940s left) gem_ccs (block-copy-compressed) [85.895302] Starting subtest: block-copy-compressed [85.897131] Subtest block-copy-compressed: SKIP (0.000s) [86.016581] [004/133] (940s left) kms_sequence (get-forked-busy) [86.098954] Starting subtest: get-forked-busy [86.099897] Starting dynamic subtest: pipe-A-eDP-1 [88.033420] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [88.039923] Starting dynamic subtest: pipe-B-eDP-1 [90.596822] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.562s) [90.602690] Starting dynamic subtest: pipe-C-eDP-1 [93.202110] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s) [93.208228] Starting dynamic subtest: pipe-D-eDP-1 [95.754517] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s) [95.755508] Subtest get-forked-busy: SUCCESS (9.656s) [96.635225] [005/133] (929s left) sysfs_preempt_timeout (timeout) [96.681081] Starting subtest: timeout [96.682073] Starting dynamic subtest: vecs0 [105.899243] Dynamic subtest vecs0: SUCCESS (9.216s) [105.910239] Starting dynamic subtest: ccs0 [107.347500] Dynamic subtest ccs0: SUCCESS (1.449s) [107.355615] Starting dynamic subtest: vcs0 [116.884295] Dynamic subtest vcs0: SUCCESS (9.534s) [116.892456] Starting dynamic subtest: bcs0 [118.209116] Dynamic subtest bcs0: SUCCESS (1.326s) [118.214923] Starting dynamic subtest: rcs0 [119.574055] Dynamic subtest rcs0: SUCCESS (1.363s) [119.581188] Starting dynamic subtest: vcs1 [128.922357] Dynamic subtest vcs1: SUCCESS (9.344s) [128.923855] Subtest timeout: SUCCESS (32.238s) [129.009730] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [129.101976] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [129.103778] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [129.228122] [007/133] (897s left) gem_ctx_persistence (legacy-engines-queued) [129.297606] Starting subtest: legacy-engines-queued [129.298753] Starting dynamic subtest: render [129.390889] Dynamic subtest render: SUCCESS (0.092s) [129.399695] Starting dynamic subtest: bsd1 [130.869171] Dynamic subtest bsd1: SUCCESS (1.474s) [130.878026] Starting dynamic subtest: bsd2 [132.852473] Dynamic subtest bsd2: SUCCESS (1.981s) [132.861379] Starting dynamic subtest: blt [132.894229] Dynamic subtest blt: SUCCESS (0.043s) [132.900878] Starting dynamic subtest: vebox [134.900761] Dynamic subtest vebox: SUCCESS (2.002s) [134.902733] Subtest legacy-engines-queued: SUCCESS (5.601s) [134.992772] [008/133] (891s left) drm_read (short-buffer-block) [135.154694] Starting subtest: short-buffer-block [135.155931] Subtest short-buffer-block: SUCCESS (0.000s) [135.317301] [009/133] (891s left) gem_render_copy_redux (normal) [135.379215] Starting subtest: normal [135.634619] Subtest normal: SUCCESS (0.255s) [135.776719] [010/133] (890s left) kms_big_fb (y-tiled-32bpp-rotate-90) [135.872081] Starting subtest: y-tiled-32bpp-rotate-90 [135.873707] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [135.986789] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [136.078197] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [143.334540] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.258s) [143.495229] [012/133] (883s left) gem_exec_suspend (basic) [143.575276] Starting subtest: basic [143.576595] Starting dynamic subtest: smem [144.918079] Dynamic subtest smem: SUCCESS (1.342s) [144.919503] Subtest basic: SUCCESS (1.343s) [145.117168] [013/133] (881s left) kms_hdmi_inject (inject-audio) [145.459593] Starting subtest: inject-audio [145.734347] Subtest inject-audio: SUCCESS (0.275s) [146.320166] [014/133] (880s left) kms_cursor_crc (cursor-sliding-32x10) [146.473036] Starting subtest: cursor-sliding-32x10 [146.511993] Subtest cursor-sliding-32x10: SKIP (0.038s) [146.804780] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [146.909470] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [153.255404] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.347s) [153.385160] [016/133] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [153.477413] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [153.479285] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [153.603769] [017/133] (873s left) gem_render_copy (y-tiled-ccs-to-linear) [153.667072] Starting subtest: y-tiled-ccs-to-linear [153.668984] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [153.862593] [018/133] (872s left) kms_big_fb (4-tiled-16bpp-rotate-90) [153.962299] Starting subtest: 4-tiled-16bpp-rotate-90 [153.982296] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [154.110831] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [154.156084] Starting subtest: transfer-timeline-point [154.156988] Subtest transfer-timeline-point: SUCCESS (0.001s) [154.266311] [020/133] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [154.309085] Starting subtest: invalid-multi-wait-unsubmitted-submitted [154.310030] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [154.436084] [021/133] (872s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [154.527399] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [154.528323] Starting dynamic subtest: pipe-A-eDP-1 [154.537885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [154.544992] Starting dynamic subtest: pipe-B-eDP-1 [154.554577] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [154.560590] Starting dynamic subtest: pipe-C-eDP-1 [154.570148] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [154.576074] Starting dynamic subtest: pipe-D-eDP-1 [154.585027] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [154.586644] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [156.787418] [022/133] (870s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [159.111216] Starting subtest: dpms-mode-unset-non-lpsp [160.266228] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s) [160.658498] [023/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [160.756788] Starting subtest: psr-rgb565-draw-mmap-wc [167.353806] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.598s) [167.495711] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [167.891189] Subtest vga-edid-read: SKIP (0.000s) [168.656179] [025/133] (858s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [168.716886] Starting subtest: yf-tiled-to-vebox-y-tiled [168.718600] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [168.915354] [026/133] (858s left) kms_flip (dpms-off-confusion) [168.999584] Starting subtest: dpms-off-confusion [169.001940] Starting dynamic subtest: A-eDP1 [177.652239] Dynamic subtest A-eDP1: SUCCESS (8.650s) [177.661375] Starting dynamic subtest: B-eDP1 [186.353247] Dynamic subtest B-eDP1: SUCCESS (8.700s) [186.362753] Starting dynamic subtest: C-eDP1 [195.036791] Dynamic subtest C-eDP1: SUCCESS (8.681s) [195.044519] Starting dynamic subtest: D-eDP1 [203.736305] Dynamic subtest D-eDP1: SUCCESS (8.698s) [203.740460] Subtest dpms-off-confusion: SUCCESS (34.740s) [204.991133] [027/133] (821s left) gem_exec_big (single) [205.050436] Starting subtest: single [207.399024] Subtest single: SUCCESS (2.345s) [207.644649] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [207.743500] Starting subtest: basic-wb-ro-default [213.211073] Subtest basic-wb-ro-default: SUCCESS (5.468s) [213.410642] [029/133] (813s left) kms_async_flips (async-flip-with-page-flip-events-linear) [213.504963] Starting subtest: async-flip-with-page-flip-events-linear [213.883940] Starting dynamic subtest: pipe-A-eDP-1 [216.623353] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s) [216.986220] Starting dynamic subtest: pipe-B-eDP-1 [219.719766] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.737s) [220.078699] Starting dynamic subtest: pipe-C-eDP-1 [222.817779] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.743s) [223.183315] Starting dynamic subtest: pipe-D-eDP-1 [225.922981] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.743s) [225.923998] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.417s) [227.089994] [030/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [227.191155] Starting subtest: planes-downscale-factor-0-75 [227.192063] Starting dynamic subtest: pipe-A [227.210060] Dynamic subtest pipe-A: SKIP (0.017s) [227.216694] Starting dynamic subtest: pipe-B [227.241244] Dynamic subtest pipe-B: SKIP (0.029s) [227.252722] Starting dynamic subtest: pipe-C [227.268745] Dynamic subtest pipe-C: SKIP (0.028s) [227.278299] Starting dynamic subtest: pipe-D [227.297817] Dynamic subtest pipe-D: SKIP (0.029s) [227.299641] Subtest planes-downscale-factor-0-75: SKIP (0.106s) [227.406452] [031/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [227.493494] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [227.495275] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [227.624731] [032/133] (799s left) kms_properties (colorop-properties-legacy) [227.723402] Starting subtest: colorop-properties-legacy [227.724244] Starting dynamic subtest: pipe-A-eDP-1 [228.074910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.350s) [228.083855] Starting dynamic subtest: pipe-B-eDP-1 [229.104452] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.029s) [229.110757] Starting dynamic subtest: pipe-C-eDP-1 [230.204579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.098s) [230.211381] Starting dynamic subtest: pipe-D-eDP-1 [231.297726] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.093s) [231.298606] Subtest colorop-properties-legacy: SUCCESS (3.575s) [232.181598] [033/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [232.276334] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [232.278076] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [232.393301] [034/133] (794s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [232.477994] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [232.478905] Starting dynamic subtest: pipe-A-eDP-1 [232.486613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [232.495555] Starting dynamic subtest: pipe-B-eDP-1 [232.503352] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [232.509901] Starting dynamic subtest: pipe-C-eDP-1 [232.517167] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [232.523514] Starting dynamic subtest: pipe-D-eDP-1 [232.530745] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [232.531619] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [234.783777] [035/133] (792s left) gem_wait (wait) [234.843473] Starting subtest: wait [234.844493] Starting dynamic subtest: all-engines [236.886848] Dynamic subtest all-engines: SUCCESS (2.041s) [236.901391] Starting dynamic subtest: rcs0 [237.935911] Dynamic subtest rcs0: SUCCESS (1.049s) [237.946800] Starting dynamic subtest: bcs0 [238.985299] Dynamic subtest bcs0: SUCCESS (1.047s) [238.995454] Starting dynamic subtest: vcs0 [240.031627] Dynamic subtest vcs0: SUCCESS (1.044s) [240.041899] Starting dynamic subtest: vcs1 [241.077279] Dynamic subtest vcs1: SUCCESS (1.043s) [241.093582] Starting dynamic subtest: vecs0 [242.125995] Dynamic subtest vecs0: SUCCESS (1.047s) [242.136055] Starting dynamic subtest: ccs0 [243.172722] Dynamic subtest ccs0: SUCCESS (1.045s) [243.173998] Subtest wait: SUCCESS (8.331s) [243.384812] [036/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [243.488618] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [243.490365] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [243.620381] [037/133] (783s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [243.755545] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [244.472621] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.503s) [244.498890] [038/133] (782s left) gem_exec_reloc (basic-concurrent0) [244.552068] Subtest basic-concurrent0: SKIP (0.000s) [244.611932] [039/133] (782s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [244.706054] Starting subtest: yf-tiled-32bpp-rotate-180 [244.707749] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [244.820984] [040/133] (782s left) kms_lease (cursor-implicit-plane) [244.906351] Starting subtest: cursor-implicit-plane [244.907490] Starting dynamic subtest: pipe-A-eDP-1 [245.360219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s) [245.370250] Starting dynamic subtest: pipe-B-eDP-1 [246.461085] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s) [246.468069] Starting dynamic subtest: pipe-C-eDP-1 [247.528951] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.066s) [247.535809] Starting dynamic subtest: pipe-D-eDP-1 [248.633749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.104s) [248.635092] Subtest cursor-implicit-plane: SUCCESS (3.728s) [249.485088] [041/133] (777s left) gem_exec_schedule (u-semaphore-resolve) [249.553683] Starting subtest: u-semaphore-resolve [249.591128] Subtest u-semaphore-resolve: SUCCESS (0.037s) [249.973374] [042/133] (777s left) gem_exec_whisper (basic-fds-priority) [250.032191] Starting subtest: basic-fds-priority [273.056875] Subtest basic-fds-priority: SUCCESS (23.023s) [273.257895] [043/133] (754s left) i915_query (query-topology-known-pci-ids) [273.304560] Starting subtest: query-topology-known-pci-ids [273.306347] Subtest query-topology-known-pci-ids: SKIP (0.000s) [273.426670] [044/133] (754s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [273.530074] Starting subtest: yf-tiled-64bpp-rotate-90 [273.531929] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [273.670754] [045/133] (753s left) perf_pmu (idle) [273.704132] Starting subtest: idle [273.705174] Starting dynamic subtest: rcs0 [274.274723] Dynamic subtest rcs0: SUCCESS (0.567s) [274.284982] Starting dynamic subtest: bcs0 [274.805258] Dynamic subtest bcs0: SUCCESS (0.527s) [274.815110] Starting dynamic subtest: vcs0 [275.333425] Dynamic subtest vcs0: SUCCESS (0.525s) [275.343343] Starting dynamic subtest: vcs1 [275.863338] Dynamic subtest vcs1: SUCCESS (0.527s) [275.873078] Starting dynamic subtest: vecs0 [276.396830] Dynamic subtest vecs0: SUCCESS (0.530s) [276.406780] Starting dynamic subtest: ccs0 [276.924840] Dynamic subtest ccs0: SUCCESS (0.524s) [276.926558] Subtest idle: SUCCESS (3.220s) [277.028495] [046/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [277.128066] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [277.130596] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [277.255489] [047/133] (750s left) gem_exec_flush (basic-uc-pro-default) [277.312558] Starting subtest: basic-uc-pro-default [282.769727] Subtest basic-uc-pro-default: SUCCESS (5.457s) [282.973267] [048/133] (744s left) gem_basic (bad-close) [283.027134] Starting subtest: bad-close [283.028883] Subtest bad-close: SUCCESS (0.000s) [283.156574] [049/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [283.253799] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [283.255648] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [283.380968] [050/133] (744s left) kms_plane (pixel-format) [283.471548] Starting subtest: pixel-format [283.502878] Starting dynamic subtest: pipe-A-plane-0 [288.213865] Dynamic subtest pipe-A-plane-0: SUCCESS (4.711s) [288.221525] Starting dynamic subtest: pipe-A-plane-3 [290.613945] Dynamic subtest pipe-A-plane-3: SUCCESS (2.399s) [290.622297] Starting dynamic subtest: pipe-A-plane-5 [290.825283] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [291.922478] Starting dynamic subtest: pipe-B-plane-0 [296.816578] Dynamic subtest pipe-B-plane-0: SUCCESS (4.900s) [296.831803] Starting dynamic subtest: pipe-B-plane-3 [299.038085] Dynamic subtest pipe-B-plane-3: SUCCESS (2.219s) [299.048913] Starting dynamic subtest: pipe-B-plane-5 [299.237850] Dynamic subtest pipe-B-plane-5: SUCCESS (0.198s) [299.545320] Subtest pixel-format: SUCCESS (16.072s) [300.385655] [051/133] (727s left) kms_psr (fbc-psr2-no-drrs) [300.493625] Starting subtest: fbc-psr2-no-drrs [300.494627] Starting dynamic subtest: eDP-1 [300.496517] Dynamic subtest eDP-1: SKIP (0.000s) [300.498341] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [300.589826] [052/133] (727s left) gem_mmap (bad-size) [300.643331] Subtest bad-size: SKIP (0.000s) [300.700585] [053/133] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [300.797493] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [300.799377] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [300.926589] [054/133] (726s left) api_intel_bb (crc32) [300.991147] Starting subtest: crc32 [300.992207] Starting dynamic subtest: rcs0-smem0 [301.321952] Dynamic subtest rcs0-smem0: SUCCESS (0.328s) [301.332293] Starting dynamic subtest: bcs0-smem0 [301.669073] Dynamic subtest bcs0-smem0: SUCCESS (0.344s) [301.680320] Starting dynamic subtest: vcs0-smem0 [302.083091] Dynamic subtest vcs0-smem0: SUCCESS (0.410s) [302.093584] Starting dynamic subtest: vcs1-smem0 [302.437546] Dynamic subtest vcs1-smem0: SUCCESS (0.351s) [302.448585] Starting dynamic subtest: vecs0-smem0 [302.807919] Dynamic subtest vecs0-smem0: SUCCESS (0.368s) [302.818651] Starting dynamic subtest: ccs0-smem0 [303.136577] Dynamic subtest ccs0-smem0: SUCCESS (0.325s) [303.141964] Subtest crc32: SUCCESS (2.145s) [303.277831] [055/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [303.393616] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [303.395413] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [303.513088] [056/133] (724s left) kms_psr (psr2-cursor-render) [303.606479] Starting subtest: psr2-cursor-render [303.607537] Starting dynamic subtest: eDP-1 [305.312768] Dynamic subtest eDP-1: SUCCESS (1.706s) [305.313880] Subtest psr2-cursor-render: SUCCESS (1.707s) [306.182927] [057/133] (721s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [306.279515] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [306.291657] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [306.426936] [058/133] (721s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [306.523222] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [306.524073] Starting dynamic subtest: pipe-A-eDP-1 [306.914883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.382s) [306.922198] Starting dynamic subtest: pipe-B-eDP-1 [308.314663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s) [308.322068] Starting dynamic subtest: pipe-C-eDP-1 [309.692518] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [309.699930] Starting dynamic subtest: pipe-D-eDP-1 [311.089398] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s) [311.090147] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.558s) [312.274923] [059/133] (715s left) kms_dp_linktrain_fallback (dp-fallback) [312.379309] Starting subtest: dp-fallback [312.381883] Subtest dp-fallback: SKIP (0.000s) [312.468245] [060/133] (715s left) gem_readwrite (beyond-eob) [312.524900] Subtest beyond-EOB: SKIP (0.000s) [312.586931] [061/133] (715s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [312.690516] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [317.218365] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.527s) [318.389381] [062/133] (709s left) prime_vgem (basic-fence-read) [318.531518] Starting subtest: basic-fence-read [318.539068] Subtest basic-fence-read: SKIP (0.007s) [318.682196] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [318.684629] [063/133] (709s left) perf_pmu (interrupts) [318.717133] Starting subtest: interrupts [319.805978] Subtest interrupts: SUCCESS (1.086s) [319.931784] [064/133] (708s left) i915_pm_rpm (system-suspend-devices) [322.053949] Starting subtest: system-suspend-devices [329.848425] Subtest system-suspend-devices: SUCCESS (7.793s) [338.269785] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [338.368314] Starting subtest: flip-vs-dpms-on-nop-interruptible [338.370988] Starting dynamic subtest: A-eDP1 [340.225077] Dynamic subtest A-eDP1: SUCCESS (1.854s) [340.236744] Starting dynamic subtest: B-eDP1 [342.137283] Dynamic subtest B-eDP1: SUCCESS (1.909s) [342.150790] Starting dynamic subtest: C-eDP1 [344.015833] Dynamic subtest C-eDP1: SUCCESS (1.876s) [344.026347] Starting dynamic subtest: D-eDP1 [345.809202] Dynamic subtest D-eDP1: SUCCESS (1.791s) [345.811459] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.443s) [346.984397] [066/133] (689s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [347.080397] Starting subtest: crc-primary-basic-y-tiled-ccs [347.081235] Starting dynamic subtest: pipe-A-eDP-1 [347.089192] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [347.097651] Starting dynamic subtest: pipe-B-eDP-1 [347.105741] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [347.113966] Starting dynamic subtest: pipe-C-eDP-1 [347.121727] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [347.129763] Starting dynamic subtest: pipe-D-eDP-1 [347.137688] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [347.139230] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [349.376485] [067/133] (686s left) kms_color (ctm-0-75) [349.456324] Starting subtest: ctm-0-75 [349.457249] Starting dynamic subtest: pipe-A-eDP-1 [354.301042] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.844s) [354.309220] Starting dynamic subtest: pipe-B-eDP-1 [359.909769] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.607s) [359.918355] Starting dynamic subtest: pipe-C-eDP-1 [365.178915] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.268s) [365.186981] Starting dynamic subtest: pipe-D-eDP-1 [370.471436] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.291s) [370.472401] Subtest ctm-0-75: SUCCESS (21.014s) [371.289757] [068/133] (664s left) gem_mmap_offset (partial-mmap) [371.350034] Starting subtest: partial-mmap [371.351065] Starting dynamic subtest: smem0 [371.352783] Dynamic subtest smem0: SUCCESS (0.004s) [371.353835] Subtest partial-mmap: SUCCESS (0.005s) [371.506686] [069/133] (664s left) syncobj_timeline (device-signal-unordered) [371.561162] Starting subtest: device-signal-unordered [371.562250] Subtest device-signal-unordered: SUCCESS (0.000s) [371.673556] [070/133] (664s left) kms_pm_dc (dc6-psr) [372.776305] Starting subtest: dc6-psr [375.652704] Subtest dc6-psr: SUCCESS (2.875s) [376.470586] [071/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [376.594581] Starting subtest: cursorB-vs-flipB-varying-size [376.596491] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [376.758310] [072/133] (659s left) kms_addfb_basic (no-handle) [376.806477] Starting subtest: no-handle [376.807481] Subtest no-handle: SUCCESS (0.000s) [376.964773] [073/133] (659s left) gem_pxp (create-regular-buffer) [377.089251] Starting subtest: create-regular-buffer [377.090348] Subtest create-regular-buffer: SUCCESS (0.000s) [377.233654] [074/133] (659s left) kms_flip (2x-dpms-vs-vblank-race) [377.322711] Starting subtest: 2x-dpms-vs-vblank-race [377.334504] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [377.435276] [075/133] (659s left) kms_psr (psr-dpms) [377.530360] Starting subtest: psr-dpms [377.531296] Starting dynamic subtest: eDP-1 [380.430478] Dynamic subtest eDP-1: SUCCESS (2.900s) [380.431332] Subtest psr-dpms: SUCCESS (2.901s) [381.280126] [076/133] (655s left) gem_lmem_swapping (massive-random) [381.317235] Subtest massive-random: SKIP (0.000s) [381.371096] [077/133] (655s left) gen9_exec_parse (bb-secure) [381.421805] Subtest bb-secure: SKIP (0.000s) [381.501154] [078/133] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [381.590284] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [381.592413] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [381.718390] [079/133] (654s left) i915_suspend (fence-restore-untiled) [381.780498] Starting subtest: fence-restore-untiled [381.782230] Subtest fence-restore-untiled: SKIP (0.000s) [381.912764] [080/133] (654s left) syncobj_wait (wait-delayed-signal) [381.970125] Starting subtest: wait-delayed-signal [382.073039] Subtest wait-delayed-signal: SUCCESS (0.102s) [382.170431] [081/133] (654s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [382.258051] Starting subtest: bad-pixel-format-yf-tiled-ccs [382.258972] Starting dynamic subtest: pipe-A-eDP-1 [382.267568] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [382.276114] Starting dynamic subtest: pipe-B-eDP-1 [382.284269] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [382.293025] Starting dynamic subtest: pipe-C-eDP-1 [382.300999] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [382.309159] Starting dynamic subtest: pipe-D-eDP-1 [382.317452] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [382.319148] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [384.571754] [082/133] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [384.675981] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [384.677679] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [384.785450] [083/133] (652s left) kms_chamelium_hpd (dp-hpd-fast) [385.171245] Subtest dp-hpd-fast: SKIP (0.000s) [385.936394] [084/133] (650s left) gem_exec_balancer (bonded-false-hang) [386.195944] Starting subtest: bonded-false-hang [386.198374] Subtest bonded-false-hang: SKIP (0.000s) [386.333059] [085/133] (650s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [386.414366] Starting subtest: crc-primary-suspend-yf-tiled-ccs [386.415241] Starting dynamic subtest: pipe-A-eDP-1 [386.418519] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [386.427254] Starting dynamic subtest: pipe-B-eDP-1 [386.430621] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [386.438620] Starting dynamic subtest: pipe-C-eDP-1 [386.441965] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [386.449646] Starting dynamic subtest: pipe-D-eDP-1 [386.452934] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [386.454569] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [388.678086] [086/133] (648s left) gem_exec_fence (syncobj-timeline-invalid-flags) [389.218407] Starting subtest: syncobj-timeline-invalid-flags [389.219380] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [391.015967] [087/133] (645s left) kms_plane_cursor (overlay) [391.112429] Starting subtest: overlay [391.114211] Starting dynamic subtest: pipe-A-eDP-1-size-64 [393.510040] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.397s) [393.572491] Starting dynamic subtest: pipe-A-eDP-1-size-128 [396.021824] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.459s) [396.084832] Starting dynamic subtest: pipe-A-eDP-1-size-256 [398.522972] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.448s) [398.869924] Starting dynamic subtest: pipe-B-eDP-1-size-64 [401.953801] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.093s) [402.015473] Starting dynamic subtest: pipe-B-eDP-1-size-128 [404.443200] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.437s) [404.505615] Starting dynamic subtest: pipe-B-eDP-1-size-256 [406.866087] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.370s) [407.223384] Starting dynamic subtest: pipe-C-eDP-1-size-64 [410.020813] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.806s) [410.064485] Starting dynamic subtest: pipe-C-eDP-1-size-128 [412.120394] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.070s) [412.157843] Starting dynamic subtest: pipe-C-eDP-1-size-256 [414.263041] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.113s) [414.587539] Starting dynamic subtest: pipe-D-eDP-1-size-64 [417.466575] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.888s) [417.504281] Starting dynamic subtest: pipe-D-eDP-1-size-128 [419.542706] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.047s) [419.581915] Starting dynamic subtest: pipe-D-eDP-1-size-256 [421.609328] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.035s) [421.934949] Subtest overlay: SUCCESS (30.821s) [422.773127] [088/133] (614s left) gem_ctx_param (basic-default) [422.825623] Starting subtest: basic-default [422.826626] Subtest basic-default: SUCCESS (0.000s) [422.916664] [089/133] (614s left) api_intel_allocator (two-level-inception-interruptible) [422.966814] Starting subtest: two-level-inception-interruptible [428.372921] Subtest two-level-inception-interruptible: SUCCESS (5.404s) [428.532119] [090/133] (608s left) kms_dsc (dsc-with-bpc-formats) [428.629598] Starting subtest: dsc-with-bpc-formats [428.671901] Subtest dsc-with-bpc-formats: SKIP (0.003s) [428.737246] [091/133] (608s left) kms_cursor_crc (cursor-alpha-opaque) [428.834555] Starting subtest: cursor-alpha-opaque [428.835519] Starting dynamic subtest: pipe-A-eDP-1 [429.525850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s) [429.536840] Starting dynamic subtest: pipe-D-eDP-1 [430.891362] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s) [430.892516] Subtest cursor-alpha-opaque: SUCCESS (2.057s) [431.776450] [092/133] (605s left) syncobj_timeline (multi-wait-all-signaled) [431.840151] Starting subtest: multi-wait-all-signaled [431.841240] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [431.987336] [093/133] (605s left) i915_drm_fdinfo (isolation) [432.028440] Starting subtest: isolation [432.029544] Starting dynamic subtest: rcs0 [432.077709] Dynamic subtest rcs0: SKIP (0.048s) [432.088540] Starting dynamic subtest: bcs0 [432.090319] Dynamic subtest bcs0: SKIP (0.001s) [432.098779] Starting dynamic subtest: vcs0 [432.100820] Dynamic subtest vcs0: SKIP (0.000s) [432.109606] Starting dynamic subtest: vcs1 [432.111746] Dynamic subtest vcs1: SKIP (0.000s) [432.121886] Starting dynamic subtest: vecs0 [432.123556] Dynamic subtest vecs0: SKIP (0.000s) [432.131821] Starting dynamic subtest: ccs0 [432.133518] Dynamic subtest ccs0: SKIP (0.000s) [432.135217] Subtest isolation: SKIP (0.055s) [432.174811] [094/133] (605s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [432.277453] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [432.278358] Starting dynamic subtest: pipe-A-default-mode [433.381502] Dynamic subtest pipe-A-default-mode: SKIP (1.100s) [433.383104] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.103s) [433.566437] [095/133] (603s left) gem_ctx_isolation (preservation-s3) [433.625642] Starting subtest: preservation-S3 [433.626790] Starting dynamic subtest: rcs0 [450.567208] Dynamic subtest rcs0: SUCCESS (2.583s) [450.577928] Starting dynamic subtest: bcs0 [467.574708] Dynamic subtest bcs0: SUCCESS (1.717s) [467.583974] Starting dynamic subtest: vcs0 [484.580459] Dynamic subtest vcs0: SUCCESS (3.440s) [484.590043] Starting dynamic subtest: vcs1 [502.578216] Dynamic subtest vcs1: SUCCESS (5.032s) [502.591170] Starting dynamic subtest: vecs0 [520.579523] Dynamic subtest vecs0: SUCCESS (4.940s) [520.588793] Starting dynamic subtest: ccs0 [538.572191] Dynamic subtest ccs0: SUCCESS (3.241s) [538.573888] Subtest preservation-S3: SUCCESS (20.959s) [544.842427] [096/133] (498s left) gem_eio (reset-stress) [545.085711] Starting subtest: reset-stress [545.086991] Starting dynamic subtest: render [550.519727] Dynamic subtest render: SUCCESS (5.527s) [550.529206] Starting dynamic subtest: bsd1 [568.462550] Dynamic subtest bsd1: SUCCESS (18.026s) [568.478338] Starting dynamic subtest: bsd2 [586.418650] Dynamic subtest bsd2: SUCCESS (17.961s) [586.433801] Starting dynamic subtest: blt [586.436262] Dynamic subtest blt: SKIP (0.000s) [586.445240] Starting dynamic subtest: vebox [603.494743] Dynamic subtest vebox: SUCCESS (17.074s) [603.496133] Subtest reset-stress: SUCCESS (58.593s) [604.963757] [097/133] (438s left) gem_softpin (evict-snoop-interruptible) [605.025740] Starting subtest: evict-snoop-interruptible [605.028673] Subtest evict-snoop-interruptible: SKIP (0.000s) [605.117514] [098/133] (438s left) i915_module_load (reload-no-display) [605.147644] Starting subtest: reload-no-display [610.993974] Subtest reload-no-display: SUCCESS (5.848s) [611.016243] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [611.016927] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [611.018840] [099/133] (432s left) kms_flip (2x-flip-vs-modeset) [613.870362] Starting subtest: 2x-flip-vs-modeset [613.883791] Subtest 2x-flip-vs-modeset: SKIP (0.012s) [613.993606] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [613.994785] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [613.998026] [100/133] (429s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [614.096000] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [614.097213] Starting dynamic subtest: pipe-A-default-mode [614.399653] Dynamic subtest pipe-A-default-mode: SKIP (0.297s) [614.401642] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.299s) [615.212142] [101/133] (428s left) kms_content_protection (type1) [615.389687] Starting subtest: type1 [615.391709] Subtest type1: SKIP (0.000s) [615.552513] [102/133] (427s left) kms_big_fb (4-tiled-16bpp-rotate-180) [615.647827] Starting subtest: 4-tiled-16bpp-rotate-180 [617.025424] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.378s) [617.202307] [103/133] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [617.302103] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [617.303790] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [617.429633] [104/133] (426s left) gem_ppgtt (flink-and-close-vma-leak) [617.483652] Starting subtest: flink-and-close-vma-leak [617.525707] Subtest flink-and-close-vma-leak: SUCCESS (0.042s) [617.677332] [105/133] (425s left) syncobj_wait (signal) [617.741771] Starting subtest: signal [617.743041] Subtest signal: SUCCESS (0.000s) [617.864402] [106/133] (425s left) kms_cursor_crc (cursor-rapid-movement-128x128) [618.053801] Starting subtest: cursor-rapid-movement-128x128 [618.059707] Starting dynamic subtest: pipe-A-eDP-1 [618.630760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.571s) [618.672627] Starting dynamic subtest: pipe-D-eDP-1 [619.818566] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s) [619.820277] Subtest cursor-rapid-movement-128x128: SUCCESS (1.764s) [620.691866] [107/133] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [625.746581] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [625.747993] Starting dynamic subtest: pipe-A-eDP-1 [626.546012] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s) [626.554305] Starting dynamic subtest: pipe-B-eDP-1 [627.669629] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s) [627.671610] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.924s) [628.872315] [108/133] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [628.963599] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [635.450486] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.487s) [635.614888] [109/133] (408s left) kms_vblank (query-forked-busy) [635.705334] Starting subtest: query-forked-busy [635.706455] Starting dynamic subtest: pipe-A-eDP-1 [637.590253] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s) [637.602025] Starting dynamic subtest: pipe-D-eDP-1 [640.137787] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s) [640.139077] Subtest query-forked-busy: SUCCESS (4.435s) [640.951817] [110/133] (402s left) syncobj_timeline (invalid-transfer-non-existent-point) [641.016826] Starting subtest: invalid-transfer-non-existent-point [641.018508] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [641.177094] [111/133] (402s left) kms_big_fb (x-tiled-16bpp-rotate-0) [641.286614] Starting subtest: x-tiled-16bpp-rotate-0 [642.677727] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.391s) [642.842705] [112/133] (401s left) kms_psr (fbc-psr-primary-blt) [642.935250] Starting subtest: fbc-psr-primary-blt [642.936057] Starting dynamic subtest: eDP-1 [642.937666] Dynamic subtest eDP-1: SKIP (0.000s) [642.939174] Subtest fbc-psr-primary-blt: SKIP (0.001s) [643.025879] [113/133] (400s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [643.081266] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [643.189719] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s) [643.283212] [114/133] (400s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [643.381901] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [643.384247] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [643.509189] [115/133] (400s left) gem_exec_reloc (basic-cpu-active) [643.565414] Subtest basic-cpu-active: SKIP (0.000s) [643.656242] [116/133] (400s left) perf (rc6-disable) [643.813577] Starting subtest: rc6-disable [644.015690] Subtest rc6-disable: SUCCESS (0.202s) [644.063198] [117/133] (399s left) gem_ctx_shared (q-independent) [644.133389] Starting subtest: Q-independent [644.134761] Starting dynamic subtest: rcs0 [644.196920] Dynamic subtest rcs0: SUCCESS (0.063s) [644.207742] Starting dynamic subtest: vcs0 [644.239485] Dynamic subtest vcs0: SUCCESS (0.042s) [644.248870] Starting dynamic subtest: vcs1 [644.274777] Dynamic subtest vcs1: SUCCESS (0.035s) [644.283819] Starting dynamic subtest: vecs0 [644.311551] Dynamic subtest vecs0: SUCCESS (0.036s) [644.321929] Starting dynamic subtest: ccs0 [644.357853] Dynamic subtest ccs0: SUCCESS (0.045s) [644.359674] Subtest Q-independent: SUCCESS (0.225s) [645.990901] [118/133] (398s left) perf (non-zero-reason) [646.085997] Starting subtest: non-zero-reason [646.087807] Starting dynamic subtest: 0-rcs0 [651.452159] Dynamic subtest 0-rcs0: SUCCESS (5.362s) [651.463250] Starting dynamic subtest: 1-vcs0 [655.346839] Dynamic subtest 1-vcs0: SUCCESS (3.892s) [655.348879] Subtest non-zero-reason: SUCCESS (9.256s) [655.392831] [119/133] (388s left) kms_psr (pr-dpms) [655.493599] Starting subtest: pr-dpms [655.495840] Subtest pr-dpms: SKIP (0.000s) [655.584134] [120/133] (388s left) kms_rotation_crc (primary-rotation-180) [655.683794] Starting subtest: primary-rotation-180 [662.674649] Subtest primary-rotation-180: SUCCESS (6.990s) [663.919058] [121/133] (380s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [664.024287] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [671.352158] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.329s) [671.491506] [122/133] (372s left) gem_create (create-size-update) [671.537798] Starting subtest: create-size-update [671.539284] Subtest create-size-update: SUCCESS (0.000s) [671.782878] [123/133] (372s left) prime_vgem (basic-fence-blt) [671.852881] Starting subtest: basic-fence-blt [671.948943] Subtest basic-fence-blt: SUCCESS (0.095s) [672.118779] [124/133] (372s left) kms_getfb (getfb2-into-addfb2) [672.202838] Starting subtest: getfb2-into-addfb2 [672.204431] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [672.318799] [125/133] (371s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [672.440015] Starting subtest: verify-pxp-execution-after-suspend-resume [679.512651] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.073s) [686.665600] [126/133] (364s left) syncobj_basic (bad-pad-fd-to-handle) [686.724244] Starting subtest: bad-pad-fd-to-handle [686.725686] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [686.859910] [127/133] (364s left) dmabuf_sync_file (export-before-signal) [686.901383] Starting subtest: export-before-signal [686.902567] Subtest export-before-signal: SUCCESS (0.001s) [686.977091] [128/133] (364s left) kms_flip (2x-flip-vs-panning-vs-hang) [687.068154] Starting subtest: 2x-flip-vs-panning-vs-hang [687.080018] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [687.182747] [129/133] (364s left) gem_softpin (allocator-nopin-reserve) [687.230574] Starting subtest: allocator-nopin-reserve [687.320315] Subtest allocator-nopin-reserve: SUCCESS (0.089s) [687.473857] [130/133] (364s left) kms_pipe_crc_basic (read-crc-frame-sequence) [687.561200] Starting subtest: read-crc-frame-sequence [687.562509] Starting dynamic subtest: pipe-A-eDP-1 [688.254498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s) [688.264140] Starting dynamic subtest: pipe-B-eDP-1 [689.606982] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s) [689.615941] Starting dynamic subtest: pipe-C-eDP-1 [690.890010] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s) [690.899476] Starting dynamic subtest: pipe-D-eDP-1 [692.225025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s) [692.226333] Subtest read-crc-frame-sequence: SUCCESS (4.665s) [693.093226] [131/133] (358s left) kms_frontbuffer_tracking (pipe-fbc-rte) [693.192833] Starting subtest: pipe-fbc-rte [693.195641] Starting dynamic subtest: pipe-B-eDP-1 [698.670220] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.478s) [698.674209] Subtest pipe-fbc-rte: SUCCESS (5.480s) [700.995108] [132/133] (350s left) kms_addfb_basic (too-wide) [701.084596] Starting subtest: too-wide [701.085658] Subtest too-wide: SUCCESS (0.000s) [701.199330] [133/133] (350s left) gem_exec_schedule (pi-shared-iova) [701.390883] Starting subtest: pi-shared-iova [701.392772] Starting dynamic subtest: rcs0 [701.475990] Dynamic subtest rcs0: SUCCESS (0.086s) [701.484892] Starting dynamic subtest: vcs0 [701.531857] Dynamic subtest vcs0: SUCCESS (0.055s) [701.543497] Starting dynamic subtest: vcs1 [701.584034] Dynamic subtest vcs1: SUCCESS (0.052s) [701.595001] Starting dynamic subtest: vecs0 [701.638526] Dynamic subtest vecs0: SUCCESS (0.053s) [701.649563] Starting dynamic subtest: ccs0 [701.694007] Dynamic subtest ccs0: SUCCESS (0.055s) [701.695866] Subtest pi-shared-iova: SUCCESS (0.305s) [703.013841] 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.