[58.184718] Initializing watchdogs [58.184764] /dev/watchdog0 [58.198345] [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.202320] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.204633] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.207933] [001/133] (960s left) syncobj_basic (bad-create-flags) [58.286910] Starting subtest: bad-create-flags [58.289063] Subtest bad-create-flags: SUCCESS (0.000s) [58.407621] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [63.436935] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [63.439037] Starting dynamic subtest: pipe-A-eDP-1 [70.147474] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.698s) [70.156374] Starting dynamic subtest: pipe-B-eDP-1 [77.035771] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.882s) [77.038196] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.585s) [77.905271] [003/133] (940s left) gem_ccs (block-copy-compressed) [77.979881] Starting subtest: block-copy-compressed [77.984387] Subtest block-copy-compressed: SKIP (0.000s) [78.126183] [004/133] (940s left) kms_sequence (get-forked-busy) [78.228380] Starting subtest: get-forked-busy [78.230799] Starting dynamic subtest: pipe-A-eDP-1 [80.178635] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s) [80.187828] Starting dynamic subtest: pipe-B-eDP-1 [82.821660] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.639s) [82.830663] Starting dynamic subtest: pipe-C-eDP-1 [85.410058] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.587s) [85.418888] Starting dynamic subtest: pipe-D-eDP-1 [87.959993] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s) [87.962248] Subtest get-forked-busy: SUCCESS (9.726s) [88.854962] [005/133] (930s left) sysfs_preempt_timeout (timeout) [88.914667] Starting subtest: timeout [88.916956] Starting dynamic subtest: vecs0 [98.914985] Dynamic subtest vecs0: SUCCESS (9.994s) [98.925057] Starting dynamic subtest: ccs0 [100.229975] Dynamic subtest ccs0: SUCCESS (1.314s) [100.239339] Starting dynamic subtest: vcs0 [109.919757] Dynamic subtest vcs0: SUCCESS (9.685s) [109.929605] Starting dynamic subtest: bcs0 [111.238508] Dynamic subtest bcs0: SUCCESS (1.318s) [111.248560] Starting dynamic subtest: rcs0 [112.622669] Dynamic subtest rcs0: SUCCESS (1.383s) [112.632510] Starting dynamic subtest: vcs1 [121.960266] Dynamic subtest vcs1: SUCCESS (9.334s) [121.962726] Subtest timeout: SUCCESS (33.035s) [122.052616] [006/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [122.176109] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [122.180330] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [122.290521] [007/133] (896s left) gem_ctx_persistence (legacy-engines-queued) [122.356936] Starting subtest: legacy-engines-queued [122.359639] Starting dynamic subtest: render [122.468347] Dynamic subtest render: SUCCESS (0.113s) [122.478886] Starting dynamic subtest: bsd1 [123.893480] Dynamic subtest bsd1: SUCCESS (1.422s) [123.903962] Starting dynamic subtest: bsd2 [125.876360] Dynamic subtest bsd2: SUCCESS (1.980s) [125.886796] Starting dynamic subtest: blt [125.938637] Dynamic subtest blt: SUCCESS (0.062s) [125.948910] Starting dynamic subtest: vebox [127.860627] Dynamic subtest vebox: SUCCESS (1.918s) [127.863770] Subtest legacy-engines-queued: SUCCESS (5.504s) [127.959653] [008/133] (890s left) drm_read (short-buffer-block) [128.140726] Starting subtest: short-buffer-block [128.143115] Subtest short-buffer-block: SUCCESS (0.000s) [128.309235] [009/133] (890s left) gem_render_copy_redux (normal) [128.366198] Starting subtest: normal [128.619683] Subtest normal: SUCCESS (0.254s) [128.788392] [010/133] (890s left) kms_big_fb (y-tiled-32bpp-rotate-90) [128.898986] Starting subtest: y-tiled-32bpp-rotate-90 [128.903056] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [129.007725] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [129.097608] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [136.520120] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.424s) [136.656114] [012/133] (882s left) gem_exec_suspend (basic) [136.728171] Starting subtest: basic [136.730563] Starting dynamic subtest: smem [137.942378] Dynamic subtest smem: SUCCESS (1.211s) [137.945342] Subtest basic: SUCCESS (1.213s) [138.144242] [013/133] (881s left) kms_hdmi_inject (inject-audio) [138.493733] Starting subtest: inject-audio [138.768307] Subtest inject-audio: SUCCESS (0.275s) [139.351059] [014/133] (879s left) kms_cursor_crc (cursor-sliding-32x10) [139.520908] Starting subtest: cursor-sliding-32x10 [139.565139] Subtest cursor-sliding-32x10: SKIP (0.040s) [139.850063] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [139.957405] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [146.396922] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.442s) [146.536912] [016/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [146.637283] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [146.641314] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [146.751719] [017/133] (872s left) gem_render_copy (y-tiled-ccs-to-linear) [146.818031] Starting subtest: y-tiled-ccs-to-linear [146.822835] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [147.040021] [018/133] (872s left) kms_big_fb (4-tiled-16bpp-rotate-90) [147.139804] Starting subtest: 4-tiled-16bpp-rotate-90 [147.160077] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [147.315150] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [147.373351] Starting subtest: transfer-timeline-point [147.375806] Subtest transfer-timeline-point: SUCCESS (0.000s) [147.511166] [020/133] (871s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [147.582713] Starting subtest: invalid-multi-wait-unsubmitted-submitted [147.584941] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [147.716962] [021/133] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [147.821425] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [147.823737] Starting dynamic subtest: pipe-A-eDP-1 [147.849301] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.858816] Starting dynamic subtest: pipe-B-eDP-1 [147.882858] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.890495] Starting dynamic subtest: pipe-C-eDP-1 [147.914245] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.922131] Starting dynamic subtest: pipe-D-eDP-1 [147.944877] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.948891] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [150.105158] [022/133] (869s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [152.038805] Starting subtest: dpms-mode-unset-non-lpsp [153.202631] Subtest dpms-mode-unset-non-lpsp: SKIP (1.165s) [153.588910] [023/133] (865s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [153.686191] Starting subtest: psr-rgb565-draw-mmap-wc [160.365194] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.683s) [160.489437] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [160.872368] Subtest vga-edid-read: SKIP (0.000s) [161.656386] [025/133] (857s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [161.711258] Starting subtest: yf-tiled-to-vebox-y-tiled [161.715440] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [161.911077] [026/133] (857s left) kms_flip (dpms-off-confusion) [162.009264] Starting subtest: dpms-off-confusion [162.011596] Starting dynamic subtest: A-eDP1 [170.664935] Dynamic subtest A-eDP1: SUCCESS (8.657s) [170.673134] Starting dynamic subtest: B-eDP1 [179.359078] Dynamic subtest B-eDP1: SUCCESS (8.693s) [179.368852] Starting dynamic subtest: C-eDP1 [188.049555] Dynamic subtest C-eDP1: SUCCESS (8.689s) [188.060684] Starting dynamic subtest: D-eDP1 [196.660681] Dynamic subtest D-eDP1: SUCCESS (8.609s) [196.663101] Subtest dpms-off-confusion: SUCCESS (34.656s) [197.907099] [027/133] (821s left) gem_exec_big (single) [197.959224] Starting subtest: single [200.297417] Subtest single: SUCCESS (2.338s) [200.522703] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [200.627605] Starting subtest: basic-wb-ro-default [206.085786] Subtest basic-wb-ro-default: SUCCESS (5.458s) [206.296073] [029/133] (813s left) kms_async_flips (async-flip-with-page-flip-events-linear) [206.418089] Starting subtest: async-flip-with-page-flip-events-linear [206.789806] Starting dynamic subtest: pipe-A-eDP-1 [209.520439] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.730s) [209.892812] Starting dynamic subtest: pipe-B-eDP-1 [212.625810] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.737s) [212.987888] Starting dynamic subtest: pipe-C-eDP-1 [215.727070] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.744s) [216.084678] Starting dynamic subtest: pipe-D-eDP-1 [218.827929] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.749s) [218.830840] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.411s) [219.997772] [030/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [220.097348] Starting subtest: planes-downscale-factor-0-75 [220.099602] Starting dynamic subtest: pipe-A [220.118983] Dynamic subtest pipe-A: SKIP (0.018s) [220.126795] Starting dynamic subtest: pipe-B [220.148771] Dynamic subtest pipe-B: SKIP (0.030s) [220.156360] Starting dynamic subtest: pipe-C [220.181655] Dynamic subtest pipe-C: SKIP (0.031s) [220.189170] Starting dynamic subtest: pipe-D [220.213016] Dynamic subtest pipe-D: SKIP (0.031s) [220.217149] Subtest planes-downscale-factor-0-75: SKIP (0.111s) [220.349715] [031/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [220.452120] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [220.456039] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [220.582498] [032/133] (799s left) kms_properties (colorop-properties-legacy) [220.681227] Starting subtest: colorop-properties-legacy [220.683558] Starting dynamic subtest: pipe-A-eDP-1 [221.044023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s) [221.052943] Starting dynamic subtest: pipe-B-eDP-1 [222.118249] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.072s) [222.131047] Starting dynamic subtest: pipe-C-eDP-1 [223.204391] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.086s) [223.213894] Starting dynamic subtest: pipe-D-eDP-1 [224.301017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.094s) [224.303203] Subtest colorop-properties-legacy: SUCCESS (3.618s) [225.211546] [033/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [225.319600] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [225.324087] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [225.451621] [034/133] (794s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [225.550664] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [225.552894] Starting dynamic subtest: pipe-A-eDP-1 [225.573710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [225.583812] Starting dynamic subtest: pipe-B-eDP-1 [225.603093] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [225.612976] Starting dynamic subtest: pipe-C-eDP-1 [225.632230] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [225.640158] Starting dynamic subtest: pipe-D-eDP-1 [225.659097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [225.660965] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [227.802805] [035/133] (792s left) gem_wait (wait) [227.884462] Starting subtest: wait [227.886888] Starting dynamic subtest: all-engines [229.909520] Dynamic subtest all-engines: SUCCESS (2.023s) [229.921254] Starting dynamic subtest: rcs0 [230.955493] Dynamic subtest rcs0: SUCCESS (1.045s) [230.966454] Starting dynamic subtest: bcs0 [232.001321] Dynamic subtest bcs0: SUCCESS (1.044s) [232.012675] Starting dynamic subtest: vcs0 [233.044073] Dynamic subtest vcs0: SUCCESS (1.041s) [233.054988] Starting dynamic subtest: vcs1 [234.088062] Dynamic subtest vcs1: SUCCESS (1.042s) [234.098689] Starting dynamic subtest: vecs0 [235.132379] Dynamic subtest vecs0: SUCCESS (1.042s) [235.143752] Starting dynamic subtest: ccs0 [236.180683] Dynamic subtest ccs0: SUCCESS (1.046s) [236.183181] Subtest wait: SUCCESS (8.297s) [236.401788] [036/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [236.510635] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [236.514693] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [236.665762] [037/133] (783s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [236.773812] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [238.096522] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.743s) [238.130952] [038/133] (782s left) gem_exec_reloc (basic-concurrent0) [238.205091] Subtest basic-concurrent0: SKIP (0.000s) [238.283273] [039/133] (781s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [238.390598] Starting subtest: yf-tiled-32bpp-rotate-180 [238.394217] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [238.514881] [040/133] (781s left) kms_lease (cursor-implicit-plane) [238.609900] Starting subtest: cursor-implicit-plane [238.611739] Starting dynamic subtest: pipe-A-eDP-1 [239.070491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [239.078571] Starting dynamic subtest: pipe-B-eDP-1 [240.161995] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s) [240.173478] Starting dynamic subtest: pipe-C-eDP-1 [241.259101] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.095s) [241.268752] Starting dynamic subtest: pipe-D-eDP-1 [242.356276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s) [242.358766] Subtest cursor-implicit-plane: SUCCESS (3.746s) [243.203195] [041/133] (777s left) gem_exec_schedule (u-semaphore-resolve) [243.292402] Starting subtest: u-semaphore-resolve [243.319112] Subtest u-semaphore-resolve: SUCCESS (0.037s) [243.693589] [042/133] (776s left) gem_exec_whisper (basic-fds-priority) [243.757599] Starting subtest: basic-fds-priority [267.348904] Subtest basic-fds-priority: SUCCESS (23.586s) [267.564417] [043/133] (752s left) i915_query (query-topology-known-pci-ids) [267.633088] Starting subtest: query-topology-known-pci-ids [267.637759] Subtest query-topology-known-pci-ids: SKIP (0.000s) [267.776949] [044/133] (752s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [267.877434] Starting subtest: yf-tiled-64bpp-rotate-90 [267.881614] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [267.998899] [045/133] (752s left) perf_pmu (idle) [268.039077] Starting subtest: idle [268.041355] Starting dynamic subtest: rcs0 [268.589917] Dynamic subtest rcs0: SUCCESS (0.550s) [268.601474] Starting dynamic subtest: bcs0 [269.120238] Dynamic subtest bcs0: SUCCESS (0.527s) [269.131433] Starting dynamic subtest: vcs0 [269.652659] Dynamic subtest vcs0: SUCCESS (0.526s) [269.663235] Starting dynamic subtest: vcs1 [270.170703] Dynamic subtest vcs1: SUCCESS (0.520s) [270.182089] Starting dynamic subtest: vecs0 [270.698596] Dynamic subtest vecs0: SUCCESS (0.525s) [270.710811] Starting dynamic subtest: ccs0 [271.220078] Dynamic subtest ccs0: SUCCESS (0.520s) [271.222984] Subtest idle: SUCCESS (3.183s) [271.339222] [046/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [271.435570] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [271.439742] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [271.558059] [047/133] (748s left) gem_exec_flush (basic-uc-pro-default) [271.620437] Starting subtest: basic-uc-pro-default [277.083361] Subtest basic-uc-pro-default: SUCCESS (5.464s) [277.295418] [048/133] (743s left) gem_basic (bad-close) [277.354753] Starting subtest: bad-close [277.358985] Subtest bad-close: SUCCESS (0.000s) [277.469380] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [277.570502] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [277.574523] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [277.713766] [050/133] (742s left) kms_plane (pixel-format) [277.818554] Starting subtest: pixel-format [277.856195] Starting dynamic subtest: pipe-A-plane-0 [282.699160] Dynamic subtest pipe-A-plane-0: SUCCESS (4.844s) [282.711960] Starting dynamic subtest: pipe-A-plane-3 [284.987717] Dynamic subtest pipe-A-plane-3: SUCCESS (2.287s) [284.996865] Starting dynamic subtest: pipe-A-plane-5 [285.198997] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [286.335728] Starting dynamic subtest: pipe-B-plane-0 [291.182111] Dynamic subtest pipe-B-plane-0: SUCCESS (4.854s) [291.190895] Starting dynamic subtest: pipe-B-plane-3 [293.414751] Dynamic subtest pipe-B-plane-3: SUCCESS (2.233s) [293.423132] Starting dynamic subtest: pipe-B-plane-5 [293.625921] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [293.947953] Subtest pixel-format: SUCCESS (16.127s) [294.802776] [051/133] (725s left) kms_psr (fbc-psr2-no-drrs) [294.898879] Starting subtest: fbc-psr2-no-drrs [294.900987] Starting dynamic subtest: eDP-1 [294.904852] Dynamic subtest eDP-1: SKIP (0.000s) [294.908699] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [294.997187] [052/133] (725s left) gem_mmap (bad-size) [295.056646] Subtest bad-size: SKIP (0.000s) [295.123316] [053/133] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [295.220650] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [295.224905] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [295.358044] [054/133] (725s left) api_intel_bb (crc32) [295.419027] Starting subtest: crc32 [295.421464] Starting dynamic subtest: rcs0-smem0 [295.693740] Dynamic subtest rcs0-smem0: SUCCESS (0.275s) [295.706658] Starting dynamic subtest: bcs0-smem0 [296.035782] Dynamic subtest bcs0-smem0: SUCCESS (0.340s) [296.046398] Starting dynamic subtest: vcs0-smem0 [296.345522] Dynamic subtest vcs0-smem0: SUCCESS (0.307s) [296.357853] Starting dynamic subtest: vcs1-smem0 [296.669710] Dynamic subtest vcs1-smem0: SUCCESS (0.320s) [296.681842] Starting dynamic subtest: vecs0-smem0 [296.962031] Dynamic subtest vecs0-smem0: SUCCESS (0.290s) [296.974740] Starting dynamic subtest: ccs0-smem0 [297.276697] Dynamic subtest ccs0-smem0: SUCCESS (0.312s) [297.279575] Subtest crc32: SUCCESS (1.861s) [297.424717] [055/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [297.516540] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [297.520575] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [297.627916] [056/133] (723s left) kms_psr (psr2-cursor-render) [297.723804] Starting subtest: psr2-cursor-render [297.726027] Starting dynamic subtest: eDP-1 [299.432039] Dynamic subtest eDP-1: SUCCESS (1.708s) [299.434396] Subtest psr2-cursor-render: SUCCESS (1.709s) [300.306241] [057/133] (720s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [300.404994] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [300.415527] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [300.532427] [058/133] (720s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [300.632313] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [300.634649] Starting dynamic subtest: pipe-A-eDP-1 [301.116239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s) [301.126609] Starting dynamic subtest: pipe-B-eDP-1 [302.574183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s) [302.585613] Starting dynamic subtest: pipe-C-eDP-1 [303.928410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s) [303.939344] Starting dynamic subtest: pipe-D-eDP-1 [305.370394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.441s) [305.372619] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.713s) [306.600560] [059/133] (714s left) kms_dp_linktrain_fallback (dp-fallback) [306.699292] Starting subtest: dp-fallback [306.705840] Subtest dp-fallback: SKIP (0.000s) [306.798270] [060/133] (714s left) gem_readwrite (beyond-eob) [306.866802] Subtest beyond-EOB: SKIP (0.000s) [306.932687] [061/133] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [307.032915] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [311.462739] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.434s) [312.610116] [062/133] (708s left) prime_vgem (basic-fence-read) [312.769865] Starting subtest: basic-fence-read [312.779768] Subtest basic-fence-read: SKIP (0.008s) [312.910750] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [312.914064] [063/133] (708s left) perf_pmu (interrupts) [312.953933] Starting subtest: interrupts [314.050614] Subtest interrupts: SUCCESS (1.095s) [314.192989] [064/133] (706s left) i915_pm_rpm (system-suspend-devices) [316.030444] Starting subtest: system-suspend-devices [323.905438] Subtest system-suspend-devices: SUCCESS (7.874s) [324.295144] [065/133] (696s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [324.410237] Starting subtest: flip-vs-dpms-on-nop-interruptible [324.412535] Starting dynamic subtest: A-eDP1 [326.234763] Dynamic subtest A-eDP1: SUCCESS (1.823s) [326.246945] Starting dynamic subtest: B-eDP1 [328.034727] Dynamic subtest B-eDP1: SUCCESS (1.799s) [328.046147] Starting dynamic subtest: C-eDP1 [329.823577] Dynamic subtest C-eDP1: SUCCESS (1.787s) [329.833641] Starting dynamic subtest: D-eDP1 [331.619263] Dynamic subtest D-eDP1: SUCCESS (1.795s) [331.621663] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.212s) [332.806594] [066/133] (688s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [332.905072] Starting subtest: crc-primary-basic-y-tiled-ccs [332.907439] Starting dynamic subtest: pipe-A-eDP-1 [332.936684] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [332.951970] Starting dynamic subtest: pipe-B-eDP-1 [332.974263] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [332.985763] Starting dynamic subtest: pipe-C-eDP-1 [333.008188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [333.019047] Starting dynamic subtest: pipe-D-eDP-1 [333.042062] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [333.046298] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [335.207532] [067/133] (686s left) kms_color (ctm-0-75) [335.309293] Starting subtest: ctm-0-75 [335.311449] Starting dynamic subtest: pipe-A-eDP-1 [340.227530] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.920s) [340.237813] Starting dynamic subtest: pipe-B-eDP-1 [345.818514] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.588s) [345.828678] Starting dynamic subtest: pipe-C-eDP-1 [351.178777] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.362s) [351.190146] Starting dynamic subtest: pipe-D-eDP-1 [356.496339] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.314s) [356.498721] Subtest ctm-0-75: SUCCESS (21.187s) [357.395671] [068/133] (663s left) gem_mmap_offset (partial-mmap) [357.464463] Starting subtest: partial-mmap [357.466397] Starting dynamic subtest: smem0 [357.468749] Dynamic subtest smem0: SUCCESS (0.004s) [357.470982] Subtest partial-mmap: SUCCESS (0.005s) [357.619279] [069/133] (663s left) syncobj_timeline (device-signal-unordered) [357.689529] Starting subtest: device-signal-unordered [357.691917] Subtest device-signal-unordered: SUCCESS (0.000s) [357.806900] [070/133] (663s left) kms_pm_dc (dc6-psr) [358.910375] Starting subtest: dc6-psr [361.789614] Subtest dc6-psr: SUCCESS (2.878s) [362.692535] [071/133] (658s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [362.816556] Starting subtest: cursorB-vs-flipB-varying-size [362.821080] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [362.981791] [072/133] (658s left) kms_addfb_basic (no-handle) [363.053669] Starting subtest: no-handle [363.055953] Subtest no-handle: SUCCESS (0.000s) [363.226735] [073/133] (658s left) gem_pxp (create-regular-buffer) [363.358857] Starting subtest: create-regular-buffer [363.361325] Subtest create-regular-buffer: SUCCESS (0.000s) [363.488767] [074/133] (658s left) kms_flip (2x-dpms-vs-vblank-race) [363.583973] Starting subtest: 2x-dpms-vs-vblank-race [363.594863] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [363.696706] [075/133] (657s left) kms_psr (psr-dpms) [363.786488] Starting subtest: psr-dpms [363.788311] Starting dynamic subtest: eDP-1 [366.733308] Dynamic subtest eDP-1: SUCCESS (2.947s) [366.735507] Subtest psr-dpms: SUCCESS (2.948s) [367.598428] [076/133] (654s left) gem_lmem_swapping (massive-random) [367.645798] Subtest massive-random: SKIP (0.000s) [367.690235] [077/133] (653s left) gen9_exec_parse (bb-secure) [367.766062] Subtest bb-secure: SKIP (0.000s) [367.859715] [078/133] (653s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [367.964831] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [367.969278] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [368.100200] [079/133] (653s left) i915_suspend (fence-restore-untiled) [368.166857] Starting subtest: fence-restore-untiled [368.171156] Subtest fence-restore-untiled: SKIP (0.000s) [368.303494] [080/133] (653s left) syncobj_wait (wait-delayed-signal) [368.369640] Starting subtest: wait-delayed-signal [368.472298] Subtest wait-delayed-signal: SUCCESS (0.103s) [368.571999] [081/133] (653s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [368.664215] Starting subtest: bad-pixel-format-yf-tiled-ccs [368.666485] Starting dynamic subtest: pipe-A-eDP-1 [368.688832] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [368.704805] Starting dynamic subtest: pipe-B-eDP-1 [368.726157] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [368.740733] Starting dynamic subtest: pipe-C-eDP-1 [368.763875] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [368.775211] Starting dynamic subtest: pipe-D-eDP-1 [368.796753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [368.801186] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [370.898881] [082/133] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [370.996067] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [371.000027] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [371.132402] [083/133] (650s left) kms_chamelium_hpd (dp-hpd-fast) [371.506449] Subtest dp-hpd-fast: SKIP (0.000s) [372.345160] [084/133] (649s left) gem_exec_balancer (bonded-false-hang) [372.589027] Starting subtest: bonded-false-hang [372.594387] Subtest bonded-false-hang: SKIP (0.000s) [372.727455] [085/133] (649s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [372.827267] Starting subtest: crc-primary-suspend-yf-tiled-ccs [372.829563] Starting dynamic subtest: pipe-A-eDP-1 [372.838402] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [372.852870] Starting dynamic subtest: pipe-B-eDP-1 [372.862259] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [372.873708] Starting dynamic subtest: pipe-C-eDP-1 [372.882049] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [372.890823] Starting dynamic subtest: pipe-D-eDP-1 [372.899585] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [372.903617] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [375.089423] [086/133] (646s left) gem_exec_fence (syncobj-timeline-invalid-flags) [375.631531] Starting subtest: syncobj-timeline-invalid-flags [375.633857] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [377.003147] [087/133] (645s left) kms_plane_cursor (overlay) [377.106979] Starting subtest: overlay [377.111379] Starting dynamic subtest: pipe-A-eDP-1-size-64 [379.634662] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.527s) [379.693467] Starting dynamic subtest: pipe-A-eDP-1-size-128 [382.224035] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.537s) [382.284260] Starting dynamic subtest: pipe-A-eDP-1-size-256 [384.815540] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.537s) [385.167060] Starting dynamic subtest: pipe-B-eDP-1-size-64 [388.320936] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.163s) [388.382424] Starting dynamic subtest: pipe-B-eDP-1-size-128 [390.799499] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.426s) [390.861397] Starting dynamic subtest: pipe-B-eDP-1-size-256 [393.279036] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.426s) [393.635584] Starting dynamic subtest: pipe-C-eDP-1-size-64 [396.388143] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.763s) [396.424531] Starting dynamic subtest: pipe-C-eDP-1-size-128 [398.620613] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s) [398.660265] Starting dynamic subtest: pipe-C-eDP-1-size-256 [400.774812] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.123s) [401.103318] Starting dynamic subtest: pipe-D-eDP-1-size-64 [404.011534] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.919s) [404.049924] Starting dynamic subtest: pipe-D-eDP-1-size-128 [406.200457] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s) [406.239299] Starting dynamic subtest: pipe-D-eDP-1-size-256 [408.333236] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s) [408.653348] Subtest overlay: SUCCESS (31.544s) [409.479993] [088/133] (612s left) gem_ctx_param (basic-default) [409.547068] Starting subtest: basic-default [409.549272] Subtest basic-default: SUCCESS (0.000s) [409.644727] [089/133] (612s left) api_intel_allocator (two-level-inception-interruptible) [409.706574] Starting subtest: two-level-inception-interruptible [415.107579] Subtest two-level-inception-interruptible: SUCCESS (5.402s) [415.263678] [090/133] (606s left) kms_dsc (dsc-with-bpc-formats) [415.376955] Starting subtest: dsc-with-bpc-formats [415.489618] Subtest dsc-with-bpc-formats: SKIP (0.003s) [415.533307] [091/133] (606s left) kms_cursor_crc (cursor-alpha-opaque) [415.632337] Starting subtest: cursor-alpha-opaque [415.634506] Starting dynamic subtest: pipe-A-eDP-1 [416.253168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s) [416.263188] Starting dynamic subtest: pipe-D-eDP-1 [417.517034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s) [417.519437] Subtest cursor-alpha-opaque: SUCCESS (1.885s) [418.380199] [092/133] (603s left) syncobj_timeline (multi-wait-all-signaled) [418.445637] Starting subtest: multi-wait-all-signaled [418.447878] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [418.580189] [093/133] (603s left) i915_drm_fdinfo (isolation) [418.622345] Starting subtest: isolation [418.624500] Starting dynamic subtest: rcs0 [418.648225] Dynamic subtest rcs0: SKIP (0.026s) [418.659975] Starting dynamic subtest: bcs0 [418.671955] Dynamic subtest bcs0: SKIP (0.022s) [418.681305] Starting dynamic subtest: vcs0 [418.685248] Dynamic subtest vcs0: SKIP (0.000s) [418.694717] Starting dynamic subtest: vcs1 [418.699172] Dynamic subtest vcs1: SKIP (0.000s) [418.708087] Starting dynamic subtest: vecs0 [418.712161] Dynamic subtest vecs0: SKIP (0.000s) [418.720831] Starting dynamic subtest: ccs0 [418.725054] Dynamic subtest ccs0: SKIP (0.000s) [418.729207] Subtest isolation: SKIP (0.056s) [418.771184] [094/133] (603s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [418.862148] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [418.864432] Starting dynamic subtest: pipe-A-default-mode [419.990644] Dynamic subtest pipe-A-default-mode: SKIP (1.127s) [419.995330] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.129s) [420.175950] [095/133] (602s left) gem_ctx_isolation (preservation-s3) [420.252974] Starting subtest: preservation-S3 [420.255393] Starting dynamic subtest: rcs0 [436.076829] Dynamic subtest rcs0: SUCCESS (1.345s) [436.087491] Starting dynamic subtest: bcs0 [452.108927] Dynamic subtest bcs0: SUCCESS (1.333s) [452.120103] Starting dynamic subtest: vcs0 [468.093359] Dynamic subtest vcs0: SUCCESS (3.008s) [468.109399] Starting dynamic subtest: vcs1 [486.095917] Dynamic subtest vcs1: SUCCESS (4.888s) [486.107118] Starting dynamic subtest: vecs0 [504.090009] Dynamic subtest vecs0: SUCCESS (4.892s) [504.101962] Starting dynamic subtest: ccs0 [522.092810] Dynamic subtest ccs0: SUCCESS (3.115s) [522.097077] Subtest preservation-S3: SUCCESS (18.587s) [522.375486] [096/133] (500s left) gem_eio (reset-stress) [522.628726] Starting subtest: reset-stress [522.631163] Starting dynamic subtest: render [528.019204] Dynamic subtest render: SUCCESS (5.289s) [528.037789] Starting dynamic subtest: bsd1 [546.402459] Dynamic subtest bsd1: SUCCESS (18.289s) [546.420152] Starting dynamic subtest: bsd2 [564.375809] Dynamic subtest bsd2: SUCCESS (17.967s) [564.392133] Starting dynamic subtest: blt [564.396038] Dynamic subtest blt: SKIP (0.000s) [564.406673] Starting dynamic subtest: vebox [582.362955] Dynamic subtest vebox: SUCCESS (17.984s) [582.365124] Subtest reset-stress: SUCCESS (59.534s) [583.856654] [097/133] (438s left) gem_softpin (evict-snoop-interruptible) [583.932773] Starting subtest: evict-snoop-interruptible [583.936891] Subtest evict-snoop-interruptible: SKIP (0.000s) [584.082313] [098/133] (438s left) i915_module_load (reload-no-display) [584.121331] Starting subtest: reload-no-display [589.185243] Subtest reload-no-display: SUCCESS (5.063s) [589.214317] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [589.215014] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [589.218291] [099/133] (433s left) kms_flip (2x-flip-vs-modeset) [590.809745] Starting subtest: 2x-flip-vs-modeset [590.821219] Subtest 2x-flip-vs-modeset: SKIP (0.013s) [590.934991] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [590.936136] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [590.939736] [100/133] (431s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [591.039479] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [591.041740] Starting dynamic subtest: pipe-A-default-mode [591.333889] Dynamic subtest pipe-A-default-mode: SKIP (0.291s) [591.338493] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.292s) [592.171377] [101/133] (430s left) kms_content_protection (type1) [592.311635] Starting subtest: type1 [592.316044] Subtest type1: SKIP (0.000s) [592.474852] [102/133] (430s left) kms_big_fb (4-tiled-16bpp-rotate-180) [592.574068] Starting subtest: 4-tiled-16bpp-rotate-180 [593.797779] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.223s) [593.965481] [103/133] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [594.064807] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [594.068488] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [594.204433] [104/133] (428s left) gem_ppgtt (flink-and-close-vma-leak) [594.278107] Starting subtest: flink-and-close-vma-leak [594.319529] Subtest flink-and-close-vma-leak: SUCCESS (0.041s) [594.482391] [105/133] (428s left) syncobj_wait (signal) [594.547000] Starting subtest: signal [594.548798] Subtest signal: SUCCESS (0.000s) [594.687163] [106/133] (428s left) kms_cursor_crc (cursor-rapid-movement-128x128) [594.894789] Starting subtest: cursor-rapid-movement-128x128 [594.899368] Starting dynamic subtest: pipe-A-eDP-1 [595.447135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s) [595.478168] Starting dynamic subtest: pipe-D-eDP-1 [596.664858] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s) [596.666742] Subtest cursor-rapid-movement-128x128: SUCCESS (1.768s) [597.541486] [107/133] (425s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [602.588219] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [602.590544] Starting dynamic subtest: pipe-A-eDP-1 [603.385741] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s) [603.396017] Starting dynamic subtest: pipe-B-eDP-1 [604.517194] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s) [604.521309] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.926s) [605.744311] [108/133] (417s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [605.842207] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [612.276342] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.434s) [612.449195] [109/133] (410s left) kms_vblank (query-forked-busy) [612.548311] Starting subtest: query-forked-busy [612.550819] Starting dynamic subtest: pipe-A-eDP-1 [614.432397] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s) [614.446653] Starting dynamic subtest: pipe-D-eDP-1 [616.975955] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s) [616.978329] Subtest query-forked-busy: SUCCESS (4.428s) [617.797794] [110/133] (405s left) syncobj_timeline (invalid-transfer-non-existent-point) [617.866793] Starting subtest: invalid-transfer-non-existent-point [617.869191] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [618.012740] [111/133] (405s left) kms_big_fb (x-tiled-16bpp-rotate-0) [618.122488] Starting subtest: x-tiled-16bpp-rotate-0 [619.456206] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.334s) [619.624722] [112/133] (403s left) kms_psr (fbc-psr-primary-blt) [619.725793] Starting subtest: fbc-psr-primary-blt [619.727636] Starting dynamic subtest: eDP-1 [619.730951] Dynamic subtest eDP-1: SKIP (0.000s) [619.734267] Subtest fbc-psr-primary-blt: SKIP (0.001s) [619.825816] [113/133] (403s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [619.887273] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [619.993227] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [620.092193] [114/133] (403s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [620.200560] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [620.204658] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [620.319472] [115/133] (402s left) gem_exec_reloc (basic-cpu-active) [620.393062] Subtest basic-cpu-active: SKIP (0.000s) [620.483289] [116/133] (402s left) perf (rc6-disable) [620.631589] Starting subtest: rc6-disable [620.804985] Subtest rc6-disable: SUCCESS (0.175s) [620.850843] [117/133] (402s left) gem_ctx_shared (q-independent) [620.925546] Starting subtest: Q-independent [620.927930] Starting dynamic subtest: rcs0 [620.996038] Dynamic subtest rcs0: SUCCESS (0.070s) [621.008051] Starting dynamic subtest: vcs0 [621.033569] Dynamic subtest vcs0: SUCCESS (0.037s) [621.043189] Starting dynamic subtest: vcs1 [621.073474] Dynamic subtest vcs1: SUCCESS (0.039s) [621.083589] Starting dynamic subtest: vecs0 [621.114757] Dynamic subtest vecs0: SUCCESS (0.041s) [621.125594] Starting dynamic subtest: ccs0 [621.159836] Dynamic subtest ccs0: SUCCESS (0.044s) [621.161976] Subtest Q-independent: SUCCESS (0.235s) [622.967016] [118/133] (400s left) perf (non-zero-reason) [623.079040] Starting subtest: non-zero-reason [623.081282] Starting dynamic subtest: 0-rcs0 [628.407538] Dynamic subtest 0-rcs0: SUCCESS (5.328s) [628.419675] Starting dynamic subtest: 1-vcs1 [632.288124] Dynamic subtest 1-vcs1: SUCCESS (3.880s) [632.291137] Subtest non-zero-reason: SUCCESS (9.210s) [632.338849] [119/133] (391s left) kms_psr (pr-dpms) [632.446691] Starting subtest: pr-dpms [632.451135] Subtest pr-dpms: SKIP (0.000s) [632.538481] [120/133] (390s left) kms_rotation_crc (primary-rotation-180) [632.634651] Starting subtest: primary-rotation-180 [639.578250] Subtest primary-rotation-180: SUCCESS (6.945s) [640.850599] [121/133] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [640.966811] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [648.179813] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.216s) [648.349785] [122/133] (375s left) gem_create (create-size-update) [648.416901] Starting subtest: create-size-update [648.419281] Subtest create-size-update: SUCCESS (0.000s) [648.665096] [123/133] (374s left) prime_vgem (basic-fence-blt) [648.743523] Starting subtest: basic-fence-blt [648.834123] Subtest basic-fence-blt: SUCCESS (0.090s) [649.003763] [124/133] (374s left) kms_getfb (getfb2-into-addfb2) [649.110682] Starting subtest: getfb2-into-addfb2 [649.112900] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [649.251731] [125/133] (374s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [649.367114] Starting subtest: verify-pxp-execution-after-suspend-resume [656.406788] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.039s) [656.572922] [126/133] (367s left) syncobj_basic (bad-pad-fd-to-handle) [656.637288] Starting subtest: bad-pad-fd-to-handle [656.639154] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [656.772392] [127/133] (366s left) dmabuf_sync_file (export-before-signal) [656.808906] Starting subtest: export-before-signal [656.811093] Subtest export-before-signal: SUCCESS (0.001s) [656.888601] [128/133] (366s left) kms_flip (2x-flip-vs-panning-vs-hang) [656.976951] Starting subtest: 2x-flip-vs-panning-vs-hang [656.987392] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s) [657.087868] [129/133] (366s left) gem_softpin (allocator-nopin-reserve) [657.154356] Starting subtest: allocator-nopin-reserve [657.241456] Subtest allocator-nopin-reserve: SUCCESS (0.087s) [657.378651] [130/133] (366s left) kms_pipe_crc_basic (read-crc-frame-sequence) [657.474081] Starting subtest: read-crc-frame-sequence [657.475997] Starting dynamic subtest: pipe-A-eDP-1 [658.173349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [658.185683] Starting dynamic subtest: pipe-B-eDP-1 [659.521345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s) [659.533210] Starting dynamic subtest: pipe-C-eDP-1 [660.827410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s) [660.838142] Starting dynamic subtest: pipe-D-eDP-1 [663.068145] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s) [663.070287] Subtest read-crc-frame-sequence: SUCCESS (5.592s) [663.617378] [131/133] (360s left) kms_frontbuffer_tracking (pipe-fbc-rte) [663.723615] Starting subtest: pipe-fbc-rte [663.730239] Starting dynamic subtest: pipe-B-eDP-1 [669.204281] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.483s) [669.211044] Subtest pipe-fbc-rte: SUCCESS (5.485s) [671.555294] [132/133] (352s left) kms_addfb_basic (too-wide) [671.658329] Starting subtest: too-wide [671.660632] Subtest too-wide: SUCCESS (0.000s) [671.769134] [133/133] (352s left) gem_exec_schedule (pi-shared-iova) [671.953972] Starting subtest: pi-shared-iova [671.956330] Starting dynamic subtest: rcs0 [672.025889] Dynamic subtest rcs0: SUCCESS (0.074s) [672.040270] Starting dynamic subtest: vcs0 [672.092782] Dynamic subtest vcs0: SUCCESS (0.059s) [672.105506] Starting dynamic subtest: vcs1 [672.137327] Dynamic subtest vcs1: SUCCESS (0.049s) [672.150842] Starting dynamic subtest: vecs0 [672.185779] Dynamic subtest vecs0: SUCCESS (0.048s) [672.196128] Starting dynamic subtest: ccs0 [672.236753] Dynamic subtest ccs0: SUCCESS (0.050s) [672.239330] Subtest pi-shared-iova: SUCCESS (0.286s) [673.915648] 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.