[58.769311] Initializing watchdogs
[58.769358]   /dev/watchdog0
[58.784880] [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]
[58.789425] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.791743] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.795900] [001/134] (960s left) kms_flip (basic-plain-flip)
[58.919287] Starting subtest: basic-plain-flip
[58.921852] Starting dynamic subtest: A-eDP1
[60.633250] Dynamic subtest A-eDP1: SUCCESS (1.714s)
[60.643318] Starting dynamic subtest: B-eDP1
[62.364716] Dynamic subtest B-eDP1: SUCCESS (1.731s)
[62.374710] Starting dynamic subtest: C-eDP1
[63.981479] Dynamic subtest C-eDP1: SUCCESS (1.617s)
[63.990712] Starting dynamic subtest: D-eDP1
[65.601265] Dynamic subtest D-eDP1: SUCCESS (1.618s)
[65.603738] Subtest basic-plain-flip: SUCCESS (6.687s)
[66.776199] [002/134] (952s left) kms_psr (fbc-psr2-cursor-blt)
[66.902862] Starting subtest: fbc-psr2-cursor-blt
[66.905187] Starting dynamic subtest: eDP-1
[66.909589] Dynamic subtest eDP-1: SKIP (0.000s)
[66.914091] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[67.000385] [003/134] (952s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[67.175199] Starting subtest: multi-wait-available-submitted-signaled
[67.177564] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[67.430673] [004/134] (952s left) gem_tiled_blits (normal)
[67.611304] Subtest normal: SKIP (0.000s)
[67.806017] [005/134] (951s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[67.931364] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[67.935850] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.078660] [006/134] (951s left) i915_pm_freq_api (freq-reset-multiple)
[68.240067] Starting subtest: freq-reset-multiple
[68.242416] Starting dynamic subtest: gt0
[76.014076] Dynamic subtest gt0: SUCCESS (7.775s)
[76.022309] Starting dynamic subtest: gt1
[82.737704] Dynamic subtest gt1: SUCCESS (6.722s)
[82.740703] Subtest freq-reset-multiple: SUCCESS (14.499s)
[82.829504] [007/134] (936s left) gem_pread (self)
[82.881159] Subtest self: SKIP (0.000s)
[82.940795] [008/134] (936s left) kms_psr (psr-primary-mmap-gtt)
[83.047033] Starting subtest: psr-primary-mmap-gtt
[83.049342] Starting dynamic subtest: eDP-1
[84.470891] Dynamic subtest eDP-1: SKIP (1.421s)
[84.475771] Subtest psr-primary-mmap-gtt: SKIP (1.422s)
[84.672580] [009/134] (934s left) sw_sync (sync_expired_merge)
[84.714020] Starting subtest: sync_expired_merge
[85.787900] Subtest sync_expired_merge: SUCCESS (1.074s)
[85.857291] [010/134] (933s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[85.957817] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[85.962365] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[86.066796] [011/134] (933s left) gem_wait (invalid-buf)
[86.131046] Starting subtest: invalid-buf
[86.133423] Subtest invalid-buf: SUCCESS (0.000s)
[86.371452] [012/134] (933s left) prime_mmap (test_refcounting)
[86.427789] Starting subtest: test_refcounting
[86.429758] Starting dynamic subtest: test_refcounting-smem
[86.478903] Dynamic subtest test_refcounting-smem: SUCCESS (0.052s)
[86.481473] Subtest test_refcounting: SUCCESS (0.052s)
[86.576911] [013/134] (933s left) kms_pm_rpm (modeset-pc8-residency-stress)
[88.103491] Starting subtest: modeset-pc8-residency-stress
[88.108357] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[88.850974] [014/134] (930s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[88.952233] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[88.956494] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[89.043847] [015/134] (930s left) gem_mmap_gtt (basic-read-write-distinct)
[89.102206] Subtest basic-read-write-distinct: SKIP (0.000s)
[89.159836] [016/134] (930s left) i915_drm_fdinfo (memory-info-purgeable)
[89.201067] Starting subtest: memory-info-purgeable
[89.203347] Starting dynamic subtest: smem0
[91.908960] Dynamic subtest smem0: SUCCESS (2.708s)
[91.911359] Subtest memory-info-purgeable: SUCCESS (2.708s)
[91.994763] [017/134] (927s left) perf_pmu (enable-race)
[92.034274] Starting subtest: enable-race
[92.036308] Starting dynamic subtest: rcs0
[104.817095] Dynamic subtest rcs0: SUCCESS (12.783s)
[104.825640] Starting dynamic subtest: bcs0
[117.563537] Dynamic subtest bcs0: SUCCESS (12.745s)
[117.572370] Starting dynamic subtest: vcs0
[132.889415] Dynamic subtest vcs0: SUCCESS (15.324s)
[132.898551] Starting dynamic subtest: vcs1
[148.886563] Dynamic subtest vcs1: SUCCESS (15.995s)
[148.897447] Starting dynamic subtest: vecs0
[164.887287] Dynamic subtest vecs0: SUCCESS (15.999s)
[164.897569] Starting dynamic subtest: ccs0
[177.631083] Dynamic subtest ccs0: SUCCESS (12.744s)
[177.633662] Subtest enable-race: SUCCESS (85.595s)
[177.758692] [018/134] (842s left) kms_sequence (queue-busy)
[177.860413] Starting subtest: queue-busy
[177.862750] Starting dynamic subtest: pipe-A-eDP-1
[179.802357] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[179.810948] Starting dynamic subtest: pipe-B-eDP-1
[182.413034] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.609s)
[182.421848] Starting dynamic subtest: pipe-C-eDP-1
[185.027744] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[185.038316] Starting dynamic subtest: pipe-D-eDP-1
[187.665525] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.636s)
[187.667485] Subtest queue-busy: SUCCESS (9.803s)
[188.483990] [019/134] (831s left) syncobj_timeline (wait-any-interrupted)
[188.543859] Starting subtest: wait-any-interrupted
[188.645573] Subtest wait-any-interrupted: SUCCESS (0.102s)
[188.728970] [020/134] (831s left) kms_setmode (basic)
[188.792987] Starting subtest: basic
[189.115793] Starting dynamic subtest: pipe-A-eDP-1
[191.188837] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[191.518207] Starting dynamic subtest: pipe-B-eDP-1
[193.602277] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.087s)
[193.908307] Subtest basic: SUCCESS (5.115s)
[194.776653] [021/134] (825s left) gem_mmap (basic-small-bo)
[194.845109] Subtest basic-small-bo: SKIP (0.000s)
[194.907161] [022/134] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[195.002132] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[202.605186] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.607s)
[202.750657] [023/134] (817s left) gem_render_copy (x-tiled)
[202.807663] Starting subtest: x-tiled
[202.809591] Starting dynamic subtest: smem
[202.849398] Dynamic subtest smem: SUCCESS (0.044s)
[202.851689] Subtest x-tiled: SUCCESS (0.044s)
[203.039234] [024/134] (817s left) kms_cursor_crc (cursor-random-128x42)
[203.265893] Starting subtest: cursor-random-128x42
[203.316413] Subtest cursor-random-128x42: SKIP (0.044s)
[203.541768] [025/134] (816s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[203.659110] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[203.663497] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[203.752176] [026/134] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[203.863377] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[203.867854] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[203.982859] [027/134] (816s left) kms_flip (nonexisting-fb-interruptible)
[204.084085] Starting subtest: nonexisting-fb-interruptible
[204.085596] Starting dynamic subtest: A-eDP1
[205.297214] Dynamic subtest A-eDP1: SUCCESS (1.211s)
[205.307433] Starting dynamic subtest: B-eDP1
[206.486809] Dynamic subtest B-eDP1: SUCCESS (1.187s)
[206.494598] Starting dynamic subtest: C-eDP1
[207.620749] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[207.630100] Starting dynamic subtest: D-eDP1
[208.760786] Dynamic subtest D-eDP1: SUCCESS (1.139s)
[208.765480] Subtest nonexisting-fb-interruptible: SUCCESS (4.680s)
[209.949342] [028/134] (810s left) i915_pm_rpm (gem-execbuf-stress)
[212.090042] Starting subtest: gem-execbuf-stress
[212.092506] Starting dynamic subtest: smem0
[225.018772] Dynamic subtest smem0: SUCCESS (12.932s)
[225.028065] Starting dynamic subtest: extra-wait-smem0
[286.861251] Dynamic subtest extra-wait-smem0: SUCCESS (61.837s)
[286.863969] Subtest gem-execbuf-stress: SUCCESS (74.772s)
[287.241783] [029/134] (733s left) prime_vgem (basic-write)
[287.381518] Starting subtest: basic-write
[287.389198] Subtest basic-write: SKIP (0.005s)
[287.510041] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[287.513084] [030/134] (732s left) kms_flip (flip-vs-suspend-interruptible)
[287.618591] Starting subtest: flip-vs-suspend-interruptible
[287.620932] Starting dynamic subtest: A-eDP1
[321.421306] Dynamic subtest A-eDP1: SUCCESS (4.405s)
[321.430813] Starting dynamic subtest: B-eDP1
[355.423061] Dynamic subtest B-eDP1: SUCCESS (4.155s)
[355.437955] Starting dynamic subtest: C-eDP1
[389.419888] Dynamic subtest C-eDP1: SUCCESS (4.197s)
[389.434242] Starting dynamic subtest: D-eDP1
[423.432203] Dynamic subtest D-eDP1: SUCCESS (4.164s)
[423.436917] Subtest flip-vs-suspend-interruptible: SUCCESS (16.928s)
[433.648688] [031/134] (595s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[433.758330] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[434.816124] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.056s)
[435.008273] [032/134] (594s left) gem_madvise (dontneed-after-mmap)
[435.051322] Starting subtest: dontneed-after-mmap
[435.094687] Subtest dontneed-after-mmap: SUCCESS (0.044s)
[435.226633] [033/134] (594s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[435.326984] Starting subtest: plane-scaler-unity-scaling-with-rotation
[435.328841] Starting dynamic subtest: pipe-A
[435.553854] Dynamic subtest pipe-A: SUCCESS (0.228s)
[435.562489] Starting dynamic subtest: pipe-B
[436.936619] Dynamic subtest pipe-B: SUCCESS (1.377s)
[436.946857] Starting dynamic subtest: pipe-C
[438.289065] Dynamic subtest pipe-C: SUCCESS (1.356s)
[438.297670] Starting dynamic subtest: pipe-D
[439.593771] Dynamic subtest pipe-D: SUCCESS (1.304s)
[439.596062] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.267s)
[440.767390] [034/134] (588s left) gem_exec_balancer (parallel-keep-in-fence)
[441.037531] Starting subtest: parallel-keep-in-fence
[442.164022] Subtest parallel-keep-in-fence: SUCCESS (1.127s)
[442.312190] [035/134] (587s left) gem_exec_whisper (basic-contexts-forked)
[442.388443] Starting subtest: basic-contexts-forked
[467.291097] Subtest basic-contexts-forked: SUCCESS (24.895s)
[467.487493] [036/134] (562s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[467.583688] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[467.588265] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[468.683338] [037/134] (561s left) gem_userptr_blits (vma-merge)
[468.759585] Starting subtest: vma-merge
[468.798628] Subtest vma-merge: SUCCESS (0.039s)
[468.963463] [038/134] (560s left) dmabuf_sync_file (import-basic)
[469.005079] Starting subtest: import-basic
[469.007726] Subtest import-basic: SUCCESS (0.002s)
[469.079306] [039/134] (560s left) gen7_exec_parse (chained-batch)
[469.141976] Subtest chained-batch: SKIP (0.000s)
[469.214584] [040/134] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[469.316187] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[469.320183] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[469.455012] [041/134] (560s left) i915_pm_rps (thresholds)
[469.522939] Starting subtest: thresholds
[469.527416] Subtest thresholds: SKIP (0.001s)
[469.646674] [042/134] (560s left) gem_exec_reloc (basic-scanout)
[469.715785] Subtest basic-scanout: SKIP (0.000s)
[469.784602] [043/134] (560s left) kms_flip (flip-vs-absolute-wf_vblank)
[469.888754] Starting subtest: flip-vs-absolute-wf_vblank
[469.890334] Starting dynamic subtest: A-eDP1
[478.811878] Dynamic subtest A-eDP1: SUCCESS (8.920s)
[478.824248] Starting dynamic subtest: B-eDP1
[487.745790] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[487.755560] Starting dynamic subtest: C-eDP1
[496.658411] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[496.668026] Starting dynamic subtest: D-eDP1
[505.597464] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[505.599789] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.704s)
[506.839842] [044/134] (523s left) gem_pxp (verify-pxp-stale-buf-execution)
[506.972548] Starting subtest: verify-pxp-stale-buf-execution
[508.034340] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[508.198544] [045/134] (521s left) sw_sync (sync_merge_invalid)
[508.233315] Starting subtest: sync_merge_invalid
[508.259766] Subtest sync_merge_invalid: SUCCESS (0.025s)
[508.346649] [046/134] (521s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[508.458792] Starting subtest: x-tiled-32bpp-rotate-270
[508.479680] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[508.629122] [047/134] (521s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[508.735852] Starting subtest: fbcpsr-rgb565-draw-blt
[515.860116] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.125s)
[516.030916] [048/134] (514s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[516.129654] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[516.156365] Starting dynamic subtest: pipe-A-plane-0
[516.160786] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[516.171292] Starting dynamic subtest: pipe-A-plane-3
[516.175855] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[516.186447] Starting dynamic subtest: pipe-A-plane-5
[516.191010] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[517.257962] Starting dynamic subtest: pipe-B-plane-0
[517.262218] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[517.274057] Starting dynamic subtest: pipe-B-plane-3
[517.279224] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[517.293745] Starting dynamic subtest: pipe-B-plane-5
[517.298217] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[517.561890] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (1.430s)
[518.447134] [049/134] (511s left) perf (oa-exponents)
[518.566962] Starting subtest: oa-exponents
[518.569248] Starting dynamic subtest: 0-rcs0
[520.338317] Dynamic subtest 0-rcs0: SUCCESS (1.770s)
[520.349228] Starting dynamic subtest: 1-vcs1
[522.164626] Dynamic subtest 1-vcs1: SUCCESS (1.825s)
[522.167265] Subtest oa-exponents: SUCCESS (3.597s)
[522.214175] [050/134] (508s left) kms_lease (lease-revoke)
[522.310873] Starting subtest: lease-revoke
[522.313204] Starting dynamic subtest: pipe-A-eDP-1
[522.343354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[522.353123] Starting dynamic subtest: pipe-B-eDP-1
[522.372061] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[522.381856] Starting dynamic subtest: pipe-C-eDP-1
[522.401040] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[522.412001] Starting dynamic subtest: pipe-D-eDP-1
[522.428527] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[522.430786] Subtest lease-revoke: SUCCESS (0.121s)
[522.587715] [051/134] (507s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-pwrite)
[522.684284] Starting subtest: fbcpsr-abgr161616f-draw-pwrite
[522.688643] Subtest fbcpsr-abgr161616f-draw-pwrite: SKIP (0.000s)
[522.794363] [052/134] (507s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[522.898209] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[522.900471] Starting dynamic subtest: pipe-A-eDP-1
[522.922694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[522.932495] Starting dynamic subtest: pipe-B-eDP-1
[522.952961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[522.961935] Starting dynamic subtest: pipe-C-eDP-1
[522.982523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[522.991105] Starting dynamic subtest: pipe-D-eDP-1
[523.012494] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[523.017008] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[525.101012] [053/134] (505s left) gem_ctx_persistence (engines-hang)
[525.171095] Starting subtest: engines-hang
[525.173337] Starting dynamic subtest: rcs0
[525.237544] Dynamic subtest rcs0: SUCCESS (0.066s)
[525.248014] Starting dynamic subtest: bcs0
[525.393425] Dynamic subtest bcs0: SUCCESS (0.155s)
[525.405104] Starting dynamic subtest: vcs0
[525.509505] Dynamic subtest vcs0: SUCCESS (0.114s)
[525.521462] Starting dynamic subtest: vcs1
[525.633638] Dynamic subtest vcs1: SUCCESS (0.121s)
[525.645533] Starting dynamic subtest: vecs0
[525.750597] Dynamic subtest vecs0: SUCCESS (0.115s)
[525.763053] Starting dynamic subtest: ccs0
[525.874655] Dynamic subtest ccs0: SUCCESS (0.122s)
[525.877276] Subtest engines-hang: SUCCESS (0.704s)
[525.970446] [054/134] (504s left) gem_ctx_persistence (process)
[526.028912] Starting subtest: process
[526.284596] Subtest process: SUCCESS (0.255s)
[526.389880] [055/134] (504s left) gem_exec_async (concurrent-writes)
[526.453769] Starting subtest: concurrent-writes
[526.455681] Starting dynamic subtest: rcs0
[526.473796] Dynamic subtest rcs0: SUCCESS (0.020s)
[526.483635] Starting dynamic subtest: bcs0
[526.485321] Dynamic subtest bcs0: SUCCESS (0.006s)
[526.496329] Starting dynamic subtest: vcs0
[526.498259] Dynamic subtest vcs0: SUCCESS (0.004s)
[526.507567] Starting dynamic subtest: vcs1
[526.509102] Dynamic subtest vcs1: SUCCESS (0.005s)
[526.517787] Starting dynamic subtest: vecs0
[526.519352] Dynamic subtest vecs0: SUCCESS (0.005s)
[526.527988] Starting dynamic subtest: ccs0
[526.529520] Dynamic subtest ccs0: SUCCESS (0.005s)
[526.531057] Subtest concurrent-writes: SUCCESS (0.049s)
[526.759440] [056/134] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[526.867896] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[526.871273] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[527.006811] [057/134] (503s left) kms_atomic (plane-cursor-legacy)
[527.114370] Starting subtest: plane-cursor-legacy
[527.116405] Starting dynamic subtest: pipe-A-eDP-1
[527.491212] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[527.493663] Subtest plane-cursor-legacy: SUCCESS (0.378s)
[528.323487] [058/134] (502s left) api_intel_allocator (reserve-simple)
[528.395425] Starting subtest: reserve-simple
[528.397782] Subtest reserve-simple: SUCCESS (0.003s)
[528.528682] [059/134] (502s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[528.623854] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[528.626066] Starting dynamic subtest: pipe-A
[528.645742] Dynamic subtest pipe-A: SKIP (0.018s)
[528.656066] Starting dynamic subtest: pipe-B
[528.678625] Dynamic subtest pipe-B: SKIP (0.033s)
[528.688278] Starting dynamic subtest: pipe-C
[528.710370] Dynamic subtest pipe-C: SKIP (0.032s)
[528.719936] Starting dynamic subtest: pipe-D
[528.743674] Dynamic subtest pipe-D: SKIP (0.032s)
[528.747485] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.117s)
[528.888565] [060/134] (501s left) kms_chamelium_audio (dp-audio)
[529.287448] Subtest dp-audio: SKIP (0.000s)
[530.122316] [061/134] (500s left) syncobj_timeline (invalid-query-zero-handles)
[530.185601] Starting subtest: invalid-query-zero-handles
[530.187507] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[530.289480] [062/134] (500s left) kms_content_protection (suspend-resume)
[530.433442] Starting subtest: suspend-resume
[530.438214] Subtest suspend-resume: SKIP (0.000s)
[530.608693] [063/134] (500s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[530.719203] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[530.729725] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[530.871467] [064/134] (500s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[530.976762] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[532.011551] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.035s)
[532.159279] [065/134] (498s left) kms_chamelium_edid (dp-edid-read)
[532.560180] Subtest dp-edid-read: SKIP (0.000s)
[533.366214] [066/134] (497s left) gem_exec_schedule (preempt-contexts)
[533.447901] Starting subtest: preempt-contexts
[533.449936] Starting dynamic subtest: rcs0
[533.489756] Dynamic subtest rcs0: SUCCESS (0.050s)
[533.499852] Starting dynamic subtest: bcs0
[533.541570] Dynamic subtest bcs0: SUCCESS (0.051s)
[533.551472] Starting dynamic subtest: vcs0
[533.594209] Dynamic subtest vcs0: SUCCESS (0.050s)
[533.605263] Starting dynamic subtest: vcs1
[533.635574] Dynamic subtest vcs1: SUCCESS (0.042s)
[533.645336] Starting dynamic subtest: vecs0
[533.674397] Dynamic subtest vecs0: SUCCESS (0.038s)
[533.684146] Starting dynamic subtest: ccs0
[533.722117] Dynamic subtest ccs0: SUCCESS (0.046s)
[533.724163] Subtest preempt-contexts: SUCCESS (0.282s)
[534.913751] [067/134] (496s left) kms_atomic_interruptible (legacy-pageflip)
[535.010486] Starting subtest: legacy-pageflip
[535.012768] Starting dynamic subtest: pipe-A-eDP-1
[542.400383] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s)
[542.402830] Subtest legacy-pageflip: SUCCESS (7.389s)
[543.243197] [068/134] (487s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[543.321407] Starting subtest: map-fixed-invalidate-overlap
[543.325742] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[543.478619] [069/134] (487s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[543.574690] Starting subtest: primary-x-tiled-reflect-x-180
[550.622102] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.047s)
[551.824451] [070/134] (479s left) kms_vblank (ts-continuation-dpms-suspend)
[551.941144] Starting subtest: ts-continuation-dpms-suspend
[551.943541] Starting dynamic subtest: pipe-A-eDP-1
[568.958935] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.298s)
[568.973499] Starting dynamic subtest: pipe-D-eDP-1
[586.948876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.880s)
[586.951344] Subtest ts-continuation-dpms-suspend: SUCCESS (5.183s)
[596.786569] [071/134] (443s left) kms_frontbuffer_tracking (fbc-2p-rte)
[596.914304] Starting subtest: fbc-2p-rte
[596.918423] Subtest fbc-2p-rte: SKIP (0.000s)
[597.028254] [072/134] (443s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-blt)
[597.129390] Starting subtest: fbc-abgr161616f-draw-blt
[597.133614] Subtest fbc-abgr161616f-draw-blt: SKIP (0.000s)
[597.273296] [073/134] (443s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[597.368000] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[597.371930] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[597.494127] [074/134] (442s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[597.599064] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[598.816691] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: FAIL (0.634s)
[598.857270] [075/134] (441s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[598.918902] Starting subtest: y-tiled-to-vebox-yf-tiled
[598.922611] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[599.117402] [076/134] (441s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[599.226055] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[599.229992] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[599.354449] [077/134] (441s left) api_intel_bb (crc32)
[599.411257] Starting subtest: crc32
[599.413455] Starting dynamic subtest: rcs0-smem0
[599.711657] Dynamic subtest rcs0-smem0: SUCCESS (0.300s)
[599.724934] Starting dynamic subtest: bcs0-smem0
[600.054590] Dynamic subtest bcs0-smem0: SUCCESS (0.340s)
[600.067856] Starting dynamic subtest: vcs0-smem0
[600.425410] Dynamic subtest vcs0-smem0: SUCCESS (0.367s)
[600.438585] Starting dynamic subtest: vcs1-smem0
[600.804375] Dynamic subtest vcs1-smem0: SUCCESS (0.376s)
[600.818788] Starting dynamic subtest: vecs0-smem0
[601.168476] Dynamic subtest vecs0-smem0: SUCCESS (0.361s)
[601.180435] Starting dynamic subtest: ccs0-smem0
[601.513232] Dynamic subtest ccs0-smem0: SUCCESS (0.342s)
[601.516070] Subtest crc32: SUCCESS (2.101s)
[601.667253] [078/134] (438s left) kms_cursor_edge_walk (256x256-right-edge)
[601.765560] Starting subtest: 256x256-right-edge
[601.767906] Starting dynamic subtest: pipe-A-eDP-1
[605.223036] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[605.233299] Starting dynamic subtest: pipe-D-eDP-1
[608.343646] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[608.345901] Subtest 256x256-right-edge: SUCCESS (6.574s)
[609.176730] [079/134] (431s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[609.251873] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[609.337637] [080/134] (431s left) kms_psr (psr-cursor-mmap-gtt)
[609.439011] Starting subtest: psr-cursor-mmap-gtt
[609.441345] Starting dynamic subtest: eDP-1
[611.157314] Dynamic subtest eDP-1: SUCCESS (1.717s)
[611.159710] Subtest psr-cursor-mmap-gtt: SUCCESS (1.718s)
[612.032215] [081/134] (428s left) kms_flip (2x-plain-flip)
[612.135203] Starting subtest: 2x-plain-flip
[612.150085] Subtest 2x-plain-flip: SKIP (0.016s)
[612.246082] [082/134] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[612.349229] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[619.428254] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.078s)
[619.547619] [083/134] (421s left) gem_exec_fence (syncobj-invalid-wait)
[620.009757] Starting subtest: syncobj-invalid-wait
[620.012262] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[621.756942] [084/134] (419s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[621.851395] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[622.224182] Starting dynamic subtest: pipe-A-eDP-1
[625.031805] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.805s)
[625.409590] Starting dynamic subtest: pipe-B-eDP-1
[628.169856] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[628.534118] Starting dynamic subtest: pipe-C-eDP-1
[631.301759] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[631.667513] Starting dynamic subtest: pipe-D-eDP-1
[634.429397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[634.431897] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.574s)
[635.632961] [085/134] (405s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[640.585544] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[640.587947] Starting dynamic subtest: pipe-A-eDP-1
[641.388509] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[641.398961] Starting dynamic subtest: pipe-B-eDP-1
[642.511149] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[642.515422] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.926s)
[643.708991] [086/134] (397s left) gem_exec_alignment (single)
[643.798182] Starting subtest: single
[643.803991] Subtest single: SUCCESS (0.003s)
[643.947962] [087/134] (396s left) kms_chamelium_hpd (vga-hpd-fast)
[644.334499] Subtest vga-hpd-fast: SKIP (0.000s)
[645.114171] [088/134] (395s left) kms_busy (basic)
[645.238879] Starting subtest: basic
[645.241227] Starting dynamic subtest: flip
[645.900031] Dynamic subtest flip: SUCCESS (0.659s)
[645.912859] Starting dynamic subtest: modeset
[649.368819] Dynamic subtest modeset: SUCCESS (3.468s)
[649.371088] Subtest basic: SUCCESS (4.129s)
[650.187222] [089/134] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[650.300994] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[650.305299] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[650.439774] [090/134] (390s left) gem_exec_reloc (basic-write-read)
[650.505211] Subtest basic-write-read: SKIP (0.000s)
[650.590778] [091/134] (390s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[650.682720] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[650.684932] Starting dynamic subtest: pipe-A-default-mode
[651.834591] Dynamic subtest pipe-A-default-mode: SKIP (1.148s)
[651.838633] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.149s)
[652.046244] [092/134] (389s left) gem_userptr_blits (sync-unmap)
[652.131795] Starting subtest: sync-unmap
[652.146659] Subtest sync-unmap: SUCCESS (0.013s)
[652.304517] [093/134] (388s left) kms_hdr (static-toggle-suspend)
[652.431689] Starting subtest: static-toggle-suspend
[652.438310] Subtest static-toggle-suspend: SKIP (0.001s)
[652.524741] [094/134] (388s left) kms_getfb (getfb-handle-not-fb)
[652.632199] Starting subtest: getfb-handle-not-fb
[652.634539] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[652.781490] [095/134] (388s left) gem_close_race (multigpu-basic-threads)
[652.852144] Starting subtest: multigpu-basic-threads
[652.856138] Subtest multigpu-basic-threads: SKIP (0.000s)
[653.107546] [096/134] (388s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[658.222608] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[658.224900] Starting dynamic subtest: pipe-A-eDP-1
[664.852705] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.625s)
[664.862882] Starting dynamic subtest: pipe-B-eDP-1
[671.511017] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[671.513240] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.285s)
[672.389927] [097/134] (369s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[672.486291] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[676.272223] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.788s)
[677.493960] [098/134] (363s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[677.552140] Starting subtest: etime-single-wait-for-submit-submitted
[677.659654] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[677.748018] [099/134] (363s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[677.811313] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[677.813335] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[677.921292] [100/134] (363s left) kms_cursor_crc (cursor-onscreen-512x512)
[678.196621] Starting subtest: cursor-onscreen-512x512
[678.200317] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[678.384470] [101/134] (363s left) kms_psr (pr-suspend)
[678.480629] Starting subtest: pr-suspend
[678.484965] Subtest pr-suspend: SKIP (0.000s)
[678.581291] [102/134] (363s left) kms_draw_crc (draw-method-mmap-wc)
[678.664593] Starting subtest: draw-method-mmap-wc
[678.666799] Starting dynamic subtest: xrgb8888-untiled
[678.918112] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[678.927528] Starting dynamic subtest: rgb565-untiled
[679.129087] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[679.138727] Starting dynamic subtest: xrgb2101010-untiled
[679.351816] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[679.361630] Starting dynamic subtest: xbgr16161616f-untiled
[679.574538] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[679.586301] Starting dynamic subtest: xrgb8888-xtiled
[679.696250] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[679.708493] Starting dynamic subtest: rgb565-xtiled
[679.840694] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s)
[679.849901] Starting dynamic subtest: xrgb2101010-xtiled
[679.951935] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[679.960972] Starting dynamic subtest: xbgr16161616f-xtiled
[680.085394] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[680.100088] Starting dynamic subtest: xrgb8888-4tiled
[680.240937] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.154s)
[680.250648] Starting dynamic subtest: rgb565-4tiled
[680.396605] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[680.406582] Starting dynamic subtest: xrgb2101010-4tiled
[680.552105] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[680.561786] Starting dynamic subtest: xbgr16161616f-4tiled
[680.729811] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.176s)
[680.731922] Subtest draw-method-mmap-wc: SUCCESS (2.067s)
[680.849088] [103/134] (360s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[680.946310] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[680.948237] Starting dynamic subtest: pipe-A-eDP-1
[680.976630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[680.987163] Starting dynamic subtest: pipe-B-eDP-1
[681.002612] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[681.011897] Starting dynamic subtest: pipe-C-eDP-1
[681.027288] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[681.035989] Starting dynamic subtest: pipe-D-eDP-1
[681.051736] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[681.053549] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[683.251842] [104/134] (358s left) drm_read (empty-nonblock)
[683.400485] Starting subtest: empty-nonblock
[683.402909] Subtest empty-nonblock: SUCCESS (0.000s)
[683.538252] [105/134] (358s left) gem_ccs (block-copy-compressed)
[683.602082] Starting subtest: block-copy-compressed
[683.606238] Subtest block-copy-compressed: SKIP (0.000s)
[683.726301] [106/134] (358s left) gem_exec_balancer (fairslice)
[683.796566] Starting subtest: fairslice
[686.717593] Subtest fairslice: SUCCESS (2.920s)
[687.065406] [107/134] (354s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[687.170388] Starting subtest: fbcpsr-shrfb-scaledprimary
[693.017307] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.847s)
[693.165742] [108/134] (348s left) sysfs_heartbeat_interval (precise)
[693.224476] Starting subtest: precise
[693.226851] Starting dynamic subtest: vecs0
[699.660989] Dynamic subtest vecs0: SUCCESS (6.433s)
[699.673512] Starting dynamic subtest: ccs0
[700.934367] Dynamic subtest ccs0: SUCCESS (1.270s)
[700.946448] Starting dynamic subtest: vcs0
[708.567492] Dynamic subtest vcs0: SUCCESS (7.627s)
[708.580379] Starting dynamic subtest: bcs0
[709.773662] Dynamic subtest bcs0: SUCCESS (1.206s)
[709.785081] Starting dynamic subtest: rcs0
[711.026684] Dynamic subtest rcs0: SUCCESS (1.251s)
[711.038837] Starting dynamic subtest: vcs1
[718.619420] Dynamic subtest vcs1: SUCCESS (7.586s)
[718.621801] Subtest precise: SUCCESS (25.385s)
[718.705567] [109/134] (323s left) gem_exec_schedule (smoketest)
[718.894009] Starting subtest: smoketest
[718.896550] Starting dynamic subtest: rcs0
[724.466390] Dynamic subtest rcs0: SUCCESS (5.525s)
[724.478007] Starting dynamic subtest: bcs0
[729.979757] Dynamic subtest bcs0: SUCCESS (5.510s)
[729.996296] Starting dynamic subtest: vcs0
[735.481253] Dynamic subtest vcs0: SUCCESS (5.491s)
[735.498444] Starting dynamic subtest: vcs1
[740.979071] Dynamic subtest vcs1: SUCCESS (5.499s)
[740.995309] Starting dynamic subtest: vecs0
[746.484212] Dynamic subtest vecs0: SUCCESS (5.500s)
[746.497297] Starting dynamic subtest: ccs0
[752.007562] Dynamic subtest ccs0: SUCCESS (5.517s)
[752.009791] Subtest smoketest: SUCCESS (33.053s)
[752.158020] [110/134] (289s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[752.256597] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[752.366279] [111/134] (289s left) perf_pmu (busy-accuracy-50)
[752.402799] Starting subtest: busy-accuracy-50
[752.405152] Starting dynamic subtest: rcs0
[753.936723] Dynamic subtest rcs0: SUCCESS (1.531s)
[753.947744] Starting dynamic subtest: bcs0
[755.481347] Dynamic subtest bcs0: SUCCESS (1.542s)
[755.491936] Starting dynamic subtest: vcs0
[757.022597] Dynamic subtest vcs0: SUCCESS (1.538s)
[757.033951] Starting dynamic subtest: vcs1
[758.563893] Dynamic subtest vcs1: SUCCESS (1.539s)
[758.575608] Starting dynamic subtest: vecs0
[760.106400] Dynamic subtest vecs0: SUCCESS (1.540s)
[760.117899] Starting dynamic subtest: ccs0
[761.651695] Dynamic subtest ccs0: SUCCESS (1.543s)
[761.654762] Subtest busy-accuracy-50: SUCCESS (9.246s)
[761.806382] [112/134] (280s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[761.905640] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[761.931627] Starting dynamic subtest: pipe-A-plane-0
[761.936170] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[761.947674] Starting dynamic subtest: pipe-A-plane-3
[761.952214] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[761.961772] Starting dynamic subtest: pipe-A-plane-5
[761.966326] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[763.071882] Starting dynamic subtest: pipe-B-plane-0
[763.075813] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[763.085138] Starting dynamic subtest: pipe-B-plane-3
[763.093861] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[763.103961] Starting dynamic subtest: pipe-B-plane-5
[763.108071] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[763.387753] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (1.481s)
[764.262714] [113/134] (277s left) kms_pipe_crc_basic (nonblocking-crc)
[764.377495] Starting subtest: nonblocking-crc
[764.382283] Starting dynamic subtest: pipe-A-eDP-1
[765.154952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[765.167394] Starting dynamic subtest: pipe-B-eDP-1
[766.584676] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s)
[766.595310] Starting dynamic subtest: pipe-C-eDP-1
[767.951419] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[767.962589] Starting dynamic subtest: pipe-D-eDP-1
[769.310455] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[769.312855] Subtest nonblocking-crc: SUCCESS (4.931s)
[770.209532] [114/134] (271s left) gem_mmap (bad-object)
[770.265810] Subtest bad-object: SKIP (0.000s)
[770.335302] [115/134] (271s left) prime_vgem (basic-blt)
[770.419714] Starting subtest: basic-blt
[770.457298] Subtest basic-blt: SUCCESS (0.039s)
[770.597099] [116/134] (271s left) gem_lmem_swapping (parallel-multi)
[770.651053] Subtest parallel-multi: SKIP (0.000s)
[770.695709] [117/134] (271s left) kms_pm_lpsp (kms-lpsp)
[771.808575] Starting subtest: kms-lpsp
[771.810715] Starting dynamic subtest: pipe-A-eDP-1
[771.954498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[772.254088] Subtest kms-lpsp: SUCCESS (0.447s)
[773.142937] [118/134] (269s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[773.211938] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[773.281902] [119/134] (269s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[773.401312] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[791.008280] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.599s)
[791.814271] [120/134] (250s left) kms_cursor_legacy (single-bo)
[791.935678] Starting subtest: single-bo
[791.938152] Starting dynamic subtest: pipe-A
[797.322193] Dynamic subtest pipe-A: SUCCESS (5.379s)
[797.334614] Starting dynamic subtest: pipe-B
[802.705877] Dynamic subtest pipe-B: SUCCESS (5.380s)
[802.717925] Starting dynamic subtest: pipe-C
[808.091111] Dynamic subtest pipe-C: SUCCESS (5.380s)
[808.103175] Starting dynamic subtest: pipe-D
[813.475348] Dynamic subtest pipe-D: SUCCESS (5.379s)
[813.488241] Starting dynamic subtest: all-pipes
[818.866453] Dynamic subtest all-pipes: SUCCESS (5.386s)
[818.868910] Subtest single-bo: SUCCESS (26.919s)
[819.035974] [121/134] (223s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[819.094864] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[819.204077] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[819.292795] [122/134] (223s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[819.403917] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[819.408262] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[819.534480] [123/134] (222s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[824.513054] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[824.515382] Starting dynamic subtest: pipe-A-eDP-1
[825.290332] Dynamic subtest pipe-A-eDP-1: SKIP (0.772s)
[825.301077] Starting dynamic subtest: pipe-B-eDP-1
[826.441784] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[826.446379] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.927s)
[827.652470] [124/134] (214s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[827.764608] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[827.768956] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[827.882786] [125/134] (214s left) kms_color (ctm-green-to-red)
[827.981890] Starting subtest: ctm-green-to-red
[827.983652] Starting dynamic subtest: pipe-A-eDP-1
[828.681395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[828.691817] Starting dynamic subtest: pipe-B-eDP-1
[830.082649] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[830.093421] Starting dynamic subtest: pipe-C-eDP-1
[831.435452] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[831.449231] Starting dynamic subtest: pipe-D-eDP-1
[832.758003] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[832.760308] Subtest ctm-green-to-red: SUCCESS (4.776s)
[833.599165] [126/134] (209s left) gem_mmap_wc (set-cache-level)
[833.662385] Subtest set-cache-level: SKIP (0.000s)
[833.720309] [127/134] (208s left) gem_exec_reloc (basic-write-cpu-active)
[833.788361] Subtest basic-write-cpu-active: SKIP (0.000s)
[833.889885] [128/134] (208s left) kms_flip (2x-flip-vs-fences)
[833.992971] Starting subtest: 2x-flip-vs-fences
[833.997216] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[834.130347] [129/134] (208s left) gem_mmap_offset (blt-coherency)
[834.181783] Starting subtest: blt-coherency
[834.186184] Subtest blt-coherency: SUCCESS (0.007s)
[834.358281] [130/134] (208s left) kms_psr (fbc-psr-cursor-plane-onoff)
[834.465412] Starting subtest: fbc-psr-cursor-plane-onoff
[834.467539] Starting dynamic subtest: eDP-1
[834.471457] Dynamic subtest eDP-1: SKIP (0.000s)
[834.475374] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[834.561748] [131/134] (208s left) gem_softpin (allocator-nopin-reserve)
[834.622911] Starting subtest: allocator-nopin-reserve
[834.713153] Subtest allocator-nopin-reserve: SUCCESS (0.090s)
[834.864594] [132/134] (208s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[834.957071] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[834.960633] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[836.149534] [133/134] (206s left) sw_sync (sync_busy_fork)
[836.183464] Starting subtest: sync_busy_fork
[837.195560] Subtest sync_busy_fork: SUCCESS (1.011s)
[837.278415] [134/134] (205s left) kms_invalid_mode (clock-too-high)
[837.379627] Starting subtest: clock-too-high
[837.382070] Starting dynamic subtest: pipe-A-eDP-1
[837.386772] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[837.398489] Starting dynamic subtest: pipe-B-eDP-1
[837.402687] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[837.412918] Starting dynamic subtest: pipe-C-eDP-1
[837.417207] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[837.428581] Starting dynamic subtest: pipe-D-eDP-1
[837.432826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[837.437207] Subtest clock-too-high: SKIP (0.005s)
[837.472968] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_tiled_blits
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: gem_pread
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_wait
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_sequence
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_setmode
results: parsing output: 20/ for test: gem_mmap
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: i915_pm_rpm
results: parsing output: 28/ for test: prime_vgem
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_madvise
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: gen7_exec_parse
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: i915_pm_rps
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_lease
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: gem_exec_async
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: api_intel_allocator
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_chamelium_audio
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_cursor_edge_walk
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: gem_exec_alignment
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_busy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_hdr
results: parsing output: 93/ for test: kms_getfb
results: parsing output: 94/ for test: gem_close_race
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_draw_crc
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: drm_read
results: parsing output: 104/ for test: gem_ccs
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: sysfs_heartbeat_interval
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_pipe_crc_basic
results: parsing output: 113/ for test: gem_mmap
results: parsing output: 114/ for test: prime_vgem
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_pm_lpsp
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_color
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_mmap_offset
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: sw_sync
results: parsing output: 133/ for test: kms_invalid_mode
Done.