[36.330324] Initializing watchdogs
[36.330469]   /dev/watchdog0
[36.341072] [001/165] (960s left) i915_module_load (load)
[36.444855] Starting subtest: load
[39.025889] Subtest load: SUCCESS (2.579s)
[39.054804] [002/165] (957s left) core_auth (basic-auth)
[39.181364] Starting subtest: basic-auth
[39.182603] Subtest basic-auth: SUCCESS (0.002s)
[39.265179] [003/165] (957s left) debugfs_test (read_all_entries)
[39.394173] Starting subtest: read_all_entries
[39.511318] Subtest read_all_entries: SUCCESS (0.117s)
[39.656407] [004/165] (957s left) debugfs_test (basic-hwmon)
[39.776561] Starting subtest: basic-hwmon
[39.780439] Subtest basic-hwmon: SKIP (0.000s)
[39.925461] [005/165] (957s left) fbdev (eof)
[40.067533] Starting subtest: eof
[40.071518] Subtest eof: SUCCESS (0.005s)
[40.158332] [006/165] (956s left) fbdev (info)
[40.248341] Starting subtest: info
[40.249432] Subtest info: SUCCESS (0.000s)
[40.324143] [007/165] (956s left) fbdev (nullptr)
[40.425909] Starting subtest: nullptr
[40.427080] Subtest nullptr: SUCCESS (0.000s)
[40.492468] [008/165] (956s left) fbdev (read)
[40.593034] Starting subtest: read
[47.692584] Subtest read: SUCCESS (7.065s)
[47.734082] [009/165] (949s left) fbdev (write)
[47.850215] Starting subtest: write
[51.623219] Subtest write: SUCCESS (3.739s)
[51.672960] [010/165] (945s left) gem_basic (bad-close)
[51.767342] Starting subtest: bad-close
[51.770108] Subtest bad-close: SUCCESS (0.000s)
[51.858277] [011/165] (945s left) gem_basic (create-close)
[51.948836] Starting subtest: create-close
[51.951102] Subtest create-close: SUCCESS (0.000s)
[52.058093] [012/165] (945s left) gem_basic (create-fd-close)
[52.147431] Starting subtest: create-fd-close
[52.149437] Subtest create-fd-close: SUCCESS (0.001s)
[52.257743] [013/165] (944s left) gem_busy (busy@all-engines)
[52.364966] Starting subtest: busy
[52.366314] Starting dynamic subtest: all-engines
[52.429102] Dynamic subtest all-engines: SUCCESS (0.064s)
[52.430180] Subtest busy: SUCCESS (0.064s)
[52.827116] [014/165] (944s left) gem_close_race (basic-process)
[52.939429] Starting subtest: basic-process
[53.035211] Subtest basic-process: SUCCESS (0.095s)
[53.244354] [015/165] (943s left) gem_close_race (basic-threads)
[53.361090] Starting subtest: basic-threads
[54.532411] Subtest basic-threads: SUCCESS (1.172s)
[54.778486] [016/165] (942s left) gem_ctx_create (basic)
[54.886227] Starting subtest: basic
[54.887442] Subtest basic: SUCCESS (0.000s)
[55.096224] [017/165] (942s left) gem_ctx_create (basic-files)
[55.202666] Starting subtest: basic-files
[57.228150] Subtest basic-files: SUCCESS (2.026s)
[57.494621] [018/165] (939s left) gem_ctx_exec (basic)
[57.593616] Starting subtest: basic
[57.598547] Subtest basic: SUCCESS (0.005s)
[57.714129] [019/165] (939s left) gem_exec_basic (basic)
[57.817877] Starting subtest: basic
[57.819079] Starting dynamic subtest: rcs0-smem
[57.820308] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[57.832180] Starting dynamic subtest: bcs0-smem
[57.833458] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[57.844050] Starting dynamic subtest: vcs0-smem
[57.845388] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[57.855858] Starting dynamic subtest: vecs0-smem
[57.857104] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[57.858391] Subtest basic: SUCCESS (0.005s)
[58.031588] [020/165] (939s left) gem_exec_create (basic)
[58.140380] Starting subtest: basic
[58.141584] Starting dynamic subtest: smem
[60.187857] Dynamic subtest smem: SUCCESS (2.047s)
[60.189076] Subtest basic: SUCCESS (2.048s)
[60.428323] [021/165] (937s left) gem_exec_fence (basic-busy)
[60.686435] Starting subtest: basic-busy
[60.687681] Starting dynamic subtest: rcs0
[60.708500] Dynamic subtest rcs0: SUCCESS (0.031s)
[60.719798] Starting dynamic subtest: bcs0
[60.744123] Dynamic subtest bcs0: SUCCESS (0.035s)
[60.758207] Starting dynamic subtest: vcs0
[60.784948] Dynamic subtest vcs0: SUCCESS (0.040s)
[60.801661] Starting dynamic subtest: vecs0
[60.808205] Dynamic subtest vecs0: SUCCESS (0.024s)
[60.809387] Subtest basic-busy: SUCCESS (0.131s)
[61.422309] [022/165] (936s left) gem_exec_fence (basic-wait)
[61.678165] Starting subtest: basic-wait
[61.679391] Starting dynamic subtest: rcs0
[61.692737] Dynamic subtest rcs0: SUCCESS (0.023s)
[61.704413] Starting dynamic subtest: bcs0
[61.719245] Dynamic subtest bcs0: SUCCESS (0.027s)
[61.730994] Starting dynamic subtest: vcs0
[61.747403] Dynamic subtest vcs0: SUCCESS (0.028s)
[61.759022] Starting dynamic subtest: vecs0
[61.772043] Dynamic subtest vecs0: SUCCESS (0.023s)
[61.773442] Subtest basic-wait: SUCCESS (0.101s)
[62.323464] [023/165] (935s left) gem_exec_fence (basic-await)
[62.581245] Starting subtest: basic-await
[62.582443] Starting dynamic subtest: rcs0
[62.674839] Dynamic subtest rcs0: SUCCESS (0.101s)
[62.693238] Starting dynamic subtest: bcs0
[62.779257] Dynamic subtest bcs0: SUCCESS (0.104s)
[62.806169] Starting dynamic subtest: vcs0
[62.921519] Dynamic subtest vcs0: SUCCESS (0.132s)
[62.947891] Starting dynamic subtest: vecs0
[63.043444] Dynamic subtest vecs0: SUCCESS (0.130s)
[63.045422] Subtest basic-await: SUCCESS (0.470s)
[63.624403] [024/165] (933s left) gem_exec_fence (nb-await)
[63.879285] Starting subtest: nb-await
[63.880509] Starting dynamic subtest: rcs0
[63.934773] Dynamic subtest rcs0: SUCCESS (0.063s)
[63.955727] Starting dynamic subtest: bcs0
[64.006535] Dynamic subtest bcs0: SUCCESS (0.071s)
[64.028709] Starting dynamic subtest: vcs0
[64.077816] Dynamic subtest vcs0: SUCCESS (0.070s)
[64.105503] Starting dynamic subtest: vecs0
[64.151875] Dynamic subtest vecs0: SUCCESS (0.074s)
[64.154093] Subtest nb-await: SUCCESS (0.280s)
[64.708925] [025/165] (932s left) gem_exec_gttfill (basic)
[64.817997] Starting subtest: basic
[70.940620] Subtest basic: SUCCESS (6.114s)
[71.130385] [026/165] (926s left) gem_exec_parallel (engines)
[71.314285] Starting subtest: engines
[71.317337] Starting dynamic subtest: basic
[73.623638] Dynamic subtest basic: SUCCESS (2.284s)
[73.637199] Starting dynamic subtest: contexts
[78.270067] Dynamic subtest contexts: SUCCESS (4.665s)
[78.283811] Starting dynamic subtest: fds
[87.412417] Dynamic subtest fds: SUCCESS (9.150s)
[87.437083] Starting dynamic subtest: userptr
[89.887273] Dynamic subtest userptr: SUCCESS (2.453s)
[89.889127] Subtest engines: SUCCESS (18.554s)
[90.110998] [027/165] (907s left) gem_exec_store (basic)
[90.220260] Starting subtest: basic
[90.276951] Subtest basic: SUCCESS (0.057s)
[90.485320] [028/165] (907s left) gem_flink_basic (bad-flink)
[90.580841] Starting subtest: bad-flink
[90.582209] Subtest bad-flink: SUCCESS (0.000s)
[90.667533] [029/165] (907s left) gem_flink_basic (bad-open)
[90.757662] Starting subtest: bad-open
[90.758863] Subtest bad-open: SUCCESS (0.000s)
[90.852859] [030/165] (906s left) gem_flink_basic (basic)
[90.943082] Starting subtest: basic
[90.944244] Subtest basic: SUCCESS (0.000s)
[91.052986] [031/165] (906s left) gem_flink_basic (double-flink)
[91.143689] Starting subtest: double-flink
[91.144815] Subtest double-flink: SUCCESS (0.000s)
[91.253114] [032/165] (906s left) gem_flink_basic (flink-lifetime)
[91.343602] Starting subtest: flink-lifetime
[91.346371] Subtest flink-lifetime: SUCCESS (0.002s)
[91.453472] [033/165] (906s left) gem_huc_copy (huc-copy)
[91.549329] Starting subtest: huc-copy
[91.551865] Subtest huc-copy: SKIP (0.000s)
[91.669783] [034/165] (906s left) gem_linear_blits (basic)
[91.909930] Starting subtest: basic
[91.922693] Subtest basic: SUCCESS (0.013s)
[92.058455] [035/165] (905s left) gem_mmap (basic)
[92.216312] Starting subtest: basic
[92.221634] Subtest basic: SUCCESS (0.000s)
[92.336417] [036/165] (905s left) gem_mmap_gtt (basic)
[92.426639] Starting subtest: basic
[92.427827] Subtest basic: SUCCESS (0.001s)
[92.514764] [037/165] (905s left) gem_render_linear_blits (basic)
[92.615236] Starting subtest: basic
[92.663769] Subtest basic: SUCCESS (0.049s)
[92.713258] [038/165] (905s left) gem_render_tiled_blits (basic)
[92.809215] Starting subtest: basic
[92.868263] Subtest basic: SUCCESS (0.059s)
[92.930712] [039/165] (905s left) gem_ringfill (basic-all)
[93.166303] Starting subtest: basic-all
[94.407749] Subtest basic-all: SUCCESS (1.232s)
[94.492252] [040/165] (903s left) gem_softpin (allocator-basic)
[94.590418] Starting subtest: allocator-basic
[94.762886] Subtest allocator-basic: SUCCESS (0.164s)
[94.888451] [041/165] (903s left) gem_softpin (allocator-basic-reserve)
[94.984919] Starting subtest: allocator-basic-reserve
[95.157222] Subtest allocator-basic-reserve: SUCCESS (0.164s)
[95.277547] [042/165] (902s left) gem_softpin (safe-alignment)
[95.374077] Starting subtest: safe-alignment
[95.391907] Subtest safe-alignment: SUCCESS (0.018s)
[95.508461] [043/165] (902s left) gem_sync (basic-all)
[95.617271] Starting subtest: basic-all
[97.843311] Subtest basic-all: SUCCESS (2.203s)
[98.023960] [044/165] (900s left) gem_sync (basic-each)
[98.140043] Starting subtest: basic-each
[100.436315] Subtest basic-each: SUCCESS (2.296s)
[100.676617] [045/165] (897s left) gem_tiled_blits (basic)
[100.895216] Starting subtest: basic
[100.922850] Subtest basic: SUCCESS (0.028s)
[101.067537] [046/165] (897s left) gem_tiled_fence_blits (basic)
[101.374087] Starting subtest: basic
[101.401354] Subtest basic: SUCCESS (0.027s)
[101.547262] [047/165] (896s left) gem_tiled_pread_basic
[102.064854] [048/165] (896s left) gem_wait (busy@all-engines)
[102.185772] Starting subtest: busy
[102.187056] Starting dynamic subtest: all-engines
[102.708483] Dynamic subtest all-engines: SUCCESS (0.523s)
[102.709560] Subtest busy: SUCCESS (0.523s)
[102.966228] [049/165] (895s left) gem_wait (wait@all-engines)
[103.081623] Starting subtest: wait
[103.082742] Starting dynamic subtest: all-engines
[104.129493] Dynamic subtest all-engines: SUCCESS (1.044s)
[104.130942] Subtest wait: SUCCESS (1.044s)
[104.383692] [050/165] (893s left) i915_getparams_basic (basic-eu-total)
[104.475167] Starting subtest: basic-eu-total
[104.477354] Subtest basic-eu-total: SUCCESS (0.000s)
[104.565616] [051/165] (893s left) i915_getparams_basic (basic-subslice-total)
[104.654257] Starting subtest: basic-subslice-total
[104.656476] Subtest basic-subslice-total: SUCCESS (0.000s)
[104.750509] [052/165] (893s left) i915_hangman (error-state-basic)
[104.857792] Starting subtest: error-state-basic
[104.871981] Subtest error-state-basic: SUCCESS (0.012s)
[104.965894] [053/165] (893s left) i915_pciid
[105.151532] [054/165] (893s left) kms_addfb_basic (addfb25-4-tiled)
[105.281173] Starting subtest: addfb25-4-tiled
[105.282298] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[105.384333] [055/165] (893s left) kms_addfb_basic (addfb25-bad-modifier)
[105.478081] Starting subtest: addfb25-bad-modifier
[105.479141] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[105.619500] [056/165] (892s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[105.712467] Starting subtest: addfb25-framebuffer-vs-set-tiling
[105.713525] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[105.834201] [057/165] (892s left) kms_addfb_basic (addfb25-modifier-no-flag)
[105.927169] Starting subtest: addfb25-modifier-no-flag
[105.928232] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[106.051866] [058/165] (892s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[106.144672] Starting subtest: addfb25-x-tiled-legacy
[106.145838] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[106.286696] [059/165] (892s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[106.380612] Starting subtest: addfb25-x-tiled-mismatch-legacy
[106.381694] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[106.519407] [060/165] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[106.642365] Starting subtest: addfb25-yf-tiled-legacy
[106.643463] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[106.752285] [061/165] (891s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[106.873215] Starting subtest: addfb25-y-tiled-legacy
[106.874357] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[106.987169] [062/165] (891s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[107.107259] Starting subtest: addfb25-y-tiled-small-legacy
[107.108521] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[107.220822] [063/165] (891s left) kms_addfb_basic (bad-pitch-0)
[107.313155] Starting subtest: bad-pitch-0
[107.314205] Subtest bad-pitch-0: SUCCESS (0.000s)
[107.436358] [064/165] (891s left) kms_addfb_basic (bad-pitch-1024)
[107.526615] Starting subtest: bad-pitch-1024
[107.527789] Subtest bad-pitch-1024: SUCCESS (0.000s)
[107.654046] [065/165] (891s left) kms_addfb_basic (bad-pitch-128)
[107.746762] Starting subtest: bad-pitch-128
[107.747858] Subtest bad-pitch-128: SUCCESS (0.000s)
[107.870420] [066/165] (890s left) kms_addfb_basic (bad-pitch-256)
[107.963176] Starting subtest: bad-pitch-256
[107.964222] Subtest bad-pitch-256: SUCCESS (0.000s)
[108.083342] [067/165] (890s left) kms_addfb_basic (bad-pitch-32)
[108.174227] Starting subtest: bad-pitch-32
[108.175342] Subtest bad-pitch-32: SUCCESS (0.000s)
[108.304445] [068/165] (890s left) kms_addfb_basic (bad-pitch-63)
[108.396242] Starting subtest: bad-pitch-63
[108.397421] Subtest bad-pitch-63: SUCCESS (0.000s)
[108.522040] [069/165] (890s left) kms_addfb_basic (bad-pitch-65536)
[108.613426] Starting subtest: bad-pitch-65536
[108.614534] Subtest bad-pitch-65536: SUCCESS (0.000s)
[108.738031] [070/165] (890s left) kms_addfb_basic (bad-pitch-999)
[108.829830] Starting subtest: bad-pitch-999
[108.830936] Subtest bad-pitch-999: SUCCESS (0.000s)
[108.953301] [071/165] (889s left) kms_addfb_basic (basic)
[109.046199] Starting subtest: basic
[109.047416] Subtest basic: SUCCESS (0.000s)
[109.171963] [072/165] (889s left) kms_addfb_basic (basic-x-tiled-legacy)
[109.265157] Starting subtest: basic-x-tiled-legacy
[109.266198] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[109.384141] [073/165] (889s left) kms_addfb_basic (basic-y-tiled-legacy)
[109.475568] Starting subtest: basic-y-tiled-legacy
[109.476641] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[109.605941] [074/165] (889s left) kms_addfb_basic (bo-too-small)
[109.727191] Starting subtest: bo-too-small
[109.728386] Subtest bo-too-small: SUCCESS (0.000s)
[109.822607] [075/165] (889s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[109.944100] Starting subtest: bo-too-small-due-to-tiling
[109.945193] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[110.057179] [076/165] (888s left) kms_addfb_basic (clobberred-modifier)
[110.149554] Starting subtest: clobberred-modifier
[110.150888] Subtest clobberred-modifier: SUCCESS (0.000s)
[110.274177] [077/165] (888s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[110.367078] Starting subtest: framebuffer-vs-set-tiling
[110.368154] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[110.484706] [078/165] (888s left) kms_addfb_basic (invalid-get-prop)
[110.576357] Starting subtest: invalid-get-prop
[110.577552] Subtest invalid-get-prop: SUCCESS (0.000s)
[110.707335] [079/165] (888s left) kms_addfb_basic (invalid-get-prop-any)
[110.801307] Starting subtest: invalid-get-prop-any
[110.802346] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[110.939703] [080/165] (888s left) kms_addfb_basic (invalid-set-prop)
[111.030751] Starting subtest: invalid-set-prop
[111.032087] Subtest invalid-set-prop: SUCCESS (0.000s)
[111.160450] [081/165] (888s left) kms_addfb_basic (invalid-set-prop-any)
[111.252640] Starting subtest: invalid-set-prop-any
[111.253700] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[111.389755] [082/165] (887s left) kms_addfb_basic (no-handle)
[111.481773] Starting subtest: no-handle
[111.483051] Subtest no-handle: SUCCESS (0.000s)
[111.624926] [083/165] (887s left) kms_addfb_basic (size-max)
[111.746320] Starting subtest: size-max
[111.747448] Subtest size-max: SUCCESS (0.000s)
[111.857198] [084/165] (887s left) kms_addfb_basic (small-bo)
[111.976754] Starting subtest: small-bo
[111.977918] Subtest small-bo: SUCCESS (0.000s)
[112.073548] [085/165] (887s left) kms_addfb_basic (tile-pitch-mismatch)
[112.167665] Starting subtest: tile-pitch-mismatch
[112.168706] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[112.291908] [086/165] (887s left) kms_addfb_basic (too-high)
[112.410169] Starting subtest: too-high
[112.411405] Subtest too-high: SUCCESS (0.001s)
[112.526418] [087/165] (886s left) kms_addfb_basic (too-wide)
[112.646604] Starting subtest: too-wide
[112.647741] Subtest too-wide: SUCCESS (0.000s)
[112.742076] [088/165] (886s left) kms_addfb_basic (unused-handle)
[112.832133] Starting subtest: unused-handle
[112.833275] Subtest unused-handle: SUCCESS (0.000s)
[112.956496] [089/165] (886s left) kms_addfb_basic (unused-modifier)
[113.046676] Starting subtest: unused-modifier
[113.047773] Subtest unused-modifier: SUCCESS (0.000s)
[113.154199] [090/165] (886s left) kms_addfb_basic (unused-offsets)
[113.248204] Starting subtest: unused-offsets
[113.249325] Subtest unused-offsets: SUCCESS (0.000s)
[113.376573] [091/165] (886s left) kms_addfb_basic (unused-pitches)
[113.469403] Starting subtest: unused-pitches
[113.470488] Subtest unused-pitches: SUCCESS (0.000s)
[113.610809] [092/165] (885s left) kms_busy (basic)
[113.738271] Starting subtest: basic
[113.739608] Starting dynamic subtest: flip
[114.740515] Dynamic subtest flip: SUCCESS (1.002s)
[114.757329] Starting dynamic subtest: modeset
[118.575532] Dynamic subtest modeset: SUCCESS (3.835s)
[118.576835] Subtest basic: SUCCESS (4.840s)
[119.550686] [093/165] (879s left) kms_prop_blob (basic)
[119.644366] Starting subtest: basic
[119.645544] Subtest basic: SUCCESS (0.000s)
[119.733273] [094/165] (879s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[119.854297] Starting subtest: basic-busy-flip-before-cursor-atomic
[119.856303] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[119.942585] [095/165] (879s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[120.061089] Starting subtest: basic-busy-flip-before-cursor-legacy
[120.063126] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[120.142748] [096/165] (879s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[120.258684] Starting subtest: basic-flip-after-cursor-atomic
[121.561970] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.303s)
[122.491198] [097/165] (877s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[122.609823] Starting subtest: basic-flip-after-cursor-legacy
[123.918560] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.308s)
[124.859224] [098/165] (874s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[124.976304] Starting subtest: basic-flip-after-cursor-varying-size
[126.254092] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.277s)
[127.225794] [099/165] (872s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[127.345620] Starting subtest: basic-flip-before-cursor-atomic
[128.656152] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.311s)
[129.594605] [100/165] (870s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[129.714292] Starting subtest: basic-flip-before-cursor-legacy
[131.023238] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.308s)
[131.961372] [101/165] (867s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[132.079574] Starting subtest: basic-flip-before-cursor-varying-size
[133.390782] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.310s)
[134.305595] [102/165] (865s left) kms_dsc (dsc-basic)
[134.428771] Subtest dsc-basic: SKIP (0.000s)
[134.482027] [103/165] (865s left) kms_flip (basic-flip-vs-dpms)
[134.585140] Starting subtest: basic-flip-vs-dpms
[134.587616] Starting dynamic subtest: A-eDP1
[137.477819] Dynamic subtest A-eDP1: SUCCESS (2.890s)
[137.506716] Starting dynamic subtest: B-eDP1
[139.891381] Dynamic subtest B-eDP1: SUCCESS (2.408s)
[139.906855] Starting dynamic subtest: C-eDP1
[142.287160] Dynamic subtest C-eDP1: SUCCESS (2.399s)
[142.292765] Subtest basic-flip-vs-dpms: SUCCESS (7.707s)
[143.203973] [104/165] (856s left) kms_flip (basic-flip-vs-modeset)
[143.305137] Starting subtest: basic-flip-vs-modeset
[143.308055] Starting dynamic subtest: A-eDP1
[146.160351] Dynamic subtest A-eDP1: SUCCESS (2.847s)
[146.175338] Starting dynamic subtest: B-eDP1
[148.527203] Dynamic subtest B-eDP1: SUCCESS (2.370s)
[148.544950] Starting dynamic subtest: C-eDP1
[150.893841] Dynamic subtest C-eDP1: SUCCESS (2.366s)
[150.897241] Subtest basic-flip-vs-modeset: SUCCESS (7.592s)
[151.867424] [105/165] (847s left) kms_flip (basic-flip-vs-wf_vblank)
[151.969314] Starting subtest: basic-flip-vs-wf_vblank
[151.972201] Starting dynamic subtest: A-eDP1
[154.329464] Dynamic subtest A-eDP1: SUCCESS (2.356s)
[154.347732] Starting dynamic subtest: B-eDP1
[156.616471] Dynamic subtest B-eDP1: SUCCESS (2.285s)
[156.634805] Starting dynamic subtest: C-eDP1
[158.855554] Dynamic subtest C-eDP1: SUCCESS (2.236s)
[158.860452] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.892s)
[160.185438] [106/165] (839s left) kms_flip (basic-plain-flip)
[160.284436] Starting subtest: basic-plain-flip
[160.287978] Starting dynamic subtest: A-eDP1
[162.367119] Dynamic subtest A-eDP1: SUCCESS (2.078s)
[162.388800] Starting dynamic subtest: B-eDP1
[164.331846] Dynamic subtest B-eDP1: SUCCESS (1.962s)
[164.351103] Starting dynamic subtest: C-eDP1
[166.315349] Dynamic subtest C-eDP1: SUCCESS (1.982s)
[166.320246] Subtest basic-plain-flip: SUCCESS (6.036s)
[167.613581] [107/165] (832s left) kms_force_connector_basic (force-connector-state)
[167.711216] Starting subtest: force-connector-state
[168.329778] Subtest force-connector-state: SUCCESS (0.617s)
[169.353398] [108/165] (830s left) kms_force_connector_basic (force-edid)
[169.448467] Starting subtest: force-edid
[169.708138] Subtest force-edid: SUCCESS (0.259s)
[169.834180] [109/165] (830s left) kms_force_connector_basic (force-load-detect)
[169.929575] Starting subtest: force-load-detect
[169.931738] Subtest force-load-detect: SKIP (0.000s)
[170.048927] [110/165] (829s left) kms_force_connector_basic (prune-stale-modes)
[170.144606] Starting subtest: prune-stale-modes
[170.459891] Subtest prune-stale-modes: SUCCESS (0.316s)
[170.604426] [111/165] (829s left) kms_frontbuffer_tracking (basic)
[170.730461] Starting subtest: basic
[174.067914] Subtest basic: SUCCESS (3.338s)
[174.211608] [112/165] (825s left) kms_hdmi_inject (inject-audio)
[174.640095] Starting subtest: inject-audio
[174.966170] Subtest inject-audio: SUCCESS (0.327s)
[175.570246] [113/165] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[175.690323] Starting subtest: compare-crc-sanitycheck-xr24
[175.702515] Starting dynamic subtest: pipe-A-eDP-1
[176.383875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[176.417663] Starting dynamic subtest: pipe-B-eDP-1
[177.818716] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s)
[177.843659] Starting dynamic subtest: pipe-C-eDP-1
[179.202016] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[179.203142] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.512s)
[180.155117] [114/165] (819s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[180.276114] Starting subtest: compare-crc-sanitycheck-nv12
[180.277182] Starting dynamic subtest: pipe-A-eDP-1
[181.215229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.934s)
[181.232534] Starting dynamic subtest: pipe-B-eDP-1
[182.628274] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[182.651455] Starting dynamic subtest: pipe-C-eDP-1
[184.002969] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[184.004436] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.726s)
[184.916656] [115/165] (815s left) kms_pipe_crc_basic (hang-read-crc)
[185.037852] Starting subtest: hang-read-crc
[185.040479] Starting dynamic subtest: pipe-A-eDP-1
[187.444066] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.403s)
[187.463893] Starting dynamic subtest: pipe-B-eDP-1
[190.543183] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.096s)
[190.562263] Starting dynamic subtest: pipe-C-eDP-1
[193.501955] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.954s)
[193.503628] Subtest hang-read-crc: SUCCESS (8.464s)
[194.426946] [116/165] (805s left) kms_pipe_crc_basic (nonblocking-crc)
[194.549391] Starting subtest: nonblocking-crc
[194.552184] Starting dynamic subtest: pipe-A-eDP-1
[195.456192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.900s)
[195.481284] Starting dynamic subtest: pipe-B-eDP-1
[197.079153] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.617s)
[197.113509] Starting dynamic subtest: pipe-C-eDP-1
[198.627559] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.540s)
[198.629252] Subtest nonblocking-crc: SUCCESS (4.077s)
[199.544807] [117/165] (800s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[199.668132] Starting subtest: nonblocking-crc-frame-sequence
[199.670864] Starting dynamic subtest: pipe-A-eDP-1
[200.572475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.902s)
[200.591956] Starting dynamic subtest: pipe-B-eDP-1
[202.190749] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.612s)
[202.207995] Starting dynamic subtest: pipe-C-eDP-1
[203.735976] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s)
[203.737252] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.068s)
[204.665761] [118/165] (795s left) kms_pipe_crc_basic (read-crc)
[204.786239] Starting subtest: read-crc
[204.789249] Starting dynamic subtest: pipe-A-eDP-1
[205.609325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s)
[205.629157] Starting dynamic subtest: pipe-B-eDP-1
[207.163747] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s)
[207.191575] Starting dynamic subtest: pipe-C-eDP-1
[208.659097] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.488s)
[208.660278] Subtest read-crc: SUCCESS (3.873s)
[209.596657] [119/165] (790s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[209.716598] Starting subtest: read-crc-frame-sequence
[209.719333] Starting dynamic subtest: pipe-A-eDP-1
[210.542770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[210.569459] Starting dynamic subtest: pipe-B-eDP-1
[212.111132] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.561s)
[212.133700] Starting dynamic subtest: pipe-C-eDP-1
[213.606267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[213.607460] Subtest read-crc-frame-sequence: SUCCESS (3.889s)
[214.521984] [120/165] (785s left) kms_pm_backlight (basic-brightness)
[214.643394] Starting subtest: basic-brightness
[214.748043] Starting dynamic subtest: eDP-1
[215.316747] Dynamic subtest eDP-1: SUCCESS (0.568s)
[215.318061] Subtest basic-brightness: SUCCESS (0.673s)
[216.252718] [121/165] (784s left) kms_pm_rpm (basic-pci-d3-state)
[218.088118] Starting subtest: basic-pci-d3-state
[222.483314] Subtest basic-pci-d3-state: SUCCESS (4.395s)
[222.689821] [122/165] (777s left) kms_pm_rpm (basic-rte)
[222.789051] Starting subtest: basic-rte
[228.947359] Subtest basic-rte: SUCCESS (6.155s)
[230.430115] [123/165] (769s left) kms_psr (primary_page_flip)
[230.554774] Starting subtest: primary_page_flip
[234.415614] Subtest primary_page_flip: SUCCESS (3.861s)
[235.387088] [124/165] (765s left) kms_psr (cursor_plane_move)
[235.511473] Starting subtest: cursor_plane_move
[239.312559] Subtest cursor_plane_move: SUCCESS (3.801s)
[240.250198] [125/165] (760s left) kms_psr (sprite_plane_onoff)
[240.374243] Starting subtest: sprite_plane_onoff
[244.275252] Subtest sprite_plane_onoff: SUCCESS (3.901s)
[245.242277] [126/165] (755s left) kms_psr (primary_mmap_gtt)
[245.366707] Starting subtest: primary_mmap_gtt
[249.195360] Subtest primary_mmap_gtt: SUCCESS (3.826s)
[250.175623] [127/165] (750s left) kms_setmode (basic-clone-single-crtc)
[250.269417] Starting subtest: basic-clone-single-crtc
[250.272738] Subtest basic-clone-single-crtc: SKIP (0.000s)
[250.354764] [128/165] (750s left) i915_pm_rps (basic-api)
[250.453393] Starting subtest: basic-api
[250.457866] Subtest basic-api: SUCCESS (0.005s)
[250.555194] [129/165] (750s left) prime_self_import (basic-llseek-bad)
[250.644199] Starting subtest: basic-llseek-bad
[250.648767] Subtest basic-llseek-bad: SUCCESS (0.003s)
[250.756112] [130/165] (749s left) prime_self_import (basic-llseek-size)
[250.844215] Starting subtest: basic-llseek-size
[250.848672] Subtest basic-llseek-size: SUCCESS (0.004s)
[250.956772] [131/165] (749s left) prime_self_import (basic-with_fd_dup)
[251.046457] Starting subtest: basic-with_fd_dup
[251.050743] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[251.173887] [132/165] (749s left) prime_self_import (basic-with_one_bo)
[251.262767] Starting subtest: basic-with_one_bo
[251.267343] Subtest basic-with_one_bo: SUCCESS (0.005s)
[251.350969] [133/165] (749s left) prime_self_import (basic-with_one_bo_two_files)
[251.439679] Starting subtest: basic-with_one_bo_two_files
[251.444355] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[251.557806] [134/165] (749s left) prime_self_import (basic-with_two_bos)
[251.649993] Starting subtest: basic-with_two_bos
[251.652402] Subtest basic-with_two_bos: SUCCESS (0.004s)
[251.759526] [135/165] (749s left) prime_vgem (basic-fence-flip)
[251.891752] Starting subtest: basic-fence-flip
[252.415441] Subtest basic-fence-flip: SUCCESS (0.522s)
[252.543102] [136/165] (748s left) prime_vgem (basic-fence-mmap)
[252.657099] Starting subtest: basic-fence-mmap
[252.708268] Subtest basic-fence-mmap: SUCCESS (0.051s)
[252.809835] [137/165] (748s left) prime_vgem (basic-fence-read)
[252.936865] Starting subtest: basic-fence-read
[253.014566] Subtest basic-fence-read: SUCCESS (0.078s)
[253.109975] [138/165] (747s left) prime_vgem (basic-gtt)
[253.223679] Starting subtest: basic-gtt
[253.249058] Subtest basic-gtt: SUCCESS (0.025s)
[253.344886] [139/165] (747s left) prime_vgem (basic-read)
[253.477183] Starting subtest: basic-read
[253.515429] Subtest basic-read: SUCCESS (0.038s)
[253.626189] [140/165] (747s left) prime_vgem (basic-write)
[253.749663] Starting subtest: basic-write
[253.794234] Subtest basic-write: SUCCESS (0.045s)
[253.892082] [141/165] (747s left) vgem_basic (setversion)
[254.000298] Starting subtest: setversion
[254.002770] Subtest setversion: SUCCESS (0.000s)
[254.075325] [142/165] (746s left) vgem_basic (create)
[254.183715] Starting subtest: create
[254.185045] Subtest create: SUCCESS (0.000s)
[254.259079] [143/165] (746s left) vgem_basic (debugfs)
[254.367576] Starting subtest: debugfs
[254.368898] Subtest debugfs: SUCCESS (0.001s)
[254.440549] [144/165] (746s left) vgem_basic (dmabuf-export)
[254.533732] Starting subtest: dmabuf-export
[254.538364] Subtest dmabuf-export: SUCCESS (0.003s)
[254.663054] [145/165] (746s left) vgem_basic (dmabuf-fence)
[254.768111] Starting subtest: dmabuf-fence
[254.769495] Subtest dmabuf-fence: SUCCESS (0.001s)
[254.842514] [146/165] (746s left) vgem_basic (dmabuf-fence-before)
[254.934310] Starting subtest: dmabuf-fence-before
[254.935388] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[255.009329] [147/165] (746s left) vgem_basic (dmabuf-mmap)
[255.118328] Starting subtest: dmabuf-mmap
[255.143749] Subtest dmabuf-mmap: SUCCESS (0.026s)
[255.225271] [148/165] (745s left) vgem_basic (mmap)
[255.334649] Starting subtest: mmap
[255.351997] Subtest mmap: SUCCESS (0.017s)
[255.424592] [149/165] (745s left) vgem_basic (second-client)
[255.535263] Starting subtest: second-client
[255.569912] Subtest second-client: SUCCESS (0.033s)
[255.643924] [150/165] (745s left) vgem_basic (sysfs)
[255.752319] Starting subtest: sysfs
[255.753476] Subtest sysfs: SUCCESS (0.001s)
[255.826390] [151/165] (745s left) core_hotunplug (unbind-rebind)
[255.968505] Starting subtest: unbind-rebind
[260.473330] Subtest unbind-rebind: SUCCESS (4.505s)
[260.510390] [152/165] (740s left) vgem_basic (unload)
[260.607043] Starting subtest: unload
[289.657254] Subtest unload: SUCCESS (29.016s)
[289.764802] [153/165] (711s left) i915_module_load (reload)
[289.859900] Starting subtest: reload
[293.251628] Subtest reload: SUCCESS (3.392s)
[293.281917] [154/165] (708s left) gem_lmem_swapping (basic)
[293.394359] Subtest basic: SKIP (0.000s)
[293.436422] [155/165] (707s left) gem_lmem_swapping (parallel-random-engines)
[293.532107] Subtest parallel-random-engines: SKIP (0.000s)
[293.587677] [156/165] (707s left) gem_lmem_swapping (random-engines)
[293.685284] Subtest random-engines: SKIP (0.000s)
[293.736757] [157/165] (707s left) gem_lmem_swapping (verify-random)
[293.834765] Subtest verify-random: SKIP (0.000s)
[293.887278] [158/165] (707s left) i915_pm_rpm (module-reload)
[306.349226] Starting subtest: module-reload
[335.645879] Subtest module-reload: SUCCESS (29.290s)
[335.669179] [159/165] (665s left) i915_selftest (live)
[335.773922] Starting subtest: live
[335.775241] Starting dynamic subtest: sanitycheck
[337.623604] Dynamic subtest sanitycheck: SUCCESS (1.842s)
[337.638387] Starting dynamic subtest: uncore
[339.477428] Dynamic subtest uncore: SUCCESS (1.850s)
[339.492527] Starting dynamic subtest: workarounds
[341.579380] Dynamic subtest workarounds: SUCCESS (2.098s)
[341.594408] Starting dynamic subtest: gt_engines
[343.871488] Dynamic subtest gt_engines: SUCCESS (2.288s)
[343.886501] Starting dynamic subtest: gt_timelines
[356.596557] Dynamic subtest gt_timelines: SUCCESS (12.721s)
[356.611682] Starting dynamic subtest: gt_contexts
[358.565551] Dynamic subtest gt_contexts: SUCCESS (1.966s)
[358.580318] Starting dynamic subtest: gt_lrc
[363.050219] Dynamic subtest gt_lrc: SUCCESS (4.481s)
[363.065471] Starting dynamic subtest: gt_mocs
[365.012212] Dynamic subtest gt_mocs: SUCCESS (1.959s)
[365.027498] Starting dynamic subtest: gt_pm
[370.132709] Dynamic subtest gt_pm: SUCCESS (5.117s)
[370.147694] Starting dynamic subtest: gt_heartbeat
[372.053442] Dynamic subtest gt_heartbeat: SUCCESS (1.917s)
[372.068165] Starting dynamic subtest: gt_tlb
[375.205555] Dynamic subtest gt_tlb: SUCCESS (3.148s)
[375.220396] Starting dynamic subtest: requests
[382.843732] Dynamic subtest requests: SUCCESS (7.634s)
[382.858815] Starting dynamic subtest: migrate
[387.470781] Dynamic subtest migrate: SUCCESS (4.623s)
[387.486036] Starting dynamic subtest: active
[389.367534] Dynamic subtest active: SUCCESS (1.893s)
[389.382427] Starting dynamic subtest: objects
[392.768211] Dynamic subtest objects: SUCCESS (3.397s)
[392.783660] Starting dynamic subtest: mman
[399.675503] Dynamic subtest mman: SUCCESS (6.904s)
[399.690707] Starting dynamic subtest: dmabuf
[401.580958] Dynamic subtest dmabuf: SUCCESS (1.901s)
[401.596751] Starting dynamic subtest: vma
[403.420532] Dynamic subtest vma: SUCCESS (1.836s)
[403.435625] Starting dynamic subtest: coherency
[409.899568] Dynamic subtest coherency: SUCCESS (6.475s)
[409.914587] Starting dynamic subtest: gtt
[419.324134] Dynamic subtest gtt: SUCCESS (9.420s)
[419.344096] Starting dynamic subtest: gem
[421.360474] Dynamic subtest gem: SUCCESS (2.033s)
[421.376169] Starting dynamic subtest: evict
[425.171763] Dynamic subtest evict: SUCCESS (3.808s)
[425.187234] Starting dynamic subtest: hugepages
[432.993067] Dynamic subtest hugepages: SUCCESS (7.818s)
[433.008982] Starting dynamic subtest: gem_contexts
[448.088413] Dynamic subtest gem_contexts: SUCCESS (15.092s)
[448.104141] Starting dynamic subtest: client
[450.018479] Dynamic subtest client: SUCCESS (1.927s)
[450.034247] Starting dynamic subtest: gem_migrate
[451.861966] Dynamic subtest gem_migrate: SUCCESS (1.844s)
[451.877200] Starting dynamic subtest: reset
[457.272624] Dynamic subtest reset: SUCCESS (5.403s)
[457.288465] Starting dynamic subtest: memory_region
[459.154664] Dynamic subtest memory_region: SUCCESS (1.878s)
[459.170600] Starting dynamic subtest: hangcheck
[483.558662] Dynamic subtest hangcheck: SUCCESS (24.400s)
[483.574646] Starting dynamic subtest: execlists
[493.814093] Dynamic subtest execlists: SUCCESS (10.252s)
[493.830108] Starting dynamic subtest: ring_submission
[495.698475] Dynamic subtest ring_submission: SUCCESS (1.881s)
[495.714603] Starting dynamic subtest: perf
[497.648447] Dynamic subtest perf: SUCCESS (1.947s)
[497.664193] Starting dynamic subtest: slpc
[499.492430] Dynamic subtest slpc: SUCCESS (1.841s)
[499.508158] Starting dynamic subtest: guc
[501.344373] Dynamic subtest guc: SUCCESS (1.848s)
[501.359972] Starting dynamic subtest: guc_multi_lrc
[503.196526] Dynamic subtest guc_multi_lrc: SUCCESS (1.848s)
[503.212275] Starting dynamic subtest: guc_hang
[505.061598] Dynamic subtest guc_hang: SUCCESS (1.861s)
[505.077208] Starting dynamic subtest: late_gt_pm
[506.959477] Dynamic subtest late_gt_pm: SUCCESS (1.894s)
[506.960714] Subtest live: SUCCESS (171.181s)
[506.985559] [160/165] (494s left) dmabuf (all-tests)
[507.084165] Starting subtest: all-tests
[507.085809] Starting dynamic subtest: sanitycheck
[507.148777] Dynamic subtest sanitycheck: SUCCESS (0.063s)
[507.168697] Starting dynamic subtest: dma_fence
[507.339937] Dynamic subtest dma_fence: SUCCESS (0.187s)
[507.360954] Starting dynamic subtest: dma_fence_chain
[524.966229] Dynamic subtest dma_fence_chain: SUCCESS (17.614s)
[524.979437] Starting dynamic subtest: dma_fence_unwrap
[525.045625] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[525.064860] Starting dynamic subtest: dma_resv
[525.107685] Dynamic subtest dma_resv: SUCCESS (0.058s)
[525.109983] Subtest all-tests: SUCCESS (18.025s)
[525.139894] [161/165] (476s left) i915_suspend (basic-s2idle-without-i915)
[525.229349] Starting subtest: basic-s2idle-without-i915
[548.744899] Subtest basic-s2idle-without-i915: SUCCESS (8.238s)
[549.135086] [162/165] (467s left) i915_suspend (basic-s3-without-i915)
[549.227968] Starting subtest: basic-s3-without-i915
[572.797015] Subtest basic-s3-without-i915: SUCCESS (6.804s)
[573.182811] [163/165] (460s left) gem_exec_suspend (basic-s0)
[573.300513] Starting subtest: basic-S0
[573.301719] Starting dynamic subtest: smem
[592.953417] Dynamic subtest smem: SUCCESS (3.807s)
[592.954625] Subtest basic-S0: SUCCESS (3.809s)
[593.169944] [164/165] (456s left) gem_exec_suspend (basic-s3)
[593.277945] Starting subtest: basic-S3
[593.279199] Starting dynamic subtest: smem
[611.984010] Dynamic subtest smem: SUCCESS (3.723s)
[611.985391] Subtest basic-S3: SUCCESS (3.725s)
[612.185699] [165/165] (452s left) kms_pipe_crc_basic (suspend-read-crc)
[612.312749] Starting subtest: suspend-read-crc
[612.314092] Starting dynamic subtest: pipe-A-eDP-1
[629.933260] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.535s)
[629.975972] Starting dynamic subtest: pipe-B-eDP-1
[647.912198] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.148s)
[647.959252] Starting dynamic subtest: pipe-C-eDP-1
[665.894343] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.120s)
[665.896299] Subtest suspend-read-crc: SUCCESS (8.826s)
[666.799067] Closing watchdogs
Done.