[59.125437] Initializing watchdogs
[59.125495]   /dev/watchdog0
[59.140741] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.145499] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.147925] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.149767] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[59.247734] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[59.249308] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[59.342360] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[59.431896] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[59.433506] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[59.518760] [003/133] (960s left) kms_atomic_transition (modeset-transition)
[59.613098] Starting subtest: modeset-transition
[59.614165] Starting dynamic subtest: 1x-outputs
[70.525974] Dynamic subtest 1x-outputs: SUCCESS (10.827s)
[70.527111] Subtest modeset-transition: SUCCESS (10.828s)
[71.383097] [004/133] (948s left) syncobj_timeline (invalid-signal-bad-pad)
[71.437052] Starting subtest: invalid-signal-bad-pad
[71.437897] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[71.557532] [005/133] (948s left) kms_cursor_legacy (forked-move)
[71.663254] Starting subtest: forked-move
[71.664192] Starting dynamic subtest: pipe-A
[77.212510] Dynamic subtest pipe-A: SUCCESS (5.490s)
[77.219356] Starting dynamic subtest: pipe-B
[82.652353] Dynamic subtest pipe-B: SUCCESS (5.469s)
[82.659673] Starting dynamic subtest: pipe-C
[88.177012] Dynamic subtest pipe-C: SUCCESS (5.482s)
[88.184789] Starting dynamic subtest: pipe-D
[93.658300] Dynamic subtest pipe-D: SUCCESS (5.477s)
[93.668143] Starting dynamic subtest: all-pipes
[99.178715] Dynamic subtest all-pipes: SUCCESS (5.516s)
[99.179972] Subtest forked-move: SUCCESS (27.439s)
[99.275190] [006/133] (920s left) kms_cursor_crc (cursor-alpha-opaque)
[99.364301] Starting subtest: cursor-alpha-opaque
[99.365196] Starting dynamic subtest: pipe-A-eDP-1
[99.995375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[100.002108] Starting dynamic subtest: pipe-D-eDP-1
[101.317216] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[101.318178] Subtest cursor-alpha-opaque: SUCCESS (1.952s)
[102.182978] [007/133] (917s left) i915_pm_rps (thresholds)
[102.242305] Starting subtest: thresholds
[102.243900] Subtest thresholds: SKIP (0.001s)
[102.306643] [008/133] (917s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[102.391035] Starting subtest: psr-modesetfrombusy
[108.555836] Subtest psr-modesetfrombusy: SUCCESS (6.163s)
[108.676390] [009/133] (911s left) sw_sync (alloc_fence)
[108.704848] Starting subtest: alloc_fence
[108.706063] Subtest alloc_fence: SUCCESS (0.000s)
[108.750721] [010/133] (911s left) gen7_exec_parse (load-register-reg)
[108.801689] Subtest load-register-reg: SKIP (0.000s)
[108.861207] [011/133] (911s left) gem_ctx_sseu (invalid-sseu)
[108.909146] Subtest invalid-sseu: SKIP (0.000s)
[108.966677] [012/133] (911s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[109.054385] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[109.847031] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[110.044245] [013/133] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[110.133440] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[110.135038] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[110.224914] [014/133] (909s left) gem_spin_batch (spin-each)
[110.277962] Starting subtest: spin-each
[113.547500] Subtest spin-each: SUCCESS (3.259s)
[114.410573] [015/133] (905s left) kms_chamelium_edid (hdmi-mode-timings)
[114.792927] Subtest hdmi-mode-timings: SKIP (0.000s)
[115.634970] [016/133] (904s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[115.719586] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[115.721108] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[115.782419] [017/133] (904s left) kms_psr (pr-cursor-plane-move)
[115.860869] Starting subtest: pr-cursor-plane-move
[115.862380] Subtest pr-cursor-plane-move: SKIP (0.000s)
[115.938897] [018/133] (904s left) kms_frontbuffer_tracking (fbc-tiling-4)
[116.031174] Starting subtest: fbc-tiling-4
[120.299518] Subtest fbc-tiling-4: SUCCESS (4.267s)
[121.456154] [019/133] (898s left) gem_exec_flush (basic-batch-kernel-default-wb)
[121.518487] Starting subtest: basic-batch-kernel-default-wb
[128.638280] Subtest basic-batch-kernel-default-wb: SUCCESS (7.118s)
[128.825241] [020/133] (891s left) syncobj_timeline (wait-for-submit-delayed-submit)
[128.891921] Starting subtest: wait-for-submit-delayed-submit
[128.995351] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[129.096640] [021/133] (891s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[129.188990] Starting subtest: plane-ctm3x4-lut1d
[129.336052] Starting dynamic subtest: pipe-A-plane-0
[129.502868] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[129.511288] Starting dynamic subtest: pipe-A-plane-1
[129.647348] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[129.654547] Starting dynamic subtest: pipe-A-plane-2
[129.813924] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[131.068627] Starting dynamic subtest: pipe-B-plane-0
[131.261548] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[131.271077] Starting dynamic subtest: pipe-B-plane-1
[131.416953] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[131.424699] Starting dynamic subtest: pipe-B-plane-2
[131.606057] Dynamic subtest pipe-B-plane-2: SUCCESS (0.189s)
[132.778352] Starting dynamic subtest: pipe-C-plane-0
[132.907294] Dynamic subtest pipe-C-plane-0: SUCCESS (0.134s)
[132.914260] Starting dynamic subtest: pipe-C-plane-1
[133.040341] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[133.048847] Starting dynamic subtest: pipe-C-plane-2
[133.188053] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[134.426183] Starting dynamic subtest: pipe-D-plane-0
[134.565806] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[134.574486] Starting dynamic subtest: pipe-D-plane-1
[134.711012] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[134.718116] Starting dynamic subtest: pipe-D-plane-2
[134.865779] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[135.163491] Subtest plane-ctm3x4-lut1d: SUCCESS (5.975s)
[135.989259] [022/133] (884s left) gem_ctx_persistence (process)
[136.038833] Starting subtest: process
[136.199705] Subtest process: SUCCESS (0.161s)
[136.267818] [023/133] (884s left) tools_test (tools_test)
[136.302564] Starting subtest: tools_test
[136.362300] Subtest tools_test: SUCCESS (0.065s)
[136.419872] [024/133] (883s left) gem_ctx_isolation (preservation-s3)
[136.464358] Starting subtest: preservation-S3
[136.465357] Starting dynamic subtest: rcs0
[152.975409] Dynamic subtest rcs0: SUCCESS (2.547s)
[152.984218] Starting dynamic subtest: bcs0
[169.958029] Dynamic subtest bcs0: SUCCESS (1.674s)
[169.966344] Starting dynamic subtest: vcs0
[186.972052] Dynamic subtest vcs0: SUCCESS (3.091s)
[186.982370] Starting dynamic subtest: vcs1
[204.969204] Dynamic subtest vcs1: SUCCESS (4.974s)
[204.978085] Starting dynamic subtest: vecs0
[222.969140] Dynamic subtest vecs0: SUCCESS (5.056s)
[222.978171] Starting dynamic subtest: ccs0
[240.980190] Dynamic subtest ccs0: SUCCESS (3.308s)
[240.981235] Subtest preservation-S3: SUCCESS (20.655s)
[248.227346] [025/133] (779s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[248.320488] Starting subtest: 4-tiled-8bpp-rotate-0
[249.603814] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.243s)
[249.723174] [026/133] (777s left) kms_psr (psr-primary-render)
[249.822838] Starting subtest: psr-primary-render
[249.823750] Starting dynamic subtest: eDP-1
[251.606715] Dynamic subtest eDP-1: SUCCESS (1.739s)
[251.607581] Subtest psr-primary-render: SUCCESS (1.740s)
[252.493188] [027/133] (775s left) gem_userptr_blits (userfault)
[252.559422] Starting subtest: userfault
[252.563840] Subtest userfault: SUCCESS (0.006s)
[252.696247] [028/133] (774s left) perf (gen12-group-exclusive-stream-sample-oa)
[252.814068] Starting subtest: gen12-group-exclusive-stream-sample-oa
[252.834872] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[252.866504] [029/133] (774s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[252.917240] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[252.976218] [030/133] (774s left) api_intel_allocator (simple-allocator)
[253.025505] Starting subtest: simple-allocator
[253.026376] Starting dynamic subtest: basic
[253.028577] Dynamic subtest basic: SUCCESS (0.003s)
[253.045118] Starting dynamic subtest: parallel-one
[253.225111] Dynamic subtest parallel-one: SUCCESS (0.184s)
[253.235234] Starting dynamic subtest: print
[253.236084] Dynamic subtest print: SUCCESS (0.000s)
[253.243957] Starting dynamic subtest: reuse
[253.244793] Dynamic subtest reuse: SUCCESS (0.000s)
[253.252322] Starting dynamic subtest: reserve
[253.253198] Dynamic subtest reserve: SUCCESS (0.000s)
[253.260636] Starting dynamic subtest: fork-reopen-allocator
[253.261551] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[253.262443] Subtest simple-allocator: SUCCESS (0.204s)
[253.347083] [031/133] (774s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[253.407406] Starting subtest: y-tiled-to-vebox-x-tiled
[253.409508] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[253.583306] [032/133] (774s left) gem_exec_balancer (persistence)
[253.851774] Starting subtest: persistence
[254.837229] Subtest persistence: SUCCESS (0.966s)
[254.932566] [033/133] (772s left) kms_pm_rpm (pm-caching)
[256.460996] Starting subtest: pm-caching
[256.463060] Subtest pm-caching: SKIP (0.000s)
[257.210213] [034/133] (770s left) kms_cursor_crc (cursor-onscreen-256x256)
[257.433337] Starting subtest: cursor-onscreen-256x256
[257.436566] Starting dynamic subtest: pipe-A-eDP-1
[259.555406] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.100s)
[259.590108] Starting dynamic subtest: pipe-D-eDP-1
[262.370380] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[262.371371] Subtest cursor-onscreen-256x256: SUCCESS (4.897s)
[263.230284] [035/133] (764s left) api_intel_bb (object-reloc-keep-cache)
[263.290918] Starting subtest: object-reloc-keep-cache
[263.294156] Subtest object-reloc-keep-cache: SKIP (0.002s)
[263.415401] [036/133] (764s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[263.514350] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[270.670654] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.131s)
[270.825970] [037/133] (757s left) gem_tiled_swapping (non-threaded)
[270.887671] Subtest non-threaded: SKIP (0.000s)
[270.941925] [038/133] (756s left) kms_cursor_crc (cursor-random-32x10)
[271.084741] Starting subtest: cursor-random-32x10
[271.130142] Subtest cursor-random-32x10: SKIP (0.044s)
[271.399014] [039/133] (756s left) syncobj_timeline (etime-multi-wait-submitted)
[271.446114] Starting subtest: etime-multi-wait-submitted
[271.549330] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[271.620885] [040/133] (756s left) gem_exec_reloc (basic-write-gtt-noreloc)
[271.685761] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[271.746490] [041/133] (756s left) prime_busy (after)
[271.805314] Starting subtest: after
[271.807019] Starting dynamic subtest: rcs0
[271.843901] Dynamic subtest rcs0: SUCCESS (0.037s)
[271.854032] Starting dynamic subtest: bcs0
[271.898026] Dynamic subtest bcs0: SUCCESS (0.053s)
[271.908411] Starting dynamic subtest: vcs0
[271.939666] Dynamic subtest vcs0: SUCCESS (0.041s)
[271.947607] Starting dynamic subtest: vcs1
[271.981267] Dynamic subtest vcs1: SUCCESS (0.041s)
[271.989433] Starting dynamic subtest: vecs0
[272.021528] Dynamic subtest vecs0: SUCCESS (0.040s)
[272.029666] Starting dynamic subtest: ccs0
[272.062567] Dynamic subtest ccs0: SUCCESS (0.040s)
[272.169172] Subtest after: SUCCESS (0.364s)
[272.237263] [042/133] (755s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[272.294459] Starting subtest: multi-wait-for-submit-submitted-signaled
[272.295617] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[272.412588] [043/133] (755s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[272.504756] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[272.506341] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[272.599675] [044/133] (755s left) gem_softpin (overlap)
[272.657219] Starting subtest: overlap
[273.585957] Subtest overlap: SUCCESS (0.927s)
[273.686242] [045/133] (754s left) kms_atomic_transition (plane-all-transition)
[273.780581] Starting subtest: plane-all-transition
[273.781433] Starting dynamic subtest: pipe-A-eDP-1
[276.279195] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[276.585697] Starting dynamic subtest: pipe-B-eDP-1
[279.840393] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.260s)
[280.138274] Subtest plane-all-transition: SUCCESS (6.349s)
[280.966910] [046/133] (747s left) kms_psr (fbc-pr-no-drrs)
[281.052864] Starting subtest: fbc-pr-no-drrs
[281.054594] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[281.120810] [047/133] (747s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[281.494625] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[282.282950] [048/133] (745s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[282.391022] Starting subtest: fbc-rgb565-draw-mmap-wc
[286.447909] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.058s)
[287.606515] [049/133] (740s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[287.701547] Starting subtest: 2x-flip-vs-rmfb-interruptible
[287.713166] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[287.787225] [050/133] (740s left) i915_drm_fdinfo (all-busy-idle-check-all)
[287.823697] Starting subtest: all-busy-idle-check-all
[287.828699] Subtest all-busy-idle-check-all: SKIP (0.004s)
[287.882299] [051/133] (740s left) dumb_buffer (create-valid-dumb)
[287.949067] Starting subtest: create-valid-dumb
[287.950181] Subtest create-valid-dumb: SUCCESS (0.000s)
[288.053437] [052/133] (740s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[288.159870] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[288.160755] Starting dynamic subtest: pipe-A-eDP-1
[290.376324] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.217s)
[290.385715] Starting dynamic subtest: pipe-B-eDP-1
[292.761836] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.384s)
[292.771081] Starting dynamic subtest: pipe-C-eDP-1
[294.831323] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.068s)
[294.840907] Starting dynamic subtest: pipe-D-eDP-1
[297.044201] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.211s)
[297.045260] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.885s)
[298.238851] [053/133] (730s left) kms_psr (psr-cursor-plane-move)
[298.333218] Starting subtest: psr-cursor-plane-move
[298.334334] Starting dynamic subtest: eDP-1
[300.040752] Dynamic subtest eDP-1: SUCCESS (1.707s)
[300.041574] Subtest psr-cursor-plane-move: SUCCESS (1.708s)
[300.896256] [054/133] (727s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[301.003327] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[301.004872] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[301.095393] [055/133] (727s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[301.192026] Starting subtest: fbc-psr-sprite-mmap-cpu
[301.192869] Starting dynamic subtest: eDP-1
[301.194470] Dynamic subtest eDP-1: SKIP (0.000s)
[301.196135] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[301.261088] [056/133] (727s left) gem_eio (execbuf)
[301.508048] Starting subtest: execbuf
[301.861783] Subtest execbuf: SUCCESS (0.356s)
[301.974062] [057/133] (726s left) gem_partial_pwrite_pread (write-uncached)
[302.038023] Subtest write-uncached: SKIP (0.000s)
[302.107143] [058/133] (726s left) kms_universal_plane (disable-primary-vs-flip)
[302.201911] Starting subtest: disable-primary-vs-flip
[302.202787] Starting dynamic subtest: pipe-A-eDP-1
[303.803585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.601s)
[303.813255] Starting dynamic subtest: pipe-B-eDP-1
[306.070435] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.264s)
[306.078814] Starting dynamic subtest: pipe-C-eDP-1
[308.320078] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.248s)
[308.330075] Starting dynamic subtest: pipe-D-eDP-1
[310.497869] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.174s)
[310.498805] Subtest disable-primary-vs-flip: SUCCESS (8.293s)
[311.379743] [059/133] (717s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[311.495784] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[311.497547] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[311.625176] [060/133] (717s left) gem_mmap_offset (basic-uaf)
[311.685863] Starting subtest: basic-uaf
[311.688109] Subtest basic-uaf: SUCCESS (0.001s)
[311.830314] [061/133] (716s left) gen3_render_linear_blits
[311.936061] [062/133] (716s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[312.027021] Starting subtest: flip-vs-dpms-off-vs-modeset
[312.029428] Starting dynamic subtest: A-eDP1
[315.701747] Dynamic subtest A-eDP1: SUCCESS (3.670s)
[315.710463] Starting dynamic subtest: B-eDP1
[318.908962] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[318.917417] Starting dynamic subtest: C-eDP1
[322.021460] Dynamic subtest C-eDP1: SUCCESS (3.111s)
[322.030022] Starting dynamic subtest: D-eDP1
[325.113157] Dynamic subtest D-eDP1: SUCCESS (3.088s)
[325.114154] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.082s)
[325.912259] [063/133] (702s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[326.002109] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[326.003043] Starting dynamic subtest: pipe-A-eDP-1
[326.460392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[326.468720] Starting dynamic subtest: pipe-B-eDP-1
[327.957606] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[327.966150] Starting dynamic subtest: pipe-C-eDP-1
[329.325892] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[329.336672] Starting dynamic subtest: pipe-D-eDP-1
[330.685898] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s)
[330.686706] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.674s)
[331.860917] [064/133] (696s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[331.929030] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[332.039096] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[332.108567] [065/133] (696s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[332.195235] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[333.230532] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.035s)
[333.366511] [066/133] (695s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[333.463870] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[333.465578] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[334.585240] [067/133] (694s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[334.675794] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[334.677603] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[334.765560] [068/133] (694s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[334.862184] Starting subtest: primary-yf-tiled-reflect-x-180
[334.921749] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[335.017536] [069/133] (693s left) gem_mmap (pf-nonblock)
[335.069068] Subtest pf-nonblock: SKIP (0.000s)
[335.118165] [070/133] (693s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[335.208200] Starting subtest: fbcpsr-shrfb-scaledprimary
[341.000242] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.791s)
[341.118427] [071/133] (687s left) gem_exec_store (pages)
[341.172321] Starting subtest: pages
[341.173293] Starting dynamic subtest: rcs0
[341.256191] Dynamic subtest rcs0: SUCCESS (0.085s)
[341.268751] Starting dynamic subtest: bcs0
[341.329205] Dynamic subtest bcs0: SUCCESS (0.071s)
[341.339500] Starting dynamic subtest: vcs0
[341.394303] Dynamic subtest vcs0: SUCCESS (0.064s)
[341.404988] Starting dynamic subtest: vcs1
[341.456542] Dynamic subtest vcs1: SUCCESS (0.061s)
[341.467179] Starting dynamic subtest: vecs0
[341.520173] Dynamic subtest vecs0: SUCCESS (0.063s)
[341.530562] Starting dynamic subtest: ccs0
[341.585558] Dynamic subtest ccs0: SUCCESS (0.064s)
[341.586759] Subtest pages: SUCCESS (0.416s)
[341.763362] [072/133] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[341.861261] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[348.745562] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.883s)
[348.875823] [073/133] (680s left) gem_exec_reloc (basic-write-cpu-noreloc)
[348.940626] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[349.008117] [074/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[349.097979] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[349.099631] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[349.202334] [075/133] (679s left) prime_mmap (test_invalid_sync_flags)
[349.245487] Starting subtest: test_invalid_sync_flags
[349.246322] Starting dynamic subtest: test_invalid_sync_flags-smem
[349.247193] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[349.248040] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[349.344565] [076/133] (679s left) kms_pm_dc (dc5-psr)
[350.435764] Starting subtest: dc5-psr
[353.310755] Subtest dc5-psr: SUCCESS (2.883s)
[354.160201] [077/133] (675s left) gem_exec_params (readonly)
[354.209857] Starting subtest: readonly
[354.212468] Subtest readonly: SUCCESS (0.002s)
[354.337541] [078/133] (674s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[354.428929] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[354.430883] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[354.499000] [079/133] (674s left) kms_setmode (invalid-clone-single-crtc-stealing)
[354.541328] Starting subtest: invalid-clone-single-crtc-stealing
[354.544071] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[354.627950] [080/133] (674s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[354.717841] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[354.720044] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[354.809719] [081/133] (674s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[354.893898] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[354.895573] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[354.964260] [082/133] (674s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[355.004863] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[355.109464] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[355.181282] [083/133] (674s left) gem_exec_schedule (promotion)
[355.233582] Starting subtest: promotion
[355.234554] Starting dynamic subtest: rcs0
[355.339052] Dynamic subtest rcs0: SUCCESS (0.104s)
[355.348221] Starting dynamic subtest: vcs0
[355.429805] Dynamic subtest vcs0: SUCCESS (0.091s)
[355.441248] Starting dynamic subtest: vcs1
[355.517427] Dynamic subtest vcs1: SUCCESS (0.085s)
[355.526957] Starting dynamic subtest: vecs0
[355.601908] Dynamic subtest vecs0: SUCCESS (0.084s)
[355.612105] Starting dynamic subtest: ccs0
[355.706382] Dynamic subtest ccs0: SUCCESS (0.103s)
[355.707777] Subtest promotion: SUCCESS (0.473s)
[357.287983] [084/133] (672s left) syncobj_timeline (multi-wait-signaled)
[357.343774] Starting subtest: multi-wait-signaled
[357.345104] Subtest multi-wait-signaled: SUCCESS (0.000s)
[357.428718] [085/133] (672s left) gem_create (create-ext-cpu-access-big)
[357.592877] Starting subtest: create-ext-cpu-access-big
[357.594655] Subtest create-ext-cpu-access-big: SKIP (0.000s)
[357.658939] [086/133] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[357.752358] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[357.754067] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[357.849294] [087/133] (671s left) gem_render_copy (linear-to-vebox-y-tiled)
[357.901793] Starting subtest: linear-to-vebox-y-tiled
[357.903556] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[358.076330] [088/133] (671s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[358.191808] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[390.146763] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.948s)
[390.999861] [089/133] (638s left) kms_plane_scaling (planes-upscale-factor-0-25)
[391.093231] Starting subtest: planes-upscale-factor-0-25
[391.094188] Starting dynamic subtest: pipe-A
[391.154083] Dynamic subtest pipe-A: SUCCESS (0.062s)
[391.162651] Starting dynamic subtest: pipe-B
[392.326568] Dynamic subtest pipe-B: SUCCESS (1.171s)
[392.340139] Starting dynamic subtest: pipe-C
[393.441911] Dynamic subtest pipe-C: SUCCESS (1.113s)
[393.452418] Starting dynamic subtest: pipe-D
[394.565472] Dynamic subtest pipe-D: SUCCESS (1.122s)
[394.566479] Subtest planes-upscale-factor-0-25: SUCCESS (3.474s)
[395.719599] [090/133] (633s left) kms_atomic_interruptible (universal-setplane-cursor)
[395.813043] Starting subtest: universal-setplane-cursor
[395.814295] Starting dynamic subtest: pipe-A-eDP-1
[403.250104] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.433s)
[403.250969] Subtest universal-setplane-cursor: SUCCESS (7.434s)
[404.095270] [091/133] (625s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[404.187271] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[404.215974] Starting dynamic subtest: pipe-A-plane-0
[404.503672] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[404.513574] Starting dynamic subtest: pipe-A-plane-3
[404.737555] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[405.898348] Starting dynamic subtest: pipe-B-plane-0
[406.189644] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[406.200000] Starting dynamic subtest: pipe-B-plane-3
[406.453410] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[406.754348] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.567s)
[407.572464] [092/133] (622s left) syncobj_timeline (transfer-timeline-point)
[407.639805] Starting subtest: transfer-timeline-point
[407.640741] Subtest transfer-timeline-point: SUCCESS (0.000s)
[407.731794] [093/133] (622s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[407.826620] Starting subtest: fbc-psr2-cursor-plane-update-sf
[407.827635] Starting dynamic subtest: pipe-A-eDP-1
[407.903984] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[407.913163] Starting dynamic subtest: pipe-B-eDP-1
[409.043133] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[409.044693] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.218s)
[410.241470] [094/133] (619s left) kms_lease (invalid-create-leases)
[410.324284] Starting subtest: invalid-create-leases
[410.330485] Subtest invalid-create-leases: SUCCESS (0.006s)
[410.434396] [095/133] (619s left) gem_exec_balancer (bonded-sync)
[410.487303] Starting subtest: bonded-sync
[410.489279] Subtest bonded-sync: SKIP (0.000s)
[410.787025] [096/133] (619s left) gem_userptr_blits (readonly-pwrite-unsync)
[410.833568] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[410.944196] [097/133] (618s left) kms_flip (2x-nonexisting-fb-interruptible)
[411.027965] Starting subtest: 2x-nonexisting-fb-interruptible
[411.039393] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[411.126367] [098/133] (618s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[411.220761] Starting subtest: x-tiled-16bpp-rotate-180
[412.521534] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.301s)
[412.649185] [099/133] (617s left) kms_draw_crc (draw-method-mmap-cpu)
[412.735264] Starting subtest: draw-method-mmap-cpu
[412.736221] Starting dynamic subtest: xrgb8888-untiled
[412.968359] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[412.984089] Starting dynamic subtest: rgb565-untiled
[413.190481] Dynamic subtest rgb565-untiled: SUCCESS (0.219s)
[413.199447] Starting dynamic subtest: xrgb2101010-untiled
[413.412847] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[413.421909] Starting dynamic subtest: xbgr16161616f-untiled
[413.646424] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[413.655274] Starting dynamic subtest: xrgb8888-xtiled
[413.768669] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[413.777248] Starting dynamic subtest: rgb565-xtiled
[413.890890] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[413.901140] Starting dynamic subtest: xrgb2101010-xtiled
[414.024299] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[414.033021] Starting dynamic subtest: xbgr16161616f-xtiled
[414.157428] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[414.166268] Starting dynamic subtest: xrgb8888-4tiled
[414.290910] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[414.299715] Starting dynamic subtest: rgb565-4tiled
[414.424306] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[414.432947] Starting dynamic subtest: xrgb2101010-4tiled
[414.569316] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[414.583633] Starting dynamic subtest: xbgr16161616f-4tiled
[414.713797] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.142s)
[414.717005] Subtest draw-method-mmap-cpu: SUCCESS (1.980s)
[414.808524] [100/133] (615s left) gem_exec_whisper (basic-sync)
[414.871063] Starting subtest: basic-sync
[423.520562] Subtest basic-sync: SUCCESS (8.631s)
[423.700934] [101/133] (606s left) kms_invalid_mode (bad-vsync-start)
[423.800164] Starting subtest: bad-vsync-start
[423.801053] Starting dynamic subtest: pipe-A-eDP-1
[424.096609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[424.107979] Starting dynamic subtest: pipe-B-eDP-1
[424.108953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[424.117685] Starting dynamic subtest: pipe-C-eDP-1
[424.118545] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[424.127305] Starting dynamic subtest: pipe-D-eDP-1
[424.128408] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[424.129429] Subtest bad-vsync-start: SUCCESS (0.303s)
[424.890186] [102/133] (605s left) vgem_basic (second-client)
[424.981864] Starting subtest: second-client
[425.004448] Subtest second-client: SUCCESS (0.022s)
[425.059539] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[425.061632] [103/133] (605s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[425.151225] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[432.286882] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.134s)
[432.382816] [104/133] (597s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[432.493917] Starting subtest: cursorB-vs-flipA-toggle
[432.496888] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[432.638429] [105/133] (597s left) kms_psr (fbc-psr2-cursor-blt)
[432.730795] Starting subtest: fbc-psr2-cursor-blt
[432.731628] Starting dynamic subtest: eDP-1
[432.733364] Dynamic subtest eDP-1: SKIP (0.000s)
[432.735131] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[432.814398] [106/133] (597s left) sw_sync (sync_merge_same)
[432.848396] Starting subtest: sync_merge_same
[432.849323] Subtest sync_merge_same: SUCCESS (0.000s)
[432.904145] [107/133] (597s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[433.002426] Starting subtest: psr-farfromfence-mmap-gtt
[433.004274] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[433.094401] [108/133] (597s left) gem_mmap_gtt (cpuset-medium-copy)
[433.140437] Subtest cpuset-medium-copy: SKIP (0.000s)
[433.196740] [109/133] (597s left) i915_fb_tiling (basic-x-tiling)
[433.255755] Subtest basic-x-tiling: SKIP (0.000s)
[433.312340] [110/133] (597s left) kms_plane_alpha_blend (coverage-7efc)
[433.403829] Starting subtest: coverage-7efc
[433.694414] Starting dynamic subtest: pipe-A-eDP-1
[434.249497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[434.278611] Starting dynamic subtest: pipe-D-eDP-1
[435.561822] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[435.562617] Subtest coverage-7efc: SUCCESS (2.158s)
[436.397003] [111/133] (594s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[436.484852] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[436.485893] Starting dynamic subtest: pipe-A-eDP-1
[437.345540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s)
[437.354665] Starting dynamic subtest: pipe-B-eDP-1
[439.051404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.705s)
[439.062925] Starting dynamic subtest: pipe-C-eDP-1
[440.518228] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.464s)
[440.527543] Starting dynamic subtest: pipe-D-eDP-1
[442.053199] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[442.054071] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.565s)
[443.249624] [112/133] (587s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[443.340978] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[443.341901] Starting dynamic subtest: pipe-A
[443.704257] Dynamic subtest pipe-A: SUCCESS (0.364s)
[443.715694] Starting dynamic subtest: pipe-B
[445.142179] Dynamic subtest pipe-B: SUCCESS (1.436s)
[445.151621] Starting dynamic subtest: pipe-C
[446.573128] Dynamic subtest pipe-C: SUCCESS (1.430s)
[446.586007] Starting dynamic subtest: pipe-D
[448.005823] Dynamic subtest pipe-D: SUCCESS (1.431s)
[448.006924] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.665s)
[449.160446] [113/133] (581s left) i915_selftest (mock)
[450.865489] Starting subtest: mock
[450.866497] Starting dynamic subtest: sanitycheck
[451.552596] Dynamic subtest sanitycheck: SUCCESS (0.687s)
[451.560869] Starting dynamic subtest: shmem
[452.244565] Dynamic subtest shmem: SUCCESS (0.689s)
[452.250973] Starting dynamic subtest: fence
[460.312256] Dynamic subtest fence: SUCCESS (8.062s)
[460.318566] Starting dynamic subtest: scatterlist
[462.024696] Dynamic subtest scatterlist: SUCCESS (1.710s)
[462.034579] Starting dynamic subtest: syncmap
[465.215336] Dynamic subtest syncmap: SUCCESS (3.187s)
[465.225268] Starting dynamic subtest: uncore
[465.924579] Dynamic subtest uncore: SUCCESS (0.707s)
[465.933976] Starting dynamic subtest: ring
[466.614332] Dynamic subtest ring: SUCCESS (0.697s)
[466.624768] Starting dynamic subtest: engine
[467.310596] Dynamic subtest engine: SUCCESS (0.684s)
[467.320070] Starting dynamic subtest: timelines
[471.228465] Dynamic subtest timelines: SUCCESS (3.914s)
[471.237768] Starting dynamic subtest: requests
[474.618556] Dynamic subtest requests: SUCCESS (3.389s)
[474.628224] Starting dynamic subtest: objects
[475.489305] Dynamic subtest objects: SUCCESS (0.870s)
[475.502885] Starting dynamic subtest: phys
[476.285342] Dynamic subtest phys: SUCCESS (0.793s)
[476.294795] Starting dynamic subtest: dmabuf
[477.065778] Dynamic subtest dmabuf: SUCCESS (0.778s)
[477.075150] Starting dynamic subtest: vma
[483.252311] Dynamic subtest vma: SUCCESS (6.186s)
[483.262031] Starting dynamic subtest: evict
[484.679258] Dynamic subtest evict: SUCCESS (1.424s)
[484.688751] Starting dynamic subtest: gtt
[488.122410] Dynamic subtest gtt: SUCCESS (3.443s)
[488.132313] Starting dynamic subtest: hugepages
[489.014791] Dynamic subtest hugepages: SUCCESS (0.892s)
[489.023976] Starting dynamic subtest: memory_region
[491.771587] Dynamic subtest memory_region: SUCCESS (2.756s)
[491.772686] Subtest mock: SUCCESS (40.905s)
[491.795971] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[491.796713] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[491.798349] [114/133] (538s left) gem_exec_schedule (noreorder-priority)
[493.428874] Starting subtest: noreorder-priority
[493.430292] Starting dynamic subtest: rcs0
[494.592546] Dynamic subtest rcs0: SUCCESS (1.164s)
[494.606831] Starting dynamic subtest: vcs0
[496.191353] Dynamic subtest vcs0: SUCCESS (1.587s)
[496.201742] Starting dynamic subtest: vcs1
[498.173096] Dynamic subtest vcs1: SUCCESS (1.990s)
[498.185270] Starting dynamic subtest: vecs0
[500.192172] Dynamic subtest vecs0: SUCCESS (2.007s)
[500.202155] Starting dynamic subtest: ccs0
[501.321316] Dynamic subtest ccs0: SUCCESS (1.136s)
[501.322742] Subtest noreorder-priority: SUCCESS (7.895s)
[501.509516] [FACT gem_exec_schedule (noreorder-priority)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[501.510795] [FACT gem_exec_schedule (noreorder-priority)] new: kernel.kmod_is_loaded.i915: true
[501.512900] [115/133] (529s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[501.576758] Subtest tiled-to-tiled: SKIP (0.000s)
[501.649822] [116/133] (528s left) kms_cursor_crc (cursor-size-change)
[501.732943] Starting subtest: cursor-size-change
[501.734043] Starting dynamic subtest: pipe-A-eDP-1
[502.577011] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.844s)
[502.585108] Starting dynamic subtest: pipe-D-eDP-1
[504.105135] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[504.106039] Subtest cursor-size-change: SUCCESS (2.373s)
[505.003915] [117/133] (525s left) kms_cursor_edge_walk (64x64-left-edge)
[505.091762] Starting subtest: 64x64-left-edge
[505.092719] Starting dynamic subtest: pipe-A-eDP-1
[508.562419] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[508.570254] Starting dynamic subtest: pipe-D-eDP-1
[511.687067] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[511.687995] Subtest 64x64-left-edge: SUCCESS (6.597s)
[512.498619] [118/133] (518s left) gem_mmap_gtt (big-copy)
[512.557241] Subtest big-copy: SKIP (0.000s)
[512.613541] [119/133] (518s left) gem_busy (parallel)
[512.804764] Starting subtest: parallel
[512.805949] Starting dynamic subtest: rcs0
[514.172372] Dynamic subtest rcs0: SUCCESS (1.363s)
[514.183273] Starting dynamic subtest: bcs0
[516.153422] Dynamic subtest bcs0: SUCCESS (1.979s)
[516.164262] Starting dynamic subtest: vcs0
[518.201974] Dynamic subtest vcs0: SUCCESS (2.045s)
[518.212425] Starting dynamic subtest: vcs1
[520.186540] Dynamic subtest vcs1: SUCCESS (1.982s)
[520.197247] Starting dynamic subtest: vecs0
[522.169557] Dynamic subtest vecs0: SUCCESS (1.980s)
[522.180710] Starting dynamic subtest: ccs0
[524.218405] Dynamic subtest ccs0: SUCCESS (2.046s)
[524.219758] Subtest parallel: SUCCESS (11.411s)
[524.464062] [120/133] (506s left) kms_flip (flip-vs-rmfb)
[524.567490] Starting subtest: flip-vs-rmfb
[524.569471] Starting dynamic subtest: A-eDP1
[533.277081] Dynamic subtest A-eDP1: SUCCESS (8.708s)
[533.286912] Starting dynamic subtest: B-eDP1
[541.918165] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[541.928865] Starting dynamic subtest: C-eDP1
[550.532203] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[550.541234] Starting dynamic subtest: D-eDP1
[559.173023] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[559.178676] Subtest flip-vs-rmfb: SUCCESS (34.611s)
[560.365323] [121/133] (470s left) gem_exec_reloc (basic-cpu-wc-active)
[560.420641] Subtest basic-cpu-wc-active: SKIP (0.000s)
[560.481546] [122/133] (470s left) gem_exec_fence (syncobj-export)
[560.908559] Starting subtest: syncobj-export
[560.913386] Subtest syncobj-export: SUCCESS (0.005s)
[562.238942] [123/133] (468s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[562.344649] Starting subtest: 2x-cursor-vs-flip-legacy
[562.346501] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[562.485999] [124/133] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[562.574694] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[569.321642] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.747s)
[569.455061] [125/133] (461s left) perf_pmu (render-node-busy)
[569.516783] Starting subtest: render-node-busy
[569.517847] Starting dynamic subtest: rcs0
[570.107308] Dynamic subtest rcs0: SUCCESS (0.590s)
[570.120406] Starting dynamic subtest: bcs0
[570.669343] Dynamic subtest bcs0: SUCCESS (0.560s)
[570.682138] Starting dynamic subtest: vcs0
[572.217398] Dynamic subtest vcs0: SUCCESS (1.537s)
[572.228735] Starting dynamic subtest: vcs1
[574.201383] Dynamic subtest vcs1: SUCCESS (1.981s)
[574.212792] Starting dynamic subtest: vecs0
[576.186344] Dynamic subtest vecs0: SUCCESS (1.982s)
[576.197686] Starting dynamic subtest: ccs0
[576.743528] Dynamic subtest ccs0: SUCCESS (0.563s)
[576.744981] Subtest render-node-busy: SUCCESS (7.227s)
[576.830625] [126/133] (454s left) kms_addfb_basic (unused-modifier)
[576.882458] Starting subtest: unused-modifier
[576.883413] Subtest unused-modifier: SUCCESS (0.000s)
[577.005352] [127/133] (453s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[577.057828] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[577.119073] [128/133] (453s left) kms_async_flips (crc)
[577.200179] Starting subtest: crc
[577.583912] Starting dynamic subtest: pipe-A-eDP-1
[580.542342] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.958s)
[580.941544] Starting dynamic subtest: pipe-B-eDP-1
[583.908308] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.975s)
[584.303119] Starting dynamic subtest: pipe-C-eDP-1
[587.166624] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.871s)
[587.542036] Starting dynamic subtest: pipe-D-eDP-1
[590.403673] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s)
[590.404541] Subtest crc: SUCCESS (13.203s)
[591.579634] [129/133] (439s left) kms_plane_multiple (tiling-4)
[591.685797] Starting subtest: tiling-4
[591.686738] Starting dynamic subtest: pipe-A-eDP-1
[595.424293] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.738s)
[595.432827] Starting dynamic subtest: pipe-B-eDP-1
[599.781487] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.355s)
[599.791624] Starting dynamic subtest: pipe-C-eDP-1
[604.094489] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.309s)
[604.103359] Starting dynamic subtest: pipe-D-eDP-1
[608.415570] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.318s)
[608.416392] Subtest tiling-4: SUCCESS (16.727s)
[609.224326] [130/133] (421s left) syncobj_wait (wait-any-interrupted)
[609.285038] Starting subtest: wait-any-interrupted
[609.389274] Subtest wait-any-interrupted: SUCCESS (0.104s)
[609.461255] [131/133] (421s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[609.506684] Starting subtest: single-wait-for-submit-unsubmitted
[609.613365] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[609.684267] [132/133] (421s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[609.771988] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[609.772966] Starting dynamic subtest: pipe-A-eDP-1
[609.913179] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[609.924573] Starting dynamic subtest: pipe-B-eDP-1
[609.932342] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[609.941210] Starting dynamic subtest: pipe-C-eDP-1
[609.948987] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[609.957301] Starting dynamic subtest: pipe-D-eDP-1
[609.964692] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[609.965465] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.146s)
[612.219207] [133/133] (418s left) kms_vblank (ts-continuation-suspend)
[612.301890] Starting subtest: ts-continuation-suspend
[612.302795] Starting dynamic subtest: pipe-A-eDP-1
[629.216183] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[629.226995] Starting dynamic subtest: pipe-D-eDP-1
[647.226218] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.597s)
[647.226957] Subtest ts-continuation-suspend: SUCCESS (4.523s)
[654.045520] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_atomic_transition
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: i915_pm_rps
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: gen7_exec_parse
results: parsing output: 10/ for test: gem_ctx_sseu
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_spin_batch
results: parsing output: 14/ for test: kms_chamelium_edid
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_color_pipeline
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: tools_test
results: parsing output: 23/ for test: gem_ctx_isolation
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: gem_fenced_exec_thrash
results: parsing output: 29/ for test: api_intel_allocator
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_tiled_swapping
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: prime_busy
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: dumb_buffer
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: gem_partial_pwrite_pread
results: parsing output: 57/ for test: kms_universal_plane
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: gen3_render_linear_blits
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: gem_mmap
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_store
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_mmap
results: parsing output: 75/ for test: kms_pm_dc
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_setmode
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_create
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: kms_atomic_interruptible
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_lease
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_draw_crc
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: kms_invalid_mode
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: i915_fb_tiling
results: parsing output: 109/ for test: kms_plane_alpha_blend
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: i915_selftest
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_set_tiling_vs_blt
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_cursor_edge_walk
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_busy
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: kms_async_flips
results: parsing output: 128/ for test: kms_plane_multiple
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_vblank
Done.