[37.915953] Initializing watchdogs
[37.916240]   /dev/watchdog0
[37.946912] [001/171] (960s left) i915_module_load (load)
[38.114585] Starting subtest: load
[39.519063] Subtest load: SUCCESS (1.401s)
[39.657089] [002/171] (958s left) core_auth (basic-auth)
[39.834513] Starting subtest: basic-auth
[39.854071] Subtest basic-auth: SUCCESS (0.000s)
[39.927246] [003/171] (958s left) debugfs_test (read_all_entries)
[40.072621] Starting subtest: read_all_entries
[40.111454] Subtest read_all_entries: SUCCESS (0.038s)
[40.210879] [004/171] (958s left) debugfs_test (basic-hwmon)
[40.346760] Starting subtest: basic-hwmon
[40.389540] Subtest basic-hwmon: SKIP (0.000s)
[40.463465] [005/171] (958s left) fbdev (eof)
[40.613206] Starting subtest: eof
[40.634661] Subtest eof: SUCCESS (0.000s)
[40.705104] [006/171] (958s left) fbdev (info)
[40.829272] Starting subtest: info
[40.851049] Subtest info: SUCCESS (0.000s)
[40.921742] [007/171] (957s left) fbdev (nullptr)
[41.066288] Starting subtest: nullptr
[41.085684] Subtest nullptr: SUCCESS (0.000s)
[41.155954] [008/171] (957s left) fbdev (read)
[41.287875] Starting subtest: read
[41.417689] Subtest read: SUCCESS (0.131s)
[41.498233] [009/171] (957s left) fbdev (write)
[41.617379] Starting subtest: write
[41.669699] Subtest write: SUCCESS (0.066s)
[41.748710] [010/171] (957s left) gem_basic (bad-close)
[41.884280] Starting subtest: bad-close
[41.928994] Subtest bad-close: SUCCESS (0.000s)
[42.004376] [011/171] (957s left) gem_basic (create-close)
[42.144448] Starting subtest: create-close
[42.193150] Subtest create-close: SUCCESS (0.000s)
[42.264134] [012/171] (956s left) gem_basic (create-fd-close)
[42.393361] Starting subtest: create-fd-close
[42.431665] Subtest create-fd-close: SUCCESS (0.000s)
[42.536142] [013/171] (956s left) gem_busy (busy@all-engines)
[42.664308] Starting subtest: busy
[42.683476] Starting dynamic subtest: all-engines
[42.702633] Dynamic subtest all-engines: SUCCESS (0.019s)
[42.721754] Subtest busy: SUCCESS (0.019s)
[43.017300] [014/171] (956s left) gem_close_race (basic-process)
[43.170489] Starting subtest: basic-process
[43.209669] Subtest basic-process: SUCCESS (0.036s)
[43.402939] [015/171] (955s left) gem_close_race (basic-threads)
[43.518401] Starting subtest: basic-threads
[44.656255] Subtest basic-threads: SUCCESS (1.142s)
[44.842885] [016/171] (954s left) gem_ctx_create (basic)
[44.985326] Starting subtest: basic
[45.007225] Subtest basic: SUCCESS (0.000s)
[45.168440] [017/171] (954s left) gem_ctx_create (basic-files)
[45.286842] Starting subtest: basic-files
[47.315077] Subtest basic-files: SUCCESS (2.011s)
[47.568640] [018/171] (951s left) gem_ctx_exec (basic)
[47.717117] Starting subtest: basic
[47.736593] Subtest basic: SUCCESS (0.002s)
[47.814584] [019/171] (951s left) gem_exec_basic (basic)
[47.956148] Starting subtest: basic
[47.978174] Starting dynamic subtest: rcs0-smem
[47.999968] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[48.025374] Starting dynamic subtest: bcs0-smem
[48.046653] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[48.072547] Starting dynamic subtest: vcs0-smem
[48.091774] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[48.111165] Subtest basic: SUCCESS (0.001s)
[48.187535] [020/171] (951s left) gem_exec_create (basic)
[48.315568] Starting subtest: basic
[48.334434] Starting dynamic subtest: smem
[50.358421] Dynamic subtest smem: SUCCESS (2.047s)
[50.379811] Subtest basic: SUCCESS (2.047s)
[50.551523] [021/171] (949s left) gem_exec_fence (basic-busy)
[50.800930] Starting subtest: basic-busy
[50.823000] Starting dynamic subtest: rcs0
[50.865336] Dynamic subtest rcs0: SUCCESS (0.028s)
[50.891343] Starting dynamic subtest: bcs0
[50.937736] Dynamic subtest bcs0: SUCCESS (0.025s)
[50.960572] Starting dynamic subtest: vcs0
[51.005534] Dynamic subtest vcs0: SUCCESS (0.021s)
[51.027997] Subtest basic-busy: SUCCESS (0.074s)
[51.407033] [022/171] (948s left) gem_exec_fence (basic-wait)
[51.643590] Starting subtest: basic-wait
[51.662935] Starting dynamic subtest: rcs0
[51.682987] Dynamic subtest rcs0: SUCCESS (0.033s)
[51.708454] Starting dynamic subtest: bcs0
[51.730728] Dynamic subtest bcs0: SUCCESS (0.028s)
[51.757750] Starting dynamic subtest: vcs0
[51.779359] Dynamic subtest vcs0: SUCCESS (0.031s)
[51.800655] Subtest basic-wait: SUCCESS (0.092s)
[52.175985] [023/171] (947s left) gem_exec_fence (basic-await)
[52.410152] Starting subtest: basic-await
[52.429334] Starting dynamic subtest: rcs0
[52.473438] Dynamic subtest rcs0: SUCCESS (0.064s)
[52.499293] Starting dynamic subtest: bcs0
[52.572333] Dynamic subtest bcs0: SUCCESS (0.063s)
[52.600292] Starting dynamic subtest: vcs0
[52.618946] Dynamic subtest vcs0: SUCCESS (0.064s)
[52.637602] Subtest basic-await: SUCCESS (0.191s)
[53.043529] [024/171] (946s left) gem_exec_fence (nb-await)
[53.285417] Starting subtest: nb-await
[53.307417] Starting dynamic subtest: rcs0
[53.349737] Dynamic subtest rcs0: SUCCESS (0.052s)
[53.375235] Starting dynamic subtest: bcs0
[53.394126] Dynamic subtest bcs0: SUCCESS (0.052s)
[53.417386] Starting dynamic subtest: vcs0
[53.454626] Dynamic subtest vcs0: SUCCESS (0.053s)
[53.475822] Subtest nb-await: SUCCESS (0.157s)
[53.884887] [025/171] (946s left) gem_exec_gttfill (basic)
[54.010189] Starting subtest: basic
[56.452660] Subtest basic: SUCCESS (2.449s)
[56.637626] [026/171] (943s left) gem_exec_parallel (engines)
[56.872613] Starting subtest: engines
[56.892513] Starting dynamic subtest: basic
[58.246703] Dynamic subtest basic: SUCCESS (1.378s)
[58.270225] Starting dynamic subtest: contexts
[59.784710] Dynamic subtest contexts: SUCCESS (1.546s)
[59.814903] Starting dynamic subtest: fds
[61.527954] Dynamic subtest fds: SUCCESS (1.740s)
[61.558914] Starting dynamic subtest: userptr
[62.952752] Dynamic subtest userptr: SUCCESS (1.422s)
[62.973876] Subtest engines: SUCCESS (6.088s)
[63.144391] [027/171] (936s left) gem_exec_store (basic)
[63.353159] Starting subtest: basic
[63.375407] Subtest basic: SUCCESS (0.039s)
[63.523162] [028/171] (936s left) gem_flink_basic (bad-flink)
[63.665147] Starting subtest: bad-flink
[63.684507] Subtest bad-flink: SUCCESS (0.000s)
[63.758652] [029/171] (936s left) gem_flink_basic (bad-open)
[63.878990] Starting subtest: bad-open
[63.898404] Subtest bad-open: SUCCESS (0.000s)
[63.972211] [030/171] (936s left) gem_flink_basic (basic)
[64.110185] Starting subtest: basic
[64.129631] Subtest basic: SUCCESS (0.000s)
[64.205923] [031/171] (936s left) gem_flink_basic (double-flink)
[64.343224] Starting subtest: double-flink
[64.362647] Subtest double-flink: SUCCESS (0.000s)
[64.441066] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[64.578105] Starting subtest: flink-lifetime
[64.598895] Subtest flink-lifetime: SUCCESS (0.001s)
[64.679046] [033/171] (935s left) gem_huc_copy (huc-copy)
[64.836926] Subtest huc-copy: SKIP (0.000s)
[64.915150] [034/171] (935s left) gem_linear_blits (basic)
[65.121111] Starting subtest: basic
[65.143336] Subtest basic: SUCCESS (0.008s)
[65.245197] [035/171] (935s left) gem_mmap (basic)
[65.479615] Starting subtest: basic
[65.579188] Subtest basic: SUCCESS (0.000s)
[65.658144] [036/171] (934s left) gem_mmap_gtt (basic)
[65.806916] Starting subtest: basic
[65.828968] Subtest basic: SUCCESS (0.000s)
[65.906519] [037/171] (934s left) gem_render_linear_blits (basic)
[66.042252] Starting subtest: basic
[66.144262] Subtest basic: SUCCESS (0.019s)
[66.222857] [038/171] (934s left) gem_render_tiled_blits (basic)
[66.366744] Starting subtest: basic
[66.491434] Subtest basic: SUCCESS (0.022s)
[66.563432] [039/171] (934s left) gem_ringfill (basic-all)
[66.813317] Starting subtest: basic-all
[67.904378] Subtest basic-all: SUCCESS (1.114s)
[68.005349] [040/171] (932s left) gem_softpin (allocator-basic)
[68.171989] Subtest allocator-basic: SKIP (0.000s)
[68.246934] [041/171] (932s left) gem_softpin (allocator-basic-reserve)
[68.386609] Subtest allocator-basic-reserve: SKIP (0.000s)
[68.461294] [042/171] (932s left) gem_softpin (safe-alignment)
[68.617555] Starting subtest: safe-alignment
[68.636859] Subtest safe-alignment: SUCCESS (0.005s)
[68.715616] [043/171] (932s left) gem_sync (basic-all)
[68.898431] Starting subtest: basic-all
[70.981069] Subtest basic-all: SUCCESS (2.126s)
[71.168854] [044/171] (929s left) gem_sync (basic-each)
[71.344673] Starting subtest: basic-each
[73.371975] Subtest basic-each: SUCCESS (2.068s)
[73.555859] [045/171] (927s left) gem_tiled_blits (basic)
[73.770206] Starting subtest: basic
[73.789759] Subtest basic: SUCCESS (0.014s)
[73.924684] [046/171] (927s left) gem_tiled_fence_blits (basic)
[74.232207] Starting subtest: basic
[74.254425] Subtest basic: SUCCESS (0.006s)
[74.378210] [047/171] (926s left) gem_tiled_pread_basic
[74.776484] [048/171] (926s left) gem_wait (busy@all-engines)
[74.937601] Starting subtest: busy
[74.956415] Starting dynamic subtest: all-engines
[75.454730] Dynamic subtest all-engines: SUCCESS (0.517s)
[75.476898] Subtest busy: SUCCESS (0.517s)
[75.659940] [049/171] (925s left) gem_wait (wait@all-engines)
[75.800043] Starting subtest: wait
[75.818932] Starting dynamic subtest: all-engines
[76.819893] Dynamic subtest all-engines: SUCCESS (1.013s)
[76.841979] Subtest wait: SUCCESS (1.013s)
[77.016301] [050/171] (924s left) i915_getparams_basic (basic-eu-total)
[77.157390] Starting subtest: basic-eu-total
[77.198851] Subtest basic-eu-total: SUCCESS (0.000s)
[77.271302] [051/171] (924s left) i915_getparams_basic (basic-subslice-total)
[77.410203] Starting subtest: basic-subslice-total
[77.448556] Subtest basic-subslice-total: SUCCESS (0.000s)
[77.526323] [052/171] (924s left) i915_hangman (error-state-basic)
[77.671295] Starting subtest: error-state-basic
[77.690630] Subtest error-state-basic: SUCCESS (0.004s)
[77.789622] [053/171] (923s left) i915_pciid
[78.023413] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[78.204811] Starting subtest: addfb25-bad-modifier
[78.226142] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[78.338873] [055/171] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[78.476507] Starting subtest: addfb25-framebuffer-vs-set-tiling
[78.495110] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[78.615647] [056/171] (923s left) kms_addfb_basic (addfb25-modifier-no-flag)
[78.780961] Starting subtest: addfb25-modifier-no-flag
[78.801298] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[78.894067] [057/171] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[79.035849] Starting subtest: addfb25-x-tiled-legacy
[79.054350] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[79.177942] [058/171] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[79.331443] Starting subtest: addfb25-x-tiled-mismatch-legacy
[79.352649] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[79.469764] [059/171] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[79.630729] Starting subtest: addfb25-yf-tiled-legacy
[79.649064] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[79.743713] [060/171] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[79.896582] Starting subtest: addfb25-y-tiled-legacy
[79.916509] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[80.014288] [061/171] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[80.171993] Starting subtest: addfb25-y-tiled-small-legacy
[80.212557] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[80.283543] [062/171] (922s left) kms_addfb_basic (bad-pitch-0)
[80.423187] Starting subtest: bad-pitch-0
[80.442027] Subtest bad-pitch-0: SUCCESS (0.000s)
[80.559371] [063/171] (921s left) kms_addfb_basic (bad-pitch-1024)
[80.692944] Starting subtest: bad-pitch-1024
[80.712838] Subtest bad-pitch-1024: SUCCESS (0.000s)
[80.830658] [064/171] (921s left) kms_addfb_basic (bad-pitch-128)
[80.970854] Starting subtest: bad-pitch-128
[80.991440] Subtest bad-pitch-128: SUCCESS (0.000s)
[81.102620] [065/171] (921s left) kms_addfb_basic (bad-pitch-256)
[81.242373] Starting subtest: bad-pitch-256
[81.260921] Subtest bad-pitch-256: SUCCESS (0.000s)
[81.423881] [066/171] (921s left) kms_addfb_basic (bad-pitch-32)
[81.538188] Starting subtest: bad-pitch-32
[81.558298] Subtest bad-pitch-32: SUCCESS (0.000s)
[81.700136] [067/171] (921s left) kms_addfb_basic (bad-pitch-63)
[81.840291] Starting subtest: bad-pitch-63
[81.864254] Subtest bad-pitch-63: SUCCESS (0.000s)
[81.984673] [068/171] (920s left) kms_addfb_basic (bad-pitch-65536)
[82.122902] Starting subtest: bad-pitch-65536
[82.141440] Subtest bad-pitch-65536: SUCCESS (0.000s)
[82.260367] [069/171] (920s left) kms_addfb_basic (bad-pitch-999)
[82.397966] Starting subtest: bad-pitch-999
[82.418752] Subtest bad-pitch-999: SUCCESS (0.000s)
[82.533343] [070/171] (920s left) kms_addfb_basic (basic)
[82.678461] Starting subtest: basic
[82.702088] Subtest basic: SUCCESS (0.000s)
[82.819876] [071/171] (920s left) kms_addfb_basic (basic-x-tiled-legacy)
[83.003631] Starting subtest: basic-x-tiled-legacy
[83.031307] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[83.131473] [072/171] (920s left) kms_addfb_basic (basic-y-tiled-legacy)
[83.315156] Starting subtest: basic-y-tiled-legacy
[83.341110] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[83.438056] [073/171] (919s left) kms_addfb_basic (bo-too-small)
[83.601119] Starting subtest: bo-too-small
[83.627852] Subtest bo-too-small: SUCCESS (0.000s)
[83.731102] [074/171] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[83.885948] Starting subtest: bo-too-small-due-to-tiling
[83.910991] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[84.027416] [075/171] (919s left) kms_addfb_basic (clobberred-modifier)
[84.181985] Starting subtest: clobberred-modifier
[84.205481] Subtest clobberred-modifier: SUCCESS (0.000s)
[84.326317] [076/171] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[84.519068] Starting subtest: framebuffer-vs-set-tiling
[84.550749] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[84.644624] [077/171] (918s left) kms_addfb_basic (invalid-get-prop)
[84.828160] Starting subtest: invalid-get-prop
[84.852812] Subtest invalid-get-prop: SUCCESS (0.000s)
[84.947098] [078/171] (918s left) kms_addfb_basic (invalid-get-prop-any)
[85.118821] Starting subtest: invalid-get-prop-any
[85.140370] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[85.236332] [079/171] (918s left) kms_addfb_basic (invalid-set-prop)
[85.425539] Starting subtest: invalid-set-prop
[85.444158] Subtest invalid-set-prop: SUCCESS (0.000s)
[85.535423] [080/171] (918s left) kms_addfb_basic (invalid-set-prop-any)
[85.713192] Starting subtest: invalid-set-prop-any
[85.734481] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[85.812502] [081/171] (917s left) kms_addfb_basic (no-handle)
[85.947056] Starting subtest: no-handle
[85.968258] Subtest no-handle: SUCCESS (0.000s)
[86.093065] [082/171] (917s left) kms_addfb_basic (size-max)
[86.234717] Starting subtest: size-max
[86.253406] Subtest size-max: SUCCESS (0.000s)
[86.368209] [083/171] (917s left) kms_addfb_basic (small-bo)
[86.501889] Starting subtest: small-bo
[86.520465] Subtest small-bo: SUCCESS (0.000s)
[86.639928] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[86.799719] Starting subtest: tile-pitch-mismatch
[86.820097] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[86.912288] [085/171] (917s left) kms_addfb_basic (too-high)
[87.048171] Starting subtest: too-high
[87.066968] Subtest too-high: SUCCESS (0.001s)
[87.187051] [086/171] (917s left) kms_addfb_basic (too-wide)
[87.318099] Starting subtest: too-wide
[87.339483] Subtest too-wide: SUCCESS (0.000s)
[87.466880] [087/171] (916s left) kms_addfb_basic (unused-handle)
[87.605862] Starting subtest: unused-handle
[87.627268] Subtest unused-handle: SUCCESS (0.000s)
[87.752366] [088/171] (916s left) kms_addfb_basic (unused-modifier)
[87.889813] Starting subtest: unused-modifier
[87.907956] Subtest unused-modifier: SUCCESS (0.000s)
[88.024647] [089/171] (916s left) kms_addfb_basic (unused-offsets)
[88.160359] Starting subtest: unused-offsets
[88.181638] Subtest unused-offsets: SUCCESS (0.000s)
[88.299058] [090/171] (916s left) kms_addfb_basic (unused-pitches)
[88.444810] Starting subtest: unused-pitches
[88.463345] Subtest unused-pitches: SUCCESS (0.000s)
[88.578413] [091/171] (916s left) kms_busy (basic)
[88.754441] Starting subtest: basic
[88.776343] Starting dynamic subtest: flip
[89.365196] Dynamic subtest flip: SUCCESS (0.627s)
[89.389130] Starting dynamic subtest: modeset
[89.845263] Dynamic subtest modeset: SUCCESS (0.487s)
[89.864434] Subtest basic: SUCCESS (1.114s)
[90.030212] [092/171] (914s left) kms_chamelium_hpd (dp-hpd-fast)
[90.237191] Subtest dp-hpd-fast: SKIP (0.000s)
[90.354424] [093/171] (914s left) kms_chamelium_edid (dp-edid-read)
[90.561176] Subtest dp-edid-read: SKIP (0.000s)
[90.679833] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast)
[90.884614] Subtest dp-crc-fast: SKIP (0.000s)
[91.016441] [095/171] (913s left) kms_chamelium_hpd (hdmi-hpd-fast)
[91.213539] Subtest hdmi-hpd-fast: SKIP (0.000s)
[91.325080] [096/171] (913s left) kms_chamelium_edid (hdmi-edid-read)
[91.541709] Subtest hdmi-edid-read: SKIP (0.000s)
[91.655568] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast)
[91.861880] Subtest hdmi-crc-fast: SKIP (0.000s)
[91.986235] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast)
[92.188336] Subtest vga-hpd-fast: SKIP (0.000s)
[92.308521] [099/171] (912s left) kms_chamelium_edid (vga-edid-read)
[92.502112] Subtest vga-edid-read: SKIP (0.000s)
[92.621313] [100/171] (912s left) kms_prop_blob (basic)
[92.770138] Starting subtest: basic
[92.791261] Subtest basic: SUCCESS (0.000s)
[92.864394] [101/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[93.011699] Starting subtest: basic-busy-flip-before-cursor-atomic
[93.943085] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.932s)
[94.112180] [102/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[94.251292] Starting subtest: basic-busy-flip-before-cursor-legacy
[95.185420] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.931s)
[95.351233] [103/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[95.488996] Starting subtest: basic-flip-after-cursor-atomic
[96.425698] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.928s)
[96.594666] [104/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[96.749282] Starting subtest: basic-flip-after-cursor-legacy
[97.677128] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.937s)
[97.840930] [105/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[97.974054] Starting subtest: basic-flip-after-cursor-varying-size
[98.906478] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.928s)
[99.068759] [106/171] (906s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[99.202103] Starting subtest: basic-flip-before-cursor-atomic
[100.161778] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.954s)
[100.330418] [107/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[100.466881] Starting subtest: basic-flip-before-cursor-legacy
[101.417034] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.947s)
[101.586189] [108/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[101.724739] Starting subtest: basic-flip-before-cursor-varying-size
[102.674199] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s)
[102.864368] [109/171] (903s left) kms_flip (basic-flip-vs-dpms)
[103.046111] Starting subtest: basic-flip-vs-dpms
[103.069704] Starting dynamic subtest: A-VGA1
[103.963971] Dynamic subtest A-VGA1: SUCCESS (0.937s)
[103.993081] Starting dynamic subtest: B-VGA1
[104.834674] Dynamic subtest B-VGA1: SUCCESS (0.886s)
[104.863904] Starting dynamic subtest: C-VGA1
[105.726287] Dynamic subtest C-VGA1: SUCCESS (0.884s)
[105.746277] Subtest basic-flip-vs-dpms: SUCCESS (2.710s)
[105.907193] [110/171] (900s left) kms_flip (basic-flip-vs-modeset)
[106.066974] Starting subtest: basic-flip-vs-modeset
[106.088249] Starting dynamic subtest: A-VGA1
[106.916269] Dynamic subtest A-VGA1: SUCCESS (0.868s)
[106.941409] Starting dynamic subtest: B-VGA1
[107.700586] Dynamic subtest B-VGA1: SUCCESS (0.788s)
[107.725477] Starting dynamic subtest: C-VGA1
[108.484985] Dynamic subtest C-VGA1: SUCCESS (0.787s)
[108.507444] Subtest basic-flip-vs-modeset: SUCCESS (2.444s)
[108.652801] [111/171] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[108.818405] Starting subtest: basic-flip-vs-wf_vblank
[108.837676] Starting dynamic subtest: A-VGA1
[109.936355] Dynamic subtest A-VGA1: SUCCESS (1.144s)
[109.962963] Starting dynamic subtest: B-VGA1
[111.061317] Dynamic subtest B-VGA1: SUCCESS (1.124s)
[111.091639] Starting dynamic subtest: C-VGA1
[112.188504] Dynamic subtest C-VGA1: SUCCESS (1.124s)
[112.210454] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.397s)
[112.402272] [112/171] (893s left) kms_flip (basic-plain-flip)
[112.567309] Starting subtest: basic-plain-flip
[112.587062] Starting dynamic subtest: A-VGA1
[113.403043] Dynamic subtest A-VGA1: SUCCESS (0.858s)
[113.430199] Starting dynamic subtest: B-VGA1
[114.243685] Dynamic subtest B-VGA1: SUCCESS (0.839s)
[114.270953] Starting dynamic subtest: C-VGA1
[115.086927] Dynamic subtest C-VGA1: SUCCESS (0.841s)
[115.106313] Subtest basic-plain-flip: SUCCESS (2.541s)
[115.285996] [113/171] (891s left) kms_force_connector_basic (force-connector-state)
[115.433490] Starting subtest: force-connector-state
[115.567413] Subtest force-connector-state: SUCCESS (0.133s)
[115.779869] [114/171] (890s left) kms_force_connector_basic (force-edid)
[115.930148] Starting subtest: force-edid
[115.991114] Subtest force-edid: SUCCESS (0.063s)
[116.121941] [115/171] (890s left) kms_force_connector_basic (force-load-detect)
[116.254981] Starting subtest: force-load-detect
[116.401859] Subtest force-load-detect: SUCCESS (0.136s)
[116.583371] [116/171] (890s left) kms_force_connector_basic (prune-stale-modes)
[116.723696] Starting subtest: prune-stale-modes
[116.743704] Subtest prune-stale-modes: SUCCESS (0.015s)
[116.863969] [117/171] (889s left) kms_frontbuffer_tracking (basic)
[117.070342] Starting subtest: basic
[118.846178] Subtest basic: SUCCESS (1.833s)
[118.955779] [118/171] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[119.102154] Starting subtest: compare-crc-sanitycheck
[119.124046] Starting dynamic subtest: pipe-A-VGA-1
[119.370796] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.266s)
[119.397394] Starting dynamic subtest: pipe-B-VGA-1
[119.635396] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.260s)
[119.661939] Starting dynamic subtest: pipe-C-VGA-1
[119.897962] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.261s)
[119.918492] Subtest compare-crc-sanitycheck: SUCCESS (0.789s)
[120.071467] [119/171] (886s left) kms_pipe_crc_basic (hang-read-crc)
[120.208808] Starting subtest: hang-read-crc
[120.227930] Starting dynamic subtest: pipe-A-VGA-1
[120.981571] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.759s)
[121.007293] Starting dynamic subtest: pipe-B-VGA-1
[121.729190] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.753s)
[121.754189] Starting dynamic subtest: pipe-C-VGA-1
[122.489378] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.756s)
[122.518968] Subtest hang-read-crc: SUCCESS (2.270s)
[122.641668] [120/171] (884s left) kms_pipe_crc_basic (nonblocking-crc)
[122.811508] Starting subtest: nonblocking-crc
[122.837173] Starting dynamic subtest: pipe-A-VGA-1
[123.256977] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.455s)
[123.291757] Starting dynamic subtest: pipe-B-VGA-1
[123.701275] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.443s)
[123.736338] Starting dynamic subtest: pipe-C-VGA-1
[124.157245] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.444s)
[124.185121] Subtest nonblocking-crc: SUCCESS (1.344s)
[124.305480] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[124.458115] Starting subtest: nonblocking-crc-frame-sequence
[124.480513] Starting dynamic subtest: pipe-A-VGA-1
[124.934294] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.447s)
[124.964764] Starting dynamic subtest: pipe-B-VGA-1
[125.369553] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.443s)
[125.400023] Starting dynamic subtest: pipe-C-VGA-1
[125.805069] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.445s)
[125.824179] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.337s)
[125.966787] [122/171] (881s left) kms_pipe_crc_basic (read-crc)
[126.106037] Starting subtest: read-crc
[126.128246] Starting dynamic subtest: pipe-A-VGA-1
[126.493160] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.376s)
[126.517959] Starting dynamic subtest: pipe-B-VGA-1
[126.863375] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.376s)
[126.888167] Starting dynamic subtest: pipe-C-VGA-1
[127.242026] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.377s)
[127.264176] Subtest read-crc: SUCCESS (1.131s)
[127.401644] [123/171] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[127.541654] Starting subtest: read-crc-frame-sequence
[127.560838] Starting dynamic subtest: pipe-A-VGA-1
[127.933139] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.383s)
[127.960259] Starting dynamic subtest: pipe-B-VGA-1
[128.314582] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.375s)
[128.341081] Starting dynamic subtest: pipe-C-VGA-1
[128.687247] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.377s)
[128.706352] Subtest read-crc-frame-sequence: SUCCESS (1.137s)
[128.850342] [124/171] (878s left) kms_psr (primary_page_flip)
[129.022563] Subtest primary_page_flip: SKIP (0.000s)
[129.101177] [125/171] (878s left) kms_psr (cursor_plane_move)
[129.250654] Subtest cursor_plane_move: SKIP (0.000s)
[129.329571] [126/171] (878s left) kms_psr (sprite_plane_onoff)
[129.494536] Subtest sprite_plane_onoff: SKIP (0.000s)
[129.571249] [127/171] (878s left) kms_psr (primary_mmap_gtt)
[129.737547] Subtest primary_mmap_gtt: SKIP (0.000s)
[129.815541] [128/171] (877s left) kms_setmode (basic-clone-single-crtc)
[129.948458] Starting subtest: basic-clone-single-crtc
[130.008994] Subtest basic-clone-single-crtc: SKIP (0.000s)
[130.095678] [129/171] (877s left) i915_pm_backlight (basic-brightness)
[130.261767] Subtest basic-brightness: SKIP (0.000s)
[130.347209] [130/171] (877s left) i915_pm_rpm (basic-pci-d3-state)
[141.660405] Subtest basic-pci-d3-state: SKIP (0.000s)
[141.734717] [131/171] (866s left) i915_pm_rpm (basic-rte)
[141.858316] Starting subtest: basic-rte
[153.015208] Subtest basic-rte: SKIP (11.101s)
[153.134049] [132/171] (854s left) i915_pm_rps (basic-api)
[153.260508] Starting subtest: basic-api
[153.279887] Subtest basic-api: SUCCESS (0.002s)
[153.360306] [133/171] (854s left) prime_self_import (basic-llseek-bad)
[153.487047] Starting subtest: basic-llseek-bad
[153.506602] Subtest basic-llseek-bad: SUCCESS (0.001s)
[153.586484] [134/171] (854s left) prime_self_import (basic-llseek-size)
[153.721642] Starting subtest: basic-llseek-size
[153.741276] Subtest basic-llseek-size: SUCCESS (0.002s)
[153.822789] [135/171] (854s left) prime_self_import (basic-with_fd_dup)
[153.957824] Starting subtest: basic-with_fd_dup
[153.979959] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[154.061376] [136/171] (854s left) prime_self_import (basic-with_one_bo)
[154.205216] Starting subtest: basic-with_one_bo
[154.227125] Subtest basic-with_one_bo: SUCCESS (0.002s)
[154.306212] [137/171] (854s left) prime_self_import (basic-with_one_bo_two_files)
[154.445092] Starting subtest: basic-with_one_bo_two_files
[154.466173] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[154.542467] [138/171] (853s left) prime_self_import (basic-with_two_bos)
[154.682848] Starting subtest: basic-with_two_bos
[154.704828] Subtest basic-with_two_bos: SUCCESS (0.003s)
[154.778818] [139/171] (853s left) prime_vgem (basic-fence-flip)
[154.947923] Starting subtest: basic-fence-flip
[155.246224] Subtest basic-fence-flip: SUCCESS (0.313s)
[155.371547] [140/171] (853s left) prime_vgem (basic-fence-mmap)
[155.510795] Starting subtest: basic-fence-mmap
[155.531958] Subtest basic-fence-mmap: SUCCESS (0.025s)
[155.627194] [141/171] (852s left) prime_vgem (basic-fence-read)
[155.755328] Starting subtest: basic-fence-read
[155.795630] Subtest basic-fence-read: SUCCESS (0.036s)
[155.893732] [142/171] (852s left) prime_vgem (basic-gtt)
[156.032445] Starting subtest: basic-gtt
[156.051667] Subtest basic-gtt: SUCCESS (0.013s)
[156.153839] [143/171] (852s left) prime_vgem (basic-read)
[156.287440] Starting subtest: basic-read
[156.309776] Subtest basic-read: SUCCESS (0.016s)
[156.409518] [144/171] (852s left) prime_vgem (basic-write)
[156.546228] Starting subtest: basic-write
[156.567655] Subtest basic-write: SUCCESS (0.018s)
[156.662520] [145/171] (852s left) prime_vgem (basic-userptr)
[156.805464] Starting subtest: basic-userptr
[156.844460] Subtest basic-userptr: SKIP (0.015s)
[156.943668] [146/171] (851s left) vgem_basic (setversion)
[157.086777] Starting subtest: setversion
[157.129167] Subtest setversion: SUCCESS (0.000s)
[157.211222] [147/171] (851s left) vgem_basic (create)
[157.349628] Starting subtest: create
[157.371450] Subtest create: SUCCESS (0.000s)
[157.448540] [148/171] (851s left) vgem_basic (debugfs)
[157.588331] Starting subtest: debugfs
[157.610150] Subtest debugfs: SUCCESS (0.001s)
[157.689845] [149/171] (851s left) vgem_basic (dmabuf-export)
[157.832267] Starting subtest: dmabuf-export
[157.852459] Subtest dmabuf-export: SUCCESS (0.001s)
[157.927348] [150/171] (851s left) vgem_basic (dmabuf-fence)
[158.070725] Starting subtest: dmabuf-fence
[158.090277] Subtest dmabuf-fence: SUCCESS (0.001s)
[158.167609] [151/171] (851s left) vgem_basic (dmabuf-fence-before)
[158.316572] Starting subtest: dmabuf-fence-before
[158.335296] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[158.414209] [152/171] (850s left) vgem_basic (dmabuf-mmap)
[158.548379] Starting subtest: dmabuf-mmap
[158.567663] Subtest dmabuf-mmap: SUCCESS (0.015s)
[158.649456] [153/171] (850s left) vgem_basic (mmap)
[158.770900] Starting subtest: mmap
[158.790520] Subtest mmap: SUCCESS (0.011s)
[158.872914] [154/171] (850s left) vgem_basic (second-client)
[158.996264] Starting subtest: second-client
[159.061160] Subtest second-client: SUCCESS (0.049s)
[159.142385] [155/171] (850s left) vgem_basic (sysfs)
[159.279845] Starting subtest: sysfs
[159.299433] Subtest sysfs: SUCCESS (0.001s)
[159.405129] [156/171] (850s left) core_hotunplug (unbind-rebind)
[159.614386] Starting subtest: unbind-rebind
[160.325769] Subtest unbind-rebind: SUCCESS (0.712s)
[160.424765] [157/171] (849s left) vgem_basic (unload)
[160.569963] Starting subtest: unload
[189.495717] Subtest unload: SUCCESS (28.752s)
[189.570400] [158/171] (820s left) i915_module_load (reload)
[189.718509] Starting subtest: reload
[191.459124] Subtest reload: SUCCESS (1.755s)
[191.559928] [159/171] (818s left) gem_lmem_swapping (basic)
[191.730646] Subtest basic: SKIP (0.000s)
[191.827477] [160/171] (818s left) gem_lmem_swapping (parallel-random-engines)
[191.992038] Subtest parallel-random-engines: SKIP (0.000s)
[192.066340] [161/171] (817s left) gem_lmem_swapping (random-engines)
[192.229430] Subtest random-engines: SKIP (0.000s)
[192.304487] [162/171] (817s left) gem_lmem_swapping (verify-random)
[192.465088] Subtest verify-random: SKIP (0.000s)
[192.542919] [163/171] (817s left) i915_pm_rpm (module-reload)
[203.839562] Subtest module-reload: SKIP (0.000s)
[203.916534] [164/171] (806s left) i915_selftest (live)
[204.631156] Starting subtest: live
[204.651971] Starting dynamic subtest: sanitycheck
[205.193414] Dynamic subtest sanitycheck: SUCCESS (0.564s)
[205.220966] Starting dynamic subtest: uncore
[205.703648] Dynamic subtest uncore: SUCCESS (0.508s)
[205.728638] Starting dynamic subtest: workarounds
[206.294535] Dynamic subtest workarounds: SUCCESS (0.589s)
[206.321324] Starting dynamic subtest: gt_engines
[206.813558] Dynamic subtest gt_engines: SUCCESS (0.521s)
[206.840398] Starting dynamic subtest: gt_timelines
[211.780331] Dynamic subtest gt_timelines: SUCCESS (4.966s)
[211.807947] Starting dynamic subtest: gt_contexts
[212.353611] Dynamic subtest gt_contexts: SUCCESS (0.573s)
[212.378542] Starting dynamic subtest: gt_lrc
[212.927392] Dynamic subtest gt_lrc: SUCCESS (0.570s)
[212.954323] Starting dynamic subtest: gt_mocs
[213.471535] Dynamic subtest gt_mocs: SUCCESS (0.546s)
[213.498737] Starting dynamic subtest: gt_pm
[221.677983] Dynamic subtest gt_pm: SUCCESS (8.203s)
[221.704927] Starting dynamic subtest: gt_heartbeat
[222.331080] Dynamic subtest gt_heartbeat: SUCCESS (0.652s)
[222.360583] Starting dynamic subtest: requests
[227.502894] Dynamic subtest requests: SUCCESS (5.171s)
[227.529840] Starting dynamic subtest: migrate
[228.040649] Dynamic subtest migrate: SUCCESS (0.540s)
[228.065664] Starting dynamic subtest: active
[228.605398] Dynamic subtest active: SUCCESS (0.562s)
[228.632300] Starting dynamic subtest: objects
[229.548673] Dynamic subtest objects: SUCCESS (0.943s)
[229.578485] Starting dynamic subtest: mman
[233.469863] Dynamic subtest mman: SUCCESS (3.922s)
[233.495770] Starting dynamic subtest: dmabuf
[234.058852] Dynamic subtest dmabuf: SUCCESS (0.589s)
[234.086809] Starting dynamic subtest: vma
[234.568609] Dynamic subtest vma: SUCCESS (0.509s)
[234.593859] Starting dynamic subtest: coherency
[236.188449] Dynamic subtest coherency: SUCCESS (1.619s)
[236.218052] Starting dynamic subtest: gtt
[239.992479] Dynamic subtest gtt: SUCCESS (3.802s)
[240.019831] Starting dynamic subtest: gem
[240.587179] Dynamic subtest gem: SUCCESS (0.597s)
[240.612044] Starting dynamic subtest: evict
[241.118155] Dynamic subtest evict: SUCCESS (0.528s)
[241.144460] Starting dynamic subtest: hugepages
[242.764573] Dynamic subtest hugepages: SUCCESS (1.648s)
[242.792801] Starting dynamic subtest: gem_contexts
[246.994154] Dynamic subtest gem_contexts: SUCCESS (4.222s)
[247.026919] Starting dynamic subtest: client
[247.554733] Dynamic subtest client: SUCCESS (0.563s)
[247.586503] Starting dynamic subtest: gem_migrate
[248.099460] Dynamic subtest gem_migrate: SUCCESS (0.542s)
[248.129284] Starting dynamic subtest: reset
[248.630188] Dynamic subtest reset: SUCCESS (0.527s)
[248.661746] Starting dynamic subtest: memory_region
[249.183204] Dynamic subtest memory_region: SUCCESS (0.545s)
[249.219155] Starting dynamic subtest: hangcheck
[262.434395] Dynamic subtest hangcheck: SUCCESS (13.265s)
[262.459756] Starting dynamic subtest: execlists
[262.964223] Dynamic subtest execlists: SUCCESS (0.527s)
[262.994984] Starting dynamic subtest: ring_submission
[263.474437] Dynamic subtest ring_submission: SUCCESS (0.512s)
[263.499676] Starting dynamic subtest: perf
[263.958133] Dynamic subtest perf: SUCCESS (0.482s)
[263.986076] Starting dynamic subtest: slpc
[264.472978] Dynamic subtest slpc: SUCCESS (0.513s)
[264.498363] Starting dynamic subtest: guc
[265.028180] Dynamic subtest guc: SUCCESS (0.557s)
[265.052930] Starting dynamic subtest: guc_multi_lrc
[265.550192] Dynamic subtest guc_multi_lrc: SUCCESS (0.519s)
[265.577357] Starting dynamic subtest: guc_hang
[266.083855] Dynamic subtest guc_hang: SUCCESS (0.531s)
[266.108679] Starting dynamic subtest: late_gt_pm
[266.615590] Dynamic subtest late_gt_pm: SUCCESS (0.534s)
[266.637224] Subtest live: SUCCESS (61.985s)
[266.741288] [165/171] (743s left) dmabuf (all-tests)
[266.893045] Starting subtest: all-tests
[266.913379] Starting dynamic subtest: sanitycheck
[266.953576] Dynamic subtest sanitycheck: SUCCESS (0.044s)
[266.979596] Starting dynamic subtest: dma_fence
[267.074362] Dynamic subtest dma_fence: SUCCESS (0.137s)
[267.097739] Starting dynamic subtest: dma_fence_chain
[278.905301] Dynamic subtest dma_fence_chain: SUCCESS (11.827s)
[278.932443] Starting dynamic subtest: dma_fence_unwrap
[278.953834] Dynamic subtest dma_fence_unwrap: SUCCESS (0.031s)
[278.979582] Starting dynamic subtest: dma_resv
[278.999204] Dynamic subtest dma_resv: SUCCESS (0.028s)
[279.018466] Subtest all-tests: SUCCESS (12.072s)
[279.098190] [166/171] (731s left) i915_suspend (basic-s2idle-without-i915)
[279.242081] Starting subtest: basic-s2idle-without-i915
[297.289161] Subtest basic-s2idle-without-i915: SUCCESS (2.336s)
[300.417166] [167/171] (728s left) i915_suspend (basic-s3-without-i915)
[300.568889] Starting subtest: basic-s3-without-i915
[319.141885] Subtest basic-s3-without-i915: SUCCESS (1.852s)
[322.180759] [168/171] (726s left) gem_exec_suspend (basic-s0)
[322.334430] Starting subtest: basic-S0
[322.352662] Starting dynamic subtest: smem
[340.129890] Dynamic subtest smem: SUCCESS (1.775s)
[340.148455] Subtest basic-S0: SUCCESS (1.776s)
[343.177646] [169/171] (724s left) gem_exec_suspend (basic-s3)
[343.323846] Starting subtest: basic-S3
[343.344460] Starting dynamic subtest: smem
[360.977642] Dynamic subtest smem: SUCCESS (1.729s)
[360.998069] Subtest basic-S3: SUCCESS (1.730s)
[365.352242] [170/171] (722s left) kms_chamelium_hpd (common-hpd-after-suspend)
[365.573058] Subtest common-hpd-after-suspend: SKIP (0.000s)
[365.694460] [171/171] (722s left) kms_pipe_crc_basic (suspend-read-crc)
[365.838087] Starting subtest: suspend-read-crc
[365.856519] Starting dynamic subtest: pipe-A-VGA-1
[384.139573] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.803s)
[384.167505] Starting dynamic subtest: pipe-B-VGA-1
[403.157855] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.833s)
[403.186550] Starting dynamic subtest: pipe-C-VGA-1
[422.144565] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.817s)
[422.165864] Subtest suspend-read-crc: SUCCESS (5.455s)
[425.276982] Closing watchdogs
Done.