[48.123275] Initializing watchdogs [48.123371] /dev/watchdog0 [48.129350] [001/165] (960s left) i915_module_load (load) [48.327306] Starting subtest: load [49.245580] Subtest load: SUCCESS (0.918s) [49.270830] [002/165] (959s left) core_auth (basic-auth) [49.341443] Starting subtest: basic-auth [49.342363] Subtest basic-auth: SUCCESS (0.001s) [49.393616] [003/165] (959s left) debugfs_test (read_all_entries) [49.439925] Starting subtest: read_all_entries [49.479233] Subtest read_all_entries: SUCCESS (0.038s) [49.555529] [004/165] (959s left) debugfs_test (basic-hwmon) [49.601403] Starting subtest: basic-hwmon [49.603420] Subtest basic-hwmon: SKIP (0.000s) [49.672241] [005/165] (959s left) fbdev (eof) [49.728015] Starting subtest: eof [49.729154] Subtest eof: SUCCESS (0.000s) [49.773268] [006/165] (958s left) fbdev (info) [49.818165] Starting subtest: info [49.819254] Subtest info: SUCCESS (0.000s) [49.872888] [007/165] (958s left) fbdev (nullptr) [49.927905] Starting subtest: nullptr [49.929295] Subtest nullptr: SUCCESS (0.000s) [49.973439] [008/165] (958s left) fbdev (read) [50.027421] Starting subtest: read [50.108998] Subtest read: SUCCESS (0.081s) [50.156070] [009/165] (958s left) fbdev (write) [50.213314] Starting subtest: write [50.255729] Subtest write: SUCCESS (0.044s) [50.290909] [010/165] (958s left) gem_basic (bad-close) [50.339237] Starting subtest: bad-close [50.341378] Subtest bad-close: SUCCESS (0.000s) [50.391313] [011/165] (958s left) gem_basic (create-close) [50.436019] Starting subtest: create-close [50.438125] Subtest create-close: SUCCESS (0.000s) [50.505463] [012/165] (958s left) gem_basic (create-fd-close) [50.553319] Starting subtest: create-fd-close [50.555600] Subtest create-fd-close: SUCCESS (0.000s) [50.622589] [013/165] (958s left) gem_busy (busy@all-engines) [50.677914] Starting subtest: busy [50.679015] Starting dynamic subtest: all-engines [50.704350] Dynamic subtest all-engines: SUCCESS (0.026s) [50.705444] Subtest busy: SUCCESS (0.027s) [51.022327] [014/165] (957s left) gem_close_race (basic-process) [51.075284] Starting subtest: basic-process [51.107444] Subtest basic-process: SUCCESS (0.031s) [51.278463] [015/165] (957s left) gem_close_race (basic-threads) [51.332701] Starting subtest: basic-threads [52.528539] Subtest basic-threads: SUCCESS (1.195s) [52.695292] [016/165] (956s left) gem_ctx_create (basic) [52.746375] Starting subtest: basic [52.747473] Subtest basic: SUCCESS (0.000s) [52.908131] [017/165] (955s left) gem_ctx_create (basic-files) [52.958721] Starting subtest: basic-files [54.972336] Subtest basic-files: SUCCESS (2.014s) [55.226648] [018/165] (953s left) gem_ctx_exec (basic) [55.274146] Starting subtest: basic [55.276542] Subtest basic: SUCCESS (0.003s) [55.355834] [019/165] (953s left) gem_exec_basic (basic) [55.402916] Starting subtest: basic [55.404052] Starting dynamic subtest: rcs0-smem [55.405260] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.410912] Starting dynamic subtest: bcs0-smem [55.412047] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [55.417934] Starting dynamic subtest: vcs0-smem [55.419044] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [55.425347] Starting dynamic subtest: vecs0-smem [55.426471] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [55.427700] Subtest basic: SUCCESS (0.002s) [55.573898] [020/165] (953s left) gem_exec_create (basic) [55.623786] Starting subtest: basic [55.624871] Starting dynamic subtest: smem [57.667339] Dynamic subtest smem: SUCCESS (2.043s) [57.668677] Subtest basic: SUCCESS (2.043s) [57.824100] [021/165] (951s left) gem_exec_fence (basic-busy) [57.988841] Starting subtest: basic-busy [57.990085] Starting dynamic subtest: rcs0 [58.024764] Dynamic subtest rcs0: SUCCESS (0.035s) [58.030294] Starting dynamic subtest: bcs0 [58.045173] Dynamic subtest bcs0: SUCCESS (0.022s) [58.051806] Starting dynamic subtest: vcs0 [58.072157] Dynamic subtest vcs0: SUCCESS (0.027s) [58.077700] Starting dynamic subtest: vecs0 [58.086249] Dynamic subtest vecs0: SUCCESS (0.014s) [58.087422] Subtest basic-busy: SUCCESS (0.098s) [58.539735] [022/165] (950s left) gem_exec_fence (basic-wait) [58.706263] Starting subtest: basic-wait [58.709566] Starting dynamic subtest: rcs0 [58.734638] Dynamic subtest rcs0: SUCCESS (0.028s) [58.741530] Starting dynamic subtest: bcs0 [58.765735] Dynamic subtest bcs0: SUCCESS (0.031s) [58.773130] Starting dynamic subtest: vcs0 [58.790641] Dynamic subtest vcs0: SUCCESS (0.025s) [58.796951] Starting dynamic subtest: vecs0 [58.818643] Dynamic subtest vecs0: SUCCESS (0.028s) [58.819870] Subtest basic-wait: SUCCESS (0.112s) [59.237483] [023/165] (949s left) gem_exec_fence (basic-await) [59.398943] Starting subtest: basic-await [59.399996] Starting dynamic subtest: rcs0 [59.471325] Dynamic subtest rcs0: SUCCESS (0.072s) [59.477033] Starting dynamic subtest: bcs0 [59.543035] Dynamic subtest bcs0: SUCCESS (0.071s) [59.550296] Starting dynamic subtest: vcs0 [59.615359] Dynamic subtest vcs0: SUCCESS (0.073s) [59.621363] Starting dynamic subtest: vecs0 [59.687889] Dynamic subtest vecs0: SUCCESS (0.072s) [59.688938] Subtest basic-await: SUCCESS (0.288s) [60.121135] [024/165] (948s left) gem_exec_fence (nb-await) [60.285183] Starting subtest: nb-await [60.286332] Starting dynamic subtest: rcs0 [60.340129] Dynamic subtest rcs0: SUCCESS (0.054s) [60.346377] Starting dynamic subtest: bcs0 [60.393726] Dynamic subtest bcs0: SUCCESS (0.054s) [60.400360] Starting dynamic subtest: vcs0 [60.447351] Dynamic subtest vcs0: SUCCESS (0.054s) [60.452774] Starting dynamic subtest: vecs0 [60.499282] Dynamic subtest vecs0: SUCCESS (0.052s) [60.500609] Subtest nb-await: SUCCESS (0.215s) [60.922140] [025/165] (948s left) gem_exec_gttfill (basic) [60.973564] Starting subtest: basic [64.220892] Subtest basic: SUCCESS (3.247s) [64.389509] [026/165] (944s left) gem_exec_parallel (engines) [64.505625] Starting subtest: engines [64.506765] Starting dynamic subtest: basic [65.842140] Dynamic subtest basic: SUCCESS (1.336s) [65.849262] Starting dynamic subtest: contexts [67.320878] Dynamic subtest contexts: SUCCESS (1.479s) [67.327522] Starting dynamic subtest: fds [68.997619] Dynamic subtest fds: SUCCESS (1.677s) [69.004303] Starting dynamic subtest: userptr [70.367411] Dynamic subtest userptr: SUCCESS (1.370s) [70.368813] Subtest engines: SUCCESS (5.862s) [70.543888] [027/165] (938s left) gem_exec_store (basic) [70.596912] Starting subtest: basic [70.633875] Subtest basic: SUCCESS (0.036s) [70.805293] [028/165] (938s left) gem_flink_basic (bad-flink) [70.849316] Starting subtest: bad-flink [70.850360] Subtest bad-flink: SUCCESS (0.000s) [70.902327] [029/165] (938s left) gem_flink_basic (bad-open) [70.945866] Starting subtest: bad-open [70.946908] Subtest bad-open: SUCCESS (0.000s) [71.003039] [030/165] (938s left) gem_flink_basic (basic) [71.046206] Starting subtest: basic [71.047279] Subtest basic: SUCCESS (0.000s) [71.118442] [031/165] (937s left) gem_flink_basic (double-flink) [71.162908] Starting subtest: double-flink [71.163956] Subtest double-flink: SUCCESS (0.000s) [71.238687] [032/165] (937s left) gem_flink_basic (flink-lifetime) [71.285013] Starting subtest: flink-lifetime [71.286201] Subtest flink-lifetime: SUCCESS (0.001s) [71.353149] [033/165] (937s left) gem_huc_copy (huc-copy) [71.399931] Subtest huc-copy: SKIP (0.000s) [71.431181] [034/165] (937s left) gem_linear_blits (basic) [71.542054] Starting subtest: basic [71.548245] Subtest basic: SUCCESS (0.006s) [71.644249] [035/165] (937s left) gem_mmap (basic) [71.757474] Starting subtest: basic [71.762859] Subtest basic: SUCCESS (0.000s) [71.818502] [036/165] (937s left) gem_mmap_gtt (basic) [71.861154] Starting subtest: basic [71.862230] Subtest basic: SUCCESS (0.000s) [71.913313] [037/165] (937s left) gem_render_linear_blits (basic) [71.956806] Starting subtest: basic [71.972507] Subtest basic: SUCCESS (0.016s) [72.016537] [038/165] (937s left) gem_render_tiled_blits (basic) [72.065385] Starting subtest: basic [72.083328] Subtest basic: SUCCESS (0.018s) [72.134084] [039/165] (937s left) gem_ringfill (basic-all) [72.301956] Starting subtest: basic-all [73.410130] Subtest basic-all: SUCCESS (1.108s) [73.487341] [040/165] (935s left) gem_softpin (allocator-basic) [73.538216] Subtest allocator-basic: SKIP (0.000s) [73.585993] [041/165] (935s left) gem_softpin (allocator-basic-reserve) [73.635272] Subtest allocator-basic-reserve: SKIP (0.000s) [73.685404] [042/165] (935s left) gem_softpin (safe-alignment) [73.735512] Starting subtest: safe-alignment [73.743935] Subtest safe-alignment: SUCCESS (0.010s) [73.820228] [043/165] (935s left) gem_sync (basic-all) [73.873344] Starting subtest: basic-all [76.005133] Subtest basic-all: SUCCESS (2.131s) [76.169533] [044/165] (933s left) gem_sync (basic-each) [76.221321] Starting subtest: basic-each [78.312636] Subtest basic-each: SUCCESS (2.091s) [78.484316] [045/165] (930s left) gem_tiled_blits (basic) [78.591872] Starting subtest: basic [78.602405] Subtest basic: SUCCESS (0.011s) [78.712296] [046/165] (930s left) gem_tiled_fence_blits (basic) [78.883208] Starting subtest: basic [78.889452] Subtest basic: SUCCESS (0.006s) [78.992924] [047/165] (930s left) gem_tiled_pread_basic [79.269471] [048/165] (930s left) gem_wait (busy@all-engines) [79.324818] Starting subtest: busy [79.325974] Starting dynamic subtest: all-engines [79.838635] Dynamic subtest all-engines: SUCCESS (0.513s) [79.840603] Subtest busy: SUCCESS (0.514s) [80.021526] [049/165] (929s left) gem_wait (wait@all-engines) [80.082085] Starting subtest: wait [80.083207] Starting dynamic subtest: all-engines [81.095186] Dynamic subtest all-engines: SUCCESS (1.014s) [81.096227] Subtest wait: SUCCESS (1.014s) [81.266562] [050/165] (928s left) i915_getparams_basic (basic-eu-total) [81.312340] Starting subtest: basic-eu-total [81.314427] Subtest basic-eu-total: SUCCESS (0.000s) [81.366896] [051/165] (928s left) i915_getparams_basic (basic-subslice-total) [81.413209] Starting subtest: basic-subslice-total [81.415296] Subtest basic-subslice-total: SUCCESS (0.000s) [81.466352] [052/165] (927s left) i915_hangman (error-state-basic) [81.519197] Starting subtest: error-state-basic [81.526274] Subtest error-state-basic: SUCCESS (0.007s) [81.585665] [053/165] (927s left) i915_pciid [81.683407] [054/165] (927s left) kms_addfb_basic (addfb25-4-tiled) [81.753152] Starting subtest: addfb25-4-tiled [81.754211] Subtest addfb25-4-tiled: SUCCESS (0.000s) [81.834248] [055/165] (927s left) kms_addfb_basic (addfb25-bad-modifier) [81.882049] Starting subtest: addfb25-bad-modifier [81.883054] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [81.986782] [056/165] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [82.031551] Starting subtest: addfb25-framebuffer-vs-set-tiling [82.032558] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [82.116390] [057/165] (927s left) kms_addfb_basic (addfb25-modifier-no-flag) [82.162063] Starting subtest: addfb25-modifier-no-flag [82.163150] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [82.251609] [058/165] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy) [82.296942] Starting subtest: addfb25-x-tiled-legacy [82.297970] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [82.404395] [059/165] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [82.451019] Starting subtest: addfb25-x-tiled-mismatch-legacy [82.452036] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [82.551140] [060/165] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [82.615939] Starting subtest: addfb25-yf-tiled-legacy [82.617094] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [82.683936] [061/165] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [82.750361] Starting subtest: addfb25-y-tiled-legacy [82.751442] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [82.816262] [062/165] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [82.883564] Starting subtest: addfb25-y-tiled-small-legacy [82.885593] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [82.949297] [063/165] (926s left) kms_addfb_basic (bad-pitch-0) [82.994492] Starting subtest: bad-pitch-0 [82.995598] Subtest bad-pitch-0: SUCCESS (0.000s) [83.083232] [064/165] (926s left) kms_addfb_basic (bad-pitch-1024) [83.126402] Starting subtest: bad-pitch-1024 [83.127428] Subtest bad-pitch-1024: SUCCESS (0.000s) [83.217351] [065/165] (926s left) kms_addfb_basic (bad-pitch-128) [83.263311] Starting subtest: bad-pitch-128 [83.264396] Subtest bad-pitch-128: SUCCESS (0.000s) [83.366610] [066/165] (926s left) kms_addfb_basic (bad-pitch-256) [83.413303] Starting subtest: bad-pitch-256 [83.414323] Subtest bad-pitch-256: SUCCESS (0.000s) [83.517797] [067/165] (926s left) kms_addfb_basic (bad-pitch-32) [83.563313] Starting subtest: bad-pitch-32 [83.564367] Subtest bad-pitch-32: SUCCESS (0.000s) [83.649320] [068/165] (925s left) kms_addfb_basic (bad-pitch-63) [83.691838] Starting subtest: bad-pitch-63 [83.692855] Subtest bad-pitch-63: SUCCESS (0.000s) [83.783047] [069/165] (925s left) kms_addfb_basic (bad-pitch-65536) [83.827695] Starting subtest: bad-pitch-65536 [83.828813] Subtest bad-pitch-65536: SUCCESS (0.000s) [83.918415] [070/165] (925s left) kms_addfb_basic (bad-pitch-999) [83.963355] Starting subtest: bad-pitch-999 [83.964462] Subtest bad-pitch-999: SUCCESS (0.000s) [84.051771] [071/165] (925s left) kms_addfb_basic (basic) [84.100205] Starting subtest: basic [84.101272] Subtest basic: SUCCESS (0.000s) [84.200155] [072/165] (925s left) kms_addfb_basic (basic-x-tiled-legacy) [84.245469] Starting subtest: basic-x-tiled-legacy [84.246455] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [84.332913] [073/165] (925s left) kms_addfb_basic (basic-y-tiled-legacy) [84.377490] Starting subtest: basic-y-tiled-legacy [84.378605] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [84.469461] [074/165] (925s left) kms_addfb_basic (bo-too-small) [84.536493] Starting subtest: bo-too-small [84.537580] Subtest bo-too-small: SUCCESS (0.000s) [84.616094] [075/165] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling) [84.682519] Starting subtest: bo-too-small-due-to-tiling [84.683546] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [84.749729] [076/165] (924s left) kms_addfb_basic (clobberred-modifier) [84.793540] Starting subtest: clobberred-modifier [84.794544] Subtest clobberred-modifier: SUCCESS (0.000s) [84.884331] [077/165] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling) [84.930904] Starting subtest: framebuffer-vs-set-tiling [84.931927] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [85.015707] [078/165] (924s left) kms_addfb_basic (invalid-get-prop) [85.060104] Starting subtest: invalid-get-prop [85.061145] Subtest invalid-get-prop: SUCCESS (0.000s) [85.149742] [079/165] (924s left) kms_addfb_basic (invalid-get-prop-any) [85.195568] Starting subtest: invalid-get-prop-any [85.196574] Subtest invalid-get-prop-any: SUCCESS (0.000s) [85.283908] [080/165] (924s left) kms_addfb_basic (invalid-set-prop) [85.328879] Starting subtest: invalid-set-prop [85.330025] Subtest invalid-set-prop: SUCCESS (0.000s) [85.417774] [081/165] (924s left) kms_addfb_basic (invalid-set-prop-any) [85.462017] Starting subtest: invalid-set-prop-any [85.463145] Subtest invalid-set-prop-any: SUCCESS (0.000s) [85.549307] [082/165] (924s left) kms_addfb_basic (no-handle) [85.595443] Starting subtest: no-handle [85.596655] Subtest no-handle: SUCCESS (0.000s) [85.683726] [083/165] (924s left) kms_addfb_basic (size-max) [85.757416] Starting subtest: size-max [85.758542] Subtest size-max: SUCCESS (0.000s) [85.836007] [084/165] (924s left) kms_addfb_basic (small-bo) [85.910341] Starting subtest: small-bo [85.911361] Subtest small-bo: SUCCESS (0.000s) [85.985466] [085/165] (923s left) kms_addfb_basic (tile-pitch-mismatch) [86.031142] Starting subtest: tile-pitch-mismatch [86.032155] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [86.115341] [086/165] (923s left) kms_addfb_basic (too-high) [86.180285] Starting subtest: too-high [86.181346] Subtest too-high: SUCCESS (0.000s) [86.250069] [087/165] (923s left) kms_addfb_basic (too-wide) [86.316536] Starting subtest: too-wide [86.317568] Subtest too-wide: SUCCESS (0.000s) [86.386679] [088/165] (923s left) kms_addfb_basic (unused-handle) [86.430455] Starting subtest: unused-handle [86.431505] Subtest unused-handle: SUCCESS (0.000s) [86.532122] [089/165] (923s left) kms_addfb_basic (unused-modifier) [86.574869] Starting subtest: unused-modifier [86.575875] Subtest unused-modifier: SUCCESS (0.000s) [86.665167] [090/165] (923s left) kms_addfb_basic (unused-offsets) [86.715974] Starting subtest: unused-offsets [86.718728] Subtest unused-offsets: SUCCESS (0.000s) [86.818244] [091/165] (923s left) kms_addfb_basic (unused-pitches) [86.863541] Starting subtest: unused-pitches [86.864625] Subtest unused-pitches: SUCCESS (0.000s) [86.964783] [092/165] (923s left) kms_busy (basic) [87.032190] Starting subtest: basic [87.033299] Starting dynamic subtest: flip [87.492481] Dynamic subtest flip: SUCCESS (0.459s) [87.499234] Starting dynamic subtest: modeset [88.004598] Dynamic subtest modeset: SUCCESS (0.512s) [88.005716] Subtest basic: SUCCESS (0.972s) [88.139525] [093/165] (921s left) kms_prop_blob (basic) [88.189317] Starting subtest: basic [88.190377] Subtest basic: SUCCESS (0.000s) [88.238511] [094/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [88.308517] Starting subtest: basic-busy-flip-before-cursor-atomic [89.227886] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.919s) [89.361164] [095/165] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [89.428443] Starting subtest: basic-busy-flip-before-cursor-legacy [90.366337] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.939s) [90.499800] [096/165] (919s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [90.565689] Starting subtest: basic-flip-after-cursor-atomic [91.485028] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.919s) [91.619402] [097/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [91.685949] Starting subtest: basic-flip-after-cursor-legacy [92.606866] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.921s) [92.745500] [098/165] (917s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [92.813793] Starting subtest: basic-flip-after-cursor-varying-size [93.735840] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.922s) [93.871547] [099/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [93.938899] Starting subtest: basic-flip-before-cursor-atomic [94.858969] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.920s) [94.997381] [100/165] (915s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [95.065370] Starting subtest: basic-flip-before-cursor-legacy [96.000721] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.935s) [96.131978] [101/165] (914s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [96.200118] Starting subtest: basic-flip-before-cursor-varying-size [97.122769] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.923s) [97.255740] [102/165] (912s left) kms_dsc (dsc-basic) [97.323566] Subtest dsc-basic: SKIP (0.000s) [97.345714] [103/165] (912s left) kms_flip (basic-flip-vs-dpms) [97.401164] Starting subtest: basic-flip-vs-dpms [97.403241] Starting dynamic subtest: A-VGA1 [98.248393] Dynamic subtest A-VGA1: SUCCESS (0.845s) [98.255670] Starting dynamic subtest: B-VGA1 [99.043107] Dynamic subtest B-VGA1: SUCCESS (0.795s) [99.051225] Starting dynamic subtest: C-VGA1 [99.844149] Dynamic subtest C-VGA1: SUCCESS (0.801s) [99.845175] Subtest basic-flip-vs-dpms: SUCCESS (2.444s) [99.981390] [104/165] (910s left) kms_flip (basic-flip-vs-modeset) [100.039484] Starting subtest: basic-flip-vs-modeset [100.041563] Starting dynamic subtest: A-VGA1 [100.914292] Dynamic subtest A-VGA1: SUCCESS (0.872s) [100.921103] Starting dynamic subtest: B-VGA1 [101.719887] Dynamic subtest B-VGA1: SUCCESS (0.806s) [101.727329] Starting dynamic subtest: C-VGA1 [102.525102] Dynamic subtest C-VGA1: SUCCESS (0.804s) [102.526143] Subtest basic-flip-vs-modeset: SUCCESS (2.487s) [102.668329] [105/165] (907s left) kms_flip (basic-flip-vs-wf_vblank) [102.726707] Starting subtest: basic-flip-vs-wf_vblank [102.727761] Starting dynamic subtest: A-VGA1 [103.875464] Dynamic subtest A-VGA1: SUCCESS (1.148s) [103.882220] Starting dynamic subtest: B-VGA1 [105.001228] Dynamic subtest B-VGA1: SUCCESS (1.125s) [105.009219] Starting dynamic subtest: C-VGA1 [106.126754] Dynamic subtest C-VGA1: SUCCESS (1.124s) [106.129211] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.404s) [106.314823] [106/165] (903s left) kms_flip (basic-plain-flip) [106.374861] Starting subtest: basic-plain-flip [106.376092] Starting dynamic subtest: A-VGA1 [107.240805] Dynamic subtest A-VGA1: SUCCESS (0.866s) [107.249462] Starting dynamic subtest: B-VGA1 [108.081893] Dynamic subtest B-VGA1: SUCCESS (0.840s) [108.091451] Starting dynamic subtest: C-VGA1 [108.923260] Dynamic subtest C-VGA1: SUCCESS (0.839s) [108.925427] Subtest basic-plain-flip: SUCCESS (2.553s) [109.112702] [107/165] (901s left) kms_force_connector_basic (force-connector-state) [109.169247] Starting subtest: force-connector-state [109.303324] Subtest force-connector-state: SUCCESS (0.133s) [109.481627] [108/165] (900s left) kms_force_connector_basic (force-edid) [109.538103] Starting subtest: force-edid [109.550413] Subtest force-edid: SUCCESS (0.016s) [109.649432] [109/165] (900s left) kms_force_connector_basic (force-load-detect) [109.706379] Starting subtest: force-load-detect [109.849808] Subtest force-load-detect: SUCCESS (0.144s) [110.033899] [110/165] (900s left) kms_force_connector_basic (prune-stale-modes) [110.087762] Starting subtest: prune-stale-modes [110.104433] Subtest prune-stale-modes: SUCCESS (0.017s) [110.203696] [111/165] (900s left) kms_frontbuffer_tracking (basic) [110.278233] Starting subtest: basic [112.103348] Subtest basic: SUCCESS (1.828s) [112.167079] [112/165] (898s left) kms_hdmi_inject (inject-audio) [112.259909] Starting subtest: inject-audio [112.356848] Subtest inject-audio: SUCCESS (0.099s) [112.553533] [113/165] (897s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [112.621272] Starting subtest: compare-crc-sanitycheck-xr24 [112.622358] Starting dynamic subtest: pipe-A-VGA-1 [112.892494] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.270s) [112.899776] Starting dynamic subtest: pipe-B-VGA-1 [113.157343] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.265s) [113.168138] Starting dynamic subtest: pipe-C-VGA-1 [113.421316] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.263s) [113.422415] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.801s) [113.554023] [114/165] (896s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [113.624746] Starting subtest: compare-crc-sanitycheck-nv12 [113.625803] Starting dynamic subtest: pipe-A-VGA-1 [113.627943] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [113.635164] Starting dynamic subtest: pipe-B-VGA-1 [113.637266] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [113.644278] Starting dynamic subtest: pipe-C-VGA-1 [113.646421] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [113.648550] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s) [113.685650] [115/165] (896s left) kms_pipe_crc_basic (hang-read-crc) [113.751612] Starting subtest: hang-read-crc [113.752679] Starting dynamic subtest: pipe-A-VGA-1 [114.488301] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.735s) [114.495401] Starting dynamic subtest: pipe-B-VGA-1 [115.213422] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.724s) [115.220428] Starting dynamic subtest: pipe-C-VGA-1 [115.942491] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.728s) [115.943574] Subtest hang-read-crc: SUCCESS (2.190s) [116.061743] [116/165] (894s left) kms_pipe_crc_basic (nonblocking-crc) [116.135356] Starting subtest: nonblocking-crc [116.136376] Starting dynamic subtest: pipe-A-VGA-1 [116.567171] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.430s) [116.574112] Starting dynamic subtest: pipe-B-VGA-1 [116.994202] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s) [117.001144] Starting dynamic subtest: pipe-C-VGA-1 [117.423432] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.429s) [117.424552] Subtest nonblocking-crc: SUCCESS (1.289s) [117.540507] [117/165] (892s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [117.607323] Starting subtest: nonblocking-crc-frame-sequence [117.608391] Starting dynamic subtest: pipe-A-VGA-1 [118.048048] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.439s) [118.055096] Starting dynamic subtest: pipe-B-VGA-1 [118.483032] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.434s) [118.490057] Starting dynamic subtest: pipe-C-VGA-1 [118.912160] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.427s) [118.913262] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.305s) [119.030779] [118/165] (891s left) kms_pipe_crc_basic (read-crc) [119.097220] Starting subtest: read-crc [119.098284] Starting dynamic subtest: pipe-A-VGA-1 [119.470096] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.371s) [119.477201] Starting dynamic subtest: pipe-B-VGA-1 [119.829370] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.359s) [119.836431] Starting dynamic subtest: pipe-C-VGA-1 [120.189937] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.360s) [120.190984] Subtest read-crc: SUCCESS (1.094s) [120.307956] [119/165] (890s left) kms_pipe_crc_basic (read-crc-frame-sequence) [120.372486] Starting subtest: read-crc-frame-sequence [120.373561] Starting dynamic subtest: pipe-A-VGA-1 [120.749752] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.376s) [120.758567] Starting dynamic subtest: pipe-B-VGA-1 [121.117749] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.366s) [121.124699] Starting dynamic subtest: pipe-C-VGA-1 [121.479378] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.361s) [121.480463] Subtest read-crc-frame-sequence: SUCCESS (1.107s) [121.600793] [120/165] (888s left) kms_pm_backlight (basic-brightness) [121.669979] Subtest basic-brightness: SKIP (0.000s) [121.692197] [121/165] (888s left) kms_pm_rpm (basic-pci-d3-state) [123.040821] Starting subtest: basic-pci-d3-state [123.227730] Subtest basic-pci-d3-state: SUCCESS (0.186s) [123.474168] [122/165] (886s left) kms_pm_rpm (basic-rte) [123.520335] Starting subtest: basic-rte [125.036058] Subtest basic-rte: SUCCESS (1.513s) [125.581267] [123/165] (884s left) kms_psr (primary_page_flip) [125.632150] Subtest primary_page_flip: SKIP (0.000s) [125.657938] [124/165] (884s left) kms_psr (cursor_plane_move) [125.701405] Subtest cursor_plane_move: SKIP (0.000s) [125.724298] [125/165] (884s left) kms_psr (sprite_plane_onoff) [125.769476] Subtest sprite_plane_onoff: SKIP (0.000s) [125.791064] [126/165] (884s left) kms_psr (primary_mmap_gtt) [125.835342] Subtest primary_mmap_gtt: SKIP (0.000s) [125.861587] [127/165] (884s left) kms_setmode (basic-clone-single-crtc) [125.906020] Starting subtest: basic-clone-single-crtc [125.909210] Subtest basic-clone-single-crtc: SKIP (0.000s) [125.962524] [128/165] (884s left) i915_pm_rps (basic-api) [126.010849] Starting subtest: basic-api [126.013138] Subtest basic-api: SUCCESS (0.002s) [126.079979] [129/165] (884s left) prime_self_import (basic-llseek-bad) [126.124742] Starting subtest: basic-llseek-bad [126.126965] Subtest basic-llseek-bad: SUCCESS (0.001s) [126.200813] [130/165] (884s left) prime_self_import (basic-llseek-size) [126.243961] Starting subtest: basic-llseek-size [126.246163] Subtest basic-llseek-size: SUCCESS (0.002s) [126.312055] [131/165] (884s left) prime_self_import (basic-with_fd_dup) [126.353736] Starting subtest: basic-with_fd_dup [126.355939] Subtest basic-with_fd_dup: SUCCESS (0.002s) [126.430812] [132/165] (884s left) prime_self_import (basic-with_one_bo) [126.476205] Starting subtest: basic-with_one_bo [126.478352] Subtest basic-with_one_bo: SUCCESS (0.002s) [126.523945] [133/165] (884s left) prime_self_import (basic-with_one_bo_two_files) [126.565156] Starting subtest: basic-with_one_bo_two_files [126.567252] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [126.629753] [134/165] (884s left) prime_self_import (basic-with_two_bos) [126.675049] Starting subtest: basic-with_two_bos [126.677197] Subtest basic-with_two_bos: SUCCESS (0.002s) [126.746753] [135/165] (883s left) prime_vgem (basic-fence-flip) [126.802580] Starting subtest: basic-fence-flip [127.132136] Subtest basic-fence-flip: SUCCESS (0.329s) [127.214620] [136/165] (883s left) prime_vgem (basic-fence-mmap) [127.269165] Starting subtest: basic-fence-mmap [127.293181] Subtest basic-fence-mmap: SUCCESS (0.025s) [127.364232] [137/165] (883s left) prime_vgem (basic-fence-read) [127.419797] Starting subtest: basic-fence-read [127.453815] Subtest basic-fence-read: SUCCESS (0.035s) [127.531145] [138/165] (883s left) prime_vgem (basic-gtt) [127.585509] Starting subtest: basic-gtt [127.597685] Subtest basic-gtt: SUCCESS (0.012s) [127.680515] [139/165] (883s left) prime_vgem (basic-read) [127.735472] Starting subtest: basic-read [127.752584] Subtest basic-read: SUCCESS (0.017s) [127.829914] [140/165] (882s left) prime_vgem (basic-write) [127.884907] Starting subtest: basic-write [127.903705] Subtest basic-write: SUCCESS (0.019s) [127.984093] [141/165] (882s left) vgem_basic (setversion) [128.032095] Starting subtest: setversion [128.034442] Subtest setversion: SUCCESS (0.000s) [128.081301] [142/165] (882s left) vgem_basic (create) [128.131934] Starting subtest: create [128.133046] Subtest create: SUCCESS (0.000s) [128.180209] [143/165] (882s left) vgem_basic (debugfs) [128.232131] Starting subtest: debugfs [128.233328] Subtest debugfs: SUCCESS (0.000s) [128.279620] [144/165] (882s left) vgem_basic (dmabuf-export) [128.331952] Starting subtest: dmabuf-export [128.334043] Subtest dmabuf-export: SUCCESS (0.002s) [128.414484] [145/165] (882s left) vgem_basic (dmabuf-fence) [128.465363] Starting subtest: dmabuf-fence [128.466383] Subtest dmabuf-fence: SUCCESS (0.001s) [128.511733] [146/165] (882s left) vgem_basic (dmabuf-fence-before) [128.565438] Starting subtest: dmabuf-fence-before [128.566573] Subtest dmabuf-fence-before: SUCCESS (0.000s) [128.614383] [147/165] (882s left) vgem_basic (dmabuf-mmap) [128.665488] Starting subtest: dmabuf-mmap [128.680147] Subtest dmabuf-mmap: SUCCESS (0.015s) [128.731215] [148/165] (882s left) vgem_basic (mmap) [128.782402] Starting subtest: mmap [128.792093] Subtest mmap: SUCCESS (0.011s) [128.831533] [149/165] (882s left) vgem_basic (second-client) [128.882239] Starting subtest: second-client [128.916195] Subtest second-client: SUCCESS (0.033s) [128.962294] [150/165] (881s left) vgem_basic (sysfs) [129.015364] Starting subtest: sysfs [129.016486] Subtest sysfs: SUCCESS (0.001s) [129.062821] [151/165] (881s left) core_hotunplug (unbind-rebind) [129.149800] Starting subtest: unbind-rebind [132.026515] Subtest unbind-rebind: SUCCESS (2.877s) [132.045167] [152/165] (878s left) vgem_basic (unload) [132.095107] Starting subtest: unload [161.012238] Subtest unload: SUCCESS (28.915s) [161.085425] [153/165] (849s left) i915_module_load (reload) [161.130133] Starting subtest: reload [162.981176] Subtest reload: SUCCESS (1.849s) [163.000104] [154/165] (847s left) gem_lmem_swapping (basic) [163.063717] Subtest basic: SKIP (0.000s) [163.090840] [155/165] (847s left) gem_lmem_swapping (parallel-random-engines) [163.140282] Subtest parallel-random-engines: SKIP (0.000s) [163.173498] [156/165] (847s left) gem_lmem_swapping (random-engines) [163.221167] Subtest random-engines: SKIP (0.000s) [163.240220] [157/165] (847s left) gem_lmem_swapping (verify-random) [163.290829] Subtest verify-random: SKIP (0.000s) [163.322781] [158/165] (847s left) i915_pm_rpm (module-reload) [165.100181] Starting subtest: module-reload [170.990168] Subtest module-reload: SUCCESS (5.890s) [171.005882] [159/165] (840s left) i915_selftest (live) [171.057354] Starting subtest: live [171.058399] Starting dynamic subtest: sanitycheck [171.751147] Dynamic subtest sanitycheck: SUCCESS (0.689s) [171.757146] Starting dynamic subtest: uncore [172.413159] Dynamic subtest uncore: SUCCESS (0.663s) [172.420372] Starting dynamic subtest: workarounds [173.124695] Dynamic subtest workarounds: SUCCESS (0.709s) [173.130960] Starting dynamic subtest: gt_engines [173.844151] Dynamic subtest gt_engines: SUCCESS (0.717s) [173.851512] Starting dynamic subtest: gt_timelines [179.532342] Dynamic subtest gt_timelines: SUCCESS (5.686s) [179.539427] Starting dynamic subtest: gt_contexts [180.180464] Dynamic subtest gt_contexts: SUCCESS (0.646s) [180.188052] Starting dynamic subtest: gt_lrc [180.891459] Dynamic subtest gt_lrc: SUCCESS (0.708s) [180.899255] Starting dynamic subtest: gt_mocs [181.573797] Dynamic subtest gt_mocs: SUCCESS (0.680s) [181.583598] Starting dynamic subtest: gt_pm [192.479200] Dynamic subtest gt_pm: SUCCESS (10.899s) [192.485253] Starting dynamic subtest: gt_heartbeat [193.205873] Dynamic subtest gt_heartbeat: SUCCESS (0.728s) [193.213181] Starting dynamic subtest: gt_tlb [193.826431] Dynamic subtest gt_tlb: SUCCESS (0.618s) [193.834260] Starting dynamic subtest: requests [200.041439] Dynamic subtest requests: SUCCESS (6.212s) [200.049139] Starting dynamic subtest: migrate [200.718870] Dynamic subtest migrate: SUCCESS (0.674s) [200.728065] Starting dynamic subtest: active [201.414856] Dynamic subtest active: SUCCESS (0.693s) [201.423879] Starting dynamic subtest: objects [202.317667] Dynamic subtest objects: SUCCESS (0.900s) [202.324358] Starting dynamic subtest: mman [206.307140] Dynamic subtest mman: SUCCESS (3.988s) [206.315361] Starting dynamic subtest: dmabuf [207.015992] Dynamic subtest dmabuf: SUCCESS (0.707s) [207.023081] Starting dynamic subtest: vma [207.585017] Dynamic subtest vma: SUCCESS (0.567s) [207.590778] Starting dynamic subtest: coherency [208.865838] Dynamic subtest coherency: SUCCESS (1.279s) [208.871779] Starting dynamic subtest: gtt [212.932133] Dynamic subtest gtt: SUCCESS (4.064s) [212.940806] Starting dynamic subtest: gem [213.833074] Dynamic subtest gem: SUCCESS (0.898s) [213.840846] Starting dynamic subtest: evict [214.506881] Dynamic subtest evict: SUCCESS (0.671s) [214.514415] Starting dynamic subtest: hugepages [215.740068] Dynamic subtest hugepages: SUCCESS (1.231s) [215.746374] Starting dynamic subtest: gem_contexts [220.611983] Dynamic subtest gem_contexts: SUCCESS (4.871s) [220.621468] Starting dynamic subtest: client [221.243435] Dynamic subtest client: SUCCESS (0.630s) [221.251343] Starting dynamic subtest: gem_migrate [221.910876] Dynamic subtest gem_migrate: SUCCESS (0.665s) [221.916660] Starting dynamic subtest: reset [223.721540] Dynamic subtest reset: SUCCESS (1.809s) [223.728976] Starting dynamic subtest: memory_region [224.403567] Dynamic subtest memory_region: SUCCESS (0.680s) [224.409839] Starting dynamic subtest: hangcheck [241.819462] Dynamic subtest hangcheck: SUCCESS (17.414s) [241.827157] Starting dynamic subtest: execlists [242.444033] Dynamic subtest execlists: SUCCESS (0.622s) [242.449805] Starting dynamic subtest: ring_submission [243.172988] Dynamic subtest ring_submission: SUCCESS (0.727s) [243.180160] Starting dynamic subtest: perf [243.963204] Dynamic subtest perf: SUCCESS (0.787s) [243.970170] Starting dynamic subtest: slpc [244.677422] Dynamic subtest slpc: SUCCESS (0.712s) [244.685187] Starting dynamic subtest: guc [245.337224] Dynamic subtest guc: SUCCESS (0.656s) [245.343525] Starting dynamic subtest: guc_multi_lrc [245.974118] Dynamic subtest guc_multi_lrc: SUCCESS (0.634s) [245.981423] Starting dynamic subtest: guc_hang [246.685257] Dynamic subtest guc_hang: SUCCESS (0.705s) [246.691347] Starting dynamic subtest: late_gt_pm [247.369053] Dynamic subtest late_gt_pm: SUCCESS (0.685s) [247.370087] Subtest live: SUCCESS (76.312s) [247.384942] [160/165] (763s left) dmabuf (all-tests) [247.435054] Starting subtest: all-tests [247.438551] Starting dynamic subtest: sanitycheck [247.496441] Dynamic subtest sanitycheck: SUCCESS (0.061s) [247.504867] Starting dynamic subtest: dma_fence [247.664115] Dynamic subtest dma_fence: SUCCESS (0.167s) [247.671365] Starting dynamic subtest: dma_fence_chain [259.269558] Dynamic subtest dma_fence_chain: SUCCESS (11.604s) [259.275520] Starting dynamic subtest: dma_fence_unwrap [259.331146] Dynamic subtest dma_fence_unwrap: SUCCESS (0.061s) [259.340897] Starting dynamic subtest: dma_resv [259.404495] Dynamic subtest dma_resv: SUCCESS (0.072s) [259.405682] Subtest all-tests: SUCCESS (11.969s) [259.417707] [161/165] (751s left) i915_suspend (basic-s2idle-without-i915) [259.461446] Starting subtest: basic-s2idle-without-i915 [276.517654] Subtest basic-s2idle-without-i915: SUCCESS (1.697s) [283.654287] [162/165] (749s left) i915_suspend (basic-s3-without-i915) [283.700403] Starting subtest: basic-s3-without-i915 [301.783693] Subtest basic-s3-without-i915: SUCCESS (1.556s) [314.818349] [163/165] (747s left) gem_exec_suspend (basic-s0) [314.877196] Starting subtest: basic-S0 [314.878368] Starting dynamic subtest: smem [331.535747] Dynamic subtest smem: SUCCESS (1.112s) [331.537116] Subtest basic-S0: SUCCESS (1.114s) [337.685435] [164/165] (746s left) gem_exec_suspend (basic-s3) [337.738187] Starting subtest: basic-S3 [337.739357] Starting dynamic subtest: smem [355.518847] Dynamic subtest smem: SUCCESS (1.152s) [355.521656] Subtest basic-S3: SUCCESS (1.153s) [361.670366] [165/165] (745s left) kms_pipe_crc_basic (suspend-read-crc) [361.738357] Starting subtest: suspend-read-crc [361.739438] Starting dynamic subtest: pipe-A-VGA-1 [379.671637] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.284s) [379.679958] Starting dynamic subtest: pipe-B-VGA-1 [397.681533] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.281s) [397.691128] Starting dynamic subtest: pipe-C-VGA-1 [415.684853] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.296s) [415.686247] Subtest suspend-read-crc: SUCCESS (3.866s) [420.778957] Closing watchdogs Done.