[46.340171] Initializing watchdogs [46.340240] /dev/watchdog0 [46.357571] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [46.363697] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [46.366632] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [46.369059] [001/156] (960s left) kms_flip (2x-flip-vs-wf_vblank) [46.465251] Starting subtest: 2x-flip-vs-wf_vblank [46.474733] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s) [46.534738] [002/156] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [46.627447] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [46.628829] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [46.720662] [003/156] (960s left) kms_joiner (basic-ultra-joiner) [46.810807] Starting subtest: basic-ultra-joiner [46.812289] Subtest basic-ultra-joiner: SKIP (0.000s) [46.869362] [004/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy) [46.970895] Starting subtest: fbcpsrhdr-modesetfrombusy [46.972380] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s) [47.064127] [005/156] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [47.157134] Starting subtest: fbcpsr-rgb565-draw-blt [47.158484] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [47.234687] [006/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render) [47.329401] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render [47.330797] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [47.420976] [007/156] (959s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [47.456413] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [47.457879] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [47.529565] [008/156] (959s left) gem_mmap (bad-object) [47.563668] Starting subtest: bad-object [47.564394] Subtest bad-object: SUCCESS (0.000s) [47.659319] [009/156] (959s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [47.692091] Starting subtest: invalid-multi-wait-all-unsubmitted [47.692807] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [47.761140] [010/156] (959s left) i915_query (query-topology-coherent-slice-mask) [47.794571] Starting subtest: query-topology-coherent-slice-mask [47.795508] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s) [47.869854] [011/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [47.962143] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [47.963511] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [48.045642] [012/156] (959s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [48.080461] Starting subtest: etime-multi-wait-available-unsubmitted [48.182789] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s) [48.258343] [013/156] (959s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [48.346413] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [48.347127] Starting dynamic subtest: pipe-A-valid-mode [49.186313] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.839s) [49.187096] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.840s) [49.330093] [014/156] (958s left) kms_addfb_basic (too-high) [49.424656] Starting subtest: too-high [49.425353] Subtest too-high: SUCCESS (0.001s) [49.520363] [015/156] (957s left) prime_vgem (fence-flip-hang) [49.593469] Subtest fence-flip-hang: SKIP (0.000s) [49.693360] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [49.694906] [016/156] (957s left) gem_mmap_gtt (big-bo) [49.727259] Starting subtest: big-bo [50.039304] Subtest big-bo: SUCCESS (0.312s) [50.144811] [017/156] (957s left) i915_drm_fdinfo (busy-idle) [50.238034] Starting subtest: busy-idle [50.238747] Starting dynamic subtest: rcs0 [50.860129] Dynamic subtest rcs0: SUCCESS (0.620s) [50.868134] Starting dynamic subtest: bcs0 [51.482481] Dynamic subtest bcs0: SUCCESS (0.624s) [51.491659] Starting dynamic subtest: vcs0 [52.106057] Dynamic subtest vcs0: SUCCESS (0.621s) [52.113931] Starting dynamic subtest: vcs1 [52.727269] Dynamic subtest vcs1: SUCCESS (0.622s) [52.736665] Starting dynamic subtest: vecs0 [53.354251] Dynamic subtest vecs0: SUCCESS (0.626s) [53.355209] Subtest busy-idle: SUCCESS (3.116s) [53.427046] [018/156] (954s left) kms_chamelium_hpd (hdmi-hpd) [53.577393] Subtest hdmi-hpd: SKIP (0.000s) [53.678421] [019/156] (953s left) gem_exec_fence (submit3) [53.849816] Starting subtest: submit3 [53.850770] Starting dynamic subtest: rcs0 [53.862212] Dynamic subtest rcs0: SUCCESS (0.012s) [53.876693] Starting dynamic subtest: bcs0 [53.877412] Dynamic subtest bcs0: SUCCESS (0.010s) [53.885144] Starting dynamic subtest: vcs0 [53.885927] Dynamic subtest vcs0: SUCCESS (0.005s) [53.892302] Starting dynamic subtest: vcs1 [53.892998] Dynamic subtest vcs1: SUCCESS (0.005s) [53.898793] Starting dynamic subtest: vecs0 [53.899481] Dynamic subtest vecs0: SUCCESS (0.004s) [53.900175] Subtest submit3: SUCCESS (0.037s) [54.351968] [020/156] (953s left) gem_exec_whisper (basic-queues) [54.395597] Starting subtest: basic-queues [56.174847] Subtest basic-queues: SUCCESS (1.778s) [56.354120] [021/156] (951s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw) [56.448323] Starting subtest: hdr-2p-pri-indfb-multidraw [56.449677] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s) [56.541839] [022/156] (951s left) vgem_basic (busy-fence) [56.582238] Starting subtest: busy-fence [56.582944] Subtest busy-fence: SUCCESS (0.000s) [56.654090] [023/156] (951s left) dmabuf_sync_file (export-multiwait) [56.691278] Starting subtest: export-multiwait [56.692058] Subtest export-multiwait: SUCCESS (0.001s) [56.766708] [024/156] (951s left) syncobj_timeline (wait-any-interrupted) [56.809457] Starting subtest: wait-any-interrupted [56.918979] Subtest wait-any-interrupted: SUCCESS (0.109s) [56.995690] [025/156] (950s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite) [57.087350] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite [57.088760] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [57.196796] [026/156] (950s left) gem_partial_pwrite_pread (write-display) [57.234798] Starting subtest: write-display [67.890212] Subtest write-display: SUCCESS (10.656s) [68.008333] [027/156] (939s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [68.102235] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [68.103564] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [68.186287] [028/156] (939s left) kms_cursor_crc (cursor-dpms) [68.280766] Starting subtest: cursor-dpms [68.282228] Starting dynamic subtest: pipe-A-HDMI-A-1 [68.908469] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.626s) [68.916669] Starting dynamic subtest: pipe-D-HDMI-A-1 [69.505164] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.595s) [69.505936] Subtest cursor-dpms: SUCCESS (1.224s) [69.667733] [029/156] (938s left) gem_mmap_gtt (basic-write) [69.705838] Starting subtest: basic-write [69.838442] Subtest basic-write: SUCCESS (0.125s) [69.913876] [030/156] (938s left) kms_psr (pr-primary-render) [70.004238] Subtest pr-primary-render: SKIP (0.000s) [70.044223] [031/156] (938s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [70.132619] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [70.133345] Starting dynamic subtest: pipe-A-HDMI-A-1 [70.792970] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.656s) [70.807420] Starting dynamic subtest: pipe-B-HDMI-A-1 [71.294230] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.499s) [71.308587] Starting dynamic subtest: pipe-C-HDMI-A-1 [71.803123] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.507s) [71.817933] Starting dynamic subtest: pipe-D-HDMI-A-1 [72.322491] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.516s) [72.323638] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.186s) [72.526628] [032/156] (935s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [72.616417] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [72.617805] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [72.690374] [033/156] (935s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt) [72.784472] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt [72.785846] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [72.900369] [034/156] (935s left) prime_vgem (fence-write-hang) [72.965083] Subtest fence-write-hang: SKIP (0.000s) [73.063374] [035/156] (935s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [73.097359] Starting subtest: etime-single-wait-available-unsubmitted [73.198814] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s) [73.265423] [036/156] (934s left) kms_plane (plane-panning-top-left) [73.353515] Starting subtest: plane-panning-top-left [73.354205] Starting dynamic subtest: pipe-A [73.720808] Dynamic subtest pipe-A: SUCCESS (0.366s) [73.728311] Starting dynamic subtest: pipe-B [74.106152] Dynamic subtest pipe-B: SUCCESS (0.384s) [74.106855] Subtest plane-panning-top-left: SUCCESS (0.753s) [74.269833] [037/156] (934s left) perf_pmu (busy-accuracy-2) [74.310292] Starting subtest: busy-accuracy-2 [74.311008] Starting dynamic subtest: rcs0 [77.343663] Dynamic subtest rcs0: SUCCESS (3.030s) [77.351568] Starting dynamic subtest: bcs0 [80.375649] Dynamic subtest bcs0: SUCCESS (3.032s) [80.384086] Starting dynamic subtest: vcs0 [83.409803] Dynamic subtest vcs0: SUCCESS (3.034s) [83.420407] Starting dynamic subtest: vcs1 [86.445355] Dynamic subtest vcs1: SUCCESS (3.032s) [86.454427] Starting dynamic subtest: vecs0 [89.476850] Dynamic subtest vecs0: SUCCESS (3.029s) [89.477913] Subtest busy-accuracy-2: SUCCESS (15.160s) [89.540521] [038/156] (918s left) kms_big_fb (linear-8bpp-rotate-90) [89.642915] Starting subtest: linear-8bpp-rotate-90 [89.721091] Subtest linear-8bpp-rotate-90: SKIP (0.077s) [89.825143] [039/156] (918s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move) [89.916270] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move [89.917721] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [90.009223] [040/156] (918s left) gem_fenced_exec_thrash (no-spare-fences) [90.045629] Starting subtest: no-spare-fences [92.200806] Subtest no-spare-fences: SUCCESS (2.153s) [92.311721] [041/156] (916s left) perf (short-reads) [92.412751] Starting subtest: short-reads [92.426626] Subtest short-reads: SUCCESS (0.014s) [92.465215] [042/156] (916s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [92.504398] Starting subtest: y-tiled-ccs-to-y-tiled [92.505219] Starting dynamic subtest: smem [92.610831] Dynamic subtest smem: SUCCESS (0.106s) [92.611576] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.106s) [92.798072] [043/156] (915s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [92.888781] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [92.889528] Starting dynamic subtest: pipe-A-HDMI-A-1 [92.892403] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [92.899815] Starting dynamic subtest: pipe-B-HDMI-A-1 [92.902723] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [92.910066] Starting dynamic subtest: pipe-C-HDMI-A-1 [92.912876] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [92.920105] Starting dynamic subtest: pipe-D-HDMI-A-1 [92.922900] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [92.924299] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s) [93.158912] [044/156] (915s left) kms_atomic_transition (plane-all-transition-fencing) [93.248065] Starting subtest: plane-all-transition-fencing [93.248832] Starting dynamic subtest: pipe-A-HDMI-A-1 [95.197173] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.947s) [95.279689] Starting dynamic subtest: pipe-B-HDMI-A-1 [97.335626] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.062s) [97.410927] Subtest plane-all-transition-fencing: SUCCESS (4.161s) [97.577129] [045/156] (911s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [97.621450] Starting subtest: yf-tiled-to-vebox-y-tiled [97.622164] Starting dynamic subtest: smem [97.722273] Dynamic subtest smem: SUCCESS (0.100s) [97.723038] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.101s) [97.904340] [046/156] (910s left) kms_tiled_display (basic-test-pattern) [98.030471] Subtest basic-test-pattern: SKIP (0.000s) [98.071999] [047/156] (910s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [98.165407] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [98.166887] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [98.262861] [048/156] (910s left) kms_big_fb (x-tiled-addfb-size-overflow) [98.359751] Starting subtest: x-tiled-addfb-size-overflow [98.360487] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s) [98.440873] [049/156] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [98.535141] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [98.536525] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [98.626735] [050/156] (910s left) kms_cursor_edge_walk (128x128-top-edge) [98.714893] Starting subtest: 128x128-top-edge [98.716632] Starting dynamic subtest: pipe-A-HDMI-A-1 [100.485999] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.770s) [100.495010] Starting dynamic subtest: pipe-D-HDMI-A-1 [102.172814] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.684s) [102.173610] Subtest 128x128-top-edge: SUCCESS (3.457s) [102.290625] [051/156] (906s left) i915_selftest (live) [103.194799] Starting subtest: live [103.195713] Starting dynamic subtest: sanitycheck [104.464775] Dynamic subtest sanitycheck: SUCCESS (1.262s) [104.471820] Starting dynamic subtest: uncore [105.684679] Dynamic subtest uncore: SUCCESS (1.218s) [105.691644] Starting dynamic subtest: workarounds [107.194737] Dynamic subtest workarounds: SUCCESS (1.508s) [107.201918] Starting dynamic subtest: gt_engines [108.941719] Dynamic subtest gt_engines: SUCCESS (1.745s) [108.948856] Starting dynamic subtest: gt_timelines [118.080777] Dynamic subtest gt_timelines: SUCCESS (9.136s) [118.087682] Starting dynamic subtest: gt_contexts [119.415793] Dynamic subtest gt_contexts: SUCCESS (1.333s) [119.423453] Starting dynamic subtest: gt_lrc [123.636879] Dynamic subtest gt_lrc: SUCCESS (4.219s) [123.648224] Starting dynamic subtest: gt_mocs [125.002892] Dynamic subtest gt_mocs: SUCCESS (1.364s) [125.009524] Starting dynamic subtest: gt_pm [146.402584] Dynamic subtest gt_pm: SUCCESS (21.398s) [146.411486] Starting dynamic subtest: gt_heartbeat [147.640653] Dynamic subtest gt_heartbeat: SUCCESS (1.236s) [147.647648] Starting dynamic subtest: gt_tlb [151.097549] Dynamic subtest gt_tlb: SUCCESS (3.455s) [151.104606] Starting dynamic subtest: requests [159.708767] Dynamic subtest requests: SUCCESS (8.610s) [159.715589] Starting dynamic subtest: migrate [163.965217] Dynamic subtest migrate: SUCCESS (4.264s) [163.979157] Starting dynamic subtest: active [165.203852] Dynamic subtest active: SUCCESS (1.228s) [165.215214] Starting dynamic subtest: objects [166.900796] Dynamic subtest objects: SUCCESS (1.695s) [166.912159] Starting dynamic subtest: mman [171.582559] Dynamic subtest mman: SUCCESS (4.680s) [171.589869] Starting dynamic subtest: dmabuf [172.846714] Dynamic subtest dmabuf: SUCCESS (1.262s) [172.854407] Starting dynamic subtest: vma [174.121591] Dynamic subtest vma: SUCCESS (1.273s) [174.132787] Starting dynamic subtest: coherency [176.906746] Dynamic subtest coherency: SUCCESS (2.783s) [176.913737] Starting dynamic subtest: gtt [185.261691] Dynamic subtest gtt: SUCCESS (8.353s) [185.268648] Starting dynamic subtest: gem [187.392788] Dynamic subtest gem: SUCCESS (2.129s) [187.399982] Starting dynamic subtest: evict [189.635577] Dynamic subtest evict: SUCCESS (2.241s) [189.642775] Starting dynamic subtest: hugepages [197.348696] Dynamic subtest hugepages: SUCCESS (7.712s) [197.356052] Starting dynamic subtest: gem_contexts [212.725636] Dynamic subtest gem_contexts: SUCCESS (15.376s) [212.733208] Starting dynamic subtest: client [214.016678] Dynamic subtest client: SUCCESS (1.289s) [214.023794] Starting dynamic subtest: gem_migrate [215.222805] Dynamic subtest gem_migrate: SUCCESS (1.204s) [215.230439] Starting dynamic subtest: reset [220.189770] Dynamic subtest reset: SUCCESS (4.965s) [220.202676] Starting dynamic subtest: memory_region [221.388615] Dynamic subtest memory_region: SUCCESS (1.196s) [221.396321] Starting dynamic subtest: hangcheck [251.394797] Dynamic subtest hangcheck: SUCCESS (30.005s) [251.401336] Starting dynamic subtest: execlists [265.128648] Dynamic subtest execlists: SUCCESS (13.732s) [265.136666] Starting dynamic subtest: ring_submission [266.323702] Dynamic subtest ring_submission: SUCCESS (1.193s) [266.335767] Starting dynamic subtest: perf [267.650770] Dynamic subtest perf: SUCCESS (1.325s) [267.659127] Starting dynamic subtest: slpc [268.857566] Dynamic subtest slpc: SUCCESS (1.204s) [268.865094] Starting dynamic subtest: guc [270.051581] Dynamic subtest guc: SUCCESS (1.192s) [270.058624] Starting dynamic subtest: guc_multi_lrc [271.260885] Dynamic subtest guc_multi_lrc: SUCCESS (1.207s) [271.267836] Starting dynamic subtest: guc_hang [272.472575] Dynamic subtest guc_hang: SUCCESS (1.209s) [272.479737] Starting dynamic subtest: late_gt_pm [273.742494] Dynamic subtest late_gt_pm: SUCCESS (1.268s) [273.743436] Subtest live: SUCCESS (170.550s) [273.765815] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [273.766597] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [273.768980] [052/156] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [274.868380] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [276.188225] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.320s) [276.316524] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [276.317869] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true [276.320647] [053/156] (732s left) gem_ctx_persistence (engines-mixed-process) [276.362911] Starting subtest: engines-mixed-process [276.363658] Starting dynamic subtest: rcs0 [276.739848] Dynamic subtest rcs0: SUCCESS (0.377s) [276.756024] Starting dynamic subtest: bcs0 [277.152837] Dynamic subtest bcs0: SUCCESS (0.410s) [277.165319] Starting dynamic subtest: vcs0 [277.512706] Dynamic subtest vcs0: SUCCESS (0.356s) [277.528587] Starting dynamic subtest: vcs1 [277.861640] Dynamic subtest vcs1: SUCCESS (0.347s) [277.877296] Starting dynamic subtest: vecs0 [278.221903] Dynamic subtest vecs0: SUCCESS (0.358s) [278.225257] Subtest engines-mixed-process: SUCCESS (1.861s) [278.324965] [054/156] (730s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [278.426688] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [278.428130] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [278.530022] [055/156] (730s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [278.622053] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [278.623838] Starting dynamic subtest: pipe-A-HDMI-A-1 [278.630701] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [278.638681] Starting dynamic subtest: pipe-B-HDMI-A-1 [278.645876] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [278.653771] Starting dynamic subtest: pipe-C-HDMI-A-1 [278.660779] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [278.668709] Starting dynamic subtest: pipe-D-HDMI-A-1 [278.675729] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [278.677097] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.006s) [278.875134] [056/156] (730s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render) [278.971079] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render [278.972537] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [279.069751] [057/156] (730s left) gem_exec_schedule (u-semaphore-user) [279.117907] Starting subtest: u-semaphore-user [279.128346] Subtest u-semaphore-user: SUCCESS (0.010s) [279.436086] [058/156] (729s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [279.534527] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [280.149223] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.614s) [280.279117] [059/156] (728s left) gem_exec_schedule (fifo) [280.322325] Starting subtest: fifo [280.323051] Starting dynamic subtest: rcs0 [280.385458] Dynamic subtest rcs0: SUCCESS (0.062s) [280.396675] Starting dynamic subtest: bcs0 [280.451773] Dynamic subtest bcs0: SUCCESS (0.063s) [280.465864] Starting dynamic subtest: vcs0 [280.516424] Dynamic subtest vcs0: SUCCESS (0.063s) [280.530099] Starting dynamic subtest: vcs1 [280.584489] Dynamic subtest vcs1: SUCCESS (0.066s) [280.598380] Starting dynamic subtest: vecs0 [280.650342] Dynamic subtest vecs0: SUCCESS (0.064s) [280.651507] Subtest fifo: SUCCESS (0.329s) [280.965814] [060/156] (728s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [281.000220] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [281.000989] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [281.076963] [061/156] (728s left) gem_userptr_blits (invalid-null-pointer) [281.115852] Starting subtest: invalid-null-pointer [281.116572] Subtest invalid-null-pointer: SUCCESS (0.001s) [281.234904] [062/156] (728s left) prime_self_import (export-vs-gem_close-race) [281.268283] Starting subtest: export-vs-gem_close-race [286.314062] Subtest export-vs-gem_close-race: SUCCESS (5.042s) [286.408350] [063/156] (722s left) gem_ctx_bad_destroy (invalid-pad) [286.443243] Starting subtest: invalid-pad [286.444030] Subtest invalid-pad: SUCCESS (0.000s) [286.521025] [064/156] (722s left) gem_exec_nop (basic-sequential) [286.562738] Starting subtest: basic-sequential [289.901324] Subtest basic-sequential: SUCCESS (3.337s) [290.131591] [065/156] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [290.230444] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [290.231844] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [290.326480] [066/156] (719s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [290.419487] Starting subtest: fbc-modesetfrombusy [291.096642] Subtest fbc-modesetfrombusy: SUCCESS (0.678s) [291.222017] [067/156] (718s left) gem_vm_create (execbuf) [291.262862] Starting subtest: execbuf [291.265178] Subtest execbuf: SUCCESS (0.003s) [291.389616] [068/156] (718s left) gem_exec_reloc (basic-write-gtt-active) [291.429458] Starting subtest: basic-write-gtt-active [291.562206] Subtest basic-write-gtt-active: SUCCESS (0.124s) [291.685407] [069/156] (717s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [291.778502] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [291.821597] [070/156] (717s left) kms_big_fb (y-tiled-8bpp-rotate-180) [291.920040] Starting subtest: y-tiled-8bpp-rotate-180 [292.922719] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.002s) [293.045146] [071/156] (716s left) gem_userptr_blits (coherency-sync) [293.091187] Starting subtest: coherency-sync [293.337019] Subtest coherency-sync: SKIP (0.234s) [293.463343] [072/156] (716s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [293.551912] Starting subtest: yf-tiled-ccs-to-y-tiled [293.552626] Starting dynamic subtest: smem [293.656426] Dynamic subtest smem: SUCCESS (0.105s) [293.657226] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.106s) [293.844117] [073/156] (715s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [293.943807] Starting subtest: bad-aux-stride-y-tiled-ccs [293.945998] Starting dynamic subtest: pipe-A-HDMI-A-1 [293.953095] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [293.965138] Starting dynamic subtest: pipe-B-HDMI-A-1 [293.972203] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [293.983769] Starting dynamic subtest: pipe-C-HDMI-A-1 [293.990775] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [293.999395] Starting dynamic subtest: pipe-D-HDMI-A-1 [294.006205] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [294.007551] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.008s) [294.231117] [074/156] (715s left) kms_psr (fbc-psr2-cursor-plane-move) [294.322295] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [294.368868] [075/156] (715s left) kms_big_fb (4-tiled-64bpp-rotate-270) [294.470066] Starting subtest: 4-tiled-64bpp-rotate-270 [294.471465] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s) [294.575864] [076/156] (715s left) kms_content_protection (dp-mst-lic-type-0) [294.670899] Starting subtest: dp-mst-lic-type-0 [294.672428] Subtest dp-mst-lic-type-0: SKIP (0.000s) [294.775969] [077/156] (715s left) gem_exec_reloc (basic-write-read-active) [294.815335] Starting subtest: basic-write-read-active [294.943816] Subtest basic-write-read-active: SUCCESS (0.119s) [295.070976] [078/156] (714s left) i915_hangman (detector) [295.114917] Starting subtest: detector [295.115637] Starting dynamic subtest: rcs0 [305.042297] Dynamic subtest rcs0: SUCCESS (9.926s) [305.054560] Starting dynamic subtest: bcs0 [315.018070] Dynamic subtest bcs0: SUCCESS (9.973s) [315.039112] Starting dynamic subtest: vcs0 [325.011817] Dynamic subtest vcs0: SUCCESS (9.989s) [325.033687] Starting dynamic subtest: vcs1 [335.049118] Dynamic subtest vcs1: SUCCESS (10.033s) [335.071163] Starting dynamic subtest: vecs0 [345.037239] Dynamic subtest vecs0: SUCCESS (9.984s) [345.038693] Subtest detector: SUCCESS (49.919s) [345.157093] [079/156] (664s left) gem_exec_fence (basic-busy) [345.329675] Starting subtest: basic-busy [345.330572] Starting dynamic subtest: rcs0 [345.358562] Dynamic subtest rcs0: SUCCESS (0.029s) [345.377441] Starting dynamic subtest: bcs0 [345.396579] Dynamic subtest bcs0: SUCCESS (0.035s) [345.414037] Starting dynamic subtest: vcs0 [345.428332] Dynamic subtest vcs0: SUCCESS (0.030s) [345.443404] Starting dynamic subtest: vcs1 [345.456389] Dynamic subtest vcs1: SUCCESS (0.026s) [345.470171] Starting dynamic subtest: vecs0 [345.488617] Dynamic subtest vecs0: SUCCESS (0.030s) [345.489928] Subtest basic-busy: SUCCESS (0.163s) [345.960910] [080/156] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [346.057329] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [346.058737] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [346.150029] [081/156] (664s left) sw_sync (timeline_closed) [346.188816] Starting subtest: timeline_closed [346.189534] Subtest timeline_closed: SUCCESS (0.000s) [346.250401] [082/156] (663s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [346.343581] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [346.344994] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [346.455078] [083/156] (663s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt) [346.548511] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt [346.549942] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [346.643427] [084/156] (663s left) gem_exec_balancer (bonded-chain) [346.686349] Starting subtest: bonded-chain [354.068705] Subtest bonded-chain: SUCCESS (7.373s) [354.245674] [085/156] (656s left) perf_pmu (init-wait) [354.283405] Starting subtest: init-wait [354.284144] Starting dynamic subtest: rcs0 [354.285963] Dynamic subtest rcs0: SUCCESS (0.001s) [354.295237] Starting dynamic subtest: bcs0 [354.295934] Dynamic subtest bcs0: SUCCESS (0.001s) [354.304188] Starting dynamic subtest: vcs0 [354.304890] Dynamic subtest vcs0: SUCCESS (0.000s) [354.313210] Starting dynamic subtest: vcs1 [354.313912] Dynamic subtest vcs1: SUCCESS (0.001s) [354.321870] Starting dynamic subtest: vecs0 [354.322577] Dynamic subtest vecs0: SUCCESS (0.000s) [354.323290] Subtest init-wait: SUCCESS (0.009s) [354.395442] [086/156] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [354.491478] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [354.492971] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [354.573232] [087/156] (655s left) kms_flip (2x-absolute-wf_vblank-interruptible) [354.667912] Starting subtest: 2x-absolute-wf_vblank-interruptible [354.677630] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.009s) [354.758438] [088/156] (655s left) kms_color (ctm-max) [354.849061] Starting subtest: ctm-max [354.849834] Starting dynamic subtest: pipe-A-HDMI-A-1 [355.147882] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.297s) [355.157531] Starting dynamic subtest: pipe-B-HDMI-A-1 [355.434751] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.286s) [355.443375] Starting dynamic subtest: pipe-C-HDMI-A-1 [355.729887] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.294s) [355.738472] Starting dynamic subtest: pipe-D-HDMI-A-1 [356.027089] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.297s) [356.027830] Subtest ctm-max: SUCCESS (1.178s) [356.178938] [089/156] (654s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [356.279499] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [356.280906] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [356.379178] [090/156] (654s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [356.473061] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [356.474417] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [356.577988] [091/156] (654s left) gen9_exec_parse (shadow-peek) [356.615924] Subtest shadow-peek: SKIP (0.000s) [356.658332] [092/156] (653s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [356.747087] Starting subtest: plane-upscale-factor-0-25-with-rotation [356.747864] Starting dynamic subtest: pipe-A [357.936546] Dynamic subtest pipe-A: SKIP (1.188s) [357.945268] Starting dynamic subtest: pipe-B [359.141277] Dynamic subtest pipe-B: SKIP (1.204s) [359.150546] Starting dynamic subtest: pipe-C [360.266443] Dynamic subtest pipe-C: SKIP (1.123s) [360.274931] Starting dynamic subtest: pipe-D [361.437205] Dynamic subtest pipe-D: SKIP (1.165s) [361.438589] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (4.684s) [361.610779] [093/156] (649s left) sw_sync (alloc_fence) [361.654321] Starting subtest: alloc_fence [361.655082] Subtest alloc_fence: SUCCESS (0.000s) [361.710482] [094/156] (649s left) gem_exec_schedule (preempt-queue-chain) [361.759814] Starting subtest: preempt-queue-chain [361.760591] Starting dynamic subtest: rcs0 [361.915229] Dynamic subtest rcs0: SUCCESS (0.146s) [361.927101] Starting dynamic subtest: bcs0 [362.061686] Dynamic subtest bcs0: SUCCESS (0.143s) [362.073319] Starting dynamic subtest: vcs0 [362.201412] Dynamic subtest vcs0: SUCCESS (0.143s) [362.213373] Starting dynamic subtest: vcs1 [362.348034] Dynamic subtest vcs1: SUCCESS (0.143s) [362.360570] Starting dynamic subtest: vecs0 [362.489668] Dynamic subtest vecs0: SUCCESS (0.140s) [362.490482] Subtest preempt-queue-chain: SUCCESS (0.721s) [362.772509] [095/156] (647s left) gem_mmap_gtt (close-race) [362.808108] Starting subtest: close-race [382.915797] Subtest close-race: SUCCESS (20.073s) [383.011117] [096/156] (627s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render) [383.108277] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render [383.109758] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [383.197311] [097/156] (627s left) kms_pm_rpm (universal-planes) [394.666065] Starting subtest: universal-planes [394.669452] Starting dynamic subtest: plane-35 [403.349613] Dynamic subtest plane-35: SUCCESS (8.680s) [403.361680] Starting dynamic subtest: plane-65 [411.894305] Dynamic subtest plane-65: SUCCESS (8.543s) [411.908698] Starting dynamic subtest: plane-95 [420.436515] Dynamic subtest plane-95: SUCCESS (8.539s) [420.450943] Starting dynamic subtest: plane-125 [429.061045] Dynamic subtest plane-125: SUCCESS (8.621s) [429.082045] Starting dynamic subtest: plane-135 [437.811062] Dynamic subtest plane-135: SUCCESS (8.747s) [437.826046] Starting dynamic subtest: plane-145 [446.482232] Dynamic subtest plane-145: SUCCESS (8.668s) [446.497401] Starting dynamic subtest: plane-155 [455.020353] Dynamic subtest plane-155: SUCCESS (8.534s) [455.034084] Starting dynamic subtest: plane-165 [463.761732] Dynamic subtest plane-165: SUCCESS (8.738s) [463.763148] Subtest universal-planes: SUCCESS (69.097s) [463.963502] [098/156] (546s left) kms_vblank (wait-busy-hang) [464.055240] Starting subtest: wait-busy-hang [464.057136] Starting dynamic subtest: pipe-A-HDMI-A-1 [477.840715] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.784s) [477.856682] Starting dynamic subtest: pipe-D-HDMI-A-1 [491.654964] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.807s) [491.655728] Subtest wait-busy-hang: SUCCESS (27.600s) [491.808887] [099/156] (519s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt) [491.909457] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt [491.910866] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [492.008886] [100/156] (518s left) gem_mmap_offset (isolation) [492.043107] Starting subtest: isolation [492.049680] Subtest isolation: SUCCESS (0.005s) [492.148717] [101/156] (518s left) gem_ctx_persistence (legacy-engines-mixed-process) [492.186524] Starting subtest: legacy-engines-mixed-process [492.187266] Starting dynamic subtest: render [492.555811] Dynamic subtest render: SUCCESS (0.368s) [492.568890] Starting dynamic subtest: bsd1 [492.918801] Dynamic subtest bsd1: SUCCESS (0.361s) [492.933602] Starting dynamic subtest: bsd2 [493.269866] Dynamic subtest bsd2: SUCCESS (0.348s) [493.284690] Starting dynamic subtest: blt [493.638031] Dynamic subtest blt: SUCCESS (0.364s) [493.657304] Starting dynamic subtest: vebox [494.012944] Dynamic subtest vebox: SUCCESS (0.371s) [494.016309] Subtest legacy-engines-mixed-process: SUCCESS (1.828s) [494.098007] [102/156] (516s left) gem_lmem_swapping (massive) [494.137504] Subtest massive: SKIP (0.000s) [494.182681] [103/156] (516s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite) [494.279468] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite [494.280867] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [494.368084] [104/156] (516s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [494.464631] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [494.465998] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [494.553892] [105/156] (516s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen) [494.648035] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen [494.649473] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [494.742244] [106/156] (516s left) gem_exec_reloc (basic-write-gtt-noreloc) [494.781164] Starting subtest: basic-write-gtt-noreloc [494.783638] Subtest basic-write-gtt-noreloc: SUCCESS (0.002s) [494.900963] [107/156] (516s left) kms_psr (fbc-psr-cursor-plane-move) [494.991156] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [495.047969] [108/156] (516s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [495.138101] Starting subtest: cursor-vs-flip-varying-size [527.275657] Subtest cursor-vs-flip-varying-size: SUCCESS (32.138s) [527.424659] [109/156] (483s left) gem_busy (parallel) [527.605788] Starting subtest: parallel [527.606771] Starting dynamic subtest: rcs0 [527.646582] Dynamic subtest rcs0: SUCCESS (0.050s) [527.669662] Starting dynamic subtest: bcs0 [527.689930] Dynamic subtest bcs0: SUCCESS (0.040s) [527.706599] Starting dynamic subtest: vcs0 [527.722164] Dynamic subtest vcs0: SUCCESS (0.029s) [527.739343] Starting dynamic subtest: vcs1 [527.764193] Dynamic subtest vcs1: SUCCESS (0.040s) [527.783776] Starting dynamic subtest: vecs0 [527.800413] Dynamic subtest vecs0: SUCCESS (0.033s) [527.801391] Subtest parallel: SUCCESS (0.206s) [528.028095] [110/156] (483s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [528.124953] Starting subtest: psr-rgb565-draw-mmap-cpu [528.126423] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s) [528.221734] [111/156] (483s left) kms_addfb_basic (basic-y-tiled-legacy) [528.257303] Starting subtest: basic-y-tiled-legacy [528.258079] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [528.379915] [112/156] (483s left) syncobj_basic (bad-pad-handle-to-fd) [528.415155] Starting subtest: bad-pad-handle-to-fd [528.415927] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [528.498794] [113/156] (483s left) gem_exec_flush (basic-wb-set-default) [528.541347] Starting subtest: basic-wb-set-default [533.975243] Subtest basic-wb-set-default: SUCCESS (5.434s) [534.185553] [114/156] (477s left) kms_getfb (getfb-reject-nv12) [534.281062] Starting subtest: getfb-reject-nv12 [534.282962] Subtest getfb-reject-nv12: SUCCESS (0.001s) [534.394297] [115/156] (477s left) sriov_basic (enable-vfs-autoprobe-off) [534.431460] Starting subtest: enable-vfs-autoprobe-off [534.432208] Starting dynamic subtest: numvfs-1 [534.433717] Dynamic subtest numvfs-1: SKIP (0.001s) [534.442690] Starting dynamic subtest: numvfs-2 [534.444095] Dynamic subtest numvfs-2: SKIP (0.001s) [534.453116] Starting dynamic subtest: numvfs-3 [534.454477] Dynamic subtest numvfs-3: SKIP (0.001s) [534.463559] Starting dynamic subtest: numvfs-4 [534.464905] Dynamic subtest numvfs-4: SKIP (0.001s) [534.473766] Starting dynamic subtest: numvfs-5 [534.475118] Dynamic subtest numvfs-5: SKIP (0.001s) [534.483489] Starting dynamic subtest: numvfs-6 [534.484834] Dynamic subtest numvfs-6: SKIP (0.001s) [534.492901] Starting dynamic subtest: numvfs-7 [534.494244] Dynamic subtest numvfs-7: SKIP (0.001s) [534.502041] Starting dynamic subtest: numvfs-random [534.503370] Dynamic subtest numvfs-random: SKIP (0.001s) [534.511172] Starting dynamic subtest: numvfs-all [534.512494] Dynamic subtest numvfs-all: SKIP (0.001s) [534.513815] Subtest enable-vfs-autoprobe-off: SKIP (0.016s) [534.546287] [116/156] (477s left) kms_dsc (dsc-fractional-bpp-with-bpc) [534.636952] Starting subtest: dsc-fractional-bpp-with-bpc [534.646260] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [534.707890] [117/156] (477s left) api_intel_bb (full-batch) [534.743555] Starting subtest: full-batch [534.746058] Subtest full-batch: SUCCESS (0.003s) [534.861080] [118/156] (476s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move) [534.955254] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move [534.956680] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [535.067789] [119/156] (476s left) gem_exec_balancer (busy) [535.111341] Starting subtest: busy [535.801933] Subtest busy: SUCCESS (0.691s) [535.984294] [120/156] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [536.080193] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [536.081641] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [536.175315] [121/156] (475s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [536.317717] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [536.413371] [122/156] (475s left) kms_async_flips (test-time-stamp-atomic) [536.506089] Starting subtest: test-time-stamp-atomic [536.631056] Starting dynamic subtest: pipe-A-HDMI-A-1 [536.750032] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.118s) [536.896509] Starting dynamic subtest: pipe-B-HDMI-A-1 [536.986457] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.097s) [537.106932] Starting dynamic subtest: pipe-C-HDMI-A-1 [537.190071] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.090s) [537.322927] Starting dynamic subtest: pipe-D-HDMI-A-1 [537.406246] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.091s) [537.407193] Subtest test-time-stamp-atomic: SUCCESS (0.901s) [537.648331] [123/156] (474s left) kms_cursor_legacy (torture-bo) [537.742096] Starting subtest: torture-bo [537.742849] Starting dynamic subtest: pipe-A [543.244751] Dynamic subtest pipe-A: SUCCESS (5.468s) [543.259588] Starting dynamic subtest: pipe-B [548.734553] Dynamic subtest pipe-B: SUCCESS (5.490s) [548.744242] Starting dynamic subtest: pipe-C [554.216170] Dynamic subtest pipe-C: SUCCESS (5.480s) [554.226986] Starting dynamic subtest: pipe-D [559.695439] Dynamic subtest pipe-D: SUCCESS (5.476s) [559.709563] Starting dynamic subtest: all-pipes [565.170038] Dynamic subtest all-pipes: SUCCESS (5.475s) [565.170903] Subtest torture-bo: SUCCESS (27.396s) [565.230892] [124/156] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [565.335098] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [565.336557] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [565.428581] [125/156] (446s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [565.524068] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [565.525435] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [565.633157] [126/156] (446s left) gem_pwrite_snooped [565.807306] [127/156] (446s left) syncobj_wait (wait-all-complex) [565.842376] Starting subtest: wait-all-complex [566.066565] Subtest wait-all-complex: SUCCESS (0.215s) [566.141596] [128/156] (446s left) gem_softpin (allocator-basic-reserve) [566.179404] Starting subtest: allocator-basic-reserve [566.259037] Subtest allocator-basic-reserve: SUCCESS (0.079s) [566.396800] [129/156] (445s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [566.490495] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [566.541181] [130/156] (445s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [566.630142] Starting subtest: cursorA-vs-flipA-varying-size [577.481760] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.851s) [577.652672] [131/156] (434s left) gem_exec_reloc (basic-write-wc-noreloc) [577.694417] Starting subtest: basic-write-wc-noreloc [577.696818] Subtest basic-write-wc-noreloc: SUCCESS (0.002s) [577.830786] [132/156] (434s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [577.923469] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [577.924966] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [578.035376] [133/156] (434s left) gem_pwrite (basic-self) [578.070278] Starting subtest: basic-self [578.108492] Subtest basic-self: SUCCESS (0.039s) [578.205984] [134/156] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [578.299046] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [578.300433] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [578.402956] [135/156] (434s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [578.496684] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [578.498106] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [578.603164] [136/156] (434s left) kms_lease (lease-again) [578.694192] Starting subtest: lease-again [578.694964] Starting dynamic subtest: pipe-A-HDMI-A-1 [578.697024] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [578.707492] Starting dynamic subtest: pipe-B-HDMI-A-1 [578.708282] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [578.717366] Starting dynamic subtest: pipe-C-HDMI-A-1 [578.718131] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [578.726942] Starting dynamic subtest: pipe-D-HDMI-A-1 [578.727752] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [578.728433] Subtest lease-again: SUCCESS (0.013s) [578.796069] [137/156] (433s left) kms_frontbuffer_tracking (hdr-modesetfrombusy) [578.889306] Starting subtest: hdr-modesetfrombusy [578.890714] Subtest hdr-modesetfrombusy: SKIP (0.000s) [579.013329] [138/156] (433s left) kms_pm_lpsp (screens-disabled) [590.158768] Starting subtest: screens-disabled [590.160232] Subtest screens-disabled: SKIP (0.000s) [590.224032] [139/156] (422s left) gem_flink_race (flink_close) [590.256299] Starting subtest: flink_close [595.298089] Subtest flink_close: SUCCESS (5.036s) [595.395419] [140/156] (417s left) kms_psr (psr-cursor-plane-move) [595.487742] Subtest psr-cursor-plane-move: SKIP (0.000s) [595.529592] [141/156] (417s left) kms_selftest (drm_dp_mst_helper) [595.567589] Starting subtest: drm_dp_mst_helper [595.586685] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [595.652598] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.065s) [595.671190] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [595.742979] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.086s) [595.754959] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [595.823652] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.080s) [595.824497] Subtest drm_dp_mst_helper: SUCCESS (0.257s) [595.982155] [142/156] (416s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [596.086761] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [596.088199] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [596.197939] [143/156] (416s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [596.286787] Starting subtest: 2x-flip-vs-blocking-wf-vblank [596.296099] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.009s) [596.367891] [144/156] (416s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [596.462074] Starting subtest: extended-pageflip-modeset-hang-oldfb [596.463969] Starting dynamic subtest: pipe-A [616.591356] Dynamic subtest pipe-A: SUCCESS (20.128s) [616.603527] Starting dynamic subtest: pipe-D [636.537971] Dynamic subtest pipe-D: SUCCESS (19.943s) [636.538770] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (40.078s) [636.716156] [145/156] (376s left) i915_pm_rpm (system-suspend) [648.165849] Starting subtest: system-suspend [667.042069] Subtest system-suspend: SUCCESS (3.602s) [675.294465] [146/156] (345s left) kms_cursor_crc (cursor-random-64x21) [675.391909] Starting subtest: cursor-random-64x21 [675.395914] Starting dynamic subtest: pipe-A-HDMI-A-1 [676.613949] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.040s) [676.625003] Starting dynamic subtest: pipe-D-HDMI-A-1 [678.460454] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.984s) [678.461170] Subtest cursor-random-64x21: FAIL (3.066s) [678.610290] [147/156] (342s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier) [678.702712] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier [678.704085] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s) [678.768017] [148/156] (342s left) kms_pipe_crc_basic (suspend-read-crc) [678.856852] Starting subtest: suspend-read-crc [678.857692] Starting dynamic subtest: pipe-A-HDMI-A-1 [695.395203] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.791s) [695.406760] Starting dynamic subtest: pipe-B-HDMI-A-1 [712.347656] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.725s) [712.358814] Starting dynamic subtest: pipe-C-HDMI-A-1 [729.381928] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.804s) [729.392886] Starting dynamic subtest: pipe-D-HDMI-A-1 [746.338424] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.703s) [746.339158] Subtest suspend-read-crc: SUCCESS (7.031s) [755.529471] [149/156] (274s left) kms_plane (pixel-format-linear-modifier-source-clamping) [755.623541] Starting subtest: pixel-format-linear-modifier-source-clamping [755.643123] Starting dynamic subtest: pipe-A-plane-0 [756.051566] Dynamic subtest pipe-A-plane-0: SUCCESS (0.408s) [756.068734] Starting dynamic subtest: pipe-A-plane-3 [756.343448] Dynamic subtest pipe-A-plane-3: SUCCESS (0.289s) [756.363352] Starting dynamic subtest: pipe-A-plane-5 [756.652087] Dynamic subtest pipe-A-plane-5: SUCCESS (0.305s) [756.823007] Starting dynamic subtest: pipe-B-plane-0 [757.158885] Dynamic subtest pipe-B-plane-0: SUCCESS (0.349s) [757.177926] Starting dynamic subtest: pipe-B-plane-3 [757.459717] Dynamic subtest pipe-B-plane-3: SUCCESS (0.298s) [757.479199] Starting dynamic subtest: pipe-B-plane-5 [757.750703] Dynamic subtest pipe-B-plane-5: SUCCESS (0.288s) [757.824484] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (2.201s) [757.976383] [150/156] (272s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [758.068063] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [758.116659] [151/156] (272s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [758.212638] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [758.214072] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [758.305103] [152/156] (272s left) gem_close_race (multigpu-basic-process) [758.349228] Starting subtest: multigpu-basic-process [758.350610] Subtest multigpu-basic-process: SKIP (0.000s) [758.534973] [153/156] (271s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [758.627919] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [758.629370] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [758.734269] [154/156] (271s left) kms_cdclk (plane-scaling) [758.768541] Subtest plane-scaling: SKIP (0.000s) [758.819979] [155/156] (271s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite) [758.912313] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite [758.913812] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [759.004690] [156/156] (271s left) gem_exec_params (secure-non-root) [759.043333] Starting subtest: secure-non-root [759.044785] Subtest secure-non-root: SKIP (0.000s) [759.140421] Closing watchdogs results: parsing output: 0/ for test: kms_flip results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_joiner results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: gem_mmap results: parsing output: 8/ for test: syncobj_wait results: parsing output: 9/ for test: i915_query results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: kms_flip_scaled_crc results: parsing output: 13/ for test: kms_addfb_basic results: parsing output: 14/ for test: prime_vgem results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: i915_drm_fdinfo results: parsing output: 17/ for test: kms_chamelium_hpd results: parsing output: 18/ for test: gem_exec_fence results: parsing output: 19/ for test: gem_exec_whisper results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: vgem_basic results: parsing output: 22/ for test: dmabuf_sync_file results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_partial_pwrite_pread results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: gem_mmap_gtt results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_flip_scaled_crc results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: prime_vgem results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: kms_plane results: parsing output: 36/ for test: perf_pmu results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_fenced_exec_thrash results: parsing output: 40/ for test: perf results: parsing output: 41/ for test: gem_render_copy results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_atomic_transition results: parsing output: 44/ for test: gem_render_copy results: parsing output: 45/ for test: kms_tiled_display results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_cursor_edge_walk results: parsing output: 50/ for test: i915_selftest results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_ctx_persistence results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_exec_schedule results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: gem_exec_schedule results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: gem_userptr_blits results: parsing output: 61/ for test: prime_self_import results: parsing output: 62/ for test: gem_ctx_bad_destroy results: parsing output: 63/ for test: gem_exec_nop results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_vm_create results: parsing output: 67/ for test: gem_exec_reloc results: parsing output: 68/ for test: kms_psr2_sf results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: gem_userptr_blits results: parsing output: 71/ for test: gem_render_copy results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_content_protection results: parsing output: 76/ for test: gem_exec_reloc results: parsing output: 77/ for test: i915_hangman results: parsing output: 78/ for test: gem_exec_fence results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: sw_sync results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_exec_balancer results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_color results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gen9_exec_parse results: parsing output: 91/ for test: kms_plane_scaling results: parsing output: 92/ for test: sw_sync results: parsing output: 93/ for test: gem_exec_schedule results: parsing output: 94/ for test: gem_mmap_gtt results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_pm_rpm results: parsing output: 97/ for test: kms_vblank results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_mmap_offset results: parsing output: 100/ for test: gem_ctx_persistence results: parsing output: 101/ for test: gem_lmem_swapping results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: gem_busy results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_addfb_basic results: parsing output: 111/ for test: syncobj_basic results: parsing output: 112/ for test: gem_exec_flush results: parsing output: 113/ for test: kms_getfb results: parsing output: 114/ for test: sriov_basic results: parsing output: 115/ for test: kms_dsc results: parsing output: 116/ for test: api_intel_bb results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_exec_balancer results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_chamelium_edid results: parsing output: 121/ for test: kms_async_flips results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_pwrite_snooped results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: gem_softpin results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: gem_exec_reloc results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_pwrite results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_lease results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_pm_lpsp results: parsing output: 138/ for test: gem_flink_race results: parsing output: 139/ for test: kms_psr results: parsing output: 140/ for test: kms_selftest results: parsing output: 141/ for test: kms_big_fb results: parsing output: 142/ for test: kms_flip results: parsing output: 143/ for test: kms_busy results: parsing output: 144/ for test: i915_pm_rpm results: parsing output: 145/ for test: kms_cursor_crc results: parsing output: 146/ for test: kms_plane results: parsing output: 147/ for test: kms_pipe_crc_basic results: parsing output: 148/ for test: kms_plane results: parsing output: 149/ for test: kms_psr2_sf results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: gem_close_race results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_cdclk results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: gem_exec_params Done.