[62.426183] Initializing watchdogs [62.426229] /dev/watchdog0 [62.441992] [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] [62.446370] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.448782] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.452231] [001/133] (960s left) syncobj_basic (bad-create-flags) [62.518908] Starting subtest: bad-create-flags [62.521035] Subtest bad-create-flags: SUCCESS (0.000s) [62.635980] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [67.714744] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [67.717215] Starting dynamic subtest: pipe-A-eDP-1 [74.764489] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.040s) [74.773062] Starting dynamic subtest: pipe-B-eDP-1 [81.816034] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.046s) [81.818372] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.090s) [82.689968] [003/133] (940s left) gem_ccs (block-copy-compressed) [82.754831] Starting subtest: block-copy-compressed [82.759260] Subtest block-copy-compressed: SKIP (0.000s) [82.886110] [004/133] (940s left) kms_sequence (get-forked-busy) [82.985598] Starting subtest: get-forked-busy [82.987470] Starting dynamic subtest: pipe-A-eDP-1 [84.930211] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s) [84.940263] Starting dynamic subtest: pipe-B-eDP-1 [87.598256] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.664s) [87.607309] Starting dynamic subtest: pipe-C-eDP-1 [90.202755] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s) [90.213404] Starting dynamic subtest: pipe-D-eDP-1 [92.828835] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.625s) [92.831187] Subtest get-forked-busy: SUCCESS (9.840s) [93.732623] [005/133] (929s left) sysfs_preempt_timeout (timeout) [93.805478] Starting subtest: timeout [93.807832] Starting dynamic subtest: vecs0 [103.926525] Dynamic subtest vecs0: SUCCESS (10.116s) [103.936840] Starting dynamic subtest: ccs0 [105.297754] Dynamic subtest ccs0: SUCCESS (1.370s) [105.307057] Starting dynamic subtest: vcs0 [114.919997] Dynamic subtest vcs0: SUCCESS (9.619s) [114.929784] Starting dynamic subtest: bcs0 [116.246468] Dynamic subtest bcs0: SUCCESS (1.326s) [116.256127] Starting dynamic subtest: rcs0 [117.554365] Dynamic subtest rcs0: SUCCESS (1.307s) [117.564964] Starting dynamic subtest: vcs1 [126.952731] Dynamic subtest vcs1: SUCCESS (9.395s) [126.955127] Subtest timeout: SUCCESS (33.140s) [127.052011] [006/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [127.165587] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [127.169843] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [127.280659] [007/133] (895s left) gem_ctx_persistence (legacy-engines-queued) [127.356033] Starting subtest: legacy-engines-queued [127.358363] Starting dynamic subtest: render [127.434899] Dynamic subtest render: SUCCESS (0.081s) [127.444599] Starting dynamic subtest: bsd1 [128.885063] Dynamic subtest bsd1: SUCCESS (1.447s) [128.895719] Starting dynamic subtest: bsd2 [130.869831] Dynamic subtest bsd2: SUCCESS (1.982s) [130.880050] Starting dynamic subtest: blt [130.953118] Dynamic subtest blt: SUCCESS (0.083s) [130.963676] Starting dynamic subtest: vebox [132.852892] Dynamic subtest vebox: SUCCESS (1.896s) [132.856056] Subtest legacy-engines-queued: SUCCESS (5.498s) [132.956843] [008/133] (890s left) drm_read (short-buffer-block) [133.123331] Starting subtest: short-buffer-block [133.125759] Subtest short-buffer-block: SUCCESS (0.000s) [133.296156] [009/133] (889s left) gem_render_copy_redux (normal) [133.356847] Starting subtest: normal [133.612503] Subtest normal: SUCCESS (0.257s) [133.773364] [010/133] (889s left) kms_big_fb (y-tiled-32bpp-rotate-90) [133.881574] Starting subtest: y-tiled-32bpp-rotate-90 [133.885450] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [133.990335] [011/133] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [134.093771] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [141.540885] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.451s) [141.697576] [012/133] (881s left) gem_exec_suspend (basic) [141.762260] Starting subtest: basic [141.764578] Starting dynamic subtest: smem [142.934979] Dynamic subtest smem: SUCCESS (1.171s) [142.937719] Subtest basic: SUCCESS (1.172s) [143.136193] [013/133] (880s left) kms_hdmi_inject (inject-audio) [143.472721] Starting subtest: inject-audio [143.747691] Subtest inject-audio: SUCCESS (0.278s) [144.336958] [014/133] (879s left) kms_cursor_crc (cursor-sliding-32x10) [144.491090] Starting subtest: cursor-sliding-32x10 [144.538565] Subtest cursor-sliding-32x10: SKIP (0.043s) [144.820454] [015/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [144.914302] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [151.425123] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.513s) [151.581017] [016/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [151.687581] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [151.692038] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [151.810317] [017/133] (871s left) gem_render_copy (y-tiled-ccs-to-linear) [151.876080] Starting subtest: y-tiled-ccs-to-linear [151.880263] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [152.077881] [018/133] (871s left) kms_big_fb (4-tiled-16bpp-rotate-90) [152.172073] Starting subtest: 4-tiled-16bpp-rotate-90 [152.194467] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [152.316696] [019/133] (871s left) syncobj_timeline (transfer-timeline-point) [152.386797] Starting subtest: transfer-timeline-point [152.388749] Subtest transfer-timeline-point: SUCCESS (0.001s) [152.501852] [020/133] (871s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [152.562307] Starting subtest: invalid-multi-wait-unsubmitted-submitted [152.564652] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [152.684202] [021/133] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [152.777637] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [152.779940] Starting dynamic subtest: pipe-A-eDP-1 [152.804869] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [152.817602] Starting dynamic subtest: pipe-B-eDP-1 [152.841515] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [152.849420] Starting dynamic subtest: pipe-C-eDP-1 [152.872266] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [152.880021] Starting dynamic subtest: pipe-D-eDP-1 [152.903138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [152.907135] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [154.994925] [022/133] (868s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [157.035723] Starting subtest: dpms-mode-unset-non-lpsp [158.185496] Subtest dpms-mode-unset-non-lpsp: SKIP (1.147s) [158.582713] [023/133] (865s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [158.696678] Starting subtest: psr-rgb565-draw-mmap-wc [165.443027] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.749s) [165.577268] [024/133] (858s left) kms_chamelium_edid (vga-edid-read) [165.967493] Subtest vga-edid-read: SKIP (0.000s) [166.765316] [025/133] (857s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [166.830350] Starting subtest: yf-tiled-to-vebox-y-tiled [166.835040] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [167.036901] [026/133] (856s left) kms_flip (dpms-off-confusion) [167.155558] Starting subtest: dpms-off-confusion [167.157823] Starting dynamic subtest: A-eDP1 [175.849057] Dynamic subtest A-eDP1: SUCCESS (8.694s) [175.858882] Starting dynamic subtest: B-eDP1 [184.539914] Dynamic subtest B-eDP1: SUCCESS (8.688s) [184.547759] Starting dynamic subtest: C-eDP1 [193.242143] Dynamic subtest C-eDP1: SUCCESS (8.699s) [193.252217] Starting dynamic subtest: D-eDP1 [201.932770] Dynamic subtest D-eDP1: SUCCESS (8.690s) [201.937625] Subtest dpms-off-confusion: SUCCESS (34.782s) [203.196676] [027/133] (820s left) gem_exec_big (single) [203.249168] Starting subtest: single [205.784787] Subtest single: SUCCESS (2.533s) [206.023926] [028/133] (817s left) gem_exec_flush (basic-wb-ro-default) [206.140237] Starting subtest: basic-wb-ro-default [211.605861] Subtest basic-wb-ro-default: SUCCESS (5.468s) [211.815324] [029/133] (812s left) kms_async_flips (async-flip-with-page-flip-events-linear) [211.926959] Starting subtest: async-flip-with-page-flip-events-linear [212.311569] Starting dynamic subtest: pipe-A-eDP-1 [215.119708] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.808s) [215.493283] Starting dynamic subtest: pipe-B-eDP-1 [218.226228] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.737s) [218.591031] Starting dynamic subtest: pipe-C-eDP-1 [221.318292] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.735s) [221.679432] Starting dynamic subtest: pipe-D-eDP-1 [224.413134] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.740s) [224.415790] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.486s) [225.592350] [030/133] (798s left) kms_plane_scaling (planes-downscale-factor-0-75) [225.687130] Starting subtest: planes-downscale-factor-0-75 [225.689422] Starting dynamic subtest: pipe-A [225.710271] Dynamic subtest pipe-A: SKIP (0.019s) [225.718869] Starting dynamic subtest: pipe-B [225.742075] Dynamic subtest pipe-B: SKIP (0.032s) [225.751730] Starting dynamic subtest: pipe-C [225.774711] Dynamic subtest pipe-C: SKIP (0.032s) [225.782845] Starting dynamic subtest: pipe-D [225.808606] Dynamic subtest pipe-D: SKIP (0.032s) [225.812922] Subtest planes-downscale-factor-0-75: SKIP (0.118s) [225.925529] [031/133] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [226.014175] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [226.018414] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [226.141925] [032/133] (797s left) kms_properties (colorop-properties-legacy) [226.241968] Starting subtest: colorop-properties-legacy [226.244288] Starting dynamic subtest: pipe-A-eDP-1 [226.606265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s) [226.618710] Starting dynamic subtest: pipe-B-eDP-1 [227.689602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s) [227.699973] Starting dynamic subtest: pipe-C-eDP-1 [228.806231] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s) [228.815280] Starting dynamic subtest: pipe-D-eDP-1 [229.893405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.087s) [229.895640] Subtest colorop-properties-legacy: SUCCESS (3.651s) [230.791801] [033/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [230.895311] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [230.899617] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [231.030123] [034/133] (793s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [231.135985] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [231.138274] Starting dynamic subtest: pipe-A-eDP-1 [231.158525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [231.168728] Starting dynamic subtest: pipe-B-eDP-1 [231.187755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [231.195313] Starting dynamic subtest: pipe-C-eDP-1 [231.214105] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [231.221988] Starting dynamic subtest: pipe-D-eDP-1 [231.241245] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [231.243463] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [233.396969] [035/133] (790s left) gem_wait (wait) [233.480737] Starting subtest: wait [233.483270] Starting dynamic subtest: all-engines [234.902856] Dynamic subtest all-engines: SUCCESS (1.420s) [234.913641] Starting dynamic subtest: rcs0 [235.947085] Dynamic subtest rcs0: SUCCESS (1.044s) [235.958049] Starting dynamic subtest: bcs0 [236.994372] Dynamic subtest bcs0: SUCCESS (1.045s) [237.005337] Starting dynamic subtest: vcs0 [238.038309] Dynamic subtest vcs0: SUCCESS (1.042s) [238.048770] Starting dynamic subtest: vcs1 [239.082384] Dynamic subtest vcs1: SUCCESS (1.042s) [239.091951] Starting dynamic subtest: vecs0 [240.126599] Dynamic subtest vecs0: SUCCESS (1.042s) [240.137504] Starting dynamic subtest: ccs0 [241.173745] Dynamic subtest ccs0: SUCCESS (1.045s) [241.176859] Subtest wait: SUCCESS (7.693s) [241.393723] [036/133] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [241.493153] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [241.497248] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [241.620295] [037/133] (782s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [241.734909] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [242.714912] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.979s) [242.883403] [038/133] (781s left) gem_exec_reloc (basic-concurrent0) [242.933711] Subtest basic-concurrent0: SKIP (0.000s) [243.020626] [039/133] (781s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [243.126332] Starting subtest: yf-tiled-32bpp-rotate-180 [243.129921] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [243.246204] [040/133] (781s left) kms_lease (cursor-implicit-plane) [243.353521] Starting subtest: cursor-implicit-plane [243.355533] Starting dynamic subtest: pipe-A-eDP-1 [243.822779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s) [243.831032] Starting dynamic subtest: pipe-B-eDP-1 [244.957048] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.135s) [244.965531] Starting dynamic subtest: pipe-C-eDP-1 [246.047470] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.089s) [246.056256] Starting dynamic subtest: pipe-D-eDP-1 [247.129851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.077s) [247.132191] Subtest cursor-implicit-plane: SUCCESS (3.775s) [248.007679] [041/133] (776s left) gem_exec_schedule (u-semaphore-resolve) [248.095145] Starting subtest: u-semaphore-resolve [248.124876] Subtest u-semaphore-resolve: SUCCESS (0.035s) [248.502065] [042/133] (776s left) gem_exec_whisper (basic-fds-priority) [248.576427] Starting subtest: basic-fds-priority [272.432023] Subtest basic-fds-priority: SUCCESS (23.852s) [272.638411] [043/133] (751s left) i915_query (query-topology-known-pci-ids) [272.707470] Starting subtest: query-topology-known-pci-ids [272.711786] Subtest query-topology-known-pci-ids: SKIP (0.000s) [272.844676] [044/133] (751s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [272.950886] Starting subtest: yf-tiled-64bpp-rotate-90 [272.955406] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [273.074967] [045/133] (751s left) perf_pmu (idle) [273.115314] Starting subtest: idle [273.117726] Starting dynamic subtest: rcs0 [273.681298] Dynamic subtest rcs0: SUCCESS (0.564s) [273.693204] Starting dynamic subtest: bcs0 [274.207171] Dynamic subtest bcs0: SUCCESS (0.523s) [274.218702] Starting dynamic subtest: vcs0 [274.733328] Dynamic subtest vcs0: SUCCESS (0.524s) [274.744872] Starting dynamic subtest: vcs1 [275.267831] Dynamic subtest vcs1: SUCCESS (0.532s) [275.279810] Starting dynamic subtest: vecs0 [275.795430] Dynamic subtest vecs0: SUCCESS (0.524s) [275.807120] Starting dynamic subtest: ccs0 [276.324834] Dynamic subtest ccs0: SUCCESS (0.527s) [276.327798] Subtest idle: SUCCESS (3.209s) [276.471295] [046/133] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [276.568309] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [276.572383] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [276.696288] [047/133] (748s left) gem_exec_flush (basic-uc-pro-default) [276.754745] Starting subtest: basic-uc-pro-default [282.205784] Subtest basic-uc-pro-default: SUCCESS (5.452s) [282.416648] [048/133] (742s left) gem_basic (bad-close) [282.480474] Starting subtest: bad-close [282.484953] Subtest bad-close: SUCCESS (0.000s) [282.618344] [049/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [282.732569] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [282.736833] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [282.879616] [050/133] (741s left) kms_plane (pixel-format) [282.987228] Starting subtest: pixel-format [283.015441] Starting dynamic subtest: pipe-A-plane-0 [287.862626] Dynamic subtest pipe-A-plane-0: SUCCESS (4.844s) [287.872299] Starting dynamic subtest: pipe-A-plane-3 [290.204157] Dynamic subtest pipe-A-plane-3: SUCCESS (2.344s) [290.213675] Starting dynamic subtest: pipe-A-plane-5 [290.415218] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [291.534150] Starting dynamic subtest: pipe-B-plane-0 [296.343894] Dynamic subtest pipe-B-plane-0: SUCCESS (4.822s) [296.354942] Starting dynamic subtest: pipe-B-plane-3 [298.666761] Dynamic subtest pipe-B-plane-3: SUCCESS (2.321s) [298.680984] Starting dynamic subtest: pipe-B-plane-5 [298.877198] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s) [299.194369] Subtest pixel-format: SUCCESS (16.206s) [300.087415] [051/133] (724s left) kms_psr (fbc-psr2-no-drrs) [300.192097] Starting subtest: fbc-psr2-no-drrs [300.194381] Starting dynamic subtest: eDP-1 [300.198790] Dynamic subtest eDP-1: SKIP (0.000s) [300.203208] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [300.290063] [052/133] (724s left) gem_mmap (bad-size) [300.356771] Subtest bad-size: SKIP (0.000s) [300.423805] [053/133] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [300.525706] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [300.530087] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [300.659406] [054/133] (724s left) api_intel_bb (crc32) [300.723513] Starting subtest: crc32 [300.725508] Starting dynamic subtest: rcs0-smem0 [301.031287] Dynamic subtest rcs0-smem0: SUCCESS (0.308s) [301.043705] Starting dynamic subtest: bcs0-smem0 [301.377304] Dynamic subtest bcs0-smem0: SUCCESS (0.344s) [301.388723] Starting dynamic subtest: vcs0-smem0 [301.785312] Dynamic subtest vcs0-smem0: SUCCESS (0.405s) [301.797504] Starting dynamic subtest: vcs1-smem0 [302.186376] Dynamic subtest vcs1-smem0: SUCCESS (0.398s) [302.197934] Starting dynamic subtest: vecs0-smem0 [302.560592] Dynamic subtest vecs0-smem0: SUCCESS (0.371s) [302.572527] Starting dynamic subtest: ccs0-smem0 [302.906082] Dynamic subtest ccs0-smem0: SUCCESS (0.343s) [302.908980] Subtest crc32: SUCCESS (2.185s) [303.078647] [055/133] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [303.195125] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [303.199091] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [303.333961] [056/133] (721s left) kms_psr (psr2-cursor-render) [303.436218] Starting subtest: psr2-cursor-render [303.438365] Starting dynamic subtest: eDP-1 [305.119380] Dynamic subtest eDP-1: SUCCESS (1.683s) [305.121653] Subtest psr2-cursor-render: SUCCESS (1.684s) [305.986096] [057/133] (719s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [306.088231] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [306.100782] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [306.199809] [058/133] (718s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [306.294265] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [306.296509] Starting dynamic subtest: pipe-A-eDP-1 [306.793105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s) [306.801664] Starting dynamic subtest: pipe-B-eDP-1 [308.206396] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s) [308.217342] Starting dynamic subtest: pipe-C-eDP-1 [309.654219] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.449s) [309.663901] Starting dynamic subtest: pipe-D-eDP-1 [311.043536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.385s) [311.045751] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.724s) [312.292242] [059/133] (712s left) kms_dp_linktrain_fallback (dp-fallback) [312.394114] Starting subtest: dp-fallback [312.400220] Subtest dp-fallback: SKIP (0.000s) [312.486550] [060/133] (712s left) gem_readwrite (beyond-eob) [312.553078] Subtest beyond-EOB: SKIP (0.000s) [312.616432] [061/133] (712s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [312.709213] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [317.303841] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.599s) [318.502106] [062/133] (706s left) prime_vgem (basic-fence-read) [318.651634] Starting subtest: basic-fence-read [318.661043] Subtest basic-fence-read: SKIP (0.007s) [318.813662] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [318.816863] [063/133] (706s left) perf_pmu (interrupts) [318.869344] Starting subtest: interrupts [319.994415] Subtest interrupts: SUCCESS (1.123s) [320.142829] [064/133] (705s left) i915_pm_rpm (system-suspend-devices) [322.108083] Starting subtest: system-suspend-devices [329.917640] Subtest system-suspend-devices: SUCCESS (7.839s) [342.318053] [065/133] (695s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [342.434979] Starting subtest: flip-vs-dpms-on-nop-interruptible [342.437356] Starting dynamic subtest: A-eDP1 [344.319991] Dynamic subtest A-eDP1: SUCCESS (1.884s) [344.335159] Starting dynamic subtest: B-eDP1 [346.130914] Dynamic subtest B-eDP1: SUCCESS (1.808s) [346.141205] Starting dynamic subtest: C-eDP1 [347.920387] Dynamic subtest C-eDP1: SUCCESS (1.788s) [347.932090] Starting dynamic subtest: D-eDP1 [349.714385] Dynamic subtest D-eDP1: SUCCESS (1.792s) [349.716710] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.281s) [350.989514] [066/133] (686s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [351.092207] Starting subtest: crc-primary-basic-y-tiled-ccs [351.094476] Starting dynamic subtest: pipe-A-eDP-1 [351.116997] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [351.131837] Starting dynamic subtest: pipe-B-eDP-1 [351.153831] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [351.165301] Starting dynamic subtest: pipe-C-eDP-1 [351.187988] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [351.198393] Starting dynamic subtest: pipe-D-eDP-1 [351.220147] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [351.224219] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [353.392368] [067/133] (684s left) kms_color (ctm-0-75) [353.495408] Starting subtest: ctm-0-75 [353.497608] Starting dynamic subtest: pipe-A-eDP-1 [358.416449] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.922s) [358.426931] Starting dynamic subtest: pipe-B-eDP-1 [364.001548] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.583s) [364.011891] Starting dynamic subtest: pipe-C-eDP-1 [369.365752] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.365s) [369.376594] Starting dynamic subtest: pipe-D-eDP-1 [374.672058] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.303s) [374.674297] Subtest ctm-0-75: SUCCESS (21.177s) [375.496197] [068/133] (662s left) gem_mmap_offset (partial-mmap) [375.559679] Starting subtest: partial-mmap [375.561603] Starting dynamic subtest: smem0 [375.563989] Dynamic subtest smem0: SUCCESS (0.004s) [375.566286] Subtest partial-mmap: SUCCESS (0.005s) [375.692420] [069/133] (661s left) syncobj_timeline (device-signal-unordered) [375.758995] Starting subtest: device-signal-unordered [375.761181] Subtest device-signal-unordered: SUCCESS (0.000s) [375.901178] [070/133] (661s left) kms_pm_dc (dc6-psr) [377.002928] Starting subtest: dc6-psr [379.878596] Subtest dc6-psr: SUCCESS (2.877s) [380.787301] [071/133] (656s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [380.917586] Starting subtest: cursorB-vs-flipB-varying-size [380.922180] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [381.087243] [072/133] (656s left) kms_addfb_basic (no-handle) [381.150629] Starting subtest: no-handle [381.152945] Subtest no-handle: SUCCESS (0.000s) [381.340302] [073/133] (656s left) gem_pxp (create-regular-buffer) [381.470689] Starting subtest: create-regular-buffer [381.473252] Subtest create-regular-buffer: SUCCESS (0.000s) [381.600756] [074/133] (656s left) kms_flip (2x-dpms-vs-vblank-race) [381.693812] Starting subtest: 2x-dpms-vs-vblank-race [381.705532] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [381.813086] [075/133] (656s left) kms_psr (psr-dpms) [381.910534] Starting subtest: psr-dpms [381.912507] Starting dynamic subtest: eDP-1 [384.829660] Dynamic subtest eDP-1: SUCCESS (2.918s) [384.832006] Subtest psr-dpms: SUCCESS (2.919s) [385.685459] [076/133] (652s left) gem_lmem_swapping (massive-random) [385.733736] Subtest massive-random: SKIP (0.000s) [385.780077] [077/133] (652s left) gen9_exec_parse (bb-secure) [385.846341] Subtest bb-secure: SKIP (0.000s) [385.921905] [078/133] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [386.017496] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [386.021998] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [386.151612] [079/133] (651s left) i915_suspend (fence-restore-untiled) [386.211221] Starting subtest: fence-restore-untiled [386.215239] Subtest fence-restore-untiled: SKIP (0.000s) [386.346962] [080/133] (651s left) syncobj_wait (wait-delayed-signal) [386.406723] Starting subtest: wait-delayed-signal [386.508215] Subtest wait-delayed-signal: SUCCESS (0.103s) [386.616225] [081/133] (651s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [386.703371] Starting subtest: bad-pixel-format-yf-tiled-ccs [386.705750] Starting dynamic subtest: pipe-A-eDP-1 [386.729077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [386.741253] Starting dynamic subtest: pipe-B-eDP-1 [386.764081] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [386.775627] Starting dynamic subtest: pipe-C-eDP-1 [386.797251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [386.806272] Starting dynamic subtest: pipe-D-eDP-1 [386.827884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [386.832269] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [388.979195] [082/133] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [389.095496] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [389.099653] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [389.221714] [083/133] (649s left) kms_chamelium_hpd (dp-hpd-fast) [389.625383] Subtest dp-hpd-fast: SKIP (0.000s) [390.443599] [084/133] (647s left) gem_exec_balancer (bonded-false-hang) [390.701033] Starting subtest: bonded-false-hang [390.706687] Subtest bonded-false-hang: SKIP (0.000s) [390.853178] [085/133] (647s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [390.951518] Starting subtest: crc-primary-suspend-yf-tiled-ccs [390.953919] Starting dynamic subtest: pipe-A-eDP-1 [390.963191] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [390.975411] Starting dynamic subtest: pipe-B-eDP-1 [390.984488] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [390.993944] Starting dynamic subtest: pipe-C-eDP-1 [391.002275] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [391.011056] Starting dynamic subtest: pipe-D-eDP-1 [391.019355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [391.023398] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [393.180581] [086/133] (645s left) gem_exec_fence (syncobj-timeline-invalid-flags) [393.716054] Starting subtest: syncobj-timeline-invalid-flags [393.719038] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [395.036573] [087/133] (643s left) kms_plane_cursor (overlay) [395.142330] Starting subtest: overlay [395.146984] Starting dynamic subtest: pipe-A-eDP-1-size-64 [397.640516] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.499s) [397.702393] Starting dynamic subtest: pipe-A-eDP-1-size-128 [400.263431] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s) [400.325029] Starting dynamic subtest: pipe-A-eDP-1-size-256 [402.943384] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.628s) [403.293118] Starting dynamic subtest: pipe-B-eDP-1-size-64 [406.670015] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.390s) [406.731455] Starting dynamic subtest: pipe-B-eDP-1-size-128 [409.251091] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s) [409.311070] Starting dynamic subtest: pipe-B-eDP-1-size-256 [411.863198] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s) [412.211477] Starting dynamic subtest: pipe-C-eDP-1-size-64 [415.133854] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.933s) [415.172959] Starting dynamic subtest: pipe-C-eDP-1-size-128 [417.345439] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s) [417.384890] Starting dynamic subtest: pipe-C-eDP-1-size-256 [419.578307] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.202s) [419.907837] Starting dynamic subtest: pipe-D-eDP-1-size-64 [422.820535] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.923s) [422.858701] Starting dynamic subtest: pipe-D-eDP-1-size-128 [425.042477] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s) [425.082153] Starting dynamic subtest: pipe-D-eDP-1-size-256 [427.253478] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s) [427.581444] Subtest overlay: SUCCESS (32.439s) [428.476773] [088/133] (610s left) gem_ctx_param (basic-default) [428.532675] Starting subtest: basic-default [428.534575] Subtest basic-default: SUCCESS (0.000s) [428.632864] [089/133] (609s left) api_intel_allocator (two-level-inception-interruptible) [428.682165] Starting subtest: two-level-inception-interruptible [434.087309] Subtest two-level-inception-interruptible: SUCCESS (5.406s) [434.244296] [090/133] (604s left) kms_dsc (dsc-with-bpc-formats) [434.344763] Starting subtest: dsc-with-bpc-formats [434.455310] Subtest dsc-with-bpc-formats: SKIP (0.003s) [434.497349] [091/133] (604s left) kms_cursor_crc (cursor-alpha-opaque) [434.597289] Starting subtest: cursor-alpha-opaque [434.599185] Starting dynamic subtest: pipe-A-eDP-1 [435.218744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s) [435.235438] Starting dynamic subtest: pipe-D-eDP-1 [436.498697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s) [436.501134] Subtest cursor-alpha-opaque: SUCCESS (1.902s) [437.382970] [092/133] (601s left) syncobj_timeline (multi-wait-all-signaled) [437.461645] Starting subtest: multi-wait-all-signaled [437.464075] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [437.599320] [093/133] (601s left) i915_drm_fdinfo (isolation) [437.644629] Starting subtest: isolation [437.646881] Starting dynamic subtest: rcs0 [437.685240] Dynamic subtest rcs0: SKIP (0.041s) [437.697606] Starting dynamic subtest: bcs0 [437.701877] Dynamic subtest bcs0: SKIP (0.001s) [437.711246] Starting dynamic subtest: vcs0 [437.715276] Dynamic subtest vcs0: SKIP (0.001s) [437.724463] Starting dynamic subtest: vcs1 [437.728829] Dynamic subtest vcs1: SKIP (0.000s) [437.738075] Starting dynamic subtest: vecs0 [437.742236] Dynamic subtest vecs0: SKIP (0.000s) [437.751173] Starting dynamic subtest: ccs0 [437.755395] Dynamic subtest ccs0: SKIP (0.000s) [437.759739] Subtest isolation: SKIP (0.049s) [437.797154] [094/133] (600s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [437.901983] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [437.904310] Starting dynamic subtest: pipe-A-default-mode [439.082055] Dynamic subtest pipe-A-default-mode: SKIP (1.178s) [439.086693] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.179s) [439.257156] [095/133] (599s left) gem_ctx_isolation (preservation-s3) [439.321966] Starting subtest: preservation-S3 [439.323801] Starting dynamic subtest: rcs0 [455.457120] Dynamic subtest rcs0: SUCCESS (1.752s) [455.467706] Starting dynamic subtest: bcs0 [472.463333] Dynamic subtest bcs0: SUCCESS (1.738s) [472.473930] Starting dynamic subtest: vcs0 [489.464332] Dynamic subtest vcs0: SUCCESS (3.556s) [489.475084] Starting dynamic subtest: vcs1 [507.452506] Dynamic subtest vcs1: SUCCESS (4.976s) [507.463142] Starting dynamic subtest: vecs0 [525.453140] Dynamic subtest vecs0: SUCCESS (5.027s) [525.463204] Starting dynamic subtest: ccs0 [543.458529] Dynamic subtest ccs0: SUCCESS (3.203s) [543.460719] Subtest preservation-S3: SUCCESS (20.259s) [550.770714] [096/133] (495s left) gem_eio (reset-stress) [551.039388] Starting subtest: reset-stress [551.041726] Starting dynamic subtest: render [556.681577] Dynamic subtest render: SUCCESS (5.523s) [556.692696] Starting dynamic subtest: bsd1 [574.393831] Dynamic subtest bsd1: SUCCESS (17.611s) [574.411201] Starting dynamic subtest: bsd2 [592.412573] Dynamic subtest bsd2: SUCCESS (18.004s) [592.429332] Starting dynamic subtest: blt [592.434075] Dynamic subtest blt: SKIP (0.000s) [592.443562] Starting dynamic subtest: vebox [610.435111] Dynamic subtest vebox: SUCCESS (18.015s) [610.437783] Subtest reset-stress: SUCCESS (59.158s) [611.837945] [097/133] (434s left) gem_softpin (evict-snoop-interruptible) [611.902166] Starting subtest: evict-snoop-interruptible [611.906965] Subtest evict-snoop-interruptible: SKIP (0.000s) [612.058682] [098/133] (433s left) i915_module_load (reload-no-display) [612.100743] Starting subtest: reload-no-display [619.536418] Subtest reload-no-display: SUCCESS (7.436s) [619.566464] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [619.567217] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [619.570305] [099/133] (426s left) kms_flip (2x-flip-vs-modeset) [621.194315] Starting subtest: 2x-flip-vs-modeset [621.206615] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [621.320508] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [621.321806] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [621.326057] [100/133] (424s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [621.428700] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [621.430891] Starting dynamic subtest: pipe-A-default-mode [621.731530] Dynamic subtest pipe-A-default-mode: SKIP (0.300s) [621.736431] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.302s) [622.541772] [101/133] (423s left) kms_content_protection (type1) [622.710183] Starting subtest: type1 [622.714771] Subtest type1: SKIP (0.000s) [622.883864] [102/133] (423s left) kms_big_fb (4-tiled-16bpp-rotate-180) [622.997296] Starting subtest: 4-tiled-16bpp-rotate-180 [624.221471] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.225s) [624.414760] [103/133] (421s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [624.515533] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [624.518974] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [624.686984] [104/133] (421s left) gem_ppgtt (flink-and-close-vma-leak) [624.747275] Starting subtest: flink-and-close-vma-leak [624.792115] Subtest flink-and-close-vma-leak: SUCCESS (0.045s) [624.952808] [105/133] (421s left) syncobj_wait (signal) [625.008766] Starting subtest: signal [625.010738] Subtest signal: SUCCESS (0.000s) [625.143221] [106/133] (421s left) kms_cursor_crc (cursor-rapid-movement-128x128) [625.352485] Starting subtest: cursor-rapid-movement-128x128 [625.354378] Starting dynamic subtest: pipe-A-eDP-1 [625.897307] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s) [625.930222] Starting dynamic subtest: pipe-D-eDP-1 [627.157368] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s) [627.159537] Subtest cursor-rapid-movement-128x128: SUCCESS (1.806s) [628.018533] [107/133] (418s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [633.071846] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [633.074222] Starting dynamic subtest: pipe-A-eDP-1 [633.866632] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s) [633.876700] Starting dynamic subtest: pipe-B-eDP-1 [634.989632] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s) [634.994287] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.917s) [636.204860] [108/133] (410s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [636.313994] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [642.888011] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.573s) [643.063048] [109/133] (403s left) kms_vblank (query-forked-busy) [643.163054] Starting subtest: query-forked-busy [643.164860] Starting dynamic subtest: pipe-A-eDP-1 [645.037312] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [645.052338] Starting dynamic subtest: pipe-D-eDP-1 [647.572709] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s) [647.574957] Subtest query-forked-busy: SUCCESS (4.409s) [648.399314] [110/133] (398s left) syncobj_timeline (invalid-transfer-non-existent-point) [648.467400] Starting subtest: invalid-transfer-non-existent-point [648.469696] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [648.605484] [111/133] (397s left) kms_big_fb (x-tiled-16bpp-rotate-0) [648.715481] Starting subtest: x-tiled-16bpp-rotate-0 [650.058872] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.345s) [650.194607] [112/133] (396s left) kms_psr (fbc-psr-primary-blt) [650.279498] Starting subtest: fbc-psr-primary-blt [650.281373] Starting dynamic subtest: eDP-1 [650.284769] Dynamic subtest eDP-1: SKIP (0.000s) [650.288195] Subtest fbc-psr-primary-blt: SKIP (0.001s) [650.375291] [113/133] (396s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [650.441572] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [650.546523] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s) [650.646626] [114/133] (395s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [650.757503] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [650.761406] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [650.865690] [115/133] (395s left) gem_exec_reloc (basic-cpu-active) [650.919411] Subtest basic-cpu-active: SKIP (0.000s) [650.998777] [116/133] (395s left) perf (rc6-disable) [651.156770] Starting subtest: rc6-disable [651.337977] Subtest rc6-disable: SUCCESS (0.182s) [651.384510] [117/133] (395s left) gem_ctx_shared (q-independent) [651.465041] Starting subtest: Q-independent [651.467408] Starting dynamic subtest: rcs0 [651.533175] Dynamic subtest rcs0: SUCCESS (0.067s) [651.545411] Starting dynamic subtest: vcs0 [651.574170] Dynamic subtest vcs0: SUCCESS (0.041s) [651.583881] Starting dynamic subtest: vcs1 [651.607998] Dynamic subtest vcs1: SUCCESS (0.033s) [651.617405] Starting dynamic subtest: vecs0 [651.641911] Dynamic subtest vecs0: SUCCESS (0.033s) [651.651286] Starting dynamic subtest: ccs0 [651.682091] Dynamic subtest ccs0: SUCCESS (0.040s) [651.683984] Subtest Q-independent: SUCCESS (0.218s) [652.937014] [118/133] (393s left) perf (non-zero-reason) [653.044948] Starting subtest: non-zero-reason [653.047721] Starting dynamic subtest: 0-rcs0 [658.515265] Dynamic subtest 0-rcs0: SUCCESS (5.470s) [658.527913] Starting dynamic subtest: 1-vcs1 [662.419064] Dynamic subtest 1-vcs1: SUCCESS (3.903s) [662.422035] Subtest non-zero-reason: SUCCESS (9.375s) [662.469586] [119/133] (384s left) kms_psr (pr-dpms) [662.583180] Starting subtest: pr-dpms [662.587666] Subtest pr-dpms: SKIP (0.000s) [662.679388] [120/133] (384s left) kms_rotation_crc (primary-rotation-180) [662.783479] Starting subtest: primary-rotation-180 [669.727366] Subtest primary-rotation-180: SUCCESS (6.947s) [670.976645] [121/133] (375s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [671.078779] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [678.411762] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.336s) [678.587202] [122/133] (368s left) gem_create (create-size-update) [678.645506] Starting subtest: create-size-update [678.647425] Subtest create-size-update: SUCCESS (0.000s) [678.888158] [123/133] (368s left) prime_vgem (basic-fence-blt) [678.972313] Starting subtest: basic-fence-blt [679.063217] Subtest basic-fence-blt: SUCCESS (0.094s) [679.231620] [124/133] (367s left) kms_getfb (getfb2-into-addfb2) [679.325226] Starting subtest: getfb2-into-addfb2 [679.327556] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [679.463569] [125/133] (367s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [679.594306] Starting subtest: verify-pxp-execution-after-suspend-resume [686.696976] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.102s) [692.914207] [126/133] (360s left) syncobj_basic (bad-pad-fd-to-handle) [692.979752] Starting subtest: bad-pad-fd-to-handle [692.982128] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [693.124615] [127/133] (360s left) dmabuf_sync_file (export-before-signal) [693.174465] Starting subtest: export-before-signal [693.176367] Subtest export-before-signal: SUCCESS (0.001s) [693.263986] [128/133] (359s left) kms_flip (2x-flip-vs-panning-vs-hang) [693.384158] Starting subtest: 2x-flip-vs-panning-vs-hang [693.397017] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.012s) [693.503742] [129/133] (359s left) gem_softpin (allocator-nopin-reserve) [693.566566] Starting subtest: allocator-nopin-reserve [693.670952] Subtest allocator-nopin-reserve: SUCCESS (0.103s) [693.841782] [130/133] (359s left) kms_pipe_crc_basic (read-crc-frame-sequence) [693.934317] Starting subtest: read-crc-frame-sequence [693.936569] Starting dynamic subtest: pipe-A-eDP-1 [694.647254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s) [694.657445] Starting dynamic subtest: pipe-B-eDP-1 [695.997952] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s) [696.009274] Starting dynamic subtest: pipe-C-eDP-1 [697.299017] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s) [697.310760] Starting dynamic subtest: pipe-D-eDP-1 [698.622212] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [698.624464] Subtest read-crc-frame-sequence: SUCCESS (4.691s) [699.482419] [131/133] (353s left) kms_frontbuffer_tracking (pipe-fbc-rte) [699.590814] Starting subtest: pipe-fbc-rte [699.597609] Starting dynamic subtest: pipe-B-eDP-1 [705.031623] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.444s) [705.038861] Subtest pipe-fbc-rte: SUCCESS (5.446s) [707.392192] [132/133] (346s left) kms_addfb_basic (too-wide) [707.504287] Starting subtest: too-wide [707.506457] Subtest too-wide: SUCCESS (0.000s) [707.640633] [133/133] (345s left) gem_exec_schedule (pi-shared-iova) [707.827121] Starting subtest: pi-shared-iova [707.829375] Starting dynamic subtest: rcs0 [707.900034] Dynamic subtest rcs0: SUCCESS (0.076s) [707.912322] Starting dynamic subtest: vcs0 [707.957384] Dynamic subtest vcs0: SUCCESS (0.057s) [707.967735] Starting dynamic subtest: vcs1 [708.013818] Dynamic subtest vcs1: SUCCESS (0.055s) [708.024767] Starting dynamic subtest: vecs0 [708.064995] Dynamic subtest vecs0: SUCCESS (0.050s) [708.076107] Starting dynamic subtest: ccs0 [708.121366] Dynamic subtest ccs0: SUCCESS (0.056s) [708.123768] Subtest pi-shared-iova: SUCCESS (0.298s) [709.938190] 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.