[109.140859] Initializing watchdogs
[109.141075]   /dev/watchdog0
[109.180521] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[109.195444] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[109.202827] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[109.208978] [001/133] (960s left) gem_exec_flush (basic-wb-prw-default)
[109.356727] Starting subtest: basic-wb-prw-default
[114.777079] Subtest basic-wb-prw-default: SUCCESS (5.421s)
[115.032489] [002/133] (954s left) gem_ctx_persistence (legacy-engines-hang)
[115.145151] Starting subtest: legacy-engines-hang
[115.147420] Starting dynamic subtest: render
[115.191168] Dynamic subtest render: SUCCESS (0.042s)
[115.211735] Starting dynamic subtest: bsd
[115.221162] Dynamic subtest bsd: SUCCESS (0.028s)
[115.247941] Starting dynamic subtest: blt
[115.252641] Dynamic subtest blt: SKIP (0.005s)
[115.271500] Starting dynamic subtest: vebox
[115.274840] Dynamic subtest vebox: SUCCESS (0.037s)
[115.278806] Subtest legacy-engines-hang: SUCCESS (0.122s)
[115.416064] [003/133] (954s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[115.538722] Starting subtest: y-tiled-to-vebox-yf-tiled
[115.543275] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[115.814555] [004/133] (954s left) gem_create (create-invalid-size)
[115.922103] Starting subtest: create-invalid-size
[115.926441] Subtest create-invalid-size: SUCCESS (0.000s)
[116.164868] [005/133] (953s left) gem_exec_schedule (implicit-write-read)
[116.294050] Starting subtest: implicit-write-read
[116.295656] Starting dynamic subtest: rcs0
[116.424998] Dynamic subtest rcs0: SUCCESS (0.127s)
[116.457024] Starting dynamic subtest: bcs0
[116.556521] Dynamic subtest bcs0: SUCCESS (0.132s)
[116.591024] Starting dynamic subtest: vcs0
[116.684954] Dynamic subtest vcs0: SUCCESS (0.120s)
[116.706738] Starting dynamic subtest: vecs0
[116.799438] Dynamic subtest vecs0: SUCCESS (0.120s)
[116.802183] Subtest implicit-write-read: SUCCESS (0.507s)
[117.182951] [006/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[117.395112] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[120.535292] Subtest fbc-2p-primscrn-indfb-plflip-blt: SUCCESS (3.138s)
[120.733401] [007/133] (949s left) api_intel_bb (render-ccs)
[120.837592] Starting subtest: render-ccs
[121.184373] Subtest render-ccs: SUCCESS (0.347s)
[121.318081] [008/133] (948s left) gem_eio (in-flight-internal-1us)
[121.449288] Starting subtest: in-flight-internal-1us
[122.952166] Subtest in-flight-internal-1us: SUCCESS (1.503s)
[123.166884] [009/133] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[123.371855] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[123.375378] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[123.515102] [010/133] (946s left) kms_feature_discovery (display-4x)
[123.699716] Starting subtest: display-4x
[123.704745] Subtest display-4x: SKIP (0.000s)
[123.832801] [011/133] (946s left) gem_busy (semaphore)
[124.093795] Starting subtest: semaphore
[124.097136] Starting dynamic subtest: rcs0
[124.125136] Dynamic subtest rcs0: SUCCESS (0.027s)
[124.148025] Starting dynamic subtest: bcs0
[124.156695] Dynamic subtest bcs0: SUCCESS (0.030s)
[124.179408] Starting dynamic subtest: vcs0
[124.183216] Dynamic subtest vcs0: SUCCESS (0.027s)
[124.204615] Starting dynamic subtest: vecs0
[124.206217] Dynamic subtest vecs0: SUCCESS (0.021s)
[124.208225] Subtest semaphore: SUCCESS (0.110s)
[124.499533] [012/133] (946s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[124.602157] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[124.690408] [013/133] (946s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[124.869560] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[124.874488] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[124.999874] [014/133] (945s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[125.201147] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[125.205275] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[125.334381] [015/133] (945s left) prime_mmap (test_refcounting)
[125.439151] Starting subtest: test_refcounting
[125.442060] Starting dynamic subtest: test_refcounting-smem
[125.447791] Dynamic subtest test_refcounting-smem: SUCCESS (0.009s)
[125.450130] Subtest test_refcounting: SUCCESS (0.010s)
[125.585357] [016/133] (945s left) kms_addfb_basic (bad-pitch-0)
[125.689080] Starting subtest: bad-pitch-0
[125.691090] Subtest bad-pitch-0: SUCCESS (0.000s)
[125.915345] [017/133] (945s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[126.031219] Starting subtest: writes-after-reads-snoop
[146.358683] Subtest writes-after-reads-snoop: SUCCESS (20.328s)
[146.498645] [018/133] (924s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[146.682997] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[146.686530] Starting dynamic subtest: pipe-A-HDMI-A-1
[146.715348] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[146.756533] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.794419] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[146.832234] Starting dynamic subtest: pipe-B-HDMI-A-1
[146.867301] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[146.885458] Starting dynamic subtest: pipe-B-HDMI-A-2
[146.904330] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[146.924805] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.942669] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[146.962237] Starting dynamic subtest: pipe-C-HDMI-A-2
[146.978842] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[146.981933] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.025s)
[147.766818] [019/133] (923s left) vgem_slow (nohang)
[147.990723] Starting subtest: nohang
[158.379826] Subtest nohang: SUCCESS (10.389s)
[158.507613] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[158.512582] [020/133] (912s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[158.631356] Starting subtest: y-tiled-ccs-to-x-tiled
[158.633856] Starting dynamic subtest: smem
[158.852113] Dynamic subtest smem: SUCCESS (0.221s)
[158.853778] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.222s)
[159.113155] [021/133] (912s left) kms_vblank (query-forked-hang)
[159.295866] Starting subtest: query-forked-hang
[159.298069] Starting dynamic subtest: pipe-A-HDMI-A-1
[166.855258] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.551s)
[166.900087] Starting dynamic subtest: pipe-A-HDMI-A-2
[173.838201] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.979s)
[173.882810] Starting dynamic subtest: pipe-C-HDMI-A-1
[180.850321] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.002s)
[180.880822] Starting dynamic subtest: pipe-C-HDMI-A-2
[187.837994] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.981s)
[187.840137] Subtest query-forked-hang: SUCCESS (28.546s)
[188.155936] [022/133] (883s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[188.841029] Starting subtest: syncobj-timeline-invalid-flags
[188.842941] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[189.107242] [023/133] (882s left) kms_big_fb (linear-16bpp-rotate-270)
[189.308742] Starting subtest: linear-16bpp-rotate-270
[189.642423] Subtest linear-16bpp-rotate-270: SKIP (0.330s)
[189.887926] [024/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[190.097417] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[190.101198] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[190.253807] [025/133] (881s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[190.435181] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[190.438099] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[192.885125] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.449s)
[192.905447] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[194.886081] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.995s)
[194.915692] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[196.846076] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.954s)
[196.849489] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (6.417s)
[197.181294] [026/133] (874s left) kms_cursor_crc (cursor-onscreen-512x170)
[197.405158] Starting subtest: cursor-onscreen-512x170
[197.409226] Subtest cursor-onscreen-512x170: SKIP (0.003s)
[197.560169] [027/133] (874s left) gem_exec_balancer (parallel-out-fence)
[197.805686] Subtest parallel-out-fence: SKIP (0.000s)
[197.951589] [028/133] (874s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[198.058094] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[198.060398] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.003s)
[198.199676] [029/133] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[198.390156] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[198.397102] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.532857] [030/133] (873s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[198.727112] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[198.736837] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[198.881163] [031/133] (873s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[199.073772] Starting subtest: invalid-modeset-force-ultra-joiner
[199.076880] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[199.213620] [032/133] (873s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[199.415069] Starting subtest: cursor-rapid-movement-64x21
[199.477580] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.407769] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.931s)
[200.529516] Starting dynamic subtest: pipe-C-HDMI-A-1
[201.068034] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.585s)
[201.069727] Subtest cursor-rapid-movement-64x21: SUCCESS (1.654s)
[201.414218] [033/133] (871s left) kms_lease (multimaster-lease)
[201.619091] Starting subtest: multimaster-lease
[201.627183] Subtest multimaster-lease: SUCCESS (0.015s)
[201.810411] [034/133] (870s left) kms_psr (psr2-cursor-mmap-gtt)
[202.010048] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[202.120435] [035/133] (870s left) gem_softpin (zero)
[202.232262] Starting subtest: zero
[202.242206] Subtest zero: SUCCESS (0.008s)
[202.396387] [036/133] (870s left) kms_atomic_transition (plane-all-modeset-transition)
[202.576140] Starting subtest: plane-all-modeset-transition
[202.578060] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.886756] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.307s)
[247.083550] Starting dynamic subtest: pipe-A-HDMI-A-2
[291.080261] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.015s)
[291.274893] Starting dynamic subtest: pipe-B-HDMI-A-1
[331.910138] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.656s)
[332.118832] Starting dynamic subtest: pipe-B-HDMI-A-2
[372.749338] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.673s)
[372.910321] Subtest plane-all-modeset-transition: SUCCESS (170.333s)
[373.235664] [037/133] (699s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[373.432236] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[373.548981] [038/133] (699s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[373.726300] Starting subtest: primary-4-tiled-reflect-x-0
[373.732998] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[373.875184] [039/133] (699s left) gem_ctx_isolation (clean)
[373.998218] Starting subtest: clean
[374.002350] Starting dynamic subtest: rcs0
[374.081121] Dynamic subtest rcs0: SUCCESS (0.079s)
[374.102242] Starting dynamic subtest: bcs0
[374.227106] Dynamic subtest bcs0: SUCCESS (0.143s)
[374.251417] Starting dynamic subtest: vcs0
[374.312131] Dynamic subtest vcs0: SUCCESS (0.085s)
[374.334031] Starting dynamic subtest: vecs0
[374.401754] Dynamic subtest vecs0: SUCCESS (0.087s)
[374.403374] Subtest clean: SUCCESS (0.404s)
[374.662844] [040/133] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[374.857190] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[374.861121] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[375.008362] [041/133] (698s left) syncobj_timeline (etime-multi-wait-submitted)
[375.117169] Starting subtest: etime-multi-wait-submitted
[375.225654] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[375.377661] [042/133] (698s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[375.573805] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[375.577606] Starting dynamic subtest: pipe-A-valid-mode
[376.628642] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.057s)
[376.631900] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.062s)
[376.977206] [043/133] (696s left) gen9_exec_parse (batch-invalid-length)
[377.105076] Starting subtest: batch-invalid-length
[377.118235] Subtest batch-invalid-length: SUCCESS (0.011s)
[377.398681] [044/133] (696s left) kms_big_fb (4-tiled-addfb)
[377.609595] Starting subtest: 4-tiled-addfb
[377.617077] Subtest 4-tiled-addfb: SKIP (0.000s)
[377.761697] [045/133] (696s left) gem_create (create-valid-nonaligned)
[377.861084] Starting subtest: create-valid-nonaligned
[377.864047] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[378.132787] [046/133] (695s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[378.241231] Starting subtest: single-wait-for-submit-available-signaled
[378.243632] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[378.396902] [047/133] (695s left) gem_fence_thrash (bo-copy)
[378.497110] Starting subtest: bo-copy
[379.819260] Subtest bo-copy: SUCCESS (1.327s)
[379.963587] [048/133] (694s left) i915_pm_sseu (full-enable)
[380.519707] Starting subtest: full-enable
[380.537469] Subtest full-enable: SUCCESS (0.018s)
[380.678784] [049/133] (693s left) kms_chamelium_color (gamma)
[380.874767] Subtest gamma: SKIP (0.000s)
[380.987347] [050/133] (693s left) kms_chamelium_hpd (hdmi-hpd-fast)
[381.662320] Subtest hdmi-hpd-fast: SKIP (0.000s)
[381.941820] [051/133] (692s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[383.887091] Starting subtest: modeset-lpsp-stress-no-wait
[383.964106] Subtest modeset-lpsp-stress-no-wait: SKIP (0.068s)
[384.321526] [052/133] (690s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[384.515167] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[385.898058] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.386s)
[386.232528] [053/133] (688s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[386.453289] Starting subtest: fbc-indfb-scaledprimary
[390.019982] Subtest fbc-indfb-scaledprimary: SUCCESS (3.567s)
[390.295845] [054/133] (684s left) gem_exec_parallel (basic)
[390.422202] Starting subtest: basic
[390.424545] Starting dynamic subtest: rcs0
[393.523196] Dynamic subtest rcs0: SUCCESS (3.100s)
[393.550470] Starting dynamic subtest: bcs0
[397.277044] Dynamic subtest bcs0: SUCCESS (3.749s)
[397.300204] Starting dynamic subtest: vcs0
[400.398038] Dynamic subtest vcs0: SUCCESS (3.118s)
[400.424069] Starting dynamic subtest: vecs0
[403.504275] Dynamic subtest vecs0: SUCCESS (3.108s)
[403.506235] Subtest basic: SUCCESS (13.085s)
[403.768445] [055/133] (670s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[403.964912] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[403.969108] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[404.112365] [056/133] (670s left) kms_flip (blocking-wf_vblank)
[404.298085] Starting subtest: blocking-wf_vblank
[404.307067] Starting dynamic subtest: A-HDMI-A1
[410.402060] Dynamic subtest A-HDMI-A1: SUCCESS (6.098s)
[410.422980] Starting dynamic subtest: B-HDMI-A1
[416.123135] Dynamic subtest B-HDMI-A1: SUCCESS (5.719s)
[416.149619] Starting dynamic subtest: C-HDMI-A1
[421.967053] Dynamic subtest C-HDMI-A1: SUCCESS (5.839s)
[421.991879] Starting dynamic subtest: A-HDMI-A2
[427.677409] Dynamic subtest A-HDMI-A2: SUCCESS (5.704s)
[427.700116] Starting dynamic subtest: B-HDMI-A2
[433.511279] Dynamic subtest B-HDMI-A2: SUCCESS (5.828s)
[433.532710] Starting dynamic subtest: C-HDMI-A2
[439.351074] Dynamic subtest C-HDMI-A2: SUCCESS (5.835s)
[439.356111] Subtest blocking-wf_vblank: SUCCESS (35.050s)
[439.909848] [057/133] (635s left) gem_lmem_swapping (verify)
[440.020687] Subtest verify: SKIP (0.000s)
[440.140143] [058/133] (634s left) sysfs_timeslice_duration (idempotent)
[440.253178] Starting subtest: idempotent
[440.255099] Starting dynamic subtest: vecs0
[440.257264] Dynamic subtest vecs0: SUCCESS (0.002s)
[440.293426] Starting dynamic subtest: vcs0
[440.295612] Dynamic subtest vcs0: SUCCESS (0.002s)
[440.317160] Starting dynamic subtest: bcs0
[440.319202] Dynamic subtest bcs0: SUCCESS (0.002s)
[440.339766] Starting dynamic subtest: rcs0
[440.342612] Dynamic subtest rcs0: SUCCESS (0.002s)
[440.345485] Subtest idempotent: SUCCESS (0.019s)
[440.435224] [059/133] (634s left) gem_exec_reloc (basic-softpin)
[440.557279] Starting subtest: basic-softpin
[440.561548] Subtest basic-softpin: SUCCESS (0.007s)
[440.797037] [060/133] (634s left) gem_close (basic)
[440.915213] Starting subtest: basic
[440.919145] Subtest basic: SUCCESS (0.000s)
[441.093713] [061/133] (634s left) gem_render_linear_blits (basic)
[441.212617] Starting subtest: basic
[441.287991] Subtest basic: SUCCESS (0.077s)
[441.404773] [062/133] (634s left) core_hotunplug (unbind-rebind)
[441.600996] Starting subtest: unbind-rebind
[445.821339] Subtest unbind-rebind: SUCCESS (4.215s)
[445.916888] [063/133] (629s left) kms_pipe_crc_basic (hang-read-crc)
[446.126096] Starting subtest: hang-read-crc
[446.129457] Starting dynamic subtest: pipe-A-HDMI-A-1
[447.870907] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.746s)
[447.908682] Starting dynamic subtest: pipe-B-HDMI-A-2
[449.224128] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.345s)
[449.255285] Starting dynamic subtest: pipe-C-HDMI-A-1
[450.571772] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.343s)
[450.574730] Subtest hang-read-crc: SUCCESS (4.454s)
[450.896501] [064/133] (624s left) kms_addfb_basic (tile-pitch-mismatch)
[451.007662] Starting subtest: tile-pitch-mismatch
[451.010166] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[451.250690] [065/133] (624s left) gem_exec_store (pages)
[451.383141] Starting subtest: pages
[451.388095] Starting dynamic subtest: rcs0
[451.481811] Dynamic subtest rcs0: SUCCESS (0.097s)
[451.507512] Starting dynamic subtest: bcs0
[451.580116] Dynamic subtest bcs0: SUCCESS (0.092s)
[451.604190] Starting dynamic subtest: vcs0
[451.673389] Dynamic subtest vcs0: SUCCESS (0.092s)
[451.701234] Starting dynamic subtest: vecs0
[451.762371] Dynamic subtest vecs0: SUCCESS (0.084s)
[451.764455] Subtest pages: SUCCESS (0.382s)
[452.059247] [066/133] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[452.256966] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[452.263405] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[452.416700] [067/133] (623s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[452.632122] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[454.198222] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.568s)
[454.494763] [068/133] (621s left) perf (polling)
[454.720089] Starting subtest: polling
[454.722572] Starting dynamic subtest: 0-rcs0
[464.753795] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[464.756259] Subtest polling: SUCCESS (10.034s)
[464.867254] [069/133] (611s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[464.976980] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[465.091232] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.110s)
[465.234511] [070/133] (610s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[465.432450] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[465.551817] [071/133] (610s left) syncobj_wait (single-wait-all-submitted)
[465.660414] Starting subtest: single-wait-all-submitted
[465.759646] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[465.944372] [072/133] (610s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[466.147098] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[469.138192] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.988s)
[469.495391] [073/133] (607s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[469.694070] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[469.805788] [074/133] (606s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[469.997381] Starting subtest: plane-lut1d-ctm3x4
[471.609698] Subtest plane-lut1d-ctm3x4: SKIP (1.617s)
[471.983899] [075/133] (604s left) gem_eio (throttle)
[472.113297] Starting subtest: throttle
[472.173545] Subtest throttle: SUCCESS (0.058s)
[472.419230] [076/133] (604s left) perf_pmu (busy-start)
[472.533326] Starting subtest: busy-start
[472.535271] Starting dynamic subtest: rcs0
[475.053273] Dynamic subtest rcs0: SUCCESS (2.517s)
[475.076595] Starting dynamic subtest: bcs0
[477.572938] Dynamic subtest bcs0: SUCCESS (2.522s)
[477.601640] Starting dynamic subtest: vcs0
[480.106743] Dynamic subtest vcs0: SUCCESS (2.530s)
[480.132748] Starting dynamic subtest: vecs0
[482.631086] Dynamic subtest vecs0: SUCCESS (2.518s)
[482.633092] Subtest busy-start: SUCCESS (10.102s)
[482.787277] [077/133] (594s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[482.973928] Starting subtest: cursorA-vs-flipB-varying-size
[494.263166] Subtest cursorA-vs-flipB-varying-size: SUCCESS (11.286s)
[494.584645] [078/133] (582s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[494.811072] Starting subtest: y-tiled-64bpp-rotate-270
[495.195245] Subtest y-tiled-64bpp-rotate-270: SKIP (0.381s)
[495.529325] [079/133] (581s left) kms_psr (pr-primary-page-flip)
[495.720776] Subtest pr-primary-page-flip: SKIP (0.000s)
[495.843200] [080/133] (581s left) kms_cursor_legacy (torture-bo)
[496.048125] Starting subtest: torture-bo
[496.051066] Starting dynamic subtest: pipe-A
[502.464623] Dynamic subtest pipe-A: SUCCESS (6.400s)
[503.179111] Starting dynamic subtest: pipe-B
[508.670146] Dynamic subtest pipe-B: SUCCESS (6.215s)
[508.716757] Starting dynamic subtest: pipe-C
[514.227929] Dynamic subtest pipe-C: SUCCESS (5.555s)
[514.256071] Starting dynamic subtest: all-pipes
[519.688094] Dynamic subtest all-pipes: SUCCESS (5.457s)
[519.689862] Subtest torture-bo: SUCCESS (23.644s)
[519.854200] [081/133] (557s left) syncobj_wait (invalid-signal-illegal-handle)
[519.964318] Starting subtest: invalid-signal-illegal-handle
[519.966399] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[520.133684] [082/133] (557s left) i915_drm_fdinfo (busy)
[520.245185] Starting subtest: busy
[520.247149] Starting dynamic subtest: rcs0
[520.782225] Dynamic subtest rcs0: SUCCESS (0.536s)
[520.812436] Starting dynamic subtest: bcs0
[521.329835] Dynamic subtest bcs0: SUCCESS (0.541s)
[521.362437] Starting dynamic subtest: vcs0
[521.862264] Dynamic subtest vcs0: SUCCESS (0.528s)
[521.895680] Starting dynamic subtest: vecs0
[522.403868] Dynamic subtest vecs0: SUCCESS (0.533s)
[522.406437] Subtest busy: SUCCESS (2.159s)
[522.564555] [083/133] (554s left) kms_3d (basic)
[522.672551] Starting subtest: basic
[527.731700] Subtest basic: SUCCESS (5.055s)
[528.265391] [084/133] (549s left) gem_eio (context-create)
[528.407077] Starting subtest: context-create
[528.490249] Subtest context-create: SUCCESS (0.085s)
[528.835084] [085/133] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[529.115414] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[531.994608] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SUCCESS (2.884s)
[532.245914] [086/133] (545s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[532.464570] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[532.467451] Starting dynamic subtest: pipe-A
[533.376582] Dynamic subtest pipe-A: SUCCESS (0.912s)
[533.403403] Starting dynamic subtest: pipe-B
[534.330908] Dynamic subtest pipe-B: SUCCESS (0.953s)
[534.384078] Starting dynamic subtest: pipe-C
[535.224021] Dynamic subtest pipe-C: SUCCESS (0.881s)
[535.226939] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.758s)
[535.884524] [087/133] (542s left) drm_read (empty-block)
[536.339022] Starting subtest: empty-block
[537.343061] Subtest empty-block: SUCCESS (1.001s)
[537.620405] [088/133] (540s left) kms_plane (pixel-format-yf-tiled-modifier)
[537.817404] Starting subtest: pixel-format-yf-tiled-modifier
[538.021720] Starting dynamic subtest: pipe-A-plane-0
[538.718496] Dynamic subtest pipe-A-plane-0: SUCCESS (0.696s)
[538.742499] Starting dynamic subtest: pipe-A-plane-1
[539.400592] Dynamic subtest pipe-A-plane-1: SUCCESS (0.680s)
[539.425748] Starting dynamic subtest: pipe-A-plane-2
[539.852101] Dynamic subtest pipe-A-plane-2: SUCCESS (0.447s)
[539.876418] Starting dynamic subtest: pipe-A-plane-3
[540.316224] Dynamic subtest pipe-A-plane-3: SUCCESS (0.463s)
[540.356296] Starting dynamic subtest: pipe-A-plane-4
[540.363380] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[540.731342] Starting dynamic subtest: pipe-B-plane-0
[541.360411] Dynamic subtest pipe-B-plane-0: SUCCESS (0.647s)
[541.384846] Starting dynamic subtest: pipe-B-plane-1
[542.027179] Dynamic subtest pipe-B-plane-1: SUCCESS (0.663s)
[542.051660] Starting dynamic subtest: pipe-B-plane-2
[542.475781] Dynamic subtest pipe-B-plane-2: SUCCESS (0.446s)
[542.500285] Starting dynamic subtest: pipe-B-plane-3
[542.926639] Dynamic subtest pipe-B-plane-3: SUCCESS (0.446s)
[542.951570] Starting dynamic subtest: pipe-B-plane-4
[542.959353] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[543.166187] Subtest pixel-format-yf-tiled-modifier: SUCCESS (5.358s)
[543.546911] [089/133] (534s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[543.739260] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[543.744154] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[544.543878] [090/133] (533s left) gem_exec_balancer (full-pulse)
[544.667574] Starting subtest: full-pulse
[549.199808] Subtest full-pulse: SUCCESS (4.529s)
[549.486130] [091/133] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[549.685219] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[552.162586] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.481s)
[552.495686] [092/133] (526s left) gem_exec_flush (basic-wb-ro-default)
[552.621584] Starting subtest: basic-wb-ro-default
[558.043719] Subtest basic-wb-ro-default: SUCCESS (5.422s)
[558.331796] [093/133] (520s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[558.521069] Starting subtest: flip-vs-cursor-busy-crc-legacy
[559.573371] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (1.049s)
[559.882399] [094/133] (518s left) i915_getparams_basic (basic-eu-total)
[559.989073] Starting subtest: basic-eu-total
[559.995116] Subtest basic-eu-total: SUCCESS (0.000s)
[560.143976] [095/133] (518s left) syncobj_eventfd (binary-wait-signaled)
[560.253097] Starting subtest: binary-wait-signaled
[560.254809] Subtest binary-wait-signaled: SUCCESS (0.001s)
[560.397354] [096/133] (518s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[560.608095] Starting subtest: fbcpsr-rgb565-draw-render
[560.612944] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[560.774300] [097/133] (518s left) api_intel_allocator (two-level-inception)
[560.881855] Starting subtest: two-level-inception
[566.416324] Subtest two-level-inception: SUCCESS (5.535s)
[566.597955] [098/133] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[566.800111] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[566.804276] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[566.945445] [099/133] (512s left) syncobj_wait (reset-signaled)
[567.056248] Starting subtest: reset-signaled
[567.058281] Subtest reset-signaled: SUCCESS (0.001s)
[567.215767] [100/133] (512s left) syncobj_timeline (multi-wait-available-submitted)
[567.324207] Starting subtest: multi-wait-available-submitted
[567.327152] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[567.479905] [101/133] (512s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[567.666526] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[567.669446] Starting dynamic subtest: pipe-A
[568.029776] Dynamic subtest pipe-A: SUCCESS (0.363s)
[568.077574] Starting dynamic subtest: pipe-B
[568.495170] Dynamic subtest pipe-B: SUCCESS (0.462s)
[568.546352] Starting dynamic subtest: pipe-C
[568.607345] Dynamic subtest pipe-C: SUCCESS (0.104s)
[568.609517] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.941s)
[569.124397] [102/133] (510s left) gem_mmap (pf-nonblock)
[569.229725] Starting subtest: pf-nonblock
[569.236580] Subtest pf-nonblock: SUCCESS (0.007s)
[569.395651] [103/133] (510s left) gem_exec_reloc (basic-gtt-active)
[569.511969] Starting subtest: basic-gtt-active
[569.651698] Subtest basic-gtt-active: SUCCESS (0.138s)
[569.876808] [104/133] (509s left) kms_setmode (invalid-clone-single-crtc-stealing)
[569.990096] Starting subtest: invalid-clone-single-crtc-stealing
[570.461077] Starting dynamic subtest: pipe-A-HDMI-A-1-HDMI-A-2
[570.891251] Dynamic subtest pipe-A-HDMI-A-1-HDMI-A-2: SUCCESS (0.428s)
[571.148692] Starting dynamic subtest: pipe-B-HDMI-A-1-HDMI-A-2
[571.548855] Dynamic subtest pipe-B-HDMI-A-1-HDMI-A-2: SUCCESS (0.417s)
[571.763150] Subtest invalid-clone-single-crtc-stealing: SUCCESS (1.776s)
[572.102099] [105/133] (507s left) kms_psr (fbc-psr2-suspend)
[572.294061] Subtest fbc-psr2-suspend: SKIP (0.000s)
[572.408267] [106/133] (507s left) perf (gen12-mi-rpc)
[572.639735] Starting subtest: gen12-mi-rpc
[572.642966] Subtest gen12-mi-rpc: SKIP (0.000s)
[572.749794] [107/133] (507s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[572.936141] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[572.939295] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[573.097126] [108/133] (507s left) prime_busy (after)
[573.215217] Starting subtest: after
[573.227129] Starting dynamic subtest: rcs0
[573.237365] Dynamic subtest rcs0: SUCCESS (0.009s)
[573.271048] Starting dynamic subtest: bcs0
[573.274158] Dynamic subtest bcs0: SUCCESS (0.007s)
[573.301262] Starting dynamic subtest: vcs0
[573.303534] Dynamic subtest vcs0: SUCCESS (0.017s)
[573.327180] Starting dynamic subtest: vecs0
[573.329428] Dynamic subtest vecs0: SUCCESS (0.008s)
[573.392120] Subtest after: SUCCESS (0.180s)
[573.548739] [109/133] (506s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[573.763609] Starting subtest: 4-tiled-16bpp-rotate-0
[573.768112] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[573.915736] [110/133] (506s left) gem_userptr_blits (probe)
[574.079980] Starting subtest: probe
[574.429588] Subtest probe: SUCCESS (0.354s)
[574.602829] [111/133] (505s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[574.795614] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[574.799574] Starting dynamic subtest: pipe-A-valid-mode
[575.821120] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.023s)
[575.824099] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.029s)
[576.142103] [112/133] (504s left) kms_content_protection (dp-mst-lic-type-1)
[576.395829] Starting subtest: dp-mst-lic-type-1
[576.398978] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[576.543056] [113/133] (504s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[576.755113] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[576.760156] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[576.906918] [114/133] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[577.109301] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[577.113123] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[577.257968] [115/133] (503s left) gem_mmap_offset (bad-object)
[577.362089] Starting subtest: bad-object
[577.369153] Subtest bad-object: SUCCESS (0.004s)
[577.556204] [116/133] (503s left) gem_lmem_swapping (parallel-random-engines)
[577.671736] Subtest parallel-random-engines: SKIP (0.000s)
[577.784363] [117/133] (503s left) kms_psr (fbc-pr-sprite-render)
[577.973197] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[578.098921] [118/133] (503s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[578.314868] Starting subtest: yf-tiled-8bpp-rotate-90
[578.320248] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[578.472638] [119/133] (502s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[578.659427] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[578.671878] Starting dynamic subtest: pipe-A-HDMI-A-1
[578.697349] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[578.744371] Starting dynamic subtest: pipe-A-HDMI-A-2
[578.775268] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[578.819217] Starting dynamic subtest: pipe-B-HDMI-A-1
[578.848228] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[578.883108] Starting dynamic subtest: pipe-B-HDMI-A-2
[578.903105] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[578.928098] Starting dynamic subtest: pipe-C-HDMI-A-1
[578.943055] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[578.967746] Starting dynamic subtest: pipe-C-HDMI-A-2
[578.982881] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[578.985856] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.039s)
[579.789227] [120/133] (501s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[579.983066] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[579.986305] Starting dynamic subtest: pipe-A-HDMI-A-1
[580.010884] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[580.063382] Starting dynamic subtest: pipe-A-HDMI-A-2
[580.093634] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[580.145424] Starting dynamic subtest: pipe-B-HDMI-A-1
[580.175354] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[580.223244] Starting dynamic subtest: pipe-B-HDMI-A-2
[580.239174] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[580.265221] Starting dynamic subtest: pipe-C-HDMI-A-1
[580.281130] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[580.305741] Starting dynamic subtest: pipe-C-HDMI-A-2
[580.321497] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[580.324667] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.047s)
[581.144566] [121/133] (500s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[581.333702] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[581.335218] Starting dynamic subtest: pipe-A-HDMI-A-1
[581.364925] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[581.414480] Starting dynamic subtest: pipe-A-HDMI-A-2
[581.439398] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[581.487646] Starting dynamic subtest: pipe-B-HDMI-A-1
[581.517256] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[581.564555] Starting dynamic subtest: pipe-B-HDMI-A-2
[581.587193] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[581.611671] Starting dynamic subtest: pipe-C-HDMI-A-1
[581.627278] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.004s)
[581.652913] Starting dynamic subtest: pipe-C-HDMI-A-2
[581.668440] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[581.671497] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.063s)
[582.462622] [122/133] (499s left) gem_pxp (hw-rejects-pxp-context)
[585.107640] Starting subtest: hw-rejects-pxp-context
[585.109552] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[585.271342] [123/133] (496s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[585.472096] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[588.274163] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.796s)
[588.470154] [124/133] (493s left) gem_exec_fence (syncobj-timeline-unused-fence)
[589.165087] Starting subtest: syncobj-timeline-unused-fence
[589.173185] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[589.450219] [125/133] (492s left) gem_exec_schedule (reorder-wide)
[589.716149] Starting subtest: reorder-wide
[589.718544] Starting dynamic subtest: rcs0
[589.860234] Dynamic subtest rcs0: SUCCESS (0.141s)
[589.887972] Starting dynamic subtest: bcs0
[590.186960] Dynamic subtest bcs0: SUCCESS (0.325s)
[590.228205] Starting dynamic subtest: vcs0
[590.354252] Dynamic subtest vcs0: SUCCESS (0.160s)
[590.399738] Starting dynamic subtest: vecs0
[590.508986] Dynamic subtest vecs0: SUCCESS (0.151s)
[590.514691] Subtest reorder-wide: SUCCESS (0.793s)
[590.790327] [126/133] (491s left) kms_sequence (get-forked)
[590.978201] Starting subtest: get-forked
[590.981204] Starting dynamic subtest: pipe-A-HDMI-A-1
[593.806244] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.826s)
[593.858339] Starting dynamic subtest: pipe-A-HDMI-A-2
[596.293045] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.480s)
[596.337476] Starting dynamic subtest: pipe-B-HDMI-A-1
[598.770040] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.471s)
[598.804056] Starting dynamic subtest: pipe-B-HDMI-A-2
[601.261076] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.485s)
[601.295174] Starting dynamic subtest: pipe-C-HDMI-A-1
[603.751446] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.484s)
[603.790273] Starting dynamic subtest: pipe-C-HDMI-A-2
[606.244096] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.477s)
[606.255870] Subtest get-forked: SUCCESS (15.272s)
[606.615997] [127/133] (475s left) i915_pm_rpm (sysfs-read)
[608.558882] Starting subtest: sysfs-read
[608.698653] Subtest sysfs-read: SUCCESS (0.137s)
[609.161396] [128/133] (473s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[609.357121] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[609.365183] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[620.191627] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.823s)
[620.220914] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[630.966083] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.767s)
[630.996442] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[641.729253] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.752s)
[641.733451] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SUCCESS (32.367s)
[642.371521] [129/133] (440s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[642.572933] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[642.577290] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[642.725194] [130/133] (439s left) kms_busy (basic)
[642.926178] Starting subtest: basic
[642.931118] Starting dynamic subtest: flip
[643.915036] Dynamic subtest flip: SUCCESS (0.988s)
[643.972415] Starting dynamic subtest: modeset
[645.427396] Dynamic subtest modeset: SUCCESS (1.504s)
[645.430197] Subtest basic: SUCCESS (2.507s)
[645.914279] [131/133] (436s left) kms_pm_rpm (fences)
[647.829108] Starting subtest: fences
[650.924971] Subtest fences: SUCCESS (3.096s)
[651.262338] [132/133] (431s left) gem_ctx_exec (basic-invalid-context)
[651.375807] Starting subtest: basic-invalid-context
[651.383236] Subtest basic-invalid-context: SUCCESS (0.008s)
[651.544726] [133/133] (431s left) kms_cursor_edge_walk (256x256-top-edge)
[651.732062] Starting subtest: 256x256-top-edge
[651.735083] Starting dynamic subtest: pipe-A-HDMI-A-1
[655.689262] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.950s)
[655.729058] Starting dynamic subtest: pipe-C-HDMI-A-1
[659.177397] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.481s)
[659.179133] Subtest 256x256-top-edge: SUCCESS (7.449s)
[659.495312] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_flush
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: gem_create
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_feature_discovery
results: parsing output: 10/ for test: gem_busy
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: prime_mmap
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_partial_pwrite_pread
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: vgem_slow
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_joiner
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_lease
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: kms_atomic_transition
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_fence_thrash
results: parsing output: 47/ for test: i915_pm_sseu
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_parallel
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: sysfs_timeslice_duration
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: gem_close
results: parsing output: 60/ for test: gem_render_linear_blits
results: parsing output: 61/ for test: core_hotunplug
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_exec_store
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_color_pipeline
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: kms_3d
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: drm_read
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_flush
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: i915_getparams_basic
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: api_intel_allocator
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: gem_mmap
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_setmode
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: prime_busy
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_sequence
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_busy
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: gem_ctx_exec
results: parsing output: 132/ for test: kms_cursor_edge_walk
Done.