[41.198598] Initializing watchdogs
[41.198698]   /dev/watchdog0
[41.206489] [001/171] (960s left) i915_module_load (load)
[41.378618] Starting subtest: load
[42.748178] Subtest load: SUCCESS (1.370s)
[42.766291] [002/171] (958s left) core_auth (basic-auth)
[42.914126] Starting subtest: basic-auth
[42.915019] Subtest basic-auth: SUCCESS (0.001s)
[42.987483] [003/171] (958s left) debugfs_test (read_all_entries)
[43.088599] Starting subtest: read_all_entries
[43.599425] Subtest read_all_entries: SUCCESS (0.510s)
[43.720447] [004/171] (958s left) debugfs_test (basic-hwmon)
[43.817138] Starting subtest: basic-hwmon
[43.821592] Subtest basic-hwmon: SUCCESS (0.004s)
[43.952503] [005/171] (957s left) fbdev (eof)
[44.031925] Starting subtest: eof
[44.033041] Subtest eof: SUCCESS (0.000s)
[44.085640] [006/171] (957s left) fbdev (info)
[44.162281] Starting subtest: info
[44.163478] Subtest info: SUCCESS (0.000s)
[44.218700] [007/171] (957s left) fbdev (nullptr)
[44.298451] Starting subtest: nullptr
[44.299564] Subtest nullptr: SUCCESS (0.000s)
[44.365255] [008/171] (957s left) fbdev (read)
[44.465321] Starting subtest: read
[56.838320] Subtest read: SUCCESS (12.338s)
[56.852525] [009/171] (944s left) fbdev (write)
[56.932144] Starting subtest: write
[63.058582] Subtest write: SUCCESS (6.118s)
[63.102337] [010/171] (938s left) gem_basic (bad-close)
[63.191395] Starting subtest: bad-close
[63.193440] Subtest bad-close: SUCCESS (0.000s)
[63.252604] [011/171] (938s left) gem_basic (create-close)
[63.341418] Starting subtest: create-close
[63.343425] Subtest create-close: SUCCESS (0.000s)
[63.427872] [012/171] (938s left) gem_basic (create-fd-close)
[63.534263] Starting subtest: create-fd-close
[63.536265] Subtest create-fd-close: SUCCESS (0.000s)
[63.631833] [013/171] (938s left) gem_busy (busy@all-engines)
[63.758470] Starting subtest: busy
[63.759550] Starting dynamic subtest: all-engines
[63.887136] Dynamic subtest all-engines: SUCCESS (0.128s)
[63.888077] Subtest busy: SUCCESS (0.129s)
[64.351147] [014/171] (937s left) gem_close_race (basic-process)
[64.497187] Starting subtest: basic-process
[64.546433] Subtest basic-process: SUCCESS (0.049s)
[64.782304] [015/171] (937s left) gem_close_race (basic-threads)
[64.923365] Starting subtest: basic-threads
[66.145469] Subtest basic-threads: SUCCESS (1.222s)
[66.410689] [016/171] (935s left) gem_ctx_create (basic)
[66.532197] Starting subtest: basic
[66.533275] Subtest basic: SUCCESS (0.000s)
[66.732614] [017/171] (935s left) gem_ctx_create (basic-files)
[66.848025] Starting subtest: basic-files
[68.863083] Subtest basic-files: SUCCESS (2.015s)
[69.213306] [018/171] (932s left) gem_ctx_exec (basic)
[69.309962] Starting subtest: basic
[69.315900] Subtest basic: SUCCESS (0.006s)
[69.461647] [019/171] (932s left) gem_exec_basic (basic)
[69.564177] Starting subtest: basic
[69.565173] Starting dynamic subtest: rcs0-smem
[69.567300] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[69.573360] Starting dynamic subtest: bcs0-smem
[69.574411] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[69.581220] Starting dynamic subtest: vcs0-smem
[69.582140] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[69.587766] Starting dynamic subtest: vcs1-smem
[69.588666] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[69.594177] Starting dynamic subtest: vecs0-smem
[69.595070] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[69.600723] Starting dynamic subtest: vecs1-smem
[69.601867] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[69.607497] Starting dynamic subtest: ccs0-smem
[69.608650] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[69.614217] Starting dynamic subtest: ccs1-smem
[69.615242] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[69.620848] Starting dynamic subtest: ccs2-smem
[69.621998] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[69.627569] Starting dynamic subtest: ccs3-smem
[69.628727] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[69.634339] Starting dynamic subtest: rcs0-lmem0
[69.635500] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[69.641177] Starting dynamic subtest: bcs0-lmem0
[69.642324] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[69.648142] Starting dynamic subtest: vcs0-lmem0
[69.649270] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[69.655048] Starting dynamic subtest: vcs1-lmem0
[69.656171] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[69.661750] Starting dynamic subtest: vecs0-lmem0
[69.662896] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[69.668502] Starting dynamic subtest: vecs1-lmem0
[69.669600] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[69.675177] Starting dynamic subtest: ccs0-lmem0
[69.676051] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[69.681640] Starting dynamic subtest: ccs1-lmem0
[69.682645] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[69.688328] Starting dynamic subtest: ccs2-lmem0
[69.689161] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[69.694800] Starting dynamic subtest: ccs3-lmem0
[69.695718] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[69.696619] Subtest basic: SUCCESS (0.017s)
[69.788342] [020/171] (932s left) gem_exec_create (basic)
[69.902481] Starting subtest: basic
[69.903503] Starting dynamic subtest: smem
[72.007861] Dynamic subtest smem: SUCCESS (2.105s)
[72.014474] Starting dynamic subtest: lmem0
[74.119144] Dynamic subtest lmem0: SUCCESS (2.111s)
[74.120219] Subtest basic: SUCCESS (4.217s)
[74.291482] [021/171] (927s left) gem_exec_fence (basic-busy)
[74.569133] Starting subtest: basic-busy
[74.570379] Starting dynamic subtest: rcs0
[74.652454] Dynamic subtest rcs0: SUCCESS (0.092s)
[74.660357] Starting dynamic subtest: bcs0
[74.706184] Dynamic subtest bcs0: SUCCESS (0.052s)
[74.732135] Starting dynamic subtest: vcs0
[74.764598] Dynamic subtest vcs0: SUCCESS (0.057s)
[74.790310] Starting dynamic subtest: vcs1
[74.829596] Dynamic subtest vcs1: SUCCESS (0.064s)
[74.855250] Starting dynamic subtest: vecs0
[74.891870] Dynamic subtest vecs0: SUCCESS (0.062s)
[74.916691] Starting dynamic subtest: vecs1
[74.954939] Dynamic subtest vecs1: SUCCESS (0.063s)
[74.969703] Starting dynamic subtest: ccs0
[75.008390] Dynamic subtest ccs0: SUCCESS (0.052s)
[75.033159] Starting dynamic subtest: ccs1
[75.068872] Dynamic subtest ccs1: SUCCESS (0.061s)
[75.083601] Starting dynamic subtest: ccs2
[75.122312] Dynamic subtest ccs2: SUCCESS (0.052s)
[75.147108] Starting dynamic subtest: ccs3
[75.184972] Dynamic subtest ccs3: SUCCESS (0.063s)
[75.186659] Subtest basic-busy: SUCCESS (0.625s)
[75.885033] [022/171] (926s left) gem_exec_fence (basic-wait)
[76.162921] Starting subtest: basic-wait
[76.163989] Starting dynamic subtest: rcs0
[76.267753] Dynamic subtest rcs0: SUCCESS (0.113s)
[76.286035] Starting dynamic subtest: bcs0
[76.326131] Dynamic subtest bcs0: SUCCESS (0.057s)
[76.356721] Starting dynamic subtest: vcs0
[76.385739] Dynamic subtest vcs0: SUCCESS (0.060s)
[76.401110] Starting dynamic subtest: vcs1
[76.444668] Dynamic subtest vcs1: SUCCESS (0.057s)
[76.475929] Starting dynamic subtest: vecs0
[76.504666] Dynamic subtest vecs0: SUCCESS (0.061s)
[76.517613] Starting dynamic subtest: vecs1
[76.555386] Dynamic subtest vecs1: SUCCESS (0.050s)
[76.580932] Starting dynamic subtest: ccs0
[76.608112] Dynamic subtest ccs0: SUCCESS (0.053s)
[76.626594] Starting dynamic subtest: ccs1
[76.658614] Dynamic subtest ccs1: SUCCESS (0.050s)
[76.681282] Starting dynamic subtest: ccs2
[76.712346] Dynamic subtest ccs2: SUCCESS (0.053s)
[76.732396] Starting dynamic subtest: ccs3
[76.768954] Dynamic subtest ccs3: SUCCESS (0.056s)
[76.771219] Subtest basic-wait: SUCCESS (0.614s)
[77.452794] [023/171] (924s left) gem_exec_fence (basic-await)
[77.689260] Starting subtest: basic-await
[77.690322] Starting dynamic subtest: rcs0
[77.824446] Dynamic subtest rcs0: SUCCESS (0.144s)
[77.830893] Starting dynamic subtest: bcs0
[77.936550] Dynamic subtest bcs0: SUCCESS (0.112s)
[77.942926] Starting dynamic subtest: vcs0
[78.048748] Dynamic subtest vcs0: SUCCESS (0.112s)
[78.055170] Starting dynamic subtest: vcs1
[78.160126] Dynamic subtest vcs1: SUCCESS (0.111s)
[78.166122] Starting dynamic subtest: vecs0
[78.271291] Dynamic subtest vecs0: SUCCESS (0.111s)
[78.277967] Starting dynamic subtest: vecs1
[78.382255] Dynamic subtest vecs1: SUCCESS (0.111s)
[78.388391] Starting dynamic subtest: ccs0
[78.495035] Dynamic subtest ccs0: SUCCESS (0.113s)
[78.502323] Starting dynamic subtest: ccs1
[78.610140] Dynamic subtest ccs1: SUCCESS (0.115s)
[78.616575] Starting dynamic subtest: ccs2
[78.725849] Dynamic subtest ccs2: SUCCESS (0.116s)
[78.731887] Starting dynamic subtest: ccs3
[78.836244] Dynamic subtest ccs3: SUCCESS (0.110s)
[78.837262] Subtest basic-await: SUCCESS (1.156s)
[79.536527] [024/171] (922s left) gem_exec_fence (nb-await)
[79.767859] Starting subtest: nb-await
[79.768972] Starting dynamic subtest: rcs0
[79.867529] Dynamic subtest rcs0: SUCCESS (0.108s)
[79.875464] Starting dynamic subtest: bcs0
[79.937261] Dynamic subtest bcs0: SUCCESS (0.069s)
[79.946194] Starting dynamic subtest: vcs0
[80.010826] Dynamic subtest vcs0: SUCCESS (0.073s)
[80.028540] Starting dynamic subtest: vcs1
[80.109194] Dynamic subtest vcs1: SUCCESS (0.098s)
[80.122085] Starting dynamic subtest: vecs0
[80.198070] Dynamic subtest vecs0: SUCCESS (0.087s)
[80.205626] Starting dynamic subtest: vecs1
[80.267693] Dynamic subtest vecs1: SUCCESS (0.070s)
[80.280955] Starting dynamic subtest: ccs0
[80.355884] Dynamic subtest ccs0: SUCCESS (0.087s)
[80.377740] Starting dynamic subtest: ccs1
[80.453863] Dynamic subtest ccs1: SUCCESS (0.098s)
[80.465370] Starting dynamic subtest: ccs2
[80.539346] Dynamic subtest ccs2: SUCCESS (0.085s)
[80.545975] Starting dynamic subtest: ccs3
[80.608614] Dynamic subtest ccs3: SUCCESS (0.070s)
[80.610038] Subtest nb-await: SUCCESS (0.849s)
[81.284159] [025/171] (920s left) gem_exec_gttfill (basic)
[81.413045] Starting subtest: basic
[89.387038] Subtest basic: SUCCESS (7.966s)
[89.638344] [026/171] (912s left) gem_exec_parallel (engines)
[89.797120] Starting subtest: engines
[89.798016] Starting dynamic subtest: basic
[92.490860] Dynamic subtest basic: SUCCESS (2.694s)
[92.498631] Starting dynamic subtest: contexts
[95.555463] Dynamic subtest contexts: SUCCESS (3.055s)
[95.562230] Starting dynamic subtest: fds
[98.973534] Dynamic subtest fds: SUCCESS (3.419s)
[98.980704] Starting dynamic subtest: userptr
[100.746338] Dynamic subtest userptr: SUCCESS (1.781s)
[100.747553] Subtest engines: SUCCESS (10.949s)
[101.003810] [027/171] (901s left) gem_exec_store (basic)
[101.114734] Starting subtest: basic
[101.251539] Subtest basic: SUCCESS (0.137s)
[101.493077] [028/171] (900s left) gem_flink_basic (bad-flink)
[101.608221] Starting subtest: bad-flink
[101.609258] Subtest bad-flink: SUCCESS (0.000s)
[101.671677] [029/171] (900s left) gem_flink_basic (bad-open)
[101.765192] Starting subtest: bad-open
[101.766266] Subtest bad-open: SUCCESS (0.000s)
[101.841632] [030/171] (900s left) gem_flink_basic (basic)
[101.935278] Starting subtest: basic
[101.936383] Subtest basic: SUCCESS (0.000s)
[102.006959] [031/171] (900s left) gem_flink_basic (double-flink)
[102.103925] Starting subtest: double-flink
[102.105051] Subtest double-flink: SUCCESS (0.000s)
[102.197402] [032/171] (900s left) gem_flink_basic (flink-lifetime)
[102.294040] Starting subtest: flink-lifetime
[102.296136] Subtest flink-lifetime: SUCCESS (0.002s)
[102.400922] [033/171] (899s left) gem_huc_copy (huc-copy)
[102.548570] Starting subtest: huc-copy
[102.555654] Subtest huc-copy: SUCCESS (0.006s)
[102.684564] [034/171] (899s left) gem_linear_blits (basic)
[102.900257] Starting subtest: basic
[102.940867] Subtest basic: SUCCESS (0.041s)
[103.082061] [035/171] (899s left) gem_mmap (basic)
[103.226433] Subtest basic: SKIP (0.000s)
[103.258499] [036/171] (899s left) gem_mmap_gtt (basic)
[103.352454] Subtest basic: SKIP (0.000s)
[103.392486] [037/171] (898s left) gem_render_linear_blits (basic)
[103.495597] Starting subtest: basic
[103.582965] Subtest basic: SUCCESS (0.087s)
[103.664365] [038/171] (898s left) gem_render_tiled_blits (basic)
[103.771160] Subtest basic: SKIP (0.000s)
[103.808485] [039/171] (898s left) gem_ringfill (basic-all)
[104.268222] Starting subtest: basic-all
[105.683991] Subtest basic-all: SUCCESS (1.408s)
[105.805867] [040/171] (896s left) gem_softpin (allocator-basic)
[105.920101] Starting subtest: allocator-basic
[106.198151] Subtest allocator-basic: SUCCESS (0.269s)
[106.306619] [041/171] (896s left) gem_softpin (allocator-basic-reserve)
[106.413277] Starting subtest: allocator-basic-reserve
[106.685627] Subtest allocator-basic-reserve: SUCCESS (0.264s)
[106.801663] [042/171] (895s left) gem_softpin (safe-alignment)
[106.901439] Starting subtest: safe-alignment
[106.971599] Subtest safe-alignment: SUCCESS (0.070s)
[107.086455] [043/171] (895s left) gem_sync (basic-all)
[107.197046] Starting subtest: basic-all
[111.151341] Subtest basic-all: SUCCESS (3.954s)
[111.351848] [044/171] (891s left) gem_sync (basic-each)
[111.458174] Starting subtest: basic-each
[114.076240] Subtest basic-each: SUCCESS (2.618s)
[114.285580] [045/171] (888s left) gem_tiled_blits (basic)
[114.392272] Subtest basic: SKIP (0.000s)
[114.424971] [046/171] (888s left) gem_tiled_fence_blits (basic)
[114.524301] Subtest basic: SKIP (0.000s)
[114.558870] [047/171] (888s left) gem_tiled_pread_basic
[114.675331] [048/171] (887s left) gem_wait (busy@all-engines)
[114.785757] Starting subtest: busy
[114.786902] Starting dynamic subtest: all-engines
[115.365571] Dynamic subtest all-engines: SUCCESS (0.580s)
[115.366596] Subtest busy: SUCCESS (0.580s)
[115.618192] [049/171] (887s left) gem_wait (wait@all-engines)
[115.732294] Starting subtest: wait
[115.733430] Starting dynamic subtest: all-engines
[116.825621] Dynamic subtest all-engines: SUCCESS (1.093s)
[116.826960] Subtest wait: SUCCESS (1.093s)
[117.105053] [050/171] (885s left) i915_getparams_basic (basic-eu-total)
[117.197430] Starting subtest: basic-eu-total
[117.199422] Subtest basic-eu-total: SUCCESS (0.000s)
[117.255074] [051/171] (885s left) i915_getparams_basic (basic-subslice-total)
[117.347289] Starting subtest: basic-subslice-total
[117.349385] Subtest basic-subslice-total: SUCCESS (0.000s)
[117.404878] [052/171] (885s left) i915_hangman (error-state-basic)
[117.519031] Starting subtest: error-state-basic
[117.701856] Subtest error-state-basic: SUCCESS (0.183s)
[117.800836] [053/171] (884s left) i915_pciid
[117.986608] [054/171] (884s left) kms_addfb_basic (addfb25-bad-modifier)
[118.102670] Starting subtest: addfb25-bad-modifier
[118.103644] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[118.256501] [055/171] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[118.352276] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[118.491169] [056/171] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[118.584539] Starting subtest: addfb25-modifier-no-flag
[118.585553] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[118.740054] [057/171] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[118.834150] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[118.973348] [058/171] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[119.068494] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[119.206644] [059/171] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[119.361300] Starting subtest: addfb25-yf-tiled-legacy
[119.362247] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[119.440258] [060/171] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[119.596904] Starting subtest: addfb25-y-tiled-legacy
[119.597957] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[119.690231] [061/171] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[119.847404] Starting subtest: addfb25-y-tiled-small-legacy
[119.849402] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[119.940200] [062/171] (882s left) kms_addfb_basic (bad-pitch-0)
[120.032204] Starting subtest: bad-pitch-0
[120.033224] Subtest bad-pitch-0: SUCCESS (0.000s)
[120.173499] [063/171] (882s left) kms_addfb_basic (bad-pitch-1024)
[120.267222] Starting subtest: bad-pitch-1024
[120.268269] Subtest bad-pitch-1024: SUCCESS (0.000s)
[120.423390] [064/171] (882s left) kms_addfb_basic (bad-pitch-128)
[120.517132] Starting subtest: bad-pitch-128
[120.518102] Subtest bad-pitch-128: SUCCESS (0.000s)
[120.673617] [065/171] (882s left) kms_addfb_basic (bad-pitch-256)
[120.766912] Starting subtest: bad-pitch-256
[120.767885] Subtest bad-pitch-256: SUCCESS (0.000s)
[120.906510] [066/171] (882s left) kms_addfb_basic (bad-pitch-32)
[120.999754] Starting subtest: bad-pitch-32
[121.000694] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.139755] [067/171] (881s left) kms_addfb_basic (bad-pitch-63)
[121.232412] Starting subtest: bad-pitch-63
[121.233467] Subtest bad-pitch-63: SUCCESS (0.000s)
[121.373275] [068/171] (881s left) kms_addfb_basic (bad-pitch-65536)
[121.466287] Starting subtest: bad-pitch-65536
[121.467340] Subtest bad-pitch-65536: SUCCESS (0.000s)
[121.606548] [069/171] (881s left) kms_addfb_basic (bad-pitch-999)
[121.699248] Starting subtest: bad-pitch-999
[121.700242] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.840214] [070/171] (881s left) kms_addfb_basic (basic)
[121.931175] Starting subtest: basic
[121.932216] Subtest basic: SUCCESS (0.000s)
[122.090200] [071/171] (880s left) kms_addfb_basic (basic-x-tiled-legacy)
[122.185110] Starting subtest: basic-x-tiled-legacy
[122.187098] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[122.340096] [072/171] (880s left) kms_addfb_basic (basic-y-tiled-legacy)
[122.434177] Starting subtest: basic-y-tiled-legacy
[122.436128] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[122.573346] [073/171] (880s left) kms_addfb_basic (bo-too-small)
[122.731037] Starting subtest: bo-too-small
[122.732076] Subtest bo-too-small: SUCCESS (0.000s)
[122.806651] [074/171] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.960899] Starting subtest: bo-too-small-due-to-tiling
[122.962699] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[123.040456] [075/171] (880s left) kms_addfb_basic (clobberred-modifier)
[123.135148] Starting subtest: clobberred-modifier
[123.137014] Subtest clobberred-modifier: SKIP (0.000s)
[123.290378] [076/171] (879s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.383503] Starting subtest: framebuffer-vs-set-tiling
[123.385439] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[123.523466] [077/171] (879s left) kms_addfb_basic (invalid-get-prop)
[123.616935] Starting subtest: invalid-get-prop
[123.617831] Subtest invalid-get-prop: SUCCESS (0.000s)
[123.756687] [078/171] (879s left) kms_addfb_basic (invalid-get-prop-any)
[123.849896] Starting subtest: invalid-get-prop-any
[123.850957] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[123.989979] [079/171] (879s left) kms_addfb_basic (invalid-set-prop)
[124.083183] Starting subtest: invalid-set-prop
[124.084216] Subtest invalid-set-prop: SUCCESS (0.000s)
[124.223356] [080/171] (878s left) kms_addfb_basic (invalid-set-prop-any)
[124.317012] Starting subtest: invalid-set-prop-any
[124.317921] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[124.473433] [081/171] (878s left) kms_addfb_basic (no-handle)
[124.568924] Starting subtest: no-handle
[124.569857] Subtest no-handle: SUCCESS (0.000s)
[124.706616] [082/171] (878s left) kms_addfb_basic (size-max)
[124.863586] Starting subtest: size-max
[124.864508] Subtest size-max: SUCCESS (0.000s)
[124.940075] [083/171] (878s left) kms_addfb_basic (small-bo)
[125.096253] Starting subtest: small-bo
[125.097273] Subtest small-bo: SUCCESS (0.000s)
[125.173601] [084/171] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[125.268472] Starting subtest: tile-pitch-mismatch
[125.270478] Subtest tile-pitch-mismatch: SKIP (0.000s)
[125.406905] [085/171] (877s left) kms_addfb_basic (too-high)
[125.561934] Starting subtest: too-high
[125.562945] Subtest too-high: SUCCESS (0.000s)
[125.640312] [086/171] (877s left) kms_addfb_basic (too-wide)
[125.796884] Starting subtest: too-wide
[125.797948] Subtest too-wide: SUCCESS (0.000s)
[125.873555] [087/171] (877s left) kms_addfb_basic (unused-handle)
[125.967047] Starting subtest: unused-handle
[125.968048] Subtest unused-handle: SUCCESS (0.000s)
[126.106870] [088/171] (877s left) kms_addfb_basic (unused-modifier)
[126.199058] Starting subtest: unused-modifier
[126.200121] Subtest unused-modifier: SUCCESS (0.000s)
[126.340652] [089/171] (876s left) kms_addfb_basic (unused-offsets)
[126.434187] Starting subtest: unused-offsets
[126.435152] Subtest unused-offsets: SUCCESS (0.000s)
[126.574061] [090/171] (876s left) kms_addfb_basic (unused-pitches)
[126.667145] Starting subtest: unused-pitches
[126.668107] Subtest unused-pitches: SUCCESS (0.000s)
[126.823510] [091/171] (876s left) kms_busy (basic)
[126.986996] Starting subtest: basic
[126.988119] Starting dynamic subtest: flip
[127.792134] Dynamic subtest flip: SUCCESS (0.804s)
[127.800218] Starting dynamic subtest: modeset
[128.768020] Dynamic subtest modeset: SUCCESS (0.977s)
[128.769079] Subtest basic: SUCCESS (1.782s)
[128.991331] [092/171] (874s left) kms_chamelium_hpd (dp-hpd-fast)
[129.225659] Subtest dp-hpd-fast: SKIP (0.000s)
[129.358526] [093/171] (873s left) kms_chamelium_edid (dp-edid-read)
[129.588943] Subtest dp-edid-read: SKIP (0.000s)
[129.723508] [094/171] (873s left) kms_chamelium_frames (dp-crc-fast)
[129.953991] Subtest dp-crc-fast: SKIP (0.000s)
[130.090588] [095/171] (873s left) kms_chamelium_hpd (hdmi-hpd-fast)
[130.320814] Subtest hdmi-hpd-fast: SKIP (0.000s)
[130.454706] [096/171] (872s left) kms_chamelium_edid (hdmi-edid-read)
[130.684292] Subtest hdmi-edid-read: SKIP (0.000s)
[130.819649] [097/171] (872s left) kms_chamelium_frames (hdmi-crc-fast)
[131.049877] Subtest hdmi-crc-fast: SKIP (0.000s)
[131.184763] [098/171] (872s left) kms_chamelium_hpd (vga-hpd-fast)
[131.415493] Subtest vga-hpd-fast: SKIP (0.000s)
[131.548650] [099/171] (871s left) kms_chamelium_edid (vga-edid-read)
[131.779196] Subtest vga-edid-read: SKIP (0.000s)
[131.911899] [100/171] (871s left) kms_prop_blob (basic)
[132.006373] Starting subtest: basic
[132.007443] Subtest basic: SUCCESS (0.000s)
[132.072542] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[132.231683] Starting subtest: basic-busy-flip-before-cursor-atomic
[132.233741] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[132.306100] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[132.460615] Starting subtest: basic-busy-flip-before-cursor-legacy
[132.462696] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[132.522573] [103/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[132.679112] Starting subtest: basic-flip-after-cursor-atomic
[133.742895] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.063s)
[133.953277] [104/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.108244] Starting subtest: basic-flip-after-cursor-legacy
[135.186377] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.079s)
[135.393659] [105/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[135.548731] Starting subtest: basic-flip-after-cursor-varying-size
[136.628417] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.080s)
[136.846439] [106/171] (866s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[137.002691] Starting subtest: basic-flip-before-cursor-atomic
[138.064361] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.063s)
[138.280917] [107/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[138.437210] Starting subtest: basic-flip-before-cursor-legacy
[139.513976] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.076s)
[139.728314] [108/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[139.882985] Starting subtest: basic-flip-before-cursor-varying-size
[140.962089] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.079s)
[141.161438] [109/171] (862s left) kms_flip (basic-flip-vs-dpms)
[141.304292] Starting subtest: basic-flip-vs-dpms
[141.308855] Starting dynamic subtest: A-DP1
[142.381471] Dynamic subtest A-DP1: SUCCESS (1.072s)
[142.389374] Starting dynamic subtest: B-DP1
[143.287201] Dynamic subtest B-DP1: SUCCESS (0.905s)
[143.295555] Starting dynamic subtest: C-DP1
[144.190157] Dynamic subtest C-DP1: SUCCESS (0.903s)
[144.198264] Starting dynamic subtest: D-DP1
[145.096415] Dynamic subtest D-DP1: SUCCESS (0.905s)
[145.101631] Subtest basic-flip-vs-dpms: SUCCESS (3.799s)
[145.311270] [110/171] (858s left) kms_flip (basic-flip-vs-modeset)
[145.453173] Starting subtest: basic-flip-vs-modeset
[145.457620] Starting dynamic subtest: A-DP1
[146.378513] Dynamic subtest A-DP1: SUCCESS (0.920s)
[146.386230] Starting dynamic subtest: B-DP1
[147.277222] Dynamic subtest B-DP1: SUCCESS (0.898s)
[147.285172] Starting dynamic subtest: C-DP1
[148.178681] Dynamic subtest C-DP1: SUCCESS (0.900s)
[148.186893] Starting dynamic subtest: D-DP1
[149.079296] Dynamic subtest D-DP1: SUCCESS (0.900s)
[149.084284] Subtest basic-flip-vs-modeset: SUCCESS (3.633s)
[149.292383] [111/171] (854s left) kms_flip (basic-flip-vs-wf_vblank)
[149.432257] Starting subtest: basic-flip-vs-wf_vblank
[149.437475] Starting dynamic subtest: A-DP1
[150.637814] Dynamic subtest A-DP1: SUCCESS (1.200s)
[150.647540] Starting dynamic subtest: B-DP1
[151.756183] Dynamic subtest B-DP1: SUCCESS (1.117s)
[151.765807] Starting dynamic subtest: C-DP1
[152.876136] Dynamic subtest C-DP1: SUCCESS (1.119s)
[152.886467] Starting dynamic subtest: D-DP1
[153.997210] Dynamic subtest D-DP1: SUCCESS (1.120s)
[154.002767] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.572s)
[154.269129] [112/171] (849s left) kms_flip (basic-plain-flip)
[154.408136] Starting subtest: basic-plain-flip
[154.412835] Starting dynamic subtest: A-DP1
[155.332436] Dynamic subtest A-DP1: SUCCESS (0.920s)
[155.342077] Starting dynamic subtest: B-DP1
[156.170852] Dynamic subtest B-DP1: SUCCESS (0.837s)
[156.180684] Starting dynamic subtest: C-DP1
[157.005646] Dynamic subtest C-DP1: SUCCESS (0.834s)
[157.015372] Starting dynamic subtest: D-DP1
[157.838778] Dynamic subtest D-DP1: SUCCESS (0.832s)
[157.844939] Subtest basic-plain-flip: SUCCESS (3.438s)
[158.108107] [113/171] (845s left) kms_force_connector_basic (force-connector-state)
[158.205863] Starting subtest: force-connector-state
[158.774272] Subtest force-connector-state: SUCCESS (0.568s)
[159.078039] [114/171] (844s left) kms_force_connector_basic (force-edid)
[159.175252] Starting subtest: force-edid
[159.192134] Subtest force-edid: SUCCESS (0.017s)
[159.361634] [115/171] (844s left) kms_force_connector_basic (force-load-detect)
[159.459873] Starting subtest: force-load-detect
[159.461590] Subtest force-load-detect: SKIP (0.000s)
[159.578069] [116/171] (844s left) kms_force_connector_basic (prune-stale-modes)
[159.674596] Starting subtest: prune-stale-modes
[159.683916] Subtest prune-stale-modes: SKIP (0.009s)
[159.844961] [117/171] (843s left) kms_frontbuffer_tracking (basic)
[160.007708] Starting subtest: basic
[164.403491] Subtest basic: SUCCESS (4.398s)
[164.505673] [118/171] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[164.667107] Starting subtest: compare-crc-sanitycheck-xr24
[164.668182] Starting dynamic subtest: pipe-A-DP-1
[165.212750] Dynamic subtest pipe-A-DP-1: SUCCESS (0.543s)
[165.222898] Starting dynamic subtest: pipe-B-DP-1
[165.782450] Dynamic subtest pipe-B-DP-1: SUCCESS (0.567s)
[165.792275] Starting dynamic subtest: pipe-C-DP-1
[166.411821] Dynamic subtest pipe-C-DP-1: SUCCESS (0.626s)
[166.421913] Starting dynamic subtest: pipe-D-DP-1
[167.111794] Dynamic subtest pipe-D-DP-1: SUCCESS (0.697s)
[167.112879] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.446s)
[167.310183] [119/171] (836s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[167.468380] Starting subtest: compare-crc-sanitycheck-nv12
[167.469289] Starting dynamic subtest: pipe-A-DP-1
[168.693276] Dynamic subtest pipe-A-DP-1: SUCCESS (1.224s)
[168.703266] Starting dynamic subtest: pipe-B-DP-1
[169.804383] Dynamic subtest pipe-B-DP-1: SUCCESS (1.108s)
[169.814593] Starting dynamic subtest: pipe-C-DP-1
[171.072255] Dynamic subtest pipe-C-DP-1: SUCCESS (1.265s)
[171.085196] Starting dynamic subtest: pipe-D-DP-1
[172.381572] Dynamic subtest pipe-D-DP-1: SUCCESS (1.306s)
[172.382530] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.914s)
[172.580781] [120/171] (831s left) kms_pipe_crc_basic (hang-read-crc)
[172.737313] Starting subtest: hang-read-crc
[172.740086] Starting dynamic subtest: pipe-A-DP-1
[174.274260] Dynamic subtest pipe-A-DP-1: SUCCESS (1.534s)
[174.284116] Starting dynamic subtest: pipe-B-DP-1
[175.833388] Dynamic subtest pipe-B-DP-1: SUCCESS (1.556s)
[175.843401] Starting dynamic subtest: pipe-C-DP-1
[177.558412] Dynamic subtest pipe-C-DP-1: SUCCESS (1.721s)
[177.567984] Starting dynamic subtest: pipe-D-DP-1
[179.363550] Dynamic subtest pipe-D-DP-1: SUCCESS (1.800s)
[179.364519] Subtest hang-read-crc: SUCCESS (6.625s)
[179.566996] [121/171] (824s left) kms_pipe_crc_basic (nonblocking-crc)
[179.729763] Starting subtest: nonblocking-crc
[179.730726] Starting dynamic subtest: pipe-A-DP-1
[180.432459] Dynamic subtest pipe-A-DP-1: SUCCESS (0.701s)
[180.442219] Starting dynamic subtest: pipe-B-DP-1
[181.153154] Dynamic subtest pipe-B-DP-1: SUCCESS (0.717s)
[181.167268] Starting dynamic subtest: pipe-C-DP-1
[182.097137] Dynamic subtest pipe-C-DP-1: FAIL (0.835s)
[182.109082] Starting dynamic subtest: pipe-D-DP-1
[182.853634] Dynamic subtest pipe-D-DP-1: SUCCESS (0.860s)
[182.854639] Subtest nonblocking-crc: FAIL (3.125s)
[183.055686] [122/171] (820s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[183.214117] Starting subtest: nonblocking-crc-frame-sequence
[183.215114] Starting dynamic subtest: pipe-A-DP-1
[183.970423] Dynamic subtest pipe-A-DP-1: SUCCESS (0.755s)
[183.980722] Starting dynamic subtest: pipe-B-DP-1
[184.703997] Dynamic subtest pipe-B-DP-1: SUCCESS (0.729s)
[184.713954] Starting dynamic subtest: pipe-C-DP-1
[185.524719] Dynamic subtest pipe-C-DP-1: FAIL (0.745s)
[185.532715] Starting dynamic subtest: pipe-D-DP-1
[186.300887] Dynamic subtest pipe-D-DP-1: SUCCESS (0.846s)
[186.301822] Subtest nonblocking-crc-frame-sequence: FAIL (3.088s)
[186.510708] [123/171] (817s left) kms_pipe_crc_basic (read-crc)
[186.668409] Starting subtest: read-crc
[186.671197] Starting dynamic subtest: pipe-A-DP-1
[187.309534] Dynamic subtest pipe-A-DP-1: SUCCESS (0.639s)
[187.319657] Starting dynamic subtest: pipe-B-DP-1
[187.963819] Dynamic subtest pipe-B-DP-1: SUCCESS (0.650s)
[187.973479] Starting dynamic subtest: pipe-C-DP-1
[188.682599] Dynamic subtest pipe-C-DP-1: SUCCESS (0.716s)
[188.692565] Starting dynamic subtest: pipe-D-DP-1
[189.464058] Dynamic subtest pipe-D-DP-1: SUCCESS (0.778s)
[189.465112] Subtest read-crc: SUCCESS (2.796s)
[189.661493] [124/171] (814s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[189.820278] Starting subtest: read-crc-frame-sequence
[189.821301] Starting dynamic subtest: pipe-A-DP-1
[190.443508] Dynamic subtest pipe-A-DP-1: SUCCESS (0.621s)
[190.453255] Starting dynamic subtest: pipe-B-DP-1
[191.100163] Dynamic subtest pipe-B-DP-1: SUCCESS (0.653s)
[191.110240] Starting dynamic subtest: pipe-C-DP-1
[191.819078] Dynamic subtest pipe-C-DP-1: SUCCESS (0.716s)
[191.829092] Starting dynamic subtest: pipe-D-DP-1
[192.619199] Dynamic subtest pipe-D-DP-1: SUCCESS (0.797s)
[192.620544] Subtest read-crc-frame-sequence: SUCCESS (2.800s)
[192.812017] [125/171] (811s left) kms_psr (primary_page_flip)
[192.910294] Subtest primary_page_flip: SKIP (0.000s)
[192.948112] [126/171] (810s left) kms_psr (cursor_plane_move)
[193.042428] Subtest cursor_plane_move: SKIP (0.000s)
[193.082736] [127/171] (810s left) kms_psr (sprite_plane_onoff)
[193.177782] Subtest sprite_plane_onoff: SKIP (0.000s)
[193.214956] [128/171] (810s left) kms_psr (primary_mmap_gtt)
[193.310652] Subtest primary_mmap_gtt: SKIP (0.000s)
[193.348797] [129/171] (810s left) kms_setmode (basic-clone-single-crtc)
[193.443459] Starting subtest: basic-clone-single-crtc
[193.446152] Subtest basic-clone-single-crtc: SKIP (0.001s)
[193.511655] [130/171] (810s left) i915_pm_backlight (basic-brightness)
[193.669678] Subtest basic-brightness: SKIP (0.000s)
[193.698547] [131/171] (810s left) i915_pm_rpm (basic-pci-d3-state)
[195.505555] Starting subtest: basic-pci-d3-state
[196.479061] Subtest basic-pci-d3-state: SUCCESS (0.973s)
[196.634787] [132/171] (807s left) i915_pm_rpm (basic-rte)
[196.712047] Starting subtest: basic-rte
[199.437475] Subtest basic-rte: SUCCESS (2.726s)
[200.426849] [133/171] (803s left) i915_pm_rps (basic-api)
[200.530410] Starting subtest: basic-api
[200.532285] Subtest basic-api: SKIP (0.000s)
[200.612456] [134/171] (803s left) prime_self_import (basic-llseek-bad)
[200.690211] Starting subtest: basic-llseek-bad
[200.708900] Subtest basic-llseek-bad: SUCCESS (0.017s)
[200.803344] [135/171] (803s left) prime_self_import (basic-llseek-size)
[200.883038] Starting subtest: basic-llseek-size
[200.901552] Subtest basic-llseek-size: SUCCESS (0.019s)
[201.007564] [136/171] (803s left) prime_self_import (basic-with_fd_dup)
[201.106221] Starting subtest: basic-with_fd_dup
[201.126560] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[201.249426] [137/171] (802s left) prime_self_import (basic-with_one_bo)
[201.332211] Starting subtest: basic-with_one_bo
[201.352196] Subtest basic-with_one_bo: SUCCESS (0.020s)
[201.430804] [138/171] (802s left) prime_self_import (basic-with_one_bo_two_files)
[201.513999] Starting subtest: basic-with_one_bo_two_files
[201.534197] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s)
[201.642266] [139/171] (802s left) prime_self_import (basic-with_two_bos)
[201.743726] Starting subtest: basic-with_two_bos
[201.764303] Subtest basic-with_two_bos: SUCCESS (0.020s)
[201.879246] [140/171] (802s left) prime_vgem (basic-fence-flip)
[202.026971] Starting subtest: basic-fence-flip
[202.136538] Subtest basic-fence-flip: SKIP (0.108s)
[202.242210] [141/171] (802s left) prime_vgem (basic-fence-mmap)
[202.359965] Starting subtest: basic-fence-mmap
[202.367056] Subtest basic-fence-mmap: SKIP (0.000s)
[202.489447] [142/171] (801s left) prime_vgem (basic-fence-read)
[202.610762] Starting subtest: basic-fence-read
[202.618955] Subtest basic-fence-read: SKIP (0.007s)
[202.762958] [143/171] (801s left) prime_vgem (basic-gtt)
[202.893157] Starting subtest: basic-gtt
[202.894901] Subtest basic-gtt: SKIP (0.000s)
[203.028057] [144/171] (801s left) prime_vgem (basic-read)
[203.155550] Starting subtest: basic-read
[203.162559] Subtest basic-read: SKIP (0.006s)
[203.285756] [145/171] (801s left) prime_vgem (basic-write)
[203.409881] Starting subtest: basic-write
[203.416955] Subtest basic-write: SKIP (0.006s)
[203.524216] [146/171] (800s left) vgem_basic (setversion)
[203.635422] Starting subtest: setversion
[203.637535] Subtest setversion: SUCCESS (0.000s)
[203.693042] [147/171] (800s left) vgem_basic (create)
[203.785271] Starting subtest: create
[203.786217] Subtest create: SUCCESS (0.000s)
[203.844624] [148/171] (800s left) vgem_basic (debugfs)
[203.935401] Starting subtest: debugfs
[203.936464] Subtest debugfs: SUCCESS (0.000s)
[204.000910] [149/171] (800s left) vgem_basic (dmabuf-export)
[204.102128] Starting subtest: dmabuf-export
[204.131034] Subtest dmabuf-export: SUCCESS (0.028s)
[204.258325] [150/171] (800s left) vgem_basic (dmabuf-fence)
[204.352427] Starting subtest: dmabuf-fence
[204.353451] Subtest dmabuf-fence: SUCCESS (0.000s)
[204.408597] [151/171] (800s left) vgem_basic (dmabuf-fence-before)
[204.502086] Starting subtest: dmabuf-fence-before
[204.503169] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[204.563584] [152/171] (799s left) vgem_basic (dmabuf-mmap)
[204.652112] Starting subtest: dmabuf-mmap
[204.665576] Subtest dmabuf-mmap: SUCCESS (0.014s)
[204.725372] [153/171] (799s left) vgem_basic (mmap)
[204.818718] Starting subtest: mmap
[204.827202] Subtest mmap: SUCCESS (0.009s)
[204.875123] [154/171] (799s left) vgem_basic (second-client)
[204.968719] Starting subtest: second-client
[205.002212] Subtest second-client: SUCCESS (0.033s)
[205.091464] [155/171] (799s left) vgem_basic (sysfs)
[205.202211] Starting subtest: sysfs
[205.203248] Subtest sysfs: SUCCESS (0.000s)
[205.266079] [156/171] (799s left) core_hotunplug (unbind-rebind)
[205.418453] Starting subtest: unbind-rebind
[208.275711] Subtest unbind-rebind: SUCCESS (2.857s)
[208.297594] [157/171] (796s left) vgem_basic (unload)
[208.379120] Starting subtest: unload
[237.402859] Subtest unload: SUCCESS (28.988s)
[237.491826] [158/171] (767s left) i915_module_load (reload)
[237.571517] Starting subtest: reload
[241.314381] Subtest reload: SUCCESS (3.744s)
[241.333244] [159/171] (763s left) gem_lmem_swapping (basic)
[245.234172] Starting subtest: basic
[245.235062] Starting dynamic subtest: lmem0
[273.587473] Dynamic subtest lmem0: SUCCESS (28.344s)
[273.588480] Subtest basic: SUCCESS (28.345s)
[276.486971] [160/171] (728s left) gem_lmem_swapping (parallel-random-engines)
[277.482125] Starting subtest: parallel-random-engines
[277.483060] Starting dynamic subtest: lmem0
[279.032527] Dynamic subtest lmem0: SUCCESS (1.541s)
[279.033610] Subtest parallel-random-engines: SUCCESS (1.542s)
[280.551956] [161/171] (724s left) gem_lmem_swapping (random-engines)
[281.516958] Starting subtest: random-engines
[281.518094] Starting dynamic subtest: lmem0
[282.777018] Dynamic subtest lmem0: SUCCESS (1.251s)
[282.778121] Subtest random-engines: SUCCESS (1.252s)
[284.365103] [162/171] (720s left) gem_lmem_swapping (verify-random)
[285.352343] Starting subtest: verify-random
[285.353316] Starting dynamic subtest: lmem0
[296.212501] Dynamic subtest lmem0: SUCCESS (10.850s)
[296.213573] Subtest verify-random: SUCCESS (10.852s)
[297.879660] [163/171] (706s left) i915_pm_rpm (module-reload)
[300.819708] Starting subtest: module-reload
[315.884162] Subtest module-reload: SUCCESS (15.055s)
[315.921482] [164/171] (688s left) i915_selftest (live)
[316.006172] Starting subtest: live
[316.007141] Starting dynamic subtest: sanitycheck
[318.110436] Dynamic subtest sanitycheck: SUCCESS (2.095s)
[318.117159] Starting dynamic subtest: uncore
[320.178447] Dynamic subtest uncore: SUCCESS (2.066s)
[320.185581] Starting dynamic subtest: workarounds
[324.726281] Dynamic subtest workarounds: SUCCESS (4.546s)
[324.732890] Starting dynamic subtest: gt_engines
[327.910653] Dynamic subtest gt_engines: SUCCESS (3.183s)
[327.918264] Starting dynamic subtest: gt_timelines
[365.525564] Dynamic subtest gt_timelines: SUCCESS (37.613s)
[365.533717] Starting dynamic subtest: gt_contexts
[367.685075] Dynamic subtest gt_contexts: SUCCESS (2.156s)
[367.691838] Starting dynamic subtest: gt_lrc
[376.870346] Dynamic subtest gt_lrc: SUCCESS (9.186s)
[376.876668] Starting dynamic subtest: gt_mocs
[381.037415] Dynamic subtest gt_mocs: SUCCESS (4.166s)
[381.048206] Starting dynamic subtest: gt_pm
[384.052576] Dynamic subtest gt_pm: SUCCESS (3.013s)
[384.059252] Starting dynamic subtest: gt_heartbeat
[386.415635] Dynamic subtest gt_heartbeat: SUCCESS (2.361s)
[386.426563] Starting dynamic subtest: gt_tlb
[403.552322] Dynamic subtest gt_tlb: SUCCESS (17.134s)
[403.560421] Starting dynamic subtest: requests
[422.148308] Dynamic subtest requests: SUCCESS (18.595s)
[422.155059] Starting dynamic subtest: migrate
[427.794502] Dynamic subtest migrate: SUCCESS (5.645s)
[427.801285] Starting dynamic subtest: active
[429.914542] Dynamic subtest active: SUCCESS (2.118s)
[429.921420] Starting dynamic subtest: objects
[433.398382] Dynamic subtest objects: SUCCESS (3.483s)
[433.405244] Starting dynamic subtest: mman
[444.634170] Dynamic subtest mman: SUCCESS (11.234s)
[444.640326] Starting dynamic subtest: dmabuf
[446.663196] Dynamic subtest dmabuf: SUCCESS (2.028s)
[446.669278] Starting dynamic subtest: vma
[448.740431] Dynamic subtest vma: SUCCESS (2.076s)
[448.746505] Starting dynamic subtest: coherency
[452.602153] Dynamic subtest coherency: SUCCESS (3.860s)
[452.608046] Starting dynamic subtest: gtt
[463.318392] Dynamic subtest gtt: SUCCESS (10.715s)
[463.325208] Starting dynamic subtest: gem
[465.485767] Dynamic subtest gem: SUCCESS (2.164s)
[465.492981] Starting dynamic subtest: evict
[470.099530] Dynamic subtest evict: SUCCESS (4.614s)
[470.107208] Starting dynamic subtest: hugepages
[488.572368] Dynamic subtest hugepages: SUCCESS (18.471s)
[488.579541] Starting dynamic subtest: gem_contexts
[535.246448] Dynamic subtest gem_contexts: SUCCESS (46.646s)
[535.252600] Starting dynamic subtest: client
[537.348484] Dynamic subtest client: SUCCESS (2.125s)
[537.358796] Starting dynamic subtest: gem_migrate
[542.531357] Dynamic subtest gem_migrate: SUCCESS (5.181s)
[542.540582] Starting dynamic subtest: reset
[544.708427] Dynamic subtest reset: SUCCESS (2.178s)
[544.715416] Starting dynamic subtest: memory_region
[548.322435] Dynamic subtest memory_region: SUCCESS (3.613s)
[548.329421] Starting dynamic subtest: hangcheck
[596.245522] Dynamic subtest hangcheck: SUCCESS (47.922s)
[596.251729] Starting dynamic subtest: execlists
[598.360575] Dynamic subtest execlists: SUCCESS (2.114s)
[598.367334] Starting dynamic subtest: ring_submission
[600.462332] Dynamic subtest ring_submission: SUCCESS (2.100s)
[600.471580] Starting dynamic subtest: perf
[602.684541] Dynamic subtest perf: SUCCESS (2.221s)
[602.691764] Starting dynamic subtest: slpc
[612.607614] Dynamic subtest slpc: SUCCESS (9.922s)
[612.616847] Starting dynamic subtest: guc
[616.235447] Dynamic subtest guc: SUCCESS (3.627s)
[616.242281] Starting dynamic subtest: guc_multi_lrc
[618.383541] Dynamic subtest guc_multi_lrc: SUCCESS (2.147s)
[618.390371] Starting dynamic subtest: guc_hang
[621.197359] Dynamic subtest guc_hang: SUCCESS (2.812s)
[621.204188] Starting dynamic subtest: late_gt_pm
[623.392609] Dynamic subtest late_gt_pm: SUCCESS (2.193s)
[623.394022] Subtest live: SUCCESS (307.377s)
[623.838974] [165/171] (381s left) dmabuf (all-tests)
[623.930313] Starting subtest: all-tests
[623.931915] Starting dynamic subtest: sanitycheck
[624.000060] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[624.030550] Starting dynamic subtest: dma_fence
[624.193676] Dynamic subtest dma_fence: SUCCESS (0.189s)
[624.214458] Starting dynamic subtest: dma_fence_chain
[638.102684] Dynamic subtest dma_fence_chain: SUCCESS (13.897s)
[638.117566] Starting dynamic subtest: dma_fence_unwrap
[638.195526] Dynamic subtest dma_fence_unwrap: SUCCESS (0.097s)
[638.206537] Starting dynamic subtest: dma_resv
[638.283072] Dynamic subtest dma_resv: SUCCESS (0.082s)
[638.285691] Subtest all-tests: SUCCESS (14.354s)
[638.338869] [166/171] (366s left) i915_suspend (basic-s2idle-without-i915)
[638.427208] Starting subtest: basic-s2idle-without-i915
[658.632014] Subtest basic-s2idle-without-i915: SUCCESS (5.795s)
[658.832756] [167/171] (360s left) i915_suspend (basic-s3-without-i915)
[658.915747] Starting subtest: basic-s3-without-i915
[661.799630] Subtest basic-s3-without-i915: SKIP (2.870s)
[662.692673] [168/171] (356s left) gem_exec_suspend (basic-s0)
[662.815552] Starting subtest: basic-S0
[662.816622] Starting dynamic subtest: smem
[683.379882] Dynamic subtest smem: SUCCESS (5.905s)
[683.390754] Starting dynamic subtest: lmem0
[703.403317] Dynamic subtest lmem0: SUCCESS (5.845s)
[703.404974] Subtest basic-S0: SUCCESS (11.753s)
[703.642739] [169/171] (344s left) gem_exec_suspend (basic-s3)
[703.754435] Starting subtest: basic-S3
[703.755507] Starting dynamic subtest: smem
[724.379152] Dynamic subtest smem: SUCCESS (5.903s)
[724.393301] Starting dynamic subtest: lmem0
[744.380357] Dynamic subtest lmem0: SUCCESS (5.802s)
[744.383548] Subtest basic-S3: SUCCESS (11.713s)
[744.613014] [170/171] (332s left) kms_chamelium_hpd (common-hpd-after-suspend)
[744.851916] Subtest common-hpd-after-suspend: SKIP (0.000s)
[744.987468] [171/171] (332s left) kms_pipe_crc_basic (suspend-read-crc)
[745.143813] Starting subtest: suspend-read-crc
[745.146456] Starting dynamic subtest: pipe-A-DP-1
[762.690143] Dynamic subtest pipe-A-DP-1: SUCCESS (2.864s)
[762.701276] Starting dynamic subtest: pipe-B-DP-1
[780.741149] Dynamic subtest pipe-B-DP-1: SUCCESS (2.876s)
[780.752188] Starting dynamic subtest: pipe-C-DP-1
[798.801865] Dynamic subtest pipe-C-DP-1: SUCCESS (3.004s)
[798.813214] Starting dynamic subtest: pipe-D-DP-1
[816.878597] Dynamic subtest pipe-D-DP-1: SUCCESS (3.150s)
[816.879581] Subtest suspend-read-crc: SUCCESS (11.907s)
[817.038724] Closing watchdogs
Done.