[67.331481] Initializing watchdogs
[67.331564]   /dev/watchdog0
[67.362520] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.377551] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.382721] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.385309] [001/133] (960s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[68.875056] Starting subtest: pixel-format-linear-modifier-source-clamping
[68.915000] Starting dynamic subtest: pipe-A-plane-0
[75.294651] Dynamic subtest pipe-A-plane-0: SUCCESS (6.369s)
[75.331313] Starting dynamic subtest: pipe-A-plane-3
[80.527663] Dynamic subtest pipe-A-plane-3: SUCCESS (5.229s)
[80.536805] Starting dynamic subtest: pipe-A-plane-5
[83.312383] Dynamic subtest pipe-A-plane-5: SUCCESS (2.783s)
[83.488290] Starting dynamic subtest: pipe-B-plane-0
[89.450507] Dynamic subtest pipe-B-plane-0: SUCCESS (5.967s)
[89.459628] Starting dynamic subtest: pipe-B-plane-3
[94.401934] Dynamic subtest pipe-B-plane-3: SUCCESS (4.950s)
[94.411544] Starting dynamic subtest: pipe-B-plane-5
[97.302631] Dynamic subtest pipe-B-plane-5: SUCCESS (2.900s)
[97.374943] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (28.481s)
[97.628298] [002/133] (930s left) kms_flip (plain-flip-fb-recreate-interruptible)
[99.125568] Starting subtest: plain-flip-fb-recreate-interruptible
[99.133583] Starting dynamic subtest: A-HDMI-A4
[107.160474] Dynamic subtest A-HDMI-A4: SUCCESS (8.024s)
[107.197738] Starting dynamic subtest: B-HDMI-A4
[115.140476] Dynamic subtest B-HDMI-A4: SUCCESS (7.975s)
[115.173282] Starting dynamic subtest: C-HDMI-A4
[123.102739] Dynamic subtest C-HDMI-A4: SUCCESS (7.958s)
[123.132525] Starting dynamic subtest: D-HDMI-A4
[131.070712] Dynamic subtest D-HDMI-A4: SUCCESS (7.963s)
[131.072959] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.941s)
[131.319660] [003/133] (896s left) kms_frontbuffer_tracking (basic)
[132.808479] Starting subtest: basic
[135.710578] Subtest basic: SUCCESS (2.901s)
[135.891525] [004/133] (892s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[137.416257] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[137.523510] [005/133] (890s left) kms_pm_rpm (legacy-planes)
[141.025095] Starting subtest: legacy-planes
[141.026769] Starting dynamic subtest: plane-65
[148.037215] Dynamic subtest plane-65: SUCCESS (7.011s)
[148.082725] Starting dynamic subtest: plane-95
[155.663516] Dynamic subtest plane-95: SUCCESS (7.624s)
[155.709080] Starting dynamic subtest: plane-125
[162.448991] Dynamic subtest plane-125: SUCCESS (6.783s)
[162.495414] Starting dynamic subtest: plane-135
[169.389624] Dynamic subtest plane-135: SUCCESS (6.938s)
[169.436458] Starting dynamic subtest: plane-145
[176.331418] Dynamic subtest plane-145: SUCCESS (6.939s)
[176.378200] Starting dynamic subtest: plane-155
[183.330070] Dynamic subtest plane-155: SUCCESS (6.995s)
[183.336034] Subtest legacy-planes: SUCCESS (42.308s)
[184.299481] [006/133] (843s left) kms_content_protection (atomic-dpms-hdcp14)
[185.852380] Starting subtest: atomic-dpms-hdcp14
[185.855210] Subtest atomic-dpms-hdcp14: SKIP (0.001s)
[186.060465] [007/133] (842s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[187.568574] Starting subtest: x-tiled-64bpp-rotate-90
[187.645397] Subtest x-tiled-64bpp-rotate-90: SKIP (0.075s)
[187.835506] [008/133] (840s left) kms_flip (flip-vs-dpms-on-nop)
[189.336869] Starting subtest: flip-vs-dpms-on-nop
[189.343821] Starting dynamic subtest: A-HDMI-A4
[190.366845] Dynamic subtest A-HDMI-A4: SUCCESS (1.023s)
[190.379209] Starting dynamic subtest: B-HDMI-A4
[191.347239] Dynamic subtest B-HDMI-A4: SUCCESS (0.978s)
[191.359484] Starting dynamic subtest: C-HDMI-A4
[192.325588] Dynamic subtest C-HDMI-A4: SUCCESS (0.973s)
[192.359898] Starting dynamic subtest: D-HDMI-A4
[193.335742] Dynamic subtest D-HDMI-A4: SUCCESS (1.004s)
[193.340405] Subtest flip-vs-dpms-on-nop: SUCCESS (4.002s)
[193.534313] [009/133] (834s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[195.038885] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[195.608473] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.569s)
[195.850160] [010/133] (832s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[197.339695] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[197.341286] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[197.509183] [011/133] (831s left) vgem_basic (second-client)
[197.658433] Starting subtest: second-client
[197.693788] Subtest second-client: SUCCESS (0.033s)
[197.823900] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[197.826696] [012/133] (830s left) gem_exec_schedule (submit-early-slice)
[197.890541] Starting subtest: submit-early-slice
[197.891604] Starting dynamic subtest: rcs0
[197.951438] Dynamic subtest rcs0: SUCCESS (0.062s)
[197.960543] Starting dynamic subtest: bcs0
[197.996535] Dynamic subtest bcs0: SUCCESS (0.044s)
[198.005521] Starting dynamic subtest: vcs0
[198.041799] Dynamic subtest vcs0: SUCCESS (0.044s)
[198.050725] Starting dynamic subtest: vcs1
[198.087557] Dynamic subtest vcs1: SUCCESS (0.045s)
[198.096542] Starting dynamic subtest: vecs0
[198.131885] Dynamic subtest vecs0: SUCCESS (0.043s)
[198.133195] Subtest submit-early-slice: SUCCESS (0.243s)
[198.549312] [013/133] (830s left) gem_mmap_gtt (zero-extend)
[198.593418] Subtest zero-extend: SKIP (0.000s)
[198.667410] [014/133] (830s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[200.149817] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[200.150595] Starting dynamic subtest: pipe-A-HDMI-A-4
[200.153827] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[200.162704] Starting dynamic subtest: pipe-B-HDMI-A-4
[200.165903] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[200.174683] Starting dynamic subtest: pipe-C-HDMI-A-4
[200.177842] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[200.186417] Starting dynamic subtest: pipe-D-HDMI-A-4
[200.189821] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[200.191410] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[200.392971] [015/133] (828s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[201.881913] Starting subtest: fbc-1p-pri-indfb-multidraw
[210.789521] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.907s)
[210.988599] [016/133] (818s left) kms_big_fb (linear-8bpp-rotate-90)
[212.511557] Starting subtest: linear-8bpp-rotate-90
[212.607564] Subtest linear-8bpp-rotate-90: SKIP (0.094s)
[212.751295] [017/133] (816s left) gem_exec_params (cliprects_ptr-dirt)
[212.801779] Starting subtest: cliprects_ptr-dirt
[212.802727] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[212.955866] [018/133] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[214.443992] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[217.056337] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.612s)
[217.260609] [019/133] (812s left) kms_plane (plane-position-hole-dpms)
[218.744107] Starting subtest: plane-position-hole-dpms
[219.177393] Starting dynamic subtest: pipe-A-plane-1
[219.679166] Dynamic subtest pipe-A-plane-1: SUCCESS (0.501s)
[219.688204] Starting dynamic subtest: pipe-A-plane-2
[220.115976] Dynamic subtest pipe-A-plane-2: SUCCESS (0.436s)
[220.126532] Starting dynamic subtest: pipe-A-plane-3
[220.618136] Dynamic subtest pipe-A-plane-3: SUCCESS (0.500s)
[220.627181] Starting dynamic subtest: pipe-A-plane-4
[221.101757] Dynamic subtest pipe-A-plane-4: SUCCESS (0.483s)
[221.110764] Starting dynamic subtest: pipe-A-plane-5
[221.571489] Dynamic subtest pipe-A-plane-5: SUCCESS (0.469s)
[221.580480] Starting dynamic subtest: pipe-A-plane-6
[222.073741] Dynamic subtest pipe-A-plane-6: SUCCESS (0.501s)
[222.082789] Starting dynamic subtest: pipe-A-plane-7
[222.095158] Dynamic subtest pipe-A-plane-7: SUCCESS (0.020s)
[222.381818] Starting dynamic subtest: pipe-B-plane-1
[222.823339] Dynamic subtest pipe-B-plane-1: SUCCESS (0.451s)
[222.832877] Starting dynamic subtest: pipe-B-plane-2
[223.304420] Dynamic subtest pipe-B-plane-2: SUCCESS (0.479s)
[223.313473] Starting dynamic subtest: pipe-B-plane-3
[223.789608] Dynamic subtest pipe-B-plane-3: SUCCESS (0.484s)
[223.798485] Starting dynamic subtest: pipe-B-plane-4
[224.252135] Dynamic subtest pipe-B-plane-4: SUCCESS (0.460s)
[224.262460] Starting dynamic subtest: pipe-B-plane-5
[224.736533] Dynamic subtest pipe-B-plane-5: SUCCESS (0.484s)
[224.745399] Starting dynamic subtest: pipe-B-plane-6
[225.185937] Dynamic subtest pipe-B-plane-6: SUCCESS (0.448s)
[225.195044] Starting dynamic subtest: pipe-B-plane-7
[225.213635] Dynamic subtest pipe-B-plane-7: SUCCESS (0.025s)
[225.214448] Subtest plane-position-hole-dpms: SUCCESS (6.471s)
[225.398502] [020/133] (804s left) gem_exec_reloc (basic-gtt-cpu)
[225.451360] Subtest basic-gtt-cpu: SKIP (0.000s)
[225.560491] [021/133] (803s left) syncobj_eventfd (binary-wait-signaled)
[225.606124] Starting subtest: binary-wait-signaled
[225.607152] Subtest binary-wait-signaled: SUCCESS (0.000s)
[225.713374] [022/133] (803s left) gen9_exec_parse (bb-start-out)
[225.763791] Subtest bb-start-out: SKIP (0.000s)
[225.842084] [023/133] (803s left) gem_pipe_control_store_loop (reused-buffer)
[225.893247] Starting subtest: reused-buffer
[228.064842] Subtest reused-buffer: SUCCESS (2.170s)
[228.201461] [024/133] (801s left) gem_exec_params (invalid-batch-start-offset)
[228.251889] Starting subtest: invalid-batch-start-offset
[228.254247] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[228.456984] [025/133] (801s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[229.946128] Starting subtest: psr-shrfb-scaledprimary
[229.948085] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[230.125645] [026/133] (799s left) kms_vblank (wait-busy)
[231.612450] Starting subtest: wait-busy
[231.613278] Starting dynamic subtest: pipe-A-HDMI-A-4
[234.089824] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.476s)
[234.102204] Starting dynamic subtest: pipe-D-HDMI-A-4
[236.448921] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.354s)
[236.449820] Subtest wait-busy: SUCCESS (4.838s)
[236.621436] [027/133] (793s left) dmabuf_sync_file (import-multiple-read-write)
[236.671214] Starting subtest: import-multiple-read-write
[236.676231] Subtest import-multiple-read-write: SUCCESS (0.006s)
[236.766609] [028/133] (793s left) gem_exec_reloc (basic-write-read-noreloc)
[236.817296] Subtest basic-write-read-noreloc: SKIP (0.000s)
[236.918686] [029/133] (793s left) gem_exec_reloc (basic-range-active)
[236.969158] Subtest basic-range-active: SKIP (0.000s)
[237.063932] [030/133] (793s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[238.549035] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[238.628975] [031/133] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[240.118454] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[240.120411] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[240.288579] [032/133] (790s left) perf_pmu (busy)
[240.342982] Starting subtest: busy
[240.344154] Starting dynamic subtest: rcs0
[240.954999] Dynamic subtest rcs0: SUCCESS (0.611s)
[240.969250] Starting dynamic subtest: bcs0
[241.514965] Dynamic subtest bcs0: SUCCESS (0.558s)
[241.528927] Starting dynamic subtest: vcs0
[242.076035] Dynamic subtest vcs0: SUCCESS (0.559s)
[242.090609] Starting dynamic subtest: vcs1
[242.637997] Dynamic subtest vcs1: SUCCESS (0.560s)
[242.651937] Starting dynamic subtest: vecs0
[243.199982] Dynamic subtest vecs0: SUCCESS (0.560s)
[243.201039] Subtest busy: SUCCESS (2.858s)
[243.359822] [033/133] (787s left) gem_exec_whisper (basic-contexts-priority)
[243.417593] Starting subtest: basic-contexts-priority
[257.966121] Subtest basic-contexts-priority: SUCCESS (14.543s)
[258.234412] [034/133] (772s left) i915_drm_fdinfo (isolation)
[258.284204] Starting subtest: isolation
[258.285098] Starting dynamic subtest: rcs0
[258.286824] Dynamic subtest rcs0: SKIP (0.001s)
[258.297181] Starting dynamic subtest: bcs0
[258.299036] Dynamic subtest bcs0: SKIP (0.001s)
[258.308800] Starting dynamic subtest: vcs0
[258.310627] Dynamic subtest vcs0: SKIP (0.001s)
[258.320351] Starting dynamic subtest: vcs1
[258.321973] Dynamic subtest vcs1: SKIP (0.013s)
[258.331622] Starting dynamic subtest: vecs0
[258.333434] Dynamic subtest vecs0: SKIP (0.000s)
[258.335298] Subtest isolation: SKIP (0.023s)
[258.419789] [035/133] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[259.908873] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[259.910699] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[260.092820] [036/133] (770s left) kms_flip (absolute-wf_vblank)
[261.579035] Starting subtest: absolute-wf_vblank
[261.586996] Starting dynamic subtest: A-HDMI-A4
[269.314203] Dynamic subtest A-HDMI-A4: SUCCESS (7.727s)
[269.326940] Starting dynamic subtest: B-HDMI-A4
[276.994022] Dynamic subtest B-HDMI-A4: SUCCESS (7.677s)
[277.006145] Starting dynamic subtest: C-HDMI-A4
[284.837316] Dynamic subtest C-HDMI-A4: SUCCESS (7.842s)
[284.849222] Starting dynamic subtest: D-HDMI-A4
[292.680972] Dynamic subtest D-HDMI-A4: SUCCESS (7.842s)
[292.681915] Subtest absolute-wf_vblank: SUCCESS (31.104s)
[292.885293] [037/133] (737s left) gem_exec_schedule (implicit-read-write)
[292.945197] Starting subtest: implicit-read-write
[292.946112] Starting dynamic subtest: rcs0
[293.141158] Dynamic subtest rcs0: SUCCESS (0.192s)
[293.150876] Starting dynamic subtest: bcs0
[293.275626] Dynamic subtest bcs0: SUCCESS (0.136s)
[293.286968] Starting dynamic subtest: vcs0
[293.409833] Dynamic subtest vcs0: SUCCESS (0.133s)
[293.420986] Starting dynamic subtest: vcs1
[293.544770] Dynamic subtest vcs1: SUCCESS (0.133s)
[293.556223] Starting dynamic subtest: vecs0
[293.693430] Dynamic subtest vecs0: SUCCESS (0.147s)
[293.694240] Subtest implicit-read-write: SUCCESS (0.749s)
[294.135017] [038/133] (736s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[295.625227] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[295.626995] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[295.791628] [039/133] (735s left) kms_psr (fbc-pr-sprite-plane-move)
[297.276315] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[297.364785] [040/133] (733s left) i915_hangman (engine-engine-hang)
[297.425530] Starting subtest: engine-engine-hang
[297.426492] Starting dynamic subtest: rcs0
[298.125287] Dynamic subtest rcs0: SUCCESS (0.700s)
[298.137191] Starting dynamic subtest: bcs0
[298.786317] Dynamic subtest bcs0: SUCCESS (0.659s)
[298.798599] Starting dynamic subtest: vcs0
[299.449286] Dynamic subtest vcs0: SUCCESS (0.661s)
[299.461219] Starting dynamic subtest: vcs1
[300.122418] Dynamic subtest vcs1: SUCCESS (0.672s)
[300.136186] Starting dynamic subtest: vecs0
[300.787386] Dynamic subtest vecs0: SUCCESS (0.663s)
[300.788380] Subtest engine-engine-hang: SUCCESS (3.364s)
[300.981699] [041/133] (730s left) kms_draw_crc (draw-method-mmap-gtt)
[302.466493] Starting subtest: draw-method-mmap-gtt
[302.468102] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[302.650249] [042/133] (728s left) kms_getfb (getfb2-handle-closed)
[304.135486] Starting subtest: getfb2-handle-closed
[304.136335] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[304.347904] [043/133] (727s left) gem_userptr_blits (sync-unmap-cycles)
[304.411516] Starting subtest: sync-unmap-cycles
[309.780024] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[309.991083] [044/133] (721s left) gem_userptr_blits (input-checking)
[310.042861] Starting subtest: input-checking
[310.043909] Subtest input-checking: SUCCESS (0.000s)
[310.227534] [045/133] (721s left) gem_ppgtt (shrink-vs-evict-any)
[310.278576] Starting subtest: shrink-vs-evict-any
[315.907543] Subtest shrink-vs-evict-any: SUCCESS (5.626s)
[316.013876] [046/133] (715s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[316.060156] Starting subtest: invalid-multi-wait-all-unsubmitted
[316.061514] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[316.185349] [047/133] (715s left) gem_exec_basic (basic)
[316.234898] Starting subtest: basic
[316.235889] Starting dynamic subtest: rcs0-smem
[316.238559] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[316.250918] Starting dynamic subtest: bcs0-smem
[316.251955] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[316.262489] Starting dynamic subtest: vcs0-smem
[316.263653] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[316.273869] Starting dynamic subtest: vcs1-smem
[316.275057] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[316.287142] Starting dynamic subtest: vecs0-smem
[316.287909] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[316.297579] Starting dynamic subtest: rcs0-lmem0
[316.298506] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[316.308180] Starting dynamic subtest: bcs0-lmem0
[316.309108] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[316.318626] Starting dynamic subtest: vcs0-lmem0
[316.319631] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[316.329432] Starting dynamic subtest: vcs1-lmem0
[316.330472] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[316.340240] Starting dynamic subtest: vecs0-lmem0
[316.341259] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[316.342259] Subtest basic: SUCCESS (0.022s)
[316.492846] [048/133] (715s left) kms_invalid_mode (overflow-vrefresh)
[317.978603] Starting subtest: overflow-vrefresh
[317.979478] Starting dynamic subtest: pipe-A-HDMI-A-4
[318.025123] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.046s)
[318.037146] Starting dynamic subtest: pipe-B-HDMI-A-4
[318.038154] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[318.048650] Starting dynamic subtest: pipe-C-HDMI-A-4
[318.049763] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[318.060385] Starting dynamic subtest: pipe-D-HDMI-A-4
[318.061292] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[318.062161] Subtest overflow-vrefresh: SUCCESS (0.059s)
[318.200758] [049/133] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[319.689758] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[322.450221] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.760s)
[322.674909] [050/133] (709s left) syncobj_wait (wait-delayed-signal)
[322.731240] Starting subtest: wait-delayed-signal
[322.836759] Subtest wait-delayed-signal: SUCCESS (0.103s)
[323.041792] [051/133] (709s left) gem_create (hog-create)
[323.092337] Starting subtest: hog-create
[323.093264] Starting dynamic subtest: lmem0
[355.366170] Dynamic subtest lmem0: SUCCESS (32.273s)
[355.377999] Starting dynamic subtest: smem0
[387.632195] Dynamic subtest smem0: SUCCESS (32.265s)
[387.633126] Subtest hog-create: SUCCESS (64.541s)
[387.923999] [052/133] (644s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[389.408567] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[389.409411] Starting dynamic subtest: pipe-A
[391.649415] Dynamic subtest pipe-A: SUCCESS (2.240s)
[391.663648] Starting dynamic subtest: pipe-B
[393.889933] Dynamic subtest pipe-B: SUCCESS (2.239s)
[393.904271] Starting dynamic subtest: pipe-C
[394.179790] Dynamic subtest pipe-C: SUCCESS (0.288s)
[394.193167] Starting dynamic subtest: pipe-D
[394.469929] Dynamic subtest pipe-D: SUCCESS (0.288s)
[394.471105] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.062s)
[394.679340] [053/133] (637s left) gem_wait (write-wait)
[394.744824] Starting subtest: write-wait
[394.745894] Starting dynamic subtest: all-engines
[395.872352] Dynamic subtest all-engines: SUCCESS (1.127s)
[395.886316] Starting dynamic subtest: rcs0
[396.938982] Dynamic subtest rcs0: SUCCESS (1.065s)
[396.952592] Starting dynamic subtest: bcs0
[398.002100] Dynamic subtest bcs0: SUCCESS (1.061s)
[398.017597] Starting dynamic subtest: vcs0
[399.063016] Dynamic subtest vcs0: SUCCESS (1.059s)
[399.078261] Starting dynamic subtest: vcs1
[400.123808] Dynamic subtest vcs1: SUCCESS (1.058s)
[400.169904] Starting dynamic subtest: vecs0
[401.206765] Dynamic subtest vecs0: SUCCESS (1.075s)
[401.210713] Subtest write-wait: SUCCESS (6.465s)
[401.522476] [054/133] (630s left) kms_force_connector_basic (force-connector-state)
[401.654478] Starting subtest: force-connector-state
[403.370166] Subtest force-connector-state: SUCCESS (1.717s)
[405.103621] [055/133] (627s left) gem_render_copy_redux (flink)
[405.158201] Starting subtest: flink
[407.197469] Subtest flink: SUCCESS (2.039s)
[407.394075] [056/133] (625s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[407.440612] Starting subtest: multi-wait-all-for-submit-signaled
[407.441566] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[407.567401] [057/133] (625s left) syncobj_wait (wait-all-for-submit-snapshot)
[407.614432] Starting subtest: wait-all-for-submit-snapshot
[407.698062] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[407.842316] [058/133] (624s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[409.333242] Starting subtest: fbcpsr-modesetfrombusy
[409.334918] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[409.515477] [059/133] (623s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[411.002501] Starting subtest: modeset-transition-nonblocking-fencing
[411.003351] Starting dynamic subtest: 1x-outputs
[412.995758] Dynamic subtest 1x-outputs: SUCCESS (1.989s)
[412.997874] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.994s)
[413.198683] [060/133] (619s left) kms_getfb (getfb-handle-closed)
[414.684283] Starting subtest: getfb-handle-closed
[414.685338] Subtest getfb-handle-closed: SUCCESS (0.000s)
[414.856270] [061/133] (618s left) gem_exec_reloc (basic-gtt-read-noreloc)
[414.909274] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[415.027914] [062/133] (618s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[416.512527] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[416.513404] Starting dynamic subtest: pipe-A-HDMI-A-4
[416.534783] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[416.545518] Starting dynamic subtest: pipe-B-HDMI-A-4
[416.567666] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[416.578126] Starting dynamic subtest: pipe-C-HDMI-A-4
[416.600278] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[416.610543] Starting dynamic subtest: pipe-D-HDMI-A-4
[416.632030] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[416.633790] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.022s)
[416.761521] [063/133] (616s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[416.813324] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[416.942149] [064/133] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[418.431798] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[418.433464] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[418.609981] [065/133] (614s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[418.658290] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[418.769468] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[418.926702] [066/133] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[420.415358] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[420.417157] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[420.575647] [067/133] (612s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[422.074688] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[422.212919] [068/133] (611s left) perf_pmu (init-wait)
[422.280462] Starting subtest: init-wait
[422.281348] Starting dynamic subtest: rcs0
[422.283803] Dynamic subtest rcs0: SUCCESS (0.002s)
[422.294461] Starting dynamic subtest: bcs0
[422.295284] Dynamic subtest bcs0: SUCCESS (0.001s)
[422.305969] Starting dynamic subtest: vcs0
[422.307138] Dynamic subtest vcs0: SUCCESS (0.001s)
[422.317598] Starting dynamic subtest: vcs1
[422.318602] Dynamic subtest vcs1: SUCCESS (0.001s)
[422.328835] Starting dynamic subtest: vecs0
[422.329958] Dynamic subtest vecs0: SUCCESS (0.001s)
[422.331103] Subtest init-wait: SUCCESS (0.012s)
[422.411316] [069/133] (611s left) kms_plane_lowres (tiling-y)
[423.897211] Starting subtest: tiling-y
[423.898217] Starting dynamic subtest: pipe-A-HDMI-A-4
[433.230884] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.333s)
[433.329355] Starting dynamic subtest: pipe-B-HDMI-A-4
[442.394585] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.075s)
[442.449829] Starting dynamic subtest: pipe-C-HDMI-A-4
[451.526725] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.087s)
[451.625406] Starting dynamic subtest: pipe-D-HDMI-A-4
[460.680410] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.064s)
[460.721995] Subtest tiling-y: SUCCESS (36.826s)
[460.946879] [070/133] (572s left) kms_flip (2x-flip-vs-wf_vblank)
[462.434227] Starting subtest: 2x-flip-vs-wf_vblank
[462.451391] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s)
[462.601724] [071/133] (571s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[464.093219] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[466.534969] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.441s)
[466.761601] [072/133] (567s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[468.251149] Starting subtest: plane-lut1d-post-ctm3x4
[468.448875] Starting dynamic subtest: pipe-A-plane-0
[468.710684] Dynamic subtest pipe-A-plane-0: SUCCESS (0.263s)
[468.729921] Starting dynamic subtest: pipe-A-plane-1
[468.912058] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[468.938064] Starting dynamic subtest: pipe-A-plane-2
[469.095362] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[469.387324] Starting dynamic subtest: pipe-B-plane-0
[469.554116] Dynamic subtest pipe-B-plane-0: SUCCESS (0.180s)
[469.582365] Starting dynamic subtest: pipe-B-plane-1
[469.740470] Dynamic subtest pipe-B-plane-1: SUCCESS (0.176s)
[469.774111] Starting dynamic subtest: pipe-B-plane-2
[469.953920] Dynamic subtest pipe-B-plane-2: SUCCESS (0.209s)
[470.245453] Starting dynamic subtest: pipe-C-plane-0
[470.412061] Dynamic subtest pipe-C-plane-0: SUCCESS (0.196s)
[470.444443] Starting dynamic subtest: pipe-C-plane-1
[470.625903] Dynamic subtest pipe-C-plane-1: SUCCESS (0.209s)
[470.656059] Starting dynamic subtest: pipe-C-plane-2
[470.825967] Dynamic subtest pipe-C-plane-2: SUCCESS (0.192s)
[471.125276] Starting dynamic subtest: pipe-D-plane-0
[471.299529] Dynamic subtest pipe-D-plane-0: SUCCESS (0.196s)
[471.330821] Starting dynamic subtest: pipe-D-plane-1
[471.516291] Dynamic subtest pipe-D-plane-1: SUCCESS (0.209s)
[471.552927] Starting dynamic subtest: pipe-D-plane-2
[471.732961] Dynamic subtest pipe-D-plane-2: SUCCESS (0.208s)
[471.787459] Subtest plane-lut1d-post-ctm3x4: SUCCESS (3.536s)
[472.031949] [073/133] (562s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[473.535229] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[473.536043] Starting dynamic subtest: pipe-A-HDMI-A-4
[473.544194] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[473.555159] Starting dynamic subtest: pipe-B-HDMI-A-4
[473.563223] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[473.574169] Starting dynamic subtest: pipe-C-HDMI-A-4
[473.582383] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[473.592786] Starting dynamic subtest: pipe-D-HDMI-A-4
[473.601207] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[473.602862] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[473.782256] [074/133] (560s left) gem_sync (basic-all)
[473.840827] Starting subtest: basic-all
[476.194055] Subtest basic-all: SUCCESS (2.352s)
[476.425439] [075/133] (557s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[477.909573] Starting subtest: 2x-long-flip-vs-cursor-atomic
[477.912919] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.003s)
[478.052438] [076/133] (556s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[479.570928] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[480.815537] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.246s)
[481.038872] [077/133] (553s left) i915_pm_rps (thresholds-park)
[481.092521] Starting subtest: thresholds-park
[481.094314] Subtest thresholds-park: SKIP (0.000s)
[481.198133] [078/133] (553s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[482.683513] Starting subtest: random-ccs-data-yf-tiled-ccs
[482.684319] Starting dynamic subtest: pipe-A-HDMI-A-4
[482.693125] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[482.704136] Starting dynamic subtest: pipe-B-HDMI-A-4
[482.713039] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[482.723924] Starting dynamic subtest: pipe-C-HDMI-A-4
[482.733177] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[482.743783] Starting dynamic subtest: pipe-D-HDMI-A-4
[482.752848] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[482.754390] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.011s)
[482.926338] [079/133] (551s left) i915_pm_rpm (system-suspend)
[487.036736] Starting subtest: system-suspend
[508.914098] Subtest system-suspend: SUCCESS (12.082s)
[513.839825] [080/133] (524s left) gem_exec_whisper (basic-sync)
[513.899138] Starting subtest: basic-sync
[517.219097] Subtest basic-sync: SUCCESS (3.319s)
[517.470644] [081/133] (521s left) syncobj_timeline (single-wait-all-available-signaled)
[517.515762] Starting subtest: single-wait-all-available-signaled
[517.516572] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[517.648887] [082/133] (521s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[517.702742] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[517.703695] Starting dynamic subtest: smem
[517.802301] Dynamic subtest smem: SUCCESS (0.099s)
[517.816996] Starting dynamic subtest: lmem0
[518.918481] Dynamic subtest lmem0: SUCCESS (1.111s)
[518.919488] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SUCCESS (1.213s)
[519.178591] [083/133] (519s left) kms_force_connector_basic (force-edid)
[519.307794] Starting subtest: force-edid
[519.327912] Subtest force-edid: SUCCESS (0.020s)
[520.986518] [084/133] (517s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[522.484336] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[522.503162] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.018s)
[522.654285] [085/133] (516s left) gem_exec_create (basic)
[522.712743] Starting subtest: basic
[522.713619] Starting dynamic subtest: smem
[524.812303] Dynamic subtest smem: SUCCESS (2.099s)
[524.826803] Starting dynamic subtest: lmem0
[526.914074] Dynamic subtest lmem0: SUCCESS (2.100s)
[526.914961] Subtest basic: SUCCESS (4.202s)
[527.148617] [086/133] (511s left) kms_chamelium_edid (hdmi-edid-read)
[528.686201] Subtest hdmi-edid-read: SKIP (0.000s)
[528.804690] [087/133] (510s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[530.292529] Starting subtest: bad-pixel-format-yf-tiled-ccs
[530.293432] Starting dynamic subtest: pipe-A-HDMI-A-4
[530.301808] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[530.314661] Starting dynamic subtest: pipe-B-HDMI-A-4
[530.322978] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[530.335302] Starting dynamic subtest: pipe-C-HDMI-A-4
[530.343880] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[530.356274] Starting dynamic subtest: pipe-D-HDMI-A-4
[530.364902] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[530.366572] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.011s)
[530.534545] [088/133] (508s left) syncobj_timeline (wait-for-submit-complex)
[530.581074] Starting subtest: wait-for-submit-complex
[530.643206] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[530.831160] [089/133] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[532.320194] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[532.321936] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[532.497345] [090/133] (506s left) gem_spin_batch (resubmit)
[532.555230] Starting subtest: resubmit
[532.556101] Starting dynamic subtest: rcs0
[532.575320] Dynamic subtest rcs0: SUCCESS (0.019s)
[532.590172] Starting dynamic subtest: bcs0
[532.591109] Dynamic subtest bcs0: SUCCESS (0.002s)
[532.603875] Starting dynamic subtest: vcs0
[532.605057] Dynamic subtest vcs0: SUCCESS (0.002s)
[532.617566] Starting dynamic subtest: vcs1
[532.618499] Dynamic subtest vcs1: SUCCESS (0.002s)
[532.630797] Starting dynamic subtest: vecs0
[532.631729] Dynamic subtest vecs0: SUCCESS (0.003s)
[532.632768] Subtest resubmit: SUCCESS (0.037s)
[532.917924] [091/133] (506s left) kms_psr (fbc-psr-primary-render)
[534.405392] Subtest fbc-psr-primary-render: SKIP (0.000s)
[534.481430] [092/133] (505s left) kms_async_flips (async-flip-suspend-resume)
[535.966276] Starting subtest: async-flip-suspend-resume
[536.211775] Starting dynamic subtest: pipe-A-HDMI-A-4
[558.741540] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.531s)
[558.920583] Starting dynamic subtest: pipe-B-HDMI-A-4
[581.740236] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (11.000s)
[581.891098] Starting dynamic subtest: pipe-C-HDMI-A-4
[604.704106] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (11.057s)
[604.870179] Starting dynamic subtest: pipe-D-HDMI-A-4
[627.720388] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (11.056s)
[627.721656] Subtest async-flip-suspend-resume: SUCCESS (45.363s)
[635.058655] [093/133] (411s left) gem_exec_reloc (basic-cpu-wc)
[635.111415] Subtest basic-cpu-wc: SKIP (0.000s)
[635.206644] [094/133] (411s left) perf_pmu (interrupts-sync)
[635.256206] Starting subtest: interrupts-sync
[636.410249] Subtest interrupts-sync: SUCCESS (1.150s)
[636.562208] [095/133] (410s left) gem_exec_balancer (bonded-sync)
[636.620616] Starting subtest: bonded-sync
[636.622340] Subtest bonded-sync: SKIP (0.000s)
[637.043581] [096/133] (409s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[638.529403] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[638.530459] Starting dynamic subtest: pipe-A-valid-mode
[639.360879] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.831s)
[639.361655] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.834s)
[639.547836] [097/133] (407s left) gem_tiled_blits (basic)
[639.598993] Subtest basic: SKIP (0.000s)
[639.675525] [098/133] (407s left) gem_ctx_shared (q-smoketest)
[639.734199] Starting subtest: Q-smoketest
[639.735079] Starting dynamic subtest: rcs0
[645.196283] Dynamic subtest rcs0: SUCCESS (5.453s)
[645.209258] Starting dynamic subtest: bcs0
[650.636228] Dynamic subtest bcs0: SUCCESS (5.437s)
[650.649418] Starting dynamic subtest: vcs0
[656.061092] Dynamic subtest vcs0: SUCCESS (5.423s)
[656.074189] Starting dynamic subtest: vcs1
[661.500029] Dynamic subtest vcs1: SUCCESS (5.438s)
[661.513363] Starting dynamic subtest: vecs0
[666.931769] Dynamic subtest vecs0: SUCCESS (5.428s)
[666.932829] Subtest Q-smoketest: SUCCESS (27.187s)
[667.253075] [099/133] (379s left) kms_cursor_crc (cursor-sliding-256x256)
[668.955762] Starting subtest: cursor-sliding-256x256
[668.962941] Starting dynamic subtest: pipe-A-HDMI-A-4
[673.401221] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.438s)
[673.437420] Starting dynamic subtest: pipe-D-HDMI-A-4
[677.611428] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.188s)
[677.614823] Subtest cursor-sliding-256x256: SUCCESS (8.657s)
[677.940759] [100/133] (369s left) gem_pxp (reject-modify-context-protection-off-2)
[680.510550] Starting subtest: reject-modify-context-protection-off-2
[680.512548] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[680.629953] [101/133] (366s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[682.134458] Starting subtest: yf-tiled-addfb-size-offset-overflow
[682.136469] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[682.317789] [102/133] (365s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[683.821957] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[683.823562] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[683.999479] [103/133] (363s left) gem_userptr_blits (usage-restrictions)
[684.051591] Starting subtest: usage-restrictions
[684.052461] Subtest usage-restrictions: SUCCESS (0.000s)
[684.250637] [104/133] (363s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[685.740543] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[685.742467] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[685.920877] [105/133] (361s left) kms_plane_alpha_blend (constant-alpha-max)
[687.423755] Starting subtest: constant-alpha-max
[687.683581] Starting dynamic subtest: pipe-A-HDMI-A-4
[688.576217] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.892s)
[688.590752] Starting dynamic subtest: pipe-D-HDMI-A-4
[689.444693] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.865s)
[689.445554] Subtest constant-alpha-max: SUCCESS (2.021s)
[689.623769] [106/133] (358s left) kms_atomic_transition (plane-toggle-modeset-transition)
[691.109704] Starting subtest: plane-toggle-modeset-transition
[691.112074] Starting dynamic subtest: pipe-A-HDMI-A-4
[692.071419] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.956s)
[692.097864] Starting dynamic subtest: pipe-B-HDMI-A-4
[692.773563] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.688s)
[692.779767] Subtest plane-toggle-modeset-transition: SUCCESS (1.668s)
[693.016723] [107/133] (354s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[694.521625] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[695.116888] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.596s)
[695.311319] [108/133] (352s left) api_intel_bb (offset-control)
[695.357686] Starting subtest: offset-control
[695.380685] Subtest offset-control: SUCCESS (0.024s)
[695.543813] [109/133] (352s left) kms_cursor_legacy (torture-move)
[697.029851] Starting subtest: torture-move
[697.030675] Starting dynamic subtest: pipe-A
[702.567614] Dynamic subtest pipe-A: SUCCESS (5.535s)
[702.581145] Starting dynamic subtest: pipe-B
[708.032126] Dynamic subtest pipe-B: SUCCESS (5.463s)
[708.045175] Starting dynamic subtest: pipe-C
[713.507602] Dynamic subtest pipe-C: SUCCESS (5.473s)
[713.526957] Starting dynamic subtest: pipe-D
[719.165450] Dynamic subtest pipe-D: SUCCESS (5.657s)
[719.181116] Starting dynamic subtest: all-pipes
[724.748552] Dynamic subtest all-pipes: SUCCESS (5.582s)
[724.749456] Subtest torture-move: SUCCESS (27.717s)
[724.874292] [110/133] (323s left) kms_selftest (drm_format)
[724.922539] Starting subtest: drm_format
[725.106489] Starting dynamic subtest: drm_test_format_block_width_invalid
[725.177512] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.072s)
[725.212222] Starting dynamic subtest: drm_test_format_block_width_one_plane
[725.247987] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.068s)
[725.275810] Starting dynamic subtest: drm_test_format_block_width_two_plane
[725.319594] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.068s)
[725.352973] Starting dynamic subtest: drm_test_format_block_width_three_plane
[725.393132] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.070s)
[725.427176] Starting dynamic subtest: drm_test_format_block_width_tiled
[725.461516] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.065s)
[725.487684] Starting dynamic subtest: drm_test_format_block_height_invalid
[725.532672] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.068s)
[725.569757] Starting dynamic subtest: drm_test_format_block_height_one_plane
[725.595367] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.059s)
[725.615828] Starting dynamic subtest: drm_test_format_block_height_two_plane
[725.664224] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.067s)
[725.699223] Starting dynamic subtest: drm_test_format_block_height_three_plane
[725.742526] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.074s)
[725.790452] Starting dynamic subtest: drm_test_format_block_height_tiled
[725.809072] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.064s)
[725.828354] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[725.875406] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.064s)
[725.902519] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[725.948938] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.068s)
[725.993447] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[726.019055] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.067s)
[726.037433] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[726.091032] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.069s)
[726.117509] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[726.159207] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.065s)
[726.178242] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[726.231392] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.069s)
[726.276065] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[726.303220] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.067s)
[726.323149] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[726.369133] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.062s)
[726.370583] Subtest drm_format: SUCCESS (1.446s)
[726.648404] [111/133] (321s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[726.696949] Starting subtest: invalid-multi-wait-all-unsubmitted
[726.697962] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[726.806134] [112/133] (321s left) kms_psr2_su (frontbuffer-xrgb8888)
[726.858172] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[726.931222] [113/133] (321s left) gem_lmem_swapping (verify-random)
[731.196860] Starting subtest: verify-random
[731.197691] Starting dynamic subtest: lmem0
[740.021282] Dynamic subtest lmem0: SUCCESS (8.821s)
[740.022242] Subtest verify-random: SUCCESS (8.822s)
[741.040866] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[741.042006] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[741.044747] [114/133] (307s left) kms_lease (lease-invalid-connector)
[745.758983] Starting subtest: lease-invalid-connector
[745.759764] Starting dynamic subtest: pipe-A-HDMI-A-4
[745.760547] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.000s)
[745.776296] Starting dynamic subtest: pipe-B-HDMI-A-4
[745.777470] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.000s)
[745.789509] Starting dynamic subtest: pipe-C-HDMI-A-4
[745.790501] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.000s)
[745.801883] Starting dynamic subtest: pipe-D-HDMI-A-4
[745.802961] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.000s)
[745.804000] Subtest lease-invalid-connector: SUCCESS (0.010s)
[745.971700] [FACT kms_lease (lease-invalid-connector)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[745.975180] [FACT kms_lease (lease-invalid-connector)] new: kernel.kmod_is_loaded.i915: true
[745.981668] [115/133] (302s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[747.613739] Starting subtest: cursor-rapid-movement-64x64
[747.629611] Starting dynamic subtest: pipe-A-HDMI-A-4
[748.103682] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.474s)
[748.138918] Starting dynamic subtest: pipe-D-HDMI-A-4
[748.449134] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.321s)
[748.449965] Subtest cursor-rapid-movement-64x64: SUCCESS (0.835s)
[749.014770] [116/133] (299s left) gem_userptr_blits (unsync-unmap-after-close)
[749.075092] Subtest unsync-unmap-after-close: SKIP (0.000s)
[749.289052] [117/133] (299s left) gem_ctx_exec (basic-nohangcheck)
[749.334640] Starting subtest: basic-nohangcheck
[749.474953] Subtest basic-nohangcheck: SUCCESS (0.140s)
[749.673022] [118/133] (299s left) sriov_basic (enable-vfs-autoprobe-on)
[749.720886] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[749.795016] [119/133] (299s left) syncobj_wait (multi-wait-for-submit-signaled)
[749.841174] Starting subtest: multi-wait-for-submit-signaled
[749.842261] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[749.966785] [120/133] (299s left) kms_cursor_crc (cursor-offscreen-64x21)
[751.609902] Starting subtest: cursor-offscreen-64x21
[751.616825] Starting dynamic subtest: pipe-A-HDMI-A-4
[754.154260] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.537s)
[754.189136] Starting dynamic subtest: pipe-D-HDMI-A-4
[756.566877] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.389s)
[756.567824] Subtest cursor-offscreen-64x21: SUCCESS (4.957s)
[757.028380] [121/133] (292s left) kms_psr (pr-sprite-plane-onoff)
[758.514173] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[758.589746] [122/133] (290s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[760.116519] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[760.118172] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[760.278232] [123/133] (289s left) kms_pm_rpm (cursor-dpms)
[764.187724] Starting subtest: cursor-dpms
[764.189985] Subtest cursor-dpms: SKIP (0.000s)
[765.123277] [124/133] (284s left) kms_psr (psr2-suspend)
[766.615290] Subtest psr2-suspend: SKIP (0.000s)
[766.696217] [125/133] (282s left) gem_exec_params (sol-reset-not-gen7)
[766.746893] Starting subtest: sol-reset-not-gen7
[766.749926] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[766.941008] [126/133] (282s left) gem_exec_fence (nb-await)
[767.160150] Starting subtest: nb-await
[767.161371] Starting dynamic subtest: rcs0
[767.251637] Dynamic subtest rcs0: SUCCESS (0.092s)
[767.267685] Starting dynamic subtest: bcs0
[767.318161] Dynamic subtest bcs0: SUCCESS (0.064s)
[767.336570] Starting dynamic subtest: vcs0
[767.385544] Dynamic subtest vcs0: SUCCESS (0.065s)
[767.418001] Starting dynamic subtest: vcs1
[767.463503] Dynamic subtest vcs1: SUCCESS (0.075s)
[767.512149] Starting dynamic subtest: vecs0
[767.559351] Dynamic subtest vecs0: SUCCESS (0.090s)
[767.563268] Subtest nb-await: SUCCESS (0.403s)
[768.230022] [127/133] (281s left) kms_psr (psr-dpms)
[769.716956] Subtest psr-dpms: SKIP (0.000s)
[769.796527] [128/133] (279s left) gem_ctx_persistence (heartbeat-hang)
[769.847897] Starting subtest: heartbeat-hang
[769.849847] Subtest heartbeat-hang: SKIP (0.000s)
[769.972944] [129/133] (279s left) api_intel_bb (add-remove-objects)
[770.018703] Starting subtest: add-remove-objects
[770.040624] Subtest add-remove-objects: SUCCESS (0.023s)
[770.261372] [130/133] (279s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[771.750276] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[771.752284] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[771.931406] [131/133] (278s left) gem_busy (parallel)
[772.201019] Starting subtest: parallel
[772.201919] Starting dynamic subtest: rcs0
[772.293892] Dynamic subtest rcs0: SUCCESS (0.092s)
[772.312886] Starting dynamic subtest: bcs0
[772.354132] Dynamic subtest bcs0: SUCCESS (0.058s)
[772.383915] Starting dynamic subtest: vcs0
[772.423804] Dynamic subtest vcs0: SUCCESS (0.067s)
[772.455295] Starting dynamic subtest: vcs1
[772.496093] Dynamic subtest vcs1: SUCCESS (0.069s)
[772.523291] Starting dynamic subtest: vecs0
[772.564987] Dynamic subtest vecs0: SUCCESS (0.066s)
[772.566295] Subtest parallel: SUCCESS (0.365s)
[772.873453] [132/133] (277s left) kms_frontbuffer_tracking (psr-2p-rte)
[774.361867] Starting subtest: psr-2p-rte
[774.363579] Subtest psr-2p-rte: SKIP (0.000s)
[774.545558] [133/133] (275s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[774.592730] Starting subtest: invalid-multi-wait-unsubmitted
[774.593576] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[774.707258] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_content_protection
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: vgem_basic
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: syncobj_eventfd
results: parsing output: 21/ for test: gen9_exec_parse
results: parsing output: 22/ for test: gem_pipe_control_store_loop
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: dmabuf_sync_file
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: i915_drm_fdinfo
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: i915_hangman
results: parsing output: 40/ for test: kms_draw_crc
results: parsing output: 41/ for test: kms_getfb
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: gem_ppgtt
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_basic
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: gem_create
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_wait
results: parsing output: 53/ for test: kms_force_connector_basic
results: parsing output: 54/ for test: gem_render_copy_redux
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_exec_flush
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_plane_lowres
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_color_pipeline
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_sync
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_force_connector_basic
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_exec_create
results: parsing output: 85/ for test: kms_chamelium_edid
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_tiled_blits
results: parsing output: 97/ for test: gem_ctx_shared
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_pxp
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane_alpha_blend
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_selftest
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_psr2_su
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: kms_lease
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: gem_ctx_exec
results: parsing output: 117/ for test: sriov_basic
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_busy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_timeline
Done.