[39.493790] Initializing watchdogs [39.493874] /dev/watchdog0 [39.502083] [001/160] (960s left) i915_module_load (load) [39.602183] Starting subtest: load [41.946812] Subtest load: SUCCESS (2.349s) [41.968651] [002/160] (958s left) core_auth (basic-auth) [42.100494] Starting subtest: basic-auth [42.105926] Subtest basic-auth: SUCCESS (0.002s) [42.182241] [003/160] (957s left) debugfs_test (read_all_entries) [42.277495] Starting subtest: read_all_entries [42.435020] Subtest read_all_entries: SUCCESS (0.156s) [42.732246] [004/160] (957s left) debugfs_test (basic-hwmon) [42.817186] Starting subtest: basic-hwmon [42.824388] Subtest basic-hwmon: SKIP (0.000s) [43.127083] [005/160] (956s left) fbdev (eof) [43.243422] Starting subtest: eof [43.246973] Subtest eof: SUCCESS (0.001s) [43.319737] [006/160] (956s left) fbdev (info) [43.410090] Starting subtest: info [43.413821] Subtest info: SUCCESS (0.000s) [43.479954] [007/160] (956s left) fbdev (nullptr) [43.558370] Starting subtest: nullptr [43.561406] Subtest nullptr: SUCCESS (0.000s) [43.611873] [008/160] (956s left) fbdev (read) [43.692541] Starting subtest: read [43.949636] Subtest read: SUCCESS (0.258s) [43.998120] [009/160] (956s left) fbdev (write) [44.075374] Starting subtest: write [44.210221] Subtest write: SUCCESS (0.135s) [44.266074] [010/160] (955s left) gem_basic (bad-close) [44.346634] Starting subtest: bad-close [44.353058] Subtest bad-close: SUCCESS (0.000s) [44.431103] [011/160] (955s left) gem_basic (create-close) [44.528126] Starting subtest: create-close [44.534708] Subtest create-close: SUCCESS (0.000s) [44.622820] [012/160] (955s left) gem_basic (create-fd-close) [44.699839] Starting subtest: create-fd-close [44.705671] Subtest create-fd-close: SUCCESS (0.000s) [44.800996] [013/160] (955s left) gem_busy (busy@all-engines) [44.894243] Starting subtest: busy [44.897468] Starting dynamic subtest: all-engines [44.957160] Dynamic subtest all-engines: SUCCESS (0.063s) [44.960560] Subtest busy: SUCCESS (0.063s) [45.338252] [014/160] (955s left) gem_close_race (basic-process) [45.424689] Starting subtest: basic-process [45.486591] Subtest basic-process: SUCCESS (0.062s) [45.691608] [015/160] (954s left) gem_close_race (basic-threads) [45.774748] Starting subtest: basic-threads [47.033777] Subtest basic-threads: SUCCESS (1.190s) [47.393570] [016/160] (953s left) gem_ctx_create (basic) [47.884135] Starting subtest: basic [47.950080] Subtest basic: SUCCESS (0.000s) [48.180670] [017/160] (952s left) gem_ctx_create (basic-files) [48.353560] Starting subtest: basic-files [50.373476] Subtest basic-files: SUCCESS (2.021s) [50.604477] [018/160] (950s left) gem_ctx_exec (basic) [50.685312] Starting subtest: basic [50.688484] Subtest basic: SUCCESS (0.004s) [50.805392] [019/160] (950s left) gem_exec_basic (basic) [50.927532] Starting subtest: basic [50.931268] Starting dynamic subtest: rcs0-smem [50.934897] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [50.946791] Starting dynamic subtest: bcs0-smem [50.950492] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [50.960503] Starting dynamic subtest: vcs0-smem [50.964148] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [50.973718] Starting dynamic subtest: vcs1-smem [50.977623] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [50.987563] Starting dynamic subtest: vecs0-smem [50.990962] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [50.994281] Subtest basic: SUCCESS (0.009s) [51.160459] [020/160] (949s left) gem_exec_create (basic) [51.263539] Starting subtest: basic [51.266919] Starting dynamic subtest: smem [53.299232] Dynamic subtest smem: SUCCESS (2.038s) [53.302366] Subtest basic: SUCCESS (2.038s) [53.511761] [021/160] (947s left) gem_exec_fence (basic-busy) [53.756564] Starting subtest: basic-busy [53.760838] Starting dynamic subtest: rcs0 [53.792311] Dynamic subtest rcs0: SUCCESS (0.036s) [53.812233] Starting dynamic subtest: bcs0 [53.823316] Dynamic subtest bcs0: SUCCESS (0.029s) [53.836152] Starting dynamic subtest: vcs0 [53.851913] Dynamic subtest vcs0: SUCCESS (0.030s) [53.865042] Starting dynamic subtest: vcs1 [53.883204] Dynamic subtest vcs1: SUCCESS (0.031s) [53.900245] Starting dynamic subtest: vecs0 [53.915381] Dynamic subtest vecs0: SUCCESS (0.032s) [53.919090] Subtest basic-busy: SUCCESS (0.160s) [54.579812] [022/160] (946s left) gem_exec_fence (basic-wait) [54.810931] Starting subtest: basic-wait [54.815259] Starting dynamic subtest: rcs0 [54.842643] Dynamic subtest rcs0: SUCCESS (0.031s) [54.861343] Starting dynamic subtest: bcs0 [54.871169] Dynamic subtest bcs0: SUCCESS (0.028s) [54.884415] Starting dynamic subtest: vcs0 [54.897060] Dynamic subtest vcs0: SUCCESS (0.025s) [54.914067] Starting dynamic subtest: vcs1 [54.921496] Dynamic subtest vcs1: SUCCESS (0.021s) [54.935491] Starting dynamic subtest: vecs0 [54.942107] Dynamic subtest vecs0: SUCCESS (0.022s) [54.945375] Subtest basic-wait: SUCCESS (0.130s) [55.569099] [023/160] (945s left) gem_exec_fence (basic-await) [55.883362] Starting subtest: basic-await [55.948049] Starting dynamic subtest: rcs0 [56.076978] Dynamic subtest rcs0: SUCCESS (0.112s) [56.142044] Starting dynamic subtest: bcs0 [56.206747] Dynamic subtest bcs0: SUCCESS (0.112s) [56.271832] Starting dynamic subtest: vcs0 [56.337173] Dynamic subtest vcs0: SUCCESS (0.103s) [56.402579] Starting dynamic subtest: vcs1 [56.467905] Dynamic subtest vcs1: SUCCESS (0.135s) [56.533378] Starting dynamic subtest: vecs0 [56.598358] Dynamic subtest vecs0: SUCCESS (0.098s) [56.663892] Subtest basic-await: SUCCESS (0.563s) [57.251269] [024/160] (943s left) gem_exec_fence (nb-await) [57.852099] Starting subtest: nb-await [57.920027] Starting dynamic subtest: rcs0 [57.990307] Dynamic subtest rcs0: SUCCESS (0.064s) [58.060708] Starting dynamic subtest: bcs0 [58.128548] Dynamic subtest bcs0: SUCCESS (0.072s) [58.196157] Starting dynamic subtest: vcs0 [58.264586] Dynamic subtest vcs0: SUCCESS (0.072s) [58.332801] Starting dynamic subtest: vcs1 [58.407607] Dynamic subtest vcs1: SUCCESS (0.070s) [58.476076] Starting dynamic subtest: vecs0 [58.543933] Dynamic subtest vecs0: SUCCESS (0.071s) [58.611746] Subtest nb-await: SUCCESS (0.350s) [58.953385] [025/160] (942s left) gem_exec_gttfill (basic) [59.452160] Starting subtest: basic [63.710317] Subtest basic: SUCCESS (4.426s) [63.885185] [026/160] (937s left) gem_exec_parallel (engines) [64.065470] Starting subtest: engines [64.068805] Starting dynamic subtest: basic [66.152294] Dynamic subtest basic: SUCCESS (2.086s) [66.161333] Starting dynamic subtest: contexts [72.731537] Dynamic subtest contexts: SUCCESS (6.581s) [72.741227] Starting dynamic subtest: fds [82.450255] Dynamic subtest fds: SUCCESS (9.718s) [82.459451] Starting dynamic subtest: userptr [84.617687] Dynamic subtest userptr: SUCCESS (2.168s) [84.621556] Subtest engines: SUCCESS (20.553s) [84.820423] [027/160] (916s left) gem_exec_store (basic) [84.909591] Starting subtest: basic [84.984731] Subtest basic: SUCCESS (0.077s) [85.200991] [028/160] (916s left) gem_flink_basic (bad-flink) [85.275735] Starting subtest: bad-flink [85.279676] Subtest bad-flink: SUCCESS (0.000s) [85.377648] [029/160] (916s left) gem_flink_basic (bad-open) [85.467525] Starting subtest: bad-open [85.470840] Subtest bad-open: SUCCESS (0.000s) [85.565738] [030/160] (915s left) gem_flink_basic (basic) [85.662165] Starting subtest: basic [85.665283] Subtest basic: SUCCESS (0.000s) [85.748688] [031/160] (915s left) gem_flink_basic (double-flink) [85.840020] Starting subtest: double-flink [85.843504] Subtest double-flink: SUCCESS (0.000s) [85.943187] [032/160] (915s left) gem_flink_basic (flink-lifetime) [86.046023] Starting subtest: flink-lifetime [86.049285] Subtest flink-lifetime: SUCCESS (0.003s) [86.157499] [033/160] (915s left) gem_huc_copy (huc-copy) [86.247582] Starting subtest: huc-copy [86.254398] Subtest huc-copy: SKIP (0.000s) [86.359551] [034/160] (915s left) gem_linear_blits (basic) [86.592179] Starting subtest: basic [86.603017] Subtest basic: SUCCESS (0.013s) [86.755773] [035/160] (914s left) gem_mmap (basic) [86.947216] Starting subtest: basic [86.965204] Subtest basic: SUCCESS (0.001s) [87.061328] [036/160] (914s left) gem_mmap_gtt (basic) [87.158117] Starting subtest: basic [87.161229] Subtest basic: SUCCESS (0.001s) [87.253601] [037/160] (914s left) gem_render_linear_blits (basic) [87.344336] Starting subtest: basic [87.375388] Subtest basic: SUCCESS (0.032s) [87.436243] [038/160] (914s left) gem_render_tiled_blits (basic) [87.543864] Starting subtest: basic [87.595164] Subtest basic: SUCCESS (0.052s) [87.642123] [039/160] (914s left) gem_ringfill (basic-all) [87.946359] Starting subtest: basic-all [89.132152] Subtest basic-all: SUCCESS (1.183s) [89.259882] [040/160] (912s left) gem_softpin (allocator-basic) [89.352514] Starting subtest: allocator-basic [89.479196] Subtest allocator-basic: SUCCESS (0.127s) [89.610814] [041/160] (912s left) gem_softpin (allocator-basic-reserve) [89.724267] Starting subtest: allocator-basic-reserve [89.848252] Subtest allocator-basic-reserve: SUCCESS (0.124s) [89.963520] [042/160] (912s left) gem_softpin (safe-alignment) [90.058403] Starting subtest: safe-alignment [90.073209] Subtest safe-alignment: SUCCESS (0.014s) [90.187758] [043/160] (911s left) gem_sync (basic-all) [90.365959] Starting subtest: basic-all [92.600239] Subtest basic-all: SUCCESS (2.283s) [92.804236] [044/160] (909s left) gem_sync (basic-each) [92.927449] Starting subtest: basic-each [95.131421] Subtest basic-each: SUCCESS (2.221s) [95.344596] [045/160] (906s left) gem_tiled_blits (basic) [95.578462] Starting subtest: basic [95.602751] Subtest basic: SUCCESS (0.024s) [95.761210] [046/160] (906s left) gem_tiled_fence_blits (basic) [96.056138] Starting subtest: basic [96.068557] Subtest basic: SUCCESS (0.012s) [96.225544] [047/160] (905s left) gem_tiled_pread_basic [96.600693] [048/160] (905s left) gem_wait (busy@all-engines) [96.714304] Starting subtest: busy [96.717460] Starting dynamic subtest: all-engines [97.237846] Dynamic subtest all-engines: SUCCESS (0.523s) [97.241038] Subtest busy: SUCCESS (0.523s) [97.484476] [049/160] (904s left) gem_wait (wait@all-engines) [97.595227] Starting subtest: wait [97.599940] Starting dynamic subtest: all-engines [98.625395] Dynamic subtest all-engines: SUCCESS (1.028s) [98.629097] Subtest wait: SUCCESS (1.028s) [98.874285] [050/160] (903s left) i915_getparams_basic (basic-eu-total) [98.975490] Starting subtest: basic-eu-total [98.982071] Subtest basic-eu-total: SUCCESS (0.000s) [99.071513] [051/160] (903s left) i915_getparams_basic (basic-subslice-total) [99.146826] Starting subtest: basic-subslice-total [99.152454] Subtest basic-subslice-total: SUCCESS (0.000s) [99.252037] [052/160] (903s left) i915_hangman (error-state-basic) [99.352943] Starting subtest: error-state-basic [99.363140] Subtest error-state-basic: SUCCESS (0.006s) [99.434851] [053/160] (902s left) i915_pciid [99.614143] [054/160] (902s left) kms_addfb_basic (addfb25-4-tiled) [99.951919] Starting subtest: addfb25-4-tiled [99.955119] Subtest addfb25-4-tiled: SUCCESS (0.000s) [100.031443] [055/160] (902s left) kms_addfb_basic (addfb25-bad-modifier) [100.121455] Starting subtest: addfb25-bad-modifier [100.124753] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [100.421092] [056/160] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [100.533301] Starting subtest: addfb25-framebuffer-vs-set-tiling [100.536076] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [100.838358] [057/160] (901s left) kms_addfb_basic (addfb25-modifier-no-flag) [100.927796] Starting subtest: addfb25-modifier-no-flag [100.931162] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [101.221302] [058/160] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [101.333311] Starting subtest: addfb25-x-tiled-legacy [101.336848] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [101.674884] [059/160] (900s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [101.772901] Starting subtest: addfb25-x-tiled-mismatch-legacy [101.775783] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [102.087482] [060/160] (900s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [102.415511] Starting subtest: addfb25-yf-tiled-legacy [102.418639] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [102.484063] [061/160] (900s left) kms_addfb_basic (addfb25-y-tiled-legacy) [102.798697] Starting subtest: addfb25-y-tiled-legacy [102.802457] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [102.886456] [062/160] (899s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [103.211351] Starting subtest: addfb25-y-tiled-small-legacy [103.216154] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [103.283049] [063/160] (899s left) kms_addfb_basic (bad-pitch-0) [103.361217] Starting subtest: bad-pitch-0 [103.364236] Subtest bad-pitch-0: SUCCESS (0.000s) [103.668693] [064/160] (899s left) kms_addfb_basic (bad-pitch-1024) [103.776352] Starting subtest: bad-pitch-1024 [103.779530] Subtest bad-pitch-1024: SUCCESS (0.000s) [104.093175] [065/160] (898s left) kms_addfb_basic (bad-pitch-128) [104.194774] Starting subtest: bad-pitch-128 [104.198226] Subtest bad-pitch-128: SUCCESS (0.000s) [104.499373] [066/160] (898s left) kms_addfb_basic (bad-pitch-256) [104.584215] Starting subtest: bad-pitch-256 [104.589070] Subtest bad-pitch-256: SUCCESS (0.000s) [104.908290] [067/160] (897s left) kms_addfb_basic (bad-pitch-32) [105.010409] Starting subtest: bad-pitch-32 [105.014208] Subtest bad-pitch-32: SUCCESS (0.000s) [105.319659] [068/160] (897s left) kms_addfb_basic (bad-pitch-63) [105.403214] Starting subtest: bad-pitch-63 [105.406295] Subtest bad-pitch-63: SUCCESS (0.000s) [105.700078] [069/160] (897s left) kms_addfb_basic (bad-pitch-65536) [105.778322] Starting subtest: bad-pitch-65536 [105.782368] Subtest bad-pitch-65536: SUCCESS (0.000s) [106.069458] [070/160] (896s left) kms_addfb_basic (bad-pitch-999) [106.163020] Starting subtest: bad-pitch-999 [106.166238] Subtest bad-pitch-999: SUCCESS (0.000s) [106.467085] [071/160] (896s left) kms_addfb_basic (basic) [106.551078] Starting subtest: basic [106.554494] Subtest basic: SUCCESS (0.000s) [106.870855] [072/160] (896s left) kms_addfb_basic (basic-x-tiled-legacy) [106.971085] Starting subtest: basic-x-tiled-legacy [106.974724] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [107.282308] [073/160] (895s left) kms_addfb_basic (basic-y-tiled-legacy) [107.381961] Starting subtest: basic-y-tiled-legacy [107.385529] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [107.724287] [074/160] (895s left) kms_addfb_basic (bo-too-small) [108.062885] Starting subtest: bo-too-small [108.065652] Subtest bo-too-small: SUCCESS (0.000s) [108.133707] [075/160] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [108.428547] Starting subtest: bo-too-small-due-to-tiling [108.431495] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [108.525591] [076/160] (894s left) kms_addfb_basic (clobberred-modifier) [108.609774] Starting subtest: clobberred-modifier [108.613083] Subtest clobberred-modifier: SUCCESS (0.000s) [108.900295] [077/160] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [108.982857] Starting subtest: framebuffer-vs-set-tiling [108.986362] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.299174] [078/160] (893s left) kms_addfb_basic (invalid-get-prop) [109.405955] Starting subtest: invalid-get-prop [109.408724] Subtest invalid-get-prop: SUCCESS (0.000s) [109.704171] [079/160] (893s left) kms_addfb_basic (invalid-get-prop-any) [109.791478] Starting subtest: invalid-get-prop-any [109.794684] Subtest invalid-get-prop-any: SUCCESS (0.000s) [110.104046] [080/160] (893s left) kms_addfb_basic (invalid-set-prop) [110.196360] Starting subtest: invalid-set-prop [110.199448] Subtest invalid-set-prop: SUCCESS (0.000s) [110.494463] [081/160] (892s left) kms_addfb_basic (invalid-set-prop-any) [110.566126] Starting subtest: invalid-set-prop-any [110.569084] Subtest invalid-set-prop-any: SUCCESS (0.000s) [110.872480] [082/160] (892s left) kms_addfb_basic (no-handle) [110.959398] Starting subtest: no-handle [110.962703] Subtest no-handle: SUCCESS (0.000s) [111.265525] [083/160] (891s left) kms_addfb_basic (size-max) [111.574826] Starting subtest: size-max [111.577537] Subtest size-max: SUCCESS (0.000s) [111.653508] [084/160] (891s left) kms_addfb_basic (small-bo) [111.972658] Starting subtest: small-bo [111.975613] Subtest small-bo: SUCCESS (0.000s) [112.053969] [085/160] (891s left) kms_addfb_basic (tile-pitch-mismatch) [112.148775] Starting subtest: tile-pitch-mismatch [112.151895] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [112.452484] [086/160] (890s left) kms_addfb_basic (too-high) [112.789546] Starting subtest: too-high [112.792820] Subtest too-high: SUCCESS (0.001s) [112.868671] [087/160] (890s left) kms_addfb_basic (too-wide) [113.194127] Starting subtest: too-wide [113.196912] Subtest too-wide: SUCCESS (0.000s) [113.270364] [088/160] (890s left) kms_addfb_basic (unused-handle) [113.354522] Starting subtest: unused-handle [113.357957] Subtest unused-handle: SUCCESS (0.000s) [113.653134] [089/160] (889s left) kms_addfb_basic (unused-modifier) [113.746809] Starting subtest: unused-modifier [113.750526] Subtest unused-modifier: SUCCESS (0.000s) [114.090035] [090/160] (889s left) kms_addfb_basic (unused-offsets) [114.184221] Starting subtest: unused-offsets [114.187320] Subtest unused-offsets: SUCCESS (0.000s) [114.505972] [091/160] (888s left) kms_addfb_basic (unused-pitches) [114.607831] Starting subtest: unused-pitches [114.611140] Subtest unused-pitches: SUCCESS (0.000s) [114.904377] [092/160] (888s left) kms_busy (basic) [115.209493] Starting subtest: basic [115.212759] Starting dynamic subtest: flip [116.146683] Dynamic subtest flip: SUCCESS (0.827s) [116.211178] Starting dynamic subtest: modeset [117.325371] Dynamic subtest modeset: SUCCESS (1.252s) [117.328408] Subtest basic: SUCCESS (2.083s) [117.707351] [093/160] (885s left) kms_prop_blob (basic) [117.794514] Starting subtest: basic [117.797628] Subtest basic: SUCCESS (0.000s) [117.905074] [094/160] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [118.217307] Starting subtest: basic-busy-flip-before-cursor-atomic [118.223239] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [118.274253] [095/160] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [118.571982] Starting subtest: basic-busy-flip-before-cursor-legacy [118.577523] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [118.642939] [096/160] (884s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [118.953541] Starting subtest: basic-flip-after-cursor-atomic [120.105434] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.041s) [120.618606] [097/160] (883s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [120.932265] Starting subtest: basic-flip-after-cursor-legacy [122.017527] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.011s) [122.562994] [098/160] (881s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [122.887125] Starting subtest: basic-flip-after-cursor-varying-size [123.900654] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.010s) [124.349358] [099/160] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [124.668896] Starting subtest: basic-flip-before-cursor-atomic [125.723733] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.057s) [126.138673] [100/160] (878s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [126.467680] Starting subtest: basic-flip-before-cursor-legacy [127.607113] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.049s) [128.161319] [101/160] (876s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [128.503386] Starting subtest: basic-flip-before-cursor-varying-size [129.537076] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.034s) [129.946544] [102/160] (874s left) kms_dsc (dsc-basic) [130.263287] Subtest dsc-basic: SKIP (0.000s) [130.304191] [103/160] (874s left) kms_flip (basic-flip-vs-dpms) [130.631084] Starting subtest: basic-flip-vs-dpms [130.633994] Starting dynamic subtest: A-DP1 [131.856358] Dynamic subtest A-DP1: SUCCESS (1.216s) [131.875459] Starting dynamic subtest: B-DP1 [133.010213] Dynamic subtest B-DP1: SUCCESS (1.153s) [133.026155] Starting dynamic subtest: C-DP1 [134.132077] Dynamic subtest C-DP1: SUCCESS (1.119s) [134.145768] Starting dynamic subtest: A-DP2 [135.034205] Dynamic subtest A-DP2: SUCCESS (0.896s) [135.045532] Starting dynamic subtest: B-DP2 [135.959882] Dynamic subtest B-DP2: SUCCESS (0.925s) [135.972411] Starting dynamic subtest: C-DP2 [136.877181] Dynamic subtest C-DP2: SUCCESS (0.911s) [136.880596] Subtest basic-flip-vs-dpms: SUCCESS (6.242s) [137.396933] [104/160] (867s left) kms_flip (basic-flip-vs-modeset) [137.720495] Starting subtest: basic-flip-vs-modeset [137.723396] Starting dynamic subtest: A-DP1 [138.863914] Dynamic subtest A-DP1: SUCCESS (1.134s) [138.879243] Starting dynamic subtest: B-DP1 [139.913735] Dynamic subtest B-DP1: SUCCESS (1.049s) [139.930462] Starting dynamic subtest: C-DP1 [140.890778] Dynamic subtest C-DP1: SUCCESS (0.973s) [140.905317] Starting dynamic subtest: A-DP2 [141.595287] Dynamic subtest A-DP2: SUCCESS (0.704s) [141.605861] Starting dynamic subtest: B-DP2 [142.309437] Dynamic subtest B-DP2: SUCCESS (0.711s) [142.319342] Starting dynamic subtest: C-DP2 [143.028340] Dynamic subtest C-DP2: SUCCESS (0.717s) [143.031451] Subtest basic-flip-vs-modeset: SUCCESS (5.310s) [143.490077] [105/160] (861s left) kms_flip (basic-flip-vs-wf_vblank) [143.826997] Starting subtest: basic-flip-vs-wf_vblank [143.830275] Starting dynamic subtest: A-DP1 [145.154550] Dynamic subtest A-DP1: SUCCESS (1.242s) [145.219675] Starting dynamic subtest: B-DP1 [146.189459] Dynamic subtest B-DP1: SUCCESS (1.121s) [146.202655] Starting dynamic subtest: C-DP1 [147.328995] Dynamic subtest C-DP1: SUCCESS (1.134s) [147.340919] Starting dynamic subtest: A-DP2 [148.558343] Dynamic subtest A-DP2: SUCCESS (1.230s) [148.570444] Starting dynamic subtest: B-DP2 [149.606665] Dynamic subtest B-DP2: SUCCESS (1.045s) [149.619639] Starting dynamic subtest: C-DP2 [150.651776] Dynamic subtest C-DP2: SUCCESS (1.045s) [150.655472] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.833s) [151.171633] [106/160] (853s left) kms_flip (basic-plain-flip) [151.486836] Starting subtest: basic-plain-flip [151.494304] Starting dynamic subtest: A-DP1 [152.437502] Dynamic subtest A-DP1: SUCCESS (0.942s) [152.462114] Starting dynamic subtest: B-DP1 [153.335861] Dynamic subtest B-DP1: SUCCESS (0.895s) [153.346688] Starting dynamic subtest: C-DP1 [154.211316] Dynamic subtest C-DP1: SUCCESS (0.871s) [154.223803] Starting dynamic subtest: A-DP2 [155.009822] Dynamic subtest A-DP2: SUCCESS (0.799s) [155.023290] Starting dynamic subtest: B-DP2 [155.838105] Dynamic subtest B-DP2: SUCCESS (0.826s) [155.849933] Starting dynamic subtest: C-DP2 [156.605406] Dynamic subtest C-DP2: SUCCESS (0.764s) [156.608604] Subtest basic-plain-flip: SUCCESS (5.120s) [157.122767] [107/160] (847s left) kms_force_connector_basic (force-connector-state) [157.288448] Starting subtest: force-connector-state [157.912842] Subtest force-connector-state: SUCCESS (0.628s) [158.812374] [108/160] (845s left) kms_force_connector_basic (force-edid) [158.945212] Starting subtest: force-edid [159.051528] Subtest force-edid: SUCCESS (0.107s) [159.611893] [109/160] (845s left) kms_force_connector_basic (force-load-detect) [159.755865] Starting subtest: force-load-detect [159.761193] Subtest force-load-detect: SKIP (0.000s) [160.107409] [110/160] (844s left) kms_force_connector_basic (prune-stale-modes) [160.257655] Starting subtest: prune-stale-modes [160.363488] Subtest prune-stale-modes: SUCCESS (0.109s) [160.912458] [111/160] (843s left) kms_frontbuffer_tracking (basic) [161.240178] Starting subtest: basic [164.028492] Subtest basic: SUCCESS (2.789s) [164.276616] [112/160] (840s left) kms_hdmi_inject (inject-audio) [164.520419] Starting subtest: inject-audio [164.691385] Subtest inject-audio: SUCCESS (0.171s) [165.357638] [113/160] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [165.667920] Starting subtest: compare-crc-sanitycheck-xr24 [165.670739] Starting dynamic subtest: pipe-A-DP-1 [166.266799] Dynamic subtest pipe-A-DP-1: SUCCESS (0.597s) [166.277782] Starting dynamic subtest: pipe-B-DP-2 [166.758278] Dynamic subtest pipe-B-DP-2: SUCCESS (0.488s) [166.770916] Starting dynamic subtest: pipe-C-DP-1 [167.319834] Dynamic subtest pipe-C-DP-1: SUCCESS (0.559s) [167.323174] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.656s) [167.762018] [114/160] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [168.082726] Starting subtest: compare-crc-sanitycheck-nv12 [168.088223] Starting dynamic subtest: pipe-A-DP-1 [168.737388] Dynamic subtest pipe-A-DP-1: SUCCESS (0.646s) [168.757345] Starting dynamic subtest: pipe-B-DP-2 [169.293490] Dynamic subtest pipe-B-DP-2: SUCCESS (0.547s) [169.311994] Starting dynamic subtest: pipe-C-DP-1 [169.318154] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [169.321164] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.216s) [169.714864] [115/160] (835s left) kms_pipe_crc_basic (hang-read-crc) [170.045259] Starting subtest: hang-read-crc [170.048086] Starting dynamic subtest: pipe-A-DP-1 [171.420175] Dynamic subtest pipe-A-DP-1: SUCCESS (1.372s) [171.435053] Starting dynamic subtest: pipe-B-DP-2 [172.580547] Dynamic subtest pipe-B-DP-2: SUCCESS (1.156s) [172.593041] Starting dynamic subtest: pipe-C-DP-1 [173.924274] Dynamic subtest pipe-C-DP-1: SUCCESS (1.343s) [173.927609] Subtest hang-read-crc: SUCCESS (3.881s) [174.343105] [116/160] (830s left) kms_pipe_crc_basic (nonblocking-crc) [174.667346] Starting subtest: nonblocking-crc [174.670283] Starting dynamic subtest: pipe-A-DP-1 [175.414187] Dynamic subtest pipe-A-DP-1: SUCCESS (0.746s) [175.424442] Starting dynamic subtest: pipe-B-DP-2 [176.084441] Dynamic subtest pipe-B-DP-2: SUCCESS (0.666s) [176.094716] Starting dynamic subtest: pipe-C-DP-1 [176.815715] Dynamic subtest pipe-C-DP-1: SUCCESS (0.727s) [176.819548] Subtest nonblocking-crc: SUCCESS (2.151s) [177.234234] [117/160] (827s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [177.571331] Starting subtest: nonblocking-crc-frame-sequence [177.574160] Starting dynamic subtest: pipe-A-DP-1 [178.375924] Dynamic subtest pipe-A-DP-1: SUCCESS (0.732s) [178.443746] Starting dynamic subtest: pipe-B-DP-2 [179.021440] Dynamic subtest pipe-B-DP-2: SUCCESS (0.628s) [179.089721] Starting dynamic subtest: pipe-C-DP-1 [179.695994] Dynamic subtest pipe-C-DP-1: SUCCESS (0.721s) [179.701147] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.090s) [180.057475] [118/160] (825s left) kms_pipe_crc_basic (read-crc) [180.374777] Starting subtest: read-crc [180.377941] Starting dynamic subtest: pipe-A-DP-1 [181.048368] Dynamic subtest pipe-A-DP-1: SUCCESS (0.670s) [181.062843] Starting dynamic subtest: pipe-B-DP-2 [181.625579] Dynamic subtest pipe-B-DP-2: SUCCESS (0.573s) [181.638601] Starting dynamic subtest: pipe-C-DP-1 [182.303146] Dynamic subtest pipe-C-DP-1: SUCCESS (0.675s) [182.306926] Subtest read-crc: SUCCESS (1.929s) [182.728543] [119/160] (822s left) kms_pipe_crc_basic (read-crc-frame-sequence) [183.059392] Starting subtest: read-crc-frame-sequence [183.062230] Starting dynamic subtest: pipe-A-DP-1 [183.755352] Dynamic subtest pipe-A-DP-1: SUCCESS (0.691s) [183.770580] Starting dynamic subtest: pipe-B-DP-2 [184.361119] Dynamic subtest pipe-B-DP-2: SUCCESS (0.594s) [184.371321] Starting dynamic subtest: pipe-C-DP-1 [185.029541] Dynamic subtest pipe-C-DP-1: SUCCESS (0.677s) [185.032837] Subtest read-crc-frame-sequence: SUCCESS (1.974s) [185.461362] [120/160] (819s left) kms_pm_backlight (basic-brightness) [185.781056] Subtest basic-brightness: SKIP (0.000s) [185.819657] [121/160] (819s left) kms_pm_rpm (basic-pci-d3-state) [187.690710] Starting subtest: basic-pci-d3-state [188.507407] Subtest basic-pci-d3-state: SUCCESS (0.815s) [188.993997] [122/160] (816s left) kms_pm_rpm (basic-rte) [189.089774] Starting subtest: basic-rte [191.729190] Subtest basic-rte: SUCCESS (2.642s) [192.969908] [123/160] (812s left) kms_psr (psr-primary-page-flip) [193.362689] Subtest psr-primary-page-flip: SKIP (0.000s) [193.403956] [124/160] (811s left) kms_psr (psr-cursor-plane-move) [193.733481] Subtest psr-cursor-plane-move: SKIP (0.000s) [193.772954] [125/160] (811s left) kms_psr (psr-sprite-plane-onoff) [194.138947] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [194.174928] [126/160] (811s left) kms_psr (psr-primary-mmap-gtt) [194.501045] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [194.539068] [127/160] (810s left) kms_setmode (basic-clone-single-crtc) [194.617271] Starting subtest: basic-clone-single-crtc [194.817401] Subtest basic-clone-single-crtc: SKIP (0.199s) [195.217096] [128/160] (810s left) i915_pm_rps (basic-api) [195.307161] Starting subtest: basic-api [195.313945] Subtest basic-api: SUCCESS (0.004s) [195.417582] [129/160] (810s left) prime_self_import (basic-llseek-bad) [195.489149] Starting subtest: basic-llseek-bad [195.508679] Subtest basic-llseek-bad: SUCCESS (0.021s) [195.615561] [130/160] (809s left) prime_self_import (basic-llseek-size) [195.698638] Starting subtest: basic-llseek-size [195.710119] Subtest basic-llseek-size: SUCCESS (0.011s) [195.837416] [131/160] (809s left) prime_self_import (basic-with_fd_dup) [195.937312] Starting subtest: basic-with_fd_dup [195.948615] Subtest basic-with_fd_dup: SUCCESS (0.014s) [196.067904] [132/160] (809s left) prime_self_import (basic-with_one_bo) [196.153153] Starting subtest: basic-with_one_bo [196.168854] Subtest basic-with_one_bo: SUCCESS (0.019s) [196.277925] [133/160] (809s left) prime_self_import (basic-with_one_bo_two_files) [196.351651] Starting subtest: basic-with_one_bo_two_files [196.362586] Subtest basic-with_one_bo_two_files: SUCCESS (0.010s) [196.454804] [134/160] (809s left) prime_self_import (basic-with_two_bos) [196.543743] Starting subtest: basic-with_two_bos [196.561270] Subtest basic-with_two_bos: SUCCESS (0.017s) [196.647825] [135/160] (809s left) prime_vgem (basic-fence-flip) [196.760320] Starting subtest: basic-fence-flip [197.417732] Subtest basic-fence-flip: SUCCESS (0.654s) [197.547804] [136/160] (808s left) prime_vgem (basic-fence-mmap) [197.655121] Starting subtest: basic-fence-mmap [197.684237] Subtest basic-fence-mmap: SUCCESS (0.028s) [197.787979] [137/160] (808s left) prime_vgem (basic-fence-read) [197.923423] Starting subtest: basic-fence-read [197.993314] Subtest basic-fence-read: SUCCESS (0.071s) [198.086266] [138/160] (807s left) prime_vgem (basic-gtt) [198.216259] Starting subtest: basic-gtt [198.236073] Subtest basic-gtt: SUCCESS (0.021s) [198.334544] [139/160] (807s left) prime_vgem (basic-read) [198.443390] Starting subtest: basic-read [198.477484] Subtest basic-read: SUCCESS (0.034s) [198.590362] [140/160] (807s left) prime_vgem (basic-write) [198.699278] Starting subtest: basic-write [198.736617] Subtest basic-write: SUCCESS (0.038s) [198.806921] [141/160] (807s left) vgem_basic (setversion) [198.886637] Starting subtest: setversion [198.893753] Subtest setversion: SUCCESS (0.000s) [198.938918] [142/160] (807s left) vgem_basic (create) [199.020499] Starting subtest: create [199.023953] Subtest create: SUCCESS (0.000s) [199.088788] [143/160] (806s left) vgem_basic (debugfs) [199.185808] Starting subtest: debugfs [199.188863] Subtest debugfs: SUCCESS (0.000s) [199.240443] [144/160] (806s left) vgem_basic (dmabuf-export) [199.321963] Starting subtest: dmabuf-export [199.337668] Subtest dmabuf-export: SUCCESS (0.017s) [199.451805] [145/160] (806s left) vgem_basic (dmabuf-fence) [199.554277] Starting subtest: dmabuf-fence [199.558373] Subtest dmabuf-fence: SUCCESS (0.001s) [199.623134] [146/160] (806s left) vgem_basic (dmabuf-fence-before) [199.703389] Starting subtest: dmabuf-fence-before [199.706440] Subtest dmabuf-fence-before: SUCCESS (0.000s) [199.757089] [147/160] (806s left) vgem_basic (dmabuf-mmap) [199.837692] Starting subtest: dmabuf-mmap [199.855138] Subtest dmabuf-mmap: SUCCESS (0.020s) [199.904149] [148/160] (806s left) vgem_basic (mmap) [199.988192] Starting subtest: mmap [200.004228] Subtest mmap: SUCCESS (0.019s) [200.070806] [149/160] (806s left) vgem_basic (second-client) [200.169924] Starting subtest: second-client [200.203500] Subtest second-client: SUCCESS (0.033s) [200.271189] [150/160] (805s left) vgem_basic (sysfs) [200.372799] Starting subtest: sysfs [200.376459] Subtest sysfs: SUCCESS (0.000s) [200.425675] [151/160] (805s left) core_hotunplug (unbind-rebind) [200.564860] Starting subtest: unbind-rebind [203.939785] Subtest unbind-rebind: SUCCESS (3.375s) [203.964869] [152/160] (802s left) vgem_basic (unload) [204.040170] Starting subtest: unload [233.078323] Subtest unload: SUCCESS (29.036s) [233.197189] [153/160] (773s left) i915_module_load (reload) [233.279128] Starting subtest: reload [236.286355] Subtest reload: SUCCESS (3.009s) [236.315551] [154/160] (770s left) gem_lmem_swapping (basic) [236.441092] Subtest basic: SKIP (0.000s) [236.465687] [155/160] (769s left) gem_lmem_swapping (parallel-random-engines) [236.545083] Subtest parallel-random-engines: SKIP (0.000s) [236.577403] [156/160] (769s left) gem_lmem_swapping (random-engines) [236.680544] Subtest random-engines: SKIP (0.000s) [236.715186] [157/160] (769s left) gem_lmem_swapping (verify-random) [236.789901] Subtest verify-random: SKIP (0.000s) [236.815285] [158/160] (769s left) i915_pm_rpm (module-reload) [239.325670] Starting subtest: module-reload [247.531055] Subtest module-reload: SUCCESS (8.153s) [247.771766] [159/160] (758s left) i915_selftest (live) [248.181112] Starting subtest: live [248.246791] Starting dynamic subtest: sanitycheck [248.813145] Dynamic subtest sanitycheck: SUCCESS (0.709s) [248.822844] Starting dynamic subtest: uncore [249.512200] Dynamic subtest uncore: SUCCESS (0.697s) [249.520853] Starting dynamic subtest: workarounds [250.460975] Dynamic subtest workarounds: SUCCESS (0.949s) [250.469677] Starting dynamic subtest: gt_engines [251.712185] Dynamic subtest gt_engines: SUCCESS (1.247s) [251.720259] Starting dynamic subtest: gt_timelines [265.712198] Dynamic subtest gt_timelines: SUCCESS (14.000s) [265.722152] Starting dynamic subtest: gt_contexts [266.539215] Dynamic subtest gt_contexts: SUCCESS (0.823s) [266.548170] Starting dynamic subtest: gt_lrc [270.304229] Dynamic subtest gt_lrc: SUCCESS (3.763s) [270.313440] Starting dynamic subtest: gt_mocs [271.105155] Dynamic subtest gt_mocs: SUCCESS (0.801s) [271.117632] Starting dynamic subtest: gt_pm [277.754901] Dynamic subtest gt_pm: SUCCESS (6.648s) [277.764838] Starting dynamic subtest: gt_heartbeat [278.562989] Dynamic subtest gt_heartbeat: SUCCESS (0.806s) [278.571601] Starting dynamic subtest: gt_tlb [280.342211] Dynamic subtest gt_tlb: SUCCESS (1.778s) [280.354699] Starting dynamic subtest: requests [288.561539] Dynamic subtest requests: SUCCESS (8.217s) [288.572684] Starting dynamic subtest: migrate [292.244351] Dynamic subtest migrate: SUCCESS (3.678s) [292.262095] Starting dynamic subtest: active [292.960240] Dynamic subtest active: SUCCESS (0.715s) [292.970344] Starting dynamic subtest: objects [294.877025] Dynamic subtest objects: SUCCESS (1.915s) [294.887653] Starting dynamic subtest: mman [299.479878] Dynamic subtest mman: SUCCESS (4.601s) [299.489279] Starting dynamic subtest: dmabuf [300.274034] Dynamic subtest dmabuf: SUCCESS (0.792s) [300.282834] Starting dynamic subtest: vma [301.021241] Dynamic subtest vma: SUCCESS (0.746s) [301.031150] Starting dynamic subtest: coherency [303.058992] Dynamic subtest coherency: SUCCESS (2.036s) [303.068498] Starting dynamic subtest: gtt [311.270049] Dynamic subtest gtt: SUCCESS (8.209s) [311.278730] Starting dynamic subtest: gem [312.183386] Dynamic subtest gem: SUCCESS (0.909s) [312.192776] Starting dynamic subtest: evict [314.909994] Dynamic subtest evict: SUCCESS (2.727s) [314.920638] Starting dynamic subtest: hugepages [322.073191] Dynamic subtest hugepages: SUCCESS (7.161s) [322.084286] Starting dynamic subtest: gem_contexts [340.025020] Dynamic subtest gem_contexts: SUCCESS (17.950s) [340.034449] Starting dynamic subtest: client [340.816981] Dynamic subtest client: SUCCESS (0.790s) [340.826072] Starting dynamic subtest: gem_migrate [341.541885] Dynamic subtest gem_migrate: SUCCESS (0.723s) [341.552250] Starting dynamic subtest: reset [343.090222] Dynamic subtest reset: SUCCESS (1.545s) [343.099050] Starting dynamic subtest: memory_region [343.786535] Dynamic subtest memory_region: SUCCESS (0.696s) [343.796754] Starting dynamic subtest: hangcheck [373.068284] Dynamic subtest hangcheck: SUCCESS (29.278s) [373.077665] Starting dynamic subtest: execlists [386.601953] Dynamic subtest execlists: SUCCESS (13.534s) [386.611533] Starting dynamic subtest: ring_submission [387.298168] Dynamic subtest ring_submission: SUCCESS (0.694s) [387.307262] Starting dynamic subtest: perf [388.082078] Dynamic subtest perf: SUCCESS (0.782s) [388.091231] Starting dynamic subtest: slpc [388.812051] Dynamic subtest slpc: SUCCESS (0.729s) [388.822744] Starting dynamic subtest: guc [389.578157] Dynamic subtest guc: SUCCESS (0.764s) [389.589301] Starting dynamic subtest: guc_multi_lrc [390.251938] Dynamic subtest guc_multi_lrc: SUCCESS (0.672s) [390.260420] Starting dynamic subtest: guc_hang [390.954159] Dynamic subtest guc_hang: SUCCESS (0.699s) [390.962855] Starting dynamic subtest: late_gt_pm [391.783162] Dynamic subtest late_gt_pm: SUCCESS (0.829s) [391.786535] Subtest live: SUCCESS (143.683s) [391.810488] [160/160] (614s left) dmabuf (all-tests) [391.893435] Starting subtest: all-tests [391.901156] Starting dynamic subtest: sanitycheck [391.970476] Dynamic subtest sanitycheck: SUCCESS (0.074s) [391.992282] Starting dynamic subtest: dma_fence [392.154290] Dynamic subtest dma_fence: SUCCESS (0.184s) [392.167069] Starting dynamic subtest: dma_fence_chain [407.509918] Dynamic subtest dma_fence_chain: SUCCESS (15.351s) [407.525824] Starting dynamic subtest: dma_fence_unwrap [407.571372] Dynamic subtest dma_fence_unwrap: SUCCESS (0.059s) [407.590851] Starting dynamic subtest: dma_resv [407.645046] Dynamic subtest dma_resv: SUCCESS (0.073s) [407.648963] Subtest all-tests: SUCCESS (15.755s) [407.681452] Closing watchdogs Done.