[39.592347] Initializing watchdogs
[39.592408]   /dev/watchdog0
[39.597625] [001/165] (960s left) i915_module_load (load)
[39.634899] Starting subtest: load
[40.713401] Subtest load: SUCCESS (1.078s)
[40.725083] [002/165] (959s left) core_auth (basic-auth)
[40.811047] Starting subtest: basic-auth
[40.812048] Subtest basic-auth: SUCCESS (0.001s)
[40.909458] [003/165] (959s left) debugfs_test (read_all_entries)
[40.999012] Starting subtest: read_all_entries
[41.346866] Subtest read_all_entries: SUCCESS (0.348s)
[41.479385] [004/165] (958s left) debugfs_test (basic-hwmon)
[41.524777] Starting subtest: basic-hwmon
[41.527527] Subtest basic-hwmon: SUCCESS (0.002s)
[41.631439] [005/165] (958s left) fbdev (eof)
[41.696403] Starting subtest: eof
[41.697406] Subtest eof: SUCCESS (0.000s)
[41.763584] [006/165] (958s left) fbdev (info)
[41.816407] Starting subtest: info
[41.817517] Subtest info: SUCCESS (0.000s)
[41.896662] [007/165] (958s left) fbdev (nullptr)
[41.946144] Starting subtest: nullptr
[41.947029] Subtest nullptr: SUCCESS (0.000s)
[42.014086] [008/165] (958s left) fbdev (read)
[42.062877] Starting subtest: read
[54.294761] Subtest read: SUCCESS (12.197s)
[54.313942] [009/165] (945s left) fbdev (write)
[54.364648] Starting subtest: write
[60.475771] Subtest write: SUCCESS (6.077s)
[60.496746] [010/165] (939s left) gem_basic (bad-close)
[60.538050] Starting subtest: bad-close
[60.540063] Subtest bad-close: SUCCESS (0.000s)
[60.597289] [011/165] (939s left) gem_basic (create-close)
[60.644809] Starting subtest: create-close
[60.646326] Subtest create-close: SUCCESS (0.000s)
[60.738220] [012/165] (939s left) gem_basic (create-fd-close)
[60.821981] Starting subtest: create-fd-close
[60.823623] Subtest create-fd-close: SUCCESS (0.000s)
[60.942826] [013/165] (939s left) gem_busy (busy@all-engines)
[61.038233] Starting subtest: busy
[61.039111] Starting dynamic subtest: all-engines
[61.138427] Dynamic subtest all-engines: SUCCESS (0.100s)
[61.139295] Subtest busy: SUCCESS (0.100s)
[61.538922] [014/165] (938s left) gem_close_race (basic-process)
[61.657134] Starting subtest: basic-process
[61.716376] Subtest basic-process: SUCCESS (0.059s)
[61.944218] [015/165] (938s left) gem_close_race (basic-threads)
[62.018413] Starting subtest: basic-threads
[63.213350] Subtest basic-threads: SUCCESS (1.195s)
[63.451872] [016/165] (936s left) gem_ctx_create (basic)
[63.554475] Starting subtest: basic
[63.555614] Subtest basic: SUCCESS (0.000s)
[63.757021] [017/165] (936s left) gem_ctx_create (basic-files)
[63.836106] Starting subtest: basic-files
[65.848886] Subtest basic-files: SUCCESS (2.013s)
[66.451471] [018/165] (933s left) gem_ctx_exec (basic)
[66.502598] Starting subtest: basic
[66.505458] Subtest basic: SUCCESS (0.003s)
[66.629628] [019/165] (933s left) gem_exec_basic (basic)
[66.714098] Starting subtest: basic
[66.714911] Starting dynamic subtest: rcs0-smem
[66.716601] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[66.721886] Starting dynamic subtest: bcs0-smem
[66.722738] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[66.727746] Starting dynamic subtest: vcs0-smem
[66.728541] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[66.733185] Starting dynamic subtest: vcs1-smem
[66.734061] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[66.738781] Starting dynamic subtest: vecs0-smem
[66.739989] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[66.744789] Starting dynamic subtest: vecs1-smem
[66.746034] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[66.750974] Starting dynamic subtest: ccs0-smem
[66.752222] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[66.757057] Starting dynamic subtest: ccs1-smem
[66.758251] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[66.762836] Starting dynamic subtest: ccs2-smem
[66.764128] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[66.768941] Starting dynamic subtest: ccs3-smem
[66.770218] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[66.775111] Starting dynamic subtest: rcs0-lmem0
[66.775928] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[66.780798] Starting dynamic subtest: bcs0-lmem0
[66.782033] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[66.786527] Starting dynamic subtest: vcs0-lmem0
[66.787297] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[66.791761] Starting dynamic subtest: vcs1-lmem0
[66.792512] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[66.797251] Starting dynamic subtest: vecs0-lmem0
[66.798443] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[66.803177] Starting dynamic subtest: vecs1-lmem0
[66.804342] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[66.809215] Starting dynamic subtest: ccs0-lmem0
[66.810392] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[66.815149] Starting dynamic subtest: ccs1-lmem0
[66.816133] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[66.820970] Starting dynamic subtest: ccs2-lmem0
[66.822208] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[66.826789] Starting dynamic subtest: ccs3-lmem0
[66.827642] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[66.828526] Subtest basic: SUCCESS (0.011s)
[66.905864] [020/165] (933s left) gem_exec_create (basic)
[66.962675] Starting subtest: basic
[66.963532] Starting dynamic subtest: smem
[69.052434] Dynamic subtest smem: SUCCESS (2.090s)
[69.057048] Starting dynamic subtest: lmem0
[71.144628] Dynamic subtest lmem0: SUCCESS (2.092s)
[71.145486] Subtest basic: SUCCESS (4.182s)
[71.340380] [021/165] (929s left) gem_exec_fence (basic-busy)
[71.567503] Starting subtest: basic-busy
[71.569103] Starting dynamic subtest: rcs0
[71.679577] Dynamic subtest rcs0: SUCCESS (0.121s)
[71.688911] Starting dynamic subtest: bcs0
[71.733565] Dynamic subtest bcs0: SUCCESS (0.054s)
[71.743599] Starting dynamic subtest: vcs0
[71.793244] Dynamic subtest vcs0: SUCCESS (0.058s)
[71.812253] Starting dynamic subtest: vcs1
[71.853149] Dynamic subtest vcs1: SUCCESS (0.061s)
[71.872252] Starting dynamic subtest: vecs0
[71.913905] Dynamic subtest vecs0: SUCCESS (0.060s)
[71.933591] Starting dynamic subtest: vecs1
[71.971332] Dynamic subtest vecs1: SUCCESS (0.057s)
[71.991351] Starting dynamic subtest: ccs0
[72.029176] Dynamic subtest ccs0: SUCCESS (0.058s)
[72.050093] Starting dynamic subtest: ccs1
[72.082173] Dynamic subtest ccs1: SUCCESS (0.052s)
[72.103050] Starting dynamic subtest: ccs2
[72.136972] Dynamic subtest ccs2: SUCCESS (0.055s)
[72.158023] Starting dynamic subtest: ccs3
[72.191278] Dynamic subtest ccs3: SUCCESS (0.054s)
[72.193291] Subtest basic-busy: SUCCESS (0.632s)
[73.167129] [022/165] (927s left) gem_exec_fence (basic-wait)
[73.351233] Starting subtest: basic-wait
[73.352852] Starting dynamic subtest: rcs0
[73.436483] Dynamic subtest rcs0: SUCCESS (0.094s)
[73.443260] Starting dynamic subtest: bcs0
[73.481586] Dynamic subtest bcs0: SUCCESS (0.045s)
[73.490061] Starting dynamic subtest: vcs0
[73.537938] Dynamic subtest vcs0: SUCCESS (0.055s)
[73.546975] Starting dynamic subtest: vcs1
[73.587841] Dynamic subtest vcs1: SUCCESS (0.050s)
[73.599297] Starting dynamic subtest: vecs0
[73.643952] Dynamic subtest vecs0: SUCCESS (0.055s)
[73.665114] Starting dynamic subtest: vecs1
[73.696955] Dynamic subtest vecs1: SUCCESS (0.053s)
[73.718218] Starting dynamic subtest: ccs0
[73.756063] Dynamic subtest ccs0: SUCCESS (0.058s)
[73.777219] Starting dynamic subtest: ccs1
[73.809858] Dynamic subtest ccs1: SUCCESS (0.053s)
[73.819014] Starting dynamic subtest: ccs2
[73.857710] Dynamic subtest ccs2: SUCCESS (0.048s)
[73.865836] Starting dynamic subtest: ccs3
[73.914060] Dynamic subtest ccs3: SUCCESS (0.055s)
[73.916136] Subtest basic-wait: SUCCESS (0.571s)
[74.816931] [023/165] (925s left) gem_exec_fence (basic-await)
[75.017287] Starting subtest: basic-await
[75.020242] Starting dynamic subtest: rcs0
[75.126577] Dynamic subtest rcs0: SUCCESS (0.115s)
[75.131953] Starting dynamic subtest: bcs0
[75.220864] Dynamic subtest bcs0: SUCCESS (0.094s)
[75.226393] Starting dynamic subtest: vcs0
[75.314144] Dynamic subtest vcs0: SUCCESS (0.093s)
[75.319223] Starting dynamic subtest: vcs1
[75.407114] Dynamic subtest vcs1: SUCCESS (0.093s)
[75.412631] Starting dynamic subtest: vecs0
[75.502986] Dynamic subtest vecs0: SUCCESS (0.095s)
[75.517388] Starting dynamic subtest: vecs1
[75.625912] Dynamic subtest vecs1: SUCCESS (0.123s)
[75.631210] Starting dynamic subtest: ccs0
[75.719589] Dynamic subtest ccs0: SUCCESS (0.093s)
[75.725185] Starting dynamic subtest: ccs1
[75.812861] Dynamic subtest ccs1: SUCCESS (0.093s)
[75.819029] Starting dynamic subtest: ccs2
[75.908308] Dynamic subtest ccs2: SUCCESS (0.095s)
[75.913294] Starting dynamic subtest: ccs3
[75.999018] Dynamic subtest ccs3: SUCCESS (0.090s)
[75.999872] Subtest basic-await: SUCCESS (0.987s)
[76.974492] [024/165] (923s left) gem_exec_fence (nb-await)
[77.150180] Starting subtest: nb-await
[77.159825] Starting dynamic subtest: rcs0
[77.233237] Dynamic subtest rcs0: SUCCESS (0.089s)
[77.241379] Starting dynamic subtest: bcs0
[77.297519] Dynamic subtest bcs0: SUCCESS (0.064s)
[77.306217] Starting dynamic subtest: vcs0
[77.367881] Dynamic subtest vcs0: SUCCESS (0.069s)
[77.391902] Starting dynamic subtest: vcs1
[77.461478] Dynamic subtest vcs1: SUCCESS (0.093s)
[77.477514] Starting dynamic subtest: vecs0
[77.534260] Dynamic subtest vecs0: SUCCESS (0.073s)
[77.543733] Starting dynamic subtest: vecs1
[77.606063] Dynamic subtest vecs1: SUCCESS (0.070s)
[77.629950] Starting dynamic subtest: ccs0
[77.697252] Dynamic subtest ccs0: SUCCESS (0.092s)
[77.710339] Starting dynamic subtest: ccs1
[77.774818] Dynamic subtest ccs1: SUCCESS (0.076s)
[77.798927] Starting dynamic subtest: ccs2
[77.866509] Dynamic subtest ccs2: SUCCESS (0.091s)
[77.890585] Starting dynamic subtest: ccs3
[77.957443] Dynamic subtest ccs3: SUCCESS (0.091s)
[77.958815] Subtest nb-await: SUCCESS (0.813s)
[78.867670] [025/165] (921s left) gem_exec_gttfill (basic)
[78.921286] Starting subtest: basic
[83.884813] Subtest basic: SUCCESS (4.955s)
[84.148099] [026/165] (916s left) gem_exec_parallel (engines)
[84.240639] Starting subtest: engines
[84.241459] Starting dynamic subtest: basic
[85.781169] Dynamic subtest basic: SUCCESS (1.540s)
[85.800278] Starting dynamic subtest: contexts
[89.491332] Dynamic subtest contexts: SUCCESS (3.701s)
[89.510319] Starting dynamic subtest: fds
[93.982143] Dynamic subtest fds: SUCCESS (4.490s)
[93.999589] Starting dynamic subtest: userptr
[95.381161] Dynamic subtest userptr: SUCCESS (1.408s)
[95.382121] Subtest engines: SUCCESS (11.141s)
[95.636216] [027/165] (904s left) gem_exec_store (basic)
[95.712706] Starting subtest: basic
[95.820107] Subtest basic: SUCCESS (0.107s)
[96.041323] [028/165] (904s left) gem_flink_basic (bad-flink)
[96.085449] Starting subtest: bad-flink
[96.086408] Subtest bad-flink: SUCCESS (0.000s)
[96.149176] [029/165] (904s left) gem_flink_basic (bad-open)
[96.191481] Starting subtest: bad-open
[96.192318] Subtest bad-open: SUCCESS (0.000s)
[96.248941] [030/165] (904s left) gem_flink_basic (basic)
[96.302124] Starting subtest: basic
[96.303378] Subtest basic: SUCCESS (0.000s)
[96.416053] [031/165] (904s left) gem_flink_basic (double-flink)
[96.491332] Starting subtest: double-flink
[96.492169] Subtest double-flink: SUCCESS (0.000s)
[96.568438] [032/165] (904s left) gem_flink_basic (flink-lifetime)
[96.633611] Starting subtest: flink-lifetime
[96.635332] Subtest flink-lifetime: SUCCESS (0.002s)
[96.723479] [033/165] (903s left) gem_huc_copy (huc-copy)
[96.793761] Starting subtest: huc-copy
[96.798393] Subtest huc-copy: SUCCESS (0.005s)
[96.932995] [034/165] (903s left) gem_linear_blits (basic)
[97.047283] Starting subtest: basic
[97.073134] Subtest basic: SUCCESS (0.026s)
[97.240093] [035/165] (903s left) gem_mmap (basic)
[97.331136] Subtest basic: SKIP (0.000s)
[97.354273] [036/165] (903s left) gem_mmap_gtt (basic)
[97.400909] Subtest basic: SKIP (0.000s)
[97.421643] [037/165] (903s left) gem_render_linear_blits (basic)
[97.470740] Starting subtest: basic
[97.523900] Subtest basic: SUCCESS (0.053s)
[97.589727] [038/165] (903s left) gem_render_tiled_blits (basic)
[97.668628] Subtest basic: SKIP (0.000s)
[97.687721] [039/165] (903s left) gem_ringfill (basic-all)
[98.077217] Starting subtest: basic-all
[100.756446] Subtest basic-all: SUCCESS (2.646s)
[100.819295] [040/165] (899s left) gem_softpin (allocator-basic)
[100.872923] Starting subtest: allocator-basic
[101.036156] Subtest allocator-basic: SUCCESS (0.154s)
[101.150651] [041/165] (899s left) gem_softpin (allocator-basic-reserve)
[101.196783] Starting subtest: allocator-basic-reserve
[101.365526] Subtest allocator-basic-reserve: SUCCESS (0.160s)
[101.459322] [042/165] (899s left) gem_softpin (safe-alignment)
[101.553743] Starting subtest: safe-alignment
[101.602842] Subtest safe-alignment: SUCCESS (0.051s)
[101.729575] [043/165] (899s left) gem_sync (basic-all)
[101.781560] Starting subtest: basic-all
[105.055869] Subtest basic-all: SUCCESS (3.274s)
[105.235715] [044/165] (895s left) gem_sync (basic-each)
[105.288031] Starting subtest: basic-each
[107.783840] Subtest basic-each: SUCCESS (2.495s)
[107.974935] [045/165] (892s left) gem_tiled_blits (basic)
[108.030122] Subtest basic: SKIP (0.000s)
[108.055441] [046/165] (892s left) gem_tiled_fence_blits (basic)
[108.116447] Subtest basic: SKIP (0.000s)
[108.138075] [047/165] (892s left) gem_tiled_pread_basic
[108.205290] [048/165] (892s left) gem_wait (busy@all-engines)
[108.261806] Starting subtest: busy
[108.262594] Starting dynamic subtest: all-engines
[108.829691] Dynamic subtest all-engines: SUCCESS (0.565s)
[108.830741] Subtest busy: SUCCESS (0.566s)
[109.064221] [049/165] (891s left) gem_wait (wait@all-engines)
[109.124369] Starting subtest: wait
[109.125259] Starting dynamic subtest: all-engines
[110.207021] Dynamic subtest all-engines: SUCCESS (1.082s)
[110.208034] Subtest wait: SUCCESS (1.082s)
[110.436084] [050/165] (890s left) i915_getparams_basic (basic-eu-total)
[110.482835] Starting subtest: basic-eu-total
[110.484395] Subtest basic-eu-total: SUCCESS (0.000s)
[110.552669] [051/165] (890s left) i915_getparams_basic (basic-subslice-total)
[110.602184] Starting subtest: basic-subslice-total
[110.604117] Subtest basic-subslice-total: SUCCESS (0.000s)
[110.694666] [052/165] (890s left) i915_hangman (error-state-basic)
[110.810426] Starting subtest: error-state-basic
[111.001283] Subtest error-state-basic: SUCCESS (0.192s)
[111.067693] [053/165] (889s left) i915_pciid
[111.197371] [054/165] (889s left) kms_addfb_basic (addfb25-4-tiled)
[111.320287] Starting subtest: addfb25-4-tiled
[111.321164] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[111.432384] [055/165] (889s left) kms_addfb_basic (addfb25-bad-modifier)
[111.509357] Starting subtest: addfb25-bad-modifier
[111.510442] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[111.639903] [056/165] (889s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[111.711528] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[111.843626] [057/165] (889s left) kms_addfb_basic (addfb25-modifier-no-flag)
[111.912509] Starting subtest: addfb25-modifier-no-flag
[111.913426] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[112.037960] [058/165] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[112.101714] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[112.220668] [059/165] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[112.282584] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[112.405868] [060/165] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[112.503189] Starting subtest: addfb25-yf-tiled-legacy
[112.504060] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[112.588146] [061/165] (888s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[112.682733] Starting subtest: addfb25-y-tiled-legacy
[112.683521] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[112.749594] [062/165] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[112.831710] Starting subtest: addfb25-y-tiled-small-legacy
[112.833392] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[112.924152] [063/165] (888s left) kms_addfb_basic (bad-pitch-0)
[112.988360] Starting subtest: bad-pitch-0
[112.989190] Subtest bad-pitch-0: SUCCESS (0.000s)
[113.102642] [064/165] (888s left) kms_addfb_basic (bad-pitch-1024)
[113.163224] Starting subtest: bad-pitch-1024
[113.164143] Subtest bad-pitch-1024: SUCCESS (0.000s)
[113.286256] [065/165] (887s left) kms_addfb_basic (bad-pitch-128)
[113.344247] Starting subtest: bad-pitch-128
[113.345175] Subtest bad-pitch-128: SUCCESS (0.000s)
[113.451909] [066/165] (887s left) kms_addfb_basic (bad-pitch-256)
[113.508769] Starting subtest: bad-pitch-256
[113.509717] Subtest bad-pitch-256: SUCCESS (0.000s)
[113.642906] [067/165] (887s left) kms_addfb_basic (bad-pitch-32)
[113.720202] Starting subtest: bad-pitch-32
[113.721105] Subtest bad-pitch-32: SUCCESS (0.000s)
[113.837718] [068/165] (887s left) kms_addfb_basic (bad-pitch-63)
[113.900617] Starting subtest: bad-pitch-63
[113.901531] Subtest bad-pitch-63: SUCCESS (0.000s)
[114.021208] [069/165] (887s left) kms_addfb_basic (bad-pitch-65536)
[114.083761] Starting subtest: bad-pitch-65536
[114.084697] Subtest bad-pitch-65536: SUCCESS (0.000s)
[114.204317] [070/165] (887s left) kms_addfb_basic (bad-pitch-999)
[114.270229] Starting subtest: bad-pitch-999
[114.271161] Subtest bad-pitch-999: SUCCESS (0.000s)
[114.366449] [071/165] (886s left) kms_addfb_basic (basic)
[114.414136] Starting subtest: basic
[114.415056] Subtest basic: SUCCESS (0.000s)
[114.540276] [072/165] (886s left) kms_addfb_basic (basic-x-tiled-legacy)
[114.604196] Starting subtest: basic-x-tiled-legacy
[114.605897] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[114.719812] [073/165] (886s left) kms_addfb_basic (basic-y-tiled-legacy)
[114.783533] Starting subtest: basic-y-tiled-legacy
[114.785121] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[114.905941] [074/165] (886s left) kms_addfb_basic (bo-too-small)
[115.012998] Starting subtest: bo-too-small
[115.013865] Subtest bo-too-small: SUCCESS (0.000s)
[115.104823] [075/165] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[115.201792] Starting subtest: bo-too-small-due-to-tiling
[115.203513] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[115.287628] [076/165] (886s left) kms_addfb_basic (clobberred-modifier)
[115.350448] Starting subtest: clobberred-modifier
[115.352387] Subtest clobberred-modifier: SKIP (0.000s)
[115.468281] [077/165] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[115.524799] Starting subtest: framebuffer-vs-set-tiling
[115.526510] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[115.636062] [078/165] (885s left) kms_addfb_basic (invalid-get-prop)
[115.692743] Starting subtest: invalid-get-prop
[115.693660] Subtest invalid-get-prop: SUCCESS (0.000s)
[115.823849] [079/165] (885s left) kms_addfb_basic (invalid-get-prop-any)
[115.892515] Starting subtest: invalid-get-prop-any
[115.893501] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[116.022873] [080/165] (885s left) kms_addfb_basic (invalid-set-prop)
[116.084777] Starting subtest: invalid-set-prop
[116.085579] Subtest invalid-set-prop: SUCCESS (0.000s)
[116.206342] [081/165] (885s left) kms_addfb_basic (invalid-set-prop-any)
[116.267975] Starting subtest: invalid-set-prop-any
[116.268840] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[116.388510] [082/165] (885s left) kms_addfb_basic (no-handle)
[116.451306] Starting subtest: no-handle
[116.452230] Subtest no-handle: SUCCESS (0.000s)
[116.573575] [083/165] (884s left) kms_addfb_basic (size-max)
[116.687641] Starting subtest: size-max
[116.688513] Subtest size-max: SUCCESS (0.000s)
[116.772319] [084/165] (884s left) kms_addfb_basic (small-bo)
[116.877288] Starting subtest: small-bo
[116.878119] Subtest small-bo: SUCCESS (0.000s)
[116.953216] [085/165] (884s left) kms_addfb_basic (tile-pitch-mismatch)
[117.012598] Starting subtest: tile-pitch-mismatch
[117.014155] Subtest tile-pitch-mismatch: SKIP (0.000s)
[117.118466] [086/165] (884s left) kms_addfb_basic (too-high)
[117.215379] Starting subtest: too-high
[117.216185] Subtest too-high: SUCCESS (0.001s)
[117.305063] [087/165] (884s left) kms_addfb_basic (too-wide)
[117.404359] Starting subtest: too-wide
[117.405270] Subtest too-wide: SUCCESS (0.000s)
[117.487736] [088/165] (884s left) kms_addfb_basic (unused-handle)
[117.548270] Starting subtest: unused-handle
[117.549314] Subtest unused-handle: SUCCESS (0.000s)
[117.673306] [089/165] (883s left) kms_addfb_basic (unused-modifier)
[117.742304] Starting subtest: unused-modifier
[117.743180] Subtest unused-modifier: SUCCESS (0.000s)
[117.877661] [090/165] (883s left) kms_addfb_basic (unused-offsets)
[117.954331] Starting subtest: unused-offsets
[117.955302] Subtest unused-offsets: SUCCESS (0.000s)
[118.090606] [091/165] (883s left) kms_addfb_basic (unused-pitches)
[118.154768] Starting subtest: unused-pitches
[118.155663] Subtest unused-pitches: SUCCESS (0.000s)
[118.269502] [092/165] (883s left) kms_busy (basic)
[118.366977] Starting subtest: basic
[118.367947] Starting dynamic subtest: flip
[119.060806] Dynamic subtest flip: SUCCESS (0.693s)
[119.072961] Starting dynamic subtest: modeset
[120.150715] Dynamic subtest modeset: SUCCESS (1.089s)
[120.152677] Subtest basic: SUCCESS (1.783s)
[120.441763] [093/165] (881s left) kms_prop_blob (basic)
[120.509614] Starting subtest: basic
[120.510660] Subtest basic: SUCCESS (0.000s)
[120.579679] [094/165] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[120.668470] Starting subtest: basic-busy-flip-before-cursor-atomic
[120.670206] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[120.727624] [095/165] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[120.811032] Starting subtest: basic-busy-flip-before-cursor-legacy
[120.812867] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[120.878294] [096/165] (880s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[120.966558] Starting subtest: basic-flip-after-cursor-atomic
[122.008209] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.035s)
[122.278908] [097/165] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[122.433046] Starting subtest: basic-flip-after-cursor-legacy
[123.451346] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.033s)
[123.698895] [098/165] (878s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[123.798222] Starting subtest: basic-flip-after-cursor-varying-size
[124.821059] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.022s)
[125.086328] [099/165] (876s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[125.225131] Starting subtest: basic-flip-before-cursor-atomic
[126.255447] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.031s)
[126.512644] [100/165] (875s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[126.614438] Starting subtest: basic-flip-before-cursor-legacy
[127.650932] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.037s)
[127.936443] [101/165] (873s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[128.054340] Starting subtest: basic-flip-before-cursor-varying-size
[129.092453] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.038s)
[129.354585] [102/165] (872s left) kms_dsc (dsc-basic)
[129.439485] Starting subtest: dsc-basic
[129.440361] Starting dynamic subtest: pipe-A-DP-1
[129.911931] Dynamic subtest pipe-A-DP-1: SUCCESS (0.472s)
[129.942708] Starting dynamic subtest: pipe-B-DP-1
[130.421901] Dynamic subtest pipe-B-DP-1: SUCCESS (0.509s)
[130.431742] Starting dynamic subtest: pipe-C-DP-1
[130.785024] Dynamic subtest pipe-C-DP-1: SUCCESS (0.362s)
[130.799668] Starting dynamic subtest: pipe-D-DP-1
[131.314256] Dynamic subtest pipe-D-DP-1: SUCCESS (0.528s)
[131.317346] Subtest dsc-basic: SUCCESS (1.875s)
[131.646755] [103/165] (870s left) kms_flip (basic-flip-vs-dpms)
[131.738961] Starting subtest: basic-flip-vs-dpms
[131.741470] Starting dynamic subtest: A-DP1
[132.664245] Dynamic subtest A-DP1: SUCCESS (0.921s)
[132.679447] Starting dynamic subtest: B-DP1
[133.615064] Dynamic subtest B-DP1: SUCCESS (0.950s)
[133.626068] Starting dynamic subtest: C-DP1
[134.546399] Dynamic subtest C-DP1: SUCCESS (0.931s)
[134.554971] Starting dynamic subtest: D-DP1
[135.449758] Dynamic subtest D-DP1: SUCCESS (0.903s)
[135.454014] Subtest basic-flip-vs-dpms: SUCCESS (3.716s)
[135.714924] [104/165] (866s left) kms_flip (basic-flip-vs-modeset)
[135.815863] Starting subtest: basic-flip-vs-modeset
[135.818365] Starting dynamic subtest: A-DP1
[136.762194] Dynamic subtest A-DP1: SUCCESS (0.943s)
[136.781822] Starting dynamic subtest: B-DP1
[137.693721] Dynamic subtest B-DP1: SUCCESS (0.929s)
[137.706782] Starting dynamic subtest: C-DP1
[138.454230] Dynamic subtest C-DP1: SUCCESS (0.760s)
[138.466502] Starting dynamic subtest: D-DP1
[139.375017] Dynamic subtest D-DP1: SUCCESS (0.920s)
[139.380232] Subtest basic-flip-vs-modeset: SUCCESS (3.566s)
[139.626203] [105/165] (862s left) kms_flip (basic-flip-vs-wf_vblank)
[139.728360] Starting subtest: basic-flip-vs-wf_vblank
[139.731368] Starting dynamic subtest: A-DP1
[140.901127] Dynamic subtest A-DP1: SUCCESS (1.170s)
[140.909155] Starting dynamic subtest: B-DP1
[142.012685] Dynamic subtest B-DP1: SUCCESS (1.109s)
[142.019416] Starting dynamic subtest: C-DP1
[143.105635] Dynamic subtest C-DP1: SUCCESS (1.094s)
[143.115550] Starting dynamic subtest: D-DP1
[144.214092] Dynamic subtest D-DP1: SUCCESS (1.108s)
[144.217411] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.490s)
[144.513371] [106/165] (857s left) kms_flip (basic-plain-flip)
[144.624101] Starting subtest: basic-plain-flip
[144.628308] Starting dynamic subtest: A-DP1
[145.529254] Dynamic subtest A-DP1: SUCCESS (0.901s)
[145.537416] Starting dynamic subtest: B-DP1
[146.355447] Dynamic subtest B-DP1: SUCCESS (0.825s)
[146.365140] Starting dynamic subtest: C-DP1
[147.182084] Dynamic subtest C-DP1: SUCCESS (0.825s)
[147.189234] Starting dynamic subtest: D-DP1
[147.993278] Dynamic subtest D-DP1: SUCCESS (0.811s)
[147.996723] Subtest basic-plain-flip: SUCCESS (3.373s)
[148.306194] [107/165] (853s left) kms_force_connector_basic (force-connector-state)
[148.381502] Starting subtest: force-connector-state
[148.612940] Subtest force-connector-state: SUCCESS (0.232s)
[148.931910] [108/165] (853s left) kms_force_connector_basic (force-edid)
[148.992659] Starting subtest: force-edid
[149.007994] Subtest force-edid: SUCCESS (0.015s)
[149.158606] [109/165] (852s left) kms_force_connector_basic (force-load-detect)
[149.204691] Starting subtest: force-load-detect
[149.206165] Subtest force-load-detect: SKIP (0.000s)
[149.308735] [110/165] (852s left) kms_force_connector_basic (prune-stale-modes)
[149.355135] Starting subtest: prune-stale-modes
[149.363984] Subtest prune-stale-modes: SKIP (0.008s)
[149.525636] [111/165] (852s left) kms_frontbuffer_tracking (basic)
[149.650921] Starting subtest: basic
[152.808541] Subtest basic: SUCCESS (3.159s)
[152.972544] [112/165] (849s left) kms_hdmi_inject (inject-audio)
[153.098505] Starting subtest: inject-audio
[153.201087] Subtest inject-audio: SUCCESS (0.102s)
[153.494394] [113/165] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[153.578133] Starting subtest: compare-crc-sanitycheck-xr24
[153.578963] Starting dynamic subtest: pipe-A-DP-1
[154.085204] Dynamic subtest pipe-A-DP-1: SUCCESS (0.506s)
[154.091671] Starting dynamic subtest: pipe-B-DP-1
[154.594110] Dynamic subtest pipe-B-DP-1: SUCCESS (0.508s)
[154.607412] Starting dynamic subtest: pipe-C-DP-1
[155.124927] Dynamic subtest pipe-C-DP-1: SUCCESS (0.528s)
[155.132709] Starting dynamic subtest: pipe-D-DP-1
[155.629900] Dynamic subtest pipe-D-DP-1: SUCCESS (0.503s)
[155.630766] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.052s)
[155.887670] [114/165] (846s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[155.991651] Starting subtest: compare-crc-sanitycheck-nv12
[155.992561] Starting dynamic subtest: pipe-A-DP-1
[157.204466] Dynamic subtest pipe-A-DP-1: SUCCESS (1.213s)
[157.213171] Starting dynamic subtest: pipe-B-DP-1
[158.378546] Dynamic subtest pipe-B-DP-1: SUCCESS (1.171s)
[158.386162] Starting dynamic subtest: pipe-C-DP-1
[159.375117] Dynamic subtest pipe-C-DP-1: SUCCESS (0.995s)
[159.383745] Starting dynamic subtest: pipe-D-DP-1
[160.415328] Dynamic subtest pipe-D-DP-1: SUCCESS (1.039s)
[160.416198] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.425s)
[160.670667] [115/165] (841s left) kms_pipe_crc_basic (hang-read-crc)
[160.787530] Starting subtest: hang-read-crc
[160.788458] Starting dynamic subtest: pipe-A-DP-1
[162.300975] Dynamic subtest pipe-A-DP-1: SUCCESS (1.512s)
[162.312560] Starting dynamic subtest: pipe-B-DP-1
[163.775883] Dynamic subtest pipe-B-DP-1: SUCCESS (1.481s)
[163.783574] Starting dynamic subtest: pipe-C-DP-1
[165.248839] Dynamic subtest pipe-C-DP-1: SUCCESS (1.472s)
[165.256721] Starting dynamic subtest: pipe-D-DP-1
[166.703037] Dynamic subtest pipe-D-DP-1: SUCCESS (1.452s)
[166.704196] Subtest hang-read-crc: SUCCESS (5.923s)
[166.975339] [116/165] (835s left) kms_pipe_crc_basic (nonblocking-crc)
[167.062845] Starting subtest: nonblocking-crc
[167.063817] Starting dynamic subtest: pipe-A-DP-1
[167.779822] Dynamic subtest pipe-A-DP-1: SUCCESS (0.715s)
[167.788669] Starting dynamic subtest: pipe-B-DP-1
[168.515863] Dynamic subtest pipe-B-DP-1: SUCCESS (0.735s)
[168.525110] Starting dynamic subtest: pipe-C-DP-1
[169.202650] Dynamic subtest pipe-C-DP-1: SUCCESS (0.684s)
[169.213674] Starting dynamic subtest: pipe-D-DP-1
[169.885724] Dynamic subtest pipe-D-DP-1: SUCCESS (0.681s)
[169.887537] Subtest nonblocking-crc: SUCCESS (2.824s)
[170.151546] [117/165] (832s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[170.267053] Starting subtest: nonblocking-crc-frame-sequence
[170.267893] Starting dynamic subtest: pipe-A-DP-1
[171.022985] Dynamic subtest pipe-A-DP-1: SUCCESS (0.756s)
[171.034245] Starting dynamic subtest: pipe-B-DP-1
[171.701559] Dynamic subtest pipe-B-DP-1: SUCCESS (0.675s)
[171.715569] Starting dynamic subtest: pipe-C-DP-1
[172.419737] Dynamic subtest pipe-C-DP-1: SUCCESS (0.716s)
[172.430546] Starting dynamic subtest: pipe-D-DP-1
[173.105882] Dynamic subtest pipe-D-DP-1: SUCCESS (0.684s)
[173.106831] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.840s)
[173.364205] [118/165] (828s left) kms_pipe_crc_basic (read-crc)
[173.466556] Starting subtest: read-crc
[173.467518] Starting dynamic subtest: pipe-A-DP-1
[174.090727] Dynamic subtest pipe-A-DP-1: SUCCESS (0.623s)
[174.104935] Starting dynamic subtest: pipe-B-DP-1
[174.710188] Dynamic subtest pipe-B-DP-1: SUCCESS (0.618s)
[174.723634] Starting dynamic subtest: pipe-C-DP-1
[175.323318] Dynamic subtest pipe-C-DP-1: SUCCESS (0.610s)
[175.336880] Starting dynamic subtest: pipe-D-DP-1
[175.979453] Dynamic subtest pipe-D-DP-1: SUCCESS (0.655s)
[175.980409] Subtest read-crc: SUCCESS (2.515s)
[176.230807] [119/165] (826s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[176.341871] Starting subtest: read-crc-frame-sequence
[176.342762] Starting dynamic subtest: pipe-A-DP-1
[176.971778] Dynamic subtest pipe-A-DP-1: SUCCESS (0.628s)
[176.988175] Starting dynamic subtest: pipe-B-DP-1
[177.584493] Dynamic subtest pipe-B-DP-1: SUCCESS (0.610s)
[177.595885] Starting dynamic subtest: pipe-C-DP-1
[178.207659] Dynamic subtest pipe-C-DP-1: SUCCESS (0.620s)
[178.222531] Starting dynamic subtest: pipe-D-DP-1
[178.866181] Dynamic subtest pipe-D-DP-1: SUCCESS (0.657s)
[178.867127] Subtest read-crc-frame-sequence: SUCCESS (2.525s)
[179.124556] [120/165] (823s left) kms_pm_backlight (basic-brightness)
[179.229536] Subtest basic-brightness: SKIP (0.000s)
[179.262971] [121/165] (823s left) kms_psr (primary_page_flip)
[179.310124] Subtest primary_page_flip: SKIP (0.000s)
[179.330032] [122/165] (822s left) kms_psr (cursor_plane_move)
[179.374509] Subtest cursor_plane_move: SKIP (0.000s)
[179.396441] [123/165] (822s left) kms_psr (sprite_plane_onoff)
[179.443035] Subtest sprite_plane_onoff: SKIP (0.000s)
[179.463599] [124/165] (822s left) kms_psr (primary_mmap_gtt)
[179.508371] Subtest primary_mmap_gtt: SKIP (0.000s)
[179.529866] [125/165] (822s left) kms_setmode (basic-clone-single-crtc)
[179.575956] Starting subtest: basic-clone-single-crtc
[179.578556] Subtest basic-clone-single-crtc: SKIP (0.000s)
[179.651628] [126/165] (822s left) i915_pm_rpm (basic-pci-d3-state)
[181.556873] Starting subtest: basic-pci-d3-state
[182.414446] Subtest basic-pci-d3-state: SUCCESS (0.858s)
[182.626689] [127/165] (819s left) i915_pm_rpm (basic-rte)
[182.689109] Starting subtest: basic-rte
[185.539443] Subtest basic-rte: SUCCESS (2.848s)
[186.659375] [128/165] (815s left) i915_pm_rps (basic-api)
[186.747517] Starting subtest: basic-api
[186.749148] Subtest basic-api: SKIP (0.000s)
[186.810264] [129/165] (815s left) prime_self_import (basic-llseek-bad)
[186.863028] Starting subtest: basic-llseek-bad
[186.866204] Subtest basic-llseek-bad: SUCCESS (0.003s)
[186.965365] [130/165] (815s left) prime_self_import (basic-llseek-size)
[187.041351] Starting subtest: basic-llseek-size
[187.044437] Subtest basic-llseek-size: SUCCESS (0.002s)
[187.111638] [131/165] (815s left) prime_self_import (basic-with_fd_dup)
[187.158327] Starting subtest: basic-with_fd_dup
[187.159916] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[187.244315] [132/165] (815s left) prime_self_import (basic-with_one_bo)
[187.288549] Starting subtest: basic-with_one_bo
[187.291552] Subtest basic-with_one_bo: SUCCESS (0.003s)
[187.352340] [133/165] (815s left) prime_self_import (basic-with_one_bo_two_files)
[187.417542] Starting subtest: basic-with_one_bo_two_files
[187.421024] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[187.545580] [134/165] (814s left) prime_self_import (basic-with_two_bos)
[187.613525] Starting subtest: basic-with_two_bos
[187.616719] Subtest basic-with_two_bos: SUCCESS (0.003s)
[187.712858] [135/165] (814s left) prime_vgem (basic-fence-flip)
[187.796920] Starting subtest: basic-fence-flip
[187.864743] Subtest basic-fence-flip: SKIP (0.067s)
[187.968389] [136/165] (814s left) prime_vgem (basic-fence-mmap)
[188.050556] Starting subtest: basic-fence-mmap
[188.052488] Subtest basic-fence-mmap: SKIP (0.000s)
[188.176923] [137/165] (814s left) prime_vgem (basic-fence-read)
[188.263896] Starting subtest: basic-fence-read
[188.268675] Subtest basic-fence-read: SKIP (0.004s)
[188.382155] [138/165] (814s left) prime_vgem (basic-gtt)
[188.446755] Starting subtest: basic-gtt
[188.449022] Subtest basic-gtt: SKIP (0.000s)
[188.580567] [139/165] (814s left) prime_vgem (basic-read)
[188.646997] Starting subtest: basic-read
[188.651789] Subtest basic-read: SKIP (0.004s)
[188.765726] [140/165] (813s left) prime_vgem (basic-write)
[188.837365] Starting subtest: basic-write
[188.842047] Subtest basic-write: SKIP (0.004s)
[188.960558] [141/165] (813s left) vgem_basic (setversion)
[189.024239] Starting subtest: setversion
[189.025888] Subtest setversion: SUCCESS (0.000s)
[189.076340] [142/165] (813s left) vgem_basic (create)
[189.124463] Starting subtest: create
[189.125645] Subtest create: SUCCESS (0.000s)
[189.180296] [143/165] (813s left) vgem_basic (debugfs)
[189.241027] Starting subtest: debugfs
[189.241914] Subtest debugfs: SUCCESS (0.000s)
[189.324553] [144/165] (813s left) vgem_basic (dmabuf-export)
[189.391286] Starting subtest: dmabuf-export
[189.407347] Subtest dmabuf-export: SUCCESS (0.016s)
[189.530586] [145/165] (813s left) vgem_basic (dmabuf-fence)
[189.591250] Starting subtest: dmabuf-fence
[189.592360] Subtest dmabuf-fence: SUCCESS (0.000s)
[189.645097] [146/165] (813s left) vgem_basic (dmabuf-fence-before)
[189.690830] Starting subtest: dmabuf-fence-before
[189.691667] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[189.751744] [147/165] (813s left) vgem_basic (dmabuf-mmap)
[189.824357] Starting subtest: dmabuf-mmap
[189.832212] Subtest dmabuf-mmap: SUCCESS (0.008s)
[189.875732] [148/165] (812s left) vgem_basic (mmap)
[189.924529] Starting subtest: mmap
[189.930286] Subtest mmap: SUCCESS (0.006s)
[189.978034] [149/165] (812s left) vgem_basic (second-client)
[190.024517] Starting subtest: second-client
[190.058279] Subtest second-client: SUCCESS (0.033s)
[190.145535] [150/165] (812s left) vgem_basic (sysfs)
[190.224417] Starting subtest: sysfs
[190.225537] Subtest sysfs: SUCCESS (0.000s)
[190.280204] [151/165] (812s left) core_hotunplug (unbind-rebind)
[190.374206] Starting subtest: unbind-rebind
[194.503563] Subtest unbind-rebind: SUCCESS (4.129s)
[194.522098] [152/165] (808s left) vgem_basic (unload)
[194.585213] Starting subtest: unload
[223.581229] Subtest unload: SUCCESS (28.961s)
[223.650577] [153/165] (779s left) i915_module_load (reload)
[223.693567] Starting subtest: reload
[226.507571] Subtest reload: SUCCESS (2.814s)
[226.520129] [154/165] (776s left) gem_lmem_swapping (basic)
[229.475847] Starting subtest: basic
[229.476781] Starting dynamic subtest: lmem0
[246.408753] Dynamic subtest lmem0: SUCCESS (16.898s)
[246.409786] Subtest basic: SUCCESS (16.898s)
[247.841941] [155/165] (755s left) gem_lmem_swapping (parallel-random-engines)
[248.550462] Starting subtest: parallel-random-engines
[248.551322] Starting dynamic subtest: lmem0
[249.356454] Dynamic subtest lmem0: SUCCESS (0.806s)
[249.357686] Subtest parallel-random-engines: SUCCESS (0.807s)
[250.604775] [156/165] (752s left) gem_lmem_swapping (random-engines)
[251.324174] Starting subtest: random-engines
[251.325029] Starting dynamic subtest: lmem0
[252.043947] Dynamic subtest lmem0: SUCCESS (0.711s)
[252.044924] Subtest random-engines: SUCCESS (0.712s)
[253.193121] [157/165] (749s left) gem_lmem_swapping (verify-random)
[253.906092] Starting subtest: verify-random
[253.906849] Starting dynamic subtest: lmem0
[261.578734] Dynamic subtest lmem0: SUCCESS (7.638s)
[261.579686] Subtest verify-random: SUCCESS (7.639s)
[262.804748] [158/165] (740s left) i915_pm_rpm (module-reload)
[265.815289] Starting subtest: module-reload
[279.023936] Subtest module-reload: SUCCESS (13.200s)
[279.033970] [159/165] (724s left) i915_selftest (live)
[279.085145] Starting subtest: live
[279.086131] Starting dynamic subtest: sanitycheck
[280.446559] Dynamic subtest sanitycheck: SUCCESS (1.352s)
[280.452758] Starting dynamic subtest: uncore
[281.807188] Dynamic subtest uncore: SUCCESS (1.360s)
[281.814783] Starting dynamic subtest: workarounds
[286.045189] Dynamic subtest workarounds: SUCCESS (4.237s)
[286.050269] Starting dynamic subtest: gt_engines
[288.451397] Dynamic subtest gt_engines: SUCCESS (2.405s)
[288.457243] Starting dynamic subtest: gt_timelines
[315.925348] Dynamic subtest gt_timelines: SUCCESS (27.473s)
[315.931422] Starting dynamic subtest: gt_contexts
[317.342338] Dynamic subtest gt_contexts: SUCCESS (1.416s)
[317.348800] Starting dynamic subtest: gt_lrc
[325.294403] Dynamic subtest gt_lrc: SUCCESS (7.958s)
[325.300416] Starting dynamic subtest: gt_mocs
[328.991342] Dynamic subtest gt_mocs: SUCCESS (3.689s)
[328.996856] Starting dynamic subtest: gt_pm
[331.333345] Dynamic subtest gt_pm: SUCCESS (2.341s)
[331.338675] Starting dynamic subtest: gt_heartbeat
[332.983189] Dynamic subtest gt_heartbeat: SUCCESS (1.649s)
[332.989255] Starting dynamic subtest: gt_tlb
[344.951464] Dynamic subtest gt_tlb: SUCCESS (11.967s)
[344.957508] Starting dynamic subtest: requests
[362.170356] Dynamic subtest requests: SUCCESS (17.218s)
[362.176221] Starting dynamic subtest: migrate
[366.711296] Dynamic subtest migrate: SUCCESS (4.540s)
[366.716648] Starting dynamic subtest: active
[368.056323] Dynamic subtest active: SUCCESS (1.344s)
[368.061788] Starting dynamic subtest: objects
[370.269303] Dynamic subtest objects: SUCCESS (2.212s)
[370.275506] Starting dynamic subtest: mman
[379.016122] Dynamic subtest mman: SUCCESS (8.748s)
[379.022191] Starting dynamic subtest: dmabuf
[380.391495] Dynamic subtest dmabuf: SUCCESS (1.372s)
[380.400120] Starting dynamic subtest: vma
[381.781151] Dynamic subtest vma: SUCCESS (1.389s)
[381.787153] Starting dynamic subtest: coherency
[385.254536] Dynamic subtest coherency: SUCCESS (3.472s)
[385.262645] Starting dynamic subtest: gtt
[394.054446] Dynamic subtest gtt: SUCCESS (8.799s)
[394.061119] Starting dynamic subtest: gem
[395.460479] Dynamic subtest gem: SUCCESS (1.405s)
[395.465708] Starting dynamic subtest: evict
[398.796632] Dynamic subtest evict: SUCCESS (3.335s)
[398.803561] Starting dynamic subtest: hugepages
[416.948393] Dynamic subtest hugepages: SUCCESS (18.151s)
[416.954488] Starting dynamic subtest: gem_contexts
[456.407868] Dynamic subtest gem_contexts: SUCCESS (39.433s)
[456.412966] Starting dynamic subtest: client
[457.804399] Dynamic subtest client: SUCCESS (1.421s)
[457.810887] Starting dynamic subtest: gem_migrate
[462.073500] Dynamic subtest gem_migrate: SUCCESS (4.268s)
[462.080177] Starting dynamic subtest: reset
[463.506607] Dynamic subtest reset: SUCCESS (1.432s)
[463.513579] Starting dynamic subtest: memory_region
[466.416472] Dynamic subtest memory_region: SUCCESS (2.909s)
[466.423053] Starting dynamic subtest: hangcheck
[512.409912] Dynamic subtest hangcheck: SUCCESS (45.992s)
[512.415641] Starting dynamic subtest: execlists
[513.813480] Dynamic subtest execlists: SUCCESS (1.403s)
[513.819681] Starting dynamic subtest: ring_submission
[515.208499] Dynamic subtest ring_submission: SUCCESS (1.394s)
[515.215706] Starting dynamic subtest: perf
[516.684240] Dynamic subtest perf: SUCCESS (1.475s)
[516.690314] Starting dynamic subtest: slpc
[525.871371] Dynamic subtest slpc: SUCCESS (9.186s)
[525.878508] Starting dynamic subtest: guc
[528.470301] Dynamic subtest guc: SUCCESS (2.598s)
[528.476479] Starting dynamic subtest: guc_multi_lrc
[529.887372] Dynamic subtest guc_multi_lrc: SUCCESS (1.416s)
[529.893427] Starting dynamic subtest: guc_hang
[531.964247] Dynamic subtest guc_hang: SUCCESS (2.076s)
[531.970014] Starting dynamic subtest: late_gt_pm
[533.382506] Dynamic subtest late_gt_pm: SUCCESS (1.417s)
[533.383896] Subtest live: SUCCESS (254.289s)
[533.605135] [160/165] (469s left) dmabuf (all-tests)
[533.653190] Starting subtest: all-tests
[533.654663] Starting dynamic subtest: sanitycheck
[533.714539] Dynamic subtest sanitycheck: SUCCESS (0.061s)
[533.737520] Starting dynamic subtest: dma_fence
[533.890541] Dynamic subtest dma_fence: SUCCESS (0.174s)
[533.897589] Starting dynamic subtest: dma_fence_chain
[544.316564] Dynamic subtest dma_fence_chain: SUCCESS (10.425s)
[544.323619] Starting dynamic subtest: dma_fence_unwrap
[544.390176] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s)
[544.405354] Starting dynamic subtest: dma_resv
[544.478260] Dynamic subtest dma_resv: SUCCESS (0.086s)
[544.480079] Subtest all-tests: SUCCESS (10.826s)
[544.520832] [161/165] (458s left) i915_suspend (basic-s2idle-without-i915)
[544.589737] Starting subtest: basic-s2idle-without-i915
[564.541650] Subtest basic-s2idle-without-i915: SUCCESS (4.588s)
[564.744039] [162/165] (453s left) i915_suspend (basic-s3-without-i915)
[564.833081] Starting subtest: basic-s3-without-i915
[586.149941] Subtest basic-s3-without-i915: SUCCESS (5.456s)
[586.357287] [163/165] (448s left) gem_exec_suspend (basic-s0)
[586.472357] Starting subtest: basic-S0
[586.473480] Starting dynamic subtest: smem
[607.739905] Dynamic subtest smem: SUCCESS (6.383s)
[607.772880] Starting dynamic subtest: lmem0
[628.790683] Dynamic subtest lmem0: SUCCESS (6.432s)
[628.792040] Subtest basic-S0: SUCCESS (12.820s)
[628.981908] [164/165] (434s left) gem_exec_suspend (basic-s3)
[629.035423] Starting subtest: basic-S3
[629.036258] Starting dynamic subtest: smem
[650.748741] Dynamic subtest smem: SUCCESS (6.342s)
[650.756629] Starting dynamic subtest: lmem0
[672.698584] Dynamic subtest lmem0: SUCCESS (6.272s)
[672.699486] Subtest basic-S3: SUCCESS (12.615s)
[672.856852] [165/165] (422s left) kms_pipe_crc_basic (suspend-read-crc)
[672.977890] Starting subtest: suspend-read-crc
[672.978787] Starting dynamic subtest: pipe-A-DP-1
[693.374283] Dynamic subtest pipe-A-DP-1: SUCCESS (4.637s)
[693.388742] Starting dynamic subtest: pipe-B-DP-1
[714.340607] Dynamic subtest pipe-B-DP-1: SUCCESS (4.487s)
[714.354310] Starting dynamic subtest: pipe-C-DP-1
[734.383673] Dynamic subtest pipe-C-DP-1: SUCCESS (4.487s)
[734.398685] Starting dynamic subtest: pipe-D-DP-1
[755.365592] Dynamic subtest pipe-D-DP-1: SUCCESS (4.549s)
[755.367645] Subtest suspend-read-crc: SUCCESS (18.169s)
[755.555409] Closing watchdogs
Done.