[59.755335] Initializing watchdogs
[59.755381]   /dev/watchdog0
[59.770152] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.774627] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.776949] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.780449] [001/134] (960s left) kms_flip (basic-plain-flip)
[59.902910] Starting subtest: basic-plain-flip
[59.905320] Starting dynamic subtest: A-eDP1
[61.644247] Dynamic subtest A-eDP1: SUCCESS (1.732s)
[61.658649] Starting dynamic subtest: B-eDP1
[63.297570] Dynamic subtest B-eDP1: SUCCESS (1.644s)
[63.305571] Starting dynamic subtest: C-eDP1
[64.925979] Dynamic subtest C-eDP1: SUCCESS (1.621s)
[64.933124] Starting dynamic subtest: D-eDP1
[66.570160] Dynamic subtest D-eDP1: SUCCESS (1.638s)
[66.575048] Subtest basic-plain-flip: SUCCESS (6.646s)
[67.874825] [002/134] (952s left) kms_psr (fbc-psr2-cursor-blt)
[67.979920] Starting subtest: fbc-psr2-cursor-blt
[67.982261] Starting dynamic subtest: eDP-1
[67.986319] Dynamic subtest eDP-1: SKIP (0.000s)
[67.990758] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[68.144284] [003/134] (952s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[68.275913] Starting subtest: multi-wait-available-submitted-signaled
[68.278365] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[68.397455] [004/134] (952s left) gem_tiled_blits (normal)
[68.459644] Subtest normal: SKIP (0.000s)
[68.530833] [005/134] (951s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[68.637173] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[68.641124] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.769657] [006/134] (951s left) i915_pm_freq_api (freq-reset-multiple)
[68.823673] Starting subtest: freq-reset-multiple
[68.825576] Starting dynamic subtest: gt0
[76.613441] Dynamic subtest gt0: SUCCESS (7.777s)
[76.627807] Starting dynamic subtest: gt1
[83.367372] Dynamic subtest gt1: SUCCESS (6.745s)
[83.369376] Subtest freq-reset-multiple: SUCCESS (14.523s)
[83.452978] [007/134] (937s left) gem_pread (self)
[83.513588] Subtest self: SKIP (0.000s)
[83.581167] [008/134] (936s left) kms_psr (psr-primary-mmap-gtt)
[83.676320] Starting subtest: psr-primary-mmap-gtt
[83.678550] Starting dynamic subtest: eDP-1
[85.160712] Dynamic subtest eDP-1: SKIP (1.479s)
[85.165425] Subtest psr-primary-mmap-gtt: SKIP (1.480s)
[85.306500] [009/134] (935s left) sw_sync (sync_expired_merge)
[85.346543] Starting subtest: sync_expired_merge
[86.421032] Subtest sync_expired_merge: SUCCESS (1.074s)
[86.502952] [010/134] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[86.608164] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[86.612497] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[86.712214] [011/134] (933s left) gem_wait (invalid-buf)
[86.768558] Starting subtest: invalid-buf
[86.770540] Subtest invalid-buf: SUCCESS (0.000s)
[87.014245] [012/134] (933s left) prime_mmap (test_refcounting)
[87.075852] Starting subtest: test_refcounting
[87.077843] Starting dynamic subtest: test_refcounting-smem
[87.105061] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[87.107533] Subtest test_refcounting: SUCCESS (0.032s)
[87.240394] [013/134] (933s left) kms_pm_rpm (modeset-pc8-residency-stress)
[89.065853] Starting subtest: modeset-pc8-residency-stress
[89.070571] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[89.536636] [014/134] (931s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[89.657679] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[89.662062] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[89.787135] [015/134] (931s left) gem_mmap_gtt (basic-read-write-distinct)
[89.855513] Subtest basic-read-write-distinct: SKIP (0.000s)
[89.925875] [016/134] (930s left) i915_drm_fdinfo (memory-info-purgeable)
[89.963449] Starting subtest: memory-info-purgeable
[89.965889] Starting dynamic subtest: smem0
[92.626981] Dynamic subtest smem0: SUCCESS (2.663s)
[92.629488] Subtest memory-info-purgeable: SUCCESS (2.664s)
[92.710101] [017/134] (928s left) perf_pmu (enable-race)
[92.747600] Starting subtest: enable-race
[92.749554] Starting dynamic subtest: rcs0
[105.516799] Dynamic subtest rcs0: SUCCESS (12.764s)
[105.524490] Starting dynamic subtest: bcs0
[118.260513] Dynamic subtest bcs0: SUCCESS (12.740s)
[118.268420] Starting dynamic subtest: vcs0
[133.909377] Dynamic subtest vcs0: SUCCESS (15.643s)
[133.919838] Starting dynamic subtest: vcs1
[149.909450] Dynamic subtest vcs1: SUCCESS (15.998s)
[149.920012] Starting dynamic subtest: vecs0
[165.911486] Dynamic subtest vecs0: SUCCESS (16.001s)
[165.921670] Starting dynamic subtest: ccs0
[178.658522] Dynamic subtest ccs0: SUCCESS (12.747s)
[178.661213] Subtest enable-race: SUCCESS (85.899s)
[178.776171] [018/134] (842s left) kms_sequence (queue-busy)
[178.872471] Starting subtest: queue-busy
[178.874762] Starting dynamic subtest: pipe-A-eDP-1
[180.818302] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[180.828597] Starting dynamic subtest: pipe-B-eDP-1
[183.409982] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.591s)
[183.419248] Starting dynamic subtest: pipe-C-eDP-1
[186.029318] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.618s)
[186.038157] Starting dynamic subtest: pipe-D-eDP-1
[188.591066] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[188.593386] Subtest queue-busy: SUCCESS (9.719s)
[189.472038] [019/134] (831s left) syncobj_timeline (wait-any-interrupted)
[189.531765] Starting subtest: wait-any-interrupted
[189.634441] Subtest wait-any-interrupted: SUCCESS (0.102s)
[189.718196] [020/134] (831s left) kms_setmode (basic)
[189.781213] Starting subtest: basic
[190.121558] Starting dynamic subtest: pipe-A-eDP-1
[192.188899] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.062s)
[192.526971] Starting dynamic subtest: pipe-B-eDP-1
[194.616432] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[194.923761] Subtest basic: SUCCESS (5.139s)
[195.766888] [021/134] (825s left) gem_mmap (basic-small-bo)
[195.827065] Subtest basic-small-bo: SKIP (0.000s)
[195.895270] [022/134] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[195.998335] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[203.620101] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.624s)
[203.755272] [023/134] (817s left) gem_render_copy (x-tiled)
[203.826473] Starting subtest: x-tiled
[203.828919] Starting dynamic subtest: smem
[203.902654] Dynamic subtest smem: SUCCESS (0.075s)
[203.905476] Subtest x-tiled: SUCCESS (0.076s)
[204.170859] [024/134] (817s left) kms_cursor_crc (cursor-random-128x42)
[204.385113] Starting subtest: cursor-random-128x42
[204.435039] Subtest cursor-random-128x42: SKIP (0.043s)
[204.658593] [025/134] (816s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[204.764593] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[204.768803] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[204.885211] [026/134] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[204.978577] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[204.982815] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[205.110910] [027/134] (816s left) kms_flip (nonexisting-fb-interruptible)
[205.212585] Starting subtest: nonexisting-fb-interruptible
[205.214607] Starting dynamic subtest: A-eDP1
[206.362512] Dynamic subtest A-eDP1: SUCCESS (1.147s)
[206.375254] Starting dynamic subtest: B-eDP1
[207.499368] Dynamic subtest B-eDP1: SUCCESS (1.135s)
[207.509066] Starting dynamic subtest: C-eDP1
[208.628863] Dynamic subtest C-eDP1: SUCCESS (1.129s)
[208.637564] Starting dynamic subtest: D-eDP1
[209.758336] Dynamic subtest D-eDP1: SUCCESS (1.129s)
[209.760813] Subtest nonexisting-fb-interruptible: SUCCESS (4.547s)
[210.954497] [028/134] (810s left) i915_pm_rpm (gem-execbuf-stress)
[213.097500] Starting subtest: gem-execbuf-stress
[213.100573] Starting dynamic subtest: smem0
[226.036548] Dynamic subtest smem0: SUCCESS (12.938s)
[226.046769] Starting dynamic subtest: extra-wait-smem0
[287.908219] Dynamic subtest extra-wait-smem0: SUCCESS (61.865s)
[287.910819] Subtest gem-execbuf-stress: SUCCESS (74.807s)
[288.296931] [029/134] (733s left) prime_vgem (basic-write)
[288.413325] Starting subtest: basic-write
[288.423102] Subtest basic-write: SKIP (0.009s)
[288.560798] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[288.563952] [030/134] (732s left) kms_flip (flip-vs-suspend-interruptible)
[288.666263] Starting subtest: flip-vs-suspend-interruptible
[288.670811] Starting dynamic subtest: A-eDP1
[321.640797] Dynamic subtest A-eDP1: SUCCESS (4.358s)
[321.653728] Starting dynamic subtest: B-eDP1
[355.641634] Dynamic subtest B-eDP1: SUCCESS (4.252s)
[355.657968] Starting dynamic subtest: C-eDP1
[389.631827] Dynamic subtest C-eDP1: SUCCESS (4.184s)
[389.653026] Starting dynamic subtest: D-eDP1
[423.643818] Dynamic subtest D-eDP1: SUCCESS (4.241s)
[423.646212] Subtest flip-vs-suspend-interruptible: SUCCESS (17.049s)
[429.885430] [031/134] (596s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[430.020174] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[431.125143] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.057s)
[431.299881] [032/134] (595s left) gem_madvise (dontneed-after-mmap)
[431.339282] Starting subtest: dontneed-after-mmap
[431.367650] Subtest dontneed-after-mmap: SUCCESS (0.029s)
[431.519522] [033/134] (595s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[431.628151] Starting subtest: plane-scaler-unity-scaling-with-rotation
[431.629988] Starting dynamic subtest: pipe-A
[431.863140] Dynamic subtest pipe-A: SUCCESS (0.228s)
[431.873814] Starting dynamic subtest: pipe-B
[433.169724] Dynamic subtest pipe-B: SUCCESS (1.261s)
[433.180081] Starting dynamic subtest: pipe-C
[434.540576] Dynamic subtest pipe-C: SUCCESS (1.331s)
[434.551632] Starting dynamic subtest: pipe-D
[435.904389] Dynamic subtest pipe-D: SUCCESS (1.331s)
[435.906782] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.153s)
[437.131386] [034/134] (589s left) gem_exec_balancer (parallel-keep-in-fence)
[437.404641] Starting subtest: parallel-keep-in-fence
[438.567674] Subtest parallel-keep-in-fence: SUCCESS (1.143s)
[438.714173] [035/134] (587s left) gem_exec_whisper (basic-contexts-forked)
[438.789903] Starting subtest: basic-contexts-forked
[462.382547] Subtest basic-contexts-forked: SUCCESS (23.475s)
[462.598251] [036/134] (564s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[462.707056] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[462.711531] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[463.800238] [037/134] (562s left) gem_userptr_blits (vma-merge)
[463.875345] Starting subtest: vma-merge
[463.915574] Subtest vma-merge: SUCCESS (0.040s)
[464.065979] [038/134] (562s left) dmabuf_sync_file (import-basic)
[464.105056] Starting subtest: import-basic
[464.107391] Subtest import-basic: SUCCESS (0.001s)
[464.174036] [039/134] (562s left) gen7_exec_parse (chained-batch)
[464.239310] Subtest chained-batch: SKIP (0.000s)
[464.328390] [040/134] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[464.421875] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[464.426053] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[464.546888] [041/134] (562s left) i915_pm_rps (thresholds)
[464.612937] Starting subtest: thresholds
[464.617102] Subtest thresholds: SKIP (0.001s)
[464.746424] [042/134] (562s left) gem_exec_reloc (basic-scanout)
[464.808399] Subtest basic-scanout: SKIP (0.000s)
[464.886815] [043/134] (562s left) kms_flip (flip-vs-absolute-wf_vblank)
[464.971880] Starting subtest: flip-vs-absolute-wf_vblank
[464.973692] Starting dynamic subtest: A-eDP1
[473.939447] Dynamic subtest A-eDP1: SUCCESS (8.961s)
[473.948260] Starting dynamic subtest: B-eDP1
[482.869817] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[482.878366] Starting dynamic subtest: C-eDP1
[491.794699] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[491.803765] Starting dynamic subtest: D-eDP1
[500.720804] Dynamic subtest D-eDP1: SUCCESS (8.919s)
[500.725568] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.735s)
[501.967564] [044/134] (525s left) gem_pxp (verify-pxp-stale-buf-execution)
[502.100614] Starting subtest: verify-pxp-stale-buf-execution
[503.161605] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.061s)
[503.330750] [045/134] (523s left) sw_sync (sync_merge_invalid)
[503.362537] Starting subtest: sync_merge_invalid
[503.382327] Subtest sync_merge_invalid: SUCCESS (0.018s)
[503.481035] [046/134] (523s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[503.588506] Starting subtest: x-tiled-32bpp-rotate-270
[503.607819] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[503.760052] [047/134] (523s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[503.860671] Starting subtest: fbcpsr-rgb565-draw-blt
[510.949321] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.089s)
[511.122124] [048/134] (516s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[511.232638] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[511.261892] Starting dynamic subtest: pipe-A-plane-0
[511.266260] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[511.275138] Starting dynamic subtest: pipe-A-plane-3
[511.279574] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[511.288478] Starting dynamic subtest: pipe-A-plane-5
[511.293024] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[512.373129] Starting dynamic subtest: pipe-B-plane-0
[512.377548] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[512.386125] Starting dynamic subtest: pipe-B-plane-3
[512.390408] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[512.398597] Starting dynamic subtest: pipe-B-plane-5
[512.402924] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[512.694167] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (1.459s)
[513.562258] [049/134] (513s left) perf (oa-exponents)
[513.689078] Starting subtest: oa-exponents
[513.690935] Starting dynamic subtest: 0-rcs0
[515.470343] Dynamic subtest 0-rcs0: SUCCESS (1.781s)
[515.482057] Starting dynamic subtest: 1-vcs0
[517.301625] Dynamic subtest 1-vcs0: SUCCESS (1.830s)
[517.304292] Subtest oa-exponents: SUCCESS (3.612s)
[517.355188] [050/134] (509s left) kms_lease (lease-revoke)
[517.451189] Starting subtest: lease-revoke
[517.453573] Starting dynamic subtest: pipe-A-eDP-1
[517.483975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[517.493265] Starting dynamic subtest: pipe-B-eDP-1
[517.510318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[517.519812] Starting dynamic subtest: pipe-C-eDP-1
[517.542705] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[517.553630] Starting dynamic subtest: pipe-D-eDP-1
[517.571359] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[517.573557] Subtest lease-revoke: SUCCESS (0.122s)
[517.722350] [051/134] (509s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-pwrite)
[517.824982] Starting subtest: fbcpsr-abgr161616f-draw-pwrite
[517.829068] Subtest fbcpsr-abgr161616f-draw-pwrite: SKIP (0.000s)
[517.958602] [052/134] (509s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[518.051285] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[518.053585] Starting dynamic subtest: pipe-A-eDP-1
[518.075422] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[518.086281] Starting dynamic subtest: pipe-B-eDP-1
[518.106813] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.115418] Starting dynamic subtest: pipe-C-eDP-1
[518.136467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.146775] Starting dynamic subtest: pipe-D-eDP-1
[518.168247] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.172587] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[520.328768] [053/134] (507s left) gem_ctx_persistence (engines-hang)
[520.392363] Starting subtest: engines-hang
[520.394782] Starting dynamic subtest: rcs0
[520.499935] Dynamic subtest rcs0: SUCCESS (0.107s)
[520.511876] Starting dynamic subtest: bcs0
[520.614023] Dynamic subtest bcs0: SUCCESS (0.112s)
[520.624738] Starting dynamic subtest: vcs0
[520.737738] Dynamic subtest vcs0: SUCCESS (0.121s)
[520.749622] Starting dynamic subtest: vcs1
[520.854229] Dynamic subtest vcs1: SUCCESS (0.114s)
[520.866669] Starting dynamic subtest: vecs0
[520.977356] Dynamic subtest vecs0: SUCCESS (0.121s)
[520.989204] Starting dynamic subtest: ccs0
[521.093067] Dynamic subtest ccs0: SUCCESS (0.114s)
[521.095774] Subtest engines-hang: SUCCESS (0.701s)
[521.197050] [054/134] (506s left) gem_ctx_persistence (process)
[521.265485] Starting subtest: process
[521.463674] Subtest process: SUCCESS (0.198s)
[521.567982] [055/134] (505s left) gem_exec_async (concurrent-writes)
[521.633193] Starting subtest: concurrent-writes
[521.635146] Starting dynamic subtest: rcs0
[521.647534] Dynamic subtest rcs0: SUCCESS (0.014s)
[521.658922] Starting dynamic subtest: bcs0
[521.660517] Dynamic subtest bcs0: SUCCESS (0.007s)
[521.669733] Starting dynamic subtest: vcs0
[521.671530] Dynamic subtest vcs0: SUCCESS (0.005s)
[521.680221] Starting dynamic subtest: vcs1
[521.681786] Dynamic subtest vcs1: SUCCESS (0.006s)
[521.690056] Starting dynamic subtest: vecs0
[521.691633] Dynamic subtest vecs0: SUCCESS (0.005s)
[521.699913] Starting dynamic subtest: ccs0
[521.701534] Dynamic subtest ccs0: SUCCESS (0.005s)
[521.703118] Subtest concurrent-writes: SUCCESS (0.045s)
[521.941075] [056/134] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[522.044607] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[522.047997] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[522.176654] [057/134] (505s left) kms_atomic (plane-cursor-legacy)
[522.291017] Starting subtest: plane-cursor-legacy
[522.292791] Starting dynamic subtest: pipe-A-eDP-1
[522.659761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[522.661947] Subtest plane-cursor-legacy: SUCCESS (0.368s)
[523.481343] [058/134] (504s left) api_intel_allocator (reserve-simple)
[523.546420] Starting subtest: reserve-simple
[523.548721] Subtest reserve-simple: SUCCESS (0.003s)
[523.692853] [059/134] (503s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[523.796267] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[523.798400] Starting dynamic subtest: pipe-A
[523.820111] Dynamic subtest pipe-A: SKIP (0.019s)
[523.832434] Starting dynamic subtest: pipe-B
[523.855194] Dynamic subtest pipe-B: SKIP (0.033s)
[523.864411] Starting dynamic subtest: pipe-C
[523.886542] Dynamic subtest pipe-C: SKIP (0.032s)
[523.895631] Starting dynamic subtest: pipe-D
[523.919835] Dynamic subtest pipe-D: SKIP (0.032s)
[523.923616] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.118s)
[524.018729] [060/134] (503s left) kms_chamelium_audio (dp-audio)
[524.401520] Subtest dp-audio: SKIP (0.000s)
[525.178359] [061/134] (502s left) syncobj_timeline (invalid-query-zero-handles)
[525.233180] Starting subtest: invalid-query-zero-handles
[525.235445] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[525.371529] [062/134] (502s left) kms_content_protection (suspend-resume)
[525.524217] Starting subtest: suspend-resume
[525.528209] Subtest suspend-resume: SKIP (0.000s)
[525.653432] [063/134] (502s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[525.763648] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[525.776929] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.014s)
[525.864005] [064/134] (502s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[525.974420] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[527.041404] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s)
[527.197386] [065/134] (500s left) kms_chamelium_edid (dp-edid-read)
[527.626547] Subtest dp-edid-read: SKIP (0.000s)
[528.407337] [066/134] (499s left) gem_exec_schedule (preempt-contexts)
[528.489123] Starting subtest: preempt-contexts
[528.491476] Starting dynamic subtest: rcs0
[528.531831] Dynamic subtest rcs0: SUCCESS (0.051s)
[528.541574] Starting dynamic subtest: bcs0
[528.585819] Dynamic subtest bcs0: SUCCESS (0.054s)
[528.595318] Starting dynamic subtest: vcs0
[528.629747] Dynamic subtest vcs0: SUCCESS (0.043s)
[528.639144] Starting dynamic subtest: vcs1
[528.674217] Dynamic subtest vcs1: SUCCESS (0.042s)
[528.683555] Starting dynamic subtest: vecs0
[528.714003] Dynamic subtest vecs0: SUCCESS (0.039s)
[528.723380] Starting dynamic subtest: ccs0
[528.755230] Dynamic subtest ccs0: SUCCESS (0.042s)
[528.757331] Subtest preempt-contexts: SUCCESS (0.276s)
[529.983518] [067/134] (498s left) kms_atomic_interruptible (legacy-pageflip)
[530.084214] Starting subtest: legacy-pageflip
[530.086810] Starting dynamic subtest: pipe-A-eDP-1
[537.482753] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.399s)
[537.485104] Subtest legacy-pageflip: SUCCESS (7.401s)
[538.324433] [068/134] (489s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[538.401896] Starting subtest: map-fixed-invalidate-overlap
[538.406427] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[538.555427] [069/134] (489s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[538.649680] Starting subtest: primary-x-tiled-reflect-x-180
[545.836260] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.189s)
[547.077504] [070/134] (481s left) kms_vblank (ts-continuation-dpms-suspend)
[547.178677] Starting subtest: ts-continuation-dpms-suspend
[547.180776] Starting dynamic subtest: pipe-A-eDP-1
[564.168079] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.332s)
[564.184141] Starting dynamic subtest: pipe-D-eDP-1
[582.206959] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.898s)
[582.209778] Subtest ts-continuation-dpms-suspend: SUCCESS (5.234s)
[589.055175] [071/134] (445s left) kms_frontbuffer_tracking (fbc-2p-rte)
[589.177148] Starting subtest: fbc-2p-rte
[589.185211] Subtest fbc-2p-rte: SKIP (0.000s)
[589.298588] [072/134] (444s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-blt)
[589.400232] Starting subtest: fbc-abgr161616f-draw-blt
[589.405958] Subtest fbc-abgr161616f-draw-blt: SKIP (0.000s)
[589.530684] [073/134] (444s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[589.640525] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[589.645430] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[589.765818] [074/134] (444s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[589.887394] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[590.918134] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s)
[591.097406] [075/134] (443s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[591.168829] Starting subtest: y-tiled-to-vebox-yf-tiled
[591.174094] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[591.378846] [076/134] (443s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[591.478931] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[591.484144] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[591.609174] [077/134] (442s left) api_intel_bb (crc32)
[591.669315] Starting subtest: crc32
[591.672218] Starting dynamic subtest: rcs0-smem0
[591.971197] Dynamic subtest rcs0-smem0: SUCCESS (0.294s)
[591.984196] Starting dynamic subtest: bcs0-smem0
[592.331524] Dynamic subtest bcs0-smem0: SUCCESS (0.346s)
[592.343531] Starting dynamic subtest: vcs0-smem0
[592.736581] Dynamic subtest vcs0-smem0: SUCCESS (0.390s)
[592.749462] Starting dynamic subtest: vcs1-smem0
[593.081313] Dynamic subtest vcs1-smem0: SUCCESS (0.332s)
[593.091876] Starting dynamic subtest: vecs0-smem0
[593.413899] Dynamic subtest vecs0-smem0: SUCCESS (0.321s)
[593.430561] Starting dynamic subtest: ccs0-smem0
[593.753667] Dynamic subtest ccs0-smem0: SUCCESS (0.327s)
[593.756638] Subtest crc32: SUCCESS (2.027s)
[593.913290] [078/134] (440s left) kms_cursor_edge_walk (256x256-right-edge)
[594.023746] Starting subtest: 256x256-right-edge
[594.026291] Starting dynamic subtest: pipe-A-eDP-1
[597.508705] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[597.519474] Starting dynamic subtest: pipe-D-eDP-1
[600.689044] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[600.691454] Subtest 256x256-right-edge: SUCCESS (6.551s)
[601.513962] [079/134] (433s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[601.584966] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[601.670841] [080/134] (432s left) kms_psr (psr-cursor-mmap-gtt)
[601.764731] Starting subtest: psr-cursor-mmap-gtt
[601.767421] Starting dynamic subtest: eDP-1
[603.503180] Dynamic subtest eDP-1: SUCCESS (1.725s)
[603.506148] Subtest psr-cursor-mmap-gtt: SUCCESS (1.726s)
[604.395440] [081/134] (430s left) kms_flip (2x-plain-flip)
[604.496296] Starting subtest: 2x-plain-flip
[604.505421] Subtest 2x-plain-flip: SKIP (0.011s)
[604.621732] [082/134] (430s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[604.736989] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[611.812272] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.046s)
[611.929304] [083/134] (422s left) gem_exec_fence (syncobj-invalid-wait)
[612.412257] Starting subtest: syncobj-invalid-wait
[612.415257] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[613.746797] [084/134] (421s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[613.839156] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[614.213055] Starting dynamic subtest: pipe-A-eDP-1
[616.941271] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.722s)
[617.328713] Starting dynamic subtest: pipe-B-eDP-1
[620.086665] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[620.471764] Starting dynamic subtest: pipe-C-eDP-1
[623.227168] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.760s)
[623.598739] Starting dynamic subtest: pipe-D-eDP-1
[626.357528] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[626.360177] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.506s)
[627.555938] [085/134] (407s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[632.504524] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[632.507326] Starting dynamic subtest: pipe-A-eDP-1
[633.302511] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s)
[633.312258] Starting dynamic subtest: pipe-B-eDP-1
[634.432765] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[634.437991] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.925s)
[635.633729] [086/134] (399s left) gem_exec_alignment (single)
[635.698816] Starting subtest: single
[635.704694] Subtest single: SUCCESS (0.003s)
[635.858525] [087/134] (399s left) kms_chamelium_hpd (vga-hpd-fast)
[636.240938] Subtest vga-hpd-fast: SKIP (0.000s)
[637.041765] [088/134] (397s left) kms_busy (basic)
[637.149922] Starting subtest: basic
[637.152097] Starting dynamic subtest: flip
[637.728030] Dynamic subtest flip: SUCCESS (0.578s)
[637.740724] Starting dynamic subtest: modeset
[641.200187] Dynamic subtest modeset: SUCCESS (3.467s)
[641.203101] Subtest basic: SUCCESS (4.048s)
[642.007831] [089/134] (393s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[642.118030] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[642.122968] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[642.221761] [090/134] (392s left) gem_exec_reloc (basic-write-read)
[642.292145] Subtest basic-write-read: SKIP (0.000s)
[642.372485] [091/134] (392s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[642.470825] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[642.473272] Starting dynamic subtest: pipe-A-default-mode
[643.658069] Dynamic subtest pipe-A-default-mode: SKIP (1.183s)
[643.663283] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.185s)
[643.828652] [092/134] (391s left) gem_userptr_blits (sync-unmap)
[643.896124] Starting subtest: sync-unmap
[643.911304] Subtest sync-unmap: SUCCESS (0.015s)
[644.041681] [093/134] (391s left) kms_hdr (static-toggle-suspend)
[644.134638] Starting subtest: static-toggle-suspend
[644.142746] Subtest static-toggle-suspend: SKIP (0.000s)
[644.221514] [094/134] (391s left) kms_getfb (getfb-handle-not-fb)
[644.304937] Starting subtest: getfb-handle-not-fb
[644.307668] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[644.418468] [095/134] (390s left) gem_close_race (multigpu-basic-threads)
[644.484307] Starting subtest: multigpu-basic-threads
[644.490114] Subtest multigpu-basic-threads: SKIP (0.000s)
[644.753546] [096/134] (390s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[649.798896] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[649.801534] Starting dynamic subtest: pipe-A-eDP-1
[656.453206] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.646s)
[656.463950] Starting dynamic subtest: pipe-B-eDP-1
[663.099217] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.644s)
[663.102125] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.295s)
[663.993183] [097/134] (371s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[664.098984] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[667.885029] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.789s)
[669.106178] [098/134] (366s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[669.176318] Starting subtest: etime-single-wait-for-submit-submitted
[669.279268] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[669.370654] [099/134] (366s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[669.426560] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[669.429198] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[669.555196] [100/134] (365s left) kms_cursor_crc (cursor-onscreen-512x512)
[669.825405] Starting subtest: cursor-onscreen-512x512
[669.831068] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[670.011626] [101/134] (365s left) kms_psr (pr-suspend)
[670.100622] Starting subtest: pr-suspend
[670.105256] Subtest pr-suspend: SKIP (0.000s)
[670.184640] [102/134] (365s left) kms_draw_crc (draw-method-mmap-wc)
[670.282731] Starting subtest: draw-method-mmap-wc
[670.285008] Starting dynamic subtest: xrgb8888-untiled
[670.547020] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[670.556395] Starting dynamic subtest: rgb565-untiled
[670.747252] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[670.756462] Starting dynamic subtest: xrgb2101010-untiled
[670.958632] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[670.968017] Starting dynamic subtest: xbgr16161616f-untiled
[671.180483] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[671.189128] Starting dynamic subtest: xrgb8888-xtiled
[671.314253] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[671.323864] Starting dynamic subtest: rgb565-xtiled
[671.447812] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[671.458511] Starting dynamic subtest: xrgb2101010-xtiled
[671.569766] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[671.579062] Starting dynamic subtest: xbgr16161616f-xtiled
[671.692108] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[671.701173] Starting dynamic subtest: xrgb8888-4tiled
[671.836675] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[671.845854] Starting dynamic subtest: rgb565-4tiled
[671.981180] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[671.990647] Starting dynamic subtest: xrgb2101010-4tiled
[672.137732] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[672.146807] Starting dynamic subtest: xbgr16161616f-4tiled
[672.325807] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.188s)
[672.327983] Subtest draw-method-mmap-wc: SUCCESS (2.045s)
[672.443259] [103/134] (363s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[672.539944] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[672.542026] Starting dynamic subtest: pipe-A-eDP-1
[672.561830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[672.571762] Starting dynamic subtest: pipe-B-eDP-1
[672.590957] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[672.599630] Starting dynamic subtest: pipe-C-eDP-1
[672.618862] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[672.627629] Starting dynamic subtest: pipe-D-eDP-1
[672.647761] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[672.649867] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[674.847020] [104/134] (360s left) drm_read (empty-nonblock)
[675.011138] Starting subtest: empty-nonblock
[675.014122] Subtest empty-nonblock: SUCCESS (0.000s)
[675.171282] [105/134] (360s left) gem_ccs (block-copy-compressed)
[675.229439] Starting subtest: block-copy-compressed
[675.234608] Subtest block-copy-compressed: SKIP (0.000s)
[675.343488] [106/134] (360s left) gem_exec_balancer (fairslice)
[675.400185] Starting subtest: fairslice
[678.291294] Subtest fairslice: SUCCESS (2.888s)
[678.687911] [107/134] (357s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[678.794479] Starting subtest: fbcpsr-shrfb-scaledprimary
[684.622013] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.828s)
[684.772955] [108/134] (351s left) sysfs_heartbeat_interval (precise)
[684.836070] Starting subtest: precise
[684.838834] Starting dynamic subtest: vecs0
[692.640563] Dynamic subtest vecs0: SUCCESS (7.805s)
[692.653063] Starting dynamic subtest: ccs0
[693.818183] Dynamic subtest ccs0: SUCCESS (1.175s)
[693.828975] Starting dynamic subtest: vcs0
[701.592205] Dynamic subtest vcs0: SUCCESS (7.772s)
[701.607989] Starting dynamic subtest: bcs0
[702.769974] Dynamic subtest bcs0: SUCCESS (1.177s)
[702.781207] Starting dynamic subtest: rcs0
[703.906119] Dynamic subtest rcs0: SUCCESS (1.135s)
[703.916669] Starting dynamic subtest: vcs1
[711.668842] Dynamic subtest vcs1: SUCCESS (7.761s)
[711.671950] Subtest precise: SUCCESS (26.838s)
[711.794007] [109/134] (324s left) gem_exec_schedule (smoketest)
[711.983634] Starting subtest: smoketest
[711.986238] Starting dynamic subtest: rcs0
[717.571306] Dynamic subtest rcs0: SUCCESS (5.532s)
[717.582081] Starting dynamic subtest: bcs0
[723.106828] Dynamic subtest bcs0: SUCCESS (5.525s)
[723.124033] Starting dynamic subtest: vcs0
[728.633713] Dynamic subtest vcs0: SUCCESS (5.527s)
[728.644619] Starting dynamic subtest: vcs1
[734.197446] Dynamic subtest vcs1: SUCCESS (5.560s)
[734.212029] Starting dynamic subtest: vecs0
[739.724710] Dynamic subtest vecs0: SUCCESS (5.518s)
[739.739118] Starting dynamic subtest: ccs0
[745.233030] Dynamic subtest ccs0: SUCCESS (5.516s)
[745.235906] Subtest smoketest: SUCCESS (33.189s)
[745.432444] [110/134] (290s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[745.530261] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[745.650707] [111/134] (290s left) perf_pmu (busy-accuracy-50)
[745.689103] Starting subtest: busy-accuracy-50
[745.691992] Starting dynamic subtest: rcs0
[747.221822] Dynamic subtest rcs0: SUCCESS (1.534s)
[747.234337] Starting dynamic subtest: bcs0
[748.765180] Dynamic subtest bcs0: SUCCESS (1.540s)
[748.777947] Starting dynamic subtest: vcs0
[750.310101] Dynamic subtest vcs0: SUCCESS (1.542s)
[750.321264] Starting dynamic subtest: vcs1
[751.855129] Dynamic subtest vcs1: SUCCESS (1.542s)
[751.867263] Starting dynamic subtest: vecs0
[753.397258] Dynamic subtest vecs0: SUCCESS (1.539s)
[753.409647] Starting dynamic subtest: ccs0
[754.944124] Dynamic subtest ccs0: SUCCESS (1.544s)
[754.947249] Subtest busy-accuracy-50: SUCCESS (9.255s)
[755.076248] [112/134] (280s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[755.172874] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[755.198783] Starting dynamic subtest: pipe-A-plane-0
[755.204009] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[755.215802] Starting dynamic subtest: pipe-A-plane-3
[755.220927] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[755.231076] Starting dynamic subtest: pipe-A-plane-5
[755.236060] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[756.250134] Starting dynamic subtest: pipe-B-plane-0
[756.255202] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[756.266253] Starting dynamic subtest: pipe-B-plane-3
[756.271789] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[756.282108] Starting dynamic subtest: pipe-B-plane-5
[756.286971] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[756.562942] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (1.388s)
[757.431647] [113/134] (278s left) kms_pipe_crc_basic (nonblocking-crc)
[757.525580] Starting subtest: nonblocking-crc
[757.528244] Starting dynamic subtest: pipe-A-eDP-1
[758.266085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[758.277949] Starting dynamic subtest: pipe-B-eDP-1
[759.675934] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[759.687079] Starting dynamic subtest: pipe-C-eDP-1
[761.022196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[761.033319] Starting dynamic subtest: pipe-D-eDP-1
[762.366534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[762.369073] Subtest nonblocking-crc: SUCCESS (4.838s)
[763.180755] [114/134] (272s left) gem_mmap (bad-object)
[763.249644] Subtest bad-object: SKIP (0.000s)
[763.321459] [115/134] (272s left) prime_vgem (basic-blt)
[763.388977] Starting subtest: basic-blt
[763.439312] Subtest basic-blt: SUCCESS (0.053s)
[763.596786] [116/134] (272s left) gem_lmem_swapping (parallel-multi)
[763.636766] Subtest parallel-multi: SKIP (0.000s)
[763.677939] [117/134] (272s left) kms_pm_lpsp (kms-lpsp)
[764.775164] Starting subtest: kms-lpsp
[764.777726] Starting dynamic subtest: pipe-A-eDP-1
[764.910689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[765.219473] Subtest kms-lpsp: SUCCESS (0.446s)
[766.034441] [118/134] (270s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[766.091802] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[766.147668] [119/134] (270s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[766.266265] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[784.070293] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.798s)
[784.965033] [120/134] (251s left) kms_cursor_legacy (single-bo)
[785.103902] Starting subtest: single-bo
[785.105989] Starting dynamic subtest: pipe-A
[790.490269] Dynamic subtest pipe-A: SUCCESS (5.381s)
[790.502804] Starting dynamic subtest: pipe-B
[795.874869] Dynamic subtest pipe-B: SUCCESS (5.380s)
[795.887064] Starting dynamic subtest: pipe-C
[801.259832] Dynamic subtest pipe-C: SUCCESS (5.380s)
[801.272068] Starting dynamic subtest: pipe-D
[806.644303] Dynamic subtest pipe-D: SUCCESS (5.379s)
[806.655946] Starting dynamic subtest: all-pipes
[812.035413] Dynamic subtest all-pipes: SUCCESS (5.387s)
[812.038208] Subtest single-bo: SUCCESS (26.921s)
[812.193175] [121/134] (224s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[812.268134] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[812.374950] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[812.466858] [122/134] (223s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[812.570455] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[812.575143] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[812.687794] [123/134] (223s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[817.720210] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[817.723023] Starting dynamic subtest: pipe-A-eDP-1
[818.523968] Dynamic subtest pipe-A-eDP-1: SKIP (0.799s)
[818.534544] Starting dynamic subtest: pipe-B-eDP-1
[819.667142] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s)
[819.673109] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.942s)
[820.860034] [124/134] (215s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[820.965098] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[820.970249] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[821.086611] [125/134] (215s left) kms_color (ctm-green-to-red)
[821.189167] Starting subtest: ctm-green-to-red
[821.191848] Starting dynamic subtest: pipe-A-eDP-1
[821.911822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s)
[821.924253] Starting dynamic subtest: pipe-B-eDP-1
[823.349158] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[823.359240] Starting dynamic subtest: pipe-C-eDP-1
[824.690587] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[824.700290] Starting dynamic subtest: pipe-D-eDP-1
[826.023319] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[826.026162] Subtest ctm-green-to-red: SUCCESS (4.837s)
[826.884589] [126/134] (209s left) gem_mmap_wc (set-cache-level)
[826.951066] Subtest set-cache-level: SKIP (0.000s)
[827.030804] [127/134] (209s left) gem_exec_reloc (basic-write-cpu-active)
[827.105149] Subtest basic-write-cpu-active: SKIP (0.000s)
[827.190369] [128/134] (209s left) kms_flip (2x-flip-vs-fences)
[827.292964] Starting subtest: 2x-flip-vs-fences
[827.298059] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[827.424638] [129/134] (209s left) gem_mmap_offset (blt-coherency)
[827.484186] Starting subtest: blt-coherency
[827.489724] Subtest blt-coherency: SUCCESS (0.008s)
[827.643262] [130/134] (209s left) kms_psr (fbc-psr-cursor-plane-onoff)
[827.733879] Starting subtest: fbc-psr-cursor-plane-onoff
[827.736323] Starting dynamic subtest: eDP-1
[827.741140] Dynamic subtest eDP-1: SKIP (0.000s)
[827.746090] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[827.823352] [131/134] (209s left) gem_softpin (allocator-nopin-reserve)
[827.886176] Starting subtest: allocator-nopin-reserve
[828.000098] Subtest allocator-nopin-reserve: SUCCESS (0.113s)
[828.154757] [132/134] (208s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[828.259121] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[828.264249] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[829.419473] [133/134] (207s left) sw_sync (sync_busy_fork)
[829.457729] Starting subtest: sync_busy_fork
[830.466687] Subtest sync_busy_fork: SUCCESS (1.012s)
[830.553537] [134/134] (206s left) kms_invalid_mode (clock-too-high)
[830.648247] Starting subtest: clock-too-high
[830.651129] Starting dynamic subtest: pipe-A-eDP-1
[830.656669] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[830.668421] Starting dynamic subtest: pipe-B-eDP-1
[830.674093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[830.686179] Starting dynamic subtest: pipe-C-eDP-1
[830.691962] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[830.701508] Starting dynamic subtest: pipe-D-eDP-1
[830.707075] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[830.712298] Subtest clock-too-high: SKIP (0.004s)
[830.748083] 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.