[64.528755] Initializing watchdogs [64.528834] /dev/watchdog0 [64.558952] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [64.573988] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [64.578951] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.582079] [001/156] (960s left) kms_chamelium_audio (dp-audio-edid) [66.128596] Subtest dp-audio-edid: SKIP (0.000s) [66.265104] [002/156] (958s left) kms_flip (2x-flip-vs-suspend) [67.761649] Starting subtest: 2x-flip-vs-suspend [67.765495] Subtest 2x-flip-vs-suspend: SKIP (0.003s) [67.901518] [003/156] (957s left) kms_addfb_basic (addfb25-modifier-no-flag) [69.405522] Starting subtest: addfb25-modifier-no-flag [69.406354] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [69.563409] [004/156] (955s left) kms_legacy_colorkey (basic) [71.067387] Starting subtest: basic [71.068427] Starting dynamic subtest: pipe-A [71.153582] Dynamic subtest pipe-A: SUCCESS (0.087s) [71.162949] Starting dynamic subtest: pipe-B [71.164789] Dynamic subtest pipe-B: SUCCESS (0.003s) [71.174225] Starting dynamic subtest: pipe-C [71.175926] Dynamic subtest pipe-C: SUCCESS (0.003s) [71.185155] Starting dynamic subtest: pipe-D [71.186882] Dynamic subtest pipe-D: SUCCESS (0.003s) [71.188679] Subtest basic: SUCCESS (0.102s) [71.554988] [005/156] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [73.072759] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [73.074539] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [73.245088] [006/156] (952s left) kms_big_fb (y-tiled-32bpp-rotate-90) [74.764921] Starting subtest: y-tiled-32bpp-rotate-90 [77.115742] Subtest y-tiled-32bpp-rotate-90: SUCCESS (2.344s) [77.296482] [007/156] (948s left) gem_ctx_bad_destroy (double-destroy) [77.342301] Starting subtest: double-destroy [77.343206] Subtest double-destroy: SUCCESS (0.000s) [77.496946] [008/156] (948s left) kms_frontbuffer_tracking (psrhdr-suspend) [78.994539] Starting subtest: psrhdr-suspend [78.996427] Subtest psrhdr-suspend: SKIP (0.000s) [79.182714] [009/156] (946s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt) [80.683195] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt [80.685970] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [80.821811] [010/156] (945s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [82.329229] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [82.330142] Starting dynamic subtest: pipe-A-HDMI-A-3 [82.337915] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.001s) [82.346449] Starting dynamic subtest: pipe-B-HDMI-A-3 [82.354088] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [82.362602] Starting dynamic subtest: pipe-C-HDMI-A-3 [82.371508] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [82.379881] Starting dynamic subtest: pipe-D-HDMI-A-3 [82.389286] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [82.390309] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.008s) [82.635154] [011/156] (943s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [84.132694] Starting subtest: fbcpsr-modesetfrombusy [84.134550] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s) [84.348894] [012/156] (941s left) kms_big_fb (yf-tiled-addfb) [85.863835] Starting subtest: yf-tiled-addfb [85.865903] Subtest yf-tiled-addfb: SKIP (0.000s) [86.033447] [013/156] (940s left) syncobj_timeline (single-wait-all-signaled) [86.082399] Starting subtest: single-wait-all-signaled [86.083436] Subtest single-wait-all-signaled: SUCCESS (0.001s) [86.214328] [014/156] (940s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [87.711168] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [90.466073] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.755s) [90.674838] [015/156] (935s left) kms_fbcon_fbt (fbc) [90.724433] Starting subtest: fbc [94.191320] Subtest fbc: SUCCESS (3.461s) [94.296910] [016/156] (932s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [95.793434] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s) [95.856856] [017/156] (930s left) gem_lmem_swapping (random) [100.284616] Starting subtest: random [100.285604] Starting dynamic subtest: lmem0 [101.515094] Dynamic subtest lmem0: SUCCESS (1.227s) [101.516103] Subtest random: SUCCESS (1.228s) [104.155859] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true [104.158233] [018/156] (922s left) gem_mmap_gtt (fault-concurrent) [107.601306] Subtest fault-concurrent: SKIP (0.000s) [107.677571] [FACT gem_mmap_gtt (fault-concurrent)] new: kernel.kmod_is_loaded.i915: true [107.680582] [019/156] (918s left) gem_wait (await) [107.750883] Starting subtest: await [107.751866] Starting dynamic subtest: all-engines [108.890346] Dynamic subtest all-engines: SUCCESS (1.139s) [108.899657] Starting dynamic subtest: rcs0 [109.947918] Dynamic subtest rcs0: SUCCESS (1.056s) [109.959642] Starting dynamic subtest: bcs0 [111.010104] Dynamic subtest bcs0: SUCCESS (1.062s) [111.021935] Starting dynamic subtest: vcs0 [112.068053] Dynamic subtest vcs0: SUCCESS (1.057s) [112.079669] Starting dynamic subtest: vcs1 [113.129975] Dynamic subtest vcs1: SUCCESS (1.060s) [113.169021] Starting dynamic subtest: vecs0 [114.206831] Dynamic subtest vecs0: SUCCESS (1.075s) [114.209087] Subtest await: SUCCESS (6.455s) [114.526153] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true [114.528455] [020/156] (912s left) kms_psr2_su (page_flip-nv12) [114.576113] Subtest page_flip-NV12: SKIP (0.000s) [114.660646] [021/156] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [116.157105] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [116.158991] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [116.311775] [022/156] (910s left) gem_ctx_param (set-priority-invalid-size) [116.362954] Starting subtest: set-priority-invalid-size [116.363894] Subtest set-priority-invalid-size: SUCCESS (0.000s) [116.489946] [023/156] (910s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [117.999213] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [119.137307] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.133s) [119.305144] [024/156] (907s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render) [120.802173] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render [120.803946] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [120.978423] [025/156] (906s left) kms_psr (pr-cursor-blt) [122.471452] Subtest pr-cursor-blt: SKIP (0.000s) [122.539724] [026/156] (904s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [124.033032] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [124.106610] [027/156] (903s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [125.597059] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [126.640576] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.043s) [126.867279] [028/156] (900s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt) [128.365474] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt [128.367995] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [128.537101] [029/156] (898s left) gem_exec_schedule (smoketest) [128.759304] Starting subtest: smoketest [128.760765] Starting dynamic subtest: rcs0 [134.230269] Dynamic subtest rcs0: SUCCESS (5.462s) [134.240596] Starting dynamic subtest: bcs0 [139.682960] Dynamic subtest bcs0: SUCCESS (5.451s) [139.693153] Starting dynamic subtest: vcs0 [145.117395] Dynamic subtest vcs0: SUCCESS (5.434s) [145.127380] Starting dynamic subtest: vcs1 [150.559162] Dynamic subtest vcs1: SUCCESS (5.442s) [150.569080] Starting dynamic subtest: vecs0 [156.014405] Dynamic subtest vecs0: SUCCESS (5.453s) [156.015709] Subtest smoketest: SUCCESS (27.244s) [156.347492] [030/156] (871s left) kms_addfb_basic (bad-pitch-999) [156.391785] Starting subtest: bad-pitch-999 [156.392629] Subtest bad-pitch-999: SUCCESS (0.000s) [158.032379] [031/156] (869s left) gem_render_copy_redux (flink-interruptible) [158.084939] Starting subtest: flink-interruptible [160.159579] Subtest flink-interruptible: SUCCESS (2.075s) [160.319199] [032/156] (867s left) gem_softpin (allocator-basic-reserve) [160.370492] Starting subtest: allocator-basic-reserve [160.645710] Subtest allocator-basic-reserve: SUCCESS (0.271s) [160.855466] [033/156] (866s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [162.352186] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [162.354554] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [162.557285] [034/156] (865s left) gem_set_tiling_vs_blt (tiled-to-tiled) [162.615615] Subtest tiled-to-tiled: SKIP (0.000s) [162.700732] [035/156] (865s left) kms_psr (psr2-cursor-mmap-cpu) [164.191998] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s) [164.266402] [036/156] (863s left) kms_chamelium_edid (hdmi-edid-read) [165.800223] Subtest hdmi-edid-read: SKIP (0.000s) [165.938851] [037/156] (862s left) fbdev (info) [165.982385] Starting subtest: info [165.983311] Subtest info: SUCCESS (0.000s) [166.090303] [038/156] (862s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [167.587048] Starting subtest: psr-rgb565-draw-mmap-wc [167.589413] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s) [167.790358] [039/156] (860s left) kms_busy (extended-pageflip-hang-oldfb) [169.313920] Starting subtest: extended-pageflip-hang-oldfb [169.316135] Starting dynamic subtest: pipe-A [169.500550] Dynamic subtest pipe-A: SUCCESS (0.184s) [169.513635] Starting dynamic subtest: pipe-D [169.724541] Dynamic subtest pipe-D: SUCCESS (0.220s) [169.725569] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.410s) [169.948285] [040/156] (858s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [171.463894] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [171.465983] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [171.627828] [041/156] (856s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [173.120907] Starting subtest: 2x-long-cursor-vs-flip-atomic [173.128556] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.003s) [173.256306] [042/156] (855s left) syncobj_wait (reset-multiple-signaled) [173.313178] Starting subtest: reset-multiple-signaled [173.314039] Subtest reset-multiple-signaled: SUCCESS (0.000s) [173.430860] [043/156] (855s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [174.921049] Starting subtest: primary-yf-tiled-reflect-x-90 [175.022339] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.101s) [175.233029] [044/156] (853s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [175.278317] Starting subtest: invalid-multi-wait-unsubmitted-submitted [175.279259] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [175.390921] [045/156] (853s left) kms_flip (2x-flip-vs-panning-interruptible) [176.889041] Starting subtest: 2x-flip-vs-panning-interruptible [176.907974] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.019s) [177.034770] [046/156] (851s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [178.530975] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s) [178.615575] [047/156] (850s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt) [180.112233] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt [180.113908] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [180.329444] [048/156] (848s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [181.857452] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [182.977255] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.115s) [183.149566] [049/156] (846s left) gem_exec_params (invalid-bsd1-flag-on-blt) [183.200515] Starting subtest: invalid-bsd1-flag-on-blt [183.201355] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [183.337281] [050/156] (846s left) syncobj_timeline (etime-multi-wait-submitted) [183.384200] Starting subtest: etime-multi-wait-submitted [183.495118] Subtest etime-multi-wait-submitted: SUCCESS (0.107s) [183.636759] [051/156] (845s left) perf_pmu (semaphore-busy) [183.696696] Starting subtest: semaphore-busy [183.697673] Starting dynamic subtest: rcs0 [185.351172] Dynamic subtest rcs0: SUCCESS (1.649s) [185.361713] Starting dynamic subtest: bcs0 [186.987178] Dynamic subtest bcs0: SUCCESS (1.632s) [186.998165] Starting dynamic subtest: vcs0 [188.617904] Dynamic subtest vcs0: SUCCESS (1.629s) [188.628672] Starting dynamic subtest: vcs1 [190.268047] Dynamic subtest vcs1: SUCCESS (1.647s) [190.278880] Starting dynamic subtest: vecs0 [191.916175] Dynamic subtest vecs0: SUCCESS (1.646s) [191.917212] Subtest semaphore-busy: SUCCESS (8.217s) [192.070939] [052/156] (837s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [193.562264] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [193.588496] Starting dynamic subtest: pipe-A-plane-0 [194.122101] Dynamic subtest pipe-A-plane-0: SUCCESS (0.533s) [194.155143] Starting dynamic subtest: pipe-A-plane-3 [194.472569] Dynamic subtest pipe-A-plane-3: SUCCESS (0.349s) [194.506819] Starting dynamic subtest: pipe-A-plane-5 [194.792057] Dynamic subtest pipe-A-plane-5: SUCCESS (0.315s) [194.832953] Starting dynamic subtest: pipe-A-plane-7 [194.836124] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [194.989549] Starting dynamic subtest: pipe-B-plane-0 [195.363745] Dynamic subtest pipe-B-plane-0: SUCCESS (0.383s) [195.400481] Starting dynamic subtest: pipe-B-plane-3 [195.713348] Dynamic subtest pipe-B-plane-3: SUCCESS (0.348s) [195.743784] Starting dynamic subtest: pipe-B-plane-5 [196.031182] Dynamic subtest pipe-B-plane-5: SUCCESS (0.316s) [196.076782] Starting dynamic subtest: pipe-B-plane-7 [196.079129] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [196.120195] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SUCCESS (2.558s) [196.317902] [053/156] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [197.815490] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [197.817956] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [197.969315] [054/156] (831s left) kms_dp_link_training (non-uhbr-mst) [199.465077] Starting subtest: non-uhbr-mst [199.468492] Subtest non-uhbr-mst: SKIP (0.000s) [199.573617] [055/156] (830s left) kms_pm_rpm (basic-pci-d3-state) [204.107502] Starting subtest: basic-pci-d3-state [205.237632] Subtest basic-pci-d3-state: SUCCESS (1.135s) [206.136712] [056/156] (823s left) gem_softpin (allocator-basic) [206.196761] Starting subtest: allocator-basic [206.468740] Subtest allocator-basic: SUCCESS (0.268s) [206.660744] [057/156] (823s left) kms_cursor_crc (cursor-sliding-64x64) [208.281331] Starting subtest: cursor-sliding-64x64 [208.287461] Starting dynamic subtest: pipe-A-HDMI-A-3 [212.742653] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.454s) [212.779330] Starting dynamic subtest: pipe-D-HDMI-A-3 [217.179492] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.409s) [217.180537] Subtest cursor-sliding-64x64: SUCCESS (8.897s) [217.671668] [058/156] (812s left) kms_psr (psr2-sprite-plane-move) [219.163364] Subtest psr2-sprite-plane-move: SKIP (0.000s) [219.248154] [059/156] (810s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [220.738596] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [220.740612] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [220.901153] [060/156] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [222.401435] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [222.403115] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [222.553042] [061/156] (807s left) gem_lmem_swapping (basic) [226.934983] Starting subtest: basic [226.937231] Starting dynamic subtest: lmem0 [250.268444] Dynamic subtest lmem0: SUCCESS (23.329s) [250.269471] Subtest basic: SUCCESS (23.329s) [251.578475] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [251.579558] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true [251.581946] [062/156] (778s left) api_intel_allocator (reopen-fork) [254.991531] Starting subtest: reopen-fork [258.346323] Subtest reopen-fork: SUCCESS (3.350s) [258.451299] [FACT api_intel_allocator (reopen-fork)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [258.454619] [FACT api_intel_allocator (reopen-fork)] new: kernel.kmod_is_loaded.i915: true [258.457704] [063/156] (772s left) prime_self_import (basic-with_two_bos) [258.501232] Starting subtest: basic-with_two_bos [258.505199] Subtest basic-with_two_bos: SUCCESS (0.005s) [258.703015] [064/156] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [260.200173] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [260.202135] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [260.410698] [065/156] (770s left) gem_exec_fence (syncobj-timeline-unused-fence) [260.987296] Starting subtest: syncobj-timeline-unused-fence [261.005870] Subtest syncobj-timeline-unused-fence: SUCCESS (0.024s) [261.334190] [066/156] (769s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc) [262.830568] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc [262.833047] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [263.023174] [067/156] (767s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [264.518952] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [264.525220] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [264.732890] [068/156] (766s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite) [266.230872] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite [266.232773] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [266.431680] [069/156] (764s left) i915_selftest (live) [267.334509] Starting subtest: live [267.335612] Starting dynamic subtest: sanitycheck [268.823098] Dynamic subtest sanitycheck: SUCCESS (1.489s) [268.832657] Starting dynamic subtest: uncore [270.283060] Dynamic subtest uncore: SUCCESS (1.459s) [270.292140] Starting dynamic subtest: workarounds [273.738854] Dynamic subtest workarounds: SUCCESS (3.455s) [273.748314] Starting dynamic subtest: gt_engines [275.798881] Dynamic subtest gt_engines: SUCCESS (2.059s) [275.808536] Starting dynamic subtest: gt_timelines [323.309937] Dynamic subtest gt_timelines: SUCCESS (47.512s) [323.319230] Starting dynamic subtest: gt_contexts [324.801764] Dynamic subtest gt_contexts: SUCCESS (1.491s) [324.811404] Starting dynamic subtest: gt_lrc [330.946972] Dynamic subtest gt_lrc: SUCCESS (6.144s) [330.955928] Starting dynamic subtest: gt_mocs [333.299992] Dynamic subtest gt_mocs: SUCCESS (2.352s) [333.309514] Starting dynamic subtest: gt_pm [337.363888] Dynamic subtest gt_pm: SUCCESS (4.063s) [337.373329] Starting dynamic subtest: gt_heartbeat [338.833976] Dynamic subtest gt_heartbeat: SUCCESS (1.469s) [338.843461] Starting dynamic subtest: gt_tlb [353.451199] Dynamic subtest gt_tlb: SUCCESS (14.616s) [353.460572] Starting dynamic subtest: requests [365.042246] Dynamic subtest requests: SUCCESS (11.590s) [365.052587] Starting dynamic subtest: migrate [369.710886] Dynamic subtest migrate: SUCCESS (4.667s) [369.720408] Starting dynamic subtest: active [371.209976] Dynamic subtest active: SUCCESS (1.498s) [371.220186] Starting dynamic subtest: objects [373.590833] Dynamic subtest objects: SUCCESS (2.380s) [373.601540] Starting dynamic subtest: mman [377.197066] Dynamic subtest mman: SUCCESS (3.605s) [377.210621] Starting dynamic subtest: dmabuf [378.740943] Dynamic subtest dmabuf: SUCCESS (1.543s) [378.750391] Starting dynamic subtest: vma [380.226931] Dynamic subtest vma: SUCCESS (1.485s) [380.236391] Starting dynamic subtest: coherency [388.681613] Dynamic subtest coherency: SUCCESS (8.453s) [388.691024] Starting dynamic subtest: gtt [398.739297] Dynamic subtest gtt: SUCCESS (10.056s) [398.748781] Starting dynamic subtest: gem [400.405861] Dynamic subtest gem: SUCCESS (1.665s) [400.415427] Starting dynamic subtest: evict [409.685990] Dynamic subtest evict: SUCCESS (9.279s) [409.695365] Starting dynamic subtest: hugepages [427.302414] Dynamic subtest hugepages: SUCCESS (17.615s) [427.312196] Starting dynamic subtest: gem_contexts [438.553212] Dynamic subtest gem_contexts: FAIL (10.995s) [438.561847] Starting dynamic subtest: client [439.816856] Dynamic subtest client: SUCCESS (1.516s) [439.826510] Starting dynamic subtest: gem_migrate [442.514660] Dynamic subtest gem_migrate: SUCCESS (2.700s) [442.525756] Starting dynamic subtest: reset [444.009840] Dynamic subtest reset: SUCCESS (1.489s) [444.019324] Starting dynamic subtest: memory_region [447.113815] Dynamic subtest memory_region: SUCCESS (3.102s) [447.123847] Starting dynamic subtest: hangcheck [468.596021] Dynamic subtest hangcheck: SUCCESS (21.480s) [468.605271] Starting dynamic subtest: execlists [470.071777] Dynamic subtest execlists: SUCCESS (1.474s) [470.081148] Starting dynamic subtest: ring_submission [471.558934] Dynamic subtest ring_submission: SUCCESS (1.486s) [471.568429] Starting dynamic subtest: perf [473.168033] Dynamic subtest perf: SUCCESS (1.607s) [473.177688] Starting dynamic subtest: slpc [479.164039] Dynamic subtest slpc: SUCCESS (5.994s) [479.173517] Starting dynamic subtest: guc [482.667765] Dynamic subtest guc: SUCCESS (3.502s) [482.677720] Starting dynamic subtest: guc_multi_lrc [484.171900] Dynamic subtest guc_multi_lrc: SUCCESS (1.503s) [484.181972] Starting dynamic subtest: guc_hang [486.453774] Dynamic subtest guc_hang: SUCCESS (2.280s) [486.463877] Starting dynamic subtest: late_gt_pm [487.974896] Dynamic subtest late_gt_pm: SUCCESS (1.520s) [487.975886] Subtest live: FAIL (220.643s) [488.025371] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [488.026447] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [488.028975] [070/156] (543s left) gem_eio (in-flight-contexts-10ms) [491.519659] Starting subtest: in-flight-contexts-10ms [504.951591] Subtest in-flight-contexts-10ms: SUCCESS (13.431s) [507.776075] [FACT gem_eio (in-flight-contexts-10ms)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [507.779622] [FACT gem_eio (in-flight-contexts-10ms)] new: kernel.kmod_is_loaded.i915: true [507.783243] [071/156] (523s left) gem_eio (wait-immediate) [507.917496] Starting subtest: wait-immediate [508.244560] Subtest wait-immediate: SUCCESS (0.327s) [510.550772] [072/156] (520s left) i915_pm_rc6_residency (media-rc6-accuracy) [510.598634] Starting subtest: media-rc6-accuracy [510.600241] Subtest media-rc6-accuracy: SKIP (0.000s) [510.716733] [073/156] (520s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [513.161047] Starting subtest: crc-primary-suspend-yf-tiled-ccs [513.161802] Starting dynamic subtest: pipe-A-HDMI-A-3 [513.164844] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [513.176269] Starting dynamic subtest: pipe-B-HDMI-A-3 [513.179206] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [513.190419] Starting dynamic subtest: pipe-C-HDMI-A-3 [513.193410] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [513.205081] Starting dynamic subtest: pipe-D-HDMI-A-3 [513.208202] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [513.209781] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.010s) [513.464792] [074/156] (518s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [515.887064] Starting subtest: 2x-cursor-vs-flip-legacy [515.889495] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s) [516.014756] [075/156] (515s left) kms_chamelium_hpd (dp-hpd) [518.655435] Subtest dp-hpd: SKIP (0.000s) [518.785573] [076/156] (512s left) gen9_exec_parse (unaligned-jump) [518.837947] Subtest unaligned-jump: SKIP (0.000s) [518.917315] [077/156] (512s left) kms_plane_cursor (viewport) [521.339145] Starting subtest: viewport [521.340653] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64 [524.355299] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.016s) [524.433262] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128 [527.340149] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (2.917s) [527.421993] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256 [530.290629] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (2.883s) [530.413061] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64 [533.446963] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.046s) [533.507967] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128 [536.579672] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.083s) [536.647296] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256 [539.713666] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.083s) [539.799984] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64 [543.035182] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.246s) [543.098549] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128 [546.136616] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.049s) [546.200983] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256 [549.401635] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.216s) [549.489040] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64 [552.712316] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.235s) [552.779914] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128 [555.895943] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.132s) [555.965900] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256 [559.212016] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.266s) [559.304471] Subtest viewport: SUCCESS (37.967s) [559.525623] [078/156] (472s left) sysfs_timeslice_duration (duration) [559.580494] Starting subtest: duration [559.581428] Starting dynamic subtest: vecs0 [572.721716] Dynamic subtest vecs0: SUCCESS (13.142s) [572.738084] Starting dynamic subtest: vcs0 [585.858856] Dynamic subtest vcs0: SUCCESS (13.134s) [585.873535] Starting dynamic subtest: bcs0 [598.993521] Dynamic subtest bcs0: SUCCESS (13.133s) [599.009247] Starting dynamic subtest: rcs0 [612.133529] Dynamic subtest rcs0: SUCCESS (13.138s) [612.149465] Starting dynamic subtest: vcs1 [625.272527] Dynamic subtest vcs1: SUCCESS (13.137s) [625.276196] Subtest duration: SUCCESS (65.697s) [625.407423] [079/156] (406s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [626.903907] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [626.905671] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [627.062415] [080/156] (404s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [628.561319] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [631.061147] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.500s) [631.256913] [081/156] (400s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [632.753133] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [632.754965] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [632.958471] [082/156] (399s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-pgflip-blt) [634.462268] Starting subtest: fbchdr-2p-primscrn-indfb-pgflip-blt [634.464183] Subtest fbchdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [634.716030] [083/156] (397s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [636.211412] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [636.212315] Starting dynamic subtest: pipe-A-HDMI-A-3 [636.234560] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s) [636.246338] Starting dynamic subtest: pipe-B-HDMI-A-3 [636.269099] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s) [636.280551] Starting dynamic subtest: pipe-C-HDMI-A-3 [636.303942] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s) [636.315652] Starting dynamic subtest: pipe-D-HDMI-A-3 [636.342975] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s) [636.344872] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.021s) [636.544985] [084/156] (395s left) kms_color (ctm-red-to-blue) [638.035747] Starting subtest: ctm-red-to-blue [638.036815] Starting dynamic subtest: pipe-A-HDMI-A-3 [638.713419] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.678s) [638.725542] Starting dynamic subtest: pipe-B-HDMI-A-3 [639.242489] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.527s) [639.254572] Starting dynamic subtest: pipe-C-HDMI-A-3 [639.766233] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.523s) [639.778052] Starting dynamic subtest: pipe-D-HDMI-A-3 [640.315048] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.548s) [640.315893] Subtest ctm-red-to-blue: SUCCESS (2.282s) [640.524535] [085/156] (391s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt) [642.020899] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt [642.023957] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [642.283748] [086/156] (390s left) kms_vrr (seamless-rr-switch-vrr) [643.774438] Starting subtest: seamless-rr-switch-vrr [643.776992] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [643.887071] [087/156] (388s left) kms_dsc (dsc-with-formats) [645.384473] Starting subtest: dsc-with-formats [645.402871] Subtest dsc-with-formats: SKIP (0.002s) [645.509110] [088/156] (387s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu) [647.014225] Starting subtest: fbchdr-rgb565-draw-mmap-cpu [647.015899] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [647.194895] [089/156] (385s left) kms_vblank (wait-forked-busy-hang) [648.684464] Starting subtest: wait-forked-busy-hang [648.685723] Starting dynamic subtest: pipe-A-HDMI-A-3 [675.486913] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.801s) [675.502646] Starting dynamic subtest: pipe-D-HDMI-A-3 [700.429844] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.939s) [700.432589] Subtest wait-forked-busy-hang: SUCCESS (51.748s) [700.635623] [090/156] (332s left) gem_madvise (dontneed-after-mmap) [700.679425] Starting subtest: dontneed-after-mmap [700.684391] Subtest dontneed-after-mmap: SUCCESS (0.004s) [700.846143] [091/156] (332s left) gem_ctx_param (invalid-set-ringsize) [700.894036] Starting subtest: invalid-set-ringsize [700.894925] Subtest invalid-set-ringsize: SUCCESS (0.000s) [701.051392] [092/156] (332s left) gem_mmap_offset (isolation) [701.096445] Starting subtest: isolation [701.102508] Subtest isolation: SUCCESS (0.005s) [701.269962] [093/156] (332s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [701.320498] Subtest writes-after-reads: SKIP (0.000s) [701.406188] [094/156] (331s left) gem_exec_reloc (basic-wc-gtt-active) [701.457243] Subtest basic-wc-gtt-active: SKIP (0.000s) [701.556874] [095/156] (331s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [703.046557] Starting subtest: plane-upscale-20x20-with-modifiers [703.047474] Starting dynamic subtest: pipe-A [703.810543] Dynamic subtest pipe-A: SUCCESS (0.764s) [703.828337] Starting dynamic subtest: pipe-B [704.584426] Dynamic subtest pipe-B: SUCCESS (0.772s) [704.604170] Starting dynamic subtest: pipe-C [705.374775] Dynamic subtest pipe-C: SUCCESS (0.788s) [705.396207] Starting dynamic subtest: pipe-D [706.165760] Dynamic subtest pipe-D: SUCCESS (0.789s) [706.166797] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (3.121s) [706.399989] [096/156] (327s left) gem_ctx_persistence (idempotent) [706.453067] Starting subtest: idempotent [706.454151] Subtest idempotent: SUCCESS (0.000s) [706.576861] [097/156] (326s left) kms_flip (flip-vs-modeset-vs-hang) [708.068289] Starting subtest: flip-vs-modeset-vs-hang [708.071270] Starting dynamic subtest: A-HDMI-A3 [759.447312] Dynamic subtest A-HDMI-A3: SUCCESS (51.371s) [759.462500] Starting dynamic subtest: D-HDMI-A3 [810.455227] Dynamic subtest D-HDMI-A3: SUCCESS (51.006s) [810.456218] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.385s) [810.659531] [098/156] (222s left) kms_universal_plane (universal-plane-sanity) [812.148884] Starting subtest: universal-plane-sanity [812.151358] Starting dynamic subtest: pipe-A-HDMI-A-3 [812.732649] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.582s) [812.746867] Starting dynamic subtest: pipe-B-HDMI-A-3 [813.136325] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.400s) [813.150730] Starting dynamic subtest: pipe-C-HDMI-A-3 [813.561409] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.422s) [813.575781] Starting dynamic subtest: pipe-D-HDMI-A-3 [813.992788] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.429s) [813.995407] Subtest universal-plane-sanity: SUCCESS (1.845s) [814.200242] [099/156] (219s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [815.695854] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt [815.697766] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [815.871760] [100/156] (217s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [817.367963] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [817.369840] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [817.566345] [101/156] (216s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [819.062620] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [819.064634] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [819.274280] [102/156] (214s left) gem_exec_reloc (basic-write-cpu) [819.326339] Subtest basic-write-cpu: SKIP (0.000s) [819.447317] [103/156] (214s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [820.943721] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [820.945372] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [821.114644] [104/156] (213s left) kms_joiner (basic-force-ultra-joiner) [822.608202] Starting subtest: basic-force-ultra-joiner [822.609987] Subtest basic-force-ultra-joiner: SKIP (0.000s) [822.750689] [105/156] (211s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [824.246471] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [824.247550] Starting dynamic subtest: pipe-A-HDMI-A-3 [824.260419] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [824.272745] Starting dynamic subtest: pipe-B-HDMI-A-3 [824.281053] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [824.293126] Starting dynamic subtest: pipe-C-HDMI-A-3 [824.301414] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [824.313281] Starting dynamic subtest: pipe-D-HDMI-A-3 [824.321748] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [824.323356] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.010s) [824.551402] [106/156] (209s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [826.048417] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [826.050336] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [826.200321] [107/156] (208s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt) [827.702948] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt [827.704915] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [827.892259] [108/156] (206s left) gem_exec_schedule (pi-shared-iova) [828.114317] Starting subtest: pi-shared-iova [828.118811] Starting dynamic subtest: rcs0 [828.291148] Dynamic subtest rcs0: SUCCESS (0.171s) [828.303480] Starting dynamic subtest: bcs0 [828.390500] Dynamic subtest bcs0: SUCCESS (0.102s) [828.404733] Starting dynamic subtest: vcs0 [828.515209] Dynamic subtest vcs0: SUCCESS (0.119s) [828.527513] Starting dynamic subtest: vcs1 [828.638364] Dynamic subtest vcs1: SUCCESS (0.122s) [828.650824] Starting dynamic subtest: vecs0 [828.756385] Dynamic subtest vecs0: SUCCESS (0.120s) [828.757270] Subtest pi-shared-iova: SUCCESS (0.643s) [829.077726] [109/156] (205s left) gem_exec_balancer (bonded-pair) [829.137366] Starting subtest: bonded-pair [829.139386] Subtest bonded-pair: SKIP (0.000s) [829.622681] [110/156] (205s left) kms_flip (bo-too-big-interruptible) [831.117485] Starting subtest: bo-too-big-interruptible [831.124946] Starting dynamic subtest: A-HDMI-A3 [831.360935] Dynamic subtest A-HDMI-A3: SUCCESS (0.236s) [831.378452] Starting dynamic subtest: B-HDMI-A3 [831.528839] Dynamic subtest B-HDMI-A3: SUCCESS (0.166s) [831.543808] Starting dynamic subtest: C-HDMI-A3 [831.682331] Dynamic subtest C-HDMI-A3: SUCCESS (0.152s) [831.695995] Starting dynamic subtest: D-HDMI-A3 [831.835480] Dynamic subtest D-HDMI-A3: SUCCESS (0.151s) [831.838051] Subtest bo-too-big-interruptible: SUCCESS (0.720s) [832.117428] [111/156] (202s left) syncobj_wait (invalid-reset-one-illegal-handle) [832.165787] Starting subtest: invalid-reset-one-illegal-handle [832.166707] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [832.288708] [112/156] (202s left) perf (invalid-oa-format-id) [832.411159] Starting subtest: invalid-oa-format-id [832.436619] Subtest invalid-oa-format-id: SUCCESS (0.025s) [832.508551] [113/156] (202s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [833.998451] Starting subtest: plane-downscale-factor-0-75-with-modifiers [833.999347] Starting dynamic subtest: pipe-A [834.791796] Dynamic subtest pipe-A: SUCCESS (0.793s) [834.812354] Starting dynamic subtest: pipe-B [835.582605] Dynamic subtest pipe-B: SUCCESS (0.789s) [835.599656] Starting dynamic subtest: pipe-C [836.356708] Dynamic subtest pipe-C: SUCCESS (0.772s) [836.375145] Starting dynamic subtest: pipe-D [837.129588] Dynamic subtest pipe-D: SUCCESS (0.771s) [837.130655] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (3.133s) [837.385237] [114/156] (197s left) gem_mmap_wc (bad-size) [837.434047] Subtest bad-size: SKIP (0.000s) [837.516450] [115/156] (197s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite) [839.016924] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite [839.018785] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [839.217439] [116/156] (196s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [839.264333] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [839.375801] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [839.558451] [117/156] (195s left) gem_exec_balancer (semaphore) [839.616534] Starting subtest: semaphore [841.634248] Subtest semaphore: SUCCESS (2.019s) [842.094426] [118/156] (193s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [843.590618] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [843.592204] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [843.767882] [119/156] (191s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc) [845.263109] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc [845.264957] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [845.464578] [120/156] (190s left) prime_mmap (test_refcounting) [845.511384] Starting subtest: test_refcounting [845.512265] Starting dynamic subtest: test_refcounting-smem [845.574461] Dynamic subtest test_refcounting-smem: SUCCESS (0.063s) [845.588235] Starting dynamic subtest: test_refcounting-lmem0 [845.638441] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.062s) [845.639398] Subtest test_refcounting: SUCCESS (0.128s) [845.753423] [121/156] (190s left) gem_exec_fence (syncobj-signal) [846.208472] Starting subtest: syncobj-signal [846.229255] Subtest syncobj-signal: SUCCESS (0.022s) [846.683514] [122/156] (189s left) kms_atomic (crtc-invalid-params) [848.173346] Starting subtest: crtc-invalid-params [848.174392] Starting dynamic subtest: pipe-A-HDMI-A-3 [848.494286] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.319s) [848.495186] Subtest crtc-invalid-params: SUCCESS (0.322s) [848.699674] [123/156] (187s left) gem_pxp (verify-pxp-stale-ctx-execution) [851.274204] Starting subtest: verify-pxp-stale-ctx-execution [851.276288] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [851.445749] [124/156] (184s left) i915_hangman (engine-error-state-capture) [851.505870] Starting subtest: engine-error-state-capture [851.506886] Starting dynamic subtest: rcs0 [853.467577] Dynamic subtest rcs0: SUCCESS (1.961s) [853.481816] Starting dynamic subtest: bcs0 [857.486411] Dynamic subtest bcs0: SUCCESS (4.017s) [857.501651] Starting dynamic subtest: vcs0 [861.447404] Dynamic subtest vcs0: SUCCESS (3.959s) [861.461892] Starting dynamic subtest: vcs1 [865.485392] Dynamic subtest vcs1: SUCCESS (4.036s) [865.500685] Starting dynamic subtest: vecs0 [869.457440] Dynamic subtest vecs0: SUCCESS (3.970s) [869.458535] Subtest engine-error-state-capture: SUCCESS (17.952s) [869.628461] [125/156] (166s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [871.124233] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [871.125944] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [871.295282] [126/156] (164s left) kms_psr (psr-sprite-mmap-cpu) [872.785435] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [872.867910] [127/156] (163s left) gem_ctx_sseu (invalid-args) [872.918771] Subtest invalid-args: SKIP (0.000s) [873.010504] [128/156] (163s left) gem_ctx_engines (independent) [873.067607] Starting subtest: independent [873.068658] Starting dynamic subtest: rcs0 [873.273600] Dynamic subtest rcs0: SUCCESS (0.201s) [873.286254] Starting dynamic subtest: bcs0 [873.469572] Dynamic subtest bcs0: SUCCESS (0.195s) [873.482257] Starting dynamic subtest: vcs0 [873.669523] Dynamic subtest vcs0: SUCCESS (0.198s) [873.682177] Starting dynamic subtest: vcs1 [873.865539] Dynamic subtest vcs1: SUCCESS (0.194s) [873.878157] Starting dynamic subtest: vecs0 [874.064647] Dynamic subtest vecs0: SUCCESS (0.198s) [874.077506] Starting dynamic subtest: all-engines [874.389624] Dynamic subtest all-engines: SUCCESS (0.324s) [874.390740] Subtest independent: SUCCESS (1.319s) [875.026787] [129/156] (161s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [876.516458] Starting subtest: cursorB-vs-flipA-varying-size [876.519903] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s) [876.663332] [130/156] (159s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [878.165145] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu [878.167232] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [878.336658] [131/156] (158s left) kms_big_fb (4-tiled-32bpp-rotate-180) [879.845974] Starting subtest: 4-tiled-32bpp-rotate-180 [879.847808] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [880.051829] [132/156] (156s left) kms_cursor_crc (cursor-rapid-movement-32x10) [881.651966] Starting subtest: cursor-rapid-movement-32x10 [881.708068] Subtest cursor-rapid-movement-32x10: SKIP (0.053s) [882.087472] [133/156] (154s left) gen9_exec_parse (bb-start-param) [882.139647] Subtest bb-start-param: SKIP (0.000s) [882.219973] [134/156] (154s left) kms_big_fb (linear-64bpp-rotate-0) [883.729047] Starting subtest: linear-64bpp-rotate-0 [886.309341] Subtest linear-64bpp-rotate-0: SUCCESS (2.576s) [886.552831] [135/156] (150s left) core_getversion (basic) [886.598113] Starting subtest: basic [886.600615] Subtest basic: SUCCESS (0.000s) [886.720531] [136/156] (150s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt) [888.215513] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt [888.217198] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [888.422833] [137/156] (148s left) prime_vgem (sync) [888.512851] Starting subtest: sync [888.513841] Starting dynamic subtest: rcs0 [888.586089] Dynamic subtest rcs0: SUCCESS (0.072s) [888.600559] Starting dynamic subtest: bcs0 [888.646303] Dynamic subtest bcs0: SUCCESS (0.059s) [888.662544] Starting dynamic subtest: vcs0 [888.690035] Dynamic subtest vcs0: SUCCESS (0.042s) [888.707181] Starting dynamic subtest: vcs1 [888.733228] Dynamic subtest vcs1: SUCCESS (0.041s) [888.752703] Starting dynamic subtest: vecs0 [888.775805] Dynamic subtest vecs0: SUCCESS (0.041s) [888.776906] Subtest sync: SUCCESS (0.264s) [888.962748] [138/156] (148s left) gem_exec_store (dword) [889.021338] Starting subtest: dword [889.022275] Starting dynamic subtest: rcs0 [889.079136] Dynamic subtest rcs0: SUCCESS (0.057s) [889.097178] Starting dynamic subtest: bcs0 [889.121333] Dynamic subtest bcs0: SUCCESS (0.040s) [889.137600] Starting dynamic subtest: vcs0 [889.165114] Dynamic subtest vcs0: SUCCESS (0.042s) [889.183400] Starting dynamic subtest: vcs1 [889.208244] Dynamic subtest vcs1: SUCCESS (0.041s) [889.231500] Starting dynamic subtest: vecs0 [889.253355] Dynamic subtest vecs0: SUCCESS (0.043s) [889.254614] Subtest dword: SUCCESS (0.233s) [889.586010] [139/156] (147s left) kms_cursor_crc (cursor-onscreen-512x170) [891.365870] Starting subtest: cursor-onscreen-512x170 [891.369190] Subtest cursor-onscreen-512x170: SKIP (0.001s) [891.654696] [140/156] (145s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [893.145497] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [893.147450] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [893.272157] [141/156] (144s left) kms_prop_blob (blob-prop-core) [893.330082] Starting subtest: blob-prop-core [893.331041] Subtest blob-prop-core: SUCCESS (0.000s) [893.461469] [142/156] (144s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt) [894.956910] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt [894.958898] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [895.127649] [143/156] (142s left) perf_pmu (rc6) [895.178604] Starting subtest: rc6 [895.179691] Starting dynamic subtest: gt0 [901.522714] Dynamic subtest gt0: SUCCESS (6.339s) [901.535784] Starting dynamic subtest: runtime-pm-gt0 [909.132457] Dynamic subtest runtime-pm-gt0: SUCCESS (7.605s) [909.145444] Starting dynamic subtest: runtime-pm-long-gt0 [921.698195] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.565s) [921.711394] Starting dynamic subtest: other-idle-gt0 [921.713314] Dynamic subtest other-idle-gt0: SKIP (0.000s) [921.714399] Subtest rc6: SUCCESS (26.518s) [922.489058] [144/156] (115s left) kms_addfb_basic (master-rmfb) [922.535946] Starting subtest: master-rmfb [922.536961] Subtest master-rmfb: SUCCESS (0.001s) [924.089185] [145/156] (113s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu) [925.591115] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu [925.593051] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [925.685312] [146/156] (112s left) gem_mmap_gtt (basic-wc) [925.732870] Subtest basic-wc: SKIP (0.000s) [925.812916] [147/156] (112s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [927.308326] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [927.310334] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [927.400439] [148/156] (110s left) api_intel_bb (simple-bb-ctx) [927.446887] Starting subtest: simple-bb-ctx [927.468742] Subtest simple-bb-ctx: SUCCESS (0.023s) [927.605100] [149/156] (110s left) kms_flip (wf_vblank-ts-check-interruptible) [929.099243] Starting subtest: wf_vblank-ts-check-interruptible [929.106633] Starting dynamic subtest: A-HDMI-A3 [937.131497] Dynamic subtest A-HDMI-A3: SUCCESS (8.024s) [937.147602] Starting dynamic subtest: B-HDMI-A3 [945.096721] Dynamic subtest B-HDMI-A3: SUCCESS (7.963s) [945.111786] Starting dynamic subtest: C-HDMI-A3 [953.065377] Dynamic subtest C-HDMI-A3: SUCCESS (7.966s) [953.080290] Starting dynamic subtest: D-HDMI-A3 [961.035189] Dynamic subtest D-HDMI-A3: SUCCESS (7.968s) [961.037885] Subtest wf_vblank-ts-check-interruptible: SUCCESS (31.938s) [961.258159] [150/156] ( 77s left) kms_content_protection (lic-type-0-hdcp14) [962.804535] Starting subtest: lic-type-0-hdcp14 [962.808904] Subtest lic-type-0-hdcp14: SKIP (0.002s) [962.951990] [151/156] ( 75s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move) [964.447968] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move [964.450089] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [964.544022] [152/156] ( 74s left) gem_partial_pwrite_pread (write-uncached) [964.603240] Subtest write-uncached: SKIP (0.000s) [964.711657] [153/156] ( 73s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [966.208157] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [966.210146] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [966.322256] [154/156] ( 72s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [966.381877] Starting subtest: multi-wait-for-submit-available-submitted [966.387637] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [966.459339] [155/156] ( 72s left) syncobj_timeline (multi-wait-all-signaled) [966.506148] Starting subtest: multi-wait-all-signaled [966.507149] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [966.596132] [156/156] ( 72s left) kms_addfb_basic (bo-too-small) [968.087497] Starting subtest: bo-too-small [968.088365] Subtest bo-too-small: SUCCESS (0.000s) [968.208283] Closing watchdogs results: parsing output: 0/ for test: kms_chamelium_audio results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_addfb_basic results: parsing output: 3/ for test: kms_legacy_colorkey results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: gem_ctx_bad_destroy results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_ccs results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_fbcon_fbt results: parsing output: 15/ for test: kms_psr2_sf results: parsing output: 16/ for test: gem_lmem_swapping results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: gem_wait results: parsing output: 19/ for test: kms_psr2_su results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_ctx_param results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_psr2_sf results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_exec_schedule results: parsing output: 29/ for test: kms_addfb_basic results: parsing output: 30/ for test: gem_render_copy_redux results: parsing output: 31/ for test: gem_softpin results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_set_tiling_vs_blt results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: kms_chamelium_edid results: parsing output: 36/ for test: fbdev results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_busy results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_cursor_legacy results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: kms_rotation_crc results: parsing output: 43/ for test: syncobj_wait results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_exec_params results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: perf_pmu results: parsing output: 51/ for test: kms_plane results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_dp_link_training results: parsing output: 54/ for test: kms_pm_rpm results: parsing output: 55/ for test: gem_softpin results: parsing output: 56/ for test: kms_cursor_crc results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_plane results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_lmem_swapping results: parsing output: 61/ for test: api_intel_allocator results: parsing output: 62/ for test: prime_self_import results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_exec_fence results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: i915_selftest results: parsing output: 69/ for test: gem_eio results: parsing output: 70/ for test: gem_eio results: parsing output: 71/ for test: i915_pm_rc6_residency results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_cursor_legacy results: parsing output: 74/ for test: kms_chamelium_hpd results: parsing output: 75/ for test: gen9_exec_parse results: parsing output: 76/ for test: kms_plane_cursor results: parsing output: 77/ for test: sysfs_timeslice_duration results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_ccs results: parsing output: 83/ for test: kms_color results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_vrr results: parsing output: 86/ for test: kms_dsc results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_vblank results: parsing output: 89/ for test: gem_madvise results: parsing output: 90/ for test: gem_ctx_param results: parsing output: 91/ for test: gem_mmap_offset results: parsing output: 92/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 93/ for test: gem_exec_reloc results: parsing output: 94/ for test: kms_plane_scaling results: parsing output: 95/ for test: gem_ctx_persistence results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: kms_universal_plane results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_exec_reloc results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_joiner results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: gem_exec_balancer results: parsing output: 109/ for test: kms_flip results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: perf results: parsing output: 112/ for test: kms_plane_scaling results: parsing output: 113/ for test: gem_mmap_wc results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: gem_exec_balancer results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: prime_mmap results: parsing output: 120/ for test: gem_exec_fence results: parsing output: 121/ for test: kms_atomic results: parsing output: 122/ for test: gem_pxp results: parsing output: 123/ for test: i915_hangman results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: gem_ctx_sseu results: parsing output: 127/ for test: gem_ctx_engines results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: kms_cursor_crc results: parsing output: 132/ for test: gen9_exec_parse results: parsing output: 133/ for test: kms_big_fb results: parsing output: 134/ for test: core_getversion results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: gem_exec_store results: parsing output: 138/ for test: kms_cursor_crc results: parsing output: 139/ for test: kms_flip_scaled_crc results: parsing output: 140/ for test: kms_prop_blob results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: perf_pmu results: parsing output: 143/ for test: kms_addfb_basic results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: gem_mmap_gtt results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: api_intel_bb results: parsing output: 148/ for test: kms_flip results: parsing output: 149/ for test: kms_content_protection results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: gem_partial_pwrite_pread results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: syncobj_timeline results: parsing output: 154/ for test: syncobj_timeline results: parsing output: 155/ for test: kms_addfb_basic Done.