[46.270079] Initializing watchdogs
[46.270146]   /dev/watchdog0
[46.345634] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[46.351373] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.353886] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[46.355905] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[46.453030] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[47.576257] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.106s)
[47.678339] [002/133] (959s left) gem_flink_basic (bad-open)
[47.718860] Starting subtest: bad-open
[47.719558] Subtest bad-open: SUCCESS (0.000s)
[47.775784] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[47.868450] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[47.869805] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[47.953844] [004/133] (959s left) gem_ppgtt (shrink-vs-evict-pinned)
[47.993290] Starting subtest: shrink-vs-evict-pinned
[53.095030] Subtest shrink-vs-evict-pinned: SUCCESS (5.027s)
[53.165587] [005/133] (953s left) gem_exec_schedule (implicit-boths)
[53.208208] Starting subtest: implicit-boths
[53.208953] Starting dynamic subtest: rcs0
[53.276143] Dynamic subtest rcs0: SUCCESS (0.067s)
[53.286540] Starting dynamic subtest: bcs0
[53.343741] Dynamic subtest bcs0: SUCCESS (0.066s)
[53.353840] Starting dynamic subtest: vcs0
[53.410325] Dynamic subtest vcs0: SUCCESS (0.065s)
[53.420174] Starting dynamic subtest: vcs1
[53.478220] Dynamic subtest vcs1: SUCCESS (0.067s)
[53.487915] Starting dynamic subtest: vecs0
[53.546275] Dynamic subtest vecs0: SUCCESS (0.067s)
[53.547454] Subtest implicit-boths: SUCCESS (0.335s)
[53.848533] [006/133] (953s left) vgem_slow (nohang)
[53.911188] Starting subtest: nohang
[64.121476] Subtest nohang: SUCCESS (10.133s)
[64.155616] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[64.158707] [007/133] (942s left) gem_exec_schedule (u-submit-late-slice)
[64.203588] Starting subtest: u-submit-late-slice
[64.204422] Starting dynamic subtest: rcs0
[64.235471] Dynamic subtest rcs0: SUCCESS (0.032s)
[64.242023] Starting dynamic subtest: bcs0
[64.261765] Dynamic subtest bcs0: SUCCESS (0.026s)
[64.267941] Starting dynamic subtest: vcs0
[64.286074] Dynamic subtest vcs0: SUCCESS (0.025s)
[64.292143] Starting dynamic subtest: vcs1
[64.311186] Dynamic subtest vcs1: SUCCESS (0.025s)
[64.318052] Starting dynamic subtest: vecs0
[64.336207] Dynamic subtest vecs0: SUCCESS (0.025s)
[64.336973] Subtest u-submit-late-slice: SUCCESS (0.133s)
[64.658610] [008/133] (942s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[64.745651] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[64.746378] Starting dynamic subtest: pipe-A-HDMI-A-1
[64.752520] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[64.758322] Starting dynamic subtest: pipe-B-HDMI-A-1
[64.764558] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[64.770278] Starting dynamic subtest: pipe-C-HDMI-A-1
[64.776463] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[64.782109] Starting dynamic subtest: pipe-D-HDMI-A-1
[64.788207] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[64.788894] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SUCCESS (0.006s)
[64.984352] [009/133] (942s left) kms_cursor_legacy (torture-move)
[65.072620] Starting subtest: torture-move
[65.073349] Starting dynamic subtest: pipe-A
[70.648041] Dynamic subtest pipe-A: SUCCESS (5.528s)
[70.659164] Starting dynamic subtest: pipe-B
[76.867354] Dynamic subtest pipe-B: SUCCESS (6.186s)
[76.876798] Starting dynamic subtest: pipe-C
[82.714985] Dynamic subtest pipe-C: SUCCESS (5.846s)
[82.724423] Starting dynamic subtest: pipe-D
[88.613286] Dynamic subtest pipe-D: SUCCESS (5.922s)
[88.628912] Starting dynamic subtest: all-pipes
[94.109906] Dynamic subtest all-pipes: SUCCESS (5.502s)
[94.110751] Subtest torture-move: SUCCESS (29.021s)
[94.193560] [010/133] (913s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[94.288645] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[94.290017] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[94.387431] [011/133] (912s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[94.475370] Starting subtest: psr-rgb101010-draw-mmap-wc
[94.476711] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[94.587646] [012/133] (912s left) i915_drm_fdinfo (virtual-busy-idle)
[94.622604] Starting subtest: virtual-busy-idle
[97.800937] Subtest virtual-busy-idle: SUCCESS (3.177s)
[97.870262] [013/133] (909s left) kms_vblank (ts-continuation-modeset)
[97.956476] Starting subtest: ts-continuation-modeset
[97.957911] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.267223] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.310s)
[98.279500] Starting dynamic subtest: pipe-D-HDMI-A-1
[98.564461] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.292s)
[98.565155] Subtest ts-continuation-modeset: SUCCESS (0.608s)
[98.697494] [014/133] (908s left) i915_pm_rps (thresholds-idle)
[98.741215] Starting subtest: thresholds-idle
[98.741935] Starting dynamic subtest: gt0
[109.129178] Dynamic subtest gt0: SUCCESS (10.386s)
[109.130418] Subtest thresholds-idle: SUCCESS (10.387s)
[109.199337] [015/133] (898s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[109.285189] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[109.285876] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.291880] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[109.297862] Starting dynamic subtest: pipe-B-HDMI-A-1
[109.303828] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[109.309697] Starting dynamic subtest: pipe-C-HDMI-A-1
[109.315644] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[109.321575] Starting dynamic subtest: pipe-D-HDMI-A-1
[109.327442] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[109.328112] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.006s)
[109.514357] [016/133] (897s left) gem_ctx_bad_destroy (invalid-default-ctx)
[109.549742] Starting subtest: invalid-default-ctx
[109.550444] Subtest invalid-default-ctx: SUCCESS (0.000s)
[109.618513] [017/133] (897s left) gem_fence_thrash (bo-write-verify-threaded-y)
[109.649940] Starting subtest: bo-write-verify-threaded-y
[113.954723] Subtest bo-write-verify-threaded-y: SUCCESS (4.271s)
[114.042391] [018/133] (893s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[114.132681] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[114.134053] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[114.220753] [019/133] (893s left) kms_color_pipeline (plane-lut1d-lut1d)
[114.307821] Starting subtest: plane-lut1d-lut1d
[114.393372] Starting dynamic subtest: pipe-A-plane-0
[114.493491] Dynamic subtest pipe-A-plane-0: SUCCESS (0.100s)
[114.506600] Starting dynamic subtest: pipe-A-plane-1
[114.584982] Dynamic subtest pipe-A-plane-1: SUCCESS (0.091s)
[114.597790] Starting dynamic subtest: pipe-A-plane-2
[114.676790] Dynamic subtest pipe-A-plane-2: SUCCESS (0.091s)
[114.859102] Starting dynamic subtest: pipe-B-plane-0
[114.939496] Dynamic subtest pipe-B-plane-0: SUCCESS (0.092s)
[114.951557] Starting dynamic subtest: pipe-B-plane-1
[115.031503] Dynamic subtest pipe-B-plane-1: SUCCESS (0.091s)
[115.043670] Starting dynamic subtest: pipe-B-plane-2
[115.123223] Dynamic subtest pipe-B-plane-2: SUCCESS (0.091s)
[115.342415] Starting dynamic subtest: pipe-C-plane-0
[115.429096] Dynamic subtest pipe-C-plane-0: SUCCESS (0.092s)
[115.440185] Starting dynamic subtest: pipe-C-plane-1
[115.529050] Dynamic subtest pipe-C-plane-1: SUCCESS (0.099s)
[115.540295] Starting dynamic subtest: pipe-C-plane-2
[115.629158] Dynamic subtest pipe-C-plane-2: SUCCESS (0.099s)
[115.819381] Starting dynamic subtest: pipe-D-plane-0
[115.910470] Dynamic subtest pipe-D-plane-0: SUCCESS (0.100s)
[115.918642] Starting dynamic subtest: pipe-D-plane-1
[116.002397] Dynamic subtest pipe-D-plane-1: SUCCESS (0.091s)
[116.012447] Starting dynamic subtest: pipe-D-plane-2
[116.102541] Dynamic subtest pipe-D-plane-2: SUCCESS (0.099s)
[116.150224] Subtest plane-lut1d-lut1d: SUCCESS (1.842s)
[116.255765] [020/133] (891s left) gem_ctx_shared (create-shared-gtt)
[116.297168] Starting subtest: create-shared-gtt
[118.455041] Subtest create-shared-gtt: SUCCESS (2.149s)
[118.627819] [021/133] (889s left) gem_exec_create (basic)
[118.667396] Starting subtest: basic
[118.668172] Starting dynamic subtest: smem
[120.717062] Dynamic subtest smem: SUCCESS (2.049s)
[120.717806] Subtest basic: SUCCESS (2.050s)
[120.900947] [022/133] (886s left) syncobj_timeline (single-wait-signaled)
[120.935288] Starting subtest: single-wait-signaled
[120.935991] Subtest single-wait-signaled: SUCCESS (0.001s)
[120.995962] [023/133] (886s left) kms_chamelium_audio (dp-audio)
[121.135645] Subtest dp-audio: SKIP (0.000s)
[121.238912] [024/133] (886s left) gem_pwrite_snooped
[121.398598] [025/133] (886s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[121.486495] Starting subtest: fbc-rgb101010-draw-render
[123.969466] Subtest fbc-rgb101010-draw-render: SUCCESS (2.483s)
[124.082187] [026/133] (883s left) perf (gen12-invalid-class-instance)
[124.166416] Starting subtest: gen12-invalid-class-instance
[124.174431] Subtest gen12-invalid-class-instance: SUCCESS (0.008s)
[124.211422] [027/133] (883s left) kms_psr (fbc-psr-primary-page-flip)
[124.298166] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[124.339830] [028/133] (883s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[124.436044] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[125.045248] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.609s)
[125.162756] [029/133] (882s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[125.251638] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[125.253063] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[125.331869] [030/133] (882s left) gem_exec_params (sol-reset-invalid)
[125.367612] Starting subtest: sol-reset-invalid
[125.369520] Subtest sol-reset-invalid: SUCCESS (0.001s)
[125.466759] [031/133] (882s left) gem_mmap_gtt (zero-extend)
[125.499727] Starting subtest: zero-extend
[125.500459] Subtest zero-extend: SUCCESS (0.000s)
[125.598854] [032/133] (882s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[125.691858] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[126.303309] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.611s)
[126.426158] [033/133] (881s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[126.511436] Starting subtest: primary-x-tiled-reflect-x-0
[130.049672] Subtest primary-x-tiled-reflect-x-0: SUCCESS (3.538s)
[130.242460] [034/133] (877s left) kms_big_fb (linear-32bpp-rotate-0)
[130.339112] Starting subtest: linear-32bpp-rotate-0
[131.780863] Subtest linear-32bpp-rotate-0: SUCCESS (1.441s)
[131.910544] [035/133] (876s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[131.996388] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[131.997749] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[132.057110] [036/133] (876s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[132.141698] Starting subtest: crc-primary-basic-yf-tiled-ccs
[132.143232] Starting dynamic subtest: pipe-A-HDMI-A-1
[132.149717] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[132.155819] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.162350] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[132.168999] Starting dynamic subtest: pipe-C-HDMI-A-1
[132.175563] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[132.181472] Starting dynamic subtest: pipe-D-HDMI-A-1
[132.188123] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[132.189420] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.007s)
[132.377012] [037/133] (875s left) kms_plane (pixel-format-x-tiled-modifier)
[132.463778] Starting subtest: pixel-format-x-tiled-modifier
[132.482387] Starting dynamic subtest: pipe-A-plane-0
[132.916209] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[132.930171] Starting dynamic subtest: pipe-A-plane-3
[133.291303] Dynamic subtest pipe-A-plane-3: SUCCESS (0.374s)
[133.302952] Starting dynamic subtest: pipe-A-plane-5
[133.591168] Dynamic subtest pipe-A-plane-5: SUCCESS (0.299s)
[133.605827] Starting dynamic subtest: pipe-A-plane-7
[133.607565] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[133.723296] Starting dynamic subtest: pipe-B-plane-0
[134.124587] Dynamic subtest pipe-B-plane-0: SUCCESS (0.408s)
[134.138630] Starting dynamic subtest: pipe-B-plane-3
[134.499715] Dynamic subtest pipe-B-plane-3: SUCCESS (0.374s)
[134.514193] Starting dynamic subtest: pipe-B-plane-5
[134.774861] Dynamic subtest pipe-B-plane-5: SUCCESS (0.274s)
[134.790715] Starting dynamic subtest: pipe-B-plane-7
[134.792238] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[134.849346] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.385s)
[135.005562] [038/133] (873s left) kms_psr (psr2-primary-render)
[135.095259] Subtest psr2-primary-render: SKIP (0.000s)
[135.140701] [039/133] (873s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[135.224548] Starting subtest: cursor-vs-flip-atomic
[164.962451] Subtest cursor-vs-flip-atomic: SUCCESS (29.738s)
[165.095449] [040/133] (843s left) gem_ctx_freq (sysfs)
[165.134430] Starting subtest: sysfs
[165.135171] Starting dynamic subtest: gt0
[170.073388] Dynamic subtest gt0: SUCCESS (4.938s)
[170.074535] Subtest sysfs: SUCCESS (4.940s)
[170.140253] [041/133] (838s left) gem_lmem_swapping (heavy-verify-multi)
[170.176849] Subtest heavy-verify-multi: SKIP (0.000s)
[170.219823] [042/133] (838s left) kms_plane_multiple (tiling-none)
[170.328463] Starting subtest: tiling-none
[170.329152] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.877800] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.549s)
[170.885449] Starting dynamic subtest: pipe-B-HDMI-A-1
[171.421640] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.542s)
[171.430292] Starting dynamic subtest: pipe-C-HDMI-A-1
[172.047692] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.625s)
[172.057900] Starting dynamic subtest: pipe-D-HDMI-A-1
[172.629283] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.579s)
[172.630030] Subtest tiling-none: SUCCESS (2.301s)
[172.775464] [043/133] (835s left) gem_partial_pwrite_pread (reads)
[172.816135] Starting subtest: reads
[174.657915] Subtest reads: SUCCESS (1.841s)
[174.762970] [044/133] (833s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[174.849888] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[174.851277] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[175.000537] [045/133] (833s left) core_getclient (basic)
[175.034613] Starting subtest: basic
[175.035357] Subtest basic: SUCCESS (0.000s)
[175.108312] [046/133] (833s left) gem_eio (create)
[175.150591] Starting subtest: create
[175.177115] Subtest create: SUCCESS (0.026s)
[175.292084] [047/133] (833s left) gem_exec_schedule (smoketest)
[175.459161] Starting subtest: smoketest
[175.460071] Starting dynamic subtest: rcs0
[180.923528] Dynamic subtest rcs0: SUCCESS (5.424s)
[180.931390] Starting dynamic subtest: bcs0
[186.346180] Dynamic subtest bcs0: SUCCESS (5.422s)
[186.354776] Starting dynamic subtest: vcs0
[191.768729] Dynamic subtest vcs0: SUCCESS (5.422s)
[191.776656] Starting dynamic subtest: vcs1
[197.192877] Dynamic subtest vcs1: SUCCESS (5.423s)
[197.200907] Starting dynamic subtest: vecs0
[202.613341] Dynamic subtest vecs0: SUCCESS (5.418s)
[202.614239] Subtest smoketest: SUCCESS (27.114s)
[202.753540] [048/133] (805s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[202.839947] Starting subtest: basic-flip-after-cursor-legacy
[203.354494] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.514s)
[203.467839] [049/133] (805s left) kms_cursor_edge_walk (64x64-top-edge)
[203.552342] Starting subtest: 64x64-top-edge
[203.554446] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.322298] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.768s)
[205.331112] Starting dynamic subtest: pipe-D-HDMI-A-1
[207.001797] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.678s)
[207.002558] Subtest 64x64-top-edge: SUCCESS (3.450s)
[207.117623] [050/133] (801s left) syncobj_eventfd (binary-wait-before-signal)
[207.154521] Starting subtest: binary-wait-before-signal
[207.185232] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[207.268750] [051/133] (801s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[207.302561] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[207.303283] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[207.367753] [052/133] (801s left) core_auth (basic-auth)
[207.399915] Starting subtest: basic-auth
[207.400613] Subtest basic-auth: SUCCESS (0.001s)
[207.457611] [053/133] (801s left) kms_flip (flip-vs-panning)
[207.545439] Starting subtest: flip-vs-panning
[207.548157] Starting dynamic subtest: A-HDMI-A1
[215.238459] Dynamic subtest A-HDMI-A1: SUCCESS (7.690s)
[215.254722] Starting dynamic subtest: B-HDMI-A1
[222.901844] Dynamic subtest B-HDMI-A1: SUCCESS (7.661s)
[222.915972] Starting dynamic subtest: C-HDMI-A1
[230.578973] Dynamic subtest C-HDMI-A1: SUCCESS (7.673s)
[230.590711] Starting dynamic subtest: D-HDMI-A1
[238.256151] Dynamic subtest D-HDMI-A1: SUCCESS (7.674s)
[238.261041] Subtest flip-vs-panning: SUCCESS (30.715s)
[238.412455] [054/133] (770s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[238.503898] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[238.506812] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[238.567321] [055/133] (770s left) gem_cs_tlb (engines)
[238.604108] Starting subtest: engines
[238.604868] Starting dynamic subtest: rcs0
[240.763782] Dynamic subtest rcs0: SUCCESS (2.150s)
[240.773137] Starting dynamic subtest: bcs0
[242.915377] Dynamic subtest bcs0: SUCCESS (2.150s)
[242.922342] Starting dynamic subtest: vcs0
[245.066392] Dynamic subtest vcs0: SUCCESS (2.150s)
[245.073674] Starting dynamic subtest: vcs1
[247.216703] Dynamic subtest vcs1: SUCCESS (2.149s)
[247.223706] Starting dynamic subtest: vecs0
[249.367638] Dynamic subtest vecs0: SUCCESS (2.150s)
[249.368359] Subtest engines: SUCCESS (10.755s)
[249.479722] [056/133] (759s left) gem_vm_create (isolation)
[249.516376] Starting subtest: isolation
[249.520779] Subtest isolation: SUCCESS (0.004s)
[249.630374] [057/133] (759s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[249.723728] Starting subtest: psr-1p-pri-indfb-multidraw
[249.725102] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[249.812108] [058/133] (759s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[249.903725] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[249.905089] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[249.984015] [059/133] (759s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[250.078493] Starting subtest: dp-mst-type-0-suspend-resume
[250.079901] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[250.172662] [060/133] (759s left) gen9_exec_parse (bb-start-param)
[250.210049] Subtest bb-start-param: SKIP (0.000s)
[250.256467] [061/133] (758s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[250.342639] Starting subtest: flip-vs-dpms-off-vs-modeset
[250.345129] Starting dynamic subtest: A-HDMI-A1
[251.057246] Dynamic subtest A-HDMI-A1: SUCCESS (0.712s)
[251.065393] Starting dynamic subtest: B-HDMI-A1
[251.687394] Dynamic subtest B-HDMI-A1: SUCCESS (0.628s)
[251.695604] Starting dynamic subtest: C-HDMI-A1
[252.306926] Dynamic subtest C-HDMI-A1: SUCCESS (0.617s)
[252.314768] Starting dynamic subtest: D-HDMI-A1
[252.923259] Dynamic subtest D-HDMI-A1: SUCCESS (0.616s)
[252.925686] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.583s)
[253.080653] [062/133] (756s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[253.175242] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[253.221931] [063/133] (756s left) core_getversion (all-cards)
[253.255232] Starting subtest: all-cards
[253.270664] Subtest all-cards: SUCCESS (0.016s)
[253.306575] [064/133] (756s left) gem_ringfill (legacy-basic)
[253.552125] Starting subtest: legacy-basic
[253.553193] Starting dynamic subtest: default
[253.581723] Dynamic subtest default: SUCCESS (0.030s)
[253.598780] Starting dynamic subtest: render
[253.602925] Dynamic subtest render: SUCCESS (0.019s)
[253.614379] Starting dynamic subtest: bsd
[253.620857] Dynamic subtest bsd: SUCCESS (0.016s)
[253.629015] Starting dynamic subtest: bsd1
[253.641232] Dynamic subtest bsd1: SUCCESS (0.019s)
[253.651811] Starting dynamic subtest: bsd2
[253.664223] Dynamic subtest bsd2: SUCCESS (0.021s)
[253.674995] Starting dynamic subtest: blt
[253.683989] Dynamic subtest blt: SUCCESS (0.017s)
[253.693264] Starting dynamic subtest: vebox
[253.702954] Dynamic subtest vebox: SUCCESS (0.018s)
[253.703848] Subtest legacy-basic: SUCCESS (0.154s)
[253.777067] [065/133] (755s left) gem_media_fill (media-fill)
[253.816245] Starting subtest: media-fill
[253.816978] Starting dynamic subtest: smem
[253.822216] Dynamic subtest smem: SUCCESS (0.006s)
[253.822920] Subtest media-fill: SUCCESS (0.007s)
[254.035799] [066/133] (755s left) perf_pmu (render-node-busy)
[254.073563] Starting subtest: render-node-busy
[254.074270] Starting dynamic subtest: rcs0
[254.608242] Dynamic subtest rcs0: SUCCESS (0.534s)
[254.620424] Starting dynamic subtest: bcs0
[255.144047] Dynamic subtest bcs0: SUCCESS (0.534s)
[255.154811] Starting dynamic subtest: vcs0
[255.681483] Dynamic subtest vcs0: SUCCESS (0.534s)
[255.691744] Starting dynamic subtest: vcs1
[256.210855] Dynamic subtest vcs1: SUCCESS (0.529s)
[256.219350] Starting dynamic subtest: vecs0
[256.744861] Dynamic subtest vecs0: SUCCESS (0.533s)
[256.745610] Subtest render-node-busy: SUCCESS (2.673s)
[256.804432] [067/133] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[256.897053] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[256.898456] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[256.986175] [068/133] (752s left) gem_partial_pwrite_pread (write-display)
[257.026504] Starting subtest: write-display
[267.567625] Subtest write-display: SUCCESS (10.541s)
[267.668143] [069/133] (741s left) gem_userptr_blits (dmabuf-sync)
[267.712662] Starting subtest: dmabuf-sync
[267.715232] Subtest dmabuf-sync: SKIP (0.002s)
[267.835976] [070/133] (741s left) i915_pm_rps (basic-api)
[267.874185] Starting subtest: basic-api
[267.876836] Subtest basic-api: SUCCESS (0.003s)
[267.936601] [071/133] (741s left) syncobj_basic (bad-handle-to-fd)
[267.969772] Starting subtest: bad-handle-to-fd
[267.970465] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[268.030267] [072/133] (741s left) sysfs_preempt_timeout (idempotent)
[268.067017] Starting subtest: idempotent
[268.068794] Starting dynamic subtest: vecs0
[268.069468] Dynamic subtest vecs0: SUCCESS (0.001s)
[268.076670] Starting dynamic subtest: vcs0
[268.077383] Dynamic subtest vcs0: SUCCESS (0.001s)
[268.084306] Starting dynamic subtest: bcs0
[268.084997] Dynamic subtest bcs0: SUCCESS (0.001s)
[268.091796] Starting dynamic subtest: rcs0
[268.092469] Dynamic subtest rcs0: SUCCESS (0.001s)
[268.099098] Starting dynamic subtest: vcs1
[268.099791] Dynamic subtest vcs1: SUCCESS (0.001s)
[268.100469] Subtest idempotent: SUCCESS (0.008s)
[268.159125] [073/133] (741s left) gem_pxp (reject-modify-context-protection-off-2)
[268.261387] Starting subtest: reject-modify-context-protection-off-2
[268.262369] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[268.341726] [074/133] (741s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[268.379491] Starting subtest: basic-wc-gtt-noreloc
[268.382936] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s)
[268.494920] [075/133] (741s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[268.529073] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[268.630626] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[268.708665] [076/133] (741s left) syncobj_basic (bad-flags-handle-to-fd)
[268.741778] Starting subtest: bad-flags-handle-to-fd
[268.742483] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[268.811031] [077/133] (741s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[268.902706] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[268.904044] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[269.006544] [078/133] (740s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[269.100151] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[269.768325] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.667s)
[269.896785] [079/133] (740s left) gem_exec_balancer (sliced)
[269.939305] Starting subtest: sliced
[271.378820] Subtest sliced: SUCCESS (1.431s)
[271.563144] [080/133] (738s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[271.651224] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[271.691678] [081/133] (738s left) syncobj_timeline (multi-wait-for-submit-signaled)
[271.726812] Starting subtest: multi-wait-for-submit-signaled
[271.727557] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[271.790282] [082/133] (738s left) syncobj_wait (multi-wait-signaled)
[271.825209] Starting subtest: multi-wait-signaled
[271.825944] Subtest multi-wait-signaled: SUCCESS (0.000s)
[271.889999] [083/133] (738s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[271.979838] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[271.981197] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[272.071933] [084/133] (738s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[272.166840] Starting subtest: yf-tiled-32bpp-rotate-90
[272.168266] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[272.264147] [085/133] (737s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[272.358203] Starting subtest: y-tiled-8bpp-rotate-270
[272.434860] Subtest y-tiled-8bpp-rotate-270: SKIP (0.075s)
[272.529244] [086/133] (737s left) gem_exec_reloc (basic-write-read-noreloc)
[272.567272] Starting subtest: basic-write-read-noreloc
[272.569097] Subtest basic-write-read-noreloc: SUCCESS (0.002s)
[272.679191] [087/133] (737s left) kms_dsc (dsc-with-output-formats)
[272.764950] Starting subtest: dsc-with-output-formats
[272.771524] Subtest dsc-with-output-formats: SKIP (0.001s)
[272.820167] [088/133] (737s left) kms_chamelium_color (gamma)
[272.904808] Subtest gamma: SKIP (0.000s)
[272.950910] [089/133] (737s left) kms_psr (psr-suspend)
[273.035824] Subtest psr-suspend: SKIP (0.000s)
[273.084256] [090/133] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[273.176170] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[273.177596] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[273.266248] [091/133] (737s left) kms_vblank (accuracy-idle)
[273.352044] Starting subtest: accuracy-idle
[273.353912] Starting dynamic subtest: pipe-A-HDMI-A-1
[274.535160] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.182s)
[274.548180] Starting dynamic subtest: pipe-D-HDMI-A-1
[275.703543] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.160s)
[275.704265] Subtest accuracy-idle: SUCCESS (2.349s)
[275.842868] [092/133] (734s left) kms_async_flips (async-flip-suspend-resume)
[275.932036] Starting subtest: async-flip-suspend-resume
[276.059610] Starting dynamic subtest: pipe-A-HDMI-A-1
[293.495649] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.517s)
[293.630011] Starting dynamic subtest: pipe-B-HDMI-A-1
[311.490968] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.269s)
[311.604958] Starting dynamic subtest: pipe-C-HDMI-A-1
[329.500221] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.298s)
[329.626405] Starting dynamic subtest: pipe-D-HDMI-A-1
[347.471559] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.268s)
[347.473860] Subtest async-flip-suspend-resume: SUCCESS (9.830s)
[356.763429] [093/133] (662s left) kms_psr (psr2-cursor-blt)
[356.864972] Subtest psr2-cursor-blt: SKIP (0.000s)
[356.910265] [094/133] (662s left) kms_plane (plane-position-covered)
[356.995404] Starting subtest: plane-position-covered
[357.202206] Starting dynamic subtest: pipe-A-plane-1
[357.445273] Dynamic subtest pipe-A-plane-1: SUCCESS (0.243s)
[357.455596] Starting dynamic subtest: pipe-A-plane-2
[357.680839] Dynamic subtest pipe-A-plane-2: SUCCESS (0.235s)
[357.690049] Starting dynamic subtest: pipe-A-plane-3
[357.934572] Dynamic subtest pipe-A-plane-3: SUCCESS (0.251s)
[357.944758] Starting dynamic subtest: pipe-A-plane-4
[358.164589] Dynamic subtest pipe-A-plane-4: SUCCESS (0.230s)
[358.172797] Starting dynamic subtest: pipe-A-plane-5
[358.387919] Dynamic subtest pipe-A-plane-5: SUCCESS (0.221s)
[358.398343] Starting dynamic subtest: pipe-A-plane-6
[358.613344] Dynamic subtest pipe-A-plane-6: SUCCESS (0.225s)
[358.624598] Starting dynamic subtest: pipe-A-plane-7
[358.625989] Dynamic subtest pipe-A-plane-7: SUCCESS (0.003s)
[358.819204] Starting dynamic subtest: pipe-B-plane-1
[359.036850] Dynamic subtest pipe-B-plane-1: SUCCESS (0.226s)
[359.045029] Starting dynamic subtest: pipe-B-plane-2
[359.256282] Dynamic subtest pipe-B-plane-2: SUCCESS (0.219s)
[359.266813] Starting dynamic subtest: pipe-B-plane-3
[359.499183] Dynamic subtest pipe-B-plane-3: SUCCESS (0.242s)
[359.510661] Starting dynamic subtest: pipe-B-plane-4
[359.728736] Dynamic subtest pipe-B-plane-4: SUCCESS (0.228s)
[359.737889] Starting dynamic subtest: pipe-B-plane-5
[359.982827] Dynamic subtest pipe-B-plane-5: SUCCESS (0.252s)
[359.992170] Starting dynamic subtest: pipe-B-plane-6
[360.235117] Dynamic subtest pipe-B-plane-6: SUCCESS (0.251s)
[360.244429] Starting dynamic subtest: pipe-B-plane-7
[360.245782] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[360.246492] Subtest plane-position-covered: SUCCESS (3.243s)
[360.411346] [095/133] (659s left) kms_joiner (basic-force-big-joiner)
[360.503311] Starting subtest: basic-force-big-joiner
[360.504709] Subtest basic-force-big-joiner: SKIP (0.000s)
[360.559158] [096/133] (659s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[360.646058] Starting subtest: 2x-cursor-vs-flip-atomic
[360.649381] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.003s)
[360.709014] [097/133] (658s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[360.850233] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[360.945753] [098/133] (658s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[361.044167] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[361.045547] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[361.139957] [099/133] (658s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[361.228102] Starting subtest: stress-xrgb8888-4tiled
[361.229449] Subtest stress-xrgb8888-4tiled: SKIP (0.000s)
[361.274347] [100/133] (658s left) kms_pm_dc (dc6-psr)
[362.373847] Starting subtest: dc6-psr
[362.375201] Subtest dc6-psr: SKIP (0.000s)
[362.435047] [101/133] (657s left) kms_cursor_crc (cursor-alpha-transparent)
[362.522404] Starting subtest: cursor-alpha-transparent
[362.523140] Starting dynamic subtest: pipe-A-HDMI-A-1
[362.796738] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.268s)
[362.805355] Starting dynamic subtest: pipe-D-HDMI-A-1
[363.043166] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.242s)
[363.043952] Subtest cursor-alpha-transparent: SUCCESS (0.513s)
[363.179788] [102/133] (656s left) i915_drm_fdinfo (virtual-busy-hang)
[363.221139] Starting subtest: virtual-busy-hang
[368.474334] Subtest virtual-busy-hang: SUCCESS (5.191s)
[368.548739] [103/133] (651s left) kms_psr2_su (page_flip-xrgb8888)
[368.583117] Subtest page_flip-XRGB8888: SKIP (0.000s)
[368.629747] [104/133] (651s left) kms_force_connector_basic (force-connector-state)
[368.755227] Starting subtest: force-connector-state
[369.063607] Subtest force-connector-state: SUCCESS (0.307s)
[369.321186] [105/133] (650s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[369.410503] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[369.411883] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[369.468773] [106/133] (650s left) gem_tiled_blits (basic)
[369.860802] Starting subtest: basic
[369.880571] Subtest basic: SUCCESS (0.020s)
[370.030845] [107/133] (650s left) gem_userptr_blits (access-control)
[370.126576] Starting subtest: access-control
[370.128579] Subtest access-control: SKIP (0.000s)
[370.225613] [108/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[370.318307] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[370.319698] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[370.414182] [109/133] (649s left) gem_exec_fence (syncobj-timeline-chain-engines)
[370.889914] Starting subtest: syncobj-timeline-chain-engines
[370.950534] Subtest syncobj-timeline-chain-engines: SUCCESS (0.070s)
[371.141078] [110/133] (649s left) gem_ccs (block-copy-uncompressed)
[371.179789] Starting subtest: block-copy-uncompressed
[371.181621] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[371.204503] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[371.214192] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[371.222960] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[371.223667] Subtest block-copy-uncompressed: SUCCESS (0.043s)
[371.334166] [111/133] (648s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[371.434112] Starting subtest: 4-tiled-64bpp-rotate-270
[371.435519] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[371.544869] [112/133] (648s left) gem_exec_schedule (preemptive-hang)
[371.720302] Starting subtest: preemptive-hang
[371.721478] Starting dynamic subtest: rcs0
[377.762882] Dynamic subtest rcs0: SUCCESS (5.993s)
[377.770972] Starting dynamic subtest: bcs0
[383.785864] Dynamic subtest bcs0: SUCCESS (6.009s)
[383.794795] Starting dynamic subtest: vcs0
[389.737444] Dynamic subtest vcs0: SUCCESS (5.941s)
[389.745624] Starting dynamic subtest: vcs1
[395.720322] Dynamic subtest vcs1: SUCCESS (6.002s)
[395.730582] Starting dynamic subtest: vecs0
[401.772767] Dynamic subtest vecs0: SUCCESS (6.021s)
[401.773727] Subtest preemptive-hang: SUCCESS (29.979s)
[401.920166] [113/133] (618s left) kms_pm_rpm (universal-planes)
[403.337318] Starting subtest: universal-planes
[403.338305] Starting dynamic subtest: plane-34
[411.524292] Dynamic subtest plane-34: SUCCESS (8.186s)
[411.538159] Starting dynamic subtest: plane-64
[420.001849] Dynamic subtest plane-64: SUCCESS (8.472s)
[420.025635] Starting dynamic subtest: plane-94
[428.321211] Dynamic subtest plane-94: SUCCESS (8.312s)
[428.335697] Starting dynamic subtest: plane-124
[436.613788] Dynamic subtest plane-124: SUCCESS (8.287s)
[436.627320] Starting dynamic subtest: plane-134
[444.808004] Dynamic subtest plane-134: SUCCESS (8.188s)
[444.829257] Starting dynamic subtest: plane-144
[453.080469] Dynamic subtest plane-144: SUCCESS (8.266s)
[453.101981] Starting dynamic subtest: plane-154
[461.259391] Dynamic subtest plane-154: SUCCESS (8.176s)
[461.271541] Starting dynamic subtest: plane-164
[469.530385] Dynamic subtest plane-164: SUCCESS (8.273s)
[469.534195] Subtest universal-planes: SUCCESS (66.183s)
[469.711082] [114/133] (550s left) gem_spin_batch (spin-all-new)
[469.756186] Starting subtest: spin-all-new
[469.767707] Subtest spin-all-new: SUCCESS (0.012s)
[469.954984] [115/133] (550s left) gem_exec_reloc (basic-gtt-read-active)
[469.994088] Starting subtest: basic-gtt-read-active
[470.120782] Subtest basic-gtt-read-active: SUCCESS (0.122s)
[470.242459] [116/133] (550s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[470.276658] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[470.277356] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[470.336343] [117/133] (550s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[470.421555] Starting subtest: 2x-long-flip-vs-cursor-atomic
[470.423838] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[470.513098] [118/133] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[470.602238] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[470.603605] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[470.693624] [119/133] (549s left) perf_pmu (semaphore-busy)
[470.730155] Starting subtest: semaphore-busy
[470.730861] Starting dynamic subtest: rcs0
[472.308606] Dynamic subtest rcs0: SUCCESS (1.569s)
[472.319969] Starting dynamic subtest: bcs0
[473.858634] Dynamic subtest bcs0: SUCCESS (1.548s)
[473.870790] Starting dynamic subtest: vcs0
[475.414337] Dynamic subtest vcs0: SUCCESS (1.554s)
[475.426325] Starting dynamic subtest: vcs1
[476.969075] Dynamic subtest vcs1: SUCCESS (1.552s)
[476.981109] Starting dynamic subtest: vecs0
[478.521699] Dynamic subtest vecs0: SUCCESS (1.552s)
[478.522598] Subtest semaphore-busy: SUCCESS (7.786s)
[478.615080] [120/133] (542s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[478.704645] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[478.745997] [121/133] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[478.834313] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[478.835685] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[478.926321] [122/133] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[479.014197] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[479.015564] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[479.113656] [123/133] (541s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[479.148186] Starting subtest: multi-wait-all-for-submit-available-submitted
[479.148858] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[479.215466] [124/133] (541s left) api_intel_allocator (two-level-inception)
[479.249219] Starting subtest: two-level-inception
[484.699496] Subtest two-level-inception: SUCCESS (5.418s)
[484.797740] [125/133] (536s left) kms_async_flips (test-time-stamp)
[484.885372] Starting subtest: test-time-stamp
[485.015466] Starting dynamic subtest: pipe-A-HDMI-A-1
[485.128432] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.112s)
[485.263763] Starting dynamic subtest: pipe-B-HDMI-A-1
[485.347127] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.095s)
[485.466443] Starting dynamic subtest: pipe-C-HDMI-A-1
[485.556705] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.098s)
[485.676464] Starting dynamic subtest: pipe-D-HDMI-A-1
[485.760502] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.093s)
[485.761261] Subtest test-time-stamp: SUCCESS (0.876s)
[485.999960] [126/133] (534s left) drm_read (empty-nonblock)
[486.108411] Starting subtest: empty-nonblock
[486.109110] Subtest empty-nonblock: SUCCESS (0.000s)
[486.220506] [127/133] (534s left) kms_lease (lease-again)
[486.305502] Starting subtest: lease-again
[486.307344] Starting dynamic subtest: pipe-A-HDMI-A-1
[486.309228] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[486.320199] Starting dynamic subtest: pipe-B-HDMI-A-1
[486.320902] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[486.329690] Starting dynamic subtest: pipe-C-HDMI-A-1
[486.330435] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[486.338883] Starting dynamic subtest: pipe-D-HDMI-A-1
[486.339614] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.002s)
[486.340319] Subtest lease-again: SUCCESS (0.017s)
[486.429103] [128/133] (534s left) gem_exec_balancer (indices)
[486.471120] Starting subtest: indices
[487.810076] Subtest indices: SUCCESS (1.339s)
[488.000866] [129/133] (533s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[488.091985] Starting subtest: cursor-rapid-movement-256x85
[488.097185] Starting dynamic subtest: pipe-A-HDMI-A-1
[488.356481] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.259s)
[488.391050] Starting dynamic subtest: pipe-D-HDMI-A-1
[488.599781] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.216s)
[488.600558] Subtest cursor-rapid-movement-256x85: SUCCESS (0.507s)
[488.761441] [130/133] (532s left) gem_basic (create-fd-close)
[488.797874] Starting subtest: create-fd-close
[488.799249] Subtest create-fd-close: SUCCESS (0.000s)
[488.893129] [131/133] (532s left) core_auth (many-magics)
[488.926079] Starting subtest: many-magics
[489.460286] Subtest many-magics: SUCCESS (0.535s)
[489.556237] [132/133] (531s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[489.648284] Starting subtest: 2x-absolute-wf_vblank-interruptible
[489.657877] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.009s)
[489.717311] [133/133] (531s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[489.803933] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[489.805064] Starting dynamic subtest: pipe-A
[490.171764] Dynamic subtest pipe-A: SUCCESS (0.368s)
[490.182872] Starting dynamic subtest: pipe-B
[490.605685] Dynamic subtest pipe-B: SUCCESS (0.433s)
[490.617075] Starting dynamic subtest: pipe-C
[491.039799] Dynamic subtest pipe-C: SUCCESS (0.433s)
[491.049338] Starting dynamic subtest: pipe-D
[491.481667] Dynamic subtest pipe-D: SUCCESS (0.441s)
[491.482382] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (1.679s)
[491.660389] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_flink_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ppgtt
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: vgem_slow
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: i915_pm_rps
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_ctx_bad_destroy
results: parsing output: 16/ for test: gem_fence_thrash
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: gem_exec_create
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_chamelium_audio
results: parsing output: 23/ for test: gem_pwrite_snooped
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: gem_ctx_freq
results: parsing output: 40/ for test: gem_lmem_swapping
results: parsing output: 41/ for test: kms_plane_multiple
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: core_getclient
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_cursor_edge_walk
results: parsing output: 49/ for test: syncobj_eventfd
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: core_auth
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: gem_cs_tlb
results: parsing output: 55/ for test: gem_vm_create
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: core_getversion
results: parsing output: 63/ for test: gem_ringfill
results: parsing output: 64/ for test: gem_media_fill
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: i915_pm_rps
results: parsing output: 70/ for test: syncobj_basic
results: parsing output: 71/ for test: sysfs_preempt_timeout
results: parsing output: 72/ for test: gem_pxp
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_dsc
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_joiner
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pipe_stress
results: parsing output: 99/ for test: kms_pm_dc
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: kms_psr2_su
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: gem_tiled_blits
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: gem_spin_batch
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: drm_read
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_basic
results: parsing output: 130/ for test: core_auth
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_plane_scaling
Done.