[56.186757] Initializing watchdogs
[56.186806]   /dev/watchdog0
[56.203699] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.208051] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.210358] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.213688] [001/131] (960s left) kms_atomic (atomic-invalid-params)
[56.337822] Starting subtest: atomic-invalid-params
[56.340085] Starting dynamic subtest: pipe-A-eDP-1
[56.754871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[56.756795] Subtest atomic-invalid-params: SUCCESS (0.418s)
[57.619061] [002/131] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[57.726172] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[64.675933] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.960s)
[64.810907] [003/131] (951s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[64.908110] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[64.910453] Starting dynamic subtest: pipe-A-eDP-1
[64.919560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.928506] Starting dynamic subtest: pipe-B-eDP-1
[64.937378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.945058] Starting dynamic subtest: pipe-C-eDP-1
[64.953390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.960239] Starting dynamic subtest: pipe-D-eDP-1
[64.968994] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.973341] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[67.237742] [004/131] (949s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[67.394659] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[67.503677] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[67.727255] [005/131] (949s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[67.876478] Starting subtest: x-tiled-16bpp-rotate-180
[69.244150] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.368s)
[69.398250] [006/131] (947s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[69.503712] Starting subtest: yf-tiled-32bpp-rotate-270
[69.507550] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[69.639970] [007/131] (947s left) kms_feature_discovery (psr1)
[69.742153] Starting subtest: psr1
[69.743753] Subtest psr1: SUCCESS (0.000s)
[69.836551] [008/131] (947s left) gen9_exec_parse (bb-start-out)
[69.897073] Subtest bb-start-out: SKIP (0.000s)
[69.957248] [009/131] (947s left) sw_sync (sync_merge_same)
[69.991851] Starting subtest: sync_merge_same
[69.993511] Subtest sync_merge_same: SUCCESS (0.000s)
[70.078799] [010/131] (947s left) kms_lease (lease-invalid-plane)
[70.177061] Starting subtest: lease-invalid-plane
[70.178966] Starting dynamic subtest: pipe-A-eDP-1
[70.180697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[70.188620] Starting dynamic subtest: pipe-B-eDP-1
[70.190212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[70.197221] Starting dynamic subtest: pipe-C-eDP-1
[70.198958] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[70.206326] Starting dynamic subtest: pipe-D-eDP-1
[70.207895] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[70.209510] Subtest lease-invalid-plane: SUCCESS (0.003s)
[70.275345] [011/131] (946s left) gem_pwrite (basic-random)
[70.337789] Subtest basic-random: SKIP (0.000s)
[70.397635] [012/131] (946s left) kms_psr (psr-sprite-mmap-cpu)
[70.511115] Starting subtest: psr-sprite-mmap-cpu
[70.513235] Starting dynamic subtest: eDP-1
[72.293894] Dynamic subtest eDP-1: SUCCESS (1.785s)
[72.296438] Subtest psr-sprite-mmap-cpu: SUCCESS (1.786s)
[73.161059] [013/131] (944s left) i915_drm_fdinfo (busy)
[73.202026] Starting subtest: busy
[73.204027] Starting dynamic subtest: rcs0
[73.227583] Dynamic subtest rcs0: SKIP (0.025s)
[73.236848] Starting dynamic subtest: bcs0
[73.240971] Dynamic subtest bcs0: SKIP (0.000s)
[73.248413] Starting dynamic subtest: vcs0
[73.252786] Dynamic subtest vcs0: SKIP (0.000s)
[73.260128] Starting dynamic subtest: vcs1
[73.264179] Dynamic subtest vcs1: SKIP (0.000s)
[73.271019] Starting dynamic subtest: vecs0
[73.275090] Dynamic subtest vecs0: SKIP (0.000s)
[73.281941] Starting dynamic subtest: ccs0
[73.286056] Dynamic subtest ccs0: SKIP (0.000s)
[73.290136] Subtest busy: SKIP (0.028s)
[73.322974] [014/131] (943s left) gem_exec_whisper (basic-forked-all)
[73.387121] Starting subtest: basic-forked-all
[86.872075] Subtest basic-forked-all: SUCCESS (13.483s)
[87.080944] [015/131] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[87.202485] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[87.206572] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[87.338988] [016/131] (930s left) kms_frontbuffer_tracking (psr-1p-rte)
[87.458384] Starting subtest: psr-1p-rte
[92.867140] Subtest psr-1p-rte: SUCCESS (5.414s)
[93.031540] [017/131] (924s left) kms_cursor_crc (cursor-random-max-size)
[93.325779] Starting subtest: cursor-random-max-size
[93.332478] Subtest cursor-random-max-size: SKIP (0.000s)
[93.492487] [018/131] (923s left) kms_getfb (getfb-handle-protection)
[93.590432] Starting subtest: getfb-handle-protection
[93.618559] Subtest getfb-handle-protection: SUCCESS (0.030s)
[93.783319] [019/131] (923s left) syncobj_timeline (wait-for-submit-delayed-submit)
[93.850181] Starting subtest: wait-for-submit-delayed-submit
[93.955397] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[94.052102] [020/131] (923s left) kms_vblank (query-forked-busy-hang)
[94.148421] Starting subtest: query-forked-busy-hang
[94.150797] Starting dynamic subtest: pipe-A-eDP-1
[120.658755] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.508s)
[120.673080] Starting dynamic subtest: pipe-D-eDP-1
[145.682283] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[145.684911] Subtest query-forked-busy-hang: SUCCESS (51.533s)
[146.531205] [021/131] (870s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[146.631365] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[153.405952] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.776s)
[153.566269] [022/131] (863s left) gem_ctx_shared (q-promotion)
[153.648778] Starting subtest: Q-promotion
[153.651186] Starting dynamic subtest: rcs0
[153.800989] Dynamic subtest rcs0: SUCCESS (0.151s)
[153.815372] Starting dynamic subtest: vcs0
[153.881167] Dynamic subtest vcs0: SUCCESS (0.080s)
[153.896664] Starting dynamic subtest: vcs1
[153.951571] Dynamic subtest vcs1: SUCCESS (0.070s)
[153.966279] Starting dynamic subtest: vecs0
[154.021686] Dynamic subtest vecs0: SUCCESS (0.070s)
[154.037277] Starting dynamic subtest: ccs0
[154.101722] Dynamic subtest ccs0: SUCCESS (0.079s)
[154.104660] Subtest Q-promotion: SUCCESS (0.452s)
[155.032823] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[155.035586] [023/131] (862s left) kms_flip (plain-flip-ts-check)
[155.132230] Starting subtest: plain-flip-ts-check
[155.134633] Starting dynamic subtest: A-eDP1
[164.035040] Dynamic subtest A-eDP1: SUCCESS (8.894s)
[164.050394] Starting dynamic subtest: B-eDP1
[172.861890] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[172.874861] Starting dynamic subtest: C-eDP1
[181.676811] Dynamic subtest C-eDP1: SUCCESS (8.812s)
[181.688045] Starting dynamic subtest: D-eDP1
[190.516794] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[190.521869] Subtest plain-flip-ts-check: SUCCESS (35.388s)
[191.727716] [024/131] (825s left) gem_ctx_persistence (engines-cleanup)
[191.796042] Starting subtest: engines-cleanup
[191.798429] Starting dynamic subtest: rcs0
[191.852315] Dynamic subtest rcs0: SUCCESS (0.056s)
[191.861923] Starting dynamic subtest: bcs0
[191.956983] Dynamic subtest bcs0: SUCCESS (0.103s)
[191.968057] Starting dynamic subtest: vcs0
[191.999436] Dynamic subtest vcs0: SUCCESS (0.042s)
[192.009813] Starting dynamic subtest: vcs1
[192.016339] Dynamic subtest vcs1: SUCCESS (0.016s)
[192.024074] Starting dynamic subtest: vecs0
[192.108525] Dynamic subtest vecs0: SUCCESS (0.092s)
[192.120131] Starting dynamic subtest: ccs0
[192.171566] Dynamic subtest ccs0: SUCCESS (0.062s)
[192.173899] Subtest engines-cleanup: SUCCESS (0.376s)
[192.272117] [025/131] (825s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[192.368139] Starting subtest: psr-shrfb-scaledprimary
[198.221217] Subtest psr-shrfb-scaledprimary: SUCCESS (5.854s)
[198.392575] [026/131] (819s left) syncobj_timeline (signal)
[198.453062] Starting subtest: signal
[198.455268] Subtest signal: SUCCESS (0.000s)
[198.590939] [027/131] (819s left) kms_plane_scaling (invalid-num-scalers)
[198.696984] Starting subtest: invalid-num-scalers
[198.699138] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[198.716843] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[198.725799] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[198.748079] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[198.756693] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[198.783866] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[198.791975] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[198.816546] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[198.818741] Subtest invalid-num-scalers: SUCCESS (0.121s)
[198.932487] [028/131] (818s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[198.999770] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[199.105990] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[199.205575] [029/131] (818s left) gen3_render_linear_blits
[199.336762] [030/131] (818s left) gem_exec_schedule (in-order)
[199.413400] Starting subtest: in-order
[199.415368] Starting dynamic subtest: rcs0
[199.504078] Dynamic subtest rcs0: SUCCESS (0.098s)
[199.515585] Starting dynamic subtest: vcs0
[199.584967] Dynamic subtest vcs0: SUCCESS (0.080s)
[199.598177] Starting dynamic subtest: vcs1
[199.662194] Dynamic subtest vcs1: SUCCESS (0.077s)
[199.673774] Starting dynamic subtest: vecs0
[199.736095] Dynamic subtest vecs0: SUCCESS (0.074s)
[199.745554] Starting dynamic subtest: ccs0
[199.822857] Dynamic subtest ccs0: SUCCESS (0.086s)
[199.825331] Subtest in-order: SUCCESS (0.418s)
[201.032432] [031/131] (816s left) kms_big_fb (linear-16bpp-rotate-180)
[201.129374] Starting subtest: linear-16bpp-rotate-180
[202.553110] Subtest linear-16bpp-rotate-180: SUCCESS (1.422s)
[202.716677] [032/131] (815s left) i915_suspend (basic-s3-without-i915)
[202.755925] Starting subtest: basic-s3-without-i915
[204.746580] Subtest basic-s3-without-i915: SKIP (1.985s)
[206.335755] [033/131] (811s left) gem_tiled_pread_pwrite
[206.479583] [034/131] (811s left) gem_exec_params (cliprects-invalid)
[206.541776] Starting subtest: cliprects-invalid
[206.543973] Subtest cliprects-invalid: SUCCESS (0.000s)
[206.673813] [035/131] (811s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[206.718693] Starting subtest: single-wait-for-submit-unsubmitted
[206.824825] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[206.923026] [036/131] (811s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[207.025307] Starting subtest: y-tiled-16bpp-rotate-90
[207.029430] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[207.142051] [037/131] (811s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[207.257442] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[207.261889] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[207.393075] [038/131] (810s left) gem_spin_batch (legacy-resubmit)
[207.468741] Starting subtest: legacy-resubmit
[207.471217] Starting dynamic subtest: default
[207.478238] Dynamic subtest default: SUCCESS (0.008s)
[207.488235] Starting dynamic subtest: render
[207.490490] Dynamic subtest render: SUCCESS (0.001s)
[207.498252] Starting dynamic subtest: bsd
[207.500111] Dynamic subtest bsd: SUCCESS (0.002s)
[207.507305] Starting dynamic subtest: bsd1
[207.509184] Dynamic subtest bsd1: SUCCESS (0.001s)
[207.516516] Starting dynamic subtest: bsd2
[207.518382] Dynamic subtest bsd2: SUCCESS (0.002s)
[207.525737] Starting dynamic subtest: blt
[207.527624] Dynamic subtest blt: SUCCESS (0.002s)
[207.534783] Starting dynamic subtest: vebox
[207.536653] Dynamic subtest vebox: SUCCESS (0.002s)
[207.538532] Subtest legacy-resubmit: SUCCESS (0.024s)
[207.771302] [039/131] (810s left) perf_pmu (busy-start)
[207.814363] Starting subtest: busy-start
[207.816611] Starting dynamic subtest: rcs0
[210.365918] Dynamic subtest rcs0: SUCCESS (2.551s)
[210.376874] Starting dynamic subtest: bcs0
[212.913664] Dynamic subtest bcs0: SUCCESS (2.546s)
[212.923685] Starting dynamic subtest: vcs0
[216.916369] Dynamic subtest vcs0: SUCCESS (3.999s)
[216.927529] Starting dynamic subtest: vcs1
[220.884474] Dynamic subtest vcs1: SUCCESS (3.966s)
[220.895340] Starting dynamic subtest: vecs0
[224.916672] Dynamic subtest vecs0: SUCCESS (4.030s)
[224.927858] Starting dynamic subtest: ccs0
[227.465137] Dynamic subtest ccs0: SUCCESS (2.549s)
[227.467611] Subtest busy-start: SUCCESS (19.651s)
[227.611049] [040/131] (790s left) perf (invalid-oa-metric-set-id)
[227.753250] Starting subtest: invalid-oa-metric-set-id
[227.768191] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s)
[227.807386] [041/131] (790s left) gem_exec_schedule (thriceslice)
[227.884763] Starting subtest: thriceslice
[227.887218] Starting dynamic subtest: rcs0
[227.911339] Dynamic subtest rcs0: SUCCESS (0.037s)
[227.922930] Starting dynamic subtest: bcs0
[227.969083] Dynamic subtest bcs0: SUCCESS (0.057s)
[227.979085] Starting dynamic subtest: vcs0
[228.026681] Dynamic subtest vcs0: SUCCESS (0.056s)
[228.037616] Starting dynamic subtest: vcs1
[228.079634] Dynamic subtest vcs1: SUCCESS (0.053s)
[228.091941] Starting dynamic subtest: vecs0
[228.138845] Dynamic subtest vecs0: SUCCESS (0.058s)
[228.153127] Starting dynamic subtest: ccs0
[228.196465] Dynamic subtest ccs0: SUCCESS (0.057s)
[228.198856] Subtest thriceslice: SUCCESS (0.323s)
[228.524334] [042/131] (789s left) gem_lmem_swapping (heavy-verify-random)
[228.562867] Subtest heavy-verify-random: SKIP (0.000s)
[228.611652] [043/131] (789s left) syncobj_wait (wait-all-snapshot)
[228.666067] Starting subtest: wait-all-snapshot
[228.747055] Subtest wait-all-snapshot: SUCCESS (0.081s)
[228.853976] [044/131] (789s left) syncobj_timeline (wait-zero-handles)
[228.911261] Starting subtest: wait-zero-handles
[228.913606] Subtest wait-zero-handles: SUCCESS (0.000s)
[229.027689] [045/131] (789s left) kms_vblank (query-idle-hang)
[229.139992] Starting subtest: query-idle-hang
[229.142262] Starting dynamic subtest: pipe-A-eDP-1
[255.645496] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.504s)
[255.658856] Starting dynamic subtest: pipe-D-eDP-1
[280.668995] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s)
[280.671326] Subtest query-idle-hang: SUCCESS (51.527s)
[281.556432] [046/131] (736s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[281.685616] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[281.690258] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[281.877143] [047/131] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[281.985125] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[285.704509] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.723s)
[286.876274] [048/131] (731s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[287.309954] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[288.147710] [049/131] (730s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[288.257396] Starting subtest: 4-tiled-64bpp-rotate-180
[289.802199] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.544s)
[290.025348] [050/131] (728s left) kms_fence_pin_leak
[290.216626] [051/131] (728s left) gem_tiling_max_stride
[290.355521] [052/131] (728s left) kms_invalid_mode (int-max-clock)
[290.453496] Starting subtest: int-max-clock
[290.455746] Starting dynamic subtest: pipe-A-eDP-1
[290.742140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[290.754851] Starting dynamic subtest: pipe-B-eDP-1
[290.756972] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[290.768732] Starting dynamic subtest: pipe-C-eDP-1
[290.771183] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[290.781404] Starting dynamic subtest: pipe-D-eDP-1
[290.783671] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[290.785957] Subtest int-max-clock: SUCCESS (0.292s)
[291.617629] [053/131] (727s left) i915_drm_fdinfo (virtual-idle)
[291.657313] Starting subtest: virtual-idle
[294.745362] Subtest virtual-idle: SUCCESS (3.084s)
[294.841177] [054/131] (724s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[294.902662] Starting subtest: multi-wait-all-for-submit-signaled
[294.904837] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[295.038961] [055/131] (723s left) gem_mmap_gtt (basic-small-copy)
[295.105472] Subtest basic-small-copy: SKIP (0.000s)
[295.177816] [056/131] (723s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[295.278776] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[295.290617] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[295.417282] [057/131] (723s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[300.461496] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[300.463769] Starting dynamic subtest: pipe-A-eDP-1
[307.101978] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.637s)
[307.111788] Starting dynamic subtest: pipe-B-eDP-1
[313.744650] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[313.747048] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.283s)
[314.644186] [058/131] (704s left) kms_psr (psr2-sprite-plane-onoff)
[314.741305] Starting subtest: psr2-sprite-plane-onoff
[314.743648] Starting dynamic subtest: eDP-1
[316.511791] Dynamic subtest eDP-1: SUCCESS (1.769s)
[316.514442] Subtest psr2-sprite-plane-onoff: SUCCESS (1.770s)
[317.393761] [059/131] (701s left) kms_flip (2x-wf_vblank-ts-check)
[317.495818] Starting subtest: 2x-wf_vblank-ts-check
[317.505161] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[317.625427] [060/131] (701s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[322.550526] Starting subtest: pr-cursor-plane-update-sf
[322.555183] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[323.427789] [061/131] (695s left) kms_chamelium_color (ctm-max)
[323.525092] Subtest ctm-max: SKIP (0.000s)
[323.570520] [062/131] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[323.660438] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[323.664615] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[323.785026] [063/131] (695s left) kms_content_protection (legacy)
[323.921960] Starting subtest: legacy
[323.926472] Subtest legacy: SKIP (0.000s)
[324.080897] [064/131] (695s left) kms_psr (fbc-psr2-primary-render)
[324.177933] Starting subtest: fbc-psr2-primary-render
[324.180178] Starting dynamic subtest: eDP-1
[324.184575] Dynamic subtest eDP-1: SKIP (0.000s)
[324.188849] Subtest fbc-psr2-primary-render: SKIP (0.002s)
[324.276800] [065/131] (695s left) kms_properties (colorop-properties-atomic)
[324.367372] Starting subtest: colorop-properties-atomic
[324.369032] Starting dynamic subtest: pipe-A-eDP-1
[324.700225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.333s)
[324.709778] Starting dynamic subtest: pipe-B-eDP-1
[325.763585] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.062s)
[325.772448] Starting dynamic subtest: pipe-C-eDP-1
[326.798653] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.031s)
[326.807717] Starting dynamic subtest: pipe-D-eDP-1
[327.841861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.044s)
[327.844200] Subtest colorop-properties-atomic: SUCCESS (3.476s)
[328.662323] [066/131] (690s left) gem_ringfill (engines-basic)
[333.912035] Starting subtest: engines-basic
[333.914580] Starting dynamic subtest: rcs0
[334.002867] Dynamic subtest rcs0: SUCCESS (0.091s)
[334.014545] Starting dynamic subtest: bcs0
[334.048867] Dynamic subtest bcs0: SUCCESS (0.044s)
[334.059398] Starting dynamic subtest: vcs0
[334.090835] Dynamic subtest vcs0: SUCCESS (0.040s)
[334.100414] Starting dynamic subtest: vcs1
[334.134816] Dynamic subtest vcs1: SUCCESS (0.042s)
[334.144868] Starting dynamic subtest: vecs0
[334.177068] Dynamic subtest vecs0: SUCCESS (0.040s)
[334.186956] Starting dynamic subtest: ccs0
[334.224840] Dynamic subtest ccs0: SUCCESS (0.045s)
[334.227378] Subtest engines-basic: SUCCESS (0.315s)
[334.328761] [067/131] (685s left) gem_watchdog (default-virtual)
[334.395456] Starting subtest: default-virtual
[340.671766] Subtest default-virtual: SUCCESS (6.287s)
[340.790674] [068/131] (678s left) kms_dp_aux_dev
[341.174946] [069/131] (678s left) kms_chamelium_edid (hdmi-edid-read)
[341.564372] Subtest hdmi-edid-read: SKIP (0.000s)
[342.347432] [070/131] (677s left) kms_fbcon_fbt (psr)
[342.412302] Starting subtest: psr
[349.725532] Subtest psr: SUCCESS (7.308s)
[349.823904] [071/131] (669s left) syncobj_timeline (invalid-transfer-illegal-handle)
[349.898061] Starting subtest: invalid-transfer-illegal-handle
[349.900341] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[350.036700] [072/131] (669s left) gem_exec_reloc (basic-write-cpu-noreloc)
[350.102803] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[350.186394] [073/131] (669s left) gem_workarounds (suspend-resume)
[350.264268] Starting subtest: suspend-resume
[366.035358] Subtest suspend-resume: SUCCESS (4.889s)
[366.191679] [074/131] (653s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[366.302767] Starting subtest: fbcpsr-tiling-4
[373.325678] Subtest fbcpsr-tiling-4: SUCCESS (7.051s)
[373.498375] [075/131] (646s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[373.633169] Starting subtest: 2x-flip-vs-cursor-legacy
[373.637576] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[373.798712] [076/131] (645s left) gem_ctx_persistence (idempotent)
[373.866821] Starting subtest: idempotent
[373.869227] Subtest idempotent: SUCCESS (0.000s)
[374.001128] [077/131] (645s left) kms_psr (psr2-cursor-blt)
[374.099639] Starting subtest: psr2-cursor-blt
[374.101528] Starting dynamic subtest: eDP-1
[375.790334] Dynamic subtest eDP-1: SUCCESS (1.691s)
[375.792231] Subtest psr2-cursor-blt: SUCCESS (1.693s)
[376.699530] [078/131] (643s left) kms_cursor_crc (cursor-offscreen-max-size)
[376.998160] Starting subtest: cursor-offscreen-max-size
[377.004765] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[377.158600] [079/131] (642s left) kms_force_connector_basic (prune-stale-modes)
[377.240151] Starting subtest: prune-stale-modes
[377.709893] Subtest prune-stale-modes: SUCCESS (0.471s)
[377.869476] [080/131] (642s left) kms_cursor_crc (cursor-suspend)
[378.000945] Starting subtest: cursor-suspend
[378.002920] Starting dynamic subtest: pipe-A-eDP-1
[410.523195] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.189s)
[410.533254] Starting dynamic subtest: pipe-D-eDP-1
[444.444468] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.687s)
[444.446743] Subtest cursor-suspend: SUCCESS (6.879s)
[445.340953] [081/131] (574s left) kms_plane_cursor (primary)
[445.460013] Starting subtest: primary
[445.464445] Starting dynamic subtest: pipe-A-eDP-1-size-64
[448.005923] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.556s)
[448.033227] Starting dynamic subtest: pipe-A-eDP-1-size-128
[450.553530] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[450.580693] Starting dynamic subtest: pipe-A-eDP-1-size-256
[453.150995] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s)
[453.466901] Starting dynamic subtest: pipe-B-eDP-1-size-64
[456.779103] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.324s)
[456.816963] Starting dynamic subtest: pipe-B-eDP-1-size-128
[459.407264] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.615s)
[459.432753] Starting dynamic subtest: pipe-B-eDP-1-size-256
[461.984286] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[462.299836] Starting dynamic subtest: pipe-C-eDP-1-size-64
[465.178179] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.892s)
[465.205117] Starting dynamic subtest: pipe-C-eDP-1-size-128
[467.410896] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.213s)
[467.446106] Starting dynamic subtest: pipe-C-eDP-1-size-256
[469.597194] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[469.916615] Starting dynamic subtest: pipe-D-eDP-1-size-64
[472.857393] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.954s)
[472.884732] Starting dynamic subtest: pipe-D-eDP-1-size-128
[475.067655] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.193s)
[475.098639] Starting dynamic subtest: pipe-D-eDP-1-size-256
[477.323150] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[477.632656] Subtest primary: SUCCESS (32.216s)
[478.500843] [082/131] (541s left) gem_exec_balancer (fairslice)
[478.567009] Starting subtest: fairslice
[481.446863] Subtest fairslice: SUCCESS (2.877s)
[482.443617] [083/131] (537s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[482.553713] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[482.555974] Starting dynamic subtest: pipe-A-eDP-1
[482.578933] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[482.590974] Starting dynamic subtest: pipe-B-eDP-1
[482.612529] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[482.622519] Starting dynamic subtest: pipe-C-eDP-1
[482.644433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[482.655245] Starting dynamic subtest: pipe-D-eDP-1
[482.677085] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[482.681126] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[484.818692] [084/131] (535s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[484.906109] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[484.908461] Starting dynamic subtest: pipe-A-default-mode
[485.213568] Dynamic subtest pipe-A-default-mode: SKIP (0.306s)
[485.218131] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.307s)
[486.087212] [085/131] (534s left) syncobj_eventfd (invalid-bad-pad)
[486.146633] Starting subtest: invalid-bad-pad
[486.148942] Subtest invalid-bad-pad: SUCCESS (0.000s)
[486.277478] [086/131] (533s left) kms_psr (fbc-psr-sprite-blt)
[486.389673] Starting subtest: fbc-psr-sprite-blt
[486.392060] Starting dynamic subtest: eDP-1
[486.396105] Dynamic subtest eDP-1: SKIP (0.000s)
[486.400184] Subtest fbc-psr-sprite-blt: SKIP (0.002s)
[486.489245] [087/131] (533s left) gem_exec_reloc (basic-concurrent16)
[486.563364] Subtest basic-concurrent16: SKIP (0.000s)
[486.657367] [088/131] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[486.767611] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[486.771977] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[486.893227] [089/131] (533s left) syncobj_wait (wait-all-interrupted)
[486.949200] Starting subtest: wait-all-interrupted
[487.056273] Subtest wait-all-interrupted: SUCCESS (0.107s)
[487.156893] [090/131] (533s left) kms_flip (flip-vs-expired-vblank)
[487.247464] Starting subtest: flip-vs-expired-vblank
[487.249918] Starting dynamic subtest: A-eDP1
[495.961473] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[495.973293] Starting dynamic subtest: B-eDP1
[504.653674] Dynamic subtest B-eDP1: SUCCESS (8.693s)
[504.667063] Starting dynamic subtest: C-eDP1
[513.339046] Dynamic subtest C-eDP1: SUCCESS (8.685s)
[513.354237] Starting dynamic subtest: D-eDP1
[522.031404] Dynamic subtest D-eDP1: SUCCESS (8.692s)
[522.036624] Subtest flip-vs-expired-vblank: SUCCESS (34.796s)
[523.273530] [091/131] (497s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[523.375906] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[523.378269] Starting dynamic subtest: pipe-A-eDP-1
[523.436658] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[523.448461] Starting dynamic subtest: pipe-B-eDP-1
[523.506077] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[523.517092] Starting dynamic subtest: pipe-C-eDP-1
[523.573856] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[523.584126] Starting dynamic subtest: pipe-D-eDP-1
[523.639961] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[523.644305] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[525.690103] [092/131] (494s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[525.818144] Starting subtest: cursorB-vs-flipA-toggle
[525.822542] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[526.016359] [093/131] (494s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[526.572679] Starting subtest: syncobj-stationary-timeline-chain-engines
[526.669828] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.098s)
[528.544966] [094/131] (491s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[528.619108] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[528.693839] [095/131] (491s left) gem_softpin (evict-active-interruptible)
[528.765195] Starting subtest: evict-active-interruptible
[528.772584] Subtest evict-active-interruptible: SUCCESS (0.010s)
[528.936792] [096/131] (491s left) gem_render_copy (yf-tiled-ccs-to-linear)
[529.004197] Starting subtest: yf-tiled-ccs-to-linear
[529.008767] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[529.217909] [097/131] (491s left) device_reset (unbind-reset-rebind)
[529.263626] Starting subtest: unbind-reset-rebind
[532.434123] Subtest unbind-reset-rebind: SUCCESS (3.166s)
[532.478033] [098/131] (488s left) kms_pm_dc (dc5-dpms)
[533.577242] Starting subtest: dc5-dpms
[535.638653] Subtest dc5-dpms: SUCCESS (2.063s)
[535.742816] [099/131] (485s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[535.837201] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[535.839584] Starting dynamic subtest: pipe-A-eDP-1
[535.863454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[535.876029] Starting dynamic subtest: pipe-B-eDP-1
[535.897613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[535.907382] Starting dynamic subtest: pipe-C-eDP-1
[535.928863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[535.938129] Starting dynamic subtest: pipe-D-eDP-1
[535.960466] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[535.965117] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[538.167704] [100/131] (482s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[538.270566] Starting subtest: yf-tiled-64bpp-rotate-90
[538.274775] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[538.399222] [101/131] (482s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[538.494626] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[538.498410] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[538.618611] [102/131] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[538.720354] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[538.724752] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[538.847053] [103/131] (482s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[538.954829] Starting subtest: fbc-indfb-scaledprimary
[541.925464] Subtest fbc-indfb-scaledprimary: SUCCESS (2.981s)
[543.073499] [104/131] (477s left) vgem_basic (create)
[543.122694] Starting subtest: create
[543.124585] Subtest create: SUCCESS (0.000s)
[543.205213] [105/131] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[543.309321] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[543.313552] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[543.435008] [106/131] (477s left) gem_exec_fence (basic-await)
[543.622486] Starting subtest: basic-await
[543.624881] Starting dynamic subtest: rcs0
[543.698355] Dynamic subtest rcs0: SUCCESS (0.075s)
[543.714943] Starting dynamic subtest: bcs0
[543.775850] Dynamic subtest bcs0: SUCCESS (0.076s)
[543.788958] Starting dynamic subtest: vcs0
[543.849106] Dynamic subtest vcs0: SUCCESS (0.071s)
[543.862395] Starting dynamic subtest: vcs1
[543.920674] Dynamic subtest vcs1: SUCCESS (0.070s)
[543.933775] Starting dynamic subtest: vecs0
[543.993157] Dynamic subtest vecs0: SUCCESS (0.070s)
[544.007159] Starting dynamic subtest: ccs0
[544.064721] Dynamic subtest ccs0: SUCCESS (0.070s)
[544.067425] Subtest basic-await: SUCCESS (0.443s)
[545.475545] [107/131] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[545.578997] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[550.020036] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.442s)
[551.257141] [108/131] (469s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[551.350131] Starting subtest: bad-aux-stride-yf-tiled-ccs
[551.352462] Starting dynamic subtest: pipe-A-eDP-1
[551.376030] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[551.387693] Starting dynamic subtest: pipe-B-eDP-1
[551.409569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[551.419498] Starting dynamic subtest: pipe-C-eDP-1
[551.441273] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[551.451153] Starting dynamic subtest: pipe-D-eDP-1
[551.473208] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[551.477330] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[553.607520] [109/131] (467s left) gem_userptr_blits (create-destroy-unsync)
[553.684736] Subtest create-destroy-unsync: SKIP (0.000s)
[553.834770] [110/131] (467s left) kms_pm_rpm (universal-planes)
[555.477867] Starting subtest: universal-planes
[555.480325] Starting dynamic subtest: plane-33
[564.099099] Dynamic subtest plane-33: SUCCESS (8.616s)
[564.112885] Starting dynamic subtest: plane-63
[572.718643] Dynamic subtest plane-63: SUCCESS (8.616s)
[572.731860] Starting dynamic subtest: plane-93
[581.015133] Dynamic subtest plane-93: SUCCESS (8.294s)
[581.027880] Starting dynamic subtest: plane-123
[589.404398] Dynamic subtest plane-123: SUCCESS (8.387s)
[589.416815] Starting dynamic subtest: plane-133
[597.996832] Dynamic subtest plane-133: SUCCESS (8.590s)
[598.009612] Starting dynamic subtest: plane-143
[606.619647] Dynamic subtest plane-143: SUCCESS (8.622s)
[606.622344] Subtest universal-planes: SUCCESS (51.141s)
[607.008499] [111/131] (414s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[607.140341] Starting subtest: 2x-flip-vs-cursor-atomic
[607.144997] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[607.309562] [112/131] (414s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[607.414135] Starting subtest: psr-rgb565-draw-blt
[614.452018] Subtest psr-rgb565-draw-blt: SUCCESS (7.043s)
[614.614369] [113/131] (406s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[614.714643] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[614.719018] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[614.836927] [114/131] (406s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[614.928749] Starting subtest: plane-upscale-20x20-with-rotation
[614.930985] Starting dynamic subtest: pipe-A
[615.154146] Dynamic subtest pipe-A: SUCCESS (0.227s)
[615.164410] Starting dynamic subtest: pipe-B
[616.492949] Dynamic subtest pipe-B: SUCCESS (1.337s)
[616.503605] Starting dynamic subtest: pipe-C
[617.812165] Dynamic subtest pipe-C: SUCCESS (1.319s)
[617.822129] Starting dynamic subtest: pipe-D
[619.147123] Dynamic subtest pipe-D: SUCCESS (1.334s)
[619.149481] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.222s)
[620.352599] [115/131] (401s left) gem_busy (busy)
[620.412305] Starting subtest: busy
[620.414546] Starting dynamic subtest: all-engines
[620.472209] Dynamic subtest all-engines: SUCCESS (0.060s)
[620.483011] Starting dynamic subtest: rcs0
[622.366839] Dynamic subtest rcs0: SUCCESS (1.892s)
[622.378650] Starting dynamic subtest: bcs0
[622.429303] Dynamic subtest bcs0: SUCCESS (0.059s)
[622.441109] Starting dynamic subtest: vcs0
[622.467679] Dynamic subtest vcs0: SUCCESS (0.038s)
[622.476959] Starting dynamic subtest: vcs1
[624.344657] Dynamic subtest vcs1: SUCCESS (1.874s)
[624.354557] Starting dynamic subtest: vecs0
[626.392863] Dynamic subtest vecs0: SUCCESS (2.047s)
[626.405359] Starting dynamic subtest: ccs0
[628.378266] Dynamic subtest ccs0: SUCCESS (1.985s)
[628.380721] Subtest busy: SUCCESS (7.965s)
[628.787862] [116/131] (392s left) kms_legacy_colorkey (invalid-plane)
[628.887910] Starting subtest: invalid-plane
[628.890212] Starting dynamic subtest: zero-id
[628.892410] Dynamic subtest zero-id: SUCCESS (0.000s)
[628.903891] Starting dynamic subtest: outrange-id
[628.905812] Dynamic subtest outrange-id: SUCCESS (0.000s)
[628.907627] Subtest invalid-plane: SUCCESS (0.001s)
[628.984894] [117/131] (392s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[629.051938] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[629.129887] [118/131] (392s left) api_intel_bb (object-noreloc-keep-cache-simple)
[629.186035] Starting subtest: object-noreloc-keep-cache-simple
[629.190058] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[629.319634] [119/131] (392s left) gem_close_race (multigpu-basic-process)
[629.387846] Starting subtest: multigpu-basic-process
[629.392338] Subtest multigpu-basic-process: SKIP (0.000s)
[629.629345] [120/131] (392s left) kms_flip (nonblocking-read)
[629.722906] Starting subtest: nonblocking-read
[629.724774] Subtest nonblocking-read: SUCCESS (0.000s)
[629.857347] [121/131] (391s left) intel_hwmon (hwmon-write)
[629.921092] Subtest hwmon-write: SKIP (0.000s)
[629.981327] [122/131] (391s left) gem_lmem_swapping (random)
[630.022210] Subtest random: SKIP (0.000s)
[630.067704] [123/131] (391s left) kms_feature_discovery (display-2x)
[630.161688] Starting subtest: display-2x
[630.166172] Subtest display-2x: SKIP (0.000s)
[630.265050] [124/131] (391s left) gem_mmap_gtt (basic-small-copy-xy)
[630.326986] Subtest basic-small-copy-XY: SKIP (0.000s)
[630.393501] [125/131] (391s left) perf (gen12-mi-rpc)
[630.530909] Starting subtest: gen12-mi-rpc
[630.532667] Starting dynamic subtest: rcs0
[630.552068] Dynamic subtest rcs0: SUCCESS (0.019s)
[630.553853] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[630.600531] [126/131] (391s left) i915_pm_rc6_residency (rc6-fence)
[630.705460] Starting subtest: rc6-fence
[630.733261] Starting dynamic subtest: gt0
[643.051436] Dynamic subtest gt0: SUCCESS (12.320s)
[643.064389] Starting dynamic subtest: gt1
[659.347244] Dynamic subtest gt1: SUCCESS (16.295s)
[659.349850] Subtest rc6-fence: SUCCESS (28.649s)
[659.449738] [127/131] (362s left) kms_addfb_basic (basic)
[659.513843] Starting subtest: basic
[659.515779] Subtest basic: SUCCESS (0.000s)
[659.678233] [128/131] (362s left) gem_mmap_offset (clear)
[659.736061] Starting subtest: clear
[659.738355] Starting dynamic subtest: smem0
[663.882900] [129/131] (358s left) gem_ctx_param (basic-default)
[663.967478] Starting subtest: basic-default
[663.969572] Subtest basic-default: SUCCESS (0.000s)
[664.057950] [130/131] (358s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[664.183920] Starting subtest: cursor-vs-flip-varying-size
[695.006863] Subtest cursor-vs-flip-varying-size: SUCCESS (30.816s)
[695.871848] [131/131] (326s left) api_intel_bb (blit-noreloc-purge-cache)
[695.939521] Starting subtest: blit-noreloc-purge-cache
[695.948302] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[696.125058] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_lease
results: parsing output: 10/ for test: gem_pwrite
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gen3_render_linear_blits
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: gem_tiled_pread_pwrite
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_spin_batch
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_fence_pin_leak
results: parsing output: 50/ for test: gem_tiling_max_stride
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: i915_drm_fdinfo
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: gem_ringfill
results: parsing output: 66/ for test: gem_watchdog
results: parsing output: 67/ for test: kms_dp_aux_dev
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: kms_fbcon_fbt
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_force_connector_basic
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_plane_cursor
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: device_reset
results: parsing output: 97/ for test: kms_pm_dc
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: gem_busy
results: parsing output: 115/ for test: kms_legacy_colorkey
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: gem_close_race
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: intel_hwmon
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: kms_feature_discovery
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: api_intel_bb
Done.