[41.006116] Initializing watchdogs
[41.006193]   /dev/watchdog0
[41.012512] [001/165] (960s left) i915_module_load (load)
[41.070046] Starting subtest: load
[42.397361] Subtest load: SUCCESS (1.327s)
[42.410963] [002/165] (959s left) core_auth (basic-auth)
[42.524417] Starting subtest: basic-auth
[42.525576] Subtest basic-auth: SUCCESS (0.002s)
[42.609105] [003/165] (958s left) debugfs_test (read_all_entries)
[42.703777] Starting subtest: read_all_entries
[43.199405] Subtest read_all_entries: SUCCESS (0.495s)
[43.333429] [004/165] (958s left) debugfs_test (basic-hwmon)
[43.406774] Starting subtest: basic-hwmon
[43.411367] Subtest basic-hwmon: SUCCESS (0.004s)
[43.533172] [005/165] (958s left) fbdev (eof)
[43.614362] Starting subtest: eof
[43.615426] Subtest eof: SUCCESS (0.000s)
[43.683984] [006/165] (957s left) fbdev (info)
[43.746791] Starting subtest: info
[43.747809] Subtest info: SUCCESS (0.000s)
[43.833424] [007/165] (957s left) fbdev (nullptr)
[43.897284] Starting subtest: nullptr
[43.898460] Subtest nullptr: SUCCESS (0.000s)
[43.966085] [008/165] (957s left) fbdev (read)
[44.030840] Starting subtest: read
[56.347908] Subtest read: SUCCESS (12.317s)
[56.400435] [009/165] (945s left) fbdev (write)
[56.464450] Starting subtest: write
[62.591379] Subtest write: SUCCESS (6.127s)
[62.650095] [010/165] (938s left) gem_basic (bad-close)
[62.713592] Starting subtest: bad-close
[62.715639] Subtest bad-close: SUCCESS (0.000s)
[62.789619] [011/165] (938s left) gem_basic (create-close)
[62.857154] Starting subtest: create-close
[62.859161] Subtest create-close: SUCCESS (0.000s)
[62.945546] [012/165] (938s left) gem_basic (create-fd-close)
[63.014898] Starting subtest: create-fd-close
[63.016938] Subtest create-fd-close: SUCCESS (0.000s)
[63.089271] [013/165] (938s left) gem_busy (busy@all-engines)
[63.187576] Starting subtest: busy
[63.188669] Starting dynamic subtest: all-engines
[63.315039] Dynamic subtest all-engines: SUCCESS (0.127s)
[63.315959] Subtest busy: SUCCESS (0.128s)
[63.801633] [014/165] (937s left) gem_close_race (basic-process)
[63.912365] Starting subtest: basic-process
[63.964451] Subtest basic-process: SUCCESS (0.052s)
[64.189192] [015/165] (937s left) gem_close_race (basic-threads)
[64.298884] Starting subtest: basic-threads
[65.615458] Subtest basic-threads: SUCCESS (1.316s)
[65.880310] [016/165] (935s left) gem_ctx_create (basic)
[65.977599] Starting subtest: basic
[65.978618] Subtest basic: SUCCESS (0.000s)
[66.169185] [017/165] (935s left) gem_ctx_create (basic-files)
[66.243829] Starting subtest: basic-files
[68.261522] Subtest basic-files: SUCCESS (2.018s)
[69.085609] [018/165] (932s left) gem_ctx_exec (basic)
[69.154561] Starting subtest: basic
[69.160818] Subtest basic: SUCCESS (0.006s)
[69.303488] [019/165] (932s left) gem_exec_basic (basic)
[69.378442] Starting subtest: basic
[69.379485] Starting dynamic subtest: rcs0-smem
[69.381522] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[69.387890] Starting dynamic subtest: bcs0-smem
[69.388926] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[69.395557] Starting dynamic subtest: vcs0-smem
[69.396716] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[69.402559] Starting dynamic subtest: vcs1-smem
[69.403713] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[69.409533] Starting dynamic subtest: vecs0-smem
[69.410686] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[69.416520] Starting dynamic subtest: vecs1-smem
[69.417672] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[69.423521] Starting dynamic subtest: ccs0-smem
[69.424672] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[69.430798] Starting dynamic subtest: ccs1-smem
[69.431962] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[69.437847] Starting dynamic subtest: ccs2-smem
[69.439053] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[69.444967] Starting dynamic subtest: ccs3-smem
[69.446144] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[69.452047] Starting dynamic subtest: rcs0-lmem0
[69.453143] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[69.459026] Starting dynamic subtest: bcs0-lmem0
[69.459969] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[69.465633] Starting dynamic subtest: vcs0-lmem0
[69.466716] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[69.472641] Starting dynamic subtest: vcs1-lmem0
[69.473784] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[69.479656] Starting dynamic subtest: vecs0-lmem0
[69.480792] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[69.486694] Starting dynamic subtest: vecs1-lmem0
[69.487806] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[69.493549] Starting dynamic subtest: ccs0-lmem0
[69.494543] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[69.500530] Starting dynamic subtest: ccs1-lmem0
[69.501512] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[69.508095] Starting dynamic subtest: ccs2-lmem0
[69.509211] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[69.515218] Starting dynamic subtest: ccs3-lmem0
[69.516433] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[69.517504] Subtest basic: SUCCESS (0.014s)
[69.568747] [020/165] (932s left) gem_exec_create (basic)
[69.648190] Starting subtest: basic
[69.649218] Starting dynamic subtest: smem
[71.766754] Dynamic subtest smem: SUCCESS (2.118s)
[71.772865] Starting dynamic subtest: lmem0
[73.898452] Dynamic subtest lmem0: SUCCESS (2.131s)
[73.899652] Subtest basic: SUCCESS (4.250s)
[74.089275] [021/165] (927s left) gem_exec_fence (basic-busy)
[74.333083] Starting subtest: basic-busy
[74.334872] Starting dynamic subtest: rcs0
[74.451088] Dynamic subtest rcs0: SUCCESS (0.118s)
[74.460570] Starting dynamic subtest: bcs0
[74.508935] Dynamic subtest bcs0: SUCCESS (0.058s)
[74.534280] Starting dynamic subtest: vcs0
[74.564670] Dynamic subtest vcs0: SUCCESS (0.055s)
[74.590536] Starting dynamic subtest: vcs1
[74.628695] Dynamic subtest vcs1: SUCCESS (0.063s)
[74.655060] Starting dynamic subtest: vecs0
[74.693629] Dynamic subtest vecs0: SUCCESS (0.064s)
[74.719799] Starting dynamic subtest: vecs1
[74.754732] Dynamic subtest vecs1: SUCCESS (0.060s)
[74.780513] Starting dynamic subtest: ccs0
[74.824717] Dynamic subtest ccs0: SUCCESS (0.070s)
[74.851237] Starting dynamic subtest: ccs1
[74.880654] Dynamic subtest ccs1: SUCCESS (0.055s)
[74.906201] Starting dynamic subtest: ccs2
[74.938376] Dynamic subtest ccs2: SUCCESS (0.057s)
[74.964610] Starting dynamic subtest: ccs3
[75.003505] Dynamic subtest ccs3: SUCCESS (0.065s)
[75.006061] Subtest basic-busy: SUCCESS (0.671s)
[76.223846] [022/165] (925s left) gem_exec_fence (basic-wait)
[76.469955] Starting subtest: basic-wait
[76.471665] Starting dynamic subtest: rcs0
[76.585203] Dynamic subtest rcs0: SUCCESS (0.115s)
[76.595211] Starting dynamic subtest: bcs0
[76.637976] Dynamic subtest bcs0: SUCCESS (0.053s)
[76.658702] Starting dynamic subtest: vcs0
[76.694392] Dynamic subtest vcs0: SUCCESS (0.055s)
[76.721190] Starting dynamic subtest: vcs1
[76.769111] Dynamic subtest vcs1: SUCCESS (0.074s)
[76.796303] Starting dynamic subtest: vecs0
[76.824398] Dynamic subtest vecs0: SUCCESS (0.055s)
[76.850815] Starting dynamic subtest: vecs1
[76.886991] Dynamic subtest vecs1: SUCCESS (0.062s)
[76.913662] Starting dynamic subtest: ccs0
[76.943419] Dynamic subtest ccs0: SUCCESS (0.056s)
[76.970273] Starting dynamic subtest: ccs1
[77.000942] Dynamic subtest ccs1: SUCCESS (0.057s)
[77.027757] Starting dynamic subtest: ccs2
[77.059374] Dynamic subtest ccs2: SUCCESS (0.058s)
[77.085831] Starting dynamic subtest: ccs3
[77.113089] Dynamic subtest ccs3: SUCCESS (0.054s)
[77.114861] Subtest basic-wait: SUCCESS (0.644s)
[78.219933] [023/165] (923s left) gem_exec_fence (basic-await)
[78.464271] Starting subtest: basic-await
[78.465912] Starting dynamic subtest: rcs0
[78.612265] Dynamic subtest rcs0: SUCCESS (0.148s)
[78.618386] Starting dynamic subtest: bcs0
[78.728181] Dynamic subtest bcs0: SUCCESS (0.116s)
[78.736166] Starting dynamic subtest: vcs0
[78.849417] Dynamic subtest vcs0: SUCCESS (0.121s)
[78.858131] Starting dynamic subtest: vcs1
[78.973758] Dynamic subtest vcs1: SUCCESS (0.124s)
[78.982298] Starting dynamic subtest: vecs0
[79.101133] Dynamic subtest vecs0: SUCCESS (0.127s)
[79.110512] Starting dynamic subtest: vecs1
[79.229076] Dynamic subtest vecs1: SUCCESS (0.128s)
[79.235722] Starting dynamic subtest: ccs0
[79.345209] Dynamic subtest ccs0: SUCCESS (0.116s)
[79.351858] Starting dynamic subtest: ccs1
[79.462602] Dynamic subtest ccs1: SUCCESS (0.117s)
[79.471281] Starting dynamic subtest: ccs2
[79.584074] Dynamic subtest ccs2: SUCCESS (0.121s)
[79.590547] Starting dynamic subtest: ccs3
[79.699975] Dynamic subtest ccs3: SUCCESS (0.116s)
[79.700932] Subtest basic-await: SUCCESS (1.237s)
[80.928384] [024/165] (920s left) gem_exec_fence (nb-await)
[81.179083] Starting subtest: nb-await
[81.180734] Starting dynamic subtest: rcs0
[81.279597] Dynamic subtest rcs0: SUCCESS (0.101s)
[81.287680] Starting dynamic subtest: bcs0
[81.348359] Dynamic subtest bcs0: SUCCESS (0.068s)
[81.366096] Starting dynamic subtest: vcs0
[81.440690] Dynamic subtest vcs0: SUCCESS (0.092s)
[81.449814] Starting dynamic subtest: vcs1
[81.513374] Dynamic subtest vcs1: SUCCESS (0.072s)
[81.525246] Starting dynamic subtest: vecs0
[81.596090] Dynamic subtest vecs0: SUCCESS (0.081s)
[81.623720] Starting dynamic subtest: vecs1
[81.696044] Dynamic subtest vecs1: SUCCESS (0.100s)
[81.711835] Starting dynamic subtest: ccs0
[81.787867] Dynamic subtest ccs0: SUCCESS (0.091s)
[81.806834] Starting dynamic subtest: ccs1
[81.880959] Dynamic subtest ccs1: SUCCESS (0.093s)
[81.903076] Starting dynamic subtest: ccs2
[81.979171] Dynamic subtest ccs2: SUCCESS (0.098s)
[81.990965] Starting dynamic subtest: ccs3
[82.062050] Dynamic subtest ccs3: SUCCESS (0.082s)
[82.064208] Subtest nb-await: SUCCESS (0.883s)
[83.221663] [025/165] (918s left) gem_exec_gttfill (basic)
[83.303922] Starting subtest: basic
[90.993569] Subtest basic: SUCCESS (7.689s)
[91.253171] [026/165] (910s left) gem_exec_parallel (engines)
[91.368789] Starting subtest: engines
[91.369838] Starting dynamic subtest: basic
[92.930276] Dynamic subtest basic: SUCCESS (1.561s)
[92.938138] Starting dynamic subtest: contexts
[95.985489] Dynamic subtest contexts: SUCCESS (3.055s)
[95.992711] Starting dynamic subtest: fds
[99.833410] Dynamic subtest fds: SUCCESS (3.848s)
[99.840705] Starting dynamic subtest: userptr
[101.279822] Dynamic subtest userptr: SUCCESS (1.446s)
[101.281051] Subtest engines: SUCCESS (9.911s)
[101.577190] [027/165] (900s left) gem_exec_store (basic)
[101.661544] Starting subtest: basic
[101.793556] Subtest basic: SUCCESS (0.132s)
[102.052238] [028/165] (899s left) gem_flink_basic (bad-flink)
[102.118690] Starting subtest: bad-flink
[102.119815] Subtest bad-flink: SUCCESS (0.000s)
[102.190072] [029/165] (899s left) gem_flink_basic (bad-open)
[102.264999] Starting subtest: bad-open
[102.266103] Subtest bad-open: SUCCESS (0.000s)
[102.344790] [030/165] (899s left) gem_flink_basic (basic)
[102.415476] Starting subtest: basic
[102.416380] Subtest basic: SUCCESS (0.000s)
[102.515445] [031/165] (899s left) gem_flink_basic (double-flink)
[102.616452] Starting subtest: double-flink
[102.617380] Subtest double-flink: SUCCESS (0.000s)
[102.690308] [032/165] (899s left) gem_flink_basic (flink-lifetime)
[102.765187] Starting subtest: flink-lifetime
[102.767218] Subtest flink-lifetime: SUCCESS (0.002s)
[102.885303] [033/165] (899s left) gem_huc_copy (huc-copy)
[102.992702] Starting subtest: huc-copy
[103.000253] Subtest huc-copy: SUCCESS (0.008s)
[103.135125] [034/165] (898s left) gem_linear_blits (basic)
[103.300346] Starting subtest: basic
[103.347984] Subtest basic: SUCCESS (0.047s)
[103.494438] [035/165] (898s left) gem_mmap (basic)
[103.607814] Subtest basic: SKIP (0.000s)
[103.640881] [036/165] (898s left) gem_mmap_gtt (basic)
[103.707585] Subtest basic: SKIP (0.000s)
[103.741042] [037/165] (898s left) gem_render_linear_blits (basic)
[103.819552] Starting subtest: basic
[103.902493] Subtest basic: SUCCESS (0.083s)
[103.974732] [038/165] (898s left) gem_render_tiled_blits (basic)
[104.062692] Subtest basic: SKIP (0.000s)
[104.090843] [039/165] (898s left) gem_ringfill (basic-all)
[104.518406] Starting subtest: basic-all
[108.242214] Subtest basic-all: SUCCESS (3.724s)
[108.386369] [040/165] (893s left) gem_softpin (allocator-basic)
[108.463013] Starting subtest: allocator-basic
[108.722520] Subtest allocator-basic: SUCCESS (0.259s)
[108.862367] [041/165] (893s left) gem_softpin (allocator-basic-reserve)
[108.943171] Starting subtest: allocator-basic-reserve
[109.211927] Subtest allocator-basic-reserve: SUCCESS (0.268s)
[109.351770] [042/165] (892s left) gem_softpin (safe-alignment)
[109.434148] Starting subtest: safe-alignment
[109.503869] Subtest safe-alignment: SUCCESS (0.070s)
[109.642613] [043/165] (892s left) gem_sync (basic-all)
[109.751351] Starting subtest: basic-all
[111.826448] Subtest basic-all: SUCCESS (2.075s)
[112.029798] [044/165] (890s left) gem_sync (basic-each)
[112.109196] Starting subtest: basic-each
[114.729260] Subtest basic-each: SUCCESS (2.620s)
[114.951405] [045/165] (887s left) gem_tiled_blits (basic)
[115.039056] Subtest basic: SKIP (0.000s)
[115.074815] [046/165] (887s left) gem_tiled_fence_blits (basic)
[115.148969] Subtest basic: SKIP (0.000s)
[115.174701] [047/165] (887s left) gem_tiled_pread_basic
[115.274962] [048/165] (887s left) gem_wait (busy@all-engines)
[115.361535] Starting subtest: busy
[115.362553] Starting dynamic subtest: all-engines
[115.947717] Dynamic subtest all-engines: SUCCESS (0.586s)
[115.948749] Subtest busy: SUCCESS (0.586s)
[116.209249] [049/165] (886s left) gem_wait (wait@all-engines)
[116.314433] Starting subtest: wait
[116.315499] Starting dynamic subtest: all-engines
[117.412513] Dynamic subtest all-engines: SUCCESS (1.098s)
[117.413859] Subtest wait: SUCCESS (1.098s)
[117.691102] [050/165] (884s left) i915_getparams_basic (basic-eu-total)
[117.778887] Starting subtest: basic-eu-total
[117.780794] Subtest basic-eu-total: SUCCESS (0.000s)
[117.841335] [051/165] (884s left) i915_getparams_basic (basic-subslice-total)
[117.909108] Starting subtest: basic-subslice-total
[117.911227] Subtest basic-subslice-total: SUCCESS (0.000s)
[117.973754] [052/165] (884s left) i915_hangman (error-state-basic)
[118.067577] Starting subtest: error-state-basic
[118.270126] Subtest error-state-basic: SUCCESS (0.203s)
[118.338039] [053/165] (884s left) i915_pciid
[118.472662] [054/165] (884s left) kms_addfb_basic (addfb25-4-tiled)
[118.613690] Starting subtest: addfb25-4-tiled
[118.614634] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[118.708906] [055/165] (883s left) kms_addfb_basic (addfb25-bad-modifier)
[118.787444] Starting subtest: addfb25-bad-modifier
[118.788338] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[118.940400] [056/165] (883s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[119.019578] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[119.173940] [057/165] (883s left) kms_addfb_basic (addfb25-modifier-no-flag)
[119.248213] Starting subtest: addfb25-modifier-no-flag
[119.249171] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[119.408574] [058/165] (883s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[119.490811] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[119.638992] [059/165] (882s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[119.711380] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[119.854457] [060/165] (882s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[119.983952] Starting subtest: addfb25-yf-tiled-legacy
[119.985088] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[120.070543] [061/165] (882s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[120.199502] Starting subtest: addfb25-y-tiled-legacy
[120.200487] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[120.290476] [062/165] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[120.426912] Starting subtest: addfb25-y-tiled-small-legacy
[120.428978] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[120.503311] [063/165] (882s left) kms_addfb_basic (bad-pitch-0)
[120.578200] Starting subtest: bad-pitch-0
[120.579171] Subtest bad-pitch-0: SUCCESS (0.000s)
[120.720503] [064/165] (881s left) kms_addfb_basic (bad-pitch-1024)
[120.787037] Starting subtest: bad-pitch-1024
[120.788057] Subtest bad-pitch-1024: SUCCESS (0.000s)
[120.919986] [065/165] (881s left) kms_addfb_basic (bad-pitch-128)
[120.987116] Starting subtest: bad-pitch-128
[120.988135] Subtest bad-pitch-128: SUCCESS (0.000s)
[121.140514] [066/165] (881s left) kms_addfb_basic (bad-pitch-256)
[121.216532] Starting subtest: bad-pitch-256
[121.217553] Subtest bad-pitch-256: SUCCESS (0.000s)
[121.354462] [067/165] (881s left) kms_addfb_basic (bad-pitch-32)
[121.421083] Starting subtest: bad-pitch-32
[121.422035] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.573201] [068/165] (881s left) kms_addfb_basic (bad-pitch-63)
[121.650697] Starting subtest: bad-pitch-63
[121.651799] Subtest bad-pitch-63: SUCCESS (0.000s)
[121.806694] [069/165] (880s left) kms_addfb_basic (bad-pitch-65536)
[121.881617] Starting subtest: bad-pitch-65536
[121.882680] Subtest bad-pitch-65536: SUCCESS (0.000s)
[122.042348] [070/165] (880s left) kms_addfb_basic (bad-pitch-999)
[122.121214] Starting subtest: bad-pitch-999
[122.122269] Subtest bad-pitch-999: SUCCESS (0.000s)
[122.273334] [071/165] (880s left) kms_addfb_basic (basic)
[122.346519] Starting subtest: basic
[122.347577] Subtest basic: SUCCESS (0.000s)
[122.487862] [072/165] (880s left) kms_addfb_basic (basic-x-tiled-legacy)
[122.559014] Starting subtest: basic-x-tiled-legacy
[122.561088] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[122.705616] [073/165] (880s left) kms_addfb_basic (basic-y-tiled-legacy)
[122.778259] Starting subtest: basic-y-tiled-legacy
[122.780240] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[122.922469] [074/165] (879s left) kms_addfb_basic (bo-too-small)
[123.061931] Starting subtest: bo-too-small
[123.063103] Subtest bo-too-small: SUCCESS (0.000s)
[123.138078] [075/165] (879s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[123.271299] Starting subtest: bo-too-small-due-to-tiling
[123.273359] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[123.355560] [076/165] (879s left) kms_addfb_basic (clobberred-modifier)
[123.425507] Starting subtest: clobberred-modifier
[123.427500] Subtest clobberred-modifier: SKIP (0.000s)
[123.571910] [077/165] (879s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.645352] Starting subtest: framebuffer-vs-set-tiling
[123.647342] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[123.788252] [078/165] (879s left) kms_addfb_basic (invalid-get-prop)
[123.856255] Starting subtest: invalid-get-prop
[123.857262] Subtest invalid-get-prop: SUCCESS (0.000s)
[124.005796] [079/165] (878s left) kms_addfb_basic (invalid-get-prop-any)
[124.080363] Starting subtest: invalid-get-prop-any
[124.081397] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[124.224656] [080/165] (878s left) kms_addfb_basic (invalid-set-prop)
[124.293735] Starting subtest: invalid-set-prop
[124.294721] Subtest invalid-set-prop: SUCCESS (0.000s)
[124.438503] [081/165] (878s left) kms_addfb_basic (invalid-set-prop-any)
[124.508851] Starting subtest: invalid-set-prop-any
[124.509885] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[124.647922] [082/165] (878s left) kms_addfb_basic (no-handle)
[124.719448] Starting subtest: no-handle
[124.720437] Subtest no-handle: SUCCESS (0.000s)
[124.874037] [083/165] (878s left) kms_addfb_basic (size-max)
[125.010470] Starting subtest: size-max
[125.011458] Subtest size-max: SUCCESS (0.000s)
[125.087560] [084/165] (877s left) kms_addfb_basic (small-bo)
[125.220925] Starting subtest: small-bo
[125.222048] Subtest small-bo: SUCCESS (0.000s)
[125.305735] [085/165] (877s left) kms_addfb_basic (tile-pitch-mismatch)
[125.378578] Starting subtest: tile-pitch-mismatch
[125.380403] Subtest tile-pitch-mismatch: SKIP (0.000s)
[125.521993] [086/165] (877s left) kms_addfb_basic (too-high)
[125.659071] Starting subtest: too-high
[125.660122] Subtest too-high: SUCCESS (0.001s)
[125.737994] [087/165] (877s left) kms_addfb_basic (too-wide)
[125.869531] Starting subtest: too-wide
[125.870470] Subtest too-wide: SUCCESS (0.000s)
[125.955769] [088/165] (877s left) kms_addfb_basic (unused-handle)
[126.026156] Starting subtest: unused-handle
[126.027088] Subtest unused-handle: SUCCESS (0.000s)
[126.172129] [089/165] (876s left) kms_addfb_basic (unused-modifier)
[126.242181] Starting subtest: unused-modifier
[126.243197] Subtest unused-modifier: SUCCESS (0.000s)
[126.411790] [090/165] (876s left) kms_addfb_basic (unused-offsets)
[126.485422] Starting subtest: unused-offsets
[126.486451] Subtest unused-offsets: SUCCESS (0.000s)
[126.640915] [091/165] (876s left) kms_addfb_basic (unused-pitches)
[126.713194] Starting subtest: unused-pitches
[126.714174] Subtest unused-pitches: SUCCESS (0.000s)
[126.854297] [092/165] (876s left) kms_busy (basic)
[126.992943] Starting subtest: basic
[126.995339] Starting dynamic subtest: flip
[127.742347] Dynamic subtest flip: SUCCESS (0.747s)
[127.751522] Starting dynamic subtest: modeset
[128.833887] Dynamic subtest modeset: SUCCESS (1.091s)
[128.834995] Subtest basic: SUCCESS (1.840s)
[129.097029] [093/165] (874s left) kms_prop_blob (basic)
[129.184574] Starting subtest: basic
[129.185575] Subtest basic: SUCCESS (0.000s)
[129.253245] [094/165] (874s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[129.389321] Starting subtest: basic-busy-flip-before-cursor-atomic
[129.391406] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[129.450810] [095/165] (873s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[129.581549] Starting subtest: basic-busy-flip-before-cursor-legacy
[129.583603] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[129.651144] [096/165] (873s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[129.782225] Starting subtest: basic-flip-after-cursor-atomic
[130.854210] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.072s)
[131.077539] [097/165] (872s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[131.217395] Starting subtest: basic-flip-after-cursor-legacy
[132.307140] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.090s)
[132.559870] [098/165] (870s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[132.707591] Starting subtest: basic-flip-after-cursor-varying-size
[133.797392] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.090s)
[134.042172] [099/165] (869s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[134.192015] Starting subtest: basic-flip-before-cursor-atomic
[135.265935] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.074s)
[135.522268] [100/165] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[135.672509] Starting subtest: basic-flip-before-cursor-legacy
[136.756194] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.084s)
[136.974906] [101/165] (866s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[137.115018] Starting subtest: basic-flip-before-cursor-varying-size
[138.190392] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.076s)
[138.455755] [102/165] (865s left) kms_dsc (dsc-basic)
[138.600280] Subtest dsc-basic: SKIP (0.000s)
[138.636445] [103/165] (864s left) kms_flip (basic-flip-vs-dpms)
[138.778151] Starting subtest: basic-flip-vs-dpms
[138.787408] Starting dynamic subtest: A-DP1
[139.724976] Dynamic subtest A-DP1: SUCCESS (0.938s)
[139.733383] Starting dynamic subtest: B-DP1
[140.650942] Dynamic subtest B-DP1: SUCCESS (0.924s)
[140.659116] Starting dynamic subtest: C-DP1
[141.559810] Dynamic subtest C-DP1: SUCCESS (0.907s)
[141.568049] Starting dynamic subtest: D-DP1
[142.498082] Dynamic subtest D-DP1: SUCCESS (0.938s)
[142.502542] Subtest basic-flip-vs-dpms: SUCCESS (3.725s)
[142.748843] [104/165] (860s left) kms_flip (basic-flip-vs-modeset)
[142.909581] Starting subtest: basic-flip-vs-modeset
[142.915815] Starting dynamic subtest: A-DP1
[143.900426] Dynamic subtest A-DP1: SUCCESS (0.984s)
[143.914474] Starting dynamic subtest: B-DP1
[144.854890] Dynamic subtest B-DP1: SUCCESS (0.952s)
[144.864960] Starting dynamic subtest: C-DP1
[145.815886] Dynamic subtest C-DP1: SUCCESS (0.960s)
[145.824407] Starting dynamic subtest: D-DP1
[146.766581] Dynamic subtest D-DP1: SUCCESS (0.949s)
[146.770820] Subtest basic-flip-vs-modeset: SUCCESS (3.862s)
[147.027782] [105/165] (856s left) kms_flip (basic-flip-vs-wf_vblank)
[147.164273] Starting subtest: basic-flip-vs-wf_vblank
[147.170346] Starting dynamic subtest: A-DP1
[148.555047] Dynamic subtest A-DP1: SUCCESS (1.385s)
[148.567823] Starting dynamic subtest: B-DP1
[149.681583] Dynamic subtest B-DP1: SUCCESS (1.125s)
[149.694527] Starting dynamic subtest: C-DP1
[150.861394] Dynamic subtest C-DP1: SUCCESS (1.178s)
[150.875537] Starting dynamic subtest: D-DP1
[152.014457] Dynamic subtest D-DP1: SUCCESS (1.151s)
[152.021355] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.858s)
[152.334126] [106/165] (851s left) kms_flip (basic-plain-flip)
[152.466293] Starting subtest: basic-plain-flip
[152.471808] Starting dynamic subtest: A-DP1
[153.388026] Dynamic subtest A-DP1: SUCCESS (0.916s)
[153.399120] Starting dynamic subtest: B-DP1
[154.226635] Dynamic subtest B-DP1: SUCCESS (0.837s)
[154.237619] Starting dynamic subtest: C-DP1
[155.071876] Dynamic subtest C-DP1: SUCCESS (0.844s)
[155.086282] Starting dynamic subtest: D-DP1
[155.940034] Dynamic subtest D-DP1: SUCCESS (0.866s)
[155.947096] Subtest basic-plain-flip: SUCCESS (3.482s)
[156.247581] [107/165] (847s left) kms_force_connector_basic (force-connector-state)
[156.319627] Starting subtest: force-connector-state
[156.593154] Subtest force-connector-state: SUCCESS (0.273s)
[156.883164] [108/165] (846s left) kms_force_connector_basic (force-edid)
[156.953664] Starting subtest: force-edid
[156.970373] Subtest force-edid: SUCCESS (0.016s)
[157.132956] [109/165] (846s left) kms_force_connector_basic (force-load-detect)
[157.203742] Starting subtest: force-load-detect
[157.205755] Subtest force-load-detect: SKIP (0.000s)
[157.316654] [110/165] (846s left) kms_force_connector_basic (prune-stale-modes)
[157.386718] Starting subtest: prune-stale-modes
[157.397033] Subtest prune-stale-modes: SKIP (0.009s)
[157.567930] [111/165] (846s left) kms_frontbuffer_tracking (basic)
[157.705578] Starting subtest: basic
[161.362126] Subtest basic: SUCCESS (3.656s)
[161.500584] [112/165] (842s left) kms_hdmi_inject (inject-audio)
[161.654037] Starting subtest: inject-audio
[161.756134] Subtest inject-audio: SUCCESS (0.102s)
[162.104490] [113/165] (841s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[162.233423] Starting subtest: compare-crc-sanitycheck-xr24
[162.234501] Starting dynamic subtest: pipe-A-DP-1
[162.809323] Dynamic subtest pipe-A-DP-1: SUCCESS (0.574s)
[162.823767] Starting dynamic subtest: pipe-B-DP-1
[163.363394] Dynamic subtest pipe-B-DP-1: SUCCESS (0.551s)
[163.373209] Starting dynamic subtest: pipe-C-DP-1
[163.904513] Dynamic subtest pipe-C-DP-1: SUCCESS (0.538s)
[163.914197] Starting dynamic subtest: pipe-D-DP-1
[164.452487] Dynamic subtest pipe-D-DP-1: SUCCESS (0.545s)
[164.453485] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.221s)
[164.703653] [114/165] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[164.862852] Starting subtest: compare-crc-sanitycheck-nv12
[164.863911] Starting dynamic subtest: pipe-A-DP-1
[166.127464] Dynamic subtest pipe-A-DP-1: SUCCESS (1.260s)
[166.135592] Starting dynamic subtest: pipe-B-DP-1
[167.341302] Dynamic subtest pipe-B-DP-1: SUCCESS (1.215s)
[167.351079] Starting dynamic subtest: pipe-C-DP-1
[168.580748] Dynamic subtest pipe-C-DP-1: SUCCESS (1.237s)
[168.590761] Starting dynamic subtest: pipe-D-DP-1
[169.670755] Dynamic subtest pipe-D-DP-1: SUCCESS (1.087s)
[169.671866] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.810s)
[169.916990] [115/165] (833s left) kms_pipe_crc_basic (hang-read-crc)
[170.055026] Starting subtest: hang-read-crc
[170.056147] Starting dynamic subtest: pipe-A-DP-1
[171.731220] Dynamic subtest pipe-A-DP-1: SUCCESS (1.675s)
[171.741030] Starting dynamic subtest: pipe-B-DP-1
[173.309079] Dynamic subtest pipe-B-DP-1: SUCCESS (1.576s)
[173.320766] Starting dynamic subtest: pipe-C-DP-1
[174.859387] Dynamic subtest pipe-C-DP-1: SUCCESS (1.547s)
[174.869151] Starting dynamic subtest: pipe-D-DP-1
[176.429179] Dynamic subtest pipe-D-DP-1: SUCCESS (1.567s)
[176.430226] Subtest hang-read-crc: SUCCESS (6.376s)
[176.671582] [116/165] (827s left) kms_pipe_crc_basic (nonblocking-crc)
[176.833571] Starting subtest: nonblocking-crc
[176.836407] Starting dynamic subtest: pipe-A-DP-1
[177.608973] Dynamic subtest pipe-A-DP-1: SUCCESS (0.773s)
[177.619164] Starting dynamic subtest: pipe-B-DP-1
[178.340306] Dynamic subtest pipe-B-DP-1: SUCCESS (0.729s)
[178.349944] Starting dynamic subtest: pipe-C-DP-1
[179.073425] Dynamic subtest pipe-C-DP-1: SUCCESS (0.730s)
[179.082878] Starting dynamic subtest: pipe-D-DP-1
[179.811270] Dynamic subtest pipe-D-DP-1: SUCCESS (0.735s)
[179.812216] Subtest nonblocking-crc: SUCCESS (2.979s)
[180.057758] [117/165] (823s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[180.205926] Starting subtest: nonblocking-crc-frame-sequence
[180.207010] Starting dynamic subtest: pipe-A-DP-1
[181.004919] Dynamic subtest pipe-A-DP-1: SUCCESS (0.795s)
[181.020321] Starting dynamic subtest: pipe-B-DP-1
[181.738288] Dynamic subtest pipe-B-DP-1: SUCCESS (0.730s)
[181.748109] Starting dynamic subtest: pipe-C-DP-1
[182.471513] Dynamic subtest pipe-C-DP-1: SUCCESS (0.730s)
[182.481459] Starting dynamic subtest: pipe-D-DP-1
[183.160800] Dynamic subtest pipe-D-DP-1: SUCCESS (0.687s)
[183.162588] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.956s)
[183.414526] [118/165] (820s left) kms_pipe_crc_basic (read-crc)
[183.572455] Starting subtest: read-crc
[183.573559] Starting dynamic subtest: pipe-A-DP-1
[184.295606] Dynamic subtest pipe-A-DP-1: SUCCESS (0.722s)
[184.305848] Starting dynamic subtest: pipe-B-DP-1
[184.942374] Dynamic subtest pipe-B-DP-1: SUCCESS (0.643s)
[184.952532] Starting dynamic subtest: pipe-C-DP-1
[185.640182] Dynamic subtest pipe-C-DP-1: SUCCESS (0.694s)
[185.650116] Starting dynamic subtest: pipe-D-DP-1
[186.308488] Dynamic subtest pipe-D-DP-1: SUCCESS (0.666s)
[186.309515] Subtest read-crc: SUCCESS (2.738s)
[186.518965] [119/165] (817s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[186.653208] Starting subtest: read-crc-frame-sequence
[186.654284] Starting dynamic subtest: pipe-A-DP-1
[187.419619] Dynamic subtest pipe-A-DP-1: SUCCESS (0.765s)
[187.429448] Starting dynamic subtest: pipe-B-DP-1
[188.085657] Dynamic subtest pipe-B-DP-1: SUCCESS (0.664s)
[188.095552] Starting dynamic subtest: pipe-C-DP-1
[188.749440] Dynamic subtest pipe-C-DP-1: SUCCESS (0.660s)
[188.759302] Starting dynamic subtest: pipe-D-DP-1
[189.417472] Dynamic subtest pipe-D-DP-1: SUCCESS (0.665s)
[189.418494] Subtest read-crc-frame-sequence: SUCCESS (2.766s)
[189.664399] [120/165] (814s left) kms_pm_backlight (basic-brightness)
[189.811012] Subtest basic-brightness: SKIP (0.000s)
[189.837430] [121/165] (814s left) kms_pm_rpm (basic-pci-d3-state)
[191.507214] Starting subtest: basic-pci-d3-state
[192.069908] Subtest basic-pci-d3-state: SUCCESS (0.564s)
[192.249860] [122/165] (811s left) kms_pm_rpm (basic-rte)
[192.320788] Starting subtest: basic-rte
[194.952037] Subtest basic-rte: SUCCESS (2.631s)
[195.518915] [123/165] (808s left) kms_psr (psr_primary_page_flip)
[195.710052] [124/165] (808s left) kms_psr (psr_cursor_plane_move)
[195.876335] [125/165] (808s left) kms_psr (psr_sprite_plane_onoff)
[196.042929] [126/165] (807s left) kms_psr (psr_primary_mmap_gtt)
[196.209487] [127/165] (807s left) kms_setmode (basic-clone-single-crtc)
[196.279057] Starting subtest: basic-clone-single-crtc
[196.282219] Subtest basic-clone-single-crtc: SKIP (0.001s)
[196.371448] [128/165] (807s left) i915_pm_rps (basic-api)
[196.472434] Starting subtest: basic-api
[196.474682] Subtest basic-api: SKIP (0.000s)
[196.539832] [129/165] (807s left) prime_self_import (basic-llseek-bad)
[196.608737] Starting subtest: basic-llseek-bad
[196.612582] Subtest basic-llseek-bad: SUCCESS (0.003s)
[196.738024] [130/165] (807s left) prime_self_import (basic-llseek-size)
[196.820140] Starting subtest: basic-llseek-size
[196.824219] Subtest basic-llseek-size: SUCCESS (0.003s)
[196.916491] [131/165] (807s left) prime_self_import (basic-with_fd_dup)
[196.986352] Starting subtest: basic-with_fd_dup
[196.990164] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[197.086955] [132/165] (807s left) prime_self_import (basic-with_one_bo)
[197.175483] Starting subtest: basic-with_one_bo
[197.179216] Subtest basic-with_one_bo: SUCCESS (0.004s)
[197.246947] [133/165] (806s left) prime_self_import (basic-with_one_bo_two_files)
[197.326164] Starting subtest: basic-with_one_bo_two_files
[197.329920] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[197.453852] [134/165] (806s left) prime_self_import (basic-with_two_bos)
[197.541374] Starting subtest: basic-with_two_bos
[197.544777] Subtest basic-with_two_bos: SUCCESS (0.004s)
[197.667331] [135/165] (806s left) prime_vgem (basic-fence-flip)
[197.766875] Starting subtest: basic-fence-flip
[197.881664] Subtest basic-fence-flip: SKIP (0.114s)
[197.993994] [136/165] (806s left) prime_vgem (basic-fence-mmap)
[198.091729] Starting subtest: basic-fence-mmap
[198.093924] Subtest basic-fence-mmap: SKIP (0.000s)
[198.223139] [137/165] (806s left) prime_vgem (basic-fence-read)
[198.308728] Starting subtest: basic-fence-read
[198.315515] Subtest basic-fence-read: SKIP (0.006s)
[198.421117] [138/165] (805s left) prime_vgem (basic-gtt)
[198.524967] Starting subtest: basic-gtt
[198.527208] Subtest basic-gtt: SKIP (0.000s)
[198.650017] [139/165] (805s left) prime_vgem (basic-read)
[198.758541] Starting subtest: basic-read
[198.765509] Subtest basic-read: SKIP (0.006s)
[198.879571] [140/165] (805s left) prime_vgem (basic-write)
[198.991452] Starting subtest: basic-write
[198.998252] Subtest basic-write: SKIP (0.006s)
[199.139619] [141/165] (805s left) vgem_basic (setversion)
[199.216199] Starting subtest: setversion
[199.218348] Subtest setversion: SUCCESS (0.000s)
[199.271675] [142/165] (805s left) vgem_basic (create)
[199.349402] Starting subtest: create
[199.350462] Subtest create: SUCCESS (0.000s)
[199.406464] [143/165] (805s left) vgem_basic (debugfs)
[199.482841] Starting subtest: debugfs
[199.483884] Subtest debugfs: SUCCESS (0.000s)
[199.539072] [144/165] (804s left) vgem_basic (dmabuf-export)
[199.616182] Starting subtest: dmabuf-export
[199.620127] Subtest dmabuf-export: SUCCESS (0.003s)
[199.733789] [145/165] (804s left) vgem_basic (dmabuf-fence)
[199.833166] Starting subtest: dmabuf-fence
[199.834250] Subtest dmabuf-fence: SUCCESS (0.000s)
[199.892513] [146/165] (804s left) vgem_basic (dmabuf-fence-before)
[199.966223] Starting subtest: dmabuf-fence-before
[199.967316] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[200.024877] [147/165] (804s left) vgem_basic (dmabuf-mmap)
[200.100833] Starting subtest: dmabuf-mmap
[200.111543] Subtest dmabuf-mmap: SUCCESS (0.012s)
[200.158914] [148/165] (804s left) vgem_basic (mmap)
[200.282813] Starting subtest: mmap
[200.291117] Subtest mmap: SUCCESS (0.009s)
[200.339106] [149/165] (804s left) vgem_basic (second-client)
[200.415901] Starting subtest: second-client
[200.449291] Subtest second-client: SUCCESS (0.033s)
[200.527838] [150/165] (804s left) vgem_basic (sysfs)
[200.616087] Starting subtest: sysfs
[200.617107] Subtest sysfs: SUCCESS (0.000s)
[200.687229] [151/165] (804s left) core_hotunplug (unbind-rebind)
[200.799187] Starting subtest: unbind-rebind
[205.532071] Subtest unbind-rebind: SUCCESS (4.733s)
[205.553398] [152/165] (799s left) vgem_basic (unload)
[205.620572] Starting subtest: unload
[234.614248] Subtest unload: SUCCESS (28.992s)
[234.746329] [153/165] (770s left) i915_module_load (reload)
[234.823166] Starting subtest: reload
[238.389278] Subtest reload: SUCCESS (3.568s)
[238.406737] [154/165] (766s left) gem_lmem_swapping (basic)
[242.005417] Starting subtest: basic
[242.006510] Starting dynamic subtest: lmem0
[269.189233] Dynamic subtest lmem0: SUCCESS (27.183s)
[269.190191] Subtest basic: SUCCESS (27.184s)
[271.839862] [155/165] (732s left) gem_lmem_swapping (parallel-random-engines)
[272.850526] Starting subtest: parallel-random-engines
[272.851496] Starting dynamic subtest: lmem0
[306.565328] Dynamic subtest lmem0: SUCCESS (33.713s)
[306.566827] Subtest parallel-random-engines: SUCCESS (33.716s)
[308.043670] [156/165] (696s left) gem_lmem_swapping (random-engines)
[308.993371] Starting subtest: random-engines
[308.994386] Starting dynamic subtest: lmem0
[310.182249] Dynamic subtest lmem0: SUCCESS (1.187s)
[310.183295] Subtest random-engines: SUCCESS (1.189s)
[311.579731] [157/165] (693s left) gem_lmem_swapping (verify-random)
[312.592671] Starting subtest: verify-random
[312.593672] Starting dynamic subtest: lmem0
[323.877028] Dynamic subtest lmem0: SUCCESS (11.283s)
[323.878051] Subtest verify-random: SUCCESS (11.285s)
[325.364705] [158/165] (679s left) i915_pm_rpm (module-reload)
[328.735810] Starting subtest: module-reload
[340.205059] Subtest module-reload: SUCCESS (11.469s)
[340.225929] [159/165] (664s left) i915_selftest (live)
[340.291829] Starting subtest: live
[340.292892] Starting dynamic subtest: sanitycheck
[342.373369] Dynamic subtest sanitycheck: SUCCESS (2.081s)
[342.383660] Starting dynamic subtest: uncore
[344.428335] Dynamic subtest uncore: SUCCESS (2.053s)
[344.438549] Starting dynamic subtest: workarounds
[349.109166] Dynamic subtest workarounds: SUCCESS (4.679s)
[349.117796] Starting dynamic subtest: gt_engines
[352.253030] Dynamic subtest gt_engines: SUCCESS (3.142s)
[352.260130] Starting dynamic subtest: gt_timelines
[387.166054] Dynamic subtest gt_timelines: SUCCESS (34.912s)
[387.172966] Starting dynamic subtest: gt_contexts
[389.256230] Dynamic subtest gt_contexts: SUCCESS (2.089s)
[389.263542] Starting dynamic subtest: gt_lrc
[398.314406] Dynamic subtest gt_lrc: SUCCESS (9.057s)
[398.325496] Starting dynamic subtest: gt_mocs
[402.370258] Dynamic subtest gt_mocs: SUCCESS (4.054s)
[402.376819] Starting dynamic subtest: gt_pm
[405.400071] Dynamic subtest gt_pm: SUCCESS (3.029s)
[405.407091] Starting dynamic subtest: gt_heartbeat
[407.707239] Dynamic subtest gt_heartbeat: SUCCESS (2.306s)
[407.717490] Starting dynamic subtest: gt_tlb
[424.397175] Dynamic subtest gt_tlb: SUCCESS (16.688s)
[424.406312] Starting dynamic subtest: requests
[442.901123] Dynamic subtest requests: SUCCESS (18.502s)
[442.910857] Starting dynamic subtest: migrate
[448.636471] Dynamic subtest migrate: SUCCESS (5.734s)
[448.644252] Starting dynamic subtest: active
[450.718184] Dynamic subtest active: SUCCESS (2.080s)
[450.727331] Starting dynamic subtest: objects
[454.159362] Dynamic subtest objects: SUCCESS (3.439s)
[454.166974] Starting dynamic subtest: mman
[465.247089] Dynamic subtest mman: SUCCESS (11.086s)
[465.254378] Starting dynamic subtest: dmabuf
[467.292055] Dynamic subtest dmabuf: SUCCESS (2.044s)
[467.301226] Starting dynamic subtest: vma
[469.325287] Dynamic subtest vma: SUCCESS (2.031s)
[469.332091] Starting dynamic subtest: coherency
[473.787144] Dynamic subtest coherency: SUCCESS (4.460s)
[473.796816] Starting dynamic subtest: gtt
[484.461192] Dynamic subtest gtt: SUCCESS (10.672s)
[484.467599] Starting dynamic subtest: gem
[486.556073] Dynamic subtest gem: SUCCESS (2.094s)
[486.565564] Starting dynamic subtest: evict
[491.061492] Dynamic subtest evict: SUCCESS (4.504s)
[491.077660] Starting dynamic subtest: hugepages
[510.224350] Dynamic subtest hugepages: SUCCESS (19.160s)
[510.233525] Starting dynamic subtest: gem_contexts
[557.243027] Dynamic subtest gem_contexts: SUCCESS (47.017s)
[557.254089] Starting dynamic subtest: client
[559.348263] Dynamic subtest client: SUCCESS (2.104s)
[559.357720] Starting dynamic subtest: gem_migrate
[564.444431] Dynamic subtest gem_migrate: SUCCESS (5.095s)
[564.453691] Starting dynamic subtest: reset
[566.598235] Dynamic subtest reset: SUCCESS (2.152s)
[566.605827] Starting dynamic subtest: memory_region
[570.190053] Dynamic subtest memory_region: SUCCESS (3.590s)
[570.197304] Starting dynamic subtest: hangcheck
[617.069297] Dynamic subtest hangcheck: SUCCESS (46.878s)
[617.076806] Starting dynamic subtest: execlists
[619.142096] Dynamic subtest execlists: SUCCESS (2.071s)
[619.150166] Starting dynamic subtest: ring_submission
[621.246056] Dynamic subtest ring_submission: SUCCESS (2.102s)
[621.253142] Starting dynamic subtest: perf
[623.466092] Dynamic subtest perf: SUCCESS (2.219s)
[623.474206] Starting dynamic subtest: slpc
[633.349255] Dynamic subtest slpc: SUCCESS (9.882s)
[633.355798] Starting dynamic subtest: guc
[636.841139] Dynamic subtest guc: SUCCESS (3.491s)
[636.850881] Starting dynamic subtest: guc_multi_lrc
[638.971058] Dynamic subtest guc_multi_lrc: SUCCESS (2.128s)
[638.980563] Starting dynamic subtest: guc_hang
[641.803317] Dynamic subtest guc_hang: SUCCESS (2.830s)
[641.813599] Starting dynamic subtest: late_gt_pm
[643.992394] Dynamic subtest late_gt_pm: SUCCESS (2.187s)
[643.993627] Subtest live: SUCCESS (303.701s)
[644.266388] [160/165] (360s left) dmabuf (all-tests)
[644.328978] Starting subtest: all-tests
[644.330214] Starting dynamic subtest: sanitycheck
[644.411151] Dynamic subtest sanitycheck: SUCCESS (0.081s)
[644.426115] Starting dynamic subtest: dma_fence
[644.593767] Dynamic subtest dma_fence: SUCCESS (0.179s)
[644.612483] Starting dynamic subtest: dma_fence_chain
[658.584478] Dynamic subtest dma_fence_chain: SUCCESS (13.988s)
[658.606358] Starting dynamic subtest: dma_fence_unwrap
[658.668681] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s)
[658.681029] Starting dynamic subtest: dma_resv
[658.754057] Dynamic subtest dma_resv: SUCCESS (0.080s)
[658.756722] Subtest all-tests: SUCCESS (14.427s)
[658.804382] [161/165] (346s left) i915_suspend (basic-s2idle-without-i915)
[658.880413] Starting subtest: basic-s2idle-without-i915
[679.984787] Subtest basic-s2idle-without-i915: SUCCESS (5.691s)
[680.200827] [162/165] (340s left) i915_suspend (basic-s3-without-i915)
[680.266360] Starting subtest: basic-s3-without-i915
[682.885112] Subtest basic-s3-without-i915: SKIP (2.616s)
[683.775508] [163/165] (336s left) gem_exec_suspend (basic-s0)
[683.864431] Starting subtest: basic-S0
[683.865566] Starting dynamic subtest: smem