[57.557863] Initializing watchdogs [57.557909] /dev/watchdog0 [57.571609] [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] [57.575714] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.577939] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.581207] [001/133] (960s left) syncobj_basic (bad-create-flags) [57.657105] Starting subtest: bad-create-flags [57.659464] Subtest bad-create-flags: SUCCESS (0.000s) [57.791156] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [62.853480] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [62.855849] Starting dynamic subtest: pipe-A-eDP-1 [69.606383] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.758s) [69.613780] Starting dynamic subtest: pipe-B-eDP-1 [76.614473] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.009s) [76.616837] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.771s) [77.501306] [003/133] (940s left) gem_ccs (block-copy-compressed) [77.575129] Starting subtest: block-copy-compressed [77.579733] Subtest block-copy-compressed: SKIP (0.000s) [77.707762] [004/133] (940s left) kms_sequence (get-forked-busy) [77.819302] Starting subtest: get-forked-busy [77.821617] Starting dynamic subtest: pipe-A-eDP-1 [79.756883] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s) [79.764045] Starting dynamic subtest: pipe-B-eDP-1 [82.382277] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.627s) [82.392896] Starting dynamic subtest: pipe-C-eDP-1 [84.984820] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s) [84.995078] Starting dynamic subtest: pipe-D-eDP-1 [87.521257] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s) [87.523663] Subtest get-forked-busy: SUCCESS (9.702s) [88.430670] [005/133] (929s left) sysfs_preempt_timeout (timeout) [88.496612] Starting subtest: timeout [88.498556] Starting dynamic subtest: vecs0 [97.891863] Dynamic subtest vecs0: SUCCESS (9.397s) [97.902576] Starting dynamic subtest: ccs0 [99.199277] Dynamic subtest ccs0: SUCCESS (1.305s) [99.208433] Starting dynamic subtest: vcs0 [108.890279] Dynamic subtest vcs0: SUCCESS (9.688s) [108.900415] Starting dynamic subtest: bcs0 [110.298894] Dynamic subtest bcs0: SUCCESS (1.409s) [110.308891] Starting dynamic subtest: rcs0 [111.709817] Dynamic subtest rcs0: SUCCESS (1.409s) [111.719989] Starting dynamic subtest: vcs1 [120.916792] Dynamic subtest vcs1: SUCCESS (9.204s) [120.919533] Subtest timeout: SUCCESS (32.419s) [121.010484] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [121.112629] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [121.117090] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [121.273656] [007/133] (897s left) gem_ctx_persistence (legacy-engines-queued) [121.346051] Starting subtest: legacy-engines-queued [121.348232] Starting dynamic subtest: render [121.429346] Dynamic subtest render: SUCCESS (0.084s) [121.440884] Starting dynamic subtest: bsd1 [122.805308] Dynamic subtest bsd1: SUCCESS (1.372s) [122.817938] Starting dynamic subtest: bsd2 [123.891244] Dynamic subtest bsd2: SUCCESS (1.084s) [123.901931] Starting dynamic subtest: blt [123.965539] Dynamic subtest blt: SUCCESS (0.074s) [123.975083] Starting dynamic subtest: vebox [125.873792] Dynamic subtest vebox: SUCCESS (1.905s) [125.877236] Subtest legacy-engines-queued: SUCCESS (4.529s) [125.973295] [008/133] (892s left) drm_read (short-buffer-block) [126.148863] Starting subtest: short-buffer-block [126.151317] Subtest short-buffer-block: SUCCESS (0.000s) [126.319646] [009/133] (892s left) gem_render_copy_redux (normal) [126.372375] Starting subtest: normal [126.628755] Subtest normal: SUCCESS (0.256s) [126.781313] [010/133] (891s left) kms_big_fb (y-tiled-32bpp-rotate-90) [126.879704] Starting subtest: y-tiled-32bpp-rotate-90 [126.884481] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [127.010765] [011/133] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [127.108769] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [134.301852] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.196s) [134.447971] [012/133] (884s left) gem_exec_suspend (basic) [134.510112] Starting subtest: basic [134.512465] Starting dynamic subtest: smem [135.892357] Dynamic subtest smem: SUCCESS (1.380s) [135.895107] Subtest basic: SUCCESS (1.381s) [136.094074] [013/133] (882s left) kms_hdmi_inject (inject-audio) [136.446294] Starting subtest: inject-audio [136.720336] Subtest inject-audio: SUCCESS (0.276s) [137.303625] [014/133] (881s left) kms_cursor_crc (cursor-sliding-32x10) [137.453096] Starting subtest: cursor-sliding-32x10 [137.497402] Subtest cursor-sliding-32x10: SKIP (0.040s) [137.788705] [015/133] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [137.897774] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [144.372844] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.478s) [144.528198] [016/133] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [144.644351] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [144.648758] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [144.783204] [017/133] (873s left) gem_render_copy (y-tiled-ccs-to-linear) [144.840897] Starting subtest: y-tiled-ccs-to-linear [144.845522] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [145.047850] [018/133] (873s left) kms_big_fb (4-tiled-16bpp-rotate-90) [145.148509] Starting subtest: 4-tiled-16bpp-rotate-90 [145.167376] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.018s) [145.337418] [019/133] (873s left) syncobj_timeline (transfer-timeline-point) [145.405109] Starting subtest: transfer-timeline-point [145.407446] Subtest transfer-timeline-point: SUCCESS (0.001s) [145.537812] [020/133] (873s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [145.605280] Starting subtest: invalid-multi-wait-unsubmitted-submitted [145.607717] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [145.744956] [021/133] (873s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [145.834854] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [145.837231] Starting dynamic subtest: pipe-A-eDP-1 [145.862374] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [145.878610] Starting dynamic subtest: pipe-B-eDP-1 [145.903454] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [145.919899] Starting dynamic subtest: pipe-C-eDP-1 [145.944458] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [145.959235] Starting dynamic subtest: pipe-D-eDP-1 [145.980520] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [145.984055] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [148.065760] [022/133] (870s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [150.092971] Starting subtest: dpms-mode-unset-non-lpsp [151.248039] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s) [151.630759] [023/133] (867s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [151.720400] Starting subtest: psr-rgb565-draw-mmap-wc [158.363263] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.645s) [158.511762] [024/133] (860s left) kms_chamelium_edid (vga-edid-read) [158.901548] Subtest vga-edid-read: SKIP (0.000s) [159.707690] [025/133] (859s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [159.780809] Starting subtest: yf-tiled-to-vebox-y-tiled [159.785460] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [159.984148] [026/133] (859s left) kms_flip (dpms-off-confusion) [160.094026] Starting subtest: dpms-off-confusion [160.099809] Starting dynamic subtest: A-eDP1 [168.812524] Dynamic subtest A-eDP1: SUCCESS (8.717s) [168.822627] Starting dynamic subtest: B-eDP1 [177.509688] Dynamic subtest B-eDP1: SUCCESS (8.696s) [177.520292] Starting dynamic subtest: C-eDP1 [186.206748] Dynamic subtest C-eDP1: SUCCESS (8.695s) [186.219209] Starting dynamic subtest: D-eDP1 [194.898487] Dynamic subtest D-eDP1: SUCCESS (8.690s) [194.901224] Subtest dpms-off-confusion: SUCCESS (34.806s) [196.067964] [027/133] (823s left) gem_exec_big (single) [196.130939] Starting subtest: single [198.453947] Subtest single: SUCCESS (2.323s) [198.679104] [028/133] (820s left) gem_exec_flush (basic-wb-ro-default) [198.778585] Starting subtest: basic-wb-ro-default [204.231609] Subtest basic-wb-ro-default: SUCCESS (5.455s) [204.435520] [029/133] (814s left) kms_async_flips (async-flip-with-page-flip-events-linear) [204.536698] Starting subtest: async-flip-with-page-flip-events-linear [204.916626] Starting dynamic subtest: pipe-A-eDP-1 [207.685262] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.768s) [208.054146] Starting dynamic subtest: pipe-B-eDP-1 [210.780963] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.734s) [211.152949] Starting dynamic subtest: pipe-C-eDP-1 [213.879237] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.733s) [214.247891] Starting dynamic subtest: pipe-D-eDP-1 [216.979100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.737s) [216.981400] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.443s) [218.160290] [030/133] (801s left) kms_plane_scaling (planes-downscale-factor-0-75) [218.265897] Starting subtest: planes-downscale-factor-0-75 [218.268222] Starting dynamic subtest: pipe-A [218.286015] Dynamic subtest pipe-A: SKIP (0.017s) [218.298448] Starting dynamic subtest: pipe-B [218.318564] Dynamic subtest pipe-B: SKIP (0.031s) [218.327489] Starting dynamic subtest: pipe-C [218.348617] Dynamic subtest pipe-C: SKIP (0.031s) [218.356918] Starting dynamic subtest: pipe-D [218.381648] Dynamic subtest pipe-D: SKIP (0.031s) [218.385536] Subtest planes-downscale-factor-0-75: SKIP (0.112s) [218.516150] [031/133] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [218.616838] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [218.620786] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [218.742392] [032/133] (800s left) kms_properties (colorop-properties-legacy) [218.833095] Starting subtest: colorop-properties-legacy [218.835441] Starting dynamic subtest: pipe-A-eDP-1 [219.195492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s) [219.204909] Starting dynamic subtest: pipe-B-eDP-1 [220.275826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.078s) [220.285087] Starting dynamic subtest: pipe-C-eDP-1 [221.362760] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.089s) [221.372582] Starting dynamic subtest: pipe-D-eDP-1 [222.475400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.108s) [222.477687] Subtest colorop-properties-legacy: SUCCESS (3.641s) [223.348652] [033/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [223.463639] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [223.467972] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [223.582556] [034/133] (795s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [223.689910] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [223.692236] Starting dynamic subtest: pipe-A-eDP-1 [223.711958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [223.720505] Starting dynamic subtest: pipe-B-eDP-1 [223.739075] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [223.747077] Starting dynamic subtest: pipe-C-eDP-1 [223.766212] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [223.774572] Starting dynamic subtest: pipe-D-eDP-1 [223.793840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [223.796064] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [225.959178] [035/133] (793s left) gem_wait (wait) [226.046427] Starting subtest: wait [226.048662] Starting dynamic subtest: all-engines [227.925287] Dynamic subtest all-engines: SUCCESS (1.876s) [227.936927] Starting dynamic subtest: rcs0 [228.970188] Dynamic subtest rcs0: SUCCESS (1.044s) [228.980807] Starting dynamic subtest: bcs0 [230.018159] Dynamic subtest bcs0: SUCCESS (1.046s) [230.028286] Starting dynamic subtest: vcs0 [231.062164] Dynamic subtest vcs0: SUCCESS (1.042s) [231.073075] Starting dynamic subtest: vcs1 [232.106660] Dynamic subtest vcs1: SUCCESS (1.042s) [232.117201] Starting dynamic subtest: vecs0 [233.151086] Dynamic subtest vecs0: SUCCESS (1.043s) [233.161350] Starting dynamic subtest: ccs0 [234.198965] Dynamic subtest ccs0: SUCCESS (1.046s) [234.201571] Subtest wait: SUCCESS (8.154s) [234.422515] [036/133] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [234.536123] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [234.540131] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [234.674340] [037/133] (784s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [234.782043] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [235.728568] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.946s) [235.896588] [038/133] (783s left) gem_exec_reloc (basic-concurrent0) [235.948647] Subtest basic-concurrent0: SKIP (0.000s) [236.007478] [039/133] (783s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [236.109639] Starting subtest: yf-tiled-32bpp-rotate-180 [236.113322] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [236.224822] [040/133] (783s left) kms_lease (cursor-implicit-plane) [236.320094] Starting subtest: cursor-implicit-plane [236.321999] Starting dynamic subtest: pipe-A-eDP-1 [236.780257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s) [236.789554] Starting dynamic subtest: pipe-B-eDP-1 [237.927759] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s) [237.936238] Starting dynamic subtest: pipe-C-eDP-1 [239.004280] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.074s) [239.012394] Starting dynamic subtest: pipe-D-eDP-1 [240.099431] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.096s) [240.101777] Subtest cursor-implicit-plane: SUCCESS (3.781s) [240.950062] [041/133] (778s left) gem_exec_schedule (u-semaphore-resolve) [241.043576] Starting subtest: u-semaphore-resolve [241.075488] Subtest u-semaphore-resolve: SUCCESS (0.034s) [241.465421] [042/133] (778s left) gem_exec_whisper (basic-fds-priority) [241.552202] Starting subtest: basic-fds-priority [265.446470] Subtest basic-fds-priority: SUCCESS (23.892s) [265.650509] [043/133] (754s left) i915_query (query-topology-known-pci-ids) [265.711087] Starting subtest: query-topology-known-pci-ids [265.715233] Subtest query-topology-known-pci-ids: SKIP (0.000s) [265.848838] [044/133] (753s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [265.950213] Starting subtest: yf-tiled-64bpp-rotate-90 [265.954496] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [266.088463] [045/133] (753s left) perf_pmu (idle) [266.124851] Starting subtest: idle [266.127406] Starting dynamic subtest: rcs0 [266.667380] Dynamic subtest rcs0: SUCCESS (0.543s) [266.678275] Starting dynamic subtest: bcs0 [267.201784] Dynamic subtest bcs0: SUCCESS (0.531s) [267.213791] Starting dynamic subtest: vcs0 [267.729279] Dynamic subtest vcs0: SUCCESS (0.525s) [267.739253] Starting dynamic subtest: vcs1 [268.258836] Dynamic subtest vcs1: SUCCESS (0.526s) [268.268534] Starting dynamic subtest: vecs0 [268.786970] Dynamic subtest vecs0: SUCCESS (0.520s) [268.797989] Starting dynamic subtest: ccs0 [269.314656] Dynamic subtest ccs0: SUCCESS (0.529s) [269.317545] Subtest idle: SUCCESS (3.192s) [269.441504] [046/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [269.551762] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [269.555876] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [269.681894] [047/133] (750s left) gem_exec_flush (basic-uc-pro-default) [269.751535] Starting subtest: basic-uc-pro-default [275.207682] Subtest basic-uc-pro-default: SUCCESS (5.456s) [275.419833] [048/133] (744s left) gem_basic (bad-close) [275.499303] Starting subtest: bad-close [275.503536] Subtest bad-close: SUCCESS (0.000s) [275.645517] [049/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [275.748656] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [275.752736] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [275.893908] [050/133] (744s left) kms_plane (pixel-format) [275.999873] Starting subtest: pixel-format [276.027861] Starting dynamic subtest: pipe-A-plane-0 [280.805483] Dynamic subtest pipe-A-plane-0: SUCCESS (4.778s) [280.814196] Starting dynamic subtest: pipe-A-plane-3 [283.127826] Dynamic subtest pipe-A-plane-3: SUCCESS (2.322s) [283.136459] Starting dynamic subtest: pipe-A-plane-5 [283.338824] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [284.484314] Starting dynamic subtest: pipe-B-plane-0 [289.377994] Dynamic subtest pipe-B-plane-0: SUCCESS (4.900s) [289.386609] Starting dynamic subtest: pipe-B-plane-3 [291.644184] Dynamic subtest pipe-B-plane-3: SUCCESS (2.264s) [291.655204] Starting dynamic subtest: pipe-B-plane-5 [291.866647] Dynamic subtest pipe-B-plane-5: SUCCESS (0.222s) [292.186076] Subtest pixel-format: SUCCESS (16.188s) [293.045263] [051/133] (726s left) kms_psr (fbc-psr2-no-drrs) [293.150972] Starting subtest: fbc-psr2-no-drrs [293.153354] Starting dynamic subtest: eDP-1 [293.157705] Dynamic subtest eDP-1: SKIP (0.000s) [293.162137] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [293.249871] [052/133] (726s left) gem_mmap (bad-size) [293.311644] Subtest bad-size: SKIP (0.000s) [293.373234] [053/133] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [293.464914] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [293.469222] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [293.601856] [054/133] (726s left) api_intel_bb (crc32) [293.659321] Starting subtest: crc32 [293.661642] Starting dynamic subtest: rcs0-smem0 [293.939260] Dynamic subtest rcs0-smem0: SUCCESS (0.278s) [293.951283] Starting dynamic subtest: bcs0-smem0 [294.307965] Dynamic subtest bcs0-smem0: SUCCESS (0.365s) [294.320594] Starting dynamic subtest: vcs0-smem0 [294.645492] Dynamic subtest vcs0-smem0: SUCCESS (0.335s) [294.658656] Starting dynamic subtest: vcs1-smem0 [294.954361] Dynamic subtest vcs1-smem0: SUCCESS (0.306s) [294.966626] Starting dynamic subtest: vecs0-smem0 [295.318309] Dynamic subtest vecs0-smem0: SUCCESS (0.361s) [295.330454] Starting dynamic subtest: ccs0-smem0 [295.683215] Dynamic subtest ccs0-smem0: SUCCESS (0.362s) [295.686426] Subtest crc32: SUCCESS (2.023s) [295.845373] [055/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [295.947867] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [295.952077] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [296.061665] [056/133] (724s left) kms_psr (psr2-cursor-render) [296.163877] Starting subtest: psr2-cursor-render [296.166316] Starting dynamic subtest: eDP-1 [297.870156] Dynamic subtest eDP-1: SUCCESS (1.705s) [297.872454] Subtest psr2-cursor-render: SUCCESS (1.707s) [298.745380] [057/133] (721s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [298.840641] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [298.852308] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [298.954625] [058/133] (721s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [299.057606] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [299.059708] Starting dynamic subtest: pipe-A-eDP-1 [299.524500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s) [299.534636] Starting dynamic subtest: pipe-B-eDP-1 [300.927918] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s) [300.936298] Starting dynamic subtest: pipe-C-eDP-1 [302.309055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s) [302.318513] Starting dynamic subtest: pipe-D-eDP-1 [303.697711] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s) [303.699982] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.612s) [304.843945] [059/133] (715s left) kms_dp_linktrain_fallback (dp-fallback) [304.947727] Starting subtest: dp-fallback [304.954073] Subtest dp-fallback: SKIP (0.000s) [305.044878] [060/133] (715s left) gem_readwrite (beyond-eob) [305.113767] Subtest beyond-EOB: SKIP (0.000s) [305.175070] [061/133] (715s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [305.280672] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [309.741778] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.464s) [310.962615] [062/133] (709s left) prime_vgem (basic-fence-read) [311.129959] Starting subtest: basic-fence-read [311.137810] Subtest basic-fence-read: SKIP (0.008s) [311.281300] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [311.284480] [063/133] (709s left) perf_pmu (interrupts) [311.335670] Starting subtest: interrupts [312.442049] Subtest interrupts: SUCCESS (1.106s) [312.581631] [064/133] (707s left) i915_pm_rpm (system-suspend-devices) [314.104495] Starting subtest: system-suspend-devices [321.915530] Subtest system-suspend-devices: SUCCESS (7.814s) [322.312247] [065/133] (698s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [322.418084] Starting subtest: flip-vs-dpms-on-nop-interruptible [322.420433] Starting dynamic subtest: A-eDP1 [324.286400] Dynamic subtest A-eDP1: SUCCESS (1.867s) [324.299732] Starting dynamic subtest: B-eDP1 [326.080921] Dynamic subtest B-eDP1: SUCCESS (1.793s) [326.092970] Starting dynamic subtest: C-eDP1 [327.883396] Dynamic subtest C-eDP1: SUCCESS (1.801s) [327.894111] Starting dynamic subtest: D-eDP1 [329.671285] Dynamic subtest D-eDP1: SUCCESS (1.786s) [329.673686] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.256s) [330.951824] [066/133] (689s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [331.048150] Starting subtest: crc-primary-basic-y-tiled-ccs [331.050414] Starting dynamic subtest: pipe-A-eDP-1 [331.073026] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [331.085901] Starting dynamic subtest: pipe-B-eDP-1 [331.107660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [331.117131] Starting dynamic subtest: pipe-C-eDP-1 [331.139050] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [331.149650] Starting dynamic subtest: pipe-D-eDP-1 [331.171791] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [331.176221] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [333.346239] [067/133] (687s left) kms_color (ctm-0-75) [333.444107] Starting subtest: ctm-0-75 [333.445966] Starting dynamic subtest: pipe-A-eDP-1 [338.376445] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.932s) [338.386746] Starting dynamic subtest: pipe-B-eDP-1 [344.003678] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.626s) [344.013098] Starting dynamic subtest: pipe-C-eDP-1 [349.426459] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.423s) [349.437251] Starting dynamic subtest: pipe-D-eDP-1 [354.748630] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.318s) [354.750775] Subtest ctm-0-75: SUCCESS (21.302s) [355.651317] [068/133] (665s left) gem_mmap_offset (partial-mmap) [355.716227] Starting subtest: partial-mmap [355.718217] Starting dynamic subtest: smem0 [355.720603] Dynamic subtest smem0: SUCCESS (0.004s) [355.722853] Subtest partial-mmap: SUCCESS (0.005s) [355.876846] [069/133] (664s left) syncobj_timeline (device-signal-unordered) [355.939609] Starting subtest: device-signal-unordered [355.941781] Subtest device-signal-unordered: SUCCESS (0.000s) [356.055697] [070/133] (664s left) kms_pm_dc (dc6-psr) [357.158876] Starting subtest: dc6-psr [360.142873] Subtest dc6-psr: SUCCESS (2.982s) [360.962663] [071/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [361.096572] Starting subtest: cursorB-vs-flipB-varying-size [361.100961] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [361.272059] [072/133] (659s left) kms_addfb_basic (no-handle) [361.335940] Starting subtest: no-handle [361.338116] Subtest no-handle: SUCCESS (0.000s) [361.504811] [073/133] (659s left) gem_pxp (create-regular-buffer) [361.634251] Starting subtest: create-regular-buffer [361.636655] Subtest create-regular-buffer: SUCCESS (0.000s) [361.779637] [074/133] (659s left) kms_flip (2x-dpms-vs-vblank-race) [361.888287] Starting subtest: 2x-dpms-vs-vblank-race [361.896989] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s) [361.999376] [075/133] (658s left) kms_psr (psr-dpms) [362.100400] Starting subtest: psr-dpms [362.102372] Starting dynamic subtest: eDP-1 [364.994390] Dynamic subtest eDP-1: SUCCESS (2.894s) [364.996632] Subtest psr-dpms: SUCCESS (2.895s) [365.836465] [076/133] (655s left) gem_lmem_swapping (massive-random) [365.883570] Subtest massive-random: SKIP (0.000s) [365.925718] [077/133] (655s left) gen9_exec_parse (bb-secure) [365.990742] Subtest bb-secure: SKIP (0.000s) [366.075805] [078/133] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [366.165801] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [366.169830] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [366.300941] [079/133] (654s left) i915_suspend (fence-restore-untiled) [366.373406] Starting subtest: fence-restore-untiled [366.378065] Subtest fence-restore-untiled: SKIP (0.000s) [366.516091] [080/133] (654s left) syncobj_wait (wait-delayed-signal) [366.570106] Starting subtest: wait-delayed-signal [366.673853] Subtest wait-delayed-signal: SUCCESS (0.103s) [366.774411] [081/133] (654s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [366.869059] Starting subtest: bad-pixel-format-yf-tiled-ccs [366.871398] Starting dynamic subtest: pipe-A-eDP-1 [366.895708] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [366.907997] Starting dynamic subtest: pipe-B-eDP-1 [366.930306] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [366.939631] Starting dynamic subtest: pipe-C-eDP-1 [366.961181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [366.969848] Starting dynamic subtest: pipe-D-eDP-1 [366.991556] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [366.995852] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [369.154890] [082/133] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [369.263730] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [369.268139] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [369.390939] [083/133] (651s left) kms_chamelium_hpd (dp-hpd-fast) [369.776799] Subtest dp-hpd-fast: SKIP (0.000s) [370.603272] [084/133] (650s left) gem_exec_balancer (bonded-false-hang) [370.863385] Starting subtest: bonded-false-hang [370.868629] Subtest bonded-false-hang: SKIP (0.000s) [370.989815] [085/133] (650s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [371.082079] Starting subtest: crc-primary-suspend-yf-tiled-ccs [371.084375] Starting dynamic subtest: pipe-A-eDP-1 [371.093390] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [371.104200] Starting dynamic subtest: pipe-B-eDP-1 [371.113355] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [371.123103] Starting dynamic subtest: pipe-C-eDP-1 [371.131558] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [371.140661] Starting dynamic subtest: pipe-D-eDP-1 [371.149075] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [371.153073] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [373.344679] [086/133] (648s left) gem_exec_fence (syncobj-timeline-invalid-flags) [373.877423] Starting subtest: syncobj-timeline-invalid-flags [373.879829] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [375.026660] [087/133] (646s left) kms_plane_cursor (overlay) [375.144875] Starting subtest: overlay [375.149132] Starting dynamic subtest: pipe-A-eDP-1-size-64 [377.762968] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.618s) [377.823079] Starting dynamic subtest: pipe-A-eDP-1-size-128 [380.341942] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.526s) [380.401781] Starting dynamic subtest: pipe-A-eDP-1-size-256 [382.842994] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.448s) [383.193655] Starting dynamic subtest: pipe-B-eDP-1-size-64 [386.447850] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.268s) [386.509380] Starting dynamic subtest: pipe-B-eDP-1-size-128 [388.948164] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.448s) [389.010357] Starting dynamic subtest: pipe-B-eDP-1-size-256 [391.496725] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.495s) [391.860466] Starting dynamic subtest: pipe-C-eDP-1-size-64 [394.761515] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.911s) [394.799902] Starting dynamic subtest: pipe-C-eDP-1-size-128 [396.961153] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.168s) [396.999599] Starting dynamic subtest: pipe-C-eDP-1-size-256 [399.105421] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.113s) [399.433307] Starting dynamic subtest: pipe-D-eDP-1-size-64 [402.253029] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.831s) [402.292356] Starting dynamic subtest: pipe-D-eDP-1-size-128 [404.420595] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.135s) [404.459602] Starting dynamic subtest: pipe-D-eDP-1-size-256 [406.564027] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.113s) [406.883967] Subtest overlay: SUCCESS (31.739s) [407.741295] [088/133] (613s left) gem_ctx_param (basic-default) [407.792794] Starting subtest: basic-default [407.795118] Subtest basic-default: SUCCESS (0.000s) [407.892093] [089/133] (613s left) api_intel_allocator (two-level-inception-interruptible) [407.947123] Starting subtest: two-level-inception-interruptible [413.349183] Subtest two-level-inception-interruptible: SUCCESS (5.403s) [413.496070] [090/133] (608s left) kms_dsc (dsc-with-bpc-formats) [413.600900] Starting subtest: dsc-with-bpc-formats [413.712523] Subtest dsc-with-bpc-formats: SKIP (0.003s) [413.754851] [091/133] (607s left) kms_cursor_crc (cursor-alpha-opaque) [413.859335] Starting subtest: cursor-alpha-opaque [413.861195] Starting dynamic subtest: pipe-A-eDP-1 [414.500065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s) [414.510681] Starting dynamic subtest: pipe-D-eDP-1 [415.756569] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.254s) [415.758876] Subtest cursor-alpha-opaque: SUCCESS (1.898s) [416.640009] [092/133] (605s left) syncobj_timeline (multi-wait-all-signaled) [416.728415] Starting subtest: multi-wait-all-signaled [416.730607] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [416.879354] [093/133] (604s left) i915_drm_fdinfo (isolation) [416.937553] Starting subtest: isolation [416.939989] Starting dynamic subtest: rcs0 [416.992476] Dynamic subtest rcs0: SKIP (0.051s) [417.004842] Starting dynamic subtest: bcs0 [417.009145] Dynamic subtest bcs0: SKIP (0.001s) [417.018536] Starting dynamic subtest: vcs0 [417.022691] Dynamic subtest vcs0: SKIP (0.000s) [417.031652] Starting dynamic subtest: vcs1 [417.035978] Dynamic subtest vcs1: SKIP (0.000s) [417.044855] Starting dynamic subtest: vecs0 [417.049145] Dynamic subtest vecs0: SKIP (0.000s) [417.057963] Starting dynamic subtest: ccs0 [417.062194] Dynamic subtest ccs0: SKIP (0.000s) [417.066352] Subtest isolation: SKIP (0.060s) [417.102400] [094/133] (604s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [417.202754] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [417.204962] Starting dynamic subtest: pipe-A-default-mode [418.360523] Dynamic subtest pipe-A-default-mode: SKIP (1.154s) [418.364873] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.156s) [418.543940] [095/133] (603s left) gem_ctx_isolation (preservation-s3) [418.612363] Starting subtest: preservation-S3 [418.614700] Starting dynamic subtest: rcs0 [434.835223] Dynamic subtest rcs0: SUCCESS (1.344s) [434.846954] Starting dynamic subtest: bcs0 [450.830022] Dynamic subtest bcs0: SUCCESS (1.321s) [450.840507] Starting dynamic subtest: vcs0 [466.825955] Dynamic subtest vcs0: SUCCESS (2.665s) [466.839787] Starting dynamic subtest: vcs1 [484.831717] Dynamic subtest vcs1: SUCCESS (5.112s) [484.848174] Starting dynamic subtest: vecs0 [502.823379] Dynamic subtest vecs0: SUCCESS (4.994s) [502.834321] Starting dynamic subtest: ccs0 [520.834044] Dynamic subtest ccs0: SUCCESS (3.269s) [520.836417] Subtest preservation-S3: SUCCESS (18.711s) [521.102543] [096/133] (500s left) gem_eio (reset-stress) [521.337161] Starting subtest: reset-stress [521.339530] Starting dynamic subtest: render [526.569751] Dynamic subtest render: SUCCESS (5.267s) [526.587238] Starting dynamic subtest: bsd1 [545.081507] Dynamic subtest bsd1: SUCCESS (18.552s) [545.098924] Starting dynamic subtest: bsd2 [563.181204] Dynamic subtest bsd2: SUCCESS (18.101s) [563.198382] Starting dynamic subtest: blt [563.202762] Dynamic subtest blt: SKIP (0.000s) [563.212614] Starting dynamic subtest: vebox [581.067133] Dynamic subtest vebox: SUCCESS (17.882s) [581.069793] Subtest reset-stress: SUCCESS (59.810s) [582.588220] [097/133] (439s left) gem_softpin (evict-snoop-interruptible) [582.650677] Starting subtest: evict-snoop-interruptible [582.655093] Subtest evict-snoop-interruptible: SKIP (0.000s) [582.803286] [098/133] (439s left) i915_module_load (reload-no-display) [582.842553] Starting subtest: reload-no-display [589.111601] Subtest reload-no-display: SUCCESS (6.270s) [589.140518] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [589.141199] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [589.144276] [099/133] (432s left) kms_flip (2x-flip-vs-modeset) [590.757840] Starting subtest: 2x-flip-vs-modeset [590.769438] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [590.891425] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [590.892743] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [590.897233] [100/133] (431s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [590.999892] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [591.002236] Starting dynamic subtest: pipe-A-default-mode [591.289766] Dynamic subtest pipe-A-default-mode: SKIP (0.289s) [591.294487] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.290s) [592.100351] [101/133] (429s left) kms_content_protection (type1) [592.252958] Starting subtest: type1 [592.257626] Subtest type1: SKIP (0.000s) [592.419232] [102/133] (429s left) kms_big_fb (4-tiled-16bpp-rotate-180) [592.521124] Starting subtest: 4-tiled-16bpp-rotate-180 [593.844101] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.322s) [594.020970] [103/133] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [594.123726] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [594.127214] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [594.261243] [104/133] (427s left) gem_ppgtt (flink-and-close-vma-leak) [594.323446] Starting subtest: flink-and-close-vma-leak [594.362883] Subtest flink-and-close-vma-leak: SUCCESS (0.042s) [594.508498] [105/133] (427s left) syncobj_wait (signal) [594.566034] Starting subtest: signal [594.568008] Subtest signal: SUCCESS (0.000s) [594.707671] [106/133] (427s left) kms_cursor_crc (cursor-rapid-movement-128x128) [594.907674] Starting subtest: cursor-rapid-movement-128x128 [594.911872] Starting dynamic subtest: pipe-A-eDP-1 [595.457412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s) [595.488937] Starting dynamic subtest: pipe-D-eDP-1 [596.688123] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s) [596.690496] Subtest cursor-rapid-movement-128x128: SUCCESS (1.780s) [597.569448] [107/133] (424s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [602.616316] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [602.618597] Starting dynamic subtest: pipe-A-eDP-1 [603.414439] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s) [603.424785] Starting dynamic subtest: pipe-B-eDP-1 [604.535535] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s) [604.539879] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.917s) [605.745044] [108/133] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [605.858224] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [612.321430] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.469s) [612.490544] [109/133] (409s left) kms_vblank (query-forked-busy) [612.587091] Starting subtest: query-forked-busy [612.589010] Starting dynamic subtest: pipe-A-eDP-1 [614.462113] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [614.477697] Starting dynamic subtest: pipe-D-eDP-1 [616.989542] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.526s) [616.991767] Subtest query-forked-busy: SUCCESS (4.403s) [617.819362] [110/133] (404s left) syncobj_timeline (invalid-transfer-non-existent-point) [617.885552] Starting subtest: invalid-transfer-non-existent-point [617.887525] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [618.022998] [111/133] (404s left) kms_big_fb (x-tiled-16bpp-rotate-0) [618.139973] Starting subtest: x-tiled-16bpp-rotate-0 [619.340122] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.200s) [619.511524] [112/133] (402s left) kms_psr (fbc-psr-primary-blt) [619.606379] Starting subtest: fbc-psr-primary-blt [619.608308] Starting dynamic subtest: eDP-1 [619.611879] Dynamic subtest eDP-1: SKIP (0.000s) [619.615391] Subtest fbc-psr-primary-blt: SKIP (0.001s) [619.709353] [113/133] (402s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [619.780500] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [619.891292] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s) [619.993744] [114/133] (402s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [620.098835] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [620.103286] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [620.217654] [115/133] (402s left) gem_exec_reloc (basic-cpu-active) [620.288300] Subtest basic-cpu-active: SKIP (0.000s) [620.366235] [116/133] (402s left) perf (rc6-disable) [620.520432] Starting subtest: rc6-disable [620.695611] Subtest rc6-disable: SUCCESS (0.180s) [620.744497] [117/133] (401s left) gem_ctx_shared (q-independent) [620.815435] Starting subtest: Q-independent [620.817413] Starting dynamic subtest: rcs0 [620.872778] Dynamic subtest rcs0: SUCCESS (0.059s) [620.884893] Starting dynamic subtest: vcs0 [620.910167] Dynamic subtest vcs0: SUCCESS (0.038s) [620.919466] Starting dynamic subtest: vcs1 [620.947507] Dynamic subtest vcs1: SUCCESS (0.036s) [620.957210] Starting dynamic subtest: vecs0 [620.992125] Dynamic subtest vecs0: SUCCESS (0.044s) [621.002755] Starting dynamic subtest: ccs0 [621.032868] Dynamic subtest ccs0: SUCCESS (0.040s) [621.034923] Subtest Q-independent: SUCCESS (0.221s) [622.682036] [118/133] (400s left) perf (non-zero-reason) [622.791321] Starting subtest: non-zero-reason [622.793789] Starting dynamic subtest: 0-rcs0 [628.104875] Dynamic subtest 0-rcs0: SUCCESS (5.309s) [628.117955] Starting dynamic subtest: 1-vcs1 [631.985440] Dynamic subtest 1-vcs1: SUCCESS (3.879s) [631.988354] Subtest non-zero-reason: SUCCESS (9.190s) [632.034005] [119/133] (390s left) kms_psr (pr-dpms) [632.137993] Starting subtest: pr-dpms [632.142469] Subtest pr-dpms: SKIP (0.000s) [632.233700] [120/133] (390s left) kms_rotation_crc (primary-rotation-180) [632.318795] Starting subtest: primary-rotation-180 [639.410471] Subtest primary-rotation-180: SUCCESS (7.090s) [640.602311] [121/133] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [640.705009] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [647.920141] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.217s) [648.093400] [122/133] (374s left) gem_create (create-size-update) [648.164259] Starting subtest: create-size-update [648.166501] Subtest create-size-update: SUCCESS (0.000s) [648.414959] [123/133] (374s left) prime_vgem (basic-fence-blt) [648.502694] Starting subtest: basic-fence-blt [648.591443] Subtest basic-fence-blt: SUCCESS (0.089s) [648.762013] [124/133] (374s left) kms_getfb (getfb2-into-addfb2) [648.866511] Starting subtest: getfb2-into-addfb2 [648.868703] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [649.009419] [125/133] (374s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [649.143682] Starting subtest: verify-pxp-execution-after-suspend-resume [656.180195] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.037s) [656.352896] [126/133] (366s left) syncobj_basic (bad-pad-fd-to-handle) [656.421486] Starting subtest: bad-pad-fd-to-handle [656.423356] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [656.535228] [127/133] (366s left) dmabuf_sync_file (export-before-signal) [656.575875] Starting subtest: export-before-signal [656.578299] Subtest export-before-signal: SUCCESS (0.001s) [656.654930] [128/133] (366s left) kms_flip (2x-flip-vs-panning-vs-hang) [656.750841] Starting subtest: 2x-flip-vs-panning-vs-hang [656.761487] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s) [656.866135] [129/133] (366s left) gem_softpin (allocator-nopin-reserve) [656.921406] Starting subtest: allocator-nopin-reserve [656.996203] Subtest allocator-nopin-reserve: SUCCESS (0.075s) [657.158688] [130/133] (366s left) kms_pipe_crc_basic (read-crc-frame-sequence) [657.248954] Starting subtest: read-crc-frame-sequence [657.250667] Starting dynamic subtest: pipe-A-eDP-1 [657.980938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s) [657.992327] Starting dynamic subtest: pipe-B-eDP-1 [659.396544] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s) [659.408597] Starting dynamic subtest: pipe-C-eDP-1 [660.694092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s) [660.704822] Starting dynamic subtest: pipe-D-eDP-1 [662.016278] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [662.018450] Subtest read-crc-frame-sequence: SUCCESS (4.769s) [662.891743] [131/133] (360s left) kms_frontbuffer_tracking (pipe-fbc-rte) [662.998529] Starting subtest: pipe-fbc-rte [663.005457] Starting dynamic subtest: pipe-B-eDP-1 [668.433739] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.440s) [668.441088] Subtest pipe-fbc-rte: SUCCESS (5.442s) [670.793579] [132/133] (352s left) kms_addfb_basic (too-wide) [670.887208] Starting subtest: too-wide [670.889400] Subtest too-wide: SUCCESS (0.000s) [671.020148] [133/133] (352s left) gem_exec_schedule (pi-shared-iova) [671.208085] Starting subtest: pi-shared-iova [671.210127] Starting dynamic subtest: rcs0 [671.286024] Dynamic subtest rcs0: SUCCESS (0.082s) [671.298930] Starting dynamic subtest: vcs0 [671.337687] Dynamic subtest vcs0: SUCCESS (0.051s) [671.352139] Starting dynamic subtest: vcs1 [671.388348] Dynamic subtest vcs1: SUCCESS (0.049s) [671.400852] Starting dynamic subtest: vecs0 [671.434894] Dynamic subtest vecs0: SUCCESS (0.046s) [671.446390] Starting dynamic subtest: ccs0 [671.485597] Dynamic subtest ccs0: SUCCESS (0.050s) [671.488014] Subtest pi-shared-iova: SUCCESS (0.282s) [672.658206] 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.