[58.283735] Initializing watchdogs
[58.283782]   /dev/watchdog0
[58.297584] [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.301787] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.304165] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.307502] [001/131] (960s left) gem_workarounds (reset-context)
[58.398698] Starting subtest: reset-context
[58.519442] Subtest reset-context: SUCCESS (0.120s)
[58.676805] [002/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[58.789076] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[65.282759] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.494s)
[65.437270] [003/131] (953s left) gem_linear_blits (basic)
[65.767092] Starting subtest: basic
[65.778668] Subtest basic: SUCCESS (0.011s)
[65.932523] [004/131] (952s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[66.085745] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[67.120332] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.034s)
[67.436127] [005/131] (951s left) gem_mmap_gtt (coherency)
[67.519349] Subtest coherency: SKIP (0.000s)
[67.681610] [006/131] (951s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[67.771488] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[67.773890] Starting dynamic subtest: pipe-A-eDP-1
[67.783444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.792872] Starting dynamic subtest: pipe-B-eDP-1
[67.802314] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.809866] Starting dynamic subtest: pipe-C-eDP-1
[67.818820] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.825561] Starting dynamic subtest: pipe-D-eDP-1
[67.833965] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.838022] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[70.095448] [007/131] (948s left) gem_eio (in-flight-suspend)
[70.255292] Starting subtest: in-flight-suspend
[117.297990] Subtest in-flight-suspend: SUCCESS (17.577s)
[117.467069] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[117.470260] [008/131] (901s left) kms_psr (psr-sprite-mmap-cpu)
[117.583512] Starting subtest: psr-sprite-mmap-cpu
[117.586346] Starting dynamic subtest: eDP-1
[119.368882] Dynamic subtest eDP-1: SUCCESS (1.782s)
[119.371309] Subtest psr-sprite-mmap-cpu: SUCCESS (1.783s)
[120.242983] [009/131] (898s left) gem_exec_alignment (pi)
[120.310897] Starting subtest: pi
[168.327947] Subtest pi: SUCCESS (47.990s)
[169.494257] [010/131] (849s left) kms_lease (lease-revoke)
[169.639091] Starting subtest: lease-revoke
[169.641456] Starting dynamic subtest: pipe-A-eDP-1
[169.677193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.038s)
[169.688494] Starting dynamic subtest: pipe-B-eDP-1
[169.703658] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[169.712261] Starting dynamic subtest: pipe-C-eDP-1
[169.732132] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[169.741073] Starting dynamic subtest: pipe-D-eDP-1
[169.762883] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.030s)
[169.765206] Subtest lease-revoke: SUCCESS (0.126s)
[169.910505] [011/131] (849s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[170.020800] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[170.023218] Starting dynamic subtest: pipe-A-eDP-1
[170.045628] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.054541] Starting dynamic subtest: pipe-B-eDP-1
[170.076167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.085796] Starting dynamic subtest: pipe-C-eDP-1
[170.106883] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.114952] Starting dynamic subtest: pipe-D-eDP-1
[170.136492] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.140795] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[172.228349] [012/131] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[172.327895] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[172.332481] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[172.454368] [013/131] (846s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[177.484966] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[177.489959] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[178.399018] [014/131] (840s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[178.518366] Starting subtest: short-flip-after-cursor-toggle
[179.482659] Subtest short-flip-after-cursor-toggle: SUCCESS (0.962s)
[180.302988] [015/131] (839s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[180.428039] Starting subtest: x-tiled-addfb-size-offset-overflow
[180.430365] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[180.565127] [016/131] (838s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[180.662183] Starting subtest: bad-pixel-format-y-tiled-ccs
[180.664525] Starting dynamic subtest: pipe-A-eDP-1
[180.687562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.702584] Starting dynamic subtest: pipe-B-eDP-1
[180.725069] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.736042] Starting dynamic subtest: pipe-C-eDP-1
[180.757958] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.767099] Starting dynamic subtest: pipe-D-eDP-1
[180.790840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.795068] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[182.885724] [017/131] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[182.985034] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[182.989539] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[183.115179] [018/131] (836s left) drm_read (empty-block)
[183.253515] Starting subtest: empty-block
[184.256089] Subtest empty-block: SUCCESS (1.000s)
[184.422281] [019/131] (835s left) syncobj_wait (multi-wait-all-submitted)
[184.484983] Starting subtest: multi-wait-all-submitted
[184.592231] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[184.690347] [020/131] (834s left) perf_pmu (semaphore-wait-idle)
[184.732024] Starting subtest: semaphore-wait-idle
[184.734116] Starting dynamic subtest: rcs0
[185.244844] Dynamic subtest rcs0: SUCCESS (0.512s)
[185.256892] Starting dynamic subtest: bcs0
[185.759734] Dynamic subtest bcs0: SUCCESS (0.513s)
[185.770027] Starting dynamic subtest: vcs0
[186.272760] Dynamic subtest vcs0: SUCCESS (0.511s)
[186.285177] Starting dynamic subtest: vcs1
[186.784231] Dynamic subtest vcs1: SUCCESS (0.510s)
[186.796360] Starting dynamic subtest: vecs0
[187.295746] Dynamic subtest vecs0: SUCCESS (0.510s)
[187.307082] Starting dynamic subtest: ccs0
[187.809718] Dynamic subtest ccs0: SUCCESS (0.513s)
[187.812482] Subtest semaphore-wait-idle: SUCCESS (3.078s)
[187.946947] [021/131] (831s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[188.009237] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[188.011709] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[188.125145] [022/131] (831s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[188.234163] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[189.046674] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.814s)
[189.256580] [023/131] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[189.351573] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[189.355574] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[189.457404] [024/131] (830s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[189.569900] Starting subtest: cursorA-vs-flipB-atomic-transitions
[189.574275] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[189.738150] [025/131] (830s left) gem_ctx_param (invalid-get-no-zeromap)
[189.783982] Starting subtest: invalid-get-no-zeromap
[189.786325] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[189.906590] [026/131] (829s left) kms_pm_backlight (bad-brightness)
[190.004516] Starting subtest: bad-brightness
[190.051623] Starting dynamic subtest: eDP-1
[190.374680] Dynamic subtest eDP-1: SUCCESS (0.321s)
[190.377134] Subtest bad-brightness: SUCCESS (0.370s)
[191.230379] [027/131] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[191.337387] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[191.341392] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[191.482158] [028/131] (828s left) gem_vm_create (invalid-destroy)
[191.555004] Starting subtest: invalid-destroy
[191.566533] Subtest invalid-destroy: SUCCESS (0.003s)
[191.685057] [029/131] (828s left) perf (gen12-group-concurrent-oa-buffer-read)
[191.843139] Starting subtest: gen12-group-concurrent-oa-buffer-read
[201.875928] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.029s)
[201.922692] [030/131] (818s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[202.019992] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[202.022306] Starting dynamic subtest: pipe-A-eDP-1
[202.041866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[202.052337] Starting dynamic subtest: pipe-B-eDP-1
[202.070966] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.079705] Starting dynamic subtest: pipe-C-eDP-1
[202.099530] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[202.110123] Starting dynamic subtest: pipe-D-eDP-1
[202.130195] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[202.132237] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[204.197454] [031/131] (815s left) gem_exec_reloc (basic-wc-active)
[204.253461] Subtest basic-wc-active: SKIP (0.000s)
[204.337918] [032/131] (815s left) syncobj_timeline (invalid-signal-illegal-handle)
[204.395202] Starting subtest: invalid-signal-illegal-handle
[204.397082] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[204.538968] [033/131] (815s left) kms_psr (fbc-pr-primary-page-flip)
[204.638008] Starting subtest: fbc-pr-primary-page-flip
[204.641983] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[204.730769] [034/131] (815s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[204.826765] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[204.830635] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[204.958560] [035/131] (815s left) kms_flip (plain-flip-interruptible)
[205.058722] Starting subtest: plain-flip-interruptible
[205.061047] Starting dynamic subtest: A-eDP1
[206.681756] Dynamic subtest A-eDP1: SUCCESS (1.622s)
[206.699719] Starting dynamic subtest: B-eDP1
[208.306190] Dynamic subtest B-eDP1: SUCCESS (1.622s)
[208.318213] Starting dynamic subtest: C-eDP1
[209.930668] Dynamic subtest C-eDP1: SUCCESS (1.622s)
[209.941923] Starting dynamic subtest: D-eDP1
[211.570861] Dynamic subtest D-eDP1: SUCCESS (1.639s)
[211.577182] Subtest plain-flip-interruptible: SUCCESS (6.517s)
[212.778713] [036/131] (807s left) dmabuf_sync_file (import-multiple-read-only)
[212.823166] Starting subtest: import-multiple-read-only
[212.825452] Subtest import-multiple-read-only: SUCCESS (0.002s)
[212.903620] [037/131] (807s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[213.010490] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[213.014867] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[213.150785] [038/131] (807s left) kms_plane_cursor (overlay)
[213.243710] Starting subtest: overlay
[213.248299] Starting dynamic subtest: pipe-A-eDP-1-size-64
[215.638243] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.393s)
[215.698216] Starting dynamic subtest: pipe-A-eDP-1-size-128
[218.105105] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.415s)
[218.165548] Starting dynamic subtest: pipe-A-eDP-1-size-256
[220.583260] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.427s)
[220.931273] Starting dynamic subtest: pipe-B-eDP-1-size-64
[224.092609] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.173s)
[224.153794] Starting dynamic subtest: pipe-B-eDP-1-size-128
[226.659864] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s)
[226.720182] Starting dynamic subtest: pipe-B-eDP-1-size-256
[229.194362] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[229.544478] Starting dynamic subtest: pipe-C-eDP-1-size-64
[232.433375] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s)
[232.471783] Starting dynamic subtest: pipe-C-eDP-1-size-128
[234.532891] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.069s)
[234.570780] Starting dynamic subtest: pipe-C-eDP-1-size-256
[236.621815] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.058s)
[236.949207] Starting dynamic subtest: pipe-D-eDP-1-size-64
[239.689455] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.750s)
[239.725734] Starting dynamic subtest: pipe-D-eDP-1-size-128
[241.855520] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.135s)
[241.892289] Starting dynamic subtest: pipe-D-eDP-1-size-256
[244.009629] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.124s)
[244.328194] Subtest overlay: SUCCESS (31.087s)
[245.193751] [039/131] (775s left) gen3_mixed_blits
[245.336155] [040/131] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[245.432101] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[249.109092] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.680s)
[250.282251] [041/131] (770s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[250.388789] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[250.391206] Starting dynamic subtest: pipe-A-default-mode
[250.682442] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[250.687113] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.293s)
[251.508210] [042/131] (768s left) kms_rotation_crc (cursor-rotation-180)
[251.612913] Starting subtest: cursor-rotation-180
[253.168741] Subtest cursor-rotation-180: SUCCESS (1.556s)
[254.377115] [043/131] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[254.472095] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[254.476341] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[254.598289] [044/131] (765s left) syncobj_wait (wait-all-interrupted)
[254.672737] Starting subtest: wait-all-interrupted
[254.773412] Subtest wait-all-interrupted: SUCCESS (0.102s)
[254.873102] [045/131] (765s left) gem_exec_flush (basic-batch-kernel-default-wb)
[254.938796] Starting subtest: basic-batch-kernel-default-wb
[261.984563] Subtest basic-batch-kernel-default-wb: SUCCESS (7.046s)
[262.195450] [046/131] (758s left) api_intel_bb (render)
[262.255156] Starting subtest: render
[262.257851] Starting dynamic subtest: render-none-512
[262.363660] Dynamic subtest render-none-512: SUCCESS (0.107s)
[262.375508] Starting dynamic subtest: render-none-1024
[263.034684] Dynamic subtest render-none-1024: SUCCESS (0.668s)
[263.045335] Starting dynamic subtest: render-x-512
[263.121266] Dynamic subtest render-x-512: SUCCESS (0.086s)
[263.131741] Starting dynamic subtest: render-x-1024
[263.520753] Dynamic subtest render-x-1024: SUCCESS (0.398s)
[263.531074] Starting dynamic subtest: render-y-512
[263.608358] Dynamic subtest render-y-512: SUCCESS (0.088s)
[263.620004] Starting dynamic subtest: render-y-1024
[264.201401] Dynamic subtest render-y-1024: SUCCESS (0.591s)
[264.204026] Subtest render: SUCCESS (1.946s)
[264.362393] [047/131] (756s left) kms_flip (2x-blocking-absolute-wf_vblank)
[264.466229] Starting subtest: 2x-blocking-absolute-wf_vblank
[264.474913] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[264.606165] [048/131] (756s left) kms_psr (pr-primary-mmap-gtt)
[264.702611] Starting subtest: pr-primary-mmap-gtt
[264.706524] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[264.795177] [049/131] (755s left) gem_render_copy (linear-to-vebox-yf-tiled)
[264.864805] Starting subtest: linear-to-vebox-yf-tiled
[264.869272] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[265.067618] [050/131] (755s left) kms_pm_lpsp (kms-lpsp)
[266.167693] Starting subtest: kms-lpsp
[266.169631] Starting dynamic subtest: pipe-A-eDP-1
[266.313682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[266.609050] Subtest kms-lpsp: SUCCESS (0.440s)
[267.505935] [051/131] (753s left) kms_addfb_basic (bad-pitch-999)
[267.579978] Starting subtest: bad-pitch-999
[267.582296] Subtest bad-pitch-999: SUCCESS (0.000s)
[267.745814] [052/131] (753s left) kms_getfb (getfb2-handle-zero)
[267.834517] Starting subtest: getfb2-handle-zero
[267.836364] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[267.961937] [053/131] (752s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[268.068792] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[268.072878] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[268.199565] [054/131] (752s left) syncobj_timeline (etime-multi-wait-all-submitted)
[268.251100] Starting subtest: etime-multi-wait-all-submitted
[268.351372] Subtest etime-multi-wait-all-submitted: SUCCESS (0.101s)
[268.452242] [055/131] (752s left) syncobj_timeline (single-wait-all-available-submitted)
[268.516715] Starting subtest: single-wait-all-available-submitted
[268.518498] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[268.648196] [056/131] (752s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[268.692054] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[268.801009] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[268.902544] [057/131] (752s left) kms_cursor_crc (cursor-onscreen-128x128)
[269.097833] Starting subtest: cursor-onscreen-128x128
[269.102830] Starting dynamic subtest: pipe-A-eDP-1
[271.208235] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.107s)
[271.238677] Starting dynamic subtest: pipe-D-eDP-1
[273.945412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.716s)
[273.947813] Subtest cursor-onscreen-128x128: SUCCESS (4.847s)
[274.773711] [058/131] (746s left) syncobj_wait (wait-all-complex)
[274.836855] Starting subtest: wait-all-complex
[275.052784] Subtest wait-all-complex: SUCCESS (0.213s)
[275.150731] [059/131] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[275.259155] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[275.263178] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[275.388421] [060/131] (745s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[275.460348] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[275.546562] [061/131] (745s left) kms_prop_blob (invalid-set-prop)
[275.612724] Starting subtest: invalid-set-prop
[275.614949] Subtest invalid-set-prop: SUCCESS (0.000s)
[275.753911] [062/131] (745s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[275.857682] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[275.859966] Starting dynamic subtest: pipe-A
[276.209882] Dynamic subtest pipe-A: SUCCESS (0.352s)
[276.219118] Starting dynamic subtest: pipe-B
[277.642874] Dynamic subtest pipe-B: SUCCESS (1.432s)
[277.651918] Starting dynamic subtest: pipe-C
[279.100575] Dynamic subtest pipe-C: SUCCESS (1.457s)
[279.110702] Starting dynamic subtest: pipe-D
[280.540707] Dynamic subtest pipe-D: SUCCESS (1.439s)
[280.543003] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.684s)
[281.706394] [063/131] (739s left) kms_psr (fbc-psr-dpms)
[281.815141] Starting subtest: fbc-psr-dpms
[281.817431] Starting dynamic subtest: eDP-1
[281.821622] Dynamic subtest eDP-1: SKIP (0.000s)
[281.825868] Subtest fbc-psr-dpms: SKIP (0.001s)
[281.915704] [064/131] (739s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[282.016678] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[282.020574] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[282.130076] [065/131] (739s left) kms_addfb_basic (bo-too-small)
[282.215493] Starting subtest: bo-too-small
[282.217680] Subtest bo-too-small: SUCCESS (0.000s)
[282.344277] [066/131] (739s left) kms_flip (bo-too-big-interruptible)
[282.438957] Starting subtest: bo-too-big-interruptible
[282.441089] Starting dynamic subtest: A-eDP1
[283.725880] Dynamic subtest A-eDP1: SUCCESS (1.284s)
[283.736884] Starting dynamic subtest: B-eDP1
[284.959793] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[284.969379] Starting dynamic subtest: C-eDP1
[286.210779] Dynamic subtest C-eDP1: SUCCESS (1.249s)
[286.221294] Starting dynamic subtest: D-eDP1
[287.456725] Dynamic subtest D-eDP1: SUCCESS (1.245s)
[287.459043] Subtest bo-too-big-interruptible: SUCCESS (5.019s)
[288.685747] [067/131] (732s left) kms_properties (connector-properties-legacy)
[288.777721] Starting subtest: connector-properties-legacy
[288.779961] Starting dynamic subtest: pipe-A-eDP-1
[296.822994] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.045s)
[296.833372] Starting dynamic subtest: pipe-None-DP-1
[296.837931] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[296.846157] Starting dynamic subtest: pipe-None-HDMI-A-1
[296.850347] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[296.858917] Starting dynamic subtest: pipe-None-DP-2
[296.863352] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[296.871742] Starting dynamic subtest: pipe-None-HDMI-A-2
[296.876166] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[296.884935] Starting dynamic subtest: pipe-None-DP-3
[296.890169] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[296.901521] Starting dynamic subtest: pipe-None-DP-4
[296.906092] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[296.908417] Subtest connector-properties-legacy: SUCCESS (8.057s)
[297.717620] [068/131] (723s left) gem_eio (wait-immediate)
[297.958703] Starting subtest: wait-immediate
[298.342452] Subtest wait-immediate: SUCCESS (0.385s)
[298.524860] [069/131] (723s left) i915_pm_sseu (full-enable)
[298.594042] Subtest full-enable: SKIP (0.000s)
[298.726233] [070/131] (722s left) kms_pm_rpm (modeset-lpsp-stress)
[300.565926] Starting subtest: modeset-lpsp-stress
[316.629467] Subtest modeset-lpsp-stress: SUCCESS (16.064s)
[316.757118] [071/131] (704s left) gem_gpgpu_fill (basic)
[316.828825] Starting subtest: basic
[316.830961] Starting dynamic subtest: smem
[316.838100] Dynamic subtest smem: SUCCESS (0.011s)
[316.840239] Subtest basic: SUCCESS (0.012s)
[317.023624] [072/131] (704s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[317.131682] Starting subtest: 4-tiled-16bpp-rotate-180
[318.365723] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.233s)
[318.544580] [073/131] (703s left) gem_exec_schedule (semaphore-power)
[318.733731] Subtest semaphore-power: SKIP (0.000s)
[318.935279] [074/131] (702s left) kms_cursor_edge_walk (256x256-right-edge)
[319.034344] Starting subtest: 256x256-right-edge
[319.036479] Starting dynamic subtest: pipe-A-eDP-1
[322.509093] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[322.519145] Starting dynamic subtest: pipe-D-eDP-1
[325.697465] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.187s)
[325.699673] Subtest 256x256-right-edge: SUCCESS (6.663s)
[326.532396] [075/131] (695s left) kms_lease (setcrtc-implicit-plane)
[326.636441] Starting subtest: setcrtc-implicit-plane
[326.638626] Starting dynamic subtest: pipe-A-eDP-1
[327.102107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s)
[327.112860] Starting dynamic subtest: pipe-B-eDP-1
[328.233780] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[328.243930] Starting dynamic subtest: pipe-C-eDP-1
[329.333786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s)
[329.343994] Starting dynamic subtest: pipe-D-eDP-1
[330.472458] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[330.474804] Subtest setcrtc-implicit-plane: SUCCESS (3.837s)
[331.344414] [076/131] (690s left) syncobj_wait (wait-all-for-submit-snapshot)
[331.400805] Starting subtest: wait-all-for-submit-snapshot
[331.480935] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[331.584547] [077/131] (690s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[331.636438] Starting subtest: invalid-bsd2-flag-on-vebox
[331.638746] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[331.771099] [078/131] (690s left) kms_setmode (basic)
[331.834959] Starting subtest: basic
[332.161168] Starting dynamic subtest: pipe-A-eDP-1
[334.238563] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s)
[334.580374] Starting dynamic subtest: pipe-B-eDP-1
[336.673933] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.097s)
[336.983898] Subtest basic: SUCCESS (5.147s)
[337.833014] [079/131] (684s left) i915_hangman (hangcheck-unterminated)
[337.904368] Starting subtest: hangcheck-unterminated
[349.322526] Subtest hangcheck-unterminated: SUCCESS (11.417s)
[349.490815] [080/131] (672s left) gem_mmap_offset (clear)
[349.561662] Starting subtest: clear
[349.563958] Starting dynamic subtest: smem0
[374.750009] Dynamic subtest smem0: SUCCESS (25.185s)
[374.751867] Subtest clear: SUCCESS (25.187s)
[374.925872] [081/131] (647s left) kms_psr (fbc-psr2-sprite-blt)
[375.081912] Starting subtest: fbc-psr2-sprite-blt
[375.084185] Starting dynamic subtest: eDP-1
[375.088473] Dynamic subtest eDP-1: SKIP (0.000s)
[375.092669] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[375.181265] [082/131] (646s left) gem_busy (extended)
[375.361940] Starting subtest: extended
[375.363856] Starting dynamic subtest: rcs0
[375.456460] Dynamic subtest rcs0: SUCCESS (0.098s)
[375.468616] Starting dynamic subtest: bcs0
[375.499827] Dynamic subtest bcs0: SUCCESS (0.041s)
[375.510446] Starting dynamic subtest: vcs0
[377.388339] Dynamic subtest vcs0: SUCCESS (1.885s)
[377.400773] Starting dynamic subtest: vcs1
[379.372144] Dynamic subtest vcs1: SUCCESS (1.981s)
[379.384292] Starting dynamic subtest: vecs0
[381.356173] Dynamic subtest vecs0: SUCCESS (1.981s)
[381.368594] Starting dynamic subtest: ccs0
[381.400070] Dynamic subtest ccs0: SUCCESS (0.044s)
[381.402462] Subtest extended: SUCCESS (6.043s)
[381.684460] [083/131] (640s left) gem_exec_whisper (basic-contexts-all)
[381.749870] Starting subtest: basic-contexts-all
[395.341118] Subtest basic-contexts-all: SUCCESS (13.589s)
[395.552614] [084/131] (626s left) gem_mmap_gtt (big-copy-odd)
[395.598107] Subtest big-copy-odd: SKIP (0.000s)
[395.667351] [085/131] (626s left) gem_readwrite (beyond-eob)
[395.730130] Subtest beyond-EOB: SKIP (0.000s)
[395.799191] [086/131] (626s left) gem_exec_flush (basic-uc-pro-default)
[395.853626] Starting subtest: basic-uc-pro-default
[401.322146] Subtest basic-uc-pro-default: SUCCESS (5.469s)
[401.537745] [087/131] (620s left) kms_joiner (basic-force-ultra-joiner)
[401.644191] Starting subtest: basic-force-ultra-joiner
[401.648511] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[401.733440] [088/131] (620s left) gem_tiled_pread_pwrite
[401.864986] [089/131] (620s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[402.030146] Starting subtest: cursor-rapid-movement-32x10
[402.074652] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[402.375628] [090/131] (620s left) kms_content_protection (dp-mst-lic-type-1)
[402.515044] Starting subtest: dp-mst-lic-type-1
[402.518883] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[402.674075] [091/131] (619s left) kms_addfb_basic (addfb25-4-tiled)
[402.773015] Starting subtest: addfb25-4-tiled
[402.774888] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[402.891886] [092/131] (619s left) sysfs_timeslice_duration (invalid)
[402.964599] Starting subtest: invalid
[402.966588] Starting dynamic subtest: vecs0
[402.968571] Dynamic subtest vecs0: SUCCESS (0.000s)
[402.977870] Starting dynamic subtest: ccs0
[402.979779] Dynamic subtest ccs0: SUCCESS (0.000s)
[402.988442] Starting dynamic subtest: vcs0
[402.990252] Dynamic subtest vcs0: SUCCESS (0.000s)
[402.998651] Starting dynamic subtest: bcs0
[403.000498] Dynamic subtest bcs0: SUCCESS (0.000s)
[403.008949] Starting dynamic subtest: rcs0
[403.010809] Dynamic subtest rcs0: SUCCESS (0.000s)
[403.019594] Starting dynamic subtest: vcs1
[403.021463] Dynamic subtest vcs1: SUCCESS (0.000s)
[403.023364] Subtest invalid: SUCCESS (0.006s)
[403.109307] [093/131] (619s left) gem_spin_batch (legacy-resubmit)
[403.181142] Starting subtest: legacy-resubmit
[403.183106] Starting dynamic subtest: default
[403.185090] Dynamic subtest default: SUCCESS (0.006s)
[403.195570] Starting dynamic subtest: render
[403.197108] Dynamic subtest render: SUCCESS (0.001s)
[403.206422] Starting dynamic subtest: bsd
[403.208175] Dynamic subtest bsd: SUCCESS (0.002s)
[403.217201] Starting dynamic subtest: bsd1
[403.219119] Dynamic subtest bsd1: SUCCESS (0.002s)
[403.228193] Starting dynamic subtest: bsd2
[403.229973] Dynamic subtest bsd2: SUCCESS (0.001s)
[403.238392] Starting dynamic subtest: blt
[403.240125] Dynamic subtest blt: SUCCESS (0.002s)
[403.248676] Starting dynamic subtest: vebox
[403.250450] Dynamic subtest vebox: SUCCESS (0.003s)
[403.252201] Subtest legacy-resubmit: SUCCESS (0.024s)
[403.459656] [094/131] (619s left) gem_exec_fence (parallel)
[403.635349] Starting subtest: parallel
[403.637680] Starting dynamic subtest: rcs0
[405.784621] Dynamic subtest rcs0: SUCCESS (2.149s)
[405.795648] Starting dynamic subtest: bcs0
[407.939494] Dynamic subtest bcs0: SUCCESS (2.154s)
[407.950955] Starting dynamic subtest: vcs0
[410.091680] Dynamic subtest vcs0: SUCCESS (2.151s)
[410.103585] Starting dynamic subtest: vcs1
[412.241046] Dynamic subtest vcs1: SUCCESS (2.149s)
[412.252166] Starting dynamic subtest: vecs0
[414.392729] Dynamic subtest vecs0: SUCCESS (2.151s)
[414.401732] Starting dynamic subtest: ccs0
[416.547597] Dynamic subtest ccs0: SUCCESS (2.154s)
[416.549604] Subtest parallel: SUCCESS (12.913s)
[417.516906] [095/131] (605s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[417.625125] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[417.629725] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.754539] [096/131] (604s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[417.858298] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[421.943241] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.089s)
[423.138821] [097/131] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[423.258729] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[430.236252] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.978s)
[430.390855] [098/131] (592s left) kms_cursor_edge_walk (64x64-top-edge)
[430.488564] Starting subtest: 64x64-top-edge
[430.490929] Starting dynamic subtest: pipe-A-eDP-1
[433.906149] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.417s)
[433.918988] Starting dynamic subtest: pipe-D-eDP-1
[437.029923] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[437.031894] Subtest 64x64-top-edge: SUCCESS (6.541s)
[437.869894] [099/131] (584s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[437.974546] Starting subtest: y-tiled-addfb-size-offset-overflow
[437.978530] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[438.109133] [100/131] (584s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[438.203494] Starting subtest: random-ccs-data-y-tiled-ccs
[438.205729] Starting dynamic subtest: pipe-A-eDP-1
[438.230692] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.241419] Starting dynamic subtest: pipe-B-eDP-1
[438.265486] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.274157] Starting dynamic subtest: pipe-C-eDP-1
[438.297772] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.306575] Starting dynamic subtest: pipe-D-eDP-1
[438.330678] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.335099] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[440.528515] [101/131] (582s left) gem_exec_schedule (pi-userfault)
[440.727057] Starting subtest: pi-userfault
[440.729433] Starting dynamic subtest: rcs0
[440.738174] Dynamic subtest rcs0: SUCCESS (0.012s)
[440.750378] Starting dynamic subtest: bcs0
[440.752728] Dynamic subtest bcs0: SUCCESS (0.008s)
[440.762397] Starting dynamic subtest: vcs0
[440.764415] Dynamic subtest vcs0: SUCCESS (0.007s)
[440.774124] Starting dynamic subtest: vcs1
[440.776512] Dynamic subtest vcs1: SUCCESS (0.008s)
[440.786373] Starting dynamic subtest: vecs0
[440.788798] Dynamic subtest vecs0: SUCCESS (0.009s)
[440.797377] Starting dynamic subtest: ccs0
[440.799381] Dynamic subtest ccs0: SUCCESS (0.010s)
[440.801379] Subtest pi-userfault: SUCCESS (0.061s)
[440.989746] [102/131] (581s left) prime_vgem (basic-blt)
[441.087340] Starting subtest: basic-blt
[441.111768] Subtest basic-blt: SUCCESS (0.024s)
[441.283863] [103/131] (581s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[441.678939] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[442.513249] [104/131] (580s left) gem_exec_balancer (indices)
[442.577177] Starting subtest: indices
[445.322308] Subtest indices: SUCCESS (2.743s)
[445.653890] [105/131] (577s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[445.770293] Starting subtest: fbc-farfromfence-mmap-gtt
[445.774797] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[445.925542] [106/131] (577s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[445.980269] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[446.053534] [107/131] (577s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[446.154085] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[446.156692] Starting dynamic subtest: pipe-A-default-mode
[446.454301] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[446.458926] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.302s)
[447.293830] [108/131] (575s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[447.359225] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[447.442528] [109/131] (575s left) gem_exec_endless (dispatch)
[447.509712] Starting subtest: dispatch
[447.512870] Starting dynamic subtest: rcs0
[447.518169] Dynamic subtest rcs0: SUCCESS (0.005s)
[447.533416] Starting dynamic subtest: bcs0
[447.538172] Dynamic subtest bcs0: SUCCESS (0.005s)
[447.548487] Starting dynamic subtest: vcs0
[447.552820] Dynamic subtest vcs0: SUCCESS (0.006s)
[447.562059] Starting dynamic subtest: vcs1
[447.566113] Dynamic subtest vcs1: SUCCESS (0.004s)
[447.575548] Starting dynamic subtest: vecs0
[447.579415] Dynamic subtest vecs0: SUCCESS (0.005s)
[447.588510] Starting dynamic subtest: ccs0
[447.592496] Dynamic subtest ccs0: SUCCESS (0.004s)
[447.594401] Subtest dispatch: SUCCESS (0.034s)
[449.451265] [110/131] (573s left) kms_vblank (wait-busy)
[449.546387] Starting subtest: wait-busy
[449.548522] Starting dynamic subtest: pipe-A-eDP-1
[451.432099] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[451.446374] Starting dynamic subtest: pipe-D-eDP-1
[454.040383] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.607s)
[454.042598] Subtest wait-busy: SUCCESS (4.496s)
[454.858556] [111/131] (568s left) kms_big_fb (4-tiled-addfb-size-overflow)
[454.959094] Starting subtest: 4-tiled-addfb-size-overflow
[454.961264] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[455.086243] [112/131] (568s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[455.191906] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[455.195901] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[455.328466] [113/131] (568s left) gen9_exec_parse (allowed-single)
[455.394548] Subtest allowed-single: SKIP (0.000s)
[455.478240] [114/131] (568s left) gem_create (busy-create)
[455.535575] Starting subtest: busy-create
[455.538074] Starting dynamic subtest: smem0
[488.309622] Dynamic subtest smem0: SUCCESS (32.768s)
[488.312337] Subtest busy-create: SUCCESS (32.770s)
[488.521245] [115/131] (535s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[488.586832] Starting subtest: y-tiled-to-vebox-x-tiled
[488.591468] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[488.801266] [116/131] (534s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[488.919833] Starting subtest: 2x-flip-vs-cursor-atomic
[488.924409] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[489.089772] [117/131] (534s left) syncobj_timeline (wait-all-snapshot)
[489.145797] Starting subtest: wait-all-snapshot
[489.226152] Subtest wait-all-snapshot: SUCCESS (0.082s)
[489.325978] [118/131] (534s left) vgem_basic (dmabuf-export)
[489.369975] Starting subtest: dmabuf-export
[489.414649] Subtest dmabuf-export: SUCCESS (0.050s)
[489.560614] [119/131] (534s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[489.645807] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[489.648003] Starting dynamic subtest: pipe-A-eDP-1
[489.670722] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.683208] Starting dynamic subtest: pipe-B-eDP-1
[489.704570] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.714163] Starting dynamic subtest: pipe-C-eDP-1
[489.731524] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.740439] Starting dynamic subtest: pipe-D-eDP-1
[489.758346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.761885] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[491.831147] [120/131] (531s left) i915_pm_rpm (system-suspend)
[493.570568] Starting subtest: system-suspend
[511.885743] Subtest system-suspend: SUCCESS (2.880s)
[512.284648] [121/131] (511s left) kms_universal_plane (disable-primary-vs-flip)
[512.388864] Starting subtest: disable-primary-vs-flip
[512.391219] Starting dynamic subtest: pipe-A-eDP-1
[513.950940] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.557s)
[513.961364] Starting dynamic subtest: pipe-B-eDP-1
[516.205093] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.247s)
[516.215570] Starting dynamic subtest: pipe-C-eDP-1
[518.436077] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.225s)
[518.447070] Starting dynamic subtest: pipe-D-eDP-1
[520.604830] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.165s)
[520.607041] Subtest disable-primary-vs-flip: SUCCESS (8.200s)
[521.430727] [122/131] (502s left) gem_pwrite (basic-self)
[521.498332] Subtest basic-self: SKIP (0.000s)
[521.578443] [123/131] (502s left) gem_ctx_persistence (legacy-engines-mixed)
[521.637037] Starting subtest: legacy-engines-mixed
[521.639165] Starting dynamic subtest: render
[521.733903] Dynamic subtest render: SUCCESS (0.096s)
[521.749364] Starting dynamic subtest: bsd1
[521.802335] Dynamic subtest bsd1: SUCCESS (0.065s)
[521.817943] Starting dynamic subtest: bsd2
[521.886329] Dynamic subtest bsd2: SUCCESS (0.081s)
[521.898213] Starting dynamic subtest: blt
[521.960178] Dynamic subtest blt: SUCCESS (0.071s)
[521.972496] Starting dynamic subtest: vebox
[522.033596] Dynamic subtest vebox: SUCCESS (0.070s)
[522.036337] Subtest legacy-engines-mixed: SUCCESS (0.397s)
[522.143494] [124/131] (501s left) api_intel_allocator (two-level-inception-interruptible)
[522.206639] Starting subtest: two-level-inception-interruptible
[527.618539] Subtest two-level-inception-interruptible: SUCCESS (5.404s)
[527.778610] [125/131] (496s left) i915_drm_fdinfo (busy)
[527.823775] Starting subtest: busy
[527.826037] Starting dynamic subtest: rcs0
[527.874411] Dynamic subtest rcs0: SKIP (0.049s)
[527.887183] Starting dynamic subtest: bcs0
[527.891485] Dynamic subtest bcs0: SKIP (0.001s)
[527.900581] Starting dynamic subtest: vcs0
[527.904513] Dynamic subtest vcs0: SKIP (0.000s)
[527.913900] Starting dynamic subtest: vcs1
[527.918128] Dynamic subtest vcs1: SKIP (0.000s)
[527.927403] Starting dynamic subtest: vecs0
[527.931760] Dynamic subtest vecs0: SKIP (0.000s)
[527.942740] Starting dynamic subtest: ccs0
[527.946982] Dynamic subtest ccs0: SKIP (0.000s)
[527.951268] Subtest busy: SKIP (0.057s)
[527.991561] [126/131] (496s left) kms_dp_link_training (uhbr-mst)
[528.100919] Starting subtest: uhbr-mst
[528.109923] Subtest uhbr-mst: SKIP (0.000s)
[528.203979] [127/131] (495s left) kms_psr (psr-cursor-mmap-gtt)
[528.311380] Starting subtest: psr-cursor-mmap-gtt
[528.313654] Starting dynamic subtest: eDP-1
[530.018584] Dynamic subtest eDP-1: SUCCESS (1.706s)
[530.020942] Subtest psr-cursor-mmap-gtt: SUCCESS (1.707s)
[530.917252] [128/131] (493s left) gem_flink_race (flink_close)
[530.952320] Starting subtest: flink_close
[536.063753] Subtest flink_close: SUCCESS (5.106s)
[536.170740] [129/131] (487s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[536.286364] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[536.298336] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[536.406584] [130/131] (487s left) kms_chamelium_hpd (dp-hpd)
[536.801756] Subtest dp-hpd: SKIP (0.000s)
[537.600405] [131/131] (486s left) gem_exec_fence (syncobj-timeline-repeat)
[538.174217] Starting subtest: syncobj-timeline-repeat
[538.447520] Subtest syncobj-timeline-repeat: SUCCESS (0.276s)
[539.981539] Closing watchdogs
results: parsing output: 0/ for test: gem_workarounds
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_linear_blits
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_exec_alignment
results: parsing output: 9/ for test: kms_lease
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: drm_read
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_ctx_param
results: parsing output: 25/ for test: kms_pm_backlight
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_vm_create
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: dmabuf_sync_file
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_plane_cursor
results: parsing output: 38/ for test: gen3_mixed_blits
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_pm_lpsp
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_getfb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_prop_blob
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: i915_pm_sseu
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_gpgpu_fill
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_cursor_edge_walk
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_setmode
results: parsing output: 78/ for test: i915_hangman
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gem_busy
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: gem_readwrite
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: gem_tiled_pread_pwrite
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_content_protection
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: sysfs_timeslice_duration
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_edge_walk
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_pipe_b_c_ivb
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gem_exec_endless
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: vgem_basic
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_universal_plane
results: parsing output: 121/ for test: gem_pwrite
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: kms_dp_link_training
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_flink_race
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: gem_exec_fence
Done.