[78.635786] Initializing watchdogs
[78.636267]   /dev/watchdog0
[78.693272] [001/171] (960s left) i915_module_load (load)
[79.594469] Starting subtest: load
[84.011729] Subtest load: SUCCESS (4.397s)
[84.538838] [002/171] (955s left) core_auth (basic-auth)
[85.765854] Starting subtest: basic-auth
[85.857649] Subtest basic-auth: SUCCESS (0.001s)
[86.125466] [003/171] (953s left) debugfs_test (read_all_entries)
[86.843382] Starting subtest: read_all_entries
[86.876978] Subtest read_all_entries: SUCCESS (0.053s)
[87.230214] [004/171] (952s left) debugfs_test (basic-hwmon)
[87.782644] Starting subtest: basic-hwmon
[87.866483] Subtest basic-hwmon: SKIP (0.000s)
[88.060499] [005/171] (952s left) fbdev (eof)
[88.536556] Starting subtest: eof
[88.586610] Subtest eof: SUCCESS (0.000s)
[88.695977] [006/171] (951s left) fbdev (info)
[89.096984] Starting subtest: info
[89.138831] Subtest info: SUCCESS (0.000s)
[89.248187] [007/171] (951s left) fbdev (nullptr)
[89.707551] Starting subtest: nullptr
[89.749503] Subtest nullptr: SUCCESS (0.000s)
[89.860685] [008/171] (950s left) fbdev (read)
[90.219133] Starting subtest: read
[90.578066] Subtest read: SUCCESS (0.470s)
[90.671259] [009/171] (950s left) fbdev (write)
[91.021447] Starting subtest: write
[91.105453] Subtest write: SUCCESS (0.109s)
[91.215184] [010/171] (949s left) gem_basic (bad-close)
[91.632555] Starting subtest: bad-close
[91.716224] Subtest bad-close: SUCCESS (0.000s)
[91.825737] [011/171] (949s left) gem_basic (create-close)
[92.176297] Starting subtest: create-close
[92.259945] Subtest create-close: SUCCESS (0.000s)
[92.369362] [012/171] (949s left) gem_basic (create-fd-close)
[92.880529] Starting subtest: create-fd-close
[92.980842] Subtest create-fd-close: SUCCESS (0.000s)
[93.106839] [013/171] (948s left) gem_busy (busy@all-engines)
[93.574536] Starting subtest: busy
[93.624827] Starting dynamic subtest: all-engines
[93.699938] Dynamic subtest all-engines: SUCCESS (0.027s)
[93.741766] Subtest busy: SUCCESS (0.028s)
[93.893377] [014/171] (947s left) gem_close_race (basic-process)
[94.327142] Starting subtest: basic-process
[94.368917] Subtest basic-process: SUCCESS (0.047s)
[94.478883] [015/171] (947s left) gem_close_race (basic-threads)
[94.870917] Starting subtest: basic-threads
[95.994428] Subtest basic-threads: SUCCESS (1.155s)
[96.196083] [016/171] (945s left) gem_ctx_create (basic)
[96.872413] Starting subtest: basic
[96.914175] Subtest basic: SUCCESS (0.000s)
[97.023788] [017/171] (945s left) gem_ctx_create (basic-files)
[97.416099] Starting subtest: basic-files
[99.382766] Subtest basic-files: SUCCESS (2.013s)
[99.609717] [018/171] (942s left) gem_ctx_exec (basic)
[100.194367] Starting subtest: basic
[100.236227] Subtest basic: SUCCESS (0.001s)
[100.347441] [019/171] (942s left) gem_exec_basic (basic)
[100.823429] Starting subtest: basic
[100.865387] Starting dynamic subtest: rcs0-smem
[100.907236] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[100.957415] Starting dynamic subtest: bcs0-smem
[100.999160] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[101.049339] Starting dynamic subtest: vcs0-smem
[101.091317] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[101.133193] Subtest basic: SUCCESS (0.002s)
[101.225921] [020/171] (941s left) gem_exec_create (basic)
[101.642925] Starting subtest: basic
[101.676440] Starting dynamic subtest: smem
[103.595118] Dynamic subtest smem: SUCCESS (2.037s)
[103.628689] Subtest basic: SUCCESS (2.038s)
[103.788731] [021/171] (938s left) gem_exec_fence (basic-busy)
[104.556823] Subtest basic-busy: SKIP (0.000s)
[104.935587] [022/171] (937s left) gem_exec_fence (basic-wait)
[105.436980] Subtest basic-wait: SKIP (0.000s)
[105.764173] [023/171] (936s left) gem_exec_fence (basic-await)
[106.324199] Subtest basic-await: SKIP (0.000s)
[106.601387] [024/171] (936s left) gem_exec_fence (nb-await)
[107.095760] Subtest nb-await: SKIP (0.000s)
[107.372733] [025/171] (935s left) gem_exec_gttfill (basic)
[107.781578] Starting subtest: basic
[112.769254] Subtest basic: SUCCESS (5.094s)
[113.137285] [026/171] (929s left) gem_exec_parallel (engines)
[115.155983] Starting subtest: engines
[115.197805] Starting dynamic subtest: basic
[116.690840] Dynamic subtest basic: SUCCESS (1.604s)
[116.741095] Starting dynamic subtest: contexts
[118.400895] Dynamic subtest contexts: SUCCESS (1.757s)
[118.451132] Starting dynamic subtest: fds
[120.870158] Dynamic subtest fds: SUCCESS (2.472s)
[120.912078] Starting dynamic subtest: userptr
[122.563920] Dynamic subtest userptr: SUCCESS (1.664s)
[122.597462] Subtest engines: SUCCESS (7.499s)
[122.758841] [027/171] (920s left) gem_exec_store (basic)
[123.477621] Starting subtest: basic
[123.519492] Subtest basic: SUCCESS (0.036s)
[123.628949] [028/171] (919s left) gem_flink_basic (bad-flink)
[123.962927] Starting subtest: bad-flink
[124.004728] Subtest bad-flink: SUCCESS (0.000s)
[124.114077] [029/171] (919s left) gem_flink_basic (bad-open)
[124.581986] Starting subtest: bad-open
[124.632151] Subtest bad-open: SUCCESS (0.000s)
[124.766438] [030/171] (918s left) gem_flink_basic (basic)
[125.269500] Starting subtest: basic
[125.311389] Subtest basic: SUCCESS (0.000s)
[125.420786] [031/171] (918s left) gem_flink_basic (double-flink)
[125.854801] Starting subtest: double-flink
[125.896771] Subtest double-flink: SUCCESS (0.000s)
[126.006364] [032/171] (918s left) gem_flink_basic (flink-lifetime)
[126.390357] Starting subtest: flink-lifetime
[126.440615] Subtest flink-lifetime: SUCCESS (0.001s)
[126.558335] [033/171] (917s left) gem_huc_copy (huc-copy)
[126.950892] Subtest huc-copy: SKIP (0.000s)
[127.051995] [034/171] (917s left) gem_linear_blits (basic)
[127.536415] Starting subtest: basic
[127.644989] Subtest basic: SUCCESS (0.039s)
[128.021368] [035/171] (916s left) gem_mmap (basic)
[130.116836] Starting subtest: basic
[130.325927] Subtest basic: SUCCESS (0.001s)
[130.418567] [036/171] (914s left) gem_mmap_gtt (basic)
[130.811165] Starting subtest: basic
[130.844526] Subtest basic: SUCCESS (0.001s)
[130.987289] [037/171] (914s left) gem_render_linear_blits (basic)
[131.388450] Starting subtest: basic
[131.597598] Subtest basic: SUCCESS (0.029s)
[131.706754] [038/171] (913s left) gem_render_tiled_blits (basic)
[132.132748] Starting subtest: basic
[132.376807] Subtest basic: SUCCESS (0.035s)
[132.469406] [039/171] (913s left) gem_ringfill (basic-all)
[132.953600] Starting subtest: basic-all
[133.996344] Subtest basic-all: SUCCESS (1.158s)
[134.114533] [040/171] (911s left) gem_softpin (allocator-basic)
[134.690856] Subtest allocator-basic: SKIP (0.000s)
[134.808683] [041/171] (911s left) gem_softpin (allocator-basic-reserve)
[135.301192] Subtest allocator-basic-reserve: SKIP (0.000s)
[135.418982] [042/171] (911s left) gem_softpin (safe-alignment)
[135.861616] Starting subtest: safe-alignment
[135.903484] Subtest safe-alignment: SUCCESS (0.006s)
[136.014656] [043/171] (910s left) gem_sync (basic-all)
[136.482090] Starting subtest: basic-all
[138.367357] Subtest basic-all: SUCCESS (2.024s)
[138.560389] [044/171] (908s left) gem_sync (basic-each)
[139.119844] Starting subtest: basic-each
[141.096949] Subtest basic-each: SUCCESS (2.068s)
[141.248595] [045/171] (905s left) gem_tiled_blits (basic)
[141.649258] Starting subtest: basic
[141.724633] Subtest basic: SUCCESS (0.016s)
[142.100832] [046/171] (904s left) gem_tiled_fence_blits (basic)
[144.271246] Starting subtest: basic
[144.421523] Subtest basic: SUCCESS (0.007s)
[144.822714] [047/171] (902s left) gem_tiled_pread_basic
[147.151540] [048/171] (900s left) gem_wait (busy@all-engines)
[147.652120] Starting subtest: busy
[147.693961] Starting dynamic subtest: all-engines
[148.095217] Dynamic subtest all-engines: SUCCESS (0.510s)
[148.145113] Subtest busy: SUCCESS (0.510s)
[148.321736] [049/171] (899s left) gem_wait (wait@all-engines)
[148.722179] Starting subtest: wait
[148.772348] Starting dynamic subtest: all-engines
[149.650286] Dynamic subtest all-engines: SUCCESS (1.017s)
[149.692171] Subtest wait: SUCCESS (1.018s)
[149.860080] [050/171] (897s left) i915_getparams_basic (basic-eu-total)
[150.394901] Starting subtest: basic-eu-total
[150.461871] Subtest basic-eu-total: SUCCESS (0.000s)
[150.562985] [051/171] (897s left) i915_getparams_basic (basic-subslice-total)
[150.980854] Starting subtest: basic-subslice-total
[151.047823] Subtest basic-subslice-total: SUCCESS (0.000s)
[151.140455] [052/171] (896s left) i915_hangman (error-state-basic)
[151.666162] Starting subtest: error-state-basic
[151.724843] Subtest error-state-basic: SUCCESS (0.005s)
[152.026156] [053/171] (896s left) i915_pciid
[152.621841] [054/171] (895s left) kms_addfb_basic (addfb25-bad-modifier)
[153.499187] Starting subtest: addfb25-bad-modifier
[153.549438] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[154.128934] [055/171] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[154.749268] Starting subtest: addfb25-framebuffer-vs-set-tiling
[154.799553] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[155.253131] [056/171] (893s left) kms_addfb_basic (addfb25-modifier-no-flag)
[155.880301] Starting subtest: addfb25-modifier-no-flag
[155.922273] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[156.344506] [057/171] (892s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[156.912413] Starting subtest: addfb25-x-tiled-legacy
[156.945914] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[157.408713] [058/171] (891s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[158.020180] Starting subtest: addfb25-x-tiled-mismatch-legacy
[158.053662] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[158.508373] [059/171] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[159.303469] Starting subtest: addfb25-yf-tiled-legacy
[159.336358] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[159.632692] [060/171] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[160.452797] Starting subtest: addfb25-y-tiled-legacy
[160.502721] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[160.763742] [061/171] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[161.576617] Starting subtest: addfb25-y-tiled-small-legacy
[161.660493] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[161.879486] [062/171] (887s left) kms_addfb_basic (bad-pitch-0)
[162.313787] Starting subtest: bad-pitch-0
[162.346950] Subtest bad-pitch-0: SUCCESS (0.000s)
[163.029090] [063/171] (886s left) kms_addfb_basic (bad-pitch-1024)
[163.529985] Starting subtest: bad-pitch-1024
[163.563579] Subtest bad-pitch-1024: SUCCESS (0.000s)
[164.286114] [064/171] (885s left) kms_addfb_basic (bad-pitch-128)
[164.788570] Starting subtest: bad-pitch-128
[164.822130] Subtest bad-pitch-128: SUCCESS (0.000s)
[165.376776] [065/171] (884s left) kms_addfb_basic (bad-pitch-256)
[165.902648] Starting subtest: bad-pitch-256
[165.944362] Subtest bad-pitch-256: SUCCESS (0.000s)
[166.533817] [066/171] (883s left) kms_addfb_basic (bad-pitch-32)
[166.968332] Starting subtest: bad-pitch-32
[167.010193] Subtest bad-pitch-32: SUCCESS (0.000s)
[167.607109] [067/171] (882s left) kms_addfb_basic (bad-pitch-63)
[168.091361] Starting subtest: bad-pitch-63
[168.124923] Subtest bad-pitch-63: SUCCESS (0.000s)
[168.731940] [068/171] (881s left) kms_addfb_basic (bad-pitch-65536)
[169.241078] Starting subtest: bad-pitch-65536
[169.282966] Subtest bad-pitch-65536: SUCCESS (0.000s)
[169.848188] [069/171] (880s left) kms_addfb_basic (bad-pitch-999)
[170.298890] Starting subtest: bad-pitch-999
[170.340741] Subtest bad-pitch-999: SUCCESS (0.000s)
[170.912326] [070/171] (879s left) kms_addfb_basic (basic)
[171.404915] Starting subtest: basic
[171.446804] Subtest basic: SUCCESS (0.000s)
[172.011624] [071/171] (878s left) kms_addfb_basic (basic-x-tiled-legacy)
[173.016341] Starting subtest: basic-x-tiled-legacy
[173.060365] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[173.170074] [072/171] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[174.165742] Starting subtest: basic-y-tiled-legacy
[174.207653] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[174.401566] [073/171] (875s left) kms_addfb_basic (bo-too-small)
[175.013397] Starting subtest: bo-too-small
[175.046850] Subtest bo-too-small: SUCCESS (0.000s)
[175.509508] [074/171] (874s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[176.094168] Starting subtest: bo-too-small-due-to-tiling
[176.136120] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[176.633853] [075/171] (873s left) kms_addfb_basic (clobberred-modifier)
[177.159582] Starting subtest: clobberred-modifier
[177.201526] Subtest clobberred-modifier: SUCCESS (0.000s)
[177.756195] [076/171] (872s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[178.719839] Starting subtest: framebuffer-vs-set-tiling
[178.762205] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[178.872254] [077/171] (871s left) kms_addfb_basic (invalid-get-prop)
[179.876141] Starting subtest: invalid-get-prop
[179.918076] Subtest invalid-get-prop: SUCCESS (0.000s)
[180.036257] [078/171] (870s left) kms_addfb_basic (invalid-get-prop-any)
[181.058387] Starting subtest: invalid-get-prop-any
[181.092254] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[181.202376] [079/171] (869s left) kms_addfb_basic (invalid-set-prop)
[182.233714] Starting subtest: invalid-set-prop
[182.267072] Subtest invalid-set-prop: SUCCESS (0.000s)
[182.368916] [080/171] (868s left) kms_addfb_basic (invalid-set-prop-any)
[183.339634] Starting subtest: invalid-set-prop-any
[183.373423] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[183.475202] [081/171] (867s left) kms_addfb_basic (no-handle)
[184.002560] Starting subtest: no-handle
[184.036110] Subtest no-handle: SUCCESS (0.000s)
[184.682912] [082/171] (866s left) kms_addfb_basic (size-max)
[185.284073] Starting subtest: size-max
[185.317526] Subtest size-max: SUCCESS (0.000s)
[186.064088] [083/171] (865s left) kms_addfb_basic (small-bo)
[186.640639] Starting subtest: small-bo
[186.682579] Subtest small-bo: SUCCESS (0.000s)
[187.145129] [084/171] (864s left) kms_addfb_basic (tile-pitch-mismatch)
[188.142094] Starting subtest: tile-pitch-mismatch
[188.184387] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[188.319702] [085/171] (863s left) kms_addfb_basic (too-high)
[188.937424] Starting subtest: too-high
[188.971180] Subtest too-high: SUCCESS (0.001s)
[189.410431] [086/171] (862s left) kms_addfb_basic (too-wide)
[190.028456] Starting subtest: too-wide
[190.070339] Subtest too-wide: SUCCESS (0.000s)
[190.498932] [087/171] (861s left) kms_addfb_basic (unused-handle)
[190.924517] Starting subtest: unused-handle
[190.966438] Subtest unused-handle: SUCCESS (0.000s)
[191.464673] [088/171] (860s left) kms_addfb_basic (unused-modifier)
[191.948198] Starting subtest: unused-modifier
[192.031843] Subtest unused-modifier: SUCCESS (0.000s)
[192.561596] [089/171] (859s left) kms_addfb_basic (unused-offsets)
[193.070199] Starting subtest: unused-offsets
[193.112048] Subtest unused-offsets: SUCCESS (0.000s)
[193.735338] [090/171] (858s left) kms_addfb_basic (unused-pitches)
[194.327728] Starting subtest: unused-pitches
[194.377920] Subtest unused-pitches: SUCCESS (0.000s)
[195.033746] [091/171] (857s left) kms_busy (basic)
[195.761850] Starting subtest: basic
[195.828797] Starting dynamic subtest: flip
[199.997460] Dynamic subtest flip: SUCCESS (4.252s)
[200.047742] Starting dynamic subtest: modeset
[202.362554] Dynamic subtest modeset: SUCCESS (2.346s)
[202.404439] Subtest basic: SUCCESS (6.614s)
[203.066365] [092/171] (849s left) kms_chamelium_hpd (dp-hpd-fast)
[204.102696] Subtest dp-hpd-fast: SKIP (0.000s)
[204.806286] [093/171] (847s left) kms_chamelium_edid (dp-edid-read)
[205.783119] Subtest dp-edid-read: SKIP (0.000s)
[206.570701] [094/171] (846s left) kms_chamelium_frames (dp-crc-fast)
[207.465805] Subtest dp-crc-fast: SKIP (0.000s)
[208.135752] [095/171] (844s left) kms_chamelium_hpd (hdmi-hpd-fast)
[209.062607] Subtest hdmi-hpd-fast: SKIP (0.000s)
[209.734512] [096/171] (843s left) kms_chamelium_edid (hdmi-edid-read)
[210.677617] Subtest hdmi-edid-read: SKIP (0.000s)
[211.339343] [097/171] (841s left) kms_chamelium_frames (hdmi-crc-fast)
[212.174478] Subtest hdmi-crc-fast: SKIP (0.000s)
[212.829622] [098/171] (840s left) kms_chamelium_hpd (vga-hpd-fast)
[213.722984] Subtest vga-hpd-fast: SKIP (0.000s)
[214.325880] [099/171] (838s left) kms_chamelium_edid (vga-edid-read)
[215.228158] Subtest vga-edid-read: SKIP (0.000s)
[216.051158] [100/171] (837s left) kms_prop_blob (basic)
[216.759670] Starting subtest: basic
[216.801778] Subtest basic: SUCCESS (0.000s)
[216.911889] [101/171] (836s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[217.470699] Starting subtest: basic-busy-flip-before-cursor-atomic
[218.664368] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.187s)
[219.503951] [102/171] (834s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[220.096227] Starting subtest: basic-busy-flip-before-cursor-legacy
[221.306605] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.188s)
[221.977236] [103/171] (831s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[222.527475] Starting subtest: basic-flip-after-cursor-atomic
[223.714554] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.177s)
[224.484355] [104/171] (829s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[225.085283] Starting subtest: basic-flip-after-cursor-legacy
[226.320807] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.226s)
[227.057803] [105/171] (826s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[227.735659] Starting subtest: basic-flip-after-cursor-varying-size
[228.879111] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.177s)
[229.826199] [106/171] (824s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[230.493699] Starting subtest: basic-flip-before-cursor-atomic
[231.655465] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.177s)
[232.384299] [107/171] (821s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[232.976447] Starting subtest: basic-flip-before-cursor-legacy
[234.178549] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.184s)
[234.873695] [108/171] (819s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[235.492776] Starting subtest: basic-flip-before-cursor-varying-size
[236.653132] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.176s)
[237.382489] [109/171] (816s left) kms_flip (basic-flip-vs-dpms)
[237.907123] Starting subtest: basic-flip-vs-dpms
[237.940563] Starting dynamic subtest: A-LVDS1
[239.696659] Dynamic subtest A-LVDS1: SUCCESS (1.808s)
[239.746991] Starting dynamic subtest: B-LVDS1
[241.209366] Dynamic subtest B-LVDS1: SUCCESS (1.502s)
[241.251347] Starting dynamic subtest: A-VGA1
[241.941578] Dynamic subtest A-VGA1: SUCCESS (0.712s)
[241.991864] Starting dynamic subtest: B-VGA1
[242.629812] Dynamic subtest B-VGA1: SUCCESS (0.716s)
[242.671747] Subtest basic-flip-vs-dpms: SUCCESS (4.746s)
[243.050384] [110/171] (811s left) kms_flip (basic-flip-vs-modeset)
[243.586735] Starting subtest: basic-flip-vs-modeset
[243.628672] Starting dynamic subtest: A-LVDS1
[245.333895] Dynamic subtest A-LVDS1: SUCCESS (1.776s)
[245.392483] Starting dynamic subtest: B-LVDS1
[246.797952] Dynamic subtest B-LVDS1: SUCCESS (1.500s)
[246.848272] Starting dynamic subtest: A-VGA1
[247.536548] Dynamic subtest A-VGA1: SUCCESS (0.724s)
[247.586765] Starting dynamic subtest: B-VGA1
[248.251946] Dynamic subtest B-VGA1: SUCCESS (0.716s)
[248.302196] Subtest basic-flip-vs-modeset: SUCCESS (4.726s)
[248.445595] [111/171] (806s left) kms_flip (basic-flip-vs-wf_vblank)
[249.055265] Starting subtest: basic-flip-vs-wf_vblank
[249.105415] Starting dynamic subtest: A-LVDS1
[250.850454] Dynamic subtest A-LVDS1: SUCCESS (1.833s)
[250.900705] Starting dynamic subtest: B-LVDS1
[252.714503] Dynamic subtest B-LVDS1: SUCCESS (1.795s)
[252.773262] Starting dynamic subtest: A-VGA1
[253.875372] Dynamic subtest A-VGA1: SUCCESS (1.216s)
[253.925570] Starting dynamic subtest: B-VGA1
[254.835707] Dynamic subtest B-VGA1: SUCCESS (0.967s)
[254.877637] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.825s)
[255.258427] [112/171] (799s left) kms_flip (basic-plain-flip)
[255.776186] Starting subtest: basic-plain-flip
[255.809321] Starting dynamic subtest: A-LVDS1
[257.295741] Dynamic subtest A-LVDS1: SUCCESS (1.507s)
[257.337648] Starting dynamic subtest: B-LVDS1
[258.798758] Dynamic subtest B-LVDS1: SUCCESS (1.487s)
[258.849267] Starting dynamic subtest: A-VGA1
[259.711656] Dynamic subtest A-VGA1: SUCCESS (0.938s)
[259.753585] Starting dynamic subtest: B-VGA1
[260.405308] Dynamic subtest B-VGA1: SUCCESS (0.698s)
[260.438885] Subtest basic-plain-flip: SUCCESS (4.639s)
[260.660346] [113/171] (794s left) kms_force_connector_basic (force-connector-state)
[261.134035] Starting subtest: force-connector-state
[261.619566] Subtest force-connector-state: SUCCESS (0.531s)
[262.744808] [114/171] (792s left) kms_force_connector_basic (force-edid)
[263.310630] Starting subtest: force-edid
[263.352620] Subtest force-edid: SUCCESS (0.244s)
[263.858511] [115/171] (791s left) kms_force_connector_basic (force-load-detect)
[264.326206] Starting subtest: force-load-detect
[264.644205] Subtest force-load-detect: SUCCESS (0.425s)
[265.877947] [116/171] (789s left) kms_force_connector_basic (prune-stale-modes)
[266.336822] Starting subtest: prune-stale-modes
[266.370333] Subtest prune-stale-modes: SUCCESS (0.019s)
[266.834490] [117/171] (788s left) kms_frontbuffer_tracking (basic)
[267.492844] Starting subtest: basic
[269.570567] Subtest basic: SUCCESS (2.215s)
[269.681961] [118/171] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[270.323358] Starting subtest: compare-crc-sanitycheck
[270.357219] Starting dynamic subtest: pipe-A-LVDS-1
[270.860552] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.535s)
[270.902428] Starting dynamic subtest: pipe-B-LVDS-1
[271.696776] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.829s)
[271.738721] Subtest compare-crc-sanitycheck: SUCCESS (1.367s)
[272.451520] [119/171] (782s left) kms_pipe_crc_basic (hang-read-crc)
[272.975777] Starting subtest: hang-read-crc
[273.017971] Starting dynamic subtest: pipe-A-LVDS-1
[274.841680] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.860s)
[274.891967] Starting dynamic subtest: pipe-B-LVDS-1
[277.233895] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.395s)
[277.267571] Subtest hang-read-crc: SUCCESS (4.258s)
[278.155870] [120/171] (777s left) kms_pipe_crc_basic (nonblocking-crc)
[278.739569] Starting subtest: nonblocking-crc
[278.789930] Starting dynamic subtest: pipe-A-LVDS-1
[279.400092] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.687s)
[279.450302] Starting dynamic subtest: pipe-B-LVDS-1
[280.722032] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.292s)
[280.772277] Subtest nonblocking-crc: SUCCESS (1.982s)
[281.476778] [121/171] (774s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[282.093829] Starting subtest: nonblocking-crc-frame-sequence
[282.127420] Starting dynamic subtest: pipe-A-LVDS-1
[282.720873] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.685s)
[282.762731] Starting dynamic subtest: pipe-B-LVDS-1
[284.026331] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.286s)
[284.068187] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.975s)
[284.763804] [122/171] (770s left) kms_pipe_crc_basic (read-crc)
[285.330771] Starting subtest: read-crc
[285.372841] Starting dynamic subtest: pipe-A-LVDS-1
[285.976673] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.626s)
[286.035278] Starting dynamic subtest: pipe-B-LVDS-1
[287.155409] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.175s)
[287.197249] Subtest read-crc: SUCCESS (1.803s)
[287.876796] [123/171] (767s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[288.602086] Starting subtest: read-crc-frame-sequence
[288.635578] Starting dynamic subtest: pipe-A-LVDS-1
[289.214191] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.622s)
[289.264412] Starting dynamic subtest: pipe-B-LVDS-1
[290.459622] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.242s)
[290.493167] Subtest read-crc-frame-sequence: SUCCESS (1.867s)
[291.288394] [124/171] (764s left) kms_psr (primary_page_flip)
[291.914645] Subtest primary_page_flip: SKIP (0.000s)
[292.027669] [125/171] (763s left) kms_psr (cursor_plane_move)
[292.476749] Subtest cursor_plane_move: SKIP (0.000s)
[292.579363] [126/171] (763s left) kms_psr (sprite_plane_onoff)
[293.061942] Subtest sprite_plane_onoff: SKIP (0.000s)
[293.173255] [127/171] (763s left) kms_psr (primary_mmap_gtt)
[293.622452] Subtest primary_mmap_gtt: SKIP (0.000s)
[293.725445] [128/171] (762s left) kms_setmode (basic-clone-single-crtc)
[294.191444] Starting subtest: basic-clone-single-crtc
[294.316937] Subtest basic-clone-single-crtc: SKIP (0.001s)
[294.427056] [129/171] (762s left) i915_pm_backlight (basic-brightness)
[295.054630] Subtest basic-brightness: SKIP (0.000s)
[295.199637] [130/171] (761s left) i915_pm_rpm (basic-pci-d3-state)
[297.176381] Subtest basic-pci-d3-state: SKIP (0.000s)
[297.312390] [131/171] (759s left) i915_pm_rpm (basic-rte)
[297.837149] Starting subtest: basic-rte
[299.266972] Subtest basic-rte: SKIP (1.396s)
[299.495424] [132/171] (757s left) i915_pm_rps (basic-api)
[300.078480] Starting subtest: basic-api
[300.120146] Subtest basic-api: SUCCESS (0.004s)
[300.231500] [133/171] (757s left) prime_self_import (basic-llseek-bad)
[300.655916] Starting subtest: basic-llseek-bad
[300.689064] Subtest basic-llseek-bad: SUCCESS (0.001s)
[300.791319] [134/171] (756s left) prime_self_import (basic-llseek-size)
[301.249664] Starting subtest: basic-llseek-size
[301.291364] Subtest basic-llseek-size: SUCCESS (0.003s)
[301.410349] [135/171] (756s left) prime_self_import (basic-with_fd_dup)
[301.803294] Starting subtest: basic-with_fd_dup
[301.845112] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[301.956240] [136/171] (755s left) prime_self_import (basic-with_one_bo)
[302.389178] Starting subtest: basic-with_one_bo
[302.431089] Subtest basic-with_one_bo: SUCCESS (0.003s)
[302.541469] [137/171] (755s left) prime_self_import (basic-with_one_bo_two_files)
[302.907966] Starting subtest: basic-with_one_bo_two_files
[302.941467] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[303.044442] [138/171] (755s left) prime_self_import (basic-with_two_bos)
[303.443302] Starting subtest: basic-with_two_bos
[303.485209] Subtest basic-with_two_bos: SUCCESS (0.002s)
[303.596663] [139/171] (754s left) prime_vgem (basic-fence-flip)
[304.111680] Starting subtest: basic-fence-flip
[304.322864] Subtest basic-fence-flip: SKIP (0.227s)
[304.501126] [140/171] (753s left) prime_vgem (basic-fence-mmap)
[304.992627] Starting subtest: basic-fence-mmap
[305.026241] Subtest basic-fence-mmap: SUCCESS (0.033s)
[305.179074] [141/171] (753s left) prime_vgem (basic-fence-read)
[305.553195] Starting subtest: basic-fence-read
[305.603354] Subtest basic-fence-read: SUCCESS (0.048s)
[305.789782] [142/171] (752s left) prime_vgem (basic-gtt)
[306.213900] Starting subtest: basic-gtt
[306.247421] Subtest basic-gtt: SUCCESS (0.013s)
[306.391841] [143/171] (752s left) prime_vgem (basic-read)
[306.767989] Starting subtest: basic-read
[306.801560] Subtest basic-read: SUCCESS (0.020s)
[306.938432] [144/171] (752s left) prime_vgem (basic-write)
[307.387152] Starting subtest: basic-write
[307.428930] Subtest basic-write: SUCCESS (0.022s)
[307.573474] [145/171] (751s left) prime_vgem (basic-userptr)
[307.955905] Starting subtest: basic-userptr
[308.022920] Subtest basic-userptr: SKIP (0.009s)
[308.208682] [146/171] (751s left) vgem_basic (setversion)
[308.666685] Starting subtest: setversion
[308.758610] Subtest setversion: SUCCESS (0.000s)
[308.869936] [147/171] (750s left) vgem_basic (create)
[309.328658] Starting subtest: create
[309.370578] Subtest create: SUCCESS (0.000s)
[309.490499] [148/171] (750s left) vgem_basic (debugfs)
[309.940216] Starting subtest: debugfs
[309.973730] Subtest debugfs: SUCCESS (0.001s)
[310.076941] [149/171] (749s left) vgem_basic (dmabuf-export)
[310.542365] Starting subtest: dmabuf-export
[310.584229] Subtest dmabuf-export: SUCCESS (0.002s)
[310.695695] [150/171] (749s left) vgem_basic (dmabuf-fence)
[311.119544] Starting subtest: dmabuf-fence
[311.161363] Subtest dmabuf-fence: SUCCESS (0.001s)
[311.272737] [151/171] (748s left) vgem_basic (dmabuf-fence-before)
[311.665117] Starting subtest: dmabuf-fence-before
[311.698444] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[311.800979] [152/171] (748s left) vgem_basic (dmabuf-mmap)
[312.192084] Starting subtest: dmabuf-mmap
[312.233874] Subtest dmabuf-mmap: SUCCESS (0.017s)
[312.345344] [153/171] (748s left) vgem_basic (mmap)
[312.827835] Starting subtest: mmap
[312.869712] Subtest mmap: SUCCESS (0.011s)
[312.980488] [154/171] (747s left) vgem_basic (second-client)
[313.371768] Starting subtest: second-client
[313.405215] Subtest second-client: SUCCESS (0.049s)
[313.574932] [155/171] (747s left) vgem_basic (sysfs)
[314.032125] Starting subtest: sysfs
[314.073931] Subtest sysfs: SUCCESS (0.001s)
[314.195260] [156/171] (746s left) core_hotunplug (unbind-rebind)
[314.744092] Starting subtest: unbind-rebind
[316.958896] Subtest unbind-rebind: SUCCESS (1.903s)
[317.521358] [157/171] (744s left) vgem_basic (unload)
[318.547490] Starting subtest: unload
[347.465647] Subtest unload: SUCCESS (29.080s)
[347.660490] [158/171] (714s left) i915_module_load (reload)
[348.735544] Starting subtest: reload
[352.511558] Subtest reload: SUCCESS (3.858s)
[352.688640] [159/171] (709s left) gem_lmem_swapping (basic)
[353.665570] Subtest basic: SKIP (0.000s)
[353.892710] [160/171] (708s left) gem_lmem_swapping (parallel-random-engines)
[354.426260] Subtest parallel-random-engines: SKIP (0.000s)
[354.679128] [161/171] (707s left) gem_lmem_swapping (random-engines)
[355.161907] Subtest random-engines: SKIP (0.000s)
[355.406619] [162/171] (707s left) gem_lmem_swapping (verify-random)
[355.957413] Subtest verify-random: SKIP (0.000s)
[356.158914] [163/171] (707s left) i915_pm_rpm (module-reload)
[358.253921] Subtest module-reload: SKIP (0.000s)
[358.498538] [164/171] (704s left) i915_selftest (live)
[359.841855] Starting subtest: live
[359.908685] Starting dynamic subtest: sanitycheck
[360.671540] Dynamic subtest sanitycheck: SUCCESS (0.791s)
[360.746723] Starting dynamic subtest: uncore
[361.374414] Dynamic subtest uncore: SUCCESS (0.733s)
[361.432901] Starting dynamic subtest: workarounds
[362.127079] Dynamic subtest workarounds: SUCCESS (0.721s)
[362.210702] Starting dynamic subtest: gt_engines
[362.839538] Dynamic subtest gt_engines: SUCCESS (0.743s)
[362.897933] Starting dynamic subtest: gt_timelines
[367.020373] Dynamic subtest gt_timelines: SUCCESS (4.145s)
[367.070576] Starting dynamic subtest: gt_contexts
[367.764680] Dynamic subtest gt_contexts: SUCCESS (0.772s)
[367.848099] Starting dynamic subtest: gt_lrc
[368.485709] Dynamic subtest gt_lrc: SUCCESS (0.724s)
[368.535854] Starting dynamic subtest: gt_mocs
[369.188334] Dynamic subtest gt_mocs: SUCCESS (0.709s)
[369.238507] Starting dynamic subtest: gt_pm
[375.491807] Dynamic subtest gt_pm: SUCCESS (6.291s)
[375.541943] Starting dynamic subtest: gt_heartbeat
[376.312447] Dynamic subtest gt_heartbeat: SUCCESS (0.814s)
[376.362647] Starting dynamic subtest: requests
[381.815201] Dynamic subtest requests: SUCCESS (5.502s)
[381.873663] Starting dynamic subtest: migrate
[382.576882] Dynamic subtest migrate: SUCCESS (0.758s)
[382.627068] Starting dynamic subtest: active
[383.349159] Dynamic subtest active: SUCCESS (0.771s)
[383.399273] Starting dynamic subtest: objects
[384.670185] Dynamic subtest objects: SUCCESS (1.317s)
[384.720312] Starting dynamic subtest: mman
[389.288765] Dynamic subtest mman: SUCCESS (4.617s)
[389.347275] Starting dynamic subtest: dmabuf
[390.150171] Dynamic subtest dmabuf: SUCCESS (0.798s)
[390.200400] Starting dynamic subtest: vma
[390.828504] Dynamic subtest vma: SUCCESS (0.741s)
[390.878781] Starting dynamic subtest: coherency
[392.492649] Dynamic subtest coherency: SUCCESS (1.671s)
[392.542782] Starting dynamic subtest: gtt
[396.734355] Dynamic subtest gtt: SUCCESS (4.228s)
[396.792804] Starting dynamic subtest: gem
[397.614995] Dynamic subtest gem: SUCCESS (0.882s)
[397.665083] Starting dynamic subtest: evict
[398.351815] Dynamic subtest evict: SUCCESS (0.737s)
[398.410234] Starting dynamic subtest: hugepages
[399.765902] Dynamic subtest hugepages: SUCCESS (1.405s)
[399.816133] Starting dynamic subtest: gem_contexts
[404.199390] Dynamic subtest gem_contexts: SUCCESS (4.444s)
[404.249521] Starting dynamic subtest: client
[404.962888] Dynamic subtest client: SUCCESS (0.755s)
[405.021361] Starting dynamic subtest: gem_migrate
[405.716367] Dynamic subtest gem_migrate: SUCCESS (0.753s)
[405.766592] Starting dynamic subtest: reset
[406.778642] Dynamic subtest reset: SUCCESS (0.999s)
[406.828897] Starting dynamic subtest: memory_region
[407.441845] Dynamic subtest memory_region: SUCCESS (0.730s)
[407.550362] Starting dynamic subtest: hangcheck
[409.906055] Dynamic subtest hangcheck: SUCCESS (2.455s)
[409.956083] Starting dynamic subtest: execlists
[410.702726] Dynamic subtest execlists: SUCCESS (0.795s)
[410.752837] Starting dynamic subtest: ring_submission
[411.481214] Dynamic subtest ring_submission: SUCCESS (0.781s)
[411.531371] Starting dynamic subtest: perf
[412.226300] Dynamic subtest perf: SUCCESS (0.735s)
[412.284788] Starting dynamic subtest: slpc
[412.939629] Dynamic subtest slpc: SUCCESS (0.719s)
[412.989769] Starting dynamic subtest: guc
[413.676428] Dynamic subtest guc: SUCCESS (0.733s)
[413.734867] Starting dynamic subtest: guc_multi_lrc
[414.438310] Dynamic subtest guc_multi_lrc: SUCCESS (0.765s)
[414.488403] Starting dynamic subtest: guc_hang
[415.210153] Dynamic subtest guc_hang: SUCCESS (0.761s)
[415.260286] Starting dynamic subtest: late_gt_pm
[416.046588] Dynamic subtest late_gt_pm: SUCCESS (0.776s)
[416.088552] Subtest live: SUCCESS (56.107s)
[416.199232] [165/171] (647s left) dmabuf (all-tests)
[417.149584] Starting subtest: all-tests
[417.182940] Starting dynamic subtest: sanitycheck
[417.216489] Dynamic subtest sanitycheck: SUCCESS (0.183s)
[417.258407] Starting dynamic subtest: dma_fence
[417.327210] Dynamic subtest dma_fence: SUCCESS (0.132s)
[417.369095] Starting dynamic subtest: dma_fence_chain
[431.411862] Dynamic subtest dma_fence_chain: SUCCESS (14.079s)
[431.454139] Starting dynamic subtest: dma_fence_unwrap
[431.496115] Dynamic subtest dma_fence_unwrap: SUCCESS (0.025s)
[431.545991] Starting dynamic subtest: dma_resv
[431.587793] Dynamic subtest dma_resv: SUCCESS (0.016s)
[431.629635] Subtest all-tests: SUCCESS (14.441s)
[431.740223] [166/171] (632s left) i915_suspend (basic-s2idle-without-i915)
[432.223678] Starting subtest: basic-s2idle-without-i915
[453.208488] Subtest basic-s2idle-without-i915: SUCCESS (6.355s)
[455.626041] [167/171] (625s left) i915_suspend (basic-s3-without-i915)
[456.685151] Starting subtest: basic-s3-without-i915
[477.277593] Subtest basic-s3-without-i915: SUCCESS (5.723s)
[479.148473] [168/171] (618s left) gem_exec_suspend (basic-s0)
[480.058052] Starting subtest: basic-S0
[480.099894] Starting dynamic subtest: smem
[499.824104] Dynamic subtest smem: SUCCESS (4.329s)
[499.857567] Subtest basic-S0: SUCCESS (4.330s)
[502.062375] [169/171] (613s left) gem_exec_suspend (basic-s3)
[502.703508] Starting subtest: basic-S3
[502.753604] Starting dynamic subtest: smem
[521.956988] Dynamic subtest smem: SUCCESS (4.602s)
[521.998718] Subtest basic-S3: SUCCESS (4.602s)
[524.169008] [170/171] (607s left) kms_chamelium_hpd (common-hpd-after-suspend)
[525.097797] Subtest common-hpd-after-suspend: SKIP (0.000s)
[525.651555] [171/171] (606s left) kms_pipe_crc_basic (suspend-read-crc)
[526.344658] Starting subtest: suspend-read-crc
[526.378512] Starting dynamic subtest: pipe-A-LVDS-1
[546.004574] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.516s)
[546.046506] Starting dynamic subtest: pipe-B-LVDS-1
[567.003421] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.260s)
[567.036886] Subtest suspend-read-crc: SUCCESS (9.778s)
[570.236640] Closing watchdogs
Done.