[55.624948] Initializing watchdogs
[55.624995]   /dev/watchdog0
[55.639639] [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]
[55.644602] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.646744] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.650149] [001/131] (960s left) kms_async_flips (alternate-sync-async-flip)
[55.764002] Starting subtest: alternate-sync-async-flip
[56.138856] Starting dynamic subtest: pipe-A-eDP-1
[58.956932] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.800s)
[59.337429] Starting dynamic subtest: pipe-B-eDP-1
[62.090357] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.749s)
[62.456312] Starting dynamic subtest: pipe-C-eDP-1
[65.221761] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[65.585440] Starting dynamic subtest: pipe-D-eDP-1
[68.356749] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[68.358948] Subtest alternate-sync-async-flip: SUCCESS (12.544s)
[69.540684] [002/131] (946s left) gem_exec_params (no-blt)
[69.614454] Starting subtest: no-blt
[69.616392] Subtest no-blt: SUCCESS (0.002s)
[69.753996] [003/131] (946s left) kms_chamelium_audio (hdmi-audio)
[70.152883] Subtest hdmi-audio: SKIP (0.000s)
[70.954203] [004/131] (945s left) kms_atomic_transition (plane-all-transition-fencing)
[71.232688] Starting subtest: plane-all-transition-fencing
[71.235257] Starting dynamic subtest: pipe-A-eDP-1
[73.754173] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.522s)
[74.059465] Starting dynamic subtest: pipe-B-eDP-1
[77.310446] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.256s)
[77.606749] Subtest plane-all-transition-fencing: SUCCESS (6.372s)
[78.421281] [005/131] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[78.525963] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[85.485065] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.960s)
[85.596228] [006/131] (930s left) gem_exec_schedule (submit-late-slice)
[85.674869] Starting subtest: submit-late-slice
[85.677044] Starting dynamic subtest: rcs0
[85.698774] Dynamic subtest rcs0: SUCCESS (0.034s)
[85.708557] Starting dynamic subtest: bcs0
[85.728179] Dynamic subtest bcs0: SUCCESS (0.029s)
[85.736501] Starting dynamic subtest: vcs0
[85.760807] Dynamic subtest vcs0: SUCCESS (0.032s)
[85.768284] Starting dynamic subtest: vcs1
[85.787344] Dynamic subtest vcs1: SUCCESS (0.026s)
[85.794483] Starting dynamic subtest: vecs0
[85.820639] Dynamic subtest vecs0: SUCCESS (0.033s)
[85.828199] Starting dynamic subtest: ccs0
[85.849782] Dynamic subtest ccs0: SUCCESS (0.029s)
[85.852034] Subtest submit-late-slice: SUCCESS (0.185s)
[87.026640] [007/131] (929s left) prime_mmap (test_forked)
[87.089971] Starting subtest: test_forked
[87.092227] Starting dynamic subtest: test_forked-smem
[87.127928] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[87.130869] Subtest test_forked: SUCCESS (0.040s)
[87.218232] [008/131] (929s left) gem_tiling_max_stride
[87.362903] [009/131] (929s left) gem_exec_whisper (basic-queues-all)
[87.430357] Starting subtest: basic-queues-all
[98.592234] Subtest basic-queues-all: SUCCESS (11.159s)
[98.773366] [010/131] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[98.877692] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[98.881698] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[98.988632] [011/131] (917s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[99.096439] Starting subtest: 4-tiled-64bpp-rotate-90
[99.115927] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[99.240744] [012/131] (917s left) syncobj_timeline (invalid-signal-zero-handles)
[99.299523] Starting subtest: invalid-signal-zero-handles
[99.301881] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[99.420421] [013/131] (917s left) gen7_exec_parse (chained-batch)
[99.486078] Subtest chained-batch: SKIP (0.000s)
[99.576168] [014/131] (917s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[99.672567] Starting subtest: yf-tiled-8bpp-rotate-90
[99.677094] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[99.765584] [015/131] (916s left) sw_sync (sync_random_merge)
[99.798077] Starting subtest: sync_random_merge
[99.837572] Subtest sync_random_merge: SUCCESS (0.039s)
[99.895290] [016/131] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[99.990281] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[99.993744] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[100.092845] [017/131] (916s left) gem_exec_reloc (basic-cpu-gtt)
[100.153277] Subtest basic-cpu-gtt: SKIP (0.000s)
[100.223437] [018/131] (916s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[100.276681] Starting subtest: etime-single-wait-for-submit-submitted
[100.384065] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[100.455734] [019/131] (916s left) gem_userptr_blits (coherency-sync)
[100.517348] Starting subtest: coherency-sync
[100.778852] Subtest coherency-sync: SKIP (0.227s)
[100.877842] [020/131] (916s left) kms_content_protection (atomic-dpms)
[101.081606] Starting subtest: atomic-dpms
[104.421625] Subtest atomic-dpms: SKIP (3.337s)
[105.595024] [021/131] (911s left) kms_cursor_crc (cursor-random-max-size)
[105.921029] Starting subtest: cursor-random-max-size
[105.927925] Subtest cursor-random-max-size: SKIP (0.000s)
[106.052504] [022/131] (910s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[106.156655] Starting subtest: y-tiled-16bpp-rotate-180
[106.161215] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[106.247079] [023/131] (910s left) gem_eio (in-flight-1us)
[106.494479] Starting subtest: in-flight-1us
[115.154787] Subtest in-flight-1us: SUCCESS (8.659s)
[115.322615] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[115.325909] [024/131] (901s left) i915_fb_tiling (basic-x-tiling)
[115.388449] Subtest basic-x-tiling: SKIP (0.000s)
[115.456941] [025/131] (901s left) kms_busy (extended-modeset-hang-oldfb)
[115.559040] Starting subtest: extended-modeset-hang-oldfb
[115.561236] Starting dynamic subtest: pipe-A
[127.475862] Dynamic subtest pipe-A: SUCCESS (11.913s)
[127.485929] Starting dynamic subtest: pipe-D
[139.739469] Dynamic subtest pipe-D: SUCCESS (12.259s)
[139.741822] Subtest extended-modeset-hang-oldfb: SUCCESS (24.177s)
[140.523916] [026/131] (876s left) kms_plane_cursor (viewport)
[140.626047] Starting subtest: viewport
[140.630428] Starting dynamic subtest: pipe-A-eDP-1-size-64
[143.571328] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.943s)
[143.631445] Starting dynamic subtest: pipe-A-eDP-1-size-128
[146.639936] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (3.015s)
[146.699632] Starting dynamic subtest: pipe-A-eDP-1-size-256
[149.696570] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (3.004s)
[150.045866] Starting dynamic subtest: pipe-B-eDP-1-size-64
[153.656878] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.622s)
[153.717607] Starting dynamic subtest: pipe-B-eDP-1-size-128
[156.635946] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.925s)
[156.695966] Starting dynamic subtest: pipe-B-eDP-1-size-256
[159.780300] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (3.092s)
[160.135752] Starting dynamic subtest: pipe-C-eDP-1-size-64
[163.424096] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.298s)
[163.462180] Starting dynamic subtest: pipe-C-eDP-1-size-128
[165.991310] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.535s)
[166.029633] Starting dynamic subtest: pipe-C-eDP-1-size-256
[168.558092] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.535s)
[168.885135] Starting dynamic subtest: pipe-D-eDP-1-size-64
[172.069091] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.194s)
[172.107742] Starting dynamic subtest: pipe-D-eDP-1-size-128
[174.614061] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.513s)
[174.654457] Starting dynamic subtest: pipe-D-eDP-1-size-256
[177.215700] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.569s)
[177.531270] Subtest viewport: SUCCESS (36.901s)
[178.322535] [027/131] (838s left) api_intel_bb (blit-reloc-purge-cache)
[178.381105] Starting subtest: blit-reloc-purge-cache
[178.385646] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[178.504069] [028/131] (838s left) gem_spin_batch (resubmit-new-all)
[178.567232] Starting subtest: resubmit-new-all
[178.569660] Starting dynamic subtest: rcs0
[178.581201] Dynamic subtest rcs0: SUCCESS (0.014s)
[178.591797] Starting dynamic subtest: bcs0
[178.594240] Dynamic subtest bcs0: SUCCESS (0.011s)
[178.602859] Starting dynamic subtest: vcs0
[178.605234] Dynamic subtest vcs0: SUCCESS (0.009s)
[178.613806] Starting dynamic subtest: vcs1
[178.615762] Dynamic subtest vcs1: SUCCESS (0.010s)
[178.624430] Starting dynamic subtest: vecs0
[178.626686] Dynamic subtest vecs0: SUCCESS (0.010s)
[178.635293] Starting dynamic subtest: ccs0
[178.637185] Dynamic subtest ccs0: SUCCESS (0.011s)
[178.639065] Subtest resubmit-new-all: SUCCESS (0.067s)
[179.963500] [029/131] (837s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[180.057295] Starting subtest: primary-yf-tiled-reflect-x-270
[180.061651] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[180.132059] [030/131] (837s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[180.239562] Starting subtest: fbc-pr-cursor-mmap-gtt
[180.243596] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[180.308106] [031/131] (837s left) gem_ctx_isolation (nonpriv-switch)
[180.358629] Starting subtest: nonpriv-switch
[180.360960] Starting dynamic subtest: rcs0
[180.938127] Dynamic subtest rcs0: SUCCESS (0.580s)
[180.949034] Starting dynamic subtest: bcs0
[181.592328] Dynamic subtest bcs0: SUCCESS (0.654s)
[181.601026] Starting dynamic subtest: vcs0
[182.242479] Dynamic subtest vcs0: SUCCESS (0.649s)
[182.251045] Starting dynamic subtest: vcs1
[183.551585] Dynamic subtest vcs1: SUCCESS (1.307s)
[183.562656] Starting dynamic subtest: vecs0
[185.509567] Dynamic subtest vecs0: SUCCESS (1.958s)
[185.520740] Starting dynamic subtest: ccs0
[187.568127] Dynamic subtest ccs0: SUCCESS (2.058s)
[187.570662] Subtest nonpriv-switch: SUCCESS (7.209s)
[187.831318] [032/131] (829s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[187.930368] Starting subtest: drrs-dirtyfb-ioctl
[187.943825] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[188.045760] [033/131] (829s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[188.153653] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[189.477839] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.326s)
[189.715995] [034/131] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[189.824949] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[189.829313] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[189.934273] [035/131] (827s left) kms_mmap_write_crc (main)
[190.034222] Starting subtest: main
[190.036518] Starting dynamic subtest: pipe-A-eDP-1
[193.718083] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.682s)
[193.720648] Subtest main: SUCCESS (3.683s)
[194.535563] [036/131] (822s left) i915_pm_rc6_residency (media-rc6-accuracy)
[194.596068] Starting subtest: media-rc6-accuracy
[194.600370] Subtest media-rc6-accuracy: SKIP (0.000s)
[194.711969] [037/131] (822s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[194.819713] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[196.143964] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.326s)
[196.466757] [038/131] (821s left) sysfs_heartbeat_interval (invalid)
[196.529656] Starting subtest: invalid
[196.532028] Starting dynamic subtest: vecs0
[196.534224] Dynamic subtest vecs0: SUCCESS (0.000s)
[196.542818] Starting dynamic subtest: ccs0
[196.545042] Dynamic subtest ccs0: SUCCESS (0.000s)
[196.553398] Starting dynamic subtest: vcs0
[196.555670] Dynamic subtest vcs0: SUCCESS (0.000s)
[196.564016] Starting dynamic subtest: bcs0
[196.566334] Dynamic subtest bcs0: SUCCESS (0.000s)
[196.574634] Starting dynamic subtest: rcs0
[196.576934] Dynamic subtest rcs0: SUCCESS (0.000s)
[196.585286] Starting dynamic subtest: vcs1
[196.587252] Dynamic subtest vcs1: SUCCESS (0.000s)
[196.589184] Subtest invalid: SUCCESS (0.005s)
[196.638263] [039/131] (821s left) dumb_buffer (map-uaf)
[196.698821] Starting subtest: map-uaf
[196.713370] Subtest map-uaf: SUCCESS (0.017s)
[196.836209] [040/131] (820s left) gem_mmap_wc (bad-size)
[196.900722] Subtest bad-size: SKIP (0.000s)
[196.971329] [041/131] (820s left) kms_atomic_interruptible (universal-setplane-primary)
[197.079093] Starting subtest: universal-setplane-primary
[197.081343] Starting dynamic subtest: pipe-A-eDP-1
[204.447144] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.367s)
[204.449458] Subtest universal-setplane-primary: SUCCESS (7.369s)
[205.281554] [042/131] (812s left) kms_frontbuffer_tracking (psr-2p-rte)
[205.373810] Starting subtest: psr-2p-rte
[205.378405] Subtest psr-2p-rte: SKIP (0.000s)
[205.479028] [043/131] (812s left) gem_close_race (multigpu-basic-threads)
[205.539045] Starting subtest: multigpu-basic-threads
[205.543712] Subtest multigpu-basic-threads: SKIP (0.000s)
[205.754889] [044/131] (812s left) gen9_exec_parse (secure-batches)
[205.810081] Subtest secure-batches: SKIP (0.000s)
[205.873586] [045/131] (812s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[205.969156] Starting subtest: crc-primary-basic-yf-tiled-ccs
[205.971438] Starting dynamic subtest: pipe-A-eDP-1
[205.994446] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[206.005038] Starting dynamic subtest: pipe-B-eDP-1
[206.026873] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[206.034884] Starting dynamic subtest: pipe-C-eDP-1
[206.057026] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[206.065070] Starting dynamic subtest: pipe-D-eDP-1
[206.087320] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[206.091208] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[208.146944] [046/131] (809s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[208.254778] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[208.259245] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[208.351104] [047/131] (809s left) kms_selftest (drm_plane_helper)
[208.385945] Starting subtest: drm_plane_helper
[208.417655] Starting dynamic subtest: drm_test_check_plane_state
[208.562252] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.144s)
[208.570430] Starting dynamic subtest: drm_test_check_invalid_plane_state
[208.702378] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.139s)
[208.704403] Subtest drm_plane_helper: SUCCESS (0.315s)
[208.887385] [048/131] (809s left) prime_self_import (export-vs-gem_close-race)
[208.919361] Starting subtest: export-vs-gem_close-race
[214.026181] Subtest export-vs-gem_close-race: SUCCESS (5.106s)
[214.101575] [049/131] (803s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[214.204342] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[214.206759] Starting dynamic subtest: pipe-A
[214.290251] Dynamic subtest pipe-A: SUCCESS (0.086s)
[214.299392] Starting dynamic subtest: pipe-B
[215.467946] Dynamic subtest pipe-B: SUCCESS (1.176s)
[215.477870] Starting dynamic subtest: pipe-C
[216.581849] Dynamic subtest pipe-C: SUCCESS (1.112s)
[216.591489] Starting dynamic subtest: pipe-D
[217.700092] Dynamic subtest pipe-D: SUCCESS (1.118s)
[217.702487] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.496s)
[218.843545] [050/131] (799s left) gem_exec_schedule (preempt-engines)
[218.921152] Starting subtest: preempt-engines
[218.923201] Starting dynamic subtest: rcs0
[221.132645] Dynamic subtest rcs0: SUCCESS (2.219s)
[221.144807] Starting dynamic subtest: bcs0
[223.347418] Dynamic subtest bcs0: SUCCESS (2.213s)
[223.358761] Starting dynamic subtest: vcs0
[225.614571] Dynamic subtest vcs0: SUCCESS (2.265s)
[225.626074] Starting dynamic subtest: vcs1
[227.927741] Dynamic subtest vcs1: SUCCESS (2.311s)
[227.941829] Starting dynamic subtest: vecs0
[230.179637] Dynamic subtest vecs0: SUCCESS (2.250s)
[230.191718] Starting dynamic subtest: ccs0
[232.500604] Dynamic subtest ccs0: SUCCESS (2.319s)
[232.503551] Subtest preempt-engines: SUCCESS (13.587s)
[232.806420] [051/131] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[232.917475] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[232.921692] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[233.024917] [052/131] (785s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[233.142105] Starting subtest: protected-encrypted-src-copy-not-readible
[233.259083] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.117s)
[233.389840] [053/131] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[233.498055] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[233.502527] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[233.610309] [054/131] (784s left) prime_busy (after)
[233.667207] Starting subtest: after
[233.672325] Starting dynamic subtest: rcs0
[233.715696] Dynamic subtest rcs0: SUCCESS (0.045s)
[233.724425] Starting dynamic subtest: bcs0
[233.789447] Dynamic subtest bcs0: SUCCESS (0.073s)
[233.799420] Starting dynamic subtest: vcs0
[233.830715] Dynamic subtest vcs0: SUCCESS (0.040s)
[233.845070] Starting dynamic subtest: vcs1
[233.871683] Dynamic subtest vcs1: SUCCESS (0.040s)
[233.882085] Starting dynamic subtest: vecs0
[233.913685] Dynamic subtest vecs0: SUCCESS (0.041s)
[233.922505] Starting dynamic subtest: ccs0
[233.954384] Dynamic subtest ccs0: SUCCESS (0.040s)
[234.062493] Subtest after: SUCCESS (0.393s)
[234.149486] [055/131] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[234.254797] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[234.259099] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[234.362270] [056/131] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[234.464823] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[234.469276] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[234.571263] [057/131] (783s left) kms_properties (plane-properties-atomic)
[234.671130] Starting subtest: plane-properties-atomic
[234.673395] Starting dynamic subtest: pipe-A-eDP-1
[235.230822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[235.240661] Starting dynamic subtest: pipe-B-eDP-1
[236.494257] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[236.503768] Starting dynamic subtest: pipe-C-eDP-1
[237.716199] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[237.725504] Starting dynamic subtest: pipe-D-eDP-1
[238.945296] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[238.947267] Subtest plane-properties-atomic: SUCCESS (4.271s)
[239.733218] [058/131] (778s left) gem_exec_fence (submit3)
[239.915296] Starting subtest: submit3
[239.920232] Subtest submit3: SKIP (0.000s)
[241.941503] [059/131] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[242.039722] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[242.043890] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[242.137808] [060/131] (776s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[242.241156] Starting subtest: invalid-modeset-force-ultra-joiner
[242.246030] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[242.305035] [061/131] (776s left) kms_psr (psr-cursor-mmap-cpu)
[242.420144] Starting subtest: psr-cursor-mmap-cpu
[242.422496] Starting dynamic subtest: eDP-1
[244.115794] Dynamic subtest eDP-1: SUCCESS (1.698s)
[244.118177] Subtest psr-cursor-mmap-cpu: SUCCESS (1.699s)
[244.982584] [062/131] (773s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[245.068404] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[245.070662] Starting dynamic subtest: pipe-A-default-mode
[245.436800] Dynamic subtest pipe-A-default-mode: SKIP (0.365s)
[245.441043] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.366s)
[246.207134] [063/131] (772s left) gem_exec_fence (syncobj-unused-fence)
[246.623969] Starting subtest: syncobj-unused-fence
[246.630795] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[247.979083] [064/131] (770s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[248.030546] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[248.095581] [065/131] (770s left) gem_workarounds (basic-read-context)
[248.165374] Starting subtest: basic-read-context
[248.180361] Subtest basic-read-context: SUCCESS (0.015s)
[248.306354] [066/131] (770s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[248.429468] Starting subtest: cursor-vs-flip-atomic
[277.798734] Subtest cursor-vs-flip-atomic: SUCCESS (29.369s)
[278.621800] [067/131] (740s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[278.731973] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[285.295685] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.566s)
[285.407234] [068/131] (733s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[285.501188] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[285.503545] Starting dynamic subtest: pipe-A-eDP-1
[285.526885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.536532] Starting dynamic subtest: pipe-B-eDP-1
[285.557972] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.566729] Starting dynamic subtest: pipe-C-eDP-1
[285.588639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.597020] Starting dynamic subtest: pipe-D-eDP-1
[285.619856] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.624040] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[287.686801] [069/131] (731s left) i915_pm_rps (thresholds)
[287.753772] Starting subtest: thresholds
[287.758643] Subtest thresholds: SKIP (0.000s)
[287.839773] [070/131] (731s left) kms_frontbuffer_tracking (psr-slowdraw)
[287.934399] Starting subtest: psr-slowdraw
[312.977498] Subtest psr-slowdraw: SUCCESS (25.044s)
[313.100962] [071/131] (705s left) kms_invalid_mode (zero-hdisplay)
[313.197413] Starting subtest: zero-hdisplay
[313.199665] Starting dynamic subtest: pipe-A-eDP-1
[313.480713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[313.489702] Starting dynamic subtest: pipe-B-eDP-1
[313.491820] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[313.500074] Starting dynamic subtest: pipe-C-eDP-1
[313.501882] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[313.510469] Starting dynamic subtest: pipe-D-eDP-1
[313.512688] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[313.514791] Subtest zero-hdisplay: SUCCESS (0.289s)
[314.305685] [072/131] (704s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[314.432764] Starting subtest: flip-vs-cursor-toggle
[322.593596] Subtest flip-vs-cursor-toggle: SUCCESS (8.160s)
[323.435258] [073/131] (695s left) kms_cursor_crc (cursor-offscreen-64x21)
[323.646498] Starting subtest: cursor-offscreen-64x21
[323.691813] Subtest cursor-offscreen-64x21: SKIP (0.040s)
[323.951663] [074/131] (695s left) perf_pmu (event-wait)
[323.990627] Starting subtest: event-wait
[323.993074] Starting dynamic subtest: rcs0
[323.997712] Dynamic subtest rcs0: SKIP (0.000s)
[324.002434] Subtest event-wait: SKIP (0.001s)
[324.137065] [075/131] (695s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[324.232355] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[324.234712] Starting dynamic subtest: pipe-A
[325.775915] Dynamic subtest pipe-A: SUCCESS (1.544s)
[325.785911] Starting dynamic subtest: pipe-B
[328.427140] Dynamic subtest pipe-B: SUCCESS (2.651s)
[328.436627] Starting dynamic subtest: pipe-C
[329.648070] Dynamic subtest pipe-C: SUCCESS (1.220s)
[329.657148] Starting dynamic subtest: pipe-D
[330.900858] Dynamic subtest pipe-D: SUCCESS (1.252s)
[330.903153] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.669s)
[332.039886] [076/131] (687s left) vgem_basic (create)
[332.096651] Starting subtest: create
[332.098566] Subtest create: SUCCESS (0.000s)
[332.152434] [077/131] (687s left) kms_addfb_basic (addfb25-bad-modifier)
[332.235316] Starting subtest: addfb25-bad-modifier
[332.237525] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[332.334274] [078/131] (686s left) perf_pmu (busy-idle-check-all)
[332.370046] Starting subtest: busy-idle-check-all
[332.372133] Starting dynamic subtest: rcs0
[333.044256] Dynamic subtest rcs0: SUCCESS (0.676s)
[333.055145] Starting dynamic subtest: bcs0
[333.698628] Dynamic subtest bcs0: SUCCESS (0.653s)
[333.710863] Starting dynamic subtest: vcs0
[334.932499] Dynamic subtest vcs0: SUCCESS (1.230s)
[334.944842] Starting dynamic subtest: vcs1
[336.915350] Dynamic subtest vcs1: SUCCESS (1.981s)
[336.927619] Starting dynamic subtest: vecs0
[338.900079] Dynamic subtest vecs0: SUCCESS (1.982s)
[338.912480] Starting dynamic subtest: ccs0
[339.556270] Dynamic subtest ccs0: SUCCESS (0.655s)
[339.558754] Subtest busy-idle-check-all: SUCCESS (7.189s)
[339.690985] [079/131] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[339.798593] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[347.122223] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.327s)
[347.279140] [080/131] (672s left) kms_chamelium_edid (dp-mode-timings)
[347.673062] Subtest dp-mode-timings: SKIP (0.000s)
[348.445446] [081/131] (670s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[348.572505] Starting subtest: short-flip-before-cursor-toggle
[349.517713] Subtest short-flip-before-cursor-toggle: SUCCESS (0.945s)
[350.391032] [082/131] (669s left) gem_exec_balancer (waits)
[350.450711] Starting subtest: waits
[356.923759] Subtest waits: SUCCESS (6.471s)
[357.230787] [083/131] (662s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[362.242540] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[362.247096] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[363.085610] [084/131] (656s left) gem_ctx_param (invalid-get-ringsize)
[363.138728] Starting subtest: invalid-get-ringsize
[363.141069] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[363.258500] [085/131] (656s left) gem_ctx_bad_destroy (double-destroy)
[363.313720] Starting subtest: double-destroy
[363.315993] Subtest double-destroy: SUCCESS (0.000s)
[363.389797] [086/131] (656s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[363.490248] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[363.494445] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[363.598375] [087/131] (656s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[363.695792] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[367.456271] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.765s)
[368.591020] [088/131] (651s left) gem_softpin (evict-single-offset)
[368.645903] Starting subtest: evict-single-offset
[396.885225] Subtest evict-single-offset: SUCCESS (28.235s)
[396.985746] [089/131] (622s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[397.118745] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[397.121064] Starting dynamic subtest: pipe-A-eDP-1
[397.177605] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[397.189198] Starting dynamic subtest: pipe-B-eDP-1
[397.245684] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[397.256730] Starting dynamic subtest: pipe-C-eDP-1
[397.313966] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[397.324931] Starting dynamic subtest: pipe-D-eDP-1
[397.382284] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[397.386356] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[399.321131] [090/131] (620s left) gem_exec_reloc (basic-scanout)
[399.398584] Subtest basic-scanout: SKIP (0.000s)
[399.465597] [091/131] (620s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[404.460674] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[404.463048] Starting dynamic subtest: pipe-A-eDP-1
[411.064749] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.603s)
[411.075397] Starting dynamic subtest: pipe-B-eDP-1
[417.587559] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.520s)
[417.589909] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.126s)
[418.464571] [092/131] (601s left) gem_ctx_sseu (mmap-args)
[418.519788] Subtest mmap-args: SKIP (0.000s)
[418.609335] [093/131] (601s left) syncobj_wait (multi-wait-submitted-signaled)
[418.660413] Starting subtest: multi-wait-submitted-signaled
[418.662808] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[418.732969] [094/131] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[418.837203] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[418.841228] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[418.950067] [095/131] (601s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[419.006537] Starting subtest: yf-tiled-ccs-to-x-tiled
[419.011239] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[419.192231] [096/131] (600s left) syncobj_wait (single-wait-all-submitted)
[419.240837] Starting subtest: single-wait-all-submitted
[419.342132] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[419.421065] [097/131] (600s left) kms_pm_rpm (universal-planes)
[421.082237] Starting subtest: universal-planes
[421.085267] Starting dynamic subtest: plane-33
[429.397317] Dynamic subtest plane-33: SUCCESS (8.315s)
[429.409185] Starting dynamic subtest: plane-43
[437.666512] Dynamic subtest plane-43: SUCCESS (8.266s)
[437.678877] Starting dynamic subtest: plane-53
[445.953882] Dynamic subtest plane-53: SUCCESS (8.285s)
[445.966176] Starting dynamic subtest: plane-63
[454.230943] Dynamic subtest plane-63: SUCCESS (8.275s)
[454.241906] Starting dynamic subtest: plane-73
[462.524408] Dynamic subtest plane-73: SUCCESS (8.291s)
[462.536608] Starting dynamic subtest: plane-83
[470.810034] Dynamic subtest plane-83: SUCCESS (8.283s)
[470.812956] Subtest universal-planes: SUCCESS (49.729s)
[471.172370] [098/131] (548s left) kms_cursor_edge_walk (128x128-left-edge)
[471.262936] Starting subtest: 128x128-left-edge
[471.265285] Starting dynamic subtest: pipe-A-eDP-1
[474.714197] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s)
[474.724477] Starting dynamic subtest: pipe-D-eDP-1
[477.842748] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[477.844949] Subtest 128x128-left-edge: SUCCESS (6.577s)
[478.638760] [099/131] (541s left) kms_psr (pr-sprite-plane-onoff)
[478.748457] Starting subtest: pr-sprite-plane-onoff
[478.752658] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[478.820948] [100/131] (541s left) drm_read (fault-buffer)
[478.985856] Starting subtest: fault-buffer
[478.988206] Subtest fault-buffer: SUCCESS (0.000s)
[479.135453] [101/131] (541s left) kms_feature_discovery (psr1)
[479.242306] Starting subtest: psr1
[479.244519] Subtest psr1: SUCCESS (0.000s)
[479.313509] [102/131] (540s left) kms_psr (fbc-psr-cursor-blt)
[479.411798] Starting subtest: fbc-psr-cursor-blt
[479.413862] Starting dynamic subtest: eDP-1
[479.418186] Dynamic subtest eDP-1: SKIP (0.000s)
[479.422461] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[479.488085] [103/131] (540s left) kms_flip (dpms-vs-vblank-race-interruptible)
[479.589128] Starting subtest: dpms-vs-vblank-race-interruptible
[479.591062] Starting dynamic subtest: A-eDP1
[484.494053] Dynamic subtest A-eDP1: SUCCESS (4.900s)
[484.506950] Starting dynamic subtest: B-eDP1
[489.114067] Dynamic subtest B-eDP1: SUCCESS (4.620s)
[489.127577] Starting dynamic subtest: C-eDP1
[493.690915] Dynamic subtest C-eDP1: SUCCESS (4.575s)
[493.700969] Starting dynamic subtest: D-eDP1
[498.302329] Dynamic subtest D-eDP1: SUCCESS (4.610s)
[498.304555] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.711s)
[499.176385] [104/131] (521s left) syncobj_timeline (32bits-limit)
[499.246262] Starting subtest: 32bits-limit
[499.248527] Subtest 32bits-limit: SUCCESS (0.001s)
[499.365700] [105/131] (521s left) kms_flip (2x-flip-vs-modeset)
[499.455281] Starting subtest: 2x-flip-vs-modeset
[499.466709] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[499.548737] [106/131] (520s left) kms_chamelium_frames (hdmi-crc-multiple)
[499.928087] Subtest hdmi-crc-multiple: SKIP (0.000s)
[500.693097] [107/131] (519s left) gem_ctx_param (set-priority-invalid-size)
[500.760334] Starting subtest: set-priority-invalid-size
[500.762730] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[500.838290] [108/131] (519s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[500.956749] Starting subtest: cursorA-vs-flipA-atomic-transitions
[512.171910] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.214s)
[513.044234] [109/131] (507s left) core_auth (many-magics)
[513.102118] Starting subtest: many-magics
[513.991517] Subtest many-magics: SUCCESS (0.891s)
[514.175687] [110/131] (506s left) kms_flip (flip-vs-rmfb)
[514.272168] Starting subtest: flip-vs-rmfb
[514.274318] Starting dynamic subtest: A-eDP1
[522.925166] Dynamic subtest A-eDP1: SUCCESS (8.652s)
[522.936377] Starting dynamic subtest: B-eDP1
[531.646794] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[531.655938] Starting dynamic subtest: C-eDP1
[540.358881] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[540.368988] Starting dynamic subtest: D-eDP1
[548.984876] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[548.989542] Subtest flip-vs-rmfb: SUCCESS (34.715s)
[550.158195] [111/131] (470s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[550.253777] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[550.257870] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[550.353074] [112/131] (470s left) gem_close (basic)
[550.414606] Starting subtest: basic
[550.416986] Subtest basic: SUCCESS (0.000s)
[550.517284] [113/131] (470s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[550.614732] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[550.618696] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[550.727241] [114/131] (470s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[550.829177] Starting subtest: x-tiled-64bpp-rotate-180
[553.269293] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.440s)
[553.500651] [115/131] (467s left) gem_softpin (overlap)
[553.568096] Starting subtest: overlap
[554.523813] Subtest overlap: SUCCESS (0.954s)
[554.647377] [116/131] (466s left) kms_addfb_basic (invalid-get-prop-any)
[554.693902] Starting subtest: invalid-get-prop-any
[554.695910] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[554.843422] [117/131] (466s left) gem_ctx_shared (q-smoketest)
[554.902972] Starting subtest: Q-smoketest
[554.905288] Starting dynamic subtest: rcs0
[560.441056] Dynamic subtest rcs0: SUCCESS (5.488s)
[560.452300] Starting dynamic subtest: bcs0
[565.943036] Dynamic subtest bcs0: SUCCESS (5.497s)
[565.960696] Starting dynamic subtest: vcs0
[571.420211] Dynamic subtest vcs0: SUCCESS (5.477s)
[571.431731] Starting dynamic subtest: vcs1
[576.899023] Dynamic subtest vcs1: SUCCESS (5.476s)
[576.913482] Starting dynamic subtest: vecs0
[582.369142] Dynamic subtest vecs0: SUCCESS (5.475s)
[582.379893] Starting dynamic subtest: ccs0
[587.867885] Dynamic subtest ccs0: SUCCESS (5.496s)
[587.870242] Subtest Q-smoketest: SUCCESS (32.915s)
[588.013449] [118/131] (432s left) syncobj_timeline (signal)
[588.071083] Starting subtest: signal
[588.073292] Subtest signal: SUCCESS (0.000s)
[588.193197] [119/131] (432s left) kms_pm_lpsp (kms-lpsp)
[589.290444] Starting subtest: kms-lpsp
[589.292732] Starting dynamic subtest: pipe-A-eDP-1
[589.440142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[589.745834] Subtest kms-lpsp: SUCCESS (0.456s)
[590.590464] [120/131] (430s left) gem_mmap_gtt (fault-concurrent)
[590.644720] Subtest fault-concurrent: SKIP (0.000s)
[590.707961] [121/131] (430s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[590.794843] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[590.797067] Starting dynamic subtest: pipe-A-eDP-1
[590.819323] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[590.831547] Starting dynamic subtest: pipe-B-eDP-1
[590.852284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[590.861362] Starting dynamic subtest: pipe-C-eDP-1
[590.882169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[590.891075] Starting dynamic subtest: pipe-D-eDP-1
[590.911993] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[590.916114] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[592.963690] [122/131] (428s left) kms_flip (wf_vblank-ts-check-interruptible)
[593.052994] Starting subtest: wf_vblank-ts-check-interruptible
[593.055406] Starting dynamic subtest: A-eDP1
[601.981333] Dynamic subtest A-eDP1: SUCCESS (8.927s)
[601.991658] Starting dynamic subtest: B-eDP1
[610.909246] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[610.921126] Starting dynamic subtest: C-eDP1
[619.822290] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[619.833228] Starting dynamic subtest: D-eDP1
[628.747870] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[628.753774] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.699s)
[629.965322] [123/131] (391s left) gem_media_vme
[630.095968] [124/131] (391s left) kms_sequence (queue-idle)
[630.192262] Starting subtest: queue-idle
[630.194602] Starting dynamic subtest: pipe-A-eDP-1
[631.988490] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.794s)
[631.998862] Starting dynamic subtest: pipe-B-eDP-1
[634.435201] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.446s)
[634.446150] Starting dynamic subtest: pipe-C-eDP-1
[636.845945] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.410s)
[636.855961] Starting dynamic subtest: pipe-D-eDP-1
[639.246475] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.398s)
[639.248907] Subtest queue-idle: SUCCESS (9.053s)
[640.069391] [125/131] (381s left) kms_psr (fbc-psr-dpms)
[640.160464] Starting subtest: fbc-psr-dpms
[640.162739] Starting dynamic subtest: eDP-1
[640.167215] Dynamic subtest eDP-1: SKIP (0.000s)
[640.171701] Subtest fbc-psr-dpms: SKIP (0.001s)
[640.234461] [126/131] (381s left) kms_vblank (wait-busy)
[640.338310] Starting subtest: wait-busy
[640.340495] Starting dynamic subtest: pipe-A-eDP-1
[642.225142] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[642.240244] Starting dynamic subtest: pipe-D-eDP-1
[644.822357] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.595s)
[644.824784] Subtest wait-busy: SUCCESS (4.484s)
[645.614142] [127/131] (375s left) kms_color (invalid-gamma-lut-sizes)
[645.713358] Starting subtest: invalid-gamma-lut-sizes
[645.715920] Starting dynamic subtest: pipe-A
[646.013158] Dynamic subtest pipe-A: SUCCESS (0.298s)
[646.023219] Starting dynamic subtest: pipe-B
[646.025483] Dynamic subtest pipe-B: SUCCESS (0.001s)
[646.034857] Starting dynamic subtest: pipe-C
[646.037138] Dynamic subtest pipe-C: SUCCESS (0.001s)
[646.046245] Starting dynamic subtest: pipe-D
[646.048418] Dynamic subtest pipe-D: SUCCESS (0.001s)
[646.050645] Subtest invalid-gamma-lut-sizes: SUCCESS (0.302s)
[646.848287] [128/131] (374s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[646.966876] Starting subtest: flip-vs-cursor-busy-crc-atomic
[647.788431] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.822s)
[648.577772] [129/131] (372s left) syncobj_timeline (transfer-timeline-point)
[648.622932] Starting subtest: transfer-timeline-point
[648.625274] Subtest transfer-timeline-point: SUCCESS (0.000s)
[648.765298] [130/131] (372s left) i915_selftest (mock)
[652.459123] Starting subtest: mock
[652.461512] Starting dynamic subtest: sanitycheck
[653.178856] Dynamic subtest sanitycheck: SUCCESS (0.718s)
[653.188628] Starting dynamic subtest: shmem
[653.891958] Dynamic subtest shmem: SUCCESS (0.711s)
[653.901033] Starting dynamic subtest: fence
[662.051980] Dynamic subtest fence: SUCCESS (8.158s)
[662.061880] Starting dynamic subtest: scatterlist
[663.724339] Dynamic subtest scatterlist: SUCCESS (1.671s)
[663.734595] Starting dynamic subtest: syncmap
[667.001618] Dynamic subtest syncmap: SUCCESS (3.276s)
[667.011266] Starting dynamic subtest: uncore
[667.718630] Dynamic subtest uncore: SUCCESS (0.715s)
[667.733895] Starting dynamic subtest: ring
[668.390550] Dynamic subtest ring: SUCCESS (0.670s)
[668.400329] Starting dynamic subtest: engine
[669.049565] Dynamic subtest engine: SUCCESS (0.657s)
[669.059655] Starting dynamic subtest: timelines
[672.972350] Dynamic subtest timelines: SUCCESS (3.920s)
[672.982619] Starting dynamic subtest: requests
[676.578363] Dynamic subtest requests: SUCCESS (3.604s)
[676.587989] Starting dynamic subtest: objects
[677.388903] Dynamic subtest objects: SUCCESS (0.809s)
[677.398032] Starting dynamic subtest: phys
[678.253815] Dynamic subtest phys: SUCCESS (0.863s)
[678.263865] Starting dynamic subtest: dmabuf
[679.059856] Dynamic subtest dmabuf: SUCCESS (0.804s)
[679.068826] Starting dynamic subtest: vma
[684.945272] Dynamic subtest vma: SUCCESS (5.882s)
[684.953866] Starting dynamic subtest: evict
[686.415518] Dynamic subtest evict: SUCCESS (1.468s)
[686.424723] Starting dynamic subtest: gtt
[689.739752] Dynamic subtest gtt: SUCCESS (3.323s)
[689.748437] Starting dynamic subtest: hugepages
[690.751369] Dynamic subtest hugepages: SUCCESS (1.009s)
[690.761292] Starting dynamic subtest: memory_region
[695.308948] Dynamic subtest memory_region: SUCCESS (4.556s)
[695.311694] Subtest mock: SUCCESS (42.847s)
[695.339562] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[695.340249] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[695.343268] [131/131] (326s left) api_intel_bb (reset-bb)
[696.816606] Starting subtest: reset-bb
[696.826259] Subtest reset-bb: SUCCESS (0.012s)
[696.928510] [FACT api_intel_bb (reset-bb)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[696.929759] [FACT api_intel_bb (reset-bb)] new: kernel.kmod_is_loaded.i915: true
[696.930426] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_chamelium_audio
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: prime_mmap
results: parsing output: 7/ for test: gem_tiling_max_stride
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_content_protection
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: i915_fb_tiling
results: parsing output: 24/ for test: kms_busy
results: parsing output: 25/ for test: kms_plane_cursor
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: gem_spin_batch
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_ctx_isolation
results: parsing output: 31/ for test: kms_dirtyfb
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_mmap_write_crc
results: parsing output: 35/ for test: i915_pm_rc6_residency
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: sysfs_heartbeat_interval
results: parsing output: 38/ for test: dumb_buffer
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_close_race
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_selftest
results: parsing output: 47/ for test: prime_self_import
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: prime_busy
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_properties
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_joiner
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_workarounds
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: vgem_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_chamelium_edid
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: gem_ctx_bad_destroy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: gem_ctx_sseu
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: kms_cursor_edge_walk
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: drm_read
results: parsing output: 100/ for test: kms_feature_discovery
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: core_auth
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_close
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: gem_ctx_shared
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_pm_lpsp
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_media_vme
results: parsing output: 123/ for test: kms_sequence
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: api_intel_bb
Done.