[71.566166] Initializing watchdogs [71.566257] /dev/watchdog0 [71.582770] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [71.587041] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [71.589048] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.592205] [001/156] (960s left) gem_mmap_wc (write-prefaulted) [71.666079] Subtest write-prefaulted: SKIP (0.000s) [71.724308] [002/156] (960s left) kms_hdr (static-toggle-dpms) [71.803661] Starting subtest: static-toggle-dpms [71.805990] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [71.810355] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [71.820024] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [71.823896] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [71.827978] Subtest static-toggle-dpms: SKIP (0.002s) [71.872698] [003/156] (960s left) gem_exec_schedule (u-submit-early-slice) [71.942624] Starting subtest: u-submit-early-slice [71.944842] Starting dynamic subtest: rcs0 [71.984864] Dynamic subtest rcs0: SUCCESS (0.047s) [71.995946] Starting dynamic subtest: bcs0 [72.023639] Dynamic subtest bcs0: SUCCESS (0.039s) [72.031719] Starting dynamic subtest: vcs0 [72.062741] Dynamic subtest vcs0: SUCCESS (0.039s) [72.071562] Starting dynamic subtest: vcs1 [72.098332] Dynamic subtest vcs1: SUCCESS (0.036s) [72.106147] Starting dynamic subtest: vecs0 [72.129691] Dynamic subtest vecs0: SUCCESS (0.031s) [72.137670] Starting dynamic subtest: ccs0 [72.169638] Dynamic subtest ccs0: SUCCESS (0.040s) [72.171841] Subtest u-submit-early-slice: SUCCESS (0.233s) [73.380446] [004/156] (958s left) gem_exec_reloc (basic-wc-cpu-active) [73.428941] Subtest basic-wc-cpu-active: SKIP (0.000s) [73.505169] [005/156] (958s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [73.566543] Starting subtest: yf-tiled-ccs-to-y-tiled [73.571117] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [73.759516] [006/156] (958s left) gem_exec_parallel (fds) [73.818410] Starting subtest: fds [73.820854] Starting dynamic subtest: rcs0 [77.061624] Dynamic subtest rcs0: SUCCESS (3.225s) [77.072153] Starting dynamic subtest: bcs0 [80.168613] Dynamic subtest bcs0: SUCCESS (3.122s) [80.178854] Starting dynamic subtest: vcs0 [84.482419] Dynamic subtest vcs0: SUCCESS (4.313s) [84.497105] Starting dynamic subtest: vcs1 [88.494831] Dynamic subtest vcs1: SUCCESS (4.012s) [88.503364] Starting dynamic subtest: vecs0 [92.485975] Dynamic subtest vecs0: SUCCESS (3.989s) [92.494827] Starting dynamic subtest: ccs0 [95.890516] Dynamic subtest ccs0: SUCCESS (3.403s) [95.892899] Subtest fds: SUCCESS (22.071s) [96.092820] [007/156] (936s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render) [96.180521] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render [96.184796] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [96.262071] [008/156] (936s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [96.352128] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [103.351805] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.005s) [103.466261] [009/156] (928s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [103.544477] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [103.548762] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [103.643597] [010/156] (928s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [103.724371] Starting subtest: yf-tiled-64bpp-rotate-0 [103.728610] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [103.828686] [011/156] (928s left) gen9_exec_parse (batch-zero-length) [103.886529] Subtest batch-zero-length: SKIP (0.000s) [103.969573] [012/156] (928s left) i915_pciid [104.128969] [013/156] (928s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [104.208885] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [105.254121] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.046s) [105.385291] [014/156] (927s left) gem_exec_fence (syncobj-timeline-unused-fence) [105.977569] Starting subtest: syncobj-timeline-unused-fence [105.982539] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s) [107.265348] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [107.269098] [015/156] (925s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [107.341091] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [107.343109] Starting dynamic subtest: pipe-A-eDP-1 [107.363918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [107.374782] Starting dynamic subtest: pipe-B-eDP-1 [107.395682] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s) [107.404812] Starting dynamic subtest: pipe-C-eDP-1 [107.426865] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s) [107.438074] Starting dynamic subtest: pipe-D-eDP-1 [107.458677] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [107.461008] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.081s) [109.740904] [016/156] (922s left) gem_userptr_blits (huge-split) [109.809388] Starting subtest: huge-split [109.815678] Subtest huge-split: SUCCESS (0.006s) [109.919374] [017/156] (922s left) kms_big_fb (y-tiled-32bpp-rotate-270) [110.005517] Starting subtest: y-tiled-32bpp-rotate-270 [110.009977] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [110.097405] [018/156] (922s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render) [110.171590] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render [110.175730] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [110.250182] [019/156] (922s left) gem_ctx_param (invalid-size-get) [110.307870] Starting subtest: invalid-size-get [110.310095] Subtest invalid-size-get: SUCCESS (0.001s) [110.430140] [020/156] (922s left) kms_rmfb (rmfb-ioctl) [110.493864] Starting subtest: rmfb-ioctl [110.495847] Starting dynamic subtest: pipe-A-eDP-1 [110.598368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [110.609193] Starting dynamic subtest: pipe-B-eDP-1 [111.811068] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s) [111.820932] Starting dynamic subtest: pipe-C-eDP-1 [113.024630] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s) [113.034942] Starting dynamic subtest: pipe-D-eDP-1 [114.160864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [114.163080] Subtest rmfb-ioctl: SUCCESS (3.669s) [115.373019] [021/156] (917s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff) [115.454785] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff [115.459067] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [115.563974] [022/156] (917s left) kms_cursor_crc (cursor-sliding-512x512) [115.821660] Starting subtest: cursor-sliding-512x512 [115.826217] Subtest cursor-sliding-512x512: SKIP (0.001s) [115.978236] [023/156] (916s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [116.060076] Starting subtest: fbcpsr-rgb565-draw-render [123.055200] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.003s) [123.200511] [024/156] (909s left) i915_suspend (basic-s3-without-i915) [123.236349] Starting subtest: basic-s3-without-i915 [124.939518] Subtest basic-s3-without-i915: SKIP (1.698s) [126.463082] [025/156] (906s left) kms_frontbuffer_tracking (fbc-1p-rte) [126.555767] Starting subtest: fbc-1p-rte [132.041170] Subtest fbc-1p-rte: SUCCESS (5.493s) [133.210200] [026/156] (899s left) kms_getfb (getfb-handle-valid) [133.290994] Starting subtest: getfb-handle-valid [133.293303] Subtest getfb-handle-valid: SUCCESS (0.000s) [133.411250] [027/156] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [133.494854] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [133.499378] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [133.596962] [028/156] (899s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt) [133.684633] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt [133.689074] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [133.776203] [029/156] (899s left) kms_lease (invalid-create-leases) [133.845065] Starting subtest: invalid-create-leases [133.849928] Subtest invalid-create-leases: SUCCESS (0.006s) [133.960086] [030/156] (899s left) gem_ccs (suspend-resume) [134.021064] Starting subtest: suspend-resume [134.025343] Subtest suspend-resume: SKIP (0.000s) [134.124310] [031/156] (899s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt) [134.203382] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt [134.206811] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [134.305998] [032/156] (899s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [134.694640] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [135.505318] [033/156] (897s left) kms_cursor_legacy (torture-move) [135.613607] Starting subtest: torture-move [135.615968] Starting dynamic subtest: pipe-A [141.606976] Dynamic subtest pipe-A: SUCCESS (5.990s) [141.618109] Starting dynamic subtest: pipe-B [148.595691] Dynamic subtest pipe-B: SUCCESS (6.987s) [148.612635] Starting dynamic subtest: pipe-C [155.163842] Dynamic subtest pipe-C: SUCCESS (6.567s) [155.173115] Starting dynamic subtest: pipe-D [161.547103] Dynamic subtest pipe-D: SUCCESS (6.382s) [161.558065] Starting dynamic subtest: all-pipes [167.846709] Dynamic subtest all-pipes: SUCCESS (6.299s) [167.848938] Subtest torture-move: SUCCESS (32.232s) [168.004893] [034/156] (865s left) kms_plane_multiple (tiling-x) [168.082944] Starting subtest: tiling-x [168.085309] Starting dynamic subtest: pipe-A-eDP-1 [171.853795] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.770s) [171.863314] Starting dynamic subtest: pipe-B-eDP-1 [176.317789] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.462s) [176.327723] Starting dynamic subtest: pipe-C-eDP-1 [180.834989] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.518s) [180.843838] Starting dynamic subtest: pipe-D-eDP-1 [185.155070] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.318s) [185.157407] Subtest tiling-x: SUCCESS (17.073s) [185.967888] [035/156] (847s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [186.051043] Starting subtest: planes-downscale-factor-0-5-unity-scaling [186.053370] Starting dynamic subtest: pipe-A [186.074015] Dynamic subtest pipe-A: SKIP (0.017s) [186.082888] Starting dynamic subtest: pipe-B [186.102526] Dynamic subtest pipe-B: SKIP (0.030s) [186.111086] Starting dynamic subtest: pipe-C [186.133630] Dynamic subtest pipe-C: SKIP (0.029s) [186.143885] Starting dynamic subtest: pipe-D [186.161787] Dynamic subtest pipe-D: SKIP (0.029s) [186.166061] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.108s) [186.261436] [036/156] (847s left) kms_cdclk (mode-transition) [186.340663] Starting subtest: mode-transition [186.342935] Starting dynamic subtest: pipe-A-eDP-1 [186.631227] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s) [186.640298] Starting dynamic subtest: pipe-B-eDP-1 [186.644952] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [186.653290] Starting dynamic subtest: pipe-C-eDP-1 [186.657858] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [186.665730] Starting dynamic subtest: pipe-D-eDP-1 [186.669816] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [186.673842] Subtest mode-transition: SKIP (0.294s) [187.489810] [037/156] (846s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [187.569893] Starting subtest: crc-primary-suspend-y-tiled-ccs [187.572189] Starting dynamic subtest: pipe-A-eDP-1 [187.581189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [187.591587] Starting dynamic subtest: pipe-B-eDP-1 [187.600413] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [187.608870] Starting dynamic subtest: pipe-C-eDP-1 [187.617106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [187.625141] Starting dynamic subtest: pipe-D-eDP-1 [187.633313] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [187.637608] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [189.859052] [038/156] (843s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [189.937895] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [189.942144] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [190.011719] [039/156] (843s left) gem_exec_fence (parallel) [190.183736] Starting subtest: parallel [190.186086] Starting dynamic subtest: rcs0 [192.331045] Dynamic subtest rcs0: SUCCESS (2.149s) [192.340798] Starting dynamic subtest: bcs0 [194.480459] Dynamic subtest bcs0: SUCCESS (2.149s) [194.489842] Starting dynamic subtest: vcs0 [196.634158] Dynamic subtest vcs0: SUCCESS (2.153s) [196.646337] Starting dynamic subtest: vcs1 [198.788684] Dynamic subtest vcs1: SUCCESS (2.153s) [198.798605] Starting dynamic subtest: vecs0 [200.942667] Dynamic subtest vecs0: SUCCESS (2.154s) [200.952948] Starting dynamic subtest: ccs0 [203.092729] Dynamic subtest ccs0: SUCCESS (2.149s) [203.094719] Subtest parallel: SUCCESS (12.911s) [204.319615] [040/156] (829s left) kms_flip (modeset-vs-vblank-race) [204.406467] Starting subtest: modeset-vs-vblank-race [204.408800] Starting dynamic subtest: A-eDP1 [209.176682] Dynamic subtest A-eDP1: SUCCESS (4.772s) [209.187947] Starting dynamic subtest: B-eDP1 [213.997229] Dynamic subtest B-eDP1: SUCCESS (4.819s) [214.008651] Starting dynamic subtest: C-eDP1 [218.712829] Dynamic subtest C-eDP1: SUCCESS (4.714s) [218.721736] Starting dynamic subtest: D-eDP1 [223.338227] Dynamic subtest D-eDP1: SUCCESS (4.624s) [223.340621] Subtest modeset-vs-vblank-race: SUCCESS (18.938s) [224.513419] [041/156] (809s left) gem_lmem_swapping (parallel-multi) [224.552973] Subtest parallel-multi: SKIP (0.000s) [224.600424] [042/156] (809s left) syncobj_timeline (single-wait-all-signaled) [224.650053] Starting subtest: single-wait-all-signaled [224.652285] Subtest single-wait-all-signaled: SUCCESS (0.000s) [224.746956] [043/156] (809s left) kms_joiner (basic-force-big-joiner) [224.822826] Starting subtest: basic-force-big-joiner [224.826972] Subtest basic-force-big-joiner: SKIP (0.000s) [224.894133] [044/156] (808s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [224.980680] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [224.984830] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [225.079670] [045/156] (808s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [225.166450] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [231.834430] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.671s) [231.950417] [046/156] (801s left) api_intel_allocator (reserve-simple) [232.006605] Starting subtest: reserve-simple [232.008779] Subtest reserve-simple: SUCCESS (0.003s) [232.133282] [047/156] (801s left) kms_flip (2x-absolute-wf_vblank) [232.217061] Starting subtest: 2x-absolute-wf_vblank [232.225353] Subtest 2x-absolute-wf_vblank: SKIP (0.008s) [232.335233] [048/156] (801s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [232.424918] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [243.621667] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.195s) [244.458949] [049/156] (789s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [244.542149] Starting subtest: fbc-1p-pri-indfb-multidraw [257.481268] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.945s) [258.891035] [050/156] (775s left) kms_scaling_modes (scaling-mode-none) [258.970802] Starting subtest: scaling-mode-none [258.973257] Starting dynamic subtest: pipe-A-eDP-1 [259.064361] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s) [259.074056] Starting dynamic subtest: pipe-B-eDP-1 [259.098589] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s) [259.108117] Starting dynamic subtest: pipe-C-eDP-1 [259.129399] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s) [259.138986] Starting dynamic subtest: pipe-D-eDP-1 [259.160750] Dynamic subtest pipe-D-eDP-1: SKIP (0.030s) [259.164685] Subtest scaling-mode-none: SKIP (0.191s) [259.280051] [051/156] (774s left) prime_self_import (basic-llseek-bad) [259.313984] Starting subtest: basic-llseek-bad [259.332579] Subtest basic-llseek-bad: SUCCESS (0.022s) [259.424833] [052/156] (774s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc) [259.503601] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc [259.507621] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [259.605032] [053/156] (774s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt) [259.681318] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt [259.685288] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [259.797439] [054/156] (774s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt) [259.870671] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt [259.874168] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [259.973068] [055/156] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [260.049336] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [260.052713] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [260.146158] [056/156] (774s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [260.222335] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [261.191953] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.968s) [261.332400] [057/156] (772s left) kms_content_protection (atomic-dpms-hdcp14) [261.457960] Starting subtest: atomic-dpms-hdcp14 [261.462567] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [261.577267] [058/156] (772s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [261.649480] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [261.651448] Starting dynamic subtest: pipe-A-eDP-1 [261.668460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [261.678574] Starting dynamic subtest: pipe-B-eDP-1 [261.694615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [261.703309] Starting dynamic subtest: pipe-C-eDP-1 [261.719287] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [261.727667] Starting dynamic subtest: pipe-D-eDP-1 [261.743067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [261.744778] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s) [263.927434] [059/156] (770s left) kms_pm_rpm (fences-dpms) [265.431068] Starting subtest: fences-dpms [265.435702] Subtest fences-dpms: SKIP (0.000s) [266.175049] [060/156] (768s left) perf_pmu (init-sema) [266.218267] Starting subtest: init-sema [266.220068] Starting dynamic subtest: rcs0 [266.222287] Dynamic subtest rcs0: SUCCESS (0.002s) [266.231233] Starting dynamic subtest: bcs0 [266.233065] Dynamic subtest bcs0: SUCCESS (0.001s) [266.241252] Starting dynamic subtest: vcs0 [266.243224] Dynamic subtest vcs0: SUCCESS (0.001s) [266.251074] Starting dynamic subtest: vcs1 [266.252925] Dynamic subtest vcs1: SUCCESS (0.001s) [266.260895] Starting dynamic subtest: vecs0 [266.262816] Dynamic subtest vecs0: SUCCESS (0.001s) [266.270722] Starting dynamic subtest: ccs0 [266.272627] Dynamic subtest ccs0: SUCCESS (0.000s) [266.274569] Subtest init-sema: SUCCESS (0.009s) [266.345108] [061/156] (768s left) kms_busy (extended-modeset-hang-newfb) [266.415063] Starting subtest: extended-modeset-hang-newfb [266.417340] Starting dynamic subtest: pipe-A [301.123742] Dynamic subtest pipe-A: SUCCESS (34.707s) [301.133854] Starting dynamic subtest: pipe-D [324.175639] Dynamic subtest pipe-D: SUCCESS (23.050s) [324.178019] Subtest extended-modeset-hang-newfb: SUCCESS (57.761s) [325.063240] [062/156] (709s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [325.148844] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [328.720603] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.579s) [329.851049] [063/156] (704s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [329.927429] Starting subtest: primary-x-tiled-reflect-x-0 [336.837836] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.910s) [338.011619] [064/156] (696s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [338.098754] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [338.103109] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [338.203356] [065/156] (696s left) kms_flip (bo-too-big-interruptible) [338.280075] Starting subtest: bo-too-big-interruptible [338.282305] Starting dynamic subtest: A-eDP1 [339.557143] Dynamic subtest A-eDP1: SUCCESS (1.276s) [339.566537] Starting dynamic subtest: B-eDP1 [340.880943] Dynamic subtest B-eDP1: SUCCESS (1.323s) [340.893601] Starting dynamic subtest: C-eDP1 [342.135455] Dynamic subtest C-eDP1: SUCCESS (1.252s) [342.145780] Starting dynamic subtest: D-eDP1 [343.459076] Dynamic subtest D-eDP1: SUCCESS (1.322s) [343.461917] Subtest bo-too-big-interruptible: SUCCESS (5.182s) [344.676045] [066/156] (690s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [344.776809] Starting subtest: basic-flip-after-cursor-varying-size [345.710657] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.933s) [346.522598] [067/156] (688s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [346.576390] Starting subtest: multi-wait-for-submit-available-submitted-signaled [346.578710] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [346.684233] [068/156] (688s left) kms_big_fb (linear-8bpp-rotate-180) [346.772913] Starting subtest: linear-8bpp-rotate-180 [348.007505] Subtest linear-8bpp-rotate-180: SUCCESS (1.235s) [348.128861] [069/156] (686s left) kms_addfb_basic (invalid-set-prop-any) [348.173244] Starting subtest: invalid-set-prop-any [348.175468] Subtest invalid-set-prop-any: SUCCESS (0.000s) [348.292138] [070/156] (686s left) kms_flip (2x-flip-vs-panning-interruptible) [348.358023] Starting subtest: 2x-flip-vs-panning-interruptible [348.367460] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.008s) [348.466827] [071/156] (686s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [348.539356] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [348.542765] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [348.626774] [072/156] (686s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc) [348.695634] Starting subtest: psrhdr-rgb565-draw-mmap-wc [348.699093] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [348.788564] [073/156] (686s left) gem_eio (create) [349.001428] Starting subtest: create [349.314069] Subtest create: SUCCESS (0.315s) [349.443746] [074/156] (685s left) gem_ctx_persistence (engines-mixed) [349.494780] Starting subtest: engines-mixed [349.496760] Starting dynamic subtest: rcs0 [349.577604] Dynamic subtest rcs0: SUCCESS (0.082s) [349.588933] Starting dynamic subtest: bcs0 [349.632320] Dynamic subtest bcs0: SUCCESS (0.053s) [349.644153] Starting dynamic subtest: vcs0 [349.688323] Dynamic subtest vcs0: SUCCESS (0.054s) [349.700071] Starting dynamic subtest: vcs1 [349.746447] Dynamic subtest vcs1: SUCCESS (0.055s) [349.756699] Starting dynamic subtest: vecs0 [349.796268] Dynamic subtest vecs0: SUCCESS (0.048s) [349.806107] Starting dynamic subtest: ccs0 [349.839497] Dynamic subtest ccs0: SUCCESS (0.041s) [349.841619] Subtest engines-mixed: SUCCESS (0.345s) [349.915013] [075/156] (685s left) kms_addfb_basic (too-high) [349.993101] Starting subtest: too-high [349.995059] Subtest too-high: SUCCESS (0.001s) [350.095791] [076/156] (684s left) i915_query (query-topology-unsupported) [350.144318] Starting subtest: query-topology-unsupported [350.148041] Subtest query-topology-unsupported: SKIP (0.000s) [350.251945] [077/156] (684s left) gem_mmap_offset (clear) [350.316384] Starting subtest: clear [350.319055] Starting dynamic subtest: smem0 [373.471122] Dynamic subtest smem0: SUCCESS (23.153s) [373.473528] Subtest clear: SUCCESS (23.154s) [373.586258] [078/156] (661s left) i915_drm_fdinfo (busy-check-all) [373.670988] Starting subtest: busy-check-all [373.673202] Starting dynamic subtest: rcs0 [373.679772] Dynamic subtest rcs0: SKIP (0.006s) [373.693740] Starting dynamic subtest: bcs0 [373.697896] Dynamic subtest bcs0: SKIP (0.000s) [373.706755] Starting dynamic subtest: vcs0 [373.711121] Dynamic subtest vcs0: SKIP (0.000s) [373.720228] Starting dynamic subtest: vcs1 [373.724313] Dynamic subtest vcs1: SKIP (0.000s) [373.733430] Starting dynamic subtest: vecs0 [373.737633] Dynamic subtest vecs0: SKIP (0.000s) [373.746667] Starting dynamic subtest: ccs0 [373.750857] Dynamic subtest ccs0: SKIP (0.000s) [373.755146] Subtest busy-check-all: SKIP (0.011s) [373.791683] [079/156] (661s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [373.917439] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [373.921569] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [374.017978] [080/156] (661s left) kms_frontbuffer_tracking (fbchdr-1p-rte) [374.098485] Starting subtest: fbchdr-1p-rte [374.102618] Subtest fbchdr-1p-rte: SKIP (0.000s) [374.208865] [081/156] (661s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render) [374.291839] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render [374.295096] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [374.384074] [082/156] (660s left) sysfs_timeslice_duration (duration) [374.432204] Starting subtest: duration [374.434153] Starting dynamic subtest: vecs0 [389.149867] Dynamic subtest vecs0: SUCCESS (14.714s) [389.162710] Starting dynamic subtest: ccs0 [402.295597] Dynamic subtest ccs0: SUCCESS (13.142s) [402.305691] Starting dynamic subtest: vcs0 [417.114788] Dynamic subtest vcs0: SUCCESS (14.817s) [417.126931] Starting dynamic subtest: bcs0 [430.257125] Dynamic subtest bcs0: SUCCESS (13.141s) [430.269197] Starting dynamic subtest: rcs0 [443.402977] Dynamic subtest rcs0: SUCCESS (13.144s) [443.415118] Starting dynamic subtest: vcs1 [458.139256] Dynamic subtest vcs1: SUCCESS (14.732s) [458.142084] Subtest duration: SUCCESS (83.707s) [458.218876] [083/156] (577s left) gem_exec_store (dword) [458.283566] Starting subtest: dword [458.285689] Starting dynamic subtest: rcs0 [458.348042] Dynamic subtest rcs0: SUCCESS (0.065s) [458.359938] Starting dynamic subtest: bcs0 [458.390978] Dynamic subtest bcs0: SUCCESS (0.041s) [458.401435] Starting dynamic subtest: vcs0 [458.434243] Dynamic subtest vcs0: SUCCESS (0.041s) [458.444842] Starting dynamic subtest: vcs1 [458.476131] Dynamic subtest vcs1: SUCCESS (0.040s) [458.485699] Starting dynamic subtest: vecs0 [458.518271] Dynamic subtest vecs0: SUCCESS (0.040s) [458.529125] Starting dynamic subtest: ccs0 [458.563728] Dynamic subtest ccs0: SUCCESS (0.044s) [458.566054] Subtest dword: SUCCESS (0.282s) [458.749756] [084/156] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [458.850457] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [458.854617] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [458.956948] [085/156] (576s left) kms_plane_alpha_blend (alpha-basic) [459.034296] Starting subtest: alpha-basic [459.321946] Starting dynamic subtest: pipe-A-eDP-1 [461.243255] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.919s) [461.271312] Starting dynamic subtest: pipe-D-eDP-1 [463.983973] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.721s) [463.986341] Subtest alpha-basic: SUCCESS (4.951s) [464.864907] [086/156] (570s left) kms_cursor_crc (cursor-rapid-movement-32x32) [464.988380] Starting subtest: cursor-rapid-movement-32x32 [465.036070] Subtest cursor-rapid-movement-32x32: SKIP (0.042s) [465.304009] [087/156] (570s left) syncobj_timeline (host-signal-points) [465.361692] Starting subtest: host-signal-points [465.367091] Subtest host-signal-points: SUCCESS (0.004s) [465.458679] [088/156] (570s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [465.533219] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [465.634267] [089/156] (569s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [465.717950] Starting subtest: ccs-on-another-bo-y-tiled-ccs [465.720264] Starting dynamic subtest: pipe-A-eDP-1 [465.743032] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [465.754249] Starting dynamic subtest: pipe-B-eDP-1 [465.776062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [465.785519] Starting dynamic subtest: pipe-C-eDP-1 [465.803804] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [465.812517] Starting dynamic subtest: pipe-D-eDP-1 [465.830855] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [465.834284] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [468.040291] [090/156] (567s left) gem_exec_schedule (preempt-other) [468.118993] Starting subtest: preempt-other [468.121128] Starting dynamic subtest: rcs0 [468.186479] Dynamic subtest rcs0: SUCCESS (0.073s) [468.196609] Starting dynamic subtest: bcs0 [468.251735] Dynamic subtest bcs0: SUCCESS (0.064s) [468.262941] Starting dynamic subtest: vcs0 [468.315372] Dynamic subtest vcs0: SUCCESS (0.063s) [468.326156] Starting dynamic subtest: vcs1 [468.382379] Dynamic subtest vcs1: SUCCESS (0.065s) [468.397134] Starting dynamic subtest: vecs0 [468.447588] Dynamic subtest vecs0: SUCCESS (0.065s) [468.457447] Starting dynamic subtest: ccs0 [468.515540] Dynamic subtest ccs0: SUCCESS (0.066s) [468.517888] Subtest preempt-other: SUCCESS (0.402s) [469.327336] [091/156] (566s left) gem_ctx_persistence (legacy-engines-queued) [469.374218] Starting subtest: legacy-engines-queued [469.376437] Starting dynamic subtest: render [469.419512] Dynamic subtest render: SUCCESS (0.047s) [469.431733] Starting dynamic subtest: bsd1 [471.197298] Dynamic subtest bsd1: SUCCESS (1.773s) [471.209191] Starting dynamic subtest: bsd2 [473.180474] Dynamic subtest bsd2: SUCCESS (1.980s) [473.194391] Starting dynamic subtest: blt [473.216294] Dynamic subtest blt: SUCCESS (0.035s) [473.225517] Starting dynamic subtest: vebox [475.227659] Dynamic subtest vebox: SUCCESS (2.008s) [475.230487] Subtest legacy-engines-queued: SUCCESS (5.857s) [475.309417] [092/156] (560s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [475.355394] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [475.456594] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s) [475.535280] [093/156] (560s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [475.619599] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [475.621772] Starting dynamic subtest: pipe-A-default-mode [476.796407] Dynamic subtest pipe-A-default-mode: SKIP (1.172s) [476.800782] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.174s) [476.940412] [094/156] (558s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [477.020524] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc [477.024804] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [477.118119] [095/156] (558s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [477.166568] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [477.220965] [096/156] (558s left) dmabuf_sync_file (import-multiple-read-only) [477.262356] Starting subtest: import-multiple-read-only [477.264590] Subtest import-multiple-read-only: SUCCESS (0.003s) [477.318334] [097/156] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [477.404285] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [477.408768] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [477.507812] [098/156] (558s left) i915_pm_rps (min-max-config-loaded) [477.574895] Starting subtest: min-max-config-loaded [477.579660] Subtest min-max-config-loaded: SKIP (0.001s) [477.702026] [099/156] (558s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render) [477.781789] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render [477.785250] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [477.879415] [100/156] (558s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [477.928933] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [478.034174] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s) [478.120414] [101/156] (557s left) gem_busy (semaphore) [478.310345] Subtest semaphore: SKIP (0.000s) [478.536300] [102/156] (557s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [478.589723] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [478.594209] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [478.773442] [103/156] (557s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [478.860453] Starting subtest: psr2-primary-plane-update-sf-dmg-area [478.863054] Starting dynamic subtest: pipe-A-eDP-1 [484.741466] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.885s) [484.752819] Starting dynamic subtest: pipe-B-eDP-1 [491.400887] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.658s) [491.403195] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.545s) [492.274157] [104/156] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [492.357017] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [492.361399] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [492.473532] [105/156] (543s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [492.555661] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [492.557802] Starting dynamic subtest: pipe-A-eDP-1 [492.652712] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [492.662679] Starting dynamic subtest: pipe-B-eDP-1 [493.840437] Dynamic subtest pipe-B-eDP-1: SKIP (1.184s) [493.845055] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.286s) [495.028489] [106/156] (541s left) gem_workarounds (basic-read-fd) [495.090735] Starting subtest: basic-read-fd [495.102673] Subtest basic-read-fd: SUCCESS (0.011s) [495.208491] [107/156] (541s left) kms_prop_blob (blob-multiple) [495.259804] Starting subtest: blob-multiple [495.262098] Subtest blob-multiple: SUCCESS (0.002s) [495.382250] [108/156] (540s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [495.454702] Starting subtest: fbc-psr2-sprite-mmap-cpu [495.456857] Starting dynamic subtest: eDP-1 [495.461183] Dynamic subtest eDP-1: SKIP (0.000s) [495.465449] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [495.528210] [109/156] (540s left) syncobj_eventfd (invalid-bad-pad) [495.577410] Starting subtest: invalid-bad-pad [495.579303] Subtest invalid-bad-pad: SUCCESS (0.000s) [495.678500] [110/156] (540s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc) [495.759837] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc [495.764227] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [495.838700] [111/156] (540s left) kms_pm_backlight (fade-with-dpms) [495.904860] Starting subtest: fade-with-dpms [498.104396] Starting dynamic subtest: eDP-1 [501.105998] Dynamic subtest eDP-1: SUCCESS (3.001s) [501.108604] Subtest fade-with-dpms: SUCCESS (5.202s) [501.990604] [112/156] (534s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [502.070360] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [502.074669] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [502.158223] [113/156] (534s left) gem_exec_reloc (basic-wc-cpu-noreloc) [502.218380] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [502.287672] [114/156] (534s left) gem_softpin (reverse) [502.349051] Starting subtest: reverse [502.351422] Subtest reverse: SUCCESS (0.005s) [502.464767] [115/156] (534s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt) [502.540072] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt [502.544239] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [502.632948] [116/156] (534s left) kms_psr (fbc-psr-cursor-blt) [502.710235] Starting subtest: fbc-psr-cursor-blt [502.712563] Starting dynamic subtest: eDP-1 [502.716998] Dynamic subtest eDP-1: SKIP (0.000s) [502.721428] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [502.796305] [117/156] (533s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [502.869824] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [502.874224] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [502.945380] [118/156] (533s left) sw_sync (sync_random_merge) [502.981762] Starting subtest: sync_random_merge [503.028729] Subtest sync_random_merge: SUCCESS (0.048s) [503.092740] [119/156] (533s left) kms_psr (psr-primary-mmap-cpu) [503.163440] Starting subtest: psr-primary-mmap-cpu [503.165391] Starting dynamic subtest: eDP-1 [504.883762] Dynamic subtest eDP-1: SUCCESS (1.720s) [504.886065] Subtest psr-primary-mmap-cpu: SUCCESS (1.722s) [505.731778] [120/156] (531s left) kms_cursor_crc (cursor-offscreen-64x64) [505.876734] Starting subtest: cursor-offscreen-64x64 [505.881913] Starting dynamic subtest: pipe-A-eDP-1 [507.816455] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [507.846201] Starting dynamic subtest: pipe-D-eDP-1 [510.437933] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s) [510.440331] Subtest cursor-offscreen-64x64: SUCCESS (4.560s) [511.303242] [121/156] (525s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [511.348081] Starting subtest: invalid-multi-wait-all-unsubmitted [511.350431] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [511.456456] [122/156] (525s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc) [511.538334] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc [511.543103] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [511.661229] [123/156] (525s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [511.739606] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf [511.742612] Starting dynamic subtest: pipe-A-eDP-1 [511.825320] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s) [511.838863] Starting dynamic subtest: pipe-B-eDP-1 [512.984740] Dynamic subtest pipe-B-eDP-1: SKIP (1.156s) [512.989095] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.249s) [514.187890] [124/156] (522s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [514.275611] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [514.279631] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [514.373185] [125/156] (522s left) kms_big_fb (4-tiled-addfb) [514.454629] Starting subtest: 4-tiled-addfb [514.456796] Subtest 4-tiled-addfb: SUCCESS (0.000s) [514.557258] [126/156] (522s left) kms_addfb_basic (basic) [514.602076] Starting subtest: basic [514.604233] Subtest basic: SUCCESS (0.000s) [514.723335] [127/156] (522s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt) [514.795138] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt [514.799178] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [514.888244] [128/156] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [514.964111] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [514.968239] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [515.055399] [129/156] (522s left) kms_vrr (negative-basic) [515.124717] Starting subtest: negative-basic [515.130037] Starting dynamic subtest: pipe-A-eDP-1 [520.548941] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.417s) [520.841897] Subtest negative-basic: SUCCESS (5.717s) [521.703935] [130/156] (515s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [521.780313] Starting subtest: blocking-absolute-wf_vblank-interruptible [521.782528] Starting dynamic subtest: A-eDP1 [530.465192] Dynamic subtest A-eDP1: SUCCESS (8.683s) [530.477228] Starting dynamic subtest: B-eDP1 [539.198602] Dynamic subtest B-eDP1: SUCCESS (8.731s) [539.212929] Starting dynamic subtest: C-eDP1 [547.908654] Dynamic subtest C-eDP1: SUCCESS (8.707s) [547.921265] Starting dynamic subtest: D-eDP1 [556.637677] Dynamic subtest D-eDP1: SUCCESS (8.726s) [556.640069] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.860s) [557.863440] [131/156] (479s left) kms_atomic_transition (plane-all-transition-fencing) [557.942093] Starting subtest: plane-all-transition-fencing [557.944395] Starting dynamic subtest: pipe-A-eDP-1 [560.437057] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [560.747244] Starting dynamic subtest: pipe-B-eDP-1 [563.986488] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.247s) [564.286718] Subtest plane-all-transition-fencing: SUCCESS (6.343s) [565.104387] [132/156] (472s left) gem_mmap_gtt (cpuset-medium-copy-xy) [565.168381] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [565.232592] [133/156] (472s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [565.310274] Starting subtest: modeset-transition-nonblocking-fencing [565.312958] Starting dynamic subtest: 1x-outputs [576.603972] Dynamic subtest 1x-outputs: SUCCESS (11.295s) [576.606710] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.297s) [577.467543] [134/156] (459s left) gem_exec_reloc (basic-cpu-gtt) [577.518943] Subtest basic-cpu-gtt: SKIP (0.000s) [577.590853] [135/156] (459s left) syncobj_timeline (invalid-signal-illegal-point) [577.636778] Starting subtest: invalid-signal-illegal-point [577.639069] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [577.728139] [136/156] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [577.801410] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [577.805795] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [577.900596] [137/156] (459s left) syncobj_wait (wait-for-submit-complex) [577.948226] Starting subtest: wait-for-submit-complex [578.008084] Subtest wait-for-submit-complex: SUCCESS (0.061s) [578.085885] [138/156] (459s left) gem_exec_reloc (basic-wc) [578.140970] Subtest basic-wc: SKIP (0.000s) [578.207981] [139/156] (459s left) prime_mmap_coherency (read) [578.261766] Starting subtest: read [583.637119] Subtest read: SUCCESS (5.377s) [583.772160] [140/156] (453s left) api_intel_bb (simple-bb) [583.823429] Starting subtest: simple-bb [583.829449] Subtest simple-bb: SUCCESS (0.010s) [583.953572] [141/156] (453s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [584.047800] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [584.051961] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [584.143425] [142/156] (453s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [584.526324] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [585.389986] [143/156] (452s left) kms_sequence (get-idle) [585.468334] Starting subtest: get-idle [585.470687] Starting dynamic subtest: pipe-A-eDP-1 [587.269252] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s) [587.279544] Starting dynamic subtest: pipe-B-eDP-1 [589.778371] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.506s) [589.788869] Starting dynamic subtest: pipe-C-eDP-1 [592.294069] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.513s) [592.304958] Starting dynamic subtest: pipe-D-eDP-1 [594.723760] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s) [594.726319] Subtest get-idle: SUCCESS (9.257s) [595.545115] [144/156] (442s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [595.619950] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [595.629210] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.008s) [595.733423] [145/156] (442s left) prime_mmap (test_invalid_sync_flags) [595.776923] Starting subtest: test_invalid_sync_flags [595.779248] Starting dynamic subtest: test_invalid_sync_flags-smem [595.781418] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [595.783606] Subtest test_invalid_sync_flags: SUCCESS (0.001s) [595.871265] [146/156] (442s left) kms_color_pipeline (plane-lut1d-ctm3x4) [595.943930] Starting subtest: plane-lut1d-ctm3x4 [596.071621] Starting dynamic subtest: pipe-A-plane-0 [596.212931] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [596.223532] Starting dynamic subtest: pipe-A-plane-1 [596.399955] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [596.410706] Starting dynamic subtest: pipe-A-plane-2 [596.544459] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s) [597.764475] Starting dynamic subtest: pipe-B-plane-0 [597.943307] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s) [597.954180] Starting dynamic subtest: pipe-B-plane-1 [598.122095] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s) [598.134862] Starting dynamic subtest: pipe-B-plane-2 [598.277320] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [599.443990] Starting dynamic subtest: pipe-C-plane-0 [599.568690] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [599.578529] Starting dynamic subtest: pipe-C-plane-1 [599.736728] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [599.746733] Starting dynamic subtest: pipe-C-plane-2 [599.891289] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [601.092158] Starting dynamic subtest: pipe-D-plane-0 [601.240711] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [601.251106] Starting dynamic subtest: pipe-D-plane-1 [601.395419] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [601.407790] Starting dynamic subtest: pipe-D-plane-2 [601.527628] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s) [601.815561] Subtest plane-lut1d-ctm3x4: SUCCESS (5.871s) [602.660610] [147/156] (435s left) gem_exec_balancer (individual) [602.719590] Starting subtest: individual [604.223370] Subtest individual: SUCCESS (1.502s) [604.545305] [148/156] (433s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc) [604.628062] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc [604.632200] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [604.734780] [149/156] (433s left) kms_dsc (dsc-fractional-bpp) [604.820766] Starting subtest: dsc-fractional-bpp [604.834039] Subtest dsc-fractional-bpp: SKIP (0.000s) [604.899915] [150/156] (433s left) gem_exec_basic (basic) [604.963378] Starting subtest: basic [604.965688] Starting dynamic subtest: rcs0-smem [604.967934] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [604.979490] Starting dynamic subtest: bcs0-smem [604.981714] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [604.991622] Starting dynamic subtest: vcs0-smem [604.993849] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [605.003750] Starting dynamic subtest: vcs1-smem [605.005998] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [605.015822] Starting dynamic subtest: vecs0-smem [605.018060] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [605.027476] Starting dynamic subtest: ccs0-smem [605.029671] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [605.031843] Subtest basic: SUCCESS (0.013s) [606.245846] [151/156] (431s left) perf_pmu (busy-accuracy-2) [606.284254] Starting subtest: busy-accuracy-2 [606.286660] Starting dynamic subtest: rcs0 [609.323867] Dynamic subtest rcs0: SUCCESS (3.042s) [609.337049] Starting dynamic subtest: bcs0 [612.376659] Dynamic subtest bcs0: SUCCESS (3.049s) [612.390224] Starting dynamic subtest: vcs0 [615.418938] Dynamic subtest vcs0: SUCCESS (3.041s) [615.431537] Starting dynamic subtest: vcs1 [618.464079] Dynamic subtest vcs1: SUCCESS (3.042s) [618.474355] Starting dynamic subtest: vecs0 [621.505881] Dynamic subtest vecs0: SUCCESS (3.039s) [621.518961] Starting dynamic subtest: ccs0 [624.562980] Dynamic subtest ccs0: SUCCESS (3.055s) [624.565044] Subtest busy-accuracy-2: SUCCESS (18.282s) [624.692925] [152/156] (413s left) perf (non-sampling-read-error) [624.823695] Starting subtest: non-sampling-read-error [624.834105] Subtest non-sampling-read-error: SUCCESS (0.010s) [624.880749] [153/156] (413s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [624.966433] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [631.794535] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.835s) [631.920491] [154/156] (406s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [632.008447] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [632.012768] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [632.105248] [155/156] (406s left) kms_psr (pr-sprite-plane-onoff) [632.174076] Starting subtest: pr-sprite-plane-onoff [632.178485] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [632.249891] [156/156] (406s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [632.327681] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [632.331744] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [632.407082] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_wc results: parsing output: 1/ for test: kms_hdr results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: gem_exec_reloc results: parsing output: 4/ for test: gem_render_copy results: parsing output: 5/ for test: gem_exec_parallel results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: gen9_exec_parse results: parsing output: 11/ for test: i915_pciid results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: gem_exec_fence results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_userptr_blits results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_ctx_param results: parsing output: 19/ for test: kms_rmfb results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: i915_suspend results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_getfb results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_lease results: parsing output: 29/ for test: gem_ccs results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_chamelium_frames results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_plane_multiple results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: kms_cdclk results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_plane results: parsing output: 38/ for test: gem_exec_fence results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: gem_lmem_swapping results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: kms_joiner results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: api_intel_allocator results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_scaling_modes results: parsing output: 50/ for test: prime_self_import results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: kms_content_protection results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_pm_rpm results: parsing output: 59/ for test: perf_pmu results: parsing output: 60/ for test: kms_busy results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_rotation_crc results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_cursor_legacy results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_eio results: parsing output: 73/ for test: gem_ctx_persistence results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: i915_query results: parsing output: 76/ for test: gem_mmap_offset results: parsing output: 77/ for test: i915_drm_fdinfo 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: sysfs_timeslice_duration results: parsing output: 82/ for test: gem_exec_store results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_plane_alpha_blend results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: gem_ctx_persistence results: parsing output: 91/ for test: syncobj_wait results: parsing output: 92/ for test: kms_flip_scaled_crc results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_mmap_wc results: parsing output: 95/ for test: dmabuf_sync_file results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: i915_pm_rps results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: gem_busy results: parsing output: 101/ for test: gem_render_copy results: parsing output: 102/ for test: kms_psr2_sf results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: gem_workarounds results: parsing output: 106/ for test: kms_prop_blob results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: syncobj_eventfd results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_pm_backlight results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: gem_softpin results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_flip_scaled_crc results: parsing output: 117/ for test: sw_sync results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_psr2_sf results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_addfb_basic results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_vrr results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_atomic_transition results: parsing output: 131/ for test: gem_mmap_gtt results: parsing output: 132/ for test: kms_atomic_transition results: parsing output: 133/ for test: gem_exec_reloc results: parsing output: 134/ for test: syncobj_timeline results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: syncobj_wait results: parsing output: 137/ for test: gem_exec_reloc results: parsing output: 138/ for test: prime_mmap_coherency results: parsing output: 139/ for test: api_intel_bb results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_chamelium_hpd results: parsing output: 142/ for test: kms_sequence results: parsing output: 143/ for test: kms_flip results: parsing output: 144/ for test: prime_mmap results: parsing output: 145/ for test: kms_color_pipeline results: parsing output: 146/ for test: gem_exec_balancer results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_dsc results: parsing output: 149/ for test: gem_exec_basic results: parsing output: 150/ for test: perf_pmu results: parsing output: 151/ for test: perf results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_psr results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.