[88.829861] Initializing watchdogs
[88.830195]   /dev/watchdog0
[88.871070] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.885722] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.892066] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.897165] [001/155] (960s left) i915_selftest (live)
[90.805248] Starting subtest: live
[90.806206] Starting dynamic subtest: sanitycheck
[93.321331] Dynamic subtest sanitycheck: SUCCESS (2.513s)
[93.341384] Starting dynamic subtest: uncore
[95.840191] Dynamic subtest uncore: SUCCESS (2.516s)
[95.860327] Starting dynamic subtest: workarounds
[98.717131] Dynamic subtest workarounds: SUCCESS (2.871s)
[98.736379] Starting dynamic subtest: gt_engines
[101.871365] Dynamic subtest gt_engines: SUCCESS (3.151s)
[101.890836] Starting dynamic subtest: gt_timelines
[118.197379] Dynamic subtest gt_timelines: SUCCESS (16.321s)
[118.216819] Starting dynamic subtest: gt_contexts
[120.845555] Dynamic subtest gt_contexts: SUCCESS (2.645s)
[120.865051] Starting dynamic subtest: gt_lrc
[126.060494] Dynamic subtest gt_lrc: SUCCESS (5.211s)
[126.080247] Starting dynamic subtest: gt_mocs
[128.997994] Dynamic subtest gt_mocs: SUCCESS (2.936s)
[129.020272] Starting dynamic subtest: gt_pm
[141.225458] Dynamic subtest gt_pm: SUCCESS (12.222s)
[141.246304] Starting dynamic subtest: gt_heartbeat
[143.868655] Dynamic subtest gt_heartbeat: SUCCESS (2.639s)
[143.889358] Starting dynamic subtest: gt_tlb
[148.017116] Dynamic subtest gt_tlb: SUCCESS (4.145s)
[148.038368] Starting dynamic subtest: requests
[157.276034] Dynamic subtest requests: SUCCESS (9.258s)
[157.296042] Starting dynamic subtest: migrate
[162.913724] Dynamic subtest migrate: SUCCESS (5.635s)
[162.934328] Starting dynamic subtest: active
[165.577415] Dynamic subtest active: SUCCESS (2.662s)
[165.597555] Starting dynamic subtest: objects
[169.814704] Dynamic subtest objects: SUCCESS (4.238s)
[169.835325] Starting dynamic subtest: mman
[177.605924] Dynamic subtest mman: SUCCESS (7.789s)
[177.627309] Starting dynamic subtest: dmabuf
[180.273537] Dynamic subtest dmabuf: SUCCESS (2.667s)
[180.294093] Starting dynamic subtest: vma
[182.969164] Dynamic subtest vma: SUCCESS (2.693s)
[182.989514] Starting dynamic subtest: coherency
[188.845260] Dynamic subtest coherency: SUCCESS (5.876s)
[188.864645] Starting dynamic subtest: gtt
[199.323858] Dynamic subtest gtt: SUCCESS (10.477s)
[199.345312] Starting dynamic subtest: gem
[202.476043] Dynamic subtest gem: SUCCESS (3.149s)
[202.497395] Starting dynamic subtest: evict
[207.997278] Dynamic subtest evict: SUCCESS (5.520s)
[208.021323] Starting dynamic subtest: hugepages
[217.039027] Dynamic subtest hugepages: SUCCESS (9.036s)
[217.058989] Starting dynamic subtest: gem_contexts
[237.744348] Dynamic subtest gem_contexts: SUCCESS (20.706s)
[237.765262] Starting dynamic subtest: client
[240.374635] Dynamic subtest client: SUCCESS (2.628s)
[240.394451] Starting dynamic subtest: gem_migrate
[242.984122] Dynamic subtest gem_migrate: SUCCESS (2.606s)
[243.005967] Starting dynamic subtest: reset
[249.375115] Dynamic subtest reset: SUCCESS (6.391s)
[249.395244] Starting dynamic subtest: memory_region
[252.138543] Dynamic subtest memory_region: SUCCESS (2.762s)
[252.162315] Starting dynamic subtest: hangcheck
[277.775388] Dynamic subtest hangcheck: SUCCESS (25.633s)
[277.798272] Starting dynamic subtest: execlists
[289.782523] Dynamic subtest execlists: SUCCESS (12.003s)
[289.803080] Starting dynamic subtest: ring_submission
[292.398308] Dynamic subtest ring_submission: SUCCESS (2.615s)
[292.418116] Starting dynamic subtest: perf
[295.081662] Dynamic subtest perf: SUCCESS (2.682s)
[295.102753] Starting dynamic subtest: slpc
[297.748502] Dynamic subtest slpc: SUCCESS (2.665s)
[297.769262] Starting dynamic subtest: guc
[300.369321] Dynamic subtest guc: SUCCESS (2.619s)
[300.393320] Starting dynamic subtest: guc_multi_lrc
[302.983598] Dynamic subtest guc_multi_lrc: SUCCESS (2.611s)
[303.004364] Starting dynamic subtest: guc_hang
[305.550083] Dynamic subtest guc_hang: SUCCESS (2.560s)
[305.580744] Starting dynamic subtest: late_gt_pm
[308.442908] Dynamic subtest late_gt_pm: SUCCESS (2.897s)
[308.444538] Subtest live: SUCCESS (217.630s)
[308.504631] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[308.507857] [002/155] (740s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[311.767151] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[313.601976] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.837s)
[313.941412] [FACT kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true
[313.948899] [003/155] (735s left) kms_content_protection (dp-mst-type-0)
[314.166568] Starting subtest: dp-mst-type-0
[314.171362] Subtest dp-mst-type-0: SKIP (0.000s)
[314.313632] [004/155] (735s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[314.421499] Starting subtest: invalid-multi-wait-unsubmitted
[314.425432] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.002s)
[314.599492] [005/155] (735s left) gem_mmap_gtt (basic-read-write-distinct)
[314.701605] Starting subtest: basic-read-write-distinct
[314.716542] Subtest basic-read-write-distinct: SUCCESS (0.013s)
[314.855474] [006/155] (734s left) kms_prime (basic-modeset-hybrid)
[315.075197] Subtest basic-modeset-hybrid: SKIP (0.000s)
[315.317856] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[315.321949] [007/155] (734s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[315.538702] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[315.541241] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.001s)
[315.695241] [008/155] (734s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[316.267674] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[316.641885] [009/155] (733s left) tools_test (tools_test)
[316.748356] Starting subtest: tools_test
[316.973764] Subtest tools_test: SUCCESS (0.232s)
[317.109346] [010/155] (733s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[317.343507] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[317.348567] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[317.516517] [011/155] (732s left) kms_dsc (dsc-fractional-bpp)
[317.759642] Subtest dsc-fractional-bpp: SKIP (0.000s)
[317.865220] [012/155] (732s left) gem_exec_fence (parallel)
[318.139211] Starting subtest: parallel
[318.141182] Starting dynamic subtest: rcs0
[320.296553] Dynamic subtest rcs0: SUCCESS (2.156s)
[320.333809] Starting dynamic subtest: bcs0
[322.454117] Dynamic subtest bcs0: SUCCESS (2.156s)
[322.483053] Starting dynamic subtest: vcs0
[324.609342] Dynamic subtest vcs0: SUCCESS (2.154s)
[324.640302] Starting dynamic subtest: vecs0
[326.768477] Dynamic subtest vecs0: SUCCESS (2.159s)
[326.771455] Subtest parallel: SUCCESS (8.632s)
[327.477790] [013/155] (722s left) gem_wait (write-wait)
[327.614807] Starting subtest: write-wait
[327.618132] Starting dynamic subtest: all-engines
[328.665822] Dynamic subtest all-engines: SUCCESS (1.049s)
[328.690527] Starting dynamic subtest: rcs0
[329.715629] Dynamic subtest rcs0: SUCCESS (1.045s)
[329.743026] Starting dynamic subtest: bcs0
[330.755911] Dynamic subtest bcs0: SUCCESS (1.037s)
[330.782649] Starting dynamic subtest: vcs0
[331.792936] Dynamic subtest vcs0: SUCCESS (1.034s)
[331.816681] Starting dynamic subtest: vecs0
[332.828444] Dynamic subtest vecs0: SUCCESS (1.035s)
[332.829646] Subtest write-wait: SUCCESS (5.215s)
[333.129251] [014/155] (717s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[333.235025] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[333.343577] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[333.492837] [015/155] (717s left) gem_mmap_gtt (basic-read-write)
[333.601172] Starting subtest: basic-read-write
[333.607760] Subtest basic-read-write: SUCCESS (0.009s)
[333.757077] [016/155] (716s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[333.936057] Starting subtest: plane-lut1d-ctm3x4-lut1d
[335.665620] Subtest plane-lut1d-ctm3x4-lut1d: SKIP (1.728s)
[336.004540] [017/155] (714s left) gem_exec_schedule (preemptive-hang)
[336.256805] Starting subtest: preemptive-hang
[336.259105] Starting dynamic subtest: rcs0
[342.094600] Dynamic subtest rcs0: SUCCESS (5.827s)
[342.124586] Starting dynamic subtest: bcs0
[348.106229] Dynamic subtest bcs0: SUCCESS (6.013s)
[348.146249] Starting dynamic subtest: vcs0
[354.119726] Dynamic subtest vcs0: SUCCESS (6.013s)
[354.161881] Starting dynamic subtest: vecs0
[360.087013] Dynamic subtest vecs0: SUCCESS (5.957s)
[360.091426] Subtest preemptive-hang: SUCCESS (23.820s)
[360.347588] [018/155] (690s left) vgem_basic (bad-flag)
[360.476091] Starting subtest: bad-flag
[360.478547] Subtest bad-flag: SUCCESS (0.000s)
[360.604486] [019/155] (690s left) kms_cursor_crc (cursor-onscreen-512x170)
[360.817188] Starting subtest: cursor-onscreen-512x170
[360.823285] Subtest cursor-onscreen-512x170: SKIP (0.004s)
[360.977633] [020/155] (690s left) kms_frontbuffer_tracking (hdr-1p-rte)
[361.189170] Starting subtest: hdr-1p-rte
[361.194082] Subtest hdr-1p-rte: SKIP (0.000s)
[361.342576] [021/155] (689s left) kms_psr (psr-sprite-plane-move)
[361.532073] Subtest psr-sprite-plane-move: SKIP (0.000s)
[361.646404] [022/155] (689s left) kms_plane_multiple (tiling-x)
[361.830898] Starting subtest: tiling-x
[361.834649] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.706990] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.876s)
[363.744375] Starting dynamic subtest: pipe-A-HDMI-A-2
[365.543755] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.830s)
[365.582619] Starting dynamic subtest: pipe-B-HDMI-A-1
[367.367447] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.819s)
[367.408071] Starting dynamic subtest: pipe-B-HDMI-A-2
[369.027511] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.656s)
[369.071697] Starting dynamic subtest: pipe-C-HDMI-A-1
[370.764287] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.731s)
[370.809913] Starting dynamic subtest: pipe-C-HDMI-A-2
[372.521193] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.749s)
[372.523341] Subtest tiling-x: SUCCESS (10.692s)
[372.879541] [023/155] (678s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[373.006967] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[373.110404] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[373.249509] [024/155] (678s left) gem_ccs (block-multicopy-inplace)
[373.360892] Subtest block-multicopy-inplace: SKIP (0.000s)
[373.473663] [025/155] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[373.686747] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[373.689606] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[373.832357] [026/155] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[374.052334] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[377.054041] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SUCCESS (3.002s)
[377.279995] [027/155] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[377.486109] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[379.569966] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SUCCESS (2.090s)
[379.798546] [028/155] (672s left) kms_vblank (query-busy-hang)
[379.981110] Starting subtest: query-busy-hang
[379.982888] Starting dynamic subtest: pipe-A-HDMI-A-1
[387.840879] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.854s)
[387.893213] Starting dynamic subtest: pipe-A-HDMI-A-2
[394.879311] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.030s)
[394.939794] Starting dynamic subtest: pipe-C-HDMI-A-1
[401.837197] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.942s)
[401.878228] Starting dynamic subtest: pipe-C-HDMI-A-2
[408.819573] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.975s)
[408.823175] Subtest query-busy-hang: SUCCESS (28.841s)
[409.156091] [029/155] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[409.363658] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[409.368201] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[409.508286] [030/155] (642s left) kms_psr (psr2-cursor-blt)
[409.700044] Subtest psr2-cursor-blt: SKIP (0.000s)
[409.817035] [031/155] (642s left) syncobj_wait (single-wait-for-submit-signaled)
[409.928921] Starting subtest: single-wait-for-submit-signaled
[409.929848] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[410.090464] [032/155] (642s left) api_intel_bb (bb-with-allocator)
[410.196076] Starting subtest: bb-with-allocator
[410.200231] Subtest bb-with-allocator: SUCCESS (0.009s)
[410.387222] [033/155] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[410.583122] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[413.494419] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.911s)
[413.708217] [034/155] (638s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[413.889546] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[413.998563] [035/155] (638s left) gem_exec_schedule (u-semaphore-user)
[414.148438] Starting subtest: u-semaphore-user
[414.172566] Subtest u-semaphore-user: SUCCESS (0.022s)
[414.575772] [036/155] (638s left) gem_ctx_param (invalid-ctx-get)
[414.683816] Starting subtest: invalid-ctx-get
[414.685968] Subtest invalid-ctx-get: SUCCESS (0.000s)
[414.827194] [037/155] (637s left) gem_userptr_blits (usage-restrictions)
[414.947123] Starting subtest: usage-restrictions
[414.949167] Subtest usage-restrictions: SUCCESS (0.000s)
[415.142254] [038/155] (637s left) syncobj_wait (single-wait-submitted)
[415.244345] Starting subtest: single-wait-submitted
[415.350571] Subtest single-wait-submitted: SUCCESS (0.105s)
[415.520508] [039/155] (637s left) kms_cursor_legacy (forked-bo)
[415.711259] Starting subtest: forked-bo
[415.713031] Starting dynamic subtest: pipe-A
[421.203904] Dynamic subtest pipe-A: SUCCESS (5.494s)
[421.239931] Starting dynamic subtest: pipe-B
[426.639906] Dynamic subtest pipe-B: SUCCESS (5.429s)
[426.664192] Starting dynamic subtest: pipe-C
[432.061818] Dynamic subtest pipe-C: SUCCESS (5.419s)
[432.084374] Starting dynamic subtest: all-pipes
[437.497697] Dynamic subtest all-pipes: SUCCESS (5.432s)
[437.499545] Subtest forked-bo: SUCCESS (21.791s)
[437.658294] [040/155] (615s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[437.835164] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[437.840721] Starting dynamic subtest: pipe-A
[438.161153] Dynamic subtest pipe-A: SUCCESS (0.328s)
[438.214416] Starting dynamic subtest: pipe-B
[438.649287] Dynamic subtest pipe-B: SUCCESS (0.480s)
[438.694264] Starting dynamic subtest: pipe-C
[438.743096] Dynamic subtest pipe-C: SUCCESS (0.088s)
[438.746992] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.911s)
[439.275246] [041/155] (613s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[439.498174] Starting subtest: x-tiled-32bpp-rotate-0
[443.417384] Subtest x-tiled-32bpp-rotate-0: SUCCESS (3.924s)
[443.845666] [042/155] (609s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[444.052903] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[444.055930] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[444.195761] [043/155] (609s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[444.416304] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[444.420281] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[444.567778] [044/155] (608s left) gem_mmap_offset (clear)
[444.674499] Starting subtest: clear
[444.675377] Starting dynamic subtest: smem0
[466.245377] Dynamic subtest smem0: SUCCESS (21.562s)
[466.249548] Subtest clear: SUCCESS (21.571s)
[466.427868] [045/155] (587s left) kms_atomic (plane-invalid-params)
[466.738996] Starting subtest: plane-invalid-params
[466.740743] Starting dynamic subtest: pipe-A-HDMI-A-1
[467.375134] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.628s)
[467.376311] Subtest plane-invalid-params: SUCCESS (0.640s)
[467.750488] [046/155] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[467.957314] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[470.088380] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SUCCESS (2.132s)
[470.306342] [047/155] (583s left) gem_ctx_persistence (saturated-hostile)
[470.433046] Starting subtest: saturated-hostile
[470.435407] Starting dynamic subtest: rcs0
[471.197529] Dynamic subtest rcs0: SUCCESS (0.761s)
[471.223871] Starting dynamic subtest: bcs0
[471.951929] Dynamic subtest bcs0: SUCCESS (0.751s)
[471.976523] Starting dynamic subtest: vcs0
[472.709059] Dynamic subtest vcs0: SUCCESS (0.755s)
[472.740168] Starting dynamic subtest: vecs0
[473.459805] Dynamic subtest vecs0: SUCCESS (0.744s)
[473.462617] Subtest saturated-hostile: SUCCESS (3.028s)
[473.626476] [048/155] (580s left) gem_exec_params (larger-than-life-batch)
[473.748105] Starting subtest: larger-than-life-batch
[473.900508] Subtest larger-than-life-batch: SKIP (0.127s)
[474.059320] [049/155] (579s left) gem_exec_await (wide-contexts)
[474.458462] Starting subtest: wide-contexts
[496.194495] Subtest wide-contexts: SUCCESS (21.730s)
[496.463282] [050/155] (557s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[496.701859] Starting subtest: yf-tiled-to-vebox-yf-tiled
[496.703817] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[497.001629] [051/155] (557s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[497.208095] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[497.213224] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[497.353230] [052/155] (556s left) gem_exec_params (invalid-bsd-ring)
[497.471617] Starting subtest: invalid-bsd-ring
[497.475135] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[497.640525] [053/155] (556s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[497.761852] Starting subtest: single-wait-for-submit-unsubmitted
[497.869934] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[498.019468] [054/155] (556s left) gem_create (create-valid-nonaligned)
[498.124279] Starting subtest: create-valid-nonaligned
[498.127152] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[498.403650] [055/155] (556s left) kms_flip (2x-flip-vs-fences-interruptible)
[498.607922] Starting subtest: 2x-flip-vs-fences-interruptible
[498.618191] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[509.553825] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.932s)
[509.586349] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[520.416690] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.852s)
[520.446751] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[531.283478] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.859s)
[531.284806] Subtest 2x-flip-vs-fences-interruptible: SUCCESS (32.674s)
[531.998338] [056/155] (522s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[532.198961] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[532.202394] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[532.355562] [057/155] (522s left) syncobj_wait (invalid-reset-illegal-handle)
[532.470970] Starting subtest: invalid-reset-illegal-handle
[532.472063] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[532.646196] [058/155] (522s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[532.835848] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[532.841440] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[532.986151] [059/155] (521s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[533.193313] Starting subtest: hdr-rgb101010-draw-mmap-wc
[533.196552] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.001s)
[533.336208] [060/155] (521s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[533.546654] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[533.550679] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[533.702400] [061/155] (521s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[533.894278] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[533.896089] Starting dynamic subtest: pipe-A-valid-mode
[534.906338] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.006s)
[534.907708] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.012s)
[535.339480] [062/155] (519s left) gem_exec_balancer (sliced)
[535.482850] Starting subtest: sliced
[539.931521] Subtest sliced: SUCCESS (4.448s)
[540.210170] [063/155] (514s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[540.424069] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[541.744230] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.322s)
[542.113891] [064/155] (513s left) i915_hangman (engine-engine-error)
[542.251214] Starting subtest: engine-engine-error
[542.253752] Starting dynamic subtest: rcs0
[542.329157] Dynamic subtest rcs0: SUCCESS (0.077s)
[542.366959] Starting dynamic subtest: bcs0
[542.372251] Dynamic subtest bcs0: SKIP (0.007s)
[542.409066] Starting dynamic subtest: vcs0
[542.430864] Dynamic subtest vcs0: SUCCESS (0.078s)
[542.459275] Starting dynamic subtest: vecs0
[542.486628] Dynamic subtest vecs0: SUCCESS (0.054s)
[542.490588] Subtest engine-engine-error: SUCCESS (0.239s)
[542.660620] [065/155] (512s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[542.856515] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[542.861182] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[543.009232] [066/155] (512s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[543.217164] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[544.912453] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.693s)
[545.222742] [067/155] (510s left) gem_ctx_isolation (dirty-switch)
[545.350320] Starting subtest: dirty-switch
[545.352500] Starting dynamic subtest: rcs0
[545.926332] Dynamic subtest rcs0: SUCCESS (0.573s)
[545.957175] Starting dynamic subtest: bcs0
[546.884096] Dynamic subtest bcs0: SUCCESS (0.954s)
[546.921578] Starting dynamic subtest: vcs0
[547.464790] Dynamic subtest vcs0: SUCCESS (0.577s)
[547.501652] Starting dynamic subtest: vecs0
[548.040544] Dynamic subtest vecs0: SUCCESS (0.570s)
[548.045294] Subtest dirty-switch: SUCCESS (2.693s)
[548.312807] [068/155] (507s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[548.521118] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[548.525141] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[548.677586] [069/155] (507s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[548.882979] Starting subtest: cursor-rapid-movement-32x10
[549.189314] Subtest cursor-rapid-movement-32x10: SKIP (0.303s)
[549.377867] [070/155] (506s left) gem_spin_batch (user-each)
[549.515082] Starting subtest: user-each
[552.830575] Subtest user-each: SUCCESS (3.316s)
[553.111505] [071/155] (502s left) syncobj_basic (bad-destroy)
[553.212813] Starting subtest: bad-destroy
[553.214301] Subtest bad-destroy: SUCCESS (0.000s)
[553.359566] [072/155] (502s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[553.585415] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[553.587459] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[553.743495] [073/155] (502s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[553.931107] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[553.933070] Starting dynamic subtest: pipe-A-valid-mode
[554.974116] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.034s)
[554.976143] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.042s)
[555.312234] [074/155] (500s left) kms_frontbuffer_tracking (fbc-suspend)
[555.540201] Starting subtest: fbc-suspend