[39.074718] Initializing watchdogs
[39.074814]   /dev/watchdog0
[39.082430] [001/170] (960s left) i915_module_load (load)
[39.163337] Starting subtest: load
[40.516476] Subtest load: SUCCESS (1.353s)
[40.536337] [002/170] (959s left) core_auth (basic-auth)
[40.677014] Starting subtest: basic-auth
[40.678094] Subtest basic-auth: SUCCESS (0.001s)
[40.736996] [003/170] (958s left) debugfs_test (read_all_entries)
[40.837667] Starting subtest: read_all_entries
[41.334192] Subtest read_all_entries: SUCCESS (0.496s)
[41.453566] [004/170] (958s left) debugfs_test (basic-hwmon)
[41.551726] Starting subtest: basic-hwmon
[41.556402] Subtest basic-hwmon: SUCCESS (0.004s)
[41.687728] [005/170] (957s left) fbdev (eof)
[41.766701] Starting subtest: eof
[41.767732] Subtest eof: SUCCESS (0.000s)
[41.821396] [006/170] (957s left) fbdev (info)
[41.899508] Starting subtest: info
[41.900703] Subtest info: SUCCESS (0.000s)
[41.973892] [007/170] (957s left) fbdev (nullptr)
[42.066414] Starting subtest: nullptr
[42.067472] Subtest nullptr: SUCCESS (0.000s)
[42.124437] [008/170] (957s left) fbdev (read)
[42.216615] Starting subtest: read
[54.574523] Subtest read: SUCCESS (12.323s)
[54.605731] [009/170] (945s left) fbdev (write)
[54.683421] Starting subtest: write
[60.804167] Subtest write: SUCCESS (6.112s)
[60.871119] [010/170] (938s left) gem_basic (bad-close)
[60.958221] Starting subtest: bad-close
[60.960350] Subtest bad-close: SUCCESS (0.000s)
[61.021622] [011/170] (938s left) gem_basic (create-close)
[61.111301] Starting subtest: create-close
[61.113380] Subtest create-close: SUCCESS (0.000s)
[61.230824] [012/170] (938s left) gem_basic (create-fd-close)
[61.345097] Starting subtest: create-fd-close
[61.347202] Subtest create-fd-close: SUCCESS (0.000s)
[61.424415] [013/170] (938s left) gem_busy (busy@all-engines)
[61.547624] Starting subtest: busy
[61.548727] Starting dynamic subtest: all-engines
[61.676810] Dynamic subtest all-engines: SUCCESS (0.129s)
[61.677977] Subtest busy: SUCCESS (0.129s)
[62.134738] [014/170] (937s left) gem_close_race (basic-process)
[62.272551] Starting subtest: basic-process
[62.326485] Subtest basic-process: SUCCESS (0.054s)
[62.580856] [015/170] (937s left) gem_close_race (basic-threads)
[62.710041] Starting subtest: basic-threads
[63.899351] Subtest basic-threads: SUCCESS (1.189s)
[64.168926] [016/170] (935s left) gem_ctx_create (basic)
[64.295610] Starting subtest: basic
[64.296810] Subtest basic: SUCCESS (0.000s)
[64.514996] [017/170] (935s left) gem_ctx_create (basic-files)
[64.613256] Starting subtest: basic-files
[66.631083] Subtest basic-files: SUCCESS (2.018s)
[67.169753] [018/170] (932s left) gem_ctx_exec (basic)
[67.276220] Starting subtest: basic
[67.281721] Subtest basic: SUCCESS (0.006s)
[67.414810] [019/170] (932s left) gem_exec_basic (basic)
[67.527179] Starting subtest: basic
[67.528136] Starting dynamic subtest: rcs0-smem
[67.530129] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[67.537085] Starting dynamic subtest: bcs0-smem
[67.538025] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[67.544152] Starting dynamic subtest: vcs0-smem
[67.545062] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[67.550779] Starting dynamic subtest: vcs1-smem
[67.551752] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[67.557922] Starting dynamic subtest: vecs0-smem
[67.559090] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[67.564908] Starting dynamic subtest: vecs1-smem
[67.566059] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[67.571728] Starting dynamic subtest: ccs0-smem
[67.572635] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[67.578447] Starting dynamic subtest: ccs1-smem
[67.579593] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[67.585449] Starting dynamic subtest: ccs2-smem
[67.586597] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[67.592434] Starting dynamic subtest: ccs3-smem
[67.593552] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[67.599409] Starting dynamic subtest: rcs0-lmem0
[67.600513] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[67.606357] Starting dynamic subtest: bcs0-lmem0
[67.607525] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[67.613414] Starting dynamic subtest: vcs0-lmem0
[67.614512] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[67.620508] Starting dynamic subtest: vcs1-lmem0
[67.621643] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[67.627475] Starting dynamic subtest: vecs0-lmem0
[67.628585] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[67.634376] Starting dynamic subtest: vecs1-lmem0
[67.635519] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[67.641259] Starting dynamic subtest: ccs0-lmem0
[67.642285] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[67.648811] Starting dynamic subtest: ccs1-lmem0
[67.649871] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[67.655576] Starting dynamic subtest: ccs2-lmem0
[67.656710] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[67.662420] Starting dynamic subtest: ccs3-lmem0
[67.663433] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[67.664387] Subtest basic: SUCCESS (0.014s)
[67.725715] [020/170] (932s left) gem_exec_create (basic)
[67.829391] Starting subtest: basic
[67.830491] Starting dynamic subtest: smem
[69.931766] Dynamic subtest smem: SUCCESS (2.102s)
[69.937752] Starting dynamic subtest: lmem0
[72.044185] Dynamic subtest lmem0: SUCCESS (2.112s)
[72.045332] Subtest basic: SUCCESS (4.215s)
[72.236035] [021/170] (927s left) gem_exec_fence (basic-busy)
[72.510111] Starting subtest: basic-busy
[72.511044] Starting dynamic subtest: rcs0
[72.597644] Dynamic subtest rcs0: SUCCESS (0.096s)
[72.608488] Starting dynamic subtest: bcs0
[72.658223] Dynamic subtest bcs0: SUCCESS (0.059s)
[72.684569] Starting dynamic subtest: vcs0
[72.715358] Dynamic subtest vcs0: SUCCESS (0.057s)
[72.740617] Starting dynamic subtest: vcs1
[72.771642] Dynamic subtest vcs1: SUCCESS (0.056s)
[72.792721] Starting dynamic subtest: vecs0
[72.829540] Dynamic subtest vecs0: SUCCESS (0.057s)
[72.855415] Starting dynamic subtest: vecs1
[72.893223] Dynamic subtest vecs1: SUCCESS (0.063s)
[72.918502] Starting dynamic subtest: ccs0
[72.955539] Dynamic subtest ccs0: SUCCESS (0.062s)
[72.981437] Starting dynamic subtest: ccs1
[73.020415] Dynamic subtest ccs1: SUCCESS (0.064s)
[73.046667] Starting dynamic subtest: ccs2
[73.079076] Dynamic subtest ccs2: SUCCESS (0.058s)
[73.102587] Starting dynamic subtest: ccs3
[73.141241] Dynamic subtest ccs3: SUCCESS (0.062s)
[73.143486] Subtest basic-busy: SUCCESS (0.639s)
[73.845088] [022/170] (926s left) gem_exec_fence (basic-wait)
[74.097717] Starting subtest: basic-wait
[74.098783] Starting dynamic subtest: rcs0
[74.201395] Dynamic subtest rcs0: SUCCESS (0.111s)
[74.211612] Starting dynamic subtest: bcs0
[74.259210] Dynamic subtest bcs0: SUCCESS (0.058s)
[74.276814] Starting dynamic subtest: vcs0
[74.318506] Dynamic subtest vcs0: SUCCESS (0.058s)
[74.345295] Starting dynamic subtest: vcs1
[74.381951] Dynamic subtest vcs1: SUCCESS (0.063s)
[74.398994] Starting dynamic subtest: vecs0
[74.433435] Dynamic subtest vecs0: SUCCESS (0.051s)
[74.460163] Starting dynamic subtest: vecs1
[74.497145] Dynamic subtest vecs1: SUCCESS (0.063s)
[74.523300] Starting dynamic subtest: ccs0
[74.559576] Dynamic subtest ccs0: SUCCESS (0.062s)
[74.576461] Starting dynamic subtest: ccs1
[74.615448] Dynamic subtest ccs1: SUCCESS (0.055s)
[74.641905] Starting dynamic subtest: ccs2
[74.681146] Dynamic subtest ccs2: SUCCESS (0.065s)
[74.704943] Starting dynamic subtest: ccs3
[74.743329] Dynamic subtest ccs3: SUCCESS (0.062s)
[74.745652] Subtest basic-wait: SUCCESS (0.653s)
[75.346615] [023/170] (924s left) gem_exec_fence (basic-await)
[75.634241] Starting subtest: basic-await
[75.635537] Starting dynamic subtest: rcs0
[75.775214] Dynamic subtest rcs0: SUCCESS (0.150s)
[75.781671] Starting dynamic subtest: bcs0
[75.889088] Dynamic subtest bcs0: SUCCESS (0.114s)
[75.895230] Starting dynamic subtest: vcs0
[76.003429] Dynamic subtest vcs0: SUCCESS (0.114s)
[76.017467] Starting dynamic subtest: vcs1
[76.131794] Dynamic subtest vcs1: SUCCESS (0.129s)
[76.138080] Starting dynamic subtest: vecs0
[76.244431] Dynamic subtest vecs0: SUCCESS (0.112s)
[76.250649] Starting dynamic subtest: vecs1
[76.358319] Dynamic subtest vecs1: SUCCESS (0.114s)
[76.367735] Starting dynamic subtest: ccs0
[76.478687] Dynamic subtest ccs0: SUCCESS (0.120s)
[76.485783] Starting dynamic subtest: ccs1
[76.595411] Dynamic subtest ccs1: SUCCESS (0.117s)
[76.602044] Starting dynamic subtest: ccs2
[76.713055] Dynamic subtest ccs2: SUCCESS (0.117s)
[76.720715] Starting dynamic subtest: ccs3
[76.830569] Dynamic subtest ccs3: SUCCESS (0.117s)
[76.831585] Subtest basic-await: SUCCESS (1.205s)
[77.504566] [024/170] (922s left) gem_exec_fence (nb-await)
[77.790117] Starting subtest: nb-await
[77.791187] Starting dynamic subtest: rcs0
[77.892590] Dynamic subtest rcs0: SUCCESS (0.104s)
[77.900534] Starting dynamic subtest: bcs0
[77.958272] Dynamic subtest bcs0: SUCCESS (0.069s)
[77.971354] Starting dynamic subtest: vcs0
[78.046593] Dynamic subtest vcs0: SUCCESS (0.087s)
[78.056879] Starting dynamic subtest: vcs1
[78.118274] Dynamic subtest vcs1: SUCCESS (0.073s)
[78.131524] Starting dynamic subtest: vecs0
[78.206289] Dynamic subtest vecs0: SUCCESS (0.087s)
[78.232998] Starting dynamic subtest: vecs1
[78.310127] Dynamic subtest vecs1: SUCCESS (0.105s)
[78.320650] Starting dynamic subtest: ccs0
[78.393077] Dynamic subtest ccs0: SUCCESS (0.082s)
[78.399694] Starting dynamic subtest: ccs1
[78.461449] Dynamic subtest ccs1: SUCCESS (0.069s)
[78.475286] Starting dynamic subtest: ccs2
[78.547534] Dynamic subtest ccs2: SUCCESS (0.085s)
[78.557588] Starting dynamic subtest: ccs3
[78.619271] Dynamic subtest ccs3: SUCCESS (0.072s)
[78.620602] Subtest nb-await: SUCCESS (0.835s)
[79.287761] [025/170] (920s left) gem_exec_gttfill (basic)
[79.414287] Starting subtest: basic
[86.604880] Subtest basic: SUCCESS (7.182s)
[86.853503] [026/170] (913s left) gem_exec_parallel (engines)
[87.008051] Starting subtest: engines
[87.008990] Starting dynamic subtest: basic
[89.060623] Dynamic subtest basic: SUCCESS (2.051s)
[89.090680] Starting dynamic subtest: contexts
[92.240937] Dynamic subtest contexts: SUCCESS (3.181s)
[92.247943] Starting dynamic subtest: fds
[95.567529] Dynamic subtest fds: SUCCESS (3.318s)
[95.574289] Starting dynamic subtest: userptr
[97.362412] Dynamic subtest userptr: SUCCESS (1.803s)
[97.363519] Subtest engines: SUCCESS (10.354s)
[97.648755] [027/170] (902s left) gem_exec_store (basic)
[97.771196] Starting subtest: basic
[97.930240] Subtest basic: SUCCESS (0.158s)
[98.173555] [028/170] (901s left) gem_flink_basic (bad-flink)
[98.278153] Starting subtest: bad-flink
[98.279131] Subtest bad-flink: SUCCESS (0.000s)
[98.348169] [029/170] (901s left) gem_flink_basic (bad-open)
[98.443935] Starting subtest: bad-open
[98.444966] Subtest bad-open: SUCCESS (0.000s)
[98.515882] [030/170] (901s left) gem_flink_basic (basic)
[98.611127] Starting subtest: basic
[98.612133] Subtest basic: SUCCESS (0.000s)
[98.714758] [031/170] (901s left) gem_flink_basic (double-flink)
[98.830133] Starting subtest: double-flink
[98.831139] Subtest double-flink: SUCCESS (0.000s)
[98.940734] [032/170] (901s left) gem_flink_basic (flink-lifetime)
[99.040264] Starting subtest: flink-lifetime
[99.042440] Subtest flink-lifetime: SUCCESS (0.002s)
[99.171113] [033/170] (901s left) gem_huc_copy (huc-copy)
[99.310772] Starting subtest: huc-copy
[99.317805] Subtest huc-copy: SUCCESS (0.007s)
[99.455621] [034/170] (900s left) gem_linear_blits (basic)
[99.662698] Starting subtest: basic
[99.700637] Subtest basic: SUCCESS (0.038s)
[99.853467] [035/170] (900s left) gem_mmap (basic)
[100.000382] Subtest basic: SKIP (0.000s)
[100.026570] [036/170] (900s left) gem_mmap_gtt (basic)
[100.119135] Subtest basic: SKIP (0.000s)
[100.143274] [037/170] (900s left) gem_render_linear_blits (basic)
[100.243842] Starting subtest: basic
[100.327794] Subtest basic: SUCCESS (0.084s)
[100.411908] [038/170] (899s left) gem_render_tiled_blits (basic)
[100.525271] Subtest basic: SKIP (0.000s)
[100.559595] [039/170] (899s left) gem_ringfill (basic-all)
[101.008850] Starting subtest: basic-all
[102.452297] Subtest basic-all: SUCCESS (1.438s)
[102.585502] [040/170] (897s left) gem_softpin (allocator-basic)
[102.712063] Starting subtest: allocator-basic
[102.973808] Subtest allocator-basic: SUCCESS (0.253s)
[103.102824] [041/170] (897s left) gem_softpin (allocator-basic-reserve)
[103.237174] Starting subtest: allocator-basic-reserve
[103.509428] Subtest allocator-basic-reserve: SUCCESS (0.264s)
[103.636457] [042/170] (896s left) gem_softpin (safe-alignment)
[103.739902] Starting subtest: safe-alignment
[103.813130] Subtest safe-alignment: SUCCESS (0.073s)
[103.957037] [043/170] (896s left) gem_sync (basic-all)
[104.084245] Starting subtest: basic-all
[108.080373] Subtest basic-all: SUCCESS (3.996s)
[108.278116] [044/170] (892s left) gem_sync (basic-each)
[108.384183] Starting subtest: basic-each
[111.141999] Subtest basic-each: SUCCESS (2.757s)
[111.369055] [045/170] (889s left) gem_tiled_blits (basic)
[111.481285] Subtest basic: SKIP (0.000s)
[111.510048] [046/170] (888s left) gem_tiled_fence_blits (basic)
[111.609060] Subtest basic: SKIP (0.000s)
[111.643283] [047/170] (888s left) gem_tiled_pread_basic
[111.760062] [048/170] (888s left) gem_wait (busy@all-engines)
[111.873700] Starting subtest: busy
[111.874768] Starting dynamic subtest: all-engines
[112.474599] Dynamic subtest all-engines: SUCCESS (0.600s)
[112.476771] Subtest busy: SUCCESS (0.600s)
[112.750197] [049/170] (887s left) gem_wait (wait@all-engines)
[112.860216] Starting subtest: wait
[112.861254] Starting dynamic subtest: all-engines
[113.968809] Dynamic subtest all-engines: SUCCESS (1.107s)
[113.971323] Subtest wait: SUCCESS (1.107s)
[114.266954] [050/170] (886s left) i915_getparams_basic (basic-eu-total)
[114.357124] Starting subtest: basic-eu-total
[114.359112] Subtest basic-eu-total: SUCCESS (0.000s)
[114.428039] [051/170] (886s left) i915_getparams_basic (basic-subslice-total)
[114.528289] Starting subtest: basic-subslice-total
[114.530258] Subtest basic-subslice-total: SUCCESS (0.000s)
[114.589724] [052/170] (886s left) i915_hangman (error-state-basic)
[114.704882] Starting subtest: error-state-basic
[114.903170] Subtest error-state-basic: SUCCESS (0.198s)
[114.976097] [053/170] (885s left) i915_pciid
[115.150447] [054/170] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[115.260245] Starting subtest: addfb25-bad-modifier
[115.261434] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[115.407105] [055/170] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[115.500762] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[115.640804] [056/170] (885s left) kms_addfb_basic (addfb25-modifier-no-flag)
[115.733853] Starting subtest: addfb25-modifier-no-flag
[115.734759] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[115.876623] [057/170] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[115.969384] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[116.123749] [058/170] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[116.218072] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[116.373895] [059/170] (884s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[116.529760] Starting subtest: addfb25-yf-tiled-legacy
[116.530836] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[116.623536] [060/170] (884s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[116.779439] Starting subtest: addfb25-y-tiled-legacy
[116.780488] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[116.857083] [061/170] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[117.008663] Starting subtest: addfb25-y-tiled-small-legacy
[117.010770] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[117.090434] [062/170] (883s left) kms_addfb_basic (bad-pitch-0)
[117.182243] Starting subtest: bad-pitch-0
[117.183315] Subtest bad-pitch-0: SUCCESS (0.000s)
[117.323951] [063/170] (883s left) kms_addfb_basic (bad-pitch-1024)
[117.416207] Starting subtest: bad-pitch-1024
[117.417227] Subtest bad-pitch-1024: SUCCESS (0.000s)
[117.556859] [064/170] (883s left) kms_addfb_basic (bad-pitch-128)
[117.648352] Starting subtest: bad-pitch-128
[117.649420] Subtest bad-pitch-128: SUCCESS (0.000s)
[117.790704] [065/170] (883s left) kms_addfb_basic (bad-pitch-256)
[117.882120] Starting subtest: bad-pitch-256
[117.883059] Subtest bad-pitch-256: SUCCESS (0.000s)
[118.040708] [066/170] (882s left) kms_addfb_basic (bad-pitch-32)
[118.133363] Starting subtest: bad-pitch-32
[118.134457] Subtest bad-pitch-32: SUCCESS (0.000s)
[118.290444] [067/170] (882s left) kms_addfb_basic (bad-pitch-63)
[118.381384] Starting subtest: bad-pitch-63
[118.382440] Subtest bad-pitch-63: SUCCESS (0.000s)
[118.523938] [068/170] (882s left) kms_addfb_basic (bad-pitch-65536)
[118.616193] Starting subtest: bad-pitch-65536
[118.617233] Subtest bad-pitch-65536: SUCCESS (0.000s)
[118.757086] [069/170] (882s left) kms_addfb_basic (bad-pitch-999)
[118.850478] Starting subtest: bad-pitch-999
[118.851507] Subtest bad-pitch-999: SUCCESS (0.000s)
[119.007277] [070/170] (881s left) kms_addfb_basic (basic)
[119.099179] Starting subtest: basic
[119.100243] Subtest basic: SUCCESS (0.000s)
[119.257193] [071/170] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[119.350176] Starting subtest: basic-x-tiled-legacy
[119.352176] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[119.490907] [072/170] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[119.585147] Starting subtest: basic-y-tiled-legacy
[119.587119] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[119.723994] [073/170] (881s left) kms_addfb_basic (bo-too-small)
[119.878072] Starting subtest: bo-too-small
[119.879131] Subtest bo-too-small: SUCCESS (0.000s)
[119.957270] [074/170] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[120.113052] Starting subtest: bo-too-small-due-to-tiling
[120.115022] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[120.190518] [075/170] (880s left) kms_addfb_basic (clobberred-modifier)
[120.282166] Starting subtest: clobberred-modifier
[120.284185] Subtest clobberred-modifier: SKIP (0.000s)
[120.423938] [076/170] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[120.516136] Starting subtest: framebuffer-vs-set-tiling
[120.518142] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[120.673817] [077/170] (880s left) kms_addfb_basic (invalid-get-prop)
[120.766502] Starting subtest: invalid-get-prop
[120.767534] Subtest invalid-get-prop: SUCCESS (0.000s)
[120.907275] [078/170] (880s left) kms_addfb_basic (invalid-get-prop-any)
[120.997962] Starting subtest: invalid-get-prop-any
[120.999034] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[121.140487] [079/170] (879s left) kms_addfb_basic (invalid-set-prop)
[121.232157] Starting subtest: invalid-set-prop
[121.233206] Subtest invalid-set-prop: SUCCESS (0.000s)
[121.373684] [080/170] (879s left) kms_addfb_basic (invalid-set-prop-any)
[121.468013] Starting subtest: invalid-set-prop-any
[121.468973] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[121.623919] [081/170] (879s left) kms_addfb_basic (no-handle)
[121.715310] Starting subtest: no-handle
[121.716394] Subtest no-handle: SUCCESS (0.000s)
[121.857176] [082/170] (879s left) kms_addfb_basic (size-max)
[122.012564] Starting subtest: size-max
[122.013530] Subtest size-max: SUCCESS (0.000s)
[122.090596] [083/170] (879s left) kms_addfb_basic (small-bo)
[122.245875] Starting subtest: small-bo
[122.246959] Subtest small-bo: SUCCESS (0.000s)
[122.324010] [084/170] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[122.417170] Starting subtest: tile-pitch-mismatch
[122.419185] Subtest tile-pitch-mismatch: SKIP (0.000s)
[122.574337] [085/170] (878s left) kms_addfb_basic (too-high)
[122.730652] Starting subtest: too-high
[122.731612] Subtest too-high: SUCCESS (0.001s)
[122.807334] [086/170] (878s left) kms_addfb_basic (too-wide)
[122.963882] Starting subtest: too-wide
[122.964968] Subtest too-wide: SUCCESS (0.000s)
[123.057453] [087/170] (878s left) kms_addfb_basic (unused-handle)
[123.149362] Starting subtest: unused-handle
[123.150406] Subtest unused-handle: SUCCESS (0.000s)
[123.307350] [088/170] (877s left) kms_addfb_basic (unused-modifier)
[123.398951] Starting subtest: unused-modifier
[123.400031] Subtest unused-modifier: SUCCESS (0.000s)
[123.557306] [089/170] (877s left) kms_addfb_basic (unused-offsets)
[123.649361] Starting subtest: unused-offsets
[123.650428] Subtest unused-offsets: SUCCESS (0.000s)
[123.790723] [090/170] (877s left) kms_addfb_basic (unused-pitches)
[123.883118] Starting subtest: unused-pitches
[123.884160] Subtest unused-pitches: SUCCESS (0.000s)
[124.040941] [091/170] (877s left) kms_busy (basic)
[124.210546] Starting subtest: basic
[124.211625] Starting dynamic subtest: flip
[124.993140] Dynamic subtest flip: SUCCESS (0.782s)
[125.003031] Starting dynamic subtest: modeset
[125.949125] Dynamic subtest modeset: SUCCESS (0.955s)
[125.950213] Subtest basic: SUCCESS (1.738s)
[126.197404] [092/170] (875s left) kms_chamelium_hpd (dp-hpd-fast)
[126.431268] Subtest dp-hpd-fast: SKIP (0.000s)
[126.567967] [093/170] (874s left) kms_chamelium_edid (dp-edid-read)
[126.812301] Subtest dp-edid-read: SKIP (0.000s)
[126.948329] [094/170] (874s left) kms_chamelium_frames (dp-crc-fast)
[127.176137] Subtest dp-crc-fast: SKIP (0.000s)
[127.311271] [095/170] (873s left) kms_chamelium_hpd (hdmi-hpd-fast)
[127.539784] Subtest hdmi-hpd-fast: SKIP (0.000s)
[127.674640] [096/170] (873s left) kms_chamelium_edid (hdmi-edid-read)
[127.901577] Subtest hdmi-edid-read: SKIP (0.000s)
[128.033629] [097/170] (873s left) kms_chamelium_frames (hdmi-crc-fast)
[128.264321] Subtest hdmi-crc-fast: SKIP (0.000s)
[128.400583] [098/170] (872s left) kms_chamelium_hpd (vga-hpd-fast)
[128.628608] Subtest vga-hpd-fast: SKIP (0.000s)
[128.763608] [099/170] (872s left) kms_chamelium_edid (vga-edid-read)
[128.992131] Subtest vga-edid-read: SKIP (0.000s)
[129.125810] [100/170] (872s left) kms_prop_blob (basic)
[129.222318] Starting subtest: basic
[129.223369] Subtest basic: SUCCESS (0.000s)
[129.286391] [101/170] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[129.455783] Starting subtest: basic-busy-flip-before-cursor-atomic
[129.457873] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[129.517549] [102/170] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[129.670897] Starting subtest: basic-busy-flip-before-cursor-legacy
[129.672975] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[129.734208] [103/170] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[129.888377] Starting subtest: basic-flip-after-cursor-atomic
[130.952521] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.065s)
[131.163733] [104/170] (870s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[131.317061] Starting subtest: basic-flip-after-cursor-legacy
[132.381348] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.064s)
[132.594405] [105/170] (868s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[132.748952] Starting subtest: basic-flip-after-cursor-varying-size
[133.827247] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.080s)
[134.049904] [106/170] (867s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[134.202946] Starting subtest: basic-flip-before-cursor-atomic
[135.249595] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.048s)
[135.461320] [107/170] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[135.615166] Starting subtest: basic-flip-before-cursor-legacy
[136.677618] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.064s)
[136.883008] [108/170] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[137.037746] Starting subtest: basic-flip-before-cursor-varying-size
[138.117852] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.080s)
[138.330129] [109/170] (863s left) kms_flip (basic-flip-vs-dpms)
[138.470266] Starting subtest: basic-flip-vs-dpms
[138.475768] Starting dynamic subtest: A-DP1
[139.545584] Dynamic subtest A-DP1: SUCCESS (1.070s)
[139.553969] Starting dynamic subtest: B-DP1
[140.442079] Dynamic subtest B-DP1: SUCCESS (0.896s)
[140.450015] Starting dynamic subtest: C-DP1
[141.363116] Dynamic subtest C-DP1: SUCCESS (0.920s)
[141.371419] Starting dynamic subtest: D-DP1
[142.246431] Dynamic subtest D-DP1: SUCCESS (0.882s)
[142.250781] Subtest basic-flip-vs-dpms: SUCCESS (3.781s)
[142.475468] [110/170] (859s left) kms_flip (basic-flip-vs-modeset)
[142.613201] Starting subtest: basic-flip-vs-modeset
[142.618872] Starting dynamic subtest: A-DP1
[143.696933] Dynamic subtest A-DP1: SUCCESS (1.077s)
[143.704895] Starting dynamic subtest: B-DP1
[144.587755] Dynamic subtest B-DP1: SUCCESS (0.891s)
[144.598540] Starting dynamic subtest: C-DP1
[145.484377] Dynamic subtest C-DP1: SUCCESS (0.895s)
[145.492371] Starting dynamic subtest: D-DP1
[146.415514] Dynamic subtest D-DP1: SUCCESS (0.931s)
[146.419811] Subtest basic-flip-vs-modeset: SUCCESS (3.807s)
[146.626489] [111/170] (854s left) kms_flip (basic-flip-vs-wf_vblank)
[146.770035] Starting subtest: basic-flip-vs-wf_vblank
[146.775282] Starting dynamic subtest: A-DP1
[147.975838] Dynamic subtest A-DP1: SUCCESS (1.201s)
[147.984088] Starting dynamic subtest: B-DP1
[149.127921] Dynamic subtest B-DP1: SUCCESS (1.151s)
[149.136164] Starting dynamic subtest: C-DP1
[150.277673] Dynamic subtest C-DP1: SUCCESS (1.149s)
[150.285717] Starting dynamic subtest: D-DP1
[151.393114] Dynamic subtest D-DP1: SUCCESS (1.115s)
[151.398154] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.629s)
[151.647379] [112/170] (849s left) kms_flip (basic-plain-flip)
[151.786480] Starting subtest: basic-plain-flip
[151.790667] Starting dynamic subtest: A-DP1
[152.707848] Dynamic subtest A-DP1: SUCCESS (0.917s)
[152.717774] Starting dynamic subtest: B-DP1
[153.546864] Dynamic subtest B-DP1: SUCCESS (0.838s)
[153.555172] Starting dynamic subtest: C-DP1
[154.383863] Dynamic subtest C-DP1: SUCCESS (0.836s)
[154.393253] Starting dynamic subtest: D-DP1
[155.239643] Dynamic subtest D-DP1: SUCCESS (0.850s)
[155.259624] Subtest basic-plain-flip: SUCCESS (3.475s)
[155.516113] [113/170] (846s left) kms_force_connector_basic (force-connector-state)
[155.613308] Starting subtest: force-connector-state
[156.179854] Subtest force-connector-state: SUCCESS (0.565s)
[156.453163] [114/170] (845s left) kms_force_connector_basic (force-edid)
[156.550351] Starting subtest: force-edid
[156.566719] Subtest force-edid: SUCCESS (0.017s)
[156.737202] [115/170] (844s left) kms_force_connector_basic (force-load-detect)
[156.833986] Starting subtest: force-load-detect
[156.835686] Subtest force-load-detect: SKIP (0.000s)
[156.952924] [116/170] (844s left) kms_force_connector_basic (prune-stale-modes)
[157.049464] Starting subtest: prune-stale-modes
[157.059042] Subtest prune-stale-modes: SKIP (0.009s)
[157.220100] [117/170] (844s left) kms_frontbuffer_tracking (basic)
[157.382750] Starting subtest: basic
[161.764175] Subtest basic: SUCCESS (4.383s)
[161.875289] [118/170] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[162.033829] Starting subtest: compare-crc-sanitycheck
[162.034910] Starting dynamic subtest: pipe-A-DP-1
[162.605302] Dynamic subtest pipe-A-DP-1: SUCCESS (0.570s)
[162.614362] Starting dynamic subtest: pipe-B-DP-1
[163.171293] Dynamic subtest pipe-B-DP-1: SUCCESS (0.563s)
[163.179540] Starting dynamic subtest: pipe-C-DP-1
[163.829487] Dynamic subtest pipe-C-DP-1: SUCCESS (0.657s)
[163.838222] Starting dynamic subtest: pipe-D-DP-1
[164.512676] Dynamic subtest pipe-D-DP-1: SUCCESS (0.680s)
[164.513734] Subtest compare-crc-sanitycheck: SUCCESS (2.480s)
[164.712679] [119/170] (837s left) kms_pipe_crc_basic (hang-read-crc)
[164.868825] Starting subtest: hang-read-crc
[164.871602] Starting dynamic subtest: pipe-A-DP-1
[166.373086] Dynamic subtest pipe-A-DP-1: SUCCESS (1.502s)
[166.382207] Starting dynamic subtest: pipe-B-DP-1
[167.924544] Dynamic subtest pipe-B-DP-1: SUCCESS (1.549s)
[167.933609] Starting dynamic subtest: pipe-C-DP-1
[169.595679] Dynamic subtest pipe-C-DP-1: SUCCESS (1.668s)
[169.604405] Starting dynamic subtest: pipe-D-DP-1
[171.389636] Dynamic subtest pipe-D-DP-1: SUCCESS (1.792s)
[171.390880] Subtest hang-read-crc: SUCCESS (6.521s)
[171.584353] [120/170] (830s left) kms_pipe_crc_basic (nonblocking-crc)
[171.744214] Starting subtest: nonblocking-crc
[171.746803] Starting dynamic subtest: pipe-A-DP-1
[172.434696] Dynamic subtest pipe-A-DP-1: SUCCESS (0.687s)
[172.442826] Starting dynamic subtest: pipe-B-DP-1
[173.150638] Dynamic subtest pipe-B-DP-1: SUCCESS (0.714s)
[173.160545] Starting dynamic subtest: pipe-C-DP-1
[173.962121] Dynamic subtest pipe-C-DP-1: FAIL (0.747s)
[173.969881] Starting dynamic subtest: pipe-D-DP-1
[174.793065] Dynamic subtest pipe-D-DP-1: SUCCESS (0.889s)
[174.794133] Subtest nonblocking-crc: FAIL (3.048s)
[174.985336] [121/170] (826s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[175.141014] Starting subtest: nonblocking-crc-frame-sequence
[175.142135] Starting dynamic subtest: pipe-A-DP-1
[175.851207] Dynamic subtest pipe-A-DP-1: SUCCESS (0.709s)
[175.860060] Starting dynamic subtest: pipe-B-DP-1
[176.573392] Dynamic subtest pipe-B-DP-1: SUCCESS (0.718s)
[176.581996] Starting dynamic subtest: pipe-C-DP-1
[177.348769] Dynamic subtest pipe-C-DP-1: SUCCESS (0.773s)
[177.357588] Starting dynamic subtest: pipe-D-DP-1
[178.226068] Dynamic subtest pipe-D-DP-1: SUCCESS (0.874s)
[178.226996] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.085s)
[178.423298] [122/170] (823s left) kms_pipe_crc_basic (read-crc)
[178.578827] Starting subtest: read-crc
[178.581572] Starting dynamic subtest: pipe-A-DP-1
[179.224540] Dynamic subtest pipe-A-DP-1: SUCCESS (0.643s)
[179.232857] Starting dynamic subtest: pipe-B-DP-1
[179.872522] Dynamic subtest pipe-B-DP-1: SUCCESS (0.646s)
[179.881764] Starting dynamic subtest: pipe-C-DP-1
[180.603609] Dynamic subtest pipe-C-DP-1: SUCCESS (0.728s)
[180.612793] Starting dynamic subtest: pipe-D-DP-1
[181.381414] Dynamic subtest pipe-D-DP-1: SUCCESS (0.774s)
[181.382439] Subtest read-crc: SUCCESS (2.801s)
[181.580085] [123/170] (820s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[181.735995] Starting subtest: read-crc-frame-sequence
[181.737015] Starting dynamic subtest: pipe-A-DP-1
[182.363730] Dynamic subtest pipe-A-DP-1: SUCCESS (0.626s)
[182.372635] Starting dynamic subtest: pipe-B-DP-1
[183.015795] Dynamic subtest pipe-B-DP-1: SUCCESS (0.649s)
[183.024398] Starting dynamic subtest: pipe-C-DP-1
[183.734850] Dynamic subtest pipe-C-DP-1: SUCCESS (0.716s)
[183.742978] Starting dynamic subtest: pipe-D-DP-1
[184.510166] Dynamic subtest pipe-D-DP-1: SUCCESS (0.773s)
[184.511093] Subtest read-crc-frame-sequence: SUCCESS (2.774s)
[184.708107] [124/170] (817s left) kms_psr (primary_page_flip)
[184.804254] Subtest primary_page_flip: SKIP (0.000s)
[184.844298] [125/170] (817s left) kms_psr (cursor_plane_move)
[184.937858] Subtest cursor_plane_move: SKIP (0.000s)
[184.961143] [126/170] (816s left) kms_psr (sprite_plane_onoff)
[185.054589] Subtest sprite_plane_onoff: SKIP (0.000s)
[185.094395] [127/170] (816s left) kms_psr (primary_mmap_gtt)
[185.190692] Subtest primary_mmap_gtt: SKIP (0.000s)
[185.227735] [128/170] (816s left) kms_setmode (basic-clone-single-crtc)
[185.322558] Starting subtest: basic-clone-single-crtc
[185.325636] Subtest basic-clone-single-crtc: SKIP (0.001s)
[185.392952] [129/170] (816s left) i915_pm_backlight (basic-brightness)
[185.551460] Subtest basic-brightness: SKIP (0.000s)
[185.577973] [130/170] (816s left) i915_pm_rpm (basic-pci-d3-state)
[187.483130] Starting subtest: basic-pci-d3-state
[188.393401] Subtest basic-pci-d3-state: SUCCESS (0.911s)
[188.533473] [131/170] (813s left) i915_pm_rpm (basic-rte)
[188.609664] Starting subtest: basic-rte
[191.436032] Subtest basic-rte: SUCCESS (2.825s)
[192.382261] [132/170] (809s left) i915_pm_rps (basic-api)
[192.485030] Starting subtest: basic-api
[192.487135] Subtest basic-api: SKIP (0.000s)
[192.548348] [133/170] (809s left) prime_self_import (basic-llseek-bad)
[192.625215] Starting subtest: basic-llseek-bad
[192.642581] Subtest basic-llseek-bad: SUCCESS (0.018s)
[192.717362] [134/170] (809s left) prime_self_import (basic-llseek-size)
[192.793046] Starting subtest: basic-llseek-size
[192.812193] Subtest basic-llseek-size: SUCCESS (0.018s)
[192.912453] [135/170] (809s left) prime_self_import (basic-with_fd_dup)
[193.011086] Starting subtest: basic-with_fd_dup
[193.031999] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[193.119389] [136/170] (808s left) prime_self_import (basic-with_one_bo)
[193.201748] Starting subtest: basic-with_one_bo
[193.221394] Subtest basic-with_one_bo: SUCCESS (0.019s)
[193.284665] [137/170] (808s left) prime_self_import (basic-with_one_bo_two_files)
[193.359063] Starting subtest: basic-with_one_bo_two_files
[193.379236] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s)
[193.496404] [138/170] (808s left) prime_self_import (basic-with_two_bos)
[193.603135] Starting subtest: basic-with_two_bos
[193.621077] Subtest basic-with_two_bos: SUCCESS (0.019s)
[193.735334] [139/170] (808s left) prime_vgem (basic-fence-flip)
[193.882336] Starting subtest: basic-fence-flip
[193.992508] Subtest basic-fence-flip: SKIP (0.109s)
[194.114927] [140/170] (808s left) prime_vgem (basic-fence-mmap)
[194.232465] Starting subtest: basic-fence-mmap
[194.234547] Subtest basic-fence-mmap: SKIP (0.000s)
[194.352682] [141/170] (807s left) prime_vgem (basic-fence-read)
[194.465559] Starting subtest: basic-fence-read
[194.473174] Subtest basic-fence-read: SKIP (0.006s)
[194.581970] [142/170] (807s left) prime_vgem (basic-gtt)
[194.715168] Starting subtest: basic-gtt
[194.717258] Subtest basic-gtt: SKIP (0.000s)
[194.846634] [143/170] (807s left) prime_vgem (basic-read)
[194.982345] Starting subtest: basic-read
[194.989204] Subtest basic-read: SKIP (0.006s)
[195.081979] [144/170] (807s left) prime_vgem (basic-write)
[195.199140] Starting subtest: basic-write
[195.206106] Subtest basic-write: SKIP (0.006s)
[195.321851] [145/170] (806s left) vgem_basic (setversion)
[195.424543] Starting subtest: setversion
[195.426514] Subtest setversion: SUCCESS (0.000s)
[195.496817] [146/170] (806s left) vgem_basic (create)
[195.591375] Starting subtest: create
[195.592489] Subtest create: SUCCESS (0.000s)
[195.650635] [147/170] (806s left) vgem_basic (debugfs)
[195.741216] Starting subtest: debugfs
[195.742280] Subtest debugfs: SUCCESS (0.000s)
[195.798838] [148/170] (806s left) vgem_basic (dmabuf-export)
[195.891356] Starting subtest: dmabuf-export
[195.908579] Subtest dmabuf-export: SUCCESS (0.017s)
[196.036827] [149/170] (806s left) vgem_basic (dmabuf-fence)
[196.141315] Starting subtest: dmabuf-fence
[196.142368] Subtest dmabuf-fence: SUCCESS (0.000s)
[196.199479] [150/170] (806s left) vgem_basic (dmabuf-fence-before)
[196.291406] Starting subtest: dmabuf-fence-before
[196.292579] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[196.351107] [151/170] (806s left) vgem_basic (dmabuf-mmap)
[196.441398] Starting subtest: dmabuf-mmap
[196.454806] Subtest dmabuf-mmap: SUCCESS (0.014s)
[196.521080] [152/170] (805s left) vgem_basic (mmap)
[196.624499] Starting subtest: mmap
[196.633045] Subtest mmap: SUCCESS (0.009s)
[196.701166] [153/170] (805s left) vgem_basic (second-client)
[196.791300] Starting subtest: second-client
[196.840471] Subtest second-client: SUCCESS (0.049s)
[196.933441] [154/170] (805s left) vgem_basic (sysfs)
[197.024463] Starting subtest: sysfs
[197.025537] Subtest sysfs: SUCCESS (0.000s)
[197.092114] [155/170] (805s left) core_hotunplug (unbind-rebind)
[197.240966] Starting subtest: unbind-rebind
[200.058219] Subtest unbind-rebind: SUCCESS (2.817s)
[200.078131] [156/170] (802s left) vgem_basic (unload)
[200.157602] Starting subtest: unload
[229.171398] Subtest unload: SUCCESS (28.979s)
[229.251449] [157/170] (773s left) i915_module_load (reload)
[229.327080] Starting subtest: reload
[233.003115] Subtest reload: SUCCESS (3.676s)
[233.021403] [158/170] (769s left) gem_lmem_swapping (basic)
[236.895913] Starting subtest: basic
[236.896872] Starting dynamic subtest: lmem0
[264.434494] Dynamic subtest lmem0: SUCCESS (27.531s)
[264.435490] Subtest basic: SUCCESS (27.532s)
[267.049508] [159/170] (735s left) gem_lmem_swapping (parallel-random-engines)
[267.987093] Starting subtest: parallel-random-engines
[267.988095] Starting dynamic subtest: lmem0
[269.506224] Dynamic subtest lmem0: SUCCESS (1.510s)
[269.507325] Subtest parallel-random-engines: SUCCESS (1.511s)
[271.070617] [160/170] (731s left) gem_lmem_swapping (random-engines)
[272.031421] Starting subtest: random-engines
[272.032367] Starting dynamic subtest: lmem0
[273.279744] Dynamic subtest lmem0: SUCCESS (1.239s)
[273.280843] Subtest random-engines: SUCCESS (1.240s)
[274.814238] [161/170] (727s left) gem_lmem_swapping (verify-random)
[275.716389] Starting subtest: verify-random
[275.717350] Starting dynamic subtest: lmem0
[286.797275] Dynamic subtest lmem0: SUCCESS (11.045s)
[286.798290] Subtest verify-random: SUCCESS (11.046s)
[288.491277] [162/170] (714s left) i915_pm_rpm (module-reload)
[291.751044] Starting subtest: module-reload
[307.105424] Subtest module-reload: SUCCESS (15.345s)
[307.149401] [163/170] (695s left) i915_selftest (live)
[307.257077] Starting subtest: live
[307.258173] Starting dynamic subtest: sanitycheck
[309.327434] Dynamic subtest sanitycheck: SUCCESS (2.060s)
[309.336062] Starting dynamic subtest: uncore
[311.358374] Dynamic subtest uncore: SUCCESS (2.031s)
[311.368476] Starting dynamic subtest: workarounds
[315.890471] Dynamic subtest workarounds: SUCCESS (4.531s)
[315.897294] Starting dynamic subtest: gt_engines
[319.047551] Dynamic subtest gt_engines: SUCCESS (3.156s)
[319.054849] Starting dynamic subtest: gt_timelines
[354.473501] Dynamic subtest gt_timelines: SUCCESS (35.425s)
[354.479592] Starting dynamic subtest: gt_contexts
[356.565526] Dynamic subtest gt_contexts: SUCCESS (2.091s)
[356.574706] Starting dynamic subtest: gt_lrc
[365.713313] Dynamic subtest gt_lrc: SUCCESS (9.147s)
[365.720222] Starting dynamic subtest: gt_mocs
[369.605712] Dynamic subtest gt_mocs: SUCCESS (3.892s)
[369.613026] Starting dynamic subtest: gt_pm
[372.546507] Dynamic subtest gt_pm: SUCCESS (2.940s)
[372.554201] Starting dynamic subtest: gt_heartbeat
[374.838412] Dynamic subtest gt_heartbeat: SUCCESS (2.291s)
[374.848531] Starting dynamic subtest: gt_tlb
[391.321262] Dynamic subtest gt_tlb: SUCCESS (16.482s)
[391.327328] Starting dynamic subtest: requests
[409.472434] Dynamic subtest requests: SUCCESS (18.150s)
[409.479737] Starting dynamic subtest: migrate
[415.093746] Dynamic subtest migrate: SUCCESS (5.620s)
[415.101449] Starting dynamic subtest: active
[417.174410] Dynamic subtest active: SUCCESS (2.080s)
[417.181409] Starting dynamic subtest: objects
[420.528739] Dynamic subtest objects: SUCCESS (3.353s)
[420.537205] Starting dynamic subtest: mman
[431.040113] Dynamic subtest mman: SUCCESS (10.511s)
[431.046329] Starting dynamic subtest: dmabuf
[433.019244] Dynamic subtest dmabuf: SUCCESS (1.978s)
[433.025496] Starting dynamic subtest: vma
[435.048266] Dynamic subtest vma: SUCCESS (2.028s)
[435.054540] Starting dynamic subtest: coherency
[438.901196] Dynamic subtest coherency: SUCCESS (3.852s)
[438.907333] Starting dynamic subtest: gtt
[449.471361] Dynamic subtest gtt: SUCCESS (10.569s)
[449.477976] Starting dynamic subtest: gem
[451.566210] Dynamic subtest gem: SUCCESS (2.094s)
[451.572647] Starting dynamic subtest: evict
[456.169648] Dynamic subtest evict: SUCCESS (4.603s)
[456.182484] Starting dynamic subtest: hugepages
[473.481672] Dynamic subtest hugepages: SUCCESS (17.311s)
[473.489479] Starting dynamic subtest: gem_contexts
[520.494368] Dynamic subtest gem_contexts: SUCCESS (46.986s)
[520.502672] Starting dynamic subtest: client
[522.579691] Dynamic subtest client: SUCCESS (2.110s)
[522.586811] Starting dynamic subtest: gem_migrate
[527.690095] Dynamic subtest gem_migrate: SUCCESS (5.107s)
[527.696475] Starting dynamic subtest: reset
[529.826781] Dynamic subtest reset: SUCCESS (2.138s)
[529.834863] Starting dynamic subtest: memory_region
[533.384297] Dynamic subtest memory_region: SUCCESS (3.556s)
[533.391267] Starting dynamic subtest: hangcheck
[582.622671] Dynamic subtest hangcheck: SUCCESS (49.238s)
[582.630421] Starting dynamic subtest: execlists
[584.720842] Dynamic subtest execlists: SUCCESS (2.097s)
[584.729240] Starting dynamic subtest: ring_submission
[586.814575] Dynamic subtest ring_submission: SUCCESS (2.093s)
[586.823056] Starting dynamic subtest: perf
[589.017802] Dynamic subtest perf: SUCCESS (2.202s)
[589.025787] Starting dynamic subtest: slpc
[598.944609] Dynamic subtest slpc: SUCCESS (9.926s)
[598.952316] Starting dynamic subtest: guc
[602.525511] Dynamic subtest guc: SUCCESS (3.580s)
[602.532891] Starting dynamic subtest: guc_multi_lrc
[604.626116] Dynamic subtest guc_multi_lrc: SUCCESS (2.099s)
[604.633930] Starting dynamic subtest: guc_hang
[607.424480] Dynamic subtest guc_hang: SUCCESS (2.798s)
[607.431560] Starting dynamic subtest: late_gt_pm
[609.584529] Dynamic subtest late_gt_pm: SUCCESS (2.158s)
[609.585770] Subtest live: SUCCESS (302.318s)
[610.040870] [164/170] (392s left) dmabuf (all-tests)
[610.118394] Starting subtest: all-tests
[610.119911] Starting dynamic subtest: sanitycheck
[610.200149] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[610.209648] Starting dynamic subtest: dma_fence
[610.384738] Dynamic subtest dma_fence: SUCCESS (0.183s)
[610.400241] Starting dynamic subtest: dma_fence_chain
[624.210866] Dynamic subtest dma_fence_chain: SUCCESS (13.816s)
[624.217456] Starting dynamic subtest: dma_fence_unwrap
[624.276075] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s)
[624.302407] Starting dynamic subtest: dma_resv
[624.361513] Dynamic subtest dma_resv: SUCCESS (0.083s)
[624.362746] Subtest all-tests: SUCCESS (14.243s)
[624.396246] [165/170] (378s left) i915_suspend (basic-s2idle-without-i915)
[624.480755] Starting subtest: basic-s2idle-without-i915
[645.713247] Subtest basic-s2idle-without-i915: SUCCESS (5.710s)
[645.910007] [166/170] (372s left) i915_suspend (basic-s3-without-i915)
[645.993964] Starting subtest: basic-s3-without-i915
[648.842301] Subtest basic-s3-without-i915: SKIP (2.837s)
[649.720280] [167/170] (368s left) gem_exec_suspend (basic-s0)
[649.839697] Starting subtest: basic-S0
[649.840832] Starting dynamic subtest: smem
[670.435326] Dynamic subtest smem: SUCCESS (5.770s)
[670.448631] Starting dynamic subtest: lmem0
[690.446040] Dynamic subtest lmem0: SUCCESS (5.870s)
[690.448339] Subtest basic-S0: SUCCESS (11.643s)
[690.674817] [168/170] (356s left) gem_exec_suspend (basic-s3)
[690.793160] Starting subtest: basic-S3
[690.794232] Starting dynamic subtest: smem
[711.410949] Dynamic subtest smem: SUCCESS (5.740s)
[711.425134] Starting dynamic subtest: lmem0
[731.446980] Dynamic subtest lmem0: SUCCESS (5.785s)
[731.449438] Subtest basic-S3: SUCCESS (11.529s)
[731.639639] [169/170] (344s left) kms_chamelium_hpd (common-hpd-after-suspend)
[731.872424] Subtest common-hpd-after-suspend: SKIP (0.000s)
[732.005026] [170/170] (344s left) kms_pipe_crc_basic (suspend-read-crc)
[732.159558] Starting subtest: suspend-read-crc
[732.160820] Starting dynamic subtest: pipe-A-DP-1
[749.757040] Dynamic subtest pipe-A-DP-1: SUCCESS (2.828s)
[749.766224] Starting dynamic subtest: pipe-B-DP-1
[767.820925] Dynamic subtest pipe-B-DP-1: SUCCESS (2.838s)
[767.834130] Starting dynamic subtest: pipe-C-DP-1
[785.875032] Dynamic subtest pipe-C-DP-1: SUCCESS (3.047s)
[785.884934] Starting dynamic subtest: pipe-D-DP-1
[803.902339] Dynamic subtest pipe-D-DP-1: SUCCESS (3.078s)
[803.903297] Subtest suspend-read-crc: SUCCESS (11.801s)
[804.061166] Closing watchdogs
Done.