[63.752852] Initializing watchdogs [63.752962] /dev/watchdog0 [63.767536] [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] [63.772190] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.774965] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.778297] [001/133] (960s left) fbdev (unaligned-read) [63.847396] Starting subtest: unaligned-read [63.862095] Subtest unaligned-read: SUCCESS (0.015s) [63.915029] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [64.015340] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [64.019412] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [64.116821] [003/133] (960s left) kms_big_fb (4-tiled-addfb-size-overflow) [64.216586] Starting subtest: 4-tiled-addfb-size-overflow [64.218817] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [64.315346] [004/133] (960s left) gem_pxp (create-valid-protected-context) [64.448065] Starting subtest: create-valid-protected-context [64.450630] Subtest create-valid-protected-context: SUCCESS (0.003s) [64.558502] [005/133] (959s left) drm_read (short-buffer-wakeup) [64.737248] Starting subtest: short-buffer-wakeup [96.961385] Subtest short-buffer-wakeup: SUCCESS (32.216s) [97.113085] [006/133] (927s left) gem_ctx_shared (disjoint-timelines) [97.186828] Starting subtest: disjoint-timelines [97.223371] Subtest disjoint-timelines: SUCCESS (0.039s) [97.456568] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true [97.460154] [007/133] (927s left) kms_color (ctm-blue-to-red) [97.554271] Starting subtest: ctm-blue-to-red [97.556274] Starting dynamic subtest: pipe-A-eDP-1 [98.252647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [98.262143] Starting dynamic subtest: pipe-B-eDP-1 [99.621696] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s) [99.629555] Starting dynamic subtest: pipe-C-eDP-1 [101.008509] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s) [101.017375] Starting dynamic subtest: pipe-D-eDP-1 [102.326659] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [102.329111] Subtest ctm-blue-to-red: SUCCESS (4.773s) [103.136544] [008/133] (921s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [103.245584] Starting subtest: switch-modeset-ultra-joiner-big-joiner [103.249622] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [103.309707] [009/133] (921s left) kms_pm_lpsp (screens-disabled) [104.408487] Starting subtest: screens-disabled [104.413065] Subtest screens-disabled: SKIP (0.000s) [104.478304] [010/133] (920s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [104.566813] Starting subtest: primary-x-tiled-reflect-x-0 [111.502231] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.937s) [112.698406] [011/133] (911s left) kms_big_fb (linear-8bpp-rotate-180) [112.787699] Starting subtest: linear-8bpp-rotate-180 [114.021811] Subtest linear-8bpp-rotate-180: SUCCESS (1.235s) [114.156515] [012/133] (910s left) kms_plane_scaling (planes-upscale-20x20) [114.251751] Starting subtest: planes-upscale-20x20 [114.253667] Starting dynamic subtest: pipe-A [114.311675] Dynamic subtest pipe-A: SUCCESS (0.062s) [114.318608] Starting dynamic subtest: pipe-B [115.419071] Dynamic subtest pipe-B: SUCCESS (1.106s) [115.428622] Starting dynamic subtest: pipe-C [116.531693] Dynamic subtest pipe-C: SUCCESS (1.112s) [116.540076] Starting dynamic subtest: pipe-D [117.664130] Dynamic subtest pipe-D: SUCCESS (1.132s) [117.666460] Subtest planes-upscale-20x20: SUCCESS (3.415s) [118.825717] [013/133] (905s left) prime_vgem (basic-fence-mmap) [118.913857] Starting subtest: basic-fence-mmap [118.918705] Subtest basic-fence-mmap: SKIP (0.000s) [119.038990] [014/133] (905s left) kms_cursor_crc (cursor-sliding-64x21) [119.229832] Starting subtest: cursor-sliding-64x21 [119.277728] Subtest cursor-sliding-64x21: SKIP (0.045s) [119.496395] [015/133] (905s left) kms_chamelium_color (ctm-red-to-blue) [119.589788] Subtest ctm-red-to-blue: SKIP (0.000s) [119.632225] [016/133] (905s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [119.740538] Starting subtest: fbc-modesetfrombusy [123.487369] Subtest fbc-modesetfrombusy: SUCCESS (3.751s) [124.651798] [017/133] (900s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [124.758803] Starting subtest: psr-farfromfence-mmap-gtt [124.763420] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [124.855433] [018/133] (900s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [124.961541] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [131.844768] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.888s) [131.957464] [019/133] (893s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [132.053699] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [136.366081] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.314s) [137.562723] [020/133] (887s left) vgem_slow (nohang) [137.604624] Starting subtest: nohang [148.082655] Subtest nohang: SUCCESS (10.478s) [148.163193] [021/133] (876s left) syncobj_timeline (invalid-signal-illegal-point) [148.223472] Starting subtest: invalid-signal-illegal-point [148.225802] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [148.323491] [022/133] (876s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [148.437965] Starting subtest: x-tiled-addfb-size-offset-overflow [148.440168] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [148.524548] [023/133] (876s left) i915_pm_rps (fence-order) [148.587267] Starting subtest: fence-order [151.446487] Subtest fence-order: SUCCESS (2.857s) [151.573791] [024/133] (873s left) gem_pxp (reject-modify-context-protection-on) [151.630424] Starting subtest: reject-modify-context-protection-on [151.632730] Subtest reject-modify-context-protection-on: SUCCESS (0.001s) [151.727609] [025/133] (873s left) kms_vblank (ts-continuation-suspend) [151.828737] Starting subtest: ts-continuation-suspend [151.830906] Starting dynamic subtest: pipe-A-eDP-1 [168.001232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.469s) [168.016691] Starting dynamic subtest: pipe-D-eDP-1 [185.009073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.223s) [185.011663] Subtest ts-continuation-suspend: SUCCESS (4.698s) [185.827985] [026/133] (839s left) kms_flip (2x-blocking-absolute-wf_vblank) [185.933606] Starting subtest: 2x-blocking-absolute-wf_vblank [185.941745] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [186.022458] [027/133] (839s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [186.110552] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [186.112838] Starting dynamic subtest: pipe-A-eDP-1 [186.136285] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [186.147231] Starting dynamic subtest: pipe-B-eDP-1 [186.169132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [186.177486] Starting dynamic subtest: pipe-C-eDP-1 [186.200169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [186.209453] Starting dynamic subtest: pipe-D-eDP-1 [186.232983] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [186.237239] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s) [188.510575] [028/133] (836s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [188.610534] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [188.612838] Starting dynamic subtest: pipe-A-eDP-1 [199.943966] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.330s) [199.953578] Starting dynamic subtest: pipe-B-eDP-1 [211.941379] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.991s) [211.943614] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.323s) [212.786831] [029/133] (812s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [212.879393] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [212.883565] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s) [212.953602] [030/133] (812s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [213.010277] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [213.114536] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s) [213.201196] [031/133] (812s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [213.295682] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [213.300111] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [213.404707] [032/133] (812s left) kms_feature_discovery (psr1) [213.498039] Starting subtest: psr1 [213.500308] Subtest psr1: SUCCESS (0.000s) [213.579592] [033/133] (811s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [213.631711] Starting subtest: invalid-smem-bo-on-discrete [213.636134] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [213.751338] [034/133] (811s left) kms_big_fb (x-tiled-8bpp-rotate-0) [213.845193] Starting subtest: x-tiled-8bpp-rotate-0 [215.047862] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.203s) [215.159870] [035/133] (810s left) gem_ctx_persistence (engines-mixed) [215.220315] Starting subtest: engines-mixed [215.222432] Starting dynamic subtest: rcs0 [215.300537] Dynamic subtest rcs0: SUCCESS (0.080s) [215.313928] Starting dynamic subtest: bcs0 [215.349887] Dynamic subtest bcs0: SUCCESS (0.048s) [215.360019] Starting dynamic subtest: vcs0 [215.409945] Dynamic subtest vcs0: SUCCESS (0.058s) [215.420438] Starting dynamic subtest: vcs1 [215.453650] Dynamic subtest vcs1: SUCCESS (0.042s) [215.463102] Starting dynamic subtest: vecs0 [215.495526] Dynamic subtest vecs0: SUCCESS (0.041s) [215.506567] Starting dynamic subtest: ccs0 [215.543043] Dynamic subtest ccs0: SUCCESS (0.046s) [215.545447] Subtest engines-mixed: SUCCESS (0.323s) [215.620817] [036/133] (810s left) gem_exec_schedule (u-semaphore-resolve) [215.691814] Starting subtest: u-semaphore-resolve [215.730953] Subtest u-semaphore-resolve: SUCCESS (0.044s) [216.067625] [037/133] (809s left) syncobj_timeline (single-wait-available-signaled) [216.115084] Starting subtest: single-wait-available-signaled [216.117342] Subtest single-wait-available-signaled: SUCCESS (0.000s) [216.212462] [038/133] (809s left) gem_exec_schedule (preempt-engines) [216.288947] Starting subtest: preempt-engines [216.290959] Starting dynamic subtest: rcs0 [218.509381] Dynamic subtest rcs0: SUCCESS (2.228s) [218.522019] Starting dynamic subtest: bcs0 [220.793064] Dynamic subtest bcs0: SUCCESS (2.282s) [220.802031] Starting dynamic subtest: vcs0 [223.085298] Dynamic subtest vcs0: SUCCESS (2.291s) [223.094201] Starting dynamic subtest: vcs1 [225.475962] Dynamic subtest vcs1: SUCCESS (2.389s) [225.492497] Starting dynamic subtest: vecs0 [227.804426] Dynamic subtest vecs0: SUCCESS (2.327s) [227.814387] Starting dynamic subtest: ccs0 [230.109162] Dynamic subtest ccs0: SUCCESS (2.302s) [230.111996] Subtest preempt-engines: SUCCESS (13.830s) [230.419937] [039/133] (795s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [230.477111] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [230.479330] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [230.579955] [040/133] (795s left) gem_exec_reloc (basic-range-active) [230.645829] Subtest basic-range-active: SKIP (0.000s) [230.715695] [041/133] (795s left) gem_mmap (bad-object) [230.766929] Subtest bad-object: SKIP (0.000s) [230.835045] [042/133] (795s left) gem_workarounds (reset) [230.892844] Starting subtest: reset [231.078173] Subtest reset: SUCCESS (0.186s) [231.190089] [043/133] (794s left) kms_cursor_crc (cursor-random-128x42) [231.421723] Starting subtest: cursor-random-128x42 [231.470626] Subtest cursor-random-128x42: SKIP (0.045s) [231.671946] [044/133] (794s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [231.772458] Starting subtest: psr-rgb101010-draw-mmap-cpu [238.882458] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.112s) [238.985804] [045/133] (787s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [239.089990] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [239.092105] Starting dynamic subtest: pipe-A-eDP-1 [239.186138] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [239.198425] Starting dynamic subtest: pipe-B-eDP-1 [240.297480] Dynamic subtest pipe-B-eDP-1: SKIP (1.109s) [240.302009] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.212s) [241.491889] [046/133] (784s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [241.583689] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [245.612272] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.030s) [246.794547] [047/133] (779s left) gem_exec_balancer (bonded-chain) [246.856239] Starting subtest: bonded-chain [253.846458] Subtest bonded-chain: SUCCESS (6.990s) [254.204782] [048/133] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [254.309765] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [254.313819] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [254.395076] [049/133] (771s left) gem_partial_pwrite_pread (write-snoop) [254.466538] Subtest write-snoop: SKIP (0.000s) [254.541405] [050/133] (771s left) kms_content_protection (uevent) [254.669406] Starting subtest: uevent [254.674045] Subtest uevent: SKIP (0.000s) [254.805129] [051/133] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [254.909547] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [254.913602] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [255.017944] [052/133] (771s left) kms_cursor_crc (cursor-onscreen-64x21) [255.194542] Starting subtest: cursor-onscreen-64x21 [255.248263] Subtest cursor-onscreen-64x21: SKIP (0.050s) [255.486071] [053/133] (770s left) gem_mmap (basic) [255.556807] Subtest basic: SKIP (0.000s) [255.625001] [054/133] (770s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [255.711830] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [255.713710] Starting dynamic subtest: pipe-A-eDP-1 [255.786271] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [255.795513] Starting dynamic subtest: pipe-B-eDP-1 [256.957477] Dynamic subtest pipe-B-eDP-1: SKIP (1.169s) [256.961868] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.249s) [258.150806] [055/133] (768s left) gem_exec_fence (submit) [258.336638] Starting subtest: submit [258.341377] Subtest submit: SKIP (0.000s) [260.457745] [056/133] (766s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [260.562560] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [260.564692] Starting dynamic subtest: pipe-A-default-mode [261.726073] Dynamic subtest pipe-A-default-mode: SKIP (1.162s) [261.730589] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.163s) [261.881796] [057/133] (764s left) gem_mmap_wc (set-cache-level) [261.942646] Subtest set-cache-level: SKIP (0.000s) [262.001265] [058/133] (764s left) gem_softpin (softpin) [262.060569] Starting subtest: softpin [294.414175] Subtest softpin: SUCCESS (32.345s) [294.525415] [059/133] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [294.636102] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [294.640399] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [294.749198] [060/133] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [294.848836] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [294.852827] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [294.956971] [061/133] (731s left) gem_mmap_offset (basic-uaf) [295.013064] Starting subtest: basic-uaf [295.015193] Subtest basic-uaf: SUCCESS (0.001s) [295.110769] [062/133] (731s left) gem_exec_balancer (semaphore) [295.175044] Starting subtest: semaphore [296.401878] Subtest semaphore: SUCCESS (1.225s) [296.719579] [063/133] (730s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [297.090962] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [297.902840] [064/133] (728s left) kms_prime (basic-modeset-hybrid) [297.991693] Subtest basic-modeset-hybrid: SKIP (0.000s) [298.094081] [065/133] (728s left) kms_rotation_crc (exhaust-fences) [298.187416] Starting subtest: exhaust-fences [298.191428] Subtest exhaust-fences: SKIP (0.000s) [298.263538] [066/133] (728s left) kms_plane (plane-position-covered) [298.355941] Starting subtest: plane-position-covered [298.892051] Starting dynamic subtest: pipe-A-plane-1 [300.230054] Dynamic subtest pipe-A-plane-1: SUCCESS (1.339s) [300.240609] Starting dynamic subtest: pipe-A-plane-2 [301.539963] Dynamic subtest pipe-A-plane-2: SUCCESS (1.307s) [301.550184] Starting dynamic subtest: pipe-A-plane-3 [302.873932] Dynamic subtest pipe-A-plane-3: SUCCESS (1.336s) [302.892793] Starting dynamic subtest: pipe-A-plane-4 [304.213811] Dynamic subtest pipe-A-plane-4: SUCCESS (1.339s) [304.223796] Starting dynamic subtest: pipe-A-plane-5 [304.241589] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s) [305.471087] Starting dynamic subtest: pipe-B-plane-1 [306.804584] Dynamic subtest pipe-B-plane-1: SUCCESS (1.340s) [306.816244] Starting dynamic subtest: pipe-B-plane-2 [308.097109] Dynamic subtest pipe-B-plane-2: SUCCESS (1.293s) [308.108117] Starting dynamic subtest: pipe-B-plane-3 [309.353769] Dynamic subtest pipe-B-plane-3: SUCCESS (1.256s) [309.363437] Starting dynamic subtest: pipe-B-plane-4 [310.680835] Dynamic subtest pipe-B-plane-4: SUCCESS (1.323s) [310.690706] Starting dynamic subtest: pipe-B-plane-5 [310.705743] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [310.708015] Subtest plane-position-covered: SUCCESS (12.351s) [311.548842] [067/133] (715s left) perf (rc6-disable) [311.679149] Starting subtest: rc6-disable [311.857856] Subtest rc6-disable: SUCCESS (0.179s) [311.908566] [068/133] (715s left) gem_exec_flush (basic-uc-prw-default) [311.964604] Starting subtest: basic-uc-prw-default [317.422872] Subtest basic-uc-prw-default: SUCCESS (5.458s) [317.622168] [069/133] (709s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [317.681889] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [317.684188] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [317.795347] [070/133] (709s left) gem_mmap (basic-small-bo) [317.852185] Subtest basic-small-bo: SKIP (0.000s) [317.908962] [071/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [318.009491] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [318.013515] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [318.094091] [072/133] (709s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [318.185119] Starting subtest: fbc-rgb565-draw-render [322.320760] Subtest fbc-rgb565-draw-render: SUCCESS (4.139s) [323.461108] [073/133] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [323.562199] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [323.566531] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [323.663538] [074/133] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [323.764954] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [331.094626] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.331s) [331.220734] [075/133] (696s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [331.307427] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [331.309582] Starting dynamic subtest: pipe-A-eDP-1 [331.329778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [331.341150] Starting dynamic subtest: pipe-B-eDP-1 [331.359476] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [331.368879] Starting dynamic subtest: pipe-C-eDP-1 [331.387597] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [331.396427] Starting dynamic subtest: pipe-D-eDP-1 [331.416887] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [331.418869] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [333.633076] [076/133] (693s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [333.726409] Starting subtest: compare-crc-sanitycheck-xr24 [333.728745] Starting dynamic subtest: pipe-A-eDP-1 [334.396657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.670s) [334.406609] Starting dynamic subtest: pipe-B-eDP-1 [335.713096] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.314s) [335.723233] Starting dynamic subtest: pipe-C-eDP-1 [336.974421] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.259s) [336.983672] Starting dynamic subtest: pipe-D-eDP-1 [338.226965] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [338.229318] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.503s) [339.051895] [077/133] (688s left) i915_pciid [339.206016] [078/133] (688s left) kms_addfb_basic (small-bo) [339.306089] Starting subtest: small-bo [339.307960] Subtest small-bo: SUCCESS (0.000s) [339.408490] [079/133] (688s left) prime_busy (hang-wait) [339.459447] Starting subtest: hang-wait [339.461841] Starting dynamic subtest: rcs0 [365.880084] Dynamic subtest rcs0: SUCCESS (26.412s) [365.888859] Starting dynamic subtest: bcs0 [373.028883] Dynamic subtest bcs0: SUCCESS (7.146s) [373.037651] Starting dynamic subtest: vcs0 [380.007251] Dynamic subtest vcs0: SUCCESS (6.972s) [380.017348] Starting dynamic subtest: vcs1 [386.979417] Dynamic subtest vcs1: SUCCESS (6.969s) [386.990744] Starting dynamic subtest: vecs0 [394.019293] Dynamic subtest vecs0: SUCCESS (7.035s) [394.029894] Starting dynamic subtest: ccs0 [407.858015] Dynamic subtest ccs0: SUCCESS (13.835s) [407.860308] Subtest hang-wait: SUCCESS (68.385s) [407.989250] [080/133] (619s left) api_intel_bb (crc32) [408.045565] Starting subtest: crc32 [408.047481] Starting dynamic subtest: rcs0-smem0 [408.360310] Dynamic subtest rcs0-smem0: SUCCESS (0.315s) [408.372188] Starting dynamic subtest: bcs0-smem0 [408.683993] Dynamic subtest bcs0-smem0: SUCCESS (0.321s) [408.696399] Starting dynamic subtest: vcs0-smem0 [409.081025] Dynamic subtest vcs0-smem0: SUCCESS (0.394s) [409.094199] Starting dynamic subtest: vcs1-smem0 [409.405820] Dynamic subtest vcs1-smem0: SUCCESS (0.322s) [409.418442] Starting dynamic subtest: vecs0-smem0 [409.757944] Dynamic subtest vecs0-smem0: SUCCESS (0.349s) [409.770117] Starting dynamic subtest: ccs0-smem0 [410.114391] Dynamic subtest ccs0-smem0: SUCCESS (0.354s) [410.116945] Subtest crc32: SUCCESS (2.071s) [410.232810] [081/133] (617s left) gem_exec_reloc (basic-write-wc-noreloc) [410.296175] Subtest basic-write-wc-noreloc: SKIP (0.000s) [410.368660] [082/133] (617s left) gem_exec_reloc (basic-write-read) [410.437862] Subtest basic-write-read: SKIP (0.000s) [410.509561] [083/133] (617s left) kms_psr (pr-sprite-blt) [410.600272] Starting subtest: pr-sprite-blt [410.604412] Subtest pr-sprite-blt: SKIP (0.000s) [410.673598] [084/133] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [410.766990] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [410.771161] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [410.851980] [085/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [410.965140] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [417.890018] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.928s) [418.040320] [086/133] (609s left) perf (gen12-mi-rpc) [418.151352] Starting subtest: gen12-mi-rpc [418.153758] Starting dynamic subtest: rcs0 [418.171680] Dynamic subtest rcs0: SUCCESS (0.020s) [418.173911] Subtest gen12-mi-rpc: SUCCESS (0.021s) [418.216086] [087/133] (609s left) kms_psr (fbc-psr-sprite-mmap-cpu) [418.313537] Starting subtest: fbc-psr-sprite-mmap-cpu [418.315618] Starting dynamic subtest: eDP-1 [418.319487] Dynamic subtest eDP-1: SKIP (0.000s) [418.323513] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [418.389756] [088/133] (609s left) kms_psr (psr-primary-mmap-cpu) [418.481388] Starting subtest: psr-primary-mmap-cpu [418.483676] Starting dynamic subtest: eDP-1 [420.272078] Dynamic subtest eDP-1: SUCCESS (1.792s) [420.274499] Subtest psr-primary-mmap-cpu: SUCCESS (1.793s) [421.139556] [089/133] (606s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [421.232749] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [421.235040] Starting dynamic subtest: pipe-A-eDP-1 [421.258305] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [421.270380] Starting dynamic subtest: pipe-B-eDP-1 [421.292128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [421.300573] Starting dynamic subtest: pipe-C-eDP-1 [421.321331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [421.329625] Starting dynamic subtest: pipe-D-eDP-1 [421.351728] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [421.356165] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s) [423.486030] [090/133] (604s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [423.567396] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [423.593120] Starting dynamic subtest: pipe-A-plane-0 [424.040018] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s) [424.055887] Starting dynamic subtest: pipe-A-plane-3 [424.295036] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s) [424.304277] Starting dynamic subtest: pipe-A-plane-5 [424.308789] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [425.383435] Starting dynamic subtest: pipe-B-plane-0 [425.806715] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s) [425.818347] Starting dynamic subtest: pipe-B-plane-3 [426.106220] Dynamic subtest pipe-B-plane-3: SUCCESS (0.299s) [426.116799] Starting dynamic subtest: pipe-B-plane-5 [426.121307] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [426.417809] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.851s) [427.258141] [091/133] (600s left) gem_create (create-ext-cpu-access-big) [427.419778] Starting subtest: create-ext-cpu-access-big [427.424643] Subtest create-ext-cpu-access-big: SKIP (0.001s) [427.490829] [092/133] (600s left) gem_userptr_blits (coherency-sync) [427.547865] Starting subtest: coherency-sync [428.013888] Subtest coherency-sync: SKIP (0.425s) [428.122052] [093/133] (599s left) gem_pwrite_snooped [428.289854] [094/133] (599s left) gem_exec_whisper (basic-fds-all) [428.357736] Starting subtest: basic-fds-all [437.864154] Subtest basic-fds-all: SUCCESS (9.504s) [438.055948] [095/133] (590s left) kms_fbcon_fbt (fbc) [438.118965] Starting subtest: fbc [444.494715] Subtest fbc: SUCCESS (6.377s) [445.586333] [096/133] (582s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [445.666616] Starting subtest: multi-wait-for-submit-submitted-signaled [445.668965] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [445.774656] [097/133] (582s left) perf_pmu (rc6-suspend) [445.820897] Starting subtest: rc6-suspend [467.883012] Subtest rc6-suspend: SUCCESS (7.498s) [468.767063] [098/133] (559s left) kms_flip (wf_vblank-ts-check) [468.899178] Starting subtest: wf_vblank-ts-check [468.901338] Starting dynamic subtest: A-eDP1 [477.851012] Dynamic subtest A-eDP1: SUCCESS (8.942s) [477.860914] Starting dynamic subtest: B-eDP1 [486.788993] Dynamic subtest B-eDP1: SUCCESS (8.930s) [486.800488] Starting dynamic subtest: C-eDP1 [495.712441] Dynamic subtest C-eDP1: SUCCESS (8.915s) [495.722306] Starting dynamic subtest: D-eDP1 [504.646759] Dynamic subtest D-eDP1: SUCCESS (8.931s) [504.649025] Subtest wf_vblank-ts-check: SUCCESS (35.728s) [505.875283] [099/133] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [505.974546] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [509.673844] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.702s) [510.869132] [100/133] (517s left) kms_atomic (atomic-invalid-params) [510.971463] Starting subtest: atomic-invalid-params [510.973669] Starting dynamic subtest: pipe-A-eDP-1 [511.362727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s) [511.364685] Subtest atomic-invalid-params: SUCCESS (0.392s) [512.197949] [101/133] (516s left) gem_ringfill (legacy-basic) [517.941256] Starting subtest: legacy-basic [517.943946] Starting dynamic subtest: default [518.001479] Dynamic subtest default: SUCCESS (0.060s) [518.013982] Starting dynamic subtest: render [518.043208] Dynamic subtest render: SUCCESS (0.040s) [518.054153] Starting dynamic subtest: bsd [518.087672] Dynamic subtest bsd: SUCCESS (0.041s) [518.103107] Starting dynamic subtest: bsd1 [518.128375] Dynamic subtest bsd1: SUCCESS (0.038s) [518.141146] Starting dynamic subtest: bsd2 [518.171460] Dynamic subtest bsd2: SUCCESS (0.040s) [518.182395] Starting dynamic subtest: blt [518.216946] Dynamic subtest blt: SUCCESS (0.043s) [518.228331] Starting dynamic subtest: vebox [518.259613] Dynamic subtest vebox: SUCCESS (0.041s) [518.262460] Subtest legacy-basic: SUCCESS (0.321s) [518.344128] [102/133] (510s left) kms_addfb_basic (unused-handle) [518.402718] Starting subtest: unused-handle [518.405117] Subtest unused-handle: SUCCESS (0.000s) [518.549865] [103/133] (509s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [518.650089] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [518.654559] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [518.761889] [104/133] (509s left) gem_softpin (reverse) [518.822596] Starting subtest: reverse [518.828671] Subtest reverse: SUCCESS (0.006s) [518.948617] [105/133] (509s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [519.039953] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [519.043524] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [519.134133] [106/133] (509s left) gem_exercise_blt (fast-copy-emit) [519.183348] Starting subtest: fast-copy-emit [519.185088] Starting dynamic subtest: linear-smem-smem-emit [519.205935] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [519.216245] Starting dynamic subtest: xmajor-smem-smem-emit [519.223110] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s) [519.232303] Starting dynamic subtest: tile4-smem-smem-emit [519.239989] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [519.249243] Starting dynamic subtest: tile64-smem-smem-emit [519.256791] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s) [519.258556] Subtest fast-copy-emit: SUCCESS (0.074s) [519.378372] [107/133] (509s left) gem_lmem_swapping (verify-random-ccs) [519.417125] Subtest verify-random-ccs: SKIP (0.000s) [519.460108] [108/133] (509s left) kms_selftest (drm_damage_helper) [519.504123] Starting subtest: drm_damage_helper [519.512885] Starting dynamic subtest: drm_test_damage_iter_no_damage [519.603995] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.090s) [519.624077] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [519.701809] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.097s) [519.722486] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [519.787157] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.085s) [519.797465] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [519.895497] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.107s) [519.905629] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [519.982862] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.086s) [519.992886] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [520.092914] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.110s) [520.103092] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [520.193885] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.098s) [520.204461] Starting dynamic subtest: drm_test_damage_iter_simple_damage [520.291746] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.096s) [520.302860] Starting dynamic subtest: drm_test_damage_iter_single_damage [520.395792] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.103s) [520.405049] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [520.479611] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.082s) [520.489898] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [520.569295] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.090s) [520.578355] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [520.672617] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.101s) [520.682920] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [520.764534] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.092s) [520.774916] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [520.852746] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.088s) [520.863270] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [520.948641] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.095s) [520.959097] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [521.049646] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.100s) [521.059895] Starting dynamic subtest: drm_test_damage_iter_damage [521.151449] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.100s) [521.161317] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [521.237630] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.086s) [521.248889] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [521.344383] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.106s) [521.356092] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [521.439146] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.094s) [521.448159] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [521.521712] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.080s) [521.523362] Subtest drm_damage_helper: SUCCESS (2.015s) [521.665144] [109/133] (507s left) gem_eio (in-flight-internal-10ms) [521.913350] Starting subtest: in-flight-internal-10ms [523.026042] Subtest in-flight-internal-10ms: SUCCESS (1.110s) [523.144363] [110/133] (505s left) kms_invalid_mode (bad-hsync-end) [523.242430] Starting subtest: bad-hsync-end [523.244718] Starting dynamic subtest: pipe-A-eDP-1 [523.538827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [523.549713] Starting dynamic subtest: pipe-B-eDP-1 [523.552077] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [523.561931] Starting dynamic subtest: pipe-C-eDP-1 [523.563865] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [523.573302] Starting dynamic subtest: pipe-D-eDP-1 [523.575186] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [523.577186] Subtest bad-hsync-end: SUCCESS (0.304s) [524.341090] [111/133] (504s left) gem_exec_schedule (fairslice) [524.411424] Starting subtest: fairslice [524.413692] Starting dynamic subtest: rcs0 [526.424467] Dynamic subtest rcs0: SUCCESS (2.019s) [526.435352] Starting dynamic subtest: bcs0 [528.441901] Dynamic subtest bcs0: SUCCESS (2.017s) [528.452577] Starting dynamic subtest: vcs0 [530.464038] Dynamic subtest vcs0: SUCCESS (2.020s) [530.475524] Starting dynamic subtest: vcs1 [532.486115] Dynamic subtest vcs1: SUCCESS (2.021s) [532.496192] Starting dynamic subtest: vecs0 [534.510827] Dynamic subtest vecs0: SUCCESS (2.021s) [534.523149] Starting dynamic subtest: ccs0 [536.533555] Dynamic subtest ccs0: SUCCESS (2.022s) [536.535396] Subtest fairslice: SUCCESS (12.125s) [536.855592] [112/133] (492s left) kms_psr (fbc-pr-sprite-render) [536.970209] Starting subtest: fbc-pr-sprite-render [536.974650] Subtest fbc-pr-sprite-render: SKIP (0.000s) [537.046363] [113/133] (491s left) gem_flink_basic (bad-flink) [537.112421] Starting subtest: bad-flink [537.114753] Subtest bad-flink: SUCCESS (0.000s) [537.219957] [114/133] (491s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [537.310349] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [537.312586] Starting dynamic subtest: pipe-A-eDP-1 [537.335297] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [537.347711] Starting dynamic subtest: pipe-B-eDP-1 [537.369376] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [537.379411] Starting dynamic subtest: pipe-C-eDP-1 [537.401087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [537.410813] Starting dynamic subtest: pipe-D-eDP-1 [537.433158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [537.437323] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s) [539.616359] [115/133] (489s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [539.732843] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [539.737541] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [539.875392] [116/133] (489s left) kms_plane_cursor (viewport) [539.979291] Starting subtest: viewport [539.983619] Starting dynamic subtest: pipe-A-eDP-1-size-64 [542.544006] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.565s) [542.605570] Starting dynamic subtest: pipe-A-eDP-1-size-128 [545.234807] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.638s) [545.296543] Starting dynamic subtest: pipe-A-eDP-1-size-256 [547.837338] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s) [548.193486] Starting dynamic subtest: pipe-B-eDP-1-size-64 [551.459540] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.275s) [551.519313] Starting dynamic subtest: pipe-B-eDP-1-size-128 [554.117191] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s) [554.176731] Starting dynamic subtest: pipe-B-eDP-1-size-256 [556.708430] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s) [557.068969] Starting dynamic subtest: pipe-C-eDP-1-size-64 [559.959369] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s) [559.999939] Starting dynamic subtest: pipe-C-eDP-1-size-128 [562.171337] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s) [562.212597] Starting dynamic subtest: pipe-C-eDP-1-size-256 [564.370471] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.170s) [564.706814] Starting dynamic subtest: pipe-D-eDP-1-size-64 [567.587518] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.901s) [567.626918] Starting dynamic subtest: pipe-D-eDP-1-size-128 [569.831506] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [569.870674] Starting dynamic subtest: pipe-D-eDP-1-size-256 [572.064759] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.202s) [572.384947] Subtest viewport: SUCCESS (32.401s) [573.238569] [117/133] (455s left) kms_big_fb (y-tiled-32bpp-rotate-270) [573.334222] Starting subtest: y-tiled-32bpp-rotate-270 [573.338965] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [573.433201] [118/133] (455s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [573.493315] Starting subtest: etime-single-wait-all-available-unsubmitted [573.598272] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.103s) [573.675164] [119/133] (455s left) api_intel_bb (simple-bb-ctx) [573.741699] Starting subtest: simple-bb-ctx [573.748441] Subtest simple-bb-ctx: SUCCESS (0.008s) [573.887451] [120/133] (455s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [573.982565] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [573.986514] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [574.074949] [121/133] (455s left) gem_ctx_persistence (heartbeat-close) [574.146894] Starting subtest: heartbeat-close [574.151395] Subtest heartbeat-close: SKIP (0.000s) [574.265123] [122/133] (455s left) kms_rotation_crc (sprite-rotation-270) [574.358602] Starting subtest: sprite-rotation-270 [574.362892] Subtest sprite-rotation-270: SKIP (0.001s) [574.438058] [123/133] (454s left) gem_pread (display) [574.503299] Subtest display: SKIP (0.000s) [574.561835] [124/133] (454s left) gem_exec_reloc (basic-gtt-cpu) [574.619361] Subtest basic-gtt-cpu: SKIP (0.000s) [574.689989] [125/133] (454s left) gen9_exec_parse (basic-rejected) [574.747597] Subtest basic-rejected: SKIP (0.000s) [574.815829] [126/133] (454s left) kms_chamelium_color (ctm-0-75) [574.923523] Subtest ctm-0-75: SKIP (0.000s) [574.966937] [127/133] (454s left) kms_psr (psr2-sprite-plane-onoff) [575.062897] Starting subtest: psr2-sprite-plane-onoff [575.064976] Starting dynamic subtest: eDP-1 [576.863315] Dynamic subtest eDP-1: SUCCESS (1.801s) [576.865741] Subtest psr2-sprite-plane-onoff: SUCCESS (1.802s) [577.703415] [128/133] (451s left) sysfs_timeslice_duration (idempotent) [577.763304] Starting subtest: idempotent [577.765580] Starting dynamic subtest: vecs0 [577.767944] Dynamic subtest vecs0: SUCCESS (0.000s) [577.779319] Starting dynamic subtest: ccs0 [577.781178] Dynamic subtest ccs0: SUCCESS (0.000s) [577.790698] Starting dynamic subtest: vcs0 [577.792616] Dynamic subtest vcs0: SUCCESS (0.000s) [577.801946] Starting dynamic subtest: bcs0 [577.803826] Dynamic subtest bcs0: SUCCESS (0.000s) [577.813793] Starting dynamic subtest: rcs0 [577.815610] Dynamic subtest rcs0: SUCCESS (0.000s) [577.825757] Starting dynamic subtest: vcs1 [577.827853] Dynamic subtest vcs1: SUCCESS (0.000s) [577.829974] Subtest idempotent: SUCCESS (0.010s) [577.882823] [129/133] (451s left) gem_wait (write-wait) [577.960569] Starting subtest: write-wait [577.962920] Starting dynamic subtest: all-engines [579.074206] Dynamic subtest all-engines: SUCCESS (1.112s) [579.091321] Starting dynamic subtest: rcs0 [580.132070] Dynamic subtest rcs0: SUCCESS (1.057s) [580.150315] Starting dynamic subtest: bcs0 [581.190452] Dynamic subtest bcs0: SUCCESS (1.056s) [581.208869] Starting dynamic subtest: vcs0 [582.243336] Dynamic subtest vcs0: SUCCESS (1.051s) [582.260723] Starting dynamic subtest: vcs1 [583.296389] Dynamic subtest vcs1: SUCCESS (1.051s) [583.314173] Starting dynamic subtest: vecs0 [584.348918] Dynamic subtest vecs0: SUCCESS (1.050s) [584.366613] Starting dynamic subtest: ccs0 [585.406512] Dynamic subtest ccs0: SUCCESS (1.055s) [585.409044] Subtest write-wait: SUCCESS (7.448s) [585.649868] [130/133] (444s left) kms_dirtyfb (psr-dirtyfb-ioctl) [585.773695] Starting subtest: psr-dirtyfb-ioctl [585.775720] Starting dynamic subtest: A-eDP-1 [589.727093] Dynamic subtest A-eDP-1: SUCCESS (3.949s) [589.729500] Subtest psr-dirtyfb-ioctl: SUCCESS (3.952s) [590.599475] [131/133] (439s left) kms_addfb_basic (too-high) [590.694457] Starting subtest: too-high [590.696856] Subtest too-high: SUCCESS (0.000s) [590.790681] [132/133] (439s left) i915_suspend (basic-s2idle-without-i915) [590.830988] Starting subtest: basic-s2idle-without-i915 [613.248053] Subtest basic-s2idle-without-i915: SUCCESS (6.951s) [613.335477] [133/133] (416s left) gen9_exec_parse (unaligned-jump) [613.424739] Subtest unaligned-jump: SKIP (0.000s) [613.494808] Closing watchdogs results: parsing output: 0/ for test: fbdev results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: gem_pxp results: parsing output: 4/ for test: drm_read results: parsing output: 5/ for test: gem_ctx_shared results: parsing output: 6/ for test: kms_color results: parsing output: 7/ for test: kms_joiner results: parsing output: 8/ for test: kms_pm_lpsp results: parsing output: 9/ for test: kms_rotation_crc results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: prime_vgem results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_chamelium_color results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: vgem_slow results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: i915_pm_rps results: parsing output: 23/ for test: gem_pxp results: parsing output: 24/ for test: kms_vblank results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_ccs results: parsing output: 27/ for test: kms_psr2_sf results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: kms_feature_discovery results: parsing output: 32/ for test: kms_addfb_basic results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: gem_ctx_persistence results: parsing output: 35/ for test: gem_exec_schedule results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: gem_exec_schedule results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: gem_exec_reloc results: parsing output: 40/ for test: gem_mmap results: parsing output: 41/ for test: gem_workarounds results: parsing output: 42/ for test: kms_cursor_crc results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_psr2_sf results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_balancer results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_partial_pwrite_pread results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_cursor_crc results: parsing output: 52/ for test: gem_mmap results: parsing output: 53/ for test: kms_psr2_sf results: parsing output: 54/ for test: gem_exec_fence results: parsing output: 55/ for test: kms_flip_scaled_crc results: parsing output: 56/ for test: gem_mmap_wc results: parsing output: 57/ for test: gem_softpin results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_mmap_offset results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: kms_chamelium_hpd results: parsing output: 63/ for test: kms_prime results: parsing output: 64/ for test: kms_rotation_crc results: parsing output: 65/ for test: kms_plane results: parsing output: 66/ for test: perf results: parsing output: 67/ for test: gem_exec_flush results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: gem_mmap results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_pipe_crc_basic results: parsing output: 76/ for test: i915_pciid results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: prime_busy results: parsing output: 79/ for test: api_intel_bb results: parsing output: 80/ for test: gem_exec_reloc results: parsing output: 81/ for test: gem_exec_reloc results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: perf results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: kms_plane results: parsing output: 90/ for test: gem_create results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: gem_pwrite_snooped results: parsing output: 93/ for test: gem_exec_whisper results: parsing output: 94/ for test: kms_fbcon_fbt results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: perf_pmu results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_atomic results: parsing output: 100/ for test: gem_ringfill results: parsing output: 101/ for test: kms_addfb_basic results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_softpin results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: gem_exercise_blt results: parsing output: 106/ for test: gem_lmem_swapping results: parsing output: 107/ for test: kms_selftest results: parsing output: 108/ for test: gem_eio results: parsing output: 109/ for test: kms_invalid_mode results: parsing output: 110/ for test: gem_exec_schedule results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: gem_flink_basic results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: kms_cursor_legacy results: parsing output: 115/ for test: kms_plane_cursor results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: api_intel_bb results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_ctx_persistence results: parsing output: 121/ for test: kms_rotation_crc results: parsing output: 122/ for test: gem_pread results: parsing output: 123/ for test: gem_exec_reloc results: parsing output: 124/ for test: gen9_exec_parse results: parsing output: 125/ for test: kms_chamelium_color results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: sysfs_timeslice_duration results: parsing output: 128/ for test: gem_wait results: parsing output: 129/ for test: kms_dirtyfb results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: i915_suspend results: parsing output: 132/ for test: gen9_exec_parse Done.