[58.240668] Initializing watchdogs
[58.240810]   /dev/watchdog0
[58.255812] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.260095] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.262857] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.266558] [001/133] (960s left) kms_plane_lowres (tiling-yf)
[58.395872] Starting subtest: tiling-yf
[58.400235] Subtest tiling-yf: SKIP (0.000s)
[58.463583] [002/133] (960s left) kms_flip (wf_vblank-ts-check-interruptible)
[58.564828] Starting subtest: wf_vblank-ts-check-interruptible
[58.567138] Starting dynamic subtest: A-eDP1
[67.547561] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[67.557498] Starting dynamic subtest: B-eDP1
[76.467057] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[76.478073] Starting dynamic subtest: C-eDP1
[85.361278] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[85.368695] Starting dynamic subtest: D-eDP1
[94.348287] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[94.350740] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.743s)
[95.518962] [003/133] (923s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[96.055924] Starting subtest: syncobj-timeline-invalid-flags
[96.058479] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[97.992886] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[97.996542] [004/133] (920s left) kms_psr (fbc-psr2-sprite-plane-move)
[98.102586] Starting subtest: fbc-psr2-sprite-plane-move
[98.104929] Starting dynamic subtest: eDP-1
[98.109290] Dynamic subtest eDP-1: SKIP (0.000s)
[98.113686] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[98.175287] [005/133] (920s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[98.263811] Starting subtest: plane-downscale-factor-0-5-with-rotation
[98.266184] Starting dynamic subtest: pipe-A
[98.283358] Dynamic subtest pipe-A: SKIP (0.017s)
[98.291681] Starting dynamic subtest: pipe-B
[98.312781] Dynamic subtest pipe-B: SKIP (0.029s)
[98.319842] Starting dynamic subtest: pipe-C
[98.343534] Dynamic subtest pipe-C: SKIP (0.029s)
[98.350412] Starting dynamic subtest: pipe-D
[98.372820] Dynamic subtest pipe-D: SKIP (0.029s)
[98.376403] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.105s)
[98.464548] [006/133] (920s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[98.525931] Starting subtest: multi-wait-available-unsubmitted-signaled
[98.528287] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[98.619832] [007/133] (920s left) prime_busy (after-wait)
[98.667535] Starting subtest: after-wait
[98.672153] Starting dynamic subtest: rcs0
[98.709934] Dynamic subtest rcs0: SUCCESS (0.040s)
[98.719405] Starting dynamic subtest: bcs0
[98.757249] Dynamic subtest bcs0: SUCCESS (0.046s)
[98.766243] Starting dynamic subtest: vcs0
[98.798151] Dynamic subtest vcs0: SUCCESS (0.041s)
[98.806499] Starting dynamic subtest: vcs1
[98.838407] Dynamic subtest vcs1: SUCCESS (0.040s)
[98.846690] Starting dynamic subtest: vecs0
[98.880438] Dynamic subtest vecs0: SUCCESS (0.042s)
[98.891505] Starting dynamic subtest: ccs0
[98.920913] Dynamic subtest ccs0: SUCCESS (0.041s)
[99.029038] Subtest after-wait: SUCCESS (0.360s)
[99.101440] [008/133] (919s left) kms_tiled_display (basic-test-pattern)
[99.207138] Subtest basic-test-pattern: SKIP (0.000s)
[99.251900] [009/133] (919s left) gem_exec_balancer (hang)
[99.550366] Starting subtest: hang
[101.140777] Subtest hang: SUCCESS (1.595s)
[101.256605] [010/133] (917s left) gem_pxp (display-protected-crc)
[101.373685] Starting subtest: display-protected-crc
[103.128228] Subtest display-protected-crc: SUCCESS (1.757s)
[103.255354] [011/133] (915s left) gem_softpin (allocator-evict)
[103.316625] Starting subtest: allocator-evict
[103.318930] Starting dynamic subtest: rcs0
[126.796740] Dynamic subtest rcs0: SUCCESS (23.478s)
[126.806927] Starting dynamic subtest: bcs0
[150.915983] Dynamic subtest bcs0: SUCCESS (24.116s)
[150.923980] Starting dynamic subtest: vcs0
[174.661064] Dynamic subtest vcs0: SUCCESS (23.745s)
[174.670187] Starting dynamic subtest: vcs1
[198.485696] Dynamic subtest vcs1: SUCCESS (23.824s)
[198.494221] Starting dynamic subtest: vecs0
[222.367235] Dynamic subtest vecs0: SUCCESS (23.881s)
[222.376791] Starting dynamic subtest: ccs0
[246.429312] Dynamic subtest ccs0: SUCCESS (24.060s)
[246.431707] Subtest allocator-evict: SUCCESS (143.109s)
[246.509574] [012/133] (772s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[246.673371] Starting subtest: 2x-long-flip-vs-cursor-atomic
[246.678059] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[246.813996] [013/133] (772s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[246.882142] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[246.884634] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[246.952727] [014/133] (772s left) kms_atomic_transition (plane-all-transition-nonblocking)
[247.044807] Starting subtest: plane-all-transition-nonblocking
[247.047157] Starting dynamic subtest: pipe-A-eDP-1
[249.539915] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[249.846066] Starting dynamic subtest: pipe-B-eDP-1
[253.042915] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s)
[253.343481] Subtest plane-all-transition-nonblocking: SUCCESS (6.297s)
[254.166324] [015/133] (765s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[254.562041] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[255.382963] [016/133] (763s left) kms_psr (fbc-pr-sprite-render)
[255.479148] Starting subtest: fbc-pr-sprite-render
[255.483593] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[255.549142] [017/133] (763s left) gem_pread (snoop)
[255.608776] Subtest snoop: SKIP (0.000s)
[255.673098] [018/133] (763s left) prime_mmap (test_forked_cpu_write)
[255.729161] Starting subtest: test_forked_cpu_write
[255.731148] Starting dynamic subtest: test_forked_cpu_write-smem
[255.735811] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[255.738124] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[255.819830] [019/133] (763s left) kms_cursor_crc (cursor-onscreen-64x64)
[255.993045] Starting subtest: cursor-onscreen-64x64
[255.995440] Starting dynamic subtest: pipe-A-eDP-1
[258.147044] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.153s)
[258.180637] Starting dynamic subtest: pipe-D-eDP-1
[260.869921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.699s)
[260.871999] Subtest cursor-onscreen-64x64: SUCCESS (4.876s)
[261.680555] [020/133] (757s left) gem_exec_parallel (engines)
[261.737221] Starting subtest: engines
[261.739502] Starting dynamic subtest: basic
[263.895286] Dynamic subtest basic: SUCCESS (2.155s)
[263.904479] Starting dynamic subtest: contexts
[268.264083] Dynamic subtest contexts: SUCCESS (4.366s)
[268.273583] Starting dynamic subtest: fds
[272.012139] Dynamic subtest fds: SUCCESS (3.747s)
[272.021884] Starting dynamic subtest: userptr
[273.876416] Dynamic subtest userptr: SUCCESS (1.863s)
[273.879094] Subtest engines: SUCCESS (12.138s)
[274.064251] [021/133] (745s left) gem_userptr_blits (userfault)
[274.141416] Starting subtest: userfault
[274.143798] Subtest userfault: SUCCESS (0.008s)
[274.266767] [022/133] (745s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[274.364474] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[274.461786] [023/133] (745s left) kms_chamelium_hpd (common-hpd-after-suspend)
[274.850241] Subtest common-hpd-after-suspend: SKIP (0.000s)
[275.683078] [024/133] (744s left) gem_mmap_gtt (hang-busy)
[275.731660] Subtest hang-busy: SKIP (0.000s)
[275.781851] [025/133] (743s left) fbdev (read)
[275.827616] Starting subtest: read
[276.356868] Subtest read: SUCCESS (0.527s)
[276.417372] [026/133] (743s left) kms_frontbuffer_tracking (fbc-tiling-y)
[276.531202] Starting subtest: fbc-tiling-y
[276.535641] Subtest fbc-tiling-y: SKIP (0.000s)
[276.614847] [027/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[276.713093] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[276.717303] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[276.824297] [028/133] (743s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[276.877137] Starting subtest: single-wait-all-for-submit-available-signaled
[276.879454] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[276.974843] [029/133] (742s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[277.067082] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[277.069309] Starting dynamic subtest: pipe-A-eDP-1
[293.431042] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.556s)
[293.441017] Starting dynamic subtest: pipe-B-eDP-1
[310.427448] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.459s)
[310.438466] Starting dynamic subtest: pipe-C-eDP-1
[327.400186] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.433s)
[327.408954] Starting dynamic subtest: pipe-D-eDP-1
[344.365212] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.327s)
[344.367596] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.779s)
[345.616286] [030/133] (674s left) i915_drm_fdinfo (busy-idle-check-all)
[345.672815] Starting subtest: busy-idle-check-all
[345.675088] Starting dynamic subtest: rcs0
[345.681700] Dynamic subtest rcs0: SKIP (0.005s)
[345.690465] Starting dynamic subtest: bcs0
[345.694337] Dynamic subtest bcs0: SKIP (0.000s)
[345.702867] Starting dynamic subtest: vcs0
[345.707385] Dynamic subtest vcs0: SKIP (0.000s)
[345.715813] Starting dynamic subtest: vcs1
[345.720627] Dynamic subtest vcs1: SKIP (0.000s)
[345.732441] Starting dynamic subtest: vecs0
[345.736720] Dynamic subtest vecs0: SKIP (0.000s)
[345.751576] Starting dynamic subtest: ccs0
[345.756106] Dynamic subtest ccs0: SKIP (0.000s)
[345.760433] Subtest busy-idle-check-all: SKIP (0.009s)
[345.805109] [031/133] (674s left) gem_fence_thrash (bo-write-verify-threaded-x)
[345.848718] Starting subtest: bo-write-verify-threaded-x
[345.892024] Subtest bo-write-verify-threaded-x: SKIP (0.040s)
[345.969862] [032/133] (674s left) kms_color (ctm-0-50)
[346.084667] Starting subtest: ctm-0-50
[346.086576] Starting dynamic subtest: pipe-A-eDP-1
[349.613771] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.532s)
[349.622607] Starting dynamic subtest: pipe-B-eDP-1
[353.900641] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.286s)
[353.909638] Starting dynamic subtest: pipe-C-eDP-1
[357.945987] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.045s)
[357.955047] Starting dynamic subtest: pipe-D-eDP-1
[361.931626] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.986s)
[361.934256] Subtest ctm-0-50: SUCCESS (15.852s)
[362.755636] [033/133] (657s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[362.868847] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[362.873319] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[362.934870] [034/133] (657s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[363.031539] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[363.033848] Starting dynamic subtest: pipe-A-eDP-1
[363.092680] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[363.103302] Starting dynamic subtest: pipe-B-eDP-1
[363.160782] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[363.171169] Starting dynamic subtest: pipe-C-eDP-1
[363.228920] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[363.238987] Starting dynamic subtest: pipe-D-eDP-1
[363.296815] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[363.301442] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[365.240117] [035/133] (654s left) kms_addfb_basic (legacy-format)
[365.290866] Starting subtest: legacy-format
[365.311483] Subtest legacy-format: SUCCESS (0.019s)
[365.467624] [036/133] (654s left) perf_pmu (init-sema)
[365.511253] Starting subtest: init-sema
[365.513611] Starting dynamic subtest: rcs0
[365.515882] Dynamic subtest rcs0: SUCCESS (0.002s)
[365.525790] Starting dynamic subtest: bcs0
[365.527957] Dynamic subtest bcs0: SUCCESS (0.000s)
[365.536155] Starting dynamic subtest: vcs0
[365.538086] Dynamic subtest vcs0: SUCCESS (0.001s)
[365.546281] Starting dynamic subtest: vcs1
[365.548167] Dynamic subtest vcs1: SUCCESS (0.001s)
[365.556432] Starting dynamic subtest: vecs0
[365.558343] Dynamic subtest vecs0: SUCCESS (0.000s)
[365.566529] Starting dynamic subtest: ccs0
[365.568460] Dynamic subtest ccs0: SUCCESS (0.001s)
[365.570388] Subtest init-sema: SUCCESS (0.008s)
[365.638679] [037/133] (654s left) gem_exec_reloc (basic-softpin)
[365.699678] Subtest basic-softpin: SKIP (0.000s)
[365.791082] [038/133] (654s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[365.846411] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[365.946026] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[366.027920] [039/133] (654s left) gem_userptr_blits (coherency-sync)
[366.106768] Starting subtest: coherency-sync
[366.330227] Subtest coherency-sync: SKIP (0.185s)
[366.440936] [040/133] (653s left) gem_ctx_param (invalid-get-engines)
[366.547394] Starting subtest: invalid-get-engines
[366.549857] Subtest invalid-get-engines: SUCCESS (0.001s)
[366.666212] [041/133] (653s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[366.772216] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[366.776323] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[366.877388] [042/133] (653s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[366.962648] Starting subtest: drrs-dirtyfb-ioctl
[366.975381] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[367.058661] [043/133] (653s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[367.114851] Starting subtest: basic-batch-kernel-default-cmd
[367.119142] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[367.309159] [044/133] (653s left) gem_exec_flush (basic-wb-ro-default)
[367.370380] Starting subtest: basic-wb-ro-default
[372.855233] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[373.020274] [045/133] (647s left) kms_plane_alpha_blend (alpha-7efc)
[373.115658] Starting subtest: alpha-7efc
[373.399350] Starting dynamic subtest: pipe-A-eDP-1
[373.991452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[374.016819] Starting dynamic subtest: pipe-D-eDP-1
[375.350375] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[375.352975] Subtest alpha-7efc: SUCCESS (2.236s)
[376.187859] [046/133] (644s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[376.298683] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[383.168702] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.873s)
[383.293050] [047/133] (637s left) kms_psr (psr2-cursor-mmap-gtt)
[383.395315] Starting subtest: psr2-cursor-mmap-gtt
[383.397463] Starting dynamic subtest: eDP-1
[385.056056] Dynamic subtest eDP-1: SUCCESS (1.661s)
[385.058425] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.663s)
[385.856487] [048/133] (634s left) perf (gen12-group-concurrent-oa-buffer-read)
[386.009035] Starting subtest: gen12-group-concurrent-oa-buffer-read
[396.049118] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.043s)
[396.095392] [049/133] (624s left) device_reset (unbind-reset-rebind)
[396.154073] Starting subtest: unbind-reset-rebind
[399.166818] Subtest unbind-reset-rebind: SUCCESS (3.011s)
[399.212147] [050/133] (621s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[399.324364] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[399.326504] Starting dynamic subtest: pipe-A-default-mode
[400.469534] Dynamic subtest pipe-A-default-mode: SKIP (1.142s)
[400.473856] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.143s)
[400.616527] [051/133] (620s left) gem_exec_whisper (basic-queues)
[400.697236] Starting subtest: basic-queues
[406.416498] Subtest basic-queues: SUCCESS (5.716s)
[406.612412] [052/133] (614s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[406.750855] Starting subtest: basic-flip-after-cursor-varying-size
[407.700217] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.949s)
[408.564666] [053/133] (612s left) kms_setmode (basic-clone-single-crtc)
[408.633015] Starting subtest: basic-clone-single-crtc
[408.639807] Subtest basic-clone-single-crtc: SKIP (0.000s)
[408.749942] [054/133] (612s left) kms_big_fb (y-tiled-addfb)
[408.865337] Starting subtest: y-tiled-addfb
[408.869827] Subtest y-tiled-addfb: SKIP (0.000s)
[408.961942] [055/133] (612s left) syncobj_timeline (etime-single-wait-all-submitted)
[409.016615] Starting subtest: etime-single-wait-all-submitted
[409.123702] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[409.211961] [056/133] (611s left) kms_pm_rpm (universal-planes-dpms)
[410.733927] Starting subtest: universal-planes-dpms
[410.736737] Starting dynamic subtest: plane-34
[419.152324] Dynamic subtest plane-34: SUCCESS (8.417s)
[419.165422] Starting dynamic subtest: plane-64
[427.472850] Dynamic subtest plane-64: SUCCESS (8.320s)
[427.485881] Starting dynamic subtest: plane-94
[436.103028] Dynamic subtest plane-94: SUCCESS (8.629s)
[436.116300] Starting dynamic subtest: plane-124
[444.421921] Dynamic subtest plane-124: SUCCESS (8.315s)
[444.435063] Starting dynamic subtest: plane-134
[452.711078] Dynamic subtest plane-134: SUCCESS (8.285s)
[452.724089] Starting dynamic subtest: plane-144
[461.006351] Dynamic subtest plane-144: SUCCESS (8.292s)
[461.008925] Subtest universal-planes-dpms: SUCCESS (50.276s)
[461.388320] [057/133] (559s left) gem_ctx_shared (exec-single-timeline)
[461.465019] Starting subtest: exec-single-timeline
[461.467324] Starting dynamic subtest: rcs0
[462.540005] Dynamic subtest rcs0: SUCCESS (1.076s)
[462.554296] Starting dynamic subtest: bcs0
[463.627919] Dynamic subtest bcs0: SUCCESS (1.084s)
[463.641476] Starting dynamic subtest: vcs0
[464.716955] Dynamic subtest vcs0: SUCCESS (1.086s)
[464.730546] Starting dynamic subtest: vcs1
[465.804594] Dynamic subtest vcs1: SUCCESS (1.085s)
[465.818758] Starting dynamic subtest: vecs0
[466.892420] Dynamic subtest vecs0: SUCCESS (1.085s)
[466.904899] Starting dynamic subtest: ccs0
[467.980419] Dynamic subtest ccs0: SUCCESS (1.085s)
[467.983441] Subtest exec-single-timeline: SUCCESS (6.518s)
[468.175289] [058/133] (552s left) i915_pm_rpm (debugfs-read)
[469.698176] Starting subtest: debugfs-read
[470.845970] Subtest debugfs-read: SUCCESS (1.145s)
[471.234769] [059/133] (549s left) kms_invalid_mode (bad-htotal)
[471.334841] Starting subtest: bad-htotal
[471.336976] Starting dynamic subtest: pipe-A-eDP-1
[471.616901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[471.628646] Starting dynamic subtest: pipe-B-eDP-1
[471.630512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[471.642065] Starting dynamic subtest: pipe-C-eDP-1
[471.644218] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[471.653239] Starting dynamic subtest: pipe-D-eDP-1
[471.655397] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[471.657616] Subtest bad-htotal: SUCCESS (0.291s)
[472.448969] [060/133] (548s left) gem_mmap_gtt (basic)
[472.510092] Subtest basic: SKIP (0.000s)
[472.569590] [061/133] (548s left) gem_exec_reloc (basic-gtt-active)
[472.636620] Subtest basic-gtt-active: SKIP (0.000s)
[472.706431] [062/133] (548s left) kms_setmode (invalid-clone-exclusive-crtc)
[472.762166] Starting subtest: invalid-clone-exclusive-crtc
[472.769058] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[472.859645] [063/133] (548s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[472.919855] Subtest untiled-to-tiled: SKIP (0.000s)
[472.990676] [064/133] (548s left) drm_read (empty-nonblock)
[473.137620] Starting subtest: empty-nonblock
[473.140002] Subtest empty-nonblock: SUCCESS (0.000s)
[473.288589] [065/133] (548s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[473.386852] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[473.390130] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[473.465770] [066/133] (547s left) gem_gpgpu_fill (offset-16x16)
[473.531012] Starting subtest: offset-16x16
[473.538831] Subtest offset-16x16: SUCCESS (0.008s)
[473.695331] [067/133] (547s left) kms_vblank (ts-continuation-idle-hang)
[473.791444] Starting subtest: ts-continuation-idle-hang
[473.793505] Starting dynamic subtest: pipe-A-eDP-1
[500.215435] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.424s)
[500.233266] Starting dynamic subtest: pipe-D-eDP-1
[515.186028] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s)
[515.187956] Subtest ts-continuation-idle-hang: SUCCESS (41.396s)
[516.011157] [068/133] (505s left) kms_flip (2x-flip-vs-dpms)
[516.110822] Starting subtest: 2x-flip-vs-dpms
[516.122005] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[516.215569] [069/133] (505s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[516.273584] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[516.278092] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[516.456942] [070/133] (505s left) gem_ctx_persistence (heartbeat-many)
[516.509122] Starting subtest: heartbeat-many
[516.513945] Subtest heartbeat-many: SKIP (0.000s)
[516.608844] [071/133] (505s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[516.707694] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[517.753260] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s)
[517.854942] [072/133] (503s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[517.945466] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[517.949033] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[518.051578] [073/133] (503s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[518.169058] Starting subtest: cursorB-vs-flipB-legacy
[518.172899] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[518.312399] [074/133] (503s left) kms_getfb (getfb-handle-closed)
[518.403927] Starting subtest: getfb-handle-closed
[518.405894] Subtest getfb-handle-closed: SUCCESS (0.000s)
[518.502909] [075/133] (503s left) kms_content_protection (content-type-change)
[518.633081] Starting subtest: content-type-change
[518.636868] Subtest content-type-change: SKIP (0.000s)
[518.750802] [076/133] (503s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[518.850957] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[525.814871] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.967s)
[525.952764] [077/133] (495s left) gem_madvise (dontneed-after-mmap)
[525.994322] Starting subtest: dontneed-after-mmap
[526.017961] Subtest dontneed-after-mmap: SUCCESS (0.026s)
[526.121655] [078/133] (495s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[526.218639] Starting subtest: random-ccs-data-y-tiled-ccs
[526.220957] Starting dynamic subtest: pipe-A-eDP-1
[526.246458] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[526.258096] Starting dynamic subtest: pipe-B-eDP-1
[526.281731] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[526.291882] Starting dynamic subtest: pipe-C-eDP-1
[526.315523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[526.325062] Starting dynamic subtest: pipe-D-eDP-1
[526.348901] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[526.352944] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[528.476134] [079/133] (493s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[528.564080] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[535.879270] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.319s)
[536.017814] [080/133] (486s left) kms_psr (pr-sprite-blt)
[536.116243] Starting subtest: pr-sprite-blt
[536.120705] Subtest pr-sprite-blt: SKIP (0.000s)
[536.190044] [081/133] (485s left) gem_close_race (multigpu-basic-process)
[536.260657] Starting subtest: multigpu-basic-process
[536.264955] Subtest multigpu-basic-process: SKIP (0.000s)
[536.480534] [082/133] (485s left) perf (invalid-oa-metric-set-id)
[536.595893] Starting subtest: invalid-oa-metric-set-id
[536.605158] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[536.644293] [083/133] (485s left) kms_lease (cursor-implicit-plane)
[536.730696] Starting subtest: cursor-implicit-plane
[536.733053] Starting dynamic subtest: pipe-A-eDP-1
[537.187137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[537.198295] Starting dynamic subtest: pipe-B-eDP-1
[538.335090] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[538.346191] Starting dynamic subtest: pipe-C-eDP-1
[539.443406] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[539.454667] Starting dynamic subtest: pipe-D-eDP-1
[540.562316] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[540.564702] Subtest cursor-implicit-plane: SUCCESS (3.832s)
[541.419099] [084/133] (480s left) kms_cursor_crc (cursor-sliding-32x32)
[541.575121] Starting subtest: cursor-sliding-32x32
[541.621744] Subtest cursor-sliding-32x32: SKIP (0.045s)
[541.893832] [085/133] (480s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[541.984026] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[541.988215] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[542.084085] [086/133] (480s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[542.179814] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[542.183951] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[542.278300] [087/133] (480s left) i915_drm_fdinfo (virtual-idle)
[542.314537] Starting subtest: virtual-idle
[545.370351] Subtest virtual-idle: SUCCESS (3.054s)
[545.496614] [088/133] (476s left) gem_userptr_blits (forbidden-operations)
[545.572780] Starting subtest: forbidden-operations
[545.577136] Subtest forbidden-operations: SKIP (0.000s)
[545.718663] [089/133] (476s left) gem_pwrite_snooped
[545.875211] [090/133] (476s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[545.979048] Starting subtest: 4-tiled-8bpp-rotate-180
[547.170843] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.192s)
[547.302059] [091/133] (475s left) gem_pxp (reject-modify-context-protection-off-2)
[547.420154] Starting subtest: reject-modify-context-protection-off-2
[547.422401] Subtest reject-modify-context-protection-off-2: SUCCESS (0.003s)
[547.526246] [092/133] (475s left) syncobj_timeline (invalid-signal-illegal-point)
[547.578643] Starting subtest: invalid-signal-illegal-point
[547.580310] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[547.663908] [093/133] (475s left) gem_readwrite (new-obj)
[547.716168] Subtest new-obj: SKIP (0.000s)
[547.774500] [094/133] (474s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[547.861088] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[547.863072] Starting dynamic subtest: pipe-A
[547.883344] Dynamic subtest pipe-A: SKIP (0.017s)
[547.894789] Starting dynamic subtest: pipe-B
[547.911343] Dynamic subtest pipe-B: SKIP (0.030s)
[547.921231] Starting dynamic subtest: pipe-C
[547.942015] Dynamic subtest pipe-C: SKIP (0.030s)
[547.951644] Starting dynamic subtest: pipe-D
[547.971888] Dynamic subtest pipe-D: SKIP (0.030s)
[547.975049] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.109s)
[548.049621] [095/133] (474s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[548.142816] Starting subtest: primary-yf-tiled-reflect-x-270
[548.146461] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[548.217596] [096/133] (474s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[548.319940] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[548.323503] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[548.417356] [097/133] (474s left) kms_big_fb (linear-8bpp-rotate-180)
[548.507998] Starting subtest: linear-8bpp-rotate-180
[549.766138] Subtest linear-8bpp-rotate-180: SUCCESS (1.257s)
[549.890996] [098/133] (472s left) gem_exec_schedule (u-lateslice)
[549.953626] Starting subtest: u-lateslice
[549.955307] Starting dynamic subtest: rcs0
[549.965977] Dynamic subtest rcs0: SUCCESS (0.020s)
[549.978283] Starting dynamic subtest: bcs0
[549.982612] Dynamic subtest bcs0: SUCCESS (0.016s)
[549.992355] Starting dynamic subtest: vcs0
[549.999658] Dynamic subtest vcs0: SUCCESS (0.017s)
[550.009304] Starting dynamic subtest: vcs1
[550.017886] Dynamic subtest vcs1: SUCCESS (0.017s)
[550.027399] Starting dynamic subtest: vecs0
[550.034669] Dynamic subtest vecs0: SUCCESS (0.016s)
[550.044224] Starting dynamic subtest: ccs0
[550.055154] Dynamic subtest ccs0: SUCCESS (0.020s)
[550.057142] Subtest u-lateslice: SUCCESS (0.110s)
[551.536067] [099/133] (471s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[551.638021] Starting subtest: plane-use-after-nonblocking-unbind
[551.640188] Starting dynamic subtest: pipe-A-eDP-1
[551.698897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[552.003231] Starting dynamic subtest: pipe-B-eDP-1
[552.822840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.830s)
[553.140697] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.502s)
[553.983788] [100/133] (469s left) gem_mmap_gtt (cpuset-big-copy-odd)
[554.054346] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[554.122711] [101/133] (468s left) gem_caching (read-writes)
[554.186945] Subtest read-writes: SKIP (0.000s)
[554.253088] [102/133] (468s left) i915_selftest (perf)
[557.548417] Starting subtest: perf
[557.551192] Starting dynamic subtest: engine_cs
[560.294342] Dynamic subtest engine_cs: SUCCESS (2.749s)
[560.304463] Starting dynamic subtest: request
[567.623764] Dynamic subtest request: SUCCESS (7.329s)
[567.633837] Starting dynamic subtest: migrate
[571.966927] Dynamic subtest migrate: SUCCESS (4.340s)
[571.977346] Starting dynamic subtest: region
[577.588200] Dynamic subtest region: SUCCESS (5.619s)
[577.590890] Subtest perf: SUCCESS (20.042s)
[577.619542] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[577.620329] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[577.623910] [103/133] (445s left) kms_dsc (dsc-with-formats)
[579.188646] Starting subtest: dsc-with-formats
[579.228261] Subtest dsc-with-formats: SKIP (0.001s)
[579.296387] [FACT kms_dsc (dsc-with-formats)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[579.299729] [FACT kms_dsc (dsc-with-formats)] new: kernel.kmod_is_loaded.i915: true
[579.303748] [104/133] (443s left) kms_getfb (getfb2-handle-zero)
[579.402303] Starting subtest: getfb2-handle-zero
[579.404583] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[579.493595] [105/133] (443s left) gem_exec_balancer (sliced)
[579.582742] Starting subtest: sliced
[579.587353] Subtest sliced: SKIP (0.000s)
[579.895326] [106/133] (443s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[579.978633] Starting subtest: fbc-pr-cursor-mmap-cpu
[579.983150] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[580.065024] [107/133] (443s left) kms_atomic_transition (modeset-transition)
[580.173627] Starting subtest: modeset-transition
[580.175542] Starting dynamic subtest: 1x-outputs
[591.048733] Dynamic subtest 1x-outputs: SUCCESS (10.874s)
[591.051226] Subtest modeset-transition: SUCCESS (10.876s)
[591.907137] [108/133] (431s left) syncobj_wait (multi-wait-signaled)
[591.965641] Starting subtest: multi-wait-signaled
[591.967869] Subtest multi-wait-signaled: SUCCESS (0.000s)
[592.044125] [109/133] (431s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[592.166422] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[592.824444] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[592.973914] [110/133] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[593.074518] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[593.078887] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[593.174055] [111/133] (430s left) gem_eio (wait-wedge-10ms)
[593.370178] Starting subtest: wait-wedge-10ms
[594.448213] Subtest wait-wedge-10ms: SUCCESS (1.076s)
[594.590590] [112/133] (428s left) kms_pm_rpm (fences)
[596.528116] Starting subtest: fences
[596.533068] Subtest fences: SKIP (0.000s)
[596.918328] [113/133] (426s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[597.006293] Starting subtest: pixel-format-y-tiled-ccs-modifier
[597.010690] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[597.080396] [114/133] (426s left) kms_scaling_modes (scaling-mode-full)
[597.173507] Starting subtest: scaling-mode-full
[597.175937] Starting dynamic subtest: pipe-A-eDP-1
[597.264995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[597.275490] Starting dynamic subtest: pipe-B-eDP-1
[598.421271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[598.433380] Starting dynamic subtest: pipe-C-eDP-1
[599.558513] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[599.571034] Starting dynamic subtest: pipe-D-eDP-1
[600.695063] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[600.697434] Subtest scaling-mode-full: SUCCESS (3.526s)
[601.858495] [115/133] (421s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[601.941177] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[601.945279] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[602.029228] [116/133] (421s left) vgem_basic (setversion)
[602.076944] Starting subtest: setversion
[602.081162] Subtest setversion: SUCCESS (0.000s)
[602.133053] [117/133] (421s left) gen9_exec_parse (allowed-single)
[602.192900] Subtest allowed-single: SKIP (0.000s)
[602.270978] [118/133] (421s left) syncobj_timeline (wait-for-submit-delayed-submit)
[602.319617] Starting subtest: wait-for-submit-delayed-submit
[602.423437] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[602.502324] [119/133] (421s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[602.585515] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[602.587783] Starting dynamic subtest: pipe-A-eDP-1
[602.610080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[602.620054] Starting dynamic subtest: pipe-B-eDP-1
[602.641306] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[602.650790] Starting dynamic subtest: pipe-C-eDP-1
[602.671927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[602.681178] Starting dynamic subtest: pipe-D-eDP-1
[602.703131] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[602.707200] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[604.915727] [120/133] (418s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[605.021940] Starting subtest: pr-overlay-plane-update-continuous-sf
[605.025986] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[605.102883] [121/133] (418s left) kms_cursor_crc (cursor-random-32x32)
[605.253452] Starting subtest: cursor-random-32x32
[605.295941] Subtest cursor-random-32x32: SKIP (0.040s)
[605.650077] [122/133] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[605.771793] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[605.776161] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[605.872798] [123/133] (418s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[605.976362] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[609.701994] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.727s)
[610.847557] [124/133] (413s left) api_intel_allocator (standalone)
[610.907831] Starting subtest: standalone
[610.922551] Subtest standalone: SUCCESS (0.017s)
[611.044632] [125/133] (413s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[611.159775] Starting subtest: psr-rgb101010-draw-mmap-wc
[618.188683] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.033s)
[618.305950] [126/133] (405s left) kms_flip (modeset-vs-vblank-race)
[618.398735] Starting subtest: modeset-vs-vblank-race
[618.401154] Starting dynamic subtest: A-eDP1
[623.086464] Dynamic subtest A-eDP1: SUCCESS (4.687s)
[623.102222] Starting dynamic subtest: B-eDP1
[627.822277] Dynamic subtest B-eDP1: SUCCESS (4.733s)
[627.839301] Starting dynamic subtest: C-eDP1
[632.683797] Dynamic subtest C-eDP1: SUCCESS (4.858s)
[632.695338] Starting dynamic subtest: D-eDP1
[637.216088] Dynamic subtest D-eDP1: SUCCESS (4.530s)
[637.221589] Subtest modeset-vs-vblank-race: SUCCESS (18.823s)
[638.378007] [127/133] (385s left) kms_flip (2x-plain-flip-interruptible)
[638.473766] Starting subtest: 2x-plain-flip-interruptible
[638.486045] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[638.561433] [128/133] (385s left) api_intel_bb (misplaced-blitter)
[638.610480] Starting subtest: misplaced-blitter
[638.615770] Subtest misplaced-blitter: SUCCESS (0.007s)
[638.742830] [129/133] (385s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[638.838611] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[646.333790] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.497s)
[646.483663] [130/133] (377s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[646.587629] Starting subtest: fbc-shrfb-scaledprimary
[649.599388] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.014s)
[650.814515] [131/133] (373s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[650.916745] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[650.918639] Starting dynamic subtest: pipe-A-eDP-1
[653.040435] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s)
[653.049806] Starting dynamic subtest: pipe-B-eDP-1
[655.336985] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.295s)
[655.346420] Starting dynamic subtest: pipe-C-eDP-1
[657.528607] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.191s)
[657.538422] Starting dynamic subtest: pipe-D-eDP-1
[659.669011] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.139s)
[659.671080] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.755s)
[660.836272] [132/133] (363s left) gem_create (create-valid-nonaligned)
[660.907144] Starting subtest: create-valid-nonaligned
[660.909365] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[661.091283] [133/133] (363s left) gem_exec_schedule (pi-userfault)
[661.279381] Starting subtest: pi-userfault
[661.281625] Starting dynamic subtest: rcs0
[661.291276] Dynamic subtest rcs0: SUCCESS (0.013s)
[661.304166] Starting dynamic subtest: bcs0
[661.306107] Dynamic subtest bcs0: SUCCESS (0.010s)
[661.316331] Starting dynamic subtest: vcs0
[661.318579] Dynamic subtest vcs0: SUCCESS (0.009s)
[661.328223] Starting dynamic subtest: vcs1
[661.330119] Dynamic subtest vcs1: SUCCESS (0.011s)
[661.339148] Starting dynamic subtest: vecs0
[661.341325] Dynamic subtest vecs0: SUCCESS (0.011s)
[661.350445] Starting dynamic subtest: ccs0
[661.352300] Dynamic subtest ccs0: SUCCESS (0.011s)
[661.354210] Subtest pi-userfault: SUCCESS (0.069s)
[661.540335] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_lowres
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: prime_busy
results: parsing output: 7/ for test: kms_tiled_display
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_atomic_transition
results: parsing output: 14/ for test: kms_chamelium_edid
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_pread
results: parsing output: 17/ for test: prime_mmap
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_exec_parallel
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: kms_chamelium_hpd
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: fbdev
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: gem_fence_thrash
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_dirtyfb
results: parsing output: 42/ for test: gem_exec_flush
results: parsing output: 43/ for test: gem_exec_flush
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: device_reset
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_exec_whisper
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_setmode
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: gem_ctx_shared
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: gem_set_tiling_vs_blt
results: parsing output: 63/ for test: drm_read
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_gpgpu_fill
results: parsing output: 66/ for test: kms_vblank
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_getfb
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_madvise
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_close_race
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: gem_pwrite_snooped
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_readwrite
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: gem_caching
results: parsing output: 101/ for test: i915_selftest
results: parsing output: 102/ for test: kms_dsc
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_atomic_transition
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_scaling_modes
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: vgem_basic
results: parsing output: 116/ for test: gen9_exec_parse
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: api_intel_bb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: gem_create
results: parsing output: 132/ for test: gem_exec_schedule
Done.