[62.238535] Initializing watchdogs
[62.238626]   /dev/watchdog0
[62.253429] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[62.257873] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.260090] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.262277] [001/133] (960s left) gen9_exec_parse (bb-start-param)
[62.331868] Subtest bb-start-param: SKIP (0.000s)
[62.408952] [002/133] (960s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[62.462332] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[62.463238] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[62.596512] [003/133] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[62.652054] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[62.760380] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[62.847575] [004/133] (960s left) kms_hdr (brightness-with-hdr)
[62.927126] Starting subtest: brightness-with-hdr
[62.929889] Subtest brightness-with-hdr: SKIP (0.000s)
[63.018014] [005/133] (959s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[63.136808] Starting subtest: basic-flip-after-cursor-legacy
[64.128211] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.985s)
[64.950386] [006/133] (957s left) gem_ctx_bad_destroy (invalid-pad)
[65.005775] Starting subtest: invalid-pad
[65.007086] Subtest invalid-pad: SUCCESS (0.000s)
[65.094065] [007/133] (957s left) gem_exec_whisper (basic-contexts-priority-all)
[65.151789] Starting subtest: basic-contexts-priority-all
[89.744202] Subtest basic-contexts-priority-all: SUCCESS (24.552s)
[89.945321] [008/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[90.055052] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[90.056839] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[90.184914] [009/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[90.275438] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[90.277256] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[90.378395] [010/133] (932s left) gem_exec_suspend (basic)
[90.432570] Starting subtest: basic
[90.433560] Starting dynamic subtest: smem
[91.933463] Dynamic subtest smem: SUCCESS (1.497s)
[91.934982] Subtest basic: SUCCESS (1.498s)
[92.124632] [011/133] (930s left) gem_exec_fence (syncobj-invalid-flags)
[92.622541] Starting subtest: syncobj-invalid-flags
[92.623749] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[94.056424] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[94.058490] [012/133] (929s left) gen3_mixed_blits
[94.159559] [013/133] (928s left) kms_feature_discovery (dp-mst)
[94.245995] Starting subtest: dp-mst
[94.247888] Subtest dp-mst: SKIP (0.000s)
[94.333370] [014/133] (928s left) kms_chamelium_color (ctm-negative)
[94.419274] Subtest ctm-negative: SKIP (0.000s)
[94.459765] [015/133] (928s left) gem_softpin (allocator-basic-reserve)
[94.514946] Starting subtest: allocator-basic-reserve
[94.586354] Subtest allocator-basic-reserve: SUCCESS (0.071s)
[94.750616] [016/133] (928s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[94.982275] Starting subtest: cursor-rapid-movement-256x256
[94.985171] Starting dynamic subtest: pipe-A-eDP-1
[95.525051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[95.555049] Starting dynamic subtest: pipe-D-eDP-1
[96.791740] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[96.792720] Subtest cursor-rapid-movement-256x256: SUCCESS (1.808s)
[97.668025] [017/133] (925s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[97.768170] Starting subtest: primary-x-tiled-reflect-x-180
[104.817065] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.047s)
[106.017325] [018/133] (917s left) syncobj_timeline (wait-any-complex)
[106.081622] Starting subtest: wait-any-complex
[106.143922] Subtest wait-any-complex: SUCCESS (0.062s)
[106.235683] [019/133] (917s left) kms_vblank (ts-continuation-dpms-rpm)
[106.327765] Starting subtest: ts-continuation-dpms-rpm
[106.328736] Starting dynamic subtest: pipe-A-eDP-1
[108.808824] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.479s)
[108.821591] Starting dynamic subtest: pipe-D-eDP-1
[111.037654] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.227s)
[111.038723] Subtest ts-continuation-dpms-rpm: SUCCESS (4.709s)
[111.851079] [020/133] (911s left) perf (unprivileged-single-ctx-counters)
[111.972220] Starting subtest: unprivileged-single-ctx-counters
[111.973857] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[112.001708] [021/133] (911s left) kms_atomic_transition (plane-all-transition)
[112.087942] Starting subtest: plane-all-transition
[112.088806] Starting dynamic subtest: pipe-A-eDP-1
[114.585199] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[114.896877] Starting dynamic subtest: pipe-B-eDP-1
[118.171049] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.280s)
[118.472212] Subtest plane-all-transition: SUCCESS (6.383s)
[119.313588] [022/133] (904s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[119.409072] Starting subtest: fbc-rgb101010-draw-mmap-wc
[124.005878] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.596s)
[125.151164] [023/133] (898s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[125.236310] Starting subtest: fbc-psr-sprite-mmap-gtt
[125.237652] Starting dynamic subtest: eDP-1
[125.240302] Dynamic subtest eDP-1: SKIP (0.000s)
[125.242760] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[125.330363] [024/133] (898s left) kms_color_pipeline (plane-ctm3x4)
[125.414832] Starting subtest: plane-ctm3x4
[125.429591] Starting dynamic subtest: pipe-A-eDP-1
[125.865359] Dynamic subtest pipe-A-eDP-1: FAIL (0.291s)
[126.802922] Starting dynamic subtest: pipe-B-eDP-1
[127.250616] Dynamic subtest pipe-B-eDP-1: FAIL (0.257s)
[128.133110] Starting dynamic subtest: pipe-C-eDP-1
[128.555948] Dynamic subtest pipe-C-eDP-1: FAIL (0.213s)
[129.376898] Starting dynamic subtest: pipe-D-eDP-1
[129.809961] Dynamic subtest pipe-D-eDP-1: FAIL (0.224s)
[129.884261] Subtest plane-ctm3x4: FAIL (4.468s)
[130.780827] [025/133] (892s left) gem_exec_reloc (basic-write-cpu-active)
[130.839190] Subtest basic-write-cpu-active: SKIP (0.000s)
[130.920155] [026/133] (892s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[131.027149] Starting subtest: 4-tiled-32bpp-rotate-0
[132.331993] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.305s)
[132.506552] [027/133] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[132.612425] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[139.287722] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.676s)
[139.443510] [028/133] (884s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[139.535989] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[139.536987] Starting dynamic subtest: pipe-A-eDP-1
[139.545903] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[139.555161] Starting dynamic subtest: pipe-B-eDP-1
[139.563690] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[139.570777] Starting dynamic subtest: pipe-C-eDP-1
[139.580023] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[139.588472] Starting dynamic subtest: pipe-D-eDP-1
[139.597109] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[139.598843] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[141.770820] [029/133] (881s left) kms_cursor_crc (cursor-sliding-32x32)
[141.911568] Starting subtest: cursor-sliding-32x32
[141.953057] Subtest cursor-sliding-32x32: SKIP (0.039s)
[142.249998] [030/133] (881s left) perf (low-oa-exponent-permissions)
[142.356076] Starting subtest: low-oa-exponent-permissions
[142.394659] Subtest low-oa-exponent-permissions: SUCCESS (0.039s)
[142.435105] [031/133] (881s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[142.532072] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[149.094783] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.564s)
[149.264095] [032/133] (874s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[149.388716] Starting subtest: verify-pxp-key-change-after-suspend-resume
[157.385719] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.998s)
[163.561603] [033/133] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[163.678797] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[170.464231] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.786s)
[170.628011] [034/133] (859s left) gem_exec_balancer (nop)
[170.693566] Starting subtest: nop
[217.324986] Subtest nop: SUCCESS (46.629s)
[217.658518] [035/133] (812s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[217.742186] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[217.743073] Starting dynamic subtest: pipe-A-eDP-1
[218.203303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[218.211188] Starting dynamic subtest: pipe-B-eDP-1
[219.561877] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.358s)
[219.569580] Starting dynamic subtest: pipe-C-eDP-1
[220.984864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.422s)
[220.992599] Starting dynamic subtest: pipe-D-eDP-1
[222.310791] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[222.311606] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.560s)
[223.538882] [036/133] (806s left) perf (invalid-remove-userspace-config)
[223.639797] Starting subtest: invalid-remove-userspace-config
[223.648250] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[223.678745] [037/133] (806s left) kms_vrr (negative-basic)
[223.776903] Starting subtest: negative-basic
[223.779633] Starting dynamic subtest: pipe-A-eDP-1
[229.201611] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.418s)
[229.490631] Subtest negative-basic: SUCCESS (5.711s)
[230.375178] [038/133] (799s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[230.467319] Starting subtest: invalid-modeset-force-ultra-joiner
[230.469119] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[230.555763] [039/133] (799s left) gem_eio (create-ext)
[230.776366] Starting subtest: create-ext
[231.109993] Subtest create-ext: SUCCESS (0.334s)
[231.283888] [040/133] (798s left) gem_exec_params (invalid-ring2)
[231.341791] Starting subtest: invalid-ring2
[231.342821] Subtest invalid-ring2: SUCCESS (0.000s)
[231.464101] [041/133] (798s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[231.579129] Starting subtest: psr-2p-pri-indfb-multidraw
[231.580855] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[231.709687] [042/133] (798s left) kms_psr (psr-primary-blt)
[231.791600] Starting subtest: psr-primary-blt
[231.793828] Starting dynamic subtest: eDP-1
[233.539098] Dynamic subtest eDP-1: SUCCESS (1.746s)
[233.539977] Subtest psr-primary-blt: SUCCESS (1.748s)
[234.426277] [043/133] (795s left) gem_eio (suspend)
[234.659909] Starting subtest: suspend
[246.877905] Subtest suspend: SUCCESS (12.217s)
[257.072901] [044/133] (783s left) kms_flip (flip-vs-dpms-on-nop)
[257.202358] Starting subtest: flip-vs-dpms-on-nop
[257.207363] Starting dynamic subtest: A-eDP1
[259.151448] Dynamic subtest A-eDP1: SUCCESS (1.944s)
[259.161362] Starting dynamic subtest: B-eDP1
[260.986150] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[260.997177] Starting dynamic subtest: C-eDP1
[262.811864] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[262.822495] Starting dynamic subtest: D-eDP1
[264.642684] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[264.645896] Subtest flip-vs-dpms-on-nop: SUCCESS (7.442s)
[265.841502] [045/133] (774s left) gem_ccs (block-multicopy-inplace)
[265.897605] Starting subtest: block-multicopy-inplace
[265.899439] Subtest block-multicopy-inplace: SKIP (0.000s)
[266.036866] [046/133] (774s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[266.150232] Starting subtest: cursorB-vs-flipB-atomic
[266.151869] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[266.314277] [047/133] (774s left) i915_pm_rps (min-max-config-loaded)
[266.380788] Starting subtest: min-max-config-loaded
[266.382778] Subtest min-max-config-loaded: SKIP (0.001s)
[266.497696] [048/133] (773s left) gem_ctx_engines (execute-allforone)
[266.564672] Starting subtest: execute-allforone
[266.580548] Subtest execute-allforone: SUCCESS (0.016s)
[268.062489] [049/133] (772s left) gem_tiled_fence_blits (normal)
[268.109458] Subtest normal: SKIP (0.000s)
[268.173826] [050/133] (772s left) gem_exec_flush (basic-uc-ro-default)
[268.249217] Starting subtest: basic-uc-ro-default
[273.728086] Subtest basic-uc-ro-default: SUCCESS (5.479s)
[273.939271] [051/133] (766s left) kms_pm_rpm (universal-planes)
[276.081350] Starting subtest: universal-planes
[276.082400] Starting dynamic subtest: plane-33
[284.685307] Dynamic subtest plane-33: SUCCESS (8.604s)
[284.697618] Starting dynamic subtest: plane-63
[292.975037] Dynamic subtest plane-63: SUCCESS (8.286s)
[292.987455] Starting dynamic subtest: plane-93
[301.573050] Dynamic subtest plane-93: SUCCESS (8.594s)
[301.585538] Starting dynamic subtest: plane-123
[309.853775] Dynamic subtest plane-123: SUCCESS (8.278s)
[309.865674] Starting dynamic subtest: plane-133
[318.127130] Dynamic subtest plane-133: SUCCESS (8.270s)
[318.139309] Starting dynamic subtest: plane-143
[326.708522] Dynamic subtest plane-143: SUCCESS (8.577s)
[326.712563] Subtest universal-planes: SUCCESS (50.628s)
[327.117561] [052/133] (713s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[327.207274] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[327.208146] Starting dynamic subtest: pipe-A-eDP-1
[327.356500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[327.366426] Starting dynamic subtest: pipe-B-eDP-1
[327.373609] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[327.381626] Starting dynamic subtest: pipe-C-eDP-1
[327.388831] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[327.398743] Starting dynamic subtest: pipe-D-eDP-1
[327.406460] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[327.407321] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.182s)
[329.667218] [053/133] (710s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[329.745987] Starting subtest: async-flip-with-page-flip-events-tiled
[330.119798] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[332.927462] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[332.936859] Starting dynamic subtest: pipe-A-eDP-1-4
[335.113628] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[335.123269] Starting dynamic subtest: pipe-A-eDP-1-4
[337.124121] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[337.132183] Starting dynamic subtest: pipe-A-eDP-1-x
[339.314131] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[339.694238] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[342.452489] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[342.460647] Starting dynamic subtest: pipe-B-eDP-1-4
[344.639970] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[344.648227] Starting dynamic subtest: pipe-B-eDP-1-4
[346.649376] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[346.657772] Starting dynamic subtest: pipe-B-eDP-1-x
[348.851043] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[349.212284] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[351.986378] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[352.005364] Starting dynamic subtest: pipe-C-eDP-1-4
[354.179965] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.194s)
[354.191187] Starting dynamic subtest: pipe-C-eDP-1-4
[356.189126] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[356.197073] Starting dynamic subtest: pipe-C-eDP-1-x
[358.379525] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[358.739851] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[361.509349] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[361.517601] Starting dynamic subtest: pipe-D-eDP-1-4
[363.684610] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[363.693141] Starting dynamic subtest: pipe-D-eDP-1-4
[365.695388] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[365.703910] Starting dynamic subtest: pipe-D-eDP-1-x
[367.885266] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[367.886083] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.135s)
[369.111270] [054/133] (671s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[369.229356] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[370.673998] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.443s)
[371.475349] [055/133] (669s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[371.607702] Starting subtest: cursorA-vs-flipA-atomic
[382.728502] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.120s)
[383.614543] [056/133] (657s left) gem_readwrite (beyond-eob)
[383.665041] Subtest beyond-EOB: SKIP (0.000s)
[383.736990] [057/133] (656s left) kms_scaling_modes (scaling-mode-center)
[383.824224] Starting subtest: scaling-mode-center
[383.825109] Starting dynamic subtest: pipe-A-eDP-1
[383.919740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[383.929896] Starting dynamic subtest: pipe-B-eDP-1
[385.114078] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[385.125207] Starting dynamic subtest: pipe-C-eDP-1
[386.240678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[386.250858] Starting dynamic subtest: pipe-D-eDP-1
[387.380734] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[387.381612] Subtest scaling-mode-center: SUCCESS (3.557s)
[388.557539] [058/133] (652s left) kms_dp_linktrain_fallback (dsc-fallback)
[388.641533] Starting subtest: dsc-fallback
[388.644373] Subtest dsc-fallback: SKIP (0.000s)
[388.736886] [059/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[388.826258] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[388.828280] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[388.954953] [060/133] (651s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-blt)
[389.047260] Starting subtest: psr-abgr161616f-draw-blt
[389.048843] Subtest psr-abgr161616f-draw-blt: SKIP (0.000s)
[389.184220] [061/133] (651s left) gem_exec_fence (basic-await)
[389.357992] Starting subtest: basic-await
[389.359636] Starting dynamic subtest: rcs0
[389.433494] Dynamic subtest rcs0: SUCCESS (0.075s)
[389.446477] Starting dynamic subtest: bcs0
[389.507505] Dynamic subtest bcs0: SUCCESS (0.072s)
[389.519266] Starting dynamic subtest: vcs0
[389.580749] Dynamic subtest vcs0: SUCCESS (0.071s)
[389.593255] Starting dynamic subtest: vcs1
[389.653906] Dynamic subtest vcs1: SUCCESS (0.072s)
[389.665511] Starting dynamic subtest: vecs0
[389.727923] Dynamic subtest vecs0: SUCCESS (0.072s)
[389.740178] Starting dynamic subtest: ccs0
[389.801555] Dynamic subtest ccs0: SUCCESS (0.072s)
[389.802793] Subtest basic-await: SUCCESS (0.445s)
[392.020678] [062/133] (648s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[392.124728] Starting subtest: y-tiled-16bpp-rotate-0
[392.126540] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[392.237934] [063/133] (648s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[392.346435] Starting subtest: 2x-cursor-vs-flip-atomic
[392.349103] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[392.511058] [064/133] (648s left) gem_mmap_gtt (basic-small-copy-xy)
[392.564135] Subtest basic-small-copy-XY: SKIP (0.000s)
[392.627351] [065/133] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[392.724301] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[392.726046] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[392.854795] [066/133] (648s left) syncobj_wait (multi-wait-signaled)
[392.916823] Starting subtest: multi-wait-signaled
[392.917829] Subtest multi-wait-signaled: SUCCESS (0.000s)
[393.033904] [067/133] (647s left) kms_psr (psr2-sprite-render)
[393.119385] Starting subtest: psr2-sprite-render
[393.120331] Starting dynamic subtest: eDP-1
[394.835159] Dynamic subtest eDP-1: SUCCESS (1.716s)
[394.836048] Subtest psr2-sprite-render: SUCCESS (1.717s)
[395.724282] [068/133] (645s left) i915_drm_fdinfo (memory-info-active)
[395.763197] Starting subtest: memory-info-active
[395.764165] Starting dynamic subtest: smem0
[398.536920] Dynamic subtest smem0: SUCCESS (2.773s)
[398.538696] Subtest memory-info-active: SUCCESS (2.774s)
[398.634434] [069/133] (642s left) kms_cursor_crc (cursor-offscreen-max-size)
[398.971728] Starting subtest: cursor-offscreen-max-size
[398.974529] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[399.143503] [070/133] (641s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[404.105509] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[404.106409] Starting dynamic subtest: pipe-A-eDP-1
[404.880997] Dynamic subtest pipe-A-eDP-1: SKIP (0.774s)
[404.890724] Starting dynamic subtest: pipe-B-eDP-1
[406.008385] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[406.009971] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.903s)
[407.228240] [071/133] (633s left) kms_async_flips (crc-atomic)
[407.320263] Starting subtest: crc-atomic
[407.697418] Starting dynamic subtest: pipe-A-eDP-1
[410.624742] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.927s)
[410.997801] Starting dynamic subtest: pipe-B-eDP-1
[413.950090] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.959s)
[414.330688] Starting dynamic subtest: pipe-C-eDP-1
[417.165050] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.842s)
[417.526680] Starting dynamic subtest: pipe-D-eDP-1
[420.399385] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.880s)
[420.400432] Subtest crc-atomic: SUCCESS (13.078s)
[421.596240] [072/133] (619s left) kms_psr (fbc-pr-primary-render)
[421.695528] Starting subtest: fbc-pr-primary-render
[421.697408] Subtest fbc-pr-primary-render: SKIP (0.000s)
[421.791335] [073/133] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[421.884401] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[421.886057] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[422.036177] [074/133] (619s left) api_intel_allocator (default-alignment)
[422.089593] Starting subtest: default-alignment
[422.090982] Subtest default-alignment: SUCCESS (0.003s)
[422.227272] [075/133] (619s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[422.323068] Starting subtest: fbc-rgb565-draw-pwrite
[426.918572] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.597s)
[428.104980] [076/133] (613s left) kms_psr (fbc-psr2-sprite-render)
[428.205791] Starting subtest: fbc-psr2-sprite-render
[428.206735] Starting dynamic subtest: eDP-1
[428.208578] Dynamic subtest eDP-1: SKIP (0.000s)
[428.210347] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[428.299137] [077/133] (613s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[428.402269] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[435.539647] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.138s)
[436.703358] [078/133] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[436.804142] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[436.805802] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[436.948284] [079/133] (604s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[437.064031] Starting subtest: cursorB-vs-flipA-atomic-transitions
[437.065801] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[437.229403] [080/133] (604s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[437.322748] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[440.967103] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.645s)
[442.191791] [081/133] (599s left) kms_plane (pixel-format)
[442.284445] Starting subtest: pixel-format
[442.311395] Starting dynamic subtest: pipe-A-plane-0
[447.289506] Dynamic subtest pipe-A-plane-0: SUCCESS (4.978s)
[447.297900] Starting dynamic subtest: pipe-A-plane-3
[449.700782] Dynamic subtest pipe-A-plane-3: SUCCESS (2.410s)
[449.711149] Starting dynamic subtest: pipe-A-plane-5
[449.923061] Dynamic subtest pipe-A-plane-5: SUCCESS (0.221s)
[451.048145] Starting dynamic subtest: pipe-B-plane-0
[456.218458] Dynamic subtest pipe-B-plane-0: SUCCESS (5.178s)
[456.230270] Starting dynamic subtest: pipe-B-plane-3
[458.540860] Dynamic subtest pipe-B-plane-3: SUCCESS (2.321s)
[458.549065] Starting dynamic subtest: pipe-B-plane-5
[458.752755] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[459.070627] Subtest pixel-format: SUCCESS (16.785s)
[459.945277] [082/133] (581s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[460.003243] Starting subtest: multi-wait-for-submit-available-submitted
[460.004189] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[460.139658] [083/133] (581s left) gem_pwrite (basic-random)
[460.195726] Subtest basic-random: SKIP (0.000s)
[460.261867] [084/133] (581s left) kms_setmode (invalid-clone-exclusive-crtc)
[460.308338] Starting subtest: invalid-clone-exclusive-crtc
[460.310991] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[460.445280] [085/133] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[460.549591] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[460.551382] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[460.683473] [086/133] (581s left) gem_ctx_bad_destroy (invalid-ctx)
[460.731585] Starting subtest: invalid-ctx
[460.732637] Subtest invalid-ctx: SUCCESS (0.000s)
[460.812873] [087/133] (580s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[465.798128] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[465.800511] Starting dynamic subtest: pipe-A-eDP-1
[472.762525] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.962s)
[472.771645] Starting dynamic subtest: pipe-B-eDP-1
[479.711879] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.944s)
[479.713300] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.910s)
[480.588865] [088/133] (561s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[485.568795] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[485.571804] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[486.421793] [089/133] (555s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[486.794443] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[487.617470] [090/133] (554s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[487.678466] Starting subtest: invalid-single-wait-all-unsubmitted
[487.679529] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[487.804816] [091/133] (554s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[487.904259] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[487.905199] Starting dynamic subtest: pipe-A
[487.922032] Dynamic subtest pipe-A: SKIP (0.017s)
[487.930328] Starting dynamic subtest: pipe-B
[487.951216] Dynamic subtest pipe-B: SKIP (0.029s)
[487.959033] Starting dynamic subtest: pipe-C
[487.980880] Dynamic subtest pipe-C: SKIP (0.029s)
[487.988779] Starting dynamic subtest: pipe-D
[488.011234] Dynamic subtest pipe-D: SKIP (0.029s)
[488.012858] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.106s)
[488.146301] [092/133] (553s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[488.201783] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[488.311741] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[488.407298] [093/133] (553s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[488.472440] Starting subtest: saturated-hostile-nopreempt
[488.473432] Starting dynamic subtest: rcs0
[488.580781] Dynamic subtest rcs0: SKIP (0.106s)
[488.591835] Starting dynamic subtest: bcs0
[488.607326] Dynamic subtest bcs0: SKIP (0.025s)
[488.617562] Starting dynamic subtest: vcs0
[488.632102] Dynamic subtest vcs0: SKIP (0.023s)
[488.641844] Starting dynamic subtest: vcs1
[488.658083] Dynamic subtest vcs1: SKIP (0.024s)
[488.667150] Starting dynamic subtest: vecs0
[488.684935] Dynamic subtest vecs0: SKIP (0.025s)
[488.692851] Starting dynamic subtest: ccs0
[488.709025] Dynamic subtest ccs0: SKIP (0.022s)
[488.710882] Subtest saturated-hostile-nopreempt: SKIP (0.237s)
[488.804419] [094/133] (553s left) syncobj_wait (wait-all-interrupted)
[488.867432] Starting subtest: wait-all-interrupted
[488.973662] Subtest wait-all-interrupted: SUCCESS (0.106s)
[489.070756] [095/133] (552s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[489.178574] Starting subtest: yf-tiled-16bpp-rotate-90
[489.180288] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[489.309073] [096/133] (552s left) kms_flip (2x-nonexisting-fb-interruptible)
[489.401924] Starting subtest: 2x-nonexisting-fb-interruptible
[489.412489] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[489.551049] [097/133] (552s left) gem_exec_schedule (preempt-user)
[489.620603] Starting subtest: preempt-user
[489.621578] Starting dynamic subtest: rcs0
[489.645402] Dynamic subtest rcs0: SUCCESS (0.024s)
[489.655519] Starting dynamic subtest: bcs0
[489.665496] Dynamic subtest bcs0: SUCCESS (0.019s)
[489.674169] Starting dynamic subtest: vcs0
[489.685447] Dynamic subtest vcs0: SUCCESS (0.019s)
[489.695587] Starting dynamic subtest: vcs1
[489.704876] Dynamic subtest vcs1: SUCCESS (0.018s)
[489.712840] Starting dynamic subtest: vecs0
[489.725043] Dynamic subtest vecs0: SUCCESS (0.019s)
[489.733026] Starting dynamic subtest: ccs0
[489.746852] Dynamic subtest ccs0: SUCCESS (0.021s)
[489.747790] Subtest preempt-user: SUCCESS (0.127s)
[491.036438] [098/133] (551s left) vgem_basic (dmabuf-export)
[491.067025] Starting subtest: dmabuf-export
[491.120854] Subtest dmabuf-export: SUCCESS (0.054s)
[491.259184] [099/133] (550s left) perf_pmu (busy-accuracy-2)
[491.295107] Starting subtest: busy-accuracy-2
[491.296061] Starting dynamic subtest: rcs0
[494.341384] Dynamic subtest rcs0: SUCCESS (3.044s)
[494.350560] Starting dynamic subtest: bcs0
[497.396044] Dynamic subtest bcs0: SUCCESS (3.051s)
[497.407082] Starting dynamic subtest: vcs0
[500.443468] Dynamic subtest vcs0: SUCCESS (3.044s)
[500.453283] Starting dynamic subtest: vcs1
[503.490613] Dynamic subtest vcs1: SUCCESS (3.044s)
[503.501728] Starting dynamic subtest: vecs0
[506.538590] Dynamic subtest vecs0: SUCCESS (3.045s)
[506.548842] Starting dynamic subtest: ccs0
[509.600334] Dynamic subtest ccs0: SUCCESS (3.059s)
[509.601379] Subtest busy-accuracy-2: SUCCESS (18.304s)
[509.734585] [100/133] (532s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[509.834131] Starting subtest: yf-tiled-addfb-size-offset-overflow
[509.835977] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[509.966906] [101/133] (532s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[510.054137] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[510.054932] Starting dynamic subtest: pipe-A-default-mode
[510.345544] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[510.347163] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.292s)
[511.190662] [102/133] (531s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[511.288501] Starting subtest: x-tiled-16bpp-rotate-180
[512.655293] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.367s)
[512.832992] [103/133] (529s left) i915_pm_freq_api (freq-suspend)
[512.904292] Starting subtest: freq-suspend
[512.905186] Starting dynamic subtest: gt0
[528.757859] Dynamic subtest gt0: SUCCESS (1.607s)
[528.793598] Starting dynamic subtest: gt1
[545.817475] Dynamic subtest gt1: SUCCESS (1.610s)
[545.818391] Subtest freq-suspend: SUCCESS (3.220s)
[552.891841] [104/133] (496s left) api_intel_bb (intel-bb-blit-none)
[552.945665] Starting subtest: intel-bb-blit-none
[557.222069] Subtest intel-bb-blit-none: SUCCESS (4.121s)
[557.369406] [105/133] (491s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[557.535432] Starting subtest: dp-mst-type-1-suspend-resume
[557.537374] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[557.698517] [106/133] (491s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[557.795082] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[558.762763] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.945s)
[558.931526] [107/133] (490s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[559.042832] Starting subtest: 2x-long-cursor-vs-flip-atomic
[559.046213] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[559.213109] [108/133] (490s left) gem_exec_schedule (independent)
[559.267560] Starting subtest: independent
[559.268453] Starting dynamic subtest: rcs0
[560.557106] Dynamic subtest rcs0: SUCCESS (1.262s)
[560.568790] Starting dynamic subtest: vcs0
[562.584619] Dynamic subtest vcs0: SUCCESS (1.993s)
[562.595722] Starting dynamic subtest: vcs1
[564.626603] Dynamic subtest vcs1: SUCCESS (2.015s)
[564.638010] Starting dynamic subtest: vecs0
[566.611590] Dynamic subtest vecs0: SUCCESS (1.965s)
[566.622961] Starting dynamic subtest: ccs0
[568.556527] Dynamic subtest ccs0: SUCCESS (1.928s)
[568.557889] Subtest independent: SUCCESS (9.174s)
[568.875026] [109/133] (480s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[569.259987] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[570.066493] [110/133] (479s left) prime_vgem (basic-blt)
[570.141290] Starting subtest: basic-blt
[570.177303] Subtest basic-blt: SUCCESS (0.036s)
[570.342455] [111/133] (479s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[570.431577] Starting subtest: blocking-absolute-wf_vblank-interruptible
[570.433902] Starting dynamic subtest: A-eDP1
[579.173061] Dynamic subtest A-eDP1: SUCCESS (8.710s)
[579.184659] Starting dynamic subtest: B-eDP1
[587.901771] Dynamic subtest B-eDP1: SUCCESS (8.716s)
[587.911540] Starting dynamic subtest: C-eDP1
[596.627729] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[596.653684] Starting dynamic subtest: D-eDP1
[605.362157] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[605.365978] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.887s)
[606.596385] [112/133] (443s left) gem_lmem_swapping (heavy-multi)
[606.633717] Subtest heavy-multi: SKIP (0.000s)
[606.675640] [113/133] (442s left) gem_mmap_offset (partial-unmap)
[606.723722] Starting subtest: partial-unmap
[606.724695] Starting dynamic subtest: smem0
[607.235008] Dynamic subtest smem0: SUCCESS (0.509s)
[607.236440] Subtest partial-unmap: SUCCESS (0.510s)
[607.386789] [114/133] (442s left) syncobj_timeline (single-wait-all-signaled)
[607.439504] Starting subtest: single-wait-all-signaled
[607.440425] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[607.556987] [115/133] (442s left) kms_lease (possible-crtcs-filtering)
[607.641800] Starting subtest: possible-crtcs-filtering
[607.646669] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[607.781290] [116/133] (441s left) gem_exec_reloc (basic-wc-read)
[607.837334] Subtest basic-wc-read: SKIP (0.000s)
[607.900677] [117/133] (441s left) kms_getfb (getfb-addfb-different-handles)
[607.995755] Starting subtest: getfb-addfb-different-handles
[607.996736] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[608.113688] [118/133] (441s left) gem_ctx_exec (basic-nohangcheck)
[608.178444] Starting subtest: basic-nohangcheck
[608.443299] Subtest basic-nohangcheck: SUCCESS (0.265s)
[608.600525] [119/133] (441s left) gem_vm_create (execbuf)
[608.657013] Starting subtest: execbuf
[608.662882] Subtest execbuf: SUCCESS (0.007s)
[608.805913] [120/133] (441s left) gem_userptr_blits (map-fixed-invalidate-busy)
[608.876643] Starting subtest: map-fixed-invalidate-busy
[608.878522] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[609.035812] [121/133] (440s left) kms_pm_rpm (cursor-dpms)
[610.648081] Starting subtest: cursor-dpms
[610.650035] Subtest cursor-dpms: SKIP (0.000s)
[611.331056] [122/133] (438s left) perf (i915-ref-count)
[611.417244] Starting subtest: i915-ref-count
[611.441953] Subtest i915-ref-count: SUCCESS (0.023s)
[611.492000] [123/133] (438s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[611.598342] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[611.600171] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[611.720571] [124/133] (438s left) gem_mmap_gtt (bad-object)
[611.778237] Subtest bad-object: SKIP (0.000s)
[611.844171] [125/133] (438s left) gem_ringfill (engines-basic)
[617.583443] Starting subtest: engines-basic
[617.584664] Starting dynamic subtest: rcs0
[617.665500] Dynamic subtest rcs0: SUCCESS (0.081s)
[617.676185] Starting dynamic subtest: bcs0
[617.709845] Dynamic subtest bcs0: SUCCESS (0.043s)
[617.721967] Starting dynamic subtest: vcs0
[617.752014] Dynamic subtest vcs0: SUCCESS (0.040s)
[617.762282] Starting dynamic subtest: vcs1
[617.793939] Dynamic subtest vcs1: SUCCESS (0.040s)
[617.804704] Starting dynamic subtest: vecs0
[617.838291] Dynamic subtest vecs0: SUCCESS (0.042s)
[617.850342] Starting dynamic subtest: ccs0
[617.884175] Dynamic subtest ccs0: SUCCESS (0.044s)
[617.886792] Subtest engines-basic: SUCCESS (0.303s)
[617.983632] [126/133] (432s left) gem_exec_schedule (fifo)
[618.055668] Starting subtest: fifo
[618.056587] Starting dynamic subtest: rcs0
[618.224174] Dynamic subtest rcs0: SUCCESS (0.167s)
[618.235727] Starting dynamic subtest: vcs0
[618.322698] Dynamic subtest vcs0: SUCCESS (0.098s)
[618.333875] Starting dynamic subtest: vcs1
[618.419869] Dynamic subtest vcs1: SUCCESS (0.096s)
[618.430871] Starting dynamic subtest: vecs0
[618.517756] Dynamic subtest vecs0: SUCCESS (0.096s)
[618.529030] Starting dynamic subtest: ccs0
[618.640714] Dynamic subtest ccs0: SUCCESS (0.122s)
[618.643013] Subtest fifo: SUCCESS (0.584s)
[619.703299] [127/133] (430s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-blt)
[619.809589] Starting subtest: fbc-abgr161616f-draw-blt
[619.811447] Subtest fbc-abgr161616f-draw-blt: SKIP (0.000s)
[619.944582] [128/133] (430s left) i915_suspend (forcewake)
[619.989121] Starting subtest: forcewake
[651.765393] Subtest forcewake: SUCCESS (3.016s)
[658.878318] [129/133] (398s left) dmabuf_sync_file (import-basic)
[658.922011] Starting subtest: import-basic
[658.924378] Subtest import-basic: SUCCESS (0.003s)
[659.005356] [130/133] (398s left) prime_mmap (test_correct_cpu_write)
[659.067340] Starting subtest: test_correct_cpu_write
[659.068249] Starting dynamic subtest: test_correct_cpu_write-smem
[659.069148] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[659.070011] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[659.207123] [131/133] (398s left) kms_plane_lowres (tiling-none)
[659.315010] Starting subtest: tiling-none
[659.315897] Starting dynamic subtest: pipe-A-eDP-1
[659.317618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[659.611179] Starting dynamic subtest: pipe-B-eDP-1
[659.612850] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[659.621260] Starting dynamic subtest: pipe-C-eDP-1
[659.622956] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[659.631523] Starting dynamic subtest: pipe-D-eDP-1
[659.633299] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[659.634994] Subtest tiling-none: SKIP (0.281s)
[660.444295] [132/133] (396s left) prime_self_import (export-vs-gem_close-race)
[660.479852] Starting subtest: export-vs-gem_close-race
[665.568136] Subtest export-vs-gem_close-race: SUCCESS (4.946s)
[665.672755] [133/133] (391s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[665.804681] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[665.805798] Starting dynamic subtest: pipe-A-eDP-1
[667.869934] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.054s)
[667.879909] Starting dynamic subtest: pipe-B-eDP-1
[670.004412] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.106s)
[670.014097] Starting dynamic subtest: pipe-C-eDP-1
[672.118522] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.092s)
[672.128546] Starting dynamic subtest: pipe-D-eDP-1
[674.175189] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.040s)
[674.176102] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.296s)
[675.426646] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_hdr
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_ctx_bad_destroy
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_suspend
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: gen3_mixed_blits
results: parsing output: 12/ for test: kms_feature_discovery
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_color_pipeline
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: kms_joiner
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_ccs
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: i915_pm_rps
results: parsing output: 47/ for test: gem_ctx_engines
results: parsing output: 48/ for test: gem_tiled_fence_blits
results: parsing output: 49/ for test: gem_exec_flush
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_async_flips
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: gem_readwrite
results: parsing output: 56/ for test: kms_scaling_modes
results: parsing output: 57/ for test: kms_dp_linktrain_fallback
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: api_intel_allocator
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_pwrite
results: parsing output: 83/ for test: kms_setmode
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_ctx_bad_destroy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: i915_pm_freq_api
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_content_protection
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_chamelium_edid
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_lease
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: gem_ctx_exec
results: parsing output: 118/ for test: gem_vm_create
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: gem_ringfill
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_suspend
results: parsing output: 128/ for test: dmabuf_sync_file
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: kms_plane_lowres
results: parsing output: 131/ for test: prime_self_import
results: parsing output: 132/ for test: kms_ccs
Done.