[41.923146] Initializing watchdogs [41.923233] /dev/watchdog0 [41.929356] [001/171] (960s left) i915_module_load (load) [41.990850] Starting subtest: load [42.908941] Subtest load: SUCCESS (0.917s) [42.923696] [002/171] (959s left) core_auth (basic-auth) [43.034749] Starting subtest: basic-auth [43.036257] Subtest basic-auth: SUCCESS (0.001s) [43.086670] [003/171] (959s left) debugfs_test (read_all_entries) [43.148738] Starting subtest: read_all_entries [43.192013] Subtest read_all_entries: SUCCESS (0.043s) [43.268221] [004/171] (959s left) debugfs_test (basic-hwmon) [43.328662] Starting subtest: basic-hwmon [43.330716] Subtest basic-hwmon: SKIP (0.000s) [43.401833] [005/171] (959s left) fbdev (eof) [43.474910] Starting subtest: eof [43.476119] Subtest eof: SUCCESS (0.000s) [43.518498] [006/171] (958s left) fbdev (info) [43.575964] Starting subtest: info [43.577158] Subtest info: SUCCESS (0.000s) [43.638875] [007/171] (958s left) fbdev (nullptr) [43.708717] Starting subtest: nullptr [43.709877] Subtest nullptr: SUCCESS (0.000s) [43.754573] [008/171] (958s left) fbdev (read) [43.824465] Starting subtest: read [43.903932] Subtest read: SUCCESS (0.079s) [43.938639] [009/171] (958s left) fbdev (write) [44.009703] Starting subtest: write [44.048775] Subtest write: SUCCESS (0.041s) [44.088282] [010/171] (958s left) gem_basic (bad-close) [44.144303] Starting subtest: bad-close [44.146425] Subtest bad-close: SUCCESS (0.000s) [44.201499] [011/171] (958s left) gem_basic (create-close) [44.257088] Starting subtest: create-close [44.259212] Subtest create-close: SUCCESS (0.000s) [44.318048] [012/171] (958s left) gem_basic (create-fd-close) [44.374711] Starting subtest: create-fd-close [44.376830] Subtest create-fd-close: SUCCESS (0.000s) [44.434798] [013/171] (958s left) gem_busy (busy@all-engines) [44.498409] Starting subtest: busy [44.499523] Starting dynamic subtest: all-engines [44.517279] Dynamic subtest all-engines: SUCCESS (0.019s) [44.518376] Subtest busy: SUCCESS (0.019s) [44.802373] [014/171] (957s left) gem_close_race (basic-process) [44.868993] Starting subtest: basic-process [44.900989] Subtest basic-process: SUCCESS (0.031s) [45.055451] [015/171] (957s left) gem_close_race (basic-threads) [45.121102] Starting subtest: basic-threads [46.268727] Subtest basic-threads: SUCCESS (1.148s) [46.436144] [016/171] (956s left) gem_ctx_create (basic) [46.500468] Starting subtest: basic [46.501636] Subtest basic: SUCCESS (0.000s) [46.651248] [017/171] (955s left) gem_ctx_create (basic-files) [46.711672] Starting subtest: basic-files [48.721996] Subtest basic-files: SUCCESS (2.010s) [48.934907] [018/171] (953s left) gem_ctx_exec (basic) [48.996639] Starting subtest: basic [48.999915] Subtest basic: SUCCESS (0.003s) [49.081818] [019/171] (953s left) gem_exec_basic (basic) [49.141754] Starting subtest: basic [49.142799] Starting dynamic subtest: rcs0-smem [49.143866] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [49.149317] Starting dynamic subtest: bcs0-smem [49.150362] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [49.156157] Starting dynamic subtest: vcs0-smem [49.157318] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [49.163627] Starting dynamic subtest: vecs0-smem [49.164715] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [49.165949] Subtest basic: SUCCESS (0.002s) [49.301512] [020/171] (953s left) gem_exec_create (basic) [49.362425] Starting subtest: basic [49.363455] Starting dynamic subtest: smem [51.402547] Dynamic subtest smem: SUCCESS (2.040s) [51.403636] Subtest basic: SUCCESS (2.040s) [51.567277] [021/171] (951s left) gem_exec_fence (basic-busy) [51.741524] Starting subtest: basic-busy [51.742601] Starting dynamic subtest: rcs0 [51.769550] Dynamic subtest rcs0: SUCCESS (0.028s) [51.776262] Starting dynamic subtest: bcs0 [51.796304] Dynamic subtest bcs0: SUCCESS (0.027s) [51.802123] Starting dynamic subtest: vcs0 [51.811150] Dynamic subtest vcs0: SUCCESS (0.015s) [51.816907] Starting dynamic subtest: vecs0 [51.834368] Dynamic subtest vecs0: SUCCESS (0.023s) [51.835618] Subtest basic-busy: SUCCESS (0.093s) [52.284446] [022/171] (950s left) gem_exec_fence (basic-wait) [52.459414] Starting subtest: basic-wait [52.460503] Starting dynamic subtest: rcs0 [52.492459] Dynamic subtest rcs0: SUCCESS (0.033s) [52.498993] Starting dynamic subtest: bcs0 [52.513421] Dynamic subtest bcs0: SUCCESS (0.021s) [52.520083] Starting dynamic subtest: vcs0 [52.545902] Dynamic subtest vcs0: SUCCESS (0.032s) [52.551811] Starting dynamic subtest: vecs0 [52.578148] Dynamic subtest vecs0: SUCCESS (0.032s) [52.579577] Subtest basic-wait: SUCCESS (0.118s) [52.986484] [023/171] (949s left) gem_exec_fence (basic-await) [53.160886] Starting subtest: basic-await [53.162058] Starting dynamic subtest: rcs0 [53.226942] Dynamic subtest rcs0: SUCCESS (0.065s) [53.232728] Starting dynamic subtest: bcs0 [53.293737] Dynamic subtest bcs0: SUCCESS (0.067s) [53.299316] Starting dynamic subtest: vcs0 [53.359782] Dynamic subtest vcs0: SUCCESS (0.066s) [53.365222] Starting dynamic subtest: vecs0 [53.425401] Dynamic subtest vecs0: SUCCESS (0.065s) [53.426495] Subtest basic-await: SUCCESS (0.265s) [53.835460] [024/171] (948s left) gem_exec_fence (nb-await) [54.007276] Starting subtest: nb-await [54.008339] Starting dynamic subtest: rcs0 [54.063205] Dynamic subtest rcs0: SUCCESS (0.056s) [54.068949] Starting dynamic subtest: bcs0 [54.116114] Dynamic subtest bcs0: SUCCESS (0.053s) [54.121606] Starting dynamic subtest: vcs0 [54.170296] Dynamic subtest vcs0: SUCCESS (0.054s) [54.176248] Starting dynamic subtest: vecs0 [54.223663] Dynamic subtest vecs0: SUCCESS (0.054s) [54.224877] Subtest nb-await: SUCCESS (0.217s) [54.633730] [025/171] (948s left) gem_exec_gttfill (basic) [54.696871] Starting subtest: basic [57.685733] Subtest basic: SUCCESS (2.988s) [57.849494] [026/171] (944s left) gem_exec_parallel (engines) [57.979901] Starting subtest: engines [57.980897] Starting dynamic subtest: basic [59.381319] Dynamic subtest basic: SUCCESS (1.401s) [59.388054] Starting dynamic subtest: contexts [60.926256] Dynamic subtest contexts: SUCCESS (1.545s) [60.932677] Starting dynamic subtest: fds [62.649022] Dynamic subtest fds: SUCCESS (1.723s) [62.655904] Starting dynamic subtest: userptr [64.053399] Dynamic subtest userptr: SUCCESS (1.404s) [64.054959] Subtest engines: SUCCESS (6.073s) [64.217320] [027/171] (938s left) gem_exec_store (basic) [64.279230] Starting subtest: basic [64.312353] Subtest basic: SUCCESS (0.032s) [64.468349] [028/171] (938s left) gem_flink_basic (bad-flink) [64.526788] Starting subtest: bad-flink [64.527900] Subtest bad-flink: SUCCESS (0.000s) [64.581390] [029/171] (938s left) gem_flink_basic (bad-open) [64.635369] Starting subtest: bad-open [64.636439] Subtest bad-open: SUCCESS (0.000s) [64.698310] [030/171] (938s left) gem_flink_basic (basic) [64.756440] Starting subtest: basic [64.757451] Subtest basic: SUCCESS (0.000s) [64.832225] [031/171] (937s left) gem_flink_basic (double-flink) [64.887865] Starting subtest: double-flink [64.888931] Subtest double-flink: SUCCESS (0.000s) [64.947949] [032/171] (937s left) gem_flink_basic (flink-lifetime) [65.004288] Starting subtest: flink-lifetime [65.005471] Subtest flink-lifetime: SUCCESS (0.001s) [65.084821] [033/171] (937s left) gem_huc_copy (huc-copy) [65.144091] Subtest huc-copy: SKIP (0.000s) [65.160541] [034/171] (937s left) gem_linear_blits (basic) [65.285155] Starting subtest: basic [65.290943] Subtest basic: SUCCESS (0.006s) [65.388728] [035/171] (937s left) gem_mmap (basic) [65.515707] Starting subtest: basic [65.521186] Subtest basic: SUCCESS (0.000s) [65.582206] [036/171] (937s left) gem_mmap_gtt (basic) [65.638811] Starting subtest: basic [65.639965] Subtest basic: SUCCESS (0.000s) [65.696133] [037/171] (937s left) gem_render_linear_blits (basic) [65.755933] Starting subtest: basic [65.778303] Subtest basic: SUCCESS (0.023s) [65.829416] [038/171] (937s left) gem_render_tiled_blits (basic) [65.890165] Starting subtest: basic [65.913539] Subtest basic: SUCCESS (0.023s) [65.961542] [039/171] (936s left) gem_ringfill (basic-all) [66.141132] Starting subtest: basic-all [67.244767] Subtest basic-all: SUCCESS (1.105s) [67.318455] [040/171] (935s left) gem_softpin (allocator-basic) [67.378305] Subtest allocator-basic: SKIP (0.000s) [67.431240] [041/171] (935s left) gem_softpin (allocator-basic-reserve) [67.490062] Subtest allocator-basic-reserve: SKIP (0.000s) [67.551220] [042/171] (935s left) gem_softpin (safe-alignment) [67.609879] Starting subtest: safe-alignment [67.616473] Subtest safe-alignment: SUCCESS (0.008s) [67.717723] [043/171] (935s left) gem_sync (basic-all) [67.781991] Starting subtest: basic-all [69.860889] Subtest basic-all: SUCCESS (2.078s) [70.015651] [044/171] (932s left) gem_sync (basic-each) [70.078264] Starting subtest: basic-each [72.127892] Subtest basic-each: SUCCESS (2.049s) [72.280949] [045/171] (930s left) gem_tiled_blits (basic) [72.398353] Starting subtest: basic [72.437925] Subtest basic: SUCCESS (0.014s) [72.527760] [046/171] (930s left) gem_tiled_fence_blits (basic) [72.718880] Starting subtest: basic [72.724270] Subtest basic: SUCCESS (0.006s) [72.818613] [047/171] (930s left) gem_tiled_pread_basic [73.100402] [048/171] (929s left) gem_wait (busy@all-engines) [73.164479] Starting subtest: busy [73.165531] Starting dynamic subtest: all-engines [73.677883] Dynamic subtest all-engines: SUCCESS (0.513s) [73.679114] Subtest busy: SUCCESS (0.513s) [73.846293] [049/171] (929s left) gem_wait (wait@all-engines) [73.910282] Starting subtest: wait [73.911349] Starting dynamic subtest: all-engines [74.928989] Dynamic subtest all-engines: SUCCESS (1.018s) [74.930144] Subtest wait: SUCCESS (1.018s) [75.097282] [050/171] (927s left) i915_getparams_basic (basic-eu-total) [75.153891] Starting subtest: basic-eu-total [75.156023] Subtest basic-eu-total: SUCCESS (0.000s) [75.212952] [051/171] (927s left) i915_getparams_basic (basic-subslice-total) [75.270828] Starting subtest: basic-subslice-total [75.272993] Subtest basic-subslice-total: SUCCESS (0.000s) [75.329168] [052/171] (927s left) i915_hangman (error-state-basic) [75.396295] Starting subtest: error-state-basic [75.401392] Subtest error-state-basic: SUCCESS (0.004s) [75.478819] [053/171] (927s left) i915_pciid [75.595295] [054/171] (927s left) kms_addfb_basic (addfb25-bad-modifier) [75.653487] Starting subtest: addfb25-bad-modifier [75.654618] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [75.746331] [055/171] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [75.802151] Starting subtest: addfb25-framebuffer-vs-set-tiling [75.803209] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [75.895431] [056/171] (927s left) kms_addfb_basic (addfb25-modifier-no-flag) [75.950925] Starting subtest: addfb25-modifier-no-flag [75.951951] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [76.028528] [057/171] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy) [76.084317] Starting subtest: addfb25-x-tiled-legacy [76.085353] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [76.179512] [058/171] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [76.235627] Starting subtest: addfb25-x-tiled-mismatch-legacy [76.236710] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [76.330632] [059/171] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [76.408699] Starting subtest: addfb25-yf-tiled-legacy [76.409735] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [76.478284] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [76.565198] Starting subtest: addfb25-y-tiled-legacy [76.566270] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [76.628413] [061/171] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [76.707610] Starting subtest: addfb25-y-tiled-small-legacy [76.709822] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [76.781068] [062/171] (926s left) kms_addfb_basic (bad-pitch-0) [76.839436] Starting subtest: bad-pitch-0 [76.840476] Subtest bad-pitch-0: SUCCESS (0.000s) [76.928601] [063/171] (926s left) kms_addfb_basic (bad-pitch-1024) [76.984235] Starting subtest: bad-pitch-1024 [76.985351] Subtest bad-pitch-1024: SUCCESS (0.000s) [77.078411] [064/171] (926s left) kms_addfb_basic (bad-pitch-128) [77.133378] Starting subtest: bad-pitch-128 [77.134463] Subtest bad-pitch-128: SUCCESS (0.000s) [77.228313] [065/171] (925s left) kms_addfb_basic (bad-pitch-256) [77.284191] Starting subtest: bad-pitch-256 [77.285190] Subtest bad-pitch-256: SUCCESS (0.000s) [77.378687] [066/171] (925s left) kms_addfb_basic (bad-pitch-32) [77.435942] Starting subtest: bad-pitch-32 [77.437200] Subtest bad-pitch-32: SUCCESS (0.000s) [77.528236] [067/171] (925s left) kms_addfb_basic (bad-pitch-63) [77.584455] Starting subtest: bad-pitch-63 [77.585482] Subtest bad-pitch-63: SUCCESS (0.000s) [77.678469] [068/171] (925s left) kms_addfb_basic (bad-pitch-65536) [77.734762] Starting subtest: bad-pitch-65536 [77.735855] Subtest bad-pitch-65536: SUCCESS (0.000s) [77.828642] [069/171] (925s left) kms_addfb_basic (bad-pitch-999) [77.885510] Starting subtest: bad-pitch-999 [77.886601] Subtest bad-pitch-999: SUCCESS (0.000s) [77.980865] [070/171] (925s left) kms_addfb_basic (basic) [78.038600] Starting subtest: basic [78.039711] Subtest basic: SUCCESS (0.000s) [78.128961] [071/171] (925s left) kms_addfb_basic (basic-x-tiled-legacy) [78.186061] Starting subtest: basic-x-tiled-legacy [78.187165] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [78.278332] [072/171] (925s left) kms_addfb_basic (basic-y-tiled-legacy) [78.334986] Starting subtest: basic-y-tiled-legacy [78.335996] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [78.428402] [073/171] (924s left) kms_addfb_basic (bo-too-small) [78.507537] Starting subtest: bo-too-small [78.508647] Subtest bo-too-small: SUCCESS (0.000s) [78.578270] [074/171] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling) [78.654615] Starting subtest: bo-too-small-due-to-tiling [78.655745] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [78.728847] [075/171] (924s left) kms_addfb_basic (clobberred-modifier) [78.786089] Starting subtest: clobberred-modifier [78.787156] Subtest clobberred-modifier: SUCCESS (0.000s) [78.879260] [076/171] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling) [78.936435] Starting subtest: framebuffer-vs-set-tiling [78.937554] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.028463] [077/171] (924s left) kms_addfb_basic (invalid-get-prop) [79.085521] Starting subtest: invalid-get-prop [79.086692] Subtest invalid-get-prop: SUCCESS (0.000s) [79.178388] [078/171] (924s left) kms_addfb_basic (invalid-get-prop-any) [79.236153] Starting subtest: invalid-get-prop-any [79.237194] Subtest invalid-get-prop-any: SUCCESS (0.000s) [79.328322] [079/171] (924s left) kms_addfb_basic (invalid-set-prop) [79.386419] Starting subtest: invalid-set-prop [79.387493] Subtest invalid-set-prop: SUCCESS (0.000s) [79.477939] [080/171] (923s left) kms_addfb_basic (invalid-set-prop-any) [79.533987] Starting subtest: invalid-set-prop-any [79.535075] Subtest invalid-set-prop-any: SUCCESS (0.000s) [79.628187] [081/171] (923s left) kms_addfb_basic (no-handle) [79.685139] Starting subtest: no-handle [79.686153] Subtest no-handle: SUCCESS (0.000s) [79.777779] [082/171] (923s left) kms_addfb_basic (size-max) [79.855588] Starting subtest: size-max [79.856712] Subtest size-max: SUCCESS (0.000s) [79.910658] [083/171] (923s left) kms_addfb_basic (small-bo) [79.987637] Starting subtest: small-bo [79.988765] Subtest small-bo: SUCCESS (0.000s) [80.044210] [084/171] (923s left) kms_addfb_basic (tile-pitch-mismatch) [80.100651] Starting subtest: tile-pitch-mismatch [80.101670] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [80.177325] [085/171] (923s left) kms_addfb_basic (too-high) [80.255142] Starting subtest: too-high [80.256180] Subtest too-high: SUCCESS (0.000s) [80.328315] [086/171] (923s left) kms_addfb_basic (too-wide) [80.410109] Starting subtest: too-wide [80.411149] Subtest too-wide: SUCCESS (0.000s) [80.478016] [087/171] (923s left) kms_addfb_basic (unused-handle) [80.535228] Starting subtest: unused-handle [80.536274] Subtest unused-handle: SUCCESS (0.000s) [80.627394] [088/171] (922s left) kms_addfb_basic (unused-modifier) [80.683950] Starting subtest: unused-modifier [80.685077] Subtest unused-modifier: SUCCESS (0.000s) [80.777744] [089/171] (922s left) kms_addfb_basic (unused-offsets) [80.834414] Starting subtest: unused-offsets [80.835528] Subtest unused-offsets: SUCCESS (0.000s) [80.927222] [090/171] (922s left) kms_addfb_basic (unused-pitches) [80.983113] Starting subtest: unused-pitches [80.984119] Subtest unused-pitches: SUCCESS (0.000s) [81.077335] [091/171] (922s left) kms_busy (basic) [81.158304] Starting subtest: basic [81.159340] Starting dynamic subtest: flip [81.603295] Dynamic subtest flip: SUCCESS (0.445s) [81.611314] Starting dynamic subtest: modeset [82.121381] Dynamic subtest modeset: SUCCESS (0.517s) [82.122352] Subtest basic: SUCCESS (0.963s) [82.250901] [092/171] (921s left) kms_chamelium_hpd (dp-hpd-fast) [82.377431] Subtest dp-hpd-fast: SKIP (0.000s) [82.458410] [093/171] (921s left) kms_chamelium_edid (dp-edid-read) [82.570641] Subtest dp-edid-read: SKIP (0.000s) [82.651481] [094/171] (920s left) kms_chamelium_frames (dp-crc-fast) [82.763881] Subtest dp-crc-fast: SKIP (0.000s) [82.843706] [095/171] (920s left) kms_chamelium_hpd (hdmi-hpd-fast) [82.957944] Subtest hdmi-hpd-fast: SKIP (0.000s) [83.038231] [096/171] (920s left) kms_chamelium_edid (hdmi-edid-read) [83.151693] Subtest hdmi-edid-read: SKIP (0.000s) [83.232214] [097/171] (920s left) kms_chamelium_frames (hdmi-crc-fast) [83.346957] Subtest hdmi-crc-fast: SKIP (0.000s) [83.427634] [098/171] (920s left) kms_chamelium_hpd (vga-hpd-fast) [83.539768] Subtest vga-hpd-fast: SKIP (0.000s) [83.620664] [099/171] (920s left) kms_chamelium_edid (vga-edid-read) [83.734405] Subtest vga-edid-read: SKIP (0.000s) [83.816115] [100/171] (919s left) kms_prop_blob (basic) [83.873866] Starting subtest: basic [83.874867] Subtest basic: SUCCESS (0.000s) [83.933783] [101/171] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [84.012355] Starting subtest: basic-busy-flip-before-cursor-atomic [84.944620] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.932s) [85.073449] [102/171] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [85.151599] Starting subtest: basic-busy-flip-before-cursor-legacy [86.080806] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.929s) [86.208300] [103/171] (917s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [86.285546] Starting subtest: basic-flip-after-cursor-atomic [87.217143] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.932s) [87.343348] [104/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [87.419364] Starting subtest: basic-flip-after-cursor-legacy [88.351617] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.932s) [88.489066] [105/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [88.572533] Starting subtest: basic-flip-after-cursor-varying-size [89.498920] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.926s) [89.627770] [106/171] (914s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [89.707136] Starting subtest: basic-flip-before-cursor-atomic [90.637372] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.930s) [90.763312] [107/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [90.842136] Starting subtest: basic-flip-before-cursor-legacy [91.770651] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.929s) [91.895810] [108/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [91.973474] Starting subtest: basic-flip-before-cursor-varying-size [92.921397] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.948s) [93.053405] [109/171] (910s left) kms_flip (basic-flip-vs-dpms) [93.123331] Starting subtest: basic-flip-vs-dpms [93.124418] Starting dynamic subtest: A-VGA1 [94.068561] Dynamic subtest A-VGA1: SUCCESS (0.944s) [94.074796] Starting dynamic subtest: B-VGA1 [94.963810] Dynamic subtest B-VGA1: SUCCESS (0.895s) [94.969975] Starting dynamic subtest: C-VGA1 [95.852864] Dynamic subtest C-VGA1: SUCCESS (0.889s) [95.854900] Subtest basic-flip-vs-dpms: SUCCESS (2.732s) [95.999620] [110/171] (907s left) kms_flip (basic-flip-vs-modeset) [96.071034] Starting subtest: basic-flip-vs-modeset [96.072197] Starting dynamic subtest: A-VGA1 [96.918841] Dynamic subtest A-VGA1: SUCCESS (0.846s) [96.925298] Starting dynamic subtest: B-VGA1 [97.711050] Dynamic subtest B-VGA1: SUCCESS (0.792s) [97.718884] Starting dynamic subtest: C-VGA1 [98.505514] Dynamic subtest C-VGA1: SUCCESS (0.794s) [98.508527] Subtest basic-flip-vs-modeset: SUCCESS (2.437s) [98.643628] [111/171] (905s left) kms_flip (basic-flip-vs-wf_vblank) [98.712654] Starting subtest: basic-flip-vs-wf_vblank [98.714822] Starting dynamic subtest: A-VGA1 [99.851957] Dynamic subtest A-VGA1: SUCCESS (1.138s) [99.858314] Starting dynamic subtest: B-VGA1 [100.974745] Dynamic subtest B-VGA1: SUCCESS (1.122s) [100.981105] Starting dynamic subtest: C-VGA1 [102.096759] Dynamic subtest C-VGA1: SUCCESS (1.122s) [102.098130] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.386s) [102.266545] [112/171] (901s left) kms_flip (basic-plain-flip) [102.334407] Starting subtest: basic-plain-flip [102.336402] Starting dynamic subtest: A-VGA1 [103.192189] Dynamic subtest A-VGA1: SUCCESS (0.856s) [103.198686] Starting dynamic subtest: B-VGA1 [104.032282] Dynamic subtest B-VGA1: SUCCESS (0.840s) [104.038613] Starting dynamic subtest: C-VGA1 [104.872578] Dynamic subtest C-VGA1: SUCCESS (0.840s) [104.874077] Subtest basic-plain-flip: SUCCESS (2.540s) [105.040855] [113/171] (898s left) kms_force_connector_basic (force-connector-state) [105.110756] Starting subtest: force-connector-state [105.254437] Subtest force-connector-state: SUCCESS (0.144s) [105.439572] [114/171] (898s left) kms_force_connector_basic (force-edid) [105.506999] Starting subtest: force-edid [105.526885] Subtest force-edid: SUCCESS (0.020s) [105.619361] [115/171] (898s left) kms_force_connector_basic (force-load-detect) [105.687051] Starting subtest: force-load-detect [105.836158] Subtest force-load-detect: SUCCESS (0.148s) [106.000492] [116/171] (897s left) kms_force_connector_basic (prune-stale-modes) [106.069348] Starting subtest: prune-stale-modes [106.084532] Subtest prune-stale-modes: SUCCESS (0.017s) [106.183876] [117/171] (897s left) kms_frontbuffer_tracking (basic) [106.268383] Starting subtest: basic [108.070596] Subtest basic: SUCCESS (1.805s) [108.151815] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [108.233899] Starting subtest: compare-crc-sanitycheck [108.234954] Starting dynamic subtest: pipe-A-VGA-1 [108.509950] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.275s) [108.517319] Starting dynamic subtest: pipe-B-VGA-1 [108.773949] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.263s) [108.782258] Starting dynamic subtest: pipe-C-VGA-1 [109.047069] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.271s) [109.048138] Subtest compare-crc-sanitycheck: SUCCESS (0.813s) [109.176389] [119/171] (894s left) kms_pipe_crc_basic (hang-read-crc) [109.253740] Starting subtest: hang-read-crc [109.254785] Starting dynamic subtest: pipe-A-VGA-1 [109.976231] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.721s) [109.982575] Starting dynamic subtest: pipe-B-VGA-1 [110.709079] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.731s) [110.715619] Starting dynamic subtest: pipe-C-VGA-1 [111.450649] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.741s) [111.451738] Subtest hang-read-crc: SUCCESS (2.197s) [111.565525] [120/171] (892s left) kms_pipe_crc_basic (nonblocking-crc) [111.645249] Starting subtest: nonblocking-crc [111.646272] Starting dynamic subtest: pipe-A-VGA-1 [112.072466] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.427s) [112.079356] Starting dynamic subtest: pipe-B-VGA-1 [112.500288] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s) [112.507234] Starting dynamic subtest: pipe-C-VGA-1 [112.938759] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.437s) [112.939871] Subtest nonblocking-crc: SUCCESS (1.294s) [113.054283] [121/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [113.134136] Starting subtest: nonblocking-crc-frame-sequence [113.135214] Starting dynamic subtest: pipe-A-VGA-1 [113.561911] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.427s) [113.568735] Starting dynamic subtest: pipe-B-VGA-1 [113.989216] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s) [113.995754] Starting dynamic subtest: pipe-C-VGA-1 [114.424798] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.435s) [114.425851] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.291s) [114.538206] [122/171] (889s left) kms_pipe_crc_basic (read-crc) [114.616362] Starting subtest: read-crc [114.617390] Starting dynamic subtest: pipe-A-VGA-1 [114.978838] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.362s) [114.985516] Starting dynamic subtest: pipe-B-VGA-1 [115.337923] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.358s) [115.344692] Starting dynamic subtest: pipe-C-VGA-1 [115.708845] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.370s) [115.709976] Subtest read-crc: SUCCESS (1.093s) [115.839822] [123/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence) [115.918673] Starting subtest: read-crc-frame-sequence [115.919828] Starting dynamic subtest: pipe-A-VGA-1 [116.284216] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.364s) [116.292715] Starting dynamic subtest: pipe-B-VGA-1 [116.645319] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.361s) [116.652196] Starting dynamic subtest: pipe-C-VGA-1 [117.017697] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.371s) [117.018876] Subtest read-crc-frame-sequence: SUCCESS (1.099s) [117.131639] [124/171] (886s left) kms_psr (primary_page_flip) [117.192844] Subtest primary_page_flip: SKIP (0.000s) [117.210580] [125/171] (886s left) kms_psr (cursor_plane_move) [117.265971] Subtest cursor_plane_move: SKIP (0.000s) [117.293743] [126/171] (886s left) kms_psr (sprite_plane_onoff) [117.350047] Subtest sprite_plane_onoff: SKIP (0.000s) [117.377356] [127/171] (886s left) kms_psr (primary_mmap_gtt) [117.435317] Subtest primary_mmap_gtt: SKIP (0.000s) [117.462407] [128/171] (886s left) kms_setmode (basic-clone-single-crtc) [117.520536] Starting subtest: basic-clone-single-crtc [117.523882] Subtest basic-clone-single-crtc: SKIP (0.000s) [117.583998] [129/171] (886s left) i915_pm_backlight (basic-brightness) [117.668346] Subtest basic-brightness: SKIP (0.000s) [117.693966] [130/171] (886s left) i915_pm_rpm (basic-pci-d3-state) [119.058811] Starting subtest: basic-pci-d3-state [119.259941] Subtest basic-pci-d3-state: SUCCESS (0.201s) [119.508151] [131/171] (884s left) i915_pm_rpm (basic-rte) [119.564583] Starting subtest: basic-rte [121.055287] Subtest basic-rte: SUCCESS (1.487s) [121.488432] [132/171] (882s left) i915_pm_rps (basic-api) [121.549290] Starting subtest: basic-api [121.551600] Subtest basic-api: SUCCESS (0.002s) [121.606762] [133/171] (882s left) prime_self_import (basic-llseek-bad) [121.663096] Starting subtest: basic-llseek-bad [121.664206] Subtest basic-llseek-bad: SUCCESS (0.001s) [121.738153] [134/171] (882s left) prime_self_import (basic-llseek-size) [121.793927] Starting subtest: basic-llseek-size [121.795134] Subtest basic-llseek-size: SUCCESS (0.002s) [121.854503] [135/171] (882s left) prime_self_import (basic-with_fd_dup) [121.909627] Starting subtest: basic-with_fd_dup [121.910679] Subtest basic-with_fd_dup: SUCCESS (0.002s) [121.971671] [136/171] (882s left) prime_self_import (basic-with_one_bo) [122.026999] Starting subtest: basic-with_one_bo [122.029358] Subtest basic-with_one_bo: SUCCESS (0.002s) [122.083635] [137/171] (882s left) prime_self_import (basic-with_one_bo_two_files) [122.139450] Starting subtest: basic-with_one_bo_two_files [122.140545] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [122.221170] [138/171] (881s left) prime_self_import (basic-with_two_bos) [122.275753] Starting subtest: basic-with_two_bos [122.278175] Subtest basic-with_two_bos: SUCCESS (0.002s) [122.355172] [139/171] (881s left) prime_vgem (basic-fence-flip) [122.428829] Starting subtest: basic-fence-flip [122.758536] Subtest basic-fence-flip: SUCCESS (0.329s) [122.838712] [140/171] (881s left) prime_vgem (basic-fence-mmap) [122.911897] Starting subtest: basic-fence-mmap [122.931630] Subtest basic-fence-mmap: SUCCESS (0.020s) [123.006398] [141/171] (881s left) prime_vgem (basic-fence-read) [123.078649] Starting subtest: basic-fence-read [123.109379] Subtest basic-fence-read: SUCCESS (0.031s) [123.189116] [142/171] (881s left) prime_vgem (basic-gtt) [123.261280] Starting subtest: basic-gtt [123.271663] Subtest basic-gtt: SUCCESS (0.010s) [123.339334] [143/171] (880s left) prime_vgem (basic-read) [123.410785] Starting subtest: basic-read [123.426041] Subtest basic-read: SUCCESS (0.015s) [123.504683] [144/171] (880s left) prime_vgem (basic-write) [123.579092] Starting subtest: basic-write [123.596280] Subtest basic-write: SUCCESS (0.017s) [123.672382] [145/171] (880s left) prime_vgem (basic-userptr) [123.746232] Starting subtest: basic-userptr [123.755385] Subtest basic-userptr: SKIP (0.009s) [123.823975] [146/171] (880s left) vgem_basic (setversion) [123.891344] Starting subtest: setversion [123.893750] Subtest setversion: SUCCESS (0.000s) [123.938380] [147/171] (880s left) vgem_basic (create) [124.008917] Starting subtest: create [124.010087] Subtest create: SUCCESS (0.000s) [124.054662] [148/171] (880s left) vgem_basic (debugfs) [124.124861] Starting subtest: debugfs [124.126045] Subtest debugfs: SUCCESS (0.000s) [124.171611] [149/171] (880s left) vgem_basic (dmabuf-export) [124.241399] Starting subtest: dmabuf-export [124.243748] Subtest dmabuf-export: SUCCESS (0.001s) [124.323404] [150/171] (880s left) vgem_basic (dmabuf-fence) [124.391554] Starting subtest: dmabuf-fence [124.392721] Subtest dmabuf-fence: SUCCESS (0.001s) [124.441371] [151/171] (879s left) vgem_basic (dmabuf-fence-before) [124.508057] Starting subtest: dmabuf-fence-before [124.509254] Subtest dmabuf-fence-before: SUCCESS (0.000s) [124.554613] [152/171] (879s left) vgem_basic (dmabuf-mmap) [124.626043] Starting subtest: dmabuf-mmap [124.640245] Subtest dmabuf-mmap: SUCCESS (0.014s) [124.687921] [153/171] (879s left) vgem_basic (mmap) [124.759536] Starting subtest: mmap [124.769438] Subtest mmap: SUCCESS (0.011s) [124.807804] [154/171] (879s left) vgem_basic (second-client) [124.874624] Starting subtest: second-client [124.924567] Subtest second-client: SUCCESS (0.050s) [124.972476] [155/171] (879s left) vgem_basic (sysfs) [125.041819] Starting subtest: sysfs [125.042852] Subtest sysfs: SUCCESS (0.001s) [125.087715] [156/171] (879s left) core_hotunplug (unbind-rebind) [125.174290] Starting subtest: unbind-rebind [126.003887] Subtest unbind-rebind: SUCCESS (0.830s) [126.019927] [157/171] (878s left) vgem_basic (unload) [126.082237] Starting subtest: unload [154.833609] Subtest unload: SUCCESS (28.750s) [154.914357] [158/171] (849s left) i915_module_load (reload) [154.975101] Starting subtest: reload [156.624787] Subtest reload: SUCCESS (1.650s) [156.645098] [159/171] (847s left) gem_lmem_swapping (basic) [156.723284] Subtest basic: SKIP (0.000s) [156.750148] [160/171] (847s left) gem_lmem_swapping (parallel-random-engines) [156.809451] Subtest parallel-random-engines: SKIP (0.000s) [156.833048] [161/171] (847s left) gem_lmem_swapping (random-engines) [156.890912] Subtest random-engines: SKIP (0.000s) [156.917888] [162/171] (847s left) gem_lmem_swapping (verify-random) [156.978666] Subtest verify-random: SKIP (0.000s) [156.999935] [163/171] (847s left) i915_pm_rpm (module-reload) [158.733448] Starting subtest: module-reload [164.918322] Subtest module-reload: SUCCESS (6.184s) [164.931978] [164/171] (839s left) i915_selftest (live) [164.997921] Starting subtest: live [164.999126] Starting dynamic subtest: sanitycheck [165.555319] Dynamic subtest sanitycheck: SUCCESS (0.556s) [165.560761] Starting dynamic subtest: uncore [166.020102] Dynamic subtest uncore: SUCCESS (0.464s) [166.025390] Starting dynamic subtest: workarounds [166.567987] Dynamic subtest workarounds: SUCCESS (0.548s) [166.573348] Starting dynamic subtest: gt_engines [167.084854] Dynamic subtest gt_engines: SUCCESS (0.516s) [167.092298] Starting dynamic subtest: gt_timelines [172.502718] Dynamic subtest gt_timelines: SUCCESS (5.417s) [172.509845] Starting dynamic subtest: gt_contexts [173.033917] Dynamic subtest gt_contexts: SUCCESS (0.531s) [173.039272] Starting dynamic subtest: gt_lrc [173.530947] Dynamic subtest gt_lrc: SUCCESS (0.497s) [173.538223] Starting dynamic subtest: gt_mocs [174.099890] Dynamic subtest gt_mocs: SUCCESS (0.568s) [174.105532] Starting dynamic subtest: gt_pm [184.611507] Dynamic subtest gt_pm: SUCCESS (10.511s) [184.617073] Starting dynamic subtest: gt_heartbeat [185.344390] Dynamic subtest gt_heartbeat: SUCCESS (0.732s) [185.349781] Starting dynamic subtest: requests [191.584430] Dynamic subtest requests: SUCCESS (6.240s) [191.590018] Starting dynamic subtest: migrate [192.096313] Dynamic subtest migrate: SUCCESS (0.511s) [192.102778] Starting dynamic subtest: active [192.606097] Dynamic subtest active: SUCCESS (0.508s) [192.612247] Starting dynamic subtest: objects [193.526070] Dynamic subtest objects: SUCCESS (0.919s) [193.531418] Starting dynamic subtest: mman [197.408312] Dynamic subtest mman: SUCCESS (3.882s) [197.414046] Starting dynamic subtest: dmabuf [197.933919] Dynamic subtest dmabuf: SUCCESS (0.525s) [197.939065] Starting dynamic subtest: vma [198.547279] Dynamic subtest vma: SUCCESS (0.613s) [198.554229] Starting dynamic subtest: coherency [200.020332] Dynamic subtest coherency: SUCCESS (1.473s) [200.026546] Starting dynamic subtest: gtt [204.006011] Dynamic subtest gtt: SUCCESS (3.985s) [204.011398] Starting dynamic subtest: gem [204.778082] Dynamic subtest gem: SUCCESS (0.772s) [204.783802] Starting dynamic subtest: evict [205.328280] Dynamic subtest evict: SUCCESS (0.550s) [205.333569] Starting dynamic subtest: hugepages [206.426122] Dynamic subtest hugepages: SUCCESS (1.097s) [206.432803] Starting dynamic subtest: gem_contexts [211.224245] Dynamic subtest gem_contexts: SUCCESS (4.798s) [211.229715] Starting dynamic subtest: client [211.705041] Dynamic subtest client: SUCCESS (0.480s) [211.710462] Starting dynamic subtest: gem_migrate [212.325694] Dynamic subtest gem_migrate: SUCCESS (0.620s) [212.331352] Starting dynamic subtest: reset [213.974156] Dynamic subtest reset: SUCCESS (1.648s) [213.979599] Starting dynamic subtest: memory_region [214.450999] Dynamic subtest memory_region: SUCCESS (0.476s) [214.456229] Starting dynamic subtest: hangcheck [231.670079] Dynamic subtest hangcheck: SUCCESS (17.218s) [231.675402] Starting dynamic subtest: execlists [232.234390] Dynamic subtest execlists: SUCCESS (0.564s) [232.239631] Starting dynamic subtest: ring_submission [232.744477] Dynamic subtest ring_submission: SUCCESS (0.510s) [232.749907] Starting dynamic subtest: perf [233.335445] Dynamic subtest perf: SUCCESS (0.590s) [233.341147] Starting dynamic subtest: slpc [233.898456] Dynamic subtest slpc: SUCCESS (0.562s) [233.903713] Starting dynamic subtest: guc [234.399355] Dynamic subtest guc: SUCCESS (0.500s) [234.405555] Starting dynamic subtest: guc_multi_lrc [234.900014] Dynamic subtest guc_multi_lrc: SUCCESS (0.500s) [234.909922] Starting dynamic subtest: guc_hang [235.456594] Dynamic subtest guc_hang: SUCCESS (0.556s) [235.461997] Starting dynamic subtest: late_gt_pm [235.927089] Dynamic subtest late_gt_pm: SUCCESS (0.470s) [235.928023] Subtest live: SUCCESS (70.929s) [235.990112] [165/171] (768s left) dmabuf (all-tests) [236.053950] Starting subtest: all-tests [236.057314] Starting dynamic subtest: sanitycheck [236.080892] Dynamic subtest sanitycheck: SUCCESS (0.026s) [236.088216] Starting dynamic subtest: dma_fence [236.220783] Dynamic subtest dma_fence: SUCCESS (0.139s) [236.227869] Starting dynamic subtest: dma_fence_chain [247.816522] Dynamic subtest dma_fence_chain: SUCCESS (11.595s) [247.822766] Starting dynamic subtest: dma_fence_unwrap [247.838139] Dynamic subtest dma_fence_unwrap: SUCCESS (0.021s) [247.844230] Starting dynamic subtest: dma_resv [247.872063] Dynamic subtest dma_resv: SUCCESS (0.033s) [247.873133] Subtest all-tests: SUCCESS (11.818s) [247.884305] [166/171] (756s left) i915_suspend (basic-s2idle-without-i915) [247.939783] Starting subtest: basic-s2idle-without-i915 [265.121246] Subtest basic-s2idle-without-i915: SUCCESS (1.757s) [272.247314] [167/171] (754s left) i915_suspend (basic-s3-without-i915) [272.304461] Starting subtest: basic-s3-without-i915 [290.166955] Subtest basic-s3-without-i915: SUCCESS (1.893s) [296.261345] [168/171] (752s left) gem_exec_suspend (basic-s0) [296.331461] Starting subtest: basic-S0 [296.332462] Starting dynamic subtest: smem [313.025636] Dynamic subtest smem: SUCCESS (1.230s) [313.026643] Subtest basic-S0: SUCCESS (1.231s) [319.159696] [169/171] (751s left) gem_exec_suspend (basic-s3) [319.223985] Starting subtest: basic-S3 [319.225128] Starting dynamic subtest: smem [337.055453] Dynamic subtest smem: SUCCESS (1.296s) [337.056682] Subtest basic-S3: SUCCESS (1.296s) [344.202198] [170/171] (749s left) kms_chamelium_hpd (common-hpd-after-suspend) [344.317021] Subtest common-hpd-after-suspend: SKIP (0.000s) [344.399900] [171/171] (749s left) kms_pipe_crc_basic (suspend-read-crc) [344.480806] Starting subtest: suspend-read-crc [344.481829] Starting dynamic subtest: pipe-A-VGA-1 [362.216793] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.447s) [362.224731] Starting dynamic subtest: pipe-B-VGA-1 [380.225645] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.467s) [380.235110] Starting dynamic subtest: pipe-C-VGA-1 [398.228807] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.480s) [398.229958] Subtest suspend-read-crc: SUCCESS (4.399s) [401.177053] Closing watchdogs Done.