[56.448513] Initializing watchdogs [56.448561] /dev/watchdog0 [56.461472] [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] [56.465430] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.467555] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.470836] [001/130] (960s left) kms_psr (fbc-psr2-cursor-blt) [56.636002] Starting subtest: fbc-psr2-cursor-blt [56.638582] Starting dynamic subtest: eDP-1 [56.643062] Dynamic subtest eDP-1: SKIP (0.000s) [56.647518] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [56.701465] [002/130] (960s left) gem_sync (basic-all) [56.789316] Starting subtest: basic-all [61.873286] Subtest basic-all: SUCCESS (5.019s) [62.050210] [003/130] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [62.167683] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [62.171973] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [62.261778] [004/130] (954s left) gem_exec_flush (basic-uc-pro-default) [62.330952] Starting subtest: basic-uc-pro-default [67.843134] Subtest basic-uc-pro-default: SUCCESS (5.477s) [68.022273] [005/130] (949s left) kms_atomic (test-only) [68.132035] Starting subtest: test-only [68.222994] Starting dynamic subtest: pipe-A-eDP-1 [70.754954] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.521s) [70.757307] Subtest test-only: SUCCESS (2.611s) [71.554482] [006/130] (945s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [71.641426] Starting subtest: multi-wait-available-unsubmitted-signaled [71.643800] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [71.760907] [007/130] (945s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [71.939642] Starting subtest: fbc-farfromfence-mmap-gtt [71.943923] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [72.109802] [008/130] (945s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [72.202999] Starting subtest: primary-y-tiled-reflect-x-180 [72.267663] Subtest primary-y-tiled-reflect-x-180: SKIP (0.061s) [72.355186] [009/130] (945s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [72.472899] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [72.477270] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [72.565928] [010/130] (944s left) gem_exec_capture (capture-recoverable) [72.619686] Starting subtest: capture-recoverable [72.622181] Subtest capture-recoverable: SUCCESS (0.003s) [72.730943] [011/130] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [72.828260] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [72.832413] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [72.926218] [012/130] (944s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [73.018397] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [73.020740] Starting dynamic subtest: A-eDP1 [81.998870] Dynamic subtest A-eDP1: SUCCESS (8.967s) [82.007021] Starting dynamic subtest: B-eDP1 [90.925845] Dynamic subtest B-eDP1: SUCCESS (8.919s) [90.933976] Starting dynamic subtest: C-eDP1 [99.836560] Dynamic subtest C-eDP1: SUCCESS (8.905s) [99.845271] Starting dynamic subtest: D-eDP1 [108.770926] Dynamic subtest D-eDP1: SUCCESS (8.931s) [108.777062] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.731s) [109.985286] [013/130] (907s left) kms_flip (basic-flip-vs-wf_vblank) [110.081789] Starting subtest: basic-flip-vs-wf_vblank [110.084262] Starting dynamic subtest: A-eDP1 [112.036962] Dynamic subtest A-eDP1: SUCCESS (1.955s) [112.045848] Starting dynamic subtest: B-eDP1 [113.966077] Dynamic subtest B-eDP1: SUCCESS (1.928s) [113.974850] Starting dynamic subtest: C-eDP1 [115.880371] Dynamic subtest C-eDP1: SUCCESS (1.913s) [115.889231] Starting dynamic subtest: D-eDP1 [117.800246] Dynamic subtest D-eDP1: SUCCESS (1.919s) [117.802455] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.720s) [119.009027] [014/130] (898s left) kms_busy (extended-modeset-hang-newfb-with-reset) [119.110440] Starting subtest: extended-modeset-hang-newfb-with-reset [119.112464] Starting dynamic subtest: pipe-A [132.771958] Dynamic subtest pipe-A: SUCCESS (13.658s) [132.781112] Starting dynamic subtest: pipe-D [148.634203] Dynamic subtest pipe-D: SUCCESS (15.859s) [148.636866] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.520s) [149.425326] [015/130] (868s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [149.508987] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [149.511544] Starting dynamic subtest: pipe-A-eDP-1 [149.942884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s) [149.952703] Starting dynamic subtest: pipe-B-eDP-1 [151.316965] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s) [151.325477] Starting dynamic subtest: pipe-C-eDP-1 [152.715797] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s) [152.724764] Starting dynamic subtest: pipe-D-eDP-1 [154.039279] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [154.041145] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.499s) [155.212789] [016/130] (862s left) gem_eio (in-flight-immediate) [155.419551] Starting subtest: in-flight-immediate [163.475860] Subtest in-flight-immediate: SUCCESS (8.057s) [163.639758] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true [163.643058] [017/130] (854s left) syncobj_timeline (multi-wait-signaled) [163.704067] Starting subtest: multi-wait-signaled [163.706290] Subtest multi-wait-signaled: SUCCESS (0.001s) [163.787674] [018/130] (853s left) kms_big_fb (yf-tiled-addfb) [163.899057] Starting subtest: yf-tiled-addfb [163.903471] Subtest yf-tiled-addfb: SKIP (0.000s) [163.996551] [019/130] (853s left) prime_self_import (basic-llseek-size) [164.029134] Starting subtest: basic-llseek-size [164.041124] Subtest basic-llseek-size: SUCCESS (0.012s) [164.140098] [020/130] (853s left) i915_pm_rpm (gem-execbuf-stress) [166.074038] Starting subtest: gem-execbuf-stress [166.076851] Starting dynamic subtest: smem0 [179.705864] Dynamic subtest smem0: SUCCESS (13.630s) [179.716687] Starting dynamic subtest: extra-wait-smem0 [241.892980] Dynamic subtest extra-wait-smem0: SUCCESS (62.180s) [241.895803] Subtest gem-execbuf-stress: SUCCESS (75.813s) [242.249606] [021/130] (775s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [242.346909] Starting subtest: addfb25-y-tiled-small-legacy [242.351283] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [242.443456] [022/130] (775s left) gem_exec_schedule (submit-early-slice) [242.517420] Starting subtest: submit-early-slice [242.519745] Starting dynamic subtest: rcs0 [242.553829] Dynamic subtest rcs0: SUCCESS (0.043s) [242.561763] Starting dynamic subtest: bcs0 [242.597479] Dynamic subtest bcs0: SUCCESS (0.043s) [242.605090] Starting dynamic subtest: vcs0 [242.634585] Dynamic subtest vcs0: SUCCESS (0.037s) [242.644382] Starting dynamic subtest: vcs1 [242.678171] Dynamic subtest vcs1: SUCCESS (0.043s) [242.685966] Starting dynamic subtest: vecs0 [242.711922] Dynamic subtest vecs0: SUCCESS (0.034s) [242.719183] Starting dynamic subtest: ccs0 [242.755761] Dynamic subtest ccs0: SUCCESS (0.044s) [242.758072] Subtest submit-early-slice: SUCCESS (0.246s) [244.060296] [023/130] (773s left) gem_pxp (create-valid-protected-context) [244.190055] Starting subtest: create-valid-protected-context [244.192707] Subtest create-valid-protected-context: SUCCESS (0.002s) [244.305994] [024/130] (773s left) gem_eio (context-create) [244.515355] Starting subtest: context-create [244.825157] Subtest context-create: SUCCESS (0.309s) [244.932497] [025/130] (773s left) gen9_exec_parse (allowed-all) [244.987511] Subtest allowed-all: SKIP (0.000s) [245.059563] [026/130] (772s left) perf_pmu (busy-idle-no-semaphores) [245.098690] Starting subtest: busy-idle-no-semaphores [245.100619] Starting dynamic subtest: rcs0 [245.762927] Dynamic subtest rcs0: SUCCESS (0.662s) [245.773927] Starting dynamic subtest: bcs0 [246.413525] Dynamic subtest bcs0: SUCCESS (0.649s) [246.422445] Starting dynamic subtest: vcs0 [247.064081] Dynamic subtest vcs0: SUCCESS (0.650s) [247.074797] Starting dynamic subtest: vcs1 [248.532548] Dynamic subtest vcs1: SUCCESS (1.467s) [248.542481] Starting dynamic subtest: vecs0 [250.518432] Dynamic subtest vecs0: SUCCESS (1.985s) [250.529760] Starting dynamic subtest: ccs0 [252.565096] Dynamic subtest ccs0: SUCCESS (2.045s) [252.567986] Subtest busy-idle-no-semaphores: SUCCESS (7.464s) [252.673505] [027/130] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [252.785022] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [257.102288] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.318s) [257.222671] [028/130] (760s left) kms_addfb_basic (invalid-set-prop-any) [257.285805] Starting subtest: invalid-set-prop-any [257.288075] Subtest invalid-set-prop-any: SUCCESS (0.000s) [257.436249] [029/130] (760s left) kms_cursor_edge_walk (256x256-top-edge) [257.528037] Starting subtest: 256x256-top-edge [257.530367] Starting dynamic subtest: pipe-A-eDP-1 [260.942861] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.411s) [260.952681] Starting dynamic subtest: pipe-D-eDP-1 [264.055901] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s) [264.058298] Subtest 256x256-top-edge: SUCCESS (6.525s) [264.860939] [030/130] (753s left) fbdev (info) [264.897094] Starting subtest: info [264.899073] Subtest info: SUCCESS (0.000s) [264.957546] [031/130] (753s left) kms_content_protection (lic-type-1) [265.137032] Starting subtest: lic-type-1 [268.487176] Subtest lic-type-1: SKIP (3.348s) [269.652124] [032/130] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [269.750963] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [269.755412] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [269.857409] [033/130] (748s left) kms_feature_discovery (display-3x) [269.958968] Starting subtest: display-3x [269.963089] Subtest display-3x: SKIP (0.000s) [270.029673] [034/130] (748s left) kms_psr (pr-cursor-blt) [270.127844] Starting subtest: pr-cursor-blt [270.132510] Subtest pr-cursor-blt: SKIP (0.000s) [270.196916] [035/130] (748s left) kms_big_fb (linear-8bpp-rotate-180) [270.307769] Starting subtest: linear-8bpp-rotate-180 [271.587849] Subtest linear-8bpp-rotate-180: SUCCESS (1.280s) [271.704179] [036/130] (746s left) kms_lease (lease-unleased-connector) [271.799574] Starting subtest: lease-unleased-connector [271.801531] Starting dynamic subtest: pipe-A-eDP-1 [271.812125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.010s) [271.820726] Starting dynamic subtest: pipe-B-eDP-1 [271.822535] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [271.831569] Starting dynamic subtest: pipe-C-eDP-1 [271.835943] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [271.844496] Starting dynamic subtest: pipe-D-eDP-1 [271.848888] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [271.850485] Subtest lease-unleased-connector: SUCCESS (0.047s) [271.949658] [037/130] (746s left) prime_self_import (basic-with_fd_dup) [271.984130] Starting subtest: basic-with_fd_dup [272.007662] Subtest basic-with_fd_dup: SUCCESS (0.022s) [272.087488] [038/130] (746s left) kms_writeback (writeback-invalid-parameters) [272.176153] Subtest writeback-invalid-parameters: SKIP (0.000s) [272.213759] [039/130] (746s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [272.267543] Starting subtest: etime-multi-wait-for-submit-unsubmitted [272.368948] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s) [272.436394] [040/130] (746s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [272.532718] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [272.534768] Starting dynamic subtest: pipe-A [274.133168] Dynamic subtest pipe-A: SUCCESS (1.600s) [274.141889] Starting dynamic subtest: pipe-B [276.715016] Dynamic subtest pipe-B: SUCCESS (2.581s) [276.724859] Starting dynamic subtest: pipe-C [277.863761] Dynamic subtest pipe-C: SUCCESS (1.148s) [277.871496] Starting dynamic subtest: pipe-D [279.075967] Dynamic subtest pipe-D: SUCCESS (1.211s) [279.078349] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.543s) [280.262609] [041/130] (738s left) gem_mmap_gtt (big-bo) [280.318347] Subtest big-bo: SKIP (0.000s) [280.378719] [042/130] (738s left) kms_addfb_basic (size-max) [280.481773] Starting subtest: size-max [280.484148] Subtest size-max: SUCCESS (0.000s) [280.578267] [043/130] (737s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [280.632108] Starting subtest: etime-single-wait-available-unsubmitted [280.737733] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s) [280.807573] [044/130] (737s left) drm_read (empty-nonblock) [280.965020] Starting subtest: empty-nonblock [280.967294] Subtest empty-nonblock: SUCCESS (0.000s) [281.097496] [045/130] (737s left) gem_spin_batch (engines) [281.158425] Starting subtest: engines [281.160639] Starting dynamic subtest: rcs0 [284.397760] Dynamic subtest rcs0: SUCCESS (3.233s) [284.411689] Starting dynamic subtest: bcs0 [287.634990] Dynamic subtest bcs0: SUCCESS (3.233s) [287.645038] Starting dynamic subtest: vcs0 [290.869210] Dynamic subtest vcs0: SUCCESS (3.233s) [290.877191] Starting dynamic subtest: vcs1 [294.107050] Dynamic subtest vcs1: SUCCESS (3.235s) [294.117773] Starting dynamic subtest: vecs0 [297.343814] Dynamic subtest vecs0: SUCCESS (3.235s) [297.352868] Starting dynamic subtest: ccs0 [300.580395] Dynamic subtest ccs0: SUCCESS (3.234s) [300.582621] Subtest engines: SUCCESS (19.417s) [300.833131] [046/130] (717s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [300.940237] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [302.196672] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.258s) [302.383594] [047/130] (716s left) gem_create (hog-create) [302.440622] Starting subtest: hog-create [302.443070] Starting dynamic subtest: smem0 [335.951387] Dynamic subtest smem0: SUCCESS (33.508s) [335.954113] Subtest hog-create: SUCCESS (33.509s) [336.132254] [048/130] (682s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [336.263647] Starting subtest: 2x-long-flip-vs-cursor-atomic [336.267993] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [336.358951] [049/130] (682s left) gem_exec_reloc (basic-cpu-read-active) [336.433059] Subtest basic-cpu-read-active: SKIP (0.000s) [336.512216] [050/130] (682s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [341.521657] Starting subtest: psr2-overlay-plane-update-continuous-sf [341.523823] Starting dynamic subtest: pipe-A-eDP-1 [343.277556] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s) [343.285813] Starting dynamic subtest: pipe-B-eDP-1 [344.998349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.720s) [345.000807] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.478s) [345.821121] [051/130] (673s left) gem_exec_schedule (lateslice) [345.899654] Starting subtest: lateslice [345.902022] Starting dynamic subtest: rcs0 [345.908075] Dynamic subtest rcs0: SUCCESS (0.018s) [345.918846] Starting dynamic subtest: bcs0 [345.923420] Dynamic subtest bcs0: SUCCESS (0.015s) [345.931477] Starting dynamic subtest: vcs0 [345.938500] Dynamic subtest vcs0: SUCCESS (0.016s) [345.946512] Starting dynamic subtest: vcs1 [345.958980] Dynamic subtest vcs1: SUCCESS (0.020s) [345.967414] Starting dynamic subtest: vecs0 [345.974987] Dynamic subtest vecs0: SUCCESS (0.016s) [345.982431] Starting dynamic subtest: ccs0 [345.992229] Dynamic subtest ccs0: SUCCESS (0.016s) [345.994383] Subtest lateslice: SUCCESS (0.104s) [348.040167] [052/130] (670s left) prime_vgem (shrink) [348.121434] Starting subtest: shrink [348.153730] Subtest shrink: SUCCESS (0.026s) [348.261550] [053/130] (670s left) kms_async_flips (crc) [348.362247] Starting subtest: crc [348.724334] Starting dynamic subtest: pipe-A-eDP-1 [351.615325] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.893s) [351.980073] Starting dynamic subtest: pipe-B-eDP-1 [354.850480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.878s) [355.232059] Starting dynamic subtest: pipe-C-eDP-1 [358.046760] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.824s) [358.407150] Starting dynamic subtest: pipe-D-eDP-1 [361.289335] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.891s) [361.291618] Subtest crc: SUCCESS (12.925s) [362.447091] [054/130] (656s left) kms_big_fb (y-tiled-8bpp-rotate-270) [362.549099] Starting subtest: y-tiled-8bpp-rotate-270 [362.553520] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [362.653975] [055/130] (656s left) gem_exec_whisper (basic-sync-all) [362.720547] Starting subtest: basic-sync-all [369.619765] Subtest basic-sync-all: SUCCESS (6.896s) [369.795289] [056/130] (649s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [369.899148] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [369.901548] Starting dynamic subtest: pipe-A-eDP-1 [370.783970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.874s) [370.792776] Starting dynamic subtest: pipe-B-eDP-1 [372.252026] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s) [372.261065] Starting dynamic subtest: pipe-C-eDP-1 [373.744772] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.495s) [373.753107] Starting dynamic subtest: pipe-D-eDP-1 [375.169196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s) [375.171121] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.259s) [376.342964] [057/130] (642s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [376.446701] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [381.636504] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.192s) [381.752682] [058/130] (637s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [381.855417] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [381.857804] Starting dynamic subtest: pipe-A-eDP-1 [382.590897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s) [382.599835] Starting dynamic subtest: pipe-B-eDP-1 [384.424266] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.832s) [384.433606] Starting dynamic subtest: pipe-C-eDP-1 [386.249989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.824s) [386.259416] Starting dynamic subtest: pipe-D-eDP-1 [388.079063] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s) [388.081094] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.215s) [389.294822] [059/130] (629s left) gem_mmap_offset (bad-extensions) [389.360275] Starting subtest: bad-extensions [389.362650] Subtest bad-extensions: SUCCESS (0.000s) [389.469428] [060/130] (629s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [389.566779] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [389.569148] Starting dynamic subtest: pipe-A-default-mode [389.881321] Dynamic subtest pipe-A-default-mode: SKIP (0.311s) [389.885876] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.312s) [390.719026] [061/130] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [390.825118] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [390.829677] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [390.909842] [062/130] (628s left) gem_exec_reloc (basic-cpu-gtt) [390.977969] Subtest basic-cpu-gtt: SKIP (0.000s) [391.052426] [063/130] (628s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [391.156096] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [391.158296] Starting dynamic subtest: pipe-A-eDP-1 [391.651193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s) [391.662092] Starting dynamic subtest: pipe-B-eDP-1 [391.682955] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [391.691587] Starting dynamic subtest: pipe-C-eDP-1 [391.711118] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [391.718811] Starting dynamic subtest: pipe-D-eDP-1 [391.738670] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [391.740637] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.507s) [393.873803] [064/130] (625s left) api_intel_allocator (reloc-allocator) [393.929726] Starting subtest: reloc-allocator [393.931708] Starting dynamic subtest: basic [393.934138] Dynamic subtest basic: SUCCESS (0.003s) [393.942412] Starting dynamic subtest: parallel-one [393.944711] Dynamic subtest parallel-one: SUCCESS (0.008s) [393.953786] Starting dynamic subtest: print [393.955795] Dynamic subtest print: SUCCESS (0.000s) [393.963864] Starting dynamic subtest: reuse [393.966196] Dynamic subtest reuse: SUCCESS (0.000s) [393.973971] Starting dynamic subtest: fork-reopen-allocator [393.976308] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [393.978569] Subtest reloc-allocator: SUCCESS (0.030s) [394.083452] [065/130] (625s left) drm_read (fault-buffer) [394.247052] Starting subtest: fault-buffer [394.249540] Subtest fault-buffer: SUCCESS (0.001s) [394.378516] [066/130] (624s left) gem_exec_nop (basic-series) [394.459063] Starting subtest: basic-series [410.929420] Subtest basic-series: SUCCESS (16.476s) [411.146123] [067/130] (608s left) kms_flip (dpms-vs-vblank-race-interruptible) [411.252592] Starting subtest: dpms-vs-vblank-race-interruptible [411.254825] Starting dynamic subtest: A-eDP1 [416.226291] Dynamic subtest A-eDP1: SUCCESS (4.971s) [416.236872] Starting dynamic subtest: B-eDP1 [420.826452] Dynamic subtest B-eDP1: SUCCESS (4.599s) [420.837813] Starting dynamic subtest: C-eDP1 [425.312282] Dynamic subtest C-eDP1: SUCCESS (4.484s) [425.321622] Starting dynamic subtest: D-eDP1 [429.814814] Dynamic subtest D-eDP1: SUCCESS (4.502s) [429.817664] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.562s) [430.595143] [068/130] (588s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [430.699104] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [431.744728] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.046s) [431.939755] [069/130] (587s left) syncobj_wait (single-wait-all-signaled) [432.000858] Starting subtest: single-wait-all-signaled [432.002812] Subtest single-wait-all-signaled: SUCCESS (0.000s) [432.105151] [070/130] (587s left) i915_hangman (engine-engine-error) [432.172205] Starting subtest: engine-engine-error [432.174523] Starting dynamic subtest: rcs0 [433.867095] Dynamic subtest rcs0: SUCCESS (1.693s) [433.876651] Starting dynamic subtest: bcs0 [435.916554] Dynamic subtest bcs0: SUCCESS (2.047s) [435.927057] Starting dynamic subtest: vcs0 [437.899753] Dynamic subtest vcs0: SUCCESS (1.981s) [437.909648] Starting dynamic subtest: vcs1 [439.884403] Dynamic subtest vcs1: SUCCESS (1.982s) [439.896871] Starting dynamic subtest: vecs0 [441.867355] Dynamic subtest vecs0: SUCCESS (1.980s) [441.878968] Starting dynamic subtest: ccs0 [443.916395] Dynamic subtest ccs0: SUCCESS (2.047s) [443.919458] Subtest engine-engine-error: SUCCESS (11.743s) [443.988666] [071/130] (575s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [444.085115] Starting subtest: sprite-rotation-90-pos-100-0 [444.089524] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [444.155445] [072/130] (575s left) gem_exec_create (forked) [444.221565] Starting subtest: forked [444.223919] Starting dynamic subtest: smem [464.426547] Dynamic subtest smem: SUCCESS (20.203s) [464.428901] Subtest forked: SUCCESS (20.204s) [464.603949] [073/130] (554s left) sysfs_heartbeat_interval (precise) [464.681077] Starting subtest: precise [464.683498] Starting dynamic subtest: vecs0 [471.914316] Dynamic subtest vecs0: SUCCESS (7.232s) [471.929099] Starting dynamic subtest: ccs0 [473.119560] Dynamic subtest ccs0: SUCCESS (1.203s) [473.129437] Starting dynamic subtest: vcs0 [480.956332] Dynamic subtest vcs0: SUCCESS (7.835s) [480.967525] Starting dynamic subtest: bcs0 [483.923424] Dynamic subtest bcs0: SUCCESS (2.965s) [483.934693] Starting dynamic subtest: rcs0 [485.010312] Dynamic subtest rcs0: SUCCESS (1.085s) [485.021458] Starting dynamic subtest: vcs1 [492.939657] Dynamic subtest vcs1: SUCCESS (7.924s) [492.943346] Subtest precise: SUCCESS (28.255s) [493.008884] [074/130] (526s left) kms_psr (fbc-psr2-suspend) [493.109833] Starting subtest: fbc-psr2-suspend [493.112077] Starting dynamic subtest: eDP-1 [493.116222] Dynamic subtest eDP-1: SKIP (0.000s) [493.120531] Subtest fbc-psr2-suspend: SKIP (0.001s) [493.180540] [075/130] (526s left) kms_joiner (invalid-modeset-force-ultra-joiner) [493.278727] Starting subtest: invalid-modeset-force-ultra-joiner [493.283235] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [493.338015] [076/130] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [493.456654] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [493.460785] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [493.559642] [077/130] (526s left) gem_exec_fence (syncobj-timeline-chain-engines) [494.137121] Starting subtest: syncobj-timeline-chain-engines [494.250641] Subtest syncobj-timeline-chain-engines: SUCCESS (0.114s) [496.020172] [078/130] (523s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [496.074806] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [496.178250] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [496.248446] [079/130] (523s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [496.352700] Starting subtest: primary-4-tiled-reflect-x-180 [503.306270] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.950s) [504.443682] [080/130] (515s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [509.501224] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [509.505844] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s) [510.355611] [081/130] (509s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [510.463369] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [515.760113] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.298s) [515.909890] [082/130] (503s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [515.996080] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [515.998360] Starting dynamic subtest: pipe-A-eDP-1 [516.020996] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [516.029174] Starting dynamic subtest: pipe-B-eDP-1 [516.050545] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [516.058346] Starting dynamic subtest: pipe-C-eDP-1 [516.080168] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [516.087817] Starting dynamic subtest: pipe-D-eDP-1 [516.109705] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [516.114172] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [518.160673] [083/130] (501s left) kms_color (degamma) [518.263067] Starting subtest: degamma [518.265263] Starting dynamic subtest: pipe-A-eDP-1 [518.980871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s) [518.991705] Starting dynamic subtest: pipe-B-eDP-1 [520.345489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.364s) [520.354402] Starting dynamic subtest: pipe-C-eDP-1 [521.718316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s) [521.728396] Starting dynamic subtest: pipe-D-eDP-1 [523.046168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s) [523.048760] Subtest degamma: SUCCESS (4.782s) [523.863525] [084/130] (496s left) kms_cursor_crc (cursor-random-max-size) [524.153382] Starting subtest: cursor-random-max-size [524.160305] Subtest cursor-random-max-size: SKIP (0.000s) [524.305934] [085/130] (495s left) gem_ctx_bad_destroy (invalid-ctx) [524.376767] Starting subtest: invalid-ctx [524.378676] Subtest invalid-ctx: SUCCESS (0.000s) [524.440947] [086/130] (495s left) kms_prop_blob (invalid-get-prop) [524.506685] Starting subtest: invalid-get-prop [524.509083] Subtest invalid-get-prop: SUCCESS (0.000s) [524.616961] [087/130] (495s left) gem_exec_reloc (basic-write-gtt) [524.678882] Subtest basic-write-gtt: SKIP (0.000s) [524.763098] [088/130] (495s left) gem_mmap_gtt (flink-race) [524.821054] Subtest flink-race: SKIP (0.000s) [524.871546] [089/130] (495s left) i915_pm_rpm (gem-execbuf) [527.121188] Starting subtest: gem-execbuf [527.124045] Starting dynamic subtest: smem0 [528.793391] Dynamic subtest smem0: SUCCESS (1.671s) [528.795783] Subtest gem-execbuf: SUCCESS (1.673s) [528.874508] [090/130] (491s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [528.977219] Starting subtest: psr-rgb101010-draw-render [534.126842] Subtest psr-rgb101010-draw-render: SUCCESS (5.151s) [534.243917] [091/130] (485s left) kms_cursor_crc (cursor-sliding-64x64) [534.406338] Starting subtest: cursor-sliding-64x64 [534.412227] Starting dynamic subtest: pipe-A-eDP-1 [537.931585] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.521s) [537.955704] Starting dynamic subtest: pipe-D-eDP-1 [541.966940] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.018s) [541.969239] Subtest cursor-sliding-64x64: SUCCESS (7.561s) [542.838143] [092/130] (477s left) kms_chamelium_frames (hdmi-aspect-ratio) [543.229284] Subtest hdmi-aspect-ratio: SKIP (0.000s) [544.044969] [093/130] (476s left) kms_plane_scaling (planes-upscale-factor-0-25) [544.139137] Starting subtest: planes-upscale-factor-0-25 [544.141490] Starting dynamic subtest: pipe-A [544.206079] Dynamic subtest pipe-A: SUCCESS (0.067s) [544.215664] Starting dynamic subtest: pipe-B [545.392379] Dynamic subtest pipe-B: SUCCESS (1.185s) [545.401935] Starting dynamic subtest: pipe-C [546.489702] Dynamic subtest pipe-C: SUCCESS (1.096s) [546.498199] Starting dynamic subtest: pipe-D [547.608721] Dynamic subtest pipe-D: SUCCESS (1.119s) [547.611098] Subtest planes-upscale-factor-0-25: SUCCESS (3.470s) [548.749726] [094/130] (471s left) syncobj_wait (invalid-reset-one-illegal-handle) [548.811811] Starting subtest: invalid-reset-one-illegal-handle [548.813780] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [548.893482] [095/130] (471s left) gem_ctx_persistence (legacy-engines-mixed-process) [548.961223] Starting subtest: legacy-engines-mixed-process [548.963652] Starting dynamic subtest: render [550.982874] Dynamic subtest render: SUCCESS (2.018s) [550.993716] Starting dynamic subtest: bsd1 [552.925065] Dynamic subtest bsd1: SUCCESS (1.942s) [552.934336] Starting dynamic subtest: bsd2 [554.962482] Dynamic subtest bsd2: SUCCESS (2.035s) [554.973065] Starting dynamic subtest: blt [556.939344] Dynamic subtest blt: SUCCESS (1.974s) [556.950485] Starting dynamic subtest: vebox [558.974223] Dynamic subtest vebox: SUCCESS (2.029s) [558.976724] Subtest legacy-engines-mixed-process: SUCCESS (10.011s) [559.044399] [096/130] (461s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [559.099607] Starting subtest: invalid-multi-wait-unsubmitted-signaled [559.101893] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [559.188744] [097/130] (461s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [559.298076] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [562.788260] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.494s) [562.920928] [098/130] (457s left) core_setmaster (master-drop-set-shared-fd) [564.990895] Starting subtest: master-drop-set-shared-fd [565.010521] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [565.039562] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.amdgpu: true [565.040211] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.xe: true [565.043547] [099/130] (455s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [565.105672] Starting subtest: yf-tiled-to-vebox-yf-tiled [565.110467] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [565.284342] [100/130] (455s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [565.393616] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [565.397874] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [565.510565] [101/130] (455s left) gem_ctx_persistence (heartbeat-stop) [565.574592] Starting subtest: heartbeat-stop [565.579123] Subtest heartbeat-stop: SKIP (0.000s) [565.668583] [102/130] (454s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [565.762316] Starting subtest: fbc-rgb565-draw-mmap-cpu [568.729907] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.970s) [568.853596] [103/130] (451s left) gem_exec_params (no-blt) [568.915012] Starting subtest: no-blt [568.919483] Subtest no-blt: SUCCESS (0.003s) [569.038637] [104/130] (451s left) kms_plane_alpha_blend (alpha-opaque-fb) [569.136758] Starting subtest: alpha-opaque-fb [569.548305] Starting dynamic subtest: pipe-A-eDP-1 [570.149589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s) [570.158245] Starting dynamic subtest: pipe-D-eDP-1 [571.447378] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s) [571.449710] Subtest alpha-opaque-fb: SUCCESS (2.311s) [572.258544] [105/130] (448s left) prime_busy (after-wait) [572.309311] Starting subtest: after-wait [572.314996] Starting dynamic subtest: rcs0 [572.358955] Dynamic subtest rcs0: SUCCESS (0.046s) [572.368454] Starting dynamic subtest: bcs0 [572.399232] Dynamic subtest bcs0: SUCCESS (0.040s) [572.407969] Starting dynamic subtest: vcs0 [572.438619] Dynamic subtest vcs0: SUCCESS (0.039s) [572.446897] Starting dynamic subtest: vcs1 [572.478738] Dynamic subtest vcs1: SUCCESS (0.039s) [572.486983] Starting dynamic subtest: vecs0 [572.518720] Dynamic subtest vecs0: SUCCESS (0.039s) [572.526864] Starting dynamic subtest: ccs0 [572.558357] Dynamic subtest ccs0: SUCCESS (0.039s) [572.668045] Subtest after-wait: SUCCESS (0.357s) [572.736338] [106/130] (447s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt) [572.846709] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt [572.851026] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [572.925720] [107/130] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [573.022657] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [578.137618] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (5.118s) [578.266957] [108/130] (442s left) kms_frontbuffer_tracking (fbc-tiling-linear) [578.372181] Starting subtest: fbc-tiling-linear [581.102295] Subtest fbc-tiling-linear: SUCCESS (2.734s) [581.232672] [109/130] (439s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [581.329579] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [584.358732] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (3.035s) [584.466095] [110/130] (436s left) kms_vblank (ts-continuation-suspend) [584.563832] Starting subtest: ts-continuation-suspend [584.566265] Starting dynamic subtest: pipe-A-eDP-1 [600.628940] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.531s) [600.643597] Starting dynamic subtest: pipe-D-eDP-1 [617.579301] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.105s) [617.581502] Subtest ts-continuation-suspend: SUCCESS (3.644s) [618.465927] [111/130] (431s left) gem_exec_await (wide-contexts) [618.655681] Starting subtest: wide-contexts [642.364076] Subtest wide-contexts: SUCCESS (23.470s) [642.557650] [112/130] (408s left) kms_psr (psr-sprite-render) [642.712480] Starting subtest: psr-sprite-render [642.714890] Starting dynamic subtest: eDP-1 [644.429180] Dynamic subtest eDP-1: SUCCESS (1.715s) [644.431671] Subtest psr-sprite-render: SUCCESS (1.716s) [645.263910] [113/130] (405s left) kms_dp_link_training (uhbr-sst) [645.360598] Starting subtest: uhbr-sst [645.369856] Subtest uhbr-sst: SKIP (0.000s) [645.431626] [114/130] (405s left) kms_flip (absolute-wf_vblank) [645.536245] Starting subtest: absolute-wf_vblank [645.538504] Starting dynamic subtest: A-eDP1 [654.324891] Dynamic subtest A-eDP1: SUCCESS (8.787s) [654.334300] Starting dynamic subtest: B-eDP1 [663.055946] Dynamic subtest B-eDP1: SUCCESS (8.730s) [663.066179] Starting dynamic subtest: C-eDP1 [671.766122] Dynamic subtest C-eDP1: SUCCESS (8.707s) [671.775456] Starting dynamic subtest: D-eDP1 [680.499744] Dynamic subtest D-eDP1: SUCCESS (8.730s) [680.502332] Subtest absolute-wf_vblank: SUCCESS (34.962s) [681.709596] [115/130] (368s left) kms_setmode (invalid-clone-exclusive-crtc) [681.767293] Starting subtest: invalid-clone-exclusive-crtc [681.774324] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [681.874590] [116/130] (368s left) drm_fdinfo (all-busy-idle-check-all) [681.916764] Starting subtest: all-busy-idle-check-all [681.923660] Subtest all-busy-idle-check-all: SKIP (0.004s) [681.989728] [117/130] (368s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [682.050974] Starting subtest: y-tiled-ccs-to-y-tiled [682.055426] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [682.224816] [118/130] (368s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [682.316758] Starting subtest: plane-downscale-factor-0-25-with-modifiers [682.319134] Starting dynamic subtest: pipe-A [682.334581] Dynamic subtest pipe-A: SKIP (0.011s) [682.345004] Starting dynamic subtest: pipe-B [682.354765] Dynamic subtest pipe-B: SKIP (0.020s) [682.366435] Starting dynamic subtest: pipe-C [682.376188] Dynamic subtest pipe-C: SKIP (0.020s) [682.387478] Starting dynamic subtest: pipe-D [682.395811] Dynamic subtest pipe-D: SKIP (0.020s) [682.399611] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.073s) [682.493591] [119/130] (368s left) gem_lmem_swapping (heavy-random) [682.544151] Subtest heavy-random: SKIP (0.000s) [682.581157] [120/130] (368s left) syncobj_timeline (wait-any-snapshot) [682.648039] Starting subtest: wait-any-snapshot [682.730244] Subtest wait-any-snapshot: SUCCESS (0.082s) [682.799433] [121/130] (368s left) kms_pm_rpm (modeset-lpsp) [684.437199] Starting subtest: modeset-lpsp [685.880245] Subtest modeset-lpsp: SUCCESS (1.446s) [685.964519] [122/130] (364s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [686.073046] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [686.077107] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [686.186909] [123/130] (364s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [686.241004] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [686.245591] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [686.416721] [124/130] (364s left) gem_exec_balancer (hog) [686.486811] Starting subtest: hog [686.491573] Subtest hog: SKIP (0.000s) [686.746873] [125/130] (364s left) kms_getfb (getfb-handle-not-fb) [686.790593] Starting subtest: getfb-handle-not-fb [686.831086] Subtest getfb-handle-not-fb: SUCCESS (0.042s) [686.940850] [126/130] (364s left) gem_softpin (noreloc-interruptible) [687.002930] Starting subtest: noreloc-interruptible [692.431166] Subtest noreloc-interruptible: SUCCESS (5.424s) [692.634188] [127/130] (358s left) kms_psr (pr-suspend) [692.738024] Starting subtest: pr-suspend [692.742259] Subtest pr-suspend: SKIP (0.000s) [692.801950] [128/130] (358s left) kms_chamelium_frames (dp-frame-dump) [693.177821] Subtest dp-frame-dump: SKIP (0.000s) [693.940048] [129/130] (357s left) gem_exec_schedule (pi-ringfull) [694.130108] Starting subtest: pi-ringfull [694.132096] Starting dynamic subtest: rcs0 [694.218229] Dynamic subtest rcs0: SUCCESS (0.089s) [694.235281] Starting dynamic subtest: bcs0 [694.308251] Dynamic subtest bcs0: SUCCESS (0.090s) [694.324748] Starting dynamic subtest: vcs0 [694.391818] Dynamic subtest vcs0: SUCCESS (0.082s) [694.408891] Starting dynamic subtest: vcs1 [694.472241] Dynamic subtest vcs1: SUCCESS (0.079s) [694.489351] Starting dynamic subtest: vecs0 [694.548189] Dynamic subtest vecs0: SUCCESS (0.074s) [694.566133] Starting dynamic subtest: ccs0 [694.624241] Dynamic subtest ccs0: SUCCESS (0.075s) [694.626975] Subtest pi-ringfull: SUCCESS (0.497s) [694.848040] [130/130] (356s left) gem_create (busy-create) [694.916764] Starting subtest: busy-create [694.919227] Starting dynamic subtest: smem0 [728.264420] Dynamic subtest smem0: SUCCESS (33.343s) [728.266952] Subtest busy-create: SUCCESS (33.345s) [728.443646] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: gem_sync results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_exec_flush results: parsing output: 4/ for test: kms_atomic results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_rotation_crc results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: gem_exec_capture results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_busy results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_eio results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: prime_self_import results: parsing output: 19/ for test: i915_pm_rpm results: parsing output: 20/ for test: kms_addfb_basic results: parsing output: 21/ for test: gem_exec_schedule results: parsing output: 22/ for test: gem_pxp results: parsing output: 23/ for test: gem_eio results: parsing output: 24/ for test: gen9_exec_parse results: parsing output: 25/ for test: perf_pmu results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_addfb_basic results: parsing output: 28/ for test: kms_cursor_edge_walk results: parsing output: 29/ for test: fbdev results: parsing output: 30/ for test: kms_content_protection results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_feature_discovery results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_lease results: parsing output: 36/ for test: prime_self_import results: parsing output: 37/ for test: kms_writeback results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_plane_scaling results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: kms_addfb_basic results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: drm_read results: parsing output: 44/ for test: gem_spin_batch results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: gem_create results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: gem_exec_reloc results: parsing output: 49/ for test: kms_psr2_sf results: parsing output: 50/ for test: gem_exec_schedule results: parsing output: 51/ for test: prime_vgem results: parsing output: 52/ for test: kms_async_flips results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: gem_exec_whisper results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: gem_mmap_offset results: parsing output: 59/ for test: kms_flip_scaled_crc results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_exec_reloc results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: api_intel_allocator results: parsing output: 64/ for test: drm_read results: parsing output: 65/ for test: gem_exec_nop results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: i915_hangman results: parsing output: 70/ for test: kms_rotation_crc results: parsing output: 71/ for test: gem_exec_create results: parsing output: 72/ for test: sysfs_heartbeat_interval results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_joiner results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_exec_fence results: parsing output: 77/ for test: syncobj_wait results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: kms_psr2_sf results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_color results: parsing output: 83/ for test: kms_cursor_crc results: parsing output: 84/ for test: gem_ctx_bad_destroy results: parsing output: 85/ for test: kms_prop_blob results: parsing output: 86/ for test: gem_exec_reloc results: parsing output: 87/ for test: gem_mmap_gtt results: parsing output: 88/ for test: i915_pm_rpm results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_chamelium_frames results: parsing output: 92/ for test: kms_plane_scaling results: parsing output: 93/ for test: syncobj_wait results: parsing output: 94/ for test: gem_ctx_persistence results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: core_setmaster results: parsing output: 98/ for test: gem_render_copy results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_ctx_persistence results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_exec_params results: parsing output: 103/ for test: kms_plane_alpha_blend results: parsing output: 104/ for test: prime_busy results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_vblank results: parsing output: 110/ for test: gem_exec_await results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: kms_dp_link_training results: parsing output: 113/ for test: kms_flip results: parsing output: 114/ for test: kms_setmode results: parsing output: 115/ for test: drm_fdinfo results: parsing output: 116/ for test: gem_render_copy results: parsing output: 117/ for test: kms_plane_scaling results: parsing output: 118/ for test: gem_lmem_swapping results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: kms_pm_rpm results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_render_copy results: parsing output: 123/ for test: gem_exec_balancer results: parsing output: 124/ for test: kms_getfb results: parsing output: 125/ for test: gem_softpin results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_chamelium_frames results: parsing output: 128/ for test: gem_exec_schedule results: parsing output: 129/ for test: gem_create Done.