[58.671194] Initializing watchdogs
[58.671248]   /dev/watchdog0
[58.686083] [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.690547] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.692935] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.696264] [001/156] (960s left) vgem_basic (bad-pad)
[58.795966] Starting subtest: bad-pad
[58.798861] Subtest bad-pad: SUCCESS (0.000s)
[58.847825] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[58.850915] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[58.956109] Starting subtest: fbcpsr-rgb565-draw-render
[66.027064] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.004s)
[66.174736] [003/156] (953s left) kms_cursor_crc (cursor-sliding-64x21)
[66.363729] Starting subtest: cursor-sliding-64x21
[66.414465] Subtest cursor-sliding-64x21: SKIP (0.045s)
[66.635275] [004/156] (952s left) gen7_exec_parse (load-register-reg)
[66.694509] Subtest load-register-reg: SKIP (0.000s)
[66.776754] [005/156] (952s left) gem_ringfill (basic-all)
[72.323500] Starting subtest: basic-all
[73.513662] Subtest basic-all: SUCCESS (1.187s)
[73.700645] [006/156] (945s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[73.839781] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[73.844191] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[74.047442] [007/156] (945s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[74.141055] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[74.145289] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[74.209882] [008/156] (945s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[74.314148] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[74.318108] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[74.402352] [009/156] (945s left) kms_plane_alpha_blend (alpha-7efc)
[74.498628] Starting subtest: alpha-7efc
[74.776749] Starting dynamic subtest: pipe-A-eDP-1
[75.380883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[75.408332] Starting dynamic subtest: pipe-D-eDP-1
[76.710349] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[76.712826] Subtest alpha-7efc: SUCCESS (2.207s)
[77.553791] [010/156] (942s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[77.643718] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[77.646062] Starting dynamic subtest: pipe-A-eDP-1
[77.654686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[77.663737] Starting dynamic subtest: pipe-B-eDP-1
[77.672543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.682183] Starting dynamic subtest: pipe-C-eDP-1
[77.690580] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.698066] Starting dynamic subtest: pipe-D-eDP-1
[77.707364] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.711598] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[79.925389] [011/156] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[80.029167] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[80.033755] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[80.129561] [012/156] (939s left) gem_bad_reloc (negative-reloc-bltcopy)
[80.182034] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[80.269999] [013/156] (939s left) gem_mmap_offset (isolation)
[80.325867] Starting subtest: isolation
[80.343214] Subtest isolation: SUCCESS (0.009s)
[80.437163] [014/156] (939s left) gem_exec_balancer (nop)
[80.495781] Starting subtest: nop
[127.201471] Subtest nop: SUCCESS (46.689s)
[127.514824] [015/156] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[127.626772] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[135.349572] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.729s)
[135.458530] [016/156] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[135.550765] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[135.555340] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[135.645458] [017/156] (884s left) i915_pm_rps (thresholds-idle)
[135.700925] Starting subtest: thresholds-idle
[135.705453] Subtest thresholds-idle: SKIP (0.001s)
[135.798341] [018/156] (884s left) kms_joiner (basic-ultra-joiner)
[135.888430] Starting subtest: basic-ultra-joiner
[135.893062] Subtest basic-ultra-joiner: SKIP (0.000s)
[135.954234] [019/156] (884s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[136.047280] Starting subtest: sprite-rotation-90-pos-100-0
[136.052268] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[136.132752] [020/156] (883s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[136.216276] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[136.218599] Starting dynamic subtest: pipe-A-eDP-1
[136.276899] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[136.286185] Starting dynamic subtest: pipe-B-eDP-1
[136.333545] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[136.341551] Starting dynamic subtest: pipe-C-eDP-1
[136.389064] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[136.398137] Starting dynamic subtest: pipe-D-eDP-1
[136.446376] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[136.450061] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[138.473788] [021/156] (881s left) kms_psr (psr-primary-blt)
[138.576711] Starting subtest: psr-primary-blt
[138.579073] Starting dynamic subtest: eDP-1
[140.292755] Dynamic subtest eDP-1: SUCCESS (1.719s)
[140.295028] Subtest psr-primary-blt: SUCCESS (1.720s)
[141.168526] [022/156] (878s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[141.346374] Starting subtest: cursor-rapid-movement-64x64
[141.348715] Starting dynamic subtest: pipe-A-eDP-1
[141.899964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[141.924040] Starting dynamic subtest: pipe-D-eDP-1
[143.152033] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[143.154750] Subtest cursor-rapid-movement-64x64: SUCCESS (1.805s)
[144.018834] [023/156] (876s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[144.082302] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[144.084771] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[144.204121] [024/156] (875s left) syncobj_timeline (invalid-query-bad-pad)
[144.258308] Starting subtest: invalid-query-bad-pad
[144.260744] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[144.342968] [025/156] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[144.437748] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[144.442144] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[144.527675] [026/156] (875s left) gem_exec_reloc (basic-gtt-read-active)
[144.586466] Subtest basic-gtt-read-active: SKIP (0.000s)
[144.640697] [027/156] (875s left) kms_setmode (invalid-clone-single-crtc)
[144.684073] Starting subtest: invalid-clone-single-crtc
[144.690423] Subtest invalid-clone-single-crtc: SKIP (0.001s)
[144.778663] [028/156] (875s left) gem_lmem_swapping (massive)
[144.818316] Subtest massive: SKIP (0.000s)
[144.853491] [029/156] (875s left) gem_softpin (safe-alignment)
[144.918641] Starting subtest: safe-alignment
[144.945097] Subtest safe-alignment: SUCCESS (0.027s)
[146.346298] [030/156] (874s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[146.439106] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[146.443447] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[146.542699] [031/156] (873s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[146.655336] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[146.659577] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[146.752212] [032/156] (873s left) kms_plane_lowres (tiling-yf)
[146.859062] Starting subtest: tiling-yf
[146.863353] Subtest tiling-yf: SKIP (0.000s)
[146.931829] [033/156] (873s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[147.035784] Starting subtest: fbc-psr-sprite-mmap-cpu
[147.038160] Starting dynamic subtest: eDP-1
[147.042491] Dynamic subtest eDP-1: SKIP (0.000s)
[147.046767] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[147.109219] [034/156] (873s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[147.210581] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[147.212833] Starting dynamic subtest: pipe-A-eDP-1
[147.938163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[147.946058] Starting dynamic subtest: pipe-B-eDP-1
[149.731869] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s)
[149.741386] Starting dynamic subtest: pipe-C-eDP-1
[151.550184] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.817s)
[151.559895] Starting dynamic subtest: pipe-D-eDP-1
[153.385370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.835s)
[153.387726] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.169s)
[154.539728] [035/156] (866s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[154.642714] Starting subtest: bad-aux-stride-yf-tiled-ccs
[154.645026] Starting dynamic subtest: pipe-A-eDP-1
[154.667241] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.677283] Starting dynamic subtest: pipe-B-eDP-1
[154.699740] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.707736] Starting dynamic subtest: pipe-C-eDP-1
[154.728611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.736270] Starting dynamic subtest: pipe-D-eDP-1
[154.757223] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.761543] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[156.914247] [036/156] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[157.048265] Starting subtest: reject-modify-context-protection-off-2
[157.050977] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[157.161107] [037/156] (863s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[157.253082] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[157.255483] Starting dynamic subtest: pipe-A-eDP-1
[157.275804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[157.286654] Starting dynamic subtest: pipe-B-eDP-1
[157.306741] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[157.314617] Starting dynamic subtest: pipe-C-eDP-1
[157.334237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[157.342266] Starting dynamic subtest: pipe-D-eDP-1
[157.361898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[157.364110] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[159.583994] [038/156] (861s left) gem_lmem_swapping (random)
[159.632154] Subtest random: SKIP (0.000s)
[159.672359] [039/156] (861s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite)
[159.768919] Starting subtest: psrhdr-rgb565-draw-pwrite
[159.773144] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[159.870264] [040/156] (860s left) gem_exec_schedule (u-submit-early-slice)
[159.937917] Starting subtest: u-submit-early-slice
[159.940333] Starting dynamic subtest: rcs0
[159.967562] Dynamic subtest rcs0: SUCCESS (0.040s)
[159.977696] Starting dynamic subtest: bcs0
[160.005165] Dynamic subtest bcs0: SUCCESS (0.037s)
[160.013373] Starting dynamic subtest: vcs0
[160.044768] Dynamic subtest vcs0: SUCCESS (0.039s)
[160.056997] Starting dynamic subtest: vcs1
[160.078710] Dynamic subtest vcs1: SUCCESS (0.033s)
[160.090057] Starting dynamic subtest: vecs0
[160.116504] Dynamic subtest vecs0: SUCCESS (0.038s)
[160.125116] Starting dynamic subtest: ccs0
[160.154172] Dynamic subtest ccs0: SUCCESS (0.037s)
[160.156387] Subtest u-submit-early-slice: SUCCESS (0.227s)
[161.368740] [041/156] (859s left) kms_pm_dc (dc5-dpms)
[162.478085] Starting subtest: dc5-dpms
[164.556789] Subtest dc5-dpms: SUCCESS (2.079s)
[164.644652] [042/156] (856s left) syncobj_wait (single-wait-signaled)
[164.695526] Starting subtest: single-wait-signaled
[164.697847] Subtest single-wait-signaled: SUCCESS (0.000s)
[164.780129] [043/156] (856s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[164.878097] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[168.464871] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.592s)
[169.611680] [044/156] (851s left) gem_eio (banned)
[169.834535] Starting subtest: banned
[170.460080] Subtest banned: SUCCESS (0.625s)
[170.609168] [045/156] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[170.718174] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[177.243429] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.529s)
[177.379245] [046/156] (843s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[177.480353] Starting subtest: 2x-plain-flip-ts-check-interruptible
[177.492850] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[177.578312] [047/156] (843s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[177.696763] Starting subtest: basic-flip-after-cursor-legacy
[178.611849] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.911s)
[179.476929] [048/156] (841s left) kms_content_protection (atomic-dpms)
[179.611935] Starting subtest: atomic-dpms
[179.616667] Subtest atomic-dpms: SKIP (0.000s)
[179.750314] [049/156] (841s left) gem_exec_schedule (preempt-engines)
[179.816429] Starting subtest: preempt-engines
[179.818431] Starting dynamic subtest: rcs0
[182.060936] Dynamic subtest rcs0: SUCCESS (2.251s)
[182.069940] Starting dynamic subtest: bcs0
[184.324504] Dynamic subtest bcs0: SUCCESS (2.262s)
[184.333190] Starting dynamic subtest: vcs0
[186.608882] Dynamic subtest vcs0: SUCCESS (2.282s)
[186.621437] Starting dynamic subtest: vcs1
[188.884278] Dynamic subtest vcs1: SUCCESS (2.274s)
[188.894852] Starting dynamic subtest: vecs0
[191.160539] Dynamic subtest vecs0: SUCCESS (2.274s)
[191.171247] Starting dynamic subtest: ccs0
[193.483297] Dynamic subtest ccs0: SUCCESS (2.321s)
[193.485942] Subtest preempt-engines: SUCCESS (13.675s)
[193.788792] [050/156] (827s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[193.877636] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[193.879911] Starting dynamic subtest: pipe-A-eDP-1
[193.902587] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.912241] Starting dynamic subtest: pipe-B-eDP-1
[193.933328] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.941515] Starting dynamic subtest: pipe-C-eDP-1
[193.962678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.971100] Starting dynamic subtest: pipe-D-eDP-1
[193.993409] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.997527] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[196.157363] [051/156] (825s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[196.270701] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[196.275040] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[196.356908] [052/156] (824s left) gem_exec_fence (syncobj-unused-fence)
[196.794675] Starting subtest: syncobj-unused-fence
[196.799491] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[198.365595] [053/156] (822s left) kms_psr (psr-no-drrs)
[198.456109] Starting subtest: psr-no-drrs
[198.458383] Starting dynamic subtest: eDP-1
[200.119776] Dynamic subtest eDP-1: SUCCESS (1.664s)
[200.122618] Subtest psr-no-drrs: SUCCESS (1.665s)
[201.010623] [054/156] (820s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[201.118921] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[202.088159] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.969s)
[202.222383] [055/156] (819s left) kms_flip (2x-flip-vs-panning-interruptible)
[202.314216] Starting subtest: 2x-flip-vs-panning-interruptible
[202.326022] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[202.435262] [056/156] (819s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[202.543934] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite
[202.547578] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[202.634742] [057/156] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[202.723072] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[202.726902] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[202.819525] [058/156] (818s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[202.921133] Starting subtest: fbcpsr-suspend
[243.713176] Subtest fbcpsr-suspend: SUCCESS (10.235s)
[243.853037] [059/156] (777s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[243.928039] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[244.034410] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[244.117722] [060/156] (777s left) perf_pmu (all-busy-check-all)
[244.158395] Starting subtest: all-busy-check-all
[245.782542] Subtest all-busy-check-all: SUCCESS (1.584s)
[245.895540] [061/156] (775s left) prime_vgem (fence-wait)
[245.967702] Starting subtest: fence-wait
[245.970308] Starting dynamic subtest: rcs0
[247.014817] Dynamic subtest rcs0: SUCCESS (1.025s)
[247.027541] Starting dynamic subtest: bcs0
[248.079265] Dynamic subtest bcs0: SUCCESS (1.045s)
[248.092446] Starting dynamic subtest: vcs0
[249.121844] Dynamic subtest vcs0: SUCCESS (1.026s)
[249.135143] Starting dynamic subtest: vcs1
[250.164428] Dynamic subtest vcs1: SUCCESS (1.027s)
[250.177388] Starting dynamic subtest: vecs0
[251.212233] Dynamic subtest vecs0: SUCCESS (1.034s)
[251.225435] Starting dynamic subtest: ccs0
[252.250882] Dynamic subtest ccs0: SUCCESS (1.026s)
[252.253761] Subtest fence-wait: SUCCESS (6.193s)
[252.384859] [062/156] (769s left) kms_cursor_crc (cursor-offscreen-128x128)
[252.603111] Starting subtest: cursor-offscreen-128x128
[252.605564] Starting dynamic subtest: pipe-A-eDP-1
[254.549324] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[254.581841] Starting dynamic subtest: pipe-D-eDP-1
[257.220141] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[257.222610] Subtest cursor-offscreen-128x128: SUCCESS (4.588s)
[258.069682] [063/156] (763s left) sw_sync (alloc_fence_invalid_timeline)
[258.109943] Starting subtest: alloc_fence_invalid_timeline
[258.112197] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[258.185371] [064/156] (763s left) syncobj_timeline (reset-multiple-signaled)
[258.231243] Starting subtest: reset-multiple-signaled
[258.233916] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[258.340328] [065/156] (763s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[258.446422] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[258.450591] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[258.573953] [066/156] (763s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[258.966764] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[259.773356] [067/156] (762s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[259.875982] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[259.880037] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[259.969926] [068/156] (761s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[260.077399] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[260.081588] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[260.189548] [069/156] (761s left) kms_force_connector_basic (force-connector-state)
[260.263388] Starting subtest: force-connector-state
[260.874668] Subtest force-connector-state: SUCCESS (0.612s)
[261.848287] [070/156] (760s left) perf_pmu (busy-check-all)
[261.888555] Starting subtest: busy-check-all
[261.891036] Starting dynamic subtest: rcs0
[262.440296] Dynamic subtest rcs0: SUCCESS (0.550s)
[262.454920] Starting dynamic subtest: bcs0
[262.991039] Dynamic subtest bcs0: SUCCESS (0.547s)
[263.004676] Starting dynamic subtest: vcs0
[264.790019] Dynamic subtest vcs0: SUCCESS (1.790s)
[264.802874] Starting dynamic subtest: vcs1
[266.774696] Dynamic subtest vcs1: SUCCESS (1.978s)
[266.788427] Starting dynamic subtest: vecs0
[268.772619] Dynamic subtest vecs0: SUCCESS (1.977s)
[268.786362] Starting dynamic subtest: ccs0
[269.312388] Dynamic subtest ccs0: SUCCESS (0.553s)
[269.315405] Subtest busy-check-all: SUCCESS (7.410s)
[269.429213] [071/156] (752s left) kms_psr (pr-primary-blt)
[269.524496] Starting subtest: pr-primary-blt
[269.528986] Subtest pr-primary-blt: SKIP (0.000s)
[269.594836] [072/156] (752s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[269.703880] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[276.371175] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.667s)
[276.509716] [073/156] (745s left) gem_watchdog (default-physical)
[276.577836] Starting subtest: default-physical
[278.335048] Subtest default-physical: SUCCESS (1.768s)
[278.450936] [074/156] (743s left) gem_flink_basic (bad-open)
[278.509725] Starting subtest: bad-open
[278.512022] Subtest bad-open: SUCCESS (0.000s)
[278.602740] [075/156] (743s left) i915_drm_fdinfo (virtual-busy-all)
[278.647848] Starting subtest: virtual-busy-all
[278.651972] Subtest virtual-busy-all: SKIP (0.000s)
[278.712305] [076/156] (743s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[278.817079] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[278.821468] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[278.910801] [077/156] (743s left) kms_big_fb (linear-8bpp-rotate-270)
[279.003595] Starting subtest: linear-8bpp-rotate-270
[279.025693] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[279.137271] [078/156] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[279.232833] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[279.236500] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[279.329536] [079/156] (743s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[279.427655] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[279.431221] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[279.535578] [080/156] (742s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[279.634289] Starting subtest: hdr-shrfb-scaledprimary
[279.637874] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[279.743485] [081/156] (742s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[279.825913] Starting subtest: async-flip-with-page-flip-events-linear
[280.203112] Starting dynamic subtest: pipe-A-eDP-1
[282.943294] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.739s)
[283.303719] Starting dynamic subtest: pipe-B-eDP-1
[286.072276] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[286.440187] Starting dynamic subtest: pipe-C-eDP-1
[289.200649] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[289.564127] Starting dynamic subtest: pipe-D-eDP-1
[292.329815] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[292.332457] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.499s)
[293.513981] [082/156] (729s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[293.618913] Starting subtest: fbc-psr2-sprite-mmap-gtt
[293.620821] Starting dynamic subtest: eDP-1
[293.624952] Dynamic subtest eDP-1: SKIP (0.000s)
[293.628989] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[293.706122] [083/156] (728s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[293.808388] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[293.810787] Starting dynamic subtest: pipe-A-eDP-1
[293.893727] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[293.904104] Starting dynamic subtest: pipe-B-eDP-1
[295.097986] Dynamic subtest pipe-B-eDP-1: SKIP (1.201s)
[295.102715] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.292s)
[296.383900] [084/156] (726s left) api_intel_bb (intel-bb-blit-none)
[296.437730] Starting subtest: intel-bb-blit-none
[300.628657] Subtest intel-bb-blit-none: SUCCESS (4.189s)
[300.759766] [085/156] (721s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[300.862734] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[300.866977] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[300.961479] [086/156] (721s left) kms_dp_link_training (uhbr-mst)
[301.055327] Starting subtest: uhbr-mst
[301.064235] Subtest uhbr-mst: SKIP (0.000s)
[301.127158] [087/156] (721s left) gem_exec_balancer (sequential)
[301.191898] Starting subtest: sequential
[304.268234] Subtest sequential: SUCCESS (3.078s)
[304.612605] [088/156] (718s left) syncobj_wait (signal)
[304.661420] Starting subtest: signal
[304.663773] Subtest signal: SUCCESS (0.000s)
[304.758953] [089/156] (718s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[304.865296] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[304.869465] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[304.965320] [090/156] (717s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[305.062284] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[305.064678] Starting dynamic subtest: pipe-A-eDP-1
[310.972108] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.910s)
[310.982904] Starting dynamic subtest: pipe-B-eDP-1
[317.629051] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.653s)
[317.631495] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.566s)
[318.500709] [091/156] (704s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[318.560042] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[318.562254] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[318.655027] [092/156] (704s left) gem_exec_schedule (u-submit-late-slice)
[318.720003] Starting subtest: u-submit-late-slice
[318.722015] Starting dynamic subtest: rcs0
[318.752018] Dynamic subtest rcs0: SUCCESS (0.038s)
[318.765361] Starting dynamic subtest: bcs0
[318.780804] Dynamic subtest bcs0: SUCCESS (0.028s)
[318.793510] Starting dynamic subtest: vcs0
[318.815935] Dynamic subtest vcs0: SUCCESS (0.034s)
[318.826324] Starting dynamic subtest: vcs1
[318.849283] Dynamic subtest vcs1: SUCCESS (0.033s)
[318.859728] Starting dynamic subtest: vecs0
[318.880082] Dynamic subtest vecs0: SUCCESS (0.030s)
[318.890922] Starting dynamic subtest: ccs0
[318.916623] Dynamic subtest ccs0: SUCCESS (0.036s)
[318.918761] Subtest u-submit-late-slice: SUCCESS (0.204s)
[320.867101] [093/156] (702s left) gem_exec_reloc (basic-gtt-read)
[320.921985] Subtest basic-gtt-read: SKIP (0.000s)
[320.983680] [094/156] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[321.084046] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[321.088253] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[321.173458] [095/156] (701s left) kms_panel_fitting (atomic-fastset)
[321.267613] Starting subtest: atomic-fastset
[321.269948] Starting dynamic subtest: pipe-A-eDP-1
[321.426984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s)
[321.439592] Starting dynamic subtest: pipe-B-eDP-1
[322.666001] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s)
[322.676954] Starting dynamic subtest: pipe-C-eDP-1
[323.854287] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[323.865108] Starting dynamic subtest: pipe-D-eDP-1
[325.084387] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[325.086754] Subtest atomic-fastset: SUCCESS (3.819s)
[326.237128] [096/156] (696s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[326.345587] Starting subtest: fbc-farfromfence-mmap-gtt
[326.349853] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[326.469263] [097/156] (696s left) gem_ccs (ctrl-surf-copy)
[326.525393] Starting subtest: ctrl-surf-copy
[326.530330] Subtest ctrl-surf-copy: SKIP (0.000s)
[326.641564] [098/156] (696s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[326.730559] Starting subtest: plane-downscale-factor-0-75-with-rotation
[326.732964] Starting dynamic subtest: pipe-A
[326.969908] Dynamic subtest pipe-A: SUCCESS (0.241s)
[326.982306] Starting dynamic subtest: pipe-B
[328.315586] Dynamic subtest pipe-B: SUCCESS (1.344s)
[328.326056] Starting dynamic subtest: pipe-C
[329.647422] Dynamic subtest pipe-C: SUCCESS (1.330s)
[329.661051] Starting dynamic subtest: pipe-D
[331.006319] Dynamic subtest pipe-D: SUCCESS (1.357s)
[331.008586] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.278s)
[332.168945] [099/156] (691s left) i915_hangman (gt-engine-hang)
[332.226355] Starting subtest: gt-engine-hang
[332.229121] Starting dynamic subtest: rcs0
[333.751536] Dynamic subtest rcs0: SUCCESS (1.525s)
[333.767761] Starting dynamic subtest: bcs0
[335.732728] Dynamic subtest bcs0: SUCCESS (1.977s)
[335.746964] Starting dynamic subtest: vcs0
[337.716412] Dynamic subtest vcs0: SUCCESS (1.981s)
[337.728738] Starting dynamic subtest: vcs1
[339.764805] Dynamic subtest vcs1: SUCCESS (2.046s)
[339.779111] Starting dynamic subtest: vecs0
[341.748122] Dynamic subtest vecs0: SUCCESS (1.981s)
[341.761202] Starting dynamic subtest: ccs0
[343.728668] Dynamic subtest ccs0: SUCCESS (1.981s)
[343.731165] Subtest gt-engine-hang: SUCCESS (11.507s)
[343.863524] [100/156] (679s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move)
[343.964931] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move
[343.969096] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[344.064890] [101/156] (679s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[344.128963] Starting subtest: basic-batch-kernel-default-cmd
[344.133427] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[344.315788] [102/156] (679s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[344.712399] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[345.566570] [103/156] (677s left) dmabuf (all-tests)
[345.600938] Starting subtest: all-tests
[345.605486] Subtest all-tests: SKIP (0.000s)
[345.670590] [104/156] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[345.775141] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[345.779525] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[345.874491] [105/156] (677s left) perf_pmu (rc6-suspend)
[345.912118] Starting subtest: rc6-suspend
[368.434781] Subtest rc6-suspend: SUCCESS (7.704s)
[369.348519] [106/156] (654s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[369.455317] Starting subtest: x-tiled-16bpp-rotate-180
[370.738203] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.256s)
[370.857120] [107/156] (652s left) gem_ctx_shared (q-in-order)
[370.915736] Starting subtest: Q-in-order
[370.917902] Starting dynamic subtest: rcs0
[371.034510] Dynamic subtest rcs0: SUCCESS (0.115s)
[371.045601] Starting dynamic subtest: vcs0
[371.132939] Dynamic subtest vcs0: SUCCESS (0.096s)
[371.151253] Starting dynamic subtest: vcs1
[371.211385] Dynamic subtest vcs1: SUCCESS (0.076s)
[371.231104] Starting dynamic subtest: vecs0
[371.295184] Dynamic subtest vecs0: SUCCESS (0.082s)
[371.314157] Starting dynamic subtest: ccs0
[371.378329] Dynamic subtest ccs0: SUCCESS (0.080s)
[371.380919] Subtest Q-in-order: SUCCESS (0.454s)
[372.597452] [108/156] (651s left) gem_pwrite (basic-exhaustion)
[372.656375] Subtest basic-exhaustion: SKIP (0.000s)
[372.721500] [109/156] (650s left) gem_ctx_isolation (preservation-s3)
[372.778082] Starting subtest: preservation-S3
[372.780339] Starting dynamic subtest: rcs0
[389.016382] Dynamic subtest rcs0: SUCCESS (1.297s)
[389.027687] Starting dynamic subtest: bcs0
[405.015456] Dynamic subtest bcs0: SUCCESS (1.317s)
[405.028360] Starting dynamic subtest: vcs0
[421.025577] Dynamic subtest vcs0: SUCCESS (3.087s)
[421.037903] Starting dynamic subtest: vcs1
[439.016265] Dynamic subtest vcs1: SUCCESS (4.843s)
[439.027408] Starting dynamic subtest: vecs0
[457.015750] Dynamic subtest vecs0: SUCCESS (4.856s)
[457.027700] Starting dynamic subtest: ccs0
[475.018183] Dynamic subtest ccs0: SUCCESS (3.149s)
[475.022714] Subtest preservation-S3: SUCCESS (18.558s)
[475.254283] [110/156] (548s left) sw_sync (sync_multi_consumer_producer)
[475.300962] Starting subtest: sync_multi_consumer_producer
[475.589915] Subtest sync_multi_consumer_producer: SUCCESS (0.282s)
[475.666445] [111/156] (548s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[475.766354] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[475.771076] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[475.881890] [112/156] (547s left) gem_exec_create (forked)
[475.952448] Starting subtest: forked
[475.954825] Starting dynamic subtest: smem
[497.702456] Dynamic subtest smem: SUCCESS (21.578s)
[497.705736] Subtest forked: SUCCESS (21.583s)
[497.893281] [113/156] (525s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[498.007864] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[498.010041] Starting dynamic subtest: pipe-A-eDP-1
[498.081535] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[498.092926] Starting dynamic subtest: pipe-B-eDP-1
[499.222417] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s)
[499.227210] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.217s)
[500.433955] [114/156] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[500.541793] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[500.546427] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[500.653339] [115/156] (523s left) syncobj_wait (single-wait-all-for-submit-signaled)
[500.698935] Starting subtest: single-wait-all-for-submit-signaled
[500.701363] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[500.809413] [116/156] (523s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[500.910326] Starting subtest: y-tiled-16bpp-rotate-0
[500.914447] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[500.992276] [117/156] (523s left) kms_vblank (query-idle-hang)
[501.087057] Starting subtest: query-idle-hang
[501.089431] Starting dynamic subtest: pipe-A-eDP-1
[527.466716] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.300s)
[527.484714] Starting dynamic subtest: pipe-D-eDP-1
[542.508731] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.031s)
[542.510622] Subtest query-idle-hang: SUCCESS (41.335s)
[543.364297] [118/156] (480s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[543.467934] Starting subtest: 4-tiled-16bpp-rotate-90
[543.488607] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[543.614815] [119/156] (480s left) kms_frontbuffer_tracking (fbchdr-shrfb-scaledprimary)
[543.709568] Starting subtest: fbchdr-shrfb-scaledprimary
[543.713584] Subtest fbchdr-shrfb-scaledprimary: SKIP (0.000s)
[543.804410] [120/156] (480s left) kms_draw_crc (draw-method-render)
[543.899934] Starting subtest: draw-method-render
[543.901835] Starting dynamic subtest: xrgb8888-untiled
[544.120161] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[544.131329] Starting dynamic subtest: rgb565-untiled
[544.330704] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[544.341704] Starting dynamic subtest: xrgb2101010-untiled
[544.541918] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[544.552643] Starting dynamic subtest: xbgr16161616f-untiled
[544.763804] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[544.774868] Starting dynamic subtest: xrgb8888-xtiled
[544.886283] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[544.896871] Starting dynamic subtest: rgb565-xtiled
[544.997193] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[545.008073] Starting dynamic subtest: xrgb2101010-xtiled
[545.108489] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[545.119314] Starting dynamic subtest: xbgr16161616f-xtiled
[545.230589] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[545.241508] Starting dynamic subtest: xrgb8888-4tiled
[545.353433] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[545.367600] Starting dynamic subtest: rgb565-4tiled
[545.474889] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[545.484992] Starting dynamic subtest: xrgb2101010-4tiled
[545.586057] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[545.596302] Starting dynamic subtest: xbgr16161616f-4tiled
[545.708641] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[545.710828] Subtest draw-method-render: SUCCESS (1.811s)
[545.828495] [121/156] (478s left) i915_pm_rpm (debugfs-forcewake-user)
[547.874902] Starting subtest: debugfs-forcewake-user
[559.272914] Subtest debugfs-forcewake-user: SUCCESS (11.402s)
[559.680386] [122/156] (464s left) gem_ctx_persistence (legacy-engines-persistence)
[559.732451] Starting subtest: legacy-engines-persistence
[559.734593] Starting dynamic subtest: render
[560.548759] Dynamic subtest render: SUCCESS (0.815s)
[560.562609] Starting dynamic subtest: bsd1
[561.310527] Dynamic subtest bsd1: SUCCESS (0.759s)
[561.323967] Starting dynamic subtest: bsd2
[562.076684] Dynamic subtest bsd2: SUCCESS (0.763s)
[562.090185] Starting dynamic subtest: blt
[562.862907] Dynamic subtest blt: SUCCESS (0.783s)
[562.879473] Starting dynamic subtest: vebox
[563.618570] Dynamic subtest vebox: SUCCESS (0.752s)
[563.621119] Subtest legacy-engines-persistence: SUCCESS (3.886s)
[563.700059] [123/156] (460s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[563.795412] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[563.799930] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[563.878273] [124/156] (460s left) gem_readwrite (write-bad-handle)
[563.945615] Subtest write-bad-handle: SKIP (0.000s)
[564.018292] [125/156] (460s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[564.112888] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[564.115211] Starting dynamic subtest: pipe-A
[564.176860] Dynamic subtest pipe-A: SUCCESS (0.064s)
[564.188621] Starting dynamic subtest: pipe-B
[565.297344] Dynamic subtest pipe-B: SUCCESS (1.120s)
[565.310094] Starting dynamic subtest: pipe-C
[566.414353] Dynamic subtest pipe-C: SUCCESS (1.116s)
[566.425556] Starting dynamic subtest: pipe-D
[567.532375] Dynamic subtest pipe-D: SUCCESS (1.117s)
[567.534726] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.420s)
[568.706418] [126/156] (455s left) syncobj_timeline (wait-all-delayed-signal)
[568.772911] Starting subtest: wait-all-delayed-signal
[568.878061] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[568.963145] [127/156] (455s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[569.064227] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[569.068156] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[569.159570] [128/156] (455s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[569.256077] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[569.260605] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[569.329456] [129/156] (455s left) gem_userptr_blits (stress-mm-invalidate-close)
[569.401731] Starting subtest: stress-mm-invalidate-close
[571.550185] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[571.703240] [130/156] (452s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[571.766285] Subtest untiled-to-tiled: SKIP (0.000s)
[571.840645] [131/156] (452s left) gem_ctx_engines (execute-one)
[571.905627] Starting subtest: execute-one
[575.477869] Subtest execute-one: SUCCESS (3.571s)
[575.661588] [132/156] (449s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[575.750915] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[575.755488] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[575.824827] [133/156] (448s left) api_intel_allocator (fork-simple-stress-signal)
[575.875891] Starting subtest: fork-simple-stress-signal
[581.281500] Subtest fork-simple-stress-signal: SUCCESS (5.405s)
[581.408491] [134/156] (443s left) kms_prop_blob (blob-multiple)
[581.471553] Starting subtest: blob-multiple
[581.473958] Subtest blob-multiple: SUCCESS (0.002s)
[581.594086] [135/156] (443s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[581.695788] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[581.699943] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[581.788058] [136/156] (443s left) kms_color (gamma)
[581.884083] Starting subtest: gamma
[581.886233] Starting dynamic subtest: pipe-A-eDP-1
[582.615490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[582.626764] Starting dynamic subtest: pipe-B-eDP-1
[584.018311] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[584.030836] Starting dynamic subtest: pipe-C-eDP-1
[585.403474] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[585.415534] Starting dynamic subtest: pipe-D-eDP-1
[586.737879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[586.740440] Subtest gamma: SUCCESS (4.854s)
[587.549281] [137/156] (437s left) gem_exec_flush (basic-wb-rw-before-default)
[587.622415] Starting subtest: basic-wb-rw-before-default
[593.075183] Subtest basic-wb-rw-before-default: SUCCESS (5.452s)
[593.265155] [138/156] (431s left) kms_pipe_crc_basic (hang-read-crc)
[593.377728] Starting subtest: hang-read-crc
[593.379986] Starting dynamic subtest: pipe-A-eDP-1
[595.439508] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.061s)
[595.451528] Starting dynamic subtest: pipe-B-eDP-1
[598.199313] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[598.215556] Starting dynamic subtest: pipe-C-eDP-1
[600.827754] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s)
[600.839994] Starting dynamic subtest: pipe-D-eDP-1
[603.501475] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.672s)
[603.503788] Subtest hang-read-crc: SUCCESS (10.122s)
[604.337168] [139/156] (420s left) kms_selftest (drm_dp_mst_helper)
[604.375541] Starting subtest: drm_dp_mst_helper
[604.405048] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[604.514229] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.110s)
[604.526708] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[604.608779] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.093s)
[604.619656] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[604.714989] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.104s)
[604.716930] Subtest drm_dp_mst_helper: SUCCESS (0.338s)
[604.902565] [140/156] (420s left) kms_getfb (getfb-handle-zero)
[604.995861] Starting subtest: getfb-handle-zero
[604.998008] Subtest getfb-handle-zero: SUCCESS (0.000s)
[605.126216] [141/156] (419s left) prime_mmap (test_forked_cpu_write)
[605.177522] Starting subtest: test_forked_cpu_write
[605.180513] Starting dynamic subtest: test_forked_cpu_write-smem
[605.186223] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[605.188514] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[605.282628] [142/156] (419s left) kms_atomic_transition (modeset-transition)
[605.379223] Starting subtest: modeset-transition
[605.381212] Starting dynamic subtest: 1x-outputs
[616.421568] Dynamic subtest 1x-outputs: SUCCESS (11.046s)
[616.423903] Subtest modeset-transition: SUCCESS (11.048s)
[617.294716] [143/156] (407s left) gem_userptr_blits (readonly-pwrite-unsync)
[617.362087] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[617.492364] [144/156] (407s left) gem_userptr_blits (input-checking)
[617.556391] Starting subtest: input-checking
[617.558318] Subtest input-checking: SUCCESS (0.000s)
[617.675767] [145/156] (407s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[617.774917] Starting subtest: fbc-rgb565-draw-mmap-wc
[621.854898] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.086s)
[622.987064] [146/156] (402s left) gem_exec_nop (basic-series)
[623.048154] Starting subtest: basic-series
[639.720062] Subtest basic-series: SUCCESS (16.678s)
[639.945035] [147/156] (385s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[640.066137] Starting subtest: cursorB-vs-flipA-toggle
[640.070607] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[640.211188] [148/156] (385s left) syncobj_wait (multi-wait-for-submit-submitted)
[640.271287] Starting subtest: multi-wait-for-submit-submitted
[640.376718] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[640.454887] [149/156] (384s left) gem_caching (read-writes)
[640.514877] Subtest read-writes: SKIP (0.000s)
[640.586605] [150/156] (384s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[640.683724] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[640.688286] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[640.784133] [151/156] (384s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[641.296673] Starting subtest: syncobj-timeline-multiple-ext-nodes
[641.299683] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[642.808245] [152/156] (382s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[642.915629] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[642.920062] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[643.019127] [153/156] (382s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[643.116406] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[643.120469] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[643.229087] [154/156] (382s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[643.335754] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[650.704747] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.373s)
[650.853093] [155/156] (374s left) prime_self_import (basic-llseek-size)
[650.892254] Starting subtest: basic-llseek-size
[650.912127] Subtest basic-llseek-size: SUCCESS (0.023s)
[651.032580] [156/156] (374s left) gem_eio (wait-wedge-1us)
[651.250821] Starting subtest: wait-wedge-1us
[652.786257] Subtest wait-wedge-1us: SUCCESS (1.534s)
[652.918381] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: gem_ringfill
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_alpha_blend
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_bad_reloc
results: parsing output: 12/ for test: gem_mmap_offset
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_joiner
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_setmode
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane_lowres
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_pxp
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_pm_dc
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: prime_vgem
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: sw_sync
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_watchdog
results: parsing output: 73/ for test: gem_flink_basic
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_dp_link_training
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_panel_fitting
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ccs
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: i915_hangman
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_flush
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: dmabuf
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_ctx_shared
results: parsing output: 107/ for test: gem_pwrite
results: parsing output: 108/ for test: gem_ctx_isolation
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_exec_create
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_draw_crc
results: parsing output: 120/ for test: i915_pm_rpm
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_readwrite
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: gem_set_tiling_vs_blt
results: parsing output: 130/ for test: gem_ctx_engines
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: api_intel_allocator
results: parsing output: 133/ for test: kms_prop_blob
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_color
results: parsing output: 136/ for test: gem_exec_flush
results: parsing output: 137/ for test: kms_pipe_crc_basic
results: parsing output: 138/ for test: kms_selftest
results: parsing output: 139/ for test: kms_getfb
results: parsing output: 140/ for test: prime_mmap
results: parsing output: 141/ for test: kms_atomic_transition
results: parsing output: 142/ for test: gem_userptr_blits
results: parsing output: 143/ for test: gem_userptr_blits
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_nop
results: parsing output: 146/ for test: kms_cursor_legacy
results: parsing output: 147/ for test: syncobj_wait
results: parsing output: 148/ for test: gem_caching
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: prime_self_import
results: parsing output: 155/ for test: gem_eio
Done.