[59.756354] Initializing watchdogs [59.756403] /dev/watchdog0 [59.771396] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.776398] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.778778] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.780690] [001/132] (960s left) syncobj_wait (single-wait-signaled) [59.834474] Starting subtest: single-wait-signaled [59.835420] Subtest single-wait-signaled: SUCCESS (0.000s) [59.920974] [002/132] (960s left) kms_vrr (seamless-rr-switch-vrr) [60.018292] Starting subtest: seamless-rr-switch-vrr [60.021079] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [60.083685] [003/132] (960s left) api_intel_allocator (standalone) [60.140084] Starting subtest: standalone [60.158959] Subtest standalone: SUCCESS (0.020s) [60.265456] [004/132] (960s left) gem_exec_schedule (u-fairslice) [60.325075] Starting subtest: u-fairslice [60.325987] Starting dynamic subtest: rcs0 [62.352569] Dynamic subtest rcs0: SUCCESS (2.024s) [62.359029] Starting dynamic subtest: bcs0 [64.374364] Dynamic subtest bcs0: SUCCESS (2.024s) [64.383796] Starting dynamic subtest: vcs0 [66.400573] Dynamic subtest vcs0: SUCCESS (2.021s) [66.406650] Starting dynamic subtest: vcs1 [68.418787] Dynamic subtest vcs1: SUCCESS (2.021s) [68.426867] Starting dynamic subtest: vecs0 [70.437764] Dynamic subtest vecs0: SUCCESS (2.017s) [70.443115] Starting dynamic subtest: ccs0 [72.457090] Dynamic subtest ccs0: SUCCESS (2.020s) [72.457953] Subtest u-fairslice: SUCCESS (12.128s) [72.746484] [005/132] (947s left) kms_pm_backlight (fade) [72.831090] Starting subtest: fade [72.926268] Starting dynamic subtest: eDP-1 [75.407633] Dynamic subtest eDP-1: SUCCESS (2.481s) [75.408727] Subtest fade: SUCCESS (2.577s) [76.259510] [006/132] (944s left) gem_userptr_blits (unsync-unmap-after-close) [76.311070] Subtest unsync-unmap-after-close: SKIP (0.000s) [76.420871] [007/132] (944s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [76.796416] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [77.571809] [008/132] (942s left) syncobj_wait (multi-wait-all-submitted) [77.636611] Starting subtest: multi-wait-all-submitted [77.740806] Subtest multi-wait-all-submitted: SUCCESS (0.103s) [77.811052] [009/132] (942s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [77.905141] Starting subtest: crc-primary-basic-yf-tiled-ccs [77.906037] Starting dynamic subtest: pipe-A-eDP-1 [77.914649] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [77.921481] Starting dynamic subtest: pipe-B-eDP-1 [77.929826] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [77.935428] Starting dynamic subtest: pipe-C-eDP-1 [77.943688] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [77.949337] Starting dynamic subtest: pipe-D-eDP-1 [77.959253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [77.960943] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s) [80.158397] [010/132] (940s left) gem_exec_reloc (basic-gtt-wc) [80.207411] Subtest basic-gtt-wc: SKIP (0.000s) [80.271862] [011/132] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [80.359734] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [80.361569] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [80.446333] [012/132] (940s left) sysfs_heartbeat_interval (precise) [80.495150] Starting subtest: precise [80.496153] Starting dynamic subtest: vecs0 [86.877065] Dynamic subtest vecs0: SUCCESS (6.372s) [86.886086] Starting dynamic subtest: ccs0 [87.942671] Dynamic subtest ccs0: SUCCESS (1.073s) [87.950582] Starting dynamic subtest: vcs0 [95.900032] Dynamic subtest vcs0: SUCCESS (7.948s) [95.908509] Starting dynamic subtest: bcs0 [97.022282] Dynamic subtest bcs0: SUCCESS (1.130s) [97.030507] Starting dynamic subtest: rcs0 [98.124819] Dynamic subtest rcs0: SUCCESS (1.101s) [98.134792] Starting dynamic subtest: vcs1 [105.875797] Dynamic subtest vcs1: SUCCESS (7.751s) [105.877253] Subtest precise: SUCCESS (25.381s) [105.950332] [013/132] (914s left) kms_getfb (getfb-handle-protection) [106.046162] Starting subtest: getfb-handle-protection [106.067161] Subtest getfb-handle-protection: SUCCESS (0.021s) [106.158522] [014/132] (914s left) gem_workarounds (reset) [106.225552] Starting subtest: reset [106.376192] Subtest reset: SUCCESS (0.151s) [106.495951] [015/132] (914s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [106.581423] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [106.582591] Starting dynamic subtest: pipe-A-eDP-1 [106.591340] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [106.597545] Starting dynamic subtest: pipe-B-eDP-1 [106.606871] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [106.613997] Starting dynamic subtest: pipe-C-eDP-1 [106.621804] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [106.627732] Starting dynamic subtest: pipe-D-eDP-1 [106.635495] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [106.637093] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [108.737016] [016/132] (912s left) gem_userptr_blits (process-exit-busy) [108.817050] Starting subtest: process-exit-busy [108.835235] Subtest process-exit-busy: SUCCESS (0.018s) [108.962771] [017/132] (911s left) kms_plane_multiple (tiling-none) [109.059076] Starting subtest: tiling-none [109.060084] Starting dynamic subtest: pipe-A-eDP-1 [112.878713] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.818s) [112.886317] Starting dynamic subtest: pipe-B-eDP-1 [117.205100] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.327s) [117.213473] Starting dynamic subtest: pipe-C-eDP-1 [121.546330] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.340s) [121.553557] Starting dynamic subtest: pipe-D-eDP-1 [125.906937] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.359s) [125.907846] Subtest tiling-none: SUCCESS (16.848s) [126.701343] [018/132] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [126.793614] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [133.464950] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.671s) [133.594396] [019/132] (887s left) prime_udl [133.666882] [020/132] (887s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [133.761160] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [133.762886] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s) [133.824819] [021/132] (887s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [133.914059] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [133.915819] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [134.011262] [022/132] (886s left) gem_mmap_offset (partial-unmap) [134.061460] Starting subtest: partial-unmap [134.062464] Starting dynamic subtest: smem0 [134.577862] Dynamic subtest smem0: SUCCESS (0.506s) [134.579442] Subtest partial-unmap: SUCCESS (0.507s) [134.663998] [023/132] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [134.762684] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [142.334542] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.572s) [142.462295] [024/132] (878s left) kms_busy (basic-hang) [142.547161] Starting subtest: basic-hang [142.547935] Starting dynamic subtest: flip-pipe-A [143.163670] Dynamic subtest flip-pipe-A: SUCCESS (0.614s) [143.170610] Starting dynamic subtest: modeset-pipe-A [146.588948] Dynamic subtest modeset-pipe-A: SUCCESS (3.425s) [146.596099] Starting dynamic subtest: flip-pipe-D [147.778394] Dynamic subtest flip-pipe-D: SUCCESS (1.187s) [147.785148] Starting dynamic subtest: modeset-pipe-D [151.229739] Dynamic subtest modeset-pipe-D: SUCCESS (3.451s) [151.230624] Subtest basic-hang: SUCCESS (8.682s) [152.017761] [025/132] (868s left) gem_mmap_wc (fault-concurrent) [152.060853] Subtest fault-concurrent: SKIP (0.000s) [152.115224] [026/132] (868s left) prime_mmap (test_aperture_limit) [152.163421] Starting subtest: test_aperture_limit [152.164345] Starting dynamic subtest: test_aperture_limit-smem [152.183583] Dynamic subtest test_aperture_limit-smem: SKIP (0.020s) [152.185641] Subtest test_aperture_limit: SKIP (0.021s) [152.249879] [027/132] (868s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [152.334750] Starting subtest: plane-all-modeset-transition-fencing [152.336580] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [152.410594] [028/132] (868s left) gem_create (create-size-update) [152.453753] Starting subtest: create-size-update [152.455031] Subtest create-size-update: SUCCESS (0.000s) [152.664206] [029/132] (868s left) gem_exec_create (legacy) [152.713775] Starting subtest: legacy [152.714715] Starting dynamic subtest: smem [154.806409] Dynamic subtest smem: SUCCESS (2.093s) [154.808775] Subtest legacy: SUCCESS (2.094s) [154.987184] [030/132] (866s left) gem_exec_schedule (noreorder) [155.186956] Starting subtest: noreorder [155.188063] Starting dynamic subtest: rcs0 [155.270699] Dynamic subtest rcs0: SUCCESS (0.090s) [155.279727] Starting dynamic subtest: vcs0 [156.871667] Dynamic subtest vcs0: SUCCESS (1.590s) [156.879253] Starting dynamic subtest: vcs1 [158.856499] Dynamic subtest vcs1: SUCCESS (1.982s) [158.865786] Starting dynamic subtest: vecs0 [160.925058] Dynamic subtest vecs0: SUCCESS (2.065s) [160.933661] Starting dynamic subtest: ccs0 [160.989397] Dynamic subtest ccs0: SUCCESS (0.073s) [160.992386] Subtest noreorder: SUCCESS (5.810s) [161.184365] [031/132] (860s left) kms_vblank (query-busy-hang) [161.291936] Starting subtest: query-busy-hang [161.292981] Starting dynamic subtest: pipe-A-eDP-1 [187.682967] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.389s) [187.692996] Starting dynamic subtest: pipe-D-eDP-1 [202.728176] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.042s) [202.728962] Subtest query-busy-hang: SUCCESS (41.435s) [203.581010] [032/132] (817s left) kms_flip (2x-blocking-wf_vblank) [203.666852] Starting subtest: 2x-blocking-wf_vblank [203.676586] Subtest 2x-blocking-wf_vblank: SKIP (0.011s) [203.746662] [033/132] (817s left) gem_exec_reloc (basic-wc-cpu) [203.795471] Subtest basic-wc-cpu: SKIP (0.000s) [203.858386] [034/132] (817s left) syncobj_timeline (invalid-signal-zero-handles) [203.907379] Starting subtest: invalid-signal-zero-handles [203.908353] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [203.993749] [035/132] (817s left) kms_hdr (static-swap) [204.079414] Starting subtest: static-swap [204.081741] Subtest static-swap: SKIP (0.000s) [204.144885] [036/132] (817s left) kms_psr (psr2-primary-mmap-gtt) [204.221168] Starting subtest: psr2-primary-mmap-gtt [204.222010] Starting dynamic subtest: eDP-1 [205.689826] Dynamic subtest eDP-1: SKIP (1.466s) [205.692813] Subtest psr2-primary-mmap-gtt: SKIP (1.467s) [205.824346] [037/132] (815s left) kms_plane_scaling (2x-scaler-multi-pipe) [205.903940] Starting subtest: 2x-scaler-multi-pipe [205.906457] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [205.992051] [038/132] (815s left) gem_exec_balancer (individual) [206.051683] Starting subtest: individual [207.905853] Subtest individual: SUCCESS (1.843s) [208.199394] [039/132] (813s left) gem_softpin (evict-prime) [208.249523] Starting subtest: evict-prime [208.250391] Starting dynamic subtest: rcs0 [209.407553] Dynamic subtest rcs0: SUCCESS (1.157s) [209.418812] Starting dynamic subtest: bcs0 [210.528506] Dynamic subtest bcs0: SUCCESS (1.120s) [210.537460] Starting dynamic subtest: vcs0 [211.871199] Dynamic subtest vcs0: SUCCESS (1.331s) [211.880584] Starting dynamic subtest: vcs1 [213.924155] Dynamic subtest vcs1: SUCCESS (2.052s) [213.934138] Starting dynamic subtest: vecs0 [215.902378] Dynamic subtest vecs0: SUCCESS (1.976s) [215.912821] Starting dynamic subtest: ccs0 [217.021685] Dynamic subtest ccs0: SUCCESS (1.128s) [217.032231] Starting dynamic subtest: all [218.908941] Dynamic subtest all: SUCCESS (1.875s) [218.910054] Subtest evict-prime: SUCCESS (10.649s) [218.972722] [040/132] (802s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [219.088360] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [219.090139] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [219.226819] [041/132] (802s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [219.315158] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [219.316073] Starting dynamic subtest: pipe-A-eDP-1 [219.338133] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [219.345777] Starting dynamic subtest: pipe-B-eDP-1 [219.368042] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [219.375122] Starting dynamic subtest: pipe-C-eDP-1 [219.395315] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [219.401699] Starting dynamic subtest: pipe-D-eDP-1 [219.421258] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [219.423294] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [221.572021] [042/132] (799s left) kms_prop_blob (blob-prop-lifetime) [221.624819] Starting subtest: blob-prop-lifetime [221.625903] Subtest blob-prop-lifetime: SUCCESS (0.001s) [221.710595] [043/132] (799s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [221.810145] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [228.966567] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.157s) [229.085273] [044/132] (792s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [229.180509] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [229.181426] Starting dynamic subtest: pipe-A-eDP-1 [229.190161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [229.197258] Starting dynamic subtest: pipe-B-eDP-1 [229.204729] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [229.213922] Starting dynamic subtest: pipe-C-eDP-1 [229.221033] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [229.227638] Starting dynamic subtest: pipe-D-eDP-1 [229.234891] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [229.235699] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.010s) [231.454884] [045/132] (790s left) kms_chamelium_frames (dp-crc-fast) [231.842895] Subtest dp-crc-fast: SKIP (0.000s) [232.636834] [046/132] (789s left) gem_barrier_race (remote-request) [232.698710] Starting subtest: remote-request [232.699690] Starting dynamic subtest: rcs0 [237.871151] Dynamic subtest rcs0: SUCCESS (5.173s) [237.872124] Subtest remote-request: SUCCESS (5.175s) [238.016646] [047/132] (783s left) kms_vrr (flip-basic-fastset) [238.108203] Starting subtest: flip-basic-fastset [238.110873] Subtest flip-basic-fastset: SKIP (0.000s) [238.173249] [048/132] (783s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [238.288230] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [238.289893] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [238.424201] [049/132] (783s left) kms_cursor_crc (cursor-random-64x21) [238.619358] Starting subtest: cursor-random-64x21 [238.665224] Subtest cursor-random-64x21: SKIP (0.043s) [238.911494] [050/132] (782s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [239.023966] Starting subtest: cursorA-vs-flipA-legacy [250.161076] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.137s) [250.985685] [051/132] (770s left) syncobj_timeline (reset-signaled) [251.041803] Starting subtest: reset-signaled [251.042604] Subtest reset-signaled: SUCCESS (0.001s) [251.143276] [052/132] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [251.225231] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [251.227026] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [251.315031] [053/132] (770s left) kms_psr (fbc-pr-cursor-blt) [251.398985] Starting subtest: fbc-pr-cursor-blt [251.400525] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [251.465057] [054/132] (770s left) gem_userptr_blits (dmabuf-unsync) [251.517350] Subtest dmabuf-unsync: SKIP (0.000s) [251.642130] [055/132] (770s left) kms_big_fb (4-tiled-64bpp-rotate-270) [251.741872] Starting subtest: 4-tiled-64bpp-rotate-270 [251.762210] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s) [251.870706] [056/132] (770s left) kms_psr (fbc-psr-cursor-render) [251.962858] Starting subtest: fbc-psr-cursor-render [251.964159] Starting dynamic subtest: eDP-1 [251.966244] Dynamic subtest eDP-1: SKIP (0.000s) [251.968125] Subtest fbc-psr-cursor-render: SKIP (0.001s) [252.029292] [057/132] (769s left) gem_render_copy (x-tiled) [252.097559] Starting subtest: x-tiled [252.098627] Starting dynamic subtest: smem [252.140960] Dynamic subtest smem: SUCCESS (0.043s) [252.141983] Subtest x-tiled: SUCCESS (0.044s) [252.371375] [058/132] (769s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [252.462629] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [252.464185] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [252.545621] [059/132] (769s left) gem_exec_fence (submit3) [252.721738] Starting subtest: submit3 [252.723580] Subtest submit3: SKIP (0.000s) [255.006449] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [255.008652] [060/132] (767s left) i915_pm_rpm (sysfs-read) [257.029076] Starting subtest: sysfs-read [258.178853] Subtest sysfs-read: SUCCESS (1.148s) [258.576536] [061/132] (763s left) kms_atomic_transition (plane-toggle-modeset-transition) [258.663128] Starting subtest: plane-toggle-modeset-transition [258.664079] Starting dynamic subtest: pipe-A-eDP-1 [271.410238] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.746s) [271.423825] Starting dynamic subtest: pipe-B-eDP-1 [283.847962] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.433s) [283.851369] Subtest plane-toggle-modeset-transition: SUCCESS (25.185s) [284.650722] [062/132] (737s left) gem_lmem_swapping (heavy-verify-random-ccs) [284.684356] Subtest heavy-verify-random-ccs: SKIP (0.000s) [284.726502] [063/132] (737s left) kms_cursor_crc (cursor-tearing-position-change) [284.837130] Starting subtest: cursor-tearing-position-change [284.838087] Starting dynamic subtest: pipe-A-eDP-1 [285.402099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s) [285.411603] Starting dynamic subtest: pipe-D-eDP-1 [286.601674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.198s) [286.602547] Subtest cursor-tearing-position-change: SUCCESS (1.764s) [287.430593] [064/132] (734s left) i915_drm_fdinfo (virtual-busy-hang) [287.470321] Starting subtest: virtual-busy-hang [287.471999] Subtest virtual-busy-hang: SKIP (0.000s) [287.552966] [065/132] (734s left) syncobj_timeline (single-wait-for-submit-available-signaled) [287.598113] Starting subtest: single-wait-for-submit-available-signaled [287.598939] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [287.690566] [066/132] (734s left) kms_legacy_colorkey (invalid-plane) [287.771174] Starting subtest: invalid-plane [287.772069] Starting dynamic subtest: zero-id [287.772928] Dynamic subtest zero-id: SUCCESS (0.000s) [287.781891] Starting dynamic subtest: outrange-id [287.782843] Dynamic subtest outrange-id: SUCCESS (0.000s) [287.783878] Subtest invalid-plane: SUCCESS (0.001s) [287.853756] [067/132] (734s left) kms_cursor_crc (cursor-offscreen-256x256) [288.087026] Starting subtest: cursor-offscreen-256x256 [288.090027] Starting dynamic subtest: pipe-A-eDP-1 [290.020988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s) [290.052061] Starting dynamic subtest: pipe-D-eDP-1 [292.671034] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.625s) [292.671906] Subtest cursor-offscreen-256x256: SUCCESS (4.584s) [293.498054] [068/132] (728s left) syncobj_wait (invalid-reset-bad-pad) [293.555806] Starting subtest: invalid-reset-bad-pad [293.556804] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [293.648835] [069/132] (728s left) kms_content_protection (legacy) [293.786843] Starting subtest: legacy [293.788658] Subtest legacy: SKIP (0.000s) [293.907336] [070/132] (728s left) kms_addfb_basic (bad-pitch-999) [293.963993] Starting subtest: bad-pitch-999 [293.964966] Subtest bad-pitch-999: SUCCESS (0.000s) [294.091734] [071/132] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [294.175360] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [294.177301] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [294.264784] [072/132] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [294.348674] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [294.350471] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [294.445343] [073/132] (728s left) prime_vgem (basic-fence-blt) [294.527208] Starting subtest: basic-fence-blt [294.603201] Subtest basic-fence-blt: SUCCESS (0.075s) [294.721477] [074/132] (727s left) kms_big_fb (x-tiled-16bpp-rotate-270) [294.814656] Starting subtest: x-tiled-16bpp-rotate-270 [294.834844] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s) [294.956269] [075/132] (727s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [295.059374] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [295.751608] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s) [295.929914] [076/132] (726s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [296.049721] Starting subtest: basic-flip-after-cursor-varying-size [296.975393] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s) [297.841813] [077/132] (724s left) gem_exec_whisper (basic-forked-all) [297.896125] Starting subtest: basic-forked-all [311.907034] Subtest basic-forked-all: SUCCESS (14.000s) [312.078420] [078/132] (710s left) kms_flip (basic-flip-vs-wf_vblank) [312.175969] Starting subtest: basic-flip-vs-wf_vblank [312.178376] Starting dynamic subtest: A-eDP1 [314.087434] Dynamic subtest A-eDP1: SUCCESS (1.909s) [314.096716] Starting dynamic subtest: B-eDP1 [316.021536] Dynamic subtest B-eDP1: SUCCESS (1.931s) [316.030049] Starting dynamic subtest: C-eDP1 [317.944305] Dynamic subtest C-eDP1: SUCCESS (1.921s) [317.951539] Starting dynamic subtest: D-eDP1 [319.881968] Dynamic subtest D-eDP1: SUCCESS (1.936s) [319.884778] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.707s) [321.098943] [079/132] (701s left) gem_mmap_wc (copy) [321.141528] Subtest copy: SKIP (0.000s) [321.195813] [080/132] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [321.290511] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [321.292391] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [321.378680] [081/132] (701s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [321.438588] Starting subtest: etime-multi-wait-for-submit-submitted [321.542051] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s) [321.627059] [082/132] (701s left) i915_pm_rps (thresholds-idle) [321.684580] Starting subtest: thresholds-idle [321.686402] Subtest thresholds-idle: SKIP (0.001s) [321.802114] [083/132] (701s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [321.889098] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [322.715045] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s) [322.884013] [084/132] (700s left) kms_frontbuffer_tracking (basic) [322.975574] Starting subtest: basic [326.366051] Subtest basic: SUCCESS (3.391s) [326.479544] [085/132] (696s left) syncobj_eventfd (binary-wait-before-signal) [326.526155] Starting subtest: binary-wait-before-signal [326.557397] Subtest binary-wait-before-signal: SUCCESS (0.031s) [326.629093] [086/132] (696s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [326.724648] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [330.790052] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.068s) [331.904104] [087/132] (691s left) gem_lmem_swapping (parallel-random-verify) [331.938909] Subtest parallel-random-verify: SKIP (0.000s) [331.975612] [088/132] (691s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [332.080327] Starting subtest: cursorA-vs-flipA-atomic-transitions [343.247896] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.167s) [344.133600] [089/132] (678s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [344.226917] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [344.228808] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [344.323415] [090/132] (678s left) perf (unprivileged-single-ctx-counters) [344.412099] Starting subtest: unprivileged-single-ctx-counters [344.414353] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [344.451582] [091/132] (678s left) kms_rotation_crc (bad-pixel-format) [344.538711] Starting subtest: bad-pixel-format [344.540337] Subtest bad-pixel-format: SKIP (0.001s) [344.621017] [092/132] (678s left) kms_async_flips (test-time-stamp) [344.710185] Starting subtest: test-time-stamp [345.097045] Starting dynamic subtest: pipe-A-eDP-1 [345.934348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s) [346.316515] Starting dynamic subtest: pipe-B-eDP-1 [347.068566] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s) [347.449739] Starting dynamic subtest: pipe-C-eDP-1 [348.207139] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [348.570197] Starting dynamic subtest: pipe-D-eDP-1 [349.333656] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s) [349.334858] Subtest test-time-stamp: SUCCESS (4.623s) [350.476354] [093/132] (672s left) kms_draw_crc (draw-method-mmap-wc) [350.564340] Starting subtest: draw-method-mmap-wc [350.565248] Starting dynamic subtest: xrgb8888-untiled [350.786783] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s) [350.794858] Starting dynamic subtest: rgb565-untiled [350.999387] Dynamic subtest rgb565-untiled: SUCCESS (0.210s) [351.009358] Starting dynamic subtest: xrgb2101010-untiled [351.220266] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [351.227967] Starting dynamic subtest: xbgr16161616f-untiled [351.453296] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [351.461958] Starting dynamic subtest: xrgb8888-xtiled [351.575515] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [351.582984] Starting dynamic subtest: rgb565-xtiled [351.709030] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [351.718036] Starting dynamic subtest: xrgb2101010-xtiled [351.831223] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s) [351.838864] Starting dynamic subtest: xbgr16161616f-xtiled [351.964610] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [351.974365] Starting dynamic subtest: xrgb8888-4tiled [352.131351] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.164s) [352.140341] Starting dynamic subtest: rgb565-4tiled [352.275803] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s) [352.284889] Starting dynamic subtest: xrgb2101010-4tiled [352.431741] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [352.441496] Starting dynamic subtest: xbgr16161616f-4tiled [352.620128] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.188s) [352.622376] Subtest draw-method-mmap-wc: SUCCESS (2.057s) [352.722950] [094/132] (670s left) perf_pmu (busy-start) [352.760439] Starting subtest: busy-start [352.761574] Starting dynamic subtest: rcs0 [355.311373] Dynamic subtest rcs0: SUCCESS (2.550s) [355.322361] Starting dynamic subtest: bcs0 [357.874758] Dynamic subtest bcs0: SUCCESS (2.548s) [357.885157] Starting dynamic subtest: vcs0 [361.891223] Dynamic subtest vcs0: SUCCESS (4.018s) [361.901495] Starting dynamic subtest: vcs1 [365.921297] Dynamic subtest vcs1: SUCCESS (4.027s) [365.931656] Starting dynamic subtest: vecs0 [369.953389] Dynamic subtest vecs0: SUCCESS (4.029s) [369.963850] Starting dynamic subtest: ccs0 [372.508205] Dynamic subtest ccs0: SUCCESS (2.549s) [372.509664] Subtest busy-start: SUCCESS (19.735s) [372.606307] [095/132] (650s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [372.694286] Starting subtest: pr-overlay-plane-update-sf-dmg-area [372.696100] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [372.762097] [096/132] (650s left) gem_pxp (regular-baseline-src-copy-readible) [372.887450] Starting subtest: regular-baseline-src-copy-readible [372.944953] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s) [373.077849] [097/132] (650s left) api_intel_bb (reset-flags) [373.125984] Starting subtest: reset-flags [373.132417] Subtest reset-flags: SUCCESS (0.007s) [373.252886] [098/132] (650s left) kms_big_fb (y-tiled-64bpp-rotate-180) [373.358443] Starting subtest: y-tiled-64bpp-rotate-180 [373.360229] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [373.496855] [099/132] (649s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [373.595596] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [373.596555] Starting dynamic subtest: pipe-A-default-mode [374.753739] Dynamic subtest pipe-A-default-mode: SKIP (1.157s) [374.755587] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.158s) [374.884276] [100/132] (648s left) gem_pread (exhaustion) [374.945371] Subtest exhaustion: SKIP (0.000s) [374.999961] [101/132] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [375.100916] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [375.102652] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [375.190436] [102/132] (648s left) gem_exec_reloc (basic-cpu-wc-noreloc) [375.252748] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [375.311652] [103/132] (648s left) kms_psr (pr-cursor-blt) [375.399412] Starting subtest: pr-cursor-blt [375.401160] Subtest pr-cursor-blt: SKIP (0.000s) [375.479596] [104/132] (648s left) kms_atomic_interruptible (legacy-cursor) [375.556120] Starting subtest: legacy-cursor [375.557094] Starting dynamic subtest: pipe-A-eDP-1 [382.915774] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.358s) [382.916733] Subtest legacy-cursor: SUCCESS (7.360s) [383.755552] [105/132] (639s left) gem_ctx_persistence (legacy-engines-cleanup) [383.806444] Starting subtest: legacy-engines-cleanup [383.807421] Starting dynamic subtest: render [383.861450] Dynamic subtest render: SUCCESS (0.054s) [383.870907] Starting dynamic subtest: bsd1 [383.921155] Dynamic subtest bsd1: SUCCESS (0.059s) [383.935501] Starting dynamic subtest: bsd2 [383.974051] Dynamic subtest bsd2: SUCCESS (0.050s) [383.983470] Starting dynamic subtest: blt [384.022085] Dynamic subtest blt: SUCCESS (0.045s) [384.032306] Starting dynamic subtest: vebox [384.070126] Dynamic subtest vebox: SUCCESS (0.045s) [384.072775] Subtest legacy-engines-cleanup: SUCCESS (0.265s) [384.150845] [106/132] (639s left) gem_eio (context-create) [384.360056] Starting subtest: context-create [384.657890] Subtest context-create: SUCCESS (0.297s) [384.765794] [107/132] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [384.858848] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [384.860526] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [384.943994] [108/132] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [385.029220] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [385.030943] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [385.120047] [109/132] (638s left) kms_pipe_stress (stress-xrgb8888-yftiled) [385.218345] Starting subtest: stress-xrgb8888-yftiled [385.220085] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [385.294559] [110/132] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [385.392546] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [385.394278] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [385.491580] [111/132] (638s left) kms_psr (fbc-psr2-primary-blt) [385.582120] Starting subtest: fbc-psr2-primary-blt [385.582915] Starting dynamic subtest: eDP-1 [385.584469] Dynamic subtest eDP-1: SKIP (0.000s) [385.586075] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [385.650643] [112/132] (638s left) kms_async_flips (async-flip-suspend-resume) [385.732332] Starting subtest: async-flip-suspend-resume [386.107817] Starting dynamic subtest: pipe-A-eDP-1 [404.205955] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s) [404.587725] Starting dynamic subtest: pipe-B-eDP-1 [423.206875] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.262s) [423.578487] Starting dynamic subtest: pipe-C-eDP-1 [442.212094] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.287s) [442.575466] Starting dynamic subtest: pipe-D-eDP-1 [461.207914] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.288s) [461.208742] Subtest async-flip-suspend-resume: SUCCESS (14.751s) [467.426875] [113/132] (561s left) gen7_exec_parse (batch-without-end) [467.477553] Subtest batch-without-end: SKIP (0.000s) [467.568215] [114/132] (561s left) gem_ctx_param (invalid-param-set) [467.620863] Starting subtest: invalid-param-set [467.621817] Subtest invalid-param-set: SUCCESS (0.000s) [467.679976] [115/132] (561s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [467.774558] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [467.775361] Starting dynamic subtest: pipe-A [467.841923] Dynamic subtest pipe-A: SUCCESS (0.068s) [467.851602] Starting dynamic subtest: pipe-B [469.001104] Dynamic subtest pipe-B: SUCCESS (1.155s) [469.011883] Starting dynamic subtest: pipe-C [470.124078] Dynamic subtest pipe-C: SUCCESS (1.119s) [470.140212] Starting dynamic subtest: pipe-D [471.267205] Dynamic subtest pipe-D: SUCCESS (1.140s) [471.268154] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.488s) [472.410936] [116/132] (556s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [472.470894] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [472.472910] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [472.655484] [117/132] (556s left) kms_chamelium_color (ctm-0-25) [472.735425] Subtest ctm-0-25: SKIP (0.000s) [472.778840] [118/132] (556s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [472.868772] Starting subtest: yf-tiled-32bpp-rotate-90 [472.870582] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [472.962991] [119/132] (556s left) kms_scaling_modes (scaling-mode-full) [473.039932] Starting subtest: scaling-mode-full [473.040924] Starting dynamic subtest: pipe-A-eDP-1 [473.134663] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s) [473.145619] Starting dynamic subtest: pipe-B-eDP-1 [474.344298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s) [474.354619] Starting dynamic subtest: pipe-C-eDP-1 [475.555579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s) [475.565499] Starting dynamic subtest: pipe-D-eDP-1 [476.686500] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s) [476.687399] Subtest scaling-mode-full: SUCCESS (3.645s) [477.847693] [120/132] (551s left) gem_mmap_gtt (basic-small-copy-xy) [477.891373] Subtest basic-small-copy-XY: SKIP (0.000s) [477.943874] [121/132] (551s left) perf (disabled-read-error) [478.015387] Starting subtest: disabled-read-error [478.030073] Subtest disabled-read-error: SUCCESS (0.015s) [478.067069] [122/132] (551s left) gen7_exec_parse (basic-allowed) [478.114717] Subtest basic-allowed: SKIP (0.000s) [478.186452] [123/132] (551s left) perf_pmu (interrupts-sync) [478.223266] Starting subtest: interrupts-sync [479.335920] Subtest interrupts-sync: SUCCESS (1.102s) [479.457124] [124/132] (549s left) i915_drm_fdinfo (virtual-busy-idle) [479.497229] Starting subtest: virtual-busy-idle [479.498897] Subtest virtual-busy-idle: SKIP (0.000s) [479.564761] [125/132] (549s left) gem_ctx_persistence (engines-mixed) [479.622865] Starting subtest: engines-mixed [479.623865] Starting dynamic subtest: rcs0 [479.693662] Dynamic subtest rcs0: SUCCESS (0.070s) [479.706536] Starting dynamic subtest: bcs0 [479.757280] Dynamic subtest bcs0: SUCCESS (0.061s) [479.770071] Starting dynamic subtest: vcs0 [479.787442] Dynamic subtest vcs0: SUCCESS (0.029s) [479.795585] Starting dynamic subtest: vcs1 [479.875129] Dynamic subtest vcs1: SUCCESS (0.086s) [479.888175] Starting dynamic subtest: vecs0 [479.932125] Dynamic subtest vecs0: SUCCESS (0.055s) [479.944268] Starting dynamic subtest: ccs0 [479.986076] Dynamic subtest ccs0: SUCCESS (0.052s) [479.987626] Subtest engines-mixed: SUCCESS (0.364s) [480.061657] [126/132] (549s left) kms_flip (absolute-wf_vblank-interruptible) [480.152045] Starting subtest: absolute-wf_vblank-interruptible [480.154416] Starting dynamic subtest: A-eDP1 [488.938210] Dynamic subtest A-eDP1: SUCCESS (8.753s) [488.949098] Starting dynamic subtest: B-eDP1 [497.684786] Dynamic subtest B-eDP1: SUCCESS (8.741s) [497.693624] Starting dynamic subtest: C-eDP1 [506.421031] Dynamic subtest C-eDP1: SUCCESS (8.722s) [506.430673] Starting dynamic subtest: D-eDP1 [515.124906] Dynamic subtest D-eDP1: SUCCESS (8.735s) [515.128108] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.965s) [516.334526] [127/132] (513s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [516.436714] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [520.152164] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.715s) [521.374270] [128/132] (508s left) dmabuf (all-tests) [521.406820] Starting subtest: all-tests [521.407826] Starting dynamic subtest: sanitycheck [521.501405] Dynamic subtest sanitycheck: SUCCESS (0.095s) [521.514910] Starting dynamic subtest: dma_fence [521.694663] Dynamic subtest dma_fence: SUCCESS (0.191s) [521.708186] Starting dynamic subtest: dma_fence_chain [531.201227] Dynamic subtest dma_fence_chain: SUCCESS (9.493s) [531.215205] Starting dynamic subtest: dma_fence_unwrap [531.267576] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s) [531.280862] Starting dynamic subtest: dma_resv [531.366644] Dynamic subtest dma_resv: SUCCESS (0.097s) [531.368099] Subtest all-tests: SUCCESS (9.959s) [531.427230] [129/132] (498s left) gem_exec_reloc (basic-active) [531.492901] Subtest basic-active: SKIP (0.000s) [531.567271] [130/132] (498s left) kms_color (ctm-0-25) [531.659670] Starting subtest: ctm-0-25 [531.660567] Starting dynamic subtest: pipe-A-eDP-1 [535.168138] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s) [535.177963] Starting dynamic subtest: pipe-B-eDP-1 [539.386986] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.216s) [539.395362] Starting dynamic subtest: pipe-C-eDP-1 [543.429258] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.040s) [543.437428] Starting dynamic subtest: pipe-D-eDP-1 [547.415529] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.984s) [547.416367] Subtest ctm-0-25: SUCCESS (15.753s) [548.243832] [131/132] (481s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [548.311341] Starting subtest: invalid-multi-wait-unsubmitted-submitted [548.312407] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [548.390410] [132/132] (481s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [548.477400] Starting subtest: fbcpsr-slowdraw [573.679864] Subtest fbcpsr-slowdraw: SUCCESS (25.200s) [573.809304] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: kms_vrr results: parsing output: 2/ for test: api_intel_allocator results: parsing output: 3/ for test: gem_exec_schedule results: parsing output: 4/ for test: kms_pm_backlight results: parsing output: 5/ for test: gem_userptr_blits results: parsing output: 6/ for test: kms_chamelium_hpd results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: sysfs_heartbeat_interval results: parsing output: 12/ for test: kms_getfb results: parsing output: 13/ for test: gem_workarounds results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_userptr_blits results: parsing output: 16/ for test: kms_plane_multiple results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: prime_udl results: parsing output: 19/ for test: kms_flip_scaled_crc results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_mmap_offset results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_busy results: parsing output: 24/ for test: gem_mmap_wc results: parsing output: 25/ for test: prime_mmap results: parsing output: 26/ for test: kms_atomic_transition results: parsing output: 27/ for test: gem_create results: parsing output: 28/ for test: gem_exec_create results: parsing output: 29/ for test: gem_exec_schedule results: parsing output: 30/ for test: kms_vblank results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: gem_exec_reloc results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: kms_hdr results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: kms_plane_scaling results: parsing output: 37/ for test: gem_exec_balancer results: parsing output: 38/ for test: gem_softpin results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: kms_ccs results: parsing output: 41/ for test: kms_prop_blob results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: kms_chamelium_frames results: parsing output: 45/ for test: gem_barrier_race results: parsing output: 46/ for test: kms_vrr results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: gem_render_copy results: parsing output: 57/ for test: kms_plane results: parsing output: 58/ for test: gem_exec_fence results: parsing output: 59/ for test: i915_pm_rpm results: parsing output: 60/ for test: kms_atomic_transition results: parsing output: 61/ for test: gem_lmem_swapping results: parsing output: 62/ for test: kms_cursor_crc results: parsing output: 63/ for test: i915_drm_fdinfo results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: kms_legacy_colorkey results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_content_protection results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: prime_vgem results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: gem_exec_whisper results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: gem_mmap_wc results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: i915_pm_rps results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: syncobj_eventfd results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_lmem_swapping results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: kms_plane results: parsing output: 89/ for test: perf results: parsing output: 90/ for test: kms_rotation_crc results: parsing output: 91/ for test: kms_async_flips results: parsing output: 92/ for test: kms_draw_crc results: parsing output: 93/ for test: perf_pmu results: parsing output: 94/ for test: kms_psr2_sf results: parsing output: 95/ for test: gem_pxp results: parsing output: 96/ for test: api_intel_bb results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_flip_scaled_crc results: parsing output: 99/ for test: gem_pread results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_exec_reloc results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: kms_atomic_interruptible results: parsing output: 104/ for test: gem_ctx_persistence results: parsing output: 105/ for test: gem_eio results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_pipe_stress results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: kms_async_flips results: parsing output: 112/ for test: gen7_exec_parse results: parsing output: 113/ for test: gem_ctx_param results: parsing output: 114/ for test: kms_plane_scaling results: parsing output: 115/ for test: gem_render_copy results: parsing output: 116/ for test: kms_chamelium_color results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_scaling_modes results: parsing output: 119/ for test: gem_mmap_gtt results: parsing output: 120/ for test: perf results: parsing output: 121/ for test: gen7_exec_parse results: parsing output: 122/ for test: perf_pmu results: parsing output: 123/ for test: i915_drm_fdinfo results: parsing output: 124/ for test: gem_ctx_persistence results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: dmabuf results: parsing output: 128/ for test: gem_exec_reloc results: parsing output: 129/ for test: kms_color results: parsing output: 130/ for test: syncobj_wait results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.