[40.997388] Initializing watchdogs [40.997485] /dev/watchdog0 [41.003339] [001/171] (960s left) i915_module_load (load) [41.065884] Starting subtest: load [41.951758] Subtest load: SUCCESS (0.884s) [41.974828] [002/171] (959s left) core_auth (basic-auth) [42.076655] Starting subtest: basic-auth [42.077703] Subtest basic-auth: SUCCESS (0.000s) [42.128499] [003/171] (959s left) debugfs_test (read_all_entries) [42.192208] Starting subtest: read_all_entries [42.234025] Subtest read_all_entries: SUCCESS (0.041s) [42.310647] [004/171] (959s left) debugfs_test (basic-hwmon) [42.368685] Starting subtest: basic-hwmon [42.370778] Subtest basic-hwmon: SKIP (0.000s) [42.443493] [005/171] (959s left) fbdev (eof) [42.518768] Starting subtest: eof [42.519968] Subtest eof: SUCCESS (0.000s) [42.561684] [006/171] (959s left) fbdev (info) [42.616930] Starting subtest: info [42.617972] Subtest info: SUCCESS (0.000s) [42.680795] [007/171] (958s left) fbdev (nullptr) [42.749936] Starting subtest: nullptr [42.751090] Subtest nullptr: SUCCESS (0.000s) [42.793825] [008/171] (958s left) fbdev (read) [42.850747] Starting subtest: read [42.929324] Subtest read: SUCCESS (0.079s) [42.961992] [009/171] (958s left) fbdev (write) [43.033144] Starting subtest: write [43.073425] Subtest write: SUCCESS (0.040s) [43.111186] [010/171] (958s left) gem_basic (bad-close) [43.169418] Starting subtest: bad-close [43.171516] Subtest bad-close: SUCCESS (0.000s) [43.227529] [011/171] (958s left) gem_basic (create-close) [43.284980] Starting subtest: create-close [43.287189] Subtest create-close: SUCCESS (0.000s) [43.360747] [012/171] (958s left) gem_basic (create-fd-close) [43.418240] Starting subtest: create-fd-close [43.420246] Subtest create-fd-close: SUCCESS (0.000s) [43.477460] [013/171] (958s left) gem_busy (busy@all-engines) [43.542222] Starting subtest: busy [43.543379] Starting dynamic subtest: all-engines [43.561049] Dynamic subtest all-engines: SUCCESS (0.019s) [43.562348] Subtest busy: SUCCESS (0.019s) [43.863209] [014/171] (957s left) gem_close_race (basic-process) [43.928056] Starting subtest: basic-process [43.959420] Subtest basic-process: SUCCESS (0.030s) [44.126643] [015/171] (957s left) gem_close_race (basic-threads) [44.193268] Starting subtest: basic-threads [45.345405] Subtest basic-threads: SUCCESS (1.151s) [45.511587] [016/171] (956s left) gem_ctx_create (basic) [45.574903] Starting subtest: basic [45.576010] Subtest basic: SUCCESS (0.000s) [45.727530] [017/171] (955s left) gem_ctx_create (basic-files) [45.791103] Starting subtest: basic-files [47.801210] Subtest basic-files: SUCCESS (2.010s) [48.010812] [018/171] (953s left) gem_ctx_exec (basic) [48.074196] Starting subtest: basic [48.076483] Subtest basic: SUCCESS (0.002s) [48.156986] [019/171] (953s left) gem_exec_basic (basic) [48.218636] Starting subtest: basic [48.219791] Starting dynamic subtest: rcs0-smem [48.220786] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [48.226264] Starting dynamic subtest: bcs0-smem [48.227346] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [48.232822] Starting dynamic subtest: vcs0-smem [48.233980] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [48.239959] Starting dynamic subtest: vecs0-smem [48.240971] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [48.242159] Subtest basic: SUCCESS (0.002s) [48.377310] [020/171] (953s left) gem_exec_create (basic) [48.439975] Starting subtest: basic [48.441129] Starting dynamic subtest: smem [50.482424] Dynamic subtest smem: SUCCESS (2.041s) [50.483991] Subtest basic: SUCCESS (2.042s) [50.647165] [021/171] (951s left) gem_exec_fence (basic-busy) [50.822914] Starting subtest: basic-busy [50.824028] Starting dynamic subtest: rcs0 [50.853406] Dynamic subtest rcs0: SUCCESS (0.031s) [50.860927] Starting dynamic subtest: bcs0 [50.884895] Dynamic subtest bcs0: SUCCESS (0.031s) [50.892158] Starting dynamic subtest: vcs0 [50.904185] Dynamic subtest vcs0: SUCCESS (0.020s) [50.909356] Starting dynamic subtest: vecs0 [50.921180] Dynamic subtest vecs0: SUCCESS (0.017s) [50.922344] Subtest basic-busy: SUCCESS (0.099s) [51.359388] [022/171] (950s left) gem_exec_fence (basic-wait) [51.537228] Starting subtest: basic-wait [51.538430] Starting dynamic subtest: rcs0 [51.571427] Dynamic subtest rcs0: SUCCESS (0.034s) [51.577284] Starting dynamic subtest: bcs0 [51.601914] Dynamic subtest bcs0: SUCCESS (0.030s) [51.608481] Starting dynamic subtest: vcs0 [51.626908] Dynamic subtest vcs0: SUCCESS (0.025s) [51.632983] Starting dynamic subtest: vecs0 [51.654256] Dynamic subtest vecs0: SUCCESS (0.028s) [51.655280] Subtest basic-wait: SUCCESS (0.117s) [52.061814] [023/171] (949s left) gem_exec_fence (basic-await) [52.234576] Starting subtest: basic-await [52.235782] Starting dynamic subtest: rcs0 [52.302406] Dynamic subtest rcs0: SUCCESS (0.067s) [52.307765] Starting dynamic subtest: bcs0 [52.369293] Dynamic subtest bcs0: SUCCESS (0.066s) [52.374668] Starting dynamic subtest: vcs0 [52.435501] Dynamic subtest vcs0: SUCCESS (0.067s) [52.441642] Starting dynamic subtest: vecs0 [52.503993] Dynamic subtest vecs0: SUCCESS (0.068s) [52.505175] Subtest basic-await: SUCCESS (0.269s) [52.928998] [024/171] (948s left) gem_exec_fence (nb-await) [53.098814] Starting subtest: nb-await [53.099836] Starting dynamic subtest: rcs0 [53.151954] Dynamic subtest rcs0: SUCCESS (0.054s) [53.157511] Starting dynamic subtest: bcs0 [53.206150] Dynamic subtest bcs0: SUCCESS (0.054s) [53.211264] Starting dynamic subtest: vcs0 [53.259042] Dynamic subtest vcs0: SUCCESS (0.053s) [53.265575] Starting dynamic subtest: vecs0 [53.312640] Dynamic subtest vecs0: SUCCESS (0.054s) [53.313667] Subtest nb-await: SUCCESS (0.214s) [53.726179] [025/171] (948s left) gem_exec_gttfill (basic) [53.790859] Starting subtest: basic [56.806777] Subtest basic: SUCCESS (3.015s) [56.958031] [026/171] (944s left) gem_exec_parallel (engines) [57.086930] Starting subtest: engines [57.087981] Starting dynamic subtest: basic [58.484155] Dynamic subtest basic: SUCCESS (1.397s) [58.490367] Starting dynamic subtest: contexts [60.026371] Dynamic subtest contexts: SUCCESS (1.542s) [60.033191] Starting dynamic subtest: fds [61.740761] Dynamic subtest fds: SUCCESS (1.714s) [61.747247] Starting dynamic subtest: userptr [63.181292] Dynamic subtest userptr: SUCCESS (1.440s) [63.182689] Subtest engines: SUCCESS (6.094s) [63.341377] [027/171] (938s left) gem_exec_store (basic) [63.405605] Starting subtest: basic [63.433773] Subtest basic: SUCCESS (0.028s) [63.593437] [028/171] (938s left) gem_flink_basic (bad-flink) [63.656423] Starting subtest: bad-flink [63.657503] Subtest bad-flink: SUCCESS (0.000s) [63.707270] [029/171] (938s left) gem_flink_basic (bad-open) [63.765353] Starting subtest: bad-open [63.766404] Subtest bad-open: SUCCESS (0.000s) [63.826961] [030/171] (938s left) gem_flink_basic (basic) [63.884298] Starting subtest: basic [63.885391] Subtest basic: SUCCESS (0.000s) [63.940669] [031/171] (937s left) gem_flink_basic (double-flink) [63.997063] Starting subtest: double-flink [63.998170] Subtest double-flink: SUCCESS (0.000s) [64.057328] [032/171] (937s left) gem_flink_basic (flink-lifetime) [64.114473] Starting subtest: flink-lifetime [64.115589] Subtest flink-lifetime: SUCCESS (0.001s) [64.190797] [033/171] (937s left) gem_huc_copy (huc-copy) [64.248776] Subtest huc-copy: SKIP (0.000s) [64.268879] [034/171] (937s left) gem_linear_blits (basic) [64.399857] Starting subtest: basic [64.405807] Subtest basic: SUCCESS (0.006s) [64.497575] [035/171] (937s left) gem_mmap (basic) [64.624345] Starting subtest: basic [64.629464] Subtest basic: SUCCESS (0.000s) [64.693632] [036/171] (937s left) gem_mmap_gtt (basic) [64.751317] Starting subtest: basic [64.752446] Subtest basic: SUCCESS (0.000s) [64.805283] [037/171] (937s left) gem_render_linear_blits (basic) [64.864622] Starting subtest: basic [64.886081] Subtest basic: SUCCESS (0.021s) [64.936968] [038/171] (937s left) gem_render_tiled_blits (basic) [64.995586] Starting subtest: basic [65.019669] Subtest basic: SUCCESS (0.024s) [65.068859] [039/171] (936s left) gem_ringfill (basic-all) [65.229127] Starting subtest: basic-all [66.330646] Subtest basic-all: SUCCESS (1.103s) [66.406478] [040/171] (935s left) gem_softpin (allocator-basic) [66.467497] Subtest allocator-basic: SKIP (0.000s) [66.522761] [041/171] (935s left) gem_softpin (allocator-basic-reserve) [66.580365] Subtest allocator-basic-reserve: SKIP (0.000s) [66.640219] [042/171] (935s left) gem_softpin (safe-alignment) [66.700777] Starting subtest: safe-alignment [66.708044] Subtest safe-alignment: SUCCESS (0.008s) [66.793300] [043/171] (935s left) gem_sync (basic-all) [66.857125] Starting subtest: basic-all [68.982539] Subtest basic-all: SUCCESS (2.124s) [69.140306] [044/171] (932s left) gem_sync (basic-each) [69.204340] Starting subtest: basic-each [71.272636] Subtest basic-each: SUCCESS (2.068s) [71.439517] [045/171] (930s left) gem_tiled_blits (basic) [71.564613] Starting subtest: basic [71.579082] Subtest basic: SUCCESS (0.015s) [71.680337] [046/171] (930s left) gem_tiled_fence_blits (basic) [71.876951] Starting subtest: basic [71.882566] Subtest basic: SUCCESS (0.006s) [71.978681] [047/171] (930s left) gem_tiled_pread_basic [72.256379] [048/171] (929s left) gem_wait (busy@all-engines) [72.325420] Starting subtest: busy [72.326524] Starting dynamic subtest: all-engines [72.846244] Dynamic subtest all-engines: SUCCESS (0.520s) [72.847375] Subtest busy: SUCCESS (0.520s) [73.024162] [049/171] (929s left) gem_wait (wait@all-engines) [73.090678] Starting subtest: wait [73.091852] Starting dynamic subtest: all-engines [74.107504] Dynamic subtest all-engines: SUCCESS (1.016s) [74.108743] Subtest wait: SUCCESS (1.017s) [74.289324] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [74.345451] Starting subtest: basic-eu-total [74.347347] Subtest basic-eu-total: SUCCESS (0.000s) [74.404122] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [74.460274] Starting subtest: basic-subslice-total [74.462361] Subtest basic-subslice-total: SUCCESS (0.000s) [74.521347] [052/171] (927s left) i915_hangman (error-state-basic) [74.583348] Starting subtest: error-state-basic [74.588855] Subtest error-state-basic: SUCCESS (0.005s) [74.653544] [053/171] (927s left) i915_pciid [74.772190] [054/171] (927s left) kms_addfb_basic (addfb25-bad-modifier) [74.829960] Starting subtest: addfb25-bad-modifier [74.831037] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [74.920731] [055/171] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [74.977151] Starting subtest: addfb25-framebuffer-vs-set-tiling [74.978193] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [75.070382] [056/171] (927s left) kms_addfb_basic (addfb25-modifier-no-flag) [75.126601] Starting subtest: addfb25-modifier-no-flag [75.127723] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [75.220522] [057/171] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [75.277309] Starting subtest: addfb25-x-tiled-legacy [75.278374] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [75.370470] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [75.429139] Starting subtest: addfb25-x-tiled-mismatch-legacy [75.430234] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [75.520280] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [75.597846] Starting subtest: addfb25-yf-tiled-legacy [75.598944] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [75.653527] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [75.731624] Starting subtest: addfb25-y-tiled-legacy [75.732631] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [75.803300] [061/171] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [75.883833] Starting subtest: addfb25-y-tiled-small-legacy [75.885910] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [75.954398] [062/171] (926s left) kms_addfb_basic (bad-pitch-0) [76.011366] Starting subtest: bad-pitch-0 [76.012375] Subtest bad-pitch-0: SUCCESS (0.000s) [76.103273] [063/171] (926s left) kms_addfb_basic (bad-pitch-1024) [76.159280] Starting subtest: bad-pitch-1024 [76.160297] Subtest bad-pitch-1024: SUCCESS (0.000s) [76.254325] [064/171] (926s left) kms_addfb_basic (bad-pitch-128) [76.312285] Starting subtest: bad-pitch-128 [76.313369] Subtest bad-pitch-128: SUCCESS (0.000s) [76.403914] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [76.460234] Starting subtest: bad-pitch-256 [76.461196] Subtest bad-pitch-256: SUCCESS (0.000s) [76.553432] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [76.610337] Starting subtest: bad-pitch-32 [76.611377] Subtest bad-pitch-32: SUCCESS (0.000s) [76.703749] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [76.759797] Starting subtest: bad-pitch-63 [76.760862] Subtest bad-pitch-63: SUCCESS (0.000s) [76.853316] [068/171] (925s left) kms_addfb_basic (bad-pitch-65536) [76.909265] Starting subtest: bad-pitch-65536 [76.910342] Subtest bad-pitch-65536: SUCCESS (0.000s) [77.003376] [069/171] (925s left) kms_addfb_basic (bad-pitch-999) [77.061254] Starting subtest: bad-pitch-999 [77.062293] Subtest bad-pitch-999: SUCCESS (0.000s) [77.153408] [070/171] (925s left) kms_addfb_basic (basic) [77.210808] Starting subtest: basic [77.211891] Subtest basic: SUCCESS (0.000s) [77.303290] [071/171] (925s left) kms_addfb_basic (basic-x-tiled-legacy) [77.360757] Starting subtest: basic-x-tiled-legacy [77.361821] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [77.453143] [072/171] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [77.509749] Starting subtest: basic-y-tiled-legacy [77.510821] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [77.586140] [073/171] (924s left) kms_addfb_basic (bo-too-small) [77.663716] Starting subtest: bo-too-small [77.664834] Subtest bo-too-small: SUCCESS (0.000s) [77.736404] [074/171] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [77.812877] Starting subtest: bo-too-small-due-to-tiling [77.813992] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [77.886493] [075/171] (924s left) kms_addfb_basic (clobberred-modifier) [77.944123] Starting subtest: clobberred-modifier [77.945164] Subtest clobberred-modifier: SUCCESS (0.000s) [78.036735] [076/171] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling) [78.094296] Starting subtest: framebuffer-vs-set-tiling [78.095295] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [78.186671] [077/171] (924s left) kms_addfb_basic (invalid-get-prop) [78.243467] Starting subtest: invalid-get-prop [78.244638] Subtest invalid-get-prop: SUCCESS (0.000s) [78.336985] [078/171] (924s left) kms_addfb_basic (invalid-get-prop-any) [78.392497] Starting subtest: invalid-get-prop-any [78.393595] Subtest invalid-get-prop-any: SUCCESS (0.000s) [78.486193] [079/171] (923s left) kms_addfb_basic (invalid-set-prop) [78.543169] Starting subtest: invalid-set-prop [78.544214] Subtest invalid-set-prop: SUCCESS (0.000s) [78.636313] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [78.691544] Starting subtest: invalid-set-prop-any [78.692633] Subtest invalid-set-prop-any: SUCCESS (0.000s) [78.770175] [081/171] (923s left) kms_addfb_basic (no-handle) [78.827151] Starting subtest: no-handle [78.828149] Subtest no-handle: SUCCESS (0.000s) [78.919638] [082/171] (923s left) kms_addfb_basic (size-max) [78.999218] Starting subtest: size-max [79.000295] Subtest size-max: SUCCESS (0.000s) [79.069125] [083/171] (923s left) kms_addfb_basic (small-bo) [79.146631] Starting subtest: small-bo [79.147730] Subtest small-bo: SUCCESS (0.000s) [79.219644] [084/171] (923s left) kms_addfb_basic (tile-pitch-mismatch) [79.277207] Starting subtest: tile-pitch-mismatch [79.278244] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [79.369323] [085/171] (923s left) kms_addfb_basic (too-high) [79.447488] Starting subtest: too-high [79.448548] Subtest too-high: SUCCESS (0.001s) [79.519412] [086/171] (923s left) kms_addfb_basic (too-wide) [79.598433] Starting subtest: too-wide [79.599463] Subtest too-wide: SUCCESS (0.000s) [79.669674] [087/171] (922s left) kms_addfb_basic (unused-handle) [79.726480] Starting subtest: unused-handle [79.727546] Subtest unused-handle: SUCCESS (0.000s) [79.819342] [088/171] (922s left) kms_addfb_basic (unused-modifier) [79.876467] Starting subtest: unused-modifier [79.877547] Subtest unused-modifier: SUCCESS (0.000s) [79.969408] [089/171] (922s left) kms_addfb_basic (unused-offsets) [80.025272] Starting subtest: unused-offsets [80.026293] Subtest unused-offsets: SUCCESS (0.000s) [80.119408] [090/171] (922s left) kms_addfb_basic (unused-pitches) [80.175302] Starting subtest: unused-pitches [80.176367] Subtest unused-pitches: SUCCESS (0.000s) [80.269216] [091/171] (922s left) kms_busy (basic) [80.351035] Starting subtest: basic [80.352066] Starting dynamic subtest: flip [80.795442] Dynamic subtest flip: SUCCESS (0.443s) [80.801501] Starting dynamic subtest: modeset [81.300061] Dynamic subtest modeset: SUCCESS (0.504s) [81.301797] Subtest basic: SUCCESS (0.948s) [81.430306] [092/171] (921s left) kms_chamelium_hpd (dp-hpd-fast) [81.556703] Subtest dp-hpd-fast: SKIP (0.000s) [81.638660] [093/171] (921s left) kms_chamelium_edid (dp-edid-read) [81.752075] Subtest dp-edid-read: SKIP (0.000s) [81.834502] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast) [81.947678] Subtest dp-crc-fast: SKIP (0.000s) [82.029934] [095/171] (920s left) kms_chamelium_hpd (hdmi-hpd-fast) [82.141910] Subtest hdmi-hpd-fast: SKIP (0.000s) [82.222451] [096/171] (920s left) kms_chamelium_edid (hdmi-edid-read) [82.335497] Subtest hdmi-edid-read: SKIP (0.000s) [82.417389] [097/171] (920s left) kms_chamelium_frames (hdmi-crc-fast) [82.531412] Subtest hdmi-crc-fast: SKIP (0.000s) [82.613266] [098/171] (920s left) kms_chamelium_hpd (vga-hpd-fast) [82.726985] Subtest vga-hpd-fast: SKIP (0.000s) [82.807072] [099/171] (919s left) kms_chamelium_edid (vga-edid-read) [82.920779] Subtest vga-edid-read: SKIP (0.000s) [83.002942] [100/171] (919s left) kms_prop_blob (basic) [83.061160] Starting subtest: basic [83.062215] Subtest basic: SUCCESS (0.000s) [83.121107] [101/171] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [83.216802] Starting subtest: basic-busy-flip-before-cursor-atomic [84.147786] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.931s) [84.272984] [102/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [84.350780] Starting subtest: basic-busy-flip-before-cursor-legacy [85.279689] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.930s) [85.404540] [103/171] (917s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [85.485748] Starting subtest: basic-flip-after-cursor-atomic [86.428477] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.943s) [86.560133] [104/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [86.638677] Starting subtest: basic-flip-after-cursor-legacy [87.567796] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.930s) [87.696861] [105/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [87.773679] Starting subtest: basic-flip-after-cursor-varying-size [88.723312] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.948s) [88.848440] [106/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [88.926971] Starting subtest: basic-flip-before-cursor-atomic [89.855564] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.929s) [89.986333] [107/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [90.065281] Starting subtest: basic-flip-before-cursor-legacy [90.994502] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.930s) [91.120130] [108/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [91.200135] Starting subtest: basic-flip-before-cursor-varying-size [92.161341] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.961s) [92.288107] [109/171] (910s left) kms_flip (basic-flip-vs-dpms) [92.358792] Starting subtest: basic-flip-vs-dpms [92.359889] Starting dynamic subtest: A-VGA1 [93.297958] Dynamic subtest A-VGA1: SUCCESS (0.938s) [93.305358] Starting dynamic subtest: B-VGA1 [94.197843] Dynamic subtest B-VGA1: SUCCESS (0.899s) [94.203911] Starting dynamic subtest: C-VGA1 [95.088715] Dynamic subtest C-VGA1: SUCCESS (0.891s) [95.091100] Subtest basic-flip-vs-dpms: SUCCESS (2.733s) [95.226368] [110/171] (907s left) kms_flip (basic-flip-vs-modeset) [95.295484] Starting subtest: basic-flip-vs-modeset [95.297640] Starting dynamic subtest: A-VGA1 [96.136920] Dynamic subtest A-VGA1: SUCCESS (0.840s) [96.144455] Starting dynamic subtest: B-VGA1 [96.922708] Dynamic subtest B-VGA1: SUCCESS (0.785s) [96.929140] Starting dynamic subtest: C-VGA1 [97.706722] Dynamic subtest C-VGA1: SUCCESS (0.784s) [97.708820] Subtest basic-flip-vs-modeset: SUCCESS (2.413s) [97.840804] [111/171] (905s left) kms_flip (basic-flip-vs-wf_vblank) [97.913274] Starting subtest: basic-flip-vs-wf_vblank [97.914351] Starting dynamic subtest: A-VGA1 [99.049857] Dynamic subtest A-VGA1: SUCCESS (1.135s) [99.056358] Starting dynamic subtest: B-VGA1 [100.170234] Dynamic subtest B-VGA1: SUCCESS (1.120s) [100.176623] Starting dynamic subtest: C-VGA1 [101.291689] Dynamic subtest C-VGA1: SUCCESS (1.121s) [101.293143] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.382s) [101.460285] [112/171] (901s left) kms_flip (basic-plain-flip) [101.526880] Starting subtest: basic-plain-flip [101.528895] Starting dynamic subtest: A-VGA1 [102.387462] Dynamic subtest A-VGA1: SUCCESS (0.858s) [102.393717] Starting dynamic subtest: B-VGA1 [103.225332] Dynamic subtest B-VGA1: SUCCESS (0.837s) [103.232283] Starting dynamic subtest: C-VGA1 [104.064575] Dynamic subtest C-VGA1: SUCCESS (0.839s) [104.066027] Subtest basic-plain-flip: SUCCESS (2.539s) [104.233936] [113/171] (898s left) kms_force_connector_basic (force-connector-state) [104.303719] Starting subtest: force-connector-state [104.447857] Subtest force-connector-state: SUCCESS (0.144s) [104.627969] [114/171] (898s left) kms_force_connector_basic (force-edid) [104.696133] Starting subtest: force-edid [104.717049] Subtest force-edid: SUCCESS (0.021s) [104.813872] [115/171] (898s left) kms_force_connector_basic (force-load-detect) [104.882236] Starting subtest: force-load-detect [105.026992] Subtest force-load-detect: SUCCESS (0.145s) [105.192061] [116/171] (897s left) kms_force_connector_basic (prune-stale-modes) [105.260785] Starting subtest: prune-stale-modes [105.277879] Subtest prune-stale-modes: SUCCESS (0.017s) [105.374769] [117/171] (897s left) kms_frontbuffer_tracking (basic) [105.457820] Starting subtest: basic [107.245205] Subtest basic: SUCCESS (1.790s) [107.312624] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [107.394445] Starting subtest: compare-crc-sanitycheck [107.395543] Starting dynamic subtest: pipe-A-VGA-1 [107.667560] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.272s) [107.674174] Starting dynamic subtest: pipe-B-VGA-1 [107.929931] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.261s) [107.936444] Starting dynamic subtest: pipe-C-VGA-1 [108.200176] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.270s) [108.201198] Subtest compare-crc-sanitycheck: SUCCESS (0.805s) [108.324354] [119/171] (894s left) kms_pipe_crc_basic (hang-read-crc) [108.404168] Starting subtest: hang-read-crc [108.405200] Starting dynamic subtest: pipe-A-VGA-1 [109.123010] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.718s) [109.129424] Starting dynamic subtest: pipe-B-VGA-1 [109.846831] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.724s) [109.853374] Starting dynamic subtest: pipe-C-VGA-1 [110.588984] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.741s) [110.590135] Subtest hang-read-crc: SUCCESS (2.185s) [110.702475] [120/171] (892s left) kms_pipe_crc_basic (nonblocking-crc) [110.781596] Starting subtest: nonblocking-crc [110.782659] Starting dynamic subtest: pipe-A-VGA-1 [111.210712] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.429s) [111.217282] Starting dynamic subtest: pipe-B-VGA-1 [111.638149] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s) [111.644636] Starting dynamic subtest: pipe-C-VGA-1 [112.074781] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.437s) [112.075915] Subtest nonblocking-crc: SUCCESS (1.294s) [112.189250] [121/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [112.266882] Starting subtest: nonblocking-crc-frame-sequence [112.267910] Starting dynamic subtest: pipe-A-VGA-1 [112.696822] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.428s) [112.703267] Starting dynamic subtest: pipe-B-VGA-1 [113.126064] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.428s) [113.134268] Starting dynamic subtest: pipe-C-VGA-1 [113.562973] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.436s) [113.564046] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.295s) [113.675931] [122/171] (889s left) kms_pipe_crc_basic (read-crc) [113.754899] Starting subtest: read-crc [113.755984] Starting dynamic subtest: pipe-A-VGA-1 [114.117855] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.361s) [114.124124] Starting dynamic subtest: pipe-B-VGA-1 [114.477019] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.359s) [114.483455] Starting dynamic subtest: pipe-C-VGA-1 [114.846704] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.370s) [114.847874] Subtest read-crc: SUCCESS (1.092s) [114.977364] [123/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence) [115.059672] Starting subtest: read-crc-frame-sequence [115.060868] Starting dynamic subtest: pipe-A-VGA-1 [115.418961] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.359s) [115.425330] Starting dynamic subtest: pipe-B-VGA-1 [115.777324] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.357s) [115.783678] Starting dynamic subtest: pipe-C-VGA-1 [116.148838] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.371s) [116.149988] Subtest read-crc-frame-sequence: SUCCESS (1.090s) [116.261821] [124/171] (886s left) kms_psr (primary_page_flip) [116.319559] Subtest primary_page_flip: SKIP (0.000s) [116.340955] [125/171] (886s left) kms_psr (cursor_plane_move) [116.398262] Subtest cursor_plane_move: SKIP (0.000s) [116.426609] [126/171] (886s left) kms_psr (sprite_plane_onoff) [116.481371] Subtest sprite_plane_onoff: SKIP (0.000s) [116.507951] [127/171] (886s left) kms_psr (primary_mmap_gtt) [116.565690] Subtest primary_mmap_gtt: SKIP (0.000s) [116.591641] [128/171] (886s left) kms_setmode (basic-clone-single-crtc) [116.648979] Starting subtest: basic-clone-single-crtc [116.652178] Subtest basic-clone-single-crtc: SKIP (0.000s) [116.711679] [129/171] (886s left) i915_pm_backlight (basic-brightness) [116.791499] Subtest basic-brightness: SKIP (0.000s) [116.807881] [130/171] (886s left) i915_pm_rpm (basic-pci-d3-state) [118.173672] Starting subtest: basic-pci-d3-state [118.391912] Subtest basic-pci-d3-state: SUCCESS (0.216s) [118.635821] [131/171] (884s left) i915_pm_rpm (basic-rte) [118.692537] Starting subtest: basic-rte [120.173677] Subtest basic-rte: SUCCESS (1.478s) [120.609752] [132/171] (882s left) i915_pm_rps (basic-api) [120.668951] Starting subtest: basic-api [120.671283] Subtest basic-api: SUCCESS (0.002s) [120.727383] [133/171] (882s left) prime_self_import (basic-llseek-bad) [120.784369] Starting subtest: basic-llseek-bad [120.785502] Subtest basic-llseek-bad: SUCCESS (0.001s) [120.861029] [134/171] (882s left) prime_self_import (basic-llseek-size) [120.917947] Starting subtest: basic-llseek-size [120.920266] Subtest basic-llseek-size: SUCCESS (0.002s) [120.992336] [135/171] (882s left) prime_self_import (basic-with_fd_dup) [121.046678] Starting subtest: basic-with_fd_dup [121.048991] Subtest basic-with_fd_dup: SUCCESS (0.002s) [121.125628] [136/171] (882s left) prime_self_import (basic-with_one_bo) [121.181535] Starting subtest: basic-with_one_bo [121.183940] Subtest basic-with_one_bo: SUCCESS (0.003s) [121.238300] [137/171] (882s left) prime_self_import (basic-with_one_bo_two_files) [121.292951] Starting subtest: basic-with_one_bo_two_files [121.295354] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [121.358628] [138/171] (881s left) prime_self_import (basic-with_two_bos) [121.413569] Starting subtest: basic-with_two_bos [121.416139] Subtest basic-with_two_bos: SUCCESS (0.002s) [121.476842] [139/171] (881s left) prime_vgem (basic-fence-flip) [121.550167] Starting subtest: basic-fence-flip [121.879897] Subtest basic-fence-flip: SUCCESS (0.329s) [121.959340] [140/171] (881s left) prime_vgem (basic-fence-mmap) [122.032914] Starting subtest: basic-fence-mmap [122.051831] Subtest basic-fence-mmap: SUCCESS (0.019s) [122.126632] [141/171] (881s left) prime_vgem (basic-fence-read) [122.199912] Starting subtest: basic-fence-read [122.231229] Subtest basic-fence-read: SUCCESS (0.031s) [122.313273] [142/171] (880s left) prime_vgem (basic-gtt) [122.383084] Starting subtest: basic-gtt [122.393651] Subtest basic-gtt: SUCCESS (0.011s) [122.460809] [143/171] (880s left) prime_vgem (basic-read) [122.532768] Starting subtest: basic-read [122.548257] Subtest basic-read: SUCCESS (0.016s) [122.626586] [144/171] (880s left) prime_vgem (basic-write) [122.701355] Starting subtest: basic-write [122.718148] Subtest basic-write: SUCCESS (0.017s) [122.778650] [145/171] (880s left) prime_vgem (basic-userptr) [122.850122] Starting subtest: basic-userptr [122.859471] Subtest basic-userptr: SKIP (0.008s) [122.928798] [146/171] (880s left) vgem_basic (setversion) [122.996385] Starting subtest: setversion [122.998704] Subtest setversion: SUCCESS (0.000s) [123.042940] [147/171] (880s left) vgem_basic (create) [123.114530] Starting subtest: create [123.115755] Subtest create: SUCCESS (0.000s) [123.158722] [148/171] (880s left) vgem_basic (debugfs) [123.230173] Starting subtest: debugfs [123.231458] Subtest debugfs: SUCCESS (0.000s) [123.275655] [149/171] (880s left) vgem_basic (dmabuf-export) [123.346537] Starting subtest: dmabuf-export [123.349285] Subtest dmabuf-export: SUCCESS (0.002s) [123.408511] [150/171] (880s left) vgem_basic (dmabuf-fence) [123.480504] Starting subtest: dmabuf-fence [123.481644] Subtest dmabuf-fence: SUCCESS (0.001s) [123.527458] [151/171] (879s left) vgem_basic (dmabuf-fence-before) [123.597938] Starting subtest: dmabuf-fence-before [123.599415] Subtest dmabuf-fence-before: SUCCESS (0.001s) [123.642927] [152/171] (879s left) vgem_basic (dmabuf-mmap) [123.713015] Starting subtest: dmabuf-mmap [123.727776] Subtest dmabuf-mmap: SUCCESS (0.015s) [123.777061] [153/171] (879s left) vgem_basic (mmap) [123.846258] Starting subtest: mmap [123.856278] Subtest mmap: SUCCESS (0.010s) [123.892635] [154/171] (879s left) vgem_basic (second-client) [123.962806] Starting subtest: second-client [124.013044] Subtest second-client: SUCCESS (0.050s) [124.059368] [155/171] (879s left) vgem_basic (sysfs) [124.130516] Starting subtest: sysfs [124.131702] Subtest sysfs: SUCCESS (0.001s) [124.175909] [156/171] (879s left) core_hotunplug (unbind-rebind) [124.262637] Starting subtest: unbind-rebind [125.079318] Subtest unbind-rebind: SUCCESS (0.817s) [125.095342] [157/171] (878s left) vgem_basic (unload) [125.157459] Starting subtest: unload [153.909074] Subtest unload: SUCCESS (28.750s) [153.988397] [158/171] (849s left) i915_module_load (reload) [154.045219] Starting subtest: reload [155.588287] Subtest reload: SUCCESS (1.544s) [155.607361] [159/171] (847s left) gem_lmem_swapping (basic) [155.676584] Subtest basic: SKIP (0.000s) [155.696928] [160/171] (847s left) gem_lmem_swapping (parallel-random-engines) [155.756378] Subtest parallel-random-engines: SKIP (0.000s) [155.780336] [161/171] (847s left) gem_lmem_swapping (random-engines) [155.840464] Subtest random-engines: SKIP (0.000s) [155.863823] [162/171] (847s left) gem_lmem_swapping (verify-random) [155.922918] Subtest verify-random: SKIP (0.000s) [155.948836] [163/171] (847s left) i915_pm_rpm (module-reload) [157.554833] Starting subtest: module-reload [163.960904] Subtest module-reload: SUCCESS (6.406s) [163.974388] [164/171] (839s left) i915_selftest (live) [164.039779] Starting subtest: live [164.040824] Starting dynamic subtest: sanitycheck [164.649945] Dynamic subtest sanitycheck: SUCCESS (0.609s) [164.655238] Starting dynamic subtest: uncore [165.121146] Dynamic subtest uncore: SUCCESS (0.471s) [165.126781] Starting dynamic subtest: workarounds [165.737883] Dynamic subtest workarounds: SUCCESS (0.616s) [165.744393] Starting dynamic subtest: gt_engines [166.244154] Dynamic subtest gt_engines: SUCCESS (0.506s) [166.249404] Starting dynamic subtest: gt_timelines [171.636295] Dynamic subtest gt_timelines: SUCCESS (5.392s) [171.641511] Starting dynamic subtest: gt_contexts [172.318634] Dynamic subtest gt_contexts: SUCCESS (0.682s) [172.323807] Starting dynamic subtest: gt_lrc [172.793999] Dynamic subtest gt_lrc: SUCCESS (0.475s) [172.800345] Starting dynamic subtest: gt_mocs [173.388358] Dynamic subtest gt_mocs: SUCCESS (0.594s) [173.393656] Starting dynamic subtest: gt_pm [183.763357] Dynamic subtest gt_pm: SUCCESS (10.374s) [183.768820] Starting dynamic subtest: gt_heartbeat [184.443872] Dynamic subtest gt_heartbeat: SUCCESS (0.680s) [184.451600] Starting dynamic subtest: requests [190.687850] Dynamic subtest requests: SUCCESS (6.243s) [190.693338] Starting dynamic subtest: migrate [191.248731] Dynamic subtest migrate: SUCCESS (0.560s) [191.253827] Starting dynamic subtest: active [191.832986] Dynamic subtest active: SUCCESS (0.584s) [191.838329] Starting dynamic subtest: objects [192.795620] Dynamic subtest objects: SUCCESS (0.962s) [192.800704] Starting dynamic subtest: mman [196.816216] Dynamic subtest mman: SUCCESS (4.020s) [196.821482] Starting dynamic subtest: dmabuf [197.331886] Dynamic subtest dmabuf: SUCCESS (0.515s) [197.337115] Starting dynamic subtest: vma [197.813119] Dynamic subtest vma: SUCCESS (0.481s) [197.818511] Starting dynamic subtest: coherency [199.395719] Dynamic subtest coherency: SUCCESS (1.582s) [199.401203] Starting dynamic subtest: gtt [203.842696] Dynamic subtest gtt: SUCCESS (4.447s) [203.848151] Starting dynamic subtest: gem [204.499244] Dynamic subtest gem: SUCCESS (0.656s) [204.506417] Starting dynamic subtest: evict [205.106795] Dynamic subtest evict: SUCCESS (0.607s) [205.112241] Starting dynamic subtest: hugepages [206.214235] Dynamic subtest hugepages: SUCCESS (1.107s) [206.219664] Starting dynamic subtest: gem_contexts [211.019835] Dynamic subtest gem_contexts: SUCCESS (4.805s) [211.025340] Starting dynamic subtest: client [211.501160] Dynamic subtest client: SUCCESS (0.480s) [211.507845] Starting dynamic subtest: gem_migrate [212.125367] Dynamic subtest gem_migrate: SUCCESS (0.623s) [212.130571] Starting dynamic subtest: reset [213.856982] Dynamic subtest reset: SUCCESS (1.731s) [213.862350] Starting dynamic subtest: memory_region [214.353716] Dynamic subtest memory_region: SUCCESS (0.496s) [214.358983] Starting dynamic subtest: hangcheck [231.645816] Dynamic subtest hangcheck: SUCCESS (17.291s) [231.652235] Starting dynamic subtest: execlists [232.201056] Dynamic subtest execlists: SUCCESS (0.555s) [232.206705] Starting dynamic subtest: ring_submission [232.693082] Dynamic subtest ring_submission: SUCCESS (0.492s) [232.698230] Starting dynamic subtest: perf [233.420500] Dynamic subtest perf: SUCCESS (0.727s) [233.425923] Starting dynamic subtest: slpc [233.892173] Dynamic subtest slpc: SUCCESS (0.471s) [233.897219] Starting dynamic subtest: guc [234.369618] Dynamic subtest guc: SUCCESS (0.477s) [234.375187] Starting dynamic subtest: guc_multi_lrc [234.845200] Dynamic subtest guc_multi_lrc: SUCCESS (0.475s) [234.852219] Starting dynamic subtest: guc_hang [235.400228] Dynamic subtest guc_hang: SUCCESS (0.555s) [235.405356] Starting dynamic subtest: late_gt_pm [235.941366] Dynamic subtest late_gt_pm: SUCCESS (0.541s) [235.942622] Subtest live: SUCCESS (71.901s) [236.005316] [165/171] (767s left) dmabuf (all-tests) [236.067566] Starting subtest: all-tests [236.071063] Starting dynamic subtest: sanitycheck [236.094831] Dynamic subtest sanitycheck: SUCCESS (0.026s) [236.101190] Starting dynamic subtest: dma_fence [236.229213] Dynamic subtest dma_fence: SUCCESS (0.133s) [236.235936] Starting dynamic subtest: dma_fence_chain [247.777586] Dynamic subtest dma_fence_chain: SUCCESS (11.547s) [247.783783] Starting dynamic subtest: dma_fence_unwrap [247.800063] Dynamic subtest dma_fence_unwrap: SUCCESS (0.023s) [247.805647] Starting dynamic subtest: dma_resv [247.827088] Dynamic subtest dma_resv: SUCCESS (0.027s) [247.828189] Subtest all-tests: SUCCESS (11.760s) [247.839114] [166/171] (755s left) i915_suspend (basic-s2idle-without-i915) [247.896013] Starting subtest: basic-s2idle-without-i915 [265.130999] Subtest basic-s2idle-without-i915: SUCCESS (1.737s) [278.264963] [167/171] (753s left) i915_suspend (basic-s3-without-i915) [278.327443] Starting subtest: basic-s3-without-i915 [296.488809] Subtest basic-s3-without-i915: SUCCESS (2.057s) [299.611467] [168/171] (751s left) gem_exec_suspend (basic-s0) [299.681469] Starting subtest: basic-S0 [299.682516] Starting dynamic subtest: smem [316.029408] Dynamic subtest smem: SUCCESS (1.216s) [316.030450] Subtest basic-S0: SUCCESS (1.217s) [321.170814] [169/171] (750s left) gem_exec_suspend (basic-s3) [321.233883] Starting subtest: basic-S3 [321.234959] Starting dynamic subtest: smem [339.051675] Dynamic subtest smem: SUCCESS (1.270s) [339.052696] Subtest basic-S3: SUCCESS (1.270s) [345.085984] [170/171] (748s left) kms_chamelium_hpd (common-hpd-after-suspend) [345.210188] Subtest common-hpd-after-suspend: SKIP (0.000s) [345.296317] [171/171] (748s left) kms_pipe_crc_basic (suspend-read-crc) [345.376521] Starting subtest: suspend-read-crc [345.377540] Starting dynamic subtest: pipe-A-VGA-1 [363.226987] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.467s) [363.234666] Starting dynamic subtest: pipe-B-VGA-1 [381.241360] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.461s) [381.249193] Starting dynamic subtest: pipe-C-VGA-1 [399.239680] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.470s) [399.240766] Subtest suspend-read-crc: SUCCESS (4.401s) [402.325350] Closing watchdogs Done.