[87.669504] Initializing watchdogs
[87.669706]   /dev/watchdog0
[87.712780] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.726692] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.733659] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.738573] [001/133] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[87.924346] Starting subtest: flip-vs-cursor-atomic
[105.655592] Subtest flip-vs-cursor-atomic: SUCCESS (17.732s)
[105.943690] [002/133] (942s left) gem_pwrite (basic-self)
[106.037327] Starting subtest: basic-self
[106.277729] Subtest basic-self: SUCCESS (0.240s)
[106.429141] [003/133] (941s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[106.599817] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[106.689422] [004/133] (941s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[106.868783] Starting subtest: psr-rgb101010-draw-render
[106.870663] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[107.042977] [005/133] (941s left) i915_pm_rc6_residency (rc6-accuracy)
[107.135348] Starting subtest: rc6-accuracy
[107.136319] Starting dynamic subtest: gt0
[110.311292] Dynamic subtest gt0: SUCCESS (3.173s)
[110.312180] Subtest rc6-accuracy: SUCCESS (3.176s)
[110.470501] [006/133] (938s left) gem_userptr_blits (forbidden-operations)
[110.581954] Starting subtest: forbidden-operations
[110.582975] Subtest forbidden-operations: SUCCESS (0.002s)
[110.802984] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[110.983365] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[110.985299] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[111.159952] [008/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[111.336271] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[114.154537] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.817s)
[114.440471] [009/133] (934s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[114.534752] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[114.645075] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.109s)
[114.787670] [010/133] (934s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[114.953108] Starting subtest: cursorA-vs-flipA-atomic
[126.213639] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.261s)
[126.493406] [011/133] (922s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[126.656732] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[126.657659] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.667305] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[126.684673] Starting dynamic subtest: pipe-A-HDMI-A-2
[126.693815] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[126.711201] Starting dynamic subtest: pipe-B-HDMI-A-1
[126.720557] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[126.739802] Starting dynamic subtest: pipe-B-HDMI-A-2
[126.748821] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[126.766023] Starting dynamic subtest: pipe-C-HDMI-A-1
[126.774420] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[126.791635] Starting dynamic subtest: pipe-C-HDMI-A-2
[126.800963] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[126.802803] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.016s)
[127.549445] [012/133] (921s left) kms_flip (2x-flip-vs-wf_vblank)
[127.715911] Starting subtest: 2x-flip-vs-wf_vblank
[127.717423] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[129.386288] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.667s)
[129.404884] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[131.014145] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.625s)
[131.032932] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[132.612924] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.597s)
[132.613850] Subtest 2x-flip-vs-wf_vblank: SUCCESS (4.900s)
[133.185787] [013/133] (915s left) kms_addfb_basic (small-bo)
[133.356113] Starting subtest: small-bo
[133.357128] Subtest small-bo: SUCCESS (0.000s)
[133.527478] [014/133] (915s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[133.688854] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[133.692068] Starting dynamic subtest: pipe-A-valid-mode
[134.221130] Dynamic subtest pipe-A-valid-mode: SKIP (0.529s)
[134.223430] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.531s)
[134.671474] [015/133] (914s left) gem_madvise (dontneed-before-mmap)
[134.759597] Starting subtest: dontneed-before-mmap
[134.774609] Subtest dontneed-before-mmap: SUCCESS (0.014s)
[134.941775] [016/133] (914s left) kms_atomic (plane-primary-legacy)
[135.112103] Starting subtest: plane-primary-legacy
[135.113050] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.710225] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.597s)
[135.711141] Subtest plane-primary-legacy: SUCCESS (0.600s)
[136.003133] [017/133] (913s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[136.178847] Starting subtest: blocking-absolute-wf_vblank-interruptible
[136.181913] Starting dynamic subtest: A-HDMI-A1
[141.944249] Dynamic subtest A-HDMI-A1: SUCCESS (5.761s)
[141.961537] Starting dynamic subtest: B-HDMI-A1
[147.303627] Dynamic subtest B-HDMI-A1: SUCCESS (5.358s)
[147.321534] Starting dynamic subtest: C-HDMI-A1
[152.666690] Dynamic subtest C-HDMI-A1: SUCCESS (5.360s)
[152.687397] Starting dynamic subtest: A-HDMI-A2
[158.047728] Dynamic subtest A-HDMI-A2: SUCCESS (5.377s)
[158.066795] Starting dynamic subtest: B-HDMI-A2
[163.407141] Dynamic subtest B-HDMI-A2: SUCCESS (5.356s)
[163.426812] Starting dynamic subtest: C-HDMI-A2
[168.768291] Dynamic subtest C-HDMI-A2: SUCCESS (5.357s)
[168.769216] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (32.585s)
[169.233703] [018/133] (880s left) kms_cursor_edge_walk (64x64-top-bottom)
[169.400411] Starting subtest: 64x64-top-bottom
[169.401321] Starting dynamic subtest: pipe-A-HDMI-A-1
[173.189392] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.788s)
[173.209432] Starting dynamic subtest: pipe-C-HDMI-A-1
[176.590483] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.396s)
[176.591529] Subtest 64x64-top-bottom: SUCCESS (7.192s)
[176.856849] [019/133] (872s left) kms_addfb_basic (invalid-get-prop-any)
[176.950298] Starting subtest: invalid-get-prop-any
[176.951225] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[177.189165] [020/133] (872s left) gem_mmap_gtt (fault-concurrent-y)
[177.279930] Starting subtest: fault-concurrent-Y
[180.761275] Subtest fault-concurrent-Y: SUCCESS (3.476s)
[181.048298] [021/133] (868s left) gem_busy (semaphore)
[181.298647] Starting subtest: semaphore
[181.299783] Starting dynamic subtest: rcs0
[181.341879] Dynamic subtest rcs0: SUCCESS (0.042s)
[181.364902] Starting dynamic subtest: bcs0
[181.377920] Dynamic subtest bcs0: SUCCESS (0.034s)
[181.399580] Starting dynamic subtest: vcs0
[181.408480] Dynamic subtest vcs0: SUCCESS (0.028s)
[181.427440] Starting dynamic subtest: vecs0
[181.428382] Dynamic subtest vecs0: SUCCESS (0.020s)
[181.429508] Subtest semaphore: SUCCESS (0.132s)
[181.732607] [022/133] (868s left) kms_vblank (query-forked-busy-hang)
[181.900367] Starting subtest: query-forked-busy-hang
[181.901314] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.914629] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.012s)
[188.947716] Starting dynamic subtest: pipe-A-HDMI-A-2
[195.886499] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.962s)
[195.931427] Starting dynamic subtest: pipe-C-HDMI-A-1
[202.907775] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.013s)
[202.929977] Starting dynamic subtest: pipe-C-HDMI-A-2
[209.892580] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.980s)
[209.896023] Subtest query-forked-busy-hang: SUCCESS (27.993s)
[210.193434] [023/133] (839s left) kms_prop_blob (invalid-set-prop)
[210.285478] Starting subtest: invalid-set-prop
[210.286536] Subtest invalid-set-prop: SUCCESS (0.000s)
[210.449606] [024/133] (839s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[210.616688] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[210.621050] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[210.759233] [025/133] (839s left) kms_lease (multimaster-lease)
[210.926901] Starting subtest: multimaster-lease
[210.932643] Subtest multimaster-lease: SUCCESS (0.005s)
[211.074740] [026/133] (839s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[211.166370] Starting subtest: invalid-smem-bo-on-discrete
[211.168190] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[211.429595] [027/133] (838s left) gem_userptr_blits (dmabuf-unsync)
[211.535384] Subtest dmabuf-unsync: SKIP (0.000s)
[211.769917] [028/133] (838s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[211.961210] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[213.570175] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.609s)
[213.844418] [029/133] (836s left) gem_ringfill (legacy-basic)
[214.248612] Starting subtest: legacy-basic
[214.249810] Starting dynamic subtest: default
[214.267693] Dynamic subtest default: SUCCESS (0.018s)
[214.291726] Starting dynamic subtest: render
[214.292745] Dynamic subtest render: SUCCESS (0.017s)
[214.312623] Starting dynamic subtest: bsd
[214.313683] Dynamic subtest bsd: SUCCESS (0.022s)
[214.334348] Starting dynamic subtest: bsd1
[214.336019] Dynamic subtest bsd1: SUCCESS (0.021s)
[214.361070] Starting dynamic subtest: blt
[214.362477] Dynamic subtest blt: SUCCESS (0.023s)
[214.381984] Starting dynamic subtest: vebox
[214.383339] Dynamic subtest vebox: SUCCESS (0.018s)
[214.384786] Subtest legacy-basic: SUCCESS (0.133s)
[214.545577] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[214.549958] [030/133] (835s left) gem_vm_create (invalid-create)
[214.653578] Starting subtest: invalid-create
[214.654670] Subtest invalid-create: SUCCESS (0.000s)
[214.838729] [031/133] (835s left) gen9_exec_parse (batch-invalid-length)
[214.956093] Starting subtest: batch-invalid-length
[214.965130] Subtest batch-invalid-length: SUCCESS (0.009s)
[215.273584] [032/133] (835s left) gem_exec_schedule (submit-early-slice)
[215.401468] Starting subtest: submit-early-slice
[215.402386] Starting dynamic subtest: rcs0
[215.457900] Dynamic subtest rcs0: SUCCESS (0.056s)
[215.481318] Starting dynamic subtest: bcs0
[215.510848] Dynamic subtest bcs0: SUCCESS (0.051s)
[215.534528] Starting dynamic subtest: vcs0
[215.564552] Dynamic subtest vcs0: SUCCESS (0.051s)
[215.587847] Starting dynamic subtest: vecs0
[215.613436] Dynamic subtest vecs0: SUCCESS (0.047s)
[215.614789] Subtest submit-early-slice: SUCCESS (0.214s)
[216.072750] [033/133] (834s left) gem_lmem_swapping (massive-random)
[216.174985] Subtest massive-random: SKIP (0.000s)
[216.286846] [034/133] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[216.464788] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[216.466592] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.636871] [035/133] (834s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[216.818892] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[216.821017] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[217.003021] [036/133] (834s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[217.167251] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[217.169729] Starting dynamic subtest: pipe-A
[218.253342] Dynamic subtest pipe-A: SUCCESS (1.087s)
[218.276301] Starting dynamic subtest: pipe-B
[219.315247] Dynamic subtest pipe-B: SUCCESS (1.060s)
[219.335324] Starting dynamic subtest: pipe-C
[220.378517] Dynamic subtest pipe-C: SUCCESS (1.062s)
[220.379863] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.214s)
[220.873804] [037/133] (830s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[220.983193] Starting subtest: saturated-hostile-nopreempt
[220.984313] Starting dynamic subtest: rcs0
[221.737351] Dynamic subtest rcs0: SUCCESS (0.752s)
[221.757728] Starting dynamic subtest: bcs0
[222.494485] Dynamic subtest bcs0: SUCCESS (0.754s)
[222.517400] Starting dynamic subtest: vcs0
[223.261025] Dynamic subtest vcs0: SUCCESS (0.765s)
[223.281211] Starting dynamic subtest: vecs0
[224.014822] Dynamic subtest vecs0: SUCCESS (0.754s)
[224.018890] Subtest saturated-hostile-nopreempt: SUCCESS (3.033s)
[224.216973] [038/133] (827s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[224.384569] Starting subtest: sprite-rotation-90-pos-100-0
[239.727763] Subtest sprite-rotation-90-pos-100-0: SUCCESS (15.345s)
[240.009826] [039/133] (811s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[240.196887] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[240.413588] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.217s)
[240.677925] [040/133] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[240.845248] Starting subtest: compare-crc-sanitycheck-xr24
[240.846183] Starting dynamic subtest: pipe-A-HDMI-A-1
[241.694968] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.847s)
[241.725491] Starting dynamic subtest: pipe-B-HDMI-A-2
[242.245572] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.540s)
[242.266983] Starting dynamic subtest: pipe-C-HDMI-A-1
[242.798225] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.547s)
[242.799298] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.954s)
[243.103933] [041/133] (808s left) kms_tv_load_detect (load-detect)
[243.196324] Subtest load-detect: SKIP (0.000s)
[243.307130] [042/133] (808s left) gem_softpin (safe-alignment)
[243.413035] Starting subtest: safe-alignment
[243.438700] Subtest safe-alignment: SUCCESS (0.026s)
[243.638965] [043/133] (808s left) gem_ctx_sseu (invalid-args)
[243.737453] Subtest invalid-args: SKIP (0.000s)
[243.838475] [044/133] (807s left) gem_exec_reloc (basic-wc-noreloc)
[243.944817] Starting subtest: basic-wc-noreloc
[243.953345] Subtest basic-wc-noreloc: SUCCESS (0.008s)
[244.187137] [045/133] (807s left) gem_exec_balancer (individual)
[244.302064] Starting subtest: individual
[248.454330] Subtest individual: SUCCESS (4.152s)
[248.787430] [046/133] (803s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[248.951898] Starting subtest: fb-8bpc-vs-panel-8bpc
[248.952853] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.699507] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.745s)
[249.721366] Starting dynamic subtest: pipe-A-HDMI-A-2
[250.148248] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.444s)
[250.149389] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.198s)
[250.426574] [047/133] (801s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[250.532111] Starting subtest: basic-gtt-wc-noreloc
[250.540230] Subtest basic-gtt-wc-noreloc: SUCCESS (0.009s)
[250.776553] [048/133] (801s left) kms_fence_pin_leak
[254.103178] [049/133] (798s left) i915_pm_rps (thresholds-idle)
[254.210514] Starting subtest: thresholds-idle
[254.211504] Starting dynamic subtest: gt0
[264.679864] Dynamic subtest gt0: SUCCESS (10.467s)
[264.683137] Subtest thresholds-idle: SUCCESS (10.472s)
[264.839325] [050/133] (787s left) core_setmaster (master-drop-set-root)
[265.035147] Starting subtest: master-drop-set-root
[265.055378] Subtest master-drop-set-root: SUCCESS (0.019s)
[265.156243] [051/133] (787s left) gem_exec_store (pages)
[265.271116] Starting subtest: pages
[265.272088] Starting dynamic subtest: rcs0
[265.372197] Dynamic subtest rcs0: SUCCESS (0.101s)
[265.394710] Starting dynamic subtest: bcs0
[265.451792] Dynamic subtest bcs0: SUCCESS (0.077s)
[265.475081] Starting dynamic subtest: vcs0
[265.536546] Dynamic subtest vcs0: SUCCESS (0.082s)
[265.565680] Starting dynamic subtest: vecs0
[265.645589] Dynamic subtest vecs0: SUCCESS (0.106s)
[265.649236] Subtest pages: SUCCESS (0.378s)
[265.906516] [052/133] (786s left) kms_flip (2x-plain-flip)
[266.072130] Starting subtest: 2x-plain-flip
[266.075186] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[267.458927] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.383s)
[267.481703] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[268.787899] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.325s)
[268.813122] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[270.116328] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.321s)
[270.118113] Subtest 2x-plain-flip: SUCCESS (4.044s)
[270.697428] [053/133] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[270.884986] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[273.809476] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (2.923s)
[274.066334] [054/133] (778s left) syncobj_timeline (invalid-query-illegal-handle)
[274.165206] Starting subtest: invalid-query-illegal-handle
[274.167081] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[274.330355] [055/133] (778s left) kms_psr (pr-primary-page-flip)
[274.497285] Subtest pr-primary-page-flip: SKIP (0.000s)
[274.604984] [056/133] (778s left) kms_fb_coherency (memset-crc)
[274.769128] Starting subtest: memset-crc
[274.770297] Starting dynamic subtest: mmap-gtt
[275.460290] Dynamic subtest mmap-gtt: SUCCESS (0.689s)
[275.697039] Starting dynamic subtest: mmap-offset-wc
[276.078684] Dynamic subtest mmap-offset-wc: SUCCESS (0.402s)
[276.298785] Starting dynamic subtest: mmap-offset-uc
[277.098332] Dynamic subtest mmap-offset-uc: SUCCESS (0.821s)
[277.323800] Starting dynamic subtest: mmap-legacy-wc
[277.724448] Dynamic subtest mmap-legacy-wc: SUCCESS (0.418s)
[277.925484] Subtest memset-crc: SUCCESS (3.156s)
[278.217869] [057/133] (774s left) api_intel_bb (reset-flags)
[278.311967] Starting subtest: reset-flags
[278.330166] Subtest reset-flags: SUCCESS (0.020s)
[278.503841] [058/133] (774s left) gem_ctx_isolation (preservation-reset)
[278.726835] Starting subtest: preservation-reset
[278.727927] Starting dynamic subtest: rcs0
[279.790603] Dynamic subtest rcs0: SUCCESS (1.065s)
[279.813805] Starting dynamic subtest: bcs0
[281.015947] Dynamic subtest bcs0: SUCCESS (1.223s)
[281.039845] Starting dynamic subtest: vcs0
[281.968258] Dynamic subtest vcs0: SUCCESS (0.950s)
[281.991828] Starting dynamic subtest: vecs0
[282.937741] Dynamic subtest vecs0: SUCCESS (0.967s)
[282.941586] Subtest preservation-reset: SUCCESS (4.216s)
[283.139313] [059/133] (770s left) sw_sync (timeline_closed)
[283.235815] Starting subtest: timeline_closed
[283.236834] Subtest timeline_closed: SUCCESS (0.000s)
[283.375887] [060/133] (769s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[283.543876] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[284.412238] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.870s)
[284.714688] [061/133] (768s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[284.892563] Starting subtest: fbcpsr-rgb565-draw-pwrite
[284.894427] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[285.063790] [062/133] (768s left) gem_mmap_gtt (basic-small-copy-xy)
[285.159672] Starting subtest: basic-small-copy-XY
[288.211202] Subtest basic-small-copy-XY: SUCCESS (3.051s)
[288.389681] [063/133] (765s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[288.680267] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[288.682079] Starting dynamic subtest: pipe-A-HDMI-A-1
[288.718511] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.010s)
[288.739160] Starting dynamic subtest: pipe-A-HDMI-A-2
[288.775533] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.010s)
[288.796161] Starting dynamic subtest: pipe-B-HDMI-A-1
[288.867820] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.010s)
[288.887878] Starting dynamic subtest: pipe-B-HDMI-A-2
[288.923199] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.010s)
[288.943824] Starting dynamic subtest: pipe-C-HDMI-A-1
[288.980894] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.010s)
[289.001534] Starting dynamic subtest: pipe-C-HDMI-A-2
[289.040977] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.010s)
[289.042897] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.091s)
[289.675549] [064/133] (763s left) kms_psr (psr-cursor-mmap-gtt)
[289.846794] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[289.954580] [065/133] (763s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[290.135946] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[290.138815] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[290.309126] [066/133] (763s left) gem_exec_schedule (preempt-queue-chain)
[290.447121] Starting subtest: preempt-queue-chain
[290.450288] Starting dynamic subtest: rcs0
[290.829954] Dynamic subtest rcs0: SUCCESS (0.382s)
[290.860920] Starting dynamic subtest: bcs0
[291.202456] Dynamic subtest bcs0: SUCCESS (0.370s)
[291.235929] Starting dynamic subtest: vcs0
[291.580075] Dynamic subtest vcs0: SUCCESS (0.372s)
[291.606262] Starting dynamic subtest: vecs0
[291.946228] Dynamic subtest vecs0: SUCCESS (0.362s)
[291.948895] Subtest preempt-queue-chain: SUCCESS (1.500s)
[292.398861] [067/133] (761s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[292.503211] Starting subtest: invalid-bsd2-flag-on-blt
[292.504457] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[292.681302] [068/133] (761s left) gem_lmem_swapping (random)
[292.785889] Subtest random: SKIP (0.000s)
[292.889553] [069/133] (761s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[293.077250] Starting subtest: y-tiled-64bpp-rotate-90
[293.359118] Subtest y-tiled-64bpp-rotate-90: SKIP (0.278s)
[293.625927] [070/133] (760s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[293.802719] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[293.804761] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[293.975461] [071/133] (760s left) gem_tiled_blits (normal)
[294.189425] Starting subtest: normal
[336.141027] Subtest normal: SUCCESS (41.960s)
[336.336588] [072/133] (718s left) vgem_basic (create)
[336.510463] Starting subtest: create
[336.511412] Subtest create: SUCCESS (0.001s)
[336.661804] [073/133] (717s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[336.861687] Starting subtest: 4-tiled-64bpp-rotate-0
[336.863564] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.001s)
[337.023786] [074/133] (717s left) sysfs_preempt_timeout (invalid)
[337.128617] Starting subtest: invalid
[337.132342] Starting dynamic subtest: vecs0
[337.133457] Dynamic subtest vecs0: SUCCESS (0.001s)
[337.155066] Starting dynamic subtest: vcs0
[337.157472] Dynamic subtest vcs0: SUCCESS (0.001s)
[337.182944] Starting dynamic subtest: bcs0
[337.184809] Dynamic subtest bcs0: SUCCESS (0.001s)
[337.212082] Starting dynamic subtest: rcs0
[337.213820] Dynamic subtest rcs0: SUCCESS (0.001s)
[337.215225] Subtest invalid: SUCCESS (0.019s)
[337.313957] [075/133] (717s left) kms_scaling_modes (scaling-mode-full-aspect)
[337.480186] Starting subtest: scaling-mode-full-aspect
[337.487204] Subtest scaling-mode-full-aspect: SKIP (0.003s)
[337.656783] [076/133] (717s left) gem_create (create-ext-cpu-access-sanity-check)
[337.869273] Starting subtest: create-ext-cpu-access-sanity-check
[337.871337] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[338.043472] [077/133] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[338.227592] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[338.229522] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[338.391594] [078/133] (716s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[338.560294] Starting subtest: bad-pixel-format-yf-tiled-ccs
[338.561194] Starting dynamic subtest: pipe-A-HDMI-A-1
[338.568632] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[338.590344] Starting dynamic subtest: pipe-A-HDMI-A-2
[338.597795] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[338.619107] Starting dynamic subtest: pipe-B-HDMI-A-1
[338.626525] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[338.647629] Starting dynamic subtest: pipe-B-HDMI-A-2
[338.661049] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[338.682111] Starting dynamic subtest: pipe-C-HDMI-A-1
[338.690948] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[338.711577] Starting dynamic subtest: pipe-C-HDMI-A-2
[338.720297] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[338.721207] Subtest bad-pixel-format-yf-tiled-ccs: SUCCESS (0.033s)
[339.483419] [079/133] (715s left) gem_exec_parallel (userptr)
[339.595842] Starting subtest: userptr
[339.597045] Starting dynamic subtest: rcs0
[342.482905] Dynamic subtest rcs0: SUCCESS (2.886s)
[342.507454] Starting dynamic subtest: bcs0
[345.819815] Dynamic subtest bcs0: SUCCESS (3.334s)
[345.845448] Starting dynamic subtest: vcs0
[349.047308] Dynamic subtest vcs0: SUCCESS (3.224s)
[349.074620] Starting dynamic subtest: vecs0
[351.913050] Dynamic subtest vecs0: SUCCESS (2.862s)
[351.918218] Subtest userptr: SUCCESS (12.320s)
[352.205635] [080/133] (702s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[352.377238] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[352.502854] [081/133] (702s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[352.674889] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[352.675848] Starting dynamic subtest: pipe-A
[352.996142] Dynamic subtest pipe-A: SUCCESS (0.322s)
[353.020068] Starting dynamic subtest: pipe-B
[353.372727] Dynamic subtest pipe-B: SUCCESS (0.374s)
[353.396522] Starting dynamic subtest: pipe-C
[353.424881] Dynamic subtest pipe-C: SUCCESS (0.048s)
[353.425955] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.752s)
[353.871882] [082/133] (701s left) kms_chamelium_frames (hdmi-crc-single)
[354.397949] Subtest hdmi-crc-single: SKIP (0.000s)
[354.639467] [083/133] (700s left) gem_exec_fence (syncobj-channel)
[355.228427] Starting subtest: syncobj-channel
[356.273657] Subtest syncobj-channel: SUCCESS (1.047s)
[356.713464] [084/133] (698s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[356.881955] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[356.883787] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[357.547609] [085/133] (698s left) syncobj_timeline (multi-wait-available-submitted)
[357.652934] Starting subtest: multi-wait-available-submitted
[357.656215] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[357.836375] [086/133] (697s left) gem_exec_flush (basic-wb-rw-before-default)
[357.951404] Starting subtest: basic-wb-rw-before-default
[363.398917] Subtest basic-wb-rw-before-default: SUCCESS (5.448s)
[363.683986] [087/133] (692s left) i915_drm_fdinfo (most-busy-idle-check-all)
[363.785156] Starting subtest: most-busy-idle-check-all
[363.786466] Starting dynamic subtest: rcs0
[364.426034] Dynamic subtest rcs0: SUCCESS (0.640s)
[364.459356] Starting dynamic subtest: bcs0
[365.063179] Dynamic subtest bcs0: SUCCESS (0.634s)
[365.095150] Starting dynamic subtest: vcs0
[365.701076] Dynamic subtest vcs0: SUCCESS (0.634s)
[365.731604] Starting dynamic subtest: vecs0
[366.338285] Dynamic subtest vecs0: SUCCESS (0.634s)
[366.344468] Subtest most-busy-idle-check-all: SUCCESS (2.555s)
[366.516393] [088/133] (689s left) kms_pm_rpm (system-suspend-modeset)
[368.339209] Starting subtest: system-suspend-modeset
[387.049708] Subtest system-suspend-modeset: SUCCESS (2.371s)
[395.165258] [089/133] (668s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[395.287294] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[395.288269] Starting dynamic subtest: smem
[395.644069] Dynamic subtest smem: SUCCESS (0.357s)
[395.648133] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.360s)
[395.929263] [090/133] (668s left) kms_sequence (get-busy)
[396.097631] Starting subtest: get-busy
[396.098986] Starting dynamic subtest: pipe-A-HDMI-A-1
[399.001031] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.850s)
[399.031069] Starting dynamic subtest: pipe-A-HDMI-A-2
[401.629840] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.595s)
[401.658216] Starting dynamic subtest: pipe-B-HDMI-A-1
[404.226892] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.568s)
[404.255221] Starting dynamic subtest: pipe-B-HDMI-A-2
[406.815436] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.568s)
[406.842794] Starting dynamic subtest: pipe-C-HDMI-A-1
[409.415795] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.583s)
[409.443898] Starting dynamic subtest: pipe-C-HDMI-A-2
[411.998834] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.571s)
[411.999768] Subtest get-busy: SUCCESS (15.765s)
[412.289304] [091/133] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[412.471167] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[412.473151] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[412.657511] [092/133] (651s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[412.825548] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[412.936608] [093/133] (651s left) kms_rotation_crc (exhaust-fences)
[413.100551] Starting subtest: exhaust-fences
[416.073257] Subtest exhaust-fences: SUCCESS (2.968s)
[416.333414] [094/133] (648s left) kms_flip (absolute-wf_vblank)
[416.502872] Starting subtest: absolute-wf_vblank
[416.507111] Starting dynamic subtest: A-HDMI-A1
[422.130961] Dynamic subtest A-HDMI-A1: SUCCESS (5.615s)
[422.161181] Starting dynamic subtest: B-HDMI-A1
[427.510261] Dynamic subtest B-HDMI-A1: SUCCESS (5.371s)
[427.537826] Starting dynamic subtest: C-HDMI-A1
[432.893238] Dynamic subtest C-HDMI-A1: SUCCESS (5.376s)
[432.918208] Starting dynamic subtest: A-HDMI-A2
[438.283341] Dynamic subtest A-HDMI-A2: SUCCESS (5.387s)
[438.312565] Starting dynamic subtest: B-HDMI-A2
[443.667254] Dynamic subtest B-HDMI-A2: SUCCESS (5.377s)
[443.698900] Starting dynamic subtest: C-HDMI-A2
[449.043139] Dynamic subtest C-HDMI-A2: SUCCESS (5.368s)
[449.044628] Subtest absolute-wf_vblank: SUCCESS (32.523s)
[449.540131] [095/133] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[449.723163] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[449.726150] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[449.888573] [096/133] (614s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[450.077416] Starting subtest: cursor-rapid-movement-max-size
[450.080151] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[450.239654] [097/133] (614s left) kms_properties (crtc-properties-atomic)
[450.404992] Starting subtest: crtc-properties-atomic
[450.406454] Starting dynamic subtest: pipe-A-HDMI-A-1
[450.965989] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.551s)
[450.990628] Starting dynamic subtest: pipe-B-HDMI-A-2
[451.390909] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.425s)
[451.420206] Starting dynamic subtest: pipe-C-HDMI-A-1
[451.812997] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.414s)
[451.814173] Subtest crtc-properties-atomic: SUCCESS (1.405s)
[452.110688] [098/133] (612s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[452.278358] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[452.279289] Starting dynamic subtest: pipe-A-valid-mode
[453.075739] Dynamic subtest pipe-A-valid-mode: SKIP (0.795s)
[453.077516] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.800s)
[453.562460] [099/133] (611s left) api_intel_allocator (simple-allocator)
[453.656755] Starting subtest: simple-allocator
[453.657688] Starting dynamic subtest: basic
[453.663031] Dynamic subtest basic: SUCCESS (0.006s)
[453.691322] Starting dynamic subtest: parallel-one
[454.078089] Dynamic subtest parallel-one: SUCCESS (0.412s)
[454.108018] Starting dynamic subtest: print
[454.109005] Dynamic subtest print: SUCCESS (0.000s)
[454.135830] Starting dynamic subtest: reuse
[454.137143] Dynamic subtest reuse: SUCCESS (0.000s)
[454.165428] Starting dynamic subtest: reserve
[454.168024] Dynamic subtest reserve: SUCCESS (0.000s)
[454.192508] Starting dynamic subtest: fork-reopen-allocator
[454.193909] Dynamic subtest fork-reopen-allocator: SUCCESS (0.029s)
[454.195172] Subtest simple-allocator: SUCCESS (0.466s)
[454.321378] [100/133] (610s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[454.487767] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[454.491937] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[454.638160] [101/133] (610s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[454.818115] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[458.417610] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.597s)
[458.676238] [102/133] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[458.858226] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[461.419368] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.560s)
[461.695009] [103/133] (603s left) drm_read (empty-block)
[462.105199] Starting subtest: empty-block
[463.107902] Subtest empty-block: SUCCESS (1.000s)
[463.408898] [104/133] (602s left) gem_mmap_gtt (basic-write-read-distinct)
[463.504073] Starting subtest: basic-write-read-distinct
[463.531583] Subtest basic-write-read-distinct: SUCCESS (0.029s)
[463.728256] [105/133] (601s left) kms_setmode (invalid-clone-single-crtc)
[463.823386] Starting subtest: invalid-clone-single-crtc
[464.254668] Starting dynamic subtest: pipe-A-HDMI-A-1-HDMI-A-2
[464.297470] Dynamic subtest pipe-A-HDMI-A-1-HDMI-A-2: SUCCESS (0.041s)
[464.349120] Starting dynamic subtest: pipe-B-HDMI-A-1-HDMI-A-2
[464.366086] Dynamic subtest pipe-B-HDMI-A-1-HDMI-A-2: SUCCESS (0.038s)
[464.370387] Subtest invalid-clone-single-crtc: SUCCESS (0.547s)
[464.674629] [106/133] (600s left) gem_exec_capture (capture-invisible)
[464.779791] Starting subtest: capture-invisible
[464.781665] Starting dynamic subtest: smem0
[464.784072] Dynamic subtest smem0: SKIP (0.000s)
[464.786260] Subtest capture-invisible: SKIP (0.003s)
[464.976735] [107/133] (600s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[465.074368] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[465.078221] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.002s)
[465.260784] [108/133] (600s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[465.442598] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[466.936075] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.491s)
[467.226735] [109/133] (598s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[467.408573] Starting subtest: fbc-rgb565-draw-mmap-cpu
[470.137354] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.726s)
[470.427324] [110/133] (595s left) i915_pm_freq_api (freq-suspend)
[470.529260] Subtest freq-suspend: SKIP (0.000s)
[470.641615] [111/133] (595s left) kms_cursor_crc (cursor-offscreen-64x64)
[470.812009] Starting subtest: cursor-offscreen-64x64
[470.849843] Starting dynamic subtest: pipe-A-HDMI-A-1
[473.691300] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.836s)
[473.776716] Starting dynamic subtest: pipe-C-HDMI-A-1
[476.280889] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.527s)
[476.286528] Subtest cursor-offscreen-64x64: SUCCESS (5.471s)
[476.627394] [112/133] (589s left) kms_color (ctm-0-25)
[476.795200] Starting subtest: ctm-0-25
[476.796118] Starting dynamic subtest: pipe-A-HDMI-A-1
[478.938831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.115s)
[478.964334] Starting dynamic subtest: pipe-A-HDMI-A-2
[480.773528] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.854s)
[480.803392] Starting dynamic subtest: pipe-B-HDMI-A-1
[482.578885] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.804s)
[482.604026] Starting dynamic subtest: pipe-B-HDMI-A-2
[484.381698] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.797s)
[484.407121] Starting dynamic subtest: pipe-C-HDMI-A-1
[486.207318] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.825s)
[486.248033] Starting dynamic subtest: pipe-C-HDMI-A-2
[488.007926] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.798s)
[488.008966] Subtest ctm-0-25: SUCCESS (11.209s)
[488.334277] [113/133] (577s left) drm_read (fault-buffer)
[488.748747] Starting subtest: fault-buffer
[488.749841] Subtest fault-buffer: SUCCESS (0.002s)
[489.035693] [114/133] (577s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[489.201742] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[489.202888] Starting dynamic subtest: pipe-A-HDMI-A-1
[489.210671] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[489.236805] Starting dynamic subtest: pipe-A-HDMI-A-2
[489.245308] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[489.270635] Starting dynamic subtest: pipe-B-HDMI-A-1
[489.278157] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[489.306040] Starting dynamic subtest: pipe-B-HDMI-A-2
[489.334177] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[489.358300] Starting dynamic subtest: pipe-C-HDMI-A-1
[489.367332] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[489.391625] Starting dynamic subtest: pipe-C-HDMI-A-2
[489.400816] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[489.401742] Subtest ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.036s)
[490.161650] [115/133] (576s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[490.344210] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[490.346199] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[490.513453] [116/133] (576s left) kms_chamelium_hpd (common-hpd-after-suspend)
[491.040979] Subtest common-hpd-after-suspend: SKIP (0.000s)
[491.286854] [117/133] (575s left) kms_content_protection (uevent)
[491.483692] Starting subtest: uevent
[491.518166] Subtest uevent: SKIP (0.027s)
[491.704669] [118/133] (575s left) kms_pm_lpsp (kms-lpsp)
[492.876968] Starting subtest: kms-lpsp
[492.878601] Subtest kms-lpsp: SKIP (0.001s)
[493.035272] [119/133] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[493.212860] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[495.262459] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SUCCESS (2.050s)
[495.521275] [120/133] (571s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[495.689251] Starting subtest: flip-vs-cursor-varying-size
[518.442189] Subtest flip-vs-cursor-varying-size: SUCCESS (22.753s)
[518.746350] [121/133] (548s left) perf_pmu (busy-accuracy-50)
[518.850474] Starting subtest: busy-accuracy-50
[518.851481] Starting dynamic subtest: rcs0
[520.402823] Dynamic subtest rcs0: SUCCESS (1.548s)
[520.428425] Starting dynamic subtest: bcs0
[521.953158] Dynamic subtest bcs0: SUCCESS (1.548s)
[521.981740] Starting dynamic subtest: vcs0
[523.501138] Dynamic subtest vcs0: SUCCESS (1.547s)
[523.530429] Starting dynamic subtest: vecs0
[525.053439] Dynamic subtest vecs0: SUCCESS (1.549s)
[525.054681] Subtest busy-accuracy-50: SUCCESS (6.204s)
[525.232427] [122/133] (541s left) prime_vgem (wait)
[525.354898] Starting subtest: wait
[525.358372] Starting dynamic subtest: rcs0
[525.388096] Dynamic subtest rcs0: SUCCESS (0.032s)
[525.419284] Starting dynamic subtest: vcs0
[525.420480] Dynamic subtest vcs0: SUCCESS (0.011s)
[525.444868] Starting dynamic subtest: vecs0
[525.445717] Dynamic subtest vecs0: SUCCESS (0.009s)
[525.446815] Subtest wait: SUCCESS (0.061s)
[525.616873] [123/133] (541s left) kms_psr (fbc-pr-basic)
[525.784641] Subtest fbc-pr-basic: SKIP (0.000s)
[525.892553] [124/133] (541s left) gem_userptr_blits (sync-overlap)
[526.016811] Starting subtest: sync-overlap
[526.017934] Subtest sync-overlap: SUCCESS (0.000s)
[526.215061] [125/133] (541s left) perf (oa-exponents)
[526.473191] Starting subtest: oa-exponents
[526.474091] Starting dynamic subtest: 0-rcs0
[530.446014] Dynamic subtest 0-rcs0: SUCCESS (3.973s)
[530.449959] Subtest oa-exponents: SUCCESS (3.976s)
[530.554377] [126/133] (536s left) vgem_basic (dmabuf-export)
[530.663201] Starting subtest: dmabuf-export
[530.668902] Subtest dmabuf-export: SUCCESS (0.004s)
[530.849548] [127/133] (536s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[531.031577] Starting subtest: yf-tiled-64bpp-rotate-90
[531.033304] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[531.251482] [128/133] (536s left) kms_hdr (invalid-metadata-sizes)
[531.421116] Starting subtest: invalid-metadata-sizes
[558.537066] Subtest invalid-metadata-sizes: SKIP (27.113s)
[558.994060] [129/133] (508s left) kms_joiner (invalid-modeset-ultra-joiner)
[559.196534] Starting subtest: invalid-modeset-ultra-joiner
[559.198783] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[559.370410] [130/133] (508s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[559.471838] Starting subtest: rel-constants-invalid-rel-gen5
[559.472989] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s)
[559.674717] [131/133] (508s left) perf_pmu (busy-start)
[559.777195] Starting subtest: busy-start
[559.778040] Starting dynamic subtest: rcs0
[562.303615] Dynamic subtest rcs0: SUCCESS (2.526s)
[562.345731] Starting dynamic subtest: bcs0
[564.831969] Dynamic subtest bcs0: SUCCESS (2.524s)
[564.863907] Starting dynamic subtest: vcs0
[567.362472] Dynamic subtest vcs0: SUCCESS (2.526s)
[567.395978] Starting dynamic subtest: vecs0
[569.889141] Dynamic subtest vecs0: SUCCESS (2.523s)
[569.893895] Subtest busy-start: SUCCESS (10.113s)
[570.101782] [132/133] (498s left) syncobj_timeline (wait-all-delayed-signal)
[570.199187] Starting subtest: wait-all-delayed-signal
[570.302450] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[570.458811] [133/133] (497s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[570.638876] Starting subtest: psr-2p-primscrn-cur-indfb-move
[570.640737] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[570.837923] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: gem_pwrite
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: i915_pm_rc6_residency
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_madvise
results: parsing output: 15/ for test: kms_atomic
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_cursor_edge_walk
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: gem_busy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_prop_blob
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ringfill
results: parsing output: 29/ for test: gem_vm_create
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_tv_load_detect
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_ctx_sseu
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_dither
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_fence_pin_leak
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: core_setmaster
results: parsing output: 50/ for test: gem_exec_store
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_fb_coherency
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: gem_ctx_isolation
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_tiled_blits
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: sysfs_preempt_timeout
results: parsing output: 74/ for test: kms_scaling_modes
results: parsing output: 75/ for test: gem_create
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_parallel
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_sequence
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: drm_read
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_setmode
results: parsing output: 105/ for test: gem_exec_capture
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_pm_freq_api
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_color
results: parsing output: 112/ for test: drm_read
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_pm_lpsp
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: kms_joiner
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.