[40.643665] Initializing watchdogs [40.643766] /dev/watchdog0 [40.651186] [001/130] (960s left) gem_lmem_swapping (heavy-verify-multi-ccs) [40.684933] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [40.706534] [002/130] (960s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [41.083755] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [41.920456] [003/130] (959s left) kms_plane (plane-position-hole-dpms) [42.012926] Starting subtest: plane-position-hole-dpms [42.496168] Starting dynamic subtest: pipe-A-plane-1 [45.022374] Dynamic subtest pipe-A-plane-1: SUCCESS (2.525s) [45.028960] Starting dynamic subtest: pipe-A-plane-2 [47.522140] Dynamic subtest pipe-A-plane-2: SUCCESS (2.483s) [47.530787] Starting dynamic subtest: pipe-A-plane-3 [50.018071] Dynamic subtest pipe-A-plane-3: SUCCESS (2.466s) [50.024894] Starting dynamic subtest: pipe-A-plane-4 [52.502214] Dynamic subtest pipe-A-plane-4: SUCCESS (2.462s) [52.508545] Starting dynamic subtest: pipe-A-plane-5 [52.521567] Dynamic subtest pipe-A-plane-5: SUCCESS (0.020s) [53.768989] Starting dynamic subtest: pipe-B-plane-1 [56.287949] Dynamic subtest pipe-B-plane-1: SUCCESS (2.515s) [56.294081] Starting dynamic subtest: pipe-B-plane-2 [58.791286] Dynamic subtest pipe-B-plane-2: SUCCESS (2.494s) [58.796690] Starting dynamic subtest: pipe-B-plane-3 [61.278699] Dynamic subtest pipe-B-plane-3: SUCCESS (2.479s) [61.284457] Starting dynamic subtest: pipe-B-plane-4 [63.773375] Dynamic subtest pipe-B-plane-4: SUCCESS (2.490s) [63.778468] Starting dynamic subtest: pipe-B-plane-5 [63.793950] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s) [63.796316] Subtest plane-position-hole-dpms: SUCCESS (21.669s) [64.637182] [004/130] (936s left) kms_busy (basic) [64.732803] Starting subtest: basic [64.735181] Starting dynamic subtest: flip [65.315573] Dynamic subtest flip: SUCCESS (0.581s) [65.323202] Starting dynamic subtest: modeset [68.953974] Dynamic subtest modeset: SUCCESS (3.632s) [68.956234] Subtest basic: SUCCESS (4.214s) [69.851296] [005/130] (931s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [69.948174] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [69.950801] Starting dynamic subtest: pipe-A-eDP-1 [69.977078] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [69.983881] Starting dynamic subtest: pipe-B-eDP-1 [70.008249] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [70.014153] Starting dynamic subtest: pipe-C-eDP-1 [70.039049] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [70.047738] Starting dynamic subtest: pipe-D-eDP-1 [70.071692] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [70.076233] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.002s) [72.276157] [006/130] (929s left) gem_mmap_gtt (cpuset-medium-copy-xy) [72.320374] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [72.362758] [007/130] (928s left) gem_exec_reloc (basic-write-cpu-noreloc) [72.421751] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [72.460462] [008/130] (928s left) gem_mmap (pf-nonblock) [72.506840] Subtest pf-nonblock: SKIP (0.000s) [72.539556] [009/130] (928s left) gem_exec_params (rsvd2-dirt) [72.592962] Starting subtest: rsvd2-dirt [72.597445] Subtest rsvd2-dirt: SKIP (0.000s) [72.672781] [010/130] (928s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [72.770696] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [72.774729] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [72.836181] [011/130] (928s left) i915_fb_tiling [72.912615] [012/130] (928s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [73.004819] Starting subtest: primary-y-tiled-reflect-x-90 [73.009396] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [73.053875] [013/130] (928s left) kms_psr (psr2-dpms) [73.136838] Starting subtest: psr2-dpms [73.139128] Starting dynamic subtest: eDP-1 [76.159474] Dynamic subtest eDP-1: SUCCESS (3.019s) [76.161699] Subtest psr2-dpms: SUCCESS (3.019s) [77.075776] [014/130] (924s left) gem_sync (basic-store-all) [77.148778] Starting subtest: basic-store-all [79.857713] Subtest basic-store-all: SUCCESS (2.722s) [80.019527] [015/130] (921s left) gem_exec_fence (syncobj-wait) [80.438467] Starting subtest: syncobj-wait [82.392508] Subtest syncobj-wait: SUCCESS (1.952s) [84.419343] [016/130] (917s left) gem_exec_create (legacy) [84.469976] Starting subtest: legacy [84.472215] Starting dynamic subtest: smem [86.557125] Dynamic subtest smem: SUCCESS (2.087s) [86.559404] Subtest legacy: SUCCESS (2.087s) [86.718508] [017/130] (914s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [86.756574] Starting subtest: invalid-multi-wait-all-unsubmitted [86.758873] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [86.847780] [018/130] (914s left) gem_exec_fence (syncobj-import) [87.252046] Starting subtest: syncobj-import [87.291342] Subtest syncobj-import: SUCCESS (0.039s) [88.437782] [019/130] (913s left) gem_ctx_persistence (legacy-engines-mixed-process) [88.488972] Starting subtest: legacy-engines-mixed-process [88.491484] Starting dynamic subtest: render [90.436255] Dynamic subtest render: SUCCESS (1.947s) [90.444596] Starting dynamic subtest: bsd1 [92.359492] Dynamic subtest bsd1: SUCCESS (1.922s) [92.369056] Starting dynamic subtest: bsd2 [94.399555] Dynamic subtest bsd2: SUCCESS (2.038s) [94.407647] Starting dynamic subtest: blt [96.371321] Dynamic subtest blt: SUCCESS (1.970s) [96.378212] Starting dynamic subtest: vebox [98.359040] Dynamic subtest vebox: SUCCESS (1.987s) [98.361792] Subtest legacy-engines-mixed-process: SUCCESS (9.869s) [98.414372] [020/130] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [98.505460] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [98.510622] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [98.572818] [021/130] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [98.672615] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [98.677736] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [98.739029] [022/130] (902s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [98.797198] Starting subtest: x-tiled-to-vebox-yf-tiled [98.802796] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [98.960216] [023/130] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [99.043207] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [99.047426] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [99.109482] [024/130] (902s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [99.159879] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [99.161881] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [99.222547] [025/130] (902s left) gem_exec_nop (basic-sequential) [99.283398] Starting subtest: basic-sequential [113.936239] Subtest basic-sequential: SUCCESS (14.665s) [114.098923] [026/130] (887s left) kms_psr (psr-cursor-render) [114.189779] Starting subtest: psr-cursor-render [114.191957] Starting dynamic subtest: eDP-1 [115.959780] Dynamic subtest eDP-1: SUCCESS (1.768s) [115.962738] Subtest psr-cursor-render: SUCCESS (1.769s) [116.822973] [027/130] (884s left) gem_close_race (multigpu-basic-process) [116.878297] Starting subtest: multigpu-basic-process [116.882769] Subtest multigpu-basic-process: SKIP (0.000s) [117.101633] [028/130] (884s left) gem_tiled_wc [117.187293] [029/130] (884s left) kms_psr (fbc-pr-cursor-blt) [117.272863] Starting subtest: fbc-pr-cursor-blt [117.277363] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [117.319785] [030/130] (884s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [122.455087] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [122.460143] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s) [123.348456] [031/130] (878s left) i915_pm_rpm (gem-execbuf-stress-pc8) [125.567556] Starting subtest: gem-execbuf-stress-pc8 [125.604832] Subtest gem-execbuf-stress-pc8: SKIP (0.035s) [125.890893] [032/130] (875s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [125.977922] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [125.980289] Starting dynamic subtest: pipe-A-default-mode [126.273827] Dynamic subtest pipe-A-default-mode: SKIP (0.290s) [126.278957] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.291s) [127.191137] [033/130] (874s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [127.231951] Starting subtest: y-tiled-to-vebox-yf-tiled [127.236647] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [127.391417] [034/130] (874s left) kms_cursor_crc (cursor-sliding-32x10) [127.520379] Starting subtest: cursor-sliding-32x10 [127.552890] Subtest cursor-sliding-32x10: SKIP (0.028s) [127.774180] [035/130] (873s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [127.853815] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [127.858501] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [129.046335] [036/130] (872s left) prime_busy (before) [129.099754] Starting subtest: before [129.102552] Starting dynamic subtest: rcs0 [129.131440] Dynamic subtest rcs0: SUCCESS (0.031s) [129.137081] Starting dynamic subtest: bcs0 [129.196038] Dynamic subtest bcs0: SUCCESS (0.064s) [129.204040] Starting dynamic subtest: vcs0 [129.237045] Dynamic subtest vcs0: SUCCESS (0.041s) [129.244481] Starting dynamic subtest: vcs1 [129.278087] Dynamic subtest vcs1: SUCCESS (0.041s) [129.287530] Starting dynamic subtest: vecs0 [129.319777] Dynamic subtest vecs0: SUCCESS (0.041s) [129.327236] Starting dynamic subtest: ccs0 [129.361362] Dynamic subtest ccs0: SUCCESS (0.041s) [129.468671] Subtest before: SUCCESS (0.367s) [129.521124] [037/130] (872s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [129.614247] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [129.632674] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.016s) [129.682622] [038/130] (872s left) syncobj_timeline (invalid-signal-illegal-handle) [129.734728] Starting subtest: invalid-signal-illegal-handle [129.737229] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [129.801596] [039/130] (872s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [129.898693] Starting subtest: psr-2p-primscrn-cur-indfb-move [129.903246] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [129.965681] [040/130] (871s left) api_intel_bb (simple-bb) [130.020828] Starting subtest: simple-bb [130.027706] Subtest simple-bb: SUCCESS (0.008s) [130.129729] [041/130] (871s left) gem_exec_reloc (basic-wc-noreloc) [130.189887] Subtest basic-wc-noreloc: SKIP (0.000s) [130.255415] [042/130] (871s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [130.361500] Starting subtest: flip-vs-cursor-crc-legacy [130.975881] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.613s) [131.862648] [043/130] (870s left) gem_exec_reloc (basic-wc-read) [131.918510] Subtest basic-wc-read: SKIP (0.000s) [131.958163] [044/130] (869s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [132.033817] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [132.036278] Starting dynamic subtest: pipe-A [132.049315] Dynamic subtest pipe-A: SKIP (0.009s) [132.056706] Starting dynamic subtest: pipe-B [132.065558] Dynamic subtest pipe-B: SKIP (0.017s) [132.071623] Starting dynamic subtest: pipe-C [132.083493] Dynamic subtest pipe-C: SKIP (0.018s) [132.089331] Starting dynamic subtest: pipe-D [132.100966] Dynamic subtest pipe-D: SKIP (0.017s) [132.105219] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.063s) [132.165478] [045/130] (869s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [132.251868] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [132.254189] Starting dynamic subtest: pipe-A-default-mode [132.536628] Dynamic subtest pipe-A-default-mode: SKIP (0.280s) [132.541655] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.281s) [133.394149] [046/130] (868s left) gem_ctx_bad_destroy (double-destroy) [133.433670] Starting subtest: double-destroy [133.436223] Subtest double-destroy: SUCCESS (0.000s) [133.473260] [047/130] (868s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [133.577546] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [134.538279] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.960s) [135.444947] [048/130] (866s left) kms_color (legacy-gamma) [135.530756] Starting subtest: legacy-gamma [135.533065] Starting dynamic subtest: pipe-A-eDP-1 [136.198687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.666s) [136.209182] Starting dynamic subtest: pipe-B-eDP-1 [137.680289] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s) [137.687676] Starting dynamic subtest: pipe-C-eDP-1 [139.106490] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.425s) [139.114390] Starting dynamic subtest: pipe-D-eDP-1 [140.504536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s) [140.507098] Subtest legacy-gamma: SUCCESS (4.970s) [141.397160] [049/130] (860s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [141.481874] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [141.484191] Starting dynamic subtest: pipe-A-default-mode [141.767467] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [141.772153] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.282s) [142.675234] [050/130] (859s left) i915_selftest (live) [144.486698] Starting subtest: live [144.489498] Starting dynamic subtest: sanitycheck [146.753164] Dynamic subtest sanitycheck: SUCCESS (2.266s) [146.760912] Starting dynamic subtest: uncore [149.007251] Dynamic subtest uncore: SUCCESS (2.253s) [149.015674] Starting dynamic subtest: workarounds [151.655395] Dynamic subtest workarounds: SUCCESS (2.647s) [151.662926] Starting dynamic subtest: gt_engines [154.296340] Dynamic subtest gt_engines: SUCCESS (2.640s) [154.302065] Starting dynamic subtest: gt_timelines [168.953776] Dynamic subtest gt_timelines: SUCCESS (14.656s) [168.961393] Starting dynamic subtest: gt_contexts [171.266343] Dynamic subtest gt_contexts: SUCCESS (2.311s) [171.273253] Starting dynamic subtest: gt_lrc [175.503721] Dynamic subtest gt_lrc: SUCCESS (4.236s) [175.513585] Starting dynamic subtest: gt_mocs [177.987386] Dynamic subtest gt_mocs: SUCCESS (2.482s) [177.994606] Starting dynamic subtest: gt_pm [181.966413] Dynamic subtest gt_pm: SUCCESS (3.978s) [181.974866] Starting dynamic subtest: gt_heartbeat [184.222878] Dynamic subtest gt_heartbeat: SUCCESS (2.255s) [184.230481] Starting dynamic subtest: gt_tlb [191.806778] Dynamic subtest gt_tlb: SUCCESS (7.583s) [191.814223] Starting dynamic subtest: requests [202.707665] Dynamic subtest requests: SUCCESS (10.900s) [202.714800] Starting dynamic subtest: migrate [208.006058] Dynamic subtest migrate: SUCCESS (5.297s) [208.013505] Starting dynamic subtest: active [210.311746] Dynamic subtest active: SUCCESS (2.305s) [210.320800] Starting dynamic subtest: objects [213.174117] Dynamic subtest objects: SUCCESS (2.861s) [213.181815] Starting dynamic subtest: mman [216.134673] Dynamic subtest mman: SUCCESS (2.960s) [216.141238] Starting dynamic subtest: dmabuf [218.485547] Dynamic subtest dmabuf: SUCCESS (2.349s) [218.492683] Starting dynamic subtest: vma [220.789462] Dynamic subtest vma: SUCCESS (2.303s) [220.797306] Starting dynamic subtest: coherency [223.888083] Dynamic subtest coherency: SUCCESS (3.098s) [223.896221] Starting dynamic subtest: gtt [233.345125] Dynamic subtest gtt: SUCCESS (9.456s) [233.351137] Starting dynamic subtest: gem [239.020132] Dynamic subtest gem: SUCCESS (5.674s) [239.027732] Starting dynamic subtest: evict [242.543416] Dynamic subtest evict: SUCCESS (3.523s) [242.549214] Starting dynamic subtest: hugepages [250.800793] Dynamic subtest hugepages: SUCCESS (8.256s) [250.808117] Starting dynamic subtest: gem_contexts [275.975594] Dynamic subtest gem_contexts: SUCCESS (25.173s) [275.982850] Starting dynamic subtest: client [278.262946] Dynamic subtest client: SUCCESS (2.287s) [278.270063] Starting dynamic subtest: gem_migrate [280.545906] Dynamic subtest gem_migrate: SUCCESS (2.281s) [280.553811] Starting dynamic subtest: reset [282.895256] Dynamic subtest reset: SUCCESS (2.349s) [282.901754] Starting dynamic subtest: memory_region [285.205400] Dynamic subtest memory_region: SUCCESS (2.309s) [285.212500] Starting dynamic subtest: hangcheck [297.558884] Dynamic subtest hangcheck: SUCCESS (12.351s) [297.566650] Starting dynamic subtest: execlists [299.864713] Dynamic subtest execlists: SUCCESS (2.305s) [299.874573] Starting dynamic subtest: ring_submission [302.143310] Dynamic subtest ring_submission: SUCCESS (2.277s) [302.151279] Starting dynamic subtest: perf [304.530707] Dynamic subtest perf: SUCCESS (2.387s) [304.538832] Starting dynamic subtest: slpc [316.225576] Dynamic subtest slpc: SUCCESS (11.693s) [316.233426] Starting dynamic subtest: guc [319.637473] Dynamic subtest guc: SUCCESS (3.411s) [319.644761] Starting dynamic subtest: guc_multi_lrc [321.959025] Dynamic subtest guc_multi_lrc: SUCCESS (2.321s) [321.969062] Starting dynamic subtest: guc_hang [324.808044] Dynamic subtest guc_hang: SUCCESS (2.848s) [324.815723] Starting dynamic subtest: late_gt_pm [327.064749] Dynamic subtest late_gt_pm: SUCCESS (2.256s) [327.067621] Subtest live: SUCCESS (182.569s) [327.256435] [051/130] (674s left) kms_cursor_crc (cursor-random-512x170) [329.003441] Starting subtest: cursor-random-512x170 [329.008113] Subtest cursor-random-512x170: SKIP (0.001s) [329.127831] [052/130] (672s left) gen7_exec_parse (bitmasks) [329.181821] Subtest bitmasks: SKIP (0.000s) [329.227825] [053/130] (672s left) kms_fbcon_fbt (fbc) [329.266937] Starting subtest: fbc [334.738991] Subtest fbc: SUCCESS (5.470s) [334.781995] [054/130] (667s left) perf_pmu (rc6-suspend) [334.817019] Starting subtest: rc6-suspend [357.032071] Subtest rc6-suspend: SUCCESS (8.276s) [357.880882] [055/130] (658s left) kms_big_fb (4-tiled-32bpp-rotate-180) [357.967797] Starting subtest: 4-tiled-32bpp-rotate-180 [359.127901] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.149s) [359.238334] [056/130] (656s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [359.325711] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [359.329867] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [359.386595] [057/130] (656s left) kms_addfb_basic (bad-pitch-63) [359.427941] Starting subtest: bad-pitch-63 [359.429883] Subtest bad-pitch-63: SUCCESS (0.000s) [359.554082] [058/130] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [359.644518] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [364.225469] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.557s) [364.323313] [059/130] (651s left) syncobj_eventfd (invalid-illegal-handle) [364.371765] Starting subtest: invalid-illegal-handle [364.373603] Subtest invalid-illegal-handle: SUCCESS (0.000s) [364.441669] [060/130] (651s left) api_intel_bb (add-remove-objects) [364.483554] Starting subtest: add-remove-objects [364.491521] Subtest add-remove-objects: SUCCESS (0.008s) [364.564859] [061/130] (651s left) gem_exec_flush (basic-wb-pro-default) [364.620515] Starting subtest: basic-wb-pro-default [370.061453] Subtest basic-wb-pro-default: SUCCESS (5.416s) [370.211909] [062/130] (645s left) kms_cursor_edge_walk (64x64-right-edge) [370.303010] Starting subtest: 64x64-right-edge [370.305476] Starting dynamic subtest: pipe-A-eDP-1 [373.834745] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.524s) [373.843031] Starting dynamic subtest: pipe-D-eDP-1 [377.071307] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.231s) [377.074032] Subtest 64x64-right-edge: SUCCESS (6.756s) [377.944470] [063/130] (638s left) gem_spin_batch (resubmit-new-all) [377.995879] Starting subtest: resubmit-new-all [377.998348] Starting dynamic subtest: rcs0 [378.007277] Dynamic subtest rcs0: SUCCESS (0.012s) [378.016022] Starting dynamic subtest: bcs0 [378.018357] Dynamic subtest bcs0: SUCCESS (0.008s) [378.025064] Starting dynamic subtest: vcs0 [378.027473] Dynamic subtest vcs0: SUCCESS (0.007s) [378.034531] Starting dynamic subtest: vcs1 [378.036596] Dynamic subtest vcs1: SUCCESS (0.006s) [378.042969] Starting dynamic subtest: vecs0 [378.045391] Dynamic subtest vecs0: SUCCESS (0.007s) [378.051315] Starting dynamic subtest: ccs0 [378.053419] Dynamic subtest ccs0: SUCCESS (0.007s) [378.055502] Subtest resubmit-new-all: SUCCESS (0.048s) [379.272062] [064/130] (636s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [379.371663] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [380.226910] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.854s) [380.333953] [065/130] (635s left) gem_media_fill (media-fill) [380.389656] Subtest media-fill: SKIP (0.000s) [380.435337] [066/130] (635s left) kms_joiner (invalid-modeset-big-joiner) [380.532278] Starting subtest: invalid-modeset-big-joiner [380.536771] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [380.576006] [067/130] (635s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [380.621035] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [380.623071] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [380.712387] [068/130] (635s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [380.803758] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [380.807291] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [380.889301] [069/130] (635s left) gem_exec_reloc (basic-wc-cpu-active) [380.941525] Subtest basic-wc-cpu-active: SKIP (0.000s) [380.985116] [070/130] (635s left) gem_mmap_wc (set-cache-level) [381.032761] Subtest set-cache-level: SKIP (0.000s) [381.063489] [071/130] (635s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [381.150816] Starting subtest: fbcpsr-rgb565-draw-blt [385.881319] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (4.730s) [385.979768] [072/130] (630s left) gem_exec_reloc (basic-write-read-active) [386.031619] Subtest basic-write-read-active: SKIP (0.000s) [386.076079] [073/130] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [386.173246] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [386.177255] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [386.239053] [074/130] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [386.327435] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [386.331872] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [386.388646] [075/130] (630s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [391.507738] Starting subtest: psr2-overlay-plane-update-continuous-sf [391.510508] Starting dynamic subtest: pipe-A-eDP-1 [393.308831] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.798s) [393.318295] Starting dynamic subtest: pipe-B-eDP-1 [395.111260] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.802s) [395.114279] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.603s) [395.994517] [076/130] (620s left) kms_vblank (wait-busy) [396.080658] Starting subtest: wait-busy [396.082910] Starting dynamic subtest: pipe-A-eDP-1 [397.944699] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.860s) [397.957566] Starting dynamic subtest: pipe-D-eDP-1 [400.559311] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s) [400.561537] Subtest wait-busy: SUCCESS (4.477s) [401.430457] [077/130] (614s left) kms_flip (modeset-vs-vblank-race-interruptible) [401.519308] Starting subtest: modeset-vs-vblank-race-interruptible [401.521657] Starting dynamic subtest: A-eDP1 [406.444458] Dynamic subtest A-eDP1: SUCCESS (4.922s) [406.453911] Starting dynamic subtest: B-eDP1 [411.372624] Dynamic subtest B-eDP1: SUCCESS (4.925s) [411.382433] Starting dynamic subtest: C-eDP1 [416.277228] Dynamic subtest C-eDP1: SUCCESS (4.902s) [416.286026] Starting dynamic subtest: D-eDP1 [421.144784] Dynamic subtest D-eDP1: SUCCESS (4.866s) [421.148576] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.623s) [422.366328] [078/130] (594s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [422.459668] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [425.590404] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.134s) [425.705360] [079/130] (590s left) kms_big_fb (linear-32bpp-rotate-0) [425.807418] Starting subtest: linear-32bpp-rotate-0 [427.165023] Subtest linear-32bpp-rotate-0: SUCCESS (1.356s) [427.253385] [080/130] (589s left) gem_exec_whisper (basic-contexts-all) [427.313649] Starting subtest: basic-contexts-all [436.904561] Subtest basic-contexts-all: SUCCESS (9.586s) [437.062544] [081/130] (579s left) syncobj_timeline (wait-any-interrupted) [437.117329] Starting subtest: wait-any-interrupted [437.225919] Subtest wait-any-interrupted: SUCCESS (0.109s) [437.280630] [082/130] (579s left) syncobj_basic (test-valid-cycle) [437.332553] Starting subtest: test-valid-cycle [437.335036] Subtest test-valid-cycle: SUCCESS (0.000s) [437.409052] [083/130] (579s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [437.506532] Starting subtest: psr-rgb101010-draw-mmap-gtt [437.511096] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [437.572693] [084/130] (578s left) gem_ctx_isolation (dirty-switch) [437.623347] Starting subtest: dirty-switch [437.625734] Starting dynamic subtest: rcs0 [437.783127] Dynamic subtest rcs0: SUCCESS (0.160s) [437.790156] Starting dynamic subtest: bcs0 [437.976922] Dynamic subtest bcs0: SUCCESS (0.193s) [437.986754] Starting dynamic subtest: vcs0 [438.158510] Dynamic subtest vcs0: SUCCESS (0.181s) [438.166509] Starting dynamic subtest: vcs1 [439.440989] Dynamic subtest vcs1: SUCCESS (1.282s) [439.450324] Starting dynamic subtest: vecs0 [441.450289] Dynamic subtest vecs0: SUCCESS (2.008s) [441.457594] Starting dynamic subtest: ccs0 [443.464064] Dynamic subtest ccs0: SUCCESS (2.013s) [443.466783] Subtest dirty-switch: SUCCESS (5.839s) [443.698905] [085/130] (572s left) kms_universal_plane (disable-primary-vs-flip) [443.790712] Starting subtest: disable-primary-vs-flip [443.793033] Starting dynamic subtest: pipe-A-eDP-1 [445.404524] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.611s) [445.414637] Starting dynamic subtest: pipe-B-eDP-1 [447.708544] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.301s) [447.716411] Starting dynamic subtest: pipe-C-eDP-1 [450.010338] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.302s) [450.019836] Starting dynamic subtest: pipe-D-eDP-1 [452.317794] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.307s) [452.320820] Subtest disable-primary-vs-flip: SUCCESS (8.525s) [453.210801] [086/130] (563s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [453.301372] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [453.801763] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.503s) [453.914463] [087/130] (562s left) kms_pipe_crc_basic (hang-read-crc) [453.997002] Starting subtest: hang-read-crc [453.999288] Starting dynamic subtest: pipe-A-eDP-1 [456.042509] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.044s) [456.052154] Starting dynamic subtest: pipe-B-eDP-1 [458.835744] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.791s) [458.844071] Starting dynamic subtest: pipe-C-eDP-1 [461.562154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.726s) [461.570349] Starting dynamic subtest: pipe-D-eDP-1 [464.266155] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.705s) [464.268866] Subtest hang-read-crc: SUCCESS (10.270s) [465.181271] [088/130] (551s left) gem_exec_schedule (preempt-user) [465.250855] Starting subtest: preempt-user [465.253540] Starting dynamic subtest: rcs0 [465.258250] Dynamic subtest rcs0: SUCCESS (0.018s) [465.267101] Starting dynamic subtest: bcs0 [465.271486] Dynamic subtest bcs0: SUCCESS (0.013s) [465.278514] Starting dynamic subtest: vcs0 [465.285426] Dynamic subtest vcs0: SUCCESS (0.013s) [465.292979] Starting dynamic subtest: vcs1 [465.299784] Dynamic subtest vcs1: SUCCESS (0.014s) [465.307507] Starting dynamic subtest: vecs0 [465.315112] Dynamic subtest vecs0: SUCCESS (0.015s) [465.322020] Starting dynamic subtest: ccs0 [465.332792] Dynamic subtest ccs0: SUCCESS (0.017s) [465.335180] Subtest preempt-user: SUCCESS (0.092s) [467.312202] [089/130] (549s left) kms_getfb (getfb2-into-addfb2) [467.354711] Starting subtest: getfb2-into-addfb2 [467.357016] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [467.441099] [090/130] (549s left) kms_pwrite_crc [469.019216] [091/130] (547s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [469.109727] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [469.620933] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.514s) [469.761885] [092/130] (546s left) kms_psr (pr-cursor-mmap-cpu) [469.841902] Starting subtest: pr-cursor-mmap-cpu [469.846486] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [469.892128] [093/130] (546s left) syncobj_wait (wait-all-for-submit-snapshot) [469.938877] Starting subtest: wait-all-for-submit-snapshot [470.017812] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [470.068141] [094/130] (546s left) kms_chamelium_frames (dp-frame-dump) [470.436456] Subtest dp-frame-dump: SKIP (0.000s) [471.302382] [095/130] (545s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [471.395892] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [471.398142] Starting dynamic subtest: pipe-A [471.462194] Dynamic subtest pipe-A: SUCCESS (0.066s) [471.471978] Starting dynamic subtest: pipe-B [472.684762] Dynamic subtest pipe-B: SUCCESS (1.222s) [472.693335] Starting dynamic subtest: pipe-C [473.880190] Dynamic subtest pipe-C: SUCCESS (1.195s) [473.887700] Starting dynamic subtest: pipe-D [475.092332] Dynamic subtest pipe-D: SUCCESS (1.212s) [475.094727] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.697s) [476.312181] [096/130] (540s left) gem_userptr_blits (userfault) [476.370316] Starting subtest: userfault [476.372228] Subtest userfault: SUCCESS (0.005s) [476.495325] [097/130] (540s left) kms_dsc (dsc-basic) [476.582660] Starting subtest: dsc-basic [476.587110] Subtest dsc-basic: SKIP (0.000s) [476.631569] [098/130] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [476.725310] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [481.012202] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.290s) [481.138733] [099/130] (535s left) gem_ctx_param (set-priority-not-supported) [481.181992] Starting subtest: set-priority-not-supported [481.186678] Subtest set-priority-not-supported: SKIP (0.000s) [481.226480] [100/130] (535s left) gem_exec_schedule (preempt-engines) [481.294603] Starting subtest: preempt-engines [481.296828] Starting dynamic subtest: rcs0 [483.529744] Dynamic subtest rcs0: SUCCESS (2.242s) [483.539469] Starting dynamic subtest: bcs0 [485.768550] Dynamic subtest bcs0: SUCCESS (2.236s) [485.776928] Starting dynamic subtest: vcs0 [488.082556] Dynamic subtest vcs0: SUCCESS (2.313s) [488.092989] Starting dynamic subtest: vcs1 [490.382006] Dynamic subtest vcs1: SUCCESS (2.299s) [490.392538] Starting dynamic subtest: vecs0 [492.622294] Dynamic subtest vecs0: SUCCESS (2.238s) [492.629809] Starting dynamic subtest: ccs0 [494.909691] Dynamic subtest ccs0: SUCCESS (2.287s) [494.912438] Subtest preempt-engines: SUCCESS (13.622s) [495.185553] [101/130] (521s left) gem_gtt_cpu_tlb [495.274659] [102/130] (521s left) drm_read (short-buffer-nonblock) [495.414520] Starting subtest: short-buffer-nonblock [495.417055] Subtest short-buffer-nonblock: SUCCESS (0.000s) [495.517784] [103/130] (521s left) kms_pm_dc (dc5-psr) [496.599821] Starting subtest: dc5-psr [500.054184] Subtest dc5-psr: SUCCESS (3.451s) [500.958148] [104/130] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [501.063598] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [501.068143] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [501.129777] [105/130] (515s left) kms_flip (2x-nonexisting-fb) [501.219888] Starting subtest: 2x-nonexisting-fb [501.233212] Subtest 2x-nonexisting-fb: SKIP (0.013s) [501.284988] [106/130] (515s left) gem_exec_alignment (pi) [501.332385] Starting subtest: pi [621.768487] Per-test timeout exceeded. Killing the current test with SIGQUIT. [646.375300] Abort requested by /sbin/init [1] via Terminated, terminating children [646.376969] Abort requested by /sbin/init [1] via Hangup, terminating children [646.376992] Exiting gracefully, currently running test will have a 'notrun' result [663.556157] Closing watchdogs Done.