[59.133395] Initializing watchdogs [59.133437] /dev/watchdog0 [59.147462] [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] [59.151697] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.154013] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.157559] [001/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [59.277374] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [59.279603] Starting dynamic subtest: pipe-A [59.362809] Dynamic subtest pipe-A: SUCCESS (0.086s) [59.370410] Starting dynamic subtest: pipe-B [60.545849] Dynamic subtest pipe-B: SUCCESS (1.187s) [60.555096] Starting dynamic subtest: pipe-C [61.649221] Dynamic subtest pipe-C: SUCCESS (1.106s) [61.657796] Starting dynamic subtest: pipe-D [62.790791] Dynamic subtest pipe-D: SUCCESS (1.145s) [62.793125] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.526s) [63.942701] [002/133] (955s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [64.064701] Starting subtest: basic-flip-after-cursor-legacy [65.027467] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.963s) [65.868191] [003/133] (953s left) kms_pipe_crc_basic (hang-read-crc) [65.955052] Starting subtest: hang-read-crc [65.957717] Starting dynamic subtest: pipe-A-eDP-1 [68.042626] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.092s) [68.051590] Starting dynamic subtest: pipe-B-eDP-1 [70.807673] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s) [70.816668] Starting dynamic subtest: pipe-C-eDP-1 [73.488472] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.683s) [73.497774] Starting dynamic subtest: pipe-D-eDP-1 [76.177076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.687s) [76.179233] Subtest hang-read-crc: SUCCESS (10.232s) [77.015670] [004/133] (942s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [77.132922] Starting subtest: yf-tiled-16bpp-rotate-270 [77.137167] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [77.233229] [005/133] (942s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [77.335676] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [77.339769] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [77.421317] [006/133] (942s left) kms_legacy_colorkey (basic) [77.518950] Starting subtest: basic [77.521086] Starting dynamic subtest: pipe-A [77.562486] Dynamic subtest pipe-A: SUCCESS (0.045s) [77.572223] Starting dynamic subtest: pipe-B [77.574372] Dynamic subtest pipe-B: SUCCESS (0.001s) [77.581065] Starting dynamic subtest: pipe-C [77.582849] Dynamic subtest pipe-C: SUCCESS (0.000s) [77.589833] Starting dynamic subtest: pipe-D [77.591939] Dynamic subtest pipe-D: SUCCESS (0.000s) [77.594066] Subtest basic: SUCCESS (0.048s) [77.628694] [007/133] (942s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [77.719764] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [77.723810] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [77.782665] [008/133] (942s left) kms_pm_dc (dc6-psr) [78.873044] Starting subtest: dc6-psr [81.852969] Subtest dc6-psr: SUCCESS (2.979s) [82.650315] [009/133] (937s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [82.719666] Starting subtest: legacy-engines-hostile-preempt [82.721986] Starting dynamic subtest: render [82.787063] Dynamic subtest render: SUCCESS (0.067s) [82.795083] Starting dynamic subtest: bsd1 [83.918303] Dynamic subtest bsd1: SUCCESS (1.130s) [83.930765] Starting dynamic subtest: bsd2 [85.903257] Dynamic subtest bsd2: SUCCESS (1.982s) [85.913196] Starting dynamic subtest: blt [85.946357] Dynamic subtest blt: SUCCESS (0.043s) [85.956612] Starting dynamic subtest: vebox [87.884106] Dynamic subtest vebox: SUCCESS (1.935s) [87.887048] Subtest legacy-engines-hostile-preempt: SUCCESS (5.164s) [87.978652] [010/133] (932s left) kms_cursor_crc (cursor-onscreen-512x170) [88.314493] Starting subtest: cursor-onscreen-512x170 [88.319323] Subtest cursor-onscreen-512x170: SKIP (0.001s) [88.449029] [011/133] (931s left) gem_exec_params (dr4-dirt) [88.507369] Starting subtest: DR4-dirt [88.509650] Subtest DR4-dirt: SUCCESS (0.000s) [88.608595] [012/133] (931s left) core_auth (many-magics) [88.665948] Starting subtest: many-magics [89.571660] Subtest many-magics: SUCCESS (0.908s) [89.779161] [013/133] (930s left) gem_ctx_sseu (mmap-args) [89.848961] Subtest mmap-args: SKIP (0.000s) [89.903509] [014/133] (930s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [89.969050] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [90.073841] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s) [90.144810] [015/133] (930s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [90.238075] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [94.266255] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.032s) [95.445669] [016/133] (924s left) kms_atomic_transition (modeset-transition-nonblocking) [95.547027] Starting subtest: modeset-transition-nonblocking [95.549146] Starting dynamic subtest: 1x-outputs [106.612826] Dynamic subtest 1x-outputs: SUCCESS (11.067s) [106.615795] Subtest modeset-transition-nonblocking: SUCCESS (11.069s) [107.479241] [017/133] (912s left) gem_ccs (block-copy-compressed) [107.545125] Starting subtest: block-copy-compressed [107.549806] Subtest block-copy-compressed: SKIP (0.000s) [107.644762] [018/133] (912s left) kms_plane (plane-position-hole-dpms) [107.731964] Starting subtest: plane-position-hole-dpms [108.268383] Starting dynamic subtest: pipe-A-plane-1 [110.561096] Dynamic subtest pipe-A-plane-1: SUCCESS (2.293s) [110.569359] Starting dynamic subtest: pipe-A-plane-2 [112.956504] Dynamic subtest pipe-A-plane-2: SUCCESS (2.395s) [112.965156] Starting dynamic subtest: pipe-A-plane-3 [115.285477] Dynamic subtest pipe-A-plane-3: SUCCESS (2.328s) [115.294343] Starting dynamic subtest: pipe-A-plane-4 [117.558602] Dynamic subtest pipe-A-plane-4: SUCCESS (2.272s) [117.568227] Starting dynamic subtest: pipe-A-plane-5 [117.582116] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [118.723207] Starting dynamic subtest: pipe-B-plane-1 [120.979908] Dynamic subtest pipe-B-plane-1: SUCCESS (2.262s) [120.987596] Starting dynamic subtest: pipe-B-plane-2 [123.362531] Dynamic subtest pipe-B-plane-2: SUCCESS (2.380s) [123.371476] Starting dynamic subtest: pipe-B-plane-3 [125.624244] Dynamic subtest pipe-B-plane-3: SUCCESS (2.262s) [125.632626] Starting dynamic subtest: pipe-B-plane-4 [127.999361] Dynamic subtest pipe-B-plane-4: SUCCESS (2.374s) [128.008170] Starting dynamic subtest: pipe-B-plane-5 [128.023319] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [128.025637] Subtest plane-position-hole-dpms: SUCCESS (20.292s) [128.813250] [019/133] (891s left) gem_reg_read (timestamp-monotonic) [128.884352] Starting subtest: timestamp-monotonic [133.661044] Subtest timestamp-monotonic: SUCCESS (4.776s) [133.733991] [020/133] (886s left) kms_cursor_crc (cursor-random-512x170) [134.023796] Starting subtest: cursor-random-512x170 [134.028175] Subtest cursor-random-512x170: SKIP (0.001s) [134.167848] [021/133] (886s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [134.257917] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [134.260220] Starting dynamic subtest: pipe-A-eDP-1 [134.720046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s) [134.730546] Starting dynamic subtest: pipe-B-eDP-1 [136.104614] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.376s) [136.114035] Starting dynamic subtest: pipe-C-eDP-1 [137.553610] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.452s) [137.562739] Starting dynamic subtest: pipe-D-eDP-1 [138.959673] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s) [138.961909] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.675s) [140.124050] [022/133] (880s left) kms_setmode (basic) [140.171487] Starting subtest: basic [140.500016] Starting dynamic subtest: pipe-A-eDP-1 [142.550891] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.046s) [142.893259] Starting dynamic subtest: pipe-B-eDP-1 [144.987890] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.097s) [145.301601] Subtest basic: SUCCESS (5.128s) [146.128535] [023/133] (874s left) kms_pm_rpm (universal-planes-dpms) [148.050847] Starting subtest: universal-planes-dpms [148.053030] Starting dynamic subtest: plane-35 [156.358165] Dynamic subtest plane-35: SUCCESS (8.307s) [156.371817] Starting dynamic subtest: plane-65 [164.642043] Dynamic subtest plane-65: SUCCESS (8.281s) [164.653048] Starting dynamic subtest: plane-95 [173.050518] Dynamic subtest plane-95: SUCCESS (8.406s) [173.063509] Starting dynamic subtest: plane-125 [181.657665] Dynamic subtest plane-125: SUCCESS (8.605s) [181.667719] Starting dynamic subtest: plane-135 [190.263057] Dynamic subtest plane-135: SUCCESS (8.602s) [190.273868] Starting dynamic subtest: plane-145 [199.001782] Dynamic subtest plane-145: SUCCESS (8.736s) [199.004403] Subtest universal-planes-dpms: SUCCESS (50.953s) [199.379940] [024/133] (821s left) gem_sync (basic-store-each) [199.455708] Starting subtest: basic-store-each [201.796337] Subtest basic-store-each: SUCCESS (2.352s) [201.984392] [025/133] (818s left) kms_psr (psr-cursor-blt) [202.077204] Starting subtest: psr-cursor-blt [202.079459] Starting dynamic subtest: eDP-1 [203.765448] Dynamic subtest eDP-1: SUCCESS (1.689s) [203.768292] Subtest psr-cursor-blt: SUCCESS (1.690s) [204.620847] [026/133] (815s left) perf (invalid-remove-userspace-config) [204.741431] Starting subtest: invalid-remove-userspace-config [204.751554] Subtest invalid-remove-userspace-config: SUCCESS (0.011s) [204.803193] [027/133] (815s left) gem_mmap_gtt (close-race) [204.856788] Subtest close-race: SKIP (0.000s) [204.914125] [028/133] (815s left) kms_color_pipeline (plane-ctm3x4-lut1d) [205.007063] Starting subtest: plane-ctm3x4-lut1d [205.131018] Starting dynamic subtest: pipe-A-plane-0 [205.297088] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [205.305006] Starting dynamic subtest: pipe-A-plane-1 [205.430653] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [205.438518] Starting dynamic subtest: pipe-A-plane-2 [205.586058] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [206.737695] Starting dynamic subtest: pipe-B-plane-0 [206.886917] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s) [206.895187] Starting dynamic subtest: pipe-B-plane-1 [207.042503] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [207.050283] Starting dynamic subtest: pipe-B-plane-2 [207.186834] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s) [208.372154] Starting dynamic subtest: pipe-C-plane-0 [208.498886] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [208.507077] Starting dynamic subtest: pipe-C-plane-1 [208.632281] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [208.640545] Starting dynamic subtest: pipe-C-plane-2 [208.777734] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [210.003825] Starting dynamic subtest: pipe-D-plane-0 [210.130410] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [210.138315] Starting dynamic subtest: pipe-D-plane-1 [210.264076] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [210.273070] Starting dynamic subtest: pipe-D-plane-2 [210.408403] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [210.694219] Subtest plane-ctm3x4-lut1d: SUCCESS (5.688s) [211.581406] [029/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [211.678802] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [211.682961] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [211.773109] [030/133] (808s left) sw_sync (sync_multi_timeline_wait) [211.816043] Starting subtest: sync_multi_timeline_wait [211.818337] Subtest sync_multi_timeline_wait: SUCCESS (0.001s) [211.881547] [031/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [211.968311] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [211.972723] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [212.048303] [032/133] (808s left) kms_invalid_mode (bad-htotal) [212.140395] Starting subtest: bad-htotal [212.142755] Starting dynamic subtest: pipe-A-eDP-1 [212.429204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [212.437750] Starting dynamic subtest: pipe-B-eDP-1 [212.439940] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [212.447274] Starting dynamic subtest: pipe-C-eDP-1 [212.449411] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [212.456721] Starting dynamic subtest: pipe-D-eDP-1 [212.458650] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [212.460588] Subtest bad-htotal: SUCCESS (0.295s) [213.233555] [033/133] (807s left) gem_spin_batch (engines) [213.303961] Starting subtest: engines [213.306780] Starting dynamic subtest: rcs0 [216.543045] Dynamic subtest rcs0: SUCCESS (3.235s) [216.552739] Starting dynamic subtest: bcs0 [219.781213] Dynamic subtest bcs0: SUCCESS (3.235s) [219.789537] Starting dynamic subtest: vcs0 [223.017191] Dynamic subtest vcs0: SUCCESS (3.233s) [223.025380] Starting dynamic subtest: vcs1 [226.256602] Dynamic subtest vcs1: SUCCESS (3.236s) [226.265490] Starting dynamic subtest: vecs0 [229.495541] Dynamic subtest vecs0: SUCCESS (3.236s) [229.504910] Starting dynamic subtest: ccs0 [232.734305] Dynamic subtest ccs0: SUCCESS (3.236s) [232.736821] Subtest engines: SUCCESS (19.427s) [232.971612] [034/133] (787s left) gem_exec_reloc (basic-write-wc-active) [233.043923] Subtest basic-write-wc-active: SKIP (0.000s) [233.112410] [035/133] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [233.223823] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [240.471604] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.251s) [240.584643] [036/133] (780s left) gem_exec_fence (syncobj-timeline-unused-fence) [241.155303] Starting subtest: syncobj-timeline-unused-fence [241.161298] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s) [242.969837] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [242.973880] [037/133] (778s left) gem_pxp (create-regular-context-1) [243.109937] Starting subtest: create-regular-context-1 [243.112716] Subtest create-regular-context-1: SUCCESS (0.001s) [243.213410] [038/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [243.321326] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [243.325601] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [243.420988] [039/133] (777s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [243.536105] Starting subtest: cursorA-vs-flipB-atomic-transitions [243.540321] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [243.680430] [040/133] (777s left) kms_flip (wf_vblank-ts-check-interruptible) [243.776193] Starting subtest: wf_vblank-ts-check-interruptible [243.778476] Starting dynamic subtest: A-eDP1 [252.699287] Dynamic subtest A-eDP1: SUCCESS (8.921s) [252.707398] Starting dynamic subtest: B-eDP1 [261.637543] Dynamic subtest B-eDP1: SUCCESS (8.937s) [261.653177] Starting dynamic subtest: C-eDP1 [270.551159] Dynamic subtest C-eDP1: SUCCESS (8.909s) [270.560645] Starting dynamic subtest: D-eDP1 [279.401773] Dynamic subtest D-eDP1: SUCCESS (8.849s) [279.403978] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.627s) [280.651491] [041/133] (740s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [280.767358] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [280.771444] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [280.874412] [042/133] (740s left) kms_chamelium_frames (dp-crc-single) [281.260159] Subtest dp-crc-single: SKIP (0.000s) [282.045617] [043/133] (739s left) kms_atomic_transition (plane-all-transition) [282.142086] Starting subtest: plane-all-transition [282.144258] Starting dynamic subtest: pipe-A-eDP-1 [284.635105] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [284.942048] Starting dynamic subtest: pipe-B-eDP-1 [288.198141] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.265s) [288.507588] Subtest plane-all-transition: SUCCESS (6.367s) [289.324587] [044/133] (732s left) kms_debugfs (display-off-read-all) [289.414190] Starting subtest: display-off-read-all [289.713027] Subtest display-off-read-all: SUCCESS (0.301s) [290.559527] [045/133] (730s left) gem_ctx_param (invalid-get-ringsize) [290.615066] Starting subtest: invalid-get-ringsize [290.617562] Subtest invalid-get-ringsize: SUCCESS (0.001s) [290.717672] [046/133] (730s left) sysfs_heartbeat_interval (invalid) [290.767543] Starting subtest: invalid [290.769868] Starting dynamic subtest: vecs0 [290.772194] Dynamic subtest vecs0: SUCCESS (0.000s) [290.780644] Starting dynamic subtest: ccs0 [290.782540] Dynamic subtest ccs0: SUCCESS (0.000s) [290.790240] Starting dynamic subtest: vcs0 [290.792425] Dynamic subtest vcs0: SUCCESS (0.000s) [290.799755] Starting dynamic subtest: bcs0 [290.802053] Dynamic subtest bcs0: SUCCESS (0.000s) [290.809550] Starting dynamic subtest: rcs0 [290.811462] Dynamic subtest rcs0: SUCCESS (0.000s) [290.818409] Starting dynamic subtest: vcs1 [290.820288] Dynamic subtest vcs1: SUCCESS (0.000s) [290.822568] Subtest invalid: SUCCESS (0.005s) [290.867957] [047/133] (730s left) gem_madvise (dontneed-before-exec) [290.903232] Starting subtest: dontneed-before-exec [290.920880] Subtest dontneed-before-exec: SKIP (0.012s) [290.973860] [048/133] (730s left) kms_atomic_interruptible (atomic-setmode) [291.080056] Starting subtest: atomic-setmode [291.082250] Starting dynamic subtest: pipe-A-eDP-1 [297.956135] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.875s) [297.958481] Subtest atomic-setmode: SUCCESS (6.876s) [298.745997] [049/133] (722s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [298.816300] Starting subtest: yf-tiled-to-vebox-y-tiled [298.820391] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [299.002673] [050/133] (722s left) prime_vgem (fence-read-hang) [299.070977] Subtest fence-read-hang: SKIP (0.000s) [299.175865] [051/133] (722s left) gem_exec_fence (syncobj-timeline-chain-engines) [299.705774] Starting subtest: syncobj-timeline-chain-engines [299.828535] Subtest syncobj-timeline-chain-engines: SUCCESS (0.123s) [300.979497] [052/133] (720s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [301.080685] Starting subtest: 2x-flip-vs-absolute-wf_vblank [301.088875] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s) [301.166883] [053/133] (720s left) gem_userptr_blits (huge-split) [301.241046] Starting subtest: huge-split [301.247450] Subtest huge-split: SUCCESS (0.006s) [301.378410] [054/133] (720s left) gem_tiled_partial_pwrite_pread (reads) [301.437705] Subtest reads: SKIP (0.000s) [301.519840] [055/133] (720s left) gem_exec_create (madvise) [301.577299] Starting subtest: madvise [301.579602] Starting dynamic subtest: smem [322.004468] Dynamic subtest smem: SUCCESS (20.424s) [322.007072] Subtest madvise: SUCCESS (20.425s) [322.889461] [056/133] (698s left) prime_vgem (sync) [322.957470] Starting subtest: sync [322.959874] Starting dynamic subtest: rcs0 [323.030785] Dynamic subtest rcs0: SUCCESS (0.070s) [323.051053] Starting dynamic subtest: bcs0 [323.094212] Dynamic subtest bcs0: SUCCESS (0.064s) [323.102330] Starting dynamic subtest: vcs0 [323.142775] Dynamic subtest vcs0: SUCCESS (0.048s) [323.150870] Starting dynamic subtest: vcs1 [323.191039] Dynamic subtest vcs1: SUCCESS (0.047s) [323.200047] Starting dynamic subtest: vecs0 [323.238163] Dynamic subtest vecs0: SUCCESS (0.045s) [323.246343] Starting dynamic subtest: ccs0 [323.286823] Dynamic subtest ccs0: SUCCESS (0.048s) [323.289268] Subtest sync: SUCCESS (0.331s) [323.432037] [057/133] (698s left) kms_psr (fbc-pr-sprite-render) [323.528858] Starting subtest: fbc-pr-sprite-render [323.533236] Subtest fbc-pr-sprite-render: SKIP (0.000s) [323.599807] [058/133] (698s left) i915_drm_fdinfo (all-busy-check-all) [323.641210] Starting subtest: all-busy-check-all [323.648089] Subtest all-busy-check-all: SKIP (0.004s) [323.718866] [059/133] (698s left) i915_pm_rpm (debugfs-forcewake-user) [325.270855] Starting subtest: debugfs-forcewake-user [336.643707] Subtest debugfs-forcewake-user: SUCCESS (11.375s) [337.024888] [060/133] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [337.113821] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [337.118199] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [337.206945] [061/133] (684s left) gem_exec_fence (expired-history) [337.619720] Starting subtest: expired-history [344.638045] Subtest expired-history: SUCCESS (7.018s) [345.186243] [062/133] (676s left) kms_big_fb (4-tiled-16bpp-rotate-90) [345.288730] Starting subtest: 4-tiled-16bpp-rotate-90 [345.308774] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [345.412160] [063/133] (676s left) gem_ccs (large-ctrl-surf-copy) [345.476289] Starting subtest: large-ctrl-surf-copy [345.480871] Subtest large-ctrl-surf-copy: SKIP (0.000s) [345.577896] [064/133] (676s left) core_auth (getclient-master-drop) [345.619569] Starting subtest: getclient-master-drop [345.635538] Subtest getclient-master-drop: SUCCESS (0.019s) [345.768856] [065/133] (676s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [345.882084] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [345.885904] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [345.992207] [066/133] (676s left) gem_pxp (reject-modify-context-protection-off-3) [346.093429] Starting subtest: reject-modify-context-protection-off-3 [346.095856] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s) [346.207284] [067/133] (676s left) gem_flink_basic (bad-open) [346.259312] Starting subtest: bad-open [346.260895] Subtest bad-open: SUCCESS (0.000s) [346.350731] [068/133] (675s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [346.457954] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [346.461538] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [346.526802] [069/133] (675s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [346.626434] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [346.629971] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [346.723084] [070/133] (675s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [346.799486] Starting subtest: bad-aux-stride-y-tiled-ccs [346.801318] Starting dynamic subtest: pipe-A-eDP-1 [346.820347] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [346.829902] Starting dynamic subtest: pipe-B-eDP-1 [346.847443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [346.855738] Starting dynamic subtest: pipe-C-eDP-1 [346.873800] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [346.881218] Starting dynamic subtest: pipe-D-eDP-1 [346.899335] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [346.902780] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s) [348.996894] [071/133] (673s left) gem_mmap_offset (oob-read) [349.054139] Starting subtest: oob-read [349.056056] Subtest oob-read: SUCCESS (0.000s) [349.144059] [072/133] (673s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [349.234822] Starting subtest: fbc-2p-pri-indfb-multidraw [349.239210] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [349.338987] [073/133] (673s left) kms_addfb_basic (basic-y-tiled-legacy) [349.389774] Starting subtest: basic-y-tiled-legacy [349.393875] Subtest basic-y-tiled-legacy: SKIP (0.000s) [349.515040] [074/133] (673s left) syncobj_timeline (etime-single-wait-submitted) [349.569533] Starting subtest: etime-single-wait-submitted [349.675049] Subtest etime-single-wait-submitted: SUCCESS (0.105s) [349.763036] [075/133] (672s left) gem_basic (bad-close) [349.812079] Starting subtest: bad-close [349.816472] Subtest bad-close: SUCCESS (0.000s) [349.898601] [076/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [350.000341] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [350.004267] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [350.083891] [077/133] (672s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [350.184060] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [350.188461] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [350.275350] [078/133] (672s left) kms_big_fb (linear-16bpp-rotate-180) [350.376271] Starting subtest: linear-16bpp-rotate-180 [351.831977] Subtest linear-16bpp-rotate-180: SUCCESS (1.456s) [351.951595] [079/133] (670s left) perf_pmu (busy-double-start) [351.990755] Starting subtest: busy-double-start [351.992786] Starting dynamic subtest: rcs0 [355.637315] Dynamic subtest rcs0: FAIL (3.591s) [355.647139] Starting dynamic subtest: bcs0 [359.178239] Dynamic subtest bcs0: SUCCESS (3.594s) [359.189317] Starting dynamic subtest: vcs0 [363.415942] Dynamic subtest vcs0: SUCCESS (4.236s) [363.426779] Starting dynamic subtest: vcs1 [367.448801] Dynamic subtest vcs1: SUCCESS (4.030s) [367.459694] Starting dynamic subtest: vecs0 [371.452195] Dynamic subtest vecs0: SUCCESS (4.001s) [371.467980] Starting dynamic subtest: ccs0 [375.089920] Dynamic subtest ccs0: FAIL (3.566s) [375.091859] Subtest busy-double-start: FAIL (23.029s) [375.135577] [080/133] (647s left) gem_lmem_swapping (heavy-multi) [375.179238] Subtest heavy-multi: SKIP (0.000s) [375.228989] [081/133] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [375.333207] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [375.337072] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [375.425865] [082/133] (647s left) kms_vblank (wait-forked) [375.514156] Starting subtest: wait-forked [375.516296] Starting dynamic subtest: pipe-A-eDP-1 [377.335475] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s) [377.349515] Starting dynamic subtest: pipe-D-eDP-1 [379.802732] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.466s) [379.805127] Subtest wait-forked: SUCCESS (4.290s) [380.707805] [083/133] (642s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [380.775534] Starting subtest: multi-wait-all-for-submit-unsubmitted [380.882530] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [380.962302] [084/133] (642s left) gem_exec_reloc (basic-write-cpu) [381.021289] Subtest basic-write-cpu: SKIP (0.000s) [381.089637] [085/133] (641s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [381.178106] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [381.180367] Starting dynamic subtest: pipe-A-default-mode [383.909429] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s) [383.911616] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.732s) [384.784464] [086/133] (638s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [384.884748] Starting subtest: plane-use-after-nonblocking-unbind-fencing [384.887529] Starting dynamic subtest: pipe-A-eDP-1 [384.945065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [385.244863] Starting dynamic subtest: pipe-B-eDP-1 [386.076498] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.840s) [386.370546] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.486s) [387.243440] [087/133] (635s left) kms_cdclk (mode-transition-all-outputs) [387.330015] Starting subtest: mode-transition-all-outputs [387.619749] Subtest mode-transition-all-outputs: SKIP (0.286s) [388.484913] [088/133] (634s left) syncobj_wait (invalid-reset-zero-handles) [388.546792] Starting subtest: invalid-reset-zero-handles [388.548835] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [388.629858] [089/133] (634s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [388.734092] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [388.738220] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [388.813871] [090/133] (634s left) gen9_exec_parse (batch-without-end) [388.875489] Subtest batch-without-end: SKIP (0.000s) [388.947687] [091/133] (634s left) syncobj_timeline (invalid-transfer-bad-pad) [388.995727] Starting subtest: invalid-transfer-bad-pad [388.997993] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [389.086135] [092/133] (634s left) kms_hdmi_inject (inject-audio) [389.432762] Starting subtest: inject-audio [389.707143] Subtest inject-audio: SUCCESS (0.275s) [390.335418] [093/133] (633s left) gem_softpin (evict-snoop) [390.405973] Starting subtest: evict-snoop [390.410455] Subtest evict-snoop: SKIP (0.000s) [390.479768] [094/133] (632s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [390.580823] Starting subtest: fbc-rgb101010-draw-pwrite [395.906736] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.329s) [397.027927] [095/133] (626s left) gem_wait (invalid-buf) [397.090043] Starting subtest: invalid-buf [397.092209] Subtest invalid-buf: SUCCESS (0.000s) [397.311932] [096/133] (626s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [397.359661] Starting subtest: multi-wait-for-submit-available-submitted [397.361660] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [397.462773] [097/133] (626s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [397.541142] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [397.597275] [098/133] (626s left) i915_suspend (sysfs-reader) [397.661494] Starting subtest: sysfs-reader [416.238022] Subtest sysfs-reader: SUCCESS (3.287s) [416.331324] [099/133] (607s left) kms_plane_lowres (tiling-yf) [416.428233] Starting subtest: tiling-yf [416.431742] Subtest tiling-yf: SKIP (0.000s) [416.503892] [100/133] (607s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [416.591204] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [416.592849] Starting dynamic subtest: pipe-A-eDP-1 [418.571910] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.013s) [418.581224] Starting dynamic subtest: pipe-B-eDP-1 [420.653722] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.106s) [420.663536] Starting dynamic subtest: pipe-C-eDP-1 [422.639369] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.005s) [422.649467] Starting dynamic subtest: pipe-D-eDP-1 [424.642776] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.016s) [424.644932] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.144s) [425.836818] [101/133] (597s left) gem_exec_whisper (basic-fds-forked) [425.909416] Starting subtest: basic-fds-forked [449.906732] Subtest basic-fds-forked: SUCCESS (24.039s) [450.097486] [102/133] (573s left) kms_selftest (drm_format_helper) [450.132181] Starting subtest: drm_format_helper [450.185329] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [450.287457] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.100s) [450.297014] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [450.380926] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.096s) [450.390818] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [450.504675] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.122s) [450.513595] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [450.614037] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.109s) [450.625825] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [450.727974] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.114s) [450.739283] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [450.829002] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.098s) [450.841266] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [450.919479] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.090s) [450.928184] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [451.029816] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.109s) [451.039951] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [451.135166] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.104s) [451.144189] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [451.232048] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.097s) [451.241952] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [451.348781] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.114s) [451.357977] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [451.451095] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.102s) [451.461131] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [451.560382] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.110s) [451.569426] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [451.677204] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.113s) [451.687039] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [451.772992] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.096s) [451.784000] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [451.874628] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.099s) [451.884055] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [451.983546] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.111s) [451.985696] Subtest drm_format_helper: SUCCESS (1.853s) [452.162456] [103/133] (571s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [452.544087] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [453.373052] [104/133] (570s left) kms_plane (pixel-format-4-tiled-modifier) [453.477388] Starting subtest: pixel-format-4-tiled-modifier [453.506941] Starting dynamic subtest: pipe-A-plane-0 [454.195151] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s) [454.205571] Starting dynamic subtest: pipe-A-plane-3 [454.639628] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s) [454.651560] Starting dynamic subtest: pipe-A-plane-5 [454.655304] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [455.750342] Starting dynamic subtest: pipe-B-plane-0 [456.370692] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s) [456.380137] Starting dynamic subtest: pipe-B-plane-3 [456.814898] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [456.827111] Starting dynamic subtest: pipe-B-plane-5 [456.830756] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [457.126151] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.650s) [457.987556] [105/133] (565s left) gem_tiled_blits (basic) [458.062933] Subtest basic: SKIP (0.000s) [458.144202] [106/133] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [458.236523] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [462.726955] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.494s) [463.917680] [107/133] (560s left) kms_big_fb (x-tiled-addfb) [464.008450] Starting subtest: x-tiled-addfb [464.010748] Subtest x-tiled-addfb: SUCCESS (0.000s) [464.123082] [108/133] (559s left) gem_softpin (evict-active) [464.194621] Starting subtest: evict-active [464.200182] Subtest evict-active: SUCCESS (0.005s) [464.326410] [109/133] (559s left) perf_pmu (multi-client) [464.368489] Starting subtest: multi-client [464.370813] Starting dynamic subtest: rcs0 [465.422953] Dynamic subtest rcs0: SUCCESS (1.054s) [465.435678] Starting dynamic subtest: bcs0 [466.474366] Dynamic subtest bcs0: SUCCESS (1.049s) [466.486673] Starting dynamic subtest: vcs0 [467.527311] Dynamic subtest vcs0: SUCCESS (1.051s) [467.540738] Starting dynamic subtest: vcs1 [469.206047] Dynamic subtest vcs1: SUCCESS (1.676s) [469.218960] Starting dynamic subtest: vecs0 [471.252978] Dynamic subtest vecs0: SUCCESS (2.045s) [471.268129] Starting dynamic subtest: ccs0 [473.237644] Dynamic subtest ccs0: SUCCESS (1.982s) [473.240724] Subtest multi-client: SUCCESS (8.872s) [473.356924] [110/133] (550s left) gem_exec_balancer (hog) [473.423515] Starting subtest: hog [473.428553] Subtest hog: SKIP (0.000s) [473.715411] [111/133] (550s left) kms_content_protection (srm) [473.865419] Starting subtest: srm [473.873204] Subtest srm: SKIP (0.002s) [474.020813] [112/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [474.121448] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [474.125701] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [474.224201] [113/133] (550s left) kms_psr (psr-sprite-blt) [474.326322] Starting subtest: psr-sprite-blt [474.328645] Starting dynamic subtest: eDP-1 [476.084943] Dynamic subtest eDP-1: SUCCESS (1.746s) [476.094991] Subtest psr-sprite-blt: SUCCESS (1.747s) [476.930459] [114/133] (547s left) kms_feature_discovery (display-4x) [477.073688] Starting subtest: display-4x [477.093985] Subtest display-4x: SKIP (0.000s) [477.190749] [115/133] (547s left) kms_addfb_basic (unused-handle) [477.263853] Starting subtest: unused-handle [477.274312] Subtest unused-handle: SUCCESS (0.000s) [477.438618] [116/133] (547s left) kms_psr (fbc-pr-cursor-render) [477.551171] Starting subtest: fbc-pr-cursor-render [477.573943] Subtest fbc-pr-cursor-render: SKIP (0.000s) [477.659433] [117/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [477.761069] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [481.580587] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.823s) [482.794987] [118/133] (541s left) kms_cursor_crc (cursor-tearing-position-change) [482.898153] Starting subtest: cursor-tearing-position-change [482.900337] Starting dynamic subtest: pipe-A-eDP-1 [483.469520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s) [483.484300] Starting dynamic subtest: pipe-D-eDP-1 [484.671413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s) [484.673327] Subtest cursor-tearing-position-change: SUCCESS (1.771s) [485.476453] [119/133] (539s left) kms_psr (pr-basic) [485.569217] Starting subtest: pr-basic [485.573299] Subtest pr-basic: SKIP (0.000s) [485.641273] [120/133] (539s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [485.733193] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [485.735394] Starting dynamic subtest: pipe-A-eDP-1 [485.744305] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [485.756993] Starting dynamic subtest: pipe-B-eDP-1 [485.765713] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [485.775968] Starting dynamic subtest: pipe-C-eDP-1 [485.784143] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [485.793215] Starting dynamic subtest: pipe-D-eDP-1 [485.801429] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [485.805440] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [487.973222] [121/133] (536s left) dumb_buffer (create-valid-dumb) [488.044440] Starting subtest: create-valid-dumb [488.046785] Subtest create-valid-dumb: SUCCESS (0.000s) [488.145726] [122/133] (536s left) i915_module_load (reload) [488.176223] Starting subtest: reload [493.006519] Subtest reload: SUCCESS (4.836s) [493.057255] [123/133] (531s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [494.260554] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [494.265060] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [494.356625] [124/133] (530s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [494.450526] Starting subtest: psr-rgb565-draw-blt [501.439013] Subtest psr-rgb565-draw-blt: SUCCESS (6.993s) [501.576004] [125/133] (523s left) gem_flink_race (flink_close) [501.623169] Starting subtest: flink_close [506.755418] Subtest flink_close: SUCCESS (5.134s) [506.833408] [126/133] (518s left) kms_psr (fbc-psr-no-drrs) [506.961946] Starting subtest: fbc-psr-no-drrs [506.964281] Starting dynamic subtest: eDP-1 [506.968696] Dynamic subtest eDP-1: SKIP (0.000s) [506.973074] Subtest fbc-psr-no-drrs: SKIP (0.001s) [507.038653] [127/133] (518s left) syncobj_wait (multi-wait-all-submitted-signaled) [507.097295] Starting subtest: multi-wait-all-submitted-signaled [507.201353] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s) [507.281186] [128/133] (517s left) gem_exec_schedule (timeslicing) [507.356765] Starting subtest: timeslicing [507.359068] Starting dynamic subtest: rcs0 [507.370567] Dynamic subtest rcs0: SUCCESS (0.022s) [507.381105] Starting dynamic subtest: bcs0 [507.391249] Dynamic subtest bcs0: SUCCESS (0.021s) [507.400562] Starting dynamic subtest: vcs0 [507.411802] Dynamic subtest vcs0: SUCCESS (0.020s) [507.421168] Starting dynamic subtest: vcs1 [507.432279] Dynamic subtest vcs1: SUCCESS (0.020s) [507.441757] Starting dynamic subtest: vecs0 [507.452360] Dynamic subtest vecs0: SUCCESS (0.019s) [507.461505] Starting dynamic subtest: ccs0 [507.471950] Dynamic subtest ccs0: SUCCESS (0.019s) [507.474169] Subtest timeslicing: SUCCESS (0.125s) [509.256071] [129/133] (515s left) syncobj_wait (multi-wait-submitted) [509.305198] Starting subtest: multi-wait-submitted [509.410324] Subtest multi-wait-submitted: SUCCESS (0.103s) [509.500856] [130/133] (515s left) syncobj_timeline (wait-all-for-submit-snapshot) [509.554938] Starting subtest: wait-all-for-submit-snapshot [509.635980] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [509.712724] [131/133] (515s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [509.796181] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [509.798402] Starting dynamic subtest: pipe-A-default-mode [512.510252] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s) [512.512539] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.714s) [513.371588] [132/133] (511s left) gem_exec_schedule (pi-userfault) [513.549141] Starting subtest: pi-userfault [513.551214] Starting dynamic subtest: rcs0 [513.556368] Dynamic subtest rcs0: SUCCESS (0.009s) [513.567710] Starting dynamic subtest: bcs0 [513.569785] Dynamic subtest bcs0: SUCCESS (0.009s) [513.582547] Starting dynamic subtest: vcs0 [513.584780] Dynamic subtest vcs0: SUCCESS (0.008s) [513.594839] Starting dynamic subtest: vcs1 [513.596945] Dynamic subtest vcs1: SUCCESS (0.007s) [513.606298] Starting dynamic subtest: vecs0 [513.608163] Dynamic subtest vecs0: SUCCESS (0.008s) [513.616958] Starting dynamic subtest: ccs0 [513.618926] Dynamic subtest ccs0: SUCCESS (0.008s) [513.620800] Subtest pi-userfault: SUCCESS (0.056s) [513.793408] [133/133] (511s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [513.880615] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [520.908302] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.028s) [521.060260] Closing watchdogs results: parsing output: 0/ for test: kms_plane_scaling results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: kms_pipe_crc_basic results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_legacy_colorkey results: parsing output: 6/ for test: kms_psr2_sf results: parsing output: 7/ for test: kms_pm_dc results: parsing output: 8/ for test: gem_ctx_persistence results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: gem_exec_params results: parsing output: 11/ for test: core_auth results: parsing output: 12/ for test: gem_ctx_sseu results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_atomic_transition results: parsing output: 16/ for test: gem_ccs results: parsing output: 17/ for test: kms_plane results: parsing output: 18/ for test: gem_reg_read results: parsing output: 19/ for test: kms_cursor_crc results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_setmode results: parsing output: 22/ for test: kms_pm_rpm results: parsing output: 23/ for test: gem_sync results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: perf results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: kms_color_pipeline results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: sw_sync results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_invalid_mode results: parsing output: 32/ for test: gem_spin_batch results: parsing output: 33/ for test: gem_exec_reloc results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_exec_fence results: parsing output: 36/ for test: gem_pxp results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_chamelium_frames results: parsing output: 42/ for test: kms_atomic_transition results: parsing output: 43/ for test: kms_debugfs results: parsing output: 44/ for test: gem_ctx_param results: parsing output: 45/ for test: sysfs_heartbeat_interval results: parsing output: 46/ for test: gem_madvise results: parsing output: 47/ for test: kms_atomic_interruptible results: parsing output: 48/ for test: gem_render_copy results: parsing output: 49/ for test: prime_vgem results: parsing output: 50/ for test: gem_exec_fence results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: gem_userptr_blits results: parsing output: 53/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 54/ for test: gem_exec_create results: parsing output: 55/ for test: prime_vgem results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: i915_drm_fdinfo results: parsing output: 58/ for test: i915_pm_rpm results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_exec_fence results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: gem_ccs results: parsing output: 63/ for test: core_auth results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_pxp results: parsing output: 66/ for test: gem_flink_basic results: parsing output: 67/ for test: kms_psr2_sf results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: gem_mmap_offset results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: gem_basic results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: gem_lmem_swapping results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_vblank results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: kms_atomic_transition results: parsing output: 86/ for test: kms_cdclk results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: gen9_exec_parse results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_hdmi_inject results: parsing output: 92/ for test: gem_softpin results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_wait results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: kms_pipe_b_c_ivb results: parsing output: 97/ for test: i915_suspend results: parsing output: 98/ for test: kms_plane_lowres results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: gem_exec_whisper results: parsing output: 101/ for test: kms_selftest results: parsing output: 102/ for test: kms_chamelium_hpd results: parsing output: 103/ for test: kms_plane results: parsing output: 104/ for test: gem_tiled_blits results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_softpin results: parsing output: 108/ for test: perf_pmu results: parsing output: 109/ for test: gem_exec_balancer results: parsing output: 110/ for test: kms_content_protection results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: kms_feature_discovery results: parsing output: 114/ for test: kms_addfb_basic results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: dumb_buffer results: parsing output: 121/ for test: i915_module_load results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_flink_race results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_flip_scaled_crc results: parsing output: 131/ for test: gem_exec_schedule results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.