[66.678353] Initializing watchdogs
[66.678399]   /dev/watchdog0
[66.691085] [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]
[66.695416] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.697751] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.701011] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[66.834639] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[74.065294] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.406s)
[74.216171] [002/131] (953s left) gem_eio (kms)
[74.405993] Starting subtest: kms
[95.721626] Subtest kms: SUCCESS (21.469s)
[96.900909] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[96.904050] [003/131] (930s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[97.032849] Starting subtest: cursorB-vs-flipB-toggle
[97.037285] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[97.175394] [004/131] (930s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[97.549681] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[98.324639] [005/131] (929s left) kms_lease (lease-revoke)
[98.426184] Starting subtest: lease-revoke
[98.428468] Starting dynamic subtest: pipe-A-eDP-1
[98.454889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[98.465270] Starting dynamic subtest: pipe-B-eDP-1
[98.484879] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[98.492457] Starting dynamic subtest: pipe-C-eDP-1
[98.512593] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[98.521611] Starting dynamic subtest: pipe-D-eDP-1
[98.538213] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[98.540495] Subtest lease-revoke: SUCCESS (0.114s)
[98.659111] [006/131] (928s left) api_intel_bb (blit-reloc-keep-cache)
[98.711081] Starting subtest: blit-reloc-keep-cache
[98.715611] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[98.847853] [007/131] (928s left) kms_psr (psr2-sprite-mmap-gtt)
[98.933180] Starting subtest: psr2-sprite-mmap-gtt
[98.935578] Starting dynamic subtest: eDP-1
[100.348389] Dynamic subtest eDP-1: SKIP (1.414s)
[100.353144] Subtest psr2-sprite-mmap-gtt: SKIP (1.415s)
[100.507829] [008/131] (926s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[100.625445] Starting subtest: cursor-vs-flip-varying-size
[131.131027] Subtest cursor-vs-flip-varying-size: SUCCESS (30.502s)
[132.007829] [009/131] (895s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[137.010618] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[137.012899] Starting dynamic subtest: pipe-A-eDP-1
[143.650069] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.637s)
[143.659629] Starting dynamic subtest: pipe-B-eDP-1
[150.306801] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.657s)
[150.309103] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.298s)
[151.106975] [010/131] (876s left) kms_chamelium_frames (dp-crc-single)
[151.494755] Subtest dp-crc-single: SKIP (0.000s)
[152.306635] [011/131] (875s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[152.403216] Starting subtest: psr-2p-pri-indfb-multidraw
[152.407257] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[152.510773] [012/131] (875s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[152.607727] Starting subtest: read-crc-frame-sequence
[152.610064] Starting dynamic subtest: pipe-A-eDP-1
[153.299269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s)
[153.309052] Starting dynamic subtest: pipe-B-eDP-1
[154.699463] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.402s)
[154.708758] Starting dynamic subtest: pipe-C-eDP-1
[155.972266] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s)
[155.980545] Starting dynamic subtest: pipe-D-eDP-1
[157.313630] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[157.315851] Subtest read-crc-frame-sequence: SUCCESS (4.707s)
[158.158892] [013/131] (869s left) gem_exec_fence (syncobj-timeline-export)
[158.689550] Starting subtest: syncobj-timeline-export
[158.694911] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[159.946116] [014/131] (867s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[160.051081] Starting subtest: x-tiled-16bpp-rotate-180
[161.428149] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.379s)
[161.580731] [015/131] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[161.677627] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[168.343467] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.669s)
[168.454861] [016/131] (859s left) kms_invalid_mode (bad-vsync-start)
[168.552518] Starting subtest: bad-vsync-start
[168.554791] Starting dynamic subtest: pipe-A-eDP-1
[168.833750] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[168.841855] Starting dynamic subtest: pipe-B-eDP-1
[168.843852] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[168.851512] Starting dynamic subtest: pipe-C-eDP-1
[168.853549] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[168.861539] Starting dynamic subtest: pipe-D-eDP-1
[168.863817] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[168.866124] Subtest bad-vsync-start: SUCCESS (0.288s)
[169.657619] [017/131] (858s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[169.773551] Starting subtest: short-flip-before-cursor-toggle
[170.709806] Subtest short-flip-before-cursor-toggle: SUCCESS (0.935s)
[171.506299] [018/131] (856s left) gem_mmap_offset (bad-extensions)
[171.558632] Starting subtest: bad-extensions
[171.560466] Subtest bad-extensions: SUCCESS (0.000s)
[171.656852] [019/131] (856s left) gem_exec_fence (nb-await)
[171.827843] Starting subtest: nb-await
[171.830380] Starting dynamic subtest: rcs0
[171.895881] Dynamic subtest rcs0: SUCCESS (0.068s)
[171.907627] Starting dynamic subtest: bcs0
[171.952879] Dynamic subtest bcs0: SUCCESS (0.056s)
[171.963999] Starting dynamic subtest: vcs0
[172.011541] Dynamic subtest vcs0: SUCCESS (0.057s)
[172.024513] Starting dynamic subtest: vcs1
[172.070990] Dynamic subtest vcs1: SUCCESS (0.058s)
[172.081850] Starting dynamic subtest: vecs0
[172.129936] Dynamic subtest vecs0: SUCCESS (0.057s)
[172.140130] Starting dynamic subtest: ccs0
[172.187754] Dynamic subtest ccs0: SUCCESS (0.057s)
[172.190321] Subtest nb-await: SUCCESS (0.361s)
[173.970158] [020/131] (853s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[174.067219] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[174.069543] Starting dynamic subtest: A-eDP1
[177.622634] Dynamic subtest A-eDP1: SUCCESS (3.553s)
[177.632043] Starting dynamic subtest: B-eDP1
[180.825632] Dynamic subtest B-eDP1: SUCCESS (3.202s)
[180.833671] Starting dynamic subtest: C-eDP1
[183.934428] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[183.943090] Starting dynamic subtest: D-eDP1
[187.015560] Dynamic subtest D-eDP1: SUCCESS (3.077s)
[187.017528] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.948s)
[187.810526] [021/131] (840s left) fbdev (info)
[187.845046] Starting subtest: info
[187.847068] Subtest info: SUCCESS (0.000s)
[187.913686] [022/131] (840s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[188.007513] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[188.009939] Starting dynamic subtest: pipe-A
[188.019272] Dynamic subtest pipe-A: SKIP (0.005s)
[188.029463] Starting dynamic subtest: pipe-B
[188.038575] Dynamic subtest pipe-B: SKIP (0.017s)
[188.046828] Starting dynamic subtest: pipe-C
[188.055941] Dynamic subtest pipe-C: SKIP (0.018s)
[188.063692] Starting dynamic subtest: pipe-D
[188.071675] Dynamic subtest pipe-D: SKIP (0.017s)
[188.075469] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.059s)
[188.164453] [023/131] (839s left) gem_ctx_isolation (clean)
[188.223850] Starting subtest: clean
[188.226441] Starting dynamic subtest: rcs0
[188.298074] Dynamic subtest rcs0: SUCCESS (0.074s)
[188.306170] Starting dynamic subtest: bcs0
[188.390121] Dynamic subtest bcs0: SUCCESS (0.091s)
[188.398737] Starting dynamic subtest: vcs0
[188.474911] Dynamic subtest vcs0: SUCCESS (0.084s)
[188.482780] Starting dynamic subtest: vcs1
[189.911172] Dynamic subtest vcs1: SUCCESS (1.436s)
[189.918978] Starting dynamic subtest: vecs0
[191.949110] Dynamic subtest vecs0: SUCCESS (2.037s)
[191.956850] Starting dynamic subtest: ccs0
[193.940310] Dynamic subtest ccs0: SUCCESS (1.989s)
[193.942901] Subtest clean: SUCCESS (5.715s)
[194.186266] [024/131] (833s left) gem_userptr_blits (stress-purge)
[194.260134] Starting subtest: stress-purge
[199.658937] Subtest stress-purge: SUCCESS (5.400s)
[199.800024] [025/131] (828s left) perf (stress-open-close)
[199.967918] Starting subtest: stress-open-close
[199.969897] Starting dynamic subtest: 0-rcs0
[202.136574] Dynamic subtest 0-rcs0: SUCCESS (2.170s)
[202.145247] Starting dynamic subtest: 1-vcs1
[204.300467] Dynamic subtest 1-vcs1: SUCCESS (2.163s)
[204.302414] Subtest stress-open-close: SUCCESS (4.335s)
[204.347404] [026/131] (823s left) gem_exec_whisper (basic-sync)
[204.409506] Starting subtest: basic-sync
[214.911063] Subtest basic-sync: SUCCESS (10.500s)
[215.089162] [027/131] (813s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[215.160649] Starting subtest: x-tiled-to-vebox-yf-tiled
[215.165285] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[215.342316] [028/131] (812s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[215.442750] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[215.444840] Starting dynamic subtest: pipe-A-default-mode
[215.739977] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[215.744279] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.297s)
[216.550487] [029/131] (811s left) kms_atomic_transition (plane-all-transition-nonblocking)
[216.646291] Starting subtest: plane-all-transition-nonblocking
[216.648834] Starting dynamic subtest: pipe-A-eDP-1
[219.146256] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[219.454877] Starting dynamic subtest: pipe-B-eDP-1
[222.692746] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.250s)
[223.009031] Subtest plane-all-transition-nonblocking: SUCCESS (6.363s)
[223.816087] [030/131] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[223.925754] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[223.929818] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[224.033328] [031/131] (804s left) syncobj_timeline (multi-wait-signaled)
[224.091768] Starting subtest: multi-wait-signaled
[224.094066] Subtest multi-wait-signaled: SUCCESS (0.001s)
[224.194365] [032/131] (804s left) gem_lmem_swapping (basic)
[224.237748] Subtest basic: SKIP (0.000s)
[224.281276] [033/131] (804s left) gem_pxp (regular-baseline-src-copy-readible)
[224.399796] Starting subtest: regular-baseline-src-copy-readible
[224.456951] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[224.599998] [034/131] (803s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[224.650020] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[224.652237] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[224.750858] [035/131] (803s left) sysfs_heartbeat_interval (nopreempt)
[224.814372] Starting subtest: nopreempt
[224.816461] Starting dynamic subtest: vecs0
[234.920868] Dynamic subtest vecs0: SUCCESS (10.102s)
[234.931820] Starting dynamic subtest: ccs0
[239.005956] Dynamic subtest ccs0: SUCCESS (4.085s)
[239.017488] Starting dynamic subtest: vcs0
[248.931773] Dynamic subtest vcs0: SUCCESS (9.921s)
[248.943620] Starting dynamic subtest: bcs0
[252.968831] Dynamic subtest bcs0: SUCCESS (4.037s)
[252.980060] Starting dynamic subtest: rcs0
[257.121774] Dynamic subtest rcs0: SUCCESS (4.152s)
[257.134270] Starting dynamic subtest: vcs1
[266.927208] Dynamic subtest vcs1: SUCCESS (9.802s)
[266.929667] Subtest nopreempt: SUCCESS (42.110s)
[267.004088] [036/131] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[267.112276] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[267.116591] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[267.220403] [037/131] (761s left) i915_suspend (fence-restore-untiled)
[267.287674] Starting subtest: fence-restore-untiled
[267.291770] Subtest fence-restore-untiled: SKIP (0.000s)
[267.393670] [038/131] (761s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[267.490169] Starting subtest: async-flip-with-page-flip-events-tiled
[267.858469] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[270.593107] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[270.603089] Starting dynamic subtest: pipe-A-eDP-1-4
[272.767783] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[272.776580] Starting dynamic subtest: pipe-A-eDP-1-4
[274.777989] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[274.789522] Starting dynamic subtest: pipe-A-eDP-1-x
[276.966945] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[277.342114] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[280.123852] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[280.133134] Starting dynamic subtest: pipe-B-eDP-1-4
[282.310543] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[282.319701] Starting dynamic subtest: pipe-B-eDP-1-4
[284.320737] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[284.329571] Starting dynamic subtest: pipe-B-eDP-1-x
[286.510942] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[286.872460] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[289.653721] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[289.663352] Starting dynamic subtest: pipe-C-eDP-1-4
[291.841237] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.186s)
[291.853036] Starting dynamic subtest: pipe-C-eDP-1-4
[293.851381] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[293.862094] Starting dynamic subtest: pipe-C-eDP-1-x
[296.029765] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[296.398803] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[299.190830] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[299.201903] Starting dynamic subtest: pipe-D-eDP-1-4
[301.365057] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[301.373952] Starting dynamic subtest: pipe-D-eDP-1-4
[303.376411] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[303.388052] Starting dynamic subtest: pipe-D-eDP-1-x
[305.565542] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[305.568055] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.076s)
[306.775460] [039/131] (721s left) gem_exec_reloc (basic-write-read-active)
[306.843776] Subtest basic-write-read-active: SKIP (0.000s)
[306.909765] [040/131] (721s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[307.010535] Starting subtest: fbc-rgb101010-draw-blt
[311.607756] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.600s)
[312.781201] [041/131] (715s left) perf (gen12-group-concurrent-oa-buffer-read)
[312.862183] Starting subtest: gen12-group-concurrent-oa-buffer-read
[322.897616] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.033s)
[322.934896] [042/131] (705s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[323.040626] Starting subtest: yf-tiled-8bpp-rotate-90
[323.045108] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[323.162045] [043/131] (705s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[323.444055] Starting subtest: cursor-rapid-movement-512x512
[323.448447] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[323.631471] [044/131] (705s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[323.752478] Starting subtest: 2x-flip-vs-cursor-legacy
[323.757037] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[323.894124] [045/131] (704s left) gem_mmap_gtt (basic-read)
[323.944614] Subtest basic-read: SKIP (0.000s)
[324.007610] [046/131] (704s left) syncobj_wait (invalid-reset-one-illegal-handle)
[324.061162] Starting subtest: invalid-reset-one-illegal-handle
[324.062666] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[324.172160] [047/131] (704s left) kms_pm_dc (dc6-psr)
[325.288887] Starting subtest: dc6-psr
[328.258254] Subtest dc6-psr: SUCCESS (2.975s)
[329.093325] [048/131] (699s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[329.153687] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[329.240433] [049/131] (699s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[334.267820] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[334.270814] Starting dynamic subtest: pipe-A-eDP-1
[335.064856] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[335.074530] Starting dynamic subtest: pipe-B-eDP-1
[336.195595] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[336.200259] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.928s)
[337.385702] [050/131] (691s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[337.447524] Starting subtest: multi-wait-all-for-submit-signaled
[337.449889] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[337.556893] [051/131] (691s left) gem_create (create-ext-cpu-access-sanity-check)
[337.717303] Starting subtest: create-ext-cpu-access-sanity-check
[337.721457] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s)
[337.786157] [052/131] (691s left) kms_rotation_crc (bad-pixel-format)
[337.881061] Starting subtest: bad-pixel-format
[337.885283] Subtest bad-pixel-format: SKIP (0.001s)
[337.953190] [053/131] (691s left) perf (invalid-oa-metric-set-id)
[338.035921] Starting subtest: invalid-oa-metric-set-id
[338.044312] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[338.082552] [054/131] (691s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[338.188931] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[338.191277] Starting dynamic subtest: pipe-A-eDP-1
[338.215279] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[338.224593] Starting dynamic subtest: pipe-B-eDP-1
[338.247121] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[338.255453] Starting dynamic subtest: pipe-C-eDP-1
[338.277931] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[338.286009] Starting dynamic subtest: pipe-D-eDP-1
[338.308674] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[338.312820] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[340.352740] [055/131] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[340.447934] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[340.452352] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[340.570184] [056/131] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[340.674640] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[340.679159] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[340.789923] [057/131] (688s left) gem_ctx_shared (q-independent)
[340.850906] Starting subtest: Q-independent
[340.853263] Starting dynamic subtest: rcs0
[340.918592] Dynamic subtest rcs0: SUCCESS (0.067s)
[340.928096] Starting dynamic subtest: vcs0
[340.959814] Dynamic subtest vcs0: SUCCESS (0.040s)
[340.968939] Starting dynamic subtest: vcs1
[341.003489] Dynamic subtest vcs1: SUCCESS (0.043s)
[341.012291] Starting dynamic subtest: vecs0
[341.046948] Dynamic subtest vecs0: SUCCESS (0.043s)
[341.055500] Starting dynamic subtest: ccs0
[341.103847] Dynamic subtest ccs0: SUCCESS (0.056s)
[341.106704] Subtest Q-independent: SUCCESS (0.253s)
[342.978250] [058/131] (686s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[343.074548] Starting subtest: y-tiled-32bpp-rotate-270
[343.078551] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[343.181834] [059/131] (686s left) kms_plane_lowres (tiling-none)
[343.269047] Starting subtest: tiling-none
[343.271352] Starting dynamic subtest: pipe-A-eDP-1
[343.275939] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[343.566157] Starting dynamic subtest: pipe-B-eDP-1
[343.570757] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[343.579769] Starting dynamic subtest: pipe-C-eDP-1
[343.584330] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[343.593191] Starting dynamic subtest: pipe-D-eDP-1
[343.597211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[343.601212] Subtest tiling-none: SKIP (0.294s)
[344.392094] [060/131] (685s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[344.494037] Starting subtest: y-tiled-8bpp-rotate-90
[344.498416] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[344.600906] [061/131] (684s left) i915_module_load (reload-with-fault-injection)
[344.640310] Starting subtest: reload-with-fault-injection
[387.115697] Subtest reload-with-fault-injection: SUCCESS (42.477s)
[387.141663] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[387.142367] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[387.145368] [062/131] (642s left) kms_flip (2x-absolute-wf_vblank)
[388.618446] Starting subtest: 2x-absolute-wf_vblank
[388.627575] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[388.712198] [FACT kms_flip (2x-absolute-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.713417] [FACT kms_flip (2x-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true
[388.716979] [063/131] (640s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[388.833950] Starting subtest: x-tiled-64bpp-rotate-270
[388.868591] Subtest x-tiled-64bpp-rotate-270: SKIP (0.033s)
[388.990459] [064/131] (640s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[389.087871] Starting subtest: dsc-fractional-bpp-with-bpc
[389.117979] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[389.159021] [065/131] (640s left) i915_power (sanity)
[389.210041] Starting subtest: sanity
[393.261614] Subtest sanity: SUCCESS (4.046s)
[394.934954] [066/131] (634s left) gen9_exec_parse (bb-start-cmd)
[394.998512] Subtest bb-start-cmd: SKIP (0.000s)
[395.087148] [067/131] (634s left) prime_self_import (basic-with_two_bos)
[395.122944] Starting subtest: basic-with_two_bos
[395.150977] Subtest basic-with_two_bos: SUCCESS (0.029s)
[395.257251] [068/131] (634s left) gen9_exec_parse (batch-invalid-length)
[395.308620] Subtest batch-invalid-length: SKIP (0.000s)
[395.366314] [069/131] (634s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[395.469670] Starting subtest: psr-rgb565-draw-blt
[402.382526] Subtest psr-rgb565-draw-blt: SUCCESS (6.915s)
[402.538735] [070/131] (627s left) kms_addfb_basic (basic)
[402.598897] Starting subtest: basic
[402.601108] Subtest basic: SUCCESS (0.000s)
[402.736256] [071/131] (627s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[402.784805] Starting subtest: y-tiled-to-vebox-x-tiled
[402.789277] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[402.964314] [072/131] (626s left) api_intel_bb (simple-bb)
[403.014412] Starting subtest: simple-bb
[403.017119] Subtest simple-bb: SUCCESS (0.006s)
[403.149968] [073/131] (626s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[403.248051] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[403.250344] Starting dynamic subtest: pipe-A-eDP-1
[403.271050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[403.281642] Starting dynamic subtest: pipe-B-eDP-1
[403.301152] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[403.309747] Starting dynamic subtest: pipe-C-eDP-1
[403.329346] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[403.338238] Starting dynamic subtest: pipe-D-eDP-1
[403.357851] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[403.360091] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[405.448185] [074/131] (624s left) gem_partial_pwrite_pread (reads-snoop)
[405.507933] Subtest reads-snoop: SKIP (0.000s)
[405.600021] [075/131] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[405.693015] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[414.150717] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.461s)
[414.262069] [076/131] (615s left) gem_exec_schedule (u-independent)
[414.339239] Starting subtest: u-independent
[414.341474] Starting dynamic subtest: rcs0
[415.891646] Dynamic subtest rcs0: SUCCESS (1.557s)
[415.904092] Starting dynamic subtest: vcs0
[417.977266] Dynamic subtest vcs0: SUCCESS (2.085s)
[417.989054] Starting dynamic subtest: vcs1
[419.964826] Dynamic subtest vcs1: SUCCESS (1.985s)
[419.976521] Starting dynamic subtest: vecs0
[421.913260] Dynamic subtest vecs0: SUCCESS (1.947s)
[421.921859] Starting dynamic subtest: ccs0
[423.891548] Dynamic subtest ccs0: SUCCESS (1.976s)
[423.894024] Subtest u-independent: SUCCESS (9.559s)
[424.187217] [077/131] (605s left) kms_busy (extended-pageflip-hang-oldfb)
[424.291126] Starting subtest: extended-pageflip-hang-oldfb
[424.295974] Starting dynamic subtest: pipe-A
[424.719162] Dynamic subtest pipe-A: SUCCESS (0.423s)
[424.729025] Starting dynamic subtest: pipe-D
[425.821780] Dynamic subtest pipe-D: SUCCESS (1.101s)
[425.824065] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.530s)
[426.646912] [078/131] (603s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[426.706518] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[426.807948] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[426.885400] [079/131] (603s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[427.002655] Starting subtest: cursor-vs-flip-atomic-transitions
[456.871198] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.869s)
[457.669420] [080/131] (572s left) kms_big_fb (linear-32bpp-rotate-180)
[457.773726] Starting subtest: linear-32bpp-rotate-180
[459.194467] Subtest linear-32bpp-rotate-180: SUCCESS (1.422s)
[459.337991] [081/131] (570s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[459.437213] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[459.440487] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[459.541004] [082/131] (570s left) perf (polling)
[459.644525] Starting subtest: polling
[459.646562] Starting dynamic subtest: 0-rcs0
[469.673083] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[469.682095] Starting dynamic subtest: 1-vcs0
[479.693157] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[479.695616] Subtest polling: SUCCESS (20.047s)
[479.740461] [083/131] (550s left) sw_sync (alloc_fence)
[479.773755] Starting subtest: alloc_fence
[479.775885] Subtest alloc_fence: SUCCESS (0.000s)
[479.834218] [084/131] (550s left) gem_exec_reloc (basic-concurrent16)
[479.890947] Subtest basic-concurrent16: SKIP (0.000s)
[479.966665] [085/131] (550s left) kms_cursor_crc (cursor-offscreen-32x32)
[480.125369] Starting subtest: cursor-offscreen-32x32
[480.164604] Subtest cursor-offscreen-32x32: SKIP (0.036s)
[480.456694] [086/131] (549s left) gem_ctx_persistence (engines-persistence)
[480.524672] Starting subtest: engines-persistence
[480.527027] Starting dynamic subtest: rcs0
[481.313281] Dynamic subtest rcs0: SUCCESS (0.788s)
[481.324866] Starting dynamic subtest: bcs0
[482.086273] Dynamic subtest bcs0: SUCCESS (0.771s)
[482.096552] Starting dynamic subtest: vcs0
[482.845507] Dynamic subtest vcs0: SUCCESS (0.757s)
[482.860693] Starting dynamic subtest: vcs1
[483.624068] Dynamic subtest vcs1: SUCCESS (0.777s)
[483.635148] Starting dynamic subtest: vecs0
[484.353865] Dynamic subtest vecs0: SUCCESS (0.728s)
[484.364867] Starting dynamic subtest: ccs0
[485.226906] Dynamic subtest ccs0: SUCCESS (0.871s)
[485.229703] Subtest engines-persistence: SUCCESS (4.703s)
[485.304882] [087/131] (545s left) kms_universal_plane (cursor-fb-leak)
[485.403220] Starting subtest: cursor-fb-leak
[485.405508] Starting dynamic subtest: pipe-A-eDP-1
[485.718266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.314s)
[485.729796] Starting dynamic subtest: pipe-B-eDP-1
[487.061982] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[487.071846] Starting dynamic subtest: pipe-C-eDP-1
[488.389255] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.324s)
[488.401163] Starting dynamic subtest: pipe-D-eDP-1
[489.713506] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[489.715855] Subtest cursor-fb-leak: SUCCESS (4.310s)
[490.894382] [088/131] (539s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[490.988626] Starting subtest: flip-vs-dpms-on-nop-interruptible
[490.991070] Starting dynamic subtest: A-eDP1
[492.789796] Dynamic subtest A-eDP1: SUCCESS (1.800s)
[492.801054] Starting dynamic subtest: B-eDP1
[494.615352] Dynamic subtest B-eDP1: SUCCESS (1.823s)
[494.628304] Starting dynamic subtest: C-eDP1
[496.441112] Dynamic subtest C-eDP1: SUCCESS (1.824s)
[496.449737] Starting dynamic subtest: D-eDP1
[498.281268] Dynamic subtest D-eDP1: SUCCESS (1.839s)
[498.283441] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.296s)
[499.460185] [089/131] (531s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[499.563767] Starting subtest: 4-tiled-16bpp-rotate-0
[500.852520] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.288s)
[500.970720] [090/131] (529s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[501.053487] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[501.055432] Starting dynamic subtest: pipe-A-eDP-1
[501.073720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[501.083872] Starting dynamic subtest: pipe-B-eDP-1
[501.100892] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[501.109260] Starting dynamic subtest: pipe-C-eDP-1
[501.126489] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.134915] Starting dynamic subtest: pipe-D-eDP-1
[501.152652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.156180] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[503.315839] [091/131] (527s left) kms_psr (fbc-psr-primary-render)
[503.416260] Starting subtest: fbc-psr-primary-render
[503.418327] Starting dynamic subtest: eDP-1
[503.422520] Dynamic subtest eDP-1: SKIP (0.000s)
[503.426964] Subtest fbc-psr-primary-render: SKIP (0.001s)
[503.497788] [092/131] (527s left) i915_drm_fdinfo (virtual-busy-hang-all)
[503.536107] Starting subtest: virtual-busy-hang-all
[503.540395] Subtest virtual-busy-hang-all: SKIP (0.000s)
[503.606635] [093/131] (527s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[503.695053] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[503.697235] Starting dynamic subtest: pipe-A
[503.706033] Dynamic subtest pipe-A: SKIP (0.005s)
[503.716345] Starting dynamic subtest: pipe-B
[503.724969] Dynamic subtest pipe-B: SKIP (0.017s)
[503.733837] Starting dynamic subtest: pipe-C
[503.742395] Dynamic subtest pipe-C: SKIP (0.018s)
[503.750983] Starting dynamic subtest: pipe-D
[503.759610] Dynamic subtest pipe-D: SKIP (0.017s)
[503.763754] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.059s)
[503.880478] [094/131] (526s left) perf_pmu (semaphore-busy)
[503.919093] Starting subtest: semaphore-busy
[503.921537] Starting dynamic subtest: rcs0
[505.584024] Dynamic subtest rcs0: SUCCESS (1.663s)
[505.593065] Starting dynamic subtest: bcs0
[507.211037] Dynamic subtest bcs0: SUCCESS (1.625s)
[507.221545] Starting dynamic subtest: vcs0
[511.438327] Dynamic subtest vcs0: SUCCESS (4.224s)
[511.449831] Starting dynamic subtest: vcs1
[517.390413] Dynamic subtest vcs1: SUCCESS (5.948s)
[517.401642] Starting dynamic subtest: vecs0
[523.407197] Dynamic subtest vecs0: SUCCESS (6.014s)
[523.417442] Starting dynamic subtest: ccs0
[526.479807] Dynamic subtest ccs0: SUCCESS (3.070s)
[526.482940] Subtest semaphore-busy: SUCCESS (22.560s)
[526.602966] [095/131] (504s left) syncobj_eventfd (timeline-wait-signaled)
[526.662876] Starting subtest: timeline-wait-signaled
[526.665315] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[526.772821] [096/131] (504s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[526.870471] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[526.874525] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[526.973804] [097/131] (503s left) kms_properties (get_properties-sanity-atomic)
[527.067173] Starting subtest: get_properties-sanity-atomic
[527.069457] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[527.139942] [098/131] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[527.237618] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[527.242271] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[527.347880] [099/131] (503s left) kms_psr (fbc-psr-cursor-blt)
[527.442091] Starting subtest: fbc-psr-cursor-blt
[527.444360] Starting dynamic subtest: eDP-1
[527.448752] Dynamic subtest eDP-1: SKIP (0.000s)
[527.453190] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[527.511992] [100/131] (503s left) kms_cursor_crc (cursor-onscreen-32x32)
[527.649608] Starting subtest: cursor-onscreen-32x32
[527.696171] Subtest cursor-onscreen-32x32: SKIP (0.042s)
[527.983937] [101/131] (503s left) kms_psr (psr-suspend)
[528.074895] Starting subtest: psr-suspend
[528.076870] Starting dynamic subtest: eDP-1
[545.882477] Dynamic subtest eDP-1: SUCCESS (3.056s)
[545.884694] Subtest psr-suspend: SUCCESS (3.057s)
[546.689784] [102/131] (484s left) kms_cursor_edge_walk (256x256-right-edge)
[546.792685] Starting subtest: 256x256-right-edge
[546.794900] Starting dynamic subtest: pipe-A-eDP-1
[550.144797] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[550.153939] Starting dynamic subtest: pipe-D-eDP-1
[553.218396] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[553.220448] Subtest 256x256-right-edge: SUCCESS (6.589s)
[554.011224] [103/131] (477s left) kms_psr (fbc-pr-dpms)
[554.108259] Starting subtest: fbc-pr-dpms
[554.112315] Subtest fbc-pr-dpms: SKIP (0.000s)
[554.175189] [104/131] (476s left) kms_psr (pr-sprite-mmap-cpu)
[554.279530] Starting subtest: pr-sprite-mmap-cpu
[554.283446] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[554.347743] [105/131] (476s left) kms_addfb_basic (bad-pitch-65536)
[554.408800] Starting subtest: bad-pitch-65536
[554.411087] Subtest bad-pitch-65536: SUCCESS (0.000s)
[554.549676] [106/131] (476s left) gem_mmap (basic)
[554.617412] Subtest basic: SKIP (0.000s)
[554.686027] [107/131] (476s left) kms_vblank (wait-busy)
[554.763842] Starting subtest: wait-busy
[554.765699] Starting dynamic subtest: pipe-A-eDP-1
[556.618215] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[556.633729] Starting dynamic subtest: pipe-D-eDP-1
[559.145110] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[559.147302] Subtest wait-busy: SUCCESS (4.427s)
[559.943239] [108/131] (471s left) syncobj_timeline (wait-all-delayed-signal)
[560.000051] Starting subtest: wait-all-delayed-signal
[560.102409] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[560.180297] [109/131] (471s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[560.277616] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[567.009219] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (6.763s)
[567.164955] [110/131] (464s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[567.260272] Starting subtest: fbcpsr-rgb101010-draw-render
[573.982367] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.741s)
[574.106163] [111/131] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[574.210902] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[574.215103] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[574.309373] [112/131] (457s left) gem_basic (bad-close)
[574.366311] Starting subtest: bad-close
[574.370549] Subtest bad-close: SUCCESS (0.000s)
[574.477141] [113/131] (457s left) gem_exec_balancer (invalid-bonds)
[574.542357] Starting subtest: invalid-bonds
[574.546893] Subtest invalid-bonds: SKIP (0.000s)
[574.850602] [114/131] (456s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[574.950754] Starting subtest: fbc-modesetfrombusy
[578.689813] Subtest fbc-modesetfrombusy: SUCCESS (3.744s)
[579.935998] [115/131] (451s left) gem_mmap_gtt (basic-small-bo-tiledy)
[579.985511] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[580.039605] [116/131] (451s left) kms_flip (blocking-absolute-wf_vblank)
[580.122022] Starting subtest: blocking-absolute-wf_vblank
[580.124453] Starting dynamic subtest: A-eDP1
[588.807473] Dynamic subtest A-eDP1: SUCCESS (8.681s)
[588.823358] Starting dynamic subtest: B-eDP1
[597.536585] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[597.548155] Starting dynamic subtest: C-eDP1
[606.250085] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[606.261609] Starting dynamic subtest: D-eDP1
[614.973348] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[614.975729] Subtest blocking-absolute-wf_vblank: SUCCESS (34.853s)
[616.185891] [117/131] (415s left) kms_atomic_interruptible (universal-setplane-primary)
[616.284014] Starting subtest: universal-setplane-primary
[616.286179] Starting dynamic subtest: pipe-A-eDP-1
[623.703777] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.422s)
[623.706094] Subtest universal-setplane-primary: SUCCESS (7.423s)
[624.536807] [118/131] (407s left) gem_mmap_offset (partial-remap)
[624.596841] Starting subtest: partial-remap
[624.599174] Starting dynamic subtest: smem0
[624.610386] Dynamic subtest smem0: SUCCESS (0.005s)
[624.612344] Subtest partial-remap: SUCCESS (0.006s)
[624.739831] [119/131] (406s left) syncobj_wait (wait-for-submit-delayed-submit)
[624.798196] Starting subtest: wait-for-submit-delayed-submit
[624.900014] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[624.974847] [120/131] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[625.071172] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[625.075116] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[625.173035] [121/131] (406s left) kms_properties (get_properties-sanity-non-atomic)
[625.259617] Starting subtest: get_properties-sanity-non-atomic
[625.261866] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[625.332032] [122/131] (406s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[625.706615] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[626.539643] [123/131] (405s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[626.638484] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[626.642576] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[626.735668] [124/131] (405s left) perf_pmu (all-busy-idle-check-all)
[626.774507] Starting subtest: all-busy-idle-check-all
[627.472604] Subtest all-busy-idle-check-all: FAIL (0.645s)
[628.732050] [125/131] (403s left) kms_prop_blob (blob-prop-core)
[628.778398] Starting subtest: blob-prop-core
[628.782532] Subtest blob-prop-core: SUCCESS (0.000s)
[628.884166] [126/131] (403s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[628.974870] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[628.977102] Starting dynamic subtest: pipe-A-default-mode
[631.699908] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[631.702051] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.718s)
[632.555782] [127/131] (399s left) gem_softpin (overlap)
[632.617430] Starting subtest: overlap
[633.477747] Subtest overlap: SUCCESS (0.860s)
[633.613008] [128/131] (398s left) sw_sync (alloc_merge_fence)
[633.644835] Starting subtest: alloc_merge_fence
[633.647081] Subtest alloc_merge_fence: SUCCESS (0.000s)
[633.701372] [129/131] (398s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[633.800964] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[633.803227] Starting dynamic subtest: pipe-A-eDP-1
[633.859964] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[633.871308] Starting dynamic subtest: pipe-B-eDP-1
[633.928862] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[633.940391] Starting dynamic subtest: pipe-C-eDP-1
[633.997718] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[634.008847] Starting dynamic subtest: pipe-D-eDP-1
[634.065069] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[634.069417] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[636.121208] [130/131] (396s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[636.216106] Starting subtest: primary-y-tiled-reflect-x-180
[636.276133] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[636.380696] [131/131] (395s left) gem_exec_schedule (preempt-queue-contexts)
[636.463291] Subtest preempt-queue-contexts: SKIP (0.000s)
[636.748440] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_chamelium_frames
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_invalid_mode
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: fbdev
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: gem_ctx_isolation
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: sysfs_heartbeat_interval
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: i915_suspend
results: parsing output: 37/ for test: kms_async_flips
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_pm_dc
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_create
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_shared
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_plane_lowres
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: i915_module_load
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: i915_power
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: prime_self_import
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_universal_plane
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_cursor_edge_walk
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: gem_mmap
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_basic
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_atomic_interruptible
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_properties
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_prop_blob
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: sw_sync
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_rotation_crc
results: parsing output: 130/ for test: gem_exec_schedule
Done.