[58.486976] Initializing watchdogs [58.487089] /dev/watchdog0 [58.503337] [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.507879] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.509991] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.513225] [001/133] (960s left) syncobj_basic (bad-create-flags) [58.594531] Starting subtest: bad-create-flags [58.596850] Subtest bad-create-flags: SUCCESS (0.000s) [58.733767] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [64.056723] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [64.059152] Starting dynamic subtest: pipe-A-eDP-1 [70.832667] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.781s) [70.841483] Starting dynamic subtest: pipe-B-eDP-1 [77.728590] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.895s) [77.730888] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.680s) [78.604310] [003/133] (940s left) gem_ccs (block-copy-compressed) [78.679439] Starting subtest: block-copy-compressed [78.684189] Subtest block-copy-compressed: SKIP (0.000s) [78.804269] [004/133] (940s left) kms_sequence (get-forked-busy) [78.888712] Starting subtest: get-forked-busy [78.890999] Starting dynamic subtest: pipe-A-eDP-1 [80.809751] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [80.818088] Starting dynamic subtest: pipe-B-eDP-1 [83.368507] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.558s) [83.376616] Starting dynamic subtest: pipe-C-eDP-1 [85.976725] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s) [85.985554] Starting dynamic subtest: pipe-D-eDP-1 [88.518941] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s) [88.521296] Subtest get-forked-busy: SUCCESS (9.631s) [89.339362] [005/133] (929s left) sysfs_preempt_timeout (timeout) [89.394967] Starting subtest: timeout [89.397385] Starting dynamic subtest: vecs0 [98.923187] Dynamic subtest vecs0: SUCCESS (9.525s) [98.934033] Starting dynamic subtest: ccs0 [100.252889] Dynamic subtest ccs0: SUCCESS (1.331s) [100.262889] Starting dynamic subtest: vcs0 [109.910988] Dynamic subtest vcs0: SUCCESS (9.657s) [109.921287] Starting dynamic subtest: bcs0 [111.237311] Dynamic subtest bcs0: SUCCESS (1.324s) [111.245272] Starting dynamic subtest: rcs0 [112.554056] Dynamic subtest rcs0: SUCCESS (1.314s) [112.564112] Starting dynamic subtest: vcs1 [121.963143] Dynamic subtest vcs1: SUCCESS (9.407s) [121.965829] Subtest timeout: SUCCESS (32.566s) [122.059760] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [122.169235] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [122.173216] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [122.302048] [007/133] (896s left) gem_ctx_persistence (legacy-engines-queued) [122.361818] Starting subtest: legacy-engines-queued [122.364073] Starting dynamic subtest: render [122.470406] Dynamic subtest render: SUCCESS (0.108s) [122.480541] Starting dynamic subtest: bsd1 [123.893744] Dynamic subtest bsd1: SUCCESS (1.419s) [123.904711] Starting dynamic subtest: bsd2 [125.876920] Dynamic subtest bsd2: SUCCESS (1.981s) [125.886840] Starting dynamic subtest: blt [125.960977] Dynamic subtest blt: SUCCESS (0.084s) [125.970566] Starting dynamic subtest: vebox [127.860861] Dynamic subtest vebox: SUCCESS (1.895s) [127.864270] Subtest legacy-engines-queued: SUCCESS (5.498s) [127.968590] [008/133] (891s left) drm_read (short-buffer-block) [128.155839] Starting subtest: short-buffer-block [128.158267] Subtest short-buffer-block: SUCCESS (0.000s) [128.328586] [009/133] (890s left) gem_render_copy_redux (normal) [128.405065] Starting subtest: normal [128.659337] Subtest normal: SUCCESS (0.254s) [128.772647] [010/133] (890s left) kms_big_fb (y-tiled-32bpp-rotate-90) [128.875857] Starting subtest: y-tiled-32bpp-rotate-90 [128.879576] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [128.995894] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [129.091324] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [136.379174] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.290s) [136.535688] [012/133] (882s left) gem_exec_suspend (basic) [136.586045] Starting subtest: basic [136.588373] Starting dynamic subtest: smem [137.878600] Dynamic subtest smem: SUCCESS (1.290s) [137.881484] Subtest basic: SUCCESS (1.292s) [138.088311] [013/133] (881s left) kms_hdmi_inject (inject-audio) [138.440849] Starting subtest: inject-audio [138.712292] Subtest inject-audio: SUCCESS (0.274s) [139.329167] [014/133] (880s left) kms_cursor_crc (cursor-sliding-32x10) [139.485592] Starting subtest: cursor-sliding-32x10 [139.531533] Subtest cursor-sliding-32x10: SKIP (0.041s) [139.818954] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [139.932389] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [146.416148] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.487s) [146.553718] [016/133] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [146.658862] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [146.663231] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [146.804125] [017/133] (872s left) gem_render_copy (y-tiled-ccs-to-linear) [146.871772] Starting subtest: y-tiled-ccs-to-linear [146.876222] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [147.078379] [018/133] (872s left) kms_big_fb (4-tiled-16bpp-rotate-90) [147.174197] Starting subtest: 4-tiled-16bpp-rotate-90 [147.193351] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [147.352879] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [147.420145] Starting subtest: transfer-timeline-point [147.422424] Subtest transfer-timeline-point: SUCCESS (0.001s) [147.548961] [020/133] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [147.609797] Starting subtest: invalid-multi-wait-unsubmitted-submitted [147.611786] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [147.747885] [021/133] (872s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [147.841126] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [147.843437] Starting dynamic subtest: pipe-A-eDP-1 [147.868627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.878883] Starting dynamic subtest: pipe-B-eDP-1 [147.902334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.910112] Starting dynamic subtest: pipe-C-eDP-1 [147.934077] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.941650] Starting dynamic subtest: pipe-D-eDP-1 [147.965864] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.969992] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [150.092870] [022/133] (869s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [152.024811] Starting subtest: dpms-mode-unset-non-lpsp [153.172841] Subtest dpms-mode-unset-non-lpsp: SKIP (1.147s) [153.577553] [023/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [153.674624] Starting subtest: psr-rgb565-draw-mmap-wc [160.286589] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.614s) [160.436171] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [160.822811] Subtest vga-edid-read: SKIP (0.000s) [161.655397] [025/133] (858s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [161.717798] Starting subtest: yf-tiled-to-vebox-y-tiled [161.722327] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [161.922008] [026/133] (858s left) kms_flip (dpms-off-confusion) [162.014346] Starting subtest: dpms-off-confusion [162.016587] Starting dynamic subtest: A-eDP1 [170.676624] Dynamic subtest A-eDP1: SUCCESS (8.663s) [170.686551] Starting dynamic subtest: B-eDP1 [179.345511] Dynamic subtest B-eDP1: SUCCESS (8.668s) [179.355067] Starting dynamic subtest: C-eDP1 [188.030581] Dynamic subtest C-eDP1: SUCCESS (8.683s) [188.043790] Starting dynamic subtest: D-eDP1 [196.736881] Dynamic subtest D-eDP1: SUCCESS (8.703s) [196.743225] Subtest dpms-off-confusion: SUCCESS (34.729s) [197.996374] [027/133] (822s left) gem_exec_big (single) [198.053872] Starting subtest: single [200.352270] Subtest single: SUCCESS (2.299s) [200.600132] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [200.701596] Starting subtest: basic-wb-ro-default [206.163239] Subtest basic-wb-ro-default: SUCCESS (5.461s) [206.374545] [029/133] (813s left) kms_async_flips (async-flip-with-page-flip-events-linear) [206.479670] Starting subtest: async-flip-with-page-flip-events-linear [206.850932] Starting dynamic subtest: pipe-A-eDP-1 [209.617816] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.765s) [210.006381] Starting dynamic subtest: pipe-B-eDP-1 [212.814363] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.813s) [213.208051] Starting dynamic subtest: pipe-C-eDP-1 [216.009562] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.807s) [216.378534] Starting dynamic subtest: pipe-D-eDP-1 [219.113320] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.741s) [219.115775] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.634s) [220.298903] [030/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [220.404264] Starting subtest: planes-downscale-factor-0-75 [220.407269] Starting dynamic subtest: pipe-A [220.430059] Dynamic subtest pipe-A: SKIP (0.018s) [220.440288] Starting dynamic subtest: pipe-B [220.466043] Dynamic subtest pipe-B: SKIP (0.037s) [220.475110] Starting dynamic subtest: pipe-C [220.495082] Dynamic subtest pipe-C: SKIP (0.031s) [220.502978] Starting dynamic subtest: pipe-D [220.528887] Dynamic subtest pipe-D: SKIP (0.031s) [220.532888] Subtest planes-downscale-factor-0-75: SKIP (0.119s) [220.665473] [031/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [220.772671] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [220.776716] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [220.932045] [032/133] (799s left) kms_properties (colorop-properties-legacy) [221.040309] Starting subtest: colorop-properties-legacy [221.042643] Starting dynamic subtest: pipe-A-eDP-1 [221.405183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s) [221.413376] Starting dynamic subtest: pipe-B-eDP-1 [222.490362] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.085s) [222.499603] Starting dynamic subtest: pipe-C-eDP-1 [223.591401] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s) [223.600959] Starting dynamic subtest: pipe-D-eDP-1 [224.706161] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.113s) [224.708347] Subtest colorop-properties-legacy: SUCCESS (3.665s) [225.595141] [033/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [225.702182] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [225.706304] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [225.833392] [034/133] (794s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [225.932581] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [225.934679] Starting dynamic subtest: pipe-A-eDP-1 [225.954424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [225.963566] Starting dynamic subtest: pipe-B-eDP-1 [225.982406] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [225.990523] Starting dynamic subtest: pipe-C-eDP-1 [226.009379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [226.017624] Starting dynamic subtest: pipe-D-eDP-1 [226.037232] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [226.039106] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [228.187348] [035/133] (792s left) gem_wait (wait) [228.267796] Starting subtest: wait [228.269800] Starting dynamic subtest: all-engines [229.909259] Dynamic subtest all-engines: SUCCESS (1.643s) [229.920687] Starting dynamic subtest: rcs0 [230.955032] Dynamic subtest rcs0: SUCCESS (1.044s) [230.966217] Starting dynamic subtest: bcs0 [232.001473] Dynamic subtest bcs0: SUCCESS (1.045s) [232.012046] Starting dynamic subtest: vcs0 [233.046637] Dynamic subtest vcs0: SUCCESS (1.042s) [233.057050] Starting dynamic subtest: vcs1 [234.090790] Dynamic subtest vcs1: SUCCESS (1.042s) [234.101104] Starting dynamic subtest: vecs0 [235.135203] Dynamic subtest vecs0: SUCCESS (1.043s) [235.144633] Starting dynamic subtest: ccs0 [236.184512] Dynamic subtest ccs0: SUCCESS (1.047s) [236.187073] Subtest wait: SUCCESS (7.921s) [236.421031] [036/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [236.524224] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [236.528134] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [236.656214] [037/133] (783s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [236.765450] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [237.723043] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.957s) [237.868679] [038/133] (782s left) gem_exec_reloc (basic-concurrent0) [237.941889] Subtest basic-concurrent0: SKIP (0.000s) [238.021458] [039/133] (782s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [238.122541] Starting subtest: yf-tiled-32bpp-rotate-180 [238.126166] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [238.265772] [040/133] (782s left) kms_lease (cursor-implicit-plane) [238.364378] Starting subtest: cursor-implicit-plane [238.366319] Starting dynamic subtest: pipe-A-eDP-1 [238.834411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s) [238.844089] Starting dynamic subtest: pipe-B-eDP-1 [239.948690] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.116s) [239.957877] Starting dynamic subtest: pipe-C-eDP-1 [241.028856] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.078s) [241.042043] Starting dynamic subtest: pipe-D-eDP-1 [242.132601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.103s) [242.134954] Subtest cursor-implicit-plane: SUCCESS (3.770s) [242.989905] [041/133] (777s left) gem_exec_schedule (u-semaphore-resolve) [243.082601] Starting subtest: u-semaphore-resolve [243.123853] Subtest u-semaphore-resolve: SUCCESS (0.050s) [243.480386] [042/133] (777s left) gem_exec_whisper (basic-fds-priority) [243.546216] Starting subtest: basic-fds-priority [267.341759] Subtest basic-fds-priority: SUCCESS (23.794s) [267.553380] [043/133] (753s left) i915_query (query-topology-known-pci-ids) [267.613601] Starting subtest: query-topology-known-pci-ids [267.618140] Subtest query-topology-known-pci-ids: SKIP (0.000s) [267.752374] [044/133] (752s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [267.855091] Starting subtest: yf-tiled-64bpp-rotate-90 [267.859513] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [267.986664] [045/133] (752s left) perf_pmu (idle) [268.033300] Starting subtest: idle [268.035255] Starting dynamic subtest: rcs0 [268.595113] Dynamic subtest rcs0: SUCCESS (0.560s) [268.606952] Starting dynamic subtest: bcs0 [269.125930] Dynamic subtest bcs0: SUCCESS (0.528s) [269.137099] Starting dynamic subtest: vcs0 [269.659665] Dynamic subtest vcs0: SUCCESS (0.527s) [269.673332] Starting dynamic subtest: vcs1 [270.184078] Dynamic subtest vcs1: SUCCESS (0.526s) [270.195385] Starting dynamic subtest: vecs0 [270.711711] Dynamic subtest vecs0: SUCCESS (0.525s) [270.723254] Starting dynamic subtest: ccs0 [271.242895] Dynamic subtest ccs0: SUCCESS (0.528s) [271.245865] Subtest idle: SUCCESS (3.210s) [271.384457] [046/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [271.487340] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [271.491539] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [271.628870] [047/133] (749s left) gem_exec_flush (basic-uc-pro-default) [271.698784] Starting subtest: basic-uc-pro-default [277.148331] Subtest basic-uc-pro-default: SUCCESS (5.452s) [277.358625] [048/133] (743s left) gem_basic (bad-close) [277.413844] Starting subtest: bad-close [277.418278] Subtest bad-close: SUCCESS (0.000s) [277.555032] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [277.648303] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [277.652509] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [277.786634] [050/133] (743s left) kms_plane (pixel-format) [277.880047] Starting subtest: pixel-format [277.909294] Starting dynamic subtest: pipe-A-plane-0 [282.842100] Dynamic subtest pipe-A-plane-0: SUCCESS (4.933s) [282.851022] Starting dynamic subtest: pipe-A-plane-3 [285.153485] Dynamic subtest pipe-A-plane-3: SUCCESS (2.311s) [285.161864] Starting dynamic subtest: pipe-A-plane-5 [285.364549] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [286.526464] Starting dynamic subtest: pipe-B-plane-0 [291.447558] Dynamic subtest pipe-B-plane-0: SUCCESS (4.933s) [291.456960] Starting dynamic subtest: pipe-B-plane-3 [293.892402] Dynamic subtest pipe-B-plane-3: SUCCESS (2.444s) [293.903663] Starting dynamic subtest: pipe-B-plane-5 [294.103554] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s) [294.418245] Subtest pixel-format: SUCCESS (16.537s) [295.282066] [051/133] (725s left) kms_psr (fbc-psr2-no-drrs) [295.389248] Starting subtest: fbc-psr2-no-drrs [295.391138] Starting dynamic subtest: eDP-1 [295.395234] Dynamic subtest eDP-1: SKIP (0.000s) [295.399299] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [295.493191] [052/133] (725s left) gem_mmap (bad-size) [295.556993] Subtest bad-size: SKIP (0.000s) [295.624711] [053/133] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [295.711350] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [295.715451] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [295.824629] [054/133] (725s left) api_intel_bb (crc32) [295.882990] Starting subtest: crc32 [295.885205] Starting dynamic subtest: rcs0-smem0 [296.165268] Dynamic subtest rcs0-smem0: SUCCESS (0.282s) [296.178104] Starting dynamic subtest: bcs0-smem0 [296.476336] Dynamic subtest bcs0-smem0: SUCCESS (0.308s) [296.489627] Starting dynamic subtest: vcs0-smem0 [296.808245] Dynamic subtest vcs0-smem0: SUCCESS (0.331s) [296.822120] Starting dynamic subtest: vcs1-smem0 [297.150260] Dynamic subtest vcs1-smem0: SUCCESS (0.337s) [297.161066] Starting dynamic subtest: vecs0-smem0 [297.474099] Dynamic subtest vecs0-smem0: SUCCESS (0.321s) [297.484684] Starting dynamic subtest: ccs0-smem0 [297.788972] Dynamic subtest ccs0-smem0: SUCCESS (0.312s) [297.791899] Subtest crc32: SUCCESS (1.908s) [297.928883] [055/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [298.026062] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [298.030223] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [298.160344] [056/133] (723s left) kms_psr (psr2-cursor-render) [298.253052] Starting subtest: psr2-cursor-render [298.255347] Starting dynamic subtest: eDP-1 [299.919801] Dynamic subtest eDP-1: SUCCESS (1.666s) [299.921770] Subtest psr2-cursor-render: SUCCESS (1.667s) [300.781278] [057/133] (720s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [300.875869] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [300.888316] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [300.988757] [058/133] (720s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [301.079164] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [301.081461] Starting dynamic subtest: pipe-A-eDP-1 [301.497996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s) [301.509348] Starting dynamic subtest: pipe-B-eDP-1 [302.941154] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s) [302.958438] Starting dynamic subtest: pipe-C-eDP-1 [304.301712] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s) [304.310729] Starting dynamic subtest: pipe-D-eDP-1 [305.711815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s) [305.714092] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.606s) [306.884141] [059/133] (714s left) kms_dp_linktrain_fallback (dp-fallback) [306.982328] Starting subtest: dp-fallback [306.988631] Subtest dp-fallback: SKIP (0.000s) [307.076182] [060/133] (714s left) gem_readwrite (beyond-eob) [307.135253] Subtest beyond-EOB: SKIP (0.000s) [307.197120] [061/133] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [307.296623] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [311.757676] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.465s) [312.903293] [062/133] (708s left) prime_vgem (basic-fence-read) [313.098400] Starting subtest: basic-fence-read [313.111069] Subtest basic-fence-read: SKIP (0.013s) [313.252832] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [313.255883] [063/133] (708s left) perf_pmu (interrupts) [313.294793] Starting subtest: interrupts [314.397585] Subtest interrupts: SUCCESS (1.100s) [314.543395] [064/133] (706s left) i915_pm_rpm (system-suspend-devices) [316.101580] Starting subtest: system-suspend-devices [323.892706] Subtest system-suspend-devices: SUCCESS (7.794s) [324.304400] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [324.425224] Starting subtest: flip-vs-dpms-on-nop-interruptible [324.427463] Starting dynamic subtest: A-eDP1 [326.232521] Dynamic subtest A-eDP1: SUCCESS (1.806s) [326.250827] Starting dynamic subtest: B-eDP1 [328.019379] Dynamic subtest B-eDP1: SUCCESS (1.784s) [328.031613] Starting dynamic subtest: C-eDP1 [329.825019] Dynamic subtest C-eDP1: SUCCESS (1.804s) [329.835826] Starting dynamic subtest: D-eDP1 [331.617260] Dynamic subtest D-eDP1: SUCCESS (1.791s) [331.619660] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.195s) [332.895885] [066/133] (688s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [332.987952] Starting subtest: crc-primary-basic-y-tiled-ccs [332.990339] Starting dynamic subtest: pipe-A-eDP-1 [333.013845] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [333.026096] Starting dynamic subtest: pipe-B-eDP-1 [333.047946] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [333.057786] Starting dynamic subtest: pipe-C-eDP-1 [333.079469] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [333.088995] Starting dynamic subtest: pipe-D-eDP-1 [333.112769] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [333.117036] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s) [335.284229] [067/133] (686s left) kms_color (ctm-0-75) [335.389690] Starting subtest: ctm-0-75 [335.391802] Starting dynamic subtest: pipe-A-eDP-1 [340.308586] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.919s) [340.319469] Starting dynamic subtest: pipe-B-eDP-1 [345.921522] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.612s) [345.933291] Starting dynamic subtest: pipe-C-eDP-1 [351.355407] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.431s) [351.365741] Starting dynamic subtest: pipe-D-eDP-1 [356.668374] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.314s) [356.670668] Subtest ctm-0-75: SUCCESS (21.279s) [357.495617] [068/133] (664s left) gem_mmap_offset (partial-mmap) [357.562616] Starting subtest: partial-mmap [357.565054] Starting dynamic subtest: smem0 [357.567282] Dynamic subtest smem0: SUCCESS (0.003s) [357.569608] Subtest partial-mmap: SUCCESS (0.004s) [357.724977] [069/133] (664s left) syncobj_timeline (device-signal-unordered) [357.787112] Starting subtest: device-signal-unordered [357.789292] Subtest device-signal-unordered: SUCCESS (0.000s) [357.923628] [070/133] (663s left) kms_pm_dc (dc6-psr) [359.028655] Starting subtest: dc6-psr [361.908496] Subtest dc6-psr: SUCCESS (2.880s) [362.781163] [071/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [362.892272] Starting subtest: cursorB-vs-flipB-varying-size [362.896603] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [363.070732] [072/133] (658s left) kms_addfb_basic (no-handle) [363.122992] Starting subtest: no-handle [363.125480] Subtest no-handle: SUCCESS (0.000s) [363.288597] [073/133] (658s left) gem_pxp (create-regular-buffer) [363.401655] Starting subtest: create-regular-buffer [363.404076] Subtest create-regular-buffer: SUCCESS (0.000s) [363.537837] [074/133] (658s left) kms_flip (2x-dpms-vs-vblank-race) [363.627969] Starting subtest: 2x-dpms-vs-vblank-race [363.638784] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s) [363.744283] [075/133] (658s left) kms_psr (psr-dpms) [363.830935] Starting subtest: psr-dpms [363.832815] Starting dynamic subtest: eDP-1 [366.721735] Dynamic subtest eDP-1: SUCCESS (2.888s) [366.724066] Subtest psr-dpms: SUCCESS (2.889s) [367.584437] [076/133] (654s left) gem_lmem_swapping (massive-random) [367.634343] Subtest massive-random: SKIP (0.000s) [367.681865] [077/133] (654s left) gen9_exec_parse (bb-secure) [367.739983] Subtest bb-secure: SKIP (0.000s) [367.837077] [078/133] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [367.940417] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [367.944525] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [368.065394] [079/133] (654s left) i915_suspend (fence-restore-untiled) [368.127131] Starting subtest: fence-restore-untiled [368.131205] Subtest fence-restore-untiled: SKIP (0.000s) [368.243888] [080/133] (653s left) syncobj_wait (wait-delayed-signal) [368.308189] Starting subtest: wait-delayed-signal [368.410085] Subtest wait-delayed-signal: SUCCESS (0.103s) [368.516066] [081/133] (653s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [368.609774] Starting subtest: bad-pixel-format-yf-tiled-ccs [368.611717] Starting dynamic subtest: pipe-A-eDP-1 [368.630163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [368.641182] Starting dynamic subtest: pipe-B-eDP-1 [368.658325] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [368.667419] Starting dynamic subtest: pipe-C-eDP-1 [368.684646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [368.694921] Starting dynamic subtest: pipe-D-eDP-1 [368.713508] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [368.717067] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [370.882655] [082/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [370.981887] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [370.985956] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [371.103458] [083/133] (651s left) kms_chamelium_hpd (dp-hpd-fast) [371.488072] Subtest dp-hpd-fast: SKIP (0.000s) [372.330587] [084/133] (650s left) gem_exec_balancer (bonded-false-hang) [372.590737] Starting subtest: bonded-false-hang [372.595891] Subtest bonded-false-hang: SKIP (0.000s) [372.731745] [085/133] (649s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [372.826682] Starting subtest: crc-primary-suspend-yf-tiled-ccs [372.828929] Starting dynamic subtest: pipe-A-eDP-1 [372.837904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [372.848523] Starting dynamic subtest: pipe-B-eDP-1 [372.857370] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [372.867102] Starting dynamic subtest: pipe-C-eDP-1 [372.875795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [372.885252] Starting dynamic subtest: pipe-D-eDP-1 [372.893865] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [372.898164] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [375.088877] [086/133] (647s left) gem_exec_fence (syncobj-timeline-invalid-flags) [375.618804] Starting subtest: syncobj-timeline-invalid-flags [375.621463] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [376.991485] [087/133] (645s left) kms_plane_cursor (overlay) [377.089239] Starting subtest: overlay [377.093820] Starting dynamic subtest: pipe-A-eDP-1-size-64 [379.616743] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.529s) [379.677723] Starting dynamic subtest: pipe-A-eDP-1-size-128 [382.184083] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.515s) [382.246337] Starting dynamic subtest: pipe-A-eDP-1-size-256 [384.731025] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.493s) [385.079887] Starting dynamic subtest: pipe-B-eDP-1-size-64 [388.284384] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.214s) [388.350265] Starting dynamic subtest: pipe-B-eDP-1-size-128 [390.817333] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.481s) [390.879844] Starting dynamic subtest: pipe-B-eDP-1-size-256 [393.387171] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s) [393.744309] Starting dynamic subtest: pipe-C-eDP-1-size-64 [396.557507] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.824s) [396.596897] Starting dynamic subtest: pipe-C-eDP-1-size-128 [398.747655] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s) [398.785055] Starting dynamic subtest: pipe-C-eDP-1-size-256 [400.890212] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.112s) [401.235297] Starting dynamic subtest: pipe-D-eDP-1-size-64 [404.060349] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.838s) [404.100046] Starting dynamic subtest: pipe-D-eDP-1-size-128 [406.294107] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.202s) [406.333495] Starting dynamic subtest: pipe-D-eDP-1-size-256 [408.607259] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.279s) [408.944714] Subtest overlay: SUCCESS (31.854s) [409.777479] [088/133] (612s left) gem_ctx_param (basic-default) [409.844924] Starting subtest: basic-default [409.847207] Subtest basic-default: SUCCESS (0.000s) [409.943552] [089/133] (612s left) api_intel_allocator (two-level-inception-interruptible) [410.007611] Starting subtest: two-level-inception-interruptible [415.416984] Subtest two-level-inception-interruptible: SUCCESS (5.409s) [415.588476] [090/133] (607s left) kms_dsc (dsc-with-bpc-formats) [415.687481] Starting subtest: dsc-with-bpc-formats [415.802398] Subtest dsc-with-bpc-formats: SKIP (0.003s) [415.848295] [091/133] (606s left) kms_cursor_crc (cursor-alpha-opaque) [415.946550] Starting subtest: cursor-alpha-opaque [415.948697] Starting dynamic subtest: pipe-A-eDP-1 [416.582715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s) [416.594395] Starting dynamic subtest: pipe-D-eDP-1 [417.884174] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [417.886658] Subtest cursor-alpha-opaque: SUCCESS (1.940s) [418.789357] [092/133] (603s left) syncobj_timeline (multi-wait-all-signaled) [418.862049] Starting subtest: multi-wait-all-signaled [418.864405] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [419.011100] [093/133] (603s left) i915_drm_fdinfo (isolation) [419.049831] Starting subtest: isolation [419.052081] Starting dynamic subtest: rcs0 [419.100762] Dynamic subtest rcs0: SKIP (0.048s) [419.113075] Starting dynamic subtest: bcs0 [419.117180] Dynamic subtest bcs0: SKIP (0.000s) [419.126928] Starting dynamic subtest: vcs0 [419.131259] Dynamic subtest vcs0: SKIP (0.000s) [419.140822] Starting dynamic subtest: vcs1 [419.144959] Dynamic subtest vcs1: SKIP (0.001s) [419.154237] Starting dynamic subtest: vecs0 [419.158228] Dynamic subtest vecs0: SKIP (0.001s) [419.167320] Starting dynamic subtest: ccs0 [419.171379] Dynamic subtest ccs0: SKIP (0.000s) [419.175426] Subtest isolation: SKIP (0.060s) [419.216345] [094/133] (603s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [419.324264] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [419.326495] Starting dynamic subtest: pipe-A-default-mode [420.487333] Dynamic subtest pipe-A-default-mode: SKIP (1.158s) [420.491899] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.160s) [420.697456] [095/133] (602s left) gem_ctx_isolation (preservation-s3) [420.763904] Starting subtest: preservation-S3 [420.770220] Starting dynamic subtest: rcs0 [436.993637] Dynamic subtest rcs0: SUCCESS (1.515s) [437.004483] Starting dynamic subtest: bcs0 [452.975743] Dynamic subtest bcs0: SUCCESS (1.325s) [452.985600] Starting dynamic subtest: vcs0 [468.968083] Dynamic subtest vcs0: SUCCESS (2.372s) [468.984826] Starting dynamic subtest: vcs1 [487.040944] Dynamic subtest vcs1: SUCCESS (5.149s) [487.052082] Starting dynamic subtest: vecs0 [504.983331] Dynamic subtest vecs0: SUCCESS (4.940s) [504.995064] Starting dynamic subtest: ccs0 [522.978956] Dynamic subtest ccs0: SUCCESS (3.241s) [522.982301] Subtest preservation-S3: SUCCESS (18.549s) [523.252927] [096/133] (499s left) gem_eio (reset-stress) [523.502800] Starting subtest: reset-stress [523.505343] Starting dynamic subtest: render [528.786018] Dynamic subtest render: SUCCESS (5.335s) [528.803165] Starting dynamic subtest: bsd1 [547.314401] Dynamic subtest bsd1: SUCCESS (18.582s) [547.331898] Starting dynamic subtest: bsd2 [565.266858] Dynamic subtest bsd2: SUCCESS (17.947s) [565.284429] Starting dynamic subtest: blt [565.289377] Dynamic subtest blt: SKIP (0.000s) [565.298918] Starting dynamic subtest: vebox [583.329820] Dynamic subtest vebox: SUCCESS (18.060s) [583.332602] Subtest reset-stress: SUCCESS (59.929s) [584.762820] [097/133] (438s left) gem_softpin (evict-snoop-interruptible) [584.834516] Starting subtest: evict-snoop-interruptible [584.839557] Subtest evict-snoop-interruptible: SKIP (0.000s) [584.983279] [098/133] (438s left) i915_module_load (reload-no-display) [585.019488] Starting subtest: reload-no-display [592.588847] Subtest reload-no-display: SUCCESS (7.570s) [592.620414] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [592.621160] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [592.624648] [099/133] (430s left) kms_flip (2x-flip-vs-modeset) [595.548920] Starting subtest: 2x-flip-vs-modeset [595.560020] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [595.684493] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [595.685719] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [595.690380] [100/133] (427s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [595.785831] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [595.788556] Starting dynamic subtest: pipe-A-default-mode [596.076803] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [596.082115] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.290s) [596.894076] [101/133] (426s left) kms_content_protection (type1) [597.042704] Starting subtest: type1 [597.047870] Subtest type1: SKIP (0.000s) [597.218316] [102/133] (425s left) kms_big_fb (4-tiled-16bpp-rotate-180) [597.313384] Starting subtest: 4-tiled-16bpp-rotate-180 [598.545464] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.234s) [598.776534] [103/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [598.867997] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [598.873262] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [599.032404] [104/133] (424s left) gem_ppgtt (flink-and-close-vma-leak) [599.098277] Starting subtest: flink-and-close-vma-leak [599.140000] Subtest flink-and-close-vma-leak: SUCCESS (0.045s) [599.306482] [105/133] (424s left) syncobj_wait (signal) [599.365993] Starting subtest: signal [599.368912] Subtest signal: SUCCESS (0.000s) [599.494925] [106/133] (423s left) kms_cursor_crc (cursor-rapid-movement-128x128) [599.696420] Starting subtest: cursor-rapid-movement-128x128 [599.700725] Starting dynamic subtest: pipe-A-eDP-1 [600.231066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s) [600.264819] Starting dynamic subtest: pipe-D-eDP-1 [601.483078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [601.485999] Subtest cursor-rapid-movement-128x128: SUCCESS (1.783s) [602.359460] [107/133] (421s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [607.400816] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [607.403155] Starting dynamic subtest: pipe-A-eDP-1 [608.211509] Dynamic subtest pipe-A-eDP-1: SKIP (0.807s) [608.221975] Starting dynamic subtest: pipe-B-eDP-1 [609.340711] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s) [609.346051] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.938s) [610.550460] [108/133] (412s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [610.651807] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [617.148360] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.501s) [617.311087] [109/133] (406s left) kms_vblank (query-forked-busy) [617.412993] Starting subtest: query-forked-busy [617.415386] Starting dynamic subtest: pipe-A-eDP-1 [619.298959] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s) [619.318887] Starting dynamic subtest: pipe-D-eDP-1 [621.820819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s) [621.823907] Subtest query-forked-busy: SUCCESS (4.409s) [622.659797] [110/133] (400s left) syncobj_timeline (invalid-transfer-non-existent-point) [622.724022] Starting subtest: invalid-transfer-non-existent-point [622.726980] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [622.858476] [111/133] (400s left) kms_big_fb (x-tiled-16bpp-rotate-0) [622.975024] Starting subtest: x-tiled-16bpp-rotate-0 [624.252013] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.276s) [624.415423] [112/133] (399s left) kms_psr (fbc-psr-primary-blt) [624.509764] Starting subtest: fbc-psr-primary-blt [624.511835] Starting dynamic subtest: eDP-1 [624.515864] Dynamic subtest eDP-1: SKIP (0.000s) [624.520651] Subtest fbc-psr-primary-blt: SKIP (0.001s) [624.610418] [113/133] (399s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [624.666270] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [624.772290] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s) [624.873469] [114/133] (398s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [624.985641] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [624.990723] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [625.114171] [115/133] (398s left) gem_exec_reloc (basic-cpu-active) [625.177736] Subtest basic-cpu-active: SKIP (0.000s) [625.235454] [116/133] (398s left) perf (rc6-disable) [625.401361] Starting subtest: rc6-disable [625.585417] Subtest rc6-disable: SUCCESS (0.185s) [625.630455] [117/133] (398s left) gem_ctx_shared (q-independent) [625.699005] Starting subtest: Q-independent [625.701828] Starting dynamic subtest: rcs0 [625.762700] Dynamic subtest rcs0: SUCCESS (0.063s) [625.775039] Starting dynamic subtest: vcs0 [625.800583] Dynamic subtest vcs0: SUCCESS (0.038s) [625.810165] Starting dynamic subtest: vcs1 [625.836152] Dynamic subtest vcs1: SUCCESS (0.035s) [625.845818] Starting dynamic subtest: vecs0 [625.871121] Dynamic subtest vecs0: SUCCESS (0.034s) [625.880489] Starting dynamic subtest: ccs0 [625.910030] Dynamic subtest ccs0: SUCCESS (0.037s) [625.912555] Subtest Q-independent: SUCCESS (0.212s) [627.871978] [118/133] (396s left) perf (non-zero-reason) [627.997154] Starting subtest: non-zero-reason [627.999982] Starting dynamic subtest: 0-rcs0 [633.269308] Dynamic subtest 0-rcs0: SUCCESS (5.269s) [633.281732] Starting dynamic subtest: 1-vecs0 [637.121178] Dynamic subtest 1-vecs0: SUCCESS (3.850s) [637.123985] Subtest non-zero-reason: SUCCESS (9.122s) [637.170245] [119/133] (386s left) kms_psr (pr-dpms) [637.272626] Starting subtest: pr-dpms [637.277571] Subtest pr-dpms: SKIP (0.000s) [637.368914] [120/133] (386s left) kms_rotation_crc (primary-rotation-180) [637.475000] Starting subtest: primary-rotation-180 [644.559132] Subtest primary-rotation-180: SUCCESS (7.084s) [645.819122] [121/133] (378s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [645.933032] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [653.167873] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.236s) [653.330942] [122/133] (370s left) gem_create (create-size-update) [653.398695] Starting subtest: create-size-update [653.400934] Subtest create-size-update: SUCCESS (0.000s) [653.623424] [123/133] (370s left) prime_vgem (basic-fence-blt) [653.710653] Starting subtest: basic-fence-blt [653.812689] Subtest basic-fence-blt: SUCCESS (0.102s) [653.986069] [124/133] (370s left) kms_getfb (getfb2-into-addfb2) [654.078580] Starting subtest: getfb2-into-addfb2 [654.080716] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [654.215059] [125/133] (369s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [654.340690] Starting subtest: verify-pxp-execution-after-suspend-resume [661.412941] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.070s) [662.579800] [126/133] (362s left) syncobj_basic (bad-pad-fd-to-handle) [662.646007] Starting subtest: bad-pad-fd-to-handle [662.648745] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [662.786167] [127/133] (362s left) dmabuf_sync_file (export-before-signal) [662.827840] Starting subtest: export-before-signal [662.830167] Subtest export-before-signal: SUCCESS (0.001s) [662.908303] [128/133] (362s left) kms_flip (2x-flip-vs-panning-vs-hang) [663.016853] Starting subtest: 2x-flip-vs-panning-vs-hang [663.026576] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [663.153500] [129/133] (362s left) gem_softpin (allocator-nopin-reserve) [663.218179] Starting subtest: allocator-nopin-reserve [663.315943] Subtest allocator-nopin-reserve: SUCCESS (0.101s) [663.490028] [130/133] (361s left) kms_pipe_crc_basic (read-crc-frame-sequence) [663.592785] Starting subtest: read-crc-frame-sequence [663.594834] Starting dynamic subtest: pipe-A-eDP-1 [664.308914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s) [664.320946] Starting dynamic subtest: pipe-B-eDP-1 [665.654113] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s) [665.665458] Starting dynamic subtest: pipe-C-eDP-1 [666.940556] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s) [666.951187] Starting dynamic subtest: pipe-D-eDP-1 [668.273788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [668.276132] Subtest read-crc-frame-sequence: SUCCESS (4.683s) [669.131517] [131/133] (356s left) kms_frontbuffer_tracking (pipe-fbc-rte) [669.234131] Starting subtest: pipe-fbc-rte [669.241080] Starting dynamic subtest: pipe-B-eDP-1 [674.687150] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.457s) [674.694865] Subtest pipe-fbc-rte: SUCCESS (5.460s) [677.029642] [132/133] (348s left) kms_addfb_basic (too-wide) [677.126447] Starting subtest: too-wide [677.128967] Subtest too-wide: SUCCESS (0.000s) [677.246534] [133/133] (348s left) gem_exec_schedule (pi-shared-iova) [677.435880] Starting subtest: pi-shared-iova [677.438597] Starting dynamic subtest: rcs0 [677.514265] Dynamic subtest rcs0: SUCCESS (0.080s) [677.526351] Starting dynamic subtest: vcs0 [677.571466] Dynamic subtest vcs0: SUCCESS (0.056s) [677.584807] Starting dynamic subtest: vcs1 [677.622971] Dynamic subtest vcs1: SUCCESS (0.051s) [677.636241] Starting dynamic subtest: vecs0 [677.675437] Dynamic subtest vecs0: SUCCESS (0.051s) [677.687195] Starting dynamic subtest: ccs0 [677.731180] Dynamic subtest ccs0: SUCCESS (0.055s) [677.734042] Subtest pi-shared-iova: SUCCESS (0.297s) [678.845872] 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.