[42.937557] Initializing watchdogs
[42.937653]   /dev/watchdog0
[42.944802] [001/171] (960s left) i915_module_load (load)
[43.028619] Starting subtest: load
[44.388645] Subtest load: SUCCESS (1.360s)
[44.407512] [002/171] (959s left) core_auth (basic-auth)
[44.553116] Starting subtest: basic-auth
[44.554151] Subtest basic-auth: SUCCESS (0.001s)
[44.625242] [003/171] (958s left) debugfs_test (read_all_entries)
[44.728166] Starting subtest: read_all_entries
[45.256497] Subtest read_all_entries: SUCCESS (0.528s)
[45.375612] [004/171] (958s left) debugfs_test (basic-hwmon)
[45.476129] Starting subtest: basic-hwmon
[45.481525] Subtest basic-hwmon: SUCCESS (0.005s)
[45.627105] [005/171] (957s left) fbdev (eof)
[45.722080] Starting subtest: eof
[45.723161] Subtest eof: SUCCESS (0.000s)
[45.775664] [006/171] (957s left) fbdev (info)
[45.853200] Starting subtest: info
[45.854217] Subtest info: SUCCESS (0.000s)
[45.910477] [007/171] (957s left) fbdev (nullptr)
[45.988320] Starting subtest: nullptr
[45.989359] Subtest nullptr: SUCCESS (0.000s)
[46.044174] [008/171] (957s left) fbdev (read)
[46.138535] Starting subtest: read
[58.492631] Subtest read: SUCCESS (12.319s)
[58.511526] [009/171] (945s left) fbdev (write)
[58.588397] Starting subtest: write
[64.724541] Subtest write: SUCCESS (6.128s)
[64.776601] [010/171] (938s left) gem_basic (bad-close)
[64.865881] Starting subtest: bad-close
[64.867700] Subtest bad-close: SUCCESS (0.000s)
[64.924843] [011/171] (938s left) gem_basic (create-close)
[65.014905] Starting subtest: create-close
[65.016957] Subtest create-close: SUCCESS (0.000s)
[65.101719] [012/171] (938s left) gem_basic (create-fd-close)
[65.213358] Starting subtest: create-fd-close
[65.215415] Subtest create-fd-close: SUCCESS (0.000s)
[65.301567] [013/171] (938s left) gem_busy (busy@all-engines)
[65.424273] Starting subtest: busy
[65.425259] Starting dynamic subtest: all-engines
[65.553226] Dynamic subtest all-engines: SUCCESS (0.129s)
[65.554254] Subtest busy: SUCCESS (0.129s)
[66.004230] [014/171] (937s left) gem_close_race (basic-process)
[66.138349] Starting subtest: basic-process
[66.190441] Subtest basic-process: SUCCESS (0.052s)
[66.427189] [015/171] (937s left) gem_close_race (basic-threads)
[66.556264] Starting subtest: basic-threads
[67.769441] Subtest basic-threads: SUCCESS (1.213s)
[68.041745] [016/171] (935s left) gem_ctx_create (basic)
[68.163415] Starting subtest: basic
[68.164597] Subtest basic: SUCCESS (0.000s)
[68.378050] [017/171] (935s left) gem_ctx_create (basic-files)
[68.480071] Starting subtest: basic-files
[70.498294] Subtest basic-files: SUCCESS (2.018s)
[71.093568] [018/171] (932s left) gem_ctx_exec (basic)
[71.186739] Starting subtest: basic
[71.195397] Subtest basic: SUCCESS (0.009s)
[71.299306] [019/171] (932s left) gem_exec_basic (basic)
[71.400054] Starting subtest: basic
[71.401164] Starting dynamic subtest: rcs0-smem
[71.403219] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[71.409241] Starting dynamic subtest: bcs0-smem
[71.410210] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[71.416621] Starting dynamic subtest: vcs0-smem
[71.417562] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[71.423158] Starting dynamic subtest: vcs1-smem
[71.424010] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[71.429551] Starting dynamic subtest: vecs0-smem
[71.430543] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[71.436168] Starting dynamic subtest: vecs1-smem
[71.437326] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[71.442890] Starting dynamic subtest: ccs0-smem
[71.443894] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[71.449447] Starting dynamic subtest: ccs1-smem
[71.450461] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[71.456121] Starting dynamic subtest: ccs2-smem
[71.457234] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[71.462871] Starting dynamic subtest: ccs3-smem
[71.464035] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[71.469695] Starting dynamic subtest: rcs0-lmem0
[71.470827] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[71.476491] Starting dynamic subtest: bcs0-lmem0
[71.477602] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[71.483319] Starting dynamic subtest: vcs0-lmem0
[71.484463] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[71.490096] Starting dynamic subtest: vcs1-lmem0
[71.491174] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[71.496828] Starting dynamic subtest: vecs0-lmem0
[71.497967] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[71.503598] Starting dynamic subtest: vecs1-lmem0
[71.504739] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[71.510409] Starting dynamic subtest: ccs0-lmem0
[71.511510] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[71.517021] Starting dynamic subtest: ccs1-lmem0
[71.518031] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[71.523733] Starting dynamic subtest: ccs2-lmem0
[71.524732] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[71.530469] Starting dynamic subtest: ccs3-lmem0
[71.531545] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[71.532692] Subtest basic: SUCCESS (0.015s)
[71.595809] [020/171] (932s left) gem_exec_create (basic)
[71.711746] Starting subtest: basic
[71.712838] Starting dynamic subtest: smem
[73.829670] Dynamic subtest smem: SUCCESS (2.118s)
[73.835920] Starting dynamic subtest: lmem0
[75.935737] Dynamic subtest lmem0: SUCCESS (2.106s)
[75.936867] Subtest basic: SUCCESS (4.224s)
[76.133293] [021/171] (927s left) gem_exec_fence (basic-busy)
[76.363911] Starting subtest: basic-busy
[76.365019] Starting dynamic subtest: rcs0
[76.463976] Dynamic subtest rcs0: SUCCESS (0.107s)
[76.490394] Starting dynamic subtest: bcs0
[76.518470] Dynamic subtest bcs0: SUCCESS (0.054s)
[76.542605] Starting dynamic subtest: vcs0
[76.576185] Dynamic subtest vcs0: SUCCESS (0.057s)
[76.601057] Starting dynamic subtest: vcs1
[76.633075] Dynamic subtest vcs1: SUCCESS (0.056s)
[76.658265] Starting dynamic subtest: vecs0
[76.691394] Dynamic subtest vecs0: SUCCESS (0.058s)
[76.716068] Starting dynamic subtest: vecs1
[76.758395] Dynamic subtest vecs1: SUCCESS (0.066s)
[76.783603] Starting dynamic subtest: ccs0
[76.820295] Dynamic subtest ccs0: SUCCESS (0.061s)
[76.845405] Starting dynamic subtest: ccs1
[76.884260] Dynamic subtest ccs1: SUCCESS (0.063s)
[76.909456] Starting dynamic subtest: ccs2
[76.942425] Dynamic subtest ccs2: SUCCESS (0.057s)
[76.966759] Starting dynamic subtest: ccs3
[77.003333] Dynamic subtest ccs3: SUCCESS (0.060s)
[77.005692] Subtest basic-busy: SUCCESS (0.647s)
[77.663289] [022/171] (926s left) gem_exec_fence (basic-wait)
[77.896212] Starting subtest: basic-wait
[77.897345] Starting dynamic subtest: rcs0
[78.003591] Dynamic subtest rcs0: SUCCESS (0.115s)
[78.012476] Starting dynamic subtest: bcs0
[78.051751] Dynamic subtest bcs0: SUCCESS (0.048s)
[78.063148] Starting dynamic subtest: vcs0
[78.104346] Dynamic subtest vcs0: SUCCESS (0.051s)
[78.131131] Starting dynamic subtest: vcs1
[78.160359] Dynamic subtest vcs1: SUCCESS (0.056s)
[78.173687] Starting dynamic subtest: vecs0
[78.212363] Dynamic subtest vecs0: SUCCESS (0.051s)
[78.238747] Starting dynamic subtest: vecs1
[78.277551] Dynamic subtest vecs1: SUCCESS (0.064s)
[78.287444] Starting dynamic subtest: ccs0
[78.334585] Dynamic subtest ccs0: SUCCESS (0.057s)
[78.359767] Starting dynamic subtest: ccs1
[78.390441] Dynamic subtest ccs1: SUCCESS (0.055s)
[78.416182] Starting dynamic subtest: ccs2
[78.449212] Dynamic subtest ccs2: SUCCESS (0.058s)
[78.475260] Starting dynamic subtest: ccs3
[78.511624] Dynamic subtest ccs3: SUCCESS (0.061s)
[78.514192] Subtest basic-wait: SUCCESS (0.623s)
[79.164758] [023/171] (924s left) gem_exec_fence (basic-await)
[79.442509] Starting subtest: basic-await
[79.443889] Starting dynamic subtest: rcs0
[79.582680] Dynamic subtest rcs0: SUCCESS (0.149s)
[79.588600] Starting dynamic subtest: bcs0
[79.694032] Dynamic subtest bcs0: SUCCESS (0.111s)
[79.699824] Starting dynamic subtest: vcs0
[79.804664] Dynamic subtest vcs0: SUCCESS (0.110s)
[79.810593] Starting dynamic subtest: vcs1
[79.923486] Dynamic subtest vcs1: SUCCESS (0.119s)
[79.932532] Starting dynamic subtest: vecs0
[80.054343] Dynamic subtest vecs0: SUCCESS (0.131s)
[80.063713] Starting dynamic subtest: vecs1
[80.184422] Dynamic subtest vecs1: SUCCESS (0.130s)
[80.191885] Starting dynamic subtest: ccs0
[80.301980] Dynamic subtest ccs0: SUCCESS (0.117s)
[80.309661] Starting dynamic subtest: ccs1
[80.419361] Dynamic subtest ccs1: SUCCESS (0.117s)
[80.427025] Starting dynamic subtest: ccs2
[80.536710] Dynamic subtest ccs2: SUCCESS (0.117s)
[80.545708] Starting dynamic subtest: ccs3
[80.664433] Dynamic subtest ccs3: SUCCESS (0.127s)
[80.665581] Subtest basic-await: SUCCESS (1.231s)
[81.333610] [024/171] (922s left) gem_exec_fence (nb-await)
[81.607750] Starting subtest: nb-await
[81.609462] Starting dynamic subtest: rcs0
[81.707578] Dynamic subtest rcs0: SUCCESS (0.107s)
[81.716402] Starting dynamic subtest: bcs0
[81.783524] Dynamic subtest bcs0: SUCCESS (0.074s)
[81.810110] Starting dynamic subtest: vcs0
[81.884192] Dynamic subtest vcs0: SUCCESS (0.101s)
[81.896826] Starting dynamic subtest: vcs1
[81.970214] Dynamic subtest vcs1: SUCCESS (0.085s)
[81.996158] Starting dynamic subtest: vecs0
[82.069634] Dynamic subtest vecs0: SUCCESS (0.100s)
[82.080547] Starting dynamic subtest: vecs1
[82.151586] Dynamic subtest vecs1: SUCCESS (0.080s)
[82.177190] Starting dynamic subtest: ccs0
[82.254176] Dynamic subtest ccs0: SUCCESS (0.098s)
[82.269484] Starting dynamic subtest: ccs1
[82.337690] Dynamic subtest ccs1: SUCCESS (0.089s)
[82.363781] Starting dynamic subtest: ccs2
[82.440441] Dynamic subtest ccs2: SUCCESS (0.103s)
[82.451768] Starting dynamic subtest: ccs3
[82.525324] Dynamic subtest ccs3: SUCCESS (0.083s)
[82.527087] Subtest nb-await: SUCCESS (0.924s)
[83.191268] [025/171] (920s left) gem_exec_gttfill (basic)
[83.309259] Starting subtest: basic
[90.526883] Subtest basic: SUCCESS (7.209s)
[90.760825] [026/171] (913s left) gem_exec_parallel (engines)
[90.917916] Starting subtest: engines
[90.918879] Starting dynamic subtest: basic
[92.921305] Dynamic subtest basic: SUCCESS (2.003s)
[92.944936] Starting dynamic subtest: contexts
[96.291644] Dynamic subtest contexts: SUCCESS (3.362s)
[96.298133] Starting dynamic subtest: fds
[99.655468] Dynamic subtest fds: SUCCESS (3.363s)
[99.662014] Starting dynamic subtest: userptr
[101.345933] Dynamic subtest userptr: SUCCESS (1.699s)
[101.347093] Subtest engines: SUCCESS (10.428s)
[101.641159] [027/171] (902s left) gem_exec_store (basic)
[101.752960] Starting subtest: basic
[101.885077] Subtest basic: SUCCESS (0.132s)
[102.127360] [028/171] (901s left) gem_flink_basic (bad-flink)
[102.224314] Starting subtest: bad-flink
[102.225304] Subtest bad-flink: SUCCESS (0.000s)
[102.295378] [029/171] (901s left) gem_flink_basic (bad-open)
[102.387195] Starting subtest: bad-open
[102.388237] Subtest bad-open: SUCCESS (0.000s)
[102.469514] [030/171] (901s left) gem_flink_basic (basic)
[102.565193] Starting subtest: basic
[102.566201] Subtest basic: SUCCESS (0.000s)
[102.684940] [031/171] (901s left) gem_flink_basic (double-flink)
[102.801249] Starting subtest: double-flink
[102.802305] Subtest double-flink: SUCCESS (0.000s)
[102.886108] [032/171] (901s left) gem_flink_basic (flink-lifetime)
[102.981174] Starting subtest: flink-lifetime
[102.983490] Subtest flink-lifetime: SUCCESS (0.002s)
[103.099626] [033/171] (900s left) gem_huc_copy (huc-copy)
[103.223563] Starting subtest: huc-copy
[103.232687] Subtest huc-copy: SUCCESS (0.008s)
[103.357101] [034/171] (900s left) gem_linear_blits (basic)
[103.568438] Starting subtest: basic
[103.607190] Subtest basic: SUCCESS (0.039s)
[103.770973] [035/171] (900s left) gem_mmap (basic)
[103.921602] Subtest basic: SKIP (0.000s)
[103.946403] [036/171] (900s left) gem_mmap_gtt (basic)
[104.039596] Subtest basic: SKIP (0.000s)
[104.064747] [037/171] (900s left) gem_render_linear_blits (basic)
[104.164949] Starting subtest: basic
[104.244471] Subtest basic: SUCCESS (0.080s)
[104.314405] [038/171] (899s left) gem_render_tiled_blits (basic)
[104.419410] Subtest basic: SKIP (0.000s)
[104.446554] [039/171] (899s left) gem_ringfill (basic-all)
[104.878655] Starting subtest: basic-all
[106.354699] Subtest basic-all: SUCCESS (1.470s)
[106.475029] [040/171] (897s left) gem_softpin (allocator-basic)
[106.597795] Starting subtest: allocator-basic
[106.873625] Subtest allocator-basic: SUCCESS (0.267s)
[107.005340] [041/171] (897s left) gem_softpin (allocator-basic-reserve)
[107.103881] Starting subtest: allocator-basic-reserve
[107.383704] Subtest allocator-basic-reserve: SUCCESS (0.271s)
[107.524158] [042/171] (896s left) gem_softpin (safe-alignment)
[107.635941] Starting subtest: safe-alignment
[107.709968] Subtest safe-alignment: SUCCESS (0.074s)
[107.843086] [043/171] (896s left) gem_sync (basic-all)
[107.956216] Starting subtest: basic-all
[111.970738] Subtest basic-all: SUCCESS (4.014s)
[112.167943] [044/171] (892s left) gem_sync (basic-each)
[112.275496] Starting subtest: basic-each
[114.899507] Subtest basic-each: SUCCESS (2.624s)
[115.106264] [045/171] (889s left) gem_tiled_blits (basic)
[115.214375] Subtest basic: SKIP (0.000s)
[115.246958] [046/171] (889s left) gem_tiled_fence_blits (basic)
[115.346976] Subtest basic: SKIP (0.000s)
[115.380284] [047/171] (888s left) gem_tiled_pread_basic
[115.513446] [048/171] (888s left) gem_wait (busy@all-engines)
[115.624508] Starting subtest: busy
[115.625558] Starting dynamic subtest: all-engines
[116.201955] Dynamic subtest all-engines: SUCCESS (0.577s)
[116.203561] Subtest busy: SUCCESS (0.577s)
[116.490226] [049/171] (887s left) gem_wait (wait@all-engines)
[116.603764] Starting subtest: wait
[116.604785] Starting dynamic subtest: all-engines
[117.700240] Dynamic subtest all-engines: SUCCESS (1.096s)
[117.701303] Subtest wait: SUCCESS (1.096s)
[117.973578] [050/171] (886s left) i915_getparams_basic (basic-eu-total)
[118.066050] Starting subtest: basic-eu-total
[118.067914] Subtest basic-eu-total: SUCCESS (0.000s)
[118.126571] [051/171] (886s left) i915_getparams_basic (basic-subslice-total)
[118.219248] Starting subtest: basic-subslice-total
[118.221280] Subtest basic-subslice-total: SUCCESS (0.000s)
[118.276612] [052/171] (886s left) i915_hangman (error-state-basic)
[118.391448] Starting subtest: error-state-basic
[118.601056] Subtest error-state-basic: SUCCESS (0.210s)
[118.682086] [053/171] (885s left) i915_pciid
[118.846013] [054/171] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[118.945267] Starting subtest: addfb25-bad-modifier
[118.946279] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[119.096790] [055/171] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[119.193991] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[119.349345] [056/171] (885s left) kms_addfb_basic (addfb25-modifier-no-flag)
[119.446498] Starting subtest: addfb25-modifier-no-flag
[119.447497] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[119.596695] [057/171] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[119.693249] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[119.847224] [058/171] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[119.943333] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[120.080228] [059/171] (884s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[120.239982] Starting subtest: addfb25-yf-tiled-legacy
[120.241056] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[120.328089] [060/171] (884s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[120.483732] Starting subtest: addfb25-y-tiled-legacy
[120.484689] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[120.561042] [061/171] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[120.716418] Starting subtest: addfb25-y-tiled-small-legacy
[120.718217] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[120.811149] [062/171] (883s left) kms_addfb_basic (bad-pitch-0)
[120.903057] Starting subtest: bad-pitch-0
[120.904010] Subtest bad-pitch-0: SUCCESS (0.000s)
[121.044581] [063/171] (883s left) kms_addfb_basic (bad-pitch-1024)
[121.137112] Starting subtest: bad-pitch-1024
[121.138105] Subtest bad-pitch-1024: SUCCESS (0.000s)
[121.278645] [064/171] (883s left) kms_addfb_basic (bad-pitch-128)
[121.372134] Starting subtest: bad-pitch-128
[121.373056] Subtest bad-pitch-128: SUCCESS (0.000s)
[121.511164] [065/171] (883s left) kms_addfb_basic (bad-pitch-256)
[121.604136] Starting subtest: bad-pitch-256
[121.605076] Subtest bad-pitch-256: SUCCESS (0.000s)
[121.744544] [066/171] (882s left) kms_addfb_basic (bad-pitch-32)
[121.840063] Starting subtest: bad-pitch-32
[121.840980] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.994591] [067/171] (882s left) kms_addfb_basic (bad-pitch-63)
[122.087099] Starting subtest: bad-pitch-63
[122.088060] Subtest bad-pitch-63: SUCCESS (0.000s)
[122.230048] [068/171] (882s left) kms_addfb_basic (bad-pitch-65536)
[122.326146] Starting subtest: bad-pitch-65536
[122.327175] Subtest bad-pitch-65536: SUCCESS (0.000s)
[122.463969] [069/171] (882s left) kms_addfb_basic (bad-pitch-999)
[122.559944] Starting subtest: bad-pitch-999
[122.561051] Subtest bad-pitch-999: SUCCESS (0.000s)
[122.713640] [070/171] (881s left) kms_addfb_basic (basic)
[122.811344] Starting subtest: basic
[122.812380] Subtest basic: SUCCESS (0.000s)
[122.963794] [071/171] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[123.061370] Starting subtest: basic-x-tiled-legacy
[123.063340] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[123.213535] [072/171] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[123.310416] Starting subtest: basic-y-tiled-legacy
[123.312443] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[123.463527] [073/171] (881s left) kms_addfb_basic (bo-too-small)
[123.622238] Starting subtest: bo-too-small
[123.623184] Subtest bo-too-small: SUCCESS (0.000s)
[123.713507] [074/171] (881s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[123.881438] Starting subtest: bo-too-small-due-to-tiling
[123.883436] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[123.968682] [075/171] (880s left) kms_addfb_basic (clobberred-modifier)
[124.061233] Starting subtest: clobberred-modifier
[124.063200] Subtest clobberred-modifier: SKIP (0.000s)
[124.214174] [076/171] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[124.317295] Starting subtest: framebuffer-vs-set-tiling
[124.319316] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[124.463500] [077/171] (880s left) kms_addfb_basic (invalid-get-prop)
[124.560364] Starting subtest: invalid-get-prop
[124.561425] Subtest invalid-get-prop: SUCCESS (0.000s)
[124.713585] [078/171] (880s left) kms_addfb_basic (invalid-get-prop-any)
[124.810252] Starting subtest: invalid-get-prop-any
[124.811292] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[124.946807] [079/171] (879s left) kms_addfb_basic (invalid-set-prop)
[125.043143] Starting subtest: invalid-set-prop
[125.044093] Subtest invalid-set-prop: SUCCESS (0.000s)
[125.196818] [080/171] (879s left) kms_addfb_basic (invalid-set-prop-any)
[125.293413] Starting subtest: invalid-set-prop-any
[125.294452] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[125.468526] [081/171] (879s left) kms_addfb_basic (no-handle)
[125.562222] Starting subtest: no-handle
[125.563279] Subtest no-handle: SUCCESS (0.000s)
[125.711577] [082/171] (879s left) kms_addfb_basic (size-max)
[125.866945] Starting subtest: size-max
[125.868017] Subtest size-max: SUCCESS (0.000s)
[125.961508] [083/171] (878s left) kms_addfb_basic (small-bo)
[126.117160] Starting subtest: small-bo
[126.118253] Subtest small-bo: SUCCESS (0.000s)
[126.194622] [084/171] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[126.287233] Starting subtest: tile-pitch-mismatch
[126.289234] Subtest tile-pitch-mismatch: SKIP (0.000s)
[126.444536] [085/171] (878s left) kms_addfb_basic (too-high)
[126.601390] Starting subtest: too-high
[126.602384] Subtest too-high: SUCCESS (0.001s)
[126.694638] [086/171] (878s left) kms_addfb_basic (too-wide)
[126.849813] Starting subtest: too-wide
[126.850854] Subtest too-wide: SUCCESS (0.000s)
[126.928157] [087/171] (878s left) kms_addfb_basic (unused-handle)
[127.021293] Starting subtest: unused-handle
[127.022307] Subtest unused-handle: SUCCESS (0.000s)
[127.162235] [088/171] (877s left) kms_addfb_basic (unused-modifier)
[127.255148] Starting subtest: unused-modifier
[127.256165] Subtest unused-modifier: SUCCESS (0.000s)
[127.411450] [089/171] (877s left) kms_addfb_basic (unused-offsets)
[127.502896] Starting subtest: unused-offsets
[127.503839] Subtest unused-offsets: SUCCESS (0.000s)
[127.644740] [090/171] (877s left) kms_addfb_basic (unused-pitches)
[127.737513] Starting subtest: unused-pitches
[127.738387] Subtest unused-pitches: SUCCESS (0.000s)
[127.877474] [091/171] (877s left) kms_busy (basic)
[128.040503] Starting subtest: basic
[128.041530] Starting dynamic subtest: flip
[128.846145] Dynamic subtest flip: SUCCESS (0.805s)
[128.854227] Starting dynamic subtest: modeset
[129.811136] Dynamic subtest modeset: SUCCESS (0.965s)
[129.812181] Subtest basic: SUCCESS (1.772s)
[130.039940] [092/171] (875s left) kms_chamelium_hpd (dp-hpd-fast)
[130.273840] Subtest dp-hpd-fast: SKIP (0.000s)
[130.408239] [093/171] (874s left) kms_chamelium_edid (dp-edid-read)
[130.639082] Subtest dp-edid-read: SKIP (0.000s)
[130.772501] [094/171] (874s left) kms_chamelium_frames (dp-crc-fast)
[131.003178] Subtest dp-crc-fast: SKIP (0.000s)
[131.136591] [095/171] (874s left) kms_chamelium_hpd (hdmi-hpd-fast)
[131.365621] Subtest hdmi-hpd-fast: SKIP (0.000s)
[131.500455] [096/171] (873s left) kms_chamelium_edid (hdmi-edid-read)
[131.731619] Subtest hdmi-edid-read: SKIP (0.000s)
[131.869566] [097/171] (873s left) kms_chamelium_frames (hdmi-crc-fast)
[132.098806] Subtest hdmi-crc-fast: SKIP (0.000s)
[132.235743] [098/171] (872s left) kms_chamelium_hpd (vga-hpd-fast)
[132.464555] Subtest vga-hpd-fast: SKIP (0.000s)
[132.597777] [099/171] (872s left) kms_chamelium_edid (vga-edid-read)
[132.828475] Subtest vga-edid-read: SKIP (0.000s)
[132.961772] [100/171] (872s left) kms_prop_blob (basic)
[133.056117] Starting subtest: basic
[133.057097] Subtest basic: SUCCESS (0.000s)
[133.124536] [101/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[133.284043] Starting subtest: basic-busy-flip-before-cursor-atomic
[133.286045] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[133.358345] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[133.517736] Starting subtest: basic-busy-flip-before-cursor-legacy
[133.519818] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[133.591740] [103/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[133.751539] Starting subtest: basic-flip-after-cursor-atomic
[134.807252] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.056s)
[135.045527] [104/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[135.210149] Starting subtest: basic-flip-after-cursor-legacy
[136.260821] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.052s)
[136.466185] [105/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[136.622303] Starting subtest: basic-flip-after-cursor-varying-size
[137.699523] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.079s)
[137.916408] [106/171] (867s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[138.072246] Starting subtest: basic-flip-before-cursor-atomic
[139.133486] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.061s)
[139.335857] [107/171] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[139.492506] Starting subtest: basic-flip-before-cursor-legacy
[140.569453] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.077s)
[140.777987] [108/171] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[140.934091] Starting subtest: basic-flip-before-cursor-varying-size
[142.013715] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.079s)
[142.260727] [109/171] (863s left) kms_flip (basic-flip-vs-dpms)
[142.399011] Starting subtest: basic-flip-vs-dpms
[142.404200] Starting dynamic subtest: A-DP1
[143.314092] Dynamic subtest A-DP1: SUCCESS (0.909s)
[143.322138] Starting dynamic subtest: B-DP1
[144.206270] Dynamic subtest B-DP1: SUCCESS (0.893s)
[144.213989] Starting dynamic subtest: C-DP1
[145.107287] Dynamic subtest C-DP1: SUCCESS (0.900s)
[145.115441] Starting dynamic subtest: D-DP1
[146.009692] Dynamic subtest D-DP1: SUCCESS (0.901s)
[146.014254] Subtest basic-flip-vs-dpms: SUCCESS (3.616s)
[146.233826] [110/171] (859s left) kms_flip (basic-flip-vs-modeset)
[146.374594] Starting subtest: basic-flip-vs-modeset
[146.380182] Starting dynamic subtest: A-DP1
[147.278130] Dynamic subtest A-DP1: SUCCESS (0.897s)
[147.286058] Starting dynamic subtest: B-DP1
[148.166285] Dynamic subtest B-DP1: SUCCESS (0.887s)
[148.174170] Starting dynamic subtest: C-DP1
[149.065576] Dynamic subtest C-DP1: SUCCESS (0.898s)
[149.074249] Starting dynamic subtest: D-DP1
[149.958366] Dynamic subtest D-DP1: SUCCESS (0.891s)
[149.962678] Subtest basic-flip-vs-modeset: SUCCESS (3.589s)
[150.172131] [111/171] (855s left) kms_flip (basic-flip-vs-wf_vblank)
[150.313281] Starting subtest: basic-flip-vs-wf_vblank
[150.318927] Starting dynamic subtest: A-DP1
[151.533870] Dynamic subtest A-DP1: SUCCESS (1.215s)
[151.543564] Starting dynamic subtest: B-DP1
[152.653130] Dynamic subtest B-DP1: SUCCESS (1.118s)
[152.662764] Starting dynamic subtest: C-DP1
[153.775109] Dynamic subtest C-DP1: SUCCESS (1.121s)
[153.786974] Starting dynamic subtest: D-DP1
[154.897212] Dynamic subtest D-DP1: SUCCESS (1.121s)
[154.902566] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.590s)
[155.167361] [112/171] (850s left) kms_flip (basic-plain-flip)
[155.307821] Starting subtest: basic-plain-flip
[155.312887] Starting dynamic subtest: A-DP1
[156.244018] Dynamic subtest A-DP1: SUCCESS (0.931s)
[156.254055] Starting dynamic subtest: B-DP1
[157.077791] Dynamic subtest B-DP1: SUCCESS (0.832s)
[157.087613] Starting dynamic subtest: C-DP1
[157.912424] Dynamic subtest C-DP1: SUCCESS (0.833s)
[157.922067] Starting dynamic subtest: D-DP1
[158.752388] Dynamic subtest D-DP1: SUCCESS (0.835s)
[158.756521] Subtest basic-plain-flip: SUCCESS (3.450s)
[159.015366] [113/171] (846s left) kms_force_connector_basic (force-connector-state)
[159.114333] Starting subtest: force-connector-state
[159.671499] Subtest force-connector-state: SUCCESS (0.556s)
[159.944818] [114/171] (845s left) kms_force_connector_basic (force-edid)
[160.042721] Starting subtest: force-edid
[160.059079] Subtest force-edid: SUCCESS (0.017s)
[160.228059] [115/171] (845s left) kms_force_connector_basic (force-load-detect)
[160.326116] Starting subtest: force-load-detect
[160.327782] Subtest force-load-detect: SKIP (0.000s)
[160.444576] [116/171] (845s left) kms_force_connector_basic (prune-stale-modes)
[160.540751] Starting subtest: prune-stale-modes
[160.551183] Subtest prune-stale-modes: SKIP (0.010s)
[160.711362] [117/171] (844s left) kms_frontbuffer_tracking (basic)
[160.873581] Starting subtest: basic
[164.971492] Subtest basic: SUCCESS (4.100s)
[165.094458] [118/171] (840s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[165.250855] Starting subtest: compare-crc-sanitycheck-xr24
[165.251862] Starting dynamic subtest: pipe-A-DP-1
[165.844446] Dynamic subtest pipe-A-DP-1: SUCCESS (0.592s)
[165.854061] Starting dynamic subtest: pipe-B-DP-1
[166.419404] Dynamic subtest pipe-B-DP-1: SUCCESS (0.571s)
[166.429410] Starting dynamic subtest: pipe-C-DP-1
[167.041544] Dynamic subtest pipe-C-DP-1: SUCCESS (0.620s)
[167.051073] Starting dynamic subtest: pipe-D-DP-1
[167.736528] Dynamic subtest pipe-D-DP-1: SUCCESS (0.692s)
[167.737592] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.487s)
[167.944198] [119/171] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[168.101416] Starting subtest: compare-crc-sanitycheck-nv12
[168.103993] Starting dynamic subtest: pipe-A-DP-1
[169.336564] Dynamic subtest pipe-A-DP-1: SUCCESS (1.233s)
[169.346292] Starting dynamic subtest: pipe-B-DP-1
[170.476967] Dynamic subtest pipe-B-DP-1: SUCCESS (1.137s)
[170.486920] Starting dynamic subtest: pipe-C-DP-1
[171.670282] Dynamic subtest pipe-C-DP-1: SUCCESS (1.191s)
[171.680438] Starting dynamic subtest: pipe-D-DP-1
[172.989943] Dynamic subtest pipe-D-DP-1: SUCCESS (1.316s)
[172.990982] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.889s)
[173.188552] [120/171] (832s left) kms_pipe_crc_basic (hang-read-crc)
[173.346876] Starting subtest: hang-read-crc
[173.347889] Starting dynamic subtest: pipe-A-DP-1
[174.827825] Dynamic subtest pipe-A-DP-1: SUCCESS (1.479s)
[174.837556] Starting dynamic subtest: pipe-B-DP-1
[176.369800] Dynamic subtest pipe-B-DP-1: SUCCESS (1.539s)
[176.379626] Starting dynamic subtest: pipe-C-DP-1
[178.040788] Dynamic subtest pipe-C-DP-1: SUCCESS (1.667s)
[178.050158] Starting dynamic subtest: pipe-D-DP-1
[179.830861] Dynamic subtest pipe-D-DP-1: SUCCESS (1.787s)
[179.831898] Subtest hang-read-crc: SUCCESS (6.485s)
[180.027742] [121/171] (825s left) kms_pipe_crc_basic (nonblocking-crc)
[180.200520] Starting subtest: nonblocking-crc
[180.203550] Starting dynamic subtest: pipe-A-DP-1
[180.893367] Dynamic subtest pipe-A-DP-1: SUCCESS (0.690s)
[180.909932] Starting dynamic subtest: pipe-B-DP-1
[181.616041] Dynamic subtest pipe-B-DP-1: SUCCESS (0.719s)
[181.628691] Starting dynamic subtest: pipe-C-DP-1
[182.446100] Dynamic subtest pipe-C-DP-1: SUCCESS (0.827s)
[182.459135] Starting dynamic subtest: pipe-D-DP-1
[183.301941] Dynamic subtest pipe-D-DP-1: SUCCESS (0.852s)
[183.303296] Subtest nonblocking-crc: SUCCESS (3.101s)
[183.499789] [122/171] (822s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[183.657082] Starting subtest: nonblocking-crc-frame-sequence
[183.658147] Starting dynamic subtest: pipe-A-DP-1
[184.349427] Dynamic subtest pipe-A-DP-1: SUCCESS (0.692s)
[184.359587] Starting dynamic subtest: pipe-B-DP-1
[185.073927] Dynamic subtest pipe-B-DP-1: SUCCESS (0.720s)
[185.083571] Starting dynamic subtest: pipe-C-DP-1
[185.883889] Dynamic subtest pipe-C-DP-1: FAIL (0.745s)
[185.892147] Starting dynamic subtest: pipe-D-DP-1
[186.678554] Dynamic subtest pipe-D-DP-1: SUCCESS (0.854s)
[186.679474] Subtest nonblocking-crc-frame-sequence: FAIL (3.023s)
[186.886162] [123/171] (818s left) kms_pipe_crc_basic (read-crc)
[187.043990] Starting subtest: read-crc
[187.045098] Starting dynamic subtest: pipe-A-DP-1
[187.702569] Dynamic subtest pipe-A-DP-1: SUCCESS (0.656s)
[187.712647] Starting dynamic subtest: pipe-B-DP-1
[188.356420] Dynamic subtest pipe-B-DP-1: SUCCESS (0.651s)
[188.365946] Starting dynamic subtest: pipe-C-DP-1
[189.073839] Dynamic subtest pipe-C-DP-1: SUCCESS (0.714s)
[189.083818] Starting dynamic subtest: pipe-D-DP-1
[189.852867] Dynamic subtest pipe-D-DP-1: SUCCESS (0.775s)
[189.853971] Subtest read-crc: SUCCESS (2.809s)
[190.047918] [124/171] (815s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[190.205828] Starting subtest: read-crc-frame-sequence
[190.206875] Starting dynamic subtest: pipe-A-DP-1
[190.830390] Dynamic subtest pipe-A-DP-1: SUCCESS (0.623s)
[190.840043] Starting dynamic subtest: pipe-B-DP-1
[191.485624] Dynamic subtest pipe-B-DP-1: SUCCESS (0.652s)
[191.495543] Starting dynamic subtest: pipe-C-DP-1
[192.200846] Dynamic subtest pipe-C-DP-1: SUCCESS (0.712s)
[192.210658] Starting dynamic subtest: pipe-D-DP-1
[193.095232] Dynamic subtest pipe-D-DP-1: SUCCESS (0.891s)
[193.096360] Subtest read-crc-frame-sequence: SUCCESS (2.890s)
[193.291677] [125/171] (812s left) kms_psr (primary_page_flip)
[193.388625] Subtest primary_page_flip: SKIP (0.000s)
[193.428208] [126/171] (812s left) kms_psr (cursor_plane_move)
[193.522781] Subtest cursor_plane_move: SKIP (0.000s)
[193.561606] [127/171] (812s left) kms_psr (sprite_plane_onoff)
[193.655644] Subtest sprite_plane_onoff: SKIP (0.000s)
[193.694879] [128/171] (812s left) kms_psr (primary_mmap_gtt)
[193.789834] Subtest primary_mmap_gtt: SKIP (0.000s)
[193.828216] [129/171] (811s left) kms_setmode (basic-clone-single-crtc)
[193.933833] Starting subtest: basic-clone-single-crtc
[193.936766] Subtest basic-clone-single-crtc: SKIP (0.001s)
[194.008099] [130/171] (811s left) i915_pm_backlight (basic-brightness)
[194.166273] Subtest basic-brightness: SKIP (0.000s)
[194.194946] [131/171] (811s left) i915_pm_rpm (basic-pci-d3-state)
[196.500950] Starting subtest: basic-pci-d3-state
[197.200029] Subtest basic-pci-d3-state: SUCCESS (0.699s)
[197.355370] [132/171] (808s left) i915_pm_rpm (basic-rte)
[197.431428] Starting subtest: basic-rte
[200.432141] Subtest basic-rte: SUCCESS (2.999s)
[201.418480] [133/171] (804s left) i915_pm_rps (basic-api)
[201.521406] Starting subtest: basic-api
[201.523409] Subtest basic-api: SKIP (0.000s)
[201.604780] [134/171] (804s left) prime_self_import (basic-llseek-bad)
[201.683489] Starting subtest: basic-llseek-bad
[201.702183] Subtest basic-llseek-bad: SUCCESS (0.018s)
[201.830259] [135/171] (804s left) prime_self_import (basic-llseek-size)
[201.905999] Starting subtest: basic-llseek-size
[201.926046] Subtest basic-llseek-size: SUCCESS (0.019s)
[202.031662] [136/171] (803s left) prime_self_import (basic-with_fd_dup)
[202.108572] Starting subtest: basic-with_fd_dup
[202.125772] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[202.240033] [137/171] (803s left) prime_self_import (basic-with_one_bo)
[202.324110] Starting subtest: basic-with_one_bo
[202.343409] Subtest basic-with_one_bo: SUCCESS (0.019s)
[202.403229] [138/171] (803s left) prime_self_import (basic-with_one_bo_two_files)
[202.477923] Starting subtest: basic-with_one_bo_two_files
[202.497364] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[202.598407] [139/171] (803s left) prime_self_import (basic-with_two_bos)
[202.696976] Starting subtest: basic-with_two_bos
[202.716687] Subtest basic-with_two_bos: SUCCESS (0.019s)
[202.816280] [140/171] (803s left) prime_vgem (basic-fence-flip)
[202.951491] Starting subtest: basic-fence-flip
[203.063381] Subtest basic-fence-flip: SKIP (0.111s)
[203.166276] [141/171] (802s left) prime_vgem (basic-fence-mmap)
[203.297134] Starting subtest: basic-fence-mmap
[203.299284] Subtest basic-fence-mmap: SKIP (0.000s)
[203.406532] [142/171] (802s left) prime_vgem (basic-fence-read)
[203.534432] Starting subtest: basic-fence-read
[203.541477] Subtest basic-fence-read: SKIP (0.006s)
[203.649276] [143/171] (802s left) prime_vgem (basic-gtt)
[203.767719] Starting subtest: basic-gtt
[203.770140] Subtest basic-gtt: SKIP (0.000s)
[203.897928] [144/171] (802s left) prime_vgem (basic-read)
[204.007183] Starting subtest: basic-read
[204.014167] Subtest basic-read: SKIP (0.006s)
[204.150906] [145/171] (801s left) prime_vgem (basic-write)
[204.268142] Starting subtest: basic-write
[204.274784] Subtest basic-write: SKIP (0.006s)
[204.387366] [146/171] (801s left) vgem_basic (setversion)
[204.510189] Starting subtest: setversion
[204.512267] Subtest setversion: SUCCESS (0.000s)
[204.569238] [147/171] (801s left) vgem_basic (create)
[204.660063] Starting subtest: create
[204.661120] Subtest create: SUCCESS (0.000s)
[204.717925] [148/171] (801s left) vgem_basic (debugfs)
[204.810051] Starting subtest: debugfs
[204.810937] Subtest debugfs: SUCCESS (0.000s)
[204.869114] [149/171] (801s left) vgem_basic (dmabuf-export)
[204.960140] Starting subtest: dmabuf-export
[204.979284] Subtest dmabuf-export: SUCCESS (0.018s)
[205.098990] [150/171] (801s left) vgem_basic (dmabuf-fence)
[205.193416] Starting subtest: dmabuf-fence
[205.194442] Subtest dmabuf-fence: SUCCESS (0.000s)
[205.252387] [151/171] (801s left) vgem_basic (dmabuf-fence-before)
[205.343442] Starting subtest: dmabuf-fence-before
[205.344529] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[205.402575] [152/171] (800s left) vgem_basic (dmabuf-mmap)
[205.493403] Starting subtest: dmabuf-mmap
[205.506462] Subtest dmabuf-mmap: SUCCESS (0.014s)
[205.568515] [153/171] (800s left) vgem_basic (mmap)
[205.660169] Starting subtest: mmap
[205.668695] Subtest mmap: SUCCESS (0.009s)
[205.717391] [154/171] (800s left) vgem_basic (second-client)
[205.810135] Starting subtest: second-client
[205.843413] Subtest second-client: SUCCESS (0.033s)
[205.926384] [155/171] (800s left) vgem_basic (sysfs)
[206.043450] Starting subtest: sysfs
[206.044481] Subtest sysfs: SUCCESS (0.000s)
[206.101177] [156/171] (800s left) core_hotunplug (unbind-rebind)
[206.242985] Starting subtest: unbind-rebind
[209.027224] Subtest unbind-rebind: SUCCESS (2.784s)
[209.049040] [157/171] (797s left) vgem_basic (unload)
[209.129427] Starting subtest: unload
[238.182456] Subtest unload: SUCCESS (29.018s)
[238.263939] [158/171] (768s left) i915_module_load (reload)
[238.345832] Starting subtest: reload
[242.060242] Subtest reload: SUCCESS (3.714s)
[242.078279] [159/171] (764s left) gem_lmem_swapping (basic)
[245.981844] Starting subtest: basic
[245.982767] Starting dynamic subtest: lmem0
[273.902225] Dynamic subtest lmem0: SUCCESS (27.911s)
[273.903211] Subtest basic: SUCCESS (27.913s)
[276.150416] [160/171] (730s left) gem_lmem_swapping (parallel-random-engines)
[277.105160] Starting subtest: parallel-random-engines
[277.106180] Starting dynamic subtest: lmem0
[278.586457] Dynamic subtest lmem0: SUCCESS (1.474s)
[278.587437] Subtest parallel-random-engines: SUCCESS (1.476s)
[280.184653] [161/171] (726s left) gem_lmem_swapping (random-engines)
[281.056380] Starting subtest: random-engines
[281.057415] Starting dynamic subtest: lmem0
[282.296459] Dynamic subtest lmem0: SUCCESS (1.231s)
[282.297479] Subtest random-engines: SUCCESS (1.232s)
[283.916128] [162/171] (722s left) gem_lmem_swapping (verify-random)
[284.900316] Starting subtest: verify-random
[284.901275] Starting dynamic subtest: lmem0
[295.033203] Dynamic subtest lmem0: SUCCESS (10.123s)
[295.034210] Subtest verify-random: SUCCESS (10.125s)
[296.692205] [163/171] (709s left) i915_pm_rpm (module-reload)
[299.829223] Starting subtest: module-reload
[314.533198] Subtest module-reload: SUCCESS (14.695s)
[314.548147] [164/171] (692s left) i915_selftest (live)
[314.644849] Starting subtest: live
[314.645919] Starting dynamic subtest: sanitycheck
[316.742358] Dynamic subtest sanitycheck: SUCCESS (2.088s)
[316.748931] Starting dynamic subtest: uncore
[318.810730] Dynamic subtest uncore: SUCCESS (2.067s)
[318.819177] Starting dynamic subtest: workarounds
[323.412269] Dynamic subtest workarounds: SUCCESS (4.600s)
[323.422544] Starting dynamic subtest: gt_engines
[326.586542] Dynamic subtest gt_engines: SUCCESS (3.172s)
[326.594203] Starting dynamic subtest: gt_timelines
[362.910391] Dynamic subtest gt_timelines: SUCCESS (36.322s)
[362.917230] Starting dynamic subtest: gt_contexts
[365.058686] Dynamic subtest gt_contexts: SUCCESS (2.147s)
[365.065830] Starting dynamic subtest: gt_lrc
[374.142605] Dynamic subtest gt_lrc: SUCCESS (9.082s)
[374.149497] Starting dynamic subtest: gt_mocs
[377.984479] Dynamic subtest gt_mocs: SUCCESS (3.841s)
[377.992067] Starting dynamic subtest: gt_pm
[380.986335] Dynamic subtest gt_pm: SUCCESS (3.000s)
[380.992282] Starting dynamic subtest: gt_heartbeat
[383.308441] Dynamic subtest gt_heartbeat: SUCCESS (2.320s)
[383.315606] Starting dynamic subtest: gt_tlb
[400.249445] Dynamic subtest gt_tlb: SUCCESS (16.940s)
[400.257220] Starting dynamic subtest: requests
[419.039523] Dynamic subtest requests: SUCCESS (18.788s)
[419.046746] Starting dynamic subtest: migrate
[424.627359] Dynamic subtest migrate: SUCCESS (5.587s)
[424.634536] Starting dynamic subtest: active
[426.695385] Dynamic subtest active: SUCCESS (2.066s)
[426.702493] Starting dynamic subtest: objects
[430.073266] Dynamic subtest objects: SUCCESS (3.377s)
[430.082536] Starting dynamic subtest: mman
[441.157197] Dynamic subtest mman: SUCCESS (11.082s)
[441.163292] Starting dynamic subtest: dmabuf
[443.196288] Dynamic subtest dmabuf: SUCCESS (2.038s)
[443.202479] Starting dynamic subtest: vma
[445.213162] Dynamic subtest vma: SUCCESS (2.016s)
[445.219306] Starting dynamic subtest: coherency
[449.747180] Dynamic subtest coherency: SUCCESS (4.533s)
[449.754852] Starting dynamic subtest: gtt
[460.347327] Dynamic subtest gtt: SUCCESS (10.599s)
[460.353471] Starting dynamic subtest: gem
[462.352373] Dynamic subtest gem: SUCCESS (2.004s)
[462.359186] Starting dynamic subtest: evict
[466.930466] Dynamic subtest evict: SUCCESS (4.577s)
[466.937667] Starting dynamic subtest: hugepages
[484.209729] Dynamic subtest hugepages: SUCCESS (17.276s)
[484.217109] Starting dynamic subtest: gem_contexts
[530.132574] Dynamic subtest gem_contexts: SUCCESS (45.923s)
[530.139538] Starting dynamic subtest: client
[532.232522] Dynamic subtest client: SUCCESS (2.099s)
[532.240299] Starting dynamic subtest: gem_migrate
[537.376392] Dynamic subtest gem_migrate: SUCCESS (5.142s)
[537.383424] Starting dynamic subtest: reset
[539.540255] Dynamic subtest reset: SUCCESS (2.163s)
[539.547191] Starting dynamic subtest: memory_region
[543.150394] Dynamic subtest memory_region: SUCCESS (3.609s)
[543.157398] Starting dynamic subtest: hangcheck
[588.814496] Dynamic subtest hangcheck: SUCCESS (45.663s)
[588.822439] Starting dynamic subtest: execlists
[590.884556] Dynamic subtest execlists: SUCCESS (2.069s)
[590.891865] Starting dynamic subtest: ring_submission
[592.934572] Dynamic subtest ring_submission: SUCCESS (2.049s)
[592.941444] Starting dynamic subtest: perf
[595.172308] Dynamic subtest perf: SUCCESS (2.236s)
[595.178388] Starting dynamic subtest: slpc
[604.995430] Dynamic subtest slpc: SUCCESS (9.822s)
[605.001735] Starting dynamic subtest: guc
[608.582747] Dynamic subtest guc: SUCCESS (3.585s)
[608.589396] Starting dynamic subtest: guc_multi_lrc
[610.667466] Dynamic subtest guc_multi_lrc: SUCCESS (2.084s)
[610.674952] Starting dynamic subtest: guc_hang
[613.446527] Dynamic subtest guc_hang: SUCCESS (2.778s)
[613.454372] Starting dynamic subtest: late_gt_pm
[615.604272] Dynamic subtest late_gt_pm: SUCCESS (2.156s)
[615.605455] Subtest live: SUCCESS (300.952s)
[616.079066] [165/171] (390s left) dmabuf (all-tests)
[616.168835] Starting subtest: all-tests
[616.170279] Starting dynamic subtest: sanitycheck
[616.235567] Dynamic subtest sanitycheck: SUCCESS (0.066s)
[616.251123] Starting dynamic subtest: dma_fence
[616.427995] Dynamic subtest dma_fence: SUCCESS (0.190s)
[616.455758] Starting dynamic subtest: dma_fence_chain
[630.132309] Dynamic subtest dma_fence_chain: SUCCESS (13.693s)
[630.140590] Starting dynamic subtest: dma_fence_unwrap
[630.207333] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s)
[630.239358] Starting dynamic subtest: dma_resv
[630.308892] Dynamic subtest dma_resv: SUCCESS (0.095s)
[630.316630] Subtest all-tests: SUCCESS (14.142s)
[630.358507] [166/171] (376s left) i915_suspend (basic-s2idle-without-i915)
[630.460363] Starting subtest: basic-s2idle-without-i915
[651.878793] Subtest basic-s2idle-without-i915: SUCCESS (5.766s)
[652.089595] [167/171] (370s left) i915_suspend (basic-s3-without-i915)
[652.173043] Starting subtest: basic-s3-without-i915
[654.921200] Subtest basic-s3-without-i915: SKIP (2.734s)
[655.822906] [168/171] (366s left) gem_exec_suspend (basic-s0)
[655.942639] Starting subtest: basic-S0
[655.943690] Starting dynamic subtest: smem
[676.603248] Dynamic subtest smem: SUCCESS (5.871s)
[676.632852] Starting dynamic subtest: lmem0
[696.613235] Dynamic subtest lmem0: SUCCESS (5.883s)
[696.614412] Subtest basic-S0: SUCCESS (11.759s)
[696.808455] [169/171] (354s left) gem_exec_suspend (basic-s3)
[696.915225] Starting subtest: basic-S3
[696.916228] Starting dynamic subtest: smem
[717.614004] Dynamic subtest smem: SUCCESS (5.790s)
[717.625964] Starting dynamic subtest: lmem0
[737.629151] Dynamic subtest lmem0: SUCCESS (5.781s)
[737.630259] Subtest basic-S3: SUCCESS (11.574s)
[737.834851] [170/171] (342s left) kms_chamelium_hpd (common-hpd-after-suspend)
[738.080821] Subtest common-hpd-after-suspend: SKIP (0.000s)
[738.216846] [171/171] (342s left) kms_pipe_crc_basic (suspend-read-crc)
[738.371478] Starting subtest: suspend-read-crc
[738.376116] Starting dynamic subtest: pipe-A-DP-1
[755.945260] Dynamic subtest pipe-A-DP-1: SUCCESS (2.854s)
[755.955693] Starting dynamic subtest: pipe-B-DP-1
[775.977571] Dynamic subtest pipe-B-DP-1: SUCCESS (4.705s)
[775.988685] Starting dynamic subtest: pipe-C-DP-1
[794.043199] Dynamic subtest pipe-C-DP-1: SUCCESS (2.927s)
[794.053994] Starting dynamic subtest: pipe-D-DP-1
[812.131957] Dynamic subtest pipe-D-DP-1: SUCCESS (3.146s)
[812.133040] Subtest suspend-read-crc: SUCCESS (13.644s)
[812.292536] Closing watchdogs
Done.