[57.173388] Initializing watchdogs
[57.173440]   /dev/watchdog0
[57.188641] [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]
[57.192895] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.195092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.198335] [001/133] (960s left) kms_sequence (get-idle)
[57.327580] Starting subtest: get-idle
[57.329534] Starting dynamic subtest: pipe-A-eDP-1
[59.155441] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.827s)
[59.163593] Starting dynamic subtest: pipe-B-eDP-1
[61.620910] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.467s)
[61.630087] Starting dynamic subtest: pipe-C-eDP-1
[64.040456] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.419s)
[64.048885] Starting dynamic subtest: pipe-D-eDP-1
[66.457306] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[66.459663] Subtest get-idle: SUCCESS (9.131s)
[67.298375] [002/133] (950s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[67.429239] Starting subtest: invalid-single-wait-all-unsubmitted
[67.431635] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[67.711277] [003/133] (950s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[67.847493] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[67.850166] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[67.994649] [004/133] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[68.151180] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[68.155617] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[68.238230] [005/133] (949s left) kms_atomic (crtc-invalid-params-fence)
[68.328962] Starting subtest: crtc-invalid-params-fence
[68.331296] Starting dynamic subtest: pipe-A-eDP-1
[68.765931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[68.767991] Subtest crtc-invalid-params-fence: SUCCESS (0.436s)
[69.616804] [006/133] (948s left) kms_chamelium_frames (hdmi-crc-fast)
[70.007319] Subtest hdmi-crc-fast: SKIP (0.000s)
[70.833207] [007/133] (947s left) kms_feature_discovery (display)
[70.927314] Starting subtest: display
[70.929498] Subtest display: SUCCESS (0.000s)
[71.002937] [008/133] (946s left) drm_read (invalid-buffer)
[71.133079] Starting subtest: invalid-buffer
[71.135602] Subtest invalid-buffer: SUCCESS (0.000s)
[71.245373] [009/133] (946s left) fbdev (info)
[71.281016] Starting subtest: info
[71.283126] Subtest info: SUCCESS (0.000s)
[71.347638] [010/133] (946s left) kms_chamelium_color (ctm-negative)
[71.448043] Subtest ctm-negative: SKIP (0.000s)
[71.490435] [011/133] (946s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[71.577161] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[71.581507] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[71.665739] [012/133] (946s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[71.756041] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[71.782071] Starting dynamic subtest: pipe-A-plane-0
[72.404124] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[72.411890] Starting dynamic subtest: pipe-A-plane-3
[72.816591] Dynamic subtest pipe-A-plane-3: SUCCESS (0.411s)
[73.940359] Starting dynamic subtest: pipe-B-plane-0
[74.547761] Dynamic subtest pipe-B-plane-0: SUCCESS (0.611s)
[74.556765] Starting dynamic subtest: pipe-B-plane-3
[74.933068] Dynamic subtest pipe-B-plane-3: SUCCESS (0.389s)
[75.245446] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.489s)
[76.115956] [013/133] (942s left) kms_flip (wf_vblank-ts-check)
[76.224781] Starting subtest: wf_vblank-ts-check
[76.227023] Starting dynamic subtest: A-eDP1
[85.171614] Dynamic subtest A-eDP1: SUCCESS (8.949s)
[85.178976] Starting dynamic subtest: B-eDP1
[94.098908] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[94.108474] Starting dynamic subtest: C-eDP1
[103.017849] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[103.025059] Starting dynamic subtest: D-eDP1
[111.951382] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[111.956183] Subtest wf_vblank-ts-check: SUCCESS (35.734s)
[113.181463] [014/133] (905s left) gem_create (create-ext-cpu-access-sanity-check)
[113.363267] Starting subtest: create-ext-cpu-access-sanity-check
[113.368179] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[113.451895] [015/133] (904s left) gem_pxp (hw-rejects-pxp-buffer)
[113.583036] Starting subtest: hw-rejects-pxp-buffer
[113.587707] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[113.697237] [016/133] (904s left) gem_render_copy (y-tiled-to-vebox-linear)
[113.756338] Starting subtest: y-tiled-to-vebox-linear
[113.760474] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[113.934757] [017/133] (904s left) gem_exec_schedule (semaphore-resolve)
[114.009283] Starting subtest: semaphore-resolve
[114.047256] Subtest semaphore-resolve: SUCCESS (0.045s)
[114.380091] [018/133] (903s left) kms_content_protection (srm)
[114.516281] Starting subtest: srm
[114.523208] Subtest srm: SKIP (0.003s)
[114.653170] [019/133] (903s left) gem_exec_fence (submit67)
[114.846742] Starting subtest: submit67
[114.851165] Subtest submit67: SKIP (0.000s)
[116.935566] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[116.938679] [020/133] (901s left) kms_psr (psr2-sprite-plane-onoff)
[117.031624] Starting subtest: psr2-sprite-plane-onoff
[117.033807] Starting dynamic subtest: eDP-1
[118.816933] Dynamic subtest eDP-1: SUCCESS (1.784s)
[118.819273] Subtest psr2-sprite-plane-onoff: SUCCESS (1.784s)
[119.667895] [021/133] (898s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[119.721227] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[119.723754] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[119.824044] [022/133] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[119.916152] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[124.204407] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.291s)
[125.373040] [023/133] (893s left) gem_ctx_param (set-priority-not-supported)
[125.426804] Starting subtest: set-priority-not-supported
[125.431425] Subtest set-priority-not-supported: SKIP (0.000s)
[125.514286] [024/133] (893s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[125.605968] Starting subtest: async-flip-with-page-flip-events-tiled
[125.977988] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[128.728210] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.750s)
[128.735702] Starting dynamic subtest: pipe-A-eDP-1-4
[130.914563] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[130.922485] Starting dynamic subtest: pipe-A-eDP-1-4
[132.925272] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[132.935488] Starting dynamic subtest: pipe-A-eDP-1-x
[135.103621] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[135.471312] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[138.253366] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[138.263396] Starting dynamic subtest: pipe-B-eDP-1-4
[140.439474] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[140.449559] Starting dynamic subtest: pipe-B-eDP-1-4
[142.449760] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[142.457956] Starting dynamic subtest: pipe-B-eDP-1-x
[144.650556] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[145.014238] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[147.775539] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.765s)
[147.786228] Starting dynamic subtest: pipe-C-eDP-1-4
[149.958740] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.183s)
[149.966679] Starting dynamic subtest: pipe-C-eDP-1-4
[151.969497] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[151.980409] Starting dynamic subtest: pipe-C-eDP-1-x
[154.171055] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s)
[154.537643] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[157.302678] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[157.310408] Starting dynamic subtest: pipe-D-eDP-1-4
[159.478066] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[159.486164] Starting dynamic subtest: pipe-D-eDP-1-4
[161.488273] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[161.496106] Starting dynamic subtest: pipe-D-eDP-1-x
[163.667400] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[163.670325] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.059s)
[164.891258] [025/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[164.996582] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[165.000585] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[165.106600] [026/133] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[165.207322] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[172.038888] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.835s)
[172.176538] [027/133] (846s left) kms_joiner (basic-max-non-joiner)
[172.271156] Starting subtest: basic-max-non-joiner
[172.275726] Subtest basic-max-non-joiner: SKIP (0.000s)
[172.350350] [028/133] (846s left) gem_readwrite (read-write)
[172.401307] Subtest read-write: SKIP (0.000s)
[172.464646] [029/133] (846s left) perf_pmu (enable-race)
[172.509739] Starting subtest: enable-race
[172.512068] Starting dynamic subtest: rcs0
[185.284231] Dynamic subtest rcs0: SUCCESS (12.774s)
[185.292385] Starting dynamic subtest: bcs0
[198.025438] Dynamic subtest bcs0: SUCCESS (12.739s)
[198.035925] Starting dynamic subtest: vcs0
[213.909466] Dynamic subtest vcs0: SUCCESS (15.880s)
[213.922776] Starting dynamic subtest: vcs1
[229.844775] Dynamic subtest vcs1: SUCCESS (15.933s)
[229.855216] Starting dynamic subtest: vecs0
[245.908905] Dynamic subtest vecs0: SUCCESS (16.062s)
[245.919243] Starting dynamic subtest: ccs0
[258.650374] Dynamic subtest ccs0: SUCCESS (12.741s)
[258.653048] Subtest enable-race: SUCCESS (86.140s)
[258.773070] [030/133] (760s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[259.167288] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[259.948429] [031/133] (758s left) prime_vgem (basic-fence-mmap)
[260.012748] Starting subtest: basic-fence-mmap
[260.017373] Subtest basic-fence-mmap: SKIP (0.000s)
[260.103289] [032/133] (758s left) i915_suspend (basic-s3-without-i915)
[260.138375] Starting subtest: basic-s3-without-i915
[263.329944] Subtest basic-s3-without-i915: SKIP (3.186s)
[264.954177] [033/133] (754s left) kms_psr (fbc-pr-cursor-plane-onoff)
[265.057903] Starting subtest: fbc-pr-cursor-plane-onoff
[265.062191] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[265.143779] [034/133] (753s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[265.242218] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[265.246684] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[265.313414] [035/133] (753s left) gem_exec_reloc (basic-write-cpu)
[265.375293] Subtest basic-write-cpu: SKIP (0.000s)
[265.433530] [036/133] (753s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[265.561296] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[265.565558] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[265.666755] [037/133] (753s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[265.769125] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[266.902583] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.133s)
[267.060560] [038/133] (752s left) syncobj_wait (invalid-reset-one-illegal-handle)
[267.118315] Starting subtest: invalid-reset-one-illegal-handle
[267.120290] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[267.204193] [039/133] (752s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[267.259658] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[267.369073] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[267.456124] [040/133] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[267.552713] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[274.102879] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.554s)
[274.204916] [041/133] (745s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[274.313700] Starting subtest: plane-all-modeset-transition-internal-panels
[274.315958] Starting dynamic subtest: pipe-A-eDP-1
[275.611550] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.297s)
[275.891202] Starting dynamic subtest: pipe-B-eDP-1
[276.942438] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.058s)
[277.224572] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.912s)
[278.071480] [042/133] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[278.167423] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[278.171819] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[278.271507] [043/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[278.379578] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[278.383626] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[278.483856] [044/133] (740s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[278.589970] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[278.592333] Starting dynamic subtest: pipe-A-eDP-1
[278.650342] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[278.658256] Starting dynamic subtest: pipe-B-eDP-1
[278.715691] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[278.725196] Starting dynamic subtest: pipe-C-eDP-1
[278.781596] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[278.790688] Starting dynamic subtest: pipe-D-eDP-1
[278.846447] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[278.852991] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[280.757703] [045/133] (738s left) kms_cursor_edge_walk (128x128-top-edge)
[280.858729] Starting subtest: 128x128-top-edge
[280.861025] Starting dynamic subtest: pipe-A-eDP-1
[284.329994] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[284.337702] Starting dynamic subtest: pipe-D-eDP-1
[287.481966] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.149s)
[287.484343] Subtest 128x128-top-edge: SUCCESS (6.622s)
[288.279750] [046/133] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[288.382677] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[295.226219] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.847s)
[295.354396] [047/133] (724s left) kms_plane_lowres (tiling-4)
[295.459426] Starting subtest: tiling-4
[295.461696] Starting dynamic subtest: pipe-A-eDP-1
[295.466303] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[295.755747] Starting dynamic subtest: pipe-B-eDP-1
[295.760084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[295.767557] Starting dynamic subtest: pipe-C-eDP-1
[295.772250] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[295.780640] Starting dynamic subtest: pipe-D-eDP-1
[295.785121] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[295.789460] Subtest tiling-4: SKIP (0.301s)
[296.555119] [048/133] (723s left) kms_flip (busy-flip)
[296.651976] Starting subtest: busy-flip
[296.654301] Starting dynamic subtest: A-eDP1
[298.369098] Dynamic subtest A-eDP1: SUCCESS (1.715s)
[298.379019] Starting dynamic subtest: B-eDP1
[300.100215] Dynamic subtest B-eDP1: SUCCESS (1.728s)
[300.109261] Starting dynamic subtest: C-eDP1
[301.830099] Dynamic subtest C-eDP1: SUCCESS (1.727s)
[301.845566] Starting dynamic subtest: D-eDP1
[303.460614] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[303.465439] Subtest busy-flip: SUCCESS (6.813s)
[304.622526] [049/133] (715s left) gem_userptr_blits (unsync-unmap-cycles)
[304.685703] Subtest unsync-unmap-cycles: SKIP (0.000s)
[304.805606] [050/133] (714s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[304.909385] Starting subtest: psr-rgb101010-draw-mmap-gtt
[304.913605] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[305.009492] [051/133] (714s left) gem_exec_schedule (preempt-contexts)
[305.080559] Starting subtest: preempt-contexts
[305.082677] Starting dynamic subtest: rcs0
[305.131748] Dynamic subtest rcs0: SUCCESS (0.055s)
[305.140819] Starting dynamic subtest: bcs0
[305.190854] Dynamic subtest bcs0: SUCCESS (0.058s)
[305.199230] Starting dynamic subtest: vcs0
[305.236460] Dynamic subtest vcs0: SUCCESS (0.045s)
[305.244430] Starting dynamic subtest: vcs1
[305.284833] Dynamic subtest vcs1: SUCCESS (0.047s)
[305.297729] Starting dynamic subtest: vecs0
[305.341726] Dynamic subtest vecs0: SUCCESS (0.056s)
[305.349898] Starting dynamic subtest: ccs0
[305.398825] Dynamic subtest ccs0: SUCCESS (0.056s)
[305.401479] Subtest preempt-contexts: SUCCESS (0.323s)
[306.990328] [052/133] (712s left) gem_exec_balancer (full-late-pulse)
[307.061886] Starting subtest: full-late-pulse
[311.786846] Subtest full-late-pulse: SUCCESS (4.724s)
[312.107054] [053/133] (707s left) perf (gen12-group-exclusive-stream-ctx-handle)
[312.250416] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[312.287457] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.037s)
[312.336456] [054/133] (707s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[313.951883] Starting subtest: fbc-psr2-cursor-plane-onoff
[313.954132] Starting dynamic subtest: eDP-1
[313.958297] Dynamic subtest eDP-1: SKIP (0.000s)
[313.962571] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[314.025742] [055/133] (705s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[314.084351] Starting subtest: single-wait-all-for-submit-signaled
[314.086640] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[314.196318] [056/133] (705s left) api_intel_bb (object-reloc-keep-cache)
[314.250983] Starting subtest: object-reloc-keep-cache
[314.255442] Subtest object-reloc-keep-cache: SKIP (0.003s)
[314.337207] [057/133] (705s left) perf_pmu (semaphore-wait-idle)
[314.374082] Starting subtest: semaphore-wait-idle
[314.376358] Starting dynamic subtest: rcs0
[314.888722] Dynamic subtest rcs0: SUCCESS (0.513s)
[314.899935] Starting dynamic subtest: bcs0
[315.403861] Dynamic subtest bcs0: SUCCESS (0.511s)
[315.415236] Starting dynamic subtest: vcs0
[315.916605] Dynamic subtest vcs0: SUCCESS (0.510s)
[315.927700] Starting dynamic subtest: vcs1
[316.428923] Dynamic subtest vcs1: SUCCESS (0.510s)
[316.440926] Starting dynamic subtest: vecs0
[316.942368] Dynamic subtest vecs0: SUCCESS (0.510s)
[316.954083] Starting dynamic subtest: ccs0
[317.458292] Dynamic subtest ccs0: SUCCESS (0.513s)
[317.461043] Subtest semaphore-wait-idle: SUCCESS (3.084s)
[318.942487] [058/133] (701s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[319.060413] Starting subtest: fbc-rgb101010-draw-render
[323.648823] Subtest fbc-rgb101010-draw-render: SUCCESS (4.592s)
[324.839901] [059/133] (695s left) kms_lease (invalid-create-leases)
[324.928821] Starting subtest: invalid-create-leases
[324.933383] Subtest invalid-create-leases: SUCCESS (0.006s)
[325.047312] [060/133] (695s left) kms_psr (psr2-cursor-blt)
[325.136980] Starting subtest: psr2-cursor-blt
[325.139243] Starting dynamic subtest: eDP-1
[326.812773] Dynamic subtest eDP-1: SUCCESS (1.677s)
[326.815062] Subtest psr2-cursor-blt: SUCCESS (1.678s)
[327.699966] [061/133] (692s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[327.807183] Starting subtest: compare-crc-sanitycheck-nv12
[327.809053] Starting dynamic subtest: pipe-A-eDP-1
[328.508342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[328.517691] Starting dynamic subtest: pipe-B-eDP-1
[329.777434] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s)
[329.787209] Starting dynamic subtest: pipe-C-eDP-1
[331.058057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[331.068471] Starting dynamic subtest: pipe-D-eDP-1
[332.325228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s)
[332.327544] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.517s)
[333.131327] [062/133] (687s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[333.231818] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[337.366795] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.138s)
[338.539466] [063/133] (681s left) syncobj_timeline (32bits-limit)
[338.596501] Starting subtest: 32bits-limit
[338.598895] Subtest 32bits-limit: SUCCESS (0.001s)
[338.709950] [064/133] (681s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[338.810166] Starting subtest: 4-tiled-32bpp-rotate-90
[338.835457] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.023s)
[338.963191] [065/133] (681s left) gem_exec_fence (basic-await)
[339.143748] Starting subtest: basic-await
[339.146256] Starting dynamic subtest: rcs0
[339.222023] Dynamic subtest rcs0: SUCCESS (0.078s)
[339.234082] Starting dynamic subtest: bcs0
[339.295087] Dynamic subtest bcs0: SUCCESS (0.072s)
[339.307025] Starting dynamic subtest: vcs0
[339.368267] Dynamic subtest vcs0: SUCCESS (0.071s)
[339.379563] Starting dynamic subtest: vcs1
[339.441826] Dynamic subtest vcs1: SUCCESS (0.072s)
[339.453831] Starting dynamic subtest: vecs0
[339.515716] Dynamic subtest vecs0: SUCCESS (0.071s)
[339.527087] Starting dynamic subtest: ccs0
[339.587658] Dynamic subtest ccs0: SUCCESS (0.071s)
[339.590275] Subtest basic-await: SUCCESS (0.445s)
[340.942918] [066/133] (679s left) kms_cursor_legacy (forked-bo)
[341.071903] Starting subtest: forked-bo
[341.074179] Starting dynamic subtest: pipe-A
[346.564064] Dynamic subtest pipe-A: SUCCESS (5.489s)
[346.578694] Starting dynamic subtest: pipe-B
[352.045211] Dynamic subtest pipe-B: SUCCESS (5.479s)
[352.057373] Starting dynamic subtest: pipe-C
[357.522253] Dynamic subtest pipe-C: SUCCESS (5.474s)
[357.533094] Starting dynamic subtest: pipe-D
[362.996441] Dynamic subtest pipe-D: SUCCESS (5.471s)
[363.007683] Starting dynamic subtest: all-pipes
[368.523083] Dynamic subtest all-pipes: SUCCESS (5.524s)
[368.526087] Subtest forked-bo: SUCCESS (27.449s)
[368.663286] [067/133] (651s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[368.770322] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[375.440780] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.672s)
[375.553660] [068/133] (644s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[375.646428] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[375.658627] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[375.758021] [069/133] (644s left) i915_pm_rpm (system-suspend)
[378.095064] Starting subtest: system-suspend
[396.210879] Subtest system-suspend: SUCCESS (3.300s)
[406.628857] [070/133] (623s left) gem_softpin (evict-prime-sanity-check)
[406.704416] Starting subtest: evict-prime-sanity-check
[406.706843] Starting dynamic subtest: rcs0
[407.843938] Dynamic subtest rcs0: SUCCESS (1.141s)
[407.854372] Starting dynamic subtest: bcs0
[408.964586] Dynamic subtest bcs0: SUCCESS (1.118s)
[408.977124] Starting dynamic subtest: vcs0
[410.719532] Dynamic subtest vcs0: SUCCESS (1.751s)
[410.731423] Starting dynamic subtest: vcs1
[412.703233] Dynamic subtest vcs1: SUCCESS (1.980s)
[412.714427] Starting dynamic subtest: vecs0
[414.686751] Dynamic subtest vecs0: SUCCESS (1.980s)
[414.703259] Starting dynamic subtest: ccs0
[415.825813] Dynamic subtest ccs0: SUCCESS (1.137s)
[415.835417] Starting dynamic subtest: all
[416.945807] Dynamic subtest all: SUCCESS (1.117s)
[416.948411] Subtest evict-prime-sanity-check: SUCCESS (10.240s)
[417.030606] [071/133] (613s left) gem_exec_fence (syncobj-timeline-unused-fence)
[417.617558] Starting subtest: syncobj-timeline-unused-fence
[417.627483] Subtest syncobj-timeline-unused-fence: SUCCESS (0.011s)
[418.834013] [072/133] (611s left) gem_lmem_swapping (smem-oom)
[418.875983] Subtest smem-oom: SKIP (0.000s)
[418.924317] [073/133] (611s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[419.032276] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[419.037102] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[419.150099] [074/133] (611s left) perf_pmu (interrupts)
[419.196040] Starting subtest: interrupts
[420.277733] Subtest interrupts: SUCCESS (1.082s)
[420.400493] [075/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[420.496406] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[427.882276] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.387s)
[428.017828] [076/133] (602s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[428.107523] Starting subtest: plane-upscale-20x20-with-pixel-format
[428.110190] Starting dynamic subtest: pipe-A
[429.155670] Dynamic subtest pipe-A: SUCCESS (1.050s)
[429.164917] Starting dynamic subtest: pipe-B
[431.238012] Dynamic subtest pipe-B: SUCCESS (2.081s)
[431.249449] Starting dynamic subtest: pipe-C
[432.429365] Dynamic subtest pipe-C: SUCCESS (1.190s)
[432.439325] Starting dynamic subtest: pipe-D
[433.584682] Dynamic subtest pipe-D: SUCCESS (1.154s)
[433.587108] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.479s)
[434.780151] [077/133] (596s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[434.878935] Starting subtest: fbcpsr-modesetfrombusy
[441.089098] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.213s)
[441.218478] [078/133] (589s left) kms_cursor_crc (cursor-onscreen-512x512)
[441.512200] Starting subtest: cursor-onscreen-512x512
[441.517044] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[441.663285] [079/133] (589s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[441.721884] Starting subtest: wait-all-for-submit-delayed-submit
[441.823536] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[441.905279] [080/133] (589s left) gem_render_copy_redux (flink-interruptible)
[441.960750] Starting subtest: flink-interruptible
[442.760982] Subtest flink-interruptible: SUCCESS (0.801s)
[442.873915] [081/133] (588s left) api_intel_allocator (reserve-simple)
[442.932242] Starting subtest: reserve-simple
[442.938252] Subtest reserve-simple: SUCCESS (0.008s)
[443.059422] [082/133] (588s left) gem_set_tiling_vs_pwrite
[443.173155] [083/133] (587s left) gem_exec_flush (basic-batch-kernel-default-uc)
[443.231175] Starting subtest: basic-batch-kernel-default-uc
[450.364670] Subtest basic-batch-kernel-default-uc: SUCCESS (7.134s)
[450.571704] [084/133] (580s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[450.631221] Starting subtest: y-tiled-ccs-to-y-tiled
[450.636268] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[450.838321] [085/133] (580s left) kms_psr (fbc-psr2-sprite-render)
[450.931973] Starting subtest: fbc-psr2-sprite-render
[450.934241] Starting dynamic subtest: eDP-1
[450.939161] Dynamic subtest eDP-1: SKIP (0.000s)
[450.943618] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[451.021333] [086/133] (580s left) kms_pm_rpm (i2c)
[452.849920] Starting subtest: i2c
[457.922387] Subtest i2c: SUCCESS (5.074s)
[458.013792] [087/133] (573s left) gem_userptr_blits (sync-unmap-after-close)
[458.079848] Starting subtest: sync-unmap-after-close
[458.091557] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[458.206680] [088/133] (573s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[458.299066] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[458.301600] Starting dynamic subtest: pipe-A-eDP-1
[458.323370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[458.335378] Starting dynamic subtest: pipe-B-eDP-1
[458.358109] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[458.368196] Starting dynamic subtest: pipe-C-eDP-1
[458.391127] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[458.402327] Starting dynamic subtest: pipe-D-eDP-1
[458.425929] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[458.428566] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[460.593592] [089/133] (570s left) gem_exec_whisper (basic-fds-priority)
[460.652256] Starting subtest: basic-fds-priority
[485.001388] Subtest basic-fds-priority: SUCCESS (24.343s)
[485.186885] [090/133] (546s left) gem_exec_params (invalid-bsd1-flag-on-render)
[485.255868] Starting subtest: invalid-bsd1-flag-on-render
[485.258392] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[485.350658] [091/133] (546s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[485.451590] Starting subtest: crc-primary-suspend-y-tiled-ccs
[485.454005] Starting dynamic subtest: pipe-A-eDP-1
[485.464295] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.474998] Starting dynamic subtest: pipe-B-eDP-1
[485.485819] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.495407] Starting dynamic subtest: pipe-C-eDP-1
[485.505770] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[485.515163] Starting dynamic subtest: pipe-D-eDP-1
[485.525408] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[485.530416] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[487.729640] [092/133] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[487.842242] Starting subtest: fbcpsr-2p-rte
[487.847203] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[487.943867] [093/133] (543s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[488.010363] Starting subtest: multi-wait-all-for-submit-available-signaled
[488.013193] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[488.127139] [094/133] (543s left) gem_sync (basic-many-each)
[488.203250] Starting subtest: basic-many-each
[490.478036] Subtest basic-many-each: SUCCESS (2.287s)
[490.669779] [095/133] (541s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[490.771326] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[490.776928] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[490.856365] [096/133] (540s left) gem_exec_reloc (basic-range)
[490.924175] Subtest basic-range: SKIP (0.000s)
[490.988605] [097/133] (540s left) sysfs_heartbeat_interval (invalid)
[491.050402] Starting subtest: invalid
[491.053305] Starting dynamic subtest: vecs0
[491.056137] Dynamic subtest vecs0: SUCCESS (0.000s)
[491.066460] Starting dynamic subtest: ccs0
[491.069404] Dynamic subtest ccs0: SUCCESS (0.000s)
[491.078964] Starting dynamic subtest: vcs0
[491.081418] Dynamic subtest vcs0: SUCCESS (0.000s)
[491.090172] Starting dynamic subtest: bcs0
[491.092683] Dynamic subtest bcs0: SUCCESS (0.000s)
[491.102147] Starting dynamic subtest: rcs0
[491.104413] Dynamic subtest rcs0: SUCCESS (0.000s)
[491.113876] Starting dynamic subtest: vcs1
[491.116088] Dynamic subtest vcs1: SUCCESS (0.000s)
[491.118257] Subtest invalid: SUCCESS (0.005s)
[491.156096] [098/133] (540s left) gem_exec_reloc (basic-wc-read-active)
[491.210308] Subtest basic-wc-read-active: SKIP (0.000s)
[491.276581] [099/133] (540s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[491.367143] Starting subtest: y-tiled-32bpp-rotate-0
[491.372267] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[491.455197] [100/133] (540s left) core_sysfs (read-all-entries)
[491.504540] Starting subtest: read-all-entries
[491.513169] Subtest read-all-entries: SUCCESS (0.010s)
[491.589867] [101/133] (540s left) gem_userptr_blits (probe)
[491.655647] Starting subtest: probe
[491.731799] Subtest probe: SUCCESS (0.076s)
[491.837719] [102/133] (540s left) kms_vblank (wait-idle)
[491.930052] Starting subtest: wait-idle
[491.932258] Starting dynamic subtest: pipe-A-eDP-1
[493.699913] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.770s)
[493.716296] Starting dynamic subtest: pipe-D-eDP-1
[496.165885] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.463s)
[496.168456] Subtest wait-idle: SUCCESS (4.237s)
[497.004851] [103/133] (535s left) kms_pm_rpm (cursor-dpms)
[498.839774] Starting subtest: cursor-dpms
[498.844658] Subtest cursor-dpms: SKIP (0.000s)
[499.243787] [104/133] (532s left) kms_color (ctm-blue-to-red)
[499.337276] Starting subtest: ctm-blue-to-red
[499.339816] Starting dynamic subtest: pipe-A-eDP-1
[500.047829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[500.058170] Starting dynamic subtest: pipe-B-eDP-1
[501.426312] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[501.436425] Starting dynamic subtest: pipe-C-eDP-1
[502.827298] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[502.847261] Starting dynamic subtest: pipe-D-eDP-1
[504.130216] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[504.132964] Subtest ctm-blue-to-red: SUCCESS (4.792s)
[504.951999] [105/133] (527s left) gem_mmap_offset (clear)
[505.010696] Starting subtest: clear
[505.013973] Starting dynamic subtest: smem0
[528.369433] Dynamic subtest smem0: SUCCESS (23.355s)
[528.372140] Subtest clear: SUCCESS (23.356s)
[528.498348] [106/133] (503s left) prime_self_import (basic-llseek-bad)
[528.596289] Starting subtest: basic-llseek-bad
[528.623372] Subtest basic-llseek-bad: SUCCESS (0.028s)
[528.722575] [107/133] (503s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[528.788229] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[528.890929] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[528.969280] [108/133] (503s left) gen9_exec_parse (bb-large)
[529.025108] Subtest bb-large: SKIP (0.000s)
[529.090087] [109/133] (503s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[529.199183] Starting subtest: yf-tiled-8bpp-rotate-180
[529.204429] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[529.301754] [110/133] (503s left) gem_ctx_isolation (preservation-s3)
[529.364813] Starting subtest: preservation-S3
[529.367328] Starting dynamic subtest: rcs0
[545.559373] Dynamic subtest rcs0: SUCCESS (1.751s)
[545.571505] Starting dynamic subtest: bcs0
[562.550411] Dynamic subtest bcs0: SUCCESS (1.733s)
[562.561188] Starting dynamic subtest: vcs0
[579.541704] Dynamic subtest vcs0: SUCCESS (3.340s)
[579.553322] Starting dynamic subtest: vcs1
[597.551479] Dynamic subtest vcs1: SUCCESS (4.980s)
[597.562423] Starting dynamic subtest: vecs0
[615.537455] Dynamic subtest vecs0: SUCCESS (5.036s)
[615.548035] Starting dynamic subtest: ccs0
[633.541484] Dynamic subtest ccs0: SUCCESS (3.159s)
[633.543788] Subtest preservation-S3: SUCCESS (20.006s)
[644.791418] [111/133] (398s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[644.910293] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[644.912475] Starting dynamic subtest: pipe-A-eDP-1
[644.933369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[644.946889] Starting dynamic subtest: pipe-B-eDP-1
[644.966596] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[644.976754] Starting dynamic subtest: pipe-C-eDP-1
[644.996427] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[645.006071] Starting dynamic subtest: pipe-D-eDP-1
[645.025800] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[645.027732] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[647.232224] [112/133] (396s left) gem_ctx_shared (q-out-order)
[647.298881] Starting subtest: Q-out-order
[647.301405] Starting dynamic subtest: rcs0
[647.416854] Dynamic subtest rcs0: SUCCESS (0.116s)
[647.430888] Starting dynamic subtest: vcs0
[647.510281] Dynamic subtest vcs0: SUCCESS (0.093s)
[647.529458] Starting dynamic subtest: vcs1
[647.588581] Dynamic subtest vcs1: SUCCESS (0.077s)
[647.607269] Starting dynamic subtest: vecs0
[647.668257] Dynamic subtest vecs0: SUCCESS (0.079s)
[647.685328] Starting dynamic subtest: ccs0
[647.746597] Dynamic subtest ccs0: SUCCESS (0.077s)
[647.749136] Subtest Q-out-order: SUCCESS (0.447s)
[648.984834] [113/133] (394s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[649.043611] Starting subtest: multi-wait-for-submit-submitted-signaled
[649.046058] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[649.155397] [114/133] (394s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[649.254684] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[650.303560] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.048s)
[650.418055] [115/133] (393s left) kms_psr (psr-sprite-plane-move)
[650.509505] Starting subtest: psr-sprite-plane-move
[650.511712] Starting dynamic subtest: eDP-1
[652.271054] Dynamic subtest eDP-1: SUCCESS (1.758s)
[652.273175] Subtest psr-sprite-plane-move: SUCCESS (1.759s)
[653.101267] [116/133] (390s left) gem_exec_create (madvise)
[653.164977] Starting subtest: madvise
[653.167193] Starting dynamic subtest: smem
[673.327714] Dynamic subtest smem: SUCCESS (20.153s)
[673.330405] Subtest madvise: SUCCESS (20.154s)
[674.428693] [117/133] (369s left) gem_ctx_persistence (file)
[674.506369] Starting subtest: file
[674.641575] Subtest file: SUCCESS (0.136s)
[674.789892] [118/133] (368s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[674.903055] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[675.974697] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.072s)
[676.099608] [119/133] (367s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[676.209540] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[679.752825] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.545s)
[680.917914] [120/133] (362s left) gem_mmap_offset (ptrace)
[680.972292] Starting subtest: ptrace
[680.974548] Starting dynamic subtest: smem0-wb
[680.986122] Dynamic subtest smem0-wb: SUCCESS (0.013s)
[680.997022] Starting dynamic subtest: smem0-wc
[681.003558] Dynamic subtest smem0-wc: SUCCESS (0.017s)
[681.014375] Starting dynamic subtest: smem0-uc
[681.024848] Dynamic subtest smem0-uc: SUCCESS (0.021s)
[681.027110] Subtest ptrace: SUCCESS (0.056s)
[681.115464] [121/133] (362s left) syncobj_wait (wait-all-for-submit-snapshot)
[681.168622] Starting subtest: wait-all-for-submit-snapshot
[681.248240] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[681.331483] [122/133] (362s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[681.427917] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[681.430159] Starting dynamic subtest: pipe-A
[681.450483] Dynamic subtest pipe-A: SKIP (0.017s)
[681.463380] Starting dynamic subtest: pipe-B
[681.482210] Dynamic subtest pipe-B: SKIP (0.032s)
[681.492788] Starting dynamic subtest: pipe-C
[681.513019] Dynamic subtest pipe-C: SKIP (0.031s)
[681.523428] Starting dynamic subtest: pipe-D
[681.543532] Dynamic subtest pipe-D: SKIP (0.031s)
[681.547255] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.114s)
[681.654390] [123/133] (362s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[681.818866] Starting subtest: cursor-rapid-movement-32x32
[681.867794] Subtest cursor-rapid-movement-32x32: SKIP (0.044s)
[682.158526] [124/133] (361s left) i915_pciid
[682.309152] [125/133] (361s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[682.402222] Starting subtest: plane-all-modeset-transition-fencing
[682.405775] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[682.477954] [126/133] (361s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[682.538429] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[682.606315] [127/133] (361s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[682.701859] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[682.703822] Starting dynamic subtest: pipe-A-default-mode
[683.866786] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[683.875339] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.161s)
[684.015069] [128/133] (360s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[684.111069] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[684.121794] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[684.202422] [129/133] (360s left) gem_exercise_blt (fast-copy-emit)
[684.262924] Starting subtest: fast-copy-emit
[684.265384] Starting dynamic subtest: linear-smem-smem-emit
[684.287662] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[684.300040] Starting dynamic subtest: xmajor-smem-smem-emit
[684.306770] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[684.318254] Starting dynamic subtest: tile4-smem-smem-emit
[684.323831] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[684.336391] Starting dynamic subtest: tile64-smem-smem-emit
[684.341721] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[684.343925] Subtest fast-copy-emit: SUCCESS (0.079s)
[684.455926] [130/133] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[684.563044] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[684.567109] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[684.663079] [131/133] (359s left) i915_drm_fdinfo (virtual-busy-hang)
[684.707423] Starting subtest: virtual-busy-hang
[684.711739] Subtest virtual-busy-hang: SKIP (0.000s)
[684.786524] [132/133] (359s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[684.887206] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[684.890935] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[684.969899] [133/133] (359s left) gem_mmap_gtt (big-bo-tiledy)
[685.032936] Subtest big-bo-tiledY: SKIP (0.000s)
[685.089662] Closing watchdogs
results: parsing output: 0/ for test: kms_sequence
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: kms_chamelium_frames
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: drm_read
results: parsing output: 8/ for test: fbdev
results: parsing output: 9/ for test: kms_chamelium_color
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_create
results: parsing output: 14/ for test: gem_pxp
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_joiner
results: parsing output: 27/ for test: gem_readwrite
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_atomic_transition
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_cursor_edge_walk
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_plane_lowres
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_pipe_crc_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: i915_pm_rpm
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: gem_lmem_swapping
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_render_copy_redux
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_sync
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: sysfs_heartbeat_interval
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: core_sysfs
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: prime_self_import
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_ctx_isolation
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_ctx_shared
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_exec_create
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: i915_pciid
results: parsing output: 124/ for test: kms_atomic_transition
results: parsing output: 125/ for test: kms_pipe_b_c_ivb
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exercise_blt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: i915_drm_fdinfo
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: gem_mmap_gtt
Done.