[73.332858] Initializing watchdogs
[73.332939]   /dev/watchdog0
[73.365208] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[73.380317] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[73.384988] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.388870] [001/156] (960s left) kms_psr (fbc-psr2-cursor-plane-move)
[74.890211] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[74.975955] [002/156] (958s left) gem_mmap_offset (partial-mmap)
[75.030321] Starting subtest: partial-mmap
[75.032062] Starting dynamic subtest: lmem0
[75.035792] Dynamic subtest lmem0: SUCCESS (0.006s)
[75.047011] Starting dynamic subtest: smem0
[75.048960] Dynamic subtest smem0: SUCCESS (0.006s)
[75.050717] Subtest partial-mmap: SUCCESS (0.013s)
[75.268308] [003/156] (958s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[76.770179] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[76.773929] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[76.957071] [004/156] (957s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[78.472349] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[78.475967] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[78.632163] [005/156] (955s left) kms_invalid_mode (zero-vdisplay)
[80.129152] Starting subtest: zero-vdisplay
[80.130803] Starting dynamic subtest: pipe-A-HDMI-A-1
[80.170072] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.043s)
[80.179487] Starting dynamic subtest: pipe-B-HDMI-A-1
[80.182115] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[80.191385] Starting dynamic subtest: pipe-C-HDMI-A-1
[80.193222] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[80.202185] Starting dynamic subtest: pipe-D-HDMI-A-1
[80.203836] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[80.205528] Subtest zero-vdisplay: SUCCESS (0.050s)
[80.367632] [006/156] (954s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[81.862203] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[81.864026] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.479050] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.613s)
[82.488183] Starting dynamic subtest: pipe-B-HDMI-A-1
[83.086833] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.606s)
[83.096144] Starting dynamic subtest: pipe-C-HDMI-A-1
[83.695132] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.606s)
[83.704522] Starting dynamic subtest: pipe-D-HDMI-A-1
[84.302910] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.607s)
[84.305248] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.437s)
[84.485649] [007/156] (949s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[85.989609] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[85.992901] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[86.188410] [008/156] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[87.689311] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[87.692379] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.879246] [009/156] (946s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[89.385202] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[89.388436] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[89.595049] [010/156] (945s left) kms_plane_scaling (planes-downscale-factor-0-5)
[91.103788] Starting subtest: planes-downscale-factor-0-5
[91.105468] Starting dynamic subtest: pipe-A
[91.276275] Dynamic subtest pipe-A: SUCCESS (0.174s)
[91.286100] Starting dynamic subtest: pipe-B
[91.433964] Dynamic subtest pipe-B: SUCCESS (0.157s)
[91.443377] Starting dynamic subtest: pipe-C
[91.592093] Dynamic subtest pipe-C: SUCCESS (0.158s)
[91.602021] Starting dynamic subtest: pipe-D
[91.747862] Dynamic subtest pipe-D: SUCCESS (0.156s)
[91.749300] Subtest planes-downscale-factor-0-5: SUCCESS (0.646s)
[91.939117] [011/156] (942s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[93.448470] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[93.452164] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[93.657411] [012/156] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[95.159814] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[95.163201] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[95.349372] [013/156] (939s left) gen7_exec_parse (bitmasks)
[95.408707] Subtest bitmasks: SKIP (0.000s)
[95.485873] [014/156] (939s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[96.983018] Starting subtest: fbc-2p-pri-indfb-multidraw
[96.986440] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[97.198701] [015/156] (938s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[98.689177] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[98.693325] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[98.888088] [016/156] (936s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[100.399063] Starting subtest: y-tiled-32bpp-rotate-90
[102.456995] Subtest y-tiled-32bpp-rotate-90: SUCCESS (2.057s)
[102.719608] [017/156] (932s left) sysfs_heartbeat_interval (nopreempt)
[102.773654] Starting subtest: nopreempt
[102.775393] Starting dynamic subtest: vecs0
[106.775770] Dynamic subtest vecs0: SUCCESS (4.000s)
[106.785718] Starting dynamic subtest: vcs0
[110.703121] Dynamic subtest vcs0: SUCCESS (3.928s)
[110.713558] Starting dynamic subtest: bcs0
[114.642608] Dynamic subtest bcs0: SUCCESS (3.939s)
[114.653416] Starting dynamic subtest: rcs0
[118.672452] Dynamic subtest rcs0: SUCCESS (4.030s)
[118.683167] Starting dynamic subtest: vcs1
[122.605394] Dynamic subtest vcs1: SUCCESS (3.932s)
[122.607140] Subtest nopreempt: SUCCESS (19.831s)
[122.810060] [018/156] (912s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[124.304979] Starting subtest: bad-rotation-90-y-tiled-ccs
[124.306487] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.320999] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[124.331582] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.346336] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[124.356194] Starting dynamic subtest: pipe-C-HDMI-A-1
[124.371090] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[124.381330] Starting dynamic subtest: pipe-D-HDMI-A-1
[124.398655] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[124.402117] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[124.584447] [019/156] (911s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[126.097040] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[126.100973] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[126.300418] [020/156] (909s left) prime_vgem (wait)
[126.443029] Starting subtest: wait
[126.444375] Starting dynamic subtest: rcs0
[126.500344] Dynamic subtest rcs0: SUCCESS (0.057s)
[126.511052] Starting dynamic subtest: bcs0
[126.551606] Dynamic subtest bcs0: SUCCESS (0.051s)
[126.569102] Starting dynamic subtest: vcs0
[126.594855] Dynamic subtest vcs0: SUCCESS (0.042s)
[126.618972] Starting dynamic subtest: vcs1
[126.638943] Dynamic subtest vcs1: SUCCESS (0.043s)
[126.662785] Starting dynamic subtest: vecs0
[126.681562] Dynamic subtest vecs0: SUCCESS (0.042s)
[126.683317] Subtest wait: SUCCESS (0.239s)
[126.942118] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[126.945279] [021/156] (909s left) i915_power (sanity)
[126.994888] Starting subtest: sanity
[131.037477] Subtest sanity: SUCCESS (4.038s)
[131.192428] [022/156] (904s left) prime_vgem (fence-write-hang)
[131.271847] Subtest fence-write-hang: SKIP (0.000s)
[131.445221] [023/156] (904s left) perf (invalid-oa-exponent)
[131.567338] Starting subtest: invalid-oa-exponent
[131.595811] Subtest invalid-oa-exponent: SUCCESS (0.028s)
[131.667303] [024/156] (904s left) perf (mi-rpc)
[131.794472] Starting subtest: mi-rpc
[131.798047] Subtest mi-rpc: SKIP (0.000s)
[131.867376] [025/156] (904s left) gem_render_copy_redux (flink)
[131.918895] Starting subtest: flink
[134.006883] Subtest flink: SUCCESS (2.088s)
[134.171752] [026/156] (902s left) kms_cursor_crc (cursor-random-32x10)
[135.777480] Starting subtest: cursor-random-32x10
[135.825773] Subtest cursor-random-32x10: SKIP (0.047s)
[136.244530] [027/156] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[137.744427] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[137.747796] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[137.924565] [028/156] (898s left) kms_cursor_crc (cursor-offscreen-64x64)
[139.542388] Starting subtest: cursor-offscreen-64x64
[139.549254] Starting dynamic subtest: pipe-A-HDMI-A-1
[142.023015] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.474s)
[142.060634] Starting dynamic subtest: pipe-D-HDMI-A-1
[144.465866] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.419s)
[144.467509] Subtest cursor-offscreen-64x64: SUCCESS (4.922s)
[144.977798] [029/156] (891s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[146.516760] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[146.649312] [030/156] (890s left) syncobj_wait (invalid-signal-bad-pad)
[146.697724] Starting subtest: invalid-signal-bad-pad
[146.699246] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[146.879194] [031/156] (890s left) gem_busy (extended)
[147.126029] Starting subtest: extended
[147.127779] Starting dynamic subtest: rcs0
[147.203709] Dynamic subtest rcs0: SUCCESS (0.077s)
[147.216955] Starting dynamic subtest: bcs0
[147.246735] Dynamic subtest bcs0: SUCCESS (0.042s)
[147.265608] Starting dynamic subtest: vcs0
[147.290973] Dynamic subtest vcs0: SUCCESS (0.043s)
[147.316191] Starting dynamic subtest: vcs1
[147.337123] Dynamic subtest vcs1: SUCCESS (0.045s)
[147.362182] Starting dynamic subtest: vecs0
[147.382899] Dynamic subtest vecs0: SUCCESS (0.045s)
[147.385146] Subtest extended: SUCCESS (0.257s)
[147.672410] [032/156] (889s left) gem_exec_fence (syncobj-timeline-repeat)
[148.201409] Starting subtest: syncobj-timeline-repeat
[148.757483] Subtest syncobj-timeline-repeat: SUCCESS (0.556s)
[149.143281] [033/156] (887s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[149.191879] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[149.298381] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[149.419236] [034/156] (887s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[150.929816] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[150.933057] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[151.089311] [035/156] (886s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[152.600939] Starting subtest: yf-tiled-32bpp-rotate-270
[152.604029] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[152.752551] [036/156] (884s left) syncobj_basic (create-signaled)
[152.799631] Starting subtest: create-signaled
[152.801243] Subtest create-signaled: SUCCESS (0.000s)
[152.926212] [037/156] (884s left) vgem_basic (dmabuf-fence)
[152.986701] Starting subtest: dmabuf-fence
[152.988490] Subtest dmabuf-fence: SUCCESS (0.001s)
[153.090647] [038/156] (884s left) dmabuf_sync_file (import-multiple-read-write)
[153.155049] Starting subtest: import-multiple-read-write
[153.158486] Subtest import-multiple-read-write: SUCCESS (0.006s)
[153.254995] [039/156] (884s left) api_intel_bb (offset-control)
[153.303324] Starting subtest: offset-control
[153.329857] Subtest offset-control: SUCCESS (0.027s)
[153.550883] [040/156] (884s left) kms_chamelium_edid (dp-mode-timings)
[155.094483] Subtest dp-mode-timings: SKIP (0.000s)
[155.226880] [041/156] (882s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[156.717066] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[156.720238] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[156.857819] [042/156] (881s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[158.361299] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[158.365045] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[158.518401] [043/156] (879s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[160.011268] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[160.012725] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.027092] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[160.038402] Starting dynamic subtest: pipe-B-HDMI-A-1
[160.053531] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[160.064416] Starting dynamic subtest: pipe-C-HDMI-A-1
[160.079741] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[160.090679] Starting dynamic subtest: pipe-D-HDMI-A-1
[160.107687] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[160.111204] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.009s)
[160.298185] [044/156] (877s left) kms_flip (blocking-absolute-wf_vblank)
[161.788722] Starting subtest: blocking-absolute-wf_vblank
[161.792972] Starting dynamic subtest: A-HDMI-A1
[169.720800] Dynamic subtest A-HDMI-A1: SUCCESS (7.927s)
[169.734444] Starting dynamic subtest: B-HDMI-A1
[177.415751] Dynamic subtest B-HDMI-A1: SUCCESS (7.694s)
[177.427605] Starting dynamic subtest: C-HDMI-A1
[185.110697] Dynamic subtest C-HDMI-A1: SUCCESS (7.693s)
[185.123164] Starting dynamic subtest: D-HDMI-A1
[192.804973] Dynamic subtest D-HDMI-A1: SUCCESS (7.693s)
[192.808583] Subtest blocking-absolute-wf_vblank: SUCCESS (31.020s)
[193.089389] [045/156] (845s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[194.592557] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[197.763083] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.175s)
[198.082885] [046/156] (840s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[199.582292] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[199.584036] Starting dynamic subtest: pipe-A
[199.734546] Dynamic subtest pipe-A: SUCCESS (0.152s)
[199.747278] Starting dynamic subtest: pipe-B
[199.891763] Dynamic subtest pipe-B: SUCCESS (0.156s)
[199.902767] Starting dynamic subtest: pipe-C
[200.048928] Dynamic subtest pipe-C: SUCCESS (0.156s)
[200.060322] Starting dynamic subtest: pipe-D
[200.206037] Dynamic subtest pipe-D: SUCCESS (0.156s)
[200.207779] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.624s)
[200.414078] [047/156] (837s left) kms_plane_alpha_blend (constant-alpha-max)
[201.905401] Starting subtest: constant-alpha-max
[202.179031] Starting dynamic subtest: pipe-A-HDMI-A-1
[203.100786] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.921s)
[203.112110] Starting dynamic subtest: pipe-D-HDMI-A-1
[204.001149] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.899s)
[204.011988] Subtest constant-alpha-max: SUCCESS (2.095s)
[204.228316] [048/156] (834s left) gem_ctx_persistence (file)
[204.283405] Starting subtest: file
[204.385778] Subtest file: SUCCESS (0.102s)
[204.612054] [049/156] (833s left) perf_pmu (init-busy)
[204.664641] Starting subtest: init-busy
[204.666232] Starting dynamic subtest: rcs0
[204.667813] Dynamic subtest rcs0: SUCCESS (0.001s)
[204.679347] Starting dynamic subtest: bcs0
[204.681179] Dynamic subtest bcs0: SUCCESS (0.001s)
[204.692203] Starting dynamic subtest: vcs0
[204.693926] Dynamic subtest vcs0: SUCCESS (0.001s)
[204.705176] Starting dynamic subtest: vcs1
[204.706968] Dynamic subtest vcs1: SUCCESS (0.001s)
[204.717944] Starting dynamic subtest: vecs0
[204.719866] Dynamic subtest vecs0: SUCCESS (0.001s)
[204.721746] Subtest init-busy: SUCCESS (0.009s)
[204.799468] [050/156] (833s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[206.310100] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[206.313215] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[206.463908] [051/156] (832s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[207.957483] Starting subtest: plane-all-modeset-transition-fencing
[207.959040] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.178568] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (15.217s)
[223.247600] Starting dynamic subtest: pipe-B-HDMI-A-1
[234.732368] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (11.508s)
[234.748958] Subtest plane-all-modeset-transition-fencing: SUCCESS (26.792s)
[234.969514] [052/156] (803s left) gem_partial_pwrite_pread (write-snoop)
[235.026118] Subtest write-snoop: SKIP (0.000s)
[235.127742] [053/156] (803s left) kms_psr (pr-cursor-plane-move)
[236.621976] Subtest pr-cursor-plane-move: SKIP (0.000s)
[236.691792] [054/156] (802s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[238.203223] Starting subtest: x-tiled-32bpp-rotate-270
[238.315824] Subtest x-tiled-32bpp-rotate-270: SKIP (0.110s)
[238.492985] [055/156] (800s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[238.543882] Starting subtest: invalid-multi-wait-unsubmitted
[238.545274] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[238.688687] [056/156] (800s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[240.187427] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[240.190971] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[240.359260] [057/156] (798s left) kms_rotation_crc (exhaust-fences)
[241.850283] Starting subtest: exhaust-fences
[241.853826] Subtest exhaust-fences: SKIP (0.000s)
[241.996013] [058/156] (797s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[243.498820] Starting subtest: psr-rgb101010-draw-mmap-gtt
[243.502243] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[243.687149] [059/156] (795s left) gem_softpin (evict-prime)
[243.740837] Starting subtest: evict-prime
[243.742531] Starting dynamic subtest: rcs0
[244.928654] Dynamic subtest rcs0: SUCCESS (1.187s)
[244.940201] Starting dynamic subtest: bcs0
[246.146147] Dynamic subtest bcs0: SUCCESS (1.212s)
[246.157628] Starting dynamic subtest: vcs0
[247.278056] Dynamic subtest vcs0: SUCCESS (1.135s)
[247.289977] Starting dynamic subtest: vcs1
[248.476245] Dynamic subtest vcs1: SUCCESS (1.194s)
[248.488340] Starting dynamic subtest: vecs0
[249.609113] Dynamic subtest vecs0: SUCCESS (1.135s)
[249.622866] Starting dynamic subtest: all
[250.752276] Dynamic subtest all: SUCCESS (1.142s)
[250.754361] Subtest evict-prime: SUCCESS (7.012s)
[250.894390] [060/156] (788s left) gem_mmap_gtt (close-race)
[250.944390] Subtest close-race: SKIP (0.000s)
[251.026376] [061/156] (788s left) kms_dsc (dsc-basic-ultrajoiner)
[252.517797] Starting subtest: dsc-basic-ultrajoiner
[252.521159] Subtest dsc-basic-ultrajoiner: SKIP (0.000s)
[252.653072] [062/156] (787s left) gem_exec_whisper (basic-fds-forked)
[252.718327] Starting subtest: basic-fds-forked
[266.547868] Subtest basic-fds-forked: SUCCESS (13.825s)
[266.791847] [063/156] (773s left) kms_setmode (basic-clone-single-crtc)
[266.840046] Starting subtest: basic-clone-single-crtc
[266.844619] Subtest basic-clone-single-crtc: SKIP (0.001s)
[266.949616] [064/156] (772s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[268.447940] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[268.451484] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[268.639957] [065/156] (771s left) kms_atomic (atomic-plane-damage)
[270.131361] Starting subtest: atomic-plane-damage
[270.381439] Starting dynamic subtest: pipe-A-HDMI-A-1
[271.083913] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.704s)
[271.085521] Subtest atomic-plane-damage: SUCCESS (0.955s)
[271.295231] [066/156] (768s left) gem_mmap_wc (write-wc-read-gtt)
[271.348481] Subtest write-wc-read-gtt: SKIP (0.000s)
[271.430755] [067/156] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[272.931765] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[272.934737] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[273.097414] [068/156] (767s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[274.608829] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[275.167561] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.559s)
[275.416434] [069/156] (764s left) kms_cursor_crc (cursor-sliding-32x32)
[276.994826] Starting subtest: cursor-sliding-32x32
[277.045007] Subtest cursor-sliding-32x32: SKIP (0.046s)
[277.428741] [070/156] (763s left) gem_ctx_param (invalid-ctx-get)
[277.497884] Starting subtest: invalid-ctx-get
[277.500396] Subtest invalid-ctx-get: SUCCESS (0.000s)
[277.647801] [071/156] (762s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[279.143047] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[279.239259] [072/156] (761s left) kms_psr (psr-sprite-plane-move)
[280.737513] Subtest psr-sprite-plane-move: SKIP (0.000s)
[280.817839] [073/156] (759s left) gem_ctx_exec (basic-invalid-context)
[280.870824] Starting subtest: basic-invalid-context
[280.873833] Subtest basic-invalid-context: SUCCESS (0.004s)
[281.100874] [074/156] (759s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[282.601255] Starting subtest: fbchdr-2p-rte
[282.604836] Subtest fbchdr-2p-rte: SKIP (0.000s)
[282.792613] [075/156] (758s left) gem_ctx_shared (q-smoketest)
[282.873532] Starting subtest: Q-smoketest
[282.875254] Starting dynamic subtest: rcs0
[288.339961] Dynamic subtest rcs0: SUCCESS (5.452s)
[288.351841] Starting dynamic subtest: bcs0
[293.784336] Dynamic subtest bcs0: SUCCESS (5.444s)
[293.795530] Starting dynamic subtest: vcs0
[299.219975] Dynamic subtest vcs0: SUCCESS (5.437s)
[299.231305] Starting dynamic subtest: vcs1
[304.668394] Dynamic subtest vcs1: SUCCESS (5.446s)
[304.679957] Starting dynamic subtest: vecs0
[310.110857] Dynamic subtest vecs0: SUCCESS (5.440s)
[310.112577] Subtest Q-smoketest: SUCCESS (27.226s)
[310.432470] [076/156] (730s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[310.480964] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[310.482526] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[310.625804] [077/156] (730s left) perf (low-oa-exponent-permissions)
[310.742121] Starting subtest: low-oa-exponent-permissions
[310.798102] Subtest low-oa-exponent-permissions: SUCCESS (0.056s)
[310.890504] [078/156] (730s left) perf_pmu (enable-race)
[310.941756] Starting subtest: enable-race
[310.943585] Starting dynamic subtest: rcs0
[323.692604] Dynamic subtest rcs0: SUCCESS (12.751s)
[323.704422] Starting dynamic subtest: bcs0
[336.441650] Dynamic subtest bcs0: SUCCESS (12.748s)
[336.453196] Starting dynamic subtest: vcs0
[349.193663] Dynamic subtest vcs0: SUCCESS (12.751s)
[349.205811] Starting dynamic subtest: vcs1
[361.944369] Dynamic subtest vcs1: SUCCESS (12.750s)
[361.956185] Starting dynamic subtest: vecs0
[374.696429] Dynamic subtest vecs0: SUCCESS (12.751s)
[374.697957] Subtest enable-race: SUCCESS (63.756s)
[374.835517] [079/156] (666s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[376.334841] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[376.338174] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[376.550474] [080/156] (664s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[378.040362] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[378.041772] Starting dynamic subtest: pipe-A-HDMI-A-1
[378.055944] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[378.067646] Starting dynamic subtest: pipe-B-HDMI-A-1
[378.082096] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[378.093429] Starting dynamic subtest: pipe-C-HDMI-A-1
[378.108384] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[378.119505] Starting dynamic subtest: pipe-D-HDMI-A-1
[378.136381] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[378.139944] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.008s)
[378.317382] [081/156] (663s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-pgflip-blt)
[379.818858] Starting subtest: hdr-2p-scndscrn-shrfb-pgflip-blt
[379.822274] Subtest hdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[380.006607] [082/156] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[381.506491] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[381.509868] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[381.667971] [083/156] (660s left) i915_drm_fdinfo (basics)
[381.720840] Starting subtest: basics
[381.722440] Subtest basics: SUCCESS (0.000s)
[381.829114] [084/156] (660s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[383.328152] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[383.331334] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[383.525857] [085/156] (658s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[385.740363] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[385.834656] [086/156] (656s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[387.340527] Starting subtest: fbchdr-tiling-4
[387.343903] Subtest fbchdr-tiling-4: SKIP (0.000s)
[387.504025] [087/156] (654s left) kms_prop_blob (blob-prop-lifetime)
[387.552791] Starting subtest: blob-prop-lifetime
[387.554361] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[387.667313] [088/156] (654s left) prime_self_import (basic-llseek-bad)
[387.713204] Starting subtest: basic-llseek-bad
[387.716480] Subtest basic-llseek-bad: SUCCESS (0.003s)
[387.891784] [089/156] (654s left) gem_exec_fence (basic-busy)
[388.067345] Starting subtest: basic-busy
[388.069012] Starting dynamic subtest: rcs0
[388.138758] Dynamic subtest rcs0: SUCCESS (0.071s)
[388.160052] Starting dynamic subtest: bcs0
[388.198278] Dynamic subtest bcs0: SUCCESS (0.057s)
[388.220287] Starting dynamic subtest: vcs0
[388.255683] Dynamic subtest vcs0: SUCCESS (0.053s)
[388.273590] Starting dynamic subtest: vcs1
[388.309610] Dynamic subtest vcs1: SUCCESS (0.052s)
[388.326540] Starting dynamic subtest: vecs0
[388.367798] Dynamic subtest vecs0: SUCCESS (0.055s)
[388.369822] Subtest basic-busy: SUCCESS (0.301s)
[389.055749] [090/156] (653s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[390.554120] Starting subtest: fbc-rgb565-draw-pwrite
[393.563647] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.011s)
[393.757249] [091/156] (648s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[393.809142] Starting subtest: invalid-multi-wait-unsubmitted
[393.810858] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[393.915920] [092/156] (648s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[395.418224] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[395.422224] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[395.613051] [093/156] (647s left) gem_pxp (reject-modify-context-protection-off-1)
[398.188800] Starting subtest: reject-modify-context-protection-off-1
[398.191781] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[398.355398] [094/156] (644s left) gem_ctx_persistence (legacy-engines-persistence)
[398.408865] Starting subtest: legacy-engines-persistence
[398.410348] Starting dynamic subtest: render
[399.218758] Dynamic subtest render: SUCCESS (0.809s)
[399.233529] Starting dynamic subtest: bsd1
[399.976709] Dynamic subtest bsd1: SUCCESS (0.756s)
[399.991235] Starting dynamic subtest: bsd2
[400.743763] Dynamic subtest bsd2: SUCCESS (0.765s)
[400.758248] Starting dynamic subtest: blt
[401.514784] Dynamic subtest blt: SUCCESS (0.769s)
[401.531265] Starting dynamic subtest: vebox
[402.276787] Dynamic subtest vebox: SUCCESS (0.760s)
[402.278394] Subtest legacy-engines-persistence: SUCCESS (3.869s)
[402.441153] [095/156] (640s left) kms_addfb_basic (bad-pitch-256)
[402.489828] Starting subtest: bad-pitch-256
[402.491369] Subtest bad-pitch-256: SUCCESS (0.000s)
[404.118884] [096/156] (638s left) kms_psr (pr-sprite-blt)
[405.625898] Subtest pr-sprite-blt: SKIP (0.000s)
[405.711900] [097/156] (637s left) gem_exec_schedule (preempt-contexts)
[405.778304] Starting subtest: preempt-contexts
[405.779807] Starting dynamic subtest: rcs0
[405.866999] Dynamic subtest rcs0: SUCCESS (0.088s)
[405.878935] Starting dynamic subtest: bcs0
[405.937576] Dynamic subtest bcs0: SUCCESS (0.069s)
[405.949814] Starting dynamic subtest: vcs0
[406.008522] Dynamic subtest vcs0: SUCCESS (0.070s)
[406.020558] Starting dynamic subtest: vcs1
[406.079797] Dynamic subtest vcs1: SUCCESS (0.070s)
[406.092094] Starting dynamic subtest: vecs0
[406.150655] Dynamic subtest vecs0: SUCCESS (0.070s)
[406.152713] Subtest preempt-contexts: SUCCESS (0.373s)
[406.620643] [098/156] (636s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[406.669989] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[406.742407] [099/156] (636s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[408.240564] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[408.243640] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[408.449400] [100/156] (634s left) gem_exec_schedule (smoketest-all)
[408.513353] Starting subtest: smoketest-all
[440.815880] Subtest smoketest-all: SUCCESS (32.287s)
[441.291848] [101/156] (602s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[442.791801] Starting subtest: hdr-rgb565-draw-pwrite
[442.795594] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[442.994854] [102/156] (600s left) syncobj_timeline (invalid-signal-zero-handles)
[443.042086] Starting subtest: invalid-signal-zero-handles
[443.043740] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[443.189294] [103/156] (600s left) kms_properties (crtc-properties-legacy)
[444.679496] Starting subtest: crtc-properties-legacy
[444.680961] Starting dynamic subtest: pipe-A-HDMI-A-1
[445.002342] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.320s)
[445.027189] Starting dynamic subtest: pipe-B-HDMI-A-1
[445.325486] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.319s)
[445.337326] Starting dynamic subtest: pipe-C-HDMI-A-1
[445.650153] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.313s)
[445.663328] Starting dynamic subtest: pipe-D-HDMI-A-1
[445.956134] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.314s)
[445.957655] Subtest crtc-properties-legacy: SUCCESS (1.278s)
[446.154620] [104/156] (597s left) gem_softpin (32b-excludes-last-page)
[446.209039] Starting subtest: 32b-excludes-last-page
[446.214511] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[446.388993] [105/156] (597s left) gem_exec_schedule (u-independent)
[446.452396] Starting subtest: u-independent
[446.454121] Starting dynamic subtest: rcs0
[446.705025] Dynamic subtest rcs0: SUCCESS (0.254s)
[446.735525] Starting dynamic subtest: bcs0
[446.932935] Dynamic subtest bcs0: SUCCESS (0.225s)
[446.958399] Starting dynamic subtest: vcs0
[447.152851] Dynamic subtest vcs0: SUCCESS (0.218s)
[447.170235] Starting dynamic subtest: vcs1
[447.375857] Dynamic subtest vcs1: SUCCESS (0.221s)
[447.387950] Starting dynamic subtest: vecs0
[447.578185] Dynamic subtest vecs0: SUCCESS (0.201s)
[447.580037] Subtest u-independent: SUCCESS (1.129s)
[447.987920] [106/156] (595s left) gem_ctx_param (invalid-param-get)
[448.038380] Starting subtest: invalid-param-get
[448.040308] Subtest invalid-param-get: SUCCESS (0.001s)
[448.165548] [107/156] (595s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[449.665125] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[449.668700] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[449.865668] [108/156] (594s left) gem_mmap_wc (write-gtt-read-wc)
[449.916269] Subtest write-gtt-read-wc: SKIP (0.000s)
[449.994081] [109/156] (594s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[451.494800] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[451.498250] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[451.692743] [110/156] (592s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[453.193127] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[453.196727] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[453.393278] [111/156] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[454.894936] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[454.898221] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[455.052406] [112/156] (589s left) kms_content_protection (uevent)
[456.599843] Starting subtest: uevent
[456.606578] Subtest uevent: SKIP (0.002s)
[456.822499] [113/156] (587s left) kms_psr (psr-cursor-plane-move)
[458.314823] Subtest psr-cursor-plane-move: SKIP (0.000s)
[458.393489] [114/156] (586s left) kms_psr (fbc-pr-suspend)
[459.885062] Subtest fbc-pr-suspend: SKIP (0.000s)
[459.981677] [115/156] (584s left) kms_pm_rpm (cursor)
[464.016501] Starting subtest: cursor
[464.021686] Subtest cursor: SKIP (0.000s)
[464.994012] [116/156] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[466.496054] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[466.499916] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[466.679185] [117/156] (578s left) kms_plane (plane-panning-bottom-right)
[468.177412] Starting subtest: plane-panning-bottom-right
[468.181164] Starting dynamic subtest: pipe-A
[468.876405] Dynamic subtest pipe-A: SUCCESS (0.696s)
[468.888369] Starting dynamic subtest: pipe-B
[469.434814] Dynamic subtest pipe-B: SUCCESS (0.556s)
[469.436599] Subtest plane-panning-bottom-right: SUCCESS (1.257s)
[469.640966] [118/156] (575s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[471.135759] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[471.139154] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[471.279866] [119/156] (573s left) gem_userptr_blits (huge-split)
[471.354117] Starting subtest: huge-split
[471.374254] Subtest huge-split: SUCCESS (0.020s)
[471.591141] [120/156] (573s left) kms_hdr (static-toggle-suspend)
[473.090836] Starting subtest: static-toggle-suspend
[473.092486] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[473.095786] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s)
[473.107747] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[473.111291] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s)
[473.114964] Subtest static-toggle-suspend: SKIP (0.006s)
[473.242929] [121/156] (572s left) gem_exec_balancer (bonded-true-hang)
[473.671108] Starting subtest: bonded-true-hang
[473.674487] Subtest bonded-true-hang: SKIP (0.000s)
[473.800593] [122/156] (571s left) syncobj_timeline (signal-array)
[473.849022] Starting subtest: signal-array
[473.850402] Subtest signal-array: SUCCESS (0.000s)
[473.967452] [123/156] (571s left) gen3_render_linear_blits
[474.090951] [124/156] (571s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[475.581975] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[475.583812] Starting dynamic subtest: pipe-A-HDMI-A-1
[475.610421] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[475.622362] Starting dynamic subtest: pipe-B-HDMI-A-1
[475.636323] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[475.648098] Starting dynamic subtest: pipe-C-HDMI-A-1
[475.662539] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[475.674193] Starting dynamic subtest: pipe-D-HDMI-A-1
[475.690123] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[475.693144] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s)
[475.867538] [125/156] (569s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[477.386699] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[477.389856] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[477.549378] [126/156] (568s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[479.048774] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[482.291789] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.246s)
[482.526688] [127/156] (563s left) kms_flip (2x-flip-vs-dpms-on-nop)
[484.018548] Starting subtest: 2x-flip-vs-dpms-on-nop
[484.041114] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.021s)
[484.192226] [128/156] (561s left) perf (oa-exponents)
[484.317681] Starting subtest: oa-exponents
[484.319444] Starting dynamic subtest: 0-rcs0
[488.021956] Dynamic subtest 0-rcs0: SUCCESS (3.700s)
[488.023820] Subtest oa-exponents: SUCCESS (3.702s)
[488.093957] [129/156] (558s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[489.597351] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[489.600969] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[489.784825] [130/156] (556s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[491.286554] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[491.289930] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[491.461555] [131/156] (554s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[492.955714] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[493.047358] [132/156] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[494.566618] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[494.569878] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[494.752617] [133/156] (551s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[496.252681] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[496.255886] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[496.444410] [134/156] (550s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[497.952937] Starting subtest: addfb25-yf-tiled-legacy
[497.954567] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[498.129210] [135/156] (548s left) kms_lease (setcrtc-implicit-plane)
[499.622040] Starting subtest: setcrtc-implicit-plane
[499.623888] Starting dynamic subtest: pipe-A-HDMI-A-1
[500.030492] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.408s)
[500.044589] Starting dynamic subtest: pipe-B-HDMI-A-1
[500.294310] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.259s)
[500.307031] Starting dynamic subtest: pipe-C-HDMI-A-1
[500.554906] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.257s)
[500.568112] Starting dynamic subtest: pipe-D-HDMI-A-1
[500.818755] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.262s)
[500.820228] Subtest setcrtc-implicit-plane: SUCCESS (1.199s)
[501.024316] [136/156] (545s left) kms_vblank (wait-idle)
[502.516617] Starting subtest: wait-idle
[502.518122] Starting dynamic subtest: pipe-A-HDMI-A-1
[504.864417] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.347s)
[504.879062] Starting dynamic subtest: pipe-D-HDMI-A-1
[507.054902] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.185s)
[507.056644] Subtest wait-idle: SUCCESS (4.539s)
[507.247714] [137/156] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[508.749081] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[511.676997] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.932s)
[511.941104] [138/156] (535s left) kms_cursor_legacy (torture-move)
[513.433664] Starting subtest: torture-move
[513.435125] Starting dynamic subtest: pipe-A
[518.941666] Dynamic subtest pipe-A: SUCCESS (5.504s)
[518.953760] Starting dynamic subtest: pipe-B
[524.393390] Dynamic subtest pipe-B: SUCCESS (5.453s)
[524.405748] Starting dynamic subtest: pipe-C
[529.847204] Dynamic subtest pipe-C: SUCCESS (5.451s)
[529.859363] Starting dynamic subtest: pipe-D
[535.298936] Dynamic subtest pipe-D: SUCCESS (5.450s)
[535.311202] Starting dynamic subtest: all-pipes
[540.762246] Dynamic subtest all-pipes: SUCCESS (5.462s)
[540.763947] Subtest torture-move: SUCCESS (27.329s)
[540.917592] [139/156] (506s left) gem_exec_suspend (basic-s3-devices)
[540.986112] Starting subtest: basic-S3-devices
[540.987859] Starting dynamic subtest: smem
[551.364906] Dynamic subtest smem: SUCCESS (10.379s)
[551.378228] Starting dynamic subtest: lmem0
[561.629596] Dynamic subtest lmem0: SUCCESS (10.263s)
[561.631428] Subtest basic-S3-devices: SUCCESS (20.645s)
[567.901356] [140/156] (485s left) i915_getparams_basic (basic-subslice-total)
[567.953153] Starting subtest: basic-subslice-total
[567.955807] Subtest basic-subslice-total: SUCCESS (0.000s)
[568.069866] [141/156] (485s left) i915_pm_rpm (system-suspend-execbuf)
[572.107770] Starting subtest: system-suspend-execbuf
[634.667212] Subtest system-suspend-execbuf: SUCCESS (51.968s)
[635.633386] [142/156] (417s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[637.133627] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[637.137231] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[637.336045] [143/156] (416s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[638.842648] Starting subtest: fbcpsr-stridechange
[638.848338] Subtest fbcpsr-stridechange: SKIP (0.000s)
[639.097304] [144/156] (414s left) gem_exec_flush (basic-wb-ro-before-default)
[639.167324] Subtest basic-wb-ro-before-default: SKIP (0.000s)
[639.268755] [145/156] (414s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[640.762144] Starting subtest: plane-ctm3x4-lut1d
[640.956668] Starting dynamic subtest: pipe-A-plane-0
[641.203427] Dynamic subtest pipe-A-plane-0: SUCCESS (0.247s)
[641.250586] Starting dynamic subtest: pipe-A-plane-1
[641.404712] Dynamic subtest pipe-A-plane-1: SUCCESS (0.193s)
[641.447705] Starting dynamic subtest: pipe-A-plane-2
[641.603060] Dynamic subtest pipe-A-plane-2: SUCCESS (0.193s)
[641.910964] Starting dynamic subtest: pipe-B-plane-0
[642.073857] Dynamic subtest pipe-B-plane-0: SUCCESS (0.197s)
[642.113811] Starting dynamic subtest: pipe-B-plane-1
[642.288220] Dynamic subtest pipe-B-plane-1: SUCCESS (0.209s)
[642.320845] Starting dynamic subtest: pipe-B-plane-2
[642.478585] Dynamic subtest pipe-B-plane-2: SUCCESS (0.176s)
[642.811055] Starting dynamic subtest: pipe-C-plane-0
[642.985867] Dynamic subtest pipe-C-plane-0: SUCCESS (0.213s)
[643.020769] Starting dynamic subtest: pipe-C-plane-1
[643.185518] Dynamic subtest pipe-C-plane-1: SUCCESS (0.192s)
[643.227749] Starting dynamic subtest: pipe-C-plane-2
[643.402242] Dynamic subtest pipe-C-plane-2: SUCCESS (0.209s)
[643.743138] Starting dynamic subtest: pipe-D-plane-0
[643.926428] Dynamic subtest pipe-D-plane-0: SUCCESS (0.213s)
[643.963619] Starting dynamic subtest: pipe-D-plane-1
[644.145028] Dynamic subtest pipe-D-plane-1: SUCCESS (0.209s)
[644.175855] Starting dynamic subtest: pipe-D-plane-2
[644.343100] Dynamic subtest pipe-D-plane-2: SUCCESS (0.193s)
[644.397993] Subtest plane-ctm3x4-lut1d: SUCCESS (3.638s)
[644.617067] [146/156] (409s left) sw_sync (sync_random_merge)
[644.664382] Starting subtest: sync_random_merge
[644.761460] Subtest sync_random_merge: SUCCESS (0.097s)
[644.865026] [147/156] (409s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[644.912944] Starting subtest: single-wait-for-submit-available-submitted
[644.914374] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[645.051862] [148/156] (409s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[646.552514] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[646.555655] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[646.730735] [149/156] (407s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[648.223587] Starting subtest: cursorB-vs-flipA-varying-size
[648.227020] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[648.414219] [150/156] (405s left) gem_exec_params (mmapped)
[648.469895] Starting subtest: mmapped
[648.473131] Subtest mmapped: SUCCESS (0.002s)
[648.705948] [151/156] (405s left) perf (short-reads)
[648.823857] Starting subtest: short-reads
[648.847022] Subtest short-reads: SUCCESS (0.025s)
[648.933133] [152/156] (405s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[650.425496] Starting subtest: flip-vs-cursor-varying-size
[664.849311] Subtest flip-vs-cursor-varying-size: SUCCESS (14.425s)
[665.053569] [153/156] (389s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[666.554660] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[666.560239] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[666.771570] [154/156] (387s left) gem_exercise_blt (fast-copy)
[666.841565] Starting subtest: fast-copy
[666.843271] Starting dynamic subtest: linear-smem-smem
[666.877676] Dynamic subtest linear-smem-smem: SUCCESS (0.038s)
[666.892276] Starting dynamic subtest: linear-smem-lmem0
[666.896744] Dynamic subtest linear-smem-lmem0: SUCCESS (0.018s)
[666.911426] Starting dynamic subtest: linear-lmem0-smem
[666.961217] Dynamic subtest linear-lmem0-smem: SUCCESS (0.063s)
[666.975727] Starting dynamic subtest: linear-lmem0-lmem0
[667.023797] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.061s)
[667.038503] Starting dynamic subtest: ymajor-smem-smem
[667.042994] Dynamic subtest ymajor-smem-smem: SUCCESS (0.018s)
[667.057537] Starting dynamic subtest: ymajor-smem-lmem0
[667.061677] Dynamic subtest ymajor-smem-lmem0: SUCCESS (0.016s)
[667.075940] Starting dynamic subtest: ymajor-lmem0-smem
[667.123509] Dynamic subtest ymajor-lmem0-smem: SUCCESS (0.062s)
[667.137717] Starting dynamic subtest: ymajor-lmem0-lmem0
[667.185601] Dynamic subtest ymajor-lmem0-lmem0: SUCCESS (0.061s)
[667.199483] Starting dynamic subtest: tile4-smem-smem
[667.204258] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[667.220236] Starting dynamic subtest: tile4-smem-lmem0
[667.222017] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.016s)
[667.238289] Starting dynamic subtest: tile4-lmem0-smem
[667.285285] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.062s)
[667.301387] Starting dynamic subtest: tile4-lmem0-lmem0
[667.347442] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.061s)
[667.363487] Starting dynamic subtest: tile64-smem-smem
[667.366241] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[667.380290] Starting dynamic subtest: tile64-smem-lmem0
[667.384070] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s)
[667.400369] Starting dynamic subtest: tile64-lmem0-smem
[667.447911] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.062s)
[667.462001] Starting dynamic subtest: tile64-lmem0-lmem0
[667.509716] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.060s)
[667.511089] Subtest fast-copy: SUCCESS (0.672s)
[667.677696] [155/156] (387s left) gem_exec_flush (basic-batch-kernel-default-uc)
[667.731461] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[667.838290] [156/156] (387s left) gem_eio (in-flight-1us)
[668.036023] Starting subtest: in-flight-1us
[672.321270] Subtest in-flight-1us: SUCCESS (4.285s)
[673.958251] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_invalid_mode
results: parsing output: 5/ for test: kms_ccs
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: kms_plane_scaling
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: sysfs_heartbeat_interval
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: prime_vgem
results: parsing output: 20/ for test: i915_power
results: parsing output: 21/ for test: prime_vgem
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: gem_render_copy_redux
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_plane_alpha_blend
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_dsc
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_setmode
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_ctx_exec
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_ctx_shared
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_tiled_display
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_prop_blob
results: parsing output: 87/ for test: prime_self_import
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: kms_hdr
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gen3_render_linear_blits
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_addfb_basic
results: parsing output: 134/ for test: kms_lease
results: parsing output: 135/ for test: kms_vblank
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: gem_exec_suspend
results: parsing output: 139/ for test: i915_getparams_basic
results: parsing output: 140/ for test: i915_pm_rpm
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_exec_flush
results: parsing output: 144/ for test: kms_color_pipeline
results: parsing output: 145/ for test: sw_sync
results: parsing output: 146/ for test: syncobj_timeline
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: gem_exec_params
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_exercise_blt
results: parsing output: 154/ for test: gem_exec_flush
results: parsing output: 155/ for test: gem_eio
Done.