[57.422413] Initializing watchdogs [57.422466] /dev/watchdog0 [57.437287] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.441938] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.444159] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.447307] [001/133] (960s left) kms_vblank (invalid) [57.582086] Starting subtest: invalid [57.584094] Starting dynamic subtest: pipe-A-eDP-1 [58.030354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s) [58.032786] Subtest invalid: SUCCESS (0.441s) [58.871196] [002/133] (959s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [58.981764] Starting subtest: yf-tiled-64bpp-rotate-180 [58.986298] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [59.064720] [003/133] (958s left) prime_busy (before-wait) [59.125676] Starting subtest: before-wait [59.130666] Starting dynamic subtest: rcs0 [59.156860] Dynamic subtest rcs0: SUCCESS (0.027s) [59.165653] Starting dynamic subtest: bcs0 [59.197392] Dynamic subtest bcs0: SUCCESS (0.040s) [59.206319] Starting dynamic subtest: vcs0 [59.238657] Dynamic subtest vcs0: SUCCESS (0.040s) [59.246963] Starting dynamic subtest: vcs1 [59.282840] Dynamic subtest vcs1: SUCCESS (0.042s) [59.295799] Starting dynamic subtest: vecs0 [59.323174] Dynamic subtest vecs0: SUCCESS (0.040s) [59.333270] Starting dynamic subtest: ccs0 [59.364475] Dynamic subtest ccs0: SUCCESS (0.041s) [59.475310] Subtest before-wait: SUCCESS (0.341s) [59.547885] [004/133] (958s left) syncobj_timeline (invalid-wait-bad-flags) [59.622065] Starting subtest: invalid-wait-bad-flags [59.624080] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [59.723058] [005/133] (958s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [59.776383] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [59.778828] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s) [59.868396] [006/133] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [59.961877] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [67.385316] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.348s) [67.508142] [007/133] (950s left) gem_exec_whisper (basic-fds-forked-all) [67.580454] Starting subtest: basic-fds-forked-all [87.691812] Subtest basic-fds-forked-all: SUCCESS (20.063s) [87.875709] [008/133] (930s left) gem_exec_async (forked-writes) [87.947990] Starting subtest: forked-writes [87.950348] Starting dynamic subtest: rcs0 [87.980661] Dynamic subtest rcs0: SUCCESS (0.034s) [87.992563] Starting dynamic subtest: bcs0 [88.005028] Dynamic subtest bcs0: SUCCESS (0.024s) [88.018017] Starting dynamic subtest: vcs0 [88.025096] Dynamic subtest vcs0: SUCCESS (0.020s) [88.035167] Starting dynamic subtest: vcs1 [88.049141] Dynamic subtest vcs1: SUCCESS (0.023s) [88.059272] Starting dynamic subtest: vecs0 [88.069590] Dynamic subtest vecs0: SUCCESS (0.020s) [88.079978] Starting dynamic subtest: ccs0 [88.092992] Dynamic subtest ccs0: SUCCESS (0.022s) [88.095954] Subtest forked-writes: SUCCESS (0.147s) [88.333509] [009/133] (929s left) gem_exec_fence (invalid-timeline-fence-array) [89.006588] Starting subtest: invalid-timeline-fence-array [89.014724] Subtest invalid-timeline-fence-array: SUCCESS (0.008s) [90.393638] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [90.396934] [010/133] (927s left) core_setmaster (master-drop-set-shared-fd) [90.479365] Starting subtest: master-drop-set-shared-fd [90.499791] Subtest master-drop-set-shared-fd: SUCCESS (0.021s) [90.539069] [011/133] (927s left) kms_pm_backlight (basic-brightness) [90.640695] Starting subtest: basic-brightness [90.724915] Starting dynamic subtest: eDP-1 [91.228301] Dynamic subtest eDP-1: SUCCESS (0.502s) [91.230655] Subtest basic-brightness: SUCCESS (0.587s) [92.064956] [012/133] (926s left) gem_fence_thrash (bo-write-verify-none) [92.098828] Starting subtest: bo-write-verify-none [92.119756] Subtest bo-write-verify-none: SKIP (0.016s) [92.183199] [013/133] (926s left) kms_psr (pr-primary-blt) [92.274900] Starting subtest: pr-primary-blt [92.279431] Subtest pr-primary-blt: SKIP (0.000s) [92.345813] [014/133] (926s left) gen9_exec_parse (batch-zero-length) [92.409650] Subtest batch-zero-length: SKIP (0.000s) [92.479090] [015/133] (926s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [92.599505] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [92.604216] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [92.744929] [016/133] (925s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [92.846402] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [92.850429] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [92.953316] [017/133] (925s left) kms_getfb (getfb2-handle-closed) [93.038979] Starting subtest: getfb2-handle-closed [93.040875] Subtest getfb2-handle-closed: SUCCESS (0.000s) [93.122080] [018/133] (925s left) kms_properties (get_properties-sanity-non-atomic) [93.224968] Starting subtest: get_properties-sanity-non-atomic [93.226918] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s) [93.295576] [019/133] (925s left) gem_fence_thrash (bo-copy) [93.327067] Starting subtest: bo-copy [93.355176] Subtest bo-copy: SKIP (0.025s) [93.413940] [020/133] (925s left) gem_spin_batch (resubmit-all) [93.483150] Starting subtest: resubmit-all [93.485090] Starting dynamic subtest: rcs0 [93.495173] Dynamic subtest rcs0: SUCCESS (0.012s) [93.507497] Starting dynamic subtest: bcs0 [93.509471] Dynamic subtest bcs0: SUCCESS (0.002s) [93.518045] Starting dynamic subtest: vcs0 [93.519913] Dynamic subtest vcs0: SUCCESS (0.003s) [93.528519] Starting dynamic subtest: vcs1 [93.530529] Dynamic subtest vcs1: SUCCESS (0.002s) [93.544842] Starting dynamic subtest: vecs0 [93.546741] Dynamic subtest vecs0: SUCCESS (0.002s) [93.557822] Starting dynamic subtest: ccs0 [93.559778] Dynamic subtest ccs0: SUCCESS (0.002s) [93.561746] Subtest resubmit-all: SUCCESS (0.024s) [95.327379] [021/133] (923s left) gem_exec_reloc (basic-cpu-read-active) [95.381760] Subtest basic-cpu-read-active: SKIP (0.000s) [95.448961] [022/133] (923s left) kms_big_fb (4-tiled-16bpp-rotate-0) [95.546712] Starting subtest: 4-tiled-16bpp-rotate-0 [96.902623] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.357s) [97.012624] [023/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [97.119270] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [97.122924] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [97.219931] [024/133] (921s left) kms_dp_link_training (uhbr-sst) [97.315077] Starting subtest: uhbr-sst [97.321900] Subtest uhbr-sst: SKIP (0.000s) [97.386622] [025/133] (921s left) gem_userptr_blits (huge-split) [97.455520] Starting subtest: huge-split [97.467211] Subtest huge-split: SUCCESS (0.012s) [97.578624] [026/133] (921s left) kms_async_flips (async-flip-hang) [97.663207] Starting subtest: async-flip-hang [98.039090] Starting dynamic subtest: pipe-A-eDP-1 [113.826248] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.775s) [114.207514] Starting dynamic subtest: pipe-B-eDP-1 [129.755836] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.550s) [130.135967] Starting dynamic subtest: pipe-C-eDP-1 [145.757684] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.615s) [146.120633] Starting dynamic subtest: pipe-D-eDP-1 [161.741465] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.628s) [161.744287] Subtest async-flip-hang: SUCCESS (64.067s) [162.954750] [027/133] (856s left) gem_eio (hibernate) [163.149417] Starting subtest: hibernate [178.628494] Subtest hibernate: SUCCESS (15.476s) [185.798314] [028/133] (840s left) syncobj_timeline (wait-any-complex) [185.866103] Starting subtest: wait-any-complex [185.927575] Subtest wait-any-complex: SUCCESS (0.062s) [186.006558] [029/133] (840s left) kms_vblank (ts-continuation-modeset) [186.104038] Starting subtest: ts-continuation-modeset [186.105964] Starting dynamic subtest: pipe-A-eDP-1 [187.593795] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.488s) [187.611310] Starting dynamic subtest: pipe-D-eDP-1 [189.756490] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s) [189.758953] Subtest ts-continuation-modeset: SUCCESS (3.653s) [190.562982] [030/133] (835s left) gem_exec_create (basic) [190.627597] Starting subtest: basic [190.629972] Starting dynamic subtest: smem [192.716920] Dynamic subtest smem: SUCCESS (2.089s) [192.719403] Subtest basic: SUCCESS (2.090s) [192.914559] [031/133] (833s left) kms_psr (fbc-pr-sprite-plane-move) [193.011695] Starting subtest: fbc-pr-sprite-plane-move [193.016086] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [193.088257] [032/133] (833s left) i915_pm_rps (thresholds) [193.139642] Starting subtest: thresholds [193.143718] Subtest thresholds: SKIP (0.001s) [193.241960] [033/133] (832s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [193.347503] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [193.351471] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [193.427707] [034/133] (832s left) gem_exec_params (larger-than-life-batch) [193.486685] Starting subtest: larger-than-life-batch [195.641877] Subtest larger-than-life-batch: SUCCESS (2.154s) [196.331256] [035/133] (829s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [196.426701] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [196.536501] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [196.616214] [036/133] (829s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [196.720291] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [196.724727] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [196.821236] [037/133] (829s left) kms_cursor_crc (cursor-rapid-movement-256x85) [197.077935] Starting subtest: cursor-rapid-movement-256x85 [197.127788] Subtest cursor-rapid-movement-256x85: SKIP (0.044s) [197.305683] [038/133] (829s left) gem_fenced_exec_thrash (no-spare-fences-busy) [197.367646] Subtest no-spare-fences-busy: SKIP (0.000s) [197.442354] [039/133] (829s left) syncobj_timeline (reset-multiple-signaled) [197.503261] Starting subtest: reset-multiple-signaled [197.505540] Subtest reset-multiple-signaled: SUCCESS (0.001s) [197.604359] [040/133] (828s left) kms_big_fb (4-tiled-8bpp-rotate-270) [197.718923] Starting subtest: 4-tiled-8bpp-rotate-270 [197.739337] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [197.853331] [041/133] (828s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [197.943711] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [197.947701] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [198.029099] [042/133] (828s left) kms_addfb_basic (addfb25-modifier-no-flag) [198.123281] Starting subtest: addfb25-modifier-no-flag [198.125115] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [198.219936] [043/133] (828s left) gem_render_copy (y-tiled) [198.270373] Starting subtest: y-tiled [198.274331] Subtest y-tiled: SKIP (0.000s) [198.471339] [044/133] (828s left) perf_pmu (busy-accuracy-2) [198.513810] Starting subtest: busy-accuracy-2 [198.516216] Starting dynamic subtest: rcs0 [201.563094] Dynamic subtest rcs0: SUCCESS (3.045s) [201.577195] Starting dynamic subtest: bcs0 [204.674950] Dynamic subtest bcs0: SUCCESS (3.060s) [204.688790] Starting dynamic subtest: vcs0 [207.672409] Dynamic subtest vcs0: SUCCESS (3.047s) [207.685943] Starting dynamic subtest: vcs1 [210.769782] Dynamic subtest vcs1: SUCCESS (3.047s) [210.788684] Starting dynamic subtest: vecs0 [213.762168] Dynamic subtest vecs0: SUCCESS (3.040s) [213.774512] Starting dynamic subtest: ccs0 [216.873618] Dynamic subtest ccs0: SUCCESS (3.060s) [216.876058] Subtest busy-accuracy-2: SUCCESS (18.307s) [216.949385] [045/133] (809s left) kms_chamelium_hpd (hdmi-hpd) [217.334774] Subtest hdmi-hpd: SKIP (0.000s) [218.180263] [046/133] (808s left) kms_cursor_edge_walk (256x256-top-bottom) [218.271197] Starting subtest: 256x256-top-bottom [218.273537] Starting dynamic subtest: pipe-A-eDP-1 [221.766268] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s) [221.778971] Starting dynamic subtest: pipe-D-eDP-1 [224.897259] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s) [224.899567] Subtest 256x256-top-bottom: SUCCESS (6.628s) [225.703308] [047/133] (801s left) gem_exec_reloc (basic-wc-cpu) [225.766520] Subtest basic-wc-cpu: SKIP (0.000s) [225.841207] [048/133] (801s left) gem_mmap_gtt (basic-read-write-distinct) [225.903471] Subtest basic-read-write-distinct: SKIP (0.000s) [225.971428] [049/133] (800s left) gem_softpin (softpin) [226.035674] Starting subtest: softpin [258.290466] Subtest softpin: SUCCESS (32.248s) [258.407221] [050/133] (768s left) kms_cursor_crc (cursor-onscreen-256x85) [258.676650] Starting subtest: cursor-onscreen-256x85 [258.724753] Subtest cursor-onscreen-256x85: SKIP (0.044s) [258.913952] [051/133] (768s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [259.028975] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [268.414739] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.386s) [269.260995] [052/133] (757s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [269.370149] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [269.374736] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [269.465011] [053/133] (757s left) gem_exec_balancer (hog) [269.519248] Starting subtest: hog [269.524057] Subtest hog: SKIP (0.000s) [269.808532] [054/133] (757s left) sysfs_heartbeat_interval (mixed) [269.865837] Starting subtest: mixed [269.868508] Starting dynamic subtest: vecs0 [275.077074] Dynamic subtest vecs0: SUCCESS (5.210s) [275.090853] Starting dynamic subtest: ccs0 [280.304059] Dynamic subtest ccs0: SUCCESS (5.225s) [280.316165] Starting dynamic subtest: vcs0 [285.517321] Dynamic subtest vcs0: SUCCESS (5.211s) [285.530854] Starting dynamic subtest: bcs0 [290.747947] Dynamic subtest bcs0: SUCCESS (5.228s) [290.759962] Starting dynamic subtest: rcs0 [295.950121] Dynamic subtest rcs0: SUCCESS (5.200s) [295.962944] Starting dynamic subtest: vcs1 [301.115117] Dynamic subtest vcs1: SUCCESS (5.164s) [301.117644] Subtest mixed: SUCCESS (31.248s) [301.196633] [055/133] (726s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [301.304120] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [301.306386] Starting dynamic subtest: pipe-A-eDP-1 [311.983614] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.683s) [311.995978] Starting dynamic subtest: pipe-B-eDP-1 [323.439872] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.451s) [323.441736] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.137s) [324.281853] [056/133] (702s left) kms_pipe_stress (stress-xrgb8888-xtiled) [324.392803] Starting subtest: stress-xrgb8888-xtiled [330.341056] Subtest stress-xrgb8888-xtiled: SUCCESS (5.950s) [330.396537] [057/133] (696s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [330.489815] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [330.493245] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [330.588900] [058/133] (696s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [330.681436] Starting subtest: fbcpsr-shrfb-scaledprimary [336.459091] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.777s) [336.606843] [059/133] (690s left) perf_pmu (render-node-busy-idle) [336.680293] Starting subtest: render-node-busy-idle [336.682907] Starting dynamic subtest: rcs0 [337.371788] Dynamic subtest rcs0: SUCCESS (0.691s) [337.387116] Starting dynamic subtest: bcs0 [338.036986] Dynamic subtest bcs0: SUCCESS (0.663s) [338.057034] Starting dynamic subtest: vcs0 [339.323411] Dynamic subtest vcs0: SUCCESS (1.282s) [339.338536] Starting dynamic subtest: vcs1 [341.307539] Dynamic subtest vcs1: SUCCESS (1.981s) [341.321202] Starting dynamic subtest: vecs0 [343.291423] Dynamic subtest vecs0: SUCCESS (1.981s) [343.304209] Starting dynamic subtest: ccs0 [343.965048] Dynamic subtest ccs0: SUCCESS (0.672s) [343.967911] Subtest render-node-busy-idle: SUCCESS (7.285s) [344.054475] [060/133] (683s left) i915_drm_fdinfo (virtual-idle) [344.098172] Starting subtest: virtual-idle [347.164676] Subtest virtual-idle: SUCCESS (3.065s) [347.242595] [061/133] (680s left) gem_exec_reloc (basic-gtt-cpu) [347.301948] Subtest basic-gtt-cpu: SKIP (0.000s) [347.368426] [062/133] (680s left) gem_mmap (bad-offset) [347.423589] Subtest bad-offset: SKIP (0.000s) [347.499674] [063/133] (680s left) gem_exec_endless (dispatch) [347.554900] Starting subtest: dispatch [347.557161] Starting dynamic subtest: rcs0 [347.564553] Dynamic subtest rcs0: SUCCESS (0.006s) [347.578245] Starting dynamic subtest: bcs0 [347.582290] Dynamic subtest bcs0: SUCCESS (0.007s) [347.594426] Starting dynamic subtest: vcs0 [347.599179] Dynamic subtest vcs0: SUCCESS (0.006s) [347.609829] Starting dynamic subtest: vcs1 [347.614276] Dynamic subtest vcs1: SUCCESS (0.007s) [347.625298] Starting dynamic subtest: vecs0 [347.629665] Dynamic subtest vecs0: SUCCESS (0.005s) [347.640780] Starting dynamic subtest: ccs0 [347.645204] Dynamic subtest ccs0: SUCCESS (0.004s) [347.647396] Subtest dispatch: SUCCESS (0.040s) [349.353968] [064/133] (678s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [349.454398] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [350.456311] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.002s) [350.593212] [065/133] (677s left) gem_compute (compute-square) [350.644592] Starting subtest: compute-square [350.647629] Subtest compute-square: SUCCESS (0.006s) [350.753870] [066/133] (676s left) kms_pm_dc (dc6-psr) [351.861617] Starting subtest: dc6-psr [354.732647] Subtest dc6-psr: SUCCESS (2.870s) [355.545328] [067/133] (672s left) api_intel_allocator (reopen-fork) [355.605432] Starting subtest: reopen-fork [358.997500] Subtest reopen-fork: SUCCESS (3.391s) [359.076665] [068/133] (668s left) gem_userptr_blits (readonly-pwrite-unsync) [359.149068] Subtest readonly-pwrite-unsync: SKIP (0.000s) [359.264307] [069/133] (668s left) kms_psr (fbc-psr-primary-blt) [359.360170] Starting subtest: fbc-psr-primary-blt [359.362306] Starting dynamic subtest: eDP-1 [359.366191] Dynamic subtest eDP-1: SKIP (0.000s) [359.370126] Subtest fbc-psr-primary-blt: SKIP (0.001s) [359.443510] [070/133] (668s left) gem_busy (busy) [359.501644] Starting subtest: busy [359.503641] Starting dynamic subtest: all-engines [359.548961] Dynamic subtest all-engines: SUCCESS (0.050s) [359.560699] Starting dynamic subtest: rcs0 [361.282037] Dynamic subtest rcs0: SUCCESS (1.731s) [361.294279] Starting dynamic subtest: bcs0 [361.338721] Dynamic subtest bcs0: SUCCESS (0.053s) [361.350845] Starting dynamic subtest: vcs0 [361.377697] Dynamic subtest vcs0: SUCCESS (0.040s) [361.388539] Starting dynamic subtest: vcs1 [363.264953] Dynamic subtest vcs1: SUCCESS (1.883s) [363.277635] Starting dynamic subtest: vecs0 [365.364713] Dynamic subtest vecs0: SUCCESS (2.046s) [365.378651] Starting dynamic subtest: ccs0 [367.232067] Dynamic subtest ccs0: SUCCESS (1.917s) [367.233951] Subtest busy: SUCCESS (7.730s) [367.595380] [071/133] (660s left) i915_drm_fdinfo (virtual-busy-hang-all) [367.635514] Starting subtest: virtual-busy-hang-all [367.640071] Subtest virtual-busy-hang-all: SKIP (0.000s) [367.704425] [072/133] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [367.800505] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [375.214896] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.418s) [375.367443] [073/133] (652s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [375.462467] Starting subtest: plane-lut1d-post-ctm3x4 [375.608201] Starting dynamic subtest: pipe-A-plane-0 [375.786113] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [375.802093] Starting dynamic subtest: pipe-A-plane-1 [375.985735] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s) [375.997277] Starting dynamic subtest: pipe-A-plane-2 [376.141564] Dynamic subtest pipe-A-plane-2: SUCCESS (0.154s) [377.403317] Starting dynamic subtest: pipe-B-plane-0 [377.558703] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [377.570406] Starting dynamic subtest: pipe-B-plane-1 [377.714593] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [377.727514] Starting dynamic subtest: pipe-B-plane-2 [377.874307] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [379.045510] Starting dynamic subtest: pipe-C-plane-0 [379.166217] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [379.177634] Starting dynamic subtest: pipe-C-plane-1 [379.300098] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [379.311494] Starting dynamic subtest: pipe-C-plane-2 [379.432691] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s) [380.662870] Starting dynamic subtest: pipe-D-plane-0 [380.785936] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [380.798087] Starting dynamic subtest: pipe-D-plane-1 [380.942699] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [380.955225] Starting dynamic subtest: pipe-D-plane-2 [381.087199] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [381.377201] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.910s) [382.247419] [074/133] (645s left) prime_mmap_kms (buffer-sharing) [382.343523] Starting subtest: buffer-sharing [382.793455] Subtest buffer-sharing: SUCCESS (0.451s) [383.666470] [075/133] (644s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [383.760026] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [383.762284] Starting dynamic subtest: pipe-A-eDP-1 [383.784479] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [383.797979] Starting dynamic subtest: pipe-B-eDP-1 [383.818985] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [383.829598] Starting dynamic subtest: pipe-C-eDP-1 [383.851270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [383.861884] Starting dynamic subtest: pipe-D-eDP-1 [383.884066] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [383.888416] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s) [386.034184] [076/133] (642s left) kms_big_fb (x-tiled-addfb) [386.136527] Starting subtest: x-tiled-addfb [386.138879] Subtest x-tiled-addfb: SUCCESS (0.000s) [386.229051] [077/133] (641s left) kms_busy (extended-modeset-hang-oldfb) [386.326262] Starting subtest: extended-modeset-hang-oldfb [386.328213] Starting dynamic subtest: pipe-A [398.123564] Dynamic subtest pipe-A: SUCCESS (11.794s) [398.137672] Starting dynamic subtest: pipe-D [410.388774] Dynamic subtest pipe-D: SUCCESS (12.262s) [410.391081] Subtest extended-modeset-hang-oldfb: SUCCESS (24.061s) [411.191577] [078/133] (616s left) syncobj_wait (wait-all-for-submit-delayed-submit) [411.243061] Starting subtest: wait-all-for-submit-delayed-submit [411.347870] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [411.448987] [079/133] (616s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [411.553715] Starting subtest: yf-tiled-32bpp-rotate-0 [411.558199] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [411.665210] [080/133] (616s left) kms_prop_blob (basic) [411.718076] Starting subtest: basic [411.720234] Subtest basic: SUCCESS (0.000s) [411.820879] [081/133] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [411.919644] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [411.923848] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [412.013073] [082/133] (616s left) kms_plane_multiple (2x-tiling-y) [412.099736] Starting subtest: 2x-tiling-y [412.103933] Subtest 2x-tiling-y: SKIP (0.000s) [412.171387] [083/133] (616s left) syncobj_wait (reset-multiple-signaled) [412.236307] Starting subtest: reset-multiple-signaled [412.238650] Subtest reset-multiple-signaled: SUCCESS (0.000s) [412.355939] [084/133] (616s left) gem_exec_parallel (basic) [412.423061] Starting subtest: basic [412.425140] Starting dynamic subtest: rcs0 [413.858733] Dynamic subtest rcs0: SUCCESS (1.438s) [413.873229] Starting dynamic subtest: bcs0 [415.329520] Dynamic subtest bcs0: SUCCESS (1.469s) [415.342507] Starting dynamic subtest: vcs0 [417.274996] Dynamic subtest vcs0: SUCCESS (1.941s) [417.287613] Starting dynamic subtest: vcs1 [419.257906] Dynamic subtest vcs1: SUCCESS (1.981s) [419.271585] Starting dynamic subtest: vecs0 [421.306399] Dynamic subtest vecs0: SUCCESS (2.046s) [421.319311] Starting dynamic subtest: ccs0 [422.823204] Dynamic subtest ccs0: SUCCESS (1.516s) [422.825668] Subtest basic: SUCCESS (10.403s) [423.011778] [085/133] (605s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [423.116720] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [427.126907] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.014s) [428.302271] [086/133] (600s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [428.421721] Starting subtest: basic-flip-before-cursor-legacy [429.332888] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.912s) [430.212149] [087/133] (598s left) gem_mmap_offset (partial-mmap) [430.272249] Starting subtest: partial-mmap [430.274153] Starting dynamic subtest: smem0 [430.276541] Dynamic subtest smem0: SUCCESS (0.003s) [430.278790] Subtest partial-mmap: SUCCESS (0.004s) [430.394300] [088/133] (598s left) api_intel_bb (reset-bb) [430.446616] Starting subtest: reset-bb [430.448740] Subtest reset-bb: SUCCESS (0.003s) [430.587994] [089/133] (598s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [430.682073] Starting subtest: primary-yf-tiled-reflect-x-270 [430.686414] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [430.760192] [090/133] (597s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [430.876471] Starting subtest: short-flip-after-cursor-atomic-transitions [431.828278] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.950s) [432.637063] [091/133] (596s left) kms_chamelium_frames (hdmi-crc-fast) [433.026241] Subtest hdmi-crc-fast: SKIP (0.000s) [433.872526] [092/133] (594s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [433.929179] Starting subtest: yf-tiled-to-vebox-x-tiled [433.933633] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [434.114933] [093/133] (594s left) gem_exec_schedule (semaphore-noskip) [434.192044] Starting subtest: semaphore-noskip [434.612276] Subtest semaphore-noskip: SUCCESS (0.425s) [434.944760] [094/133] (593s left) perf (oa-exponents) [435.100405] Starting subtest: oa-exponents [435.102649] Starting dynamic subtest: 0-rcs0 [436.852596] Dynamic subtest 0-rcs0: SUCCESS (1.751s) [436.865808] Starting dynamic subtest: 1-vcs0 [438.683333] Dynamic subtest 1-vcs0: SUCCESS (1.829s) [438.685782] Subtest oa-exponents: SUCCESS (3.582s) [438.732943] [095/133] (590s left) kms_lease (lease-get) [438.830866] Starting subtest: lease-get [438.833174] Starting dynamic subtest: pipe-A-eDP-1 [438.835409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [438.847355] Starting dynamic subtest: pipe-B-eDP-1 [438.849204] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [438.859927] Starting dynamic subtest: pipe-C-eDP-1 [438.861831] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [438.872517] Starting dynamic subtest: pipe-D-eDP-1 [438.874418] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [438.876382] Subtest lease-get: SUCCESS (0.009s) [438.951731] [096/133] (590s left) kms_properties (colorop-properties-legacy) [439.042107] Starting subtest: colorop-properties-legacy [439.044410] Starting dynamic subtest: pipe-A-eDP-1 [439.413823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s) [439.428872] Starting dynamic subtest: pipe-B-eDP-1 [440.454430] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.037s) [440.466111] Starting dynamic subtest: pipe-C-eDP-1 [441.482893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.027s) [441.495785] Starting dynamic subtest: pipe-D-eDP-1 [442.522517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.038s) [442.524780] Subtest colorop-properties-legacy: SUCCESS (3.480s) [443.315614] [097/133] (585s left) gem_pwrite (basic-self) [443.373918] Subtest basic-self: SKIP (0.000s) [443.436177] [098/133] (585s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [443.527914] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [443.532397] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [444.652766] [099/133] (584s left) gem_exec_alignment (single) [444.708813] Starting subtest: single [444.714032] Subtest single: SUCCESS (0.003s) [444.838188] [100/133] (584s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [444.938833] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [444.941148] Starting dynamic subtest: pipe-A [444.960664] Dynamic subtest pipe-A: SKIP (0.017s) [444.973732] Starting dynamic subtest: pipe-B [444.990598] Dynamic subtest pipe-B: SKIP (0.031s) [445.002553] Starting dynamic subtest: pipe-C [445.022638] Dynamic subtest pipe-C: SKIP (0.030s) [445.034466] Starting dynamic subtest: pipe-D [445.052597] Dynamic subtest pipe-D: SKIP (0.030s) [445.056998] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.111s) [445.152383] [101/133] (584s left) i915_selftest (perf) [449.746835] Starting subtest: perf [449.751596] Starting dynamic subtest: engine_cs [454.153760] Dynamic subtest engine_cs: SUCCESS (4.409s) [454.172068] Starting dynamic subtest: request [461.442080] Dynamic subtest request: SUCCESS (7.286s) [461.454308] Starting dynamic subtest: migrate [465.789662] Dynamic subtest migrate: SUCCESS (4.346s) [465.801303] Starting dynamic subtest: region [471.756934] Dynamic subtest region: SUCCESS (5.964s) [471.759769] Subtest perf: SUCCESS (22.011s) [471.789756] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [471.790559] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [471.793812] [102/133] (557s left) kms_invalid_mode (zero-clock) [473.360522] Starting subtest: zero-clock [473.362980] Starting dynamic subtest: pipe-A-eDP-1 [473.658063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s) [473.673782] Starting dynamic subtest: pipe-B-eDP-1 [473.676191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [473.688130] Starting dynamic subtest: pipe-C-eDP-1 [473.690420] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [473.700684] Starting dynamic subtest: pipe-D-eDP-1 [473.702641] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [473.704544] Subtest zero-clock: SUCCESS (0.305s) [474.578840] [FACT kms_invalid_mode (zero-clock)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [474.580076] [FACT kms_invalid_mode (zero-clock)] new: kernel.kmod_is_loaded.i915: true [474.585270] [103/133] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [474.680985] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [474.685299] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [474.786424] [104/133] (554s left) gem_exec_schedule (implicit-write-read) [474.865946] Starting subtest: implicit-write-read [474.868807] Starting dynamic subtest: rcs0 [474.972066] Dynamic subtest rcs0: SUCCESS (0.114s) [474.990792] Starting dynamic subtest: vcs0 [475.054964] Dynamic subtest vcs0: SUCCESS (0.083s) [475.068479] Starting dynamic subtest: vcs1 [475.135317] Dynamic subtest vcs1: SUCCESS (0.080s) [475.150170] Starting dynamic subtest: vecs0 [475.209659] Dynamic subtest vecs0: SUCCESS (0.074s) [475.221389] Starting dynamic subtest: ccs0 [475.289144] Dynamic subtest ccs0: SUCCESS (0.079s) [475.291424] Subtest implicit-write-read: SUCCESS (0.433s) [476.377260] [105/133] (553s left) gem_ctx_persistence (many-contexts) [476.433864] Starting subtest: many-contexts [521.662583] Subtest many-contexts: SUCCESS (45.221s) [521.740580] [106/133] (507s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [521.841614] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [521.852476] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s) [521.940467] [107/133] (507s left) gem_ctx_param (invalid-size-set) [521.987700] Starting subtest: invalid-size-set [521.990064] Subtest invalid-size-set: SUCCESS (0.001s) [522.079340] [108/133] (507s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [522.165704] Starting subtest: primary-4-tiled-reflect-x-180 [529.149464] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.985s) [530.320372] [109/133] (499s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [530.409802] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [530.412085] Starting dynamic subtest: pipe-A-eDP-1 [530.841387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s) [530.856823] Starting dynamic subtest: pipe-B-eDP-1 [530.876993] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s) [530.890410] Starting dynamic subtest: pipe-C-eDP-1 [530.909367] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [530.920172] Starting dynamic subtest: pipe-D-eDP-1 [530.938684] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [530.940771] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.448s) [533.183484] [110/133] (496s left) core_setmaster_vs_auth [533.349782] [111/133] (496s left) drm_read (short-buffer-block) [533.510429] Starting subtest: short-buffer-block [533.513073] Subtest short-buffer-block: SUCCESS (0.000s) [533.650492] [112/133] (496s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [533.753538] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [533.758101] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [533.826875] [113/133] (495s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [533.915888] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [533.918306] Starting dynamic subtest: pipe-A-eDP-1 [533.941774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [533.955734] Starting dynamic subtest: pipe-B-eDP-1 [533.978234] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [533.988967] Starting dynamic subtest: pipe-C-eDP-1 [534.010734] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [534.021022] Starting dynamic subtest: pipe-D-eDP-1 [534.043253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [534.047226] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s) [536.158105] [114/133] (493s left) kms_feature_discovery (dp-mst) [536.259184] Starting subtest: dp-mst [536.263698] Subtest dp-mst: SKIP (0.000s) [536.336898] [115/133] (493s left) kms_psr (psr2-cursor-mmap-gtt) [536.430180] Starting subtest: psr2-cursor-mmap-gtt [536.432528] Starting dynamic subtest: eDP-1 [538.124611] Dynamic subtest eDP-1: SUCCESS (1.695s) [538.127034] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.695s) [538.923065] [116/133] (490s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [539.019304] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [547.745670] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.728s) [547.888878] [117/133] (482s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [547.993090] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [552.266997] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.278s) [553.407837] [118/133] (476s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [553.506506] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [553.508921] Starting dynamic subtest: pipe-A-default-mode [554.653898] Dynamic subtest pipe-A-default-mode: SKIP (1.144s) [554.658105] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.146s) [554.796306] [119/133] (475s left) kms_addfb_basic (bad-pitch-1024) [554.847411] Starting subtest: bad-pitch-1024 [554.849693] Subtest bad-pitch-1024: SUCCESS (0.000s) [554.994418] [120/133] (475s left) gem_exec_whisper (basic-queues-forked-all) [555.058740] Starting subtest: basic-queues-forked-all [574.486028] Subtest basic-queues-forked-all: SUCCESS (19.421s) [574.668525] [121/133] (455s left) kms_content_protection (atomic-dpms) [574.821724] Starting subtest: atomic-dpms [574.826382] Subtest atomic-dpms: SKIP (0.000s) [574.937817] [122/133] (455s left) gem_pxp (reject-modify-context-protection-off-1) [575.064405] Starting subtest: reject-modify-context-protection-off-1 [575.066951] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s) [575.170802] [123/133] (454s left) kms_big_fb (y-tiled-16bpp-rotate-90) [575.265944] Starting subtest: y-tiled-16bpp-rotate-90 [575.270259] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [575.379809] [124/133] (454s left) gem_userptr_blits (usage-restrictions) [575.436993] Starting subtest: usage-restrictions [575.439046] Subtest usage-restrictions: SUCCESS (0.000s) [575.589761] [125/133] (454s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [575.698113] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [575.701618] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [575.817369] [126/133] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [575.920490] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [575.924259] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [576.022508] [127/133] (454s left) gem_exec_reloc (basic-cpu-wc) [576.079088] Subtest basic-cpu-wc: SKIP (0.000s) [576.155467] [128/133] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [576.252182] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [576.255544] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [576.347642] [129/133] (454s left) kms_psr2_su (page_flip-p010) [576.405262] Subtest page_flip-P010: SKIP (0.000s) [576.468087] [130/133] (453s left) syncobj_eventfd (timeline-wait-signaled) [576.522870] Starting subtest: timeline-wait-signaled [576.524881] Subtest timeline-wait-signaled: SUCCESS (0.000s) [576.627186] [131/133] (453s left) kms_flip (flip-vs-panning-interruptible) [576.713156] Starting subtest: flip-vs-panning-interruptible [576.715134] Starting dynamic subtest: A-eDP1 [585.428402] Dynamic subtest A-eDP1: SUCCESS (8.712s) [585.442927] Starting dynamic subtest: B-eDP1 [594.152139] Dynamic subtest B-eDP1: SUCCESS (8.720s) [594.164129] Starting dynamic subtest: C-eDP1 [602.867250] Dynamic subtest C-eDP1: SUCCESS (8.713s) [602.879029] Starting dynamic subtest: D-eDP1 [611.498050] Dynamic subtest D-eDP1: SUCCESS (8.629s) [611.500134] Subtest flip-vs-panning-interruptible: SUCCESS (34.784s) [612.652924] [132/133] (417s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [612.748078] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [612.752580] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [613.888710] [133/133] (416s left) gem_ctx_persistence (engines-hang) [613.955034] Starting subtest: engines-hang [613.957465] Starting dynamic subtest: rcs0 [614.091402] Dynamic subtest rcs0: SUCCESS (0.135s) [614.104644] Starting dynamic subtest: bcs0 [614.137704] Dynamic subtest bcs0: SUCCESS (0.045s) [614.150089] Starting dynamic subtest: vcs0 [614.237204] Dynamic subtest vcs0: SUCCESS (0.097s) [614.250333] Starting dynamic subtest: vcs1 [614.352288] Dynamic subtest vcs1: SUCCESS (0.113s) [614.366448] Starting dynamic subtest: vecs0 [614.461799] Dynamic subtest vecs0: SUCCESS (0.108s) [614.475890] Starting dynamic subtest: ccs0 [614.569781] Dynamic subtest ccs0: SUCCESS (0.106s) [614.572746] Subtest engines-hang: SUCCESS (0.616s) [614.649374] Closing watchdogs results: parsing output: 0/ for test: kms_vblank results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: prime_busy results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_whisper results: parsing output: 7/ for test: gem_exec_async results: parsing output: 8/ for test: gem_exec_fence results: parsing output: 9/ for test: core_setmaster results: parsing output: 10/ for test: kms_pm_backlight results: parsing output: 11/ for test: gem_fence_thrash results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: gen9_exec_parse results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_getfb results: parsing output: 17/ for test: kms_properties results: parsing output: 18/ for test: gem_fence_thrash results: parsing output: 19/ for test: gem_spin_batch results: parsing output: 20/ for test: gem_exec_reloc results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_dp_link_training results: parsing output: 24/ for test: gem_userptr_blits results: parsing output: 25/ for test: kms_async_flips results: parsing output: 26/ for test: gem_eio results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: kms_vblank results: parsing output: 29/ for test: gem_exec_create results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: i915_pm_rps results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_params results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_cursor_crc results: parsing output: 37/ for test: gem_fenced_exec_thrash results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: kms_plane results: parsing output: 41/ for test: kms_addfb_basic results: parsing output: 42/ for test: gem_render_copy results: parsing output: 43/ for test: perf_pmu results: parsing output: 44/ for test: kms_chamelium_hpd results: parsing output: 45/ for test: kms_cursor_edge_walk results: parsing output: 46/ for test: gem_exec_reloc results: parsing output: 47/ for test: gem_mmap_gtt results: parsing output: 48/ for test: gem_softpin results: parsing output: 49/ for test: kms_cursor_crc results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_exec_balancer results: parsing output: 53/ for test: sysfs_heartbeat_interval results: parsing output: 54/ for test: kms_psr2_sf results: parsing output: 55/ for test: kms_pipe_stress results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: perf_pmu results: parsing output: 59/ for test: i915_drm_fdinfo results: parsing output: 60/ for test: gem_exec_reloc results: parsing output: 61/ for test: gem_mmap results: parsing output: 62/ for test: gem_exec_endless results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: gem_compute results: parsing output: 65/ for test: kms_pm_dc results: parsing output: 66/ for test: api_intel_allocator results: parsing output: 67/ for test: gem_userptr_blits results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: gem_busy results: parsing output: 70/ for test: i915_drm_fdinfo results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_color_pipeline results: parsing output: 73/ for test: prime_mmap_kms results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: kms_busy results: parsing output: 77/ for test: syncobj_wait results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_prop_blob results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_plane_multiple results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: gem_exec_parallel results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_cursor_legacy results: parsing output: 86/ for test: gem_mmap_offset results: parsing output: 87/ for test: api_intel_bb results: parsing output: 88/ for test: kms_rotation_crc results: parsing output: 89/ for test: kms_cursor_legacy results: parsing output: 90/ for test: kms_chamelium_frames results: parsing output: 91/ for test: gem_render_copy results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: perf results: parsing output: 94/ for test: kms_lease results: parsing output: 95/ for test: kms_properties results: parsing output: 96/ for test: gem_pwrite results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: gem_exec_alignment results: parsing output: 99/ for test: kms_plane_scaling results: parsing output: 100/ for test: i915_selftest results: parsing output: 101/ for test: kms_invalid_mode results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_exec_schedule results: parsing output: 104/ for test: gem_ctx_persistence results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: gem_ctx_param results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: core_setmaster_vs_auth results: parsing output: 110/ for test: drm_read results: parsing output: 111/ for test: kms_flip_scaled_crc results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_feature_discovery results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_flip_scaled_crc results: parsing output: 118/ for test: kms_addfb_basic results: parsing output: 119/ for test: gem_exec_whisper results: parsing output: 120/ for test: kms_content_protection results: parsing output: 121/ for test: gem_pxp results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: gem_userptr_blits results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_psr2_su results: parsing output: 129/ for test: syncobj_eventfd results: parsing output: 130/ for test: kms_flip results: parsing output: 131/ for test: kms_ccs results: parsing output: 132/ for test: gem_ctx_persistence Done.