[56.213365] Initializing watchdogs [56.213419] /dev/watchdog0 [56.227705] [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] [56.232036] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.234551] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.237959] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85) [56.527950] Starting subtest: cursor-offscreen-256x85 [56.589265] Subtest cursor-offscreen-256x85: SKIP (0.055s) [56.762113] [002/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [56.848233] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [56.850460] Starting dynamic subtest: pipe-A-eDP-1 [56.909227] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [56.916816] Starting dynamic subtest: pipe-B-eDP-1 [56.972239] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s) [56.980915] Starting dynamic subtest: pipe-C-eDP-1 [57.032907] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [57.041330] Starting dynamic subtest: pipe-D-eDP-1 [57.087622] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s) [57.091280] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s) [59.187184] [003/133] (957s left) sysfs_timeslice_duration (duration) [59.249958] Starting subtest: duration [59.252490] Starting dynamic subtest: vecs0 [73.847426] Dynamic subtest vecs0: SUCCESS (14.613s) [73.858056] Starting dynamic subtest: ccs0 [86.994442] Dynamic subtest ccs0: SUCCESS (13.148s) [87.007039] Starting dynamic subtest: vcs0 [100.856332] Dynamic subtest vcs0: SUCCESS (13.856s) [100.870335] Starting dynamic subtest: bcs0 [113.997400] Dynamic subtest bcs0: SUCCESS (13.144s) [114.007699] Starting dynamic subtest: rcs0 [127.133600] Dynamic subtest rcs0: SUCCESS (13.135s) [127.145625] Starting dynamic subtest: vcs1 [141.877407] Dynamic subtest vcs1: SUCCESS (14.741s) [141.880080] Subtest duration: SUCCESS (82.647s) [141.953912] [004/133] (874s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [142.063843] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [142.066201] Starting dynamic subtest: pipe-A-eDP-1 [158.664258] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.539s) [158.673035] Starting dynamic subtest: pipe-B-eDP-1 [175.617509] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.447s) [175.627312] Starting dynamic subtest: pipe-C-eDP-1 [192.605389] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.357s) [192.618747] Starting dynamic subtest: pipe-D-eDP-1 [209.592397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.353s) [209.594631] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.700s) [210.813280] [005/133] (806s left) drm_buddy (drm_buddy) [210.854007] Starting subtest: drm_buddy [210.858442] Subtest drm_buddy: SKIP (0.001s) [210.908112] [006/133] (806s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [211.018414] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [211.832947] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s) [211.995546] [007/133] (804s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [212.098153] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [212.100379] Starting dynamic subtest: pipe-A-eDP-1 [212.850411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s) [212.860272] Starting dynamic subtest: pipe-B-eDP-1 [214.619619] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.784s) [214.629585] Starting dynamic subtest: pipe-C-eDP-1 [216.438331] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.829s) [216.452939] Starting dynamic subtest: pipe-D-eDP-1 [218.255958] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s) [218.257871] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.195s) [219.374353] [008/133] (797s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [219.466575] Starting subtest: bad-pixel-format-yf-tiled-ccs [219.468856] Starting dynamic subtest: pipe-A-eDP-1 [219.491977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [219.501231] Starting dynamic subtest: pipe-B-eDP-1 [219.523106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [219.531025] Starting dynamic subtest: pipe-C-eDP-1 [219.551977] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [219.559964] Starting dynamic subtest: pipe-D-eDP-1 [219.580368] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [219.584175] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s) [221.727658] [009/133] (795s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [221.783607] Starting subtest: multi-wait-available-unsubmitted-submitted [221.785783] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s) [221.892085] [010/133] (795s left) perf_pmu (event-wait) [221.933643] Starting subtest: event-wait [221.935742] Starting dynamic subtest: rcs0 [221.939615] Dynamic subtest rcs0: SKIP (0.000s) [221.943527] Subtest event-wait: SKIP (0.000s) [222.026132] [011/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [222.124849] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [222.129176] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [222.224628] [012/133] (794s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [222.320074] Starting subtest: psr-rgb565-draw-mmap-gtt [222.324055] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [222.417762] [013/133] (794s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [222.523300] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [222.525646] Starting dynamic subtest: pipe-A-eDP-1 [228.403949] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.897s) [228.413830] Starting dynamic subtest: pipe-B-eDP-1 [235.037000] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.641s) [235.039200] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.540s) [235.915715] [014/133] (781s left) kms_psr (fbc-psr2-dpms) [236.001487] Starting subtest: fbc-psr2-dpms [236.003628] Starting dynamic subtest: eDP-1 [236.007607] Dynamic subtest eDP-1: SKIP (0.000s) [236.011572] Subtest fbc-psr2-dpms: SKIP (0.001s) [236.082913] [015/133] (781s left) gem_exec_balancer (parallel-ordering) [236.345573] Starting subtest: parallel-ordering [237.313017] Subtest parallel-ordering: SUCCESS (0.968s) [237.452601] [016/133] (779s left) kms_joiner (basic-big-joiner) [237.564098] Starting subtest: basic-big-joiner [237.568169] Subtest basic-big-joiner: SKIP (0.000s) [237.633880] [017/133] (779s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [237.745987] Starting subtest: flip-vs-cursor-crc-atomic [238.462150] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.714s) [239.334706] [018/133] (778s left) gem_wait (wait) [239.396897] Starting subtest: wait [239.398753] Starting dynamic subtest: all-engines [240.831290] Dynamic subtest all-engines: SUCCESS (1.435s) [240.842583] Starting dynamic subtest: rcs0 [241.876153] Dynamic subtest rcs0: SUCCESS (1.045s) [241.887324] Starting dynamic subtest: bcs0 [242.924478] Dynamic subtest bcs0: SUCCESS (1.047s) [242.935812] Starting dynamic subtest: vcs0 [243.968715] Dynamic subtest vcs0: SUCCESS (1.043s) [243.979733] Starting dynamic subtest: vcs1 [245.012832] Dynamic subtest vcs1: SUCCESS (1.043s) [245.022929] Starting dynamic subtest: vecs0 [246.057032] Dynamic subtest vecs0: SUCCESS (1.043s) [246.067828] Starting dynamic subtest: ccs0 [247.110587] Dynamic subtest ccs0: SUCCESS (1.051s) [247.113155] Subtest wait: SUCCESS (7.717s) [247.314555] [019/133] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [247.422121] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [247.426228] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [247.519048] [020/133] (769s left) kms_flip (2x-flip-vs-expired-vblank) [247.617375] Starting subtest: 2x-flip-vs-expired-vblank [247.630963] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s) [247.710384] [021/133] (769s left) kms_lease (page-flip-implicit-plane) [247.805762] Starting subtest: page-flip-implicit-plane [247.808049] Starting dynamic subtest: pipe-A-eDP-1 [248.287914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s) [248.297145] Starting dynamic subtest: pipe-B-eDP-1 [249.483447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s) [249.494137] Starting dynamic subtest: pipe-C-eDP-1 [250.582717] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s) [250.592727] Starting dynamic subtest: pipe-D-eDP-1 [251.722684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s) [251.724965] Subtest page-flip-implicit-plane: SUCCESS (3.918s) [252.544286] [022/133] (765s left) gem_exec_params (rsvd2-dirt) [252.605078] Starting subtest: rsvd2-dirt [252.609438] Subtest rsvd2-dirt: SKIP (0.000s) [252.694756] [023/133] (764s left) api_intel_bb (blit-reloc-purge-cache) [252.746000] Starting subtest: blit-reloc-purge-cache [252.750088] Subtest blit-reloc-purge-cache: SKIP (0.000s) [252.847904] [024/133] (764s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [252.937216] Starting subtest: fbc-shrfb-scaledprimary [255.925505] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.991s) [257.066042] [025/133] (760s left) i915_pm_rpm (gem-idle) [259.001446] Starting subtest: gem-idle [265.197714] Subtest gem-idle: SUCCESS (6.201s) [265.532407] [026/133] (752s left) kms_big_fb (x-tiled-8bpp-rotate-0) [266.829659] Starting subtest: x-tiled-8bpp-rotate-0 [268.019970] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.192s) [268.131186] [027/133] (749s left) gem_exec_schedule (preempt-contexts) [268.197129] Starting subtest: preempt-contexts [268.199141] Starting dynamic subtest: rcs0 [268.250098] Dynamic subtest rcs0: SUCCESS (0.056s) [268.259311] Starting dynamic subtest: bcs0 [268.303498] Dynamic subtest bcs0: SUCCESS (0.053s) [268.312355] Starting dynamic subtest: vcs0 [268.351460] Dynamic subtest vcs0: SUCCESS (0.048s) [268.360144] Starting dynamic subtest: vcs1 [268.398749] Dynamic subtest vcs1: SUCCESS (0.047s) [268.407712] Starting dynamic subtest: vecs0 [268.442706] Dynamic subtest vecs0: SUCCESS (0.043s) [268.451218] Starting dynamic subtest: ccs0 [268.489518] Dynamic subtest ccs0: SUCCESS (0.047s) [268.491431] Subtest preempt-contexts: SUCCESS (0.297s) [269.920769] [028/133] (747s left) gem_exec_flush (basic-uc-rw-default) [269.998872] Starting subtest: basic-uc-rw-default [275.449081] Subtest basic-uc-rw-default: SUCCESS (5.453s) [275.644395] [029/133] (742s left) kms_color_pipeline (plane-lut1d) [275.753878] Starting subtest: plane-lut1d [275.922264] Starting dynamic subtest: pipe-A-plane-0 [276.304387] Dynamic subtest pipe-A-plane-0: FAIL (0.221s) [276.314287] Starting dynamic subtest: pipe-A-plane-1 [276.528040] Dynamic subtest pipe-A-plane-1: FAIL (0.164s) [276.538186] Starting dynamic subtest: pipe-A-plane-2 [276.747019] Dynamic subtest pipe-A-plane-2: FAIL (0.189s) [277.741444] Starting dynamic subtest: pipe-B-plane-0 [278.164776] Dynamic subtest pipe-B-plane-0: FAIL (0.164s) [278.173889] Starting dynamic subtest: pipe-B-plane-1 [278.470514] Dynamic subtest pipe-B-plane-1: FAIL (0.166s) [278.481024] Starting dynamic subtest: pipe-B-plane-2 [278.770852] Dynamic subtest pipe-B-plane-2: FAIL (0.177s) [279.454018] Starting dynamic subtest: pipe-C-plane-0 [279.951406] Dynamic subtest pipe-C-plane-0: FAIL (0.162s) [279.960773] Starting dynamic subtest: pipe-C-plane-1 [280.330205] Dynamic subtest pipe-C-plane-1: FAIL (0.133s) [280.339236] Starting dynamic subtest: pipe-C-plane-2 [280.684545] Dynamic subtest pipe-C-plane-2: FAIL (0.605s) [281.587272] Starting dynamic subtest: pipe-D-plane-0 [282.186241] Dynamic subtest pipe-D-plane-0: FAIL (0.151s) [282.203621] Starting dynamic subtest: pipe-D-plane-1 [282.642284] Dynamic subtest pipe-D-plane-1: FAIL (0.698s) [282.664708] Starting dynamic subtest: pipe-D-plane-2 [283.086323] Dynamic subtest pipe-D-plane-2: FAIL (0.209s) [283.088068] Subtest plane-lut1d: FAIL (7.204s) [283.757071] [030/133] (734s left) gem_exec_schedule (deep) [283.943163] Starting subtest: deep [283.945543] Starting dynamic subtest: rcs0 [289.157655] Dynamic subtest rcs0: SKIP (5.212s) [289.167092] Starting dynamic subtest: vcs0 [299.518689] Dynamic subtest vcs0: SUCCESS (10.367s) [299.529879] Starting dynamic subtest: vcs1 [311.231322] Dynamic subtest vcs1: SUCCESS (11.710s) [311.243542] Starting dynamic subtest: vecs0 [322.044292] Dynamic subtest vecs0: SUCCESS (10.808s) [322.058636] Starting dynamic subtest: ccs0 [334.971278] Dynamic subtest ccs0: SUCCESS (12.924s) [334.974159] Subtest deep: SUCCESS (51.026s) [336.770944] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true [336.774475] [031/133] (681s left) kms_cursor_crc (cursor-suspend) [336.902642] Starting subtest: cursor-suspend [336.904898] Starting dynamic subtest: pipe-A-eDP-1 [369.936980] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.187s) [369.946047] Starting dynamic subtest: pipe-D-eDP-1 [403.894450] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.778s) [403.897248] Subtest cursor-suspend: SUCCESS (6.968s) [404.716019] [032/133] (613s left) perf (gen8-unprivileged-single-ctx-counters) [404.864228] Starting subtest: gen8-unprivileged-single-ctx-counters [404.869275] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [404.908035] [033/133] (613s left) api_intel_bb (intel-bb-blit-y) [404.977566] Starting subtest: intel-bb-blit-y [408.620793] Subtest intel-bb-blit-y: SUCCESS (3.681s) [408.752671] [034/133] (609s left) prime_mmap (test_refcounting) [408.797773] Starting subtest: test_refcounting [408.800154] Starting dynamic subtest: test_refcounting-smem [408.827914] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s) [408.830868] Subtest test_refcounting: SUCCESS (0.033s) [408.921336] [035/133] (609s left) kms_atomic_transition (modeset-transition) [409.012560] Starting subtest: modeset-transition [409.014757] Starting dynamic subtest: 1x-outputs [419.778047] Dynamic subtest 1x-outputs: SUCCESS (10.809s) [419.780938] Subtest modeset-transition: SUCCESS (10.811s) [420.645063] [036/133] (597s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [420.734747] Starting subtest: plane-downscale-factor-0-5-with-modifiers [420.737424] Starting dynamic subtest: pipe-A [420.758164] Dynamic subtest pipe-A: SKIP (0.017s) [420.767687] Starting dynamic subtest: pipe-B [420.823726] Dynamic subtest pipe-B: SKIP (0.064s) [420.832812] Starting dynamic subtest: pipe-C [420.862636] Dynamic subtest pipe-C: SKIP (0.037s) [420.871754] Starting dynamic subtest: pipe-D [420.892384] Dynamic subtest pipe-D: SKIP (0.030s) [420.897512] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.155s) [420.988756] [037/133] (597s left) kms_frontbuffer_tracking (fbc-suspend) [421.103525] Starting subtest: fbc-suspend [458.882503] Subtest fbc-suspend: SUCCESS (7.413s) [460.063072] [038/133] (558s left) gem_pxp (display-protected-crc) [460.200061] Starting subtest: display-protected-crc [461.871291] Subtest display-protected-crc: SUCCESS (1.686s) [461.990346] [039/133] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [462.099507] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [462.105650] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [462.210302] [040/133] (556s left) gem_userptr_blits (dmabuf-unsync) [462.282199] Subtest dmabuf-unsync: SKIP (0.000s) [462.395438] [041/133] (555s left) gem_eio (context-create) [462.623812] Starting subtest: context-create [462.945527] Subtest context-create: SUCCESS (0.321s) [463.069086] [042/133] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [463.167245] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [469.915719] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.777s) [470.086174] [043/133] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [470.182699] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [470.187854] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [470.283518] [044/133] (548s left) kms_selftest (drm_dp_mst_helper) [470.326376] Starting subtest: drm_dp_mst_helper [470.395453] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [470.493458] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.096s) [470.505227] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [470.611021] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.118s) [470.621290] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [470.726404] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.115s) [470.728798] Subtest drm_dp_mst_helper: SUCCESS (0.401s) [470.895193] [045/133] (547s left) gem_spin_batch (resubmit-new) [470.965587] Starting subtest: resubmit-new [470.968282] Starting dynamic subtest: rcs0 [470.976386] Dynamic subtest rcs0: SUCCESS (0.010s) [470.986429] Starting dynamic subtest: bcs0 [470.988406] Dynamic subtest bcs0: SUCCESS (0.007s) [470.998462] Starting dynamic subtest: vcs0 [471.001070] Dynamic subtest vcs0: SUCCESS (0.006s) [471.010655] Starting dynamic subtest: vcs1 [471.013533] Dynamic subtest vcs1: SUCCESS (0.006s) [471.023306] Starting dynamic subtest: vecs0 [471.025552] Dynamic subtest vecs0: SUCCESS (0.005s) [471.035048] Starting dynamic subtest: ccs0 [471.037530] Dynamic subtest ccs0: SUCCESS (0.004s) [471.039876] Subtest resubmit-new: SUCCESS (0.045s) [472.349991] [046/133] (546s left) testdisplay [472.683036] [047/133] (545s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [472.779020] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [472.781419] Starting dynamic subtest: pipe-A-eDP-1 [472.907429] Dynamic subtest pipe-A-eDP-1: SKIP (0.133s) [472.919206] Starting dynamic subtest: pipe-B-eDP-1 [474.102850] Dynamic subtest pipe-B-eDP-1: SKIP (1.196s) [474.107756] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.331s) [475.289084] [048/133] (543s left) i915_selftest (live) [477.019441] Starting subtest: live [477.024143] Starting dynamic subtest: sanitycheck [482.128285] Dynamic subtest sanitycheck: SUCCESS (5.136s) [482.137892] Starting dynamic subtest: uncore [487.156810] Dynamic subtest uncore: SUCCESS (5.029s) [487.166680] Starting dynamic subtest: workarounds [491.189802] Dynamic subtest workarounds: SUCCESS (4.027s) [491.199955] Starting dynamic subtest: gt_engines [495.074479] Dynamic subtest gt_engines: SUCCESS (3.880s) [495.085799] Starting dynamic subtest: gt_timelines [512.508568] Dynamic subtest gt_timelines: SUCCESS (17.427s) [512.518396] Starting dynamic subtest: gt_contexts [516.090928] Dynamic subtest gt_contexts: SUCCESS (3.581s) [516.099956] Starting dynamic subtest: gt_lrc [521.237702] Dynamic subtest gt_lrc: SUCCESS (5.144s) [521.247312] Starting dynamic subtest: gt_mocs [525.052466] Dynamic subtest gt_mocs: SUCCESS (3.813s) [525.062558] Starting dynamic subtest: gt_pm [532.611487] Dynamic subtest gt_pm: SUCCESS (7.560s) [532.619332] Starting dynamic subtest: gt_heartbeat [536.184735] Dynamic subtest gt_heartbeat: SUCCESS (3.572s) [536.194392] Starting dynamic subtest: gt_tlb [546.865924] Dynamic subtest gt_tlb: SUCCESS (10.683s) [546.875314] Starting dynamic subtest: requests [559.670967] Dynamic subtest requests: SUCCESS (12.802s) [559.681220] Starting dynamic subtest: migrate [566.274924] Dynamic subtest migrate: SUCCESS (6.601s) [566.292831] Starting dynamic subtest: active [569.827816] Dynamic subtest active: SUCCESS (3.551s) [569.838407] Starting dynamic subtest: objects [574.068838] Dynamic subtest objects: SUCCESS (4.238s) [574.080960] Starting dynamic subtest: mman [578.400635] Dynamic subtest mman: SUCCESS (4.331s) [578.416065] Starting dynamic subtest: dmabuf [581.967022] Dynamic subtest dmabuf: SUCCESS (3.564s) [581.977536] Starting dynamic subtest: vma [585.538774] Dynamic subtest vma: SUCCESS (3.570s) [585.548895] Starting dynamic subtest: coherency [589.906692] Dynamic subtest coherency: SUCCESS (4.366s) [589.916766] Starting dynamic subtest: gtt [600.771427] Dynamic subtest gtt: SUCCESS (10.864s) [600.783330] Starting dynamic subtest: gem [607.974102] Dynamic subtest gem: SUCCESS (7.203s) [607.984380] Starting dynamic subtest: evict [612.896977] Dynamic subtest evict: SUCCESS (4.922s) [612.908483] Starting dynamic subtest: hugepages [623.117922] Dynamic subtest hugepages: SUCCESS (10.219s) [623.128204] Starting dynamic subtest: gem_contexts [649.916284] Dynamic subtest gem_contexts: SUCCESS (26.802s) [649.926577] Starting dynamic subtest: client [653.512240] Dynamic subtest client: SUCCESS (3.595s) [653.521986] Starting dynamic subtest: gem_migrate [658.635989] Dynamic subtest gem_migrate: SUCCESS (5.123s) [658.646545] Starting dynamic subtest: reset [663.806263] Dynamic subtest reset: SUCCESS (5.170s) [663.821643] Starting dynamic subtest: memory_region [668.890429] Dynamic subtest memory_region: SUCCESS (5.083s) [668.900883] Starting dynamic subtest: hangcheck [683.158233] Dynamic subtest hangcheck: SUCCESS (14.266s) [683.168655] Starting dynamic subtest: execlists [688.321661] Dynamic subtest execlists: SUCCESS (5.159s) [688.330978] Starting dynamic subtest: ring_submission [691.825670] Dynamic subtest ring_submission: SUCCESS (3.500s) [691.835661] Starting dynamic subtest: perf [695.462721] Dynamic subtest perf: SUCCESS (3.634s) [695.473249] Starting dynamic subtest: slpc [709.107703] Dynamic subtest slpc: SUCCESS (13.640s) [709.117254] Starting dynamic subtest: guc [713.904000] Dynamic subtest guc: SUCCESS (4.794s) [713.914446] Starting dynamic subtest: guc_multi_lrc [719.066094] Dynamic subtest guc_multi_lrc: SUCCESS (5.158s) [719.075890] Starting dynamic subtest: guc_hang [723.288958] Dynamic subtest guc_hang: SUCCESS (4.221s) [723.299473] Starting dynamic subtest: late_gt_pm [726.932148] Dynamic subtest late_gt_pm: SUCCESS (3.641s) [726.934981] Subtest live: SUCCESS (249.935s) [726.967570] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [726.969526] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [726.973587] [049/133] (291s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [729.360230] Subtest writes-after-reads-uncached: SKIP (0.000s) [729.443509] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [729.445396] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true [729.449866] [050/133] (289s left) kms_getfb (getfb-handle-not-fb) [729.551468] Starting subtest: getfb-handle-not-fb [729.554208] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [729.644002] [051/133] (289s left) kms_psr (fbc-psr-sprite-plane-onoff) [729.742812] Starting subtest: fbc-psr-sprite-plane-onoff [729.745490] Starting dynamic subtest: eDP-1 [729.750403] Dynamic subtest eDP-1: SKIP (0.000s) [729.754717] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [729.827817] [052/133] (289s left) i915_hangman (gt-error-state-capture) [729.891414] Starting subtest: gt-error-state-capture [729.893669] Starting dynamic subtest: rcs0 [740.305488] Dynamic subtest rcs0: SUCCESS (10.416s) [740.318514] Starting dynamic subtest: bcs0 [752.276953] Dynamic subtest bcs0: SUCCESS (11.968s) [752.292812] Starting dynamic subtest: vcs0 [764.244235] Dynamic subtest vcs0: SUCCESS (11.965s) [764.256500] Starting dynamic subtest: vcs1 [775.250543] Dynamic subtest vcs1: SUCCESS (11.004s) [775.262241] Starting dynamic subtest: vecs0 [787.218512] Dynamic subtest vecs0: SUCCESS (11.965s) [787.230585] Starting dynamic subtest: ccs0 [797.267464] Dynamic subtest ccs0: SUCCESS (10.046s) [797.270555] Subtest gt-error-state-capture: SUCCESS (67.377s) [797.354552] [053/133] (221s left) perf (invalid-open-flags) [797.479165] Starting subtest: invalid-open-flags [797.481448] Subtest invalid-open-flags: SUCCESS (0.000s) [797.529966] [054/133] (221s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [797.635226] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [797.640378] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [797.729740] [055/133] (221s left) kms_async_flips (async-flip-with-page-flip-events-linear) [797.813847] Starting subtest: async-flip-with-page-flip-events-linear [798.194497] Starting dynamic subtest: pipe-A-eDP-1 [800.988423] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.792s) [801.361911] Starting dynamic subtest: pipe-B-eDP-1 [804.123399] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s) [804.485310] Starting dynamic subtest: pipe-C-eDP-1 [807.253686] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s) [807.625854] Starting dynamic subtest: pipe-D-eDP-1 [810.378176] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s) [810.381041] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.565s) [811.564387] [056/133] (207s left) sw_sync (alloc_fence) [811.604816] Starting subtest: alloc_fence [811.607464] Subtest alloc_fence: SUCCESS (0.000s) [811.659690] [057/133] (207s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [811.748531] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [811.751112] Starting dynamic subtest: pipe-A-default-mode [812.919471] Dynamic subtest pipe-A-default-mode: SKIP (1.168s) [812.924682] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.169s) [813.052675] [058/133] (206s left) gem_ctx_persistence (heartbeat-close) [813.112952] Starting subtest: heartbeat-close [813.118559] Subtest heartbeat-close: SKIP (0.000s) [813.223794] [059/133] (205s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [813.323670] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [813.328334] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [813.433968] [060/133] (205s left) kms_flip (2x-flip-vs-modeset) [813.520606] Starting subtest: 2x-flip-vs-modeset [813.529585] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [813.610485] [061/133] (205s left) sw_sync (alloc_timeline) [813.650479] Starting subtest: alloc_timeline [813.653086] Subtest alloc_timeline: SUCCESS (0.000s) [813.709478] [062/133] (205s left) gem_exec_fence (syncobj-timeline-chain-engines) [814.245303] Starting subtest: syncobj-timeline-chain-engines [814.402952] Subtest syncobj-timeline-chain-engines: SUCCESS (0.137s) [815.365945] [063/133] (203s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [815.460492] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [815.465966] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [815.536968] [064/133] (203s left) perf_pmu (all-busy-check-all) [815.580612] Starting subtest: all-busy-check-all [817.333256] Subtest all-busy-check-all: SUCCESS (1.753s) [817.426389] [065/133] (201s left) kms_chamelium_frames (hdmi-crc-single) [817.814530] Subtest hdmi-crc-single: SKIP (0.000s) [818.611178] [066/133] (200s left) kms_draw_crc (draw-method-mmap-wc) [818.704899] Starting subtest: draw-method-mmap-wc [818.707149] Starting dynamic subtest: xrgb8888-untiled [818.939290] Dynamic subtest xrgb8888-untiled: SUCCESS (0.235s) [818.950653] Starting dynamic subtest: rgb565-untiled [819.173098] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [819.182887] Starting dynamic subtest: xrgb2101010-untiled [819.394817] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [819.405008] Starting dynamic subtest: xbgr16161616f-untiled [819.617062] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [819.627569] Starting dynamic subtest: xrgb8888-xtiled [819.738620] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [819.748040] Starting dynamic subtest: rgb565-xtiled [819.860804] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [819.870857] Starting dynamic subtest: xrgb2101010-xtiled [819.972711] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [819.983038] Starting dynamic subtest: xbgr16161616f-xtiled [820.105375] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [820.115497] Starting dynamic subtest: xrgb8888-4tiled [820.249967] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s) [820.259909] Starting dynamic subtest: rgb565-4tiled [820.394481] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [820.404471] Starting dynamic subtest: xrgb2101010-4tiled [820.550078] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [820.569677] Starting dynamic subtest: xbgr16161616f-4tiled [820.728104] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [820.730232] Subtest draw-method-mmap-wc: SUCCESS (2.027s) [820.837414] [067/133] (198s left) kms_content_protection (atomic) [820.983445] Starting subtest: atomic [820.987805] Subtest atomic: SKIP (0.000s) [821.096757] [068/133] (198s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [821.183179] Starting subtest: ccs-on-another-bo-y-tiled-ccs [821.185166] Starting dynamic subtest: pipe-A-eDP-1 [821.203289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [821.216338] Starting dynamic subtest: pipe-B-eDP-1 [821.236409] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [821.245904] Starting dynamic subtest: pipe-C-eDP-1 [821.272237] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [821.281696] Starting dynamic subtest: pipe-D-eDP-1 [821.303345] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [821.307610] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [823.481983] [069/133] (196s left) kms_psr (pr-primary-render) [823.585392] Starting subtest: pr-primary-render [823.590398] Subtest pr-primary-render: SKIP (0.000s) [823.664149] [070/133] (195s left) gem_exec_flush (basic-uc-ro-default) [823.719601] Starting subtest: basic-uc-ro-default [829.192085] Subtest basic-uc-ro-default: SUCCESS (5.473s) [829.386684] [071/133] (190s left) kms_dither (fb-8bpc-vs-panel-8bpc) [829.489308] Starting subtest: fb-8bpc-vs-panel-8bpc [829.491489] Starting dynamic subtest: pipe-A-eDP-1 [830.878029] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.392s) [830.880463] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.393s) [831.741361] [072/133] (187s left) gem_madvise (dontneed-after-mmap) [831.780553] Starting subtest: dontneed-after-mmap [831.806125] Subtest dontneed-after-mmap: SUCCESS (0.030s) [831.927676] [073/133] (187s left) kms_plane_alpha_blend (constant-alpha-mid) [832.025678] Starting subtest: constant-alpha-mid [832.320588] Starting dynamic subtest: pipe-A-eDP-1 [833.248440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.926s) [833.259423] Starting dynamic subtest: pipe-D-eDP-1 [834.708651] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.461s) [834.711479] Subtest constant-alpha-mid: SUCCESS (2.686s) [835.515460] [074/133] (184s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [835.570961] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [835.626164] [075/133] (184s left) kms_flip (2x-flip-vs-wf_vblank) [835.716904] Starting subtest: 2x-flip-vs-wf_vblank [835.725363] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s) [835.822829] [076/133] (184s left) kms_cursor_crc (cursor-sliding-128x42) [836.037638] Starting subtest: cursor-sliding-128x42 [836.086151] Subtest cursor-sliding-128x42: SKIP (0.042s) [836.293521] [077/133] (183s left) kms_psr (psr2-suspend) [836.393088] Starting subtest: psr2-suspend [836.395491] Starting dynamic subtest: eDP-1 [853.885461] Dynamic subtest eDP-1: SUCCESS (3.635s) [853.887854] Subtest psr2-suspend: SUCCESS (3.636s) [854.764730] [078/133] (165s left) gem_mmap_offset (open-flood) [854.822530] Starting subtest: open-flood [876.340281] Subtest open-flood: SUCCESS (21.491s) [876.444300] [079/133] (143s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [876.549492] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [876.553838] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [876.655147] [080/133] (143s left) gem_exec_nop (basic-sequential) [876.728197] Starting subtest: basic-sequential [891.651891] Subtest basic-sequential: SUCCESS (14.930s) [891.870291] [081/133] (128s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [891.973348] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [891.978459] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [892.048403] [082/133] (128s left) gem_mmap_gtt (basic-small-bo-tiledy) [892.105970] Subtest basic-small-bo-tiledY: SKIP (0.000s) [892.167220] [083/133] (128s left) kms_big_fb (y-tiled-64bpp-rotate-90) [892.258420] Starting subtest: y-tiled-64bpp-rotate-90 [892.263611] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [892.352091] [084/133] (127s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [892.444859] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [901.097278] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.657s) [901.234381] [085/133] (119s left) gem_exec_alignment (single) [901.298957] Starting subtest: single [901.304352] Subtest single: SUCCESS (0.004s) [901.409451] [086/133] (118s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [901.524631] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [901.529324] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [901.630477] [087/133] (118s left) syncobj_timeline (etime-single-wait-submitted) [901.687226] Starting subtest: etime-single-wait-submitted [901.796297] Subtest etime-single-wait-submitted: SUCCESS (0.109s) [901.881247] [088/133] (118s left) i915_drm_fdinfo (virtual-busy-all) [901.925460] Starting subtest: virtual-busy-all [901.931179] Subtest virtual-busy-all: SKIP (0.000s) [902.027499] [089/133] (118s left) gem_ctx_exec (basic) [902.087642] Starting subtest: basic [902.094289] Subtest basic: SUCCESS (0.009s) [902.227315] [090/133] (118s left) gem_busy (parallel) [902.415867] Starting subtest: parallel [902.418542] Starting dynamic subtest: rcs0 [904.147370] Dynamic subtest rcs0: SUCCESS (1.731s) [904.167301] Starting dynamic subtest: bcs0 [906.196548] Dynamic subtest bcs0: SUCCESS (2.045s) [906.210177] Starting dynamic subtest: vcs0 [908.181252] Dynamic subtest vcs0: SUCCESS (1.982s) [908.194866] Starting dynamic subtest: vcs1 [910.166177] Dynamic subtest vcs1: SUCCESS (1.982s) [910.179697] Starting dynamic subtest: vecs0 [912.149079] Dynamic subtest vecs0: SUCCESS (1.981s) [912.162581] Starting dynamic subtest: ccs0 [914.196778] Dynamic subtest ccs0: SUCCESS (2.045s) [914.199934] Subtest parallel: SUCCESS (11.780s) [914.444315] [091/133] (106s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [914.513020] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [914.515417] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [914.616750] [092/133] (105s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [914.715598] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [914.720395] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [914.788179] [093/133] (105s left) kms_vblank (ts-continuation-dpms-rpm) [914.880447] Starting subtest: ts-continuation-dpms-rpm [914.882818] Starting dynamic subtest: pipe-A-eDP-1 [917.442141] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.561s) [917.473982] Starting dynamic subtest: pipe-D-eDP-1 [919.701283] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s) [919.703894] Subtest ts-continuation-dpms-rpm: SUCCESS (4.820s) [920.502135] [094/133] (100s left) sw_sync (timeline_closed_signaled) [920.547138] Starting subtest: timeline_closed_signaled [920.549425] Subtest timeline_closed_signaled: SUCCESS (0.000s) [920.602923] [095/133] (100s left) gem_lmem_swapping (verify) [920.652206] Subtest verify: SKIP (0.000s) [920.699396] [096/133] (100s left) syncobj_wait (invalid-signal-zero-handles) [920.757772] Starting subtest: invalid-signal-zero-handles [920.760299] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [920.852000] [097/133] ( 99s left) kms_pm_rpm (i2c) [922.370335] Starting subtest: i2c [928.095389] Subtest i2c: SUCCESS (5.725s) [928.201845] [098/133] ( 92s left) vgem_basic (setversion) [928.262055] Starting subtest: setversion [928.267418] Subtest setversion: SUCCESS (0.000s) [928.322113] [099/133] ( 92s left) gem_exec_reloc (basic-write-gtt) [928.380571] Subtest basic-write-gtt: SKIP (0.000s) [928.453241] [100/133] ( 92s left) kms_scaling_modes (scaling-mode-center) [928.538795] Starting subtest: scaling-mode-center [928.541069] Starting dynamic subtest: pipe-A-eDP-1 [928.635072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s) [928.645603] Starting dynamic subtest: pipe-B-eDP-1 [929.804940] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s) [929.816352] Starting dynamic subtest: pipe-C-eDP-1 [930.922265] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s) [930.933164] Starting dynamic subtest: pipe-D-eDP-1 [932.060060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [932.062508] Subtest scaling-mode-center: SUCCESS (3.524s) [933.227634] [101/133] ( 87s left) perf_pmu (frequency) [933.269412] Starting subtest: frequency [933.276039] Starting dynamic subtest: gt0 [935.401127] Dynamic subtest gt0: SUCCESS (2.123s) [935.413157] Starting dynamic subtest: idle-gt0 [935.905944] Dynamic subtest idle-gt0: SUCCESS (0.504s) [935.918104] Starting dynamic subtest: gt1 [940.160284] Dynamic subtest gt1: SUCCESS (4.248s) [940.172249] Starting dynamic subtest: idle-gt1 [940.676479] Dynamic subtest idle-gt1: SUCCESS (0.516s) [940.679488] Subtest frequency: SUCCESS (7.408s) [940.774911] [102/133] ( 80s left) kms_big_fb (4-tiled-32bpp-rotate-180) [940.869447] Starting subtest: 4-tiled-32bpp-rotate-180 [942.249484] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.379s) [942.372220] [103/133] ( 78s left) kms_hdr (bpc-switch-dpms) [942.463048] Starting subtest: bpc-switch-dpms [943.500464] Starting dynamic subtest: pipe-A-eDP-1 [948.028158] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.526s) [948.030848] Subtest bpc-switch-dpms: SUCCESS (5.565s) [948.136444] [104/133] ( 72s left) syncobj_timeline (wait-any-interrupted) [948.196501] Starting subtest: wait-any-interrupted [948.296636] Subtest wait-any-interrupted: SUCCESS (0.101s) [948.376927] [105/133] ( 72s left) gem_exec_parallel (contexts) [948.432653] Starting subtest: contexts [948.435596] Starting dynamic subtest: rcs0 [951.982094] Dynamic subtest rcs0: SUCCESS (3.547s) [951.997165] Starting dynamic subtest: bcs0 [956.136892] Dynamic subtest bcs0: SUCCESS (4.152s) [956.148729] Starting dynamic subtest: vcs0 [960.669341] Dynamic subtest vcs0: SUCCESS (4.530s) [960.680869] Starting dynamic subtest: vcs1 [965.636213] Dynamic subtest vcs1: SUCCESS (4.964s) [965.647450] Starting dynamic subtest: vecs0 [971.516631] Dynamic subtest vecs0: SUCCESS (5.880s) [971.531762] Starting dynamic subtest: ccs0 [976.222752] Dynamic subtest ccs0: SUCCESS (4.703s) [976.225565] Subtest contexts: SUCCESS (27.791s) [976.413693] [106/133] ( 44s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [976.545781] Starting subtest: verify-pxp-key-change-after-suspend-resume [983.750613] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.207s) [983.880259] [107/133] ( 37s left) gem_create (create-ext-placement-each) [984.059791] Starting subtest: create-ext-placement-each [984.062483] Subtest create-ext-placement-each: SUCCESS (0.000s) [984.178810] [108/133] ( 37s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [984.268235] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [984.270705] Starting dynamic subtest: pipe-A-eDP-1 [984.296397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [984.309640] Starting dynamic subtest: pipe-B-eDP-1 [984.330954] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [984.341081] Starting dynamic subtest: pipe-C-eDP-1 [984.365986] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [984.377467] Starting dynamic subtest: pipe-D-eDP-1 [984.400265] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [984.402376] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [986.618925] [109/133] ( 34s left) gem_close_race (basic-process) [986.689908] Starting subtest: basic-process [986.739066] Subtest basic-process: SUCCESS (0.051s) [986.950840] [110/133] ( 34s left) gem_exec_schedule (u-independent) [987.021894] Starting subtest: u-independent [987.024471] Starting dynamic subtest: rcs0 [988.117920] Dynamic subtest rcs0: SUCCESS (1.109s) [988.133321] Starting dynamic subtest: vcs0 [990.177297] Dynamic subtest vcs0: SUCCESS (2.057s) [990.191696] Starting dynamic subtest: vcs1 [992.147315] Dynamic subtest vcs1: SUCCESS (1.969s) [992.158300] Starting dynamic subtest: vecs0 [994.215915] Dynamic subtest vecs0: SUCCESS (2.068s) [994.229958] Starting dynamic subtest: ccs0 [996.180137] Dynamic subtest ccs0: SUCCESS (1.961s) [996.182766] Subtest u-independent: SUCCESS (9.172s) [996.497839] [111/133] ( 24s left) gen9_exec_parse (batch-without-end) [996.563895] Subtest batch-without-end: SKIP (0.000s) [996.647563] [112/133] ( 24s left) kms_pm_rpm (dpms-mode-unset-lpsp) [1001.503872] Starting subtest: dpms-mode-unset-lpsp [1005.535714] Subtest dpms-mode-unset-lpsp: SUCCESS (4.035s) [1005.947472] [113/133] ( 15s left) kms_chamelium_hpd (vga-hpd) [1006.344207] Subtest vga-hpd: SKIP (0.000s) [1007.146304] [114/133] ( 14s left) gem_lmem_swapping (heavy-multi) [1007.191868] Subtest heavy-multi: SKIP (0.000s) [1007.246867] [115/133] ( 14s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [1007.350415] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf [1007.355283] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [1007.430504] [116/133] ( 14s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [1007.524432] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [1007.529417] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [1007.603820] [117/133] ( 14s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [1007.698454] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [1012.154895] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.460s) [1013.290835] [118/133] ( 8s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [1013.396296] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [1020.696316] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.301s) [1020.812548] [119/133] ( 0s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [1020.910966] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [1020.915204] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [1020.992311] [120/133] ( 0s left) gem_exec_balancer (noheartbeat) [1021.315367] Starting subtest: noheartbeat [1021.320757] Subtest noheartbeat: SKIP (0.000s) [1021.399826] Overall timeout time exceeded, stopping. [1021.415942] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: sysfs_timeslice_duration results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: drm_buddy results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: perf_pmu results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: gem_exec_balancer results: parsing output: 15/ for test: kms_joiner results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: gem_wait results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_lease results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: api_intel_bb results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: i915_pm_rpm results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: gem_exec_schedule results: parsing output: 27/ for test: gem_exec_flush results: parsing output: 28/ for test: kms_color_pipeline results: parsing output: 29/ for test: gem_exec_schedule results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: perf results: parsing output: 32/ for test: api_intel_bb results: parsing output: 33/ for test: prime_mmap results: parsing output: 34/ for test: kms_atomic_transition results: parsing output: 35/ for test: kms_plane_scaling results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_pxp results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_userptr_blits results: parsing output: 40/ for test: gem_eio results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_selftest results: parsing output: 44/ for test: gem_spin_batch results: parsing output: 45/ for test: testdisplay results: parsing output: 46/ for test: kms_psr2_sf results: parsing output: 47/ for test: i915_selftest results: parsing output: 48/ for test: gem_partial_pwrite_pread results: parsing output: 49/ for test: kms_getfb results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_async_flips results: parsing output: 55/ for test: sw_sync results: parsing output: 56/ for test: kms_flip_scaled_crc results: parsing output: 57/ for test: gem_ctx_persistence results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: sw_sync results: parsing output: 61/ for test: gem_exec_fence results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: kms_chamelium_frames results: parsing output: 65/ for test: kms_draw_crc results: parsing output: 66/ for test: kms_content_protection results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: gem_exec_flush results: parsing output: 70/ for test: kms_dither results: parsing output: 71/ for test: gem_madvise results: parsing output: 72/ for test: kms_plane_alpha_blend results: parsing output: 73/ for test: kms_pipe_b_c_ivb results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_cursor_crc results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: gem_mmap_offset results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_nop results: parsing output: 80/ for test: kms_flip_scaled_crc results: parsing output: 81/ for test: gem_mmap_gtt results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_exec_alignment results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: i915_drm_fdinfo results: parsing output: 88/ for test: gem_ctx_exec results: parsing output: 89/ for test: gem_busy results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_flip_scaled_crc results: parsing output: 92/ for test: kms_vblank results: parsing output: 93/ for test: sw_sync results: parsing output: 94/ for test: gem_lmem_swapping results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_pm_rpm results: parsing output: 97/ for test: vgem_basic results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: kms_scaling_modes results: parsing output: 100/ for test: perf_pmu results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_hdr results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: gem_exec_parallel results: parsing output: 105/ for test: gem_pxp results: parsing output: 106/ for test: gem_create results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: gem_close_race results: parsing output: 109/ for test: gem_exec_schedule results: parsing output: 110/ for test: gen9_exec_parse results: parsing output: 111/ for test: kms_pm_rpm results: parsing output: 112/ for test: kms_chamelium_hpd results: parsing output: 113/ for test: gem_lmem_swapping results: parsing output: 114/ for test: kms_psr2_sf results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_exec_balancer results: parsing output: 120/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 121/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 122/ for test: perf_pmu results: no output, setting notrun results: parsing output: 123/ for test: kms_force_connector_basic results: no output, setting notrun results: parsing output: 124/ for test: gem_ctx_param results: no output, setting notrun results: parsing output: 125/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 126/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 127/ for test: kms_flip results: no output, setting notrun results: parsing output: 128/ for test: kms_plane_scaling results: no output, setting notrun results: parsing output: 129/ for test: gem_exec_whisper results: no output, setting notrun results: parsing output: 130/ for test: kms_plane_lowres results: no output, setting notrun results: parsing output: 131/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 132/ for test: prime_vgem results: no output, setting notrun Done.