[57.856346] Initializing watchdogs
[57.856389]   /dev/watchdog0
[57.869925] [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]
[57.874336] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.876660] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.879915] [001/132] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[58.015638] Starting subtest: psr-rgb565-draw-mmap-wc
[64.720814] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.724s)
[64.853288] [002/132] (953s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[64.995393] Starting subtest: flip-vs-cursor-atomic-transitions
[72.782877] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.793s)
[73.624890] [003/132] (944s left) i915_hangman (engine-error-state-capture)
[73.701337] Starting subtest: engine-error-state-capture
[73.703607] Starting dynamic subtest: rcs0
[76.852819] Dynamic subtest rcs0: SUCCESS (3.152s)
[76.863630] Starting dynamic subtest: bcs0
[82.870745] Dynamic subtest bcs0: SUCCESS (6.017s)
[82.880434] Starting dynamic subtest: vcs0
[88.819799] Dynamic subtest vcs0: SUCCESS (5.948s)
[88.830828] Starting dynamic subtest: vcs1
[93.814548] Dynamic subtest vcs1: SUCCESS (4.993s)
[93.826303] Starting dynamic subtest: vecs0
[99.827552] Dynamic subtest vecs0: SUCCESS (6.012s)
[99.838650] Starting dynamic subtest: ccs0
[104.884966] Dynamic subtest ccs0: SUCCESS (5.055s)
[104.887672] Subtest engine-error-state-capture: SUCCESS (31.184s)
[104.984549] [004/132] (913s left) perf_pmu (frequency)
[105.024863] Starting subtest: frequency
[105.029234] Starting dynamic subtest: gt0
[107.217492] Dynamic subtest gt0: SUCCESS (2.183s)
[107.226868] Starting dynamic subtest: idle-gt0
[107.721167] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[107.731421] Starting dynamic subtest: gt1
[111.908642] Dynamic subtest gt1: SUCCESS (4.184s)
[111.919638] Starting dynamic subtest: idle-gt1
[112.412732] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[112.415397] Subtest frequency: SUCCESS (7.389s)
[112.531631] [005/132] (906s left) kms_pm_dc (dc5-dpms)
[113.647142] Starting subtest: dc5-dpms
[115.679739] Subtest dc5-dpms: SUCCESS (2.033s)
[115.775455] [006/132] (902s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[115.842205] Starting subtest: multi-wait-all-for-submit-available-submitted
[115.844489] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[115.978450] [007/132] (902s left) gen9_exec_parse (basic-rejected)
[116.052830] Subtest basic-rejected: SKIP (0.000s)
[116.122041] [008/132] (902s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[116.230400] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[116.234600] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[116.345652] [009/132] (902s left) gem_exec_schedule (promotion)
[116.425939] Starting subtest: promotion
[116.428064] Starting dynamic subtest: rcs0
[116.530686] Dynamic subtest rcs0: SUCCESS (0.111s)
[116.540977] Starting dynamic subtest: vcs0
[116.621861] Dynamic subtest vcs0: SUCCESS (0.090s)
[116.632262] Starting dynamic subtest: vcs1
[116.702385] Dynamic subtest vcs1: SUCCESS (0.080s)
[116.713778] Starting dynamic subtest: vecs0
[116.780237] Dynamic subtest vecs0: SUCCESS (0.078s)
[116.790609] Starting dynamic subtest: ccs0
[116.861570] Dynamic subtest ccs0: SUCCESS (0.081s)
[116.863811] Subtest promotion: SUCCESS (0.443s)
[118.041784] [010/132] (900s left) kms_rotation_crc (exhaust-fences)
[118.145467] Starting subtest: exhaust-fences
[118.149981] Subtest exhaust-fences: SKIP (0.000s)
[118.238988] [011/132] (900s left) syncobj_wait (signal)
[118.294996] Starting subtest: signal
[118.297266] Subtest signal: SUCCESS (0.000s)
[118.411342] [012/132] (900s left) kms_color (deep-color)
[118.504957] Starting subtest: deep-color
[119.609762] Starting dynamic subtest: pipe-A-eDP-1-gamma
[120.304908] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.694s)
[120.314394] Starting dynamic subtest: pipe-A-eDP-1-degamma
[121.714124] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.401s)
[121.723709] Starting dynamic subtest: pipe-A-eDP-1-ctm
[123.117691] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.410s)
[123.918697] Starting dynamic subtest: pipe-B-eDP-1-gamma
[124.625950] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.714s)
[124.634796] Starting dynamic subtest: pipe-B-eDP-1-degamma
[126.082794] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.456s)
[126.092231] Starting dynamic subtest: pipe-B-eDP-1-ctm
[127.509286] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.424s)
[128.306049] Starting dynamic subtest: pipe-C-eDP-1-gamma
[128.988522] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[128.998280] Starting dynamic subtest: pipe-C-eDP-1-degamma
[130.359098] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.369s)
[130.366918] Starting dynamic subtest: pipe-C-eDP-1-ctm
[131.796322] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.436s)
[132.614149] Starting dynamic subtest: pipe-D-eDP-1-gamma
[133.291036] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.684s)
[133.299734] Starting dynamic subtest: pipe-D-eDP-1-degamma
[134.656623] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.366s)
[134.665766] Starting dynamic subtest: pipe-D-eDP-1-ctm
[136.068052] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.410s)
[136.070252] Subtest deep-color: SUCCESS (17.563s)
[136.962874] [013/132] (881s left) gem_exec_fence (syncobj-signal)
[137.401717] Starting subtest: syncobj-signal
[137.406744] Subtest syncobj-signal: SUCCESS (0.005s)
[138.976256] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[138.979344] [014/132] (879s left) gem_exec_balancer (semaphore)
[139.047702] Starting subtest: semaphore
[140.877552] Subtest semaphore: SUCCESS (1.828s)
[141.229458] [015/132] (877s left) gem_workarounds (suspend-resume-context)
[141.305051] Starting subtest: suspend-resume-context
[157.953572] Subtest suspend-resume-context: SUCCESS (1.305s)
[158.118810] [016/132] (860s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[158.234676] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[158.236995] Starting dynamic subtest: pipe-A-eDP-1
[158.259202] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[158.270175] Starting dynamic subtest: pipe-B-eDP-1
[158.291419] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[158.299988] Starting dynamic subtest: pipe-C-eDP-1
[158.322318] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.331061] Starting dynamic subtest: pipe-D-eDP-1
[158.352710] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.356852] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[160.487525] [017/132] (858s left) gem_spin_batch (resubmit-new)
[160.542520] Starting subtest: resubmit-new
[160.544931] Starting dynamic subtest: rcs0
[160.551070] Dynamic subtest rcs0: SUCCESS (0.009s)
[160.562802] Starting dynamic subtest: bcs0
[160.565017] Dynamic subtest bcs0: SUCCESS (0.006s)
[160.573646] Starting dynamic subtest: vcs0
[160.575841] Dynamic subtest vcs0: SUCCESS (0.005s)
[160.584728] Starting dynamic subtest: vcs1
[160.588757] Dynamic subtest vcs1: SUCCESS (0.004s)
[160.597208] Starting dynamic subtest: vecs0
[160.599013] Dynamic subtest vecs0: SUCCESS (0.006s)
[160.610580] Starting dynamic subtest: ccs0
[160.612652] Dynamic subtest ccs0: SUCCESS (0.005s)
[160.614841] Subtest resubmit-new: SUCCESS (0.037s)
[162.308087] [018/132] (856s left) kms_pm_rpm (i2c)
[164.347725] Starting subtest: i2c
[169.297114] Subtest i2c: SUCCESS (4.978s)
[169.412622] [019/132] (849s left) gem_pxp (display-protected-crc)
[169.541653] Starting subtest: display-protected-crc
[171.222862] Subtest display-protected-crc: SUCCESS (1.690s)
[171.396861] [020/132] (847s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[171.499933] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[171.502101] Starting dynamic subtest: pipe-A-eDP-1
[171.524658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[171.535286] Starting dynamic subtest: pipe-B-eDP-1
[171.556896] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[171.565347] Starting dynamic subtest: pipe-C-eDP-1
[171.586080] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[171.594521] Starting dynamic subtest: pipe-D-eDP-1
[171.616596] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[171.620645] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[173.760022] [021/132] (845s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[173.843973] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[173.848524] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[174.986070] [022/132] (844s left) i915_selftest (live)
[178.402518] Starting subtest: live
[178.405212] Starting dynamic subtest: sanitycheck
[182.845441] Dynamic subtest sanitycheck: SUCCESS (4.449s)
[182.855063] Starting dynamic subtest: uncore
[185.594147] Dynamic subtest uncore: SUCCESS (2.750s)
[185.603767] Starting dynamic subtest: workarounds
[203.284285] Dynamic subtest workarounds: FAIL (17.203s)
[203.293757] Starting dynamic subtest: gt_engines
[207.479945] Dynamic subtest gt_engines: SUCCESS (4.681s)
[207.489346] Starting dynamic subtest: gt_timelines
[225.271242] Dynamic subtest gt_timelines: SUCCESS (17.793s)
[225.280409] Starting dynamic subtest: gt_contexts
[229.773875] Dynamic subtest gt_contexts: SUCCESS (4.501s)
[229.783885] Starting dynamic subtest: gt_lrc
[234.230481] Dynamic subtest gt_lrc: SUCCESS (4.456s)
[234.246458] Starting dynamic subtest: gt_mocs
[237.287019] Dynamic subtest gt_mocs: SUCCESS (3.056s)
[237.296133] Starting dynamic subtest: gt_pm
[244.220760] Dynamic subtest gt_pm: SUCCESS (6.935s)
[244.229966] Starting dynamic subtest: gt_heartbeat
[248.650524] Dynamic subtest gt_heartbeat: SUCCESS (4.429s)
[248.665016] Starting dynamic subtest: gt_tlb
[258.012888] Dynamic subtest gt_tlb: SUCCESS (9.360s)
[258.022611] Starting dynamic subtest: requests
[271.724274] Dynamic subtest requests: SUCCESS (13.705s)
[271.734211] Starting dynamic subtest: migrate
[279.832321] Dynamic subtest migrate: SUCCESS (8.105s)
[279.847496] Starting dynamic subtest: active
[284.295945] Dynamic subtest active: SUCCESS (4.461s)
[284.305475] Starting dynamic subtest: objects
[289.144285] Dynamic subtest objects: SUCCESS (4.847s)
[289.154104] Starting dynamic subtest: mman
[294.095790] Dynamic subtest mman: SUCCESS (4.950s)
[294.105614] Starting dynamic subtest: dmabuf
[298.614052] Dynamic subtest dmabuf: SUCCESS (4.516s)
[298.623754] Starting dynamic subtest: vma
[303.106301] Dynamic subtest vma: SUCCESS (4.490s)
[303.116227] Starting dynamic subtest: coherency
[308.100080] Dynamic subtest coherency: SUCCESS (4.992s)
[308.110534] Starting dynamic subtest: gtt
[320.064486] Dynamic subtest gtt: SUCCESS (11.964s)
[320.073958] Starting dynamic subtest: gem
[326.111594] Dynamic subtest gem: SUCCESS (6.046s)
[326.121595] Starting dynamic subtest: evict
[331.584474] Dynamic subtest evict: SUCCESS (5.473s)
[331.594066] Starting dynamic subtest: hugepages
[342.712870] Dynamic subtest hugepages: SUCCESS (11.129s)
[342.721702] Starting dynamic subtest: gem_contexts
[369.484304] Dynamic subtest gem_contexts: SUCCESS (26.777s)
[369.493472] Starting dynamic subtest: client
[373.942751] Dynamic subtest client: SUCCESS (4.458s)
[373.952195] Starting dynamic subtest: gem_migrate
[378.394569] Dynamic subtest gem_migrate: SUCCESS (4.451s)
[378.404094] Starting dynamic subtest: reset
[382.761196] Dynamic subtest reset: SUCCESS (4.365s)
[382.771130] Starting dynamic subtest: memory_region
[387.219327] Dynamic subtest memory_region: SUCCESS (4.455s)
[387.229309] Starting dynamic subtest: hangcheck
[400.335433] Dynamic subtest hangcheck: SUCCESS (13.109s)
[400.345371] Starting dynamic subtest: execlists
[404.786133] Dynamic subtest execlists: SUCCESS (4.448s)
[404.795496] Starting dynamic subtest: ring_submission
[409.198043] Dynamic subtest ring_submission: SUCCESS (4.409s)
[409.207387] Starting dynamic subtest: perf
[413.570930] Dynamic subtest perf: SUCCESS (4.369s)
[413.580714] Starting dynamic subtest: slpc
[427.681387] Dynamic subtest slpc: SUCCESS (14.106s)
[427.691627] Starting dynamic subtest: guc
[431.758414] Dynamic subtest guc: SUCCESS (4.074s)
[431.768192] Starting dynamic subtest: guc_multi_lrc
[434.571460] Dynamic subtest guc_multi_lrc: SUCCESS (2.810s)
[434.581449] Starting dynamic subtest: guc_hang
[439.581440] Dynamic subtest guc_hang: SUCCESS (5.008s)
[439.590897] Starting dynamic subtest: late_gt_pm
[444.011156] Dynamic subtest late_gt_pm: SUCCESS (4.428s)
[444.013693] Subtest live: FAIL (265.625s)
[444.045751] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[444.046435] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[444.049528] [023/132] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[445.767639] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[452.634962] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.871s)
[452.786725] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[452.787881] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[452.791596] [024/132] (566s left) perf (gen12-oa-tlb-invalidate)
[452.948441] Starting subtest: gen12-oa-tlb-invalidate
[452.950596] Starting dynamic subtest: 0-rcs0
[462.997170] Dynamic subtest 0-rcs0: SUCCESS (10.048s)
[463.005999] Starting dynamic subtest: 1-vecs0
[473.045776] Dynamic subtest 1-vecs0: SUCCESS (10.049s)
[473.048882] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.099s)
[473.088763] [025/132] (546s left) kms_addfb_basic (too-wide)
[473.197580] Starting subtest: too-wide
[473.199870] Subtest too-wide: SUCCESS (0.000s)
[473.313354] [026/132] (546s left) kms_big_fb (linear-8bpp-rotate-180)
[473.430269] Starting subtest: linear-8bpp-rotate-180
[474.701774] Subtest linear-8bpp-rotate-180: SUCCESS (1.271s)
[474.854154] [027/132] (544s left) kms_getfb (getfb-reject-nv12)
[474.953145] Starting subtest: getfb-reject-nv12
[474.954993] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[475.091162] [028/132] (544s left) kms_plane (plane-panning-bottom-right)
[475.187142] Starting subtest: plane-panning-bottom-right
[475.188729] Starting dynamic subtest: pipe-A
[476.887447] Dynamic subtest pipe-A: SUCCESS (1.700s)
[476.898038] Starting dynamic subtest: pipe-B
[479.226981] Dynamic subtest pipe-B: SUCCESS (2.337s)
[479.229283] Subtest plane-panning-bottom-right: SUCCESS (4.040s)
[480.062249] [029/132] (539s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[480.133236] Starting subtest: map-fixed-invalidate-overlap-busy
[480.137967] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[480.291106] [030/132] (539s left) prime_vgem (basic-write)
[480.389451] Starting subtest: basic-write
[480.398913] Subtest basic-write: SKIP (0.007s)
[480.531043] [031/132] (539s left) gem_exec_whisper (basic-contexts-forked-all)
[480.600597] Starting subtest: basic-contexts-forked-all
[501.295198] Subtest basic-contexts-forked-all: SUCCESS (20.694s)
[501.504346] [032/132] (518s left) kms_psr (fbc-pr-cursor-blt)
[501.598013] Starting subtest: fbc-pr-cursor-blt
[501.602417] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[501.695359] [033/132] (517s left) gen7_exec_parse (basic-allowed)
[501.756966] Subtest basic-allowed: SKIP (0.000s)
[501.843592] [034/132] (517s left) core_auth (getclient-simple)
[501.879360] Starting subtest: getclient-simple
[501.899396] Subtest getclient-simple: SUCCESS (0.021s)
[502.034025] [035/132] (517s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[502.132924] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[502.135108] Starting dynamic subtest: pipe-A-default-mode
[502.422238] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[502.426825] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.287s)
[503.296087] [036/132] (516s left) gem_create (create-ext-placement-sanity-check)
[503.474816] Starting subtest: create-ext-placement-sanity-check
[503.477397] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s)
[503.614594] [037/132] (516s left) kms_psr (psr2-sprite-blt)
[503.711825] Starting subtest: psr2-sprite-blt
[503.714124] Starting dynamic subtest: eDP-1
[505.471329] Dynamic subtest eDP-1: SUCCESS (1.757s)
[505.475731] Subtest psr2-sprite-blt: SUCCESS (1.758s)
[506.353717] [038/132] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[506.447600] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[506.451679] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[506.568261] [039/132] (513s left) gem_ctx_persistence (engines-hang)
[506.624884] Starting subtest: engines-hang
[506.627237] Starting dynamic subtest: rcs0
[506.777795] Dynamic subtest rcs0: SUCCESS (0.152s)
[506.790731] Starting dynamic subtest: bcs0
[506.898778] Dynamic subtest bcs0: SUCCESS (0.119s)
[506.911148] Starting dynamic subtest: vcs0
[507.026830] Dynamic subtest vcs0: SUCCESS (0.126s)
[507.039180] Starting dynamic subtest: vcs1
[507.138115] Dynamic subtest vcs1: SUCCESS (0.109s)
[507.150280] Starting dynamic subtest: vecs0
[507.254570] Dynamic subtest vecs0: SUCCESS (0.115s)
[507.265890] Starting dynamic subtest: ccs0
[507.378444] Dynamic subtest ccs0: SUCCESS (0.122s)
[507.380922] Subtest engines-hang: SUCCESS (0.755s)
[507.479958] [040/132] (512s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[507.584149] Starting subtest: cursorA-vs-flipB-atomic
[507.587954] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[507.748204] [041/132] (512s left) gem_exec_reloc (basic-write-gtt)
[507.823776] Subtest basic-write-gtt: SKIP (0.000s)
[507.923192] [042/132] (512s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[507.984090] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[508.091617] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[508.190659] [043/132] (511s left) gem_render_copy (linear-to-vebox-yf-tiled)
[508.253545] Starting subtest: linear-to-vebox-yf-tiled
[508.257581] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[508.458417] [044/132] (511s left) kms_addfb_basic (invalid-get-prop-any)
[508.514100] Starting subtest: invalid-get-prop-any
[508.516296] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[508.679502] [045/132] (511s left) kms_flip (busy-flip)
[508.760057] Starting subtest: busy-flip
[508.762266] Starting dynamic subtest: A-eDP1
[510.441528] Dynamic subtest A-eDP1: SUCCESS (1.683s)
[510.451977] Starting dynamic subtest: B-eDP1
[512.163821] Dynamic subtest B-eDP1: SUCCESS (1.720s)
[512.177554] Starting dynamic subtest: C-eDP1
[513.884041] Dynamic subtest C-eDP1: SUCCESS (1.719s)
[513.893123] Starting dynamic subtest: D-eDP1
[515.520036] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[515.522373] Subtest busy-flip: SUCCESS (6.767s)
[516.710221] [046/132] (503s left) gem_readwrite (read-bad-handle)
[516.773454] Subtest read-bad-handle: SKIP (0.000s)
[516.838954] [047/132] (503s left) core_getstats (basic)
[516.901046] Starting subtest: basic
[516.903133] Subtest basic: SUCCESS (0.000s)
[517.035092] [048/132] (503s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[517.132900] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[517.768054] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[517.986799] [049/132] (502s left) kms_atomic (plane-invalid-params-fence)
[518.085814] Starting subtest: plane-invalid-params-fence
[518.087924] Starting dynamic subtest: pipe-A-eDP-1
[518.445043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[518.447535] Subtest plane-invalid-params-fence: SUCCESS (0.362s)
[519.346419] [050/132] (501s left) kms_pm_rpm (pc8-residency)
[521.368468] Starting subtest: pc8-residency
[521.373923] Subtest pc8-residency: SKIP (0.000s)
[521.772892] [051/132] (498s left) kms_psr2_su (frontbuffer-xrgb8888)
[521.833984] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[521.899452] [052/132] (498s left) syncobj_timeline (etime-single-wait-submitted)
[521.962930] Starting subtest: etime-single-wait-submitted
[522.066952] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[522.167092] [053/132] (498s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[522.261127] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[522.265797] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[522.402540] [054/132] (498s left) kms_chamelium_color (ctm-blue-to-red)
[522.487880] Subtest ctm-blue-to-red: SKIP (0.000s)
[522.534814] [055/132] (498s left) syncobj_wait (multi-wait-all-signaled)
[522.596457] Starting subtest: multi-wait-all-signaled
[522.598629] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[522.710716] [056/132] (497s left) prime_mmap (test_correct_cpu_write)
[522.771267] Starting subtest: test_correct_cpu_write
[522.773484] Starting dynamic subtest: test_correct_cpu_write-smem
[522.775605] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[522.777795] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[522.898264] [057/132] (497s left) gem_exec_reloc (basic-concurrent16)
[522.972438] Subtest basic-concurrent16: SKIP (0.000s)
[523.053773] [058/132] (497s left) vgem_basic (bad-handle)
[523.085551] Starting subtest: bad-handle
[523.087503] Subtest bad-handle: SUCCESS (0.000s)
[523.169216] [059/132] (497s left) gem_userptr_blits (readonly-pwrite-unsync)
[523.228103] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[523.391019] [060/132] (497s left) gem_exec_schedule (implicit-read-write)
[523.458167] Starting subtest: implicit-read-write
[523.459901] Starting dynamic subtest: rcs0
[523.559381] Dynamic subtest rcs0: SUCCESS (0.109s)
[523.572249] Starting dynamic subtest: vcs0
[523.637309] Dynamic subtest vcs0: SUCCESS (0.077s)
[523.649475] Starting dynamic subtest: vcs1
[523.718456] Dynamic subtest vcs1: SUCCESS (0.081s)
[523.732208] Starting dynamic subtest: vecs0
[523.792336] Dynamic subtest vecs0: SUCCESS (0.073s)
[523.804924] Starting dynamic subtest: ccs0
[523.873143] Dynamic subtest ccs0: SUCCESS (0.080s)
[523.875213] Subtest implicit-read-write: SUCCESS (0.425s)
[525.382928] [061/132] (495s left) gem_tiled_fence_blits (normal)
[525.449498] Subtest normal: SKIP (0.000s)
[525.536930] [062/132] (495s left) i915_pm_rpm (gem-idle)
[527.363576] Starting subtest: gem-idle
[533.560664] Subtest gem-idle: SUCCESS (6.201s)
[533.914077] [063/132] (486s left) kms_content_protection (content-type-change)
[535.294674] Starting subtest: content-type-change
[535.299168] Subtest content-type-change: SKIP (0.000s)
[535.485984] [064/132] (485s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[535.602550] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[539.329617] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.734s)
[540.509016] [065/132] (480s left) kms_vblank (ts-continuation-dpms-suspend)
[540.619095] Starting subtest: ts-continuation-dpms-suspend
[540.620951] Starting dynamic subtest: pipe-A-eDP-1
[557.509672] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.848s)
[557.524595] Starting dynamic subtest: pipe-D-eDP-1
[575.492143] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.509s)
[575.494523] Subtest ts-continuation-dpms-suspend: SUCCESS (4.362s)
[576.311166] [066/132] (444s left) perf_pmu (most-busy-idle-check-all)
[576.361447] Starting subtest: most-busy-idle-check-all
[576.363781] Starting dynamic subtest: rcs0
[577.058144] Dynamic subtest rcs0: FAIL (0.631s)
[577.068818] Starting dynamic subtest: bcs0
[577.817836] Dynamic subtest bcs0: SUCCESS (0.839s)
[577.829622] Starting dynamic subtest: vcs0
[579.801981] Dynamic subtest vcs0: SUCCESS (1.999s)
[579.813230] Starting dynamic subtest: vcs1
[581.786234] Dynamic subtest vcs1: SUCCESS (1.996s)
[581.797258] Starting dynamic subtest: vecs0
[583.771343] Dynamic subtest vecs0: SUCCESS (1.994s)
[583.782576] Starting dynamic subtest: ccs0
[585.819384] Dynamic subtest ccs0: SUCCESS (2.054s)
[585.822271] Subtest most-busy-idle-check-all: FAIL (9.527s)
[585.941986] [067/132] (435s left) gem_exec_balancer (full-pulse)
[586.002318] Starting subtest: full-pulse
[590.695787] Subtest full-pulse: SUCCESS (4.708s)
[590.988908] [068/132] (430s left) kms_invalid_mode (bad-hsync-end)
[591.104227] Starting subtest: bad-hsync-end
[591.106462] Starting dynamic subtest: pipe-A-eDP-1
[591.388958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[591.400030] Starting dynamic subtest: pipe-B-eDP-1
[591.402206] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[591.411365] Starting dynamic subtest: pipe-C-eDP-1
[591.413643] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[591.422996] Starting dynamic subtest: pipe-D-eDP-1
[591.425229] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[591.427546] Subtest bad-hsync-end: SUCCESS (0.293s)
[592.250919] [069/132] (428s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[592.324931] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[592.327142] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[592.466690] [070/132] (428s left) kms_draw_crc (fill-fb)
[592.564586] Starting subtest: fill-fb
[593.027511] Subtest fill-fb: SUCCESS (0.465s)
[593.165492] [071/132] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[593.278464] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[593.281797] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[593.394837] [072/132] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[593.490629] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[600.761580] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.282s)
[600.929449] [073/132] (420s left) syncobj_timeline (multi-wait-submitted-signaled)
[600.989342] Starting subtest: multi-wait-submitted-signaled
[600.991598] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[601.132779] [074/132] (420s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[601.238433] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[601.242665] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[601.384160] [075/132] (420s left) kms_lease (invalid-create-leases)
[601.481222] Starting subtest: invalid-create-leases
[601.486412] Subtest invalid-create-leases: SUCCESS (0.005s)
[601.626851] [076/132] (419s left) gem_render_copy (linear)
[601.690976] Starting subtest: linear
[601.692984] Starting dynamic subtest: smem
[601.729981] Dynamic subtest smem: SUCCESS (0.039s)
[601.732068] Subtest linear: SUCCESS (0.039s)
[601.974295] [077/132] (419s left) gem_mmap_offset (clear-via-pagefault)
[602.048336] Starting subtest: clear-via-pagefault
[602.050307] Starting dynamic subtest: smem0
[637.480791] Dynamic subtest smem0: SUCCESS (35.425s)
[637.482858] Subtest clear-via-pagefault: SUCCESS (35.427s)
[637.623365] [078/132] (383s left) i915_query (query-garbage)
[637.681075] Starting subtest: query-garbage
[637.683301] Subtest query-garbage: SUCCESS (0.000s)
[637.812134] [079/132] (383s left) gem_exec_whisper (basic-queues-forked-all)
[637.883309] Starting subtest: basic-queues-forked-all
[658.222012] Subtest basic-queues-forked-all: SUCCESS (20.338s)
[658.435656] [080/132] (363s left) gem_media_fill (media-fill)
[658.497526] Subtest media-fill: SKIP (0.000s)
[658.635321] [081/132] (363s left) i915_query (query-topology-kernel-writes)
[658.698508] Starting subtest: query-topology-kernel-writes
[658.700798] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[658.840643] [082/132] (362s left) kms_flip (2x-flip-vs-rmfb)
[658.946901] Starting subtest: 2x-flip-vs-rmfb
[658.956654] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[659.059691] [083/132] (362s left) kms_psr (pr-primary-mmap-cpu)
[659.154347] Starting subtest: pr-primary-mmap-cpu
[659.158398] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[659.255684] [084/132] (362s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[659.359719] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[659.363343] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[659.477338] [085/132] (362s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[659.530855] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[659.534532] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[659.736783] [086/132] (362s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[659.847772] Starting subtest: modeset-atomic-cursor-hotspot
[659.852081] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[660.038803] [087/132] (361s left) perf (blocking-parameterized)
[660.146238] Starting subtest: blocking-parameterized
[680.169872] Subtest blocking-parameterized: SUCCESS (20.022s)
[680.219521] [088/132] (341s left) kms_frontbuffer_tracking (psr-1p-rte)
[680.326573] Starting subtest: psr-1p-rte
[685.711223] Subtest psr-1p-rte: SUCCESS (5.385s)
[685.874667] [089/132] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[685.968144] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[685.972245] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[686.093200] [090/132] (335s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[691.080873] Starting subtest: pr-cursor-plane-update-sf
[691.085276] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[691.965148] [091/132] (330s left) kms_async_flips (async-flip-suspend-resume)
[692.070523] Starting subtest: async-flip-suspend-resume
[692.441805] Starting dynamic subtest: pipe-A-eDP-1
[710.946639] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.919s)
[711.343425] Starting dynamic subtest: pipe-B-eDP-1
[728.936700] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.885s)
[729.299643] Starting dynamic subtest: pipe-C-eDP-1
[746.959045] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.911s)
[747.321659] Starting dynamic subtest: pipe-D-eDP-1
[764.956879] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.908s)
[764.959782] Subtest async-flip-suspend-resume: SUCCESS (13.105s)
[766.130492] [092/132] (255s left) prime_mmap_coherency (ioctl-errors)
[766.194334] Starting subtest: ioctl-errors
[790.019910] Subtest ioctl-errors: SUCCESS (23.915s)
[790.204662] [093/132] (231s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[790.339307] Starting subtest: psr-rgb101010-draw-mmap-cpu
[797.255398] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.922s)
[797.425728] [094/132] (224s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[797.546373] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[797.551949] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[797.684483] [095/132] (224s left) kms_fb_coherency (memset-crc)
[797.788726] Starting subtest: memset-crc
[797.791043] Starting dynamic subtest: mmap-offset-wc
[798.183774] Dynamic subtest mmap-offset-wc: SUCCESS (0.395s)
[798.485321] Starting dynamic subtest: mmap-offset-uc
[803.878223] Dynamic subtest mmap-offset-uc: SUCCESS (5.400s)
[804.175126] Subtest memset-crc: SUCCESS (6.384s)
[805.029343] [096/132] (217s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[805.132019] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[805.134662] Starting dynamic subtest: pipe-A-default-mode
[807.869140] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[807.872129] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.738s)
[808.742797] [097/132] (213s left) gem_ppgtt (blt-vs-render-ctxn)
[808.807916] Starting subtest: blt-vs-render-ctxN
[841.699444] Subtest blt-vs-render-ctxN: SUCCESS (32.896s)
[841.887877] [098/132] (180s left) i915_drm_fdinfo (busy-idle)
[841.967602] Starting subtest: busy-idle
[841.970469] Starting dynamic subtest: rcs0
[842.005613] Dynamic subtest rcs0: SKIP (0.035s)
[842.018734] Starting dynamic subtest: bcs0
[842.024132] Dynamic subtest bcs0: SKIP (0.001s)
[842.034246] Starting dynamic subtest: vcs0
[842.039843] Dynamic subtest vcs0: SKIP (0.001s)
[842.050228] Starting dynamic subtest: vcs1
[842.055628] Dynamic subtest vcs1: SKIP (0.001s)
[842.065603] Starting dynamic subtest: vecs0
[842.070945] Dynamic subtest vecs0: SKIP (0.001s)
[842.081018] Starting dynamic subtest: ccs0
[842.086097] Dynamic subtest ccs0: SKIP (0.001s)
[842.091126] Subtest busy-idle: SKIP (0.050s)
[842.132506] [099/132] (180s left) kms_frontbuffer_tracking (fbc-1p-rte)
[842.244172] Starting subtest: fbc-1p-rte
[847.707816] Subtest fbc-1p-rte: SUCCESS (5.471s)
[848.937128] [100/132] (173s left) dumb_buffer (map-valid)
[848.983642] Starting subtest: map-valid
[848.985589] Subtest map-valid: SUCCESS (0.000s)
[849.104800] [101/132] (173s left) kms_chamelium_edid (dp-edid-resolution-list)
[849.485540] Subtest dp-edid-resolution-list: SKIP (0.000s)
[850.304851] [102/132] (172s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[850.405086] Starting subtest: fbc-dirtyfb-ioctl
[850.407639] Starting dynamic subtest: A-eDP-1
[852.997024] Dynamic subtest A-eDP-1: SUCCESS (2.593s)
[852.999914] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.595s)
[853.897516] [103/132] (168s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[853.999017] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[854.004189] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[854.132403] [104/132] (168s left) prime_vgem (fence-wait)
[854.214429] Starting subtest: fence-wait
[854.217400] Starting dynamic subtest: rcs0
[855.270645] Dynamic subtest rcs0: SUCCESS (1.056s)
[855.284070] Starting dynamic subtest: bcs0
[856.345636] Dynamic subtest bcs0: SUCCESS (1.074s)
[856.359352] Starting dynamic subtest: vcs0
[857.397073] Dynamic subtest vcs0: SUCCESS (1.050s)
[857.410905] Starting dynamic subtest: vcs1
[858.436761] Dynamic subtest vcs1: SUCCESS (1.039s)
[858.451371] Starting dynamic subtest: vecs0
[859.480674] Dynamic subtest vecs0: SUCCESS (1.043s)
[859.494202] Starting dynamic subtest: ccs0
[860.523716] Dynamic subtest ccs0: SUCCESS (1.041s)
[860.526854] Subtest fence-wait: SUCCESS (6.312s)
[860.685691] [105/132] (162s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[860.782930] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[860.787545] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[860.904058] [106/132] (161s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[860.998355] Starting subtest: yf-tiled-64bpp-rotate-0
[861.003029] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[861.129985] [107/132] (161s left) gem_ctx_persistence (legacy-engines-mixed)
[861.205035] Starting subtest: legacy-engines-mixed
[861.207583] Starting dynamic subtest: render
[861.312369] Dynamic subtest render: SUCCESS (0.108s)
[861.326893] Starting dynamic subtest: bsd1
[861.393634] Dynamic subtest bsd1: SUCCESS (0.078s)
[861.407328] Starting dynamic subtest: bsd2
[861.464670] Dynamic subtest bsd2: SUCCESS (0.068s)
[861.477987] Starting dynamic subtest: blt
[861.545120] Dynamic subtest blt: SUCCESS (0.078s)
[861.559605] Starting dynamic subtest: vebox
[861.616852] Dynamic subtest vebox: SUCCESS (0.069s)
[861.619184] Subtest legacy-engines-mixed: SUCCESS (0.415s)
[861.732617] [108/132] (161s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[861.832373] Starting subtest: fbc-2p-pri-indfb-multidraw
[861.836784] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[861.965004] [109/132] (160s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[862.066058] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[862.070651] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[862.185238] [110/132] (160s left) syncobj_wait (wait-any-snapshot)
[862.251277] Starting subtest: wait-any-snapshot
[862.333926] Subtest wait-any-snapshot: SUCCESS (0.082s)
[862.436789] [111/132] (160s left) kms_psr (psr-sprite-blt)
[862.521661] Starting subtest: psr-sprite-blt
[862.524082] Starting dynamic subtest: eDP-1
[864.299679] Dynamic subtest eDP-1: SUCCESS (1.784s)
[864.302657] Subtest psr-sprite-blt: SUCCESS (1.785s)
[865.156637] [112/132] (157s left) kms_cursor_crc (cursor-onscreen-256x256)
[865.419935] Starting subtest: cursor-onscreen-256x256
[865.422338] Starting dynamic subtest: pipe-A-eDP-1
[867.561724] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.140s)
[867.596804] Starting dynamic subtest: pipe-D-eDP-1
[870.321308] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.734s)
[870.323935] Subtest cursor-onscreen-256x256: SUCCESS (4.903s)
[871.227418] [113/132] (151s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[871.337238] Starting subtest: x-tiled-64bpp-rotate-90
[871.357012] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[871.521542] [114/132] (151s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[871.647133] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[871.652863] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[871.821052] [115/132] (151s left) gem_ctx_shared (q-in-order)
[871.891901] Starting subtest: Q-in-order
[871.894673] Starting dynamic subtest: rcs0
[872.003317] Dynamic subtest rcs0: SUCCESS (0.110s)
[872.021426] Starting dynamic subtest: vcs0
[872.085614] Dynamic subtest vcs0: SUCCESS (0.082s)
[872.104972] Starting dynamic subtest: vcs1
[872.169316] Dynamic subtest vcs1: SUCCESS (0.083s)
[872.188679] Starting dynamic subtest: vecs0
[872.242566] Dynamic subtest vecs0: SUCCESS (0.072s)
[872.262126] Starting dynamic subtest: ccs0
[872.321367] Dynamic subtest ccs0: SUCCESS (0.078s)
[872.324628] Subtest Q-in-order: SUCCESS (0.430s)
[873.807807] [116/132] (149s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[873.906788] Starting subtest: fbc-rgb101010-draw-mmap-wc
[878.499690] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.595s)
[879.627634] [117/132] (143s left) syncobj_wait (invalid-reset-zero-handles)
[879.687321] Starting subtest: invalid-reset-zero-handles
[879.690366] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[879.804732] [118/132] (143s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[879.900437] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[879.902919] Starting dynamic subtest: pipe-A
[879.928697] Dynamic subtest pipe-A: SKIP (0.017s)
[879.940346] Starting dynamic subtest: pipe-B
[879.949356] Dynamic subtest pipe-B: SKIP (0.029s)
[879.959726] Starting dynamic subtest: pipe-C
[879.986044] Dynamic subtest pipe-C: SKIP (0.030s)
[879.996708] Starting dynamic subtest: pipe-D
[880.012815] Dynamic subtest pipe-D: SKIP (0.031s)
[880.017593] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.110s)
[880.152508] [119/132] (143s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[880.244203] Starting subtest: y-tiled-16bpp-rotate-90
[880.250010] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[880.378139] [120/132] (143s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[880.465374] Starting subtest: fbc-psr-cursor-mmap-gtt
[880.467847] Starting dynamic subtest: eDP-1
[880.472618] Dynamic subtest eDP-1: SKIP (0.000s)
[880.477134] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[880.560529] [121/132] (142s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[880.657402] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[880.659344] Starting dynamic subtest: pipe-A-eDP-1
[881.376337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[881.392374] Starting dynamic subtest: pipe-B-eDP-1
[883.113218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.734s)
[883.123470] Starting dynamic subtest: pipe-C-eDP-1
[884.856051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.743s)
[884.866747] Starting dynamic subtest: pipe-D-eDP-1
[886.581021] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.723s)
[886.583219] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.915s)
[887.777635] [122/132] (135s left) kms_busy (basic)
[887.880817] Starting subtest: basic
[887.883218] Starting dynamic subtest: flip
[888.463645] Dynamic subtest flip: SUCCESS (0.581s)
[888.475943] Starting dynamic subtest: modeset
[891.876780] Dynamic subtest modeset: SUCCESS (3.412s)
[891.879499] Subtest basic: SUCCESS (3.995s)
[892.702183] [123/132] (130s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[892.978969] Starting subtest: cursor-rapid-movement-512x170
[892.984170] Subtest cursor-rapid-movement-512x170: SKIP (0.002s)
[893.165638] [124/132] (130s left) kms_plane_alpha_blend (constant-alpha-min)
[893.268742] Starting subtest: constant-alpha-min
[893.566168] Starting dynamic subtest: pipe-A-eDP-1
[894.356746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s)
[894.367067] Starting dynamic subtest: pipe-D-eDP-1
[895.916370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.559s)
[895.919106] Subtest constant-alpha-min: SUCCESS (2.650s)
[896.761751] [125/132] (126s left) prime_self_import (basic-llseek-bad)
[896.801324] Starting subtest: basic-llseek-bad
[896.826393] Subtest basic-llseek-bad: SUCCESS (0.026s)
[896.953110] [126/132] (126s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[897.333990] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[898.149702] [127/132] (125s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[898.248555] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[898.250950] Starting dynamic subtest: A-eDP1
[907.116212] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[907.128358] Starting dynamic subtest: B-eDP1
[916.041820] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[916.053297] Starting dynamic subtest: C-eDP1
[924.965349] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[924.977699] Starting dynamic subtest: D-eDP1
[933.887951] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[933.890365] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.647s)
[935.137683] [128/132] ( 88s left) gem_exec_parallel (fds)
[935.203327] Starting subtest: fds
[935.206086] Starting dynamic subtest: rcs0
[938.770333] Dynamic subtest rcs0: SUCCESS (3.566s)
[938.784087] Starting dynamic subtest: bcs0
[943.700801] Dynamic subtest bcs0: SUCCESS (4.929s)
[943.715462] Starting dynamic subtest: vcs0
[947.983637] Dynamic subtest vcs0: SUCCESS (4.282s)
[947.994322] Starting dynamic subtest: vcs1
[953.711698] Dynamic subtest vcs1: SUCCESS (5.726s)
[953.723854] Starting dynamic subtest: vecs0
[957.993246] Dynamic subtest vecs0: SUCCESS (4.280s)
[958.012637] Starting dynamic subtest: ccs0
[962.871894] Dynamic subtest ccs0: SUCCESS (4.877s)
[962.874867] Subtest fds: SUCCESS (27.674s)
[963.094188] [129/132] ( 60s left) prime_vgem (fence-write-hang)
[963.167345] Subtest fence-write-hang: SKIP (0.000s)
[963.319059] [130/132] ( 60s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[963.429072] Starting subtest: fbc-modesetfrombusy
[967.273123] Subtest fbc-modesetfrombusy: SUCCESS (3.850s)
[968.477703] [131/132] ( 55s left) syncobj_timeline (wait-all-for-submit-snapshot)
[968.541147] Starting subtest: wait-all-for-submit-snapshot
[968.620363] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[968.724199] [132/132] ( 55s left) kms_scaling_modes (scaling-mode-center)
[968.825702] Starting subtest: scaling-mode-center
[968.827961] Starting dynamic subtest: pipe-A-eDP-1
[968.926823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.103s)
[968.938600] Starting dynamic subtest: pipe-B-eDP-1
[970.065701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[970.076384] Starting dynamic subtest: pipe-C-eDP-1
[971.182638] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[971.194125] Starting dynamic subtest: pipe-D-eDP-1
[972.418875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[972.421517] Subtest scaling-mode-center: SUCCESS (3.597s)
[973.609142] 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.