[58.256159] Initializing watchdogs [58.256204] /dev/watchdog0 [58.270507] [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.274802] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.277177] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.280601] [001/133] (960s left) syncobj_basic (bad-create-flags) [58.367977] Starting subtest: bad-create-flags [58.370435] Subtest bad-create-flags: SUCCESS (0.000s) [58.507839] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [63.599471] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [63.601888] Starting dynamic subtest: pipe-A-eDP-1 [70.512280] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.911s) [70.521733] Starting dynamic subtest: pipe-B-eDP-1 [77.455179] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.939s) [77.457461] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.855s) [78.340046] [003/133] (940s left) gem_ccs (block-copy-compressed) [78.414100] Starting subtest: block-copy-compressed [78.418406] Subtest block-copy-compressed: SKIP (0.000s) [78.547996] [004/133] (940s left) kms_sequence (get-forked-busy) [78.640067] Starting subtest: get-forked-busy [78.642492] Starting dynamic subtest: pipe-A-eDP-1 [80.581050] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s) [80.590264] Starting dynamic subtest: pipe-B-eDP-1 [83.218526] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.634s) [83.232245] Starting dynamic subtest: pipe-C-eDP-1 [85.824861] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s) [85.833515] Starting dynamic subtest: pipe-D-eDP-1 [88.367638] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s) [88.369980] Subtest get-forked-busy: SUCCESS (9.728s) [89.266015] [005/133] (929s left) sysfs_preempt_timeout (timeout) [89.343998] Starting subtest: timeout [89.346427] Starting dynamic subtest: vecs0 [98.934055] Dynamic subtest vecs0: SUCCESS (9.586s) [98.944795] Starting dynamic subtest: ccs0 [100.350902] Dynamic subtest ccs0: SUCCESS (1.417s) [100.360981] Starting dynamic subtest: vcs0 [109.919982] Dynamic subtest vcs0: SUCCESS (9.570s) [109.930578] Starting dynamic subtest: bcs0 [111.281101] Dynamic subtest bcs0: SUCCESS (1.359s) [111.293266] Starting dynamic subtest: rcs0 [112.743925] Dynamic subtest rcs0: SUCCESS (1.462s) [112.753566] Starting dynamic subtest: vcs1 [121.944450] Dynamic subtest vcs1: SUCCESS (9.198s) [121.947072] Subtest timeout: SUCCESS (32.597s) [122.046170] [006/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [122.153521] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [122.158147] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [122.283280] [007/133] (896s left) gem_ctx_persistence (legacy-engines-queued) [122.345443] Starting subtest: legacy-engines-queued [122.347845] Starting dynamic subtest: render [122.443486] Dynamic subtest render: SUCCESS (0.098s) [122.454590] Starting dynamic subtest: bsd1 [123.891805] Dynamic subtest bsd1: SUCCESS (1.445s) [123.900448] Starting dynamic subtest: bsd2 [125.873357] Dynamic subtest bsd2: SUCCESS (1.980s) [125.880769] Starting dynamic subtest: blt [125.950850] Dynamic subtest blt: SUCCESS (0.077s) [125.964268] Starting dynamic subtest: vebox [127.859240] Dynamic subtest vebox: SUCCESS (1.904s) [127.862459] Subtest legacy-engines-queued: SUCCESS (5.513s) [127.960981] [008/133] (891s left) drm_read (short-buffer-block) [128.140912] Starting subtest: short-buffer-block [128.143343] Subtest short-buffer-block: SUCCESS (0.000s) [128.299013] [009/133] (890s left) gem_render_copy_redux (normal) [128.360762] Starting subtest: normal [128.612629] Subtest normal: SUCCESS (0.251s) [128.775309] [010/133] (890s left) kms_big_fb (y-tiled-32bpp-rotate-90) [128.889238] Starting subtest: y-tiled-32bpp-rotate-90 [128.892906] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [129.028258] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [129.136971] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [136.536292] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.401s) [136.684391] [012/133] (882s left) gem_exec_suspend (basic) [136.752400] Starting subtest: basic [136.754867] Starting dynamic subtest: smem [137.877490] Dynamic subtest smem: SUCCESS (1.123s) [137.880281] Subtest basic: SUCCESS (1.124s) [138.076834] [013/133] (881s left) kms_hdmi_inject (inject-audio) [138.415740] Starting subtest: inject-audio [138.690058] Subtest inject-audio: SUCCESS (0.276s) [139.330186] [014/133] (879s left) kms_cursor_crc (cursor-sliding-32x10) [139.499195] Starting subtest: cursor-sliding-32x10 [139.545288] Subtest cursor-sliding-32x10: SKIP (0.042s) [139.838723] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [139.955274] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [146.421082] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.470s) [146.581861] [016/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [146.686469] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [146.690683] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [146.809294] [017/133] (872s left) gem_render_copy (y-tiled-ccs-to-linear) [146.872533] Starting subtest: y-tiled-ccs-to-linear [146.877045] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [147.078057] [018/133] (872s left) kms_big_fb (4-tiled-16bpp-rotate-90) [147.180070] Starting subtest: 4-tiled-16bpp-rotate-90 [147.200142] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [147.345184] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [147.407094] Starting subtest: transfer-timeline-point [147.409437] Subtest transfer-timeline-point: SUCCESS (0.000s) [147.533147] [020/133] (871s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [147.582884] Starting subtest: invalid-multi-wait-unsubmitted-submitted [147.585170] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [147.700453] [021/133] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [147.792194] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [147.794528] Starting dynamic subtest: pipe-A-eDP-1 [147.820308] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.830623] Starting dynamic subtest: pipe-B-eDP-1 [147.854591] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.862322] Starting dynamic subtest: pipe-C-eDP-1 [147.886246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.893702] Starting dynamic subtest: pipe-D-eDP-1 [147.918086] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.922218] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [150.094551] [022/133] (869s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [152.027683] Starting subtest: dpms-mode-unset-non-lpsp [153.197033] Subtest dpms-mode-unset-non-lpsp: SKIP (1.166s) [153.589745] [023/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [153.689523] Starting subtest: psr-rgb565-draw-mmap-wc [160.345354] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.658s) [160.479546] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [160.872662] Subtest vga-edid-read: SKIP (0.000s) [161.652526] [025/133] (858s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [161.724863] Starting subtest: yf-tiled-to-vebox-y-tiled [161.729611] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [161.928719] [026/133] (857s left) kms_flip (dpms-off-confusion) [162.028272] Starting subtest: dpms-off-confusion [162.030499] Starting dynamic subtest: A-eDP1 [170.775925] Dynamic subtest A-eDP1: SUCCESS (8.743s) [170.788579] Starting dynamic subtest: B-eDP1 [179.454854] Dynamic subtest B-eDP1: SUCCESS (8.682s) [179.462970] Starting dynamic subtest: C-eDP1 [188.130315] Dynamic subtest C-eDP1: SUCCESS (8.674s) [188.138184] Starting dynamic subtest: D-eDP1 [196.830492] Dynamic subtest D-eDP1: SUCCESS (8.697s) [196.832841] Subtest dpms-off-confusion: SUCCESS (34.803s) [198.009599] [027/133] (821s left) gem_exec_big (single) [198.077951] Starting subtest: single [200.440716] Subtest single: SUCCESS (2.363s) [200.693577] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [200.815066] Starting subtest: basic-wb-ro-default [206.274296] Subtest basic-wb-ro-default: SUCCESS (5.461s) [206.483021] [029/133] (813s left) kms_async_flips (async-flip-with-page-flip-events-linear) [206.593846] Starting subtest: async-flip-with-page-flip-events-linear [206.966338] Starting dynamic subtest: pipe-A-eDP-1 [209.724517] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.757s) [210.100520] Starting dynamic subtest: pipe-B-eDP-1 [212.829496] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.735s) [213.187506] Starting dynamic subtest: pipe-C-eDP-1 [215.919488] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.737s) [216.282789] Starting dynamic subtest: pipe-D-eDP-1 [219.013141] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.736s) [219.015810] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.420s) [220.184150] [030/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [220.299264] Starting subtest: planes-downscale-factor-0-75 [220.301532] Starting dynamic subtest: pipe-A [220.322097] Dynamic subtest pipe-A: SKIP (0.019s) [220.331042] Starting dynamic subtest: pipe-B [220.354761] Dynamic subtest pipe-B: SKIP (0.033s) [220.363087] Starting dynamic subtest: pipe-C [220.387582] Dynamic subtest pipe-C: SKIP (0.033s) [220.395690] Starting dynamic subtest: pipe-D [220.421533] Dynamic subtest pipe-D: SKIP (0.033s) [220.425323] Subtest planes-downscale-factor-0-75: SKIP (0.120s) [220.541189] [031/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [220.645304] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [220.649550] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [220.767611] [032/133] (799s left) kms_properties (colorop-properties-legacy) [220.862808] Starting subtest: colorop-properties-legacy [220.864681] Starting dynamic subtest: pipe-A-eDP-1 [221.247528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s) [221.256555] Starting dynamic subtest: pipe-B-eDP-1 [222.313427] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.064s) [222.322179] Starting dynamic subtest: pipe-C-eDP-1 [223.410964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.097s) [223.419238] Starting dynamic subtest: pipe-D-eDP-1 [224.504173] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.093s) [224.506459] Subtest colorop-properties-legacy: SUCCESS (3.643s) [225.401316] [033/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [225.509209] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [225.513088] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [225.657099] [034/133] (794s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [225.750367] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [225.752713] Starting dynamic subtest: pipe-A-eDP-1 [225.772785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [225.783244] Starting dynamic subtest: pipe-B-eDP-1 [225.802453] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [225.812186] Starting dynamic subtest: pipe-C-eDP-1 [225.831147] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [225.839293] Starting dynamic subtest: pipe-D-eDP-1 [225.859256] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [225.861230] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [227.999878] [035/133] (792s left) gem_wait (wait) [228.071159] Starting subtest: wait [228.073531] Starting dynamic subtest: all-engines [229.908456] Dynamic subtest all-engines: SUCCESS (1.835s) [229.920362] Starting dynamic subtest: rcs0 [230.955373] Dynamic subtest rcs0: SUCCESS (1.046s) [230.966084] Starting dynamic subtest: bcs0 [232.003239] Dynamic subtest bcs0: SUCCESS (1.046s) [232.014189] Starting dynamic subtest: vcs0 [233.047299] Dynamic subtest vcs0: SUCCESS (1.042s) [233.057972] Starting dynamic subtest: vcs1 [234.091060] Dynamic subtest vcs1: SUCCESS (1.042s) [234.101528] Starting dynamic subtest: vecs0 [235.135074] Dynamic subtest vecs0: SUCCESS (1.042s) [235.145597] Starting dynamic subtest: ccs0 [236.182222] Dynamic subtest ccs0: SUCCESS (1.045s) [236.184776] Subtest wait: SUCCESS (8.112s) [236.403341] [036/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [236.506548] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [236.510941] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [236.626259] [037/133] (783s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [236.728719] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [237.706193] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.979s) [237.888795] [038/133] (782s left) gem_exec_reloc (basic-concurrent0) [237.960274] Subtest basic-concurrent0: SKIP (0.000s) [238.034806] [039/133] (782s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [238.144933] Starting subtest: yf-tiled-32bpp-rotate-180 [238.148631] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [238.265255] [040/133] (782s left) kms_lease (cursor-implicit-plane) [238.362079] Starting subtest: cursor-implicit-plane [238.363933] Starting dynamic subtest: pipe-A-eDP-1 [238.821826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [238.831175] Starting dynamic subtest: pipe-B-eDP-1 [239.976509] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s) [239.992697] Starting dynamic subtest: pipe-C-eDP-1 [241.067722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.090s) [241.076208] Starting dynamic subtest: pipe-D-eDP-1 [242.139925] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.071s) [242.142237] Subtest cursor-implicit-plane: SUCCESS (3.777s) [242.994257] [041/133] (777s left) gem_exec_schedule (u-semaphore-resolve) [243.075692] Starting subtest: u-semaphore-resolve [243.123292] Subtest u-semaphore-resolve: SUCCESS (0.048s) [243.505538] [042/133] (776s left) gem_exec_whisper (basic-fds-priority) [243.576353] Starting subtest: basic-fds-priority [267.418067] Subtest basic-fds-priority: SUCCESS (23.837s) [267.621705] [043/133] (752s left) i915_query (query-topology-known-pci-ids) [267.690699] Starting subtest: query-topology-known-pci-ids [267.695152] Subtest query-topology-known-pci-ids: SKIP (0.000s) [267.823088] [044/133] (752s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [267.930095] Starting subtest: yf-tiled-64bpp-rotate-90 [267.934506] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [268.064973] [045/133] (752s left) perf_pmu (idle) [268.109324] Starting subtest: idle [268.111636] Starting dynamic subtest: rcs0 [268.689789] Dynamic subtest rcs0: SUCCESS (0.581s) [268.700211] Starting dynamic subtest: bcs0 [269.217105] Dynamic subtest bcs0: SUCCESS (0.525s) [269.228586] Starting dynamic subtest: vcs0 [269.743942] Dynamic subtest vcs0: SUCCESS (0.524s) [269.755216] Starting dynamic subtest: vcs1 [270.279655] Dynamic subtest vcs1: SUCCESS (0.528s) [270.288871] Starting dynamic subtest: vecs0 [270.794574] Dynamic subtest vecs0: SUCCESS (0.516s) [270.804570] Starting dynamic subtest: ccs0 [271.328875] Dynamic subtest ccs0: SUCCESS (0.527s) [271.331489] Subtest idle: SUCCESS (3.218s) [271.467120] [046/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [271.579276] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [271.583417] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [271.708813] [047/133] (748s left) gem_exec_flush (basic-uc-pro-default) [271.766778] Starting subtest: basic-uc-pro-default [277.215568] Subtest basic-uc-pro-default: SUCCESS (5.450s) [277.426190] [048/133] (743s left) gem_basic (bad-close) [277.484081] Starting subtest: bad-close [277.488602] Subtest bad-close: SUCCESS (0.000s) [277.610664] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [277.719272] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [277.723179] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [277.841037] [050/133] (742s left) kms_plane (pixel-format) [277.932807] Starting subtest: pixel-format [277.962777] Starting dynamic subtest: pipe-A-plane-0 [282.817904] Dynamic subtest pipe-A-plane-0: SUCCESS (4.855s) [282.826882] Starting dynamic subtest: pipe-A-plane-3 [285.051775] Dynamic subtest pipe-A-plane-3: SUCCESS (2.233s) [285.063045] Starting dynamic subtest: pipe-A-plane-5 [285.262903] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s) [286.323067] Starting dynamic subtest: pipe-B-plane-0 [291.104154] Dynamic subtest pipe-B-plane-0: SUCCESS (4.789s) [291.113898] Starting dynamic subtest: pipe-B-plane-3 [293.370946] Dynamic subtest pipe-B-plane-3: SUCCESS (2.266s) [293.379779] Starting dynamic subtest: pipe-B-plane-5 [293.582155] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [293.892818] Subtest pixel-format: SUCCESS (15.958s) [294.788738] [051/133] (725s left) kms_psr (fbc-psr2-no-drrs) [294.892094] Starting subtest: fbc-psr2-no-drrs [294.894317] Starting dynamic subtest: eDP-1 [294.898651] Dynamic subtest eDP-1: SKIP (0.000s) [294.902904] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [294.988945] [052/133] (725s left) gem_mmap (bad-size) [295.057578] Subtest bad-size: SKIP (0.000s) [295.124876] [053/133] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [295.224128] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [295.228101] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [295.351863] [054/133] (725s left) api_intel_bb (crc32) [295.409238] Starting subtest: crc32 [295.411409] Starting dynamic subtest: rcs0-smem0 [295.733275] Dynamic subtest rcs0-smem0: SUCCESS (0.324s) [295.745427] Starting dynamic subtest: bcs0-smem0 [296.069474] Dynamic subtest bcs0-smem0: SUCCESS (0.333s) [296.080769] Starting dynamic subtest: vcs0-smem0 [296.399274] Dynamic subtest vcs0-smem0: SUCCESS (0.327s) [296.410788] Starting dynamic subtest: vcs1-smem0 [296.796055] Dynamic subtest vcs1-smem0: SUCCESS (0.393s) [296.806958] Starting dynamic subtest: vecs0-smem0 [297.103043] Dynamic subtest vecs0-smem0: SUCCESS (0.304s) [297.114576] Starting dynamic subtest: ccs0-smem0 [297.445092] Dynamic subtest ccs0-smem0: SUCCESS (0.339s) [297.447846] Subtest crc32: SUCCESS (2.039s) [297.609106] [055/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [297.713980] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [297.718364] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [297.852528] [056/133] (723s left) kms_psr (psr2-cursor-render) [297.946961] Starting subtest: psr2-cursor-render [297.949116] Starting dynamic subtest: eDP-1 [299.602410] Dynamic subtest eDP-1: SUCCESS (1.654s) [299.604286] Subtest psr2-cursor-render: SUCCESS (1.656s) [300.484925] [057/133] (720s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [300.584268] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [300.595687] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [300.696335] [058/133] (720s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [300.798413] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [300.800697] Starting dynamic subtest: pipe-A-eDP-1 [301.320398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s) [301.331357] Starting dynamic subtest: pipe-B-eDP-1 [302.805243] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [302.814367] Starting dynamic subtest: pipe-C-eDP-1 [304.242460] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.436s) [304.253501] Starting dynamic subtest: pipe-D-eDP-1 [305.627086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.384s) [305.629075] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.802s) [306.784786] [059/133] (714s left) kms_dp_linktrain_fallback (dp-fallback) [306.879941] Starting subtest: dp-fallback [306.886118] Subtest dp-fallback: SKIP (0.000s) [306.972472] [060/133] (714s left) gem_readwrite (beyond-eob) [307.031329] Subtest beyond-EOB: SKIP (0.000s) [307.105120] [061/133] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [307.216427] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [311.723994] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.512s) [312.898392] [062/133] (708s left) prime_vgem (basic-fence-read) [313.071557] Starting subtest: basic-fence-read [313.079476] Subtest basic-fence-read: SKIP (0.008s) [313.219692] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [313.223310] [063/133] (707s left) perf_pmu (interrupts) [313.275586] Starting subtest: interrupts [314.378190] Subtest interrupts: SUCCESS (1.108s) [314.526769] [064/133] (706s left) i915_pm_rpm (system-suspend-devices) [316.065849] Starting subtest: system-suspend-devices [323.815240] Subtest system-suspend-devices: SUCCESS (7.752s) [324.212192] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [324.323827] Starting subtest: flip-vs-dpms-on-nop-interruptible [324.326143] Starting dynamic subtest: A-eDP1 [326.139526] Dynamic subtest A-eDP1: SUCCESS (1.814s) [326.151656] Starting dynamic subtest: B-eDP1 [327.938750] Dynamic subtest B-eDP1: SUCCESS (1.798s) [327.950691] Starting dynamic subtest: C-eDP1 [329.732173] Dynamic subtest C-eDP1: SUCCESS (1.792s) [329.744852] Starting dynamic subtest: D-eDP1 [331.615963] Dynamic subtest D-eDP1: SUCCESS (1.880s) [331.621818] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.297s) [332.803125] [066/133] (688s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [332.909347] Starting subtest: crc-primary-basic-y-tiled-ccs [332.912569] Starting dynamic subtest: pipe-A-eDP-1 [332.934660] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [332.945196] Starting dynamic subtest: pipe-B-eDP-1 [332.965777] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [332.975206] Starting dynamic subtest: pipe-C-eDP-1 [332.995809] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [333.005550] Starting dynamic subtest: pipe-D-eDP-1 [333.028192] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [333.032565] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.007s) [335.186497] [067/133] (686s left) kms_color (ctm-0-75) [335.285071] Starting subtest: ctm-0-75 [335.287265] Starting dynamic subtest: pipe-A-eDP-1 [340.225451] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.940s) [340.235132] Starting dynamic subtest: pipe-B-eDP-1 [345.802077] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.575s) [345.812328] Starting dynamic subtest: pipe-C-eDP-1 [351.162427] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.360s) [351.172536] Starting dynamic subtest: pipe-D-eDP-1 [356.469905] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.307s) [356.472323] Subtest ctm-0-75: SUCCESS (21.185s) [357.295507] [068/133] (664s left) gem_mmap_offset (partial-mmap) [357.357634] Starting subtest: partial-mmap [357.360153] Starting dynamic subtest: smem0 [357.362512] Dynamic subtest smem0: SUCCESS (0.003s) [357.364505] Subtest partial-mmap: SUCCESS (0.004s) [357.503867] [069/133] (663s left) syncobj_timeline (device-signal-unordered) [357.565589] Starting subtest: device-signal-unordered [357.567545] Subtest device-signal-unordered: SUCCESS (0.000s) [357.689095] [070/133] (663s left) kms_pm_dc (dc6-psr) [358.793276] Starting subtest: dc6-psr [361.672732] Subtest dc6-psr: SUCCESS (2.879s) [362.496188] [071/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [362.625270] Starting subtest: cursorB-vs-flipB-varying-size [362.629569] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [362.797347] [072/133] (658s left) kms_addfb_basic (no-handle) [362.866309] Starting subtest: no-handle [362.868465] Subtest no-handle: SUCCESS (0.000s) [363.045712] [073/133] (658s left) gem_pxp (create-regular-buffer) [363.181570] Starting subtest: create-regular-buffer [363.183924] Subtest create-regular-buffer: SUCCESS (0.000s) [363.329371] [074/133] (658s left) kms_flip (2x-dpms-vs-vblank-race) [363.415917] Starting subtest: 2x-dpms-vs-vblank-race [363.424162] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [363.528042] [075/133] (658s left) kms_psr (psr-dpms) [363.612616] Starting subtest: psr-dpms [363.614517] Starting dynamic subtest: eDP-1 [366.539068] Dynamic subtest eDP-1: SUCCESS (2.924s) [366.541331] Subtest psr-dpms: SUCCESS (2.927s) [367.387308] [076/133] (654s left) gem_lmem_swapping (massive-random) [367.433022] Subtest massive-random: SKIP (0.000s) [367.483178] [077/133] (654s left) gen9_exec_parse (bb-secure) [367.557348] Subtest bb-secure: SKIP (0.000s) [367.658403] [078/133] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [367.765778] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [367.770195] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [367.902367] [079/133] (653s left) i915_suspend (fence-restore-untiled) [367.963793] Starting subtest: fence-restore-untiled [367.968162] Subtest fence-restore-untiled: SKIP (0.000s) [368.106476] [080/133] (653s left) syncobj_wait (wait-delayed-signal) [368.173840] Starting subtest: wait-delayed-signal [368.276250] Subtest wait-delayed-signal: SUCCESS (0.103s) [368.380864] [081/133] (653s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [368.486341] Starting subtest: bad-pixel-format-yf-tiled-ccs [368.488690] Starting dynamic subtest: pipe-A-eDP-1 [368.512456] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [368.524851] Starting dynamic subtest: pipe-B-eDP-1 [368.546185] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [368.557078] Starting dynamic subtest: pipe-C-eDP-1 [368.577802] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [368.586737] Starting dynamic subtest: pipe-D-eDP-1 [368.608694] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [368.613195] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [370.787202] [082/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [370.888201] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [370.892128] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [371.030482] [083/133] (650s left) kms_chamelium_hpd (dp-hpd-fast) [371.423047] Subtest dp-hpd-fast: SKIP (0.000s) [372.238764] [084/133] (649s left) gem_exec_balancer (bonded-false-hang) [372.501931] Starting subtest: bonded-false-hang [372.506840] Subtest bonded-false-hang: SKIP (0.000s) [372.651765] [085/133] (649s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [372.748234] Starting subtest: crc-primary-suspend-yf-tiled-ccs [372.750422] Starting dynamic subtest: pipe-A-eDP-1 [372.759154] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [372.773584] Starting dynamic subtest: pipe-B-eDP-1 [372.782284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [372.793217] Starting dynamic subtest: pipe-C-eDP-1 [372.801171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [372.810656] Starting dynamic subtest: pipe-D-eDP-1 [372.818784] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [372.822676] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [374.979991] [086/133] (647s left) gem_exec_fence (syncobj-timeline-invalid-flags) [375.515296] Starting subtest: syncobj-timeline-invalid-flags [375.517760] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [377.043543] [087/133] (645s left) kms_plane_cursor (overlay) [377.142794] Starting subtest: overlay [377.146852] Starting dynamic subtest: pipe-A-eDP-1-size-64 [379.753250] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.611s) [379.813868] Starting dynamic subtest: pipe-A-eDP-1-size-128 [382.364293] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.559s) [382.425090] Starting dynamic subtest: pipe-A-eDP-1-size-256 [384.932975] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.515s) [385.295743] Starting dynamic subtest: pipe-B-eDP-1-size-64 [388.597476] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.311s) [388.658020] Starting dynamic subtest: pipe-B-eDP-1-size-128 [391.254038] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.606s) [391.314460] Starting dynamic subtest: pipe-B-eDP-1-size-256 [393.899603] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.593s) [394.272082] Starting dynamic subtest: pipe-C-eDP-1-size-64 [397.170230] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.913s) [397.209015] Starting dynamic subtest: pipe-C-eDP-1-size-128 [399.404433] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s) [399.443197] Starting dynamic subtest: pipe-C-eDP-1-size-256 [401.604513] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s) [401.949705] Starting dynamic subtest: pipe-D-eDP-1-size-64 [404.858513] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.920s) [404.895921] Starting dynamic subtest: pipe-D-eDP-1-size-128 [407.080360] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s) [407.119638] Starting dynamic subtest: pipe-D-eDP-1-size-256 [409.325167] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s) [409.642780] Subtest overlay: SUCCESS (32.499s) [410.485385] [088/133] (611s left) gem_ctx_param (basic-default) [410.533812] Starting subtest: basic-default [410.536123] Subtest basic-default: SUCCESS (0.000s) [410.634104] [089/133] (611s left) api_intel_allocator (two-level-inception-interruptible) [410.696128] Starting subtest: two-level-inception-interruptible [416.105298] Subtest two-level-inception-interruptible: SUCCESS (5.411s) [416.262584] [090/133] (606s left) kms_dsc (dsc-with-bpc-formats) [416.361660] Starting subtest: dsc-with-bpc-formats [416.477922] Subtest dsc-with-bpc-formats: SKIP (0.003s) [416.524954] [091/133] (605s left) kms_cursor_crc (cursor-alpha-opaque) [416.624363] Starting subtest: cursor-alpha-opaque [416.626482] Starting dynamic subtest: pipe-A-eDP-1 [417.245539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s) [417.255835] Starting dynamic subtest: pipe-D-eDP-1 [418.489387] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s) [418.491689] Subtest cursor-alpha-opaque: SUCCESS (1.867s) [419.374557] [092/133] (603s left) syncobj_timeline (multi-wait-all-signaled) [419.444244] Starting subtest: multi-wait-all-signaled [419.446665] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [419.579981] [093/133] (602s left) i915_drm_fdinfo (isolation) [419.620635] Starting subtest: isolation [419.622680] Starting dynamic subtest: rcs0 [419.656811] Dynamic subtest rcs0: SKIP (0.035s) [419.669107] Starting dynamic subtest: bcs0 [419.672953] Dynamic subtest bcs0: SKIP (0.000s) [419.682854] Starting dynamic subtest: vcs0 [419.687180] Dynamic subtest vcs0: SKIP (0.000s) [419.696633] Starting dynamic subtest: vcs1 [419.700642] Dynamic subtest vcs1: SKIP (0.000s) [419.710829] Starting dynamic subtest: vecs0 [419.714968] Dynamic subtest vecs0: SKIP (0.000s) [419.724780] Starting dynamic subtest: ccs0 [419.728956] Dynamic subtest ccs0: SKIP (0.000s) [419.733119] Subtest isolation: SKIP (0.041s) [419.770838] [094/133] (602s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [419.877395] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [419.879636] Starting dynamic subtest: pipe-A-default-mode [420.996406] Dynamic subtest pipe-A-default-mode: SKIP (1.117s) [421.000913] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.119s) [421.183453] [095/133] (601s left) gem_ctx_isolation (preservation-s3) [421.242939] Starting subtest: preservation-S3 [421.245434] Starting dynamic subtest: rcs0 [437.917605] Dynamic subtest rcs0: SUCCESS (1.380s) [437.928926] Starting dynamic subtest: bcs0 [453.886843] Dynamic subtest bcs0: SUCCESS (1.326s) [453.898116] Starting dynamic subtest: vcs0 [469.876317] Dynamic subtest vcs0: SUCCESS (3.031s) [469.887406] Starting dynamic subtest: vcs1 [487.901237] Dynamic subtest vcs1: SUCCESS (4.965s) [487.912534] Starting dynamic subtest: vecs0 [505.888256] Dynamic subtest vecs0: SUCCESS (5.037s) [505.900900] Starting dynamic subtest: ccs0 [523.865260] Dynamic subtest ccs0: SUCCESS (3.131s) [523.867536] Subtest preservation-S3: SUCCESS (18.876s) [524.137143] [096/133] (498s left) gem_eio (reset-stress) [524.381599] Starting subtest: reset-stress [524.384011] Starting dynamic subtest: render [529.841562] Dynamic subtest render: SUCCESS (5.445s) [529.858256] Starting dynamic subtest: bsd1 [548.174845] Dynamic subtest bsd1: SUCCESS (18.316s) [548.192416] Starting dynamic subtest: bsd2 [566.191556] Dynamic subtest bsd2: SUCCESS (18.007s) [566.208357] Starting dynamic subtest: blt [566.212651] Dynamic subtest blt: SKIP (0.000s) [566.222092] Starting dynamic subtest: vebox [584.167053] Dynamic subtest vebox: SUCCESS (17.964s) [584.169552] Subtest reset-stress: SUCCESS (59.736s) [585.681478] [097/133] (436s left) gem_softpin (evict-snoop-interruptible) [585.764478] Starting subtest: evict-snoop-interruptible [585.769006] Subtest evict-snoop-interruptible: SKIP (0.000s) [585.925499] [098/133] (436s left) i915_module_load (reload-no-display) [585.972488] Starting subtest: reload-no-display [592.274243] Subtest reload-no-display: SUCCESS (6.300s) [592.306453] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [592.307197] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [592.310395] [099/133] (430s left) kms_flip (2x-flip-vs-modeset) [593.972186] Starting subtest: 2x-flip-vs-modeset [593.985262] Subtest 2x-flip-vs-modeset: SKIP (0.012s) [594.087348] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [594.088622] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [594.092263] [100/133] (428s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [594.195333] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [594.197671] Starting dynamic subtest: pipe-A-default-mode [594.487683] Dynamic subtest pipe-A-default-mode: SKIP (0.290s) [594.492326] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.291s) [595.388621] [101/133] (427s left) kms_content_protection (type1) [595.554111] Starting subtest: type1 [595.558134] Subtest type1: SKIP (0.000s) [595.717019] [102/133] (427s left) kms_big_fb (4-tiled-16bpp-rotate-180) [595.834641] Starting subtest: 4-tiled-16bpp-rotate-180 [597.120378] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.285s) [597.273286] [103/133] (425s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [597.377027] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [597.380387] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [597.492573] [104/133] (425s left) gem_ppgtt (flink-and-close-vma-leak) [597.551650] Starting subtest: flink-and-close-vma-leak [597.592515] Subtest flink-and-close-vma-leak: SUCCESS (0.043s) [597.762530] [105/133] (425s left) syncobj_wait (signal) [597.816669] Starting subtest: signal [597.818800] Subtest signal: SUCCESS (0.000s) [597.939938] [106/133] (425s left) kms_cursor_crc (cursor-rapid-movement-128x128) [598.145171] Starting subtest: cursor-rapid-movement-128x128 [598.147217] Starting dynamic subtest: pipe-A-eDP-1 [598.708121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s) [598.742365] Starting dynamic subtest: pipe-D-eDP-1 [599.884877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.148s) [599.887181] Subtest cursor-rapid-movement-128x128: SUCCESS (1.740s) [600.762458] [107/133] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [605.821151] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [605.823552] Starting dynamic subtest: pipe-A-eDP-1 [606.610885] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s) [606.620735] Starting dynamic subtest: pipe-B-eDP-1 [607.738779] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s) [607.743107] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.915s) [608.954324] [108/133] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [609.063394] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [615.732123] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.667s) [615.887302] [109/133] (407s left) kms_vblank (query-forked-busy) [615.987844] Starting subtest: query-forked-busy [615.990078] Starting dynamic subtest: pipe-A-eDP-1 [617.876918] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s) [617.897203] Starting dynamic subtest: pipe-D-eDP-1 [620.429670] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [620.431989] Subtest query-forked-busy: SUCCESS (4.440s) [621.248907] [110/133] (401s left) syncobj_timeline (invalid-transfer-non-existent-point) [621.299875] Starting subtest: invalid-transfer-non-existent-point [621.302159] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [621.419131] [111/133] (401s left) kms_big_fb (x-tiled-16bpp-rotate-0) [621.516814] Starting subtest: x-tiled-16bpp-rotate-0 [622.848689] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.334s) [622.993445] [112/133] (400s left) kms_psr (fbc-psr-primary-blt) [623.099347] Starting subtest: fbc-psr-primary-blt [623.101206] Starting dynamic subtest: eDP-1 [623.104577] Dynamic subtest eDP-1: SKIP (0.000s) [623.107905] Subtest fbc-psr-primary-blt: SKIP (0.001s) [623.198507] [113/133] (400s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [623.262078] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [623.371334] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s) [623.472289] [114/133] (399s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [623.577156] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [623.581255] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [623.692096] [115/133] (399s left) gem_exec_reloc (basic-cpu-active) [623.763247] Subtest basic-cpu-active: SKIP (0.000s) [623.856392] [116/133] (399s left) perf (rc6-disable) [624.001527] Starting subtest: rc6-disable [624.180681] Subtest rc6-disable: SUCCESS (0.179s) [624.233529] [117/133] (399s left) gem_ctx_shared (q-independent) [624.300802] Starting subtest: Q-independent [624.303127] Starting dynamic subtest: rcs0 [624.367767] Dynamic subtest rcs0: SUCCESS (0.066s) [624.380299] Starting dynamic subtest: vcs0 [624.407644] Dynamic subtest vcs0: SUCCESS (0.040s) [624.417609] Starting dynamic subtest: vcs1 [624.444100] Dynamic subtest vcs1: SUCCESS (0.036s) [624.454031] Starting dynamic subtest: vecs0 [624.477895] Dynamic subtest vecs0: SUCCESS (0.033s) [624.487776] Starting dynamic subtest: ccs0 [624.519675] Dynamic subtest ccs0: SUCCESS (0.041s) [624.521710] Subtest Q-independent: SUCCESS (0.220s) [625.736343] [118/133] (397s left) perf (non-zero-reason) [625.841179] Starting subtest: non-zero-reason [625.843695] Starting dynamic subtest: 0-rcs0 [631.233557] Dynamic subtest 0-rcs0: SUCCESS (5.393s) [631.245741] Starting dynamic subtest: 1-vecs0 [635.136948] Dynamic subtest 1-vecs0: SUCCESS (3.904s) [635.139634] Subtest non-zero-reason: SUCCESS (9.299s) [635.176397] [119/133] (388s left) kms_psr (pr-dpms) [635.280151] Starting subtest: pr-dpms [635.284624] Subtest pr-dpms: SKIP (0.000s) [635.378522] [120/133] (388s left) kms_rotation_crc (primary-rotation-180) [635.479149] Starting subtest: primary-rotation-180 [642.431898] Subtest primary-rotation-180: SUCCESS (6.957s) [643.674573] [121/133] (379s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [643.768007] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [651.117262] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.353s) [651.290704] [122/133] (372s left) gem_create (create-size-update) [651.354378] Starting subtest: create-size-update [651.356671] Subtest create-size-update: SUCCESS (0.000s) [651.598902] [123/133] (372s left) prime_vgem (basic-fence-blt) [651.692566] Starting subtest: basic-fence-blt [651.780706] Subtest basic-fence-blt: SUCCESS (0.088s) [651.942855] [124/133] (371s left) kms_getfb (getfb2-into-addfb2) [652.051915] Starting subtest: getfb2-into-addfb2 [652.054264] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [652.188543] [125/133] (371s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [652.330458] Starting subtest: verify-pxp-execution-after-suspend-resume [659.385516] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.057s) [659.568903] [126/133] (364s left) syncobj_basic (bad-pad-fd-to-handle) [659.633769] Starting subtest: bad-pad-fd-to-handle [659.636085] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [659.780642] [127/133] (364s left) dmabuf_sync_file (export-before-signal) [659.825689] Starting subtest: export-before-signal [659.828019] Subtest export-before-signal: SUCCESS (0.001s) [659.904282] [128/133] (364s left) kms_flip (2x-flip-vs-panning-vs-hang) [660.010160] Starting subtest: 2x-flip-vs-panning-vs-hang [660.022899] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.014s) [660.131272] [129/133] (363s left) gem_softpin (allocator-nopin-reserve) [660.202146] Starting subtest: allocator-nopin-reserve [660.305257] Subtest allocator-nopin-reserve: SUCCESS (0.104s) [660.476797] [130/133] (363s left) kms_pipe_crc_basic (read-crc-frame-sequence) [660.570801] Starting subtest: read-crc-frame-sequence [660.573110] Starting dynamic subtest: pipe-A-eDP-1 [661.271067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s) [661.282848] Starting dynamic subtest: pipe-B-eDP-1 [662.622673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s) [662.632939] Starting dynamic subtest: pipe-C-eDP-1 [663.934248] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.309s) [663.944273] Starting dynamic subtest: pipe-D-eDP-1 [665.253028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [665.255393] Subtest read-crc-frame-sequence: SUCCESS (4.684s) [666.112456] [131/133] (357s left) kms_frontbuffer_tracking (pipe-fbc-rte) [666.211401] Starting subtest: pipe-fbc-rte [666.217956] Starting dynamic subtest: pipe-B-eDP-1 [671.699483] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.491s) [671.707422] Subtest pipe-fbc-rte: SUCCESS (5.493s) [674.062077] [132/133] (350s left) kms_addfb_basic (too-wide) [674.166738] Starting subtest: too-wide [674.168582] Subtest too-wide: SUCCESS (0.000s) [674.304294] [133/133] (349s left) gem_exec_schedule (pi-shared-iova) [674.483221] Starting subtest: pi-shared-iova [674.485625] Starting dynamic subtest: rcs0 [674.560167] Dynamic subtest rcs0: SUCCESS (0.078s) [674.573632] Starting dynamic subtest: vcs0 [674.610654] Dynamic subtest vcs0: SUCCESS (0.051s) [674.624308] Starting dynamic subtest: vcs1 [674.663608] Dynamic subtest vcs1: SUCCESS (0.052s) [674.676528] Starting dynamic subtest: vecs0 [674.714202] Dynamic subtest vecs0: SUCCESS (0.050s) [674.730903] Starting dynamic subtest: ccs0 [674.768411] Dynamic subtest ccs0: SUCCESS (0.054s) [674.770714] Subtest pi-shared-iova: SUCCESS (0.288s) [676.762617] 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.