[62.047352] Initializing watchdogs
[62.047398]   /dev/watchdog0
[62.061061] [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]
[62.065371] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.067568] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.070988] [001/133] (960s left) syncobj_wait (multi-wait-for-submit-signaled)
[62.150944] Starting subtest: multi-wait-for-submit-signaled
[62.153344] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[62.262553] [002/133] (960s left) kms_lease (lessee-list)
[62.351558] Starting subtest: lessee-list
[62.353901] Starting dynamic subtest: pipe-A-eDP-1
[62.356332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[62.365164] Starting dynamic subtest: pipe-B-eDP-1
[62.367313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[62.374083] Starting dynamic subtest: pipe-C-eDP-1
[62.376223] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[62.382829] Starting dynamic subtest: pipe-D-eDP-1
[62.385108] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[62.387256] Subtest lessee-list: SUCCESS (0.007s)
[62.459636] [003/133] (960s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[62.589163] Starting subtest: cursorB-vs-flipA-toggle
[62.593801] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[62.733053] [004/133] (959s left) kms_async_flips (test-cursor-atomic)
[62.827888] Starting subtest: test-cursor-atomic
[63.200701] Starting dynamic subtest: pipe-A-eDP-1
[63.953501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[64.329641] Starting dynamic subtest: pipe-B-eDP-1
[65.079620] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[65.461334] Starting dynamic subtest: pipe-C-eDP-1
[66.206264] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.751s)
[66.569398] Starting dynamic subtest: pipe-D-eDP-1
[67.335384] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[67.337988] Subtest test-cursor-atomic: SUCCESS (4.512s)
[68.513701] [005/133] (954s left) kms_psr (fbc-pr-primary-page-flip)
[68.619027] Starting subtest: fbc-pr-primary-page-flip
[68.623565] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[68.688282] [006/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[68.796611] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[68.800636] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[68.882888] [007/133] (953s left) gem_ctx_engines (none)
[68.942258] Starting subtest: none
[68.944665] Subtest none: SUCCESS (0.002s)
[69.136940] [008/133] (953s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[71.080039] Starting subtest: modeset-non-lpsp-stress-no-wait
[71.130705] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[71.456326] [009/133] (951s left) kms_vblank (ts-continuation-idle)
[71.552046] Starting subtest: ts-continuation-idle
[71.554385] Starting dynamic subtest: pipe-A-eDP-1
[71.951442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[71.965249] Starting dynamic subtest: pipe-D-eDP-1
[73.042658] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.089s)
[73.044855] Subtest ts-continuation-idle: SUCCESS (1.491s)
[73.931780] [010/133] (948s left) kms_psr (fbc-psr2-suspend)
[74.028843] Starting subtest: fbc-psr2-suspend
[74.030706] Starting dynamic subtest: eDP-1
[74.034679] Dynamic subtest eDP-1: SKIP (0.000s)
[74.038654] Subtest fbc-psr2-suspend: SKIP (0.001s)
[74.099486] [011/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[74.204242] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[74.208082] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[74.297411] [012/133] (948s left) kms_dirtyfb (default-dirtyfb-ioctl)
[74.393597] Starting subtest: default-dirtyfb-ioctl
[74.395529] Starting dynamic subtest: A-eDP-1
[76.006091] Dynamic subtest A-eDP-1: SUCCESS (1.612s)
[76.008640] Subtest default-dirtyfb-ioctl: SUCCESS (1.613s)
[76.858634] [013/133] (946s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[76.963122] Starting subtest: plane-all-transition-nonblocking-fencing
[76.965524] Starting dynamic subtest: pipe-A-eDP-1
[79.459217] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[79.763353] Starting dynamic subtest: pipe-B-eDP-1
[82.983864] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s)
[83.299527] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.339s)
[84.114791] [014/133] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[84.218351] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[84.222320] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[84.316060] [015/133] (938s left) syncobj_basic (bad-destroy-pad)
[84.368989] Starting subtest: bad-destroy-pad
[84.371217] Subtest bad-destroy-pad: SUCCESS (0.000s)
[84.475068] [016/133] (938s left) gem_exec_schedule (semaphore-codependency)
[84.548789] Starting subtest: semaphore-codependency
[84.557237] Subtest semaphore-codependency: SUCCESS (0.016s)
[84.902267] [017/133] (938s left) kms_chamelium_audio (dp-audio)
[85.309344] Subtest dp-audio: SKIP (0.000s)
[86.127200] [018/133] (937s left) gem_ctx_shared (exec-shared-gtt)
[86.183948] Starting subtest: exec-shared-gtt
[86.186316] Starting dynamic subtest: rcs0
[86.194807] Dynamic subtest rcs0: SUCCESS (0.010s)
[86.202271] Starting dynamic subtest: bcs0
[86.204581] Dynamic subtest bcs0: SUCCESS (0.009s)
[86.212707] Starting dynamic subtest: vcs0
[86.214677] Dynamic subtest vcs0: SUCCESS (0.010s)
[86.222276] Starting dynamic subtest: vcs1
[86.224619] Dynamic subtest vcs1: SUCCESS (0.008s)
[86.231618] Starting dynamic subtest: vecs0
[86.233736] Dynamic subtest vecs0: SUCCESS (0.011s)
[86.241272] Starting dynamic subtest: ccs0
[86.243524] Dynamic subtest ccs0: SUCCESS (0.004s)
[86.245809] Subtest exec-shared-gtt: SUCCESS (0.055s)
[86.416751] [019/133] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[86.513623] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[86.517945] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[86.613580] [020/133] (936s left) gem_exec_schedule (independent)
[86.685940] Starting subtest: independent
[86.687923] Starting dynamic subtest: rcs0
[87.895624] Dynamic subtest rcs0: SUCCESS (1.218s)
[87.906058] Starting dynamic subtest: vcs0
[89.898839] Dynamic subtest vcs0: SUCCESS (2.002s)
[89.909489] Starting dynamic subtest: vcs1
[91.940254] Dynamic subtest vcs1: SUCCESS (2.041s)
[91.949501] Starting dynamic subtest: vecs0
[93.922267] Dynamic subtest vecs0: SUCCESS (1.979s)
[93.933079] Starting dynamic subtest: ccs0
[95.894688] Dynamic subtest ccs0: SUCCESS (1.973s)
[95.897613] Subtest independent: SUCCESS (9.220s)
[96.194969] [021/133] (927s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[96.295865] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[96.298235] Starting dynamic subtest: pipe-A-default-mode
[97.437589] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[97.442247] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.139s)
[97.567746] [022/133] (925s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[97.672575] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[98.319168] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[98.478878] [023/133] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[98.577440] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[98.581902] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[98.666740] [024/133] (924s left) kms_chamelium_frames (dp-crc-multiple)
[99.043775] Subtest dp-crc-multiple: SKIP (0.000s)
[99.816598] [025/133] (923s left) kms_cursor_crc (cursor-offscreen-64x21)
[100.011338] Starting subtest: cursor-offscreen-64x21
[100.060484] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[100.302218] [026/133] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[100.406478] Starting subtest: addfb25-yf-tiled-legacy
[100.408414] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[100.508271] [027/133] (923s left) kms_pm_dc (dc5-retention-flops)
[101.609108] Starting subtest: dc5-retention-flops
[101.613675] Subtest dc5-retention-flops: SKIP (0.000s)
[101.690159] [028/133] (921s left) gem_eio (wait-immediate)
[101.915388] Starting subtest: wait-immediate
[102.292590] Subtest wait-immediate: SUCCESS (0.377s)
[102.400641] [029/133] (921s left) kms_atomic_interruptible (legacy-dpms)
[102.502521] Starting subtest: legacy-dpms
[102.504632] Starting dynamic subtest: pipe-A-eDP-1
[109.963355] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.460s)
[109.965631] Subtest legacy-dpms: SUCCESS (7.461s)
[110.796397] [030/133] (912s left) kms_big_fb (linear-16bpp-rotate-270)
[110.909063] Starting subtest: linear-16bpp-rotate-270
[110.928035] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[111.025916] [031/133] (912s left) i915_drm_fdinfo (virtual-busy-all)
[111.065881] Starting subtest: virtual-busy-all
[111.070405] Subtest virtual-busy-all: SKIP (0.000s)
[111.126687] [032/133] (912s left) sriov_basic (enable-vfs-autoprobe-off)
[111.182362] Starting subtest: enable-vfs-autoprobe-off
[111.184722] Starting dynamic subtest: numvfs-1
[111.263752] Dynamic subtest numvfs-1: FAIL (0.036s)
[111.273310] Starting dynamic subtest: numvfs-2
[111.346594] Dynamic subtest numvfs-2: FAIL (0.004s)
[111.356074] Starting dynamic subtest: numvfs-3
[111.428789] Dynamic subtest numvfs-3: FAIL (0.003s)
[111.437299] Starting dynamic subtest: numvfs-4
[111.506345] Dynamic subtest numvfs-4: FAIL (0.003s)
[111.514466] Starting dynamic subtest: numvfs-5
[111.584402] Dynamic subtest numvfs-5: FAIL (0.003s)
[111.592517] Starting dynamic subtest: numvfs-6
[111.661591] Dynamic subtest numvfs-6: FAIL (0.003s)
[111.669642] Starting dynamic subtest: numvfs-7
[111.739287] Dynamic subtest numvfs-7: FAIL (0.003s)
[111.748456] Starting dynamic subtest: numvfs-random
[111.811527] Dynamic subtest numvfs-random: FAIL (0.003s)
[111.820445] Starting dynamic subtest: numvfs-all
[111.879769] Dynamic subtest numvfs-all: FAIL (0.488s)
[111.881488] Subtest enable-vfs-autoprobe-off: FAIL (0.553s)
[111.916885] [033/133] (911s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[111.978405] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[112.083251] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[112.156290] [034/133] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[112.268490] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[119.242889] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.977s)
[119.330953] [035/133] (904s left) gem_vm_create (invalid-destroy)
[119.382861] Starting subtest: invalid-destroy
[119.385241] Subtest invalid-destroy: SUCCESS (0.002s)
[119.488206] [036/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[119.583523] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[126.072145] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.491s)
[126.192360] [037/133] (897s left) kms_flip (plain-flip-interruptible)
[126.297427] Starting subtest: plain-flip-interruptible
[126.299849] Starting dynamic subtest: A-eDP1
[127.965526] Dynamic subtest A-eDP1: SUCCESS (1.667s)
[127.975782] Starting dynamic subtest: B-eDP1
[129.594803] Dynamic subtest B-eDP1: SUCCESS (1.628s)
[129.605114] Starting dynamic subtest: C-eDP1
[131.212950] Dynamic subtest C-eDP1: SUCCESS (1.616s)
[131.224568] Starting dynamic subtest: D-eDP1
[132.856675] Dynamic subtest D-eDP1: SUCCESS (1.642s)
[132.861876] Subtest plain-flip-interruptible: SUCCESS (6.565s)
[134.043742] [038/133] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[134.145289] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[134.149238] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[134.237120] [039/133] (889s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[134.340764] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[138.063865] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.728s)
[139.232299] [040/133] (884s left) kms_psr (pr-primary-mmap-cpu)
[139.329302] Starting subtest: pr-primary-mmap-cpu
[139.333705] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[139.399415] [041/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[139.497186] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[147.156094] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.662s)
[147.257343] [042/133] (876s left) api_intel_allocator (standalone)
[147.319665] Starting subtest: standalone
[147.336175] Subtest standalone: SUCCESS (0.019s)
[147.449357] [043/133] (876s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[147.502946] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[147.505549] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[147.618678] [044/133] (876s left) kms_psr (fbc-pr-cursor-plane-onoff)
[147.709331] Starting subtest: fbc-pr-cursor-plane-onoff
[147.713414] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[147.779896] [045/133] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[147.869182] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[147.873636] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[147.950614] [046/133] (876s left) gem_exec_reloc (basic-write-cpu)
[148.006451] Subtest basic-write-cpu: SKIP (0.000s)
[148.080418] [047/133] (876s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[148.170896] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[148.174751] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[148.263883] [048/133] (876s left) i915_pm_rpm (gem-pread)
[150.083261] Starting subtest: gem-pread
[152.183292] Subtest gem-pread: SUCCESS (2.104s)
[152.302198] [049/133] (872s left) kms_chamelium_hpd (common-hpd-after-suspend)
[152.694648] Subtest common-hpd-after-suspend: SKIP (0.000s)
[153.558602] [050/133] (870s left) gem_exec_fence (long-history)
[154.007185] Starting subtest: long-history
[161.566779] Subtest long-history: SUCCESS (7.561s)
[162.128514] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[162.132283] [051/133] (862s left) kms_prop_blob (invalid-get-prop)
[162.186670] Starting subtest: invalid-get-prop
[162.189079] Subtest invalid-get-prop: SUCCESS (0.000s)
[162.282280] [052/133] (862s left) i915_hangman (gt-engine-error)
[162.345805] Starting subtest: gt-engine-error
[162.348159] Starting dynamic subtest: rcs0
[163.893605] Dynamic subtest rcs0: SUCCESS (1.546s)
[163.905426] Starting dynamic subtest: bcs0
[165.879377] Dynamic subtest bcs0: SUCCESS (1.983s)
[165.891092] Starting dynamic subtest: vcs0
[167.861251] Dynamic subtest vcs0: SUCCESS (1.979s)
[167.873355] Starting dynamic subtest: vcs1
[169.909356] Dynamic subtest vcs1: SUCCESS (2.046s)
[169.920872] Starting dynamic subtest: vecs0
[171.893363] Dynamic subtest vecs0: SUCCESS (1.981s)
[171.904381] Starting dynamic subtest: ccs0
[173.813486] Dynamic subtest ccs0: SUCCESS (1.917s)
[173.816533] Subtest gt-engine-error: SUCCESS (11.469s)
[173.895673] [053/133] (850s left) gem_exec_fence (basic-await)
[174.083987] Starting subtest: basic-await
[174.086400] Starting dynamic subtest: rcs0
[174.161746] Dynamic subtest rcs0: SUCCESS (0.077s)
[174.172243] Starting dynamic subtest: bcs0
[174.239260] Dynamic subtest bcs0: SUCCESS (0.076s)
[174.250321] Starting dynamic subtest: vcs0
[174.314626] Dynamic subtest vcs0: SUCCESS (0.074s)
[174.325791] Starting dynamic subtest: vcs1
[174.388065] Dynamic subtest vcs1: SUCCESS (0.072s)
[174.399308] Starting dynamic subtest: vecs0
[174.460326] Dynamic subtest vecs0: SUCCESS (0.071s)
[174.470836] Starting dynamic subtest: ccs0
[174.533288] Dynamic subtest ccs0: SUCCESS (0.071s)
[174.535821] Subtest basic-await: SUCCESS (0.450s)
[175.897903] [054/133] (848s left) syncobj_timeline (wait-for-submit-delayed-submit)
[175.954805] Starting subtest: wait-for-submit-delayed-submit
[176.058747] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[176.150432] [055/133] (848s left) gem_userptr_blits (sync-overlap)
[176.212736] Starting subtest: sync-overlap
[176.214991] Subtest sync-overlap: SUCCESS (0.000s)
[176.325987] [056/133] (848s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[176.425404] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[183.589338] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.165s)
[183.715803] [057/133] (840s left) gem_mmap_gtt (fault-concurrent-y)
[183.784810] Subtest fault-concurrent-Y: SKIP (0.000s)
[183.840023] [058/133] (840s left) prime_vgem (basic-fence-mmap)
[183.925252] Starting subtest: basic-fence-mmap
[183.929740] Subtest basic-fence-mmap: SKIP (0.000s)
[184.025575] [059/133] (840s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[184.116255] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[184.118484] Starting dynamic subtest: pipe-A-eDP-1
[184.139287] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[184.152056] Starting dynamic subtest: pipe-B-eDP-1
[184.171103] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[184.179105] Starting dynamic subtest: pipe-C-eDP-1
[184.198190] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[184.205606] Starting dynamic subtest: pipe-D-eDP-1
[184.224908] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[184.226837] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[186.299780] [060/133] (838s left) kms_psr (psr-basic)
[186.406406] Starting subtest: psr-basic
[186.408922] Starting dynamic subtest: eDP-1
[188.066530] Dynamic subtest eDP-1: SUCCESS (1.660s)
[188.069050] Subtest psr-basic: SUCCESS (1.661s)
[188.949303] [061/133] (835s left) kms_color (gamma)
[189.038139] Starting subtest: gamma
[189.040175] Starting dynamic subtest: pipe-A-eDP-1
[189.760894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[189.768831] Starting dynamic subtest: pipe-B-eDP-1
[191.181994] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s)
[191.190501] Starting dynamic subtest: pipe-C-eDP-1
[192.525927] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s)
[192.533950] Starting dynamic subtest: pipe-D-eDP-1
[193.849061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[193.851389] Subtest gamma: SUCCESS (4.812s)
[194.661169] [062/133] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[194.758394] Starting subtest: compare-crc-sanitycheck-xr24
[194.760377] Starting dynamic subtest: pipe-A-eDP-1
[195.386566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[195.396363] Starting dynamic subtest: pipe-B-eDP-1
[196.628509] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[196.637938] Starting dynamic subtest: pipe-C-eDP-1
[197.816368] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[197.824955] Starting dynamic subtest: pipe-D-eDP-1
[199.022555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[199.024899] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.263s)
[199.875731] [063/133] (825s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[199.975263] Starting subtest: y-tiled-64bpp-rotate-0
[199.979482] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[200.076927] [064/133] (824s left) perf_pmu (busy)
[200.120591] Starting subtest: busy
[200.122900] Starting dynamic subtest: rcs0
[200.700251] Dynamic subtest rcs0: SUCCESS (0.579s)
[200.712651] Starting dynamic subtest: bcs0
[201.261386] Dynamic subtest bcs0: SUCCESS (0.559s)
[201.272602] Starting dynamic subtest: vcs0
[202.903043] Dynamic subtest vcs0: SUCCESS (1.638s)
[202.914635] Starting dynamic subtest: vcs1
[204.887273] Dynamic subtest vcs1: SUCCESS (1.981s)
[204.898871] Starting dynamic subtest: vecs0
[206.935315] Dynamic subtest vecs0: SUCCESS (2.045s)
[206.946730] Starting dynamic subtest: ccs0
[207.501931] Dynamic subtest ccs0: SUCCESS (0.565s)
[207.504782] Subtest busy: SUCCESS (7.383s)
[207.607679] [065/133] (817s left) gem_workarounds (suspend-resume-context)
[207.687261] Starting subtest: suspend-resume-context
[224.266745] Subtest suspend-resume-context: SUCCESS (2.056s)
[224.410946] [066/133] (800s left) kms_plane_multiple (tiling-yf)
[224.520789] Starting subtest: tiling-yf
[224.524717] Subtest tiling-yf: SKIP (0.000s)
[224.598120] [067/133] (800s left) kms_flip (basic-flip-vs-dpms)
[224.684608] Starting subtest: basic-flip-vs-dpms
[224.686804] Starting dynamic subtest: A-eDP1
[227.216913] Dynamic subtest A-eDP1: SUCCESS (2.544s)
[227.226807] Starting dynamic subtest: B-eDP1
[229.387173] Dynamic subtest B-eDP1: SUCCESS (2.180s)
[229.397399] Starting dynamic subtest: C-eDP1
[231.457672] Dynamic subtest C-eDP1: SUCCESS (2.073s)
[231.467468] Starting dynamic subtest: D-eDP1
[233.523868] Dynamic subtest D-eDP1: SUCCESS (2.072s)
[233.526408] Subtest basic-flip-vs-dpms: SUCCESS (8.877s)
[234.336753] [068/133] (790s left) gem_ctx_create (basic)
[234.405344] Starting subtest: basic
[234.407735] Subtest basic: SUCCESS (0.000s)
[234.590965] [069/133] (790s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[234.646207] Starting subtest: multi-wait-all-for-submit-available-submitted
[234.648548] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[234.752250] [070/133] (790s left) gem_lmem_swapping (heavy-verify-multi)
[234.806778] Subtest heavy-verify-multi: SKIP (0.000s)
[234.852384] [071/133] (790s left) api_intel_bb (object-reloc-purge-cache)
[234.912699] Starting subtest: object-reloc-purge-cache
[234.916965] Subtest object-reloc-purge-cache: SKIP (0.002s)
[235.038398] [072/133] (790s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[235.097062] Starting subtest: multi-wait-for-submit-submitted-signaled
[235.099625] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[235.202947] [073/133] (790s left) gem_exec_params (rel-constants-invalid-ring)
[235.256292] Starting subtest: rel-constants-invalid-ring
[235.258669] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[235.370136] [074/133] (790s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[235.470313] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[235.474862] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[235.574549] [075/133] (789s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[235.643610] Starting subtest: yf-tiled-to-vebox-x-tiled
[235.647577] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[235.844168] [076/133] (789s left) i915_pm_rps (waitboost)
[235.905208] Starting subtest: waitboost
[241.998540] Subtest waitboost: SUCCESS (6.101s)
[242.106847] [077/133] (783s left) kms_joiner (invalid-modeset-force-big-joiner)
[242.210221] Starting subtest: invalid-modeset-force-big-joiner
[242.214665] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[242.290056] [078/133] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[242.390643] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[242.394534] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[242.488048] [079/133] (783s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[242.579534] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[242.606145] Starting dynamic subtest: pipe-A-plane-0
[243.027368] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[243.036337] Starting dynamic subtest: pipe-A-plane-3
[243.282552] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[243.291282] Starting dynamic subtest: pipe-A-plane-5
[243.294747] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[244.385532] Starting dynamic subtest: pipe-B-plane-0
[244.810314] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[244.819749] Starting dynamic subtest: pipe-B-plane-3
[245.065708] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[245.075933] Starting dynamic subtest: pipe-B-plane-5
[245.079915] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[245.392993] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.815s)
[246.265203] [080/133] (779s left) perf (short-reads)
[246.395621] Starting subtest: short-reads
[246.409155] Subtest short-reads: SUCCESS (0.016s)
[246.448586] [081/133] (779s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[246.541914] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[246.544119] Starting dynamic subtest: pipe-A
[246.561883] Dynamic subtest pipe-A: SKIP (0.017s)
[246.571037] Starting dynamic subtest: pipe-B
[246.594016] Dynamic subtest pipe-B: SKIP (0.030s)
[246.603235] Starting dynamic subtest: pipe-C
[246.622088] Dynamic subtest pipe-C: SKIP (0.029s)
[246.631900] Starting dynamic subtest: pipe-D
[246.653148] Dynamic subtest pipe-D: SKIP (0.029s)
[246.657512] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.107s)
[246.755231] [082/133] (778s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[246.859326] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[247.803732] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.945s)
[247.936746] [083/133] (777s left) kms_cursor_crc (cursor-random-512x512)
[248.195292] Starting subtest: cursor-random-512x512
[248.199053] Subtest cursor-random-512x512: SKIP (0.001s)
[248.381029] [084/133] (777s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[248.504061] Starting subtest: short-flip-before-cursor-toggle
[249.417514] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[250.283496] [085/133] (775s left) gem_exec_params (sol-reset-not-gen7)
[250.350203] Starting subtest: sol-reset-not-gen7
[250.355263] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[250.474783] [086/133] (775s left) kms_addfb_basic (bad-pitch-1024)
[250.542059] Starting subtest: bad-pitch-1024
[250.544030] Subtest bad-pitch-1024: SUCCESS (0.000s)
[250.674350] [087/133] (775s left) gem_exec_params (no-vebox)
[250.741637] Starting subtest: no-vebox
[250.743968] Subtest no-vebox: SUCCESS (0.004s)
[252.498152] [088/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[252.595161] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[252.599631] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[252.692987] [089/133] (773s left) kms_rotation_crc (primary-rotation-270)
[252.790870] Starting subtest: primary-rotation-270
[252.794606] Subtest primary-rotation-270: SKIP (0.001s)
[252.863793] [090/133] (773s left) gem_barrier_race (remote-request)
[252.918634] Starting subtest: remote-request
[252.920855] Starting dynamic subtest: rcs0
[258.110104] Dynamic subtest rcs0: SUCCESS (5.193s)
[258.112122] Subtest remote-request: SUCCESS (5.194s)
[258.259110] [091/133] (767s left) syncobj_basic (bad-flags-handle-to-fd)
[258.308620] Starting subtest: bad-flags-handle-to-fd
[258.310517] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[258.409458] [092/133] (767s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[258.504669] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[258.506456] Starting dynamic subtest: pipe-A
[258.867293] Dynamic subtest pipe-A: SUCCESS (0.364s)
[258.876765] Starting dynamic subtest: pipe-B
[260.304178] Dynamic subtest pipe-B: SUCCESS (1.434s)
[260.316335] Starting dynamic subtest: pipe-C
[261.728936] Dynamic subtest pipe-C: SUCCESS (1.423s)
[261.738766] Starting dynamic subtest: pipe-D
[263.206171] Dynamic subtest pipe-D: SUCCESS (1.476s)
[263.208466] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.701s)
[264.411240] [093/133] (761s left) gen9_exec_parse (batch-zero-length)
[264.467773] Subtest batch-zero-length: SKIP (0.000s)
[264.533254] [094/133] (761s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[264.581721] Starting subtest: multi-wait-for-submit-submitted-signaled
[264.584086] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[264.671789] [095/133] (761s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[264.767457] Starting subtest: pr-cursor-plane-move-continuous-sf
[264.771605] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[264.836159] [096/133] (761s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[264.938134] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[264.942420] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[265.046409] [097/133] (761s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[265.163402] Starting subtest: cursor-tearing-framebuffer-change
[265.165645] Starting dynamic subtest: pipe-A-eDP-1
[265.730266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[265.739730] Starting dynamic subtest: pipe-D-eDP-1
[266.940827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[266.942677] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.775s)
[267.776006] [098/133] (758s left) gem_ctx_persistence (legacy-engines-hang)
[267.834282] Starting subtest: legacy-engines-hang
[267.836636] Starting dynamic subtest: render
[267.904443] Dynamic subtest render: SUCCESS (0.069s)
[267.918918] Starting dynamic subtest: bsd1
[268.003226] Dynamic subtest bsd1: SUCCESS (0.096s)
[268.016143] Starting dynamic subtest: bsd2
[268.103371] Dynamic subtest bsd2: SUCCESS (0.097s)
[268.114705] Starting dynamic subtest: blt
[268.199603] Dynamic subtest blt: SUCCESS (0.093s)
[268.215035] Starting dynamic subtest: vebox
[268.294462] Dynamic subtest vebox: SUCCESS (0.092s)
[268.297302] Subtest legacy-engines-hang: SUCCESS (0.461s)
[268.375860] [099/133] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[268.478202] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[268.482645] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[268.597546] [100/133] (757s left) gem_mmap_gtt (cpuset-big-copy)
[268.647010] Subtest cpuset-big-copy: SKIP (0.000s)
[268.713387] [101/133] (757s left) kms_psr (psr-sprite-mmap-gtt)
[268.800221] Starting subtest: psr-sprite-mmap-gtt
[268.802164] Starting dynamic subtest: eDP-1
[270.205114] Dynamic subtest eDP-1: SKIP (1.401s)
[270.209747] Subtest psr-sprite-mmap-gtt: SKIP (1.404s)
[270.384793] [102/133] (756s left) gem_exec_fence (syncobj-timeline-wait)
[270.931708] Starting subtest: syncobj-timeline-wait
[272.493869] Subtest syncobj-timeline-wait: SUCCESS (1.566s)
[274.520344] [103/133] (752s left) syncobj_timeline (signal-point-0)
[274.583315] Starting subtest: signal-point-0
[274.585796] Subtest signal-point-0: SUCCESS (0.000s)
[274.713326] [104/133] (751s left) gem_tiled_partial_pwrite_pread (reads)
[274.774733] Subtest reads: SKIP (0.000s)
[274.846391] [105/133] (751s left) gem_render_copy (yf-tiled-ccs-to-linear)
[274.899742] Starting subtest: yf-tiled-ccs-to-linear
[274.903890] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[275.097354] [106/133] (751s left) gem_readwrite (read-write)
[275.147138] Subtest read-write: SKIP (0.000s)
[275.216282] [107/133] (751s left) gem_mmap_wc (bad-object)
[275.269864] Subtest bad-object: SKIP (0.000s)
[275.331717] [108/133] (751s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[275.435975] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[275.440175] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[275.547954] [109/133] (751s left) gem_exec_balancer (parallel-bb-first)
[275.807329] Starting subtest: parallel-bb-first
[276.730848] Subtest parallel-bb-first: SUCCESS (0.924s)
[277.501153] [110/133] (749s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[277.597665] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[277.601673] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[277.705001] [111/133] (749s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[277.797424] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[277.799660] Starting dynamic subtest: pipe-A-eDP-1
[279.842935] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.046s)
[279.863280] Starting dynamic subtest: pipe-B-eDP-1
[281.978895] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.133s)
[281.987983] Starting dynamic subtest: pipe-C-eDP-1
[283.967414] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.988s)
[283.977699] Starting dynamic subtest: pipe-D-eDP-1
[285.998852] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.031s)
[286.001158] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.204s)
[287.178976] [112/133] (739s left) kms_flip (nonexisting-fb-interruptible)
[287.282198] Starting subtest: nonexisting-fb-interruptible
[287.284617] Starting dynamic subtest: A-eDP1
[288.451831] Dynamic subtest A-eDP1: SUCCESS (1.168s)
[288.468401] Starting dynamic subtest: B-eDP1
[289.583339] Dynamic subtest B-eDP1: SUCCESS (1.129s)
[289.593774] Starting dynamic subtest: C-eDP1
[290.714615] Dynamic subtest C-eDP1: SUCCESS (1.129s)
[290.724789] Starting dynamic subtest: D-eDP1
[291.836017] Dynamic subtest D-eDP1: SUCCESS (1.121s)
[291.838995] Subtest nonexisting-fb-interruptible: SUCCESS (4.558s)
[293.006074] [113/133] (734s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[293.113201] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[293.121640] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[293.212906] [114/133] (733s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[293.309743] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[293.317058] Starting dynamic subtest: pipe-A-eDP-1
[293.777633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[293.788934] Starting dynamic subtest: pipe-B-eDP-1
[295.216829] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[295.228155] Starting dynamic subtest: pipe-C-eDP-1
[296.658237] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.449s)
[296.668136] Starting dynamic subtest: pipe-D-eDP-1
[298.087803] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[298.089729] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.754s)
[299.255058] [115/133] (727s left) perf_pmu (busy-idle-no-semaphores)
[299.298519] Starting subtest: busy-idle-no-semaphores
[299.301011] Starting dynamic subtest: rcs0
[299.942083] Dynamic subtest rcs0: SUCCESS (0.644s)
[299.954629] Starting dynamic subtest: bcs0
[300.596515] Dynamic subtest bcs0: SUCCESS (0.652s)
[300.608828] Starting dynamic subtest: vcs0
[301.249429] Dynamic subtest vcs0: SUCCESS (0.651s)
[301.262227] Starting dynamic subtest: vcs1
[303.037056] Dynamic subtest vcs1: SUCCESS (1.785s)
[303.049626] Starting dynamic subtest: vecs0
[305.081440] Dynamic subtest vecs0: SUCCESS (2.042s)
[305.094261] Starting dynamic subtest: ccs0
[307.067403] Dynamic subtest ccs0: SUCCESS (1.983s)
[307.070657] Subtest busy-idle-no-semaphores: SUCCESS (7.772s)
[307.181252] [116/133] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[307.286571] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[307.290539] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.383312] [117/133] (719s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[307.521802] Starting subtest: dp-mst-type-0-suspend-resume
[307.526404] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[307.644474] [118/133] (719s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[307.746865] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[314.460129] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.717s)
[314.602163] [119/133] (712s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[314.700652] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[314.702929] Starting dynamic subtest: A-eDP1
[323.625323] Dynamic subtest A-eDP1: SUCCESS (8.923s)
[323.638467] Starting dynamic subtest: B-eDP1
[332.557387] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[332.570466] Starting dynamic subtest: C-eDP1
[341.476435] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[341.489214] Starting dynamic subtest: D-eDP1
[350.326630] Dynamic subtest D-eDP1: SUCCESS (8.847s)
[350.329043] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.622s)
[351.552315] [120/133] (675s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[351.641514] Starting subtest: primary-y-tiled-reflect-x-0
[351.700540] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[351.803019] [121/133] (675s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[351.919044] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[351.923530] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[352.018011] [122/133] (675s left) gem_ctx_isolation (preservation-s3)
[352.074838] Starting subtest: preservation-S3
[352.077345] Starting dynamic subtest: rcs0
[368.322857] Dynamic subtest rcs0: SUCCESS (1.349s)
[368.338579] Starting dynamic subtest: bcs0
[384.334769] Dynamic subtest bcs0: SUCCESS (1.367s)
[384.348429] Starting dynamic subtest: vcs0
[400.311564] Dynamic subtest vcs0: SUCCESS (2.733s)
[400.324417] Starting dynamic subtest: vcs1
[418.303897] Dynamic subtest vcs1: SUCCESS (5.013s)
[418.314990] Starting dynamic subtest: vecs0
[436.321372] Dynamic subtest vecs0: SUCCESS (5.013s)
[436.336541] Starting dynamic subtest: ccs0
[454.314811] Dynamic subtest ccs0: SUCCESS (3.212s)
[454.317518] Subtest preservation-S3: SUCCESS (18.693s)
[454.543713] [123/133] (572s left) gem_exec_store (cachelines)
[454.615616] Starting subtest: cachelines
[454.618169] Starting dynamic subtest: rcs0
[454.666990] Dynamic subtest rcs0: SUCCESS (0.056s)
[454.677755] Starting dynamic subtest: bcs0
[454.724953] Dynamic subtest bcs0: SUCCESS (0.054s)
[454.734741] Starting dynamic subtest: vcs0
[454.777185] Dynamic subtest vcs0: SUCCESS (0.053s)
[454.787055] Starting dynamic subtest: vcs1
[454.832003] Dynamic subtest vcs1: SUCCESS (0.051s)
[454.842632] Starting dynamic subtest: vecs0
[454.885881] Dynamic subtest vecs0: SUCCESS (0.052s)
[454.896986] Starting dynamic subtest: ccs0
[454.939438] Dynamic subtest ccs0: SUCCESS (0.052s)
[454.942277] Subtest cachelines: SUCCESS (0.329s)
[455.137577] [124/133] (572s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[455.239707] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[455.244657] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[456.355891] [125/133] (571s left) gem_exec_reloc (basic-wc-cpu-active)
[456.422089] Subtest basic-wc-cpu-active: SKIP (0.000s)
[456.493058] [126/133] (571s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[456.596107] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[456.598798] Starting dynamic subtest: pipe-A-default-mode
[457.712000] Dynamic subtest pipe-A-default-mode: SKIP (1.116s)
[457.716257] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.118s)
[457.857085] [127/133] (569s left) kms_universal_plane (universal-plane-functional)
[457.945600] Starting subtest: universal-plane-functional
[457.947890] Starting dynamic subtest: pipe-A-eDP-1
[461.828773] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.892s)
[461.839577] Starting dynamic subtest: pipe-B-eDP-1
[466.331132] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.507s)
[466.342832] Starting dynamic subtest: pipe-C-eDP-1
[470.681513] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.354s)
[470.692840] Starting dynamic subtest: pipe-D-eDP-1
[475.002405] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.322s)
[475.004809] Subtest universal-plane-functional: SUCCESS (17.081s)
[475.815362] [128/133] (551s left) device_reset (cold-reset-bound)
[475.873247] Starting subtest: cold-reset-bound
[475.878455] Subtest cold-reset-bound: SKIP (0.000s)
[475.958934] [129/133] (551s left) kms_fb_coherency (memset-crc)
[476.047622] Starting subtest: memset-crc
[476.050275] Starting dynamic subtest: mmap-offset-wc
[476.433938] Dynamic subtest mmap-offset-wc: SUCCESS (0.387s)
[476.723684] Starting dynamic subtest: mmap-offset-uc
[482.769247] Dynamic subtest mmap-offset-uc: SUCCESS (6.057s)
[483.047522] Subtest memset-crc: SUCCESS (7.007s)
[483.851445] [130/133] (543s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[483.951266] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[483.956817] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[484.050425] [131/133] (543s left) syncobj_eventfd (invalid-bad-pad)
[484.109819] Starting subtest: invalid-bad-pad
[484.112530] Subtest invalid-bad-pad: SUCCESS (0.000s)
[484.208242] [132/133] (543s left) gem_exec_nop (basic-parallel)
[484.287031] Starting subtest: basic-parallel
[498.988590] Subtest basic-parallel: SUCCESS (14.709s)
[499.210568] [133/133] (528s left) gem_softpin (reverse)
[499.280760] Starting subtest: reverse
[499.289270] Subtest reverse: SUCCESS (0.009s)
[499.417244] 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.