[59.375371] Initializing watchdogs
[59.375415]   /dev/watchdog0
[59.389303] [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]
[59.393418] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.395539] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.398664] [001/132] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[59.535238] Starting subtest: psr-rgb565-draw-mmap-wc
[66.270061] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.699s)
[66.413385] [002/132] (953s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[66.542062] Starting subtest: flip-vs-cursor-atomic-transitions
[74.425939] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.867s)
[75.298190] [003/132] (944s left) i915_hangman (engine-error-state-capture)
[75.376080] Starting subtest: engine-error-state-capture
[75.378323] Starting dynamic subtest: rcs0
[78.899731] Dynamic subtest rcs0: SUCCESS (3.519s)
[78.910068] Starting dynamic subtest: bcs0
[84.853943] Dynamic subtest bcs0: SUCCESS (5.947s)
[84.865035] Starting dynamic subtest: vcs0
[90.804426] Dynamic subtest vcs0: SUCCESS (5.945s)
[90.815453] Starting dynamic subtest: vcs1
[95.796587] Dynamic subtest vcs1: SUCCESS (4.988s)
[95.807734] Starting dynamic subtest: vecs0
[100.852902] Dynamic subtest vecs0: SUCCESS (5.053s)
[100.862847] Starting dynamic subtest: ccs0
[106.868879] Dynamic subtest ccs0: SUCCESS (6.012s)
[106.871705] Subtest engine-error-state-capture: SUCCESS (31.472s)
[107.029863] [004/132] (912s left) perf_pmu (frequency)
[107.070425] Starting subtest: frequency
[107.074717] Starting dynamic subtest: gt0
[109.242257] Dynamic subtest gt0: SUCCESS (2.162s)
[109.252073] Starting dynamic subtest: idle-gt0
[109.747828] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[109.757980] Starting dynamic subtest: gt1
[113.864056] Dynamic subtest gt1: SUCCESS (4.112s)
[113.871949] Starting dynamic subtest: idle-gt1
[114.412763] Dynamic subtest idle-gt1: SUCCESS (0.549s)
[114.415435] Subtest frequency: SUCCESS (7.340s)
[114.547219] [005/132] (905s left) kms_pm_dc (dc5-dpms)
[115.663899] Starting subtest: dc5-dpms
[117.777696] Subtest dc5-dpms: SUCCESS (2.112s)
[117.876686] [006/132] (902s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[117.946074] Starting subtest: multi-wait-all-for-submit-available-submitted
[117.948600] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[118.081028] [007/132] (902s left) gen9_exec_parse (basic-rejected)
[118.146117] Subtest basic-rejected: SKIP (0.000s)
[118.229105] [008/132] (901s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[118.337968] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[118.342077] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[118.465085] [009/132] (901s left) gem_exec_schedule (promotion)
[118.544585] Starting subtest: promotion
[118.546600] Starting dynamic subtest: rcs0
[118.642351] Dynamic subtest rcs0: SUCCESS (0.105s)
[118.652189] Starting dynamic subtest: vcs0
[118.728564] Dynamic subtest vcs0: SUCCESS (0.086s)
[118.738848] Starting dynamic subtest: vcs1
[118.812132] Dynamic subtest vcs1: SUCCESS (0.082s)
[118.825532] Starting dynamic subtest: vecs0
[118.889535] Dynamic subtest vecs0: SUCCESS (0.078s)
[118.900486] Starting dynamic subtest: ccs0
[118.973040] Dynamic subtest ccs0: SUCCESS (0.083s)
[118.975457] Subtest promotion: SUCCESS (0.436s)
[120.037831] [010/132] (900s left) kms_rotation_crc (exhaust-fences)
[120.132870] Starting subtest: exhaust-fences
[120.136873] Subtest exhaust-fences: SKIP (0.000s)
[120.223737] [011/132] (900s left) syncobj_wait (signal)
[120.270979] Starting subtest: signal
[120.273306] Subtest signal: SUCCESS (0.000s)
[120.387007] [012/132] (899s left) kms_color (deep-color)
[120.485969] Starting subtest: deep-color
[121.519188] Starting dynamic subtest: pipe-A-eDP-1-gamma
[122.222886] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.704s)
[122.232586] Starting dynamic subtest: pipe-A-eDP-1-degamma
[123.710554] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.487s)
[123.720267] Starting dynamic subtest: pipe-A-eDP-1-ctm
[125.140025] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.430s)
[125.910062] Starting dynamic subtest: pipe-B-eDP-1-gamma
[126.611475] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.711s)
[126.621199] Starting dynamic subtest: pipe-B-eDP-1-degamma
[128.074550] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.461s)
[128.091568] Starting dynamic subtest: pipe-B-eDP-1-ctm
[129.527296] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.451s)
[130.292896] Starting dynamic subtest: pipe-C-eDP-1-gamma
[130.990133] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.702s)
[130.999401] Starting dynamic subtest: pipe-C-eDP-1-degamma
[132.439093] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.448s)
[132.448390] Starting dynamic subtest: pipe-C-eDP-1-ctm
[133.902229] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.463s)
[134.704461] Starting dynamic subtest: pipe-D-eDP-1-gamma
[135.393456] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.694s)
[135.402560] Starting dynamic subtest: pipe-D-eDP-1-degamma
[136.746991] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.354s)
[136.756155] Starting dynamic subtest: pipe-D-eDP-1-ctm
[138.169527] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.423s)
[138.171906] Subtest deep-color: SUCCESS (17.682s)
[138.990628] [013/132] (881s left) gem_exec_fence (syncobj-signal)
[139.453046] Starting subtest: syncobj-signal
[139.458044] Subtest syncobj-signal: SUCCESS (0.005s)
[140.969618] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[140.972920] [014/132] (879s left) gem_exec_balancer (semaphore)
[141.034575] Starting subtest: semaphore
[142.940323] Subtest semaphore: SUCCESS (1.904s)
[143.303900] [015/132] (877s left) gem_workarounds (suspend-resume-context)
[143.380453] Starting subtest: suspend-resume-context
[158.847815] Subtest suspend-resume-context: SUCCESS (2.049s)
[159.018254] [016/132] (861s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[159.117466] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[159.119759] Starting dynamic subtest: pipe-A-eDP-1
[159.142794] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.154221] Starting dynamic subtest: pipe-B-eDP-1
[159.175619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.184731] Starting dynamic subtest: pipe-C-eDP-1
[159.206697] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.216575] Starting dynamic subtest: pipe-D-eDP-1
[159.238498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.242503] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[161.367171] [017/132] (859s left) gem_spin_batch (resubmit-new)
[161.444419] Starting subtest: resubmit-new
[161.446829] Starting dynamic subtest: rcs0
[161.451800] Dynamic subtest rcs0: SUCCESS (0.007s)
[161.463197] Starting dynamic subtest: bcs0
[161.465150] Dynamic subtest bcs0: SUCCESS (0.004s)
[161.474101] Starting dynamic subtest: vcs0
[161.476375] Dynamic subtest vcs0: SUCCESS (0.004s)
[161.484953] Starting dynamic subtest: vcs1
[161.486906] Dynamic subtest vcs1: SUCCESS (0.004s)
[161.495599] Starting dynamic subtest: vecs0
[161.497475] Dynamic subtest vecs0: SUCCESS (0.004s)
[161.505810] Starting dynamic subtest: ccs0
[161.507764] Dynamic subtest ccs0: SUCCESS (0.003s)
[161.509705] Subtest resubmit-new: SUCCESS (0.029s)
[163.392050] [018/132] (857s left) kms_pm_rpm (i2c)
[165.434336] Starting subtest: i2c
[170.761347] Subtest i2c: SUCCESS (5.240s)
[170.873224] [019/132] (849s left) gem_pxp (display-protected-crc)
[170.995732] Starting subtest: display-protected-crc
[172.614622] Subtest display-protected-crc: SUCCESS (1.605s)
[172.793414] [020/132] (847s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[172.895408] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[172.897751] Starting dynamic subtest: pipe-A-eDP-1
[172.921423] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.930969] Starting dynamic subtest: pipe-B-eDP-1
[172.954237] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.965010] Starting dynamic subtest: pipe-C-eDP-1
[172.986856] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[172.996151] Starting dynamic subtest: pipe-D-eDP-1
[173.018912] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[173.022991] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[175.256318] [021/132] (845s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[175.349801] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[175.354634] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[176.495621] [022/132] (844s left) i915_selftest (live)
[179.985268] Starting subtest: live
[179.987845] Starting dynamic subtest: sanitycheck
[184.450328] Dynamic subtest sanitycheck: SUCCESS (4.452s)
[184.459933] Starting dynamic subtest: uncore
[188.962580] Dynamic subtest uncore: SUCCESS (4.503s)
[188.972233] Starting dynamic subtest: workarounds
[192.263673] Dynamic subtest workarounds: SUCCESS (3.299s)
[192.273233] Starting dynamic subtest: gt_engines
[196.999573] Dynamic subtest gt_engines: SUCCESS (4.733s)
[197.009199] Starting dynamic subtest: gt_timelines
[212.927655] Dynamic subtest gt_timelines: SUCCESS (15.920s)
[212.937686] Starting dynamic subtest: gt_contexts
[217.422541] Dynamic subtest gt_contexts: SUCCESS (4.491s)
[217.432071] Starting dynamic subtest: gt_lrc
[223.800848] Dynamic subtest gt_lrc: SUCCESS (6.374s)
[223.810178] Starting dynamic subtest: gt_mocs
[227.007323] Dynamic subtest gt_mocs: SUCCESS (3.203s)
[227.017097] Starting dynamic subtest: gt_pm
[233.791939] Dynamic subtest gt_pm: SUCCESS (6.779s)
[233.802573] Starting dynamic subtest: gt_heartbeat
[238.276339] Dynamic subtest gt_heartbeat: SUCCESS (4.480s)
[238.285012] Starting dynamic subtest: gt_tlb
[247.755321] Dynamic subtest gt_tlb: SUCCESS (9.473s)
[247.763804] Starting dynamic subtest: requests
[261.231803] Dynamic subtest requests: SUCCESS (13.475s)
[261.241694] Starting dynamic subtest: migrate
[269.383032] Dynamic subtest migrate: SUCCESS (8.151s)
[269.392880] Starting dynamic subtest: active
[273.882775] Dynamic subtest active: SUCCESS (4.494s)
[273.892582] Starting dynamic subtest: objects
[278.719107] Dynamic subtest objects: SUCCESS (4.839s)
[278.728539] Starting dynamic subtest: mman
[283.661712] Dynamic subtest mman: SUCCESS (4.940s)
[283.671156] Starting dynamic subtest: dmabuf
[288.160907] Dynamic subtest dmabuf: SUCCESS (4.497s)
[288.170772] Starting dynamic subtest: vma
[292.608787] Dynamic subtest vma: SUCCESS (4.445s)
[292.619075] Starting dynamic subtest: coherency
[297.672542] Dynamic subtest coherency: SUCCESS (5.061s)
[297.682457] Starting dynamic subtest: gtt
[309.755823] Dynamic subtest gtt: SUCCESS (12.079s)
[309.766158] Starting dynamic subtest: gem
[316.177731] Dynamic subtest gem: SUCCESS (6.419s)
[316.187909] Starting dynamic subtest: evict
[321.666761] Dynamic subtest evict: SUCCESS (5.485s)
[321.676259] Starting dynamic subtest: hugepages
[332.696440] Dynamic subtest hugepages: SUCCESS (11.022s)
[332.706544] Starting dynamic subtest: gem_contexts
[359.463639] Dynamic subtest gem_contexts: SUCCESS (26.761s)
[359.474312] Starting dynamic subtest: client
[363.918797] Dynamic subtest client: SUCCESS (4.451s)
[363.928695] Starting dynamic subtest: gem_migrate
[368.368793] Dynamic subtest gem_migrate: SUCCESS (4.447s)
[368.378754] Starting dynamic subtest: reset
[371.229746] Dynamic subtest reset: SUCCESS (2.857s)
[371.244604] Starting dynamic subtest: memory_region
[374.044015] Dynamic subtest memory_region: SUCCESS (2.811s)
[374.053795] Starting dynamic subtest: hangcheck
[387.282584] Dynamic subtest hangcheck: SUCCESS (13.236s)
[387.292456] Starting dynamic subtest: execlists
[391.716606] Dynamic subtest execlists: SUCCESS (4.431s)
[391.726523] Starting dynamic subtest: ring_submission
[396.162678] Dynamic subtest ring_submission: SUCCESS (4.447s)
[396.172422] Starting dynamic subtest: perf
[399.230525] Dynamic subtest perf: SUCCESS (3.066s)
[399.239970] Starting dynamic subtest: slpc
[411.411204] Dynamic subtest slpc: SUCCESS (12.181s)
[411.421221] Starting dynamic subtest: guc
[415.453707] Dynamic subtest guc: SUCCESS (4.041s)
[415.463575] Starting dynamic subtest: guc_multi_lrc
[419.945099] Dynamic subtest guc_multi_lrc: SUCCESS (4.490s)
[419.954041] Starting dynamic subtest: guc_hang
[424.956047] Dynamic subtest guc_hang: SUCCESS (5.009s)
[424.965711] Starting dynamic subtest: late_gt_pm
[429.392641] Dynamic subtest late_gt_pm: SUCCESS (4.435s)
[429.395440] Subtest live: SUCCESS (249.352s)
[429.421196] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[429.421868] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[429.425126] [023/132] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[430.993822] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[437.916495] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.926s)
[438.083237] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[438.084484] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[438.088271] [024/132] (582s left) perf (gen12-oa-tlb-invalidate)
[438.247951] Starting subtest: gen12-oa-tlb-invalidate
[438.249858] Starting dynamic subtest: 0-rcs0
[448.286372] Dynamic subtest 0-rcs0: SUCCESS (10.037s)
[448.295470] Starting dynamic subtest: 1-vecs0
[458.334427] Dynamic subtest 1-vecs0: SUCCESS (10.046s)
[458.337396] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.086s)
[458.375494] [025/132] (562s left) kms_addfb_basic (too-wide)
[458.466580] Starting subtest: too-wide
[458.468463] Subtest too-wide: SUCCESS (0.000s)
[458.587849] [026/132] (562s left) kms_big_fb (linear-8bpp-rotate-180)
[458.683824] Starting subtest: linear-8bpp-rotate-180
[459.912071] Subtest linear-8bpp-rotate-180: SUCCESS (1.228s)
[460.079966] [027/132] (560s left) kms_getfb (getfb-reject-nv12)
[460.182730] Starting subtest: getfb-reject-nv12
[460.184744] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[460.316020] [028/132] (560s left) kms_plane (plane-panning-bottom-right)
[460.414094] Starting subtest: plane-panning-bottom-right
[460.415940] Starting dynamic subtest: pipe-A
[462.106296] Dynamic subtest pipe-A: SUCCESS (1.693s)
[462.115687] Starting dynamic subtest: pipe-B
[464.469052] Dynamic subtest pipe-B: SUCCESS (2.361s)
[464.471413] Subtest plane-panning-bottom-right: SUCCESS (4.056s)
[465.301695] [029/132] (555s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[465.380437] Starting subtest: map-fixed-invalidate-overlap-busy
[465.385037] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[465.545861] [030/132] (555s left) prime_vgem (basic-write)
[465.617465] Starting subtest: basic-write
[465.627213] Subtest basic-write: SKIP (0.008s)
[465.764631] [031/132] (555s left) gem_exec_whisper (basic-contexts-forked-all)
[465.838769] Starting subtest: basic-contexts-forked-all
[486.314695] Subtest basic-contexts-forked-all: SUCCESS (20.475s)
[486.528223] [032/132] (534s left) kms_psr (fbc-pr-cursor-blt)
[486.629883] Starting subtest: fbc-pr-cursor-blt
[486.634098] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[486.726018] [033/132] (534s left) gen7_exec_parse (basic-allowed)
[486.781759] Subtest basic-allowed: SKIP (0.000s)
[486.878170] [034/132] (534s left) core_auth (getclient-simple)
[486.914139] Starting subtest: getclient-simple
[486.929483] Subtest getclient-simple: SUCCESS (0.013s)
[487.064202] [035/132] (534s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[487.170235] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[487.173007] Starting dynamic subtest: pipe-A-default-mode
[487.459455] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[487.464264] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.290s)
[488.336728] [036/132] (532s left) gem_create (create-ext-placement-sanity-check)
[488.510218] Starting subtest: create-ext-placement-sanity-check
[488.513101] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[488.638557] [037/132] (532s left) kms_psr (psr2-sprite-blt)
[488.735198] Starting subtest: psr2-sprite-blt
[488.737495] Starting dynamic subtest: eDP-1
[490.414125] Dynamic subtest eDP-1: SUCCESS (1.680s)
[490.416424] Subtest psr2-sprite-blt: SUCCESS (1.681s)
[491.306135] [038/132] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[491.405633] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[491.409611] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[491.537178] [039/132] (529s left) gem_ctx_persistence (engines-hang)
[491.596670] Starting subtest: engines-hang
[491.599096] Starting dynamic subtest: rcs0
[491.759334] Dynamic subtest rcs0: SUCCESS (0.162s)
[491.772616] Starting dynamic subtest: bcs0
[491.872297] Dynamic subtest bcs0: SUCCESS (0.111s)
[491.885225] Starting dynamic subtest: vcs0
[491.991887] Dynamic subtest vcs0: SUCCESS (0.118s)
[492.004302] Starting dynamic subtest: vcs1
[492.069055] Dynamic subtest vcs1: SUCCESS (0.075s)
[492.079845] Starting dynamic subtest: vecs0
[492.224886] Dynamic subtest vecs0: SUCCESS (0.154s)
[492.237228] Starting dynamic subtest: ccs0
[492.346129] Dynamic subtest ccs0: SUCCESS (0.119s)
[492.348756] Subtest engines-hang: SUCCESS (0.750s)
[492.450822] [040/132] (529s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[492.570008] Starting subtest: cursorA-vs-flipB-atomic
[492.573763] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[492.738307] [041/132] (528s left) gem_exec_reloc (basic-write-gtt)
[492.807602] Subtest basic-write-gtt: SKIP (0.000s)
[492.931993] [042/132] (528s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[492.998658] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[493.098208] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[493.198677] [043/132] (528s left) gem_render_copy (linear-to-vebox-yf-tiled)
[493.255801] Starting subtest: linear-to-vebox-yf-tiled
[493.259406] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[493.459714] [044/132] (528s left) kms_addfb_basic (invalid-get-prop-any)
[493.510957] Starting subtest: invalid-get-prop-any
[493.512863] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[493.651315] [045/132] (528s left) kms_flip (busy-flip)
[493.755627] Starting subtest: busy-flip
[493.757506] Starting dynamic subtest: A-eDP1
[495.408181] Dynamic subtest A-eDP1: SUCCESS (1.654s)
[495.420001] Starting dynamic subtest: B-eDP1
[497.140230] Dynamic subtest B-eDP1: SUCCESS (1.731s)
[497.150297] Starting dynamic subtest: C-eDP1
[498.858808] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[498.870164] Starting dynamic subtest: D-eDP1
[500.491422] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[500.493734] Subtest busy-flip: SUCCESS (6.741s)
[501.681473] [046/132] (520s left) gem_readwrite (read-bad-handle)
[501.746996] Subtest read-bad-handle: SKIP (0.000s)
[501.815821] [047/132] (519s left) core_getstats (basic)
[501.874543] Starting subtest: basic
[501.876743] Subtest basic: SUCCESS (0.000s)
[502.010588] [048/132] (519s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[502.117727] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[502.742324] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[502.964257] [049/132] (518s left) kms_atomic (plane-invalid-params-fence)
[503.065206] Starting subtest: plane-invalid-params-fence
[503.067427] Starting dynamic subtest: pipe-A-eDP-1
[503.429822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.365s)
[503.432159] Subtest plane-invalid-params-fence: SUCCESS (0.366s)
[504.319707] [050/132] (517s left) kms_pm_rpm (pc8-residency)
[506.457262] Starting subtest: pc8-residency
[506.462558] Subtest pc8-residency: SKIP (0.000s)
[506.871052] [051/132] (515s left) kms_psr2_su (frontbuffer-xrgb8888)
[506.938659] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[507.009065] [052/132] (514s left) syncobj_timeline (etime-single-wait-submitted)
[507.060924] Starting subtest: etime-single-wait-submitted
[507.163728] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[507.259868] [053/132] (514s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[507.376657] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[507.380756] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[507.516308] [054/132] (514s left) kms_chamelium_color (ctm-blue-to-red)
[507.616845] Subtest ctm-blue-to-red: SKIP (0.000s)
[507.659973] [055/132] (514s left) syncobj_wait (multi-wait-all-signaled)
[507.723019] Starting subtest: multi-wait-all-signaled
[507.724942] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[507.846267] [056/132] (514s left) prime_mmap (test_correct_cpu_write)
[507.902017] Starting subtest: test_correct_cpu_write
[507.904220] Starting dynamic subtest: test_correct_cpu_write-smem
[507.906593] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[507.908886] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[508.048186] [057/132] (514s left) gem_exec_reloc (basic-concurrent16)
[508.110750] Subtest basic-concurrent16: SKIP (0.000s)
[508.194769] [058/132] (514s left) vgem_basic (bad-handle)
[508.239314] Starting subtest: bad-handle
[508.241359] Subtest bad-handle: SUCCESS (0.000s)
[508.323140] [059/132] (513s left) gem_userptr_blits (readonly-pwrite-unsync)
[508.385533] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[508.553417] [060/132] (513s left) gem_exec_schedule (implicit-read-write)
[508.628539] Starting subtest: implicit-read-write
[508.630388] Starting dynamic subtest: rcs0
[508.723208] Dynamic subtest rcs0: SUCCESS (0.103s)
[508.734641] Starting dynamic subtest: vcs0
[508.800239] Dynamic subtest vcs0: SUCCESS (0.076s)
[508.811298] Starting dynamic subtest: vcs1
[508.875336] Dynamic subtest vcs1: SUCCESS (0.074s)
[508.887942] Starting dynamic subtest: vecs0
[508.948449] Dynamic subtest vecs0: SUCCESS (0.072s)
[508.960444] Starting dynamic subtest: ccs0
[509.026416] Dynamic subtest ccs0: SUCCESS (0.077s)
[509.028686] Subtest implicit-read-write: SUCCESS (0.407s)
[510.478284] [061/132] (511s left) gem_tiled_fence_blits (normal)
[510.532048] Subtest normal: SKIP (0.000s)
[510.626617] [062/132] (511s left) i915_pm_rpm (gem-idle)
[512.471483] Starting subtest: gem-idle
[518.676644] Subtest gem-idle: SUCCESS (6.200s)
[519.023122] [063/132] (503s left) kms_content_protection (content-type-change)
[520.377067] Starting subtest: content-type-change
[520.381768] Subtest content-type-change: SKIP (0.000s)
[520.556589] [064/132] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[520.665127] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[524.375784] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.713s)
[525.599420] [065/132] (496s left) kms_vblank (ts-continuation-dpms-suspend)
[525.698561] Starting subtest: ts-continuation-dpms-suspend
[525.700676] Starting dynamic subtest: pipe-A-eDP-1
[542.408127] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.838s)
[542.423821] Starting dynamic subtest: pipe-D-eDP-1
[560.450050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.478s)
[560.453048] Subtest ts-continuation-dpms-suspend: SUCCESS (4.321s)
[561.327097] [066/132] (461s left) perf_pmu (most-busy-idle-check-all)
[561.383118] Starting subtest: most-busy-idle-check-all
[561.386074] Starting dynamic subtest: rcs0
[562.133306] Dynamic subtest rcs0: FAIL (0.647s)
[562.144471] Starting dynamic subtest: bcs0
[562.783771] Dynamic subtest bcs0: FAIL (0.615s)
[562.794528] Starting dynamic subtest: vcs0
[564.650015] Dynamic subtest vcs0: SUCCESS (1.902s)
[564.663799] Starting dynamic subtest: vcs1
[566.634668] Dynamic subtest vcs1: SUCCESS (1.937s)
[566.648430] Starting dynamic subtest: vecs0
[568.618204] Dynamic subtest vecs0: SUCCESS (1.946s)
[568.631424] Starting dynamic subtest: ccs0
[570.668130] Dynamic subtest ccs0: SUCCESS (2.019s)
[570.671025] Subtest most-busy-idle-check-all: FAIL (9.079s)
[570.818580] [067/132] (451s left) gem_exec_balancer (full-pulse)
[570.885949] Starting subtest: full-pulse
[575.491646] Subtest full-pulse: SUCCESS (4.564s)
[575.833157] [068/132] (446s left) kms_invalid_mode (bad-hsync-end)
[575.943735] Starting subtest: bad-hsync-end
[575.946196] Starting dynamic subtest: pipe-A-eDP-1
[576.231024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[576.241810] Starting dynamic subtest: pipe-B-eDP-1
[576.244405] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[576.254198] Starting dynamic subtest: pipe-C-eDP-1
[576.256670] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[576.266154] Starting dynamic subtest: pipe-D-eDP-1
[576.268945] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[576.271707] Subtest bad-hsync-end: SUCCESS (0.291s)
[577.122718] [069/132] (445s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[577.185460] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[577.188023] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[577.301795] [070/132] (445s left) kms_draw_crc (fill-fb)
[577.392875] Starting subtest: fill-fb
[577.835989] Subtest fill-fb: SUCCESS (0.442s)
[577.995220] [071/132] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[578.098434] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[578.102995] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[578.225340] [072/132] (444s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[578.324792] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[585.616960] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.270s)
[585.786582] [073/132] (437s left) syncobj_timeline (multi-wait-submitted-signaled)
[585.839166] Starting subtest: multi-wait-submitted-signaled
[585.841888] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[586.010884] [074/132] (437s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[586.113247] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[586.119021] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[586.253541] [075/132] (436s left) kms_lease (invalid-create-leases)
[586.350986] Starting subtest: invalid-create-leases
[586.356484] Subtest invalid-create-leases: SUCCESS (0.006s)
[586.490602] [076/132] (436s left) gem_render_copy (linear)
[586.552595] Starting subtest: linear
[586.554943] Starting dynamic subtest: smem
[586.591800] Dynamic subtest smem: SUCCESS (0.039s)
[586.594561] Subtest linear: SUCCESS (0.040s)
[586.841953] [077/132] (436s left) gem_mmap_offset (clear-via-pagefault)
[586.894311] Starting subtest: clear-via-pagefault
[586.896853] Starting dynamic subtest: smem0
[618.396026] Dynamic subtest smem0: SUCCESS (31.484s)
[618.398661] Subtest clear-via-pagefault: SUCCESS (31.485s)
[618.540351] [078/132] (404s left) i915_query (query-garbage)
[618.599146] Starting subtest: query-garbage
[618.601787] Subtest query-garbage: SUCCESS (0.000s)
[618.736802] [079/132] (404s left) gem_exec_whisper (basic-queues-forked-all)
[618.804818] Starting subtest: basic-queues-forked-all
[640.957467] Subtest basic-queues-forked-all: SUCCESS (22.142s)
[641.164995] [080/132] (382s left) gem_media_fill (media-fill)
[641.228956] Subtest media-fill: SKIP (0.000s)
[641.368010] [081/132] (381s left) i915_query (query-topology-kernel-writes)
[641.427011] Starting subtest: query-topology-kernel-writes
[641.430066] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[641.569471] [082/132] (381s left) kms_flip (2x-flip-vs-rmfb)
[641.658359] Starting subtest: 2x-flip-vs-rmfb
[641.669168] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[641.814135] [083/132] (381s left) kms_psr (pr-primary-mmap-cpu)
[641.911911] Starting subtest: pr-primary-mmap-cpu
[641.916912] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[642.008443] [084/132] (381s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[642.099888] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[642.104366] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[642.234528] [085/132] (381s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[642.313040] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[642.317519] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[642.521809] [086/132] (381s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[642.642151] Starting subtest: modeset-atomic-cursor-hotspot
[642.647695] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[642.810700] [087/132] (380s left) perf (blocking-parameterized)
[642.918347] Starting subtest: blocking-parameterized
[662.938726] Subtest blocking-parameterized: SUCCESS (20.015s)
[662.989595] [088/132] (360s left) kms_frontbuffer_tracking (psr-1p-rte)
[663.096124] Starting subtest: psr-1p-rte
[668.463423] Subtest psr-1p-rte: SUCCESS (5.373s)
[668.634001] [089/132] (355s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[668.743015] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[668.748551] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[668.875808] [090/132] (354s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[673.860642] Starting subtest: pr-cursor-plane-update-sf
[673.866063] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[674.733070] [091/132] (349s left) kms_async_flips (async-flip-suspend-resume)
[674.834130] Starting subtest: async-flip-suspend-resume
[675.220148] Starting dynamic subtest: pipe-A-eDP-1
[692.840685] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.896s)
[693.221914] Starting dynamic subtest: pipe-B-eDP-1
[710.889461] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.862s)
[711.300140] Starting dynamic subtest: pipe-C-eDP-1
[728.873000] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.839s)
[729.240227] Starting dynamic subtest: pipe-D-eDP-1
[746.877095] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s)
[746.881605] Subtest async-flip-suspend-resume: SUCCESS (12.955s)
[748.124555] [092/132] (275s left) prime_mmap_coherency (ioctl-errors)
[748.196507] Starting subtest: ioctl-errors
[763.742262] Subtest ioctl-errors: SUCCESS (15.307s)
[763.943822] [093/132] (259s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[764.079159] Starting subtest: psr-rgb101010-draw-mmap-cpu
[771.054508] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.953s)
[771.194833] [094/132] (252s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[771.293097] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[771.297530] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[771.427970] [095/132] (252s left) kms_fb_coherency (memset-crc)
[771.538385] Starting subtest: memset-crc
[771.540705] Starting dynamic subtest: mmap-offset-wc
[771.943075] Dynamic subtest mmap-offset-wc: SUCCESS (0.404s)
[772.247823] Starting dynamic subtest: mmap-offset-uc
[778.338967] Dynamic subtest mmap-offset-uc: SUCCESS (6.096s)
[778.636327] Subtest memset-crc: SUCCESS (7.087s)
[779.523670] [096/132] (244s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[779.624809] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[779.627121] Starting dynamic subtest: pipe-A-default-mode
[782.323951] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[782.326267] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.701s)
[783.213637] [097/132] (240s left) gem_ppgtt (blt-vs-render-ctxn)
[783.275978] Starting subtest: blt-vs-render-ctxN
[816.205496] Subtest blt-vs-render-ctxN: SUCCESS (32.918s)
[816.385289] [098/132] (207s left) i915_drm_fdinfo (busy-idle)
[816.466710] Starting subtest: busy-idle
[816.468861] Starting dynamic subtest: rcs0
[816.518141] Dynamic subtest rcs0: SKIP (0.051s)
[816.531735] Starting dynamic subtest: bcs0
[816.536133] Dynamic subtest bcs0: SKIP (0.001s)
[816.546636] Starting dynamic subtest: vcs0
[816.550717] Dynamic subtest vcs0: SKIP (0.000s)
[816.562107] Starting dynamic subtest: vcs1
[816.566726] Dynamic subtest vcs1: SKIP (0.001s)
[816.579053] Starting dynamic subtest: vecs0
[816.583318] Dynamic subtest vecs0: SKIP (0.000s)
[816.593112] Starting dynamic subtest: ccs0
[816.597462] Dynamic subtest ccs0: SKIP (0.000s)
[816.601692] Subtest busy-idle: SKIP (0.060s)
[816.638496] [099/132] (207s left) kms_frontbuffer_tracking (fbc-1p-rte)
[816.750492] Starting subtest: fbc-1p-rte
[822.201499] Subtest fbc-1p-rte: SUCCESS (5.453s)
[823.417844] [100/132] (200s left) dumb_buffer (map-valid)
[823.478127] Starting subtest: map-valid
[823.480522] Subtest map-valid: SUCCESS (0.000s)
[823.611084] [101/132] (200s left) kms_chamelium_edid (dp-edid-resolution-list)
[824.012881] Subtest dp-edid-resolution-list: SKIP (0.000s)
[824.794166] [102/132] (199s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[824.890949] Starting subtest: fbc-dirtyfb-ioctl
[824.893354] Starting dynamic subtest: A-eDP-1
[827.492169] Dynamic subtest A-eDP-1: SUCCESS (2.598s)
[827.494254] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.600s)
[828.390589] [103/132] (195s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[828.496911] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[828.501210] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[828.629557] [104/132] (195s left) prime_vgem (fence-wait)
[828.717976] Starting subtest: fence-wait
[828.719926] Starting dynamic subtest: rcs0
[829.775256] Dynamic subtest rcs0: SUCCESS (1.058s)
[829.788253] Starting dynamic subtest: bcs0
[830.856686] Dynamic subtest bcs0: SUCCESS (1.080s)
[830.869420] Starting dynamic subtest: vcs0
[831.900753] Dynamic subtest vcs0: SUCCESS (1.043s)
[831.914183] Starting dynamic subtest: vcs1
[832.941674] Dynamic subtest vcs1: SUCCESS (1.039s)
[832.954317] Starting dynamic subtest: vecs0
[833.982385] Dynamic subtest vecs0: SUCCESS (1.039s)
[833.995263] Starting dynamic subtest: ccs0
[835.025425] Dynamic subtest ccs0: SUCCESS (1.041s)
[835.028042] Subtest fence-wait: SUCCESS (6.308s)
[835.197515] [105/132] (189s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[835.305837] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[835.309841] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[835.432802] [106/132] (188s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[835.533944] Starting subtest: yf-tiled-64bpp-rotate-0
[835.538372] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[835.662788] [107/132] (188s left) gem_ctx_persistence (legacy-engines-mixed)
[835.729409] Starting subtest: legacy-engines-mixed
[835.731810] Starting dynamic subtest: render
[835.843463] Dynamic subtest render: SUCCESS (0.113s)
[835.860194] Starting dynamic subtest: bsd1
[835.913072] Dynamic subtest bsd1: SUCCESS (0.066s)
[835.929182] Starting dynamic subtest: bsd2
[835.995254] Dynamic subtest bsd2: SUCCESS (0.079s)
[836.009159] Starting dynamic subtest: blt
[836.064037] Dynamic subtest blt: SUCCESS (0.066s)
[836.081024] Starting dynamic subtest: vebox
[836.136972] Dynamic subtest vebox: SUCCESS (0.070s)
[836.139111] Subtest legacy-engines-mixed: SUCCESS (0.409s)
[836.242125] [108/132] (188s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[836.338412] Starting subtest: fbc-2p-pri-indfb-multidraw
[836.341767] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[836.471386] [109/132] (188s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[836.582860] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[836.586712] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[836.707491] [110/132] (187s left) syncobj_wait (wait-any-snapshot)
[836.767733] Starting subtest: wait-any-snapshot
[836.848076] Subtest wait-any-snapshot: SUCCESS (0.082s)
[836.946920] [111/132] (187s left) kms_psr (psr-sprite-blt)
[837.036705] Starting subtest: psr-sprite-blt
[837.038598] Starting dynamic subtest: eDP-1
[838.790524] Dynamic subtest eDP-1: SUCCESS (1.750s)
[838.793042] Subtest psr-sprite-blt: SUCCESS (1.751s)
[839.657456] [112/132] (185s left) kms_cursor_crc (cursor-onscreen-256x256)
[839.875337] Starting subtest: cursor-onscreen-256x256
[839.880563] Starting dynamic subtest: pipe-A-eDP-1
[842.010632] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[842.042540] Starting dynamic subtest: pipe-D-eDP-1
[844.824789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.792s)
[844.827161] Subtest cursor-onscreen-256x256: SUCCESS (4.948s)
[845.722719] [113/132] (178s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[845.817000] Starting subtest: x-tiled-64bpp-rotate-90
[845.836680] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[845.989643] [114/132] (178s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[846.103722] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[846.108116] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[846.275410] [115/132] (178s left) gem_ctx_shared (q-in-order)
[846.344241] Starting subtest: Q-in-order
[846.346589] Starting dynamic subtest: rcs0
[846.460378] Dynamic subtest rcs0: SUCCESS (0.114s)
[846.481927] Starting dynamic subtest: vcs0
[846.562524] Dynamic subtest vcs0: SUCCESS (0.102s)
[846.579154] Starting dynamic subtest: vcs1
[846.644386] Dynamic subtest vcs1: SUCCESS (0.080s)
[846.663323] Starting dynamic subtest: vecs0
[846.720265] Dynamic subtest vecs0: SUCCESS (0.074s)
[846.738057] Starting dynamic subtest: ccs0
[846.796122] Dynamic subtest ccs0: SUCCESS (0.076s)
[846.798657] Subtest Q-in-order: SUCCESS (0.452s)
[848.528039] [116/132] (176s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[848.626628] Starting subtest: fbc-rgb101010-draw-mmap-wc
[853.180764] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.560s)
[854.322335] [117/132] (170s left) syncobj_wait (invalid-reset-zero-handles)
[854.402852] Starting subtest: invalid-reset-zero-handles
[854.405111] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[854.545580] [118/132] (170s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[854.640161] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[854.642322] Starting dynamic subtest: pipe-A
[854.663126] Dynamic subtest pipe-A: SKIP (0.020s)
[854.674503] Starting dynamic subtest: pipe-B
[854.693986] Dynamic subtest pipe-B: SKIP (0.031s)
[854.705810] Starting dynamic subtest: pipe-C
[854.730661] Dynamic subtest pipe-C: SKIP (0.034s)
[854.740906] Starting dynamic subtest: pipe-D
[854.762078] Dynamic subtest pipe-D: SKIP (0.031s)
[854.766157] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.120s)
[854.882161] [119/132] (170s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[854.979397] Starting subtest: y-tiled-16bpp-rotate-90
[854.983639] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[855.103383] [120/132] (169s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[855.205321] Starting subtest: fbc-psr-cursor-mmap-gtt
[855.207490] Starting dynamic subtest: eDP-1
[855.211379] Dynamic subtest eDP-1: SKIP (0.000s)
[855.215148] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[855.304259] [121/132] (169s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[855.434805] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[855.436723] Starting dynamic subtest: pipe-A-eDP-1
[856.185334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[856.195692] Starting dynamic subtest: pipe-B-eDP-1
[858.001176] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.814s)
[858.013283] Starting dynamic subtest: pipe-C-eDP-1
[859.827250] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[859.837606] Starting dynamic subtest: pipe-D-eDP-1
[861.581682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.753s)
[861.583601] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.141s)
[862.858222] [122/132] (162s left) kms_busy (basic)
[862.962421] Starting subtest: basic
[862.964828] Starting dynamic subtest: flip
[863.565417] Dynamic subtest flip: SUCCESS (0.601s)
[863.577515] Starting dynamic subtest: modeset
[867.198877] Dynamic subtest modeset: SUCCESS (3.634s)
[867.201246] Subtest basic: SUCCESS (4.237s)
[868.022011] [123/132] (157s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[868.318405] Starting subtest: cursor-rapid-movement-512x170
[868.322858] Subtest cursor-rapid-movement-512x170: SKIP (0.002s)
[868.479248] [124/132] (156s left) kms_plane_alpha_blend (constant-alpha-min)
[868.576746] Starting subtest: constant-alpha-min
[868.860743] Starting dynamic subtest: pipe-A-eDP-1
[869.603651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[869.615159] Starting dynamic subtest: pipe-D-eDP-1
[871.080720] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.476s)
[871.083010] Subtest constant-alpha-min: SUCCESS (2.504s)
[871.905178] [125/132] (153s left) prime_self_import (basic-llseek-bad)
[871.947389] Starting subtest: basic-llseek-bad
[871.973914] Subtest basic-llseek-bad: SUCCESS (0.026s)
[872.111902] [126/132] (153s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[872.504753] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[873.296577] [127/132] (152s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[873.391950] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[873.394300] Starting dynamic subtest: A-eDP1
[882.256988] Dynamic subtest A-eDP1: SUCCESS (8.864s)
[882.275757] Starting dynamic subtest: B-eDP1
[891.195231] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[891.210145] Starting dynamic subtest: C-eDP1
[900.116865] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[900.129347] Starting dynamic subtest: D-eDP1
[909.044867] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[909.050292] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.653s)
[910.312602] [128/132] (115s left) gem_exec_parallel (fds)
[910.389115] Starting subtest: fds
[910.391489] Starting dynamic subtest: rcs0
[913.291022] Dynamic subtest rcs0: SUCCESS (2.899s)
[913.304842] Starting dynamic subtest: bcs0
[916.781550] Dynamic subtest bcs0: SUCCESS (3.489s)
[916.797744] Starting dynamic subtest: vcs0
[920.677610] Dynamic subtest vcs0: SUCCESS (3.891s)
[920.691861] Starting dynamic subtest: vcs1
[924.685310] Dynamic subtest vcs1: SUCCESS (4.004s)
[924.699059] Starting dynamic subtest: vecs0
[928.653478] Dynamic subtest vecs0: SUCCESS (3.964s)
[928.667470] Starting dynamic subtest: ccs0
[932.446017] Dynamic subtest ccs0: SUCCESS (3.788s)
[932.448951] Subtest fds: SUCCESS (22.050s)
[932.664460] [129/132] ( 92s left) prime_vgem (fence-write-hang)
[932.749749] Subtest fence-write-hang: SKIP (0.000s)
[932.901946] [130/132] ( 92s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[933.004154] Starting subtest: fbc-modesetfrombusy
[936.858297] Subtest fbc-modesetfrombusy: SUCCESS (3.856s)
[938.050851] [131/132] ( 87s left) syncobj_timeline (wait-all-for-submit-snapshot)
[938.115972] Starting subtest: wait-all-for-submit-snapshot
[938.197223] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[938.300106] [132/132] ( 87s left) kms_scaling_modes (scaling-mode-center)
[938.398676] Starting subtest: scaling-mode-center
[938.400823] Starting dynamic subtest: pipe-A-eDP-1
[938.497869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[938.508720] Starting dynamic subtest: pipe-B-eDP-1
[939.640965] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[939.657328] Starting dynamic subtest: pipe-C-eDP-1
[940.752746] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[940.764544] Starting dynamic subtest: pipe-D-eDP-1
[941.886575] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[941.888838] Subtest scaling-mode-center: SUCCESS (3.487s)
[943.076059] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: i915_hangman
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gem_workarounds
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: i915_selftest
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_getfb
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: prime_vgem
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: core_auth
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: gem_readwrite
results: parsing output: 46/ for test: core_getstats
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: kms_psr2_su
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: vgem_basic
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: gem_tiled_fence_blits
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_invalid_mode
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: i915_query
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: gem_media_fill
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: prime_mmap_coherency
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_fb_coherency
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_ppgtt
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: dumb_buffer
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_dirtyfb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: prime_self_import
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_exec_parallel
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_scaling_modes
Done.