[39.558433] Initializing watchdogs [39.558539] /dev/watchdog0 [39.567470] [001/165] (960s left) i915_module_load (load) [39.645131] Starting subtest: load [41.865839] Subtest load: SUCCESS (2.222s) [41.897705] [002/165] (958s left) core_auth (basic-auth) [42.015207] Starting subtest: basic-auth [42.018845] Subtest basic-auth: SUCCESS (0.001s) [42.085276] [003/165] (958s left) debugfs_test (read_all_entries) [42.160982] Starting subtest: read_all_entries [42.286221] Subtest read_all_entries: SUCCESS (0.126s) [42.585184] [004/165] (957s left) debugfs_test (basic-hwmon) [42.679462] Starting subtest: basic-hwmon [42.685814] Subtest basic-hwmon: SKIP (0.000s) [42.969322] [005/165] (957s left) fbdev (eof) [43.085248] Starting subtest: eof [43.088642] Subtest eof: SUCCESS (0.001s) [43.138177] [006/165] (957s left) fbdev (info) [43.208571] Starting subtest: info [43.212060] Subtest info: SUCCESS (0.000s) [43.271694] [007/165] (956s left) fbdev (nullptr) [43.352218] Starting subtest: nullptr [43.356299] Subtest nullptr: SUCCESS (0.000s) [43.418502] [008/165] (956s left) fbdev (read) [43.518055] Starting subtest: read [43.806925] Subtest read: SUCCESS (0.256s) [44.097366] [009/165] (956s left) fbdev (write) [44.454022] Starting subtest: write [44.585362] Subtest write: SUCCESS (0.159s) [44.912767] [010/165] (955s left) gem_basic (bad-close) [45.082127] Starting subtest: bad-close [45.090214] Subtest bad-close: SUCCESS (0.000s) [45.369516] [011/165] (955s left) gem_basic (create-close) [45.805555] Starting subtest: create-close [45.943447] Subtest create-close: SUCCESS (0.000s) [46.182065] [012/165] (954s left) gem_basic (create-fd-close) [46.648303] Starting subtest: create-fd-close [46.658097] Subtest create-fd-close: SUCCESS (0.001s) [46.696762] [013/165] (954s left) gem_busy (busy@all-engines) [46.793015] Starting subtest: busy [46.796141] Starting dynamic subtest: all-engines [46.858466] Dynamic subtest all-engines: SUCCESS (0.065s) [46.861901] Subtest busy: SUCCESS (0.066s) [47.262065] [014/165] (953s left) gem_close_race (basic-process) [47.377078] Starting subtest: basic-process [47.438297] Subtest basic-process: SUCCESS (0.061s) [47.660627] [015/165] (953s left) gem_close_race (basic-threads) [47.763677] Starting subtest: basic-threads [48.909722] Subtest basic-threads: SUCCESS (1.146s) [49.112255] [016/165] (952s left) gem_ctx_create (basic) [49.196535] Starting subtest: basic [49.199603] Subtest basic: SUCCESS (0.000s) [49.397363] [017/165] (951s left) gem_ctx_create (basic-files) [49.491268] Starting subtest: basic-files [51.509821] Subtest basic-files: SUCCESS (2.018s) [51.745363] [018/165] (949s left) gem_ctx_exec (basic) [51.827981] Starting subtest: basic [51.838363] Subtest basic: SUCCESS (0.008s) [51.943518] [019/165] (949s left) gem_exec_basic (basic) [52.039527] Starting subtest: basic [52.042738] Starting dynamic subtest: rcs0-smem [52.046033] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.054018] Starting dynamic subtest: bcs0-smem [52.057284] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [52.065071] Starting dynamic subtest: vcs0-smem [52.068093] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [52.075780] Starting dynamic subtest: vcs1-smem [52.078923] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [52.086827] Starting dynamic subtest: vecs0-smem [52.089940] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.093258] Subtest basic: SUCCESS (0.004s) [52.261436] [020/165] (949s left) gem_exec_create (basic) [52.371672] Starting subtest: basic [52.375157] Starting dynamic subtest: smem [54.418567] Dynamic subtest smem: SUCCESS (2.047s) [54.421772] Subtest basic: SUCCESS (2.047s) [54.625529] [021/165] (946s left) gem_exec_fence (basic-busy) [54.842138] Starting subtest: basic-busy [54.845634] Starting dynamic subtest: rcs0 [54.872604] Dynamic subtest rcs0: SUCCESS (0.030s) [54.882134] Starting dynamic subtest: bcs0 [54.901417] Dynamic subtest bcs0: SUCCESS (0.029s) [54.911228] Starting dynamic subtest: vcs0 [54.930273] Dynamic subtest vcs0: SUCCESS (0.028s) [54.946448] Starting dynamic subtest: vcs1 [54.958143] Dynamic subtest vcs1: SUCCESS (0.027s) [54.970997] Starting dynamic subtest: vecs0 [54.991434] Dynamic subtest vecs0: SUCCESS (0.035s) [54.994746] Subtest basic-busy: SUCCESS (0.150s) [55.647897] [022/165] (945s left) gem_exec_fence (basic-wait) [55.900212] Starting subtest: basic-wait [55.905109] Starting dynamic subtest: rcs0 [55.942583] Dynamic subtest rcs0: SUCCESS (0.042s) [55.959962] Starting dynamic subtest: bcs0 [55.979200] Dynamic subtest bcs0: SUCCESS (0.036s) [55.993183] Starting dynamic subtest: vcs0 [56.012904] Dynamic subtest vcs0: SUCCESS (0.034s) [56.024703] Starting dynamic subtest: vcs1 [56.038789] Dynamic subtest vcs1: SUCCESS (0.026s) [56.050612] Starting dynamic subtest: vecs0 [56.068763] Dynamic subtest vecs0: SUCCESS (0.030s) [56.072356] Subtest basic-wait: SUCCESS (0.169s) [56.699288] [023/165] (944s left) gem_exec_fence (basic-await) [56.943636] Starting subtest: basic-await [56.946757] Starting dynamic subtest: rcs0 [57.044483] Dynamic subtest rcs0: SUCCESS (0.101s) [57.054556] Starting dynamic subtest: bcs0 [57.147950] Dynamic subtest bcs0: SUCCESS (0.102s) [57.158763] Starting dynamic subtest: vcs0 [57.257068] Dynamic subtest vcs0: SUCCESS (0.110s) [57.267078] Starting dynamic subtest: vcs1 [57.368095] Dynamic subtest vcs1: SUCCESS (0.111s) [57.382906] Starting dynamic subtest: vecs0 [57.512141] Dynamic subtest vecs0: SUCCESS (0.144s) [57.515357] Subtest basic-await: SUCCESS (0.569s) [58.164209] [024/165] (943s left) gem_exec_fence (nb-await) [58.402401] Starting subtest: nb-await [58.406698] Starting dynamic subtest: rcs0 [58.477225] Dynamic subtest rcs0: SUCCESS (0.075s) [58.498503] Starting dynamic subtest: bcs0 [58.554934] Dynamic subtest bcs0: SUCCESS (0.077s) [58.572511] Starting dynamic subtest: vcs0 [58.628703] Dynamic subtest vcs0: SUCCESS (0.073s) [58.645714] Starting dynamic subtest: vcs1 [58.703356] Dynamic subtest vcs1: SUCCESS (0.072s) [58.725516] Starting dynamic subtest: vecs0 [58.779392] Dynamic subtest vecs0: SUCCESS (0.077s) [58.783185] Subtest nb-await: SUCCESS (0.377s) [59.415579] [025/165] (942s left) gem_exec_gttfill (basic) [59.516195] Starting subtest: basic [64.120329] Subtest basic: SUCCESS (4.604s) [64.290906] [026/165] (937s left) gem_exec_parallel (engines) [64.443437] Starting subtest: engines [64.446531] Starting dynamic subtest: basic [66.406951] Dynamic subtest basic: SUCCESS (1.964s) [66.415988] Starting dynamic subtest: contexts [69.966739] Dynamic subtest contexts: SUCCESS (3.560s) [69.977147] Starting dynamic subtest: fds [77.073770] Dynamic subtest fds: SUCCESS (7.107s) [77.083496] Starting dynamic subtest: userptr [79.138111] Dynamic subtest userptr: SUCCESS (2.063s) [79.141984] Subtest engines: SUCCESS (14.695s) [79.350698] [027/165] (922s left) gem_exec_store (basic) [79.445380] Starting subtest: basic [79.493496] Subtest basic: SUCCESS (0.051s) [79.713072] [028/165] (921s left) gem_flink_basic (bad-flink) [79.805275] Starting subtest: bad-flink [79.808709] Subtest bad-flink: SUCCESS (0.000s) [79.889494] [029/165] (921s left) gem_flink_basic (bad-open) [79.957540] Starting subtest: bad-open [79.960895] Subtest bad-open: SUCCESS (0.000s) [80.024413] [030/165] (921s left) gem_flink_basic (basic) [80.100030] Starting subtest: basic [80.103492] Subtest basic: SUCCESS (0.000s) [80.209136] [031/165] (921s left) gem_flink_basic (double-flink) [80.301576] Starting subtest: double-flink [80.305050] Subtest double-flink: SUCCESS (0.000s) [80.404577] [032/165] (921s left) gem_flink_basic (flink-lifetime) [80.481655] Starting subtest: flink-lifetime [80.485124] Subtest flink-lifetime: SUCCESS (0.002s) [80.592574] [033/165] (921s left) gem_huc_copy (huc-copy) [80.691835] Starting subtest: huc-copy [80.698599] Subtest huc-copy: SKIP (0.000s) [80.811919] [034/165] (921s left) gem_linear_blits (basic) [81.015050] Starting subtest: basic [81.022804] Subtest basic: SUCCESS (0.007s) [81.176485] [035/165] (920s left) gem_mmap (basic) [81.382018] Starting subtest: basic [81.398559] Subtest basic: SUCCESS (0.000s) [81.463372] [036/165] (920s left) gem_mmap_gtt (basic) [81.544843] Starting subtest: basic [81.547988] Subtest basic: SUCCESS (0.001s) [81.604498] [037/165] (920s left) gem_render_linear_blits (basic) [81.675268] Starting subtest: basic [81.704589] Subtest basic: SUCCESS (0.029s) [81.745951] [038/165] (920s left) gem_render_tiled_blits (basic) [81.844565] Starting subtest: basic [81.877251] Subtest basic: SUCCESS (0.034s) [81.912513] [039/165] (920s left) gem_ringfill (basic-all) [82.201873] Starting subtest: basic-all [83.390035] Subtest basic-all: SUCCESS (1.185s) [83.507997] [040/165] (918s left) gem_softpin (allocator-basic) [83.595614] Starting subtest: allocator-basic [83.701488] Subtest allocator-basic: SUCCESS (0.106s) [83.788545] [041/165] (918s left) gem_softpin (allocator-basic-reserve) [83.865126] Starting subtest: allocator-basic-reserve [83.977235] Subtest allocator-basic-reserve: SUCCESS (0.110s) [84.087395] [042/165] (918s left) gem_softpin (safe-alignment) [84.182851] Starting subtest: safe-alignment [84.193684] Subtest safe-alignment: SUCCESS (0.014s) [84.310141] [043/165] (917s left) gem_sync (basic-all) [84.413500] Starting subtest: basic-all [86.722285] Subtest basic-all: SUCCESS (2.322s) [86.930902] [044/165] (915s left) gem_sync (basic-each) [87.056863] Starting subtest: basic-each [89.230221] Subtest basic-each: SUCCESS (2.190s) [89.449364] [045/165] (912s left) gem_tiled_blits (basic) [89.655068] Starting subtest: basic [89.675900] Subtest basic: SUCCESS (0.020s) [89.821682] [046/165] (912s left) gem_tiled_fence_blits (basic) [90.073050] Starting subtest: basic [90.084711] Subtest basic: SUCCESS (0.011s) [90.276570] [047/165] (912s left) gem_tiled_pread_basic [90.652818] [048/165] (911s left) gem_wait (busy@all-engines) [90.767428] Starting subtest: busy [90.773212] Starting dynamic subtest: all-engines [91.290400] Dynamic subtest all-engines: SUCCESS (0.523s) [91.293565] Subtest busy: SUCCESS (0.523s) [91.511434] [049/165] (910s left) gem_wait (wait@all-engines) [91.612439] Starting subtest: wait [91.615964] Starting dynamic subtest: all-engines [92.654140] Dynamic subtest all-engines: SUCCESS (1.041s) [92.658023] Subtest wait: SUCCESS (1.041s) [92.895542] [050/165] (909s left) i915_getparams_basic (basic-eu-total) [92.982015] Starting subtest: basic-eu-total [92.988841] Subtest basic-eu-total: SUCCESS (0.000s) [93.039316] [051/165] (909s left) i915_getparams_basic (basic-subslice-total) [93.150105] Starting subtest: basic-subslice-total [93.157679] Subtest basic-subslice-total: SUCCESS (0.000s) [93.191912] [052/165] (909s left) i915_hangman (error-state-basic) [93.287830] Starting subtest: error-state-basic [93.292188] Subtest error-state-basic: SUCCESS (0.006s) [93.354026] [053/165] (909s left) i915_pciid [93.493097] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled) [93.787563] Starting subtest: addfb25-4-tiled [93.790703] Subtest addfb25-4-tiled: SUCCESS (0.000s) [93.876043] [055/165] (908s left) kms_addfb_basic (addfb25-bad-modifier) [93.956746] Starting subtest: addfb25-bad-modifier [93.959804] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [94.254070] [056/165] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [94.329055] Starting subtest: addfb25-framebuffer-vs-set-tiling [94.331764] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [94.632111] [057/165] (908s left) kms_addfb_basic (addfb25-modifier-no-flag) [94.726085] Starting subtest: addfb25-modifier-no-flag [94.729483] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [95.020533] [058/165] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy) [95.092302] Starting subtest: addfb25-x-tiled-legacy [95.095625] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [95.380927] [059/165] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [95.482453] Starting subtest: addfb25-x-tiled-mismatch-legacy [95.485874] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [95.774090] [060/165] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [96.060538] Starting subtest: addfb25-yf-tiled-legacy [96.063378] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [96.141079] [061/165] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy) [96.428758] Starting subtest: addfb25-y-tiled-legacy [96.431589] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [96.506872] [062/165] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [96.794547] Starting subtest: addfb25-y-tiled-small-legacy [96.797385] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [96.873271] [063/165] (905s left) kms_addfb_basic (bad-pitch-0) [96.953519] Starting subtest: bad-pitch-0 [96.956843] Subtest bad-pitch-0: SUCCESS (0.000s) [97.258644] [064/165] (905s left) kms_addfb_basic (bad-pitch-1024) [97.349434] Starting subtest: bad-pitch-1024 [97.352515] Subtest bad-pitch-1024: SUCCESS (0.000s) [97.652097] [065/165] (905s left) kms_addfb_basic (bad-pitch-128) [97.721558] Starting subtest: bad-pitch-128 [97.724964] Subtest bad-pitch-128: SUCCESS (0.000s) [98.020508] [066/165] (904s left) kms_addfb_basic (bad-pitch-256) [98.088259] Starting subtest: bad-pitch-256 [98.091906] Subtest bad-pitch-256: SUCCESS (0.000s) [98.392164] [067/165] (904s left) kms_addfb_basic (bad-pitch-32) [98.470206] Starting subtest: bad-pitch-32 [98.473372] Subtest bad-pitch-32: SUCCESS (0.000s) [98.756331] [068/165] (904s left) kms_addfb_basic (bad-pitch-63) [98.831772] Starting subtest: bad-pitch-63 [98.834946] Subtest bad-pitch-63: SUCCESS (0.000s) [99.140306] [069/165] (903s left) kms_addfb_basic (bad-pitch-65536) [99.240225] Starting subtest: bad-pitch-65536 [99.243485] Subtest bad-pitch-65536: SUCCESS (0.000s) [99.540494] [070/165] (903s left) kms_addfb_basic (bad-pitch-999) [99.622921] Starting subtest: bad-pitch-999 [99.626218] Subtest bad-pitch-999: SUCCESS (0.000s) [99.904254] [071/165] (903s left) kms_addfb_basic (basic) [99.972228] Starting subtest: basic [99.975341] Subtest basic: SUCCESS (0.000s) [100.277393] [072/165] (902s left) kms_addfb_basic (basic-x-tiled-legacy) [100.361727] Starting subtest: basic-x-tiled-legacy [100.364856] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [100.655319] [073/165] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [100.732835] Starting subtest: basic-y-tiled-legacy [100.736475] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [101.046633] [074/165] (902s left) kms_addfb_basic (bo-too-small) [101.344822] Starting subtest: bo-too-small [101.347976] Subtest bo-too-small: SUCCESS (0.000s) [101.424512] [075/165] (901s left) kms_addfb_basic (bo-too-small-due-to-tiling) [101.717699] Starting subtest: bo-too-small-due-to-tiling [101.720454] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [101.788160] [076/165] (901s left) kms_addfb_basic (clobberred-modifier) [101.859156] Starting subtest: clobberred-modifier [101.862298] Subtest clobberred-modifier: SUCCESS (0.000s) [102.165624] [077/165] (901s left) kms_addfb_basic (framebuffer-vs-set-tiling) [102.259464] Starting subtest: framebuffer-vs-set-tiling [102.262677] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.554076] [078/165] (900s left) kms_addfb_basic (invalid-get-prop) [102.623880] Starting subtest: invalid-get-prop [102.627441] Subtest invalid-get-prop: SUCCESS (0.000s) [102.920574] [079/165] (900s left) kms_addfb_basic (invalid-get-prop-any) [102.992687] Starting subtest: invalid-get-prop-any [102.995894] Subtest invalid-get-prop-any: SUCCESS (0.000s) [103.299428] [080/165] (900s left) kms_addfb_basic (invalid-set-prop) [103.408832] Starting subtest: invalid-set-prop [103.412752] Subtest invalid-set-prop: SUCCESS (0.000s) [103.708890] [081/165] (899s left) kms_addfb_basic (invalid-set-prop-any) [103.787878] Starting subtest: invalid-set-prop-any [103.791110] Subtest invalid-set-prop-any: SUCCESS (0.000s) [104.075042] [082/165] (899s left) kms_addfb_basic (no-handle) [104.152800] Starting subtest: no-handle [104.155964] Subtest no-handle: SUCCESS (0.000s) [104.448826] [083/165] (898s left) kms_addfb_basic (size-max) [104.769705] Starting subtest: size-max [104.772822] Subtest size-max: SUCCESS (0.000s) [104.854566] [084/165] (898s left) kms_addfb_basic (small-bo) [105.132646] Starting subtest: small-bo [105.135532] Subtest small-bo: SUCCESS (0.000s) [105.204862] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch) [105.305660] Starting subtest: tile-pitch-mismatch [105.309152] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [105.587528] [086/165] (897s left) kms_addfb_basic (too-high) [105.863610] Starting subtest: too-high [105.866325] Subtest too-high: SUCCESS (0.001s) [105.963853] [087/165] (897s left) kms_addfb_basic (too-wide) [106.276683] Starting subtest: too-wide [106.279684] Subtest too-wide: SUCCESS (0.000s) [106.381289] [088/165] (897s left) kms_addfb_basic (unused-handle) [106.469060] Starting subtest: unused-handle [106.471871] Subtest unused-handle: SUCCESS (0.000s) [106.758825] [089/165] (896s left) kms_addfb_basic (unused-modifier) [106.836917] Starting subtest: unused-modifier [106.839811] Subtest unused-modifier: SUCCESS (0.000s) [107.123382] [090/165] (896s left) kms_addfb_basic (unused-offsets) [107.203533] Starting subtest: unused-offsets [107.206662] Subtest unused-offsets: SUCCESS (0.000s) [107.498657] [091/165] (896s left) kms_addfb_basic (unused-pitches) [107.570425] Starting subtest: unused-pitches [107.574353] Subtest unused-pitches: SUCCESS (0.000s) [107.871959] [092/165] (895s left) kms_busy (basic) [108.196272] Starting subtest: basic [108.200234] Starting dynamic subtest: flip [109.092781] Dynamic subtest flip: SUCCESS (0.776s) [109.157394] Starting dynamic subtest: modeset [110.254893] Dynamic subtest modeset: SUCCESS (1.103s) [110.258690] Subtest basic: SUCCESS (1.882s) [110.501314] [093/165] (893s left) kms_prop_blob (basic) [110.593954] Starting subtest: basic [110.597275] Subtest basic: SUCCESS (0.000s) [110.674895] [094/165] (893s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [110.958906] Starting subtest: basic-busy-flip-before-cursor-atomic [110.965103] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [111.022961] [095/165] (892s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [111.303306] Starting subtest: basic-busy-flip-before-cursor-legacy [111.308849] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [111.373959] [096/165] (892s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [111.657155] Starting subtest: basic-flip-after-cursor-atomic [112.816528] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.034s) [113.291634] [097/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [113.585977] Starting subtest: basic-flip-after-cursor-legacy [114.681986] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.021s) [115.257463] [098/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [115.566507] Starting subtest: basic-flip-after-cursor-varying-size [116.625223] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.061s) [117.043463] [099/165] (887s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [117.343834] Starting subtest: basic-flip-before-cursor-atomic [118.391168] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.048s) [118.808994] [100/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [119.133178] Starting subtest: basic-flip-before-cursor-legacy [120.306774] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.051s) [120.820611] [101/165] (883s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [121.124102] Starting subtest: basic-flip-before-cursor-varying-size [122.160821] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.039s) [122.635953] [102/165] (881s left) kms_dsc (dsc-basic) [122.920725] Subtest dsc-basic: SKIP (0.000s) [122.949029] [103/165] (881s left) kms_flip (basic-flip-vs-dpms) [123.208383] Starting subtest: basic-flip-vs-dpms [123.211368] Starting dynamic subtest: A-DP1 [124.344290] Dynamic subtest A-DP1: SUCCESS (1.130s) [124.355320] Starting dynamic subtest: B-DP1 [125.356233] Dynamic subtest B-DP1: SUCCESS (1.008s) [125.367283] Starting dynamic subtest: C-DP1 [126.347516] Dynamic subtest C-DP1: SUCCESS (0.992s) [126.370704] Starting dynamic subtest: A-DP2 [127.157149] Dynamic subtest A-DP2: SUCCESS (0.803s) [127.168057] Starting dynamic subtest: B-DP2 [127.903566] Dynamic subtest B-DP2: SUCCESS (0.745s) [127.914651] Starting dynamic subtest: C-DP2 [128.615999] Dynamic subtest C-DP2: SUCCESS (0.714s) [128.618790] Subtest basic-flip-vs-dpms: SUCCESS (5.410s) [129.035330] [104/165] (875s left) kms_flip (basic-flip-vs-modeset) [129.315430] Starting subtest: basic-flip-vs-modeset [129.321686] Starting dynamic subtest: A-DP1 [130.439690] Dynamic subtest A-DP1: SUCCESS (1.115s) [130.455510] Starting dynamic subtest: B-DP1 [131.456683] Dynamic subtest B-DP1: SUCCESS (1.018s) [131.467113] Starting dynamic subtest: C-DP1 [132.465618] Dynamic subtest C-DP1: SUCCESS (1.004s) [132.485173] Starting dynamic subtest: A-DP2 [133.385151] Dynamic subtest A-DP2: SUCCESS (0.916s) [133.397304] Starting dynamic subtest: B-DP2 [134.099299] Dynamic subtest B-DP2: SUCCESS (0.708s) [134.123242] Starting dynamic subtest: C-DP2 [135.051250] Dynamic subtest C-DP2: SUCCESS (0.947s) [135.054280] Subtest basic-flip-vs-modeset: SUCCESS (5.735s) [135.525214] [105/165] (869s left) kms_flip (basic-flip-vs-wf_vblank) [135.825614] Starting subtest: basic-flip-vs-wf_vblank [135.828379] Starting dynamic subtest: A-DP1 [137.110602] Dynamic subtest A-DP1: SUCCESS (1.200s) [137.176929] Starting dynamic subtest: B-DP1 [138.186640] Dynamic subtest B-DP1: SUCCESS (1.156s) [138.198396] Starting dynamic subtest: C-DP1 [139.325480] Dynamic subtest C-DP1: SUCCESS (1.133s) [139.358829] Starting dynamic subtest: A-DP2 [140.577514] Dynamic subtest A-DP2: SUCCESS (1.248s) [140.588529] Starting dynamic subtest: B-DP2 [141.636512] Dynamic subtest B-DP2: SUCCESS (1.056s) [141.650205] Starting dynamic subtest: C-DP2 [142.694891] Dynamic subtest C-DP2: SUCCESS (1.053s) [142.700288] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.876s) [143.244395] [106/165] (861s left) kms_flip (basic-plain-flip) [143.509603] Starting subtest: basic-plain-flip [143.512575] Starting dynamic subtest: A-DP1 [144.423766] Dynamic subtest A-DP1: SUCCESS (0.915s) [144.437244] Starting dynamic subtest: B-DP1 [145.285245] Dynamic subtest B-DP1: SUCCESS (0.859s) [145.297954] Starting dynamic subtest: C-DP1 [146.137560] Dynamic subtest C-DP1: SUCCESS (0.847s) [146.150600] Starting dynamic subtest: A-DP2 [146.935861] Dynamic subtest A-DP2: SUCCESS (0.793s) [146.962028] Starting dynamic subtest: B-DP2 [147.770305] Dynamic subtest B-DP2: SUCCESS (0.833s) [147.782514] Starting dynamic subtest: C-DP2 [148.542761] Dynamic subtest C-DP2: SUCCESS (0.770s) [148.546181] Subtest basic-plain-flip: SUCCESS (5.039s) [149.074900] [107/165] (855s left) kms_force_connector_basic (force-connector-state) [149.228437] Starting subtest: force-connector-state [149.841719] Subtest force-connector-state: SUCCESS (0.612s) [150.795057] [108/165] (854s left) kms_force_connector_basic (force-edid) [150.957215] Starting subtest: force-edid [151.065134] Subtest force-edid: SUCCESS (0.107s) [151.582447] [109/165] (853s left) kms_force_connector_basic (force-load-detect) [151.713967] Starting subtest: force-load-detect [151.719428] Subtest force-load-detect: SKIP (0.000s) [152.038780] [110/165] (852s left) kms_force_connector_basic (prune-stale-modes) [152.196436] Starting subtest: prune-stale-modes [152.306306] Subtest prune-stale-modes: SUCCESS (0.110s) [152.816362] [111/165] (852s left) kms_frontbuffer_tracking (basic) [153.126025] Starting subtest: basic [155.863922] Subtest basic: SUCCESS (2.744s) [156.144716] [112/165] (848s left) kms_hdmi_inject (inject-audio) [156.389050] Starting subtest: inject-audio [156.567212] Subtest inject-audio: SUCCESS (0.179s) [157.241937] [113/165] (847s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [157.554773] Starting subtest: compare-crc-sanitycheck-xr24 [157.557699] Starting dynamic subtest: pipe-A-DP-1 [158.134716] Dynamic subtest pipe-A-DP-1: SUCCESS (0.577s) [158.145451] Starting dynamic subtest: pipe-B-DP-2 [158.618973] Dynamic subtest pipe-B-DP-2: SUCCESS (0.481s) [158.630821] Starting dynamic subtest: pipe-C-DP-1 [159.178338] Dynamic subtest pipe-C-DP-1: SUCCESS (0.553s) [159.181769] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.622s) [159.581427] [114/165] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [159.898886] Starting subtest: compare-crc-sanitycheck-nv12 [159.901685] Starting dynamic subtest: pipe-A-DP-1 [160.523664] Dynamic subtest pipe-A-DP-1: SUCCESS (0.615s) [160.538254] Starting dynamic subtest: pipe-B-DP-2 [161.045527] Dynamic subtest pipe-B-DP-2: SUCCESS (0.525s) [161.056661] Starting dynamic subtest: pipe-C-DP-1 [161.063335] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [161.066444] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.153s) [161.444491] [115/165] (843s left) kms_pipe_crc_basic (hang-read-crc) [161.738981] Starting subtest: hang-read-crc [161.741760] Starting dynamic subtest: pipe-A-DP-1 [163.082609] Dynamic subtest pipe-A-DP-1: SUCCESS (1.341s) [163.101256] Starting dynamic subtest: pipe-B-DP-2 [164.268206] Dynamic subtest pipe-B-DP-2: SUCCESS (1.177s) [164.281904] Starting dynamic subtest: pipe-C-DP-1 [165.592472] Dynamic subtest pipe-C-DP-1: SUCCESS (1.321s) [165.596592] Subtest hang-read-crc: SUCCESS (3.853s) [166.041162] [116/165] (839s left) kms_pipe_crc_basic (nonblocking-crc) [166.346137] Starting subtest: nonblocking-crc [166.349185] Starting dynamic subtest: pipe-A-DP-1 [167.120983] Dynamic subtest pipe-A-DP-1: SUCCESS (0.748s) [167.134050] Starting dynamic subtest: pipe-B-DP-2 [167.798308] Dynamic subtest pipe-B-DP-2: SUCCESS (0.629s) [167.867969] Starting dynamic subtest: pipe-C-DP-1 [168.522694] Dynamic subtest pipe-C-DP-1: SUCCESS (0.701s) [168.591927] Subtest nonblocking-crc: SUCCESS (2.088s) [169.045844] [117/165] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [169.603103] Starting subtest: nonblocking-crc-frame-sequence [169.680073] Starting dynamic subtest: pipe-A-DP-1 [170.382554] Dynamic subtest pipe-A-DP-1: SUCCESS (0.755s) [170.542097] Starting dynamic subtest: pipe-B-DP-2 [170.991069] Dynamic subtest pipe-B-DP-2: SUCCESS (0.631s) [171.057205] Starting dynamic subtest: pipe-C-DP-1 [171.690818] Dynamic subtest pipe-C-DP-1: SUCCESS (0.703s) [171.758054] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.097s) [172.132531] [118/165] (833s left) kms_pipe_crc_basic (read-crc) [172.444352] Starting subtest: read-crc [172.447549] Starting dynamic subtest: pipe-A-DP-1 [173.144239] Dynamic subtest pipe-A-DP-1: SUCCESS (0.696s) [173.158517] Starting dynamic subtest: pipe-B-DP-2 [173.740086] Dynamic subtest pipe-B-DP-2: SUCCESS (0.596s) [173.759143] Starting dynamic subtest: pipe-C-DP-1 [174.400166] Dynamic subtest pipe-C-DP-1: SUCCESS (0.652s) [174.403598] Subtest read-crc: SUCCESS (1.955s) [174.821320] [119/165] (830s left) kms_pipe_crc_basic (read-crc-frame-sequence) [175.125869] Starting subtest: read-crc-frame-sequence [175.129046] Starting dynamic subtest: pipe-A-DP-1 [175.816603] Dynamic subtest pipe-A-DP-1: SUCCESS (0.690s) [175.830175] Starting dynamic subtest: pipe-B-DP-2 [176.409802] Dynamic subtest pipe-B-DP-2: SUCCESS (0.591s) [176.430494] Starting dynamic subtest: pipe-C-DP-1 [177.097904] Dynamic subtest pipe-C-DP-1: SUCCESS (0.683s) [177.101217] Subtest read-crc-frame-sequence: SUCCESS (1.976s) [177.490476] [120/165] (828s left) kms_pm_backlight (basic-brightness) [177.787572] Subtest basic-brightness: SKIP (0.000s) [177.825751] [121/165] (827s left) kms_psr (primary_page_flip) [177.925258] Subtest primary_page_flip: SKIP (0.000s) [177.970678] [122/165] (827s left) kms_psr (cursor_plane_move) [178.049210] Subtest cursor_plane_move: SKIP (0.000s) [178.074666] [123/165] (827s left) kms_psr (sprite_plane_onoff) [178.142717] Subtest sprite_plane_onoff: SKIP (0.000s) [178.175118] [124/165] (827s left) kms_psr (primary_mmap_gtt) [178.246493] Subtest primary_mmap_gtt: SKIP (0.000s) [178.287920] [125/165] (827s left) kms_setmode (basic-clone-single-crtc) [178.373086] Starting subtest: basic-clone-single-crtc [178.559489] Subtest basic-clone-single-crtc: SKIP (0.192s) [178.956611] [126/165] (826s left) i915_pm_rpm (basic-pci-d3-state) [180.899929] Starting subtest: basic-pci-d3-state [181.774392] Subtest basic-pci-d3-state: SUCCESS (0.878s) [182.236981] [127/165] (823s left) i915_pm_rpm (basic-rte) [182.330308] Starting subtest: basic-rte [184.970979] Subtest basic-rte: SUCCESS (2.632s) [186.098202] [128/165] (819s left) i915_pm_rps (basic-api) [186.187795] Starting subtest: basic-api [186.191142] Subtest basic-api: SUCCESS (0.003s) [186.264113] [129/165] (819s left) prime_self_import (basic-llseek-bad) [186.339979] Starting subtest: basic-llseek-bad [186.345526] Subtest basic-llseek-bad: SUCCESS (0.002s) [186.454252] [130/165] (819s left) prime_self_import (basic-llseek-size) [186.534545] Starting subtest: basic-llseek-size [186.540883] Subtest basic-llseek-size: SUCCESS (0.003s) [186.658075] [131/165] (819s left) prime_self_import (basic-with_fd_dup) [186.750376] Starting subtest: basic-with_fd_dup [186.756932] Subtest basic-with_fd_dup: SUCCESS (0.002s) [186.872688] [132/165] (819s left) prime_self_import (basic-with_one_bo) [186.958824] Starting subtest: basic-with_one_bo [186.965629] Subtest basic-with_one_bo: SUCCESS (0.003s) [187.018383] [133/165] (819s left) prime_self_import (basic-with_one_bo_two_files) [187.081554] Starting subtest: basic-with_one_bo_two_files [187.087153] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [187.194076] [134/165] (818s left) prime_self_import (basic-with_two_bos) [187.280251] Starting subtest: basic-with_two_bos [187.286743] Subtest basic-with_two_bos: SUCCESS (0.002s) [187.398599] [135/165] (818s left) prime_vgem (basic-fence-flip) [187.499874] Starting subtest: basic-fence-flip [188.172383] Subtest basic-fence-flip: SUCCESS (0.672s) [188.308661] [136/165] (817s left) prime_vgem (basic-fence-mmap) [188.419840] Starting subtest: basic-fence-mmap [188.449281] Subtest basic-fence-mmap: SUCCESS (0.029s) [188.569960] [137/165] (817s left) prime_vgem (basic-fence-read) [188.661902] Starting subtest: basic-fence-read [188.706823] Subtest basic-fence-read: SUCCESS (0.049s) [188.784835] [138/165] (817s left) prime_vgem (basic-gtt) [188.889168] Starting subtest: basic-gtt [188.902812] Subtest basic-gtt: SUCCESS (0.013s) [189.024274] [139/165] (817s left) prime_vgem (basic-read) [189.134919] Starting subtest: basic-read [189.157087] Subtest basic-read: SUCCESS (0.022s) [189.245717] [140/165] (817s left) prime_vgem (basic-write) [189.357579] Starting subtest: basic-write [189.382540] Subtest basic-write: SUCCESS (0.025s) [189.465166] [141/165] (816s left) vgem_basic (setversion) [189.555123] Starting subtest: setversion [189.561990] Subtest setversion: SUCCESS (0.000s) [189.609752] [142/165] (816s left) vgem_basic (create) [189.691805] Starting subtest: create [189.695049] Subtest create: SUCCESS (0.000s) [189.742588] [143/165] (816s left) vgem_basic (debugfs) [189.823405] Starting subtest: debugfs [189.826389] Subtest debugfs: SUCCESS (0.000s) [189.876431] [144/165] (816s left) vgem_basic (dmabuf-export) [189.959718] Starting subtest: dmabuf-export [189.966125] Subtest dmabuf-export: SUCCESS (0.002s) [190.068783] [145/165] (816s left) vgem_basic (dmabuf-fence) [190.160329] Starting subtest: dmabuf-fence [190.163618] Subtest dmabuf-fence: SUCCESS (0.001s) [190.208643] [146/165] (816s left) vgem_basic (dmabuf-fence-before) [190.291150] Starting subtest: dmabuf-fence-before [190.294100] Subtest dmabuf-fence-before: SUCCESS (0.000s) [190.354096] [147/165] (816s left) vgem_basic (dmabuf-mmap) [190.452277] Starting subtest: dmabuf-mmap [190.463414] Subtest dmabuf-mmap: SUCCESS (0.013s) [190.528729] [148/165] (816s left) vgem_basic (mmap) [190.618915] Starting subtest: mmap [190.626221] Subtest mmap: SUCCESS (0.010s) [190.674397] [149/165] (815s left) vgem_basic (second-client) [190.752549] Starting subtest: second-client [190.786144] Subtest second-client: SUCCESS (0.033s) [190.852678] [150/165] (815s left) vgem_basic (sysfs) [190.923967] Starting subtest: sysfs [190.927238] Subtest sysfs: SUCCESS (0.000s) [190.974882] [151/165] (815s left) core_hotunplug (unbind-rebind) [191.088110] Starting subtest: unbind-rebind [194.546169] Subtest unbind-rebind: SUCCESS (3.458s) [194.571379] [152/165] (812s left) vgem_basic (unload) [194.655062] Starting subtest: unload [223.644291] Subtest unload: SUCCESS (28.988s) [223.756892] [153/165] (782s left) i915_module_load (reload) [223.827549] Starting subtest: reload [226.750249] Subtest reload: SUCCESS (2.927s) [226.771657] [154/165] (779s left) gem_lmem_swapping (basic) [226.852613] Subtest basic: SKIP (0.000s) [226.884882] [155/165] (779s left) gem_lmem_swapping (parallel-random-engines) [226.955785] Subtest parallel-random-engines: SKIP (0.000s) [226.984902] [156/165] (779s left) gem_lmem_swapping (random-engines) [227.057282] Subtest random-engines: SKIP (0.000s) [227.084699] [157/165] (779s left) gem_lmem_swapping (verify-random) [227.160539] Subtest verify-random: SKIP (0.000s) [227.184874] [158/165] (779s left) i915_pm_rpm (module-reload) [229.496305] Starting subtest: module-reload [240.319041] Subtest module-reload: SUCCESS (10.826s) [240.342039] [159/165] (766s left) i915_selftest (live) [240.429387] Starting subtest: live [240.432478] Starting dynamic subtest: sanitycheck [241.098136] Dynamic subtest sanitycheck: SUCCESS (0.668s) [241.108631] Starting dynamic subtest: uncore [241.782108] Dynamic subtest uncore: SUCCESS (0.681s) [241.795273] Starting dynamic subtest: workarounds [242.730262] Dynamic subtest workarounds: SUCCESS (0.944s) [242.739945] Starting dynamic subtest: gt_engines [243.954945] Dynamic subtest gt_engines: SUCCESS (1.225s) [243.963844] Starting dynamic subtest: gt_timelines [254.824966] Dynamic subtest gt_timelines: SUCCESS (10.868s) [254.834412] Starting dynamic subtest: gt_contexts [255.646053] Dynamic subtest gt_contexts: SUCCESS (0.819s) [255.656364] Starting dynamic subtest: gt_lrc [259.311936] Dynamic subtest gt_lrc: SUCCESS (3.664s) [259.320804] Starting dynamic subtest: gt_mocs [260.116280] Dynamic subtest gt_mocs: SUCCESS (0.800s) [260.128644] Starting dynamic subtest: gt_pm [266.645155] Dynamic subtest gt_pm: SUCCESS (6.529s) [266.654642] Starting dynamic subtest: gt_heartbeat [267.489337] Dynamic subtest gt_heartbeat: SUCCESS (0.839s) [267.499640] Starting dynamic subtest: gt_tlb [269.233881] Dynamic subtest gt_tlb: SUCCESS (1.746s) [269.245109] Starting dynamic subtest: requests [277.361052] Dynamic subtest requests: SUCCESS (8.125s) [277.371304] Starting dynamic subtest: migrate [280.835051] Dynamic subtest migrate: SUCCESS (3.472s) [280.844460] Starting dynamic subtest: active [281.596266] Dynamic subtest active: SUCCESS (0.757s) [281.608644] Starting dynamic subtest: objects [283.289079] Dynamic subtest objects: SUCCESS (1.693s) [283.299734] Starting dynamic subtest: mman [287.782391] Dynamic subtest mman: SUCCESS (4.491s) [287.793880] Starting dynamic subtest: dmabuf [288.552874] Dynamic subtest dmabuf: SUCCESS (0.769s) [288.561866] Starting dynamic subtest: vma [289.289972] Dynamic subtest vma: SUCCESS (0.735s) [289.299506] Starting dynamic subtest: coherency [290.922872] Dynamic subtest coherency: SUCCESS (1.631s) [290.931832] Starting dynamic subtest: gtt [298.854212] Dynamic subtest gtt: SUCCESS (7.929s) [298.863825] Starting dynamic subtest: gem [299.728030] Dynamic subtest gem: SUCCESS (0.872s) [299.737985] Starting dynamic subtest: evict [302.072256] Dynamic subtest evict: SUCCESS (2.340s) [302.082799] Starting dynamic subtest: hugepages [309.238797] Dynamic subtest hugepages: SUCCESS (7.167s) [309.249610] Starting dynamic subtest: gem_contexts [325.725968] Dynamic subtest gem_contexts: SUCCESS (16.486s) [325.735286] Starting dynamic subtest: client [326.486088] Dynamic subtest client: SUCCESS (0.758s) [326.495864] Starting dynamic subtest: gem_migrate [327.149080] Dynamic subtest gem_migrate: SUCCESS (0.661s) [327.160691] Starting dynamic subtest: reset [328.680801] Dynamic subtest reset: SUCCESS (1.529s) [328.692483] Starting dynamic subtest: memory_region [329.403189] Dynamic subtest memory_region: SUCCESS (0.721s) [329.412488] Starting dynamic subtest: hangcheck [358.657186] Dynamic subtest hangcheck: SUCCESS (29.251s) [358.668082] Starting dynamic subtest: execlists [371.774147] Dynamic subtest execlists: SUCCESS (13.117s) [371.784045] Starting dynamic subtest: ring_submission [372.439220] Dynamic subtest ring_submission: SUCCESS (0.661s) [372.451643] Starting dynamic subtest: perf [373.213980] Dynamic subtest perf: SUCCESS (0.775s) [373.223141] Starting dynamic subtest: slpc [373.882876] Dynamic subtest slpc: SUCCESS (0.668s) [373.894113] Starting dynamic subtest: guc [374.571900] Dynamic subtest guc: SUCCESS (0.687s) [374.583309] Starting dynamic subtest: guc_multi_lrc [375.297084] Dynamic subtest guc_multi_lrc: SUCCESS (0.723s) [375.307540] Starting dynamic subtest: guc_hang [375.982927] Dynamic subtest guc_hang: SUCCESS (0.684s) [375.993555] Starting dynamic subtest: late_gt_pm [376.723062] Dynamic subtest late_gt_pm: SUCCESS (0.739s) [376.726459] Subtest live: SUCCESS (136.295s) [376.755203] [160/165] (630s left) dmabuf (all-tests) [376.858830] Starting subtest: all-tests [376.863443] Starting dynamic subtest: sanitycheck [376.921314] Dynamic subtest sanitycheck: SUCCESS (0.066s) [376.943403] Starting dynamic subtest: dma_fence [377.106655] Dynamic subtest dma_fence: SUCCESS (0.182s) [377.119397] Starting dynamic subtest: dma_fence_chain [391.884063] Dynamic subtest dma_fence_chain: SUCCESS (14.775s) [391.901711] Starting dynamic subtest: dma_fence_unwrap [391.964304] Dynamic subtest dma_fence_unwrap: SUCCESS (0.075s) [391.987885] Starting dynamic subtest: dma_resv [392.046235] Dynamic subtest dma_resv: SUCCESS (0.079s) [392.050089] Subtest all-tests: SUCCESS (15.191s) [392.087500] [161/165] (614s left) i915_suspend (basic-s2idle-without-i915) [392.174704] Starting subtest: basic-s2idle-without-i915 [410.953949] Subtest basic-s2idle-without-i915: SUCCESS (3.664s) [414.575811] [162/165] (610s left) i915_suspend (basic-s3-without-i915) [414.650766] Starting subtest: basic-s3-without-i915 [433.664049] Subtest basic-s3-without-i915: SUCCESS (3.235s) [437.300057] [163/165] (606s left) gem_exec_suspend (basic-s0) [437.406722] Starting subtest: basic-S0 [437.409954] Starting dynamic subtest: smem [456.060317] Dynamic subtest smem: SUCCESS (2.838s) [456.063899] Subtest basic-S0: SUCCESS (2.840s) [459.255819] [164/165] (603s left) gem_exec_suspend (basic-s3) [459.334061] Starting subtest: basic-S3 [459.338626] Starting dynamic subtest: smem [478.745870] Dynamic subtest smem: SUCCESS (3.572s) [478.749261] Subtest basic-S3: SUCCESS (3.574s) [482.933441] [165/165] (599s left) kms_pipe_crc_basic (suspend-read-crc) [483.222682] Starting subtest: suspend-read-crc [483.225897] Starting dynamic subtest: pipe-A-DP-1 [502.720363] Dynamic subtest pipe-A-DP-1: SUCCESS (3.620s) [502.733069] Starting dynamic subtest: pipe-B-DP-2 [522.635585] Dynamic subtest pipe-B-DP-2: SUCCESS (2.708s) [522.648321] Starting dynamic subtest: pipe-C-DP-1 [542.733058] Dynamic subtest pipe-C-DP-1: SUCCESS (2.849s) [542.736688] Subtest suspend-read-crc: SUCCESS (9.191s) [547.105025] Closing watchdogs Done.