[81.126736] Initializing watchdogs
[81.127227]   /dev/watchdog0
[81.184130] [001/171] (960s left) i915_module_load (load)
[81.917472] Starting subtest: load
[86.767199] Subtest load: SUCCESS (4.735s)
[87.410525] [002/171] (954s left) core_auth (basic-auth)
[88.437291] Starting subtest: basic-auth
[88.553846] Subtest basic-auth: SUCCESS (0.001s)
[88.813528] [003/171] (953s left) debugfs_test (read_all_entries)
[89.574869] Starting subtest: read_all_entries
[89.616740] Subtest read_all_entries: SUCCESS (0.054s)
[90.053741] [004/171] (952s left) debugfs_test (basic-hwmon)
[90.554258] Starting subtest: basic-hwmon
[90.638092] Subtest basic-hwmon: SKIP (0.000s)
[90.967398] [005/171] (952s left) fbdev (eof)
[91.443308] Starting subtest: eof
[91.485129] Subtest eof: SUCCESS (0.001s)
[91.628226] [006/171] (951s left) fbdev (info)
[92.020383] Starting subtest: info
[92.062235] Subtest info: SUCCESS (0.000s)
[92.213433] [007/171] (951s left) fbdev (nullptr)
[92.630721] Starting subtest: nullptr
[92.672571] Subtest nullptr: SUCCESS (0.000s)
[92.823836] [008/171] (950s left) fbdev (read)
[93.215669] Starting subtest: read
[93.641126] Subtest read: SUCCESS (0.526s)
[93.775918] [009/171] (950s left) fbdev (write)
[94.161328] Starting subtest: write
[94.203547] Subtest write: SUCCESS (0.109s)
[94.362939] [010/171] (949s left) gem_basic (bad-close)
[94.821920] Starting subtest: bad-close
[94.905603] Subtest bad-close: SUCCESS (0.000s)
[95.015157] [011/171] (949s left) gem_basic (create-close)
[95.432345] Starting subtest: create-close
[95.515813] Subtest create-close: SUCCESS (0.000s)
[95.625374] [012/171] (948s left) gem_basic (create-fd-close)
[96.084586] Starting subtest: create-fd-close
[96.168084] Subtest create-fd-close: SUCCESS (0.000s)
[96.277507] [013/171] (948s left) gem_busy (busy@all-engines)
[96.754616] Starting subtest: busy
[96.796804] Starting dynamic subtest: all-engines
[96.846993] Dynamic subtest all-engines: SUCCESS (0.037s)
[96.896847] Subtest busy: SUCCESS (0.038s)
[97.073388] [014/171] (947s left) gem_close_race (basic-process)
[97.615828] Starting subtest: basic-process
[97.649563] Subtest basic-process: SUCCESS (0.051s)
[97.742378] [015/171] (946s left) gem_close_race (basic-threads)
[98.159615] Starting subtest: basic-threads
[99.207303] Subtest basic-threads: SUCCESS (1.166s)
[99.416554] [016/171] (945s left) gem_ctx_create (basic)
[99.951395] Starting subtest: basic
[99.993212] Subtest basic: SUCCESS (0.000s)
[100.102723] [017/171] (944s left) gem_ctx_create (basic-files)
[100.553313] Starting subtest: basic-files
[102.527356] Subtest basic-files: SUCCESS (2.018s)
[102.745812] [018/171] (942s left) gem_ctx_exec (basic)
[103.338395] Starting subtest: basic
[103.380267] Subtest basic: SUCCESS (0.001s)
[103.497989] [019/171] (941s left) gem_exec_basic (basic)
[103.973316] Starting subtest: basic
[104.015406] Starting dynamic subtest: rcs0-smem
[104.057428] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[104.107553] Starting dynamic subtest: bcs0-smem
[104.149399] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[104.199548] Starting dynamic subtest: vcs0-smem
[104.241400] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[104.283183] Subtest basic: SUCCESS (0.001s)
[104.384274] [020/171] (940s left) gem_exec_create (basic)
[104.844619] Starting subtest: basic
[104.886491] Starting dynamic subtest: smem
[106.771107] Dynamic subtest smem: SUCCESS (2.047s)
[106.812678] Subtest basic: SUCCESS (2.048s)
[106.981194] [021/171] (938s left) gem_exec_fence (basic-busy)
[107.882629] Subtest basic-busy: SKIP (0.000s)
[108.217755] [022/171] (937s left) gem_exec_fence (basic-wait)
[108.786117] Subtest basic-wait: SKIP (0.000s)
[109.055590] [023/171] (936s left) gem_exec_fence (basic-await)
[109.699140] Subtest basic-await: SKIP (0.000s)
[109.959122] [024/171] (935s left) gem_exec_fence (nb-await)
[110.501854] Subtest nb-await: SKIP (0.000s)
[110.762216] [025/171] (934s left) gem_exec_gttfill (basic)
[111.229256] Starting subtest: basic
[116.608058] Subtest basic: SUCCESS (5.471s)
[116.867653] [026/171] (928s left) gem_exec_parallel (engines)
[119.252302] Starting subtest: engines
[119.285782] Starting dynamic subtest: basic
[120.803160] Dynamic subtest basic: SUCCESS (1.640s)
[120.844973] Starting dynamic subtest: contexts
[122.695660] Dynamic subtest contexts: SUCCESS (1.921s)
[122.737494] Starting dynamic subtest: fds
[125.237238] Dynamic subtest fds: SUCCESS (2.542s)
[125.279107] Starting dynamic subtest: userptr
[127.022095] Dynamic subtest userptr: SUCCESS (1.756s)
[127.063310] Subtest engines: SUCCESS (7.860s)
[127.214925] [027/171] (918s left) gem_exec_store (basic)
[127.958368] Starting subtest: basic
[127.999980] Subtest basic: SUCCESS (0.042s)
[128.109314] [028/171] (917s left) gem_flink_basic (bad-flink)
[128.578624] Starting subtest: bad-flink
[128.620284] Subtest bad-flink: SUCCESS (0.000s)
[128.729827] [029/171] (917s left) gem_flink_basic (bad-open)
[129.138862] Starting subtest: bad-open
[129.180707] Subtest bad-open: SUCCESS (0.000s)
[129.298478] [030/171] (916s left) gem_flink_basic (basic)
[129.724531] Starting subtest: basic
[129.766305] Subtest basic: SUCCESS (0.000s)
[129.884213] [031/171] (916s left) gem_flink_basic (double-flink)
[130.318162] Starting subtest: double-flink
[130.368333] Subtest double-flink: SUCCESS (0.000s)
[130.477694] [032/171] (916s left) gem_flink_basic (flink-lifetime)
[130.886655] Starting subtest: flink-lifetime
[130.930234] Subtest flink-lifetime: SUCCESS (0.001s)
[131.039352] [033/171] (915s left) gem_huc_copy (huc-copy)
[131.657160] Subtest huc-copy: SKIP (0.000s)
[131.775076] [034/171] (915s left) gem_linear_blits (basic)
[132.267441] Starting subtest: basic
[132.409423] Subtest basic: SUCCESS (0.010s)
[132.877374] [035/171] (914s left) gem_mmap (basic)
[135.203342] Starting subtest: basic
[135.412378] Subtest basic: SUCCESS (0.001s)
[135.521660] [036/171] (911s left) gem_mmap_gtt (basic)
[136.015691] Starting subtest: basic
[136.057617] Subtest basic: SUCCESS (0.001s)
[136.175089] [037/171] (911s left) gem_render_linear_blits (basic)
[136.667882] Starting subtest: basic
[136.918605] Subtest basic: SUCCESS (0.022s)
[137.036199] [038/171] (911s left) gem_render_tiled_blits (basic)
[137.528718] Starting subtest: basic
[137.779546] Subtest basic: SUCCESS (0.033s)
[137.880449] [039/171] (910s left) gem_ringfill (basic-all)
[138.531269] Starting subtest: basic-all
[139.565131] Subtest basic-all: SUCCESS (1.167s)
[139.684820] [040/171] (909s left) gem_softpin (allocator-basic)
[140.169368] Subtest allocator-basic: SKIP (0.000s)
[140.278744] [041/171] (908s left) gem_softpin (allocator-basic-reserve)
[140.704789] Subtest allocator-basic-reserve: SKIP (0.000s)
[140.805803] [042/171] (908s left) gem_softpin (safe-alignment)
[141.256659] Starting subtest: safe-alignment
[141.298496] Subtest safe-alignment: SUCCESS (0.007s)
[141.416328] [043/171] (908s left) gem_sync (basic-all)
[141.958491] Starting subtest: basic-all
[143.969463] Subtest basic-all: SUCCESS (2.195s)
[144.154300] [044/171] (905s left) gem_sync (basic-each)
[144.646897] Starting subtest: basic-each
[146.606325] Subtest basic-each: SUCCESS (2.068s)
[146.749627] [045/171] (902s left) gem_tiled_blits (basic)
[147.308799] Starting subtest: basic
[147.417105] Subtest basic: SUCCESS (0.013s)
[147.868509] [046/171] (901s left) gem_tiled_fence_blits (basic)
[150.194293] Starting subtest: basic
[150.303000] Subtest basic: SUCCESS (0.007s)
[150.772311] [047/171] (899s left) gem_tiled_pread_basic
[153.183115] [048/171] (896s left) gem_wait (busy@all-engines)
[153.675318] Starting subtest: busy
[153.717146] Starting dynamic subtest: all-engines
[154.109997] Dynamic subtest all-engines: SUCCESS (0.507s)
[154.151229] Subtest busy: SUCCESS (0.507s)
[154.302632] [049/171] (895s left) gem_wait (wait@all-engines)
[154.728351] Starting subtest: wait
[154.778496] Starting dynamic subtest: all-engines
[155.646046] Dynamic subtest all-engines: SUCCESS (1.018s)
[155.687624] Subtest wait: SUCCESS (1.018s)
[155.857492] [050/171] (894s left) i915_getparams_basic (basic-eu-total)
[156.416740] Starting subtest: basic-eu-total
[156.509087] Subtest basic-eu-total: SUCCESS (0.000s)
[156.626960] [051/171] (893s left) i915_getparams_basic (basic-subslice-total)
[157.094214] Starting subtest: basic-subslice-total
[157.194547] Subtest basic-subslice-total: SUCCESS (0.000s)
[157.321152] [052/171] (893s left) i915_hangman (error-state-basic)
[157.846243] Starting subtest: error-state-basic
[157.954743] Subtest error-state-basic: SUCCESS (0.005s)
[158.197820] [053/171] (893s left) i915_pciid
[158.851401] [054/171] (892s left) kms_addfb_basic (addfb25-bad-modifier)
[159.402300] Starting subtest: addfb25-bad-modifier
[159.477403] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[160.214843] [055/171] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[160.707274] Starting subtest: addfb25-framebuffer-vs-set-tiling
[160.749153] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[161.120643] [056/171] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[161.613104] Starting subtest: addfb25-modifier-no-flag
[161.646667] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[162.017157] [057/171] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[162.501250] Starting subtest: addfb25-x-tiled-legacy
[162.543198] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[162.939527] [058/171] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[163.431925] Starting subtest: addfb25-x-tiled-mismatch-legacy
[163.465373] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[163.885501] [059/171] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[164.503851] Starting subtest: addfb25-yf-tiled-legacy
[164.555530] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[164.857735] [060/171] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[165.467768] Starting subtest: addfb25-y-tiled-legacy
[165.509567] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[165.820101] [061/171] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[166.413475] Starting subtest: addfb25-y-tiled-small-legacy
[166.497232] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[166.751340] [062/171] (885s left) kms_addfb_basic (bad-pitch-0)
[167.293997] Starting subtest: bad-pitch-0
[167.335842] Subtest bad-pitch-0: SUCCESS (0.000s)
[167.739261] [063/171] (884s left) kms_addfb_basic (bad-pitch-1024)
[168.206640] Starting subtest: bad-pitch-1024
[168.240146] Subtest bad-pitch-1024: SUCCESS (0.000s)
[168.611682] [064/171] (884s left) kms_addfb_basic (bad-pitch-128)
[169.171034] Starting subtest: bad-pitch-128
[169.212865] Subtest bad-pitch-128: SUCCESS (0.000s)
[169.574267] [065/171] (883s left) kms_addfb_basic (bad-pitch-256)
[170.100079] Starting subtest: bad-pitch-256
[170.142835] Subtest bad-pitch-256: SUCCESS (0.000s)
[170.521717] [066/171] (882s left) kms_addfb_basic (bad-pitch-32)
[171.056758] Starting subtest: bad-pitch-32
[171.106140] Subtest bad-pitch-32: SUCCESS (0.000s)
[171.417283] [067/171] (881s left) kms_addfb_basic (bad-pitch-63)
[171.851538] Starting subtest: bad-pitch-63
[171.885289] Subtest bad-pitch-63: SUCCESS (0.000s)
[172.306317] [068/171] (880s left) kms_addfb_basic (bad-pitch-65536)
[172.824029] Starting subtest: bad-pitch-65536
[172.865935] Subtest bad-pitch-65536: SUCCESS (0.000s)
[173.211285] [069/171] (879s left) kms_addfb_basic (bad-pitch-999)
[173.704103] Starting subtest: bad-pitch-999
[173.746044] Subtest bad-pitch-999: SUCCESS (0.000s)
[174.157616] [070/171] (879s left) kms_addfb_basic (basic)
[174.651855] Starting subtest: basic
[174.685443] Subtest basic: SUCCESS (0.000s)
[175.130269] [071/171] (878s left) kms_addfb_basic (basic-x-tiled-legacy)
[175.656363] Starting subtest: basic-x-tiled-legacy
[175.706561] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[176.034538] [072/171] (877s left) kms_addfb_basic (basic-y-tiled-legacy)
[176.537183] Starting subtest: basic-y-tiled-legacy
[176.579062] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[176.964986] [073/171] (876s left) kms_addfb_basic (bo-too-small)
[177.500237] Starting subtest: bo-too-small
[177.533856] Subtest bo-too-small: SUCCESS (0.000s)
[177.778234] [074/171] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[178.331031] Starting subtest: bo-too-small-due-to-tiling
[178.372868] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[178.692399] [075/171] (875s left) kms_addfb_basic (clobberred-modifier)
[179.201634] Starting subtest: clobberred-modifier
[179.243543] Subtest clobberred-modifier: SUCCESS (0.000s)
[179.612892] [076/171] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[180.124103] Starting subtest: framebuffer-vs-set-tiling
[180.165976] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[180.502287] [077/171] (873s left) kms_addfb_basic (invalid-get-prop)
[180.969811] Starting subtest: invalid-get-prop
[181.011735] Subtest invalid-get-prop: SUCCESS (0.000s)
[181.373089] [078/171] (872s left) kms_addfb_basic (invalid-get-prop-any)
[181.875695] Starting subtest: invalid-get-prop-any
[181.917611] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[182.203822] [079/171] (872s left) kms_addfb_basic (invalid-set-prop)
[182.713217] Starting subtest: invalid-set-prop
[182.755091] Subtest invalid-set-prop: SUCCESS (0.000s)
[183.066669] [080/171] (871s left) kms_addfb_basic (invalid-set-prop-any)
[183.542074] Starting subtest: invalid-set-prop-any
[183.585591] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[183.955697] [081/171] (870s left) kms_addfb_basic (no-handle)
[184.456755] Starting subtest: no-handle
[184.498596] Subtest no-handle: SUCCESS (0.000s)
[184.876335] [082/171] (869s left) kms_addfb_basic (size-max)
[185.463197] Starting subtest: size-max
[185.496664] Subtest size-max: SUCCESS (0.000s)
[185.782820] [083/171] (868s left) kms_addfb_basic (small-bo)
[186.367576] Starting subtest: small-bo
[186.409407] Subtest small-bo: SUCCESS (0.000s)
[186.670340] [084/171] (868s left) kms_addfb_basic (tile-pitch-mismatch)
[187.161886] Starting subtest: tile-pitch-mismatch
[187.195499] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[187.523477] [085/171] (867s left) kms_addfb_basic (too-high)
[188.200154] Starting subtest: too-high
[188.250393] Subtest too-high: SUCCESS (0.001s)
[188.485878] [086/171] (866s left) kms_addfb_basic (too-wide)
[189.072372] Starting subtest: too-wide
[189.114300] Subtest too-wide: SUCCESS (0.000s)
[189.383476] [087/171] (865s left) kms_addfb_basic (unused-handle)
[189.901246] Starting subtest: unused-handle
[189.943160] Subtest unused-handle: SUCCESS (0.000s)
[190.329996] [088/171] (864s left) kms_addfb_basic (unused-modifier)
[190.790488] Starting subtest: unused-modifier
[190.824117] Subtest unused-modifier: SUCCESS (0.000s)
[191.218995] [089/171] (863s left) kms_addfb_basic (unused-offsets)
[191.744699] Starting subtest: unused-offsets
[191.786569] Subtest unused-offsets: SUCCESS (0.000s)
[192.173469] [090/171] (863s left) kms_addfb_basic (unused-pitches)
[192.650697] Starting subtest: unused-pitches
[192.684280] Subtest unused-pitches: SUCCESS (0.000s)
[193.096532] [091/171] (862s left) kms_busy (basic)
[193.730729] Starting subtest: basic
[193.789261] Starting dynamic subtest: flip
[197.957793] Dynamic subtest flip: SUCCESS (4.259s)
[198.008086] Starting dynamic subtest: modeset
[200.306023] Dynamic subtest modeset: SUCCESS (2.333s)
[200.347825] Subtest basic: SUCCESS (6.595s)
[201.227331] [092/171] (854s left) kms_chamelium_hpd (dp-hpd-fast)
[202.213499] Subtest dp-hpd-fast: SKIP (0.000s)
[202.975654] [093/171] (852s left) kms_chamelium_edid (dp-edid-read)
[203.926670] Subtest dp-edid-read: SKIP (0.000s)
[204.671685] [094/171] (851s left) kms_chamelium_frames (dp-crc-fast)
[205.633614] Subtest dp-crc-fast: SKIP (0.000s)
[206.387064] [095/171] (849s left) kms_chamelium_hpd (hdmi-hpd-fast)
[207.296609] Subtest hdmi-hpd-fast: SKIP (0.000s)
[208.102339] [096/171] (847s left) kms_chamelium_edid (hdmi-edid-read)
[209.028444] Subtest hdmi-edid-read: SKIP (0.000s)
[209.798427] [097/171] (846s left) kms_chamelium_frames (hdmi-crc-fast)
[210.691714] Subtest hdmi-crc-fast: SKIP (0.000s)
[211.497059] [098/171] (844s left) kms_chamelium_hpd (vga-hpd-fast)
[212.414948] Subtest vga-hpd-fast: SKIP (0.000s)
[213.218621] [099/171] (843s left) kms_chamelium_edid (vga-edid-read)
[214.129927] Subtest vga-edid-read: SKIP (0.000s)
[214.916428] [100/171] (841s left) kms_prop_blob (basic)
[215.492523] Starting subtest: basic
[215.534356] Subtest basic: SUCCESS (0.000s)
[215.643981] [101/171] (841s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[216.203269] Starting subtest: basic-busy-flip-before-cursor-atomic
[217.414795] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.215s)
[218.327914] [102/171] (838s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[218.903435] Starting subtest: basic-busy-flip-before-cursor-legacy
[220.071230] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.188s)
[220.994510] [103/171] (835s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[221.569943] Starting subtest: basic-flip-after-cursor-atomic
[222.738200] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.177s)
[223.694196] [104/171] (833s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[224.311840] Starting subtest: basic-flip-after-cursor-legacy
[225.504650] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.197s)
[226.417917] [105/171] (830s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[226.984457] Starting subtest: basic-flip-after-cursor-varying-size
[228.170993] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.184s)
[229.124825] [106/171] (828s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[229.784468] Starting subtest: basic-flip-before-cursor-atomic
[230.994453] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.230s)
[231.892680] [107/171] (825s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[232.535130] Starting subtest: basic-flip-before-cursor-legacy
[233.711091] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.205s)
[234.725584] [108/171] (822s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[235.292611] Starting subtest: basic-flip-before-cursor-varying-size
[236.477553] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.176s)
[237.382110] [109/171] (820s left) kms_flip (basic-flip-vs-dpms)
[237.973827] Starting subtest: basic-flip-vs-dpms
[238.017375] Starting dynamic subtest: A-LVDS1
[239.662738] Dynamic subtest A-LVDS1: SUCCESS (1.743s)
[239.713023] Starting dynamic subtest: B-LVDS1
[241.165861] Dynamic subtest B-LVDS1: SUCCESS (1.490s)
[241.216119] Starting dynamic subtest: A-VGA1
[241.897265] Dynamic subtest A-VGA1: SUCCESS (0.727s)
[241.947510] Starting dynamic subtest: B-VGA1
[242.627338] Dynamic subtest B-VGA1: SUCCESS (0.729s)
[242.677496] Subtest basic-flip-vs-dpms: SUCCESS (4.700s)
[243.065660] [110/171] (814s left) kms_flip (basic-flip-vs-modeset)
[243.591946] Starting subtest: basic-flip-vs-modeset
[243.633824] Starting dynamic subtest: A-LVDS1
[245.254512] Dynamic subtest A-LVDS1: SUCCESS (1.773s)
[245.297962] Starting dynamic subtest: B-LVDS1
[246.759504] Dynamic subtest B-LVDS1: SUCCESS (1.488s)
[246.809780] Starting dynamic subtest: A-VGA1
[247.481139] Dynamic subtest A-VGA1: SUCCESS (0.731s)
[247.533082] Starting dynamic subtest: B-VGA1
[248.204316] Dynamic subtest B-VGA1: SUCCESS (0.720s)
[248.237852] Subtest basic-flip-vs-modeset: SUCCESS (4.728s)
[248.658275] [111/171] (809s left) kms_flip (basic-flip-vs-wf_vblank)
[249.202344] Starting subtest: basic-flip-vs-wf_vblank
[249.244211] Starting dynamic subtest: A-LVDS1
[250.896538] Dynamic subtest A-LVDS1: SUCCESS (1.754s)
[250.955068] Starting dynamic subtest: B-LVDS1
[252.924269] Dynamic subtest B-LVDS1: SUCCESS (1.969s)
[252.974813] Starting dynamic subtest: A-VGA1
[254.101701] Dynamic subtest A-VGA1: SUCCESS (1.225s)
[254.153600] Starting dynamic subtest: B-VGA1
[255.088329] Dynamic subtest B-VGA1: SUCCESS (0.979s)
[255.130200] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.941s)
[255.575427] [112/171] (802s left) kms_flip (basic-plain-flip)
[256.076200] Starting subtest: basic-plain-flip
[256.118133] Starting dynamic subtest: A-LVDS1
[257.645363] Dynamic subtest A-LVDS1: SUCCESS (1.579s)
[257.697250] Starting dynamic subtest: B-LVDS1
[259.141288] Dynamic subtest B-LVDS1: SUCCESS (1.488s)
[259.191489] Starting dynamic subtest: A-VGA1
[260.101704] Dynamic subtest A-VGA1: SUCCESS (0.932s)
[260.151942] Starting dynamic subtest: B-VGA1
[260.753072] Dynamic subtest B-VGA1: SUCCESS (0.681s)
[260.794777] Subtest basic-plain-flip: SUCCESS (4.696s)
[261.228073] [113/171] (796s left) kms_force_connector_basic (force-connector-state)
[261.776789] Starting subtest: force-connector-state
[262.236820] Subtest force-connector-state: SUCCESS (0.560s)
[263.503921] [114/171] (794s left) kms_force_connector_basic (force-edid)
[264.153138] Starting subtest: force-edid
[264.194969] Subtest force-edid: SUCCESS (0.253s)
[264.767732] [115/171] (793s left) kms_force_connector_basic (force-load-detect)
[265.216808] Starting subtest: force-load-detect
[265.486098] Subtest force-load-detect: SUCCESS (0.387s)
[266.040882] [116/171] (792s left) kms_force_connector_basic (prune-stale-modes)
[266.557898] Starting subtest: prune-stale-modes
[266.599767] Subtest prune-stale-modes: SUCCESS (0.021s)
[267.107598] [117/171] (791s left) kms_frontbuffer_tracking (basic)
[267.865731] Starting subtest: basic
[269.967280] Subtest basic: SUCCESS (2.242s)
[270.279519] [118/171] (788s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[270.954270] Starting subtest: compare-crc-sanitycheck-xr24
[271.038121] Starting dynamic subtest: pipe-A-LVDS-1
[271.497632] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.529s)
[271.547847] Starting dynamic subtest: pipe-B-LVDS-1
[272.493198] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.916s)
[272.535145] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.451s)
[273.431518] [119/171] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[274.030590] Starting subtest: compare-crc-sanitycheck-nv12
[274.072367] Starting dynamic subtest: pipe-A-LVDS-1
[274.156192] Dynamic subtest pipe-A-LVDS-1: SKIP (0.000s)
[274.206372] Starting dynamic subtest: pipe-B-LVDS-1
[274.332214] Dynamic subtest pipe-B-LVDS-1: SKIP (0.000s)
[274.415836] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[274.535472] [120/171] (784s left) kms_pipe_crc_basic (hang-read-crc)
[275.095110] Starting subtest: hang-read-crc
[275.137224] Starting dynamic subtest: pipe-A-LVDS-1
[276.975095] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.864s)
[277.025332] Starting dynamic subtest: pipe-B-LVDS-1
[279.349288] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.390s)
[279.391313] Subtest hang-read-crc: SUCCESS (4.260s)
[280.313743] [121/171] (778s left) kms_pipe_crc_basic (nonblocking-crc)
[280.906512] Starting subtest: nonblocking-crc
[280.956861] Starting dynamic subtest: pipe-A-LVDS-1
[281.583363] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.695s)
[281.633567] Starting dynamic subtest: pipe-B-LVDS-1
[282.819891] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.227s)
[282.861858] Subtest nonblocking-crc: SUCCESS (1.926s)
[283.785769] [122/171] (775s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[284.443296] Starting subtest: nonblocking-crc-frame-sequence
[284.477243] Starting dynamic subtest: pipe-A-LVDS-1
[285.153771] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.683s)
[285.195668] Starting dynamic subtest: pipe-B-LVDS-1
[286.423400] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.260s)
[286.465271] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.948s)
[287.397572] [123/171] (771s left) kms_pipe_crc_basic (read-crc)
[287.921807] Starting subtest: read-crc
[287.963823] Starting dynamic subtest: pipe-A-LVDS-1
[288.531666] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.649s)
[288.581896] Starting dynamic subtest: pipe-B-LVDS-1
[289.752980] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.209s)
[289.794921] Subtest read-crc: SUCCESS (1.865s)
[290.749213] [124/171] (768s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[291.383197] Starting subtest: read-crc-frame-sequence
[291.433562] Starting dynamic subtest: pipe-A-LVDS-1
[292.009876] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.641s)
[292.060070] Starting dynamic subtest: pipe-B-LVDS-1
[293.239378] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.226s)
[293.281240] Subtest read-crc-frame-sequence: SUCCESS (1.872s)
[294.184790] [125/171] (765s left) kms_psr (primary_page_flip)
[294.802812] Subtest primary_page_flip: SKIP (0.000s)
[294.922561] [126/171] (764s left) kms_psr (cursor_plane_move)
[295.438292] Subtest cursor_plane_move: SKIP (0.000s)
[295.559475] [127/171] (763s left) kms_psr (sprite_plane_onoff)
[296.041813] Subtest sprite_plane_onoff: SKIP (0.000s)
[296.161279] [128/171] (763s left) kms_psr (primary_mmap_gtt)
[296.702127] Subtest primary_mmap_gtt: SKIP (0.000s)
[296.813187] [129/171] (763s left) kms_setmode (basic-clone-single-crtc)
[297.253895] Starting subtest: basic-clone-single-crtc
[297.354217] Subtest basic-clone-single-crtc: SKIP (0.001s)
[297.465628] [130/171] (762s left) i915_pm_backlight (basic-brightness)
[298.265117] Subtest basic-brightness: SKIP (0.000s)
[298.403308] [131/171] (761s left) i915_pm_rpm (basic-pci-d3-state)
[300.438409] Subtest basic-pci-d3-state: SKIP (0.000s)
[300.557960] [132/171] (759s left) i915_pm_rpm (basic-rte)
[300.914857] Starting subtest: basic-rte
[302.402806] Subtest basic-rte: SKIP (1.397s)
[302.613870] [133/171] (757s left) i915_pm_rps (basic-api)
[303.213682] Starting subtest: basic-api
[303.255555] Subtest basic-api: SUCCESS (0.003s)
[303.416415] [134/171] (757s left) prime_self_import (basic-llseek-bad)
[303.857232] Starting subtest: basic-llseek-bad
[303.940876] Subtest basic-llseek-bad: SUCCESS (0.002s)
[304.058913] [135/171] (756s left) prime_self_import (basic-llseek-size)
[304.509313] Starting subtest: basic-llseek-size
[304.592873] Subtest basic-llseek-size: SUCCESS (0.003s)
[304.703284] [136/171] (756s left) prime_self_import (basic-with_fd_dup)
[305.104846] Starting subtest: basic-with_fd_dup
[305.171857] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[305.273661] [137/171] (755s left) prime_self_import (basic-with_one_bo)
[305.631741] Starting subtest: basic-with_one_bo
[305.715527] Subtest basic-with_one_bo: SUCCESS (0.003s)
[305.825603] [138/171] (755s left) prime_self_import (basic-with_one_bo_two_files)
[306.200312] Starting subtest: basic-with_one_bo_two_files
[306.284204] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[306.394759] [139/171] (754s left) prime_self_import (basic-with_two_bos)
[306.802456] Starting subtest: basic-with_two_bos
[306.885945] Subtest basic-with_two_bos: SUCCESS (0.003s)
[307.005420] [140/171] (754s left) prime_vgem (basic-fence-flip)
[307.489324] Starting subtest: basic-fence-flip
[307.648323] Subtest basic-fence-flip: SKIP (0.222s)
[307.961169] [141/171] (753s left) prime_vgem (basic-fence-mmap)
[308.460384] Starting subtest: basic-fence-mmap
[308.502290] Subtest basic-fence-mmap: SUCCESS (0.032s)
[308.712892] [142/171] (753s left) prime_vgem (basic-fence-read)
[309.262840] Starting subtest: basic-fence-read
[309.304623] Subtest basic-fence-read: SUCCESS (0.052s)
[309.456766] [143/171] (752s left) prime_vgem (basic-gtt)
[310.000196] Starting subtest: basic-gtt
[310.042141] Subtest basic-gtt: SUCCESS (0.018s)
[310.202551] [144/171] (751s left) prime_vgem (basic-read)
[310.694243] Starting subtest: basic-read
[310.736139] Subtest basic-read: SUCCESS (0.022s)
[310.897309] [145/171] (751s left) prime_vgem (basic-write)
[311.338233] Starting subtest: basic-write
[311.371768] Subtest basic-write: SUCCESS (0.024s)
[311.508172] [146/171] (750s left) vgem_basic (setversion)
[312.048644] Starting subtest: setversion
[312.115564] Subtest setversion: SUCCESS (0.000s)
[312.218444] [147/171] (750s left) vgem_basic (create)
[312.719126] Starting subtest: create
[312.760832] Subtest create: SUCCESS (0.000s)
[312.880446] [148/171] (749s left) vgem_basic (debugfs)
[313.304423] Starting subtest: debugfs
[313.346115] Subtest debugfs: SUCCESS (0.001s)
[313.456165] [149/171] (749s left) vgem_basic (dmabuf-export)
[313.914528] Starting subtest: dmabuf-export
[313.998259] Subtest dmabuf-export: SUCCESS (0.002s)
[314.116874] [150/171] (748s left) vgem_basic (dmabuf-fence)
[314.583592] Starting subtest: dmabuf-fence
[314.625389] Subtest dmabuf-fence: SUCCESS (0.001s)
[314.736501] [151/171] (748s left) vgem_basic (dmabuf-fence-before)
[315.195513] Starting subtest: dmabuf-fence-before
[315.237369] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[315.348815] [152/171] (748s left) vgem_basic (dmabuf-mmap)
[315.780754] Starting subtest: dmabuf-mmap
[315.822625] Subtest dmabuf-mmap: SUCCESS (0.018s)
[315.933478] [153/171] (747s left) vgem_basic (mmap)
[316.374464] Starting subtest: mmap
[316.416232] Subtest mmap: SUCCESS (0.012s)
[316.527379] [154/171] (747s left) vgem_basic (second-client)
[316.993129] Starting subtest: second-client
[317.076757] Subtest second-client: SUCCESS (0.033s)
[317.196261] [155/171] (746s left) vgem_basic (sysfs)
[317.603334] Starting subtest: sysfs
[317.645351] Subtest sysfs: SUCCESS (0.001s)
[317.774786] [156/171] (746s left) core_hotunplug (unbind-rebind)
[318.556925] Starting subtest: unbind-rebind
[320.428277] Subtest unbind-rebind: SUCCESS (1.648s)
[321.106326] [157/171] (743s left) vgem_basic (unload)
[322.149253] Starting subtest: unload
[351.130168] Subtest unload: SUCCESS (29.197s)
[351.433336] [158/171] (713s left) i915_module_load (reload)
[352.532736] Starting subtest: reload
[356.831583] Subtest reload: SUCCESS (4.420s)
[357.067034] [159/171] (708s left) gem_lmem_swapping (basic)
[358.143386] Subtest basic: SKIP (0.000s)
[358.312407] [160/171] (707s left) gem_lmem_swapping (parallel-random-engines)
[358.905405] Subtest parallel-random-engines: SKIP (0.000s)
[359.107242] [161/171] (706s left) gem_lmem_swapping (random-engines)
[359.690804] Subtest random-engines: SKIP (0.000s)
[359.917645] [162/171] (706s left) gem_lmem_swapping (verify-random)
[360.484867] Subtest verify-random: SKIP (0.000s)
[360.686088] [163/171] (705s left) i915_pm_rpm (module-reload)
[362.648941] Subtest module-reload: SKIP (0.000s)
[362.842118] [164/171] (703s left) i915_selftest (live)
[364.360835] Starting subtest: live
[364.460977] Starting dynamic subtest: sanitycheck
[365.238257] Dynamic subtest sanitycheck: SUCCESS (0.904s)
[365.296788] Starting dynamic subtest: uncore
[366.134374] Dynamic subtest uncore: SUCCESS (0.888s)
[366.201143] Starting dynamic subtest: workarounds
[366.979137] Dynamic subtest workarounds: SUCCESS (0.847s)
[367.045831] Starting dynamic subtest: gt_engines
[367.831722] Dynamic subtest gt_engines: SUCCESS (0.817s)
[367.890138] Starting dynamic subtest: gt_timelines
[372.521701] Dynamic subtest gt_timelines: SUCCESS (4.687s)
[372.605173] Starting dynamic subtest: gt_contexts
[373.415634] Dynamic subtest gt_contexts: SUCCESS (0.881s)
[373.507564] Starting dynamic subtest: gt_lrc
[374.242837] Dynamic subtest gt_lrc: SUCCESS (0.841s)
[374.301315] Starting dynamic subtest: gt_mocs
[375.138877] Dynamic subtest gt_mocs: SUCCESS (0.890s)
[375.222324] Starting dynamic subtest: gt_pm
[381.412565] Dynamic subtest gt_pm: SUCCESS (6.315s)
[381.462676] Starting dynamic subtest: gt_heartbeat
[382.375871] Dynamic subtest gt_heartbeat: SUCCESS (0.954s)
[382.425924] Starting dynamic subtest: gt_tlb
[383.253789] Dynamic subtest gt_tlb: SUCCESS (0.869s)
[383.303852] Starting dynamic subtest: requests
[388.769872] Dynamic subtest requests: SUCCESS (5.521s)
[388.828281] Starting dynamic subtest: migrate
[389.730918] Dynamic subtest migrate: SUCCESS (0.957s)
[389.781089] Starting dynamic subtest: active
[390.644050] Dynamic subtest active: SUCCESS (0.911s)
[390.694108] Starting dynamic subtest: objects
[392.072570] Dynamic subtest objects: SUCCESS (1.429s)
[392.122562] Starting dynamic subtest: mman
[396.646852] Dynamic subtest mman: SUCCESS (4.571s)
[396.696982] Starting dynamic subtest: dmabuf
[397.667056] Dynamic subtest dmabuf: SUCCESS (1.018s)
[397.717121] Starting dynamic subtest: vma
[398.495133] Dynamic subtest vma: SUCCESS (0.817s)
[398.545269] Starting dynamic subtest: coherency
[400.325132] Dynamic subtest coherency: SUCCESS (1.834s)
[400.375221] Starting dynamic subtest: gtt
[404.623149] Dynamic subtest gtt: SUCCESS (4.300s)
[404.674928] Starting dynamic subtest: gem
[405.595472] Dynamic subtest gem: SUCCESS (0.964s)
[405.645667] Starting dynamic subtest: evict
[406.481947] Dynamic subtest evict: SUCCESS (0.885s)
[406.532042] Starting dynamic subtest: hugepages
[407.895217] Dynamic subtest hugepages: SUCCESS (1.404s)
[407.945387] Starting dynamic subtest: gem_contexts
[412.560540] Dynamic subtest gem_contexts: SUCCESS (4.668s)
[412.612241] Starting dynamic subtest: client
[413.415558] Dynamic subtest client: SUCCESS (0.857s)
[413.465639] Starting dynamic subtest: gem_migrate
[414.352327] Dynamic subtest gem_migrate: SUCCESS (0.930s)
[414.402443] Starting dynamic subtest: reset
[415.348147] Dynamic subtest reset: SUCCESS (0.997s)
[415.398349] Starting dynamic subtest: memory_region
[416.218206] Dynamic subtest memory_region: SUCCESS (0.861s)
[416.268311] Starting dynamic subtest: hangcheck
[418.791140] Dynamic subtest hangcheck: SUCCESS (2.569s)
[418.841185] Starting dynamic subtest: execlists
[419.727414] Dynamic subtest execlists: SUCCESS (0.936s)
[419.777535] Starting dynamic subtest: ring_submission
[420.588961] Dynamic subtest ring_submission: SUCCESS (0.856s)
[420.647376] Starting dynamic subtest: perf
[421.502211] Dynamic subtest perf: SUCCESS (0.913s)
[421.552316] Starting dynamic subtest: slpc
[422.405446] Dynamic subtest slpc: SUCCESS (0.895s)
[422.463902] Starting dynamic subtest: guc
[423.324987] Dynamic subtest guc: SUCCESS (0.923s)
[423.375071] Starting dynamic subtest: guc_multi_lrc
[424.221300] Dynamic subtest guc_multi_lrc: SUCCESS (0.891s)
[424.271445] Starting dynamic subtest: guc_hang
[425.024464] Dynamic subtest guc_hang: SUCCESS (0.811s)
[425.074656] Starting dynamic subtest: late_gt_pm
[425.860881] Dynamic subtest late_gt_pm: SUCCESS (0.832s)
[425.902630] Subtest live: SUCCESS (61.537s)
[426.157220] [165/171] (640s left) dmabuf (all-tests)
[426.881998] Starting subtest: all-tests
[426.931964] Starting dynamic subtest: sanitycheck
[426.982115] Dynamic subtest sanitycheck: SUCCESS (0.143s)
[427.032349] Starting dynamic subtest: dma_fence
[427.158033] Dynamic subtest dma_fence: SUCCESS (0.184s)
[427.208251] Starting dynamic subtest: dma_fence_chain
[441.169166] Dynamic subtest dma_fence_chain: SUCCESS (14.008s)
[441.219219] Starting dynamic subtest: dma_fence_unwrap
[441.261198] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s)
[441.311493] Starting dynamic subtest: dma_resv
[441.353312] Dynamic subtest dma_resv: SUCCESS (0.066s)
[441.395132] Subtest all-tests: SUCCESS (14.483s)
[441.522849] [166/171] (625s left) i915_suspend (basic-s2idle-without-i915)
[442.030394] Starting subtest: basic-s2idle-without-i915
[463.464885] Subtest basic-s2idle-without-i915: SUCCESS (6.894s)
[464.743005] [167/171] (617s left) i915_suspend (basic-s3-without-i915)
[465.476945] Starting subtest: basic-s3-without-i915
[486.605893] Subtest basic-s3-without-i915: SUCCESS (6.012s)
[488.620757] [168/171] (611s left) gem_exec_suspend (basic-s0)
[489.628196] Starting subtest: basic-S0
[489.670010] Starting dynamic subtest: smem
[509.015581] Dynamic subtest smem: SUCCESS (4.334s)
[509.057204] Subtest basic-S0: SUCCESS (4.336s)
[510.926231] [169/171] (605s left) gem_exec_suspend (basic-s3)
[511.560143] Starting subtest: basic-S3
[511.601969] Starting dynamic subtest: smem
[530.053108] Dynamic subtest smem: SUCCESS (4.400s)
[530.094830] Subtest basic-S3: SUCCESS (4.401s)
[532.272478] [170/171] (600s left) kms_chamelium_hpd (common-hpd-after-suspend)
[533.223852] Subtest common-hpd-after-suspend: SKIP (0.000s)
[533.844945] [171/171] (599s left) kms_pipe_crc_basic (suspend-read-crc)
[534.437785] Starting subtest: suspend-read-crc
[534.480082] Starting dynamic subtest: pipe-A-LVDS-1
[554.087019] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.573s)
[554.137169] Starting dynamic subtest: pipe-B-LVDS-1
[575.083386] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.150s)
[575.125203] Subtest suspend-read-crc: SUCCESS (9.727s)
[577.693722] Closing watchdogs
Done.