[44.423378] Initializing watchdogs
[44.423442]   /dev/watchdog0
[44.438717] [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]
[44.444698] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.447531] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[44.449451] [001/132] (960s left) kms_content_protection (dp-mst-type-1)
[44.548569] Starting subtest: dp-mst-type-1
[44.549937] Subtest dp-mst-type-1: SKIP (0.000s)
[44.650668] [002/132] (960s left) gem_exec_schedule (out-order)
[44.697992] Starting subtest: out-order
[44.698927] Starting dynamic subtest: rcs0
[44.763986] Dynamic subtest rcs0: SUCCESS (0.066s)
[44.772559] Starting dynamic subtest: bcs0
[44.832234] Dynamic subtest bcs0: SUCCESS (0.067s)
[44.845391] Starting dynamic subtest: vcs0
[44.902856] Dynamic subtest vcs0: SUCCESS (0.070s)
[44.912061] Starting dynamic subtest: vcs1
[44.972616] Dynamic subtest vcs1: SUCCESS (0.069s)
[44.986854] Starting dynamic subtest: vecs0
[45.042756] Dynamic subtest vecs0: SUCCESS (0.069s)
[45.043767] Subtest out-order: SUCCESS (0.345s)
[45.345707] [003/132] (959s left) kms_getfb (getfb2-handle-zero)
[45.430466] Starting subtest: getfb2-handle-zero
[45.431167] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[45.513798] [004/132] (959s left) perf_pmu (busy-check-all)
[45.550949] Starting subtest: busy-check-all
[45.551707] Starting dynamic subtest: rcs0
[46.076327] Dynamic subtest rcs0: SUCCESS (0.525s)
[46.084460] Starting dynamic subtest: bcs0
[46.603706] Dynamic subtest bcs0: SUCCESS (0.527s)
[46.611837] Starting dynamic subtest: vcs0
[47.126188] Dynamic subtest vcs0: SUCCESS (0.522s)
[47.134553] Starting dynamic subtest: vcs1
[47.652279] Dynamic subtest vcs1: SUCCESS (0.525s)
[47.660326] Starting dynamic subtest: vecs0
[48.178100] Dynamic subtest vecs0: SUCCESS (0.525s)
[48.179112] Subtest busy-check-all: SUCCESS (2.627s)
[48.272730] [005/132] (956s left) drm_read (empty-nonblock)
[48.409554] Starting subtest: empty-nonblock
[48.410290] Subtest empty-nonblock: SUCCESS (0.000s)
[48.527622] [006/132] (956s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[48.616631] Starting subtest: fbcpsr-indfb-scaledprimary
[48.618076] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[48.695489] [007/132] (956s left) kms_pm_rpm (modeset-lpsp-stress)
[50.087466] Starting subtest: modeset-lpsp-stress
[62.914734] Subtest modeset-lpsp-stress: SUCCESS (12.828s)
[63.017558] [008/132] (942s left) i915_hangman (hangcheck-unterminated)
[63.061432] Starting subtest: hangcheck-unterminated
[72.937330] Subtest hangcheck-unterminated: SUCCESS (9.876s)
[73.035125] [009/132] (932s left) gem_ctx_param (set-priority-not-supported)
[73.068238] Starting subtest: set-priority-not-supported
[73.069619] Subtest set-priority-not-supported: SKIP (0.000s)
[73.120743] [010/132] (932s left) gem_exec_fence (syncobj-timeline-unused-fence)
[73.599747] Starting subtest: syncobj-timeline-unused-fence
[73.600642] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[73.773416] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[73.777765] [011/132] (931s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[73.867418] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[73.868781] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[73.957845] [012/132] (931s left) gem_eio (wait-wedge-immediate)
[74.000290] Starting subtest: wait-wedge-immediate
[74.253571] Subtest wait-wedge-immediate: SUCCESS (0.253s)
[74.362454] [013/132] (931s left) kms_chamelium_hpd (hdmi-hpd-storm)
[74.497389] Subtest hdmi-hpd-storm: SKIP (0.000s)
[74.586221] [014/132] (930s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[75.040450] Starting subtest: syncobj-stationary-timeline-chain-engines
[75.104886] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.073s)
[75.283450] [015/132] (930s left) api_intel_bb (crc32)
[75.315771] Starting subtest: crc32
[75.317124] Subtest crc32: SKIP (0.000s)
[75.398641] [016/132] (930s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[75.432695] Starting subtest: multi-wait-all-available-submitted-signaled
[75.433366] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[75.488879] [017/132] (930s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[75.576294] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[75.578146] Starting dynamic subtest: A-HDMI-A1
[76.266240] Dynamic subtest A-HDMI-A1: SUCCESS (0.684s)
[76.274760] Starting dynamic subtest: B-HDMI-A1
[76.950012] Dynamic subtest B-HDMI-A1: SUCCESS (0.687s)
[76.956760] Starting dynamic subtest: C-HDMI-A1
[77.630188] Dynamic subtest C-HDMI-A1: SUCCESS (0.679s)
[77.636672] Starting dynamic subtest: D-HDMI-A1
[78.327361] Dynamic subtest D-HDMI-A1: SUCCESS (0.697s)
[78.329281] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.754s)
[78.472972] [018/132] (927s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[78.566046] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[78.566822] Starting dynamic subtest: pipe-A-HDMI-A-1
[78.569760] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[78.578369] Starting dynamic subtest: pipe-B-HDMI-A-1
[78.581285] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[78.590035] Starting dynamic subtest: pipe-C-HDMI-A-1
[78.592815] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[78.598811] Starting dynamic subtest: pipe-D-HDMI-A-1
[78.601522] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[78.602938] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[78.818308] [019/132] (926s left) syncobj_wait (wait-all-complex)
[78.853438] Starting subtest: wait-all-complex
[79.077677] Subtest wait-all-complex: SUCCESS (0.215s)
[79.142926] [020/132] (926s left) syncobj_wait (single-wait-submitted)
[79.176459] Starting subtest: single-wait-submitted
[79.279600] Subtest single-wait-submitted: SUCCESS (0.103s)
[79.353320] [021/132] (926s left) kms_flip (2x-flip-vs-modeset)
[79.437422] Starting subtest: 2x-flip-vs-modeset
[79.446704] Subtest 2x-flip-vs-modeset: SKIP (0.009s)
[79.519536] [022/132] (926s left) perf_pmu (multi-client)
[79.554616] Starting subtest: multi-client
[79.555315] Starting dynamic subtest: rcs0
[80.590216] Dynamic subtest rcs0: SUCCESS (1.033s)
[80.598225] Starting dynamic subtest: bcs0
[81.624343] Dynamic subtest bcs0: SUCCESS (1.026s)
[81.634038] Starting dynamic subtest: vcs0
[82.645075] Dynamic subtest vcs0: SUCCESS (1.019s)
[82.654926] Starting dynamic subtest: vcs1
[83.657705] Dynamic subtest vcs1: SUCCESS (1.020s)
[83.666880] Starting dynamic subtest: vecs0
[84.689152] Dynamic subtest vecs0: SUCCESS (1.022s)
[84.690192] Subtest multi-client: SUCCESS (5.126s)
[84.748792] [023/132] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[84.840754] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[86.107223] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (1.267s)
[86.239725] [024/132] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[86.331479] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[86.332825] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[86.439018] [025/132] (919s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[86.473290] Starting subtest: single-wait-all-for-submit-available-submitted
[86.474047] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[86.554529] [026/132] (919s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[86.640839] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[86.642260] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[86.700581] [027/132] (919s left) gem_caching (read-writes)
[86.738310] Starting subtest: read-writes
[98.546314] Subtest read-writes: SUCCESS (11.808s)
[98.645939] [028/132] (907s left) gem_softpin (safe-alignment)
[98.686600] Starting subtest: safe-alignment
[98.698262] Subtest safe-alignment: SUCCESS (0.012s)
[98.796163] [029/132] (907s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[98.830504] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[98.855978] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.013s)
[98.906371] [030/132] (907s left) drm_mm (drm_mm)
[98.939292] Starting subtest: drm_mm
[98.954954] Starting dynamic subtest: drm_test_mm_init
[99.031119] Dynamic subtest drm_test_mm_init: SUCCESS (0.075s)
[99.048456] Starting dynamic subtest: drm_test_mm_debug
[99.106053] Dynamic subtest drm_test_mm_debug: SUCCESS (0.071s)
[99.123220] Starting dynamic subtest: drm_test_mm_align32
[99.182336] Dynamic subtest drm_test_mm_align32: SUCCESS (0.073s)
[99.197158] Starting dynamic subtest: drm_test_mm_align64
[99.248909] Dynamic subtest drm_test_mm_align64: SUCCESS (0.064s)
[99.263818] Starting dynamic subtest: drm_test_mm_lowest
[99.316743] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.066s)
[99.331179] Starting dynamic subtest: drm_test_mm_highest
[99.385729] Dynamic subtest drm_test_mm_highest: SUCCESS (0.067s)
[99.386949] Subtest drm_mm: SUCCESS (0.448s)
[99.515184] [031/132] (906s left) kms_getfb (getfb-handle-zero)
[99.601786] Starting subtest: getfb-handle-zero
[99.602463] Subtest getfb-handle-zero: SUCCESS (0.000s)
[99.685842] [032/132] (906s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[99.769780] Starting subtest: plane-all-modeset-transition-fencing
[99.771355] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.000818] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (11.230s)
[111.042940] Starting dynamic subtest: pipe-B-HDMI-A-1
[120.535096] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (9.498s)
[120.562229] Subtest plane-all-modeset-transition-fencing: SUCCESS (20.792s)
[120.712688] [033/132] (885s left) kms_psr (fbc-psr-sprite-render)
[120.805481] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[120.850542] [034/132] (885s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[120.885105] Starting subtest: etime-multi-wait-all-available-unsubmitted
[120.991716] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[121.076684] [035/132] (885s left) core_auth (getclient-simple)
[121.108631] Starting subtest: getclient-simple
[121.110059] Subtest getclient-simple: SUCCESS (0.002s)
[121.175805] [036/132] (885s left) kms_addfb_basic (unused-offsets)
[121.208443] Starting subtest: unused-offsets
[121.209204] Subtest unused-offsets: SUCCESS (0.000s)
[121.357654] [037/132] (885s left) gem_ctx_isolation (clean)
[121.398354] Starting subtest: clean
[121.399073] Starting dynamic subtest: rcs0
[121.422861] Dynamic subtest rcs0: SUCCESS (0.024s)
[121.429691] Starting dynamic subtest: bcs0
[121.458275] Dynamic subtest bcs0: SUCCESS (0.035s)
[121.465233] Starting dynamic subtest: vcs0
[121.523355] Dynamic subtest vcs0: SUCCESS (0.064s)
[121.529967] Starting dynamic subtest: vcs1
[121.588246] Dynamic subtest vcs1: SUCCESS (0.064s)
[121.595098] Starting dynamic subtest: vecs0
[121.653889] Dynamic subtest vecs0: SUCCESS (0.065s)
[121.654734] Subtest clean: SUCCESS (0.256s)
[121.837990] [038/132] (884s left) gem_exec_reloc (basic-wc-noreloc)
[121.875122] Starting subtest: basic-wc-noreloc
[121.877398] Subtest basic-wc-noreloc: SUCCESS (0.002s)
[121.988813] [039/132] (884s left) syncobj_timeline (multi-wait-for-submit-signaled)
[122.022472] Starting subtest: multi-wait-for-submit-signaled
[122.024088] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[122.111117] [040/132] (884s left) gen9_exec_parse (basic-rejected)
[122.147958] Subtest basic-rejected: SKIP (0.000s)
[122.192150] [041/132] (884s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[122.281638] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[122.282984] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[122.385964] [042/132] (884s left) perf (missing-sample-flags)
[122.466803] Starting subtest: missing-sample-flags
[122.467485] Subtest missing-sample-flags: SUCCESS (0.000s)
[122.504966] [043/132] (884s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[122.601846] Starting subtest: 4-tiled-16bpp-rotate-90
[122.603264] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[122.688443] [044/132] (883s left) gem_render_tiled_blits (basic)
[122.726856] Starting subtest: basic
[122.758856] Subtest basic: SUCCESS (0.032s)
[122.819767] [045/132] (883s left) gem_ctx_persistence (legacy-engines-hostile)
[122.858113] Starting subtest: legacy-engines-hostile
[122.858852] Starting dynamic subtest: render
[122.896632] Dynamic subtest render: SUCCESS (0.037s)
[122.914407] Starting dynamic subtest: bsd1
[122.991678] Dynamic subtest bsd1: SUCCESS (0.093s)
[123.008658] Starting dynamic subtest: bsd2
[123.082738] Dynamic subtest bsd2: SUCCESS (0.089s)
[123.100695] Starting dynamic subtest: blt
[123.179560] Dynamic subtest blt: SUCCESS (0.095s)
[123.197390] Starting dynamic subtest: vebox
[123.275671] Dynamic subtest vebox: SUCCESS (0.094s)
[123.277080] Subtest legacy-engines-hostile: SUCCESS (0.418s)
[123.341564] [046/132] (883s left) gem_exec_balancer (bonded-sync)
[123.384186] Starting subtest: bonded-sync
[138.172679] Subtest bonded-sync: SUCCESS (14.780s)
[138.339159] [047/132] (868s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[138.426871] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[138.428243] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[138.588205] [048/132] (868s left) gem_ctx_shared (q-in-order)
[138.631029] Starting subtest: Q-in-order
[138.631865] Starting dynamic subtest: rcs0
[138.696728] Dynamic subtest rcs0: SUCCESS (0.065s)
[138.707308] Starting dynamic subtest: bcs0
[138.758358] Dynamic subtest bcs0: SUCCESS (0.059s)
[138.774456] Starting dynamic subtest: vcs0
[138.818317] Dynamic subtest vcs0: SUCCESS (0.057s)
[138.834110] Starting dynamic subtest: vcs1
[138.875772] Dynamic subtest vcs1: SUCCESS (0.055s)
[138.889194] Starting dynamic subtest: vecs0
[138.928502] Dynamic subtest vecs0: SUCCESS (0.051s)
[138.929521] Subtest Q-in-order: SUCCESS (0.298s)
[139.118017] [049/132] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[139.210798] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[139.212301] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[139.311329] [050/132] (867s left) i915_selftest (live)
[140.175758] Starting subtest: live
[140.176588] Starting dynamic subtest: sanitycheck
[141.349775] Dynamic subtest sanitycheck: SUCCESS (1.173s)
[141.360594] Starting dynamic subtest: uncore
[142.519771] Dynamic subtest uncore: SUCCESS (1.168s)
[142.526500] Starting dynamic subtest: workarounds
[144.007321] Dynamic subtest workarounds: SUCCESS (1.486s)
[144.013032] Starting dynamic subtest: gt_engines
[145.759712] Dynamic subtest gt_engines: SUCCESS (1.751s)
[145.769713] Starting dynamic subtest: gt_timelines
[154.333694] Dynamic subtest gt_timelines: SUCCESS (8.572s)
[154.343921] Starting dynamic subtest: gt_contexts
[155.664895] Dynamic subtest gt_contexts: SUCCESS (1.329s)
[155.676109] Starting dynamic subtest: gt_lrc
[159.803823] Dynamic subtest gt_lrc: SUCCESS (4.136s)
[159.812620] Starting dynamic subtest: gt_mocs
[161.133572] Dynamic subtest gt_mocs: SUCCESS (1.328s)
[161.139728] Starting dynamic subtest: gt_pm
[182.496789] Dynamic subtest gt_pm: SUCCESS (21.361s)
[182.505402] Starting dynamic subtest: gt_heartbeat
[183.706601] Dynamic subtest gt_heartbeat: SUCCESS (1.208s)
[183.713050] Starting dynamic subtest: gt_tlb
[187.137757] Dynamic subtest gt_tlb: SUCCESS (3.429s)
[187.144055] Starting dynamic subtest: requests
[195.694739] Dynamic subtest requests: SUCCESS (8.555s)
[195.702327] Starting dynamic subtest: migrate
[199.923515] Dynamic subtest migrate: SUCCESS (4.226s)
[199.929816] Starting dynamic subtest: active
[201.112662] Dynamic subtest active: SUCCESS (1.187s)
[201.123171] Starting dynamic subtest: objects
[202.772528] Dynamic subtest objects: SUCCESS (1.657s)
[202.779187] Starting dynamic subtest: mman
[207.396572] Dynamic subtest mman: SUCCESS (4.622s)
[207.407767] Starting dynamic subtest: dmabuf
[208.607788] Dynamic subtest dmabuf: SUCCESS (1.209s)
[208.617982] Starting dynamic subtest: vma
[209.817689] Dynamic subtest vma: SUCCESS (1.207s)
[209.824145] Starting dynamic subtest: coherency
[212.675582] Dynamic subtest coherency: SUCCESS (2.856s)
[212.681871] Starting dynamic subtest: gtt
[221.449563] Dynamic subtest gtt: SUCCESS (8.772s)
[221.456225] Starting dynamic subtest: gem
[223.572649] Dynamic subtest gem: SUCCESS (2.121s)
[223.579228] Starting dynamic subtest: evict
[225.771732] Dynamic subtest evict: SUCCESS (2.197s)
[225.787034] Starting dynamic subtest: hugepages
[233.490457] Dynamic subtest hugepages: SUCCESS (7.716s)
[233.496814] Starting dynamic subtest: gem_contexts
[248.911368] Dynamic subtest gem_contexts: SUCCESS (15.419s)
[248.922519] Starting dynamic subtest: client
[250.159757] Dynamic subtest client: SUCCESS (1.246s)
[250.165654] Starting dynamic subtest: gem_migrate
[251.314720] Dynamic subtest gem_migrate: SUCCESS (1.153s)
[251.321425] Starting dynamic subtest: reset
[256.204575] Dynamic subtest reset: SUCCESS (4.888s)
[256.210807] Starting dynamic subtest: memory_region
[257.391703] Dynamic subtest memory_region: SUCCESS (1.185s)
[257.401808] Starting dynamic subtest: hangcheck
[287.339738] Dynamic subtest hangcheck: SUCCESS (29.946s)
[287.346450] Starting dynamic subtest: execlists
[301.079510] Dynamic subtest execlists: SUCCESS (13.738s)
[301.086346] Starting dynamic subtest: ring_submission
[302.255910] Dynamic subtest ring_submission: SUCCESS (1.174s)
[302.266079] Starting dynamic subtest: perf
[303.557682] Dynamic subtest perf: SUCCESS (1.299s)
[303.568029] Starting dynamic subtest: slpc
[304.747698] Dynamic subtest slpc: SUCCESS (1.188s)
[304.754072] Starting dynamic subtest: guc
[305.965107] Dynamic subtest guc: SUCCESS (1.216s)
[305.984347] Starting dynamic subtest: guc_multi_lrc
[307.130665] Dynamic subtest guc_multi_lrc: SUCCESS (1.163s)
[307.137296] Starting dynamic subtest: guc_hang
[308.302788] Dynamic subtest guc_hang: SUCCESS (1.170s)
[308.309755] Starting dynamic subtest: late_gt_pm
[309.526495] Dynamic subtest late_gt_pm: SUCCESS (1.221s)
[309.527342] Subtest live: SUCCESS (169.351s)
[309.555266] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[309.556181] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[309.558794] [051/132] (697s left) kms_vblank (wait-forked)
[310.608185] Starting subtest: wait-forked
[310.609168] Starting dynamic subtest: pipe-A-HDMI-A-1
[311.875908] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.266s)
[311.885247] Starting dynamic subtest: pipe-D-HDMI-A-1
[313.079702] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.200s)
[313.080391] Subtest wait-forked: SUCCESS (2.472s)
[313.233503] [FACT kms_vblank (wait-forked)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[313.234824] [FACT kms_vblank (wait-forked)] new: kernel.kmod_is_loaded.i915: true
[313.237399] [052/132] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[313.331942] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[313.333363] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[313.422128] [053/132] (693s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[313.461982] Starting subtest: yf-tiled-ccs-to-yf-tiled
[313.462767] Starting dynamic subtest: smem
[313.541239] Dynamic subtest smem: SUCCESS (0.079s)
[313.541952] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.080s)
[313.726933] [054/132] (693s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[313.811964] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[313.813799] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.820360] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[313.827143] Starting dynamic subtest: pipe-B-HDMI-A-1
[313.833765] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[313.840255] Starting dynamic subtest: pipe-C-HDMI-A-1
[313.847194] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[313.853592] Starting dynamic subtest: pipe-D-HDMI-A-1
[313.860481] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[313.861799] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[314.041082] [055/132] (693s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[314.088305] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[314.119118] [056/132] (692s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[314.215018] Starting subtest: y-tiled-64bpp-rotate-90
[314.270447] Subtest y-tiled-64bpp-rotate-90: SKIP (0.054s)
[314.368237] [057/132] (692s left) kms_atomic (plane-invalid-params-fence)
[314.454049] Starting subtest: plane-invalid-params-fence
[314.455880] Starting dynamic subtest: pipe-A-HDMI-A-1
[314.571700] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.116s)
[314.572393] Subtest plane-invalid-params-fence: SUCCESS (0.118s)
[314.691854] [058/132] (692s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[314.784206] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[314.785554] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[314.959559] [059/132] (692s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[315.044971] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[315.047349] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[315.101468] [060/132] (692s left) i915_drm_fdinfo (virtual-busy-all)
[315.137748] Starting subtest: virtual-busy-all
[315.656662] Subtest virtual-busy-all: SUCCESS (0.519s)
[315.728357] [061/132] (691s left) kms_cursor_crc (cursor-tearing-position-change)
[315.815185] Starting subtest: cursor-tearing-position-change
[315.816923] Starting dynamic subtest: pipe-A-HDMI-A-1
[316.083545] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.267s)
[316.091824] Starting dynamic subtest: pipe-D-HDMI-A-1
[316.316716] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.231s)
[316.317456] Subtest cursor-tearing-position-change: SUCCESS (0.502s)
[316.451365] [062/132] (690s left) gem_wait (await)
[316.499029] Starting subtest: await
[316.499795] Starting dynamic subtest: all-engines
[317.537371] Dynamic subtest all-engines: SUCCESS (1.039s)
[317.549105] Starting dynamic subtest: rcs0
[318.569334] Dynamic subtest rcs0: SUCCESS (1.030s)
[318.583201] Starting dynamic subtest: bcs0
[319.599241] Dynamic subtest bcs0: SUCCESS (1.027s)
[319.612494] Starting dynamic subtest: vcs0
[320.629348] Dynamic subtest vcs0: SUCCESS (1.028s)
[320.643529] Starting dynamic subtest: vcs1
[321.658426] Dynamic subtest vcs1: SUCCESS (1.026s)
[321.670452] Starting dynamic subtest: vecs0
[322.690609] Dynamic subtest vecs0: SUCCESS (1.030s)
[322.691523] Subtest await: SUCCESS (6.193s)
[322.886376] [063/132] (684s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[322.976910] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[322.977602] Starting dynamic subtest: pipe-A
[324.310577] Dynamic subtest pipe-A: SUCCESS (1.334s)
[324.329122] Starting dynamic subtest: pipe-B
[325.611685] Dynamic subtest pipe-B: SUCCESS (1.300s)
[325.620430] Starting dynamic subtest: pipe-C
[325.812351] Dynamic subtest pipe-C: SUCCESS (0.200s)
[325.824078] Starting dynamic subtest: pipe-D
[326.013112] Dynamic subtest pipe-D: SUCCESS (0.200s)
[326.013826] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (3.038s)
[326.193605] [064/132] (681s left) kms_dsc (dsc-with-output-formats)
[326.285093] Starting subtest: dsc-with-output-formats
[326.291729] Subtest dsc-with-output-formats: SKIP (0.001s)
[326.342272] [065/132] (681s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[326.431798] Starting subtest: fbc-rgb101010-draw-pwrite
[328.916501] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.484s)
[329.014483] [066/132] (678s left) kms_chamelium_color (ctm-blue-to-red)
[329.103711] Subtest ctm-blue-to-red: SKIP (0.000s)
[329.147229] [067/132] (678s left) gem_exec_whisper (basic-fds-all)
[329.190265] Starting subtest: basic-fds-all
[331.824953] Subtest basic-fds-all: SUCCESS (2.634s)
[331.996623] [068/132] (675s left) gem_pwrite (basic-exhaustion)
[332.030208] Starting subtest: basic-exhaustion
[336.397998] Subtest basic-exhaustion: SUCCESS (4.356s)
[336.727982] [069/132] (670s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[336.817993] Starting subtest: primary-yf-tiled-reflect-x-270
[336.867641] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.049s)
[336.950148] [070/132] (670s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[337.041800] Starting subtest: fbcpsr-tiling-4
[337.043174] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[337.139961] [071/132] (670s left) gem_ctx_param (set-priority-invalid-size)
[337.175132] Starting subtest: set-priority-invalid-size
[337.175838] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[337.258239] [072/132] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[337.348846] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[337.350217] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[337.433262] [073/132] (670s left) kms_psr (fbc-psr2-primary-blt)
[337.520660] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[337.566210] [074/132] (670s left) gem_mmap_offset (blt-coherency)
[337.598958] Starting subtest: blt-coherency
[337.606959] Subtest blt-coherency: SUCCESS (0.009s)
[337.696571] [075/132] (670s left) kms_selftest (drm_damage_helper)
[337.730482] Starting subtest: drm_damage_helper
[337.735297] Starting dynamic subtest: drm_test_damage_iter_no_damage
[337.800021] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.064s)
[337.819547] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[337.864671] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.062s)
[337.882873] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[337.933771] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.066s)
[337.952385] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[338.009530] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.073s)
[338.028021] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[338.075636] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.063s)
[338.094656] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[338.140686] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.062s)
[338.158919] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[338.213097] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.069s)
[338.231574] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[338.284758] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.069s)
[338.303301] Starting dynamic subtest: drm_test_damage_iter_single_damage
[338.355932] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.068s)
[338.374280] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[338.425781] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.067s)
[338.444365] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[338.496961] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.068s)
[338.510450] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[338.566480] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.064s)
[338.582473] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[338.638215] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.069s)
[338.654553] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[338.708322] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.067s)
[338.724775] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[338.786058] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.075s)
[338.802654] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[338.854199] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.066s)
[338.872400] Starting dynamic subtest: drm_test_damage_iter_damage
[338.926941] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.070s)
[338.943591] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[339.000910] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.071s)
[339.017448] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[339.067074] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.063s)
[339.083621] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[339.139147] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.069s)
[339.155558] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[339.204953] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.063s)
[339.206191] Subtest drm_damage_helper: SUCCESS (1.474s)
[339.337483] [076/132] (668s left) kms_big_fb (linear-8bpp-rotate-180)
[339.439576] Starting subtest: linear-8bpp-rotate-180
[340.718185] Subtest linear-8bpp-rotate-180: SUCCESS (1.280s)
[340.838682] [077/132] (667s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[340.873601] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[340.975824] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[341.055904] [078/132] (666s left) kms_chamelium_frames (hdmi-crc-fast)
[341.201445] Subtest hdmi-crc-fast: SKIP (0.000s)
[341.286264] [079/132] (666s left) kms_plane_lowres (tiling-x)
[341.374089] Starting subtest: tiling-x
[341.374882] Starting dynamic subtest: pipe-A-HDMI-A-1
[348.490609] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.115s)
[348.579741] Starting dynamic subtest: pipe-B-HDMI-A-1
[355.469528] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.896s)
[355.549384] Starting dynamic subtest: pipe-C-HDMI-A-1
[362.460755] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.917s)
[362.549614] Starting dynamic subtest: pipe-D-HDMI-A-1
[369.430654] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.887s)
[369.512351] Subtest tiling-x: SUCCESS (28.138s)
[369.650146] [080/132] (638s left) syncobj_basic (bad-flags-fd-to-handle)
[369.691813] Starting subtest: bad-flags-fd-to-handle
[369.692493] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[369.752340] [081/132] (638s left) gem_softpin (32b-excludes-last-page)
[369.790766] Starting subtest: 32b-excludes-last-page
[369.791530] Subtest 32b-excludes-last-page: SUCCESS (0.002s)
[369.903188] [082/132] (638s left) gem_sync (basic-store-each)
[369.945279] Starting subtest: basic-store-each
[372.104482] Subtest basic-store-each: SUCCESS (2.159s)
[372.293130] [083/132] (635s left) kms_fence_pin_leak
[373.793533] [084/132] (634s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[373.885950] Starting subtest: compare-crc-sanitycheck-xr24
[373.886681] Starting dynamic subtest: pipe-A-HDMI-A-1
[374.157010] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.270s)
[374.165436] Starting dynamic subtest: pipe-B-HDMI-A-1
[374.400597] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.241s)
[374.412324] Starting dynamic subtest: pipe-C-HDMI-A-1
[374.650411] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.247s)
[374.658779] Starting dynamic subtest: pipe-D-HDMI-A-1
[374.894657] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.242s)
[374.895343] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.010s)
[375.030901] [085/132] (633s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[375.120730] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[375.163308] [086/132] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[375.253766] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[375.255147] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.341873] [087/132] (632s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[375.428438] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[375.429891] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[375.489950] [088/132] (632s left) kms_cursor_legacy (single-bo)
[375.578561] Starting subtest: single-bo
[375.579321] Starting dynamic subtest: pipe-A
[380.992344] Dynamic subtest pipe-A: SUCCESS (5.379s)
[380.999922] Starting dynamic subtest: pipe-B
[386.372115] Dynamic subtest pipe-B: SUCCESS (5.378s)
[386.378926] Starting dynamic subtest: pipe-C
[391.751722] Dynamic subtest pipe-C: SUCCESS (5.378s)
[391.758795] Starting dynamic subtest: pipe-D
[397.130965] Dynamic subtest pipe-D: SUCCESS (5.378s)
[397.137738] Starting dynamic subtest: all-pipes
[402.510747] Dynamic subtest all-pipes: SUCCESS (5.379s)
[402.511508] Subtest single-bo: SUCCESS (26.899s)
[402.550235] [089/132] (605s left) gem_close_race (multigpu-basic-process)
[402.593747] Starting subtest: multigpu-basic-process
[402.595117] Subtest multigpu-basic-process: SKIP (0.000s)
[402.778722] [090/132] (605s left) gem_exec_schedule (preempt-user)
[402.824830] Starting subtest: preempt-user
[402.825527] Starting dynamic subtest: rcs0
[402.844621] Dynamic subtest rcs0: SUCCESS (0.020s)
[402.853528] Starting dynamic subtest: bcs0
[402.865373] Dynamic subtest bcs0: SUCCESS (0.020s)
[402.874446] Starting dynamic subtest: vcs0
[402.887760] Dynamic subtest vcs0: SUCCESS (0.021s)
[402.896009] Starting dynamic subtest: vcs1
[402.908089] Dynamic subtest vcs1: SUCCESS (0.019s)
[402.917364] Starting dynamic subtest: vecs0
[402.929197] Dynamic subtest vecs0: SUCCESS (0.019s)
[402.929951] Subtest preempt-user: SUCCESS (0.106s)
[403.243888] [091/132] (605s left) kms_cursor_crc (cursor-random-256x85)
[403.337345] Starting subtest: cursor-random-256x85
[403.343361] Starting dynamic subtest: pipe-A-HDMI-A-1
[405.269169] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.925s)
[405.309892] Starting dynamic subtest: pipe-D-HDMI-A-1
[407.192634] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.891s)
[407.193350] Subtest cursor-random-256x85: SUCCESS (3.855s)
[407.323371] [092/132] (601s left) gem_mmap_gtt (basic)
[407.358400] Starting subtest: basic
[407.359101] Subtest basic: SUCCESS (0.001s)
[407.445162] [093/132] (601s left) syncobj_wait (invalid-signal-one-illegal-handle)
[407.479838] Starting subtest: invalid-signal-one-illegal-handle
[407.480533] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[407.545231] [094/132] (601s left) kms_psr (fbc-psr-cursor-blt)
[407.635767] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[407.675943] [095/132] (600s left) gem_eio (reset-stress)
[407.722129] Starting subtest: reset-stress
[407.724417] Starting dynamic subtest: render
[410.600532] Dynamic subtest render: SUCCESS (2.876s)
[410.614676] Starting dynamic subtest: bsd1
[413.497818] Dynamic subtest bsd1: SUCCESS (2.894s)
[413.509514] Starting dynamic subtest: bsd2
[416.384430] Dynamic subtest bsd2: SUCCESS (2.883s)
[416.396777] Starting dynamic subtest: blt
[419.268483] Dynamic subtest blt: SUCCESS (2.881s)
[419.280319] Starting dynamic subtest: vebox
[422.193534] Dynamic subtest vebox: SUCCESS (2.923s)
[422.194249] Subtest reset-stress: SUCCESS (14.471s)
[422.316112] [096/132] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[422.408798] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[422.410194] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[422.499806] [097/132] (586s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[422.597380] Starting subtest: yf-tiled-64bpp-rotate-270
[422.598795] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[422.684771] [098/132] (586s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[422.775326] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[422.819438] [099/132] (585s left) kms_prop_blob (invalid-set-prop)
[422.853561] Starting subtest: invalid-set-prop
[422.854270] Subtest invalid-set-prop: SUCCESS (0.000s)
[422.924381] [100/132] (585s left) kms_addfb_basic (bo-too-small)
[423.012942] Starting subtest: bo-too-small
[423.013658] Subtest bo-too-small: SUCCESS (0.000s)
[423.119381] [101/132] (585s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[423.211110] Starting subtest: plane-lut1d-pre-ctm3x4
[423.305257] Starting dynamic subtest: pipe-A-plane-0
[423.404693] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[423.419377] Starting dynamic subtest: pipe-A-plane-1
[423.496617] Dynamic subtest pipe-A-plane-1: SUCCESS (0.090s)
[423.511945] Starting dynamic subtest: pipe-A-plane-2
[423.596452] Dynamic subtest pipe-A-plane-2: SUCCESS (0.097s)
[423.789742] Starting dynamic subtest: pipe-B-plane-0
[423.867500] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[423.882198] Starting dynamic subtest: pipe-B-plane-1
[423.967475] Dynamic subtest pipe-B-plane-1: SUCCESS (0.097s)
[423.981091] Starting dynamic subtest: pipe-B-plane-2
[424.061047] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[424.277116] Starting dynamic subtest: pipe-C-plane-0
[424.360060] Dynamic subtest pipe-C-plane-0: SUCCESS (0.091s)
[424.372178] Starting dynamic subtest: pipe-C-plane-1
[424.458243] Dynamic subtest pipe-C-plane-1: SUCCESS (0.097s)
[424.470938] Starting dynamic subtest: pipe-C-plane-2
[424.557998] Dynamic subtest pipe-C-plane-2: SUCCESS (0.097s)
[424.768990] Starting dynamic subtest: pipe-D-plane-0
[424.857251] Dynamic subtest pipe-D-plane-0: SUCCESS (0.099s)
[424.872853] Starting dynamic subtest: pipe-D-plane-1
[424.957305] Dynamic subtest pipe-D-plane-1: SUCCESS (0.097s)
[424.971796] Starting dynamic subtest: pipe-D-plane-2
[425.057450] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[425.105762] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (1.895s)
[425.211334] [102/132] (583s left) gem_lmem_swapping (random-engines)
[425.249712] Subtest random-engines: SKIP (0.000s)
[425.296902] [103/132] (583s left) kms_invalid_mode (bad-vsync-start)
[425.386810] Starting subtest: bad-vsync-start
[425.387529] Starting dynamic subtest: pipe-A-HDMI-A-1
[425.439504] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.052s)
[425.448203] Starting dynamic subtest: pipe-B-HDMI-A-1
[425.448918] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[425.456349] Starting dynamic subtest: pipe-C-HDMI-A-1
[425.457049] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[425.464106] Starting dynamic subtest: pipe-D-HDMI-A-1
[425.464796] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[425.465477] Subtest bad-vsync-start: SUCCESS (0.061s)
[425.582524] [104/132] (583s left) gem_partial_pwrite_pread (reads-uncached)
[425.620976] Starting subtest: reads-uncached
[427.404509] Subtest reads-uncached: SUCCESS (1.782s)
[427.508093] [105/132] (581s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[427.601917] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[427.602903] Starting dynamic subtest: pipe-A
[427.736738] Dynamic subtest pipe-A: SUCCESS (0.135s)
[427.748422] Starting dynamic subtest: pipe-B
[427.879893] Dynamic subtest pipe-B: SUCCESS (0.142s)
[427.891621] Starting dynamic subtest: pipe-C
[428.005082] Dynamic subtest pipe-C: SUCCESS (0.124s)
[428.014333] Starting dynamic subtest: pipe-D
[428.140793] Dynamic subtest pipe-D: SUCCESS (0.135s)
[428.141477] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.540s)
[428.324751] [106/132] (580s left) fbdev (unaligned-read)
[428.366317] Starting subtest: unaligned-read
[428.375140] Subtest unaligned-read: SUCCESS (0.009s)
[428.425722] [107/132] (580s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[428.523808] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[429.091088] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.567s)
[429.211138] [108/132] (579s left) kms_addfb_basic (basic-x-tiled-legacy)
[429.246081] Starting subtest: basic-x-tiled-legacy
[429.246772] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[429.424750] [109/132] (579s left) kms_lease (multimaster-lease)
[429.512140] Starting subtest: multimaster-lease
[429.514041] Subtest multimaster-lease: SUCCESS (0.002s)
[429.577142] [110/132] (579s left) kms_addfb_basic (addfb25-bad-modifier)
[429.664087] Starting subtest: addfb25-bad-modifier
[429.664827] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[429.752508] [111/132] (579s left) kms_pm_rpm (drm-resources-equal)
[441.195811] Starting subtest: drm-resources-equal
[443.925034] Subtest drm-resources-equal: SUCCESS (2.729s)
[444.006166] [112/132] (565s left) gem_exec_reloc (basic-write-gtt)
[444.045166] Starting subtest: basic-write-gtt
[444.051912] Subtest basic-write-gtt: SUCCESS (0.007s)
[444.168346] [113/132] (565s left) perf_pmu (all-busy-idle-check-all)
[444.204183] Starting subtest: all-busy-idle-check-all
[444.825056] Subtest all-busy-idle-check-all: SUCCESS (0.621s)
[444.892531] [114/132] (564s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[444.981869] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[444.983225] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.070375] [115/132] (564s left) gem_exec_balancer (sliced)
[445.113262] Starting subtest: sliced
[446.567867] Subtest sliced: SUCCESS (1.446s)
[446.745677] [116/132] (562s left) syncobj_wait (reset-multiple-signaled)
[446.780212] Starting subtest: reset-multiple-signaled
[446.780956] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[446.852813] [117/132] (562s left) gem_partial_pwrite_pread (writes-after-reads-display)
[446.889800] Starting subtest: writes-after-reads-display
[459.286877] Subtest writes-after-reads-display: SUCCESS (12.397s)
[459.412402] [118/132] (550s left) kms_psr (psr-sprite-mmap-cpu)
[459.501483] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[459.543230] [119/132] (550s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[459.579887] Starting subtest: no-spare-fences-busy
[461.750711] Subtest no-spare-fences-busy: SUCCESS (2.170s)
[461.869443] [120/132] (547s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[473.317757] Starting subtest: gem-execbuf-stress-pc8
[473.403820] Subtest gem-execbuf-stress-pc8: SKIP (0.086s)
[473.525926] [121/132] (536s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[473.617731] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[473.619112] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[473.701787] [122/132] (535s left) kms_cursor_crc (cursor-offscreen-64x21)
[473.792561] Starting subtest: cursor-offscreen-64x21
[473.797863] Starting dynamic subtest: pipe-A-HDMI-A-1
[475.055121] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.257s)
[475.091055] Starting dynamic subtest: pipe-D-HDMI-A-1
[476.305854] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.221s)
[476.306588] Subtest cursor-offscreen-64x21: SUCCESS (2.514s)
[476.442941] [123/132] (533s left) kms_atomic_interruptible (universal-setplane-cursor)
[476.533703] Starting subtest: universal-setplane-cursor
[476.535463] Starting dynamic subtest: pipe-A-HDMI-A-1
[482.728204] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.192s)
[482.728907] Subtest universal-setplane-cursor: SUCCESS (6.195s)
[482.868080] [124/132] (526s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[482.967692] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[483.648502] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.680s)
[483.776951] [125/132] (526s left) sysfs_preempt_timeout (invalid)
[483.814715] Starting subtest: invalid
[483.816472] Starting dynamic subtest: vecs0
[483.817181] Dynamic subtest vecs0: SUCCESS (0.001s)
[483.825121] Starting dynamic subtest: vcs0
[483.825803] Dynamic subtest vcs0: SUCCESS (0.000s)
[483.833429] Starting dynamic subtest: bcs0
[483.834111] Dynamic subtest bcs0: SUCCESS (0.000s)
[483.841518] Starting dynamic subtest: rcs0
[483.842193] Dynamic subtest rcs0: SUCCESS (0.000s)
[483.849812] Starting dynamic subtest: vcs1
[483.850510] Dynamic subtest vcs1: SUCCESS (0.000s)
[483.851187] Subtest invalid: SUCCESS (0.008s)
[483.882896] [126/132] (525s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[483.980782] Starting subtest: x-tiled-64bpp-rotate-180
[485.390451] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.410s)
[485.511936] [127/132] (524s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[485.604722] Starting subtest: psr-rgb101010-draw-blt
[485.606081] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[485.704836] [128/132] (524s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[485.792961] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[485.794341] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[485.851485] [129/132] (524s left) kms_psr (psr-cursor-plane-move)
[485.939805] Subtest psr-cursor-plane-move: SKIP (0.000s)
[485.980749] [130/132] (524s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[486.071873] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[486.073280] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[486.164903] [131/132] (523s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[486.204102] Starting subtest: y-tiled-ccs-to-y-tiled
[486.204806] Starting dynamic subtest: smem
[486.309997] Dynamic subtest smem: SUCCESS (0.105s)
[486.310777] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.106s)
[486.497439] [132/132] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[486.587868] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[486.589246] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[486.695576] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_pm_rpm
results: parsing output: 7/ for test: i915_hangman
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_caching
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: sriov_basic
results: parsing output: 29/ for test: drm_mm
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: kms_atomic_transition
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: core_auth
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_ctx_isolation
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_render_tiled_blits
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_ctx_shared
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: i915_selftest
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gem_wait
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_chamelium_color
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: gem_pwrite
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: gem_mmap_offset
results: parsing output: 74/ for test: kms_selftest
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: kms_plane_lowres
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: gem_sync
results: parsing output: 82/ for test: kms_fence_pin_leak
results: parsing output: 83/ for test: kms_pipe_crc_basic
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_close_race
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: kms_color_pipeline
results: parsing output: 101/ for test: gem_lmem_swapping
results: parsing output: 102/ for test: kms_invalid_mode
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: fbdev
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: kms_pm_rpm
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: gem_partial_pwrite_pread
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_fenced_exec_thrash
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_atomic_interruptible
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: sysfs_preempt_timeout
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.