[58.750265] Initializing watchdogs [58.750310] /dev/watchdog0 [58.763789] [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] [58.767991] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.770303] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.773660] [001/133] (960s left) syncobj_basic (bad-create-flags) [58.843056] Starting subtest: bad-create-flags [58.845330] Subtest bad-create-flags: SUCCESS (0.000s) [58.993830] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [64.048568] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [64.051070] Starting dynamic subtest: pipe-A-eDP-1 [70.931998] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.889s) [70.940684] Starting dynamic subtest: pipe-B-eDP-1 [77.851413] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.923s) [77.853396] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.815s) [78.721082] [003/133] (940s left) gem_ccs (block-copy-compressed) [78.796379] Starting subtest: block-copy-compressed [78.800623] Subtest block-copy-compressed: SKIP (0.000s) [78.934838] [004/133] (940s left) kms_sequence (get-forked-busy) [79.012747] Starting subtest: get-forked-busy [79.015058] Starting dynamic subtest: pipe-A-eDP-1 [80.948368] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [80.957744] Starting dynamic subtest: pipe-B-eDP-1 [83.591779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.643s) [83.599057] Starting dynamic subtest: pipe-C-eDP-1 [86.213482] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s) [86.223490] Starting dynamic subtest: pipe-D-eDP-1 [88.761668] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s) [88.763842] Subtest get-forked-busy: SUCCESS (9.746s) [89.650939] [005/133] (929s left) sysfs_preempt_timeout (timeout) [89.717947] Starting subtest: timeout [89.720236] Starting dynamic subtest: vecs0 [97.965193] Dynamic subtest vecs0: SUCCESS (8.242s) [97.975196] Starting dynamic subtest: ccs0 [99.284941] Dynamic subtest ccs0: SUCCESS (1.322s) [99.294778] Starting dynamic subtest: vcs0 [108.894054] Dynamic subtest vcs0: SUCCESS (9.604s) [108.904228] Starting dynamic subtest: bcs0 [110.239682] Dynamic subtest bcs0: SUCCESS (1.347s) [110.250066] Starting dynamic subtest: rcs0 [111.612638] Dynamic subtest rcs0: SUCCESS (1.372s) [111.624477] Starting dynamic subtest: vcs1 [120.945113] Dynamic subtest vcs1: SUCCESS (9.330s) [120.947744] Subtest timeout: SUCCESS (31.224s) [121.051297] [006/133] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [121.178689] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [121.182811] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [121.317195] [007/133] (898s left) gem_ctx_persistence (legacy-engines-queued) [121.392360] Starting subtest: legacy-engines-queued [121.394629] Starting dynamic subtest: render [121.490828] Dynamic subtest render: SUCCESS (0.098s) [121.499941] Starting dynamic subtest: bsd1 [122.866836] Dynamic subtest bsd1: SUCCESS (1.373s) [122.874374] Starting dynamic subtest: bsd2 [124.852742] Dynamic subtest bsd2: SUCCESS (1.983s) [124.863212] Starting dynamic subtest: blt [124.938280] Dynamic subtest blt: SUCCESS (0.084s) [124.948026] Starting dynamic subtest: vebox [126.899650] Dynamic subtest vebox: SUCCESS (1.958s) [126.902755] Subtest legacy-engines-queued: SUCCESS (5.506s) [126.996635] [008/133] (892s left) drm_read (short-buffer-block) [127.179934] Starting subtest: short-buffer-block [127.182439] Subtest short-buffer-block: SUCCESS (0.000s) [127.341159] [009/133] (892s left) gem_render_copy_redux (normal) [127.406306] Starting subtest: normal [127.673867] Subtest normal: SUCCESS (0.267s) [127.833072] [010/133] (891s left) kms_big_fb (y-tiled-32bpp-rotate-90) [127.950406] Starting subtest: y-tiled-32bpp-rotate-90 [127.954087] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [128.082033] [011/133] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [128.187372] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [135.439158] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.255s) [135.608752] [012/133] (884s left) gem_exec_suspend (basic) [135.680608] Starting subtest: basic [135.683024] Starting dynamic subtest: smem [136.918408] Dynamic subtest smem: SUCCESS (1.235s) [136.921322] Subtest basic: SUCCESS (1.237s) [137.121313] [013/133] (882s left) kms_hdmi_inject (inject-audio) [137.476351] Starting subtest: inject-audio [137.753331] Subtest inject-audio: SUCCESS (0.279s) [138.346172] [014/133] (881s left) kms_cursor_crc (cursor-sliding-32x10) [138.499469] Starting subtest: cursor-sliding-32x10 [138.546805] Subtest cursor-sliding-32x10: SKIP (0.041s) [138.841157] [015/133] (881s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [138.944264] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [145.392082] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.450s) [145.538733] [016/133] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [145.644279] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [145.648461] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [145.765254] [017/133] (874s left) gem_render_copy (y-tiled-ccs-to-linear) [145.831816] Starting subtest: y-tiled-ccs-to-linear [145.836420] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [146.039205] [018/133] (873s left) kms_big_fb (4-tiled-16bpp-rotate-90) [146.133920] Starting subtest: 4-tiled-16bpp-rotate-90 [146.153691] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [146.323518] [019/133] (873s left) syncobj_timeline (transfer-timeline-point) [146.382585] Starting subtest: transfer-timeline-point [146.385181] Subtest transfer-timeline-point: SUCCESS (0.001s) [146.523810] [020/133] (873s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [146.575796] Starting subtest: invalid-multi-wait-unsubmitted-submitted [146.577955] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [146.684435] [021/133] (873s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [146.774119] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [146.776397] Starting dynamic subtest: pipe-A-eDP-1 [146.800614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [146.810574] Starting dynamic subtest: pipe-B-eDP-1 [146.833617] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [146.841616] Starting dynamic subtest: pipe-C-eDP-1 [146.865826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [146.874771] Starting dynamic subtest: pipe-D-eDP-1 [146.899158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [146.903226] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [148.992178] [022/133] (871s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [151.122847] Starting subtest: dpms-mode-unset-non-lpsp [152.268235] Subtest dpms-mode-unset-non-lpsp: SKIP (1.146s) [152.658812] [023/133] (867s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [152.760196] Starting subtest: psr-rgb565-draw-mmap-wc [159.410680] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.652s) [159.547330] [024/133] (860s left) kms_chamelium_edid (vga-edid-read) [159.934404] Subtest vga-edid-read: SKIP (0.000s) [160.751082] [025/133] (859s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [160.816140] Starting subtest: yf-tiled-to-vebox-y-tiled [160.820857] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [161.020773] [026/133] (859s left) kms_flip (dpms-off-confusion) [161.126814] Starting subtest: dpms-off-confusion [161.131233] Starting dynamic subtest: A-eDP1 [169.859044] Dynamic subtest A-eDP1: SUCCESS (8.725s) [169.879730] Starting dynamic subtest: B-eDP1 [178.540967] Dynamic subtest B-eDP1: SUCCESS (8.681s) [178.551264] Starting dynamic subtest: C-eDP1 [187.228589] Dynamic subtest C-eDP1: SUCCESS (8.685s) [187.236308] Starting dynamic subtest: D-eDP1 [195.933074] Dynamic subtest D-eDP1: SUCCESS (8.704s) [195.937947] Subtest dpms-off-confusion: SUCCESS (34.811s) [197.185941] [027/133] (823s left) gem_exec_big (single) [197.259835] Starting subtest: single [199.600688] Subtest single: SUCCESS (2.338s) [199.819513] [028/133] (820s left) gem_exec_flush (basic-wb-ro-default) [199.922297] Starting subtest: basic-wb-ro-default [205.381283] Subtest basic-wb-ro-default: SUCCESS (5.459s) [205.588761] [029/133] (814s left) kms_async_flips (async-flip-with-page-flip-events-linear) [205.691550] Starting subtest: async-flip-with-page-flip-events-linear [206.064123] Starting dynamic subtest: pipe-A-eDP-1 [208.806121] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.742s) [209.180381] Starting dynamic subtest: pipe-B-eDP-1 [211.906397] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.732s) [212.277437] Starting dynamic subtest: pipe-C-eDP-1 [215.014137] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.743s) [215.371418] Starting dynamic subtest: pipe-D-eDP-1 [218.106594] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.741s) [218.109389] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.415s) [219.284420] [030/133] (801s left) kms_plane_scaling (planes-downscale-factor-0-75) [219.395200] Starting subtest: planes-downscale-factor-0-75 [219.397468] Starting dynamic subtest: pipe-A [219.417580] Dynamic subtest pipe-A: SKIP (0.018s) [219.426059] Starting dynamic subtest: pipe-B [219.448322] Dynamic subtest pipe-B: SKIP (0.031s) [219.456083] Starting dynamic subtest: pipe-C [219.480577] Dynamic subtest pipe-C: SKIP (0.031s) [219.488080] Starting dynamic subtest: pipe-D [219.510414] Dynamic subtest pipe-D: SKIP (0.031s) [219.514862] Subtest planes-downscale-factor-0-75: SKIP (0.113s) [219.645350] [031/133] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [219.748408] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [219.752454] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [219.891179] [032/133] (800s left) kms_properties (colorop-properties-legacy) [219.989049] Starting subtest: colorop-properties-legacy [219.991367] Starting dynamic subtest: pipe-A-eDP-1 [220.386540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s) [220.395352] Starting dynamic subtest: pipe-B-eDP-1 [221.499440] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.111s) [221.508312] Starting dynamic subtest: pipe-C-eDP-1 [222.597409] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.097s) [222.606604] Starting dynamic subtest: pipe-D-eDP-1 [223.677764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.079s) [223.679949] Subtest colorop-properties-legacy: SUCCESS (3.691s) [224.579584] [033/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [224.687831] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [224.692148] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [224.816717] [034/133] (795s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [224.901674] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [224.903880] Starting dynamic subtest: pipe-A-eDP-1 [224.922848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [224.931480] Starting dynamic subtest: pipe-B-eDP-1 [224.950421] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [224.958097] Starting dynamic subtest: pipe-C-eDP-1 [224.976136] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [224.983948] Starting dynamic subtest: pipe-D-eDP-1 [225.003314] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [225.005497] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [227.191504] [035/133] (793s left) gem_wait (wait) [227.265556] Starting subtest: wait [227.267589] Starting dynamic subtest: all-engines [228.884781] Dynamic subtest all-engines: SUCCESS (1.620s) [228.895701] Starting dynamic subtest: rcs0 [229.930595] Dynamic subtest rcs0: SUCCESS (1.045s) [229.941649] Starting dynamic subtest: bcs0 [230.977201] Dynamic subtest bcs0: SUCCESS (1.045s) [230.987664] Starting dynamic subtest: vcs0 [232.021253] Dynamic subtest vcs0: SUCCESS (1.042s) [232.032157] Starting dynamic subtest: vcs1 [233.066746] Dynamic subtest vcs1: SUCCESS (1.043s) [233.077652] Starting dynamic subtest: vecs0 [234.112695] Dynamic subtest vecs0: SUCCESS (1.044s) [234.123727] Starting dynamic subtest: ccs0 [235.157985] Dynamic subtest ccs0: SUCCESS (1.044s) [235.160851] Subtest wait: SUCCESS (7.896s) [235.383312] [036/133] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [235.489410] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [235.493686] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [235.604724] [037/133] (785s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [235.716123] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [236.684393] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.967s) [236.864382] [038/133] (783s left) gem_exec_reloc (basic-concurrent0) [236.935028] Subtest basic-concurrent0: SKIP (0.000s) [237.017469] [039/133] (783s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [237.114269] Starting subtest: yf-tiled-32bpp-rotate-180 [237.117906] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [237.263723] [040/133] (783s left) kms_lease (cursor-implicit-plane) [237.370314] Starting subtest: cursor-implicit-plane [237.372231] Starting dynamic subtest: pipe-A-eDP-1 [237.816684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s) [237.825574] Starting dynamic subtest: pipe-B-eDP-1 [238.959773] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s) [238.971581] Starting dynamic subtest: pipe-C-eDP-1 [240.046293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.082s) [240.054951] Starting dynamic subtest: pipe-D-eDP-1 [241.131988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.086s) [241.134554] Subtest cursor-implicit-plane: SUCCESS (3.763s) [241.980407] [041/133] (778s left) gem_exec_schedule (u-semaphore-resolve) [242.063785] Starting subtest: u-semaphore-resolve [242.092333] Subtest u-semaphore-resolve: SUCCESS (0.037s) [242.476921] [042/133] (778s left) gem_exec_whisper (basic-fds-priority) [242.533730] Starting subtest: basic-fds-priority [267.066815] Subtest basic-fds-priority: SUCCESS (24.528s) [267.263529] [043/133] (753s left) i915_query (query-topology-known-pci-ids) [267.328539] Starting subtest: query-topology-known-pci-ids [267.332902] Subtest query-topology-known-pci-ids: SKIP (0.000s) [267.460218] [044/133] (753s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [267.576254] Starting subtest: yf-tiled-64bpp-rotate-90 [267.580541] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [267.683428] [045/133] (753s left) perf_pmu (idle) [267.731879] Starting subtest: idle [267.734722] Starting dynamic subtest: rcs0 [268.279825] Dynamic subtest rcs0: SUCCESS (0.548s) [268.291066] Starting dynamic subtest: bcs0 [268.806030] Dynamic subtest bcs0: SUCCESS (0.524s) [268.815510] Starting dynamic subtest: vcs0 [269.334284] Dynamic subtest vcs0: SUCCESS (0.525s) [269.352967] Starting dynamic subtest: vcs1 [269.850918] Dynamic subtest vcs1: SUCCESS (0.515s) [269.863330] Starting dynamic subtest: vecs0 [270.373544] Dynamic subtest vecs0: SUCCESS (0.520s) [270.384587] Starting dynamic subtest: ccs0 [270.900110] Dynamic subtest ccs0: SUCCESS (0.524s) [270.903079] Subtest idle: SUCCESS (3.171s) [271.042503] [046/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [271.154200] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [271.158462] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [271.292514] [047/133] (749s left) gem_exec_flush (basic-uc-pro-default) [271.354404] Starting subtest: basic-uc-pro-default [276.802507] Subtest basic-uc-pro-default: SUCCESS (5.449s) [277.012191] [048/133] (744s left) gem_basic (bad-close) [277.078928] Starting subtest: bad-close [277.083637] Subtest bad-close: SUCCESS (0.000s) [277.222640] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [277.327550] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [277.331735] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [277.454411] [050/133] (743s left) kms_plane (pixel-format) [277.554790] Starting subtest: pixel-format [277.583288] Starting dynamic subtest: pipe-A-plane-0 [282.405279] Dynamic subtest pipe-A-plane-0: SUCCESS (4.822s) [282.420272] Starting dynamic subtest: pipe-A-plane-3 [284.649992] Dynamic subtest pipe-A-plane-3: SUCCESS (2.242s) [284.664248] Starting dynamic subtest: pipe-A-plane-5 [284.861193] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [285.927771] Starting dynamic subtest: pipe-B-plane-0 [290.765239] Dynamic subtest pipe-B-plane-0: SUCCESS (4.844s) [290.774315] Starting dynamic subtest: pipe-B-plane-3 [293.021201] Dynamic subtest pipe-B-plane-3: SUCCESS (2.254s) [293.032564] Starting dynamic subtest: pipe-B-plane-5 [293.232217] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s) [293.546892] Subtest pixel-format: SUCCESS (15.991s) [294.380958] [051/133] (726s left) kms_psr (fbc-psr2-no-drrs) [294.480848] Starting subtest: fbc-psr2-no-drrs [294.483122] Starting dynamic subtest: eDP-1 [294.487345] Dynamic subtest eDP-1: SKIP (0.000s) [294.491605] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [294.576878] [052/133] (726s left) gem_mmap (bad-size) [294.638958] Subtest bad-size: SKIP (0.000s) [294.704517] [053/133] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [294.799975] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [294.804311] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [294.937447] [054/133] (726s left) api_intel_bb (crc32) [294.998980] Starting subtest: crc32 [295.001861] Starting dynamic subtest: rcs0-smem0 [295.303868] Dynamic subtest rcs0-smem0: SUCCESS (0.303s) [295.316149] Starting dynamic subtest: bcs0-smem0 [295.654633] Dynamic subtest bcs0-smem0: SUCCESS (0.348s) [295.667361] Starting dynamic subtest: vcs0-smem0 [295.980390] Dynamic subtest vcs0-smem0: SUCCESS (0.323s) [295.992735] Starting dynamic subtest: vcs1-smem0 [296.356964] Dynamic subtest vcs1-smem0: SUCCESS (0.374s) [296.369387] Starting dynamic subtest: vecs0-smem0 [296.699844] Dynamic subtest vecs0-smem0: SUCCESS (0.340s) [296.711957] Starting dynamic subtest: ccs0-smem0 [297.001931] Dynamic subtest ccs0-smem0: SUCCESS (0.300s) [297.004826] Subtest crc32: SUCCESS (2.003s) [297.170453] [055/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [297.273590] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [297.278040] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [297.399256] [056/133] (724s left) kms_psr (psr2-cursor-render) [297.493815] Starting subtest: psr2-cursor-render [297.496080] Starting dynamic subtest: eDP-1 [299.204981] Dynamic subtest eDP-1: SUCCESS (1.709s) [299.207288] Subtest psr2-cursor-render: SUCCESS (1.711s) [300.072913] [057/133] (721s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [300.175828] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [300.186657] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [300.287371] [058/133] (721s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [300.386739] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [300.389114] Starting dynamic subtest: pipe-A-eDP-1 [300.827876] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s) [300.838676] Starting dynamic subtest: pipe-B-eDP-1 [302.303345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.473s) [302.313927] Starting dynamic subtest: pipe-C-eDP-1 [303.703172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s) [303.713933] Starting dynamic subtest: pipe-D-eDP-1 [305.140102] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.440s) [305.142184] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.730s) [306.379684] [059/133] (715s left) kms_dp_linktrain_fallback (dp-fallback) [306.490178] Starting subtest: dp-fallback [306.496715] Subtest dp-fallback: SKIP (0.001s) [306.584973] [060/133] (714s left) gem_readwrite (beyond-eob) [306.634143] Subtest beyond-EOB: SKIP (0.000s) [306.699442] [061/133] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [306.804843] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [311.269820] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.467s) [312.489169] [062/133] (709s left) prime_vgem (basic-fence-read) [312.649714] Starting subtest: basic-fence-read [312.656997] Subtest basic-fence-read: SKIP (0.006s) [312.795606] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [312.799197] [063/133] (708s left) perf_pmu (interrupts) [312.852790] Starting subtest: interrupts [313.955887] Subtest interrupts: SUCCESS (1.109s) [314.099420] [064/133] (707s left) i915_pm_rpm (system-suspend-devices) [316.133726] Starting subtest: system-suspend-devices [323.897891] Subtest system-suspend-devices: SUCCESS (7.765s) [324.293540] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [324.405693] Starting subtest: flip-vs-dpms-on-nop-interruptible [324.407872] Starting dynamic subtest: A-eDP1 [326.217810] Dynamic subtest A-eDP1: SUCCESS (1.810s) [326.229926] Starting dynamic subtest: B-eDP1 [328.015084] Dynamic subtest B-eDP1: SUCCESS (1.796s) [328.026740] Starting dynamic subtest: C-eDP1 [329.807317] Dynamic subtest C-eDP1: SUCCESS (1.790s) [329.819680] Starting dynamic subtest: D-eDP1 [331.597382] Dynamic subtest D-eDP1: SUCCESS (1.788s) [331.599704] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.194s) [332.792270] [066/133] (689s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [332.887681] Starting subtest: crc-primary-basic-y-tiled-ccs [332.890059] Starting dynamic subtest: pipe-A-eDP-1 [332.921941] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [332.932534] Starting dynamic subtest: pipe-B-eDP-1 [332.953637] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [332.962631] Starting dynamic subtest: pipe-C-eDP-1 [332.984027] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [332.992813] Starting dynamic subtest: pipe-D-eDP-1 [333.015141] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [333.019120] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [335.171495] [067/133] (686s left) kms_color (ctm-0-75) [335.269538] Starting subtest: ctm-0-75 [335.271654] Starting dynamic subtest: pipe-A-eDP-1 [340.207650] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.937s) [340.217187] Starting dynamic subtest: pipe-B-eDP-1 [345.821375] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.610s) [345.831530] Starting dynamic subtest: pipe-C-eDP-1 [351.174442] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.352s) [351.184599] Starting dynamic subtest: pipe-D-eDP-1 [356.556558] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.383s) [356.558905] Subtest ctm-0-75: SUCCESS (21.287s) [357.369778] [068/133] (664s left) gem_mmap_offset (partial-mmap) [357.439532] Starting subtest: partial-mmap [357.441507] Starting dynamic subtest: smem0 [357.443984] Dynamic subtest smem0: SUCCESS (0.003s) [357.446216] Subtest partial-mmap: SUCCESS (0.004s) [357.596208] [069/133] (664s left) syncobj_timeline (device-signal-unordered) [357.647332] Starting subtest: device-signal-unordered [357.649219] Subtest device-signal-unordered: SUCCESS (0.000s) [357.790564] [070/133] (664s left) kms_pm_dc (dc6-psr) [358.895953] Starting subtest: dc6-psr [361.783528] Subtest dc6-psr: SUCCESS (2.887s) [362.676734] [071/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [362.807578] Starting subtest: cursorB-vs-flipB-varying-size [362.812152] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [362.973162] [072/133] (659s left) kms_addfb_basic (no-handle) [363.015983] Starting subtest: no-handle [363.018273] Subtest no-handle: SUCCESS (0.000s) [363.186086] [073/133] (658s left) gem_pxp (create-regular-buffer) [363.309129] Starting subtest: create-regular-buffer [363.311594] Subtest create-regular-buffer: SUCCESS (0.000s) [363.461690] [074/133] (658s left) kms_flip (2x-dpms-vs-vblank-race) [363.550415] Starting subtest: 2x-dpms-vs-vblank-race [363.558516] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s) [363.682007] [075/133] (658s left) kms_psr (psr-dpms) [363.774226] Starting subtest: psr-dpms [363.776101] Starting dynamic subtest: eDP-1 [366.717198] Dynamic subtest eDP-1: SUCCESS (2.943s) [366.719601] Subtest psr-dpms: SUCCESS (2.944s) [367.577872] [076/133] (654s left) gem_lmem_swapping (massive-random) [367.623504] Subtest massive-random: SKIP (0.000s) [367.664015] [077/133] (654s left) gen9_exec_parse (bb-secure) [367.732266] Subtest bb-secure: SKIP (0.000s) [367.823239] [078/133] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [367.932702] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [367.936689] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [368.073740] [079/133] (654s left) i915_suspend (fence-restore-untiled) [368.136625] Starting subtest: fence-restore-untiled [368.141071] Subtest fence-restore-untiled: SKIP (0.000s) [368.260196] [080/133] (654s left) syncobj_wait (wait-delayed-signal) [368.317802] Starting subtest: wait-delayed-signal [368.419747] Subtest wait-delayed-signal: SUCCESS (0.103s) [368.526259] [081/133] (653s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [368.607144] Starting subtest: bad-pixel-format-yf-tiled-ccs [368.609366] Starting dynamic subtest: pipe-A-eDP-1 [368.631473] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [368.643657] Starting dynamic subtest: pipe-B-eDP-1 [368.664672] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [368.674141] Starting dynamic subtest: pipe-C-eDP-1 [368.695602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [368.705412] Starting dynamic subtest: pipe-D-eDP-1 [368.726329] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [368.730584] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [370.873281] [082/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [370.982411] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [370.986781] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [371.113328] [083/133] (651s left) kms_chamelium_hpd (dp-hpd-fast) [371.502757] Subtest dp-hpd-fast: SKIP (0.000s) [372.333178] [084/133] (650s left) gem_exec_balancer (bonded-false-hang) [372.599474] Starting subtest: bonded-false-hang [372.609251] Subtest bonded-false-hang: SKIP (0.000s) [372.727210] [085/133] (649s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [372.824214] Starting subtest: crc-primary-suspend-yf-tiled-ccs [372.826368] Starting dynamic subtest: pipe-A-eDP-1 [372.835017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [372.850612] Starting dynamic subtest: pipe-B-eDP-1 [372.859581] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [372.871249] Starting dynamic subtest: pipe-C-eDP-1 [372.879452] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [372.888294] Starting dynamic subtest: pipe-D-eDP-1 [372.897033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [372.901161] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [375.070450] [086/133] (647s left) gem_exec_fence (syncobj-timeline-invalid-flags) [375.618505] Starting subtest: syncobj-timeline-invalid-flags [375.620835] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [376.992381] [087/133] (645s left) kms_plane_cursor (overlay) [377.084521] Starting subtest: overlay [377.088773] Starting dynamic subtest: pipe-A-eDP-1-size-64 [379.629536] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.546s) [379.692352] Starting dynamic subtest: pipe-A-eDP-1-size-128 [382.132718] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.448s) [382.193074] Starting dynamic subtest: pipe-A-eDP-1-size-256 [384.633989] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.448s) [384.983433] Starting dynamic subtest: pipe-B-eDP-1-size-64 [388.218686] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.245s) [388.281863] Starting dynamic subtest: pipe-B-eDP-1-size-128 [390.786837] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s) [390.847506] Starting dynamic subtest: pipe-B-eDP-1-size-256 [393.331569] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.492s) [393.690225] Starting dynamic subtest: pipe-C-eDP-1-size-64 [396.585603] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.907s) [396.624219] Starting dynamic subtest: pipe-C-eDP-1-size-128 [398.773693] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s) [398.813017] Starting dynamic subtest: pipe-C-eDP-1-size-256 [400.919308] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.113s) [401.246189] Starting dynamic subtest: pipe-D-eDP-1-size-64 [404.016680] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.781s) [404.054067] Starting dynamic subtest: pipe-D-eDP-1-size-128 [406.160143] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.113s) [406.199899] Starting dynamic subtest: pipe-D-eDP-1-size-256 [408.283903] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.091s) [408.607429] Subtest overlay: SUCCESS (31.521s) [409.473435] [088/133] (613s left) gem_ctx_param (basic-default) [409.534813] Starting subtest: basic-default [409.537135] Subtest basic-default: SUCCESS (0.000s) [409.630952] [089/133] (613s left) api_intel_allocator (two-level-inception-interruptible) [409.696593] Starting subtest: two-level-inception-interruptible [415.098837] Subtest two-level-inception-interruptible: SUCCESS (5.404s) [415.256331] [090/133] (607s left) kms_dsc (dsc-with-bpc-formats) [415.362935] Starting subtest: dsc-with-bpc-formats [415.472689] Subtest dsc-with-bpc-formats: SKIP (0.003s) [415.518990] [091/133] (607s left) kms_cursor_crc (cursor-alpha-opaque) [415.615298] Starting subtest: cursor-alpha-opaque [415.617163] Starting dynamic subtest: pipe-A-eDP-1 [416.232763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s) [416.244064] Starting dynamic subtest: pipe-D-eDP-1 [417.489816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s) [417.492123] Subtest cursor-alpha-opaque: SUCCESS (1.876s) [418.390219] [092/133] (604s left) syncobj_timeline (multi-wait-all-signaled) [418.458594] Starting subtest: multi-wait-all-signaled [418.460944] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [418.619623] [093/133] (604s left) i915_drm_fdinfo (isolation) [418.663069] Starting subtest: isolation [418.667428] Starting dynamic subtest: rcs0 [418.709605] Dynamic subtest rcs0: SKIP (0.049s) [418.719892] Starting dynamic subtest: bcs0 [418.724220] Dynamic subtest bcs0: SKIP (0.000s) [418.734136] Starting dynamic subtest: vcs0 [418.738356] Dynamic subtest vcs0: SKIP (0.000s) [418.747794] Starting dynamic subtest: vcs1 [418.752134] Dynamic subtest vcs1: SKIP (0.000s) [418.762639] Starting dynamic subtest: vecs0 [418.767034] Dynamic subtest vecs0: SKIP (0.000s) [418.776884] Starting dynamic subtest: ccs0 [418.781247] Dynamic subtest ccs0: SKIP (0.000s) [418.785611] Subtest isolation: SKIP (0.055s) [418.830631] [094/133] (604s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [418.934690] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [418.936962] Starting dynamic subtest: pipe-A-default-mode [420.079964] Dynamic subtest pipe-A-default-mode: SKIP (1.141s) [420.084348] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.142s) [420.287247] [095/133] (602s left) gem_ctx_isolation (preservation-s3) [420.374835] Starting subtest: preservation-S3 [420.377092] Starting dynamic subtest: rcs0 [436.941134] Dynamic subtest rcs0: SUCCESS (1.982s) [436.951933] Starting dynamic subtest: bcs0 [452.933354] Dynamic subtest bcs0: SUCCESS (1.320s) [452.943792] Starting dynamic subtest: vcs0 [468.943170] Dynamic subtest vcs0: SUCCESS (2.324s) [468.954420] Starting dynamic subtest: vcs1 [486.971678] Dynamic subtest vcs1: SUCCESS (5.070s) [486.984280] Starting dynamic subtest: vecs0 [504.941141] Dynamic subtest vecs0: SUCCESS (5.076s) [504.954056] Starting dynamic subtest: ccs0 [522.941315] Dynamic subtest ccs0: SUCCESS (3.230s) [522.944210] Subtest preservation-S3: SUCCESS (19.008s) [523.211716] [096/133] (499s left) gem_eio (reset-stress) [523.437442] Starting subtest: reset-stress [523.440286] Starting dynamic subtest: render [528.748989] Dynamic subtest render: SUCCESS (5.390s) [528.766226] Starting dynamic subtest: bsd1 [547.268694] Dynamic subtest bsd1: SUCCESS (18.595s) [547.285162] Starting dynamic subtest: bsd2 [565.221540] Dynamic subtest bsd2: SUCCESS (17.951s) [565.237766] Starting dynamic subtest: blt [565.242573] Dynamic subtest blt: SKIP (0.000s) [565.252296] Starting dynamic subtest: vebox [583.239421] Dynamic subtest vebox: SUCCESS (18.016s) [583.241773] Subtest reset-stress: SUCCESS (59.957s) [584.717511] [097/133] (438s left) gem_softpin (evict-snoop-interruptible) [584.787576] Starting subtest: evict-snoop-interruptible [584.793094] Subtest evict-snoop-interruptible: SKIP (0.000s) [584.941538] [098/133] (438s left) i915_module_load (reload-no-display) [584.978577] Starting subtest: reload-no-display [590.970698] Subtest reload-no-display: SUCCESS (5.993s) [591.001651] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [591.002324] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [591.006023] [099/133] (432s left) kms_flip (2x-flip-vs-modeset) [593.869806] Starting subtest: 2x-flip-vs-modeset [593.879544] Subtest 2x-flip-vs-modeset: SKIP (0.012s) [593.998069] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [593.999279] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [594.003359] [100/133] (429s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [594.097220] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [594.099617] Starting dynamic subtest: pipe-A-default-mode [594.387366] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [594.392768] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.288s) [595.219609] [101/133] (428s left) kms_content_protection (type1) [595.371216] Starting subtest: type1 [595.376428] Subtest type1: SKIP (0.000s) [595.538345] [102/133] (427s left) kms_big_fb (4-tiled-16bpp-rotate-180) [595.633259] Starting subtest: 4-tiled-16bpp-rotate-180 [596.897999] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.267s) [597.056358] [103/133] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [597.165519] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [597.170296] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [597.302712] [104/133] (426s left) gem_ppgtt (flink-and-close-vma-leak) [597.366522] Starting subtest: flink-and-close-vma-leak [597.410742] Subtest flink-and-close-vma-leak: SUCCESS (0.044s) [597.576539] [105/133] (425s left) syncobj_wait (signal) [597.641363] Starting subtest: signal [597.643508] Subtest signal: SUCCESS (0.000s) [597.779107] [106/133] (425s left) kms_cursor_crc (cursor-rapid-movement-128x128) [597.985199] Starting subtest: cursor-rapid-movement-128x128 [597.987155] Starting dynamic subtest: pipe-A-eDP-1 [598.516817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s) [598.550218] Starting dynamic subtest: pipe-D-eDP-1 [599.701745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.159s) [599.703874] Subtest cursor-rapid-movement-128x128: SUCCESS (1.717s) [600.573573] [107/133] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [605.652722] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [605.655457] Starting dynamic subtest: pipe-A-eDP-1 [606.444236] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s) [606.456579] Starting dynamic subtest: pipe-B-eDP-1 [607.574980] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s) [607.580393] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.919s) [608.784197] [108/133] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [608.881515] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [615.351605] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.474s) [615.498974] [109/133] (408s left) kms_vblank (query-forked-busy) [615.601216] Starting subtest: query-forked-busy [615.604136] Starting dynamic subtest: pipe-A-eDP-1 [617.474338] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.872s) [617.496387] Starting dynamic subtest: pipe-D-eDP-1 [620.027485] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [620.030406] Subtest query-forked-busy: SUCCESS (4.425s) [620.846997] [110/133] (402s left) syncobj_timeline (invalid-transfer-non-existent-point) [620.909813] Starting subtest: invalid-transfer-non-existent-point [620.912153] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [621.045029] [111/133] (402s left) kms_big_fb (x-tiled-16bpp-rotate-0) [621.144589] Starting subtest: x-tiled-16bpp-rotate-0 [622.377088] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.233s) [622.566269] [112/133] (401s left) kms_psr (fbc-psr-primary-blt) [622.665304] Starting subtest: fbc-psr-primary-blt [622.667399] Starting dynamic subtest: eDP-1 [622.672070] Dynamic subtest eDP-1: SKIP (0.000s) [622.676176] Subtest fbc-psr-primary-blt: SKIP (0.001s) [622.760291] [113/133] (401s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [622.820127] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [622.925881] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s) [623.026594] [114/133] (400s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [623.129333] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [623.134826] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [623.243432] [115/133] (400s left) gem_exec_reloc (basic-cpu-active) [623.313385] Subtest basic-cpu-active: SKIP (0.000s) [623.392903] [116/133] (400s left) perf (rc6-disable) [623.534261] Starting subtest: rc6-disable [623.709909] Subtest rc6-disable: SUCCESS (0.175s) [623.761515] [117/133] (400s left) gem_ctx_shared (q-independent) [623.825423] Starting subtest: Q-independent [623.827758] Starting dynamic subtest: rcs0 [623.894598] Dynamic subtest rcs0: SUCCESS (0.068s) [623.906034] Starting dynamic subtest: vcs0 [623.939854] Dynamic subtest vcs0: SUCCESS (0.045s) [623.952099] Starting dynamic subtest: vcs1 [623.981987] Dynamic subtest vcs1: SUCCESS (0.042s) [623.993796] Starting dynamic subtest: vecs0 [624.018803] Dynamic subtest vecs0: SUCCESS (0.036s) [624.030346] Starting dynamic subtest: ccs0 [624.058066] Dynamic subtest ccs0: SUCCESS (0.039s) [624.060249] Subtest Q-independent: SUCCESS (0.233s) [625.814429] [118/133] (398s left) perf (non-zero-reason) [625.924338] Starting subtest: non-zero-reason [625.926389] Starting dynamic subtest: 0-rcs0 [631.303376] Dynamic subtest 0-rcs0: SUCCESS (5.378s) [631.316558] Starting dynamic subtest: 1-vecs0 [635.175489] Dynamic subtest 1-vecs0: SUCCESS (3.870s) [635.178398] Subtest non-zero-reason: SUCCESS (9.250s) [635.225266] [119/133] (388s left) kms_psr (pr-dpms) [635.329213] Starting subtest: pr-dpms [635.334360] Subtest pr-dpms: SKIP (0.000s) [635.421829] [120/133] (388s left) kms_rotation_crc (primary-rotation-180) [635.517478] Starting subtest: primary-rotation-180 [642.728516] Subtest primary-rotation-180: SUCCESS (7.210s) [643.926267] [121/133] (380s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [644.036526] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [651.279481] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.245s) [651.447006] [122/133] (372s left) gem_create (create-size-update) [651.507364] Starting subtest: create-size-update [651.510296] Subtest create-size-update: SUCCESS (0.000s) [651.753011] [123/133] (372s left) prime_vgem (basic-fence-blt) [651.823383] Starting subtest: basic-fence-blt [651.928427] Subtest basic-fence-blt: SUCCESS (0.112s) [652.085105] [124/133] (372s left) kms_getfb (getfb2-into-addfb2) [652.192879] Starting subtest: getfb2-into-addfb2 [652.195228] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [652.327862] [125/133] (371s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [652.442527] Starting subtest: verify-pxp-execution-after-suspend-resume [659.501434] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.058s) [659.677015] [126/133] (364s left) syncobj_basic (bad-pad-fd-to-handle) [659.745542] Starting subtest: bad-pad-fd-to-handle [659.748369] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [659.884142] [127/133] (364s left) dmabuf_sync_file (export-before-signal) [659.942577] Starting subtest: export-before-signal [659.945543] Subtest export-before-signal: SUCCESS (0.001s) [660.038227] [128/133] (364s left) kms_flip (2x-flip-vs-panning-vs-hang) [660.141239] Starting subtest: 2x-flip-vs-panning-vs-hang [660.149567] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s) [660.255777] [129/133] (364s left) gem_softpin (allocator-nopin-reserve) [660.317735] Starting subtest: allocator-nopin-reserve [660.424298] Subtest allocator-nopin-reserve: SUCCESS (0.105s) [660.595199] [130/133] (363s left) kms_pipe_crc_basic (read-crc-frame-sequence) [660.693793] Starting subtest: read-crc-frame-sequence [660.696150] Starting dynamic subtest: pipe-A-eDP-1 [661.396326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s) [661.407579] Starting dynamic subtest: pipe-B-eDP-1 [662.728819] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s) [662.740653] Starting dynamic subtest: pipe-C-eDP-1 [664.033007] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.303s) [664.045146] Starting dynamic subtest: pipe-D-eDP-1 [665.339128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s) [665.342236] Subtest read-crc-frame-sequence: SUCCESS (4.647s) [666.217363] [131/133] (358s left) kms_frontbuffer_tracking (pipe-fbc-rte) [666.321481] Starting subtest: pipe-fbc-rte [666.329671] Starting dynamic subtest: pipe-B-eDP-1 [671.743798] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.428s) [671.753385] Subtest pipe-fbc-rte: SUCCESS (5.431s) [674.025248] [132/133] (350s left) kms_addfb_basic (too-wide) [674.120785] Starting subtest: too-wide [674.123641] Subtest too-wide: SUCCESS (0.000s) [674.244745] [133/133] (350s left) gem_exec_schedule (pi-shared-iova) [674.436326] Starting subtest: pi-shared-iova [674.439358] Starting dynamic subtest: rcs0 [674.517125] Dynamic subtest rcs0: SUCCESS (0.082s) [674.531441] Starting dynamic subtest: vcs0 [674.574128] Dynamic subtest vcs0: SUCCESS (0.057s) [674.587153] Starting dynamic subtest: vcs1 [674.628041] Dynamic subtest vcs1: SUCCESS (0.052s) [674.641523] Starting dynamic subtest: vecs0 [674.683670] Dynamic subtest vecs0: SUCCESS (0.055s) [674.697124] Starting dynamic subtest: ccs0 [674.761576] Dynamic subtest ccs0: SUCCESS (0.077s) [674.764978] Subtest pi-shared-iova: SUCCESS (0.328s) [675.790159] 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.