[57.085830] Initializing watchdogs
[57.085878]   /dev/watchdog0
[57.101200] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.105856] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.108206] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.111569] [001/156] (960s left) gem_workarounds (basic-read)
[57.205997] Starting subtest: basic-read
[57.223967] Subtest basic-read: SUCCESS (0.020s)
[57.358505] [002/156] (960s left) kms_cursor_crc (cursor-random-256x256)
[57.614900] Starting subtest: cursor-random-256x256
[57.632222] Starting dynamic subtest: pipe-A-eDP-1
[61.861715] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.164s)
[61.898061] Starting dynamic subtest: pipe-D-eDP-1
[65.459423] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.535s)
[65.461400] Subtest cursor-random-256x256: SUCCESS (7.751s)
[66.313655] [003/156] (951s left) kms_color (ctm-0-50)
[66.414958] Starting subtest: ctm-0-50
[66.417229] Starting dynamic subtest: pipe-A-eDP-1
[69.956730] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.526s)
[69.964682] Starting dynamic subtest: pipe-B-eDP-1
[74.293670] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.323s)
[74.301658] Starting dynamic subtest: pipe-C-eDP-1
[78.320583] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.020s)
[78.328127] Starting dynamic subtest: pipe-D-eDP-1
[82.307718] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.983s)
[82.310243] Subtest ctm-0-50: SUCCESS (15.853s)
[83.150832] [004/156] (934s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[83.252138] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[83.254566] Starting dynamic subtest: pipe-A-eDP-1
[89.131736] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.879s)
[89.140069] Starting dynamic subtest: pipe-B-eDP-1
[95.790925] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.657s)
[95.793368] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.539s)
[96.667975] [005/156] (921s left) kms_psr (psr-cursor-render)
[96.770993] Starting subtest: psr-cursor-render
[96.773340] Starting dynamic subtest: eDP-1
[98.466837] Dynamic subtest eDP-1: SUCCESS (1.695s)
[98.469055] Subtest psr-cursor-render: SUCCESS (1.697s)
[99.338408] [006/156] (918s left) template (a)
[99.387985] Starting subtest: A
[99.389913] Subtest A: SUCCESS (0.000s)
[99.491765] [007/156] (918s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[99.578827] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[99.583127] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[99.671556] [008/156] (918s left) i915_suspend (basic-s2idle-without-i915)
[99.701980] Starting subtest: basic-s2idle-without-i915
[119.721155] Subtest basic-s2idle-without-i915: SUCCESS (5.619s)
[119.836288] [009/156] (898s left) prime_busy (after)
[119.911040] Starting subtest: after
[119.913454] Starting dynamic subtest: rcs0
[119.949226] Dynamic subtest rcs0: SUCCESS (0.036s)
[119.963065] Starting dynamic subtest: bcs0
[119.990717] Dynamic subtest bcs0: SUCCESS (0.039s)
[119.999004] Starting dynamic subtest: vcs0
[120.030991] Dynamic subtest vcs0: SUCCESS (0.038s)
[120.039226] Starting dynamic subtest: vcs1
[120.070625] Dynamic subtest vcs1: SUCCESS (0.038s)
[120.079833] Starting dynamic subtest: vecs0
[120.116646] Dynamic subtest vecs0: SUCCESS (0.038s)
[120.125261] Starting dynamic subtest: ccs0
[120.149998] Dynamic subtest ccs0: SUCCESS (0.036s)
[120.256111] Subtest after: SUCCESS (0.336s)
[120.338677] [010/156] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[120.439687] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[125.063685] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.521s)
[126.291779] [011/156] (891s left) gem_exec_fence (parallel)
[126.469481] Starting subtest: parallel
[126.472154] Starting dynamic subtest: rcs0
[128.646817] Dynamic subtest rcs0: SUCCESS (2.151s)
[128.657435] Starting dynamic subtest: bcs0
[130.817529] Dynamic subtest bcs0: SUCCESS (2.149s)
[130.830417] Starting dynamic subtest: vcs0
[132.984335] Dynamic subtest vcs0: SUCCESS (2.150s)
[132.995990] Starting dynamic subtest: vcs1
[135.149436] Dynamic subtest vcs1: SUCCESS (2.152s)
[135.159400] Starting dynamic subtest: vecs0
[137.314280] Dynamic subtest vecs0: SUCCESS (2.154s)
[137.325119] Starting dynamic subtest: ccs0
[139.470251] Dynamic subtest ccs0: SUCCESS (2.148s)
[139.472258] Subtest parallel: SUCCESS (12.909s)
[141.707829] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[141.711075] [012/156] (876s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move)
[141.819574] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move
[141.823750] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[141.908208] [013/156] (876s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[141.995598] Starting subtest: fbc-psr-sprite-mmap-cpu
[141.997612] Starting dynamic subtest: eDP-1
[142.001883] Dynamic subtest eDP-1: SKIP (0.000s)
[142.006216] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[142.070788] [014/156] (876s left) i915_query (query-topology-unsupported)
[142.125243] Starting subtest: query-topology-unsupported
[142.129248] Subtest query-topology-unsupported: SKIP (0.000s)
[142.216118] [015/156] (875s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[142.313023] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[142.315383] Starting dynamic subtest: pipe-A
[142.540205] Dynamic subtest pipe-A: SUCCESS (0.229s)
[142.556297] Starting dynamic subtest: pipe-B
[143.858561] Dynamic subtest pipe-B: SUCCESS (1.315s)
[143.869050] Starting dynamic subtest: pipe-C
[145.193386] Dynamic subtest pipe-C: SUCCESS (1.332s)
[145.203537] Starting dynamic subtest: pipe-D
[146.541940] Dynamic subtest pipe-D: SUCCESS (1.345s)
[146.544630] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.224s)
[147.721746] [016/156] (870s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[147.831123] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[147.835517] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[147.955401] [017/156] (870s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[148.103817] Starting subtest: dp-mst-type-0-suspend-resume
[148.108341] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[148.219655] [018/156] (870s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[148.307035] Starting subtest: fbc-2p-pri-indfb-multidraw
[148.311543] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[148.403476] [019/156] (869s left) gen9_exec_parse (valid-registers)
[148.465786] Subtest valid-registers: SKIP (0.000s)
[148.540033] [020/156] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[148.640553] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[148.644527] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[148.737609] [021/156] (869s left) kms_cursor_crc (cursor-offscreen-64x21)
[148.927625] Starting subtest: cursor-offscreen-64x21
[148.980438] Subtest cursor-offscreen-64x21: SKIP (0.047s)
[149.256975] [022/156] (869s left) syncobj_timeline (reset-unsignaled)
[149.309326] Starting subtest: reset-unsignaled
[149.311373] Subtest reset-unsignaled: SUCCESS (0.000s)
[149.412459] [023/156] (869s left) kms_flip (busy-flip)
[149.516296] Starting subtest: busy-flip
[149.517974] Starting dynamic subtest: A-eDP1
[151.240005] Dynamic subtest A-eDP1: SUCCESS (1.724s)
[151.250584] Starting dynamic subtest: B-eDP1
[152.971937] Dynamic subtest B-eDP1: SUCCESS (1.729s)
[152.981786] Starting dynamic subtest: C-eDP1
[154.692122] Dynamic subtest C-eDP1: SUCCESS (1.718s)
[154.701805] Starting dynamic subtest: D-eDP1
[156.344512] Dynamic subtest D-eDP1: SUCCESS (1.649s)
[156.346891] Subtest busy-flip: SUCCESS (6.829s)
[157.552213] [024/156] (861s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[157.605743] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[157.711167] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[157.793412] [025/156] (860s left) gem_exec_schedule (preempt-queue-contexts)
[157.858680] Subtest preempt-queue-contexts: SKIP (0.000s)
[158.160566] [026/156] (860s left) gem_exec_balancer (bonded-true-hang)
[158.424194] Starting subtest: bonded-true-hang
[158.429101] Subtest bonded-true-hang: SKIP (0.000s)
[158.551270] [027/156] (860s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[158.610372] Starting subtest: y-tiled-to-vebox-x-tiled
[158.614908] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[158.788747] [028/156] (859s left) gem_exec_balancer (sequential)
[158.844937] Starting subtest: sequential
[161.966626] Subtest sequential: SUCCESS (3.120s)
[162.272782] [029/156] (856s left) kms_feature_discovery (psr1)
[162.365967] Starting subtest: psr1
[162.368301] Subtest psr1: SUCCESS (0.000s)
[162.455318] [030/156] (856s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[162.549665] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[162.553761] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[162.651258] [031/156] (856s left) kms_frontbuffer_tracking (psr-suspend)
[162.758232] Starting subtest: psr-suspend
[200.803945] Subtest psr-suspend: SUCCESS (8.654s)
[200.937191] [032/156] (817s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[201.038797] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[201.043409] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[201.155330] [033/156] (817s left) kms_plane_alpha_blend (alpha-transparent-fb)
[201.243361] Starting subtest: alpha-transparent-fb
[201.546620] Starting dynamic subtest: pipe-A-eDP-1
[202.224118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s)
[202.234047] Starting dynamic subtest: pipe-D-eDP-1
[203.667782] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[203.670292] Subtest alpha-transparent-fb: SUCCESS (2.355s)
[204.587982] [034/156] (814s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[204.697252] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[204.701729] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[204.805762] [035/156] (814s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[204.904400] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[204.908532] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[204.978569] [036/156] (814s left) gem_mmap_gtt (basic-small-bo)
[205.026240] Subtest basic-small-bo: SKIP (0.000s)
[205.082504] [037/156] (814s left) kms_flip (2x-flip-vs-rmfb)
[205.174428] Starting subtest: 2x-flip-vs-rmfb
[205.186605] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[205.270508] [038/156] (813s left) kms_universal_plane (universal-plane-sanity)
[205.363382] Starting subtest: universal-plane-sanity
[205.365826] Starting dynamic subtest: pipe-A-eDP-1
[205.968510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[205.978655] Starting dynamic subtest: pipe-B-eDP-1
[207.244475] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[207.254522] Starting dynamic subtest: pipe-C-eDP-1
[208.469926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[208.484928] Starting dynamic subtest: pipe-D-eDP-1
[209.707382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[209.709672] Subtest universal-plane-sanity: SUCCESS (4.277s)
[210.599507] [039/156] (808s left) gem_exec_schedule (promotion)
[210.668178] Starting subtest: promotion
[210.670575] Starting dynamic subtest: rcs0
[210.771817] Dynamic subtest rcs0: SUCCESS (0.110s)
[210.781894] Starting dynamic subtest: vcs0
[210.869185] Dynamic subtest vcs0: SUCCESS (0.097s)
[210.881050] Starting dynamic subtest: vcs1
[210.965384] Dynamic subtest vcs1: SUCCESS (0.092s)
[210.977868] Starting dynamic subtest: vecs0
[211.045032] Dynamic subtest vecs0: SUCCESS (0.078s)
[211.054752] Starting dynamic subtest: ccs0
[211.147717] Dynamic subtest ccs0: SUCCESS (0.101s)
[211.150520] Subtest promotion: SUCCESS (0.484s)
[212.109296] [040/156] (807s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[212.216248] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[212.220326] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[212.328828] [041/156] (806s left) kms_chamelium_color (degamma)
[212.433457] Subtest degamma: SKIP (0.000s)
[212.481248] [042/156] (806s left) syncobj_wait (multi-wait-for-submit-signaled)
[212.541836] Starting subtest: multi-wait-for-submit-signaled
[212.544374] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[212.656760] [043/156] (806s left) gem_sync (basic-all)
[212.734803] Starting subtest: basic-all
[215.843083] Subtest basic-all: SUCCESS (3.099s)
[216.039706] [044/156] (803s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[216.151909] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[216.156192] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.235910] [045/156] (803s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[216.333236] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[216.337292] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[216.434962] [046/156] (803s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[216.494219] Starting subtest: etime-multi-wait-all-available-unsubmitted
[216.596116] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[216.675287] [047/156] (802s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[216.765040] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[216.767409] Starting dynamic subtest: pipe-A-eDP-1
[216.793680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.805468] Starting dynamic subtest: pipe-B-eDP-1
[216.829729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.839042] Starting dynamic subtest: pipe-C-eDP-1
[216.863066] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.871962] Starting dynamic subtest: pipe-D-eDP-1
[216.896233] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.900321] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[219.039741] [048/156] (800s left) gem_mmap_gtt (close-race)
[219.096215] Subtest close-race: SKIP (0.000s)
[219.152279] [049/156] (800s left) syncobj_wait (wait-delayed-signal)
[219.200408] Starting subtest: wait-delayed-signal
[219.302073] Subtest wait-delayed-signal: SUCCESS (0.102s)
[219.382202] [050/156] (800s left) perf (gen12-group-exclusive-stream-sample-oa)
[219.489934] Starting subtest: gen12-group-exclusive-stream-sample-oa
[219.513946] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.024s)
[219.557919] [051/156] (800s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[219.660729] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[219.664768] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[219.770064] [052/156] (799s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[219.877745] Starting subtest: x-tiled-64bpp-rotate-180
[221.483508] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.601s)
[221.650625] [053/156] (798s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[221.742286] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[221.744584] Starting dynamic subtest: pipe-A-eDP-1
[221.795975] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[221.805520] Starting dynamic subtest: pipe-B-eDP-1
[221.853336] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[221.863022] Starting dynamic subtest: pipe-C-eDP-1
[221.910168] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[221.919534] Starting dynamic subtest: pipe-D-eDP-1
[221.966300] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[221.969959] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[224.027605] [054/156] (795s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[224.123399] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[224.125760] Starting dynamic subtest: pipe-A-eDP-1
[224.148855] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[224.159699] Starting dynamic subtest: pipe-B-eDP-1
[224.181232] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[224.190729] Starting dynamic subtest: pipe-C-eDP-1
[224.211860] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.221101] Starting dynamic subtest: pipe-D-eDP-1
[224.243424] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.247494] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[226.395266] [055/156] (793s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[226.513517] Starting subtest: cursor-vs-flip-toggle
[257.861768] Subtest cursor-vs-flip-toggle: SUCCESS (31.340s)
[258.720410] [056/156] (761s left) gem_ctx_persistence (engines-queued)
[258.799117] Starting subtest: engines-queued
[258.801497] Starting dynamic subtest: rcs0
[258.907778] Dynamic subtest rcs0: SUCCESS (0.108s)
[258.921469] Starting dynamic subtest: bcs0
[258.980881] Dynamic subtest bcs0: SUCCESS (0.070s)
[258.995327] Starting dynamic subtest: vcs0
[260.935492] Dynamic subtest vcs0: SUCCESS (1.950s)
[260.950248] Starting dynamic subtest: vcs1
[262.920187] Dynamic subtest vcs1: SUCCESS (1.981s)
[262.933738] Starting dynamic subtest: vecs0
[264.970726] Dynamic subtest vecs0: SUCCESS (2.043s)
[264.981561] Starting dynamic subtest: ccs0
[265.085082] Dynamic subtest ccs0: SUCCESS (0.117s)
[265.087823] Subtest engines-queued: SUCCESS (6.284s)
[265.165966] [057/156] (754s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[265.271178] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[269.390600] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.123s)
[270.541580] [058/156] (749s left) gem_cs_tlb (engines)
[270.597713] Starting subtest: engines
[270.599886] Starting dynamic subtest: rcs0
[272.754259] Dynamic subtest rcs0: SUCCESS (2.152s)
[272.769041] Starting dynamic subtest: bcs0
[274.907421] Dynamic subtest bcs0: SUCCESS (2.151s)
[274.919649] Starting dynamic subtest: vcs0
[277.061584] Dynamic subtest vcs0: SUCCESS (2.152s)
[277.073765] Starting dynamic subtest: vcs1
[279.216446] Dynamic subtest vcs1: SUCCESS (2.154s)
[279.226504] Starting dynamic subtest: vecs0
[281.371440] Dynamic subtest vecs0: SUCCESS (2.152s)
[281.381161] Starting dynamic subtest: ccs0
[283.527903] Dynamic subtest ccs0: SUCCESS (2.154s)
[283.530456] Subtest engines: SUCCESS (12.922s)
[283.678253] [059/156] (736s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[284.076611] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[284.941666] [060/156] (735s left) gem_eio (context-create)
[285.158980] Starting subtest: context-create
[285.475316] Subtest context-create: SUCCESS (0.316s)
[285.604637] [061/156] (734s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[285.701215] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[285.705706] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[285.810710] [062/156] (734s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[285.907780] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[285.911231] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[286.007337] [063/156] (734s left) gem_mmap (basic-small-bo)
[286.068206] Subtest basic-small-bo: SKIP (0.000s)
[286.141327] [064/156] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[286.231661] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[293.191073] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.961s)
[293.307009] [065/156] (727s left) perf_pmu (gt-awake)
[293.349696] Starting subtest: gt-awake
[301.994602] Subtest gt-awake: SUCCESS (8.645s)
[302.100214] [066/156] (718s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[302.204872] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[302.209080] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[302.302707] [067/156] (718s left) kms_flip (2x-plain-flip-interruptible)
[302.386615] Starting subtest: 2x-plain-flip-interruptible
[302.399646] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[302.476942] [068/156] (717s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[302.587132] Starting subtest: cursorB-vs-flipB-legacy
[302.591522] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[302.734804] [069/156] (717s left) gem_ctx_param (get-priority-new-ctx)
[302.780880] Starting subtest: get-priority-new-ctx
[302.783241] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[302.876666] [070/156] (717s left) kms_setmode (basic-clone-single-crtc)
[302.922511] Starting subtest: basic-clone-single-crtc
[302.928842] Subtest basic-clone-single-crtc: SKIP (0.000s)
[303.046143] [071/156] (717s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[303.145068] Starting subtest: extended-modeset-hang-oldfb-with-reset
[303.147046] Starting dynamic subtest: pipe-A
[315.183746] Dynamic subtest pipe-A: SUCCESS (12.037s)
[315.196525] Starting dynamic subtest: pipe-D
[327.650093] Dynamic subtest pipe-D: SUCCESS (12.465s)
[327.652280] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.507s)
[328.537008] [072/156] (692s left) gem_exec_reloc (basic-cpu-read)
[328.615042] Subtest basic-cpu-read: SKIP (0.000s)
[328.687532] [073/156] (691s left) kms_frontbuffer_tracking (fbchdr-suspend)
[328.788254] Starting subtest: fbchdr-suspend
[328.792808] Subtest fbchdr-suspend: SKIP (0.000s)
[328.888090] [074/156] (691s left) gem_exec_capture (userptr)
[328.945291] Starting subtest: userptr
[329.758612] Subtest userptr: SUCCESS (0.815s)
[329.867714] [075/156] (690s left) gem_exec_whisper (basic-fds-priority)
[329.926443] Starting subtest: basic-fds-priority
[353.004679] Subtest basic-fds-priority: SUCCESS (23.072s)
[353.193430] [076/156] (667s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[353.249190] Starting subtest: single-wait-for-submit-available-submitted
[353.251665] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[353.356662] [077/156] (667s left) gen7_exec_parse (cmd-crossing-page)
[353.417622] Subtest cmd-crossing-page: SKIP (0.000s)
[353.485424] [078/156] (667s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[353.591138] Starting subtest: psrhdr-indfb-scaledprimary
[353.595308] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[353.685506] [079/156] (667s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[353.775922] Starting subtest: async-flip-with-page-flip-events-linear
[354.158654] Starting dynamic subtest: pipe-A-eDP-1
[356.906442] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.748s)
[357.271605] Starting dynamic subtest: pipe-B-eDP-1
[360.029986] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[360.408755] Starting dynamic subtest: pipe-C-eDP-1
[363.158235] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[363.546020] Starting dynamic subtest: pipe-D-eDP-1
[366.299145] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[366.301830] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.523s)
[367.480546] [080/156] (653s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[367.590593] Starting subtest: pr-overlay-plane-update-continuous-sf
[367.594748] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[367.662605] [081/156] (653s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[367.748707] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[367.753541] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[368.906158] [082/156] (652s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[369.002905] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[369.005319] Starting dynamic subtest: pipe-A-default-mode
[371.783087] Dynamic subtest pipe-A-default-mode: SUCCESS (2.778s)
[371.785315] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.780s)
[372.640432] [083/156] (648s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[372.738713] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[372.743117] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[372.860920] [084/156] (648s left) kms_lease (setcrtc-implicit-plane)
[372.952584] Starting subtest: setcrtc-implicit-plane
[372.954964] Starting dynamic subtest: pipe-A-eDP-1
[373.427739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[373.438764] Starting dynamic subtest: pipe-B-eDP-1
[374.552796] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.122s)
[374.563839] Starting dynamic subtest: pipe-C-eDP-1
[375.674311] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[375.686887] Starting dynamic subtest: pipe-D-eDP-1
[376.819666] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[376.822023] Subtest setcrtc-implicit-plane: SUCCESS (3.868s)
[377.669487] [085/156] (643s left) gem_softpin (allocator-nopin-reserve)
[377.736860] Starting subtest: allocator-nopin-reserve
[377.835892] Subtest allocator-nopin-reserve: SUCCESS (0.099s)
[377.972525] [086/156] (643s left) kms_psr (pr-primary-mmap-gtt)
[378.082197] Starting subtest: pr-primary-mmap-gtt
[378.086697] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[378.173556] [087/156] (643s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[378.260211] Starting subtest: pixel-format-linear-modifier-source-clamping
[378.287726] Starting dynamic subtest: pipe-A-plane-0
[378.853785] Dynamic subtest pipe-A-plane-0: SUCCESS (0.566s)
[378.864368] Starting dynamic subtest: pipe-A-plane-3
[379.288500] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s)
[380.460406] Starting dynamic subtest: pipe-B-plane-0
[381.050458] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s)
[381.061220] Starting dynamic subtest: pipe-B-plane-3
[381.505180] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[382.539900] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (4.274s)
[382.925120] [088/156] (638s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[383.026366] Starting subtest: yf-tiled-16bpp-rotate-180
[383.030761] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[383.138542] [089/156] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[383.246740] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[383.251187] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[383.350678] [090/156] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[383.447953] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[383.452094] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[383.558326] [091/156] (637s left) gem_softpin (noreloc)
[383.611622] Starting subtest: noreloc
[389.023131] Subtest noreloc: SUCCESS (5.409s)
[389.153280] [092/156] (632s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[389.263154] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[389.267356] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[389.359752] [093/156] (632s left) gem_userptr_blits (dmabuf-unsync)
[389.432635] Subtest dmabuf-unsync: SKIP (0.000s)
[389.556599] [094/156] (632s left) gem_userptr_blits (stress-purge)
[389.615881] Starting subtest: stress-purge
[394.998861] Subtest stress-purge: SUCCESS (5.381s)
[395.142194] [095/156] (626s left) vgem_basic (bad-fence)
[395.243166] Starting subtest: bad-fence
[395.244860] Subtest bad-fence: SUCCESS (0.000s)
[395.302405] [096/156] (626s left) gem_render_copy (linear-to-vebox-yf-tiled)
[395.362663] Starting subtest: linear-to-vebox-yf-tiled
[395.366643] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[395.559432] [097/156] (626s left) gem_exec_reloc (basic-concurrent16)
[395.627980] Subtest basic-concurrent16: SKIP (0.000s)
[395.704848] [098/156] (626s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt)
[395.825056] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt
[395.829330] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[395.925839] [099/156] (625s left) kms_properties (plane-properties-atomic)
[396.021848] Starting subtest: plane-properties-atomic
[396.023695] Starting dynamic subtest: pipe-A-eDP-1
[396.599991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[396.611855] Starting dynamic subtest: pipe-B-eDP-1
[397.880875] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.279s)
[397.892300] Starting dynamic subtest: pipe-C-eDP-1
[399.120094] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[399.131584] Starting dynamic subtest: pipe-D-eDP-1
[400.343515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[400.345661] Subtest plane-properties-atomic: SUCCESS (4.319s)
[401.163324] [100/156] (620s left) gem_mmap_gtt (basic-write-gtt)
[401.220447] Subtest basic-write-gtt: SKIP (0.000s)
[401.282212] [101/156] (620s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[401.381976] Starting subtest: plane-use-after-nonblocking-unbind
[401.384268] Starting dynamic subtest: pipe-A-eDP-1
[401.443944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[401.756340] Starting dynamic subtest: pipe-B-eDP-1
[402.553462] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.808s)
[402.863979] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.480s)
[403.721562] [102/156] (618s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[403.834328] Starting subtest: 4-tiled-64bpp-rotate-0
[405.470824] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.636s)
[405.636923] [103/156] (616s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[405.739804] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[405.743445] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[405.855950] [104/156] (616s left) core_getstats (basic)
[405.909503] Starting subtest: basic
[405.911337] Subtest basic: SUCCESS (0.000s)
[406.003687] [105/156] (616s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[406.105989] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[406.109525] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[406.199671] [106/156] (615s left) syncobj_timeline (multi-wait-all-available-signaled)
[406.263130] Starting subtest: multi-wait-all-available-signaled
[406.265187] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[406.340882] [107/156] (615s left) gem_mmap_wc (write-wc-read-gtt)
[406.395037] Subtest write-wc-read-gtt: SKIP (0.000s)
[406.452958] [108/156] (615s left) kms_pm_dc (dc5-dpms-negative)
[407.552970] Starting subtest: dc5-dpms-negative
[407.557446] Subtest dc5-dpms-negative: SKIP (0.000s)
[407.642325] [109/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[407.745144] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[407.749599] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[407.849036] [110/156] (614s left) drm_read (fault-buffer)
[407.989496] Starting subtest: fault-buffer
[407.991933] Subtest fault-buffer: SUCCESS (0.001s)
[408.114231] [111/156] (614s left) device_reset (unbind-cold-reset-rebind)
[408.160789] Starting subtest: unbind-cold-reset-rebind
[408.165649] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[408.223036] [112/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[408.335614] Starting subtest: fbcpsrhdr-rgb565-draw-render
[408.339799] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[408.460540] [113/156] (613s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[408.560727] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[408.564162] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[408.634066] [114/156] (613s left) kms_joiner (invalid-modeset-ultra-joiner)
[408.737019] Starting subtest: invalid-modeset-ultra-joiner
[408.740672] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[408.805357] [115/156] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[408.908946] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[413.233425] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.328s)
[414.424706] [116/156] (608s left) syncobj_wait (invalid-reset-illegal-handle)
[414.492077] Starting subtest: invalid-reset-illegal-handle
[414.494473] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[414.622920] [117/156] (607s left) gem_userptr_blits (sync-unmap-after-close)
[414.704240] Starting subtest: sync-unmap-after-close
[414.715762] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[414.867409] [118/156] (607s left) gem_lmem_swapping (heavy-multi)
[414.908281] Subtest heavy-multi: SKIP (0.000s)
[414.948727] [119/156] (607s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[415.042454] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[415.047575] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[415.145177] [120/156] (607s left) kms_getfb (getfb-reject-nv12)
[415.243319] Starting subtest: getfb-reject-nv12
[415.245544] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[415.368099] [121/156] (607s left) kms_pm_rpm (modeset-non-lpsp)
[417.195983] Starting subtest: modeset-non-lpsp
[418.351065] Subtest modeset-non-lpsp: SKIP (1.157s)
[418.761936] [122/156] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[418.863887] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[418.868476] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[418.964354] [123/156] (603s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[419.061950] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[419.065986] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[419.171187] [124/156] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[419.259793] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[419.264217] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[419.360530] [125/156] (603s left) gem_userptr_blits (readonly-unsync)
[419.429248] Subtest readonly-unsync: SKIP (0.000s)
[419.551664] [126/156] (603s left) gem_exec_parallel (fds)
[419.606117] Starting subtest: fds
[419.608334] Starting dynamic subtest: rcs0
[423.383323] Dynamic subtest rcs0: SUCCESS (3.777s)
[423.397491] Starting dynamic subtest: bcs0
[427.390482] Dynamic subtest bcs0: SUCCESS (4.007s)
[427.404393] Starting dynamic subtest: vcs0
[431.226927] Dynamic subtest vcs0: SUCCESS (3.835s)
[431.241867] Starting dynamic subtest: vcs1
[435.201606] Dynamic subtest vcs1: SUCCESS (3.973s)
[435.215672] Starting dynamic subtest: vecs0
[439.264819] Dynamic subtest vecs0: SUCCESS (4.062s)
[439.277787] Starting dynamic subtest: ccs0
[443.774254] Dynamic subtest ccs0: SUCCESS (4.507s)
[443.776798] Subtest fds: SUCCESS (24.174s)
[443.982619] [127/156] (579s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[444.087537] Starting subtest: y-tiled-64bpp-rotate-90
[444.092082] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[444.198816] [128/156] (578s left) kms_cursor_edge_walk (64x64-left-edge)
[444.291896] Starting subtest: 64x64-left-edge
[444.294271] Starting dynamic subtest: pipe-A-eDP-1
[447.787082] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[447.799645] Starting dynamic subtest: pipe-D-eDP-1
[450.904871] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[450.907146] Subtest 64x64-left-edge: SUCCESS (6.616s)
[451.730629] [129/156] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[451.823772] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[458.952340] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.135s)
[459.092897] [130/156] (564s left) gem_barrier_race (remote-request)
[459.161499] Starting subtest: remote-request
[459.163725] Starting dynamic subtest: rcs0
[464.333316] Dynamic subtest rcs0: SUCCESS (5.173s)
[464.335549] Subtest remote-request: SUCCESS (5.175s)
[464.490712] [131/156] (558s left) kms_properties (colorop-properties-legacy)
[464.588453] Starting subtest: colorop-properties-legacy
[464.590135] Starting dynamic subtest: pipe-A-eDP-1
[464.959624] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s)
[464.973571] Starting dynamic subtest: pipe-B-eDP-1
[466.039970] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.080s)
[466.052983] Starting dynamic subtest: pipe-C-eDP-1
[467.087686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.045s)
[467.099795] Starting dynamic subtest: pipe-D-eDP-1
[468.129700] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.039s)
[468.131872] Subtest colorop-properties-legacy: SUCCESS (3.540s)
[468.947420] [132/156] (554s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[469.045254] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[469.049160] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[469.136817] [133/156] (554s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[469.233653] Starting subtest: invalidate-primary-flip-overlay
[480.034587] Subtest invalidate-primary-flip-overlay: SUCCESS (10.803s)
[480.162136] [134/156] (543s left) gem_exec_reloc (basic-cpu)
[480.227951] Subtest basic-cpu: SKIP (0.000s)
[480.303882] [135/156] (543s left) gem_mmap_offset (close-race)
[480.360273] Starting subtest: close-race
[500.467656] Subtest close-race: SUCCESS (20.105s)
[500.620090] [136/156] (522s left) kms_psr (fbc-pr-sprite-render)
[500.728813] Starting subtest: fbc-pr-sprite-render
[500.733137] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[500.803078] [137/156] (522s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[500.898357] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[500.900659] Starting dynamic subtest: pipe-A-eDP-1
[500.923195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[500.939908] Starting dynamic subtest: pipe-B-eDP-1
[500.961157] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.973347] Starting dynamic subtest: pipe-C-eDP-1
[500.995493] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.006607] Starting dynamic subtest: pipe-D-eDP-1
[501.028884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.033015] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[503.200208] [138/156] (520s left) kms_vblank (ts-continuation-idle)
[503.289850] Starting subtest: ts-continuation-idle
[503.291720] Starting dynamic subtest: pipe-A-eDP-1
[503.694228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[503.710955] Starting dynamic subtest: pipe-D-eDP-1
[504.783352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.087s)
[504.785687] Subtest ts-continuation-idle: SUCCESS (1.496s)
[505.657228] [139/156] (517s left) gem_ctx_persistence (legacy-engines-persistence)
[505.724324] Starting subtest: legacy-engines-persistence
[505.726780] Starting dynamic subtest: render
[506.538720] Dynamic subtest render: SUCCESS (0.813s)
[506.556252] Starting dynamic subtest: bsd1
[507.305077] Dynamic subtest bsd1: SUCCESS (0.763s)
[507.318968] Starting dynamic subtest: bsd2
[508.072934] Dynamic subtest bsd2: SUCCESS (0.765s)
[508.087710] Starting dynamic subtest: blt
[508.815209] Dynamic subtest blt: SUCCESS (0.739s)
[508.828778] Starting dynamic subtest: vebox
[509.612777] Dynamic subtest vebox: SUCCESS (0.795s)
[509.615700] Subtest legacy-engines-persistence: SUCCESS (3.889s)
[509.724874] [140/156] (513s left) i915_drm_fdinfo (virtual-busy-idle-all)
[509.771481] Starting subtest: virtual-busy-idle-all
[509.775930] Subtest virtual-busy-idle-all: SKIP (0.000s)
[509.859400] [141/156] (513s left) kms_flip (plain-flip-ts-check)
[509.960613] Starting subtest: plain-flip-ts-check
[509.963068] Starting dynamic subtest: A-eDP1
[518.844464] Dynamic subtest A-eDP1: SUCCESS (8.882s)
[518.858462] Starting dynamic subtest: B-eDP1
[527.688575] Dynamic subtest B-eDP1: SUCCESS (8.842s)
[527.705098] Starting dynamic subtest: C-eDP1
[536.508555] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[536.521152] Starting dynamic subtest: D-eDP1
[545.338657] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[545.343344] Subtest plain-flip-ts-check: SUCCESS (35.378s)
[546.525305] [142/156] (477s left) api_intel_bb (add-remove-objects)
[546.593733] Starting subtest: add-remove-objects
[546.598540] Subtest add-remove-objects: SUCCESS (0.006s)
[546.720139] [143/156] (477s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[546.821579] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[546.825856] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[546.937570] [144/156] (476s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[547.027443] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[547.029780] Starting dynamic subtest: pipe-A
[547.048689] Dynamic subtest pipe-A: SKIP (0.018s)
[547.061139] Starting dynamic subtest: pipe-B
[547.082388] Dynamic subtest pipe-B: SKIP (0.033s)
[547.094069] Starting dynamic subtest: pipe-C
[547.117680] Dynamic subtest pipe-C: SKIP (0.034s)
[547.129170] Starting dynamic subtest: pipe-D
[547.150221] Dynamic subtest pipe-D: SKIP (0.033s)
[547.154615] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.120s)
[547.248601] [145/156] (476s left) gem_userptr_blits (map-fixed-invalidate)
[547.313606] Starting subtest: map-fixed-invalidate
[547.318138] Subtest map-fixed-invalidate: SKIP (0.000s)
[547.438818] [146/156] (476s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[547.526558] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[554.619346] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.098s)
[554.750519] [147/156] (469s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte)
[554.856836] Starting subtest: fbcpsrhdr-1p-rte
[554.861036] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s)
[554.958702] [148/156] (468s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[555.060360] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[557.532772] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.477s)
[558.649463] [149/156] (465s left) kms_cursor_legacy (single-bo)
[558.771447] Starting subtest: single-bo
[558.773749] Starting dynamic subtest: pipe-A
[564.156497] Dynamic subtest pipe-A: SUCCESS (5.379s)
[564.170409] Starting dynamic subtest: pipe-B
[569.540737] Dynamic subtest pipe-B: SUCCESS (5.380s)
[569.553036] Starting dynamic subtest: pipe-C
[574.924062] Dynamic subtest pipe-C: SUCCESS (5.382s)
[574.937900] Starting dynamic subtest: pipe-D
[580.307827] Dynamic subtest pipe-D: SUCCESS (5.379s)
[580.322056] Starting dynamic subtest: all-pipes
[585.699080] Dynamic subtest all-pipes: SUCCESS (5.387s)
[585.701865] Subtest single-bo: SUCCESS (26.921s)
[585.860518] [150/156] (438s left) kms_atomic (plane-primary-legacy)
[585.955502] Starting subtest: plane-primary-legacy
[585.957876] Starting dynamic subtest: pipe-A-eDP-1
[586.375225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[586.377624] Subtest plane-primary-legacy: SUCCESS (0.422s)
[587.263878] [151/156] (436s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[587.318257] Starting subtest: multi-wait-for-submit-unsubmitted
[587.421260] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[587.516950] [152/156] (436s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[587.625736] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[588.660480] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.034s)
[588.786506] [153/156] (435s left) i915_pm_rps (thresholds)
[588.844836] Starting subtest: thresholds
[588.849603] Subtest thresholds: SKIP (0.001s)
[588.943438] [154/156] (435s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[589.029962] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[596.279787] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.251s)
[596.412524] [155/156] (427s left) gem_eio (wait-10ms)
[596.616780] Starting subtest: wait-10ms
[596.946915] Subtest wait-10ms: SUCCESS (0.331s)
[597.085341] [156/156] (427s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[597.187486] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[597.191835] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[597.292089] Closing watchdogs
results: parsing output: 0/ for test: gem_workarounds
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_color
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: template
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_suspend
results: parsing output: 8/ for test: prime_busy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: i915_query
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gen9_exec_parse
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_universal_plane
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_chamelium_color
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: gem_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_cs_tlb
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_mmap
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: kms_setmode
results: parsing output: 70/ for test: kms_busy
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_capture
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gen7_exec_parse
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: gem_softpin
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_properties
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_atomic_transition
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: core_getstats
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_pm_dc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: drm_read
results: parsing output: 110/ for test: device_reset
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_joiner
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: gem_exec_parallel
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_cursor_edge_walk
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_barrier_race
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr_stress_test
results: parsing output: 133/ for test: gem_exec_reloc
results: parsing output: 134/ for test: gem_mmap_offset
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: kms_ccs
results: parsing output: 137/ for test: kms_vblank
results: parsing output: 138/ for test: gem_ctx_persistence
results: parsing output: 139/ for test: i915_drm_fdinfo
results: parsing output: 140/ for test: kms_flip
results: parsing output: 141/ for test: api_intel_bb
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_plane_scaling
results: parsing output: 144/ for test: gem_userptr_blits
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: kms_atomic
results: parsing output: 150/ for test: syncobj_wait
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: i915_pm_rps
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_eio
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.