[56.202965] Initializing watchdogs
[56.203109]   /dev/watchdog0
[56.217334] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.221711] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.224335] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.227853] [001/132] (960s left) gem_busy (extended)
[56.443640] Starting subtest: extended
[56.445928] Starting dynamic subtest: rcs0
[56.543944] Dynamic subtest rcs0: SUCCESS (0.100s)
[56.551884] Starting dynamic subtest: bcs0
[56.588578] Dynamic subtest bcs0: SUCCESS (0.044s)
[56.595777] Starting dynamic subtest: vcs0
[58.313321] Dynamic subtest vcs0: SUCCESS (1.751s)
[58.322692] Starting dynamic subtest: vcs1
[60.297485] Dynamic subtest vcs1: SUCCESS (2.008s)
[60.307233] Starting dynamic subtest: vecs0
[62.283348] Dynamic subtest vecs0: SUCCESS (2.002s)
[62.292855] Starting dynamic subtest: ccs0
[62.329923] Dynamic subtest ccs0: SUCCESS (0.049s)
[62.332376] Subtest extended: SUCCESS (5.962s)
[62.559388] [002/132] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[62.658501] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[62.660787] Starting dynamic subtest: pipe-A-eDP-1
[62.684183] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.694585] Starting dynamic subtest: pipe-B-eDP-1
[62.718584] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.728279] Starting dynamic subtest: pipe-C-eDP-1
[62.749783] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.757139] Starting dynamic subtest: pipe-D-eDP-1
[62.781274] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.785489] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[65.206205] [003/132] (951s left) kms_frontbuffer_tracking (psr-2p-rte)
[65.299447] Starting subtest: psr-2p-rte
[65.303747] Subtest psr-2p-rte: SKIP (0.000s)
[65.396068] [004/132] (951s left) syncobj_wait (reset-during-wait-for-submit)
[65.461266] Starting subtest: reset-during-wait-for-submit
[65.565977] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[65.637081] [005/132] (951s left) gem_fenced_exec_thrash (too-many-fences)
[65.702168] Subtest too-many-fences: SKIP (0.000s)
[65.776922] [006/132] (951s left) gem_tiled_fence_blits (basic)
[65.831469] Subtest basic: SKIP (0.000s)
[65.895905] [007/132] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[65.986479] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[73.694323] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.737s)
[73.813441] [008/132] (943s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[73.911942] Starting subtest: psr-rgb101010-draw-render
[81.294702] Subtest psr-rgb101010-draw-render: SUCCESS (7.397s)
[81.407812] [009/132] (935s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[81.513763] Starting subtest: x-tiled-64bpp-rotate-90
[81.534046] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[81.635352] [010/132] (935s left) gem_eio (wait-1us)
[81.811795] Starting subtest: wait-1us
[82.029643] Subtest wait-1us: SUCCESS (0.218s)
[82.169557] [011/132] (934s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[82.254436] Starting subtest: fbc-psr-sprite-mmap-cpu
[82.256438] Starting dynamic subtest: eDP-1
[82.259973] Dynamic subtest eDP-1: SKIP (0.000s)
[82.263596] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[82.326254] [012/132] (934s left) gem_exec_schedule (manyslice)
[82.394386] Starting subtest: manyslice
[82.396459] Starting dynamic subtest: rcs0
[87.529151] Dynamic subtest rcs0: SUCCESS (5.142s)
[87.539527] Starting dynamic subtest: bcs0
[94.175669] Dynamic subtest bcs0: SUCCESS (6.646s)
[94.186665] Starting dynamic subtest: vcs0
[100.266821] Dynamic subtest vcs0: SUCCESS (6.091s)
[100.276703] Starting dynamic subtest: vcs1
[106.362348] Dynamic subtest vcs1: SUCCESS (6.085s)
[106.385832] Starting dynamic subtest: vecs0
[111.916974] Dynamic subtest vecs0: SUCCESS (5.564s)
[111.929495] Starting dynamic subtest: ccs0
[119.145647] Dynamic subtest ccs0: SUCCESS (7.227s)
[119.148675] Subtest manyslice: SUCCESS (36.759s)
[119.467974] [013/132] (897s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[119.519921] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[119.522398] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[119.613759] [014/132] (897s left) gem_exec_schedule (wide)
[119.793804] Starting subtest: wide
[119.796404] Starting dynamic subtest: rcs0
[131.304959] Dynamic subtest rcs0: SUCCESS (11.510s)
[131.314352] Starting dynamic subtest: vcs0
[144.459251] Dynamic subtest vcs0: SUCCESS (13.155s)
[144.468560] Starting dynamic subtest: vcs1
[156.356869] Dynamic subtest vcs1: SUCCESS (11.895s)
[156.365837] Starting dynamic subtest: vecs0
[168.115732] Dynamic subtest vecs0: SUCCESS (11.757s)
[168.127606] Starting dynamic subtest: ccs0
[182.352190] Dynamic subtest ccs0: SUCCESS (14.234s)
[182.354568] Subtest wide: SUCCESS (62.553s)
[184.111956] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[184.114794] [015/132] (833s left) kms_addfb_basic (small-bo)
[184.209718] Starting subtest: small-bo
[184.211647] Subtest small-bo: SUCCESS (0.000s)
[184.311760] [016/132] (832s left) gem_exec_balancer (full-late)
[184.376702] Starting subtest: full-late
[189.170392] Subtest full-late: SUCCESS (4.793s)
[189.479329] [017/132] (827s left) kms_pm_backlight (brightness-with-dpms)
[189.580051] Starting subtest: brightness-with-dpms
[189.658360] Starting dynamic subtest: eDP-1
[192.093184] Dynamic subtest eDP-1: SUCCESS (2.432s)
[192.095552] Subtest brightness-with-dpms: SUCCESS (2.512s)
[192.967197] [018/132] (824s left) api_intel_allocator (fork-simple-once)
[193.021634] Starting subtest: fork-simple-once
[193.034071] Subtest fork-simple-once: SUCCESS (0.015s)
[193.153517] [019/132] (824s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[193.246726] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[193.251375] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[193.316701] [020/132] (824s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[193.412481] Starting subtest: psr2-plane-move-sf-dmg-area
[193.415043] Starting dynamic subtest: pipe-A-eDP-1
[197.913706] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.504s)
[197.923643] Starting dynamic subtest: pipe-B-eDP-1
[203.233684] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.322s)
[203.236120] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.828s)
[204.111091] [021/132] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[204.208088] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[207.767609] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.564s)
[208.908680] [022/132] (808s left) kms_frontbuffer_tracking (fbc-2p-rte)
[209.001581] Starting subtest: fbc-2p-rte
[209.005702] Subtest fbc-2p-rte: SKIP (0.000s)
[209.110344] [023/132] (808s left) gem_exec_reloc (basic-cpu-wc)
[209.176104] Subtest basic-cpu-wc: SKIP (0.000s)
[209.257916] [024/132] (808s left) syncobj_timeline (wait-all-for-submit-complex)
[209.329624] Starting subtest: wait-all-for-submit-complex
[209.543197] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[209.631277] [025/132] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[209.724828] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[209.729202] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[209.823217] [026/132] (807s left) kms_dsc (dsc-with-output-formats-with-bpc)
[209.910227] Starting subtest: dsc-with-output-formats-with-bpc
[209.968093] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[210.006310] [027/132] (807s left) gem_exec_flush (basic-wb-rw-default)
[210.070898] Starting subtest: basic-wb-rw-default
[215.526122] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[215.730298] [028/132] (802s left) kms_joiner (basic-big-joiner)
[215.829565] Starting subtest: basic-big-joiner
[215.834327] Subtest basic-big-joiner: SKIP (0.000s)
[215.903793] [029/132] (801s left) perf_pmu (render-node-busy-idle)
[215.994497] Starting subtest: render-node-busy-idle
[215.996888] Starting dynamic subtest: rcs0
[216.681043] Dynamic subtest rcs0: SUCCESS (0.686s)
[216.692217] Starting dynamic subtest: bcs0
[217.354804] Dynamic subtest bcs0: SUCCESS (0.673s)
[217.365840] Starting dynamic subtest: vcs0
[219.338396] Dynamic subtest vcs0: SUCCESS (1.980s)
[219.349082] Starting dynamic subtest: vcs1
[221.321699] Dynamic subtest vcs1: SUCCESS (1.982s)
[221.334082] Starting dynamic subtest: vecs0
[223.306224] Dynamic subtest vecs0: SUCCESS (1.983s)
[223.316908] Starting dynamic subtest: ccs0
[223.969226] Dynamic subtest ccs0: SUCCESS (0.663s)
[223.971926] Subtest render-node-busy-idle: SUCCESS (7.975s)
[224.061534] [030/132] (793s left) kms_addfb_basic (invalid-get-prop)
[224.112116] Starting subtest: invalid-get-prop
[224.114265] Subtest invalid-get-prop: SUCCESS (0.000s)
[224.272756] [031/132] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[224.381221] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[224.385197] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[224.498487] [032/132] (793s left) i915_pm_rps (thresholds)
[224.564996] Starting subtest: thresholds
[224.569694] Subtest thresholds: SKIP (0.001s)
[224.689366] [033/132] (793s left) gem_mmap_wc (bad-offset)
[224.748285] Subtest bad-offset: SKIP (0.000s)
[224.805523] [034/132] (793s left) kms_rotation_crc (multiplane-rotation)
[224.893915] Starting subtest: multiplane-rotation
[242.374297] Subtest multiplane-rotation: SUCCESS (17.482s)
[242.503118] [035/132] (775s left) gem_softpin (evict-prime-sanity-check)
[242.567898] Starting subtest: evict-prime-sanity-check
[242.569957] Starting dynamic subtest: rcs0
[243.726066] Dynamic subtest rcs0: SUCCESS (1.157s)
[243.739037] Starting dynamic subtest: bcs0
[244.849885] Dynamic subtest bcs0: SUCCESS (1.122s)
[244.860943] Starting dynamic subtest: vcs0
[246.261033] Dynamic subtest vcs0: SUCCESS (1.408s)
[246.272887] Starting dynamic subtest: vcs1
[248.256663] Dynamic subtest vcs1: SUCCESS (1.993s)
[248.268849] Starting dynamic subtest: vecs0
[250.309731] Dynamic subtest vecs0: SUCCESS (2.051s)
[250.319420] Starting dynamic subtest: ccs0
[251.441235] Dynamic subtest ccs0: SUCCESS (1.131s)
[251.453527] Starting dynamic subtest: all
[252.555627] Dynamic subtest all: SUCCESS (1.113s)
[252.558053] Subtest evict-prime-sanity-check: SUCCESS (9.988s)
[252.638490] [036/132] (765s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[252.728049] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[252.732126] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[252.799181] [037/132] (765s left) kms_flip (flip-vs-expired-vblank-interruptible)
[252.891314] Starting subtest: flip-vs-expired-vblank-interruptible
[252.893683] Starting dynamic subtest: A-eDP1
[261.594244] Dynamic subtest A-eDP1: SUCCESS (8.702s)
[261.606095] Starting dynamic subtest: B-eDP1
[265.650418] Dynamic subtest B-eDP1: FAIL (3.564s)
[265.662210] Starting dynamic subtest: C-eDP1
[273.833700] Dynamic subtest C-eDP1: SUCCESS (8.668s)
[273.846173] Starting dynamic subtest: D-eDP1
[282.454768] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[282.457098] Subtest flip-vs-expired-vblank-interruptible: FAIL (29.566s)
[283.631511] [038/132] (734s left) gem_ctx_shared (disjoint-timelines)
[283.702347] Starting subtest: disjoint-timelines
[283.733081] Subtest disjoint-timelines: SUCCESS (0.031s)
[283.958277] [039/132] (734s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[284.042607] Starting subtest: fbcpsr-rgb101010-draw-render
[290.816129] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.777s)
[290.941194] [040/132] (727s left) gem_exec_parallel (fds)
[290.999775] Starting subtest: fds
[291.002111] Starting dynamic subtest: rcs0
[293.964428] Dynamic subtest rcs0: SUCCESS (2.962s)
[293.974714] Starting dynamic subtest: bcs0
[298.357608] Dynamic subtest bcs0: SUCCESS (4.391s)
[298.367488] Starting dynamic subtest: vcs0
[302.569548] Dynamic subtest vcs0: SUCCESS (4.209s)
[302.581821] Starting dynamic subtest: vcs1
[306.627675] Dynamic subtest vcs1: SUCCESS (4.055s)
[306.640407] Starting dynamic subtest: vecs0
[310.589488] Dynamic subtest vecs0: SUCCESS (3.959s)
[310.599402] Starting dynamic subtest: ccs0
[314.971348] Dynamic subtest ccs0: SUCCESS (4.380s)
[314.974237] Subtest fds: SUCCESS (23.969s)
[315.189419] [041/132] (703s left) gem_readwrite (new-obj)
[315.237896] Subtest new-obj: SKIP (0.000s)
[315.303825] [042/132] (703s left) gem_mmap_wc (fault-concurrent)
[315.372684] Subtest fault-concurrent: SKIP (0.000s)
[315.438751] [043/132] (703s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[315.546330] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[316.658528] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.113s)
[316.767529] [044/132] (701s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[316.820058] Starting subtest: multi-wait-for-submit-available-signaled
[316.822372] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[316.923193] [045/132] (701s left) gem_exec_fence (basic-busy-all)
[316.976636] Starting subtest: basic-busy-all
[317.082791] Subtest basic-busy-all: SUCCESS (0.106s)
[319.397996] [046/132] (699s left) gem_lmem_swapping (parallel-random-verify-ccs)
[319.441659] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[319.488275] [047/132] (699s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[319.586223] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[319.588489] Starting dynamic subtest: pipe-A-eDP-1
[319.611920] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.624499] Starting dynamic subtest: pipe-B-eDP-1
[319.645909] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.655816] Starting dynamic subtest: pipe-C-eDP-1
[319.677417] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.686789] Starting dynamic subtest: pipe-D-eDP-1
[319.708517] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.712531] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[321.835571] [048/132] (696s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[321.939763] Starting subtest: pr-plane-move-sf-dmg-area
[321.944277] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[322.021283] [049/132] (696s left) kms_psr (fbc-psr2-sprite-blt)
[322.124501] Starting subtest: fbc-psr2-sprite-blt
[322.126683] Starting dynamic subtest: eDP-1
[322.130939] Dynamic subtest eDP-1: SKIP (0.000s)
[322.135191] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[322.224524] [050/132] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[322.319401] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[329.043563] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.727s)
[329.181008] [051/132] (689s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[329.281627] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[329.285626] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[329.382915] [052/132] (689s left) gem_eio (wait-10ms)
[329.605685] Starting subtest: wait-10ms
[329.953381] Subtest wait-10ms: SUCCESS (0.347s)
[330.125516] [053/132] (688s left) kms_prime (basic-crc-vgem)
[330.200738] Starting subtest: basic-crc-vgem
[330.202398] Starting dynamic subtest: second-to-first
[331.225842] Dynamic subtest second-to-first: SUCCESS (1.028s)
[331.227864] Subtest basic-crc-vgem: SUCCESS (1.030s)
[331.324183] [054/132] (687s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[331.464880] Starting subtest: extended-modeset-hang-newfb-with-reset
[331.466882] Starting dynamic subtest: pipe-A
[346.526438] Dynamic subtest pipe-A: SUCCESS (15.059s)
[346.539659] Starting dynamic subtest: pipe-D
[362.031782] Dynamic subtest pipe-D: SUCCESS (15.501s)
[362.034104] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.564s)
[362.828056] [055/132] (656s left) kms_hdr (static-swap)
[362.921240] Starting subtest: static-swap
[362.927612] Subtest static-swap: SKIP (0.001s)
[363.008307] [056/132] (656s left) kms_content_protection (type1)
[363.145180] Starting subtest: type1
[363.149777] Subtest type1: SKIP (0.000s)
[363.276202] [057/132] (655s left) gem_flink_basic (double-flink)
[363.323897] Starting subtest: double-flink
[363.326264] Subtest double-flink: SUCCESS (0.000s)
[363.448871] [058/132] (655s left) gem_tiled_swapping (non-threaded)
[363.497687] Subtest non-threaded: SKIP (0.000s)
[363.553116] [059/132] (655s left) gem_render_copy (yf-tiled)
[363.608315] Starting subtest: yf-tiled
[363.612477] Subtest yf-tiled: SKIP (0.000s)
[363.787504] [060/132] (655s left) gem_exec_balancer (semaphore)
[363.848284] Starting subtest: semaphore
[365.298476] Subtest semaphore: SUCCESS (1.448s)
[365.594325] [061/132] (653s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[365.654133] Starting subtest: y-tiled-to-vebox-x-tiled
[365.658185] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[365.833629] [062/132] (653s left) gem_exec_fence (syncobj-timeline-wait)
[366.371751] Starting subtest: syncobj-timeline-wait
[367.353799] Subtest syncobj-timeline-wait: SUCCESS (0.982s)
[369.373347] [063/132] (649s left) kms_flip (dpms-vs-vblank-race)
[369.475195] Starting subtest: dpms-vs-vblank-race
[369.477420] Starting dynamic subtest: A-eDP1
[374.410605] Dynamic subtest A-eDP1: SUCCESS (4.932s)
[374.420679] Starting dynamic subtest: B-eDP1
[379.039091] Dynamic subtest B-eDP1: SUCCESS (4.626s)
[379.049289] Starting dynamic subtest: C-eDP1
[383.632612] Dynamic subtest C-eDP1: SUCCESS (4.592s)
[383.642735] Starting dynamic subtest: D-eDP1
[388.274827] Dynamic subtest D-eDP1: SUCCESS (4.641s)
[388.277116] Subtest dpms-vs-vblank-race: SUCCESS (18.805s)
[389.147399] [064/132] (630s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[389.197370] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[389.301924] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[389.380459] [065/132] (630s left) syncobj_timeline (invalid-transfer-bad-pad)
[389.434893] Starting subtest: invalid-transfer-bad-pad
[389.437190] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[389.529394] [066/132] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[389.619413] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[396.265697] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.648s)
[396.403637] [067/132] (623s left) kms_color (ctm-max)
[396.492236] Starting subtest: ctm-max
[396.494424] Starting dynamic subtest: pipe-A-eDP-1
[397.208251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[397.217927] Starting dynamic subtest: pipe-B-eDP-1
[398.594133] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[398.604285] Starting dynamic subtest: pipe-C-eDP-1
[399.971657] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[399.983653] Starting dynamic subtest: pipe-D-eDP-1
[401.297507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[401.299795] Subtest ctm-max: SUCCESS (4.806s)
[402.104548] [068/132] (617s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[402.194993] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[402.198971] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[402.283755] [069/132] (617s left) gem_eio (hibernate)
[402.513451] Starting subtest: hibernate
[418.089951] Subtest hibernate: SUCCESS (15.575s)
[426.223516] [070/132] (601s left) gem_wait (write-wait)
[426.296738] Starting subtest: write-wait
[426.299056] Starting dynamic subtest: all-engines
[427.431173] Dynamic subtest all-engines: SUCCESS (1.133s)
[427.449438] Starting dynamic subtest: rcs0
[428.490787] Dynamic subtest rcs0: SUCCESS (1.056s)
[428.508146] Starting dynamic subtest: bcs0
[429.546290] Dynamic subtest bcs0: SUCCESS (1.055s)
[429.566682] Starting dynamic subtest: vcs0
[430.602714] Dynamic subtest vcs0: SUCCESS (1.053s)
[430.621235] Starting dynamic subtest: vcs1
[431.656695] Dynamic subtest vcs1: SUCCESS (1.051s)
[431.673817] Starting dynamic subtest: vecs0
[432.711391] Dynamic subtest vecs0: SUCCESS (1.053s)
[432.729909] Starting dynamic subtest: ccs0
[433.770550] Dynamic subtest ccs0: SUCCESS (1.056s)
[433.773293] Subtest write-wait: SUCCESS (7.475s)
[433.990823] [071/132] (593s left) kms_async_flips (async-flip-dpms)
[434.097908] Starting subtest: async-flip-dpms
[434.486581] Starting dynamic subtest: pipe-A-eDP-1
[438.307587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.819s)
[438.702642] Starting dynamic subtest: pipe-B-eDP-1
[441.567485] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.872s)
[441.972796] Starting dynamic subtest: pipe-C-eDP-1
[444.731665] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[445.115059] Starting dynamic subtest: pipe-D-eDP-1
[447.879882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[447.882204] Subtest async-flip-dpms: SUCCESS (13.782s)
[449.055944] [072/132] (578s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[449.152201] Starting subtest: primary-yf-tiled-reflect-x-270
[449.156661] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[449.227364] [073/132] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[449.334834] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[449.338725] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[449.430908] [074/132] (578s left) gem_exec_fence (syncobj-invalid-flags)
[449.838027] Starting subtest: syncobj-invalid-flags
[449.840365] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[451.336480] [075/132] (576s left) perf (non-zero-reason)
[451.460406] Starting subtest: non-zero-reason
[451.462271] Starting dynamic subtest: 0-rcs0
[456.898393] Dynamic subtest 0-rcs0: SUCCESS (5.437s)
[456.915096] Starting dynamic subtest: 1-vcs1
[460.840071] Dynamic subtest 1-vcs1: SUCCESS (3.941s)
[460.843206] Subtest non-zero-reason: SUCCESS (9.380s)
[460.896395] [076/132] (566s left) i915_pm_freq_api (freq-basic-api)
[460.969268] Starting subtest: freq-basic-api
[460.971648] Starting dynamic subtest: gt0
[460.976912] Dynamic subtest gt0: SUCCESS (0.006s)
[460.991136] Starting dynamic subtest: gt1
[460.993365] Dynamic subtest gt1: SUCCESS (0.003s)
[460.995578] Subtest freq-basic-api: SUCCESS (0.011s)
[461.106502] [077/132] (566s left) gem_mmap_gtt (ptrace)
[461.165658] Subtest ptrace: SKIP (0.000s)
[461.239486] [078/132] (566s left) kms_pipe_crc_basic (suspend-read-crc)
[461.340792] Starting subtest: suspend-read-crc
[461.343091] Starting dynamic subtest: pipe-A-eDP-1
[478.883143] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.550s)
[478.894632] Starting dynamic subtest: pipe-B-eDP-1
[496.866956] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[496.878563] Starting dynamic subtest: pipe-C-eDP-1
[514.810454] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.153s)
[514.822077] Starting dynamic subtest: pipe-D-eDP-1
[532.822546] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[532.824872] Subtest suspend-read-crc: SUCCESS (12.041s)
[533.614376] [079/132] (494s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[533.732672] Starting subtest: 4-tiled-64bpp-rotate-90
[533.752279] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[533.857156] [080/132] (494s left) gem_partial_pwrite_pread (reads-uncached)
[533.907952] Subtest reads-uncached: SKIP (0.000s)
[533.975938] [081/132] (494s left) sysfs_heartbeat_interval (precise)
[534.037665] Starting subtest: precise
[534.039549] Starting dynamic subtest: vecs0
[541.970127] Dynamic subtest vecs0: SUCCESS (8.035s)
[541.984401] Starting dynamic subtest: ccs0
[544.959395] Dynamic subtest ccs0: SUCCESS (3.009s)
[544.972781] Starting dynamic subtest: vcs0
[552.975803] Dynamic subtest vcs0: SUCCESS (8.039s)
[552.987787] Starting dynamic subtest: bcs0
[555.926359] Dynamic subtest bcs0: SUCCESS (2.957s)
[555.938782] Starting dynamic subtest: rcs0
[556.995079] Dynamic subtest rcs0: SUCCESS (1.067s)
[557.006289] Starting dynamic subtest: vcs1
[564.943122] Dynamic subtest vcs1: SUCCESS (7.951s)
[564.945628] Subtest precise: SUCCESS (31.071s)
[565.035561] [082/132] (463s left) gem_ctx_exec (basic-close-race)
[565.102268] Starting subtest: basic-close-race
[570.897036] Subtest basic-close-race: SUCCESS (5.791s)
[571.019342] [083/132] (457s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[571.333037] Starting subtest: cursor-rapid-movement-max-size
[571.341696] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[571.456846] [084/132] (456s left) kms_psr (pr-no-drrs)
[571.564918] Starting subtest: pr-no-drrs
[571.569534] Subtest pr-no-drrs: SKIP (0.000s)
[571.640185] [085/132] (456s left) gem_userptr_blits (process-exit-busy)
[571.699255] Starting subtest: process-exit-busy
[571.713333] Subtest process-exit-busy: SUCCESS (0.014s)
[571.845585] [086/132] (456s left) gem_ctx_persistence (engines-mixed-process)
[571.911170] Starting subtest: engines-mixed-process
[571.913383] Starting dynamic subtest: rcs0
[573.976964] Dynamic subtest rcs0: SUCCESS (2.062s)
[573.990360] Starting dynamic subtest: bcs0
[575.946665] Dynamic subtest bcs0: SUCCESS (1.971s)
[575.960121] Starting dynamic subtest: vcs0
[577.944777] Dynamic subtest vcs0: SUCCESS (1.997s)
[577.956783] Starting dynamic subtest: vcs1
[579.968992] Dynamic subtest vcs1: SUCCESS (2.023s)
[579.980209] Starting dynamic subtest: vecs0
[581.938675] Dynamic subtest vecs0: SUCCESS (1.969s)
[581.954792] Starting dynamic subtest: ccs0
[583.955877] Dynamic subtest ccs0: SUCCESS (2.016s)
[583.958242] Subtest engines-mixed-process: SUCCESS (12.044s)
[584.044213] [087/132] (444s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[584.155985] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[584.159890] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[584.247553] [088/132] (444s left) kms_psr (psr-cursor-mmap-cpu)
[584.342763] Starting subtest: psr-cursor-mmap-cpu
[584.345031] Starting dynamic subtest: eDP-1
[586.034950] Dynamic subtest eDP-1: SUCCESS (1.691s)
[586.037231] Subtest psr-cursor-mmap-cpu: SUCCESS (1.692s)
[586.922972] [089/132] (441s left) gem_exec_schedule (preempt-self)
[587.005246] Starting subtest: preempt-self
[587.007647] Starting dynamic subtest: rcs0
[587.020529] Dynamic subtest rcs0: SUCCESS (0.021s)
[587.033638] Starting dynamic subtest: bcs0
[587.044729] Dynamic subtest bcs0: SUCCESS (0.023s)
[587.056353] Starting dynamic subtest: vcs0
[587.069327] Dynamic subtest vcs0: SUCCESS (0.023s)
[587.080576] Starting dynamic subtest: vcs1
[587.093171] Dynamic subtest vcs1: SUCCESS (0.022s)
[587.104381] Starting dynamic subtest: vecs0
[587.114751] Dynamic subtest vecs0: SUCCESS (0.021s)
[587.126286] Starting dynamic subtest: ccs0
[587.139059] Dynamic subtest ccs0: SUCCESS (0.023s)
[587.141418] Subtest preempt-self: SUCCESS (0.141s)
[589.039253] [090/132] (439s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[589.098759] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[589.206998] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[589.297281] [091/132] (439s left) kms_flip (flip-vs-absolute-wf_vblank)
[589.399019] Starting subtest: flip-vs-absolute-wf_vblank
[589.401277] Starting dynamic subtest: A-eDP1
[598.358610] Dynamic subtest A-eDP1: SUCCESS (8.962s)
[598.370403] Starting dynamic subtest: B-eDP1
[607.292761] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[607.303989] Starting dynamic subtest: C-eDP1
[616.195330] Dynamic subtest C-eDP1: SUCCESS (8.905s)
[616.208369] Starting dynamic subtest: D-eDP1
[625.122058] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[625.123947] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.739s)
[626.350098] [092/132] (402s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[626.449605] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[626.451870] Starting dynamic subtest: pipe-A
[627.621521] Dynamic subtest pipe-A: SUCCESS (1.174s)
[627.633594] Starting dynamic subtest: pipe-B
[629.850115] Dynamic subtest pipe-B: SUCCESS (2.226s)
[629.866149] Starting dynamic subtest: pipe-C
[631.035960] Dynamic subtest pipe-C: SUCCESS (1.182s)
[631.048355] Starting dynamic subtest: pipe-D
[632.262813] Dynamic subtest pipe-D: SUCCESS (1.225s)
[632.265421] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.813s)
[633.461098] [093/132] (395s left) sw_sync (sync_multi_consumer_producer)
[633.500584] Starting subtest: sync_multi_consumer_producer
[633.799381] Subtest sync_multi_consumer_producer: SUCCESS (0.297s)
[633.866265] [094/132] (394s left) gem_readwrite (write-bad-handle)
[633.927875] Subtest write-bad-handle: SKIP (0.000s)
[633.993249] [095/132] (394s left) kms_chamelium_color (ctm-limited-range)
[634.088660] Subtest ctm-limited-range: SKIP (0.000s)
[634.140169] [096/132] (394s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[634.235804] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[634.240332] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[634.342577] [097/132] (394s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[634.440909] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[634.442822] Starting dynamic subtest: pipe-A-eDP-1
[634.463080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[634.476099] Starting dynamic subtest: pipe-B-eDP-1
[634.495318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.024s)
[634.507734] Starting dynamic subtest: pipe-C-eDP-1
[634.526852] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[634.538805] Starting dynamic subtest: pipe-D-eDP-1
[634.558583] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[634.560808] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[636.816667] [098/132] (392s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[637.206975] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[638.025106] [099/132] (390s left) kms_sequence (get-forked)
[638.116818] Starting subtest: get-forked
[638.119172] Starting dynamic subtest: pipe-A-eDP-1
[640.013746] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[640.026315] Starting dynamic subtest: pipe-B-eDP-1
[642.594085] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s)
[642.606598] Starting dynamic subtest: pipe-C-eDP-1
[645.097850] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.505s)
[645.109932] Starting dynamic subtest: pipe-D-eDP-1
[647.625540] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[647.628198] Subtest get-forked: SUCCESS (9.508s)
[648.489210] [100/132] (380s left) gem_lmem_swapping (heavy-verify-multi)
[648.532977] Subtest heavy-verify-multi: SKIP (0.000s)
[648.582391] [101/132] (380s left) api_intel_bb (intel-bb-blit-y)
[648.625984] Starting subtest: intel-bb-blit-y
[652.369057] Subtest intel-bb-blit-y: SUCCESS (3.743s)
[652.502657] [102/132] (376s left) kms_cursor_crc (cursor-tearing-position-change)
[652.618484] Starting subtest: cursor-tearing-position-change
[652.620728] Starting dynamic subtest: pipe-A-eDP-1
[653.202374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[653.213830] Starting dynamic subtest: pipe-D-eDP-1
[654.409182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.205s)
[654.411501] Subtest cursor-tearing-position-change: SUCCESS (1.791s)
[655.260149] [103/132] (373s left) i915_suspend (fence-restore-untiled)
[655.319388] Starting subtest: fence-restore-untiled
[655.323921] Subtest fence-restore-untiled: SKIP (0.000s)
[655.410000] [104/132] (373s left) kms_addfb_basic (addfb25-modifier-no-flag)
[655.502492] Starting subtest: addfb25-modifier-no-flag
[655.504678] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[655.594637] [105/132] (373s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[655.685988] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[655.690551] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[655.781402] [106/132] (373s left) kms_chamelium_hpd (vga-hpd)
[656.158249] Subtest vga-hpd: SKIP (0.000s)
[656.955905] [107/132] (372s left) drm_read (short-buffer-wakeup)
[657.110669] Starting subtest: short-buffer-wakeup
[689.321052] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[689.473289] [108/132] (339s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[689.580370] Starting subtest: y-tiled-32bpp-rotate-90
[689.584790] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[689.678855] [109/132] (339s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[689.777116] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[689.781334] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[689.889030] [110/132] (339s left) i915_drm_fdinfo (most-busy-check-all)
[689.926783] Starting subtest: most-busy-check-all
[689.928980] Starting dynamic subtest: rcs0
[689.934162] Dynamic subtest rcs0: SKIP (0.004s)
[689.946066] Starting dynamic subtest: bcs0
[689.950489] Dynamic subtest bcs0: SKIP (0.000s)
[689.961749] Starting dynamic subtest: vcs0
[689.966163] Dynamic subtest vcs0: SKIP (0.000s)
[689.981507] Starting dynamic subtest: vcs1
[689.985801] Dynamic subtest vcs1: SKIP (0.000s)
[689.996778] Starting dynamic subtest: vecs0
[690.001052] Dynamic subtest vecs0: SKIP (0.000s)
[690.011926] Starting dynamic subtest: ccs0
[690.016327] Dynamic subtest ccs0: SKIP (0.000s)
[690.020799] Subtest most-busy-check-all: SKIP (0.010s)
[690.061908] [111/132] (339s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[690.178503] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[696.978751] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.804s)
[697.116647] [112/132] (332s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[697.212388] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[697.216770] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[697.310971] [113/132] (332s left) perf (polling-small-buf)
[697.400901] Starting subtest: polling-small-buf
[697.491863] Subtest polling-small-buf: SUCCESS (0.089s)
[697.544532] [114/132] (332s left) kms_plane_multiple (tiling-x)
[697.629082] Starting subtest: tiling-x
[697.630964] Starting dynamic subtest: pipe-A-eDP-1
[701.344035] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.716s)
[701.355656] Starting dynamic subtest: pipe-B-eDP-1
[705.782346] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.437s)
[705.794542] Starting dynamic subtest: pipe-C-eDP-1
[710.106415] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.324s)
[710.117648] Starting dynamic subtest: pipe-D-eDP-1
[714.440972] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.336s)
[714.443471] Subtest tiling-x: SUCCESS (16.817s)
[715.267371] [115/132] (314s left) gen9_exec_parse (bb-start-cmd)
[715.324539] Subtest bb-start-cmd: SKIP (0.000s)
[715.392419] [116/132] (314s left) kms_cursor_crc (cursor-offscreen-512x512)
[715.686342] Starting subtest: cursor-offscreen-512x512
[715.691090] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[715.854489] [117/132] (313s left) gem_ctx_shared (create-shared-gtt)
[715.918600] Starting subtest: create-shared-gtt
[718.072166] Subtest create-shared-gtt: SUCCESS (2.154s)
[718.443506] [118/132] (311s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[718.536749] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[718.549073] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[718.628219] [119/132] (311s left) kms_dp_linktrain_fallback (dsc-fallback)
[718.719144] Starting subtest: dsc-fallback
[718.725479] Subtest dsc-fallback: SKIP (0.000s)
[718.793466] [120/132] (311s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[718.888800] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[718.890935] Starting dynamic subtest: pipe-A-eDP-1
[718.912927] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[718.925686] Starting dynamic subtest: pipe-B-eDP-1
[718.946895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[718.959905] Starting dynamic subtest: pipe-C-eDP-1
[718.981233] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[718.992399] Starting dynamic subtest: pipe-D-eDP-1
[719.013403] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[719.017304] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[721.208818] [121/132] (308s left) syncobj_wait (single-wait-all-submitted)
[721.258910] Starting subtest: single-wait-all-submitted
[721.366043] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[721.455822] [122/132] (308s left) kms_atomic (atomic-invalid-params)
[721.546777] Starting subtest: atomic-invalid-params
[721.549015] Starting dynamic subtest: pipe-A-eDP-1
[721.943782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[721.946068] Subtest atomic-invalid-params: SUCCESS (0.398s)
[722.735004] [123/132] (307s left) perf_pmu (all-busy-check-all)
[722.776782] Starting subtest: all-busy-check-all
[723.987480] Subtest all-busy-check-all: SUCCESS (1.210s)
[724.079550] [124/132] (305s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[724.174517] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[724.178767] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[724.281973] [125/132] (305s left) kms_lease (lease-invalid-connector)
[724.386446] Starting subtest: lease-invalid-connector
[724.389097] Starting dynamic subtest: pipe-A-eDP-1
[724.391428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[724.403838] Starting dynamic subtest: pipe-B-eDP-1
[724.405747] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[724.417098] Starting dynamic subtest: pipe-C-eDP-1
[724.419242] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[724.430784] Starting dynamic subtest: pipe-D-eDP-1
[724.432894] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[724.434992] Subtest lease-invalid-connector: SUCCESS (0.004s)
[724.480870] [126/132] (305s left) gem_madvise (dontneed-after-mmap)
[724.518244] Starting subtest: dontneed-after-mmap
[724.534360] Subtest dontneed-after-mmap: SUCCESS (0.019s)
[724.652882] [127/132] (305s left) kms_flip (flip-vs-suspend-interruptible)
[724.743497] Starting subtest: flip-vs-suspend-interruptible
[724.745810] Starting dynamic subtest: A-eDP1
[869.985620] Dynamic subtest A-eDP1: SUCCESS (11.249s)
[869.988098] Subtest flip-vs-suspend-interruptible: SUCCESS (11.253s)
[870.133784] [128/132] (160s left) kms_vblank (wait-forked-busy)
[870.232255] Starting subtest: wait-forked-busy
[870.234160] Starting dynamic subtest: pipe-A-eDP-1
[872.115816] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[872.134650] Starting dynamic subtest: pipe-D-eDP-1
[874.716736] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[874.719102] Subtest wait-forked-busy: SUCCESS (4.468s)
[875.521684] [129/132] (154s left) kms_big_fb (linear-32bpp-rotate-180)
[875.631073] Starting subtest: linear-32bpp-rotate-180
[877.158807] Subtest linear-32bpp-rotate-180: SUCCESS (1.523s)
[877.295476] [130/132] (152s left) gen3_render_tiledx_blits
[877.418261] [131/132] (152s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[877.514755] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[884.620172] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.095s)
[884.737443] [132/132] (145s left) kms_plane_scaling (planes-scaler-unity-scaling)
[884.828663] Starting subtest: planes-scaler-unity-scaling
[884.831565] Starting dynamic subtest: pipe-A
[884.890011] Dynamic subtest pipe-A: SUCCESS (0.064s)
[884.903214] Starting dynamic subtest: pipe-B
[886.060300] Dynamic subtest pipe-B: SUCCESS (1.168s)
[886.074189] Starting dynamic subtest: pipe-C
[887.174611] Dynamic subtest pipe-C: SUCCESS (1.111s)
[887.187735] Starting dynamic subtest: pipe-D
[888.301850] Dynamic subtest pipe-D: SUCCESS (1.126s)
[888.304163] Subtest planes-scaler-unity-scaling: SUCCESS (3.474s)
[889.474590] Closing watchdogs
results: parsing output: 0/ for test: gem_busy
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_fenced_exec_thrash
results: parsing output: 5/ for test: gem_tiled_fence_blits
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_pm_backlight
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_dsc
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: kms_joiner
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: i915_pm_rps
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_ctx_shared
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: gem_readwrite
results: parsing output: 41/ for test: gem_mmap_wc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: kms_prime
results: parsing output: 53/ for test: kms_busy
results: parsing output: 54/ for test: kms_hdr
results: parsing output: 55/ for test: kms_content_protection
results: parsing output: 56/ for test: gem_flink_basic
results: parsing output: 57/ for test: gem_tiled_swapping
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: i915_pm_freq_api
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_pipe_crc_basic
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_partial_pwrite_pread
results: parsing output: 80/ for test: sysfs_heartbeat_interval
results: parsing output: 81/ for test: gem_ctx_exec
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: gem_readwrite
results: parsing output: 94/ for test: kms_chamelium_color
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_chamelium_frames
results: parsing output: 98/ for test: kms_sequence
results: parsing output: 99/ for test: gem_lmem_swapping
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: i915_suspend
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: drm_read
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_plane_multiple
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: gem_ctx_shared
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_dp_linktrain_fallback
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_atomic
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: gem_madvise
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gen3_render_tiledx_blits
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_plane_scaling
Done.