[42.623201] Initializing watchdogs [42.623319] /dev/watchdog0 [42.635728] [001/133] (960s left) kms_psr (fbc-pr-cursor-mmap-gtt) [42.720129] Starting subtest: fbc-pr-cursor-mmap-gtt [42.727380] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [42.765378] [002/133] (960s left) gem_userptr_blits (invalid-mmap-offset-unsync) [42.864881] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [42.966786] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [43.058047] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [43.061241] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [43.131732] [004/133] (960s left) gem_exec_fair (basic-pace-solo) [43.209168] Subtest basic-pace-solo: SKIP (0.000s) [43.246585] [005/133] (959s left) gem_exec_reloc (basic-wc-gtt) [43.318210] Subtest basic-wc-gtt: SKIP (0.000s) [43.361542] [006/133] (959s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [43.431832] Subtest writes-after-reads-snoop: SKIP (0.000s) [43.470100] [007/133] (959s left) gem_ctx_param (invalid-get-no-zeromap) [43.539456] Starting subtest: invalid-get-no-zeromap [43.541553] Subtest invalid-get-no-zeromap: SUCCESS (0.002s) [43.624079] [008/133] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [43.708779] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [43.712432] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [43.799428] [009/133] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [43.914315] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [43.918191] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [43.997925] [010/133] (959s left) sw_sync (sync_merge_invalid) [44.057464] Starting subtest: sync_merge_invalid [44.069374] Subtest sync_merge_invalid: SUCCESS (0.011s) [44.112114] [011/133] (959s left) kms_psr (fbc-pr-sprite-plane-move) [44.195504] Starting subtest: fbc-pr-sprite-plane-move [44.199465] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [44.254346] [012/133] (959s left) gem_eio (banned) [44.425239] Starting subtest: banned [44.886274] Subtest banned: SUCCESS (0.462s) [45.015356] [013/133] (958s left) prime_vgem (coherency-blt) [45.172090] Starting subtest: coherency-blt [47.360750] Subtest coherency-blt: SUCCESS (2.186s) [47.457177] [014/133] (955s left) api_intel_bb (blit-noreloc-purge-cache) [47.520822] Starting subtest: blit-noreloc-purge-cache [47.542069] Subtest blit-noreloc-purge-cache: SUCCESS (0.023s) [47.637761] [015/133] (955s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [47.696592] Starting subtest: multi-wait-all-for-submit-unsubmitted [47.803766] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [47.869424] [016/133] (955s left) gem_exec_reloc (basic-write-cpu) [47.942741] Subtest basic-write-cpu: SKIP (0.000s) [47.998776] [017/133] (955s left) v3d/v3d_mmap (mmap-bad-flags) [48.096312] Subtest mmap-bad-flags: SKIP (0.000s) [48.142748] [018/133] (955s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [48.249455] Starting subtest: fbcpsr-stridechange [52.597652] Subtest fbcpsr-stridechange: SUCCESS (4.352s) [52.732680] [019/133] (950s left) kms_busy (extended-modeset-hang-newfb-with-reset) [52.821875] Starting subtest: extended-modeset-hang-newfb-with-reset [52.824234] Starting dynamic subtest: pipe-A [66.400100] Dynamic subtest pipe-A: SUCCESS (13.577s) [66.413381] Starting dynamic subtest: pipe-D [82.274655] Dynamic subtest pipe-D: SUCCESS (15.868s) [82.277533] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.453s) [83.172158] [020/133] (920s left) kms_big_fb (x-tiled-8bpp-rotate-0) [83.246141] Starting subtest: x-tiled-8bpp-rotate-0 [84.637788] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.392s) [84.762143] [021/133] (918s left) kms_psr (psr-dpms) [84.861536] Starting subtest: psr-dpms [84.863861] Starting dynamic subtest: eDP-1 [87.972813] Dynamic subtest eDP-1: SUCCESS (3.113s) [87.975537] Subtest psr-dpms: SUCCESS (3.113s) [88.874052] [022/133] (914s left) perf (polling) [89.047531] Starting subtest: polling [89.049717] Starting dynamic subtest: 0-rcs0 [99.074290] Dynamic subtest 0-rcs0: SUCCESS (10.028s) [99.084680] Starting dynamic subtest: 1-vcs0 [109.095851] Dynamic subtest 1-vcs0: SUCCESS (10.021s) [109.098488] Subtest polling: SUCCESS (20.050s) [109.134683] [023/133] (894s left) gem_lmem_swapping (heavy-verify-multi-ccs) [109.215665] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [109.251347] [024/133] (894s left) perf (invalid-create-userspace-config) [109.371554] Starting subtest: invalid-create-userspace-config [109.374054] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [109.398580] [025/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [109.512888] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [109.517920] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [109.590506] [026/133] (894s left) gem_ctx_shared (q-out-order) [109.676421] Starting subtest: Q-out-order [109.678966] Starting dynamic subtest: rcs0 [109.797735] Dynamic subtest rcs0: SUCCESS (0.120s) [109.821722] Starting dynamic subtest: vcs0 [109.897493] Dynamic subtest vcs0: SUCCESS (0.100s) [109.920050] Starting dynamic subtest: vcs1 [109.996927] Dynamic subtest vcs1: SUCCESS (0.099s) [110.018961] Starting dynamic subtest: vecs0 [110.096089] Dynamic subtest vecs0: SUCCESS (0.099s) [110.118250] Starting dynamic subtest: ccs0 [110.197060] Dynamic subtest ccs0: SUCCESS (0.101s) [110.199734] Subtest Q-out-order: SUCCESS (0.520s) [111.618451] [027/133] (892s left) syncobj_eventfd (invalid-illegal-eventfd) [111.693109] Starting subtest: invalid-illegal-eventfd [111.695462] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [111.765954] [028/133] (892s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged) [111.850897] Subtest mark-unpurgeable-purged: SKIP (0.000s) [111.898642] [029/133] (891s left) gem_exec_schedule (implicit-boths) [111.981546] Starting subtest: implicit-boths [111.983908] Starting dynamic subtest: rcs0 [112.089909] Dynamic subtest rcs0: SUCCESS (0.118s) [112.104330] Starting dynamic subtest: vcs0 [112.206913] Dynamic subtest vcs0: SUCCESS (0.117s) [112.220552] Starting dynamic subtest: vcs1 [112.307554] Dynamic subtest vcs1: SUCCESS (0.100s) [112.321581] Starting dynamic subtest: vecs0 [112.435930] Dynamic subtest vecs0: SUCCESS (0.128s) [112.449910] Starting dynamic subtest: ccs0 [112.539209] Dynamic subtest ccs0: SUCCESS (0.103s) [112.541768] Subtest implicit-boths: SUCCESS (0.568s) [113.612397] [030/133] (890s left) gem_media_vme [113.717103] [031/133] (890s left) kms_frontbuffer_tracking (fbc-suspend) [113.831597] Starting subtest: fbc-suspend [151.238104] Subtest fbc-suspend: SUCCESS (7.290s) [151.368120] [032/133] (882s left) kms_ccs (random-ccs-data-4-tiled-xe2-ccs) [151.458540] Starting subtest: random-ccs-data-4-tiled-xe2-ccs [151.463624] Subtest random-ccs-data-4-tiled-xe2-ccs: SKIP (0.000s) [151.523215] [033/133] (882s left) gem_exec_fence (long-history) [152.008025] Starting subtest: long-history [159.284085] Subtest long-history: SUCCESS (7.277s) [160.255960] [034/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [160.365641] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [160.370370] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [160.453554] [035/133] (873s left) kms_vblank (ts-continuation-idle) [160.554368] Starting subtest: ts-continuation-idle [160.556676] Starting dynamic subtest: pipe-A-eDP-1 [160.981632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s) [160.999383] Starting dynamic subtest: pipe-D-eDP-1 [162.166961] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.175s) [162.169413] Subtest ts-continuation-idle: SUCCESS (1.608s) [163.093059] [036/133] (871s left) kms_flip (wf_vblank-ts-check-interruptible) [163.186798] Starting subtest: wf_vblank-ts-check-interruptible [163.191849] Starting dynamic subtest: A-eDP1 [172.169325] Dynamic subtest A-eDP1: SUCCESS (8.978s) [172.185188] Starting dynamic subtest: B-eDP1 [181.183317] Dynamic subtest B-eDP1: SUCCESS (9.013s) [181.202124] Starting dynamic subtest: C-eDP1 [190.197163] Dynamic subtest C-eDP1: SUCCESS (9.014s) [190.210337] Starting dynamic subtest: D-eDP1 [199.154019] Dynamic subtest D-eDP1: SUCCESS (8.955s) [199.160776] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.974s) [200.417673] [037/133] (833s left) kms_chamelium_color (ctm-blue-to-red) [200.525679] Subtest ctm-blue-to-red: SKIP (0.000s) [200.564496] [038/133] (833s left) v3d/v3d_submit_csd (valid-submission) [200.664932] Subtest valid-submission: SKIP (0.000s) [200.715299] [039/133] (833s left) gem_exec_balancer (parallel-contexts) [200.970426] Starting subtest: parallel-contexts [204.048261] Subtest parallel-contexts: SUCCESS (3.078s) [204.831799] [040/133] (829s left) kms_async_flips (async-flip-with-page-flip-events) [204.926923] Starting subtest: async-flip-with-page-flip-events [205.322127] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs [206.157503] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.831s) [206.165975] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [206.342036] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SKIP (0.186s) [206.357455] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc [206.532447] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.189s) [206.548237] Starting dynamic subtest: pipe-A-eDP-1-4 [208.734108] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.205s) [208.751154] Starting dynamic subtest: pipe-A-eDP-1-x [210.934961] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s) [210.950906] Starting dynamic subtest: pipe-A-eDP-1-linear [213.124586] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.189s) [213.514945] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs [214.338889] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.832s) [214.354844] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [214.504596] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SKIP (0.167s) [214.520548] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc [214.670381] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.165s) [214.686767] Starting dynamic subtest: pipe-B-eDP-1-4 [216.807882] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.140s) [216.822460] Starting dynamic subtest: pipe-B-eDP-1-x [219.007751] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [219.024949] Starting dynamic subtest: pipe-B-eDP-1-linear [221.207988] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.200s) [221.589834] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs [222.411239] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.829s) [222.422393] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [222.587104] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SKIP (0.173s) [222.599435] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc [222.736359] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.152s) [222.751942] Starting dynamic subtest: pipe-C-eDP-1-4 [224.901647] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.167s) [224.916981] Starting dynamic subtest: pipe-C-eDP-1-x [227.068524] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s) [227.084766] Starting dynamic subtest: pipe-C-eDP-1-linear [229.257280] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.189s) [229.636605] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs [230.456697] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.832s) [230.466514] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [230.648854] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SKIP (0.192s) [230.662283] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc [230.851308] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.203s) [230.862385] Starting dynamic subtest: pipe-D-eDP-1-4 [233.062044] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.211s) [233.077930] Starting dynamic subtest: pipe-D-eDP-1-x [235.259266] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s) [235.271975] Starting dynamic subtest: pipe-D-eDP-1-linear [237.450000] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.188s) [237.452452] Subtest async-flip-with-page-flip-events: SUCCESS (32.522s) [238.677943] [041/133] (795s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [238.778014] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [238.782387] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [238.847612] [042/133] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [238.954872] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [244.388976] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (5.440s) [244.529066] [043/133] (789s left) gem_render_copy (linear-to-vebox-y-tiled) [244.601762] Starting subtest: linear-to-vebox-y-tiled [244.606172] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [244.784262] [044/133] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [244.887925] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [244.893026] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [244.969816] [045/133] (789s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [245.066594] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [245.071266] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [245.150642] [046/133] (789s left) i915_module_load (reload) [245.219923] Starting subtest: reload [247.991136] Subtest reload: SUCCESS (2.773s) [248.016012] [047/133] (786s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [249.634667] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [252.404505] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.775s) [252.520902] [048/133] (781s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [252.625183] Starting subtest: primary-x-tiled-reflect-x-180 [260.912305] Subtest primary-x-tiled-reflect-x-180: SUCCESS (8.288s) [262.163567] [049/133] (772s left) kms_big_fb (4-tiled-8bpp-rotate-90) [262.257109] Starting subtest: 4-tiled-8bpp-rotate-90 [262.276842] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s) [262.372171] [050/133] (772s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [262.450726] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [262.453066] Starting dynamic subtest: pipe-A-default-mode [262.745098] Dynamic subtest pipe-A-default-mode: SKIP (0.289s) [262.750208] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.290s) [263.637497] [051/133] (770s left) gem_ringfill (basic-all) [269.661543] Starting subtest: basic-all [270.917816] Subtest basic-all: SUCCESS (1.258s) [271.020791] [052/133] (763s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [271.097703] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [271.100507] Starting dynamic subtest: pipe-A-eDP-1 [271.110340] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s) [271.124608] Starting dynamic subtest: pipe-B-eDP-1 [271.130103] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s) [271.143103] Starting dynamic subtest: pipe-C-eDP-1 [271.148568] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s) [271.160071] Starting dynamic subtest: pipe-D-eDP-1 [271.164659] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s) [271.169168] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.061s) [271.225668] [053/133] (763s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [271.297992] Starting subtest: invalid-bsd2-flag-on-vebox [271.300466] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [271.386058] [054/133] (763s left) gem_mmap_wc (coherency) [271.460767] Subtest coherency: SKIP (0.000s) [271.512832] [055/133] (763s left) dmabuf_sync_file (export-basic) [271.588529] Starting subtest: export-basic [271.591032] Subtest export-basic: SUCCESS (0.002s) [271.638190] [056/133] (763s left) sysfs_defaults (readonly) [271.734747] Starting subtest: readonly [271.737449] Starting dynamic subtest: vecs0 [271.740150] Dynamic subtest vecs0: SUCCESS (0.000s) [271.755491] Starting dynamic subtest: ccs0 [271.757697] Dynamic subtest ccs0: SUCCESS (0.000s) [271.770285] Starting dynamic subtest: vcs0 [271.772534] Dynamic subtest vcs0: SUCCESS (0.000s) [271.783764] Starting dynamic subtest: bcs0 [271.786421] Dynamic subtest bcs0: SUCCESS (0.000s) [271.800723] Starting dynamic subtest: rcs0 [271.803984] Dynamic subtest rcs0: SUCCESS (0.000s) [271.816682] Starting dynamic subtest: vcs1 [271.819774] Dynamic subtest vcs1: SUCCESS (0.000s) [271.822923] Subtest readonly: SUCCESS (0.003s) [271.845374] [057/133] (762s left) kms_psr (psr2-dpms) [271.913599] Starting subtest: psr2-dpms [271.915963] Starting dynamic subtest: eDP-1 [275.007021] Dynamic subtest eDP-1: SUCCESS (3.094s) [275.009530] Subtest psr2-dpms: SUCCESS (3.095s) [275.922017] [058/133] (758s left) gem_mmap_gtt (basic-small-copy-odd) [276.000162] Subtest basic-small-copy-odd: SKIP (0.000s) [276.051335] [059/133] (758s left) kms_lease (empty-lease) [276.141583] Starting subtest: empty-lease [276.144156] Starting dynamic subtest: pipe-A-eDP-1 [276.146591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [276.160948] Starting dynamic subtest: pipe-B-eDP-1 [276.163125] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [276.174840] Starting dynamic subtest: pipe-C-eDP-1 [276.176940] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [276.185784] Starting dynamic subtest: pipe-D-eDP-1 [276.187849] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [276.189941] Subtest empty-lease: SUCCESS (0.006s) [276.243234] [060/133] (758s left) gem_request_retire (retire-vma-not-inactive) [276.313969] Starting subtest: retire-vma-not-inactive [276.337038] Subtest retire-vma-not-inactive: SUCCESS (0.023s) [276.440570] [061/133] (758s left) v3d/v3d_submit_cl (simple-flush-cache) [276.533706] Subtest simple-flush-cache: SKIP (0.000s) [276.584807] [062/133] (758s left) gem_exec_flush (basic-wb-ro-before-default) [276.640856] Starting subtest: basic-wb-ro-before-default [282.118620] Subtest basic-wb-ro-before-default: SUCCESS (5.479s) [282.303154] [063/133] (752s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [282.395776] Starting subtest: plane-upscale-20x20-with-rotation [282.398482] Starting dynamic subtest: pipe-A-eDP-1 [282.720867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.327s) [282.735469] Starting dynamic subtest: pipe-B-eDP-1 [284.204337] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s) [284.220648] Starting dynamic subtest: pipe-C-eDP-1 [285.751150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.543s) [285.765884] Starting dynamic subtest: pipe-D-eDP-1 [287.284971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s) [287.287563] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.893s) [288.532298] [064/133] (746s left) kms_color (invalid-gamma-lut-sizes) [288.625700] Starting subtest: invalid-gamma-lut-sizes [288.628493] Starting dynamic subtest: pipe-A [288.933191] Dynamic subtest pipe-A: SUCCESS (0.308s) [288.948309] Starting dynamic subtest: pipe-B [288.951195] Dynamic subtest pipe-B: SUCCESS (0.001s) [288.963940] Starting dynamic subtest: pipe-C [288.966181] Dynamic subtest pipe-C: SUCCESS (0.001s) [288.975628] Starting dynamic subtest: pipe-D [288.977865] Dynamic subtest pipe-D: SUCCESS (0.001s) [288.980072] Subtest invalid-gamma-lut-sizes: SUCCESS (0.316s) [289.812835] [065/133] (745s left) vgem_basic (dmabuf-export) [289.875236] Starting subtest: dmabuf-export [289.890220] Subtest dmabuf-export: SUCCESS (0.016s) [289.972184] [066/133] (745s left) kms_pm_rpm (modeset-stress-extra-wait) [291.806833] Starting subtest: modeset-stress-extra-wait [348.477184] Subtest modeset-stress-extra-wait: SUCCESS (56.670s) [348.561933] [067/133] (686s left) kms_big_fb (linear-64bpp-rotate-180) [348.656562] Starting subtest: linear-64bpp-rotate-180 [350.508176] Subtest linear-64bpp-rotate-180: SUCCESS (1.852s) [350.715612] [068/133] (684s left) kms_psr (fbc-psr2-suspend) [350.789261] Starting subtest: fbc-psr2-suspend [350.791841] Starting dynamic subtest: eDP-1 [350.796549] Dynamic subtest eDP-1: SKIP (0.000s) [350.801220] Subtest fbc-psr2-suspend: SKIP (0.001s) [350.856093] [069/133] (684s left) gem_mmap_gtt (big-bo) [350.942760] Subtest big-bo: SKIP (0.000s) [350.991640] [070/133] (684s left) kms_dp_aux_dev [351.205619] [071/133] (683s left) kms_flip (dpms-vs-vblank-race) [351.300019] Starting subtest: dpms-vs-vblank-race [351.304740] Starting dynamic subtest: A-eDP1 [355.562915] Dynamic subtest A-eDP1: SUCCESS (4.257s) [355.580158] Starting dynamic subtest: B-eDP1 [359.201475] Dynamic subtest B-eDP1: SUCCESS (3.635s) [359.219010] Starting dynamic subtest: C-eDP1 [362.846261] Dynamic subtest C-eDP1: SUCCESS (3.643s) [362.863042] Starting dynamic subtest: D-eDP1 [366.507483] Dynamic subtest D-eDP1: SUCCESS (3.660s) [366.513080] Subtest dpms-vs-vblank-race: SUCCESS (15.217s) [367.391199] [072/133] (667s left) kms_chamelium_edid (dp-mode-timings) [367.791531] Subtest dp-mode-timings: SKIP (0.000s) [368.694711] [073/133] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [368.786283] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [373.428363] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.648s) [373.545751] [074/133] (661s left) i915_suspend (fence-restore-tiled2untiled) [373.622891] Starting subtest: fence-restore-tiled2untiled [373.627592] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [373.714497] [075/133] (661s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [373.796706] Starting subtest: map-fixed-invalidate-overlap-busy [373.801005] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [373.894064] [076/133] (661s left) gem_exec_fence (syncobj-timeline-unused-fence) [374.488151] Starting subtest: syncobj-timeline-unused-fence [374.498918] Subtest syncobj-timeline-unused-fence: SUCCESS (0.012s) [375.686706] [077/133] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [375.812956] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [375.817899] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [375.895423] [078/133] (659s left) perf_pmu (busy-accuracy-50) [375.960006] Starting subtest: busy-accuracy-50 [375.962396] Starting dynamic subtest: rcs0 [377.501415] Dynamic subtest rcs0: SUCCESS (1.540s) [377.517075] Starting dynamic subtest: bcs0 [379.057981] Dynamic subtest bcs0: SUCCESS (1.555s) [379.073784] Starting dynamic subtest: vcs0 [380.615866] Dynamic subtest vcs0: SUCCESS (1.556s) [380.631646] Starting dynamic subtest: vcs1 [382.175071] Dynamic subtest vcs1: SUCCESS (1.558s) [382.188824] Starting dynamic subtest: vecs0 [383.727305] Dynamic subtest vecs0: SUCCESS (1.551s) [383.743667] Starting dynamic subtest: ccs0 [385.287894] Dynamic subtest ccs0: SUCCESS (1.559s) [385.290428] Subtest busy-accuracy-50: SUCCESS (9.327s) [385.397696] [079/133] (649s left) gem_tiled_pread_pwrite [385.501071] [080/133] (649s left) kms_cursor_edge_walk (64x64-top-bottom) [385.586283] Starting subtest: 64x64-top-bottom [385.588770] Starting dynamic subtest: pipe-A-eDP-1 [389.116421] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.527s) [389.130645] Starting dynamic subtest: pipe-D-eDP-1 [392.394928] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.275s) [392.397565] Subtest 64x64-top-bottom: SUCCESS (6.806s) [393.306080] [081/133] (642s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [393.374993] Starting subtest: yf-tiled-16bpp-rotate-0 [393.378960] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [393.463270] [082/133] (641s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [393.580985] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [393.583533] Starting dynamic subtest: pipe-A-eDP-1 [393.587984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [393.595007] Starting dynamic subtest: pipe-B-eDP-1 [393.599455] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [393.609011] Starting dynamic subtest: pipe-C-eDP-1 [393.614008] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [393.623281] Starting dynamic subtest: pipe-D-eDP-1 [393.628328] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [393.633040] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s) [393.658548] [083/133] (641s left) vgem_basic (bad-flag) [393.724250] Starting subtest: bad-flag [393.726938] Subtest bad-flag: SUCCESS (0.000s) [393.778039] [084/133] (641s left) gen9_exec_parse (batch-without-end) [393.845844] Subtest batch-without-end: SKIP (0.000s) [393.903802] [085/133] (641s left) perf_pmu (interrupts) [393.979267] Starting subtest: interrupts [395.032497] Subtest interrupts: SUCCESS (1.062s) [395.137232] [086/133] (640s left) kms_psr2_sf (fbc-plane-move-sf-dmg-area) [400.427519] Starting subtest: fbc-plane-move-sf-dmg-area [400.430216] Starting dynamic subtest: psr2-pipe-A-eDP-1 [401.267569] Dynamic subtest psr2-pipe-A-eDP-1: SKIP (0.833s) [401.283797] Starting dynamic subtest: psr2-pipe-B-eDP-1 [402.473268] Dynamic subtest psr2-pipe-B-eDP-1: SKIP (1.204s) [402.478274] Subtest fbc-plane-move-sf-dmg-area: SKIP (2.044s) [403.798716] [087/133] (631s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [403.892328] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [403.896352] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [403.970814] [088/133] (631s left) syncobj_timeline (multi-wait-all-available-submitted) [404.030532] Starting subtest: multi-wait-all-available-submitted [404.032890] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [404.108942] [089/133] (631s left) gem_caching (read-writes) [404.165075] Subtest read-writes: SKIP (0.000s) [404.228974] [090/133] (631s left) gem_mmap_gtt (coherency) [404.295233] Subtest coherency: SKIP (0.000s) [404.330185] [091/133] (631s left) gem_softpin (allocator-nopin) [404.401876] Starting subtest: allocator-nopin [404.492787] Subtest allocator-nopin: SUCCESS (0.091s) [404.601004] [092/133] (631s left) gem_ctx_engines (execute-oneforall) [404.687384] Starting subtest: execute-oneforall [405.391132] Subtest execute-oneforall: SUCCESS (0.702s) [406.748253] [093/133] (628s left) api_intel_bb (intel-bb-blit-none) [406.823801] Starting subtest: intel-bb-blit-none [411.209652] Subtest intel-bb-blit-none: SUCCESS (4.388s) [411.313718] [094/133] (624s left) kms_lease (lease-unleased-crtc) [411.389453] Starting subtest: lease-unleased-crtc [411.392030] Starting dynamic subtest: pipe-A-eDP-1 [411.678873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [411.696302] Starting dynamic subtest: pipe-B-eDP-1 [412.494809] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.810s) [412.515121] Starting dynamic subtest: pipe-C-eDP-1 [412.517692] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [412.527233] Starting dynamic subtest: pipe-D-eDP-1 [412.529257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [412.531340] Subtest lease-unleased-crtc: SUCCESS (1.127s) [412.854732] [095/133] (622s left) gem_readwrite (read-write) [412.934410] Subtest read-write: SKIP (0.000s) [412.986038] [096/133] (622s left) gem_exec_params (no-blt) [413.052310] Starting subtest: no-blt [413.058772] Subtest no-blt: SUCCESS (0.006s) [413.158490] [097/133] (622s left) kms_flip_event_leak (basic) [413.230187] Starting subtest: basic [413.232654] Starting dynamic subtest: pipe-A-eDP-1 [413.687934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s) [413.703771] Starting dynamic subtest: pipe-B-eDP-1 [414.933723] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s) [414.950387] Starting dynamic subtest: pipe-C-eDP-1 [416.136486] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s) [416.153973] Starting dynamic subtest: pipe-D-eDP-1 [417.347871] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s) [417.351328] Subtest basic: SUCCESS (4.115s) [418.262548] [098/133] (617s left) syncobj_timeline (multi-wait-for-submit-signaled) [418.346384] Starting subtest: multi-wait-for-submit-signaled [418.349771] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [418.432904] [099/133] (617s left) gem_ctx_sseu (mmap-args) [418.513139] Subtest mmap-args: SKIP (0.000s) [418.550930] [100/133] (617s left) syncobj_wait (multi-wait-for-submit-signaled) [418.636426] Starting subtest: multi-wait-for-submit-signaled [418.639110] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [418.725249] [101/133] (617s left) perf_pmu (module-unload) [418.803146] Starting subtest: module-unload [457.378534] Subtest module-unload: SUCCESS (38.574s) [457.400676] [102/133] (578s left) gem_mmap_gtt (ptrace) [458.618630] Subtest ptrace: SKIP (0.000s) [458.655659] [103/133] (577s left) kms_big_fb (y-tiled-32bpp-rotate-0) [458.748889] Starting subtest: y-tiled-32bpp-rotate-0 [458.753314] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [458.820719] [104/133] (577s left) gem_partial_pwrite_pread (write-uncached) [458.901418] Subtest write-uncached: SKIP (0.000s) [458.943080] [105/133] (577s left) kms_plane_scaling (intel-max-src-size) [459.050081] Starting subtest: intel-max-src-size [459.055622] Subtest intel-max-src-size: SKIP (0.000s) [459.145021] [106/133] (576s left) prime_vgem (basic-read) [459.240662] Starting subtest: basic-read [459.252655] Subtest basic-read: SKIP (0.010s) [459.347492] [107/133] (576s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [459.447043] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [459.449473] Starting dynamic subtest: pipe-A-eDP-1 [459.454163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [459.465576] Starting dynamic subtest: pipe-B-eDP-1 [459.470114] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [459.478738] Starting dynamic subtest: pipe-C-eDP-1 [459.483258] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [459.491391] Starting dynamic subtest: pipe-D-eDP-1 [459.496047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [459.500492] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s) [459.519814] [108/133] (576s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [459.580478] Starting subtest: single-wait-all-for-submit-available-signaled [459.582633] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [459.660073] [109/133] (576s left) kms_cursor_crc (cursor-rapid-movement-512x512) [459.934814] Starting subtest: cursor-rapid-movement-512x512 [459.938869] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [460.062755] [110/133] (576s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [460.134555] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [460.138774] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [460.210151] [111/133] (576s left) gem_mmap_wc (write-read-distinct) [460.295761] Subtest write-read-distinct: SKIP (0.000s) [460.343760] [112/133] (575s left) kms_vblank (query-busy) [460.419904] Starting subtest: query-busy [460.421585] Starting dynamic subtest: pipe-A-eDP-1 [462.348225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s) [462.367939] Starting dynamic subtest: pipe-D-eDP-1 [465.009211] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s) [465.011666] Subtest query-busy: SUCCESS (4.591s) [465.941501] [113/133] (570s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [466.048794] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [466.052834] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [466.135817] [114/133] (570s left) gem_exec_schedule (smoketest) [466.351329] Starting subtest: smoketest [466.354305] Starting dynamic subtest: rcs0 [472.009747] Dynamic subtest rcs0: SUCCESS (5.604s) [472.023144] Starting dynamic subtest: bcs0 [477.617209] Dynamic subtest bcs0: SUCCESS (5.601s) [477.635246] Starting dynamic subtest: vcs0 [483.155885] Dynamic subtest vcs0: SUCCESS (5.539s) [483.163237] Starting dynamic subtest: vcs1 [488.664103] Dynamic subtest vcs1: SUCCESS (5.504s) [488.683462] Starting dynamic subtest: vecs0 [494.179120] Dynamic subtest vecs0: SUCCESS (5.522s) [494.189153] Starting dynamic subtest: ccs0 [499.746477] Dynamic subtest ccs0: SUCCESS (5.566s) [499.748881] Subtest smoketest: SUCCESS (33.342s) [499.879215] [115/133] (536s left) kms_hdr (invalid-hdr) [499.991391] Starting subtest: invalid-hdr [501.156826] Starting dynamic subtest: pipe-A-eDP-1 [504.658291] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s) [504.661565] Subtest invalid-hdr: SUCCESS (4.669s) [504.761809] [116/133] (531s left) kms_chamelium_hpd (hdmi-hpd-storm) [505.154339] Subtest hdmi-hpd-storm: SKIP (0.000s) [506.042335] [117/133] (530s left) i915_pm_rpm (gem-idle) [507.773532] Starting subtest: gem-idle [516.455907] Subtest gem-idle: SUCCESS (8.683s) [516.981854] [118/133] (519s left) gem_pread (exhaustion) [517.630610] Subtest exhaustion: SKIP (0.000s) [517.688643] [119/133] (518s left) kms_atomic (plane-overlay-legacy) [517.778872] Starting subtest: plane-overlay-legacy [517.781276] Starting dynamic subtest: pipe-A-eDP-1 [518.234908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [518.237476] Subtest plane-overlay-legacy: SUCCESS (0.458s) [519.120487] [120/133] (517s left) kms_addfb_basic (bo-too-small-due-to-tiling) [519.214890] Starting subtest: bo-too-small-due-to-tiling [519.219393] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [519.306296] [121/133] (517s left) drm_fdinfo (virtual-busy-idle) [519.349435] Starting subtest: virtual-busy-idle [519.353552] Subtest virtual-busy-idle: SKIP (0.000s) [519.413787] [122/133] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [519.481247] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [519.485888] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [519.553388] [123/133] (517s left) gem_sync (basic-store-all) [519.644011] Starting subtest: basic-store-all [522.345939] Subtest basic-store-all: SUCCESS (2.710s) [522.529024] [124/133] (514s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [522.593092] Starting subtest: etime-multi-wait-all-submitted-signaled [522.699269] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s) [522.776131] [125/133] (513s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [522.895689] Starting subtest: cursorB-vs-flipA-varying-size [522.900531] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s) [523.035051] [126/133] (513s left) gem_create (create-clear) [523.099022] Starting subtest: create-clear [523.101667] Starting dynamic subtest: smem0 [556.314670] Dynamic subtest smem0: SUCCESS (33.213s) [556.317305] Subtest create-clear: SUCCESS (33.214s) [556.499506] [127/133] (480s left) kms_psr (pr-sprite-plane-move) [556.603453] Starting subtest: pr-sprite-plane-move [556.607996] Subtest pr-sprite-plane-move: SKIP (0.000s) [556.666829] [128/133] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [556.753864] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [556.758482] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [556.835650] [129/133] (479s left) kms_cursor_crc (cursor-offscreen-256x85) [557.108430] Starting subtest: cursor-offscreen-256x85 [557.164784] Subtest cursor-offscreen-256x85: SKIP (0.049s) [557.303323] [130/133] (479s left) gem_exec_whisper (basic-contexts-forked) [557.382012] Starting subtest: basic-contexts-forked [582.811715] Subtest basic-contexts-forked: SUCCESS (25.426s) [582.989514] [131/133] (453s left) kms_plane_alpha_blend (constant-alpha-mid) [583.065176] Starting subtest: constant-alpha-mid [583.387618] Starting dynamic subtest: pipe-A-eDP-1 [584.394257] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.003s) [584.409898] Starting dynamic subtest: pipe-D-eDP-1 [586.079430] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.683s) [586.082205] Subtest constant-alpha-mid: SUCCESS (3.016s) [586.959721] [132/133] (449s left) gem_exec_reloc (basic-softpin) [587.041302] Subtest basic-softpin: SKIP (0.000s) [587.102926] [133/133] (449s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [587.202910] Starting subtest: basic-busy-flip-before-cursor-legacy [587.207809] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [587.341441] Closing watchdogs Done.