[58.639344] Initializing watchdogs
[58.639391]   /dev/watchdog0
[58.652698] [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]
[58.656857] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.658899] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.662176] [001/132] (960s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[58.806952] Starting subtest: basic-flip-after-cursor-legacy
[59.774403] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.973s)
[60.598759] [002/132] (958s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[60.692898] Starting subtest: read-crc-frame-sequence
[60.695393] Starting dynamic subtest: pipe-A-eDP-1
[61.406793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[61.416871] Starting dynamic subtest: pipe-B-eDP-1
[62.790376] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[62.799266] Starting dynamic subtest: pipe-C-eDP-1
[64.140554] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s)
[64.149645] Starting dynamic subtest: pipe-D-eDP-1
[65.463635] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[65.466099] Subtest read-crc-frame-sequence: SUCCESS (4.788s)
[66.300954] [003/132] (952s left) gem_lmem_swapping (massive)
[66.361578] Subtest massive: SKIP (0.000s)
[66.402180] [004/132] (952s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[66.462310] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[66.464717] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[66.576426] [005/132] (952s left) core_getversion (basic)
[66.613285] Starting subtest: basic
[66.617779] Subtest basic: SUCCESS (0.000s)
[66.675725] [006/132] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[66.815685] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[73.714987] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.911s)
[73.847867] [007/132] (945s left) syncobj_wait (invalid-signal-illegal-handle)
[73.910638] Starting subtest: invalid-signal-illegal-handle
[73.913196] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[73.990635] [008/132] (945s left) gem_mmap (bad-offset)
[74.046432] Subtest bad-offset: SKIP (0.000s)
[74.099207] [009/132] (945s left) gen9_exec_parse (unaligned-jump)
[74.157423] Subtest unaligned-jump: SKIP (0.000s)
[74.237868] [010/132] (945s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[74.352382] Starting subtest: 4-tiled-16bpp-rotate-270
[74.371934] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[74.495029] [011/132] (945s left) kms_big_fb (linear-64bpp-rotate-180)
[74.601672] Starting subtest: linear-64bpp-rotate-180
[76.112334] Subtest linear-64bpp-rotate-180: SUCCESS (1.511s)
[76.283160] [012/132] (943s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[76.422236] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[87.618273] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.194s)
[88.455872] [013/132] (931s left) i915_pm_rpm (system-suspend-execbuf)
[89.985502] Starting subtest: system-suspend-execbuf
[152.035449] Subtest system-suspend-execbuf: SUCCESS (47.391s)
[152.402530] [014/132] (867s left) perf_pmu (init-wait)
[152.459532] Starting subtest: init-wait
[152.461988] Starting dynamic subtest: rcs0
[152.464392] Dynamic subtest rcs0: SUCCESS (0.002s)
[152.473775] Starting dynamic subtest: bcs0
[152.476084] Dynamic subtest bcs0: SUCCESS (0.000s)
[152.486962] Starting dynamic subtest: vcs0
[152.488932] Dynamic subtest vcs0: SUCCESS (0.001s)
[152.496081] Starting dynamic subtest: vcs1
[152.498064] Dynamic subtest vcs1: SUCCESS (0.001s)
[152.505605] Starting dynamic subtest: vecs0
[152.507870] Dynamic subtest vecs0: SUCCESS (0.000s)
[152.515228] Starting dynamic subtest: ccs0
[152.517359] Dynamic subtest ccs0: SUCCESS (0.001s)
[152.519526] Subtest init-wait: SUCCESS (0.007s)
[152.564509] [015/132] (867s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[152.658104] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[152.660386] Starting dynamic subtest: pipe-A-eDP-1
[152.717835] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[152.727220] Starting dynamic subtest: pipe-B-eDP-1
[152.784356] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[152.794316] Starting dynamic subtest: pipe-C-eDP-1
[152.851801] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[152.860821] Starting dynamic subtest: pipe-D-eDP-1
[152.919619] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[152.924288] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[154.958341] [016/132] (864s left) gem_busy (close-race)
[155.035940] Starting subtest: close-race
[180.748887] Subtest close-race: SUCCESS (25.717s)
[181.113915] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[181.118413] [017/132] (838s left) syncobj_timeline (wait-any-complex)
[181.233576] Starting subtest: wait-any-complex
[181.294458] Subtest wait-any-complex: SUCCESS (0.064s)
[181.389636] [018/132] (838s left) gem_ringfill (basic-all)
[185.811642] Starting subtest: basic-all
[186.960345] Subtest basic-all: SUCCESS (1.151s)
[187.077220] [019/132] (832s left) gem_eio (wait-wedge-immediate)
[187.302972] Starting subtest: wait-wedge-immediate
[188.913301] Subtest wait-wedge-immediate: SUCCESS (1.611s)
[189.049346] [020/132] (830s left) gem_softpin (evict-prime)
[189.108051] Starting subtest: evict-prime
[189.110175] Starting dynamic subtest: rcs0
[190.273271] Dynamic subtest rcs0: SUCCESS (1.166s)
[190.285599] Starting dynamic subtest: bcs0
[191.392670] Dynamic subtest bcs0: SUCCESS (1.118s)
[191.403206] Starting dynamic subtest: vcs0
[192.772997] Dynamic subtest vcs0: SUCCESS (1.379s)
[192.785007] Starting dynamic subtest: vcs1
[194.771264] Dynamic subtest vcs1: SUCCESS (1.996s)
[194.783199] Starting dynamic subtest: vecs0
[196.749391] Dynamic subtest vecs0: SUCCESS (1.977s)
[196.765491] Starting dynamic subtest: ccs0
[197.864539] Dynamic subtest ccs0: SUCCESS (1.115s)
[197.873937] Starting dynamic subtest: all
[199.757539] Dynamic subtest all: SUCCESS (1.890s)
[199.760633] Subtest evict-prime: SUCCESS (10.653s)
[199.838461] [021/132] (820s left) api_intel_bb (destroy-bb)
[199.925791] Starting subtest: destroy-bb
[199.950868] Subtest destroy-bb: SUCCESS (0.024s)
[200.074274] [022/132] (819s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[200.141224] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[200.143505] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[200.237845] [023/132] (819s left) kms_joiner (basic-force-ultra-joiner)
[200.338427] Starting subtest: basic-force-ultra-joiner
[200.342714] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[200.407159] [024/132] (819s left) syncobj_timeline (wait-zero-handles)
[200.461425] Starting subtest: wait-zero-handles
[200.463662] Subtest wait-zero-handles: SUCCESS (0.000s)
[200.554104] [025/132] (819s left) syncobj_timeline (etime-single-wait-submitted)
[200.615370] Starting subtest: etime-single-wait-submitted
[200.719919] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[200.809302] [026/132] (819s left) gem_exec_whisper (basic-fds)
[200.868695] Starting subtest: basic-fds
[208.809733] Subtest basic-fds: SUCCESS (7.937s)
[208.989687] [027/132] (811s left) gem_exec_schedule (fifo)
[209.067978] Starting subtest: fifo
[209.070264] Starting dynamic subtest: rcs0
[209.215651] Dynamic subtest rcs0: SUCCESS (0.156s)
[209.229071] Starting dynamic subtest: vcs0
[209.316630] Dynamic subtest vcs0: SUCCESS (0.100s)
[209.329321] Starting dynamic subtest: vcs1
[209.419757] Dynamic subtest vcs1: SUCCESS (0.102s)
[209.432063] Starting dynamic subtest: vecs0
[209.529515] Dynamic subtest vecs0: SUCCESS (0.109s)
[209.541671] Starting dynamic subtest: ccs0
[209.666464] Dynamic subtest ccs0: SUCCESS (0.134s)
[209.669076] Subtest fifo: SUCCESS (0.606s)
[210.931161] [028/132] (809s left) gem_exec_reloc (basic-gtt-active)
[210.995535] Subtest basic-gtt-active: SKIP (0.000s)
[211.058357] [029/132] (809s left) kms_flip (flip-vs-suspend)
[211.150848] Starting subtest: flip-vs-suspend
[211.153365] Starting dynamic subtest: A-eDP1
[245.083580] Dynamic subtest A-eDP1: SUCCESS (3.699s)
[245.097647] Starting dynamic subtest: B-eDP1
[294.093067] Dynamic subtest B-eDP1: SUCCESS (4.485s)
[294.104274] Starting dynamic subtest: C-eDP1
[343.075251] Dynamic subtest C-eDP1: SUCCESS (4.540s)
[343.086385] Starting dynamic subtest: D-eDP1
[392.068210] Dynamic subtest D-eDP1: SUCCESS (4.559s)
[392.070883] Subtest flip-vs-suspend: SUCCESS (17.292s)
[393.225775] [030/132] (627s left) kms_cursor_edge_walk (64x64-left-edge)
[393.321126] Starting subtest: 64x64-left-edge
[393.323677] Starting dynamic subtest: pipe-A-eDP-1
[396.720845] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[396.731466] Starting dynamic subtest: pipe-D-eDP-1
[400.536522] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.861s)
[400.538900] Subtest 64x64-left-edge: SUCCESS (7.334s)
[400.881076] [031/132] (619s left) gem_wait (invalid-flags)
[400.939774] Starting subtest: invalid-flags
[400.942452] Subtest invalid-flags: SUCCESS (0.000s)
[401.171130] [032/132] (619s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[401.268807] Starting subtest: psr-indfb-scaledprimary
[406.998074] Subtest psr-indfb-scaledprimary: SUCCESS (5.770s)
[407.110403] [033/132] (613s left) gen9_exec_parse (batch-zero-length)
[407.167865] Subtest batch-zero-length: SKIP (0.000s)
[407.230883] [034/132] (613s left) gem_ctx_persistence (engines-hostile)
[407.293727] Starting subtest: engines-hostile
[407.296295] Starting dynamic subtest: rcs0
[407.381339] Dynamic subtest rcs0: SUCCESS (0.088s)
[407.393097] Starting dynamic subtest: bcs0
[407.481446] Dynamic subtest bcs0: SUCCESS (0.098s)
[407.494133] Starting dynamic subtest: vcs0
[407.592297] Dynamic subtest vcs0: SUCCESS (0.109s)
[407.605395] Starting dynamic subtest: vcs1
[407.685373] Dynamic subtest vcs1: SUCCESS (0.091s)
[407.698165] Starting dynamic subtest: vecs0
[407.782135] Dynamic subtest vecs0: SUCCESS (0.095s)
[407.795753] Starting dynamic subtest: ccs0
[407.881968] Dynamic subtest ccs0: SUCCESS (0.098s)
[407.884736] Subtest engines-hostile: SUCCESS (0.592s)
[407.974196] [035/132] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[408.071100] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[408.075206] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[408.175778] [036/132] (612s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[408.290005] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[408.294638] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[408.386425] [037/132] (612s left) gem_userptr_blits (probe)
[408.456848] Starting subtest: probe
[408.528830] Subtest probe: SUCCESS (0.072s)
[408.646230] [038/132] (612s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[408.735087] Starting subtest: multiplane-rotation-cropping-bottom
[426.133223] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.426s)
[426.238762] [039/132] (594s left) kms_universal_plane (universal-plane-sanity)
[426.338121] Starting subtest: universal-plane-sanity
[426.340521] Starting dynamic subtest: pipe-A-eDP-1
[426.942883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[426.952803] Starting dynamic subtest: pipe-B-eDP-1
[428.149424] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[428.159998] Starting dynamic subtest: pipe-C-eDP-1
[429.361901] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[429.372779] Starting dynamic subtest: pipe-D-eDP-1
[430.592335] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[430.594857] Subtest universal-plane-sanity: SUCCESS (4.256s)
[431.450452] [040/132] (589s left) kms_prime (basic-modeset-hybrid)
[431.536849] Subtest basic-modeset-hybrid: SKIP (0.000s)
[431.630408] [041/132] (589s left) syncobj_timeline (device-signal-unordered)
[431.698938] Starting subtest: device-signal-unordered
[431.701785] Subtest device-signal-unordered: SUCCESS (0.001s)
[431.805097] [042/132] (589s left) gem_exec_balancer (full-late)
[431.861758] Starting subtest: full-late
[436.402564] Subtest full-late: SUCCESS (4.543s)
[436.713750] [043/132] (584s left) prime_vgem (fence-flip-hang)
[436.794739] Subtest fence-flip-hang: SKIP (0.000s)
[436.898876] [044/132] (584s left) i915_hangman (error-state-basic)
[436.973615] Starting subtest: error-state-basic
[437.132981] Subtest error-state-basic: SUCCESS (0.161s)
[437.216472] [045/132] (583s left) i915_suspend (sysfs-reader)
[437.280847] Starting subtest: sysfs-reader
[456.063000] Subtest sysfs-reader: SUCCESS (3.151s)
[456.111241] [046/132] (564s left) kms_pwrite_crc
[457.697956] [047/132] (563s left) gem_unref_active_buffers
[457.901142] [048/132] (563s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[457.999167] Starting subtest: drrs-dirtyfb-ioctl
[458.013525] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[458.107792] [049/132] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[458.199262] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[458.204251] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[458.294222] [050/132] (562s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[458.400126] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[462.277300] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.947s)
[463.386897] [051/132] (557s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[463.484498] Starting subtest: y-tiled-32bpp-rotate-180
[463.489443] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[463.584285] [052/132] (557s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[463.681119] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[463.683684] Starting dynamic subtest: pipe-A-eDP-1
[463.694017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.705672] Starting dynamic subtest: pipe-B-eDP-1
[463.715727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.726190] Starting dynamic subtest: pipe-C-eDP-1
[463.736195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.746250] Starting dynamic subtest: pipe-D-eDP-1
[463.756884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.761912] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[465.907062] [053/132] (555s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[465.965007] Starting subtest: multi-wait-for-submit-submitted-signaled
[465.967201] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[466.061803] [054/132] (555s left) kms_frontbuffer_tracking (fbc-stridechange)
[466.156153] Starting subtest: fbc-stridechange
[469.389437] Subtest fbc-stridechange: SUCCESS (3.259s)
[470.521849] [055/132] (550s left) gem_ccs (ctrl-surf-copy-new-ctx)
[470.580707] Starting subtest: ctrl-surf-copy-new-ctx
[470.585857] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[470.695170] [056/132] (550s left) kms_pipe_crc_basic (bad-source)
[470.785281] Starting subtest: bad-source
[470.787651] Subtest bad-source: SUCCESS (0.000s)
[470.854243] [057/132] (550s left) kms_flip (dpms-off-confusion-interruptible)
[470.940031] Starting subtest: dpms-off-confusion-interruptible
[470.942332] Starting dynamic subtest: A-eDP1
[479.606117] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[479.617496] Starting dynamic subtest: B-eDP1
[488.236241] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[488.247508] Starting dynamic subtest: C-eDP1
[496.844415] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[496.854433] Starting dynamic subtest: D-eDP1
[505.470080] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[505.473001] Subtest dpms-off-confusion-interruptible: SUCCESS (34.579s)
[506.639790] [058/132] (514s left) gem_compute (compute-square)
[506.703136] Starting subtest: compute-square
[506.708701] Subtest compute-square: SUCCESS (0.006s)
[506.824044] [059/132] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[506.928837] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[514.240213] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.319s)
[514.386773] [060/132] (507s left) kms_plane (plane-position-covered)
[514.489326] Starting subtest: plane-position-covered
[514.994979] Starting dynamic subtest: pipe-A-plane-1
[516.356271] Dynamic subtest pipe-A-plane-1: SUCCESS (1.361s)
[516.369010] Starting dynamic subtest: pipe-A-plane-2
[517.672441] Dynamic subtest pipe-A-plane-2: SUCCESS (1.318s)
[517.683737] Starting dynamic subtest: pipe-A-plane-3
[518.970977] Dynamic subtest pipe-A-plane-3: SUCCESS (1.297s)
[518.982223] Starting dynamic subtest: pipe-A-plane-4
[520.195990] Dynamic subtest pipe-A-plane-4: SUCCESS (1.223s)
[520.206287] Starting dynamic subtest: pipe-A-plane-5
[520.221706] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[521.350200] Starting dynamic subtest: pipe-B-plane-1
[522.618460] Dynamic subtest pipe-B-plane-1: SUCCESS (1.276s)
[522.629162] Starting dynamic subtest: pipe-B-plane-2
[523.917282] Dynamic subtest pipe-B-plane-2: SUCCESS (1.295s)
[523.927890] Starting dynamic subtest: pipe-B-plane-3
[525.179216] Dynamic subtest pipe-B-plane-3: SUCCESS (1.259s)
[525.189770] Starting dynamic subtest: pipe-B-plane-4
[526.500465] Dynamic subtest pipe-B-plane-4: SUCCESS (1.323s)
[526.514068] Starting dynamic subtest: pipe-B-plane-5
[526.529802] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[526.532268] Subtest plane-position-covered: SUCCESS (12.039s)
[527.373700] [061/132] (494s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[527.471860] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[527.474261] Starting dynamic subtest: pipe-A-eDP-1
[527.495890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[527.507788] Starting dynamic subtest: pipe-B-eDP-1
[527.529967] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[527.540019] Starting dynamic subtest: pipe-C-eDP-1
[527.563007] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[527.574955] Starting dynamic subtest: pipe-D-eDP-1
[527.597482] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[527.599924] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[529.638765] [062/132] (492s left) kms_atomic_transition (modeset-transition)
[529.734190] Starting subtest: modeset-transition
[529.736388] Starting dynamic subtest: 1x-outputs
[540.576592] Dynamic subtest 1x-outputs: SUCCESS (10.838s)
[540.579470] Subtest modeset-transition: SUCCESS (10.840s)
[541.435181] [063/132] (480s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[541.524164] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[541.550258] Starting dynamic subtest: pipe-A-plane-0
[541.982769] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[541.993421] Starting dynamic subtest: pipe-A-plane-3
[542.249231] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[542.259760] Starting dynamic subtest: pipe-A-plane-5
[542.264360] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[543.317985] Starting dynamic subtest: pipe-B-plane-0
[543.754323] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[543.764891] Starting dynamic subtest: pipe-B-plane-3
[544.010205] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[544.020635] Starting dynamic subtest: pipe-B-plane-5
[544.025185] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[544.326022] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.801s)
[545.194017] [064/132] (476s left) kms_flip (plain-flip-ts-check)
[545.296792] Starting subtest: plain-flip-ts-check
[545.299232] Starting dynamic subtest: A-eDP1
[554.188134] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[554.197891] Starting dynamic subtest: B-eDP1
[563.024161] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[563.034128] Starting dynamic subtest: C-eDP1
[571.861388] Dynamic subtest C-eDP1: SUCCESS (8.836s)
[571.877344] Starting dynamic subtest: D-eDP1
[580.686947] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[580.692837] Subtest plain-flip-ts-check: SUCCESS (35.398s)
[581.853277] [065/132] (439s left) gem_exec_fence (basic-await)
[582.051948] Starting subtest: basic-await
[582.054921] Starting dynamic subtest: rcs0
[582.127749] Dynamic subtest rcs0: SUCCESS (0.076s)
[582.141986] Starting dynamic subtest: bcs0
[582.201429] Dynamic subtest bcs0: SUCCESS (0.072s)
[582.214733] Starting dynamic subtest: vcs0
[582.276134] Dynamic subtest vcs0: SUCCESS (0.073s)
[582.289003] Starting dynamic subtest: vcs1
[582.348022] Dynamic subtest vcs1: SUCCESS (0.071s)
[582.361931] Starting dynamic subtest: vecs0
[582.422454] Dynamic subtest vecs0: SUCCESS (0.073s)
[582.434985] Starting dynamic subtest: ccs0
[582.495338] Dynamic subtest ccs0: SUCCESS (0.071s)
[582.498199] Subtest basic-await: SUCCESS (0.446s)
[584.270655] [066/132] (437s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[584.361237] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[584.366475] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[584.459006] [067/132] (437s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[584.580023] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[585.214428] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[585.380369] [068/132] (436s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[585.474090] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[585.479308] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[585.564015] [069/132] (436s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[585.673995] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[585.678438] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[585.744997] [070/132] (436s left) kms_rotation_crc (bad-pixel-format)
[585.840227] Starting subtest: bad-pixel-format
[585.845244] Subtest bad-pixel-format: SKIP (0.001s)
[585.914377] [071/132] (436s left) gem_exec_reloc (basic-write-cpu)
[585.970178] Subtest basic-write-cpu: SKIP (0.000s)
[586.038374] [072/132] (436s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[586.129134] Starting subtest: x-tiled-64bpp-rotate-180
[587.646284] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.512s)
[587.801422] [073/132] (434s left) kms_addfb_basic (bad-pitch-63)
[587.854722] Starting subtest: bad-pitch-63
[587.857330] Subtest bad-pitch-63: SUCCESS (0.000s)
[587.991214] [074/132] (434s left) kms_psr (fbc-pr-sprite-plane-move)
[588.074130] Starting subtest: fbc-pr-sprite-plane-move
[588.078824] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[588.150370] [075/132] (434s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[588.242825] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[588.245102] Starting dynamic subtest: pipe-A-eDP-1
[589.464339] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.221s)
[589.475367] Starting dynamic subtest: pipe-B-eDP-1
[591.748933] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.284s)
[591.760906] Starting dynamic subtest: pipe-C-eDP-1
[593.986182] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.236s)
[593.997349] Starting dynamic subtest: pipe-D-eDP-1
[596.241944] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[596.244671] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.001s)
[597.395954] [076/132] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[597.496668] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[597.501471] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[597.592748] [077/132] (424s left) kms_vblank (ts-continuation-dpms-suspend)
[597.678020] Starting subtest: ts-continuation-dpms-suspend
[597.680436] Starting dynamic subtest: pipe-A-eDP-1
[614.635760] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.844s)
[614.650151] Starting dynamic subtest: pipe-D-eDP-1
[632.596275] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.485s)
[632.598964] Subtest ts-continuation-dpms-suspend: SUCCESS (4.335s)
[633.402304] [078/132] (388s left) kms_addfb_basic (bad-pitch-32)
[633.459446] Starting subtest: bad-pitch-32
[633.461333] Subtest bad-pitch-32: SUCCESS (0.000s)
[633.606702] [079/132] (388s left) sw_sync (sync_busy)
[633.644393] Starting subtest: sync_busy
[633.646570] Subtest sync_busy: SUCCESS (0.002s)
[633.700090] [080/132] (388s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[633.790333] Starting subtest: fbcpsr-modesetfrombusy
[639.841099] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.156s)
[639.980370] [081/132] (382s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[640.100058] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[657.529228] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.507s)
[658.335205] [082/132] (364s left) kms_flip (2x-flip-vs-rmfb)
[658.430516] Starting subtest: 2x-flip-vs-rmfb
[658.438623] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[658.520206] [083/132] (364s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[658.613061] Starting subtest: yf-tiled-64bpp-rotate-90
[658.617298] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[658.722685] [084/132] (363s left) prime_busy (before-wait)
[658.773446] Starting subtest: before-wait
[658.775733] Starting dynamic subtest: rcs0
[658.804532] Dynamic subtest rcs0: SUCCESS (0.031s)
[658.816518] Starting dynamic subtest: bcs0
[658.844370] Dynamic subtest bcs0: SUCCESS (0.038s)
[658.853783] Starting dynamic subtest: vcs0
[658.882614] Dynamic subtest vcs0: SUCCESS (0.038s)
[658.891944] Starting dynamic subtest: vcs1
[658.922339] Dynamic subtest vcs1: SUCCESS (0.039s)
[658.931584] Starting dynamic subtest: vecs0
[658.961195] Dynamic subtest vecs0: SUCCESS (0.038s)
[658.970428] Starting dynamic subtest: ccs0
[658.999959] Dynamic subtest ccs0: SUCCESS (0.038s)
[659.109001] Subtest before-wait: SUCCESS (0.337s)
[659.185450] [085/132] (363s left) kms_flip (modeset-vs-vblank-race)
[659.284467] Starting subtest: modeset-vs-vblank-race
[659.286780] Starting dynamic subtest: A-eDP1
[663.943965] Dynamic subtest A-eDP1: SUCCESS (4.661s)
[663.958730] Starting dynamic subtest: B-eDP1
[668.666478] Dynamic subtest B-eDP1: SUCCESS (4.718s)
[668.680448] Starting dynamic subtest: C-eDP1
[673.370984] Dynamic subtest C-eDP1: SUCCESS (4.699s)
[673.382863] Starting dynamic subtest: D-eDP1
[678.001715] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[678.004000] Subtest modeset-vs-vblank-race: SUCCESS (18.717s)
[679.279448] [086/132] (343s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[679.380782] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[679.384776] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[679.452439] [087/132] (343s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[679.533279] Starting subtest: fbc-pr-cursor-mmap-cpu
[679.537736] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[679.605298] [088/132] (343s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[679.661894] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[679.663900] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[679.753601] [089/132] (343s left) kms_chamelium_frames (dp-crc-fast)
[680.130454] Subtest dp-crc-fast: SKIP (0.000s)
[680.970852] [090/132] (341s left) i915_query (query-topology-kernel-writes)
[681.028450] Starting subtest: query-topology-kernel-writes
[681.030789] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[681.142576] [091/132] (341s left) gem_mmap_offset (partial-unmap)
[681.203806] Starting subtest: partial-unmap
[681.206155] Starting dynamic subtest: smem0
[681.716402] Dynamic subtest smem0: SUCCESS (0.513s)
[681.719187] Subtest partial-unmap: SUCCESS (0.514s)
[681.830763] [092/132] (341s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[681.875001] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[681.877349] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[681.968658] [093/132] (341s left) kms_plane_multiple (2x-tiling-y)
[682.060974] Starting subtest: 2x-tiling-y
[682.064850] Subtest 2x-tiling-y: SKIP (0.000s)
[682.151257] [094/132] (340s left) gem_exec_schedule (submit-golden-slice)
[682.226808] Starting subtest: submit-golden-slice
[682.229330] Starting dynamic subtest: rcs0
[682.254630] Dynamic subtest rcs0: SUCCESS (0.036s)
[682.267406] Starting dynamic subtest: bcs0
[682.290243] Dynamic subtest bcs0: SUCCESS (0.035s)
[682.300835] Starting dynamic subtest: vcs0
[682.332195] Dynamic subtest vcs0: SUCCESS (0.041s)
[682.345766] Starting dynamic subtest: vcs1
[682.366014] Dynamic subtest vcs1: SUCCESS (0.033s)
[682.377990] Starting dynamic subtest: vecs0
[682.393383] Dynamic subtest vecs0: SUCCESS (0.027s)
[682.403880] Starting dynamic subtest: ccs0
[682.428557] Dynamic subtest ccs0: SUCCESS (0.034s)
[682.430855] Subtest submit-golden-slice: SUCCESS (0.211s)
[683.927520] [095/132] (339s left) kms_color_pipeline (plane-lut1d)
[684.022748] Starting subtest: plane-lut1d
[684.191029] Starting dynamic subtest: pipe-A-plane-0
[684.357211] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[684.367918] Starting dynamic subtest: pipe-A-plane-1
[684.535435] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[684.546058] Starting dynamic subtest: pipe-A-plane-2
[684.668767] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[685.882281] Starting dynamic subtest: pipe-B-plane-0
[686.028987] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[686.039190] Starting dynamic subtest: pipe-B-plane-1
[686.162660] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[686.173207] Starting dynamic subtest: pipe-B-plane-2
[686.295721] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[687.507235] Starting dynamic subtest: pipe-C-plane-0
[687.665614] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[687.676410] Starting dynamic subtest: pipe-C-plane-1
[687.798693] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[687.809260] Starting dynamic subtest: pipe-C-plane-2
[687.965672] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[689.127183] Starting dynamic subtest: pipe-D-plane-0
[689.263218] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[689.273937] Starting dynamic subtest: pipe-D-plane-1
[689.396252] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[689.406905] Starting dynamic subtest: pipe-D-plane-2
[689.540623] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[689.828107] Subtest plane-lut1d: SUCCESS (5.807s)
[690.702977] [096/132] (332s left) gem_softpin (noreloc-interruptible)
[690.770612] Starting subtest: noreloc-interruptible
[696.178217] Subtest noreloc-interruptible: SUCCESS (5.407s)
[696.325109] [097/132] (326s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[696.420198] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[696.424794] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[697.542965] [098/132] (325s left) kms_cursor_crc (cursor-random-256x256)
[697.790414] Starting subtest: cursor-random-256x256
[697.795456] Starting dynamic subtest: pipe-A-eDP-1
[701.124876] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.329s)
[701.157667] Starting dynamic subtest: pipe-D-eDP-1
[705.117558] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.974s)
[705.119455] Subtest cursor-random-256x256: SUCCESS (7.327s)
[705.996634] [099/132] (317s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[706.101444] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[710.065892] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.969s)
[711.220893] [100/132] (312s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[711.307302] Starting subtest: basic-modeset-with-all-modifiers-formats
[711.680957] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[712.483829] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.803s)
[712.493989] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[712.506005] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[712.519043] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[712.528812] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[712.538343] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[712.672697] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[712.684882] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[712.694648] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[712.704489] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[712.716961] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[712.726578] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[712.739189] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[712.752638] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[712.761476] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.019s)
[712.771232] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[712.783763] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[712.795194] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[712.805852] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[712.815091] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[712.827710] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[712.837166] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[712.850256] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[712.859558] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[713.005794] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[713.019809] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[713.027979] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[713.039016] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[713.050248] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[713.059583] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[713.072448] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[713.081791] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[713.094619] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[713.103893] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[713.116936] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[713.126416] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[713.139199] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[713.148553] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[713.161203] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[713.170649] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[713.183577] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[713.193185] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[713.339497] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[713.350289] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[713.361466] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[713.371131] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[713.383858] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[713.394347] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[713.406173] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[713.421176] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[713.428516] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[713.438334] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[713.450388] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[713.460201] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[713.472205] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[713.481960] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[713.494582] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[713.504205] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[713.516600] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[713.899704] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.593s)
[714.657874] [101/132] (308s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[714.772956] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[714.776925] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[714.877544] [102/132] (308s left) gem_pxp (verify-pxp-stale-buf-execution)
[715.002952] Starting subtest: verify-pxp-stale-buf-execution
[716.062960] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[716.200279] [103/132] (307s left) kms_psr (pr-sprite-plane-onoff)
[716.302363] Starting subtest: pr-sprite-plane-onoff
[716.306314] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[716.380341] [104/132] (307s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[716.480960] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[724.010467] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.534s)
[724.133958] [105/132] (299s left) kms_pm_rpm (cursor-dpms)
[725.970434] Starting subtest: cursor-dpms
[725.975408] Subtest cursor-dpms: SKIP (0.000s)
[726.392847] [106/132] (297s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[726.494700] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[730.184810] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.692s)
[731.388596] [107/132] (292s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[731.449312] Starting subtest: legacy-engines-hostile-preempt
[731.451270] Starting dynamic subtest: render
[731.508919] Dynamic subtest render: SUCCESS (0.062s)
[731.527013] Starting dynamic subtest: bsd1
[732.857728] Dynamic subtest bsd1: SUCCESS (1.345s)
[732.871078] Starting dynamic subtest: bsd2
[734.823003] Dynamic subtest bsd2: SUCCESS (1.961s)
[734.839664] Starting dynamic subtest: blt
[734.902367] Dynamic subtest blt: SUCCESS (0.078s)
[734.920017] Starting dynamic subtest: vebox
[736.806352] Dynamic subtest vebox: SUCCESS (1.899s)
[736.809137] Subtest legacy-engines-hostile-preempt: SUCCESS (5.357s)
[736.945132] [108/132] (286s left) gem_exec_schedule (preempt)
[737.009028] Starting subtest: preempt
[737.010969] Starting dynamic subtest: rcs0
[737.034278] Dynamic subtest rcs0: SUCCESS (0.032s)
[737.047998] Starting dynamic subtest: bcs0
[737.065895] Dynamic subtest bcs0: SUCCESS (0.031s)
[737.076795] Starting dynamic subtest: vcs0
[737.099875] Dynamic subtest vcs0: SUCCESS (0.033s)
[737.115189] Starting dynamic subtest: vcs1
[737.129399] Dynamic subtest vcs1: SUCCESS (0.028s)
[737.139692] Starting dynamic subtest: vecs0
[737.152333] Dynamic subtest vecs0: SUCCESS (0.022s)
[737.162388] Starting dynamic subtest: ccs0
[737.184183] Dynamic subtest ccs0: SUCCESS (0.031s)
[737.186422] Subtest preempt: SUCCESS (0.183s)
[738.902804] [109/132] (284s left) gem_mmap_gtt (basic-small-copy)
[738.968616] Subtest basic-small-copy: SKIP (0.000s)
[739.038360] [110/132] (284s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[739.143114] Starting subtest: fbc-psr2-sprite-plane-onoff
[739.145469] Starting dynamic subtest: eDP-1
[739.149903] Dynamic subtest eDP-1: SKIP (0.000s)
[739.154341] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[739.231667] [111/132] (284s left) kms_psr (psr-basic)
[739.322089] Starting subtest: psr-basic
[739.324367] Starting dynamic subtest: eDP-1
[740.950058] Dynamic subtest eDP-1: SUCCESS (1.626s)
[740.952367] Subtest psr-basic: SUCCESS (1.627s)
[741.827807] [112/132] (281s left) gem_exec_fence (syncobj-timeline-export)
[742.402868] Starting subtest: syncobj-timeline-export
[742.405287] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[743.881646] [113/132] (279s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[743.987207] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[743.991345] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[744.079288] [114/132] (279s left) kms_feature_discovery (dp-mst)
[744.174391] Starting subtest: dp-mst
[744.178604] Subtest dp-mst: SKIP (0.000s)
[744.248939] [115/132] (279s left) perf (global-sseu-config)
[744.369413] Starting subtest: global-sseu-config
[744.373074] Subtest global-sseu-config: SKIP (0.000s)
[744.410385] [116/132] (279s left) kms_addfb_basic (unused-handle)
[744.464767] Starting subtest: unused-handle
[744.466941] Subtest unused-handle: SUCCESS (0.000s)
[744.634780] [117/132] (279s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[744.779997] Starting subtest: dp-mst-lic-type-0-hdcp14
[744.784776] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[744.891928] [118/132] (279s left) kms_flip (2x-flip-vs-panning-vs-hang)
[744.980599] Starting subtest: 2x-flip-vs-panning-vs-hang
[744.991160] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[745.072363] [119/132] (279s left) kms_chamelium_hpd (vga-hpd)
[745.450954] Subtest vga-hpd: SKIP (0.000s)
[746.240129] [120/132] (277s left) gem_exec_async (forked-writes)
[746.296875] Starting subtest: forked-writes
[746.299403] Starting dynamic subtest: rcs0
[746.325819] Dynamic subtest rcs0: SUCCESS (0.029s)
[746.337515] Starting dynamic subtest: bcs0
[746.352182] Dynamic subtest bcs0: SUCCESS (0.025s)
[746.362754] Starting dynamic subtest: vcs0
[746.376664] Dynamic subtest vcs0: SUCCESS (0.024s)
[746.387204] Starting dynamic subtest: vcs1
[746.401475] Dynamic subtest vcs1: SUCCESS (0.024s)
[746.411940] Starting dynamic subtest: vecs0
[746.424922] Dynamic subtest vecs0: SUCCESS (0.023s)
[746.436723] Starting dynamic subtest: ccs0
[746.448133] Dynamic subtest ccs0: SUCCESS (0.022s)
[746.450372] Subtest forked-writes: SUCCESS (0.152s)
[746.682499] [121/132] (277s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[746.787539] Starting subtest: psr-farfromfence-mmap-gtt
[746.791997] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[746.880041] [122/132] (277s left) kms_cursor_crc (cursor-onscreen-32x10)
[747.029033] Starting subtest: cursor-onscreen-32x10
[747.085005] Subtest cursor-onscreen-32x10: SKIP (0.051s)
[747.337319] [123/132] (276s left) vgem_basic (dmabuf-fence)
[747.385410] Starting subtest: dmabuf-fence
[747.387728] Subtest dmabuf-fence: SUCCESS (0.001s)
[747.442033] [124/132] (276s left) gem_mmap_gtt (basic-read-write-distinct)
[747.492328] Subtest basic-read-write-distinct: SKIP (0.000s)
[747.560345] [125/132] (276s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[747.653882] Starting subtest: plane-upscale-20x20-with-modifiers
[747.655798] Starting dynamic subtest: pipe-A
[747.990468] Dynamic subtest pipe-A: SUCCESS (0.337s)
[748.002253] Starting dynamic subtest: pipe-B
[749.375542] Dynamic subtest pipe-B: SUCCESS (1.383s)
[749.386670] Starting dynamic subtest: pipe-C
[750.811320] Dynamic subtest pipe-C: SUCCESS (1.435s)
[750.822462] Starting dynamic subtest: pipe-D
[752.242431] Dynamic subtest pipe-D: SUCCESS (1.430s)
[752.244710] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.590s)
[753.426897] [126/132] (270s left) gem_mmap_gtt (basic-write-read)
[753.491799] Subtest basic-write-read: SKIP (0.000s)
[753.554207] [127/132] (270s left) api_intel_allocator (reopen-fork)
[753.607210] Starting subtest: reopen-fork
[757.081375] Subtest reopen-fork: SUCCESS (3.474s)
[757.176910] [128/132] (267s left) syncobj_basic (bad-flags-handle-to-fd)
[757.235699] Starting subtest: bad-flags-handle-to-fd
[757.237792] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[757.341406] [129/132] (267s left) kms_lease (possible-crtcs-filtering)
[757.441409] Starting subtest: possible-crtcs-filtering
[757.443698] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[757.555269] [130/132] (266s left) gem_pxp (create-regular-context-1)
[757.669851] Starting subtest: create-regular-context-1
[757.672213] Subtest create-regular-context-1: SUCCESS (0.002s)
[757.790681] [131/132] (266s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[757.886075] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[757.889881] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[757.965079] [132/132] (266s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[758.055814] Starting subtest: pipe-fbc-rte
[758.062685] Starting dynamic subtest: pipe-B-eDP-1
[763.494346] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.441s)
[763.501714] Subtest pipe-fbc-rte: SUCCESS (5.444s)
[765.740666] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_pipe_crc_basic
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: core_getversion
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_mmap
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: i915_pm_rpm
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_busy
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_ringfill
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: gem_softpin
results: parsing output: 20/ for test: api_intel_bb
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_joiner
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: gem_wait
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_universal_plane
results: parsing output: 39/ for test: kms_prime
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: i915_hangman
results: parsing output: 44/ for test: i915_suspend
results: parsing output: 45/ for test: kms_pwrite_crc
results: parsing output: 46/ for test: gem_unref_active_buffers
results: parsing output: 47/ for test: kms_dirtyfb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ccs
results: parsing output: 55/ for test: kms_pipe_crc_basic
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_compute
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_atomic_transition
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_rotation_crc
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: prime_busy
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_chamelium_frames
results: parsing output: 89/ for test: i915_query
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_plane_multiple
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_color_pipeline
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: gem_exec_async
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: vgem_basic
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: gem_pxp
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.