[40.421536] Initializing watchdogs
[40.421644]   /dev/watchdog0
[40.426969] [001/171] (960s left) i915_module_load (load)
[40.478882] Starting subtest: load
[41.568409] Subtest load: SUCCESS (1.089s)
[41.578803] [002/171] (959s left) core_auth (basic-auth)
[41.656862] Starting subtest: basic-auth
[41.657624] Subtest basic-auth: SUCCESS (0.001s)
[41.744068] [003/171] (959s left) debugfs_test (read_all_entries)
[41.833743] Starting subtest: read_all_entries
[42.235945] Subtest read_all_entries: SUCCESS (0.401s)
[42.385280] [004/171] (958s left) debugfs_test (basic-hwmon)
[42.447047] Starting subtest: basic-hwmon
[42.449613] Subtest basic-hwmon: SUCCESS (0.002s)
[42.551784] [005/171] (958s left) fbdev (eof)
[42.618414] Starting subtest: eof
[42.619435] Subtest eof: SUCCESS (0.000s)
[42.685111] [006/171] (958s left) fbdev (info)
[42.740271] Starting subtest: info
[42.741099] Subtest info: SUCCESS (0.000s)
[42.818710] [007/171] (958s left) fbdev (nullptr)
[42.884857] Starting subtest: nullptr
[42.885819] Subtest nullptr: SUCCESS (0.000s)
[42.952256] [008/171] (958s left) fbdev (read)
[43.018708] Starting subtest: read
[55.255558] Subtest read: SUCCESS (12.202s)
[55.268954] [009/171] (945s left) fbdev (write)
[55.335483] Starting subtest: write
[61.404514] Subtest write: SUCCESS (6.060s)
[61.452472] [010/171] (939s left) gem_basic (bad-close)
[61.509049] Starting subtest: bad-close
[61.511073] Subtest bad-close: SUCCESS (0.000s)
[61.570935] [011/171] (939s left) gem_basic (create-close)
[61.628263] Starting subtest: create-close
[61.630212] Subtest create-close: SUCCESS (0.000s)
[61.708011] [012/171] (939s left) gem_basic (create-fd-close)
[61.767049] Starting subtest: create-fd-close
[61.768660] Subtest create-fd-close: SUCCESS (0.000s)
[61.839970] [013/171] (939s left) gem_busy (busy@all-engines)
[61.917794] Starting subtest: busy
[61.918594] Starting dynamic subtest: all-engines
[62.026777] Dynamic subtest all-engines: SUCCESS (0.109s)
[62.027588] Subtest busy: SUCCESS (0.109s)
[62.430878] [014/171] (938s left) gem_close_race (basic-process)
[62.543255] Starting subtest: basic-process
[62.596454] Subtest basic-process: SUCCESS (0.053s)
[62.814489] [015/171] (938s left) gem_close_race (basic-threads)
[62.901967] Starting subtest: basic-threads
[64.098276] Subtest basic-threads: SUCCESS (1.196s)
[64.330843] [016/171] (936s left) gem_ctx_create (basic)
[64.427439] Starting subtest: basic
[64.428533] Subtest basic: SUCCESS (0.000s)
[64.630478] [017/171] (936s left) gem_ctx_create (basic-files)
[64.695068] Starting subtest: basic-files
[66.705961] Subtest basic-files: SUCCESS (2.011s)
[67.470765] [018/171] (933s left) gem_ctx_exec (basic)
[67.556297] Starting subtest: basic
[67.559189] Subtest basic: SUCCESS (0.003s)
[67.665670] [019/171] (933s left) gem_exec_basic (basic)
[67.727189] Starting subtest: basic
[67.728008] Starting dynamic subtest: rcs0-smem
[67.730464] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[67.735309] Starting dynamic subtest: bcs0-smem
[67.736213] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[67.741116] Starting dynamic subtest: vcs0-smem
[67.741902] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[67.746522] Starting dynamic subtest: vcs1-smem
[67.747312] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[67.751736] Starting dynamic subtest: vecs0-smem
[67.752715] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[67.757332] Starting dynamic subtest: vecs1-smem
[67.758123] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[67.762539] Starting dynamic subtest: ccs0-smem
[67.763326] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[67.767758] Starting dynamic subtest: ccs1-smem
[67.768890] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[67.773474] Starting dynamic subtest: ccs2-smem
[67.774296] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[67.778818] Starting dynamic subtest: ccs3-smem
[67.779585] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[67.784026] Starting dynamic subtest: rcs0-lmem0
[67.784809] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[67.789247] Starting dynamic subtest: bcs0-lmem0
[67.790048] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[67.794499] Starting dynamic subtest: vcs0-lmem0
[67.795296] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[67.799684] Starting dynamic subtest: vcs1-lmem0
[67.800473] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[67.804907] Starting dynamic subtest: vecs0-lmem0
[67.805705] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[67.810149] Starting dynamic subtest: vecs1-lmem0
[67.810934] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[67.815360] Starting dynamic subtest: ccs0-lmem0
[67.816327] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[67.820830] Starting dynamic subtest: ccs1-lmem0
[67.821620] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[67.826043] Starting dynamic subtest: ccs2-lmem0
[67.826827] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[67.831253] Starting dynamic subtest: ccs3-lmem0
[67.832042] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[67.832833] Subtest basic: SUCCESS (0.012s)
[67.911684] [020/171] (933s left) gem_exec_create (basic)
[67.981256] Starting subtest: basic
[67.982181] Starting dynamic subtest: smem
[70.085162] Dynamic subtest smem: SUCCESS (2.104s)
[70.090702] Starting dynamic subtest: lmem0
[72.188542] Dynamic subtest lmem0: SUCCESS (2.103s)
[72.189641] Subtest basic: SUCCESS (4.207s)
[72.373320] [021/171] (928s left) gem_exec_fence (basic-busy)
[72.575375] Starting subtest: basic-busy
[72.576393] Starting dynamic subtest: rcs0
[72.666348] Dynamic subtest rcs0: SUCCESS (0.099s)
[72.684383] Starting dynamic subtest: bcs0
[72.718949] Dynamic subtest bcs0: SUCCESS (0.052s)
[72.739166] Starting dynamic subtest: vcs0
[72.779074] Dynamic subtest vcs0: SUCCESS (0.060s)
[72.799524] Starting dynamic subtest: vcs1
[72.838077] Dynamic subtest vcs1: SUCCESS (0.059s)
[72.858728] Starting dynamic subtest: vecs0
[72.891048] Dynamic subtest vecs0: SUCCESS (0.053s)
[72.911568] Starting dynamic subtest: vecs1
[72.948217] Dynamic subtest vecs1: SUCCESS (0.057s)
[72.968860] Starting dynamic subtest: ccs0
[73.006830] Dynamic subtest ccs0: SUCCESS (0.058s)
[73.027609] Starting dynamic subtest: ccs1
[73.060046] Dynamic subtest ccs1: SUCCESS (0.053s)
[73.080773] Starting dynamic subtest: ccs2
[73.119855] Dynamic subtest ccs2: SUCCESS (0.059s)
[73.140706] Starting dynamic subtest: ccs3
[73.173049] Dynamic subtest ccs3: SUCCESS (0.053s)
[73.175037] Subtest basic-busy: SUCCESS (0.605s)
[74.159938] [022/171] (927s left) gem_exec_fence (basic-wait)
[74.343110] Starting subtest: basic-wait
[74.343994] Starting dynamic subtest: rcs0
[74.435220] Dynamic subtest rcs0: SUCCESS (0.093s)
[74.443594] Starting dynamic subtest: bcs0
[74.483805] Dynamic subtest bcs0: SUCCESS (0.049s)
[74.496914] Starting dynamic subtest: vcs0
[74.536051] Dynamic subtest vcs0: SUCCESS (0.051s)
[74.557414] Starting dynamic subtest: vcs1
[74.587722] Dynamic subtest vcs1: SUCCESS (0.051s)
[74.609217] Starting dynamic subtest: vecs0
[74.638954] Dynamic subtest vecs0: SUCCESS (0.051s)
[74.660622] Starting dynamic subtest: vecs1
[74.691931] Dynamic subtest vecs1: SUCCESS (0.052s)
[74.713486] Starting dynamic subtest: ccs0
[74.744045] Dynamic subtest ccs0: SUCCESS (0.052s)
[74.765286] Starting dynamic subtest: ccs1
[74.800980] Dynamic subtest ccs1: SUCCESS (0.056s)
[74.822557] Starting dynamic subtest: ccs2
[74.855067] Dynamic subtest ccs2: SUCCESS (0.054s)
[74.876452] Starting dynamic subtest: ccs3
[74.910765] Dynamic subtest ccs3: SUCCESS (0.055s)
[74.912556] Subtest basic-wait: SUCCESS (0.568s)
[75.909920] [023/171] (925s left) gem_exec_fence (basic-await)
[76.122083] Starting subtest: basic-await
[76.123015] Starting dynamic subtest: rcs0
[76.228331] Dynamic subtest rcs0: SUCCESS (0.112s)
[76.233434] Starting dynamic subtest: bcs0
[76.318546] Dynamic subtest bcs0: SUCCESS (0.090s)
[76.324178] Starting dynamic subtest: vcs0
[76.410448] Dynamic subtest vcs0: SUCCESS (0.092s)
[76.415960] Starting dynamic subtest: vcs1
[76.503589] Dynamic subtest vcs1: SUCCESS (0.093s)
[76.508678] Starting dynamic subtest: vecs0
[76.594093] Dynamic subtest vecs0: SUCCESS (0.090s)
[76.599274] Starting dynamic subtest: vecs1
[76.684421] Dynamic subtest vecs1: SUCCESS (0.090s)
[76.690306] Starting dynamic subtest: ccs0
[76.782128] Dynamic subtest ccs0: SUCCESS (0.098s)
[76.788294] Starting dynamic subtest: ccs1
[76.879395] Dynamic subtest ccs1: SUCCESS (0.097s)
[76.894998] Starting dynamic subtest: ccs2
[76.973718] Dynamic subtest ccs2: SUCCESS (0.094s)
[76.979433] Starting dynamic subtest: ccs3
[77.067964] Dynamic subtest ccs3: SUCCESS (0.094s)
[77.068845] Subtest basic-await: SUCCESS (0.952s)
[78.044090] [024/171] (923s left) gem_exec_fence (nb-await)
[78.238942] Starting subtest: nb-await
[78.240211] Starting dynamic subtest: rcs0
[78.336823] Dynamic subtest rcs0: SUCCESS (0.105s)
[78.342845] Starting dynamic subtest: bcs0
[78.401792] Dynamic subtest bcs0: SUCCESS (0.064s)
[78.412051] Starting dynamic subtest: vcs0
[78.464380] Dynamic subtest vcs0: SUCCESS (0.063s)
[78.473649] Starting dynamic subtest: vcs1
[78.535573] Dynamic subtest vcs1: SUCCESS (0.070s)
[78.543625] Starting dynamic subtest: vecs0
[78.600150] Dynamic subtest vecs0: SUCCESS (0.065s)
[78.607709] Starting dynamic subtest: vecs1
[78.667486] Dynamic subtest vecs1: SUCCESS (0.067s)
[78.690353] Starting dynamic subtest: ccs0
[78.760981] Dynamic subtest ccs0: SUCCESS (0.093s)
[78.774159] Starting dynamic subtest: ccs1
[78.834456] Dynamic subtest ccs1: SUCCESS (0.073s)
[78.841295] Starting dynamic subtest: ccs2
[78.897476] Dynamic subtest ccs2: SUCCESS (0.063s)
[78.908283] Starting dynamic subtest: ccs3
[78.972893] Dynamic subtest ccs3: SUCCESS (0.074s)
[78.975057] Subtest nb-await: SUCCESS (0.741s)
[79.904897] [025/171] (921s left) gem_exec_gttfill (basic)
[79.973178] Starting subtest: basic
[84.858748] Subtest basic: SUCCESS (4.877s)
[85.086985] [026/171] (916s left) gem_exec_parallel (engines)
[85.195499] Starting subtest: engines
[85.196316] Starting dynamic subtest: basic
[87.912480] Dynamic subtest basic: SUCCESS (2.717s)
[87.920582] Starting dynamic subtest: contexts
[90.941235] Dynamic subtest contexts: SUCCESS (3.020s)
[90.946981] Starting dynamic subtest: fds
[95.003591] Dynamic subtest fds: SUCCESS (4.062s)
[95.009021] Starting dynamic subtest: userptr
[96.687794] Dynamic subtest userptr: SUCCESS (1.693s)
[96.688664] Subtest engines: SUCCESS (11.492s)
[96.946644] [027/171] (904s left) gem_exec_store (basic)
[97.041473] Starting subtest: basic
[97.179862] Subtest basic: SUCCESS (0.138s)
[97.370526] [028/171] (903s left) gem_flink_basic (bad-flink)
[97.430328] Starting subtest: bad-flink
[97.431209] Subtest bad-flink: SUCCESS (0.000s)
[97.490441] [029/171] (903s left) gem_flink_basic (bad-open)
[97.547520] Starting subtest: bad-open
[97.548447] Subtest bad-open: SUCCESS (0.000s)
[97.605945] [030/171] (903s left) gem_flink_basic (basic)
[97.673224] Starting subtest: basic
[97.674146] Subtest basic: SUCCESS (0.000s)
[97.766436] [031/171] (903s left) gem_flink_basic (double-flink)
[97.853261] Starting subtest: double-flink
[97.854127] Subtest double-flink: SUCCESS (0.000s)
[97.923620] [032/171] (903s left) gem_flink_basic (flink-lifetime)
[97.994292] Starting subtest: flink-lifetime
[97.996009] Subtest flink-lifetime: SUCCESS (0.002s)
[98.104329] [033/171] (903s left) gem_huc_copy (huc-copy)
[98.197869] Starting subtest: huc-copy
[98.202892] Subtest huc-copy: SUCCESS (0.005s)
[98.336706] [034/171] (903s left) gem_linear_blits (basic)
[98.461621] Starting subtest: basic
[98.486886] Subtest basic: SUCCESS (0.025s)
[98.638397] [035/171] (902s left) gem_mmap (basic)
[98.743877] Subtest basic: SKIP (0.000s)
[98.776895] [036/171] (902s left) gem_mmap_gtt (basic)
[98.837486] Subtest basic: SKIP (0.000s)
[98.860587] [037/171] (902s left) gem_render_linear_blits (basic)
[98.923324] Starting subtest: basic
[98.978295] Subtest basic: SUCCESS (0.052s)
[99.043426] [038/171] (902s left) gem_render_tiled_blits (basic)
[99.109446] Subtest basic: SKIP (0.000s)
[99.143289] [039/171] (902s left) gem_ringfill (basic-all)
[99.553227] Starting subtest: basic-all
[102.302212] Subtest basic-all: SUCCESS (2.740s)
[102.392005] [040/171] (899s left) gem_softpin (allocator-basic)
[102.465299] Starting subtest: allocator-basic
[102.627683] Subtest allocator-basic: SUCCESS (0.154s)
[102.735691] [041/171] (898s left) gem_softpin (allocator-basic-reserve)
[102.798360] Starting subtest: allocator-basic-reserve
[102.967212] Subtest allocator-basic-reserve: SUCCESS (0.160s)
[103.107122] [042/171] (898s left) gem_softpin (safe-alignment)
[103.200165] Starting subtest: safe-alignment
[103.251937] Subtest safe-alignment: SUCCESS (0.050s)
[103.356336] [043/171] (898s left) gem_sync (basic-all)
[103.456670] Starting subtest: basic-all
[106.761756] Subtest basic-all: SUCCESS (3.306s)
[106.970076] [044/171] (894s left) gem_sync (basic-each)
[107.083605] Starting subtest: basic-each
[109.627566] Subtest basic-each: SUCCESS (2.544s)
[109.839215] [045/171] (891s left) gem_tiled_blits (basic)
[109.921510] Subtest basic: SKIP (0.000s)
[109.945335] [046/171] (891s left) gem_tiled_fence_blits (basic)
[110.008796] Subtest basic: SKIP (0.000s)
[110.044307] [047/171] (891s left) gem_tiled_pread_basic
[110.127307] [048/171] (891s left) gem_wait (busy@all-engines)
[110.196964] Starting subtest: busy
[110.197858] Starting dynamic subtest: all-engines
[110.760847] Dynamic subtest all-engines: SUCCESS (0.564s)
[110.761773] Subtest busy: SUCCESS (0.564s)
[111.020558] [049/171] (890s left) gem_wait (wait@all-engines)
[111.094389] Starting subtest: wait
[111.095239] Starting dynamic subtest: all-engines
[112.178029] Dynamic subtest all-engines: SUCCESS (1.083s)
[112.179032] Subtest wait: SUCCESS (1.084s)
[112.450475] [050/171] (889s left) i915_getparams_basic (basic-eu-total)
[112.508147] Starting subtest: basic-eu-total
[112.509731] Subtest basic-eu-total: SUCCESS (0.000s)
[112.576180] [051/171] (889s left) i915_getparams_basic (basic-subslice-total)
[112.650673] Starting subtest: basic-subslice-total
[112.652473] Subtest basic-subslice-total: SUCCESS (0.000s)
[112.706963] [052/171] (889s left) i915_hangman (error-state-basic)
[112.783134] Starting subtest: error-state-basic
[112.960046] Subtest error-state-basic: SUCCESS (0.176s)
[113.033314] [053/171] (888s left) i915_pciid
[113.172818] [054/171] (888s left) kms_addfb_basic (addfb25-bad-modifier)
[113.235217] Starting subtest: addfb25-bad-modifier
[113.236099] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[113.354564] [055/171] (888s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[113.418425] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[113.537908] [056/171] (888s left) kms_addfb_basic (addfb25-modifier-no-flag)
[113.595966] Starting subtest: addfb25-modifier-no-flag
[113.596910] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[113.705754] [057/171] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[113.764412] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[113.871924] [058/171] (887s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[113.931511] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[114.038234] [059/171] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[114.132359] Starting subtest: addfb25-yf-tiled-legacy
[114.133215] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[114.205130] [060/171] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[114.298699] Starting subtest: addfb25-y-tiled-legacy
[114.299586] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[114.371619] [061/171] (887s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[114.465413] Starting subtest: addfb25-y-tiled-small-legacy
[114.467119] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[114.538658] [062/171] (887s left) kms_addfb_basic (bad-pitch-0)
[114.596958] Starting subtest: bad-pitch-0
[114.597772] Subtest bad-pitch-0: SUCCESS (0.000s)
[114.705233] [063/171] (887s left) kms_addfb_basic (bad-pitch-1024)
[114.764813] Starting subtest: bad-pitch-1024
[114.765702] Subtest bad-pitch-1024: SUCCESS (0.000s)
[114.871539] [064/171] (887s left) kms_addfb_basic (bad-pitch-128)
[114.929931] Starting subtest: bad-pitch-128
[114.930767] Subtest bad-pitch-128: SUCCESS (0.000s)
[115.038379] [065/171] (886s left) kms_addfb_basic (bad-pitch-256)
[115.096917] Starting subtest: bad-pitch-256
[115.097706] Subtest bad-pitch-256: SUCCESS (0.000s)
[115.205233] [066/171] (886s left) kms_addfb_basic (bad-pitch-32)
[115.263183] Starting subtest: bad-pitch-32
[115.264014] Subtest bad-pitch-32: SUCCESS (0.000s)
[115.371660] [067/171] (886s left) kms_addfb_basic (bad-pitch-63)
[115.429963] Starting subtest: bad-pitch-63
[115.430796] Subtest bad-pitch-63: SUCCESS (0.000s)
[115.538481] [068/171] (886s left) kms_addfb_basic (bad-pitch-65536)
[115.596710] Starting subtest: bad-pitch-65536
[115.597611] Subtest bad-pitch-65536: SUCCESS (0.000s)
[115.738475] [069/171] (886s left) kms_addfb_basic (bad-pitch-999)
[115.800446] Starting subtest: bad-pitch-999
[115.801266] Subtest bad-pitch-999: SUCCESS (0.000s)
[115.921638] [070/171] (886s left) kms_addfb_basic (basic)
[115.979830] Starting subtest: basic
[115.980752] Subtest basic: SUCCESS (0.000s)
[116.104691] [071/171] (885s left) kms_addfb_basic (basic-x-tiled-legacy)
[116.162856] Starting subtest: basic-x-tiled-legacy
[116.164406] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[116.271992] [072/171] (885s left) kms_addfb_basic (basic-y-tiled-legacy)
[116.331354] Starting subtest: basic-y-tiled-legacy
[116.332887] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[116.454277] [073/171] (885s left) kms_addfb_basic (bo-too-small)
[116.548047] Starting subtest: bo-too-small
[116.548866] Subtest bo-too-small: SUCCESS (0.000s)
[116.638262] [074/171] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[116.734365] Starting subtest: bo-too-small-due-to-tiling
[116.735925] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[116.805152] [075/171] (885s left) kms_addfb_basic (clobberred-modifier)
[116.862685] Starting subtest: clobberred-modifier
[116.864465] Subtest clobberred-modifier: SKIP (0.000s)
[116.972018] [076/171] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[117.031239] Starting subtest: framebuffer-vs-set-tiling
[117.032930] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[117.138586] [077/171] (884s left) kms_addfb_basic (invalid-get-prop)
[117.196772] Starting subtest: invalid-get-prop
[117.197696] Subtest invalid-get-prop: SUCCESS (0.000s)
[117.321288] [078/171] (884s left) kms_addfb_basic (invalid-get-prop-any)
[117.378691] Starting subtest: invalid-get-prop-any
[117.379482] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[117.504556] [079/171] (884s left) kms_addfb_basic (invalid-set-prop)
[117.562984] Starting subtest: invalid-set-prop
[117.563901] Subtest invalid-set-prop: SUCCESS (0.000s)
[117.672238] [080/171] (884s left) kms_addfb_basic (invalid-set-prop-any)
[117.730963] Starting subtest: invalid-set-prop-any
[117.731818] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[117.838873] [081/171] (884s left) kms_addfb_basic (no-handle)
[117.896490] Starting subtest: no-handle
[117.897371] Subtest no-handle: SUCCESS (0.000s)
[118.021076] [082/171] (884s left) kms_addfb_basic (size-max)
[118.113424] Starting subtest: size-max
[118.114268] Subtest size-max: SUCCESS (0.000s)
[118.188583] [083/171] (883s left) kms_addfb_basic (small-bo)
[118.282143] Starting subtest: small-bo
[118.282987] Subtest small-bo: SUCCESS (0.000s)
[118.371579] [084/171] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[118.430498] Starting subtest: tile-pitch-mismatch
[118.432170] Subtest tile-pitch-mismatch: SKIP (0.000s)
[118.538593] [085/171] (883s left) kms_addfb_basic (too-high)
[118.633266] Starting subtest: too-high
[118.634052] Subtest too-high: SUCCESS (0.000s)
[118.721689] [086/171] (883s left) kms_addfb_basic (too-wide)
[118.816736] Starting subtest: too-wide
[118.817560] Subtest too-wide: SUCCESS (0.000s)
[118.904823] [087/171] (883s left) kms_addfb_basic (unused-handle)
[118.963060] Starting subtest: unused-handle
[118.963929] Subtest unused-handle: SUCCESS (0.000s)
[119.072274] [088/171] (883s left) kms_addfb_basic (unused-modifier)
[119.129882] Starting subtest: unused-modifier
[119.130614] Subtest unused-modifier: SUCCESS (0.000s)
[119.238633] [089/171] (882s left) kms_addfb_basic (unused-offsets)
[119.296133] Starting subtest: unused-offsets
[119.297019] Subtest unused-offsets: SUCCESS (0.000s)
[119.405285] [090/171] (882s left) kms_addfb_basic (unused-pitches)
[119.464066] Starting subtest: unused-pitches
[119.464889] Subtest unused-pitches: SUCCESS (0.000s)
[119.571982] [091/171] (882s left) kms_busy (basic)
[119.671240] Starting subtest: basic
[119.672042] Starting dynamic subtest: flip
[120.345131] Dynamic subtest flip: SUCCESS (0.674s)
[120.351232] Starting dynamic subtest: modeset
[121.215499] Dynamic subtest modeset: SUCCESS (0.870s)
[121.216422] Subtest basic: SUCCESS (1.546s)
[121.419754] [092/171] (880s left) kms_chamelium_hpd (dp-hpd-fast)
[121.593205] Subtest dp-hpd-fast: SKIP (0.000s)
[121.722217] [093/171] (880s left) kms_chamelium_edid (dp-edid-read)
[121.886610] Subtest dp-edid-read: SKIP (0.000s)
[122.016977] [094/171] (880s left) kms_chamelium_frames (dp-crc-fast)
[122.181213] Subtest dp-crc-fast: SKIP (0.000s)
[122.311801] [095/171] (879s left) kms_chamelium_hpd (hdmi-hpd-fast)
[122.476420] Subtest hdmi-hpd-fast: SKIP (0.000s)
[122.605284] [096/171] (879s left) kms_chamelium_edid (hdmi-edid-read)
[122.770931] Subtest hdmi-edid-read: SKIP (0.000s)
[122.899141] [097/171] (879s left) kms_chamelium_frames (hdmi-crc-fast)
[123.064667] Subtest hdmi-crc-fast: SKIP (0.000s)
[123.194221] [098/171] (879s left) kms_chamelium_hpd (vga-hpd-fast)
[123.359326] Subtest vga-hpd-fast: SKIP (0.000s)
[123.487560] [099/171] (878s left) kms_chamelium_edid (vga-edid-read)
[123.652970] Subtest vga-edid-read: SKIP (0.000s)
[123.782259] [100/171] (878s left) kms_prop_blob (basic)
[123.841211] Starting subtest: basic
[123.842145] Subtest basic: SUCCESS (0.000s)
[123.907424] [101/171] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[124.003581] Starting subtest: basic-busy-flip-before-cursor-atomic
[124.005324] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[124.057504] [102/171] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[124.151930] Starting subtest: basic-busy-flip-before-cursor-legacy
[124.153592] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[124.207670] [103/171] (878s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[124.300895] Starting subtest: basic-flip-after-cursor-atomic
[125.313921] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.013s)
[125.509405] [104/171] (876s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[125.605179] Starting subtest: basic-flip-after-cursor-legacy
[126.635361] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.026s)
[126.832259] [105/171] (875s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[126.925712] Starting subtest: basic-flip-after-cursor-varying-size
[127.973159] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.047s)
[128.183081] [106/171] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[128.276933] Starting subtest: basic-flip-before-cursor-atomic
[129.288907] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.011s)
[129.497428] [107/171] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[129.596200] Starting subtest: basic-flip-before-cursor-legacy
[130.636203] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.040s)
[130.834526] [108/171] (871s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[130.927874] Starting subtest: basic-flip-before-cursor-varying-size
[131.958035] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.030s)
[132.160504] [109/171] (870s left) kms_flip (basic-flip-vs-dpms)
[132.249280] Starting subtest: basic-flip-vs-dpms
[132.252021] Starting dynamic subtest: A-DP1
[133.273258] Dynamic subtest A-DP1: SUCCESS (1.020s)
[133.279736] Starting dynamic subtest: B-DP1
[134.184082] Dynamic subtest B-DP1: SUCCESS (0.911s)
[134.190478] Starting dynamic subtest: C-DP1
[135.060127] Dynamic subtest C-DP1: SUCCESS (0.875s)
[135.066573] Starting dynamic subtest: D-DP1
[135.936904] Dynamic subtest D-DP1: SUCCESS (0.876s)
[135.939188] Subtest basic-flip-vs-dpms: SUCCESS (3.691s)
[136.158281] [110/171] (866s left) kms_flip (basic-flip-vs-modeset)
[136.244225] Starting subtest: basic-flip-vs-modeset
[136.246464] Starting dynamic subtest: A-DP1
[137.131039] Dynamic subtest A-DP1: SUCCESS (0.884s)
[137.137427] Starting dynamic subtest: B-DP1
[138.008922] Dynamic subtest B-DP1: SUCCESS (0.878s)
[138.015317] Starting dynamic subtest: C-DP1
[138.887515] Dynamic subtest C-DP1: SUCCESS (0.877s)
[138.894400] Starting dynamic subtest: D-DP1
[139.762785] Dynamic subtest D-DP1: SUCCESS (0.875s)
[139.765347] Subtest basic-flip-vs-modeset: SUCCESS (3.523s)
[139.971146] [111/171] (862s left) kms_flip (basic-flip-vs-wf_vblank)
[140.056950] Starting subtest: basic-flip-vs-wf_vblank
[140.059283] Starting dynamic subtest: A-DP1
[141.222537] Dynamic subtest A-DP1: SUCCESS (1.163s)
[141.230111] Starting dynamic subtest: B-DP1
[142.313686] Dynamic subtest B-DP1: SUCCESS (1.090s)
[142.320161] Starting dynamic subtest: C-DP1
[143.430279] Dynamic subtest C-DP1: SUCCESS (1.116s)
[143.436902] Starting dynamic subtest: D-DP1
[144.532333] Dynamic subtest D-DP1: SUCCESS (1.101s)
[144.535482] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.480s)
[144.810498] [112/171] (857s left) kms_flip (basic-plain-flip)
[144.895095] Starting subtest: basic-plain-flip
[144.896908] Starting dynamic subtest: A-DP1
[145.778180] Dynamic subtest A-DP1: SUCCESS (0.881s)
[145.785959] Starting dynamic subtest: B-DP1
[146.575373] Dynamic subtest B-DP1: SUCCESS (0.796s)
[146.581745] Starting dynamic subtest: C-DP1
[147.377309] Dynamic subtest C-DP1: SUCCESS (0.801s)
[147.383816] Starting dynamic subtest: D-DP1
[148.178239] Dynamic subtest D-DP1: SUCCESS (0.800s)
[148.181542] Subtest basic-plain-flip: SUCCESS (3.288s)
[148.459839] [113/171] (854s left) kms_force_connector_basic (force-connector-state)
[148.522180] Starting subtest: force-connector-state
[149.050658] Subtest force-connector-state: SUCCESS (0.528s)
[149.346886] [114/171] (853s left) kms_force_connector_basic (force-edid)
[149.407154] Starting subtest: force-edid
[149.422364] Subtest force-edid: SUCCESS (0.015s)
[149.579932] [115/171] (852s left) kms_force_connector_basic (force-load-detect)
[149.640138] Starting subtest: force-load-detect
[149.641624] Subtest force-load-detect: SKIP (0.000s)
[149.746771] [116/171] (852s left) kms_force_connector_basic (prune-stale-modes)
[149.807494] Starting subtest: prune-stale-modes
[149.817185] Subtest prune-stale-modes: SKIP (0.008s)
[149.980030] [117/171] (852s left) kms_frontbuffer_tracking (basic)
[150.120128] Starting subtest: basic
[153.445682] Subtest basic: SUCCESS (3.326s)
[153.564229] [118/171] (849s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[153.660015] Starting subtest: compare-crc-sanitycheck-xr24
[153.660784] Starting dynamic subtest: pipe-A-DP-1
[154.184281] Dynamic subtest pipe-A-DP-1: SUCCESS (0.524s)
[154.191971] Starting dynamic subtest: pipe-B-DP-1
[154.722365] Dynamic subtest pipe-B-DP-1: SUCCESS (0.536s)
[154.730271] Starting dynamic subtest: pipe-C-DP-1
[155.325500] Dynamic subtest pipe-C-DP-1: SUCCESS (0.601s)
[155.333592] Starting dynamic subtest: pipe-D-DP-1
[155.990397] Dynamic subtest pipe-D-DP-1: SUCCESS (0.663s)
[155.991225] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.331s)
[156.181310] [119/171] (846s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[156.275591] Starting subtest: compare-crc-sanitycheck-nv12
[156.276464] Starting dynamic subtest: pipe-A-DP-1
[157.485305] Dynamic subtest pipe-A-DP-1: SUCCESS (1.209s)
[157.493046] Starting dynamic subtest: pipe-B-DP-1
[158.695422] Dynamic subtest pipe-B-DP-1: SUCCESS (1.208s)
[158.701711] Starting dynamic subtest: pipe-C-DP-1
[159.941551] Dynamic subtest pipe-C-DP-1: SUCCESS (1.245s)
[159.948175] Starting dynamic subtest: pipe-D-DP-1
[161.153808] Dynamic subtest pipe-D-DP-1: SUCCESS (1.210s)
[161.155036] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.878s)
[161.357858] [120/171] (841s left) kms_pipe_crc_basic (hang-read-crc)
[161.452978] Starting subtest: hang-read-crc
[161.453819] Starting dynamic subtest: pipe-A-DP-1
[162.875403] Dynamic subtest pipe-A-DP-1: SUCCESS (1.422s)
[162.881705] Starting dynamic subtest: pipe-B-DP-1
[164.449210] Dynamic subtest pipe-B-DP-1: SUCCESS (1.573s)
[164.457209] Starting dynamic subtest: pipe-C-DP-1
[166.076040] Dynamic subtest pipe-C-DP-1: SUCCESS (1.625s)
[166.083530] Starting dynamic subtest: pipe-D-DP-1
[167.809108] Dynamic subtest pipe-D-DP-1: SUCCESS (1.731s)
[167.809963] Subtest hang-read-crc: SUCCESS (6.358s)
[168.004926] [121/171] (834s left) kms_pipe_crc_basic (nonblocking-crc)
[168.103721] Starting subtest: nonblocking-crc
[168.104675] Starting dynamic subtest: pipe-A-DP-1
[168.809123] Dynamic subtest pipe-A-DP-1: SUCCESS (0.706s)
[168.816854] Starting dynamic subtest: pipe-B-DP-1
[169.514016] Dynamic subtest pipe-B-DP-1: SUCCESS (0.703s)
[169.521930] Starting dynamic subtest: pipe-C-DP-1
[170.283348] Dynamic subtest pipe-C-DP-1: SUCCESS (0.767s)
[170.289792] Starting dynamic subtest: pipe-D-DP-1
[171.092184] Dynamic subtest pipe-D-DP-1: SUCCESS (0.808s)
[171.093036] Subtest nonblocking-crc: SUCCESS (2.989s)
[171.275233] [122/171] (831s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[171.377905] Starting subtest: nonblocking-crc-frame-sequence
[171.378815] Starting dynamic subtest: pipe-A-DP-1
[172.063122] Dynamic subtest pipe-A-DP-1: SUCCESS (0.684s)
[172.071639] Starting dynamic subtest: pipe-B-DP-1
[172.783252] Dynamic subtest pipe-B-DP-1: SUCCESS (0.718s)
[172.789905] Starting dynamic subtest: pipe-C-DP-1
[173.550459] Dynamic subtest pipe-C-DP-1: SUCCESS (0.766s)
[173.557049] Starting dynamic subtest: pipe-D-DP-1
[174.403375] Dynamic subtest pipe-D-DP-1: SUCCESS (0.851s)
[174.404248] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.026s)
[174.593823] [123/171] (828s left) kms_pipe_crc_basic (read-crc)
[174.694530] Starting subtest: read-crc
[174.695362] Starting dynamic subtest: pipe-A-DP-1
[175.283217] Dynamic subtest pipe-A-DP-1: SUCCESS (0.588s)
[175.289667] Starting dynamic subtest: pipe-B-DP-1
[175.920396] Dynamic subtest pipe-B-DP-1: SUCCESS (0.636s)
[175.927124] Starting dynamic subtest: pipe-C-DP-1
[176.599967] Dynamic subtest pipe-C-DP-1: SUCCESS (0.678s)
[176.606318] Starting dynamic subtest: pipe-D-DP-1
[177.379537] Dynamic subtest pipe-D-DP-1: SUCCESS (0.777s)
[177.380438] Subtest read-crc: SUCCESS (2.685s)
[177.572418] [124/171] (825s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[177.666934] Starting subtest: read-crc-frame-sequence
[177.667858] Starting dynamic subtest: pipe-A-DP-1
[178.262476] Dynamic subtest pipe-A-DP-1: SUCCESS (0.595s)
[178.269146] Starting dynamic subtest: pipe-B-DP-1
[178.902398] Dynamic subtest pipe-B-DP-1: SUCCESS (0.638s)
[178.908859] Starting dynamic subtest: pipe-C-DP-1
[179.600048] Dynamic subtest pipe-C-DP-1: SUCCESS (0.696s)
[179.606533] Starting dynamic subtest: pipe-D-DP-1
[180.363635] Dynamic subtest pipe-D-DP-1: SUCCESS (0.762s)
[180.364590] Subtest read-crc-frame-sequence: SUCCESS (2.698s)
[180.555048] [125/171] (822s left) kms_psr (primary_page_flip)
[180.618488] Subtest primary_page_flip: SKIP (0.000s)
[180.644293] [126/171] (822s left) kms_psr (cursor_plane_move)
[180.710353] Subtest cursor_plane_move: SKIP (0.000s)
[180.743615] [127/171] (821s left) kms_psr (sprite_plane_onoff)
[180.805277] Subtest sprite_plane_onoff: SKIP (0.000s)
[180.827816] [128/171] (821s left) kms_psr (primary_mmap_gtt)
[180.887101] Subtest primary_mmap_gtt: SKIP (0.000s)
[180.910179] [129/171] (821s left) kms_setmode (basic-clone-single-crtc)
[180.969484] Starting subtest: basic-clone-single-crtc
[180.971850] Subtest basic-clone-single-crtc: SKIP (0.000s)
[181.044306] [130/171] (821s left) i915_pm_backlight (basic-brightness)
[181.140534] Subtest basic-brightness: SKIP (0.000s)
[181.161323] [131/171] (821s left) i915_pm_rpm (basic-pci-d3-state)
[182.548921] Starting subtest: basic-pci-d3-state
[184.281059] Subtest basic-pci-d3-state: SUCCESS (1.732s)
[184.439381] [132/171] (818s left) i915_pm_rpm (basic-rte)
[184.520301] Starting subtest: basic-rte
[187.856374] Subtest basic-rte: SUCCESS (3.336s)
[188.866724] [133/171] (813s left) i915_pm_rps (basic-api)
[188.929643] Starting subtest: basic-api
[188.931231] Subtest basic-api: SKIP (0.000s)
[189.004966] [134/171] (813s left) prime_self_import (basic-llseek-bad)
[189.072265] Starting subtest: basic-llseek-bad
[189.073975] Subtest basic-llseek-bad: SUCCESS (0.002s)
[189.155968] [135/171] (813s left) prime_self_import (basic-llseek-size)
[189.217115] Starting subtest: basic-llseek-size
[189.220266] Subtest basic-llseek-size: SUCCESS (0.003s)
[189.310397] [136/171] (813s left) prime_self_import (basic-with_fd_dup)
[189.372126] Starting subtest: basic-with_fd_dup
[189.375239] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[189.484098] [137/171] (813s left) prime_self_import (basic-with_one_bo)
[189.548166] Starting subtest: basic-with_one_bo
[189.551295] Subtest basic-with_one_bo: SUCCESS (0.003s)
[189.604293] [138/171] (813s left) prime_self_import (basic-with_one_bo_two_files)
[189.665643] Starting subtest: basic-with_one_bo_two_files
[189.668782] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[189.771553] [139/171] (813s left) prime_self_import (basic-with_two_bos)
[189.829208] Starting subtest: basic-with_two_bos
[189.832217] Subtest basic-with_two_bos: SUCCESS (0.003s)
[189.933648] [140/171] (813s left) prime_vgem (basic-fence-flip)
[190.035337] Starting subtest: basic-fence-flip
[190.102048] Subtest basic-fence-flip: SKIP (0.066s)
[190.198433] [141/171] (812s left) prime_vgem (basic-fence-mmap)
[190.298676] Starting subtest: basic-fence-mmap
[190.300251] Subtest basic-fence-mmap: SKIP (0.000s)
[190.433950] [142/171] (812s left) prime_vgem (basic-fence-read)
[190.528668] Starting subtest: basic-fence-read
[190.533521] Subtest basic-fence-read: SKIP (0.004s)
[190.632530] [143/171] (812s left) prime_vgem (basic-gtt)
[190.771286] Starting subtest: basic-gtt
[190.773424] Subtest basic-gtt: SKIP (0.000s)
[190.898945] [144/171] (812s left) prime_vgem (basic-read)
[191.002015] Starting subtest: basic-read
[191.006583] Subtest basic-read: SKIP (0.004s)
[191.125108] [145/171] (811s left) prime_vgem (basic-write)
[191.202087] Starting subtest: basic-write
[191.206931] Subtest basic-write: SKIP (0.004s)
[191.317521] [146/171] (811s left) vgem_basic (setversion)
[191.413153] Starting subtest: setversion
[191.415517] Subtest setversion: SUCCESS (0.000s)
[191.466752] [147/171] (811s left) vgem_basic (create)
[191.529717] Starting subtest: create
[191.530869] Subtest create: SUCCESS (0.000s)
[191.582542] [148/171] (811s left) vgem_basic (debugfs)
[191.646039] Starting subtest: debugfs
[191.646853] Subtest debugfs: SUCCESS (0.000s)
[191.699569] [149/171] (811s left) vgem_basic (dmabuf-export)
[191.779574] Starting subtest: dmabuf-export
[191.794239] Subtest dmabuf-export: SUCCESS (0.014s)
[191.917406] [150/171] (811s left) vgem_basic (dmabuf-fence)
[192.013020] Starting subtest: dmabuf-fence
[192.014241] Subtest dmabuf-fence: SUCCESS (0.000s)
[192.067215] [151/171] (811s left) vgem_basic (dmabuf-fence-before)
[192.129570] Starting subtest: dmabuf-fence-before
[192.130420] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[192.181791] [152/171] (811s left) vgem_basic (dmabuf-mmap)
[192.246240] Starting subtest: dmabuf-mmap
[192.254783] Subtest dmabuf-mmap: SUCCESS (0.009s)
[192.298387] [153/171] (810s left) vgem_basic (mmap)
[192.362886] Starting subtest: mmap
[192.367822] Subtest mmap: SUCCESS (0.005s)
[192.417874] [154/171] (810s left) vgem_basic (second-client)
[192.496449] Starting subtest: second-client
[192.530203] Subtest second-client: SUCCESS (0.033s)
[192.617060] [155/171] (810s left) vgem_basic (sysfs)
[192.713075] Starting subtest: sysfs
[192.714059] Subtest sysfs: SUCCESS (0.000s)
[192.765484] [156/171] (810s left) core_hotunplug (unbind-rebind)
[192.862596] Starting subtest: unbind-rebind
[195.033391] Subtest unbind-rebind: SUCCESS (2.171s)
[195.048813] [157/171] (808s left) vgem_basic (unload)
[195.113424] Starting subtest: unload
[224.057291] Subtest unload: SUCCESS (28.934s)
[224.158923] [158/171] (779s left) i915_module_load (reload)
[224.220186] Starting subtest: reload
[227.121764] Subtest reload: SUCCESS (2.902s)
[227.136679] [159/171] (776s left) gem_lmem_swapping (basic)
[230.179542] Starting subtest: basic
[230.180288] Starting dynamic subtest: lmem0
[247.621493] Dynamic subtest lmem0: SUCCESS (17.407s)
[247.622352] Subtest basic: SUCCESS (17.408s)
[249.318966] [160/171] (754s left) gem_lmem_swapping (parallel-random-engines)
[249.989792] Starting subtest: parallel-random-engines
[249.993044] Starting dynamic subtest: lmem0
[250.784048] Dynamic subtest lmem0: SUCCESS (0.794s)
[250.784819] Subtest parallel-random-engines: SUCCESS (0.795s)
[252.116410] [161/171] (751s left) gem_lmem_swapping (random-engines)
[252.812620] Starting subtest: random-engines
[252.813644] Starting dynamic subtest: lmem0
[253.555352] Dynamic subtest lmem0: SUCCESS (0.738s)
[253.556297] Subtest random-engines: SUCCESS (0.739s)
[254.956442] [162/171] (748s left) gem_lmem_swapping (verify-random)
[255.678979] Starting subtest: verify-random
[255.679730] Starting dynamic subtest: lmem0
[263.187363] Dynamic subtest lmem0: SUCCESS (7.473s)
[263.188226] Subtest verify-random: SUCCESS (7.474s)
[264.582373] [163/171] (738s left) i915_pm_rpm (module-reload)
[267.867598] Starting subtest: module-reload
[280.258504] Subtest module-reload: SUCCESS (12.382s)
[280.304587] [164/171] (723s left) i915_selftest (live)
[280.388178] Starting subtest: live
[280.389038] Starting dynamic subtest: sanitycheck
[281.745467] Dynamic subtest sanitycheck: SUCCESS (1.348s)
[281.752046] Starting dynamic subtest: uncore
[283.112137] Dynamic subtest uncore: SUCCESS (1.366s)
[283.117942] Starting dynamic subtest: workarounds
[287.465328] Dynamic subtest workarounds: SUCCESS (4.352s)
[287.470795] Starting dynamic subtest: gt_engines
[289.890255] Dynamic subtest gt_engines: SUCCESS (2.424s)
[289.895700] Starting dynamic subtest: gt_timelines
[317.542251] Dynamic subtest gt_timelines: SUCCESS (27.651s)
[317.547330] Starting dynamic subtest: gt_contexts
[318.958308] Dynamic subtest gt_contexts: SUCCESS (1.414s)
[318.966692] Starting dynamic subtest: gt_lrc
[326.809664] Dynamic subtest gt_lrc: SUCCESS (7.859s)
[326.816088] Starting dynamic subtest: gt_mocs
[330.377485] Dynamic subtest gt_mocs: SUCCESS (3.559s)
[330.383970] Starting dynamic subtest: gt_pm
[332.626233] Dynamic subtest gt_pm: SUCCESS (2.248s)
[332.631201] Starting dynamic subtest: gt_heartbeat
[334.206395] Dynamic subtest gt_heartbeat: SUCCESS (1.579s)
[334.211344] Starting dynamic subtest: gt_tlb
[346.218404] Dynamic subtest gt_tlb: SUCCESS (12.011s)
[346.224343] Starting dynamic subtest: requests
[363.685302] Dynamic subtest requests: SUCCESS (17.466s)
[363.690821] Starting dynamic subtest: migrate
[368.183541] Dynamic subtest migrate: SUCCESS (4.497s)
[368.188738] Starting dynamic subtest: active
[369.539125] Dynamic subtest active: SUCCESS (1.355s)
[369.544309] Starting dynamic subtest: objects
[371.767180] Dynamic subtest objects: SUCCESS (2.227s)
[371.772219] Starting dynamic subtest: mman
[380.489248] Dynamic subtest mman: SUCCESS (8.721s)
[380.494289] Starting dynamic subtest: dmabuf
[381.888962] Dynamic subtest dmabuf: SUCCESS (1.399s)
[381.894147] Starting dynamic subtest: vma
[383.271937] Dynamic subtest vma: SUCCESS (1.382s)
[383.277109] Starting dynamic subtest: coherency
[386.591973] Dynamic subtest coherency: SUCCESS (3.319s)
[386.597050] Starting dynamic subtest: gtt
[395.366295] Dynamic subtest gtt: SUCCESS (8.773s)
[395.372286] Starting dynamic subtest: gem
[396.801420] Dynamic subtest gem: SUCCESS (1.434s)
[396.807492] Starting dynamic subtest: evict
[400.164233] Dynamic subtest evict: SUCCESS (3.362s)
[400.170166] Starting dynamic subtest: hugepages
[418.398310] Dynamic subtest hugepages: SUCCESS (18.233s)
[418.404268] Starting dynamic subtest: gem_contexts
[458.298192] Dynamic subtest gem_contexts: SUCCESS (39.873s)
[458.303781] Starting dynamic subtest: client
[459.709267] Dynamic subtest client: SUCCESS (1.436s)
[459.715371] Starting dynamic subtest: gem_migrate
[464.397491] Dynamic subtest gem_migrate: SUCCESS (4.687s)
[464.403158] Starting dynamic subtest: reset
[465.868503] Dynamic subtest reset: SUCCESS (1.470s)
[465.874516] Starting dynamic subtest: memory_region
[468.755447] Dynamic subtest memory_region: SUCCESS (2.886s)
[468.761444] Starting dynamic subtest: hangcheck
[515.512303] Dynamic subtest hangcheck: SUCCESS (46.756s)
[515.517305] Starting dynamic subtest: execlists
[516.918352] Dynamic subtest execlists: SUCCESS (1.405s)
[516.923441] Starting dynamic subtest: ring_submission
[518.305346] Dynamic subtest ring_submission: SUCCESS (1.386s)
[518.310483] Starting dynamic subtest: perf
[519.808242] Dynamic subtest perf: SUCCESS (1.502s)
[519.813288] Starting dynamic subtest: slpc
[528.886412] Dynamic subtest slpc: SUCCESS (9.077s)
[528.891430] Starting dynamic subtest: guc
[531.496183] Dynamic subtest guc: SUCCESS (2.609s)
[531.501324] Starting dynamic subtest: guc_multi_lrc
[532.892253] Dynamic subtest guc_multi_lrc: SUCCESS (1.395s)
[532.897473] Starting dynamic subtest: guc_hang
[534.965230] Dynamic subtest guc_hang: SUCCESS (2.072s)
[534.970673] Starting dynamic subtest: late_gt_pm
[536.425363] Dynamic subtest late_gt_pm: SUCCESS (1.459s)
[536.426458] Subtest live: SUCCESS (256.029s)
[536.859235] [165/171] (466s left) dmabuf (all-tests)
[536.942220] Starting subtest: all-tests
[536.943550] Starting dynamic subtest: sanitycheck
[537.015631] Dynamic subtest sanitycheck: SUCCESS (0.073s)
[537.023896] Starting dynamic subtest: dma_fence
[537.184426] Dynamic subtest dma_fence: SUCCESS (0.168s)
[537.193973] Starting dynamic subtest: dma_fence_chain
[547.581673] Dynamic subtest dma_fence_chain: SUCCESS (10.396s)
[547.588972] Starting dynamic subtest: dma_fence_unwrap
[547.657105] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[547.666738] Starting dynamic subtest: dma_resv
[547.730311] Dynamic subtest dma_resv: SUCCESS (0.071s)
[547.732057] Subtest all-tests: SUCCESS (10.789s)
[547.775947] [166/171] (455s left) i915_suspend (basic-s2idle-without-i915)
[547.862393] Starting subtest: basic-s2idle-without-i915
[567.553091] Subtest basic-s2idle-without-i915: SUCCESS (4.703s)
[567.739999] [167/171] (450s left) i915_suspend (basic-s3-without-i915)
[567.801208] Starting subtest: basic-s3-without-i915
[589.232107] Subtest basic-s3-without-i915: SUCCESS (5.629s)
[589.408873] [168/171] (444s left) gem_exec_suspend (basic-s0)
[589.485818] Starting subtest: basic-S0
[589.486661] Starting dynamic subtest: smem
[609.116864] Dynamic subtest smem: SUCCESS (4.520s)
[609.128673] Starting dynamic subtest: lmem0
[628.128825] Dynamic subtest lmem0: SUCCESS (4.453s)
[628.130010] Subtest basic-S0: SUCCESS (8.976s)
[628.313723] [169/171] (435s left) gem_exec_suspend (basic-s3)
[628.381520] Starting subtest: basic-S3
[628.382325] Starting dynamic subtest: smem
[648.439680] Dynamic subtest smem: SUCCESS (4.990s)
[648.447380] Starting dynamic subtest: lmem0
[669.462383] Dynamic subtest lmem0: SUCCESS (4.775s)
[669.463752] Subtest basic-S3: SUCCESS (9.768s)
[669.621800] [170/171] (425s left) kms_chamelium_hpd (common-hpd-after-suspend)
[669.856556] Subtest common-hpd-after-suspend: SKIP (0.000s)
[669.969183] [171/171] (425s left) kms_pipe_crc_basic (suspend-read-crc)
[670.062981] Starting subtest: suspend-read-crc
[670.063969] Starting dynamic subtest: pipe-A-DP-1
[689.145874] Dynamic subtest pipe-A-DP-1: SUCCESS (3.109s)
[689.154329] Starting dynamic subtest: pipe-B-DP-1
[708.148276] Dynamic subtest pipe-B-DP-1: SUCCESS (3.083s)
[708.157173] Starting dynamic subtest: pipe-C-DP-1
[727.218897] Dynamic subtest pipe-C-DP-1: SUCCESS (3.258s)
[727.227892] Starting dynamic subtest: pipe-D-DP-1
[746.309275] Dynamic subtest pipe-D-DP-1: SUCCESS (3.391s)
[746.310166] Subtest suspend-read-crc: SUCCESS (12.848s)
[746.458632] Closing watchdogs
Done.