[67.380632] Initializing watchdogs
[67.380714]   /dev/watchdog0
[67.412210] [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.427217] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.432158] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.435762] [001/156] (960s left) i915_selftest (live)
[68.428867] Starting subtest: live
[68.430472] Starting dynamic subtest: sanitycheck
[69.872267] Dynamic subtest sanitycheck: SUCCESS (1.443s)
[69.880509] Starting dynamic subtest: uncore
[72.173586] Dynamic subtest uncore: SUCCESS (2.300s)
[72.182298] Starting dynamic subtest: workarounds
[75.561438] Dynamic subtest workarounds: SUCCESS (3.388s)
[75.569930] Starting dynamic subtest: gt_engines
[77.547298] Dynamic subtest gt_engines: SUCCESS (1.986s)
[77.555906] Starting dynamic subtest: gt_timelines
[143.185533] Dynamic subtest gt_timelines: SUCCESS (65.638s)
[143.193977] Starting dynamic subtest: gt_contexts
[144.641280] Dynamic subtest gt_contexts: SUCCESS (1.455s)
[144.649701] Starting dynamic subtest: gt_lrc
[151.002522] Dynamic subtest gt_lrc: SUCCESS (6.361s)
[151.010950] Starting dynamic subtest: gt_mocs
[153.407470] Dynamic subtest gt_mocs: SUCCESS (2.405s)
[153.416596] Starting dynamic subtest: gt_pm
[157.407567] Dynamic subtest gt_pm: SUCCESS (4.000s)
[157.416326] Starting dynamic subtest: gt_heartbeat
[158.847401] Dynamic subtest gt_heartbeat: SUCCESS (1.440s)
[158.856155] Starting dynamic subtest: gt_tlb
[172.765094] Dynamic subtest gt_tlb: SUCCESS (13.917s)
[172.773804] Starting dynamic subtest: requests
[183.131915] Dynamic subtest requests: SUCCESS (10.367s)
[183.140971] Starting dynamic subtest: migrate
[187.654518] Dynamic subtest migrate: SUCCESS (4.522s)
[187.663446] Starting dynamic subtest: active
[189.094461] Dynamic subtest active: SUCCESS (1.440s)
[189.103444] Starting dynamic subtest: objects
[191.467554] Dynamic subtest objects: SUCCESS (2.373s)
[191.477222] Starting dynamic subtest: mman
[195.091388] Dynamic subtest mman: SUCCESS (3.624s)
[195.100313] Starting dynamic subtest: dmabuf
[196.631288] Dynamic subtest dmabuf: SUCCESS (1.540s)
[196.639994] Starting dynamic subtest: vma
[198.065251] Dynamic subtest vma: SUCCESS (1.434s)
[198.074440] Starting dynamic subtest: coherency
[208.211246] Dynamic subtest coherency: SUCCESS (10.146s)
[208.219797] Starting dynamic subtest: gtt
[217.255810] Dynamic subtest gtt: SUCCESS (9.044s)
[217.265128] Starting dynamic subtest: gem
[218.861247] Dynamic subtest gem: SUCCESS (1.605s)
[218.870285] Starting dynamic subtest: evict
[230.255534] Dynamic subtest evict: SUCCESS (11.394s)
[230.263955] Starting dynamic subtest: hugepages
[247.815916] Dynamic subtest hugepages: SUCCESS (17.560s)
[247.824731] Starting dynamic subtest: gem_contexts
[275.669042] Dynamic subtest gem_contexts: SUCCESS (27.852s)
[275.677705] Starting dynamic subtest: client
[277.165599] Dynamic subtest client: SUCCESS (1.496s)
[277.174672] Starting dynamic subtest: gem_migrate
[279.873324] Dynamic subtest gem_migrate: SUCCESS (2.707s)
[279.883197] Starting dynamic subtest: reset
[281.372384] Dynamic subtest reset: SUCCESS (1.498s)
[281.380966] Starting dynamic subtest: memory_region
[284.425696] Dynamic subtest memory_region: SUCCESS (3.052s)
[284.434918] Starting dynamic subtest: hangcheck
[312.566112] Dynamic subtest hangcheck: SUCCESS (28.139s)
[312.575094] Starting dynamic subtest: execlists
[314.035599] Dynamic subtest execlists: SUCCESS (1.469s)
[314.045038] Starting dynamic subtest: ring_submission
[315.467465] Dynamic subtest ring_submission: SUCCESS (1.431s)
[315.476997] Starting dynamic subtest: perf
[317.046371] Dynamic subtest perf: SUCCESS (1.578s)
[317.055509] Starting dynamic subtest: slpc
[322.995311] Dynamic subtest slpc: SUCCESS (5.948s)
[323.004252] Starting dynamic subtest: guc
[326.474757] Dynamic subtest guc: SUCCESS (3.478s)
[326.483765] Starting dynamic subtest: guc_multi_lrc
[327.916593] Dynamic subtest guc_multi_lrc: SUCCESS (1.441s)
[327.925464] Starting dynamic subtest: guc_hang
[330.167779] Dynamic subtest guc_hang: SUCCESS (2.250s)
[330.176729] Starting dynamic subtest: late_gt_pm
[331.658257] Dynamic subtest late_gt_pm: SUCCESS (1.490s)
[331.659798] Subtest live: SUCCESS (263.231s)
[331.699299] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[331.702402] [002/156] (696s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[336.541490] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[337.866133] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.324s)
[338.162431] [FACT kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true
[338.166784] [003/156] (689s left) kms_content_protection (dp-mst-type-0)
[339.726160] Starting subtest: dp-mst-type-0
[339.729580] Subtest dp-mst-type-0: SKIP (0.000s)
[339.908112] [004/156] (688s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[339.989181] Starting subtest: invalid-multi-wait-unsubmitted
[339.990866] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[340.093906] [005/156] (688s left) gem_mmap_gtt (basic-read-write-distinct)
[340.143992] Subtest basic-read-write-distinct: SKIP (0.000s)
[340.228889] [006/156] (688s left) kms_prime (basic-modeset-hybrid)
[341.738202] Subtest basic-modeset-hybrid: SKIP (0.000s)
[341.973231] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[341.979432] [007/156] (686s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[343.482243] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[343.485832] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[343.635986] [008/156] (684s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[345.173796] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[345.309644] [009/156] (683s left) tools_test (tools_test)
[345.367624] Starting subtest: tools_test
[345.471156] Subtest tools_test: SUCCESS (0.114s)
[345.564803] [010/156] (683s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[347.066972] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[347.070814] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[347.260376] [011/156] (681s left) kms_dsc (dsc-fractional-bpp)
[348.757476] Starting subtest: dsc-fractional-bpp
[348.767739] Subtest dsc-fractional-bpp: SKIP (0.000s)
[348.920379] [012/156] (679s left) gem_exec_fence (parallel)
[349.150637] Starting subtest: parallel
[349.152640] Starting dynamic subtest: rcs0
[351.302172] Dynamic subtest rcs0: SUCCESS (2.151s)
[351.322638] Starting dynamic subtest: bcs0
[353.457859] Dynamic subtest bcs0: SUCCESS (2.155s)
[353.468429] Starting dynamic subtest: vcs0
[355.613194] Dynamic subtest vcs0: SUCCESS (2.154s)
[355.624134] Starting dynamic subtest: vcs1
[357.768098] Dynamic subtest vcs1: SUCCESS (2.154s)
[357.778504] Starting dynamic subtest: vecs0
[359.924612] Dynamic subtest vecs0: SUCCESS (2.155s)
[359.926056] Subtest parallel: SUCCESS (10.775s)
[360.659443] [013/156] (668s left) gem_wait (write-wait)
[360.807896] Starting subtest: write-wait
[360.829795] Starting dynamic subtest: all-engines
[361.873535] Dynamic subtest all-engines: SUCCESS (1.103s)
[361.900177] Starting dynamic subtest: rcs0
[362.940271] Dynamic subtest rcs0: SUCCESS (1.064s)
[362.961862] Starting dynamic subtest: bcs0
[364.008550] Dynamic subtest bcs0: SUCCESS (1.063s)
[364.021643] Starting dynamic subtest: vcs0
[365.070221] Dynamic subtest vcs0: SUCCESS (1.059s)
[365.090886] Starting dynamic subtest: vcs1
[366.140250] Dynamic subtest vcs1: SUCCESS (1.064s)
[366.160905] Starting dynamic subtest: vecs0
[367.208331] Dynamic subtest vecs0: SUCCESS (1.062s)
[367.216743] Subtest write-wait: SUCCESS (6.441s)
[367.587586] [014/156] (661s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[367.636820] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[367.741283] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[367.898832] [015/156] (661s left) gem_mmap_gtt (basic-read-write)
[367.949527] Subtest basic-read-write: SKIP (0.000s)
[368.024086] [016/156] (661s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[369.513373] Starting subtest: plane-lut1d-ctm3x4-lut1d
[369.716080] Starting dynamic subtest: pipe-A-plane-0
[369.980562] Dynamic subtest pipe-A-plane-0: SUCCESS (0.265s)
[370.018435] Starting dynamic subtest: pipe-A-plane-1
[370.180126] Dynamic subtest pipe-A-plane-1: SUCCESS (0.194s)
[370.214792] Starting dynamic subtest: pipe-A-plane-2
[370.381714] Dynamic subtest pipe-A-plane-2: SUCCESS (0.194s)
[370.714284] Starting dynamic subtest: pipe-B-plane-0
[370.881219] Dynamic subtest pipe-B-plane-0: SUCCESS (0.197s)
[370.912571] Starting dynamic subtest: pipe-B-plane-1
[371.082752] Dynamic subtest pipe-B-plane-1: SUCCESS (0.193s)
[371.112902] Starting dynamic subtest: pipe-B-plane-2
[371.295919] Dynamic subtest pipe-B-plane-2: SUCCESS (0.210s)
[371.633493] Starting dynamic subtest: pipe-C-plane-0
[371.816274] Dynamic subtest pipe-C-plane-0: SUCCESS (0.214s)
[371.854142] Starting dynamic subtest: pipe-C-plane-1
[372.032947] Dynamic subtest pipe-C-plane-1: SUCCESS (0.210s)
[372.062649] Starting dynamic subtest: pipe-C-plane-2
[372.249717] Dynamic subtest pipe-C-plane-2: SUCCESS (0.210s)
[372.603708] Starting dynamic subtest: pipe-D-plane-0
[372.788267] Dynamic subtest pipe-D-plane-0: SUCCESS (0.200s)
[372.822625] Starting dynamic subtest: pipe-D-plane-1
[373.002527] Dynamic subtest pipe-D-plane-1: SUCCESS (0.209s)
[373.013029] Starting dynamic subtest: pipe-D-plane-2
[373.187149] Dynamic subtest pipe-D-plane-2: SUCCESS (0.183s)
[373.227958] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (3.714s)
[373.432481] [017/156] (655s left) gem_exec_schedule (preemptive-hang)
[373.633291] Starting subtest: preemptive-hang
[373.634852] Starting dynamic subtest: rcs0
[383.098252] Dynamic subtest rcs0: SUCCESS (9.468s)
[383.109213] Starting dynamic subtest: bcs0
[392.050927] Dynamic subtest bcs0: SUCCESS (8.951s)
[392.062093] Starting dynamic subtest: vcs0
[401.082169] Dynamic subtest vcs0: SUCCESS (9.030s)
[401.093217] Starting dynamic subtest: vcs1
[410.108736] Dynamic subtest vcs1: SUCCESS (9.024s)
[410.119853] Starting dynamic subtest: vecs0
[419.061846] Dynamic subtest vecs0: SUCCESS (8.952s)
[419.063395] Subtest preemptive-hang: SUCCESS (45.434s)
[419.377939] [018/156] (610s left) vgem_basic (bad-flag)
[419.440065] Starting subtest: bad-flag
[419.441772] Subtest bad-flag: SUCCESS (0.000s)
[419.542887] [019/156] (609s left) kms_cursor_crc (cursor-onscreen-512x170)
[421.339259] Starting subtest: cursor-onscreen-512x170
[421.342866] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[421.568898] [020/156] (608s left) kms_frontbuffer_tracking (hdr-1p-rte)
[423.072213] Starting subtest: hdr-1p-rte
[423.076200] Subtest hdr-1p-rte: SKIP (0.000s)
[423.275472] [021/156] (606s left) kms_psr (psr-sprite-plane-move)
[424.769980] Subtest psr-sprite-plane-move: SKIP (0.000s)
[424.857930] [022/156] (604s left) kms_plane_multiple (tiling-x)
[426.357721] Starting subtest: tiling-x
[426.359299] Starting dynamic subtest: pipe-A-HDMI-A-1
[427.295903] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.938s)
[427.307389] Starting dynamic subtest: pipe-B-HDMI-A-1
[428.204416] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.906s)
[428.215514] Starting dynamic subtest: pipe-C-HDMI-A-1
[429.109365] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.902s)
[429.120260] Starting dynamic subtest: pipe-D-HDMI-A-1
[429.987866] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.876s)
[429.989497] Subtest tiling-x: SUCCESS (3.631s)
[430.203740] [023/156] (599s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[430.259984] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[430.364408] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[430.498827] [024/156] (599s left) gem_ccs (block-multicopy-inplace)
[430.555519] Starting subtest: block-multicopy-inplace
[430.558114] Subtest block-multicopy-inplace: SKIP (0.000s)
[430.706272] [025/156] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[432.204871] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[432.208692] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[432.396943] [026/156] (597s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[433.921954] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[433.925490] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[434.123514] [027/156] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[435.625225] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[435.628730] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[435.818902] [028/156] (594s left) kms_vblank (query-busy-hang)
[437.309405] Starting subtest: query-busy-hang
[437.312989] Starting dynamic subtest: pipe-A-HDMI-A-1
[463.461356] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.149s)
[463.475148] Starting dynamic subtest: pipe-D-HDMI-A-1
[488.468929] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (25.003s)
[488.470692] Subtest query-busy-hang: SUCCESS (51.160s)
[488.684781] [029/156] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[490.186115] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[490.190030] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[490.361189] [030/156] (540s left) kms_psr (psr2-cursor-blt)
[491.853041] Subtest psr2-cursor-blt: SKIP (0.000s)
[491.937054] [031/156] (538s left) syncobj_wait (single-wait-for-submit-signaled)
[491.989502] Starting subtest: single-wait-for-submit-signaled
[491.991284] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[492.117861] [032/156] (538s left) api_intel_bb (bb-with-allocator)
[492.168139] Starting subtest: bb-with-allocator
[492.187588] Subtest bb-with-allocator: SUCCESS (0.021s)
[492.370393] [033/156] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[493.884702] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[493.888278] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[494.099183] [034/156] (536s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[495.590883] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[495.667958] [035/156] (535s left) gem_exec_schedule (u-semaphore-user)
[495.731702] Starting subtest: u-semaphore-user
[495.763547] Subtest u-semaphore-user: SUCCESS (0.032s)
[496.267799] [036/156] (534s left) gem_ctx_param (invalid-ctx-get)
[496.326111] Starting subtest: invalid-ctx-get
[496.327776] Subtest invalid-ctx-get: SUCCESS (0.000s)
[496.470578] [037/156] (534s left) gem_userptr_blits (usage-restrictions)
[496.525769] Starting subtest: usage-restrictions
[496.527267] Subtest usage-restrictions: SUCCESS (0.000s)
[496.741600] [038/156] (534s left) syncobj_wait (single-wait-submitted)
[496.791941] Starting subtest: single-wait-submitted
[496.902948] Subtest single-wait-submitted: SUCCESS (0.108s)
[497.065746] [039/156] (534s left) kms_cursor_legacy (forked-bo)
[498.558734] Starting subtest: forked-bo
[498.560246] Starting dynamic subtest: pipe-A
[503.981323] Dynamic subtest pipe-A: SUCCESS (5.417s)
[503.995318] Starting dynamic subtest: pipe-B
[509.409327] Dynamic subtest pipe-B: SUCCESS (5.425s)
[509.429768] Starting dynamic subtest: pipe-C
[514.862891] Dynamic subtest pipe-C: SUCCESS (5.449s)
[514.882905] Starting dynamic subtest: pipe-D
[520.305351] Dynamic subtest pipe-D: SUCCESS (5.442s)
[520.327887] Starting dynamic subtest: all-pipes
[525.748434] Dynamic subtest all-pipes: SUCCESS (5.440s)
[525.750066] Subtest forked-bo: SUCCESS (27.187s)
[525.872221] [040/156] (505s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[527.364887] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[527.366597] Starting dynamic subtest: pipe-A
[527.545140] Dynamic subtest pipe-A: SUCCESS (0.181s)
[527.571894] Starting dynamic subtest: pipe-B
[527.736456] Dynamic subtest pipe-B: SUCCESS (0.189s)
[527.747684] Starting dynamic subtest: pipe-C
[527.893340] Dynamic subtest pipe-C: SUCCESS (0.156s)
[527.904369] Starting dynamic subtest: pipe-D
[528.050453] Dynamic subtest pipe-D: SUCCESS (0.155s)
[528.051978] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.688s)
[528.261312] [041/156] (503s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[529.775924] Starting subtest: x-tiled-32bpp-rotate-0
[532.108722] Subtest x-tiled-32bpp-rotate-0: SUCCESS (2.332s)
[532.438072] [042/156] (499s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[533.939923] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[533.943963] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[534.143251] [043/156] (497s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[535.648214] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[535.651950] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[535.826243] [044/156] (496s left) gem_mmap_offset (clear)
[535.877700] Starting subtest: clear
[535.879030] Starting dynamic subtest: lmem0
[557.881547] Dynamic subtest lmem0: SUCCESS (21.997s)
[557.893281] Starting dynamic subtest: smem0
[586.017728] Dynamic subtest smem0: SUCCESS (28.141s)
[586.020211] Subtest clear: SUCCESS (50.141s)
[586.283255] [045/156] (445s left) kms_atomic (plane-invalid-params)
[587.845438] Starting subtest: plane-invalid-params
[587.849180] Starting dynamic subtest: pipe-A-HDMI-A-1
[588.412631] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.565s)
[588.414351] Subtest plane-invalid-params: SUCCESS (0.568s)
[588.628097] [046/156] (443s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[590.129220] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[590.132748] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[590.320140] [047/156] (442s left) gem_ctx_persistence (saturated-hostile)
[590.378278] Starting subtest: saturated-hostile
[590.379943] Starting dynamic subtest: rcs0
[591.186832] Dynamic subtest rcs0: SUCCESS (0.807s)
[591.199500] Starting dynamic subtest: bcs0
[591.965269] Dynamic subtest bcs0: SUCCESS (0.773s)
[591.978260] Starting dynamic subtest: vcs0
[592.749843] Dynamic subtest vcs0: SUCCESS (0.781s)
[592.762514] Starting dynamic subtest: vcs1
[593.528810] Dynamic subtest vcs1: SUCCESS (0.779s)
[593.540991] Starting dynamic subtest: vecs0
[594.307753] Dynamic subtest vecs0: SUCCESS (0.778s)
[594.309288] Subtest saturated-hostile: SUCCESS (3.930s)
[594.453151] [048/156] (437s left) gem_exec_params (larger-than-life-batch)
[594.520674] Starting subtest: larger-than-life-batch
[604.771687] Subtest larger-than-life-batch: SUCCESS (10.250s)
[605.372965] [049/156] (427s left) gem_exec_await (wide-contexts)
[605.585887] Starting subtest: wide-contexts
[627.512026] Subtest wide-contexts: SUCCESS (21.926s)
[627.784947] [050/156] (404s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[627.904401] Starting subtest: yf-tiled-to-vebox-yf-tiled
[627.905934] Starting dynamic subtest: smem
[627.995838] Dynamic subtest smem: SUCCESS (0.091s)
[628.009800] Starting dynamic subtest: lmem0
[628.756842] Dynamic subtest lmem0: SUCCESS (0.756s)
[628.758164] Subtest yf-tiled-to-vebox-yf-tiled: SUCCESS (0.850s)
[629.033860] [051/156] (403s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[630.546224] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[630.549945] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[630.745397] [052/156] (402s left) gem_exec_params (invalid-bsd-ring)
[630.801717] Starting subtest: invalid-bsd-ring
[630.803416] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[630.956862] [053/156] (401s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[631.014784] Starting subtest: single-wait-for-submit-unsubmitted
[631.126928] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[631.269652] [054/156] (401s left) gem_create (create-valid-nonaligned)
[631.318141] Starting subtest: create-valid-nonaligned
[631.319678] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[631.562667] [055/156] (401s left) kms_flip (2x-flip-vs-fences-interruptible)
[633.060531] Starting subtest: 2x-flip-vs-fences-interruptible
[633.063612] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[633.212841] [056/156] (399s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[634.724670] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[634.728238] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[634.919341] [057/156] (398s left) syncobj_wait (invalid-reset-illegal-handle)
[634.983121] Starting subtest: invalid-reset-illegal-handle
[634.984661] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[635.102445] [058/156] (398s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[636.600923] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[636.604140] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[636.784778] [059/156] (396s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[638.297581] Starting subtest: hdr-rgb101010-draw-mmap-wc
[638.301047] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[638.459958] [060/156] (395s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[639.960201] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[639.965321] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[640.179540] [061/156] (393s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[641.671861] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[641.673551] Starting dynamic subtest: pipe-A-valid-mode
[642.854681] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.181s)
[642.856341] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.184s)
[643.115931] [062/156] (390s left) gem_exec_balancer (sliced)
[643.178416] Starting subtest: sliced
[643.181611] Subtest sliced: SKIP (0.000s)
[643.613601] [063/156] (390s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[645.130444] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[645.134041] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[645.316932] [064/156] (388s left) i915_hangman (engine-engine-error)
[645.397031] Starting subtest: engine-engine-error
[645.398499] Starting dynamic subtest: rcs0
[646.107994] Dynamic subtest rcs0: SUCCESS (0.711s)
[646.124654] Starting dynamic subtest: bcs0
[646.784987] Dynamic subtest bcs0: SUCCESS (0.675s)
[646.800272] Starting dynamic subtest: vcs0
[647.449888] Dynamic subtest vcs0: SUCCESS (0.663s)
[647.462083] Starting dynamic subtest: vcs1
[648.112911] Dynamic subtest vcs1: SUCCESS (0.662s)
[648.126122] Starting dynamic subtest: vecs0
[648.777965] Dynamic subtest vecs0: SUCCESS (0.663s)
[648.779590] Subtest engine-engine-error: SUCCESS (3.383s)
[649.040976] [065/156] (385s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[650.541681] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[650.544931] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[650.700695] [066/156] (383s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[652.213608] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[653.496109] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.282s)
[653.747355] [067/156] (380s left) gem_ctx_isolation (dirty-switch)
[653.808128] Starting subtest: dirty-switch
[653.809860] Starting dynamic subtest: rcs0
[654.605032] Dynamic subtest rcs0: SUCCESS (0.797s)
[654.619456] Starting dynamic subtest: bcs0
[655.455693] Dynamic subtest bcs0: SUCCESS (0.849s)
[655.468437] Starting dynamic subtest: vcs0
[656.322464] Dynamic subtest vcs0: SUCCESS (0.865s)
[656.334895] Starting dynamic subtest: vcs1
[657.185626] Dynamic subtest vcs1: SUCCESS (0.861s)
[657.198134] Starting dynamic subtest: vecs0
[658.034969] Dynamic subtest vecs0: SUCCESS (0.848s)
[658.036792] Subtest dirty-switch: SUCCESS (4.228s)
[658.389312] [068/156] (376s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[659.889506] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[659.892968] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[660.099993] [069/156] (374s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[661.704592] Starting subtest: cursor-rapid-movement-32x10
[661.759900] Subtest cursor-rapid-movement-32x10: SKIP (0.051s)
[662.198766] [070/156] (372s left) gem_spin_batch (user-each)
[662.262112] Starting subtest: user-each
[665.542889] Subtest user-each: SUCCESS (3.281s)
[665.865295] [071/156] (368s left) syncobj_basic (bad-destroy)
[665.912533] Starting subtest: bad-destroy
[665.913971] Subtest bad-destroy: SUCCESS (0.000s)
[666.048973] [072/156] (368s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[667.549703] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[667.552765] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[667.737411] [073/156] (367s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[669.230921] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[669.232681] Starting dynamic subtest: pipe-A-valid-mode
[670.577500] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.347s)
[670.578837] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.350s)
[670.782590] [074/156] (364s left) kms_frontbuffer_tracking (fbc-suspend)
[672.295501] Starting subtest: fbc-suspend
[718.221932] Subtest fbc-suspend: SUCCESS (24.138s)
[722.490081] [075/156] (316s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[723.993422] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[723.996551] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[724.172391] [076/156] (315s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[725.714252] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[725.855103] [077/156] (313s left) kms_chamelium_audio (hdmi-audio)
[727.393529] Subtest hdmi-audio: SKIP (0.000s)
[727.531961] [078/156] (311s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[729.026345] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[729.216779] [079/156] (310s left) kms_psr (fbc-pr-primary-render)
[730.710477] Subtest fbc-pr-primary-render: SKIP (0.000s)
[730.809181] [080/156] (308s left) prime_vgem (basic-gtt)
[730.902137] Starting subtest: basic-gtt
[730.905653] Subtest basic-gtt: SKIP (0.000s)
[731.091093] [081/156] (308s left) gem_mmap_gtt (fault-concurrent-y)
[731.141579] Subtest fault-concurrent-Y: SKIP (0.000s)
[731.243506] [082/156] (308s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[732.744207] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[732.747235] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[732.947317] [083/156] (307s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[733.010885] Starting subtest: multi-wait-all-for-submit-available-submitted
[733.012344] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[733.137882] [084/156] (307s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[734.648834] Starting subtest: fbchdr-tiling-4
[734.652069] Subtest fbchdr-tiling-4: SKIP (0.000s)
[734.858028] [085/156] (305s left) kms_vrr (flip-basic-fastset)
[736.353671] Starting subtest: flip-basic-fastset
[736.358016] Subtest flip-basic-fastset: SKIP (0.000s)
[736.499819] [086/156] (303s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[738.003550] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[738.009787] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[738.214876] [087/156] (302s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[739.718116] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[739.721482] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[739.916342] [088/156] (300s left) gem_lmem_swapping (massive)
[744.436880] Starting subtest: massive
[744.440138] Starting dynamic subtest: lmem0
[756.408804] Dynamic subtest lmem0: SUCCESS (11.964s)
[756.410518] Subtest massive: SUCCESS (11.968s)
[757.995364] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[757.996606] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[757.999324] [089/156] (282s left) kms_psr (pr-basic)
[763.031671] Subtest pr-basic: SKIP (0.000s)
[763.137103] [FACT kms_psr (pr-basic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[763.141581] [FACT kms_psr (pr-basic)] new: kernel.kmod_is_loaded.i915: true
[763.146243] [090/156] (277s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[764.647361] Starting subtest: async-flip-with-page-flip-events-linear
[764.886192] Starting dynamic subtest: pipe-A-HDMI-A-1
[767.222089] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.332s)
[767.395890] Starting dynamic subtest: pipe-B-HDMI-A-1
[769.457240] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.071s)
[769.641370] Starting dynamic subtest: pipe-C-HDMI-A-1
[771.707808] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.075s)
[771.885691] Starting dynamic subtest: pipe-D-HDMI-A-1
[773.962295] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.085s)
[773.964048] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.312s)
[774.351991] [091/156] (266s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[775.846741] Starting subtest: basic-busy-flip-before-cursor-atomic
[775.849641] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[775.999972] [092/156] (264s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[777.513283] Starting subtest: y-tiled-8bpp-rotate-90
[777.621335] Subtest y-tiled-8bpp-rotate-90: SKIP (0.107s)
[777.830059] [093/156] (263s left) kms_invalid_mode (bad-vsync-start)
[779.323624] Starting subtest: bad-vsync-start
[779.326996] Starting dynamic subtest: pipe-A-HDMI-A-1
[779.371296] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.044s)
[779.386865] Starting dynamic subtest: pipe-B-HDMI-A-1
[779.388485] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[779.401246] Starting dynamic subtest: pipe-C-HDMI-A-1
[779.402826] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[779.416050] Starting dynamic subtest: pipe-D-HDMI-A-1
[779.417418] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[779.418852] Subtest bad-vsync-start: SUCCESS (0.057s)
[779.589027] [094/156] (261s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[781.090024] Starting subtest: short-flip-after-cursor-toggle
[782.093742] Subtest short-flip-after-cursor-toggle: SUCCESS (1.010s)
[782.306078] [095/156] (258s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[783.801163] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[783.802662] Starting dynamic subtest: pipe-A-HDMI-A-1
[783.817589] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[783.831000] Starting dynamic subtest: pipe-B-HDMI-A-1
[783.847474] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[783.860611] Starting dynamic subtest: pipe-C-HDMI-A-1
[783.877401] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[783.890983] Starting dynamic subtest: pipe-D-HDMI-A-1
[783.910847] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[783.914460] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.013s)
[784.115405] [096/156] (257s left) gem_exec_alignment (forked)
[784.184759] Starting subtest: forked
[821.630643] Subtest forked: SUCCESS (37.442s)
[822.004416] [097/156] (219s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[823.581556] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[823.584647] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[823.778176] [098/156] (217s left) drm_read (short-buffer-block)
[825.373071] Starting subtest: short-buffer-block
[825.374761] Subtest short-buffer-block: SUCCESS (0.000s)
[825.620124] [099/156] (216s left) perf_pmu (busy-idle)
[825.680250] Starting subtest: busy-idle
[825.681645] Starting dynamic subtest: rcs0
[826.388886] Dynamic subtest rcs0: SUCCESS (0.708s)
[826.408756] Starting dynamic subtest: bcs0
[827.050821] Dynamic subtest bcs0: SUCCESS (0.660s)
[827.070298] Starting dynamic subtest: vcs0
[827.715865] Dynamic subtest vcs0: SUCCESS (0.663s)
[827.735322] Starting dynamic subtest: vcs1
[828.377899] Dynamic subtest vcs1: SUCCESS (0.660s)
[828.397866] Starting dynamic subtest: vecs0
[829.043922] Dynamic subtest vecs0: SUCCESS (0.664s)
[829.045544] Subtest busy-idle: SUCCESS (3.365s)
[829.212401] [100/156] (212s left) syncobj_timeline (wait-for-submit-snapshot)
[829.271115] Starting subtest: wait-for-submit-snapshot
[829.355032] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[829.584091] [101/156] (212s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[831.077904] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[831.081045] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.000s)
[831.223827] [102/156] (210s left) gem_exec_balancer (bonded-semaphore)
[831.284532] Starting subtest: bonded-semaphore
[831.287669] Subtest bonded-semaphore: SKIP (0.000s)
[831.782907] [103/156] (210s left) kms_big_fb (linear-32bpp-rotate-90)
[833.299165] Starting subtest: linear-32bpp-rotate-90
[833.416527] Subtest linear-32bpp-rotate-90: SKIP (0.115s)
[833.560152] [104/156] (208s left) sw_sync (sync_multi_consumer)
[833.610251] Starting subtest: sync_multi_consumer
[834.065213] Subtest sync_multi_consumer: SUCCESS (0.454s)
[834.201382] [105/156] (208s left) perf_pmu (render-node-busy)
[834.256275] Starting subtest: render-node-busy
[834.257979] Starting dynamic subtest: rcs0
[834.836396] Dynamic subtest rcs0: SUCCESS (0.580s)
[834.853719] Starting dynamic subtest: bcs0
[835.397796] Dynamic subtest bcs0: SUCCESS (0.558s)
[835.418128] Starting dynamic subtest: vcs0
[835.959485] Dynamic subtest vcs0: SUCCESS (0.556s)
[835.978384] Starting dynamic subtest: vcs1
[836.523426] Dynamic subtest vcs1: SUCCESS (0.558s)
[836.542636] Starting dynamic subtest: vecs0
[837.087472] Dynamic subtest vecs0: SUCCESS (0.558s)
[837.093356] Subtest render-node-busy: SUCCESS (2.835s)
[837.262404] [106/156] (205s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[838.779587] Starting subtest: stress-xrgb8888-ytiled
[852.413585] Subtest stress-xrgb8888-ytiled: SUCCESS (13.638s)
[852.604585] [107/156] (189s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[854.106946] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[854.110282] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[854.256510] [108/156] (188s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[855.757069] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[855.760253] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[855.954664] [109/156] (186s left) device_reset (unbind-cold-reset-rebind)
[856.062816] Starting subtest: unbind-cold-reset-rebind
[856.065568] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[856.219418] [110/156] (186s left) gem_ctx_exec (basic-close-race)
[856.271024] Starting subtest: basic-close-race
[861.889633] Subtest basic-close-race: SUCCESS (5.615s)
[862.122081] [111/156] (180s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[863.612815] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[863.614290] Starting dynamic subtest: pipe-A-HDMI-A-1
[863.628991] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[863.644108] Starting dynamic subtest: pipe-B-HDMI-A-1
[863.659167] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[863.673933] Starting dynamic subtest: pipe-C-HDMI-A-1
[863.689147] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[863.704306] Starting dynamic subtest: pipe-D-HDMI-A-1
[863.721629] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[863.725064] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.013s)
[863.935622] [112/156] (179s left) kms_flip (2x-plain-flip)
[865.427182] Starting subtest: 2x-plain-flip
[865.450200] Subtest 2x-plain-flip: SKIP (0.022s)
[865.597756] [113/156] (177s left) syncobj_wait (multi-wait-all-submitted)
[865.651393] Starting subtest: multi-wait-all-submitted
[865.761726] Subtest multi-wait-all-submitted: SUCCESS (0.109s)
[865.952375] [114/156] (177s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[867.455368] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[867.459303] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[867.642167] [115/156] (175s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[869.137193] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[869.138758] Starting dynamic subtest: pipe-A-HDMI-A-1
[869.179071] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[869.194343] Starting dynamic subtest: pipe-B-HDMI-A-1
[869.247198] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[869.261373] Starting dynamic subtest: pipe-C-HDMI-A-1
[869.298959] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[869.313345] Starting dynamic subtest: pipe-D-HDMI-A-1
[869.354849] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.003s)
[869.358362] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.020s)
[869.484372] [116/156] (173s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[870.987316] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[870.990643] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[871.209638] [117/156] (172s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[872.708665] Starting subtest: psr-1p-primscrn-spr-indfb-move
[872.711855] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[872.864192] [118/156] (170s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[874.366531] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[874.369636] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[874.563346] [119/156] (169s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[876.062342] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[876.066217] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[876.280724] [120/156] (167s left) i915_pm_rc6_residency (rc6-accuracy)
[876.330546] Starting subtest: rc6-accuracy
[876.332421] Starting dynamic subtest: gt0
[879.518334] Dynamic subtest gt0: SUCCESS (3.172s)
[879.519894] Subtest rc6-accuracy: SUCCESS (3.177s)
[879.624445] [121/156] (164s left) kms_legacy_colorkey (invalid-plane)
[881.116245] Starting subtest: invalid-plane
[881.118061] Starting dynamic subtest: zero-id
[881.119781] Dynamic subtest zero-id: SUCCESS (0.000s)
[881.135395] Starting dynamic subtest: outrange-id
[881.137423] Dynamic subtest outrange-id: SUCCESS (0.000s)
[881.139655] Subtest invalid-plane: SUCCESS (0.003s)
[881.255662] [122/156] (162s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[882.758385] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[882.762178] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[882.944145] [123/156] (161s left) gem_partial_pwrite_pread (write-uncached)
[883.015956] Subtest write-uncached: SKIP (0.000s)
[883.120965] [124/156] (161s left) gem_userptr_blits (readonly-unsync)
[883.190327] Subtest readonly-unsync: SKIP (0.000s)
[883.335131] [125/156] (161s left) syncobj_basic (bad-pad-fd-to-handle)
[883.384276] Starting subtest: bad-pad-fd-to-handle
[883.385814] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[883.505061] [126/156] (160s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[885.004350] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[885.007571] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[885.198455] [127/156] (159s left) perf (invalid-oa-format-id)
[885.350580] Starting subtest: invalid-oa-format-id
[885.376438] Subtest invalid-oa-format-id: SUCCESS (0.026s)
[885.450501] [128/156] (159s left) gem_mmap_wc (pf-nonblock)
[885.503018] Subtest pf-nonblock: SKIP (0.000s)
[885.582114] [129/156] (159s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[885.630721] Starting subtest: multi-wait-for-submit-submitted-signaled
[885.632273] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[885.766911] [130/156] (159s left) kms_psr (psr2-sprite-plane-onoff)
[887.260213] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[887.349063] [131/156] (157s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[888.851965] Starting subtest: psr-shrfb-scaledprimary
[888.857230] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[889.089364] [132/156] (155s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[890.590107] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[890.593313] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[890.771638] [133/156] (154s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[892.273312] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[892.276557] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[892.482337] [134/156] (152s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[892.533538] Starting subtest: invalid-single-wait-all-unsubmitted
[892.535146] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[892.660152] [135/156] (152s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[894.154605] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[894.230578] [136/156] (151s left) kms_dp_link_training (uhbr-mst)
[895.724604] Starting subtest: uhbr-mst
[895.727619] Subtest uhbr-mst: SKIP (0.000s)
[895.868155] [137/156] (149s left) prime_busy (hang)
[895.922229] Starting subtest: hang
[895.925868] Starting dynamic subtest: rcs0
[922.209587] Dynamic subtest rcs0: SUCCESS (26.285s)
[922.224255] Starting dynamic subtest: bcs0
[929.353391] Dynamic subtest bcs0: SUCCESS (7.144s)
[929.370647] Starting dynamic subtest: vcs0
[936.398189] Dynamic subtest vcs0: SUCCESS (7.041s)
[936.413071] Starting dynamic subtest: vcs1
[943.373196] Dynamic subtest vcs1: SUCCESS (6.973s)
[943.388206] Starting dynamic subtest: vecs0
[950.345605] Dynamic subtest vecs0: SUCCESS (6.973s)
[950.347102] Subtest hang: SUCCESS (54.425s)
[950.511133] [138/156] ( 95s left) i915_drm_fdinfo (virtual-busy-all)
[950.569285] Starting subtest: virtual-busy-all
[950.572660] Subtest virtual-busy-all: SKIP (0.000s)
[950.688393] [139/156] ( 95s left) gen9_exec_parse (allowed-all)
[950.742805] Subtest allowed-all: SKIP (0.000s)
[950.830119] [140/156] ( 94s left) gem_exec_schedule (u-submit-late-slice)
[950.897202] Starting subtest: u-submit-late-slice
[950.898906] Starting dynamic subtest: rcs0
[950.958225] Dynamic subtest rcs0: SUCCESS (0.060s)
[950.974330] Starting dynamic subtest: bcs0
[950.999885] Dynamic subtest bcs0: SUCCESS (0.040s)
[951.015657] Starting dynamic subtest: vcs0
[951.042551] Dynamic subtest vcs0: SUCCESS (0.041s)
[951.068567] Starting dynamic subtest: vcs1
[951.084739] Dynamic subtest vcs1: SUCCESS (0.041s)
[951.102375] Starting dynamic subtest: vecs0
[951.129253] Dynamic subtest vecs0: SUCCESS (0.043s)
[951.130842] Subtest u-submit-late-slice: SUCCESS (0.233s)
[951.616636] [141/156] ( 94s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[951.676156] Starting subtest: x-tiled-to-vebox-y-tiled
[951.677640] Starting dynamic subtest: smem
[951.756836] Dynamic subtest smem: SUCCESS (0.082s)
[951.772153] Starting dynamic subtest: lmem0
[952.511398] Dynamic subtest lmem0: SUCCESS (0.750s)
[952.513246] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.835s)
[952.774865] [142/156] ( 93s left) api_intel_bb (reset-flags)
[952.823892] Starting subtest: reset-flags
[952.850228] Subtest reset-flags: SUCCESS (0.026s)
[953.013726] [143/156] ( 93s left) kms_flip (2x-flip-vs-wf_vblank)
[954.506988] Starting subtest: 2x-flip-vs-wf_vblank
[954.529267] Subtest 2x-flip-vs-wf_vblank: SKIP (0.021s)
[954.671974] [144/156] ( 91s left) kms_pm_dc (dc5-dpms)
[957.175080] Starting subtest: dc5-dpms
[958.471383] Subtest dc5-dpms: SUCCESS (1.293s)
[958.624881] [145/156] ( 87s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[960.125200] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[960.128592] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[960.329881] [146/156] ( 86s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[961.823877] Starting subtest: bad-rotation-90-yf-tiled-ccs
[961.825278] Starting dynamic subtest: pipe-A-HDMI-A-1
[961.839029] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[961.854334] Starting dynamic subtest: pipe-B-HDMI-A-1
[961.868576] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[961.883535] Starting dynamic subtest: pipe-C-HDMI-A-1
[961.898039] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[961.913320] Starting dynamic subtest: pipe-D-HDMI-A-1
[961.930314] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[961.933538] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.010s)
[962.143888] [147/156] ( 84s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[963.656435] Starting subtest: 4-tiled-addfb-size-offset-overflow
[963.659679] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[963.846994] [148/156] ( 82s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[965.353254] Starting subtest: fbcpsr-1p-rte
[965.356655] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[965.559681] [149/156] ( 81s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[965.615801] Subtest writes-after-reads: SKIP (0.000s)
[965.714834] [150/156] ( 81s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[967.216055] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[967.219286] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[967.394057] [151/156] ( 79s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[968.896267] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[968.901689] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[969.151777] [152/156] ( 77s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[970.641546] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[970.664162] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.021s)
[970.833941] [153/156] ( 76s left) kms_plane (plane-panning-bottom-right-suspend)
[972.326650] Starting subtest: plane-panning-bottom-right-suspend
[972.328368] Starting dynamic subtest: pipe-A
[993.500671] Dynamic subtest pipe-A: SUCCESS (10.893s)
[993.518337] Starting dynamic subtest: pipe-B
[1015.507556] Dynamic subtest pipe-B: SUCCESS (10.437s)
[1015.509064] Subtest plane-panning-bottom-right-suspend: SUCCESS (21.334s)
[1021.731431] [154/156] ( 31s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[1023.227392] Starting subtest: basic-flip-before-cursor-legacy
[1024.217481] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.990s)
[1024.434970] [155/156] ( 28s left) kms_getfb (getfb-reject-nv12)
[1025.928363] Starting subtest: getfb-reject-nv12
[1025.929911] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[1026.139629] [156/156] ( 27s left) gem_render_copy (x-tiled)
[1026.195729] Starting subtest: x-tiled
[1026.197470] Starting dynamic subtest: smem
[1026.287427] Dynamic subtest smem: SUCCESS (0.091s)
[1026.302942] Starting dynamic subtest: lmem0
[1027.050658] Dynamic subtest lmem0: SUCCESS (0.758s)
[1027.052609] Subtest x-tiled: SUCCESS (0.852s)
[1027.307243] Closing watchdogs
results: parsing output: 0/ for test: i915_selftest
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_prime
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_dsc
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_plane_multiple
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: gem_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: kms_atomic
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: gem_exec_await
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: i915_hangman
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_ctx_isolation
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_spin_batch
results: parsing output: 70/ for test: syncobj_basic
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_chamelium_frames
results: parsing output: 76/ for test: kms_chamelium_audio
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: prime_vgem
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_vrr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_invalid_mode
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_alignment
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: sw_sync
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: kms_pipe_stress
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: device_reset
results: parsing output: 109/ for test: gem_ctx_exec
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_pm_rc6_residency
results: parsing output: 120/ for test: kms_legacy_colorkey
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_partial_pwrite_pread
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: syncobj_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: syncobj_wait
results: parsing output: 134/ for test: kms_psr2_sf
results: parsing output: 135/ for test: kms_dp_link_training
results: parsing output: 136/ for test: prime_busy
results: parsing output: 137/ for test: i915_drm_fdinfo
results: parsing output: 138/ for test: gen9_exec_parse
results: parsing output: 139/ for test: gem_exec_schedule
results: parsing output: 140/ for test: gem_render_copy
results: parsing output: 141/ for test: api_intel_bb
results: parsing output: 142/ for test: kms_flip
results: parsing output: 143/ for test: kms_pm_dc
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_flip
results: parsing output: 152/ for test: kms_plane
results: parsing output: 153/ for test: kms_cursor_legacy
results: parsing output: 154/ for test: kms_getfb
results: parsing output: 155/ for test: gem_render_copy
Done.