[59.560044] Initializing watchdogs
[59.560094]   /dev/watchdog0
[59.577357] [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]
[59.581872] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.584127] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.587423] [001/132] (960s left) gem_mmap_gtt (medium-copy)
[59.676961] Subtest medium-copy: SKIP (0.000s)
[59.738556] [002/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[59.832612] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[64.605890] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.769s)
[65.799930] [003/132] (954s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[65.887223] Starting subtest: fbc-psr2-cursor-mmap-cpu
[65.889658] Starting dynamic subtest: eDP-1
[65.893933] Dynamic subtest eDP-1: SKIP (0.000s)
[65.898309] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[65.960941] [004/132] (954s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[66.021673] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[66.131416] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[66.215865] [005/132] (954s left) gem_exec_schedule (fairslice-all)
[66.293187] Starting subtest: fairslice-all
[68.354850] Subtest fairslice-all: SUCCESS (2.058s)
[68.970257] [006/132] (951s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[69.079422] Starting subtest: fbc-2p-pri-indfb-multidraw
[69.083870] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[69.179957] [007/132] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[69.284360] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[76.204145] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.921s)
[76.325384] [008/132] (944s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[76.420053] Starting subtest: fbc-modesetfrombusy
[80.207375] Subtest fbc-modesetfrombusy: SUCCESS (3.791s)
[81.382913] [009/132] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[81.490795] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[88.953509] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.465s)
[89.077596] [010/132] (931s left) syncobj_wait (multi-wait-all-signaled)
[89.135966] Starting subtest: multi-wait-all-signaled
[89.138512] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[89.237178] [011/132] (931s left) gem_exec_flush (basic-uc-set-default)
[89.294612] Starting subtest: basic-uc-set-default
[94.746506] Subtest basic-uc-set-default: SUCCESS (5.453s)
[94.929083] [012/132] (925s left) gem_exec_schedule (preempt-queue)
[95.001491] Subtest preempt-queue: SKIP (0.000s)
[95.289235] [013/132] (925s left) gem_exec_reloc (basic-cpu-wc-active)
[95.358650] Subtest basic-cpu-wc-active: SKIP (0.000s)
[95.424342] [014/132] (925s left) gem_exec_capture (pi)
[95.480799] Starting subtest: pi
[95.483837] Starting dynamic subtest: rcs0
[99.736086] Dynamic subtest rcs0: SUCCESS (4.254s)
[99.746780] Starting dynamic subtest: bcs0
[103.719805] Dynamic subtest bcs0: SUCCESS (3.983s)
[103.730753] Starting dynamic subtest: vcs0
[107.697969] Dynamic subtest vcs0: SUCCESS (3.977s)
[107.709242] Starting dynamic subtest: vcs1
[111.658550] Dynamic subtest vcs1: SUCCESS (3.960s)
[111.666582] Starting dynamic subtest: vecs0
[115.556602] Dynamic subtest vecs0: SUCCESS (3.897s)
[115.564527] Starting dynamic subtest: ccs0
[119.499817] Dynamic subtest ccs0: SUCCESS (3.942s)
[119.502323] Subtest pi: SUCCESS (24.017s)
[119.602792] [015/132] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[119.757826] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[119.761714] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[119.852660] [016/132] (900s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[119.909419] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[119.913947] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[120.102726] [017/132] (900s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[120.192400] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[120.194855] Starting dynamic subtest: pipe-A-eDP-1
[120.711154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.492s)
[120.721142] Starting dynamic subtest: pipe-B-eDP-1
[122.141222] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[122.150046] Starting dynamic subtest: pipe-C-eDP-1
[123.518305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[123.528193] Starting dynamic subtest: pipe-D-eDP-1
[124.950869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[124.952958] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.731s)
[126.144587] [018/132] (894s left) gem_exec_reloc (basic-write-read-noreloc)
[126.207382] Subtest basic-write-read-noreloc: SKIP (0.000s)
[126.271479] [019/132] (894s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[126.397083] Starting subtest: verify-pxp-stale-buf-optout-execution
[127.460424] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.064s)
[127.575561] [020/132] (893s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[129.121034] Starting subtest: dpms-mode-unset-non-lpsp
[130.276472] Subtest dpms-mode-unset-non-lpsp: SKIP (1.153s)
[130.647231] [021/132] (890s left) kms_getfb (getfb-handle-closed)
[130.741145] Starting subtest: getfb-handle-closed
[130.743058] Subtest getfb-handle-closed: SUCCESS (0.000s)
[130.841394] [022/132] (890s left) kms_flip (2x-blocking-absolute-wf_vblank)
[130.944226] Starting subtest: 2x-blocking-absolute-wf_vblank
[130.953800] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[131.070176] [023/132] (889s left) perf_pmu (init-busy)
[131.110426] Starting subtest: init-busy
[131.112777] Starting dynamic subtest: rcs0
[131.115680] Dynamic subtest rcs0: SUCCESS (0.001s)
[131.124349] Starting dynamic subtest: bcs0
[131.126534] Dynamic subtest bcs0: SUCCESS (0.000s)
[131.134663] Starting dynamic subtest: vcs0
[131.136865] Dynamic subtest vcs0: SUCCESS (0.001s)
[131.144872] Starting dynamic subtest: vcs1
[131.147082] Dynamic subtest vcs1: SUCCESS (0.001s)
[131.155055] Starting dynamic subtest: vecs0
[131.157206] Dynamic subtest vecs0: SUCCESS (0.001s)
[131.165569] Starting dynamic subtest: ccs0
[131.167423] Dynamic subtest ccs0: SUCCESS (0.000s)
[131.169294] Subtest init-busy: SUCCESS (0.006s)
[131.218288] [024/132] (889s left) gem_pread (self)
[131.277385] Subtest self: SKIP (0.000s)
[131.330984] [025/132] (889s left) perf (buffer-fill)
[131.470078] Starting subtest: buffer-fill
[131.471999] Starting dynamic subtest: 0-rcs0
[133.724066] Dynamic subtest 0-rcs0: SUCCESS (2.254s)
[133.734301] Starting dynamic subtest: 1-vcs1
[138.160318] Dynamic subtest 1-vcs1: SUCCESS (4.435s)
[138.163046] Subtest buffer-fill: SUCCESS (6.690s)
[138.209775] [026/132] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[138.301401] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[138.305574] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[138.402252] [027/132] (882s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[138.499241] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[138.503679] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[138.584536] [028/132] (882s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[138.687541] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[138.690044] Starting dynamic subtest: pipe-A-eDP-1
[138.699073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.716249] Starting dynamic subtest: pipe-B-eDP-1
[138.725503] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.739443] Starting dynamic subtest: pipe-C-eDP-1
[138.747773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.755733] Starting dynamic subtest: pipe-D-eDP-1
[138.764273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.768554] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[141.006827] [029/132] (880s left) dmabuf_sync_file (export-before-signal)
[141.116231] Starting subtest: export-before-signal
[141.118748] Subtest export-before-signal: SUCCESS (0.001s)
[141.173811] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[141.177670] [030/132] (880s left) gem_exec_schedule (smoketest)
[141.366163] Starting subtest: smoketest
[141.368765] Starting dynamic subtest: rcs0
[146.952895] Dynamic subtest rcs0: SUCCESS (5.534s)
[146.966957] Starting dynamic subtest: bcs0
[152.456819] Dynamic subtest bcs0: SUCCESS (5.505s)
[152.469056] Starting dynamic subtest: vcs0
[157.967914] Dynamic subtest vcs0: SUCCESS (5.511s)
[157.977638] Starting dynamic subtest: vcs1
[163.456516] Dynamic subtest vcs1: SUCCESS (5.485s)
[163.466781] Starting dynamic subtest: vecs0
[168.963866] Dynamic subtest vecs0: SUCCESS (5.506s)
[168.980616] Starting dynamic subtest: ccs0
[174.475611] Dynamic subtest ccs0: SUCCESS (5.511s)
[174.478072] Subtest smoketest: SUCCESS (33.060s)
[174.666562] [031/132] (846s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[174.780505] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[174.784817] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[174.884285] [032/132] (846s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[174.949885] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[174.952259] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[175.051083] [033/132] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[175.150453] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[175.154669] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[175.262363] [034/132] (846s left) kms_chamelium_hpd (hdmi-hpd-fast)
[175.641187] Subtest hdmi-hpd-fast: SKIP (0.000s)
[176.449023] [035/132] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[176.557959] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[183.294074] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.738s)
[183.431323] [036/132] (838s left) api_intel_bb (purge-bb)
[183.485406] Starting subtest: purge-bb
[183.487877] Subtest purge-bb: SUCCESS (0.004s)
[183.608071] [037/132] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[183.706551] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[183.710943] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[183.805447] [038/132] (837s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[183.916789] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[183.920992] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[184.017298] [039/132] (837s left) kms_cursor_crc (cursor-sliding-256x256)
[184.251670] Starting subtest: cursor-sliding-256x256
[184.256635] Starting dynamic subtest: pipe-A-eDP-1
[187.475710] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.219s)
[187.506707] Starting dynamic subtest: pipe-D-eDP-1
[191.423699] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.922s)
[191.425644] Subtest cursor-sliding-256x256: SUCCESS (7.170s)
[192.260592] [040/132] (829s left) syncobj_basic (create-signaled)
[192.316690] Starting subtest: create-signaled
[192.318984] Subtest create-signaled: SUCCESS (0.000s)
[192.407836] [041/132] (829s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[192.532056] Starting subtest: x-tiled-16bpp-rotate-270
[192.561989] Subtest x-tiled-16bpp-rotate-270: SKIP (0.027s)
[192.663078] [042/132] (829s left) gem_softpin (evict-prime-sanity-check)
[192.714625] Starting subtest: evict-prime-sanity-check
[192.716838] Starting dynamic subtest: rcs0
[193.846689] Dynamic subtest rcs0: SUCCESS (1.132s)
[193.855135] Starting dynamic subtest: bcs0
[194.958402] Dynamic subtest bcs0: SUCCESS (1.111s)
[194.966770] Starting dynamic subtest: vcs0
[196.882276] Dynamic subtest vcs0: SUCCESS (1.922s)
[196.890837] Starting dynamic subtest: vcs1
[198.931451] Dynamic subtest vcs1: SUCCESS (2.047s)
[198.944511] Starting dynamic subtest: vecs0
[200.828102] Dynamic subtest vecs0: SUCCESS (1.894s)
[200.838737] Starting dynamic subtest: ccs0
[201.969063] Dynamic subtest ccs0: SUCCESS (1.141s)
[201.979867] Starting dynamic subtest: all
[203.089651] Dynamic subtest all: SUCCESS (1.119s)
[203.092310] Subtest evict-prime-sanity-check: SUCCESS (10.375s)
[203.169653] [043/132] (818s left) kms_psr (pr-suspend)
[203.268982] Starting subtest: pr-suspend
[203.273445] Subtest pr-suspend: SKIP (0.000s)
[203.342616] [044/132] (818s left) gem_ctx_param (invalid-ctx-get)
[203.389835] Starting subtest: invalid-ctx-get
[203.392198] Subtest invalid-ctx-get: SUCCESS (0.000s)
[203.462689] [045/132] (818s left) kms_dp_link_training (uhbr-mst)
[203.548205] Starting subtest: uhbr-mst
[203.557031] Subtest uhbr-mst: SKIP (0.000s)
[203.617476] [046/132] (818s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[203.714397] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[203.716552] Starting dynamic subtest: pipe-A-eDP-1
[210.424265] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.714s)
[210.439057] Starting dynamic subtest: pipe-B-eDP-1
[217.414387] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.987s)
[217.416310] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.704s)
[218.272470] [047/132] (803s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[218.388442] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[219.213330] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[219.373661] [048/132] (802s left) gem_exec_balancer (hog)
[219.449855] Starting subtest: hog
[219.454744] Subtest hog: SKIP (0.000s)
[219.759369] [049/132] (802s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[219.869067] Starting subtest: extended-pageflip-modeset-hang-oldfb
[219.870930] Starting dynamic subtest: pipe-A
[227.758726] Dynamic subtest pipe-A: SUCCESS (7.887s)
[227.767794] Starting dynamic subtest: pipe-D
[236.370662] Dynamic subtest pipe-D: SUCCESS (8.611s)
[236.373085] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.503s)
[237.226849] [050/132] (784s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[237.334114] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[237.338729] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[237.440894] [051/132] (784s left) i915_pm_rps (waitboost)
[237.500882] Starting subtest: waitboost
[243.587349] Subtest waitboost: SUCCESS (6.086s)
[243.712794] [052/132] (778s left) gem_tiled_partial_pwrite_pread (reads)
[243.769297] Subtest reads: SKIP (0.000s)
[243.837085] [053/132] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[243.944538] Starting subtest: psr-2p-primscrn-spr-indfb-move
[243.948911] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[244.041770] [054/132] (778s left) gen7_exec_parse (bitmasks)
[244.095215] Subtest bitmasks: SKIP (0.000s)
[244.160758] [055/132] (778s left) gem_exec_async (forked-writes)
[244.225817] Starting subtest: forked-writes
[244.228288] Starting dynamic subtest: rcs0
[244.254580] Dynamic subtest rcs0: SUCCESS (0.028s)
[244.266391] Starting dynamic subtest: bcs0
[244.281432] Dynamic subtest bcs0: SUCCESS (0.026s)
[244.290874] Starting dynamic subtest: vcs0
[244.304861] Dynamic subtest vcs0: SUCCESS (0.023s)
[244.313686] Starting dynamic subtest: vcs1
[244.328339] Dynamic subtest vcs1: SUCCESS (0.023s)
[244.337329] Starting dynamic subtest: vecs0
[244.350767] Dynamic subtest vecs0: SUCCESS (0.022s)
[244.360122] Starting dynamic subtest: ccs0
[244.372838] Dynamic subtest ccs0: SUCCESS (0.021s)
[244.375133] Subtest forked-writes: SUCCESS (0.148s)
[244.592944] [056/132] (777s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[244.648727] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[244.651048] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[244.742286] [057/132] (777s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[244.844929] Starting subtest: yf-tiled-16bpp-rotate-0
[244.849277] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[244.950394] [058/132] (777s left) kms_flip (flip-vs-panning-vs-hang)
[245.044589] Starting subtest: flip-vs-panning-vs-hang
[245.046989] Starting dynamic subtest: A-eDP1
[296.386056] Dynamic subtest A-eDP1: SUCCESS (51.339s)
[296.395257] Starting dynamic subtest: D-eDP1
[336.387062] Dynamic subtest D-eDP1: SUCCESS (39.997s)
[336.389501] Subtest flip-vs-panning-vs-hang: SUCCESS (91.341s)
[337.602977] [059/132] (684s left) gem_mmap_gtt (fault-concurrent-x)
[337.672769] Subtest fault-concurrent-X: SKIP (0.000s)
[337.737979] [060/132] (684s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[337.803736] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[337.864879] [061/132] (684s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[337.986692] Starting subtest: basic-flip-after-cursor-legacy
[338.900888] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s)
[339.748111] [062/132] (682s left) kms_properties (colorop-properties-legacy)
[339.849340] Starting subtest: colorop-properties-legacy
[339.851660] Starting dynamic subtest: pipe-A-eDP-1
[340.188404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.340s)
[340.201540] Starting dynamic subtest: pipe-B-eDP-1
[341.315412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.124s)
[341.323813] Starting dynamic subtest: pipe-C-eDP-1
[342.349244] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.033s)
[342.362369] Starting dynamic subtest: pipe-D-eDP-1
[343.388517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[343.390419] Subtest colorop-properties-legacy: SUCCESS (3.539s)
[344.184340] [063/132] (678s left) gem_ctx_engines (independent)
[344.242650] Starting subtest: independent
[344.244878] Starting dynamic subtest: rcs0
[344.379804] Dynamic subtest rcs0: SUCCESS (0.135s)
[344.388742] Starting dynamic subtest: bcs0
[344.492662] Dynamic subtest bcs0: SUCCESS (0.112s)
[344.504221] Starting dynamic subtest: vcs0
[344.608097] Dynamic subtest vcs0: SUCCESS (0.114s)
[344.617765] Starting dynamic subtest: vcs1
[344.744124] Dynamic subtest vcs1: SUCCESS (0.135s)
[344.754027] Starting dynamic subtest: vecs0
[344.866124] Dynamic subtest vecs0: SUCCESS (0.121s)
[344.874759] Starting dynamic subtest: ccs0
[345.001871] Dynamic subtest ccs0: SUCCESS (0.135s)
[345.013050] Starting dynamic subtest: all-engines
[345.426892] Dynamic subtest all-engines: SUCCESS (0.425s)
[345.429205] Subtest independent: SUCCESS (1.184s)
[346.010502] [064/132] (676s left) kms_flip (flip-vs-fences)
[346.110513] Starting subtest: flip-vs-fences
[346.114633] Subtest flip-vs-fences: SKIP (0.000s)
[346.205054] [065/132] (676s left) intel_hwmon (hwmon-read)
[346.268793] Subtest hwmon-read: SKIP (0.000s)
[346.324355] [066/132] (676s left) kms_chamelium_frames (dp-crc-single)
[346.707341] Subtest dp-crc-single: SKIP (0.000s)
[347.484691] [067/132] (675s left) kms_flip (2x-dpms-vs-vblank-race)
[347.572463] Starting subtest: 2x-dpms-vs-vblank-race
[347.581084] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[347.659253] [068/132] (675s left) gem_exec_whisper (basic-fds-forked)
[347.719079] Starting subtest: basic-fds-forked
[371.472114] Subtest basic-fds-forked: SUCCESS (23.748s)
[371.672131] [069/132] (651s left) kms_chamelium_audio (hdmi-audio)
[372.080582] Subtest hdmi-audio: SKIP (0.000s)
[372.907922] [070/132] (649s left) kms_atomic (plane-cursor-legacy)
[373.003186] Starting subtest: plane-cursor-legacy
[373.005424] Starting dynamic subtest: pipe-A-eDP-1
[373.371111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.370s)
[373.373670] Subtest plane-cursor-legacy: SUCCESS (0.372s)
[374.259278] [071/132] (648s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[374.351291] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[374.353599] Starting dynamic subtest: pipe-A-eDP-1
[374.450057] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[374.461573] Starting dynamic subtest: pipe-B-eDP-1
[375.627768] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[375.632511] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.278s)
[376.802790] [072/132] (646s left) kms_cursor_crc (cursor-onscreen-64x64)
[376.982108] Starting subtest: cursor-onscreen-64x64
[376.987683] Starting dynamic subtest: pipe-A-eDP-1
[379.117685] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s)
[379.148810] Starting dynamic subtest: pipe-D-eDP-1
[381.899809] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[381.902574] Subtest cursor-onscreen-64x64: SUCCESS (4.918s)
[382.765773] [073/132] (640s left) kms_psr (psr-sprite-render)
[382.859812] Starting subtest: psr-sprite-render
[382.862058] Starting dynamic subtest: eDP-1
[384.581233] Dynamic subtest eDP-1: SUCCESS (1.719s)
[384.583518] Subtest psr-sprite-render: SUCCESS (1.720s)
[385.409166] [074/132] (637s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[385.501465] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[385.506173] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[385.589113] [075/132] (637s left) gem_fence_thrash (bo-copy)
[385.632525] Starting subtest: bo-copy
[385.657298] Subtest bo-copy: SKIP (0.023s)
[385.721043] [076/132] (637s left) kms_lease (possible-crtcs-filtering)
[385.803989] Starting subtest: possible-crtcs-filtering
[385.811081] Subtest possible-crtcs-filtering: SUCCESS (0.008s)
[385.934801] [077/132] (637s left) gem_busy (semaphore)
[386.125687] Subtest semaphore: SKIP (0.000s)
[386.359587] [078/132] (636s left) gem_lmem_swapping (heavy-verify-random)
[386.406297] Subtest heavy-verify-random: SKIP (0.000s)
[386.456343] [079/132] (636s left) syncobj_timeline (signal-point-0)
[386.520440] Starting subtest: signal-point-0
[386.522762] Subtest signal-point-0: SUCCESS (0.000s)
[386.623791] [080/132] (636s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[386.713151] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[386.715510] Starting dynamic subtest: pipe-A
[386.942472] Dynamic subtest pipe-A: SUCCESS (0.231s)
[386.951801] Starting dynamic subtest: pipe-B
[388.290601] Dynamic subtest pipe-B: SUCCESS (1.347s)
[388.304677] Starting dynamic subtest: pipe-C
[389.655974] Dynamic subtest pipe-C: SUCCESS (1.365s)
[389.665618] Starting dynamic subtest: pipe-D
[390.973533] Dynamic subtest pipe-D: SUCCESS (1.316s)
[390.975867] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.263s)
[392.131287] [081/132] (631s left) core_auth (many-magics)
[392.197602] Starting subtest: many-magics
[393.140712] Subtest many-magics: SUCCESS (0.945s)
[393.332227] [082/132] (630s left) gem_mmap_wc (read-write)
[393.401935] Subtest read-write: SKIP (0.000s)
[393.465580] [083/132] (629s left) gem_ctx_persistence (many-contexts)
[393.524378] Starting subtest: many-contexts
[438.696102] Subtest many-contexts: SUCCESS (45.170s)
[438.776961] [084/132] (584s left) gem_readwrite (read-write)
[438.843405] Subtest read-write: SKIP (0.000s)
[438.909258] [085/132] (584s left) kms_plane_scaling (invalid-num-scalers)
[438.993345] Starting subtest: invalid-num-scalers
[438.995513] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[439.011942] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[439.021213] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[439.049720] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[439.058913] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[439.083261] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[439.092759] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[439.119167] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[439.121418] Subtest invalid-num-scalers: SUCCESS (0.127s)
[439.225643] [086/132] (584s left) gem_mmap_offset (open-flood)
[439.283538] Starting subtest: open-flood
[460.771051] Subtest open-flood: SUCCESS (21.490s)
[460.877022] [087/132] (562s left) gem_ctx_isolation (preservation-s3)
[460.942288] Starting subtest: preservation-S3
[460.944243] Starting dynamic subtest: rcs0
[477.198526] Dynamic subtest rcs0: SUCCESS (2.157s)
[477.210342] Starting dynamic subtest: bcs0
[493.215123] Dynamic subtest bcs0: SUCCESS (1.306s)
[493.231859] Starting dynamic subtest: vcs0
[509.225388] Dynamic subtest vcs0: SUCCESS (2.519s)
[509.237445] Starting dynamic subtest: vcs1
[527.223317] Dynamic subtest vcs1: SUCCESS (5.023s)
[527.235581] Starting dynamic subtest: vecs0
[545.214647] Dynamic subtest vecs0: SUCCESS (4.939s)
[545.225573] Starting dynamic subtest: ccs0
[563.213000] Dynamic subtest ccs0: SUCCESS (3.186s)
[563.216061] Subtest preservation-S3: SUCCESS (19.135s)
[563.451492] [088/132] (460s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[563.558485] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[564.627880] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.058s)
[564.739634] [089/132] (458s left) api_intel_allocator (fork-simple-stress-signal)
[564.798186] Starting subtest: fork-simple-stress-signal
[570.243444] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[570.367796] [090/132] (453s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[570.493162] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[570.545582] [091/132] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[570.649920] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[577.413985] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.745s)
[577.538954] [092/132] (446s left) kms_psr (psr2-primary-mmap-gtt)
[577.630790] Starting subtest: psr2-primary-mmap-gtt
[577.633305] Starting dynamic subtest: eDP-1
[579.067757] Dynamic subtest eDP-1: SKIP (1.431s)
[579.072943] Subtest psr2-primary-mmap-gtt: SKIP (1.433s)
[579.198247] [093/132] (444s left) gem_userptr_blits (vma-merge)
[579.280186] Starting subtest: vma-merge
[579.319367] Subtest vma-merge: SUCCESS (0.041s)
[579.433584] [094/132] (444s left) gem_reg_read (timestamp-moving)
[579.483549] Starting subtest: timestamp-moving
[580.483205] Subtest timestamp-moving: SUCCESS (0.999s)
[580.559765] [095/132] (443s left) perf_pmu (busy-double-start)
[580.607033] Starting subtest: busy-double-start
[580.610067] Starting dynamic subtest: rcs0
[584.269274] Dynamic subtest rcs0: FAIL (3.587s)
[584.280033] Starting dynamic subtest: bcs0
[587.783489] Dynamic subtest bcs0: SUCCESS (3.581s)
[587.796826] Starting dynamic subtest: vcs0
[591.506049] Dynamic subtest vcs0: FAIL (3.633s)
[591.516937] Starting dynamic subtest: vcs1
[595.474492] Dynamic subtest vcs1: FAIL (3.965s)
[595.485418] Starting dynamic subtest: vecs0
[599.506395] Dynamic subtest vecs0: FAIL (4.032s)
[599.516978] Starting dynamic subtest: ccs0
[603.071112] Dynamic subtest ccs0: FAIL (3.564s)
[603.073699] Subtest busy-double-start: FAIL (22.370s)
[603.117551] [096/132] (420s left) gem_ctx_param (invalid-size-get)
[603.171193] Starting subtest: invalid-size-get
[603.174073] Subtest invalid-size-get: SUCCESS (0.001s)
[603.271574] [097/132] (420s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[603.362831] Starting subtest: primary-y-tiled-reflect-x-0
[603.423934] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[603.529724] [098/132] (420s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[603.670170] Starting subtest: dp-mst-type-0-suspend-resume
[603.675573] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[603.798447] [099/132] (420s left) kms_color (invalid-ctm-matrix-sizes)
[603.890824] Starting subtest: invalid-ctm-matrix-sizes
[603.893274] Starting dynamic subtest: pipe-A
[603.896163] Dynamic subtest pipe-A: SUCCESS (0.002s)
[603.906653] Starting dynamic subtest: pipe-B
[603.909064] Dynamic subtest pipe-B: SUCCESS (0.003s)
[603.918992] Starting dynamic subtest: pipe-C
[603.921191] Dynamic subtest pipe-C: SUCCESS (0.003s)
[603.930982] Starting dynamic subtest: pipe-D
[603.933775] Dynamic subtest pipe-D: SUCCESS (0.004s)
[603.936278] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[603.975500] [100/132] (420s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[604.069689] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[604.071883] Starting dynamic subtest: pipe-A-default-mode
[605.178124] Dynamic subtest pipe-A-default-mode: SKIP (1.105s)
[605.183066] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.106s)
[605.312967] [101/132] (418s left) kms_pipe_crc_basic (hang-read-crc)
[605.407935] Starting subtest: hang-read-crc
[605.410574] Starting dynamic subtest: pipe-A-eDP-1
[607.526186] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[607.538419] Starting dynamic subtest: pipe-B-eDP-1
[610.398227] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[610.409440] Starting dynamic subtest: pipe-C-eDP-1
[613.099349] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.700s)
[613.110563] Starting dynamic subtest: pipe-D-eDP-1
[615.758358] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s)
[615.760833] Subtest hang-read-crc: SUCCESS (10.350s)
[616.591040] [102/132] (407s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[616.709976] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[616.712361] Starting dynamic subtest: pipe-A-eDP-1
[616.735746] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[616.746579] Starting dynamic subtest: pipe-B-eDP-1
[616.771024] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[616.780942] Starting dynamic subtest: pipe-C-eDP-1
[616.805741] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[616.816296] Starting dynamic subtest: pipe-D-eDP-1
[616.841610] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.846568] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[618.965934] [103/132] (405s left) syncobj_basic (bad-pad-handle-to-fd)
[619.019071] Starting subtest: bad-pad-handle-to-fd
[619.021361] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[619.109310] [104/132] (405s left) kms_dsc (dsc-fractional-bpp)
[619.200996] Starting subtest: dsc-fractional-bpp
[619.216895] Subtest dsc-fractional-bpp: SKIP (0.000s)
[619.298747] [105/132] (405s left) perf (polling-parameterized)
[619.414695] Starting subtest: polling-parameterized
[639.432049] Subtest polling-parameterized: SUCCESS (20.013s)
[639.483513] [106/132] (384s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[639.606340] Starting subtest: cursorB-vs-flipB-atomic-transitions
[639.610832] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[639.770556] [107/132] (384s left) gem_mmap_gtt (big-bo-tiledx)
[639.838758] Subtest big-bo-tiledX: SKIP (0.000s)
[639.901574] [108/132] (384s left) gem_eio (wait-1us)
[640.109399] Starting subtest: wait-1us
[640.424034] Subtest wait-1us: SUCCESS (0.316s)
[640.586532] [109/132] (384s left) sysfs_heartbeat_interval (nopreempt)
[640.651451] Starting subtest: nopreempt
[640.653837] Starting dynamic subtest: vecs0
[648.896947] Dynamic subtest vecs0: SUCCESS (8.240s)
[648.910877] Starting dynamic subtest: ccs0
[652.831104] Dynamic subtest ccs0: SUCCESS (3.931s)
[652.843963] Starting dynamic subtest: vcs0
[662.909239] Dynamic subtest vcs0: SUCCESS (10.077s)
[662.922211] Starting dynamic subtest: bcs0
[666.811087] Dynamic subtest bcs0: SUCCESS (3.902s)
[666.823760] Starting dynamic subtest: rcs0
[670.800767] Dynamic subtest rcs0: SUCCESS (3.988s)
[670.812035] Starting dynamic subtest: vcs1
[679.869863] Dynamic subtest vcs1: SUCCESS (9.067s)
[679.872783] Subtest nopreempt: SUCCESS (39.217s)
[679.947995] [110/132] (344s left) i915_pm_rpm (gem-mmap-type)
[682.092193] Starting subtest: gem-mmap-type
[682.094746] Starting dynamic subtest: wb-smem0
[685.866383] Dynamic subtest wb-smem0: SUCCESS (3.776s)
[685.876210] Starting dynamic subtest: wc-smem0
[688.750608] Dynamic subtest wc-smem0: SUCCESS (2.883s)
[688.760827] Starting dynamic subtest: uc-smem0
[691.925696] Dynamic subtest uc-smem0: SUCCESS (3.174s)
[691.927966] Subtest gem-mmap-type: SUCCESS (9.837s)
[692.029487] [111/132] (332s left) kms_plane_lowres (tiling-4)
[692.119902] Starting subtest: tiling-4
[692.122207] Starting dynamic subtest: pipe-A-eDP-1
[692.127034] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[692.422712] Starting dynamic subtest: pipe-B-eDP-1
[692.428059] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[692.438037] Starting dynamic subtest: pipe-C-eDP-1
[692.444106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[692.455936] Starting dynamic subtest: pipe-D-eDP-1
[692.461507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[692.466579] Subtest tiling-4: SKIP (0.306s)
[693.211556] [112/132] (331s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[693.561529] Starting subtest: cursor-rapid-movement-max-size
[693.568718] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[693.683675] [113/132] (331s left) syncobj_timeline (reset-signaled)
[693.754061] Starting subtest: reset-signaled
[693.756993] Subtest reset-signaled: SUCCESS (0.000s)
[693.871789] [114/132] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[693.974079] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[693.979746] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[694.070846] [115/132] (330s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[694.171926] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[694.175860] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[694.278857] [116/132] (330s left) gem_mmap_gtt (basic-read-write)
[694.332005] Subtest basic-read-write: SKIP (0.000s)
[694.397291] [117/132] (330s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[694.496715] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[694.498706] Starting dynamic subtest: pipe-A-eDP-1
[694.638739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[694.650587] Starting dynamic subtest: pipe-B-eDP-1
[694.669383] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[694.679043] Starting dynamic subtest: pipe-C-eDP-1
[694.699431] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[694.708819] Starting dynamic subtest: pipe-D-eDP-1
[694.729713] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[694.731833] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[696.945829] [118/132] (328s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[697.057871] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[697.062840] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[697.158660] [119/132] (327s left) kms_hdr (invalid-metadata-sizes)
[697.257198] Starting subtest: invalid-metadata-sizes
[697.265443] Subtest invalid-metadata-sizes: SKIP (0.000s)
[697.332216] [120/132] (327s left) kms_flip (2x-flip-vs-panning-interruptible)
[697.425874] Starting subtest: 2x-flip-vs-panning-interruptible
[697.437343] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[697.515935] [121/132] (327s left) kms_addfb_basic (bad-pitch-65536)
[697.570918] Starting subtest: bad-pitch-65536
[697.573578] Subtest bad-pitch-65536: SUCCESS (0.000s)
[697.703580] [122/132] (327s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[697.813207] Starting subtest: y-tiled-16bpp-rotate-270
[697.818630] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[697.911607] [123/132] (327s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[697.976091] Starting subtest: invalid-bsd2-flag-on-vebox
[697.979046] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[698.094282] [124/132] (327s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[698.186700] Starting subtest: fbc-rgb101010-draw-render
[702.801870] Subtest fbc-rgb101010-draw-render: SUCCESS (4.617s)
[704.003075] [125/132] (321s left) kms_psr (fbc-psr-primary-mmap-gtt)
[704.106081] Starting subtest: fbc-psr-primary-mmap-gtt
[704.108647] Starting dynamic subtest: eDP-1
[704.114201] Dynamic subtest eDP-1: SKIP (0.000s)
[704.119418] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[704.180347] [126/132] (321s left) gem_ctx_param (basic)
[704.233645] Starting subtest: basic
[704.236375] Subtest basic: SUCCESS (0.001s)
[704.330586] [127/132] (321s left) kms_vblank (wait-forked-busy)
[704.414090] Starting subtest: wait-forked-busy
[704.417084] Starting dynamic subtest: pipe-A-eDP-1
[706.292185] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[706.320716] Starting dynamic subtest: pipe-D-eDP-1
[708.863018] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[708.865811] Subtest wait-forked-busy: SUCCESS (4.446s)
[709.666746] [128/132] (315s left) kms_hdr (static-toggle)
[709.757059] Starting subtest: static-toggle
[709.764918] Subtest static-toggle: SKIP (0.000s)
[709.830611] [129/132] (315s left) i915_drm_fdinfo (virtual-idle)
[709.877045] Starting subtest: virtual-idle
[712.937785] Subtest virtual-idle: SUCCESS (3.062s)
[713.061481] [130/132] (312s left) i915_drm_fdinfo (all-busy-idle-check-all)
[713.107901] Starting subtest: all-busy-idle-check-all
[713.116447] Subtest all-busy-idle-check-all: SKIP (0.006s)
[713.188653] [131/132] (312s left) gem_exec_fence (submit-chain)
[713.363514] Starting subtest: submit-chain
[713.399197] Subtest submit-chain: SUCCESS (0.036s)
[714.988608] [132/132] (310s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[715.111480] Starting subtest: short-flip-before-cursor-atomic-transitions
[716.085488] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.973s)
[716.912227] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_exec_capture
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_getfb
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: gem_pread
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: dmabuf_sync_file
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: kms_dp_link_training
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_busy
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: i915_pm_rps
results: parsing output: 51/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gen7_exec_parse
results: parsing output: 54/ for test: gem_exec_async
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_properties
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: intel_hwmon
results: parsing output: 65/ for test: kms_chamelium_frames
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_exec_whisper
results: parsing output: 68/ for test: kms_chamelium_audio
results: parsing output: 69/ for test: kms_atomic
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: gem_fence_thrash
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: gem_busy
results: parsing output: 77/ for test: gem_lmem_swapping
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: core_auth
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: gem_readwrite
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: gem_ctx_isolation
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: api_intel_allocator
results: parsing output: 89/ for test: kms_tiled_display
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_reg_read
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: gem_ctx_param
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: kms_color
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_pipe_crc_basic
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_dsc
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: sysfs_heartbeat_interval
results: parsing output: 109/ for test: i915_pm_rpm
results: parsing output: 110/ for test: kms_plane_lowres
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_hdr
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: i915_drm_fdinfo
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
Done.