[44.570538] Initializing watchdogs [44.570648] /dev/watchdog0 [44.577215] [001/165] (960s left) i915_module_load (load) [44.654197] Starting subtest: load [45.666947] Subtest load: SUCCESS (1.012s) [45.685726] [002/165] (959s left) core_auth (basic-auth) [45.772385] Starting subtest: basic-auth [45.773975] Subtest basic-auth: SUCCESS (0.001s) [45.858984] [003/165] (959s left) debugfs_test (read_all_entries) [45.954906] Starting subtest: read_all_entries [46.042483] Subtest read_all_entries: SUCCESS (0.087s) [46.145347] [004/165] (958s left) debugfs_test (basic-hwmon) [46.214590] Starting subtest: basic-hwmon [46.216498] Subtest basic-hwmon: SKIP (0.000s) [46.310412] [005/165] (958s left) fbdev (eof) [46.391396] Starting subtest: eof [46.392453] Subtest eof: SUCCESS (0.001s) [46.445670] [006/165] (958s left) fbdev (info) [46.511218] Starting subtest: info [46.512513] Subtest info: SUCCESS (0.000s) [46.587137] [007/165] (958s left) fbdev (nullptr) [46.674168] Starting subtest: nullptr [46.675290] Subtest nullptr: SUCCESS (0.000s) [46.729043] [008/165] (958s left) fbdev (read) [46.807397] Starting subtest: read [47.661334] Subtest read: SUCCESS (0.845s) [47.713794] [009/165] (957s left) fbdev (write) [47.791322] Starting subtest: write [48.219519] Subtest write: SUCCESS (0.420s) [48.261941] [010/165] (956s left) gem_basic (bad-close) [48.329309] Starting subtest: bad-close [48.331258] Subtest bad-close: SUCCESS (0.000s) [48.400116] [011/165] (956s left) gem_basic (create-close) [48.471481] Starting subtest: create-close [48.473593] Subtest create-close: SUCCESS (0.000s) [48.551028] [012/165] (956s left) gem_basic (create-fd-close) [48.624696] Starting subtest: create-fd-close [48.626651] Subtest create-fd-close: SUCCESS (0.000s) [48.725907] [013/165] (956s left) gem_busy (busy@all-engines) [48.809906] Starting subtest: busy [48.811040] Starting dynamic subtest: all-engines [48.867704] Dynamic subtest all-engines: SUCCESS (0.058s) [48.868710] Subtest busy: SUCCESS (0.058s) [49.339886] [014/165] (956s left) gem_close_race (basic-process) [49.424890] Starting subtest: basic-process [49.492418] Subtest basic-process: SUCCESS (0.068s) [49.736885] [015/165] (955s left) gem_close_race (basic-threads) [49.839417] Starting subtest: basic-threads [51.063865] Subtest basic-threads: SUCCESS (1.224s) [51.348814] [016/165] (954s left) gem_ctx_create (basic) [51.440579] Starting subtest: basic [51.441632] Subtest basic: SUCCESS (0.000s) [51.675777] [017/165] (953s left) gem_ctx_create (basic-files) [51.767860] Starting subtest: basic-files [53.791756] Subtest basic-files: SUCCESS (2.024s) [54.083704] [018/165] (951s left) gem_ctx_exec (basic) [54.157051] Starting subtest: basic [54.163165] Subtest basic: SUCCESS (0.006s) [54.303431] [019/165] (951s left) gem_exec_basic (basic) [54.386305] Starting subtest: basic [54.387484] Starting dynamic subtest: rcs0-smem [54.388522] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [54.397448] Starting dynamic subtest: bcs0-smem [54.398446] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [54.405602] Starting dynamic subtest: vcs0-smem [54.406655] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [54.413797] Starting dynamic subtest: vecs0-smem [54.415231] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [54.416642] Subtest basic: SUCCESS (0.005s) [54.643045] [020/165] (950s left) gem_exec_create (basic) [54.725524] Starting subtest: basic [54.726605] Starting dynamic subtest: smem [56.766645] Dynamic subtest smem: SUCCESS (2.041s) [56.767770] Subtest basic: SUCCESS (2.041s) [57.033950] [021/165] (948s left) gem_exec_fence (basic-busy) [57.294328] Starting subtest: basic-busy [57.295568] Starting dynamic subtest: rcs0 [57.322288] Dynamic subtest rcs0: SUCCESS (0.030s) [57.329587] Starting dynamic subtest: bcs0 [57.346374] Dynamic subtest bcs0: SUCCESS (0.024s) [57.353690] Starting dynamic subtest: vcs0 [57.369378] Dynamic subtest vcs0: SUCCESS (0.023s) [57.376874] Starting dynamic subtest: vecs0 [57.392356] Dynamic subtest vecs0: SUCCESS (0.023s) [57.393389] Subtest basic-busy: SUCCESS (0.101s) [58.097811] [022/165] (947s left) gem_exec_fence (basic-wait) [58.333512] Starting subtest: basic-wait [58.335341] Starting dynamic subtest: rcs0 [58.359323] Dynamic subtest rcs0: SUCCESS (0.026s) [58.367126] Starting dynamic subtest: bcs0 [58.383318] Dynamic subtest bcs0: SUCCESS (0.024s) [58.391274] Starting dynamic subtest: vcs0 [58.408340] Dynamic subtest vcs0: SUCCESS (0.022s) [58.415750] Starting dynamic subtest: vecs0 [58.433248] Dynamic subtest vecs0: SUCCESS (0.028s) [58.434149] Subtest basic-wait: SUCCESS (0.100s) [59.104741] [023/165] (946s left) gem_exec_fence (basic-await) [59.340993] Starting subtest: basic-await [59.342525] Starting dynamic subtest: rcs0 [59.445955] Dynamic subtest rcs0: SUCCESS (0.105s) [59.454314] Starting dynamic subtest: bcs0 [59.543539] Dynamic subtest bcs0: SUCCESS (0.097s) [59.552998] Starting dynamic subtest: vcs0 [59.646104] Dynamic subtest vcs0: SUCCESS (0.103s) [59.654557] Starting dynamic subtest: vecs0 [59.741440] Dynamic subtest vecs0: SUCCESS (0.095s) [59.742393] Subtest basic-await: SUCCESS (0.401s) [60.522779] [024/165] (945s left) gem_exec_fence (nb-await) [60.764848] Starting subtest: nb-await [60.766873] Starting dynamic subtest: rcs0 [60.838380] Dynamic subtest rcs0: SUCCESS (0.071s) [60.847728] Starting dynamic subtest: bcs0 [60.904375] Dynamic subtest bcs0: SUCCESS (0.064s) [60.947358] Starting dynamic subtest: vcs0 [61.007634] Dynamic subtest vcs0: SUCCESS (0.102s) [61.053457] Starting dynamic subtest: vecs0 [61.114516] Dynamic subtest vecs0: SUCCESS (0.105s) [61.117744] Subtest nb-await: SUCCESS (0.347s) [61.861776] [025/165] (943s left) gem_exec_gttfill (basic) [61.947701] Starting subtest: basic [71.693071] Subtest basic: SUCCESS (9.737s) [71.887578] [026/165] (933s left) gem_exec_parallel (engines) [72.025899] Starting subtest: engines [72.027445] Starting dynamic subtest: basic [74.910245] Dynamic subtest basic: SUCCESS (2.885s) [74.919543] Starting dynamic subtest: contexts [80.132726] Dynamic subtest contexts: SUCCESS (5.222s) [80.141876] Starting dynamic subtest: fds [86.905062] Dynamic subtest fds: SUCCESS (6.772s) [86.914374] Starting dynamic subtest: userptr [89.620409] Dynamic subtest userptr: SUCCESS (2.714s) [89.621700] Subtest engines: SUCCESS (17.594s) [89.877950] [027/165] (915s left) gem_exec_store (basic) [89.969879] Starting subtest: basic [90.027421] Subtest basic: SUCCESS (0.058s) [90.266641] [028/165] (915s left) gem_flink_basic (bad-flink) [90.342356] Starting subtest: bad-flink [90.343446] Subtest bad-flink: SUCCESS (0.000s) [90.409648] [029/165] (915s left) gem_flink_basic (bad-open) [90.481716] Starting subtest: bad-open [90.482783] Subtest bad-open: SUCCESS (0.000s) [90.542317] [030/165] (915s left) gem_flink_basic (basic) [90.612317] Starting subtest: basic [90.613257] Subtest basic: SUCCESS (0.000s) [90.703210] [031/165] (915s left) gem_flink_basic (double-flink) [90.782793] Starting subtest: double-flink [90.783914] Subtest double-flink: SUCCESS (0.000s) [90.863236] [032/165] (914s left) gem_flink_basic (flink-lifetime) [90.939274] Starting subtest: flink-lifetime [90.940326] Subtest flink-lifetime: SUCCESS (0.002s) [91.032358] [033/165] (914s left) gem_huc_copy (huc-copy) [91.109722] Starting subtest: huc-copy [91.111890] Subtest huc-copy: SKIP (0.000s) [91.255896] [034/165] (914s left) gem_linear_blits (basic) [91.467023] Starting subtest: basic [91.479410] Subtest basic: SUCCESS (0.012s) [91.647274] [035/165] (914s left) gem_mmap (basic) [91.765861] Starting subtest: basic [91.770588] Subtest basic: SUCCESS (0.000s) [91.832865] [036/165] (914s left) gem_mmap_gtt (basic) [91.905224] Starting subtest: basic [91.906262] Subtest basic: SUCCESS (0.001s) [92.002874] [037/165] (913s left) gem_render_linear_blits (basic) [92.081139] Starting subtest: basic [92.122958] Subtest basic: SUCCESS (0.042s) [92.169865] [038/165] (913s left) gem_render_tiled_blits (basic) [92.247342] Starting subtest: basic [92.288302] Subtest basic: SUCCESS (0.041s) [92.335966] [039/165] (913s left) gem_ringfill (basic-all) [92.606445] Starting subtest: basic-all [93.777934] Subtest basic-all: SUCCESS (1.164s) [93.894318] [040/165] (912s left) gem_softpin (allocator-basic) [93.973630] Starting subtest: allocator-basic [94.125207] Subtest allocator-basic: SUCCESS (0.143s) [94.248791] [041/165] (911s left) gem_softpin (allocator-basic-reserve) [94.326617] Starting subtest: allocator-basic-reserve [94.470663] Subtest allocator-basic-reserve: SUCCESS (0.135s) [94.597694] [042/165] (911s left) gem_softpin (safe-alignment) [94.692384] Starting subtest: safe-alignment [94.706795] Subtest safe-alignment: SUCCESS (0.014s) [94.838239] [043/165] (911s left) gem_sync (basic-all) [94.936216] Starting subtest: basic-all [97.194404] Subtest basic-all: SUCCESS (2.258s) [97.461284] [044/165] (908s left) gem_sync (basic-each) [97.551840] Starting subtest: basic-each [99.742507] Subtest basic-each: SUCCESS (2.193s) [100.054296] [045/165] (906s left) gem_tiled_blits (basic) [100.256795] Starting subtest: basic [100.280732] Subtest basic: SUCCESS (0.024s) [100.438152] [046/165] (905s left) gem_tiled_fence_blits (basic) [100.685881] Starting subtest: basic [100.700185] Subtest basic: SUCCESS (0.014s) [100.853463] [047/165] (905s left) gem_tiled_pread_basic [101.227804] [048/165] (904s left) gem_wait (busy@all-engines) [101.319259] Starting subtest: busy [101.320396] Starting dynamic subtest: all-engines [101.844197] Dynamic subtest all-engines: SUCCESS (0.524s) [101.845327] Subtest busy: SUCCESS (0.524s) [102.130375] [049/165] (904s left) gem_wait (wait@all-engines) [102.226502] Starting subtest: wait [102.227687] Starting dynamic subtest: all-engines [103.283565] Dynamic subtest all-engines: SUCCESS (1.045s) [103.285861] Subtest wait: SUCCESS (1.046s) [103.571531] [050/165] (902s left) i915_getparams_basic (basic-eu-total) [103.645690] Starting subtest: basic-eu-total [103.649670] Subtest basic-eu-total: SUCCESS (0.000s) [103.718347] [051/165] (902s left) i915_getparams_basic (basic-subslice-total) [103.790349] Starting subtest: basic-subslice-total [103.792171] Subtest basic-subslice-total: SUCCESS (0.000s) [103.865759] [052/165] (902s left) i915_hangman (error-state-basic) [103.948234] Starting subtest: error-state-basic [103.955164] Subtest error-state-basic: SUCCESS (0.007s) [104.032097] [053/165] (902s left) i915_pciid [104.166571] [054/165] (902s left) kms_addfb_basic (addfb25-4-tiled) [104.288278] Starting subtest: addfb25-4-tiled [104.289290] Subtest addfb25-4-tiled: SUCCESS (0.000s) [104.397313] [055/165] (901s left) kms_addfb_basic (addfb25-bad-modifier) [104.484174] Starting subtest: addfb25-bad-modifier [104.485276] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [104.635281] [056/165] (901s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [104.708318] Starting subtest: addfb25-framebuffer-vs-set-tiling [104.709346] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.849812] [057/165] (901s left) kms_addfb_basic (addfb25-modifier-no-flag) [104.930216] Starting subtest: addfb25-modifier-no-flag [104.931151] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [105.076451] [058/165] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [105.154640] Starting subtest: addfb25-x-tiled-legacy [105.155764] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [105.301574] [059/165] (901s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [105.388730] Starting subtest: addfb25-x-tiled-mismatch-legacy [105.389797] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [105.575583] [060/165] (900s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [105.697075] Starting subtest: addfb25-yf-tiled-legacy [105.698192] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [105.792427] [061/165] (900s left) kms_addfb_basic (addfb25-y-tiled-legacy) [105.908305] Starting subtest: addfb25-y-tiled-legacy [105.909301] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [106.005241] [062/165] (900s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [106.117222] Starting subtest: addfb25-y-tiled-small-legacy [106.118219] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [106.216094] [063/165] (900s left) kms_addfb_basic (bad-pitch-0) [106.296349] Starting subtest: bad-pitch-0 [106.297439] Subtest bad-pitch-0: SUCCESS (0.000s) [106.433429] [064/165] (900s left) kms_addfb_basic (bad-pitch-1024) [106.512282] Starting subtest: bad-pitch-1024 [106.513399] Subtest bad-pitch-1024: SUCCESS (0.000s) [106.675258] [065/165] (899s left) kms_addfb_basic (bad-pitch-128) [106.754536] Starting subtest: bad-pitch-128 [106.755659] Subtest bad-pitch-128: SUCCESS (0.000s) [106.892669] [066/165] (899s left) kms_addfb_basic (bad-pitch-256) [106.966272] Starting subtest: bad-pitch-256 [106.967243] Subtest bad-pitch-256: SUCCESS (0.000s) [107.126765] [067/165] (899s left) kms_addfb_basic (bad-pitch-32) [107.212673] Starting subtest: bad-pitch-32 [107.213774] Subtest bad-pitch-32: SUCCESS (0.000s) [107.350447] [068/165] (899s left) kms_addfb_basic (bad-pitch-63) [107.430434] Starting subtest: bad-pitch-63 [107.431373] Subtest bad-pitch-63: SUCCESS (0.000s) [107.575304] [069/165] (899s left) kms_addfb_basic (bad-pitch-65536) [107.648022] Starting subtest: bad-pitch-65536 [107.649157] Subtest bad-pitch-65536: SUCCESS (0.000s) [107.782464] [070/165] (898s left) kms_addfb_basic (bad-pitch-999) [107.857574] Starting subtest: bad-pitch-999 [107.858702] Subtest bad-pitch-999: SUCCESS (0.000s) [107.992221] [071/165] (898s left) kms_addfb_basic (basic) [108.064604] Starting subtest: basic [108.065551] Subtest basic: SUCCESS (0.000s) [108.208628] [072/165] (898s left) kms_addfb_basic (basic-x-tiled-legacy) [108.282218] Starting subtest: basic-x-tiled-legacy [108.283244] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [108.420596] [073/165] (898s left) kms_addfb_basic (basic-y-tiled-legacy) [108.493305] Starting subtest: basic-y-tiled-legacy [108.494326] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [108.656219] [074/165] (898s left) kms_addfb_basic (bo-too-small) [108.772854] Starting subtest: bo-too-small [108.773970] Subtest bo-too-small: SUCCESS (0.000s) [108.893592] [075/165] (897s left) kms_addfb_basic (bo-too-small-due-to-tiling) [109.013257] Starting subtest: bo-too-small-due-to-tiling [109.014407] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [109.110842] [076/165] (897s left) kms_addfb_basic (clobberred-modifier) [109.181388] Starting subtest: clobberred-modifier [109.182317] Subtest clobberred-modifier: SUCCESS (0.000s) [109.339650] [077/165] (897s left) kms_addfb_basic (framebuffer-vs-set-tiling) [109.415307] Starting subtest: framebuffer-vs-set-tiling [109.416216] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.554985] [078/165] (897s left) kms_addfb_basic (invalid-get-prop) [109.634416] Starting subtest: invalid-get-prop [109.635529] Subtest invalid-get-prop: SUCCESS (0.000s) [109.792605] [079/165] (897s left) kms_addfb_basic (invalid-get-prop-any) [109.873990] Starting subtest: invalid-get-prop-any [109.875069] Subtest invalid-get-prop-any: SUCCESS (0.000s) [110.050619] [080/165] (896s left) kms_addfb_basic (invalid-set-prop) [110.123793] Starting subtest: invalid-set-prop [110.124786] Subtest invalid-set-prop: SUCCESS (0.000s) [110.264071] [081/165] (896s left) kms_addfb_basic (invalid-set-prop-any) [110.336118] Starting subtest: invalid-set-prop-any [110.337154] Subtest invalid-set-prop-any: SUCCESS (0.000s) [110.480403] [082/165] (896s left) kms_addfb_basic (no-handle) [110.551420] Starting subtest: no-handle [110.552526] Subtest no-handle: SUCCESS (0.000s) [110.691089] [083/165] (896s left) kms_addfb_basic (size-max) [110.800496] Starting subtest: size-max [110.801520] Subtest size-max: SUCCESS (0.000s) [110.897798] [084/165] (896s left) kms_addfb_basic (small-bo) [111.006315] Starting subtest: small-bo [111.007518] Subtest small-bo: SUCCESS (0.000s) [111.134632] [085/165] (895s left) kms_addfb_basic (tile-pitch-mismatch) [111.214988] Starting subtest: tile-pitch-mismatch [111.216104] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [111.379030] [086/165] (895s left) kms_addfb_basic (too-high) [111.497611] Starting subtest: too-high [111.498753] Subtest too-high: SUCCESS (0.001s) [111.592383] [087/165] (895s left) kms_addfb_basic (too-wide) [111.704449] Starting subtest: too-wide [111.705474] Subtest too-wide: SUCCESS (0.000s) [111.809428] [088/165] (895s left) kms_addfb_basic (unused-handle) [111.897088] Starting subtest: unused-handle [111.898098] Subtest unused-handle: SUCCESS (0.000s) [112.074797] [089/165] (895s left) kms_addfb_basic (unused-modifier) [112.145625] Starting subtest: unused-modifier [112.146745] Subtest unused-modifier: SUCCESS (0.000s) [112.308561] [090/165] (894s left) kms_addfb_basic (unused-offsets) [112.395527] Starting subtest: unused-offsets [112.396472] Subtest unused-offsets: SUCCESS (0.000s) [112.531143] [091/165] (894s left) kms_addfb_basic (unused-pitches) [112.601676] Starting subtest: unused-pitches [112.602727] Subtest unused-pitches: SUCCESS (0.000s) [112.748413] [092/165] (894s left) kms_busy (basic) [112.872581] Starting subtest: basic [112.874986] Starting dynamic subtest: flip [113.847099] Dynamic subtest flip: SUCCESS (0.971s) [113.863572] Starting dynamic subtest: modeset [117.595236] Dynamic subtest modeset: SUCCESS (3.742s) [117.600099] Subtest basic: SUCCESS (4.717s) [118.489191] [093/165] (888s left) kms_prop_blob (basic) [118.566165] Starting subtest: basic [118.567109] Subtest basic: SUCCESS (0.000s) [118.629701] [094/165] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [118.739236] Starting subtest: basic-busy-flip-before-cursor-atomic [118.741293] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [118.836925] [095/165] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [118.950213] Starting subtest: basic-busy-flip-before-cursor-legacy [118.952019] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [119.050956] [096/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [119.173227] Starting subtest: basic-flip-after-cursor-atomic [120.487622] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.307s) [121.364228] [097/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [121.472058] Starting subtest: basic-flip-after-cursor-legacy [122.793409] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.320s) [123.712808] [098/165] (883s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [123.820804] Starting subtest: basic-flip-after-cursor-varying-size [125.124492] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.299s) [126.078922] [099/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [126.189110] Starting subtest: basic-flip-before-cursor-atomic [127.483253] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.290s) [128.357399] [100/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [128.470262] Starting subtest: basic-flip-before-cursor-legacy [129.815912] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.343s) [130.737783] [101/165] (876s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [130.850953] Starting subtest: basic-flip-before-cursor-varying-size [132.138134] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.284s) [133.054589] [102/165] (874s left) kms_dsc (dsc-basic) [133.163985] Subtest dsc-basic: SKIP (0.000s) [133.210228] [103/165] (874s left) kms_flip (basic-flip-vs-dpms) [133.320514] Starting subtest: basic-flip-vs-dpms [133.324769] Starting dynamic subtest: A-eDP1 [136.240613] Dynamic subtest A-eDP1: SUCCESS (2.913s) [136.292274] Starting dynamic subtest: B-eDP1 [138.614788] Dynamic subtest B-eDP1: SUCCESS (2.362s) [138.676609] Starting dynamic subtest: C-eDP1 [140.967424] Dynamic subtest C-eDP1: SUCCESS (2.349s) [140.993280] Subtest basic-flip-vs-dpms: SUCCESS (7.668s) [141.871397] [104/165] (865s left) kms_flip (basic-flip-vs-modeset) [141.981055] Starting subtest: basic-flip-vs-modeset [141.986376] Starting dynamic subtest: A-eDP1 [144.884273] Dynamic subtest A-eDP1: SUCCESS (2.890s) [144.939238] Starting dynamic subtest: B-eDP1 [147.268402] Dynamic subtest B-eDP1: SUCCESS (2.376s) [147.325108] Starting dynamic subtest: C-eDP1 [149.630670] Dynamic subtest C-eDP1: SUCCESS (2.356s) [149.663348] Subtest basic-flip-vs-modeset: SUCCESS (7.674s) [150.547257] [105/165] (857s left) kms_flip (basic-flip-vs-wf_vblank) [150.657481] Starting subtest: basic-flip-vs-wf_vblank [150.660739] Starting dynamic subtest: A-eDP1 [152.986141] Dynamic subtest A-eDP1: SUCCESS (2.325s) [152.997563] Starting dynamic subtest: B-eDP1 [155.291537] Dynamic subtest B-eDP1: SUCCESS (2.303s) [155.304174] Starting dynamic subtest: C-eDP1 [157.591974] Dynamic subtest C-eDP1: SUCCESS (2.299s) [157.594601] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.938s) [158.907951] [106/165] (848s left) kms_flip (basic-plain-flip) [159.022178] Starting subtest: basic-plain-flip [159.025177] Starting dynamic subtest: A-eDP1 [161.029300] Dynamic subtest A-eDP1: SUCCESS (1.998s) [161.096143] Starting dynamic subtest: B-eDP1 [163.140251] Dynamic subtest B-eDP1: SUCCESS (2.108s) [163.152022] Starting dynamic subtest: C-eDP1 [165.188832] Dynamic subtest C-eDP1: SUCCESS (2.039s) [165.209675] Subtest basic-plain-flip: SUCCESS (6.186s) [166.564977] [107/165] (841s left) kms_force_connector_basic (force-connector-state) [166.664653] Starting subtest: force-connector-state [167.185975] Subtest force-connector-state: SUCCESS (0.521s) [168.492178] [108/165] (839s left) kms_force_connector_basic (force-edid) [168.591191] Starting subtest: force-edid [168.621403] Subtest force-edid: SUCCESS (0.032s) [168.802031] [109/165] (838s left) kms_force_connector_basic (force-load-detect) [168.900191] Starting subtest: force-load-detect [168.902270] Subtest force-load-detect: SKIP (0.000s) [169.041779] [110/165] (838s left) kms_force_connector_basic (prune-stale-modes) [169.142099] Starting subtest: prune-stale-modes [169.174706] Subtest prune-stale-modes: SUCCESS (0.034s) [169.332652] [111/165] (838s left) kms_frontbuffer_tracking (basic) [169.444787] Starting subtest: basic [172.386299] Subtest basic: SUCCESS (2.939s) [172.500830] [112/165] (835s left) kms_hdmi_inject (inject-audio) [172.905677] Starting subtest: inject-audio [173.027047] Subtest inject-audio: SUCCESS (0.122s) [173.833696] [113/165] (833s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [173.963557] Starting subtest: compare-crc-sanitycheck-xr24 [173.966151] Starting dynamic subtest: pipe-A-eDP-1 [174.675468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s) [174.709801] Starting dynamic subtest: pipe-B-eDP-1 [176.009697] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s) [176.044308] Starting dynamic subtest: pipe-C-eDP-1 [177.384812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s) [177.393453] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.416s) [178.288452] [114/165] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [178.399019] Starting subtest: compare-crc-sanitycheck-nv12 [178.400059] Starting dynamic subtest: pipe-A-eDP-1 [178.402083] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [178.414553] Starting dynamic subtest: pipe-B-eDP-1 [178.416457] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [178.425777] Starting dynamic subtest: pipe-C-eDP-1 [178.427713] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [178.429619] Subtest compare-crc-sanitycheck-nv12: SKIP (0.010s) [178.493981] [115/165] (829s left) kms_pipe_crc_basic (hang-read-crc) [178.602563] Starting subtest: hang-read-crc [178.604918] Starting dynamic subtest: pipe-A-eDP-1 [181.081313] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.465s) [181.149696] Starting dynamic subtest: pipe-B-eDP-1 [184.482465] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.392s) [184.558439] Starting dynamic subtest: pipe-C-eDP-1 [187.720743] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.216s) [187.724801] Subtest hang-read-crc: SUCCESS (9.116s) [188.608797] [116/165] (819s left) kms_pipe_crc_basic (nonblocking-crc) [188.727132] Starting subtest: nonblocking-crc [188.728214] Starting dynamic subtest: pipe-A-eDP-1 [189.759751] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.026s) [189.825264] Starting dynamic subtest: pipe-B-eDP-1 [191.526400] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.744s) [191.607063] Starting dynamic subtest: pipe-C-eDP-1 [193.322763] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.771s) [193.326520] Subtest nonblocking-crc: SUCCESS (4.589s) [194.251798] [117/165] (813s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [194.376871] Starting subtest: nonblocking-crc-frame-sequence [194.378377] Starting dynamic subtest: pipe-A-eDP-1 [195.426929] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.044s) [195.504926] Starting dynamic subtest: pipe-B-eDP-1 [197.208215] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.753s) [197.278497] Starting dynamic subtest: pipe-C-eDP-1 [198.946809] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.718s) [198.952739] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.563s) [199.868109] [118/165] (808s left) kms_pipe_crc_basic (read-crc) [199.992669] Starting subtest: read-crc [199.993733] Starting dynamic subtest: pipe-A-eDP-1 [201.001268] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.002s) [201.074284] Starting dynamic subtest: pipe-B-eDP-1 [202.591447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.574s) [202.662304] Starting dynamic subtest: pipe-C-eDP-1 [204.232887] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.620s) [204.239769] Subtest read-crc: SUCCESS (4.242s) [205.159207] [119/165] (802s left) kms_pipe_crc_basic (read-crc-frame-sequence) [205.283098] Starting subtest: read-crc-frame-sequence [205.285846] Starting dynamic subtest: pipe-A-eDP-1 [206.285816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.990s) [206.353991] Starting dynamic subtest: pipe-B-eDP-1 [207.921714] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.616s) [207.983650] Starting dynamic subtest: pipe-C-eDP-1 [209.567291] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.621s) [209.578526] Subtest read-crc-frame-sequence: SUCCESS (4.290s) [210.508312] [120/165] (797s left) kms_pm_backlight (basic-brightness) [210.628473] Starting subtest: basic-brightness [210.729507] Starting dynamic subtest: eDP-1 [211.389134] Dynamic subtest eDP-1: SUCCESS (0.654s) [211.392882] Subtest basic-brightness: SUCCESS (0.761s) [212.325823] [121/165] (795s left) kms_pm_rpm (basic-pci-d3-state) [214.081152] Starting subtest: basic-pci-d3-state [218.530712] Subtest basic-pci-d3-state: SUCCESS (4.452s) [218.713672] [122/165] (789s left) kms_pm_rpm (basic-rte) [218.793041] Starting subtest: basic-rte [224.929773] Subtest basic-rte: SUCCESS (6.137s) [230.333923] [123/165] (777s left) kms_psr (psr-primary-page-flip) [230.448823] Starting subtest: psr-primary-page-flip [230.449728] Starting dynamic subtest: eDP-1 [232.581991] Dynamic subtest eDP-1: SUCCESS (2.119s) [232.586207] Subtest psr-primary-page-flip: SUCCESS (2.128s) [233.499610] [124/165] (774s left) kms_psr (psr-cursor-plane-move) [233.609478] Starting subtest: psr-cursor-plane-move [233.610542] Starting dynamic subtest: eDP-1 [235.639392] Dynamic subtest eDP-1: SUCCESS (2.027s) [235.647585] Subtest psr-cursor-plane-move: SUCCESS (2.037s) [236.525246] [125/165] (771s left) kms_psr (psr-sprite-plane-onoff) [236.634439] Starting subtest: psr-sprite-plane-onoff [236.635481] Starting dynamic subtest: eDP-1 [238.772415] Dynamic subtest eDP-1: SUCCESS (2.132s) [238.777930] Subtest psr-sprite-plane-onoff: SUCCESS (2.141s) [239.689485] [126/165] (768s left) kms_psr (psr-primary-mmap-gtt) [239.799348] Starting subtest: psr-primary-mmap-gtt [239.800428] Starting dynamic subtest: eDP-1 [241.851149] Dynamic subtest eDP-1: SUCCESS (2.040s) [241.854895] Subtest psr-primary-mmap-gtt: SUCCESS (2.049s) [242.738073] [127/165] (765s left) kms_setmode (basic-clone-single-crtc) [242.821173] Starting subtest: basic-clone-single-crtc [242.823969] Subtest basic-clone-single-crtc: SKIP (0.001s) [242.951103] [128/165] (765s left) i915_pm_rps (basic-api) [243.030453] Starting subtest: basic-api [243.035212] Subtest basic-api: SUCCESS (0.005s) [243.155773] [129/165] (765s left) prime_self_import (basic-llseek-bad) [243.225309] Starting subtest: basic-llseek-bad [243.227507] Subtest basic-llseek-bad: SUCCESS (0.002s) [243.386242] [130/165] (764s left) prime_self_import (basic-llseek-size) [243.456332] Starting subtest: basic-llseek-size [243.460576] Subtest basic-llseek-size: SUCCESS (0.005s) [243.591647] [131/165] (764s left) prime_self_import (basic-with_fd_dup) [243.661593] Starting subtest: basic-with_fd_dup [243.665844] Subtest basic-with_fd_dup: SUCCESS (0.003s) [243.801877] [132/165] (764s left) prime_self_import (basic-with_one_bo) [243.872506] Starting subtest: basic-with_one_bo [243.876561] Subtest basic-with_one_bo: SUCCESS (0.004s) [243.983105] [133/165] (764s left) prime_self_import (basic-with_one_bo_two_files) [244.065133] Starting subtest: basic-with_one_bo_two_files [244.067207] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [244.185182] [134/165] (764s left) prime_self_import (basic-with_two_bos) [244.262575] Starting subtest: basic-with_two_bos [244.267308] Subtest basic-with_two_bos: SUCCESS (0.003s) [244.391279] [135/165] (764s left) prime_vgem (basic-fence-flip) [244.485119] Starting subtest: basic-fence-flip [244.960506] Subtest basic-fence-flip: SUCCESS (0.475s) [245.076556] [136/165] (763s left) prime_vgem (basic-fence-mmap) [245.173959] Starting subtest: basic-fence-mmap [245.211113] Subtest basic-fence-mmap: SUCCESS (0.037s) [245.295404] [137/165] (763s left) prime_vgem (basic-fence-read) [245.386231] Starting subtest: basic-fence-read [245.444976] Subtest basic-fence-read: SUCCESS (0.059s) [245.526223] [138/165] (763s left) prime_vgem (basic-gtt) [245.623546] Starting subtest: basic-gtt [245.640434] Subtest basic-gtt: SUCCESS (0.017s) [245.761404] [139/165] (762s left) prime_vgem (basic-read) [245.851705] Starting subtest: basic-read [245.878312] Subtest basic-read: SUCCESS (0.027s) [245.978574] [140/165] (762s left) prime_vgem (basic-write) [246.085314] Starting subtest: basic-write [246.114846] Subtest basic-write: SUCCESS (0.029s) [246.189193] [141/165] (762s left) vgem_basic (setversion) [246.279083] Starting subtest: setversion [246.281163] Subtest setversion: SUCCESS (0.000s) [246.341853] [142/165] (762s left) vgem_basic (create) [246.428430] Starting subtest: create [246.429538] Subtest create: SUCCESS (0.000s) [246.487474] [143/165] (762s left) vgem_basic (debugfs) [246.563329] Starting subtest: debugfs [246.564458] Subtest debugfs: SUCCESS (0.001s) [246.621996] [144/165] (762s left) vgem_basic (dmabuf-export) [246.695239] Starting subtest: dmabuf-export [246.700198] Subtest dmabuf-export: SUCCESS (0.002s) [246.805723] [145/165] (761s left) vgem_basic (dmabuf-fence) [246.895208] Starting subtest: dmabuf-fence [246.896343] Subtest dmabuf-fence: SUCCESS (0.001s) [246.954331] [146/165] (761s left) vgem_basic (dmabuf-fence-before) [247.031236] Starting subtest: dmabuf-fence-before [247.032559] Subtest dmabuf-fence-before: SUCCESS (0.000s) [247.088592] [147/165] (761s left) vgem_basic (dmabuf-mmap) [247.162345] Starting subtest: dmabuf-mmap [247.179662] Subtest dmabuf-mmap: SUCCESS (0.018s) [247.239217] [148/165] (761s left) vgem_basic (mmap) [247.313523] Starting subtest: mmap [247.324319] Subtest mmap: SUCCESS (0.012s) [247.389028] [149/165] (761s left) vgem_basic (second-client) [247.462272] Starting subtest: second-client [247.496146] Subtest second-client: SUCCESS (0.033s) [247.568688] [150/165] (761s left) vgem_basic (sysfs) [247.662595] Starting subtest: sysfs [247.663716] Subtest sysfs: SUCCESS (0.001s) [247.720894] [151/165] (761s left) core_hotunplug (unbind-rebind) [247.828815] Starting subtest: unbind-rebind [252.210211] Subtest unbind-rebind: SUCCESS (4.381s) [252.239641] [152/165] (756s left) vgem_basic (unload) [252.317803] Starting subtest: unload [281.414099] Subtest unload: SUCCESS (29.060s) [281.535465] [153/165] (727s left) i915_module_load (reload) [281.609237] Starting subtest: reload [284.771734] Subtest reload: SUCCESS (3.159s) [284.793484] [154/165] (724s left) gem_lmem_swapping (basic) [284.915222] Subtest basic: SKIP (0.000s) [284.970383] [155/165] (724s left) gem_lmem_swapping (parallel-random-engines) [285.051312] Subtest parallel-random-engines: SKIP (0.000s) [285.080847] [156/165] (723s left) gem_lmem_swapping (random-engines) [285.159683] Subtest random-engines: SKIP (0.000s) [285.197305] [157/165] (723s left) gem_lmem_swapping (verify-random) [285.276623] Subtest verify-random: SKIP (0.000s) [285.313694] [158/165] (723s left) i915_pm_rpm (module-reload) [288.047327] Starting subtest: module-reload [301.192806] Subtest module-reload: SUCCESS (13.143s) [301.214764] [159/165] (707s left) i915_selftest (live) [301.300723] Starting subtest: live [301.301865] Starting dynamic subtest: sanitycheck [302.984814] Dynamic subtest sanitycheck: SUCCESS (1.674s) [302.993988] Starting dynamic subtest: uncore [304.655087] Dynamic subtest uncore: SUCCESS (1.668s) [304.665463] Starting dynamic subtest: workarounds [306.646908] Dynamic subtest workarounds: SUCCESS (1.990s) [306.656078] Starting dynamic subtest: gt_engines [308.827627] Dynamic subtest gt_engines: SUCCESS (2.179s) [308.837509] Starting dynamic subtest: gt_timelines [319.086729] Dynamic subtest gt_timelines: SUCCESS (10.257s) [319.098842] Starting dynamic subtest: gt_contexts [320.881674] Dynamic subtest gt_contexts: SUCCESS (1.793s) [320.889244] Starting dynamic subtest: gt_lrc [324.977895] Dynamic subtest gt_lrc: SUCCESS (4.095s) [324.987025] Starting dynamic subtest: gt_mocs [326.734712] Dynamic subtest gt_mocs: SUCCESS (1.755s) [326.745897] Starting dynamic subtest: gt_pm [332.770652] Dynamic subtest gt_pm: SUCCESS (6.034s) [332.778060] Starting dynamic subtest: gt_heartbeat [334.620910] Dynamic subtest gt_heartbeat: SUCCESS (1.848s) [334.640081] Starting dynamic subtest: gt_tlb [337.425679] Dynamic subtest gt_tlb: SUCCESS (2.801s) [337.433210] Starting dynamic subtest: requests [344.874741] Dynamic subtest requests: SUCCESS (7.447s) [344.883058] Starting dynamic subtest: migrate [349.315676] Dynamic subtest migrate: SUCCESS (4.439s) [349.323064] Starting dynamic subtest: active [351.094400] Dynamic subtest active: SUCCESS (1.776s) [351.107463] Starting dynamic subtest: objects [353.958080] Dynamic subtest objects: SUCCESS (2.861s) [353.968700] Starting dynamic subtest: mman [359.121735] Dynamic subtest mman: SUCCESS (5.162s) [359.129426] Starting dynamic subtest: dmabuf [360.911845] Dynamic subtest dmabuf: SUCCESS (1.789s) [360.920038] Starting dynamic subtest: vma [362.622693] Dynamic subtest vma: SUCCESS (1.709s) [362.633109] Starting dynamic subtest: coherency [366.262792] Dynamic subtest coherency: SUCCESS (3.638s) [366.275571] Starting dynamic subtest: gtt [374.755641] Dynamic subtest gtt: SUCCESS (8.491s) [374.763220] Starting dynamic subtest: gem [376.630750] Dynamic subtest gem: SUCCESS (1.873s) [376.639109] Starting dynamic subtest: evict [379.801730] Dynamic subtest evict: SUCCESS (3.169s) [379.809429] Starting dynamic subtest: hugepages [386.780281] Dynamic subtest hugepages: SUCCESS (6.976s) [386.796112] Starting dynamic subtest: gem_contexts [401.134720] Dynamic subtest gem_contexts: SUCCESS (14.353s) [401.142461] Starting dynamic subtest: client [402.910032] Dynamic subtest client: SUCCESS (1.774s) [402.922869] Starting dynamic subtest: gem_migrate [404.627694] Dynamic subtest gem_migrate: SUCCESS (1.716s) [404.638145] Starting dynamic subtest: reset [407.037969] Dynamic subtest reset: SUCCESS (2.408s) [407.051296] Starting dynamic subtest: memory_region [408.702725] Dynamic subtest memory_region: SUCCESS (1.663s) [408.710441] Starting dynamic subtest: hangcheck [432.880793] Dynamic subtest hangcheck: SUCCESS (24.176s) [432.888484] Starting dynamic subtest: execlists [442.483759] Dynamic subtest execlists: SUCCESS (9.601s) [442.491539] Starting dynamic subtest: ring_submission [444.168697] Dynamic subtest ring_submission: SUCCESS (1.683s) [444.176633] Starting dynamic subtest: perf [446.098906] Dynamic subtest perf: SUCCESS (1.929s) [446.111779] Starting dynamic subtest: slpc [447.782698] Dynamic subtest slpc: SUCCESS (1.682s) [447.793234] Starting dynamic subtest: guc [449.553735] Dynamic subtest guc: SUCCESS (1.769s) [449.564495] Starting dynamic subtest: guc_multi_lrc [451.290951] Dynamic subtest guc_multi_lrc: SUCCESS (1.736s) [451.302481] Starting dynamic subtest: guc_hang [452.942729] Dynamic subtest guc_hang: SUCCESS (1.650s) [452.951275] Starting dynamic subtest: late_gt_pm [454.734586] Dynamic subtest late_gt_pm: SUCCESS (1.790s) [454.735633] Subtest live: SUCCESS (153.426s) [454.751497] [160/165] (554s left) dmabuf (all-tests) [454.827388] Starting subtest: all-tests [454.828656] Starting dynamic subtest: sanitycheck [454.908494] Dynamic subtest sanitycheck: SUCCESS (0.079s) [454.947391] Starting dynamic subtest: dma_fence [455.114608] Dynamic subtest dma_fence: SUCCESS (0.200s) [455.130682] Starting dynamic subtest: dma_fence_chain [471.180554] Dynamic subtest dma_fence_chain: SUCCESS (16.055s) [471.193632] Starting dynamic subtest: dma_fence_unwrap [471.240538] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s) [471.275836] Starting dynamic subtest: dma_resv [471.330764] Dynamic subtest dma_resv: SUCCESS (0.082s) [471.335723] Subtest all-tests: SUCCESS (16.505s) [471.370926] [161/165] (537s left) i915_suspend (basic-s2idle-without-i915) [471.453067] Starting subtest: basic-s2idle-without-i915 [490.401021] Subtest basic-s2idle-without-i915: SUCCESS (4.179s) [493.791031] [162/165] (533s left) i915_suspend (basic-s3-without-i915) [493.871407] Starting subtest: basic-s3-without-i915 [514.633700] Subtest basic-s3-without-i915: SUCCESS (4.477s) [517.007086] [163/165] (528s left) gem_exec_suspend (basic-s0) [517.123172] Starting subtest: basic-S0 [517.126084] Starting dynamic subtest: smem [535.388853] Dynamic subtest smem: SUCCESS (3.235s) [535.389848] Subtest basic-S0: SUCCESS (3.237s) [540.633989] [164/165] (524s left) gem_exec_suspend (basic-s3) [540.764303] Starting subtest: basic-S3 [540.765456] Starting dynamic subtest: smem [561.740347] Dynamic subtest smem: SUCCESS (4.537s) [561.742070] Subtest basic-S3: SUCCESS (4.542s) [563.942973] [165/165] (520s left) kms_pipe_crc_basic (suspend-read-crc) [564.072298] Starting subtest: suspend-read-crc [564.075044] Starting dynamic subtest: pipe-A-eDP-1 [584.670761] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.713s) [584.690953] Starting dynamic subtest: pipe-B-eDP-1 [605.589033] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.305s) [605.609404] Starting dynamic subtest: pipe-C-eDP-1 [626.447690] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.058s) [626.450577] Subtest suspend-read-crc: SUCCESS (12.093s) [630.297027] Closing watchdogs Done.