[58.649211] Initializing watchdogs
[58.649255]   /dev/watchdog0
[58.663480] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.667540] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.669539] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.673405] [001/133] (960s left) syncobj_wait (multi-wait-for-submit-signaled)
[58.750037] Starting subtest: multi-wait-for-submit-signaled
[58.752418] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[58.844418] [002/133] (960s left) kms_lease (lessee-list)
[58.920062] Starting subtest: lessee-list
[58.922512] Starting dynamic subtest: pipe-A-eDP-1
[58.924783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[58.931957] Starting dynamic subtest: pipe-B-eDP-1
[58.934179] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[58.941113] Starting dynamic subtest: pipe-C-eDP-1
[58.943259] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[58.949992] Starting dynamic subtest: pipe-D-eDP-1
[58.952224] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[58.954375] Subtest lessee-list: SUCCESS (0.008s)
[59.053441] [003/133] (960s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[59.146094] Starting subtest: cursorB-vs-flipA-toggle
[59.150712] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[59.288052] [004/133] (959s left) kms_async_flips (test-cursor-atomic)
[59.369494] Starting subtest: test-cursor-atomic
[59.750523] Starting dynamic subtest: pipe-A-eDP-1
[60.499545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[60.880832] Starting dynamic subtest: pipe-B-eDP-1
[61.626647] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.751s)
[62.015230] Starting dynamic subtest: pipe-C-eDP-1
[62.754446] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.747s)
[63.126502] Starting dynamic subtest: pipe-D-eDP-1
[63.889372] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[63.891836] Subtest test-cursor-atomic: SUCCESS (4.511s)
[65.059671] [005/133] (954s left) kms_psr (fbc-pr-primary-page-flip)
[65.138606] Starting subtest: fbc-pr-primary-page-flip
[65.142838] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[65.211275] [006/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[65.289626] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[65.293951] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[65.396927] [007/133] (953s left) gem_ctx_engines (none)
[65.465015] Starting subtest: none
[65.467088] Subtest none: SUCCESS (0.002s)
[65.660584] [008/133] (953s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[67.179716] Starting subtest: modeset-non-lpsp-stress-no-wait
[67.230652] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.052s)
[67.898034] [009/133] (951s left) kms_vblank (ts-continuation-idle)
[68.099684] Starting subtest: ts-continuation-idle
[68.102104] Starting dynamic subtest: pipe-A-eDP-1
[68.500280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[68.513781] Starting dynamic subtest: pipe-D-eDP-1
[69.602566] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.098s)
[69.604485] Subtest ts-continuation-idle: SUCCESS (1.501s)
[70.469177] [010/133] (949s left) kms_psr (fbc-psr2-suspend)
[70.543395] Starting subtest: fbc-psr2-suspend
[70.545892] Starting dynamic subtest: eDP-1
[70.550523] Dynamic subtest eDP-1: SKIP (0.000s)
[70.555167] Subtest fbc-psr2-suspend: SKIP (0.000s)
[70.642106] [011/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[70.716543] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[70.720769] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[70.807120] [012/133] (948s left) kms_dirtyfb (default-dirtyfb-ioctl)
[70.882933] Starting subtest: default-dirtyfb-ioctl
[70.885342] Starting dynamic subtest: A-eDP-1
[72.471751] Dynamic subtest A-eDP-1: SUCCESS (1.587s)
[72.474182] Subtest default-dirtyfb-ioctl: SUCCESS (1.588s)
[73.329624] [013/133] (946s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[73.418247] Starting subtest: plane-all-transition-nonblocking-fencing
[73.420736] Starting dynamic subtest: pipe-A-eDP-1
[75.914796] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[76.238622] Starting dynamic subtest: pipe-B-eDP-1
[79.447552] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.217s)
[79.752370] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.331s)
[80.577605] [014/133] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[80.659335] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[80.663443] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[80.760951] [015/133] (938s left) syncobj_basic (bad-destroy-pad)
[80.820060] Starting subtest: bad-destroy-pad
[80.822469] Subtest bad-destroy-pad: SUCCESS (0.000s)
[80.912938] [016/133] (938s left) gem_exec_schedule (semaphore-codependency)
[80.985790] Starting subtest: semaphore-codependency
[80.994751] Subtest semaphore-codependency: SUCCESS (0.015s)
[81.326587] [017/133] (938s left) kms_chamelium_audio (dp-audio)
[81.693447] Subtest dp-audio: SKIP (0.000s)
[82.469308] [018/133] (937s left) gem_ctx_shared (exec-shared-gtt)
[82.536795] Starting subtest: exec-shared-gtt
[82.539339] Starting dynamic subtest: rcs0
[82.550495] Dynamic subtest rcs0: SUCCESS (0.013s)
[82.561581] Starting dynamic subtest: bcs0
[82.563599] Dynamic subtest bcs0: SUCCESS (0.007s)
[82.571369] Starting dynamic subtest: vcs0
[82.573709] Dynamic subtest vcs0: SUCCESS (0.008s)
[82.581951] Starting dynamic subtest: vcs1
[82.584338] Dynamic subtest vcs1: SUCCESS (0.006s)
[82.591694] Starting dynamic subtest: vecs0
[82.594059] Dynamic subtest vecs0: SUCCESS (0.006s)
[82.601080] Starting dynamic subtest: ccs0
[82.603272] Dynamic subtest ccs0: SUCCESS (0.005s)
[82.605439] Subtest exec-shared-gtt: SUCCESS (0.047s)
[82.768681] [019/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[82.849146] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[82.853297] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[82.986384] [020/133] (936s left) gem_exec_schedule (independent)
[83.059754] Starting subtest: independent
[83.062022] Starting dynamic subtest: rcs0
[84.824894] Dynamic subtest rcs0: SUCCESS (1.774s)
[84.835858] Starting dynamic subtest: vcs0
[86.880549] Dynamic subtest vcs0: SUCCESS (2.053s)
[86.891037] Starting dynamic subtest: vcs1
[88.873209] Dynamic subtest vcs1: SUCCESS (1.991s)
[88.883436] Starting dynamic subtest: vecs0
[90.851173] Dynamic subtest vecs0: SUCCESS (1.976s)
[90.859599] Starting dynamic subtest: ccs0
[92.824794] Dynamic subtest ccs0: SUCCESS (1.971s)
[92.827688] Subtest independent: SUCCESS (9.774s)
[93.121563] [021/133] (926s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[93.210265] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[93.212556] Starting dynamic subtest: pipe-A-default-mode
[94.355760] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[94.360465] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.144s)
[94.518612] [022/133] (925s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[94.612576] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[95.236657] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[95.405926] [023/133] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[95.479169] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[95.483830] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[95.590823] [024/133] (924s left) kms_chamelium_frames (dp-crc-multiple)
[95.966289] Subtest dp-crc-multiple: SKIP (0.000s)
[96.729971] [025/133] (923s left) kms_cursor_crc (cursor-offscreen-64x21)
[96.897668] Starting subtest: cursor-offscreen-64x21
[96.945459] Subtest cursor-offscreen-64x21: SKIP (0.045s)
[97.171957] [026/133] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[97.244852] Starting subtest: addfb25-yf-tiled-legacy
[97.246674] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[97.346874] [027/133] (922s left) kms_pm_dc (dc5-retention-flops)
[98.427316] Starting subtest: dc5-retention-flops
[98.431785] Subtest dc5-retention-flops: SKIP (0.000s)
[98.499480] [028/133] (921s left) gem_eio (wait-immediate)
[98.722494] Starting subtest: wait-immediate
[99.088158] Subtest wait-immediate: SUCCESS (0.366s)
[99.212030] [029/133] (921s left) kms_atomic_interruptible (legacy-dpms)
[99.297888] Starting subtest: legacy-dpms
[99.300117] Starting dynamic subtest: pipe-A-eDP-1
[106.694585] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.395s)
[106.696954] Subtest legacy-dpms: SUCCESS (7.396s)
[107.511537] [030/133] (912s left) kms_big_fb (linear-16bpp-rotate-270)
[107.605192] Starting subtest: linear-16bpp-rotate-270
[107.623421] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[107.722911] [031/133] (912s left) i915_drm_fdinfo (virtual-busy-all)
[107.760709] Starting subtest: virtual-busy-all
[107.765315] Subtest virtual-busy-all: SKIP (0.000s)
[107.822963] [032/133] (912s left) sriov_basic (enable-vfs-autoprobe-off)
[107.873481] Starting subtest: enable-vfs-autoprobe-off
[107.875661] Starting dynamic subtest: numvfs-1
[107.947821] Dynamic subtest numvfs-1: FAIL (0.016s)
[107.957558] Starting dynamic subtest: numvfs-2
[108.029403] Dynamic subtest numvfs-2: FAIL (0.004s)
[108.039161] Starting dynamic subtest: numvfs-3
[108.111740] Dynamic subtest numvfs-3: FAIL (0.003s)
[108.120499] Starting dynamic subtest: numvfs-4
[108.192885] Dynamic subtest numvfs-4: FAIL (0.004s)
[108.202562] Starting dynamic subtest: numvfs-5
[108.274680] Dynamic subtest numvfs-5: FAIL (0.004s)
[108.284083] Starting dynamic subtest: numvfs-6
[108.356444] Dynamic subtest numvfs-6: FAIL (0.004s)
[108.365413] Starting dynamic subtest: numvfs-7
[108.438387] Dynamic subtest numvfs-7: FAIL (0.004s)
[108.447937] Starting dynamic subtest: numvfs-random
[108.506909] Dynamic subtest numvfs-random: FAIL (0.004s)
[108.515693] Starting dynamic subtest: numvfs-all
[108.574378] Dynamic subtest numvfs-all: FAIL (0.502s)
[108.576279] Subtest enable-vfs-autoprobe-off: FAIL (0.549s)
[108.609924] [033/133] (911s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[108.666373] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[108.773065] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[108.844402] [034/133] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[108.928284] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[115.856251] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.930s)
[115.980780] [035/133] (904s left) gem_vm_create (invalid-destroy)
[116.046859] Starting subtest: invalid-destroy
[116.049339] Subtest invalid-destroy: SUCCESS (0.002s)
[116.145994] [036/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[116.238162] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[122.755163] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.519s)
[122.901066] [037/133] (897s left) kms_flip (plain-flip-interruptible)
[122.975803] Starting subtest: plain-flip-interruptible
[122.978082] Starting dynamic subtest: A-eDP1
[124.631355] Dynamic subtest A-eDP1: SUCCESS (1.654s)
[124.641777] Starting dynamic subtest: B-eDP1
[126.270730] Dynamic subtest B-eDP1: SUCCESS (1.637s)
[126.281053] Starting dynamic subtest: C-eDP1
[127.893771] Dynamic subtest C-eDP1: SUCCESS (1.619s)
[127.907731] Starting dynamic subtest: D-eDP1
[129.532656] Dynamic subtest D-eDP1: SUCCESS (1.638s)
[129.537808] Subtest plain-flip-interruptible: SUCCESS (6.561s)
[130.718545] [038/133] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[130.810390] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[130.814736] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[130.917813] [039/133] (889s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[130.996502] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[134.715551] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.722s)
[135.924336] [040/133] (884s left) kms_psr (pr-primary-mmap-cpu)
[135.990860] Starting subtest: pr-primary-mmap-cpu
[135.995507] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[136.091407] [041/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[136.188453] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[143.698212] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.511s)
[143.798932] [042/133] (877s left) api_intel_allocator (standalone)
[143.857133] Starting subtest: standalone
[143.871115] Subtest standalone: SUCCESS (0.016s)
[143.993355] [043/133] (876s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[144.057509] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[144.059894] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[144.172387] [044/133] (876s left) kms_psr (fbc-pr-cursor-plane-onoff)
[144.261510] Starting subtest: fbc-pr-cursor-plane-onoff
[144.265884] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[144.329579] [045/133] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[144.407231] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[144.411399] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[144.491131] [046/133] (876s left) gem_exec_reloc (basic-write-cpu)
[144.545938] Subtest basic-write-cpu: SKIP (0.000s)
[144.616837] [047/133] (876s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[144.692789] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[144.696325] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[144.792706] [048/133] (876s left) i915_pm_rpm (gem-pread)
[146.995885] Starting subtest: gem-pread
[148.690636] Subtest gem-pread: SUCCESS (1.698s)
[148.775227] [049/133] (872s left) kms_chamelium_hpd (common-hpd-after-suspend)
[149.145675] Subtest common-hpd-after-suspend: SKIP (0.000s)
[149.949769] [050/133] (871s left) gem_exec_fence (long-history)
[150.402965] Starting subtest: long-history
[157.576462] Subtest long-history: SUCCESS (7.173s)
[158.031561] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[158.035260] [051/133] (863s left) kms_prop_blob (invalid-get-prop)
[158.080915] Starting subtest: invalid-get-prop
[158.083258] Subtest invalid-get-prop: SUCCESS (0.000s)
[158.181665] [052/133] (863s left) i915_hangman (gt-engine-error)
[158.241102] Starting subtest: gt-engine-error
[158.243130] Starting dynamic subtest: rcs0
[159.799442] Dynamic subtest rcs0: SUCCESS (1.557s)
[159.810839] Starting dynamic subtest: bcs0
[161.783057] Dynamic subtest bcs0: SUCCESS (1.981s)
[161.795020] Starting dynamic subtest: vcs0
[163.830417] Dynamic subtest vcs0: SUCCESS (2.045s)
[163.841923] Starting dynamic subtest: vcs1
[165.814671] Dynamic subtest vcs1: SUCCESS (1.981s)
[165.826575] Starting dynamic subtest: vecs0
[167.798490] Dynamic subtest vecs0: SUCCESS (1.981s)
[167.810246] Starting dynamic subtest: ccs0
[169.782427] Dynamic subtest ccs0: SUCCESS (1.982s)
[169.785751] Subtest gt-engine-error: SUCCESS (11.542s)
[169.881299] [053/133] (851s left) gem_exec_fence (basic-await)
[170.062764] Starting subtest: basic-await
[170.065669] Starting dynamic subtest: rcs0
[170.143292] Dynamic subtest rcs0: SUCCESS (0.080s)
[170.158600] Starting dynamic subtest: bcs0
[170.217373] Dynamic subtest bcs0: SUCCESS (0.073s)
[170.228775] Starting dynamic subtest: vcs0
[170.294856] Dynamic subtest vcs0: SUCCESS (0.074s)
[170.306233] Starting dynamic subtest: vcs1
[170.370036] Dynamic subtest vcs1: SUCCESS (0.073s)
[170.381891] Starting dynamic subtest: vecs0
[170.443681] Dynamic subtest vecs0: SUCCESS (0.072s)
[170.454768] Starting dynamic subtest: ccs0
[170.516302] Dynamic subtest ccs0: SUCCESS (0.071s)
[170.519031] Subtest basic-await: SUCCESS (0.455s)
[171.963294] [054/133] (849s left) syncobj_timeline (wait-for-submit-delayed-submit)
[172.019125] Starting subtest: wait-for-submit-delayed-submit
[172.120578] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[172.205405] [055/133] (849s left) gem_userptr_blits (sync-overlap)
[172.267194] Starting subtest: sync-overlap
[172.269410] Subtest sync-overlap: SUCCESS (0.000s)
[172.387590] [056/133] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[172.474101] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[179.747069] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.275s)
[179.884480] [057/133] (841s left) gem_mmap_gtt (fault-concurrent-y)
[179.935945] Subtest fault-concurrent-Y: SKIP (0.000s)
[179.992655] [058/133] (841s left) prime_vgem (basic-fence-mmap)
[180.055998] Starting subtest: basic-fence-mmap
[180.060477] Subtest basic-fence-mmap: SKIP (0.000s)
[180.151185] [059/133] (841s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[180.226762] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[180.229059] Starting dynamic subtest: pipe-A-eDP-1
[180.249468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[180.260148] Starting dynamic subtest: pipe-B-eDP-1
[180.279811] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[180.290726] Starting dynamic subtest: pipe-C-eDP-1
[180.310380] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[180.318192] Starting dynamic subtest: pipe-D-eDP-1
[180.337675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[180.340170] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[182.466773] [060/133] (839s left) kms_psr (psr-basic)
[182.551035] Starting subtest: psr-basic
[182.553501] Starting dynamic subtest: eDP-1
[184.170959] Dynamic subtest eDP-1: SUCCESS (1.621s)
[184.173172] Subtest psr-basic: SUCCESS (1.622s)
[185.036480] [061/133] (836s left) kms_color (gamma)
[185.109406] Starting subtest: gamma
[185.111649] Starting dynamic subtest: pipe-A-eDP-1
[185.838406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[185.847229] Starting dynamic subtest: pipe-B-eDP-1
[187.234615] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[187.243548] Starting dynamic subtest: pipe-C-eDP-1
[188.631660] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[188.641111] Starting dynamic subtest: pipe-D-eDP-1
[189.958510] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[189.960726] Subtest gamma: SUCCESS (4.851s)
[190.792911] [062/133] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[190.869971] Starting subtest: compare-crc-sanitycheck-xr24
[190.872332] Starting dynamic subtest: pipe-A-eDP-1
[191.482268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s)
[191.490820] Starting dynamic subtest: pipe-B-eDP-1
[192.731084] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s)
[192.740536] Starting dynamic subtest: pipe-C-eDP-1
[193.921807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[193.931210] Starting dynamic subtest: pipe-D-eDP-1
[195.156965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[195.159429] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.291s)
[195.991968] [063/133] (825s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[196.075427] Starting subtest: y-tiled-64bpp-rotate-0
[196.079799] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[196.169760] [064/133] (825s left) perf_pmu (busy)
[196.214069] Starting subtest: busy
[196.216629] Starting dynamic subtest: rcs0
[196.814513] Dynamic subtest rcs0: SUCCESS (0.599s)
[196.826191] Starting dynamic subtest: bcs0
[197.381880] Dynamic subtest bcs0: SUCCESS (0.565s)
[197.393838] Starting dynamic subtest: vcs0
[198.873570] Dynamic subtest vcs0: SUCCESS (1.488s)
[198.885540] Starting dynamic subtest: vcs1
[200.856673] Dynamic subtest vcs1: SUCCESS (1.981s)
[200.869201] Starting dynamic subtest: vecs0
[202.841715] Dynamic subtest vecs0: SUCCESS (1.982s)
[202.853633] Starting dynamic subtest: ccs0
[203.404491] Dynamic subtest ccs0: SUCCESS (0.561s)
[203.407562] Subtest busy: SUCCESS (7.191s)
[203.525620] [065/133] (818s left) gem_workarounds (suspend-resume-context)
[203.597149] Starting subtest: suspend-resume-context
[220.051772] Subtest suspend-resume-context: SUCCESS (2.069s)
[220.211289] [066/133] (801s left) kms_plane_multiple (tiling-yf)
[220.291800] Starting subtest: tiling-yf
[220.296060] Subtest tiling-yf: SKIP (0.000s)
[220.369304] [067/133] (801s left) kms_flip (basic-flip-vs-dpms)
[220.451777] Starting subtest: basic-flip-vs-dpms
[220.453654] Starting dynamic subtest: A-eDP1
[223.085672] Dynamic subtest A-eDP1: SUCCESS (2.590s)
[223.097800] Starting dynamic subtest: B-eDP1
[225.274693] Dynamic subtest B-eDP1: SUCCESS (2.157s)
[225.284622] Starting dynamic subtest: C-eDP1
[227.361648] Dynamic subtest C-eDP1: SUCCESS (2.066s)
[227.373794] Starting dynamic subtest: D-eDP1
[229.445604] Dynamic subtest D-eDP1: SUCCESS (2.066s)
[229.448065] Subtest basic-flip-vs-dpms: SUCCESS (8.889s)
[230.243275] [068/133] (791s left) gem_ctx_create (basic)
[230.313351] Starting subtest: basic
[230.315332] Subtest basic: SUCCESS (0.000s)
[230.498181] [069/133] (791s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[230.553763] Starting subtest: multi-wait-all-for-submit-available-submitted
[230.556182] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[230.648504] [070/133] (791s left) gem_lmem_swapping (heavy-verify-multi)
[230.694712] Subtest heavy-verify-multi: SKIP (0.000s)
[230.738959] [071/133] (791s left) api_intel_bb (object-reloc-purge-cache)
[230.797058] Starting subtest: object-reloc-purge-cache
[230.801080] Subtest object-reloc-purge-cache: SKIP (0.003s)
[230.935153] [072/133] (791s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[230.993207] Starting subtest: multi-wait-for-submit-submitted-signaled
[230.995534] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[231.098381] [073/133] (791s left) gem_exec_params (rel-constants-invalid-ring)
[231.155196] Starting subtest: rel-constants-invalid-ring
[231.157470] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[231.265703] [074/133] (790s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[231.353099] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[231.357111] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[231.454327] [075/133] (790s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[231.505622] Starting subtest: yf-tiled-to-vebox-x-tiled
[231.509352] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[231.692215] [076/133] (790s left) i915_pm_rps (waitboost)
[231.741240] Starting subtest: waitboost
[238.108132] Subtest waitboost: SUCCESS (6.343s)
[238.188934] [077/133] (784s left) kms_joiner (invalid-modeset-force-big-joiner)
[238.281433] Starting subtest: invalid-modeset-force-big-joiner
[238.285562] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[238.347809] [078/133] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[238.436395] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[238.440372] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[238.538160] [079/133] (783s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[238.610090] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[238.638068] Starting dynamic subtest: pipe-A-plane-0
[239.060417] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[239.072263] Starting dynamic subtest: pipe-A-plane-3
[239.316376] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[239.327474] Starting dynamic subtest: pipe-A-plane-5
[239.331068] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[240.462335] Starting dynamic subtest: pipe-B-plane-0
[240.922071] Dynamic subtest pipe-B-plane-0: SUCCESS (0.466s)
[240.933741] Starting dynamic subtest: pipe-B-plane-3
[241.178093] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[241.187423] Starting dynamic subtest: pipe-B-plane-5
[241.191448] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[241.499707] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.883s)
[242.342427] [080/133] (780s left) perf (short-reads)
[242.458683] Starting subtest: short-reads
[242.472701] Subtest short-reads: SUCCESS (0.016s)
[242.515220] [081/133] (779s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[242.582067] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[242.584171] Starting dynamic subtest: pipe-A
[242.604069] Dynamic subtest pipe-A: SKIP (0.018s)
[242.613921] Starting dynamic subtest: pipe-B
[242.641429] Dynamic subtest pipe-B: SKIP (0.035s)
[242.651058] Starting dynamic subtest: pipe-C
[242.670906] Dynamic subtest pipe-C: SKIP (0.029s)
[242.680331] Starting dynamic subtest: pipe-D
[242.702770] Dynamic subtest pipe-D: SKIP (0.030s)
[242.707060] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.115s)
[242.792445] [082/133] (779s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[242.875559] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[243.834860] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.957s)
[243.949281] [083/133] (778s left) kms_cursor_crc (cursor-random-512x512)
[244.201601] Starting subtest: cursor-random-512x512
[244.205407] Subtest cursor-random-512x512: SKIP (0.001s)
[244.392399] [084/133] (778s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[244.491047] Starting subtest: short-flip-before-cursor-toggle
[245.413313] Subtest short-flip-before-cursor-toggle: SUCCESS (0.918s)
[246.272531] [085/133] (776s left) gem_exec_params (sol-reset-not-gen7)
[246.336661] Starting subtest: sol-reset-not-gen7
[246.341902] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[246.448861] [086/133] (776s left) kms_addfb_basic (bad-pitch-1024)
[246.511413] Starting subtest: bad-pitch-1024
[246.513675] Subtest bad-pitch-1024: SUCCESS (0.000s)
[246.644148] [087/133] (776s left) gem_exec_params (no-vebox)
[246.700300] Starting subtest: no-vebox
[246.705811] Subtest no-vebox: SUCCESS (0.003s)
[248.252434] [088/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[248.326579] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[248.330611] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[248.408219] [089/133] (774s left) kms_rotation_crc (primary-rotation-270)
[248.474058] Starting subtest: primary-rotation-270
[248.478410] Subtest primary-rotation-270: SKIP (0.001s)
[248.549093] [090/133] (774s left) gem_barrier_race (remote-request)
[248.617657] Starting subtest: remote-request
[248.619927] Starting dynamic subtest: rcs0
[253.790003] Dynamic subtest rcs0: SUCCESS (5.171s)
[253.791868] Subtest remote-request: SUCCESS (5.172s)
[253.941529] [091/133] (768s left) syncobj_basic (bad-flags-handle-to-fd)
[253.989359] Starting subtest: bad-flags-handle-to-fd
[253.991299] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[254.086913] [092/133] (768s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[254.166427] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[254.168391] Starting dynamic subtest: pipe-A
[254.517567] Dynamic subtest pipe-A: SUCCESS (0.353s)
[254.527110] Starting dynamic subtest: pipe-B
[255.959247] Dynamic subtest pipe-B: SUCCESS (1.441s)
[255.968660] Starting dynamic subtest: pipe-C
[257.402388] Dynamic subtest pipe-C: SUCCESS (1.442s)
[257.411772] Starting dynamic subtest: pipe-D
[258.823085] Dynamic subtest pipe-D: SUCCESS (1.420s)
[258.825402] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.659s)
[259.995119] [093/133] (762s left) gen9_exec_parse (batch-zero-length)
[260.048460] Subtest batch-zero-length: SKIP (0.000s)
[260.109350] [094/133] (762s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[260.155046] Starting subtest: multi-wait-for-submit-submitted-signaled
[260.157269] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[260.255390] [095/133] (762s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[260.331737] Starting subtest: pr-cursor-plane-move-continuous-sf
[260.336138] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[260.397921] [096/133] (762s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[260.473167] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[260.477702] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[260.565415] [097/133] (762s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[260.654908] Starting subtest: cursor-tearing-framebuffer-change
[260.657113] Starting dynamic subtest: pipe-A-eDP-1
[261.225647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[261.235663] Starting dynamic subtest: pipe-D-eDP-1
[262.428643] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[262.430942] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.773s)
[263.276360] [098/133] (759s left) gem_ctx_persistence (legacy-engines-hang)
[263.324091] Starting subtest: legacy-engines-hang
[263.326509] Starting dynamic subtest: render
[263.390691] Dynamic subtest render: SUCCESS (0.066s)
[263.402622] Starting dynamic subtest: bsd1
[263.490974] Dynamic subtest bsd1: SUCCESS (0.097s)
[263.503153] Starting dynamic subtest: bsd2
[263.588707] Dynamic subtest bsd2: SUCCESS (0.094s)
[263.599691] Starting dynamic subtest: blt
[263.675018] Dynamic subtest blt: SUCCESS (0.085s)
[263.693597] Starting dynamic subtest: vebox
[263.770939] Dynamic subtest vebox: SUCCESS (0.093s)
[263.773681] Subtest legacy-engines-hang: SUCCESS (0.449s)
[263.855342] [099/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[263.929632] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[263.934117] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[264.024956] [100/133] (759s left) gem_mmap_gtt (cpuset-big-copy)
[264.084953] Subtest cpuset-big-copy: SKIP (0.000s)
[264.142868] [101/133] (759s left) kms_psr (psr-sprite-mmap-gtt)
[264.212090] Starting subtest: psr-sprite-mmap-gtt
[264.213950] Starting dynamic subtest: eDP-1
[265.690766] Dynamic subtest eDP-1: SKIP (1.472s)
[265.695848] Subtest psr-sprite-mmap-gtt: SKIP (1.476s)
[265.860755] [102/133] (757s left) gem_exec_fence (syncobj-timeline-wait)
[266.390034] Starting subtest: syncobj-timeline-wait
[268.240082] Subtest syncobj-timeline-wait: SUCCESS (1.850s)
[270.270714] [103/133] (753s left) syncobj_timeline (signal-point-0)
[270.314021] Starting subtest: signal-point-0
[270.316318] Subtest signal-point-0: SUCCESS (0.000s)
[270.404093] [104/133] (753s left) gem_tiled_partial_pwrite_pread (reads)
[270.454997] Subtest reads: SKIP (0.000s)
[270.530779] [105/133] (752s left) gem_render_copy (yf-tiled-ccs-to-linear)
[270.579060] Starting subtest: yf-tiled-ccs-to-linear
[270.583433] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[270.762431] [106/133] (752s left) gem_readwrite (read-write)
[270.812325] Subtest read-write: SKIP (0.000s)
[270.867912] [107/133] (752s left) gem_mmap_wc (bad-object)
[270.914717] Subtest bad-object: SKIP (0.000s)
[270.973080] [108/133] (752s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[271.055330] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[271.059232] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[271.149555] [109/133] (752s left) gem_exec_balancer (parallel-bb-first)
[271.398871] Starting subtest: parallel-bb-first
[272.321046] Subtest parallel-bb-first: SUCCESS (0.922s)
[273.284271] [110/133] (750s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[273.353775] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[273.358372] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[273.449252] [111/133] (750s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[273.512589] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[273.514943] Starting dynamic subtest: pipe-A-eDP-1
[275.590858] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.079s)
[275.600820] Starting dynamic subtest: pipe-B-eDP-1
[277.768157] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.176s)
[277.777110] Starting dynamic subtest: pipe-C-eDP-1
[279.849840] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.079s)
[279.860041] Starting dynamic subtest: pipe-D-eDP-1
[281.903960] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.050s)
[281.906188] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.390s)
[283.109805] [112/133] (740s left) kms_flip (nonexisting-fb-interruptible)
[283.199795] Starting subtest: nonexisting-fb-interruptible
[283.202255] Starting dynamic subtest: A-eDP1
[284.381679] Dynamic subtest A-eDP1: SUCCESS (1.181s)
[284.392547] Starting dynamic subtest: B-eDP1
[285.512435] Dynamic subtest B-eDP1: SUCCESS (1.129s)
[285.524910] Starting dynamic subtest: C-eDP1
[286.642746] Dynamic subtest C-eDP1: SUCCESS (1.127s)
[286.653688] Starting dynamic subtest: D-eDP1
[287.771253] Dynamic subtest D-eDP1: SUCCESS (1.126s)
[287.773617] Subtest nonexisting-fb-interruptible: SUCCESS (4.573s)
[288.942535] [113/133] (734s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[289.036668] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[289.042719] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.008s)
[289.155055] [114/133] (734s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[289.223162] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[289.225517] Starting dynamic subtest: pipe-A-eDP-1
[289.727500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.475s)
[289.740657] Starting dynamic subtest: pipe-B-eDP-1
[291.177937] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[291.189093] Starting dynamic subtest: pipe-C-eDP-1
[292.556028] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[292.565947] Starting dynamic subtest: pipe-D-eDP-1
[293.926795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.373s)
[293.929077] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.676s)
[295.075400] [115/133] (728s left) perf_pmu (busy-idle-no-semaphores)
[295.123680] Starting subtest: busy-idle-no-semaphores
[295.125828] Starting dynamic subtest: rcs0
[295.791790] Dynamic subtest rcs0: SUCCESS (0.656s)
[295.804535] Starting dynamic subtest: bcs0
[296.431067] Dynamic subtest bcs0: SUCCESS (0.647s)
[296.444060] Starting dynamic subtest: vcs0
[297.082293] Dynamic subtest vcs0: SUCCESS (0.648s)
[297.094604] Starting dynamic subtest: vcs1
[298.867694] Dynamic subtest vcs1: SUCCESS (1.781s)
[298.880761] Starting dynamic subtest: vecs0
[300.851827] Dynamic subtest vecs0: SUCCESS (1.980s)
[300.864746] Starting dynamic subtest: ccs0
[302.836551] Dynamic subtest ccs0: SUCCESS (1.981s)
[302.839573] Subtest busy-idle-no-semaphores: SUCCESS (7.710s)
[302.956024] [116/133] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[303.048931] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[303.053425] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[303.135623] [117/133] (720s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[303.249899] Starting subtest: dp-mst-type-0-suspend-resume
[303.254543] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[303.359661] [118/133] (720s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[303.442419] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[310.214110] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.773s)
[310.357745] [119/133] (713s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[310.432601] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[310.434957] Starting dynamic subtest: A-eDP1
[319.375551] Dynamic subtest A-eDP1: SUCCESS (8.942s)
[319.384812] Starting dynamic subtest: B-eDP1
[328.302127] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[328.313727] Starting dynamic subtest: C-eDP1
[337.215023] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[337.228338] Starting dynamic subtest: D-eDP1
[346.146815] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[346.149250] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.721s)
[347.370480] [120/133] (676s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[347.447653] Starting subtest: primary-y-tiled-reflect-x-0
[347.506269] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[347.609376] [121/133] (676s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[347.695551] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[347.700038] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[347.793191] [122/133] (676s left) gem_ctx_isolation (preservation-s3)
[347.859940] Starting subtest: preservation-S3
[347.862360] Starting dynamic subtest: rcs0
[364.090739] Dynamic subtest rcs0: SUCCESS (1.302s)
[364.101242] Starting dynamic subtest: bcs0
[380.102183] Dynamic subtest bcs0: SUCCESS (1.351s)
[380.114620] Starting dynamic subtest: vcs0
[396.113173] Dynamic subtest vcs0: SUCCESS (2.744s)
[396.125759] Starting dynamic subtest: vcs1
[414.108653] Dynamic subtest vcs1: SUCCESS (4.949s)
[414.119626] Starting dynamic subtest: vecs0
[432.097042] Dynamic subtest vecs0: SUCCESS (4.954s)
[432.107360] Starting dynamic subtest: ccs0
[450.108344] Dynamic subtest ccs0: SUCCESS (3.093s)
[450.110938] Subtest preservation-S3: SUCCESS (18.398s)
[450.350295] [123/133] (573s left) gem_exec_store (cachelines)
[450.419859] Starting subtest: cachelines
[450.422236] Starting dynamic subtest: rcs0
[450.475712] Dynamic subtest rcs0: SUCCESS (0.057s)
[450.488704] Starting dynamic subtest: bcs0
[450.529383] Dynamic subtest bcs0: SUCCESS (0.051s)
[450.542012] Starting dynamic subtest: vcs0
[450.586744] Dynamic subtest vcs0: SUCCESS (0.055s)
[450.598776] Starting dynamic subtest: vcs1
[450.645926] Dynamic subtest vcs1: SUCCESS (0.056s)
[450.658555] Starting dynamic subtest: vecs0
[450.703975] Dynamic subtest vecs0: SUCCESS (0.055s)
[450.713816] Starting dynamic subtest: ccs0
[450.771306] Dynamic subtest ccs0: SUCCESS (0.064s)
[450.773836] Subtest cachelines: SUCCESS (0.349s)
[450.954618] [124/133] (573s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[451.028739] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[451.033426] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[452.200650] [125/133] (572s left) gem_exec_reloc (basic-wc-cpu-active)
[452.254506] Subtest basic-wc-cpu-active: SKIP (0.000s)
[452.326802] [126/133] (572s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[452.396802] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[452.399282] Starting dynamic subtest: pipe-A-default-mode
[453.580795] Dynamic subtest pipe-A-default-mode: SKIP (1.164s)
[453.585419] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.165s)
[453.740766] [127/133] (570s left) kms_universal_plane (universal-plane-functional)
[453.817125] Starting subtest: universal-plane-functional
[453.819460] Starting dynamic subtest: pipe-A-eDP-1
[457.742435] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.885s)
[457.752768] Starting dynamic subtest: pipe-B-eDP-1
[462.259717] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.488s)
[462.270787] Starting dynamic subtest: pipe-C-eDP-1
[466.648639] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.371s)
[466.659118] Starting dynamic subtest: pipe-D-eDP-1
[471.050011] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.391s)
[471.052271] Subtest universal-plane-functional: SUCCESS (17.141s)
[471.929184] [128/133] (552s left) device_reset (cold-reset-bound)
[471.982246] Starting subtest: cold-reset-bound
[471.986872] Subtest cold-reset-bound: SKIP (0.000s)
[472.058735] [129/133] (552s left) kms_fb_coherency (memset-crc)
[472.137565] Starting subtest: memset-crc
[472.140013] Starting dynamic subtest: mmap-offset-wc
[472.506437] Dynamic subtest mmap-offset-wc: SUCCESS (0.367s)
[472.808595] Starting dynamic subtest: mmap-offset-uc
[478.864339] Dynamic subtest mmap-offset-uc: SUCCESS (6.057s)
[479.153456] Subtest memset-crc: SUCCESS (7.007s)
[479.998674] [130/133] (544s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[480.088707] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[480.093162] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[480.180449] [131/133] (544s left) syncobj_eventfd (invalid-bad-pad)
[480.242341] Starting subtest: invalid-bad-pad
[480.244285] Subtest invalid-bad-pad: SUCCESS (0.000s)
[480.364506] [132/133] (544s left) gem_exec_nop (basic-parallel)
[480.440588] Starting subtest: basic-parallel
[496.809487] Subtest basic-parallel: SUCCESS (16.379s)
[497.035264] [133/133] (527s left) gem_softpin (reverse)
[497.100470] Starting subtest: reverse
[497.107526] Subtest reverse: SUCCESS (0.010s)
[497.238285] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_engines
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_dirtyfb
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_basic
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_chamelium_audio
results: parsing output: 17/ for test: gem_ctx_shared
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_pm_dc
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_atomic_interruptible
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: sriov_basic
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_vm_create
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_color
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: gem_workarounds
results: parsing output: 65/ for test: kms_plane_multiple
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_ctx_create
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: i915_pm_rps
results: parsing output: 76/ for test: kms_joiner
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: gem_barrier_race
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: gen9_exec_parse
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_readwrite
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: gem_exec_store
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_universal_plane
results: parsing output: 127/ for test: device_reset
results: parsing output: 128/ for test: kms_fb_coherency
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_eventfd
results: parsing output: 131/ for test: gem_exec_nop
results: parsing output: 132/ for test: gem_softpin
Done.