[35.266284] Initializing watchdogs
[35.266458]   /dev/watchdog0
[35.293637] [001/171] (960s left) i915_module_load (load)
[35.447991] Starting subtest: load
[36.829584] Subtest load: SUCCESS (1.371s)
[36.935086] [002/171] (958s left) core_auth (basic-auth)
[37.094299] Starting subtest: basic-auth
[37.115785] Subtest basic-auth: SUCCESS (0.000s)
[37.188673] [003/171] (958s left) debugfs_test (read_all_entries)
[37.338540] Starting subtest: read_all_entries
[37.379307] Subtest read_all_entries: SUCCESS (0.047s)
[37.478732] [004/171] (958s left) debugfs_test (basic-hwmon)
[37.617643] Starting subtest: basic-hwmon
[37.655112] Subtest basic-hwmon: SKIP (0.000s)
[37.738140] [005/171] (958s left) fbdev (eof)
[37.862999] Starting subtest: eof
[37.885249] Subtest eof: SUCCESS (0.000s)
[37.963998] [006/171] (958s left) fbdev (info)
[38.084058] Starting subtest: info
[38.106557] Subtest info: SUCCESS (0.000s)
[38.182242] [007/171] (957s left) fbdev (nullptr)
[38.324288] Starting subtest: nullptr
[38.345853] Subtest nullptr: SUCCESS (0.000s)
[38.419100] [008/171] (957s left) fbdev (read)
[38.561642] Starting subtest: read
[38.686412] Subtest read: SUCCESS (0.128s)
[38.757187] [009/171] (957s left) fbdev (write)
[38.900358] Starting subtest: write
[38.959564] Subtest write: SUCCESS (0.068s)
[39.042656] [010/171] (957s left) gem_basic (bad-close)
[39.166349] Starting subtest: bad-close
[39.204734] Subtest bad-close: SUCCESS (0.000s)
[39.282547] [011/171] (957s left) gem_basic (create-close)
[39.404394] Starting subtest: create-close
[39.444362] Subtest create-close: SUCCESS (0.000s)
[39.522701] [012/171] (956s left) gem_basic (create-fd-close)
[39.660554] Starting subtest: create-fd-close
[39.704672] Subtest create-fd-close: SUCCESS (0.000s)
[39.778114] [013/171] (956s left) gem_busy (busy@all-engines)
[39.928265] Starting subtest: busy
[39.949516] Starting dynamic subtest: all-engines
[39.969461] Dynamic subtest all-engines: SUCCESS (0.018s)
[39.988770] Subtest busy: SUCCESS (0.018s)
[40.290600] [014/171] (956s left) gem_close_race (basic-process)
[40.415559] Starting subtest: basic-process
[40.459749] Subtest basic-process: SUCCESS (0.031s)
[40.638029] [015/171] (956s left) gem_close_race (basic-threads)
[40.779175] Starting subtest: basic-threads
[41.957578] Subtest basic-threads: SUCCESS (1.185s)
[42.143892] [016/171] (954s left) gem_ctx_create (basic)
[42.289733] Starting subtest: basic
[42.311562] Subtest basic: SUCCESS (0.000s)
[42.457202] [017/171] (954s left) gem_ctx_create (basic-files)
[42.600367] Starting subtest: basic-files
[44.630505] Subtest basic-files: SUCCESS (2.010s)
[44.901801] [018/171] (951s left) gem_ctx_exec (basic)
[45.054838] Starting subtest: basic
[45.077272] Subtest basic: SUCCESS (0.003s)
[45.152970] [019/171] (951s left) gem_exec_basic (basic)
[45.301609] Starting subtest: basic
[45.322980] Starting dynamic subtest: rcs0-smem
[45.343036] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[45.366076] Starting dynamic subtest: bcs0-smem
[45.385207] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[45.409918] Starting dynamic subtest: vcs0-smem
[45.430585] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[45.452626] Subtest basic: SUCCESS (0.002s)
[45.528795] [020/171] (951s left) gem_exec_create (basic)
[45.661788] Starting subtest: basic
[45.682563] Starting dynamic subtest: smem
[47.692318] Dynamic subtest smem: SUCCESS (2.038s)
[47.711323] Subtest basic: SUCCESS (2.038s)
[47.912404] [021/171] (949s left) gem_exec_fence (basic-busy)
[48.160114] Starting subtest: basic-busy
[48.180340] Starting dynamic subtest: rcs0
[48.218350] Dynamic subtest rcs0: SUCCESS (0.033s)
[48.243268] Starting dynamic subtest: bcs0
[48.285705] Dynamic subtest bcs0: SUCCESS (0.026s)
[48.311143] Starting dynamic subtest: vcs0
[48.351755] Dynamic subtest vcs0: SUCCESS (0.031s)
[48.371775] Subtest basic-busy: SUCCESS (0.090s)
[48.757731] [022/171] (948s left) gem_exec_fence (basic-wait)
[48.978506] Starting subtest: basic-wait
[48.997698] Starting dynamic subtest: rcs0
[49.018277] Dynamic subtest rcs0: SUCCESS (0.028s)
[49.045522] Starting dynamic subtest: bcs0
[49.067492] Dynamic subtest bcs0: SUCCESS (0.021s)
[49.092351] Starting dynamic subtest: vcs0
[49.112405] Dynamic subtest vcs0: SUCCESS (0.021s)
[49.131633] Subtest basic-wait: SUCCESS (0.070s)
[49.758766] [023/171] (947s left) gem_exec_fence (basic-await)
[50.020571] Starting subtest: basic-await
[50.047880] Starting dynamic subtest: rcs0
[50.099104] Dynamic subtest rcs0: SUCCESS (0.063s)
[50.128160] Starting dynamic subtest: bcs0
[50.189318] Dynamic subtest bcs0: SUCCESS (0.062s)
[50.216540] Starting dynamic subtest: vcs0
[50.241858] Dynamic subtest vcs0: SUCCESS (0.063s)
[50.267899] Subtest basic-await: SUCCESS (0.189s)
[50.674958] [024/171] (946s left) gem_exec_fence (nb-await)
[50.940457] Starting subtest: nb-await
[50.967945] Starting dynamic subtest: rcs0
[50.995118] Dynamic subtest rcs0: SUCCESS (0.053s)
[51.029070] Starting dynamic subtest: bcs0
[51.056476] Dynamic subtest bcs0: SUCCESS (0.052s)
[51.085398] Starting dynamic subtest: vcs0
[51.112094] Dynamic subtest vcs0: SUCCESS (0.052s)
[51.139706] Subtest nb-await: SUCCESS (0.157s)
[51.558515] [025/171] (945s left) gem_exec_gttfill (basic)
[51.720209] Starting subtest: basic
[54.091411] Subtest basic: SUCCESS (2.393s)
[54.294063] [026/171] (943s left) gem_exec_parallel (engines)
[54.527120] Starting subtest: engines
[54.545363] Starting dynamic subtest: basic
[55.921841] Dynamic subtest basic: SUCCESS (1.399s)
[55.947815] Starting dynamic subtest: contexts
[57.457217] Dynamic subtest contexts: SUCCESS (1.542s)
[57.481641] Starting dynamic subtest: fds
[59.212787] Dynamic subtest fds: SUCCESS (1.753s)
[59.237571] Starting dynamic subtest: userptr
[60.660183] Dynamic subtest userptr: SUCCESS (1.444s)
[60.680819] Subtest engines: SUCCESS (6.139s)
[60.849719] [027/171] (936s left) gem_exec_store (basic)
[61.039750] Starting subtest: basic
[61.059887] Subtest basic: SUCCESS (0.030s)
[61.196185] [028/171] (936s left) gem_flink_basic (bad-flink)
[61.334182] Starting subtest: bad-flink
[61.354864] Subtest bad-flink: SUCCESS (0.000s)
[61.434290] [029/171] (936s left) gem_flink_basic (bad-open)
[61.570988] Starting subtest: bad-open
[61.592690] Subtest bad-open: SUCCESS (0.000s)
[61.670592] [030/171] (936s left) gem_flink_basic (basic)
[61.810214] Starting subtest: basic
[61.831855] Subtest basic: SUCCESS (0.000s)
[61.907649] [031/171] (936s left) gem_flink_basic (double-flink)
[62.048795] Starting subtest: double-flink
[62.069993] Subtest double-flink: SUCCESS (0.000s)
[62.143827] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[62.288157] Starting subtest: flink-lifetime
[62.308417] Subtest flink-lifetime: SUCCESS (0.001s)
[62.380516] [033/171] (935s left) gem_huc_copy (huc-copy)
[62.545153] Subtest huc-copy: SKIP (0.000s)
[62.619874] [034/171] (935s left) gem_linear_blits (basic)
[62.842182] Starting subtest: basic
[62.862671] Subtest basic: SUCCESS (0.005s)
[62.978268] [035/171] (935s left) gem_mmap (basic)
[63.210815] Starting subtest: basic
[63.313867] Subtest basic: SUCCESS (0.000s)
[63.386563] [036/171] (934s left) gem_mmap_gtt (basic)
[63.534434] Starting subtest: basic
[63.553722] Subtest basic: SUCCESS (0.000s)
[63.632250] [037/171] (934s left) gem_render_linear_blits (basic)
[63.770868] Starting subtest: basic
[63.876315] Subtest basic: SUCCESS (0.019s)
[63.948915] [038/171] (934s left) gem_render_tiled_blits (basic)
[64.101105] Starting subtest: basic
[64.221754] Subtest basic: SUCCESS (0.022s)
[64.297273] [039/171] (934s left) gem_ringfill (basic-all)
[64.546428] Starting subtest: basic-all
[65.627914] Subtest basic-all: SUCCESS (1.114s)
[65.730059] [040/171] (932s left) gem_softpin (allocator-basic)
[65.896787] Subtest allocator-basic: SKIP (0.000s)
[65.970610] [041/171] (932s left) gem_softpin (allocator-basic-reserve)
[66.135989] Subtest allocator-basic-reserve: SKIP (0.000s)
[66.208265] [042/171] (932s left) gem_softpin (safe-alignment)
[66.371321] Starting subtest: safe-alignment
[66.390621] Subtest safe-alignment: SUCCESS (0.005s)
[66.464284] [043/171] (932s left) gem_sync (basic-all)
[66.646904] Starting subtest: basic-all
[68.765248] Subtest basic-all: SUCCESS (2.154s)
[68.961208] [044/171] (929s left) gem_sync (basic-each)
[69.146768] Starting subtest: basic-each
[71.214053] Subtest basic-each: SUCCESS (2.108s)
[71.401565] [045/171] (927s left) gem_tiled_blits (basic)
[71.599421] Starting subtest: basic
[71.620709] Subtest basic: SUCCESS (0.014s)
[71.742104] [046/171] (927s left) gem_tiled_fence_blits (basic)
[72.044295] Starting subtest: basic
[72.063898] Subtest basic: SUCCESS (0.007s)
[72.196289] [047/171] (926s left) gem_tiled_pread_basic
[72.595863] [048/171] (926s left) gem_wait (busy@all-engines)
[72.742349] Starting subtest: busy
[72.762427] Starting dynamic subtest: all-engines
[73.253635] Dynamic subtest all-engines: SUCCESS (0.521s)
[73.273103] Subtest busy: SUCCESS (0.521s)
[73.478571] [049/171] (925s left) gem_wait (wait@all-engines)
[73.595468] Starting subtest: wait
[73.617023] Starting dynamic subtest: all-engines
[74.618305] Dynamic subtest all-engines: SUCCESS (1.012s)
[74.637847] Subtest wait: SUCCESS (1.012s)
[74.808553] [050/171] (924s left) i915_getparams_basic (basic-eu-total)
[74.948555] Starting subtest: basic-eu-total
[74.987072] Subtest basic-eu-total: SUCCESS (0.000s)
[75.066975] [051/171] (924s left) i915_getparams_basic (basic-subslice-total)
[75.203561] Starting subtest: basic-subslice-total
[75.247786] Subtest basic-subslice-total: SUCCESS (0.000s)
[75.323712] [052/171] (923s left) i915_hangman (error-state-basic)
[75.473227] Starting subtest: error-state-basic
[75.494225] Subtest error-state-basic: SUCCESS (0.007s)
[75.566264] [053/171] (923s left) i915_pciid
[75.803286] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[75.957128] Starting subtest: addfb25-bad-modifier
[75.976275] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[76.131271] [055/171] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[76.274610] Starting subtest: addfb25-framebuffer-vs-set-tiling
[76.296424] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[76.375241] [056/171] (923s left) kms_addfb_basic (addfb25-modifier-no-flag)
[76.511458] Starting subtest: addfb25-modifier-no-flag
[76.532821] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[76.610675] [057/171] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[76.750450] Starting subtest: addfb25-x-tiled-legacy
[76.770843] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[76.846919] [058/171] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[76.988120] Starting subtest: addfb25-x-tiled-mismatch-legacy
[77.008120] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[77.080427] [059/171] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[77.228423] Starting subtest: addfb25-yf-tiled-legacy
[77.246737] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[77.322742] [060/171] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[77.460968] Starting subtest: addfb25-y-tiled-legacy
[77.479810] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[77.578526] [061/171] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[77.714519] Starting subtest: addfb25-y-tiled-small-legacy
[77.758193] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[77.834637] [062/171] (921s left) kms_addfb_basic (bad-pitch-0)
[77.969086] Starting subtest: bad-pitch-0
[77.987499] Subtest bad-pitch-0: SUCCESS (0.000s)
[78.110149] [063/171] (921s left) kms_addfb_basic (bad-pitch-1024)
[78.268864] Starting subtest: bad-pitch-1024
[78.294756] Subtest bad-pitch-1024: SUCCESS (0.000s)
[78.386529] [064/171] (921s left) kms_addfb_basic (bad-pitch-128)
[78.547955] Starting subtest: bad-pitch-128
[78.571616] Subtest bad-pitch-128: SUCCESS (0.000s)
[78.671639] [065/171] (921s left) kms_addfb_basic (bad-pitch-256)
[78.836070] Starting subtest: bad-pitch-256
[78.861017] Subtest bad-pitch-256: SUCCESS (0.000s)
[78.970639] [066/171] (921s left) kms_addfb_basic (bad-pitch-32)
[79.128794] Starting subtest: bad-pitch-32
[79.154915] Subtest bad-pitch-32: SUCCESS (0.000s)
[79.253891] [067/171] (920s left) kms_addfb_basic (bad-pitch-63)
[79.416862] Starting subtest: bad-pitch-63
[79.443684] Subtest bad-pitch-63: SUCCESS (0.000s)
[79.538471] [068/171] (920s left) kms_addfb_basic (bad-pitch-65536)
[79.715062] Starting subtest: bad-pitch-65536
[79.741525] Subtest bad-pitch-65536: SUCCESS (0.000s)
[79.838920] [069/171] (920s left) kms_addfb_basic (bad-pitch-999)
[79.987406] Starting subtest: bad-pitch-999
[80.013817] Subtest bad-pitch-999: SUCCESS (0.000s)
[80.091638] [070/171] (920s left) kms_addfb_basic (basic)
[80.235288] Starting subtest: basic
[80.254127] Subtest basic: SUCCESS (0.000s)
[80.352485] [071/171] (920s left) kms_addfb_basic (basic-x-tiled-legacy)
[80.490742] Starting subtest: basic-x-tiled-legacy
[80.509307] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[80.588530] [072/171] (919s left) kms_addfb_basic (basic-y-tiled-legacy)
[80.724986] Starting subtest: basic-y-tiled-legacy
[80.745202] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[80.845255] [073/171] (919s left) kms_addfb_basic (bo-too-small)
[80.982600] Starting subtest: bo-too-small
[81.003747] Subtest bo-too-small: SUCCESS (0.000s)
[81.080191] [074/171] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[81.220699] Starting subtest: bo-too-small-due-to-tiling
[81.242325] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[81.316883] [075/171] (919s left) kms_addfb_basic (clobberred-modifier)
[81.458841] Starting subtest: clobberred-modifier
[81.479190] Subtest clobberred-modifier: SUCCESS (0.000s)
[81.572847] [076/171] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[81.713175] Starting subtest: framebuffer-vs-set-tiling
[81.731833] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[81.829494] [077/171] (918s left) kms_addfb_basic (invalid-get-prop)
[81.968976] Starting subtest: invalid-get-prop
[81.989020] Subtest invalid-get-prop: SUCCESS (0.000s)
[82.070442] [078/171] (918s left) kms_addfb_basic (invalid-get-prop-any)
[82.186524] Starting subtest: invalid-get-prop-any
[82.207631] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[82.286843] [079/171] (918s left) kms_addfb_basic (invalid-set-prop)
[82.421441] Starting subtest: invalid-set-prop
[82.442596] Subtest invalid-set-prop: SUCCESS (0.000s)
[82.540455] [080/171] (918s left) kms_addfb_basic (invalid-set-prop-any)
[82.683158] Starting subtest: invalid-set-prop-any
[82.704038] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[82.776378] [081/171] (918s left) kms_addfb_basic (no-handle)
[82.927252] Starting subtest: no-handle
[82.946091] Subtest no-handle: SUCCESS (0.000s)
[83.020526] [082/171] (918s left) kms_addfb_basic (size-max)
[83.161755] Starting subtest: size-max
[83.180159] Subtest size-max: SUCCESS (0.000s)
[83.255144] [083/171] (917s left) kms_addfb_basic (small-bo)
[83.394330] Starting subtest: small-bo
[83.412437] Subtest small-bo: SUCCESS (0.000s)
[83.490281] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[83.626091] Starting subtest: tile-pitch-mismatch
[83.644305] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[83.726557] [085/171] (917s left) kms_addfb_basic (too-high)
[83.883990] Starting subtest: too-high
[83.905656] Subtest too-high: SUCCESS (0.001s)
[83.981163] [086/171] (917s left) kms_addfb_basic (too-wide)
[84.124143] Starting subtest: too-wide
[84.144686] Subtest too-wide: SUCCESS (0.000s)
[84.219645] [087/171] (917s left) kms_addfb_basic (unused-handle)
[84.361715] Starting subtest: unused-handle
[84.381450] Subtest unused-handle: SUCCESS (0.000s)
[84.455171] [088/171] (917s left) kms_addfb_basic (unused-modifier)
[84.597701] Starting subtest: unused-modifier
[84.616261] Subtest unused-modifier: SUCCESS (0.000s)
[84.690985] [089/171] (916s left) kms_addfb_basic (unused-offsets)
[84.830730] Starting subtest: unused-offsets
[84.849143] Subtest unused-offsets: SUCCESS (0.000s)
[84.924847] [090/171] (916s left) kms_addfb_basic (unused-pitches)
[85.062956] Starting subtest: unused-pitches
[85.081562] Subtest unused-pitches: SUCCESS (0.000s)
[85.160243] [091/171] (916s left) kms_busy (basic)
[85.326152] Starting subtest: basic
[85.348142] Starting dynamic subtest: flip
[85.926860] Dynamic subtest flip: SUCCESS (0.614s)
[85.953271] Starting dynamic subtest: modeset
[86.436765] Dynamic subtest modeset: SUCCESS (0.509s)
[86.455315] Subtest basic: SUCCESS (1.124s)
[86.608424] [092/171] (915s left) kms_chamelium_hpd (dp-hpd-fast)
[86.809675] Subtest dp-hpd-fast: SKIP (0.000s)
[86.927865] [093/171] (914s left) kms_chamelium_edid (dp-edid-read)
[87.132890] Subtest dp-edid-read: SKIP (0.000s)
[87.257805] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast)
[87.464231] Subtest dp-crc-fast: SKIP (0.000s)
[87.588194] [095/171] (914s left) kms_chamelium_hpd (hdmi-hpd-fast)
[87.785504] Subtest hdmi-hpd-fast: SKIP (0.000s)
[87.896344] [096/171] (914s left) kms_chamelium_edid (hdmi-edid-read)
[88.092586] Subtest hdmi-edid-read: SKIP (0.000s)
[88.212021] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast)
[88.411443] Subtest hdmi-crc-fast: SKIP (0.000s)
[88.559817] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast)
[88.761438] Subtest vga-hpd-fast: SKIP (0.000s)
[88.880319] [099/171] (913s left) kms_chamelium_edid (vga-edid-read)
[89.076653] Subtest vga-edid-read: SKIP (0.000s)
[89.214264] [100/171] (913s left) kms_prop_blob (basic)
[89.365816] Starting subtest: basic
[89.386313] Subtest basic: SUCCESS (0.000s)
[89.458280] [101/171] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[89.613705] Starting subtest: basic-busy-flip-before-cursor-atomic
[90.553893] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.934s)
[90.710230] [102/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[90.870839] Starting subtest: basic-busy-flip-before-cursor-legacy
[91.816116] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.954s)
[91.980711] [103/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[92.115671] Starting subtest: basic-flip-after-cursor-atomic
[93.049185] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.927s)
[93.218037] [104/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[93.377571] Starting subtest: basic-flip-after-cursor-legacy
[94.296640] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.932s)
[94.467916] [105/171] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[94.609517] Starting subtest: basic-flip-after-cursor-varying-size
[95.545516] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.939s)
[95.710960] [106/171] (907s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[95.847075] Starting subtest: basic-flip-before-cursor-atomic
[96.796670] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.928s)
[96.952991] [107/171] (906s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[97.127505] Starting subtest: basic-flip-before-cursor-legacy
[98.090324] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.947s)
[98.268426] [108/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[98.431927] Starting subtest: basic-flip-before-cursor-varying-size
[99.378253] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[99.551167] [109/171] (903s left) kms_flip (basic-flip-vs-dpms)
[99.749461] Starting subtest: basic-flip-vs-dpms
[99.772821] Starting dynamic subtest: A-VGA1
[100.692087] Dynamic subtest A-VGA1: SUCCESS (0.952s)
[100.723062] Starting dynamic subtest: B-VGA1
[101.572180] Dynamic subtest B-VGA1: SUCCESS (0.880s)
[101.604657] Starting dynamic subtest: C-VGA1
[102.434341] Dynamic subtest C-VGA1: SUCCESS (0.880s)
[102.453778] Subtest basic-flip-vs-dpms: SUCCESS (2.715s)
[102.609428] [110/171] (900s left) kms_flip (basic-flip-vs-modeset)
[102.774930] Starting subtest: basic-flip-vs-modeset
[102.796203] Starting dynamic subtest: A-VGA1
[103.602266] Dynamic subtest A-VGA1: SUCCESS (0.854s)
[103.627154] Starting dynamic subtest: B-VGA1
[104.391295] Dynamic subtest B-VGA1: SUCCESS (0.787s)
[104.415358] Starting dynamic subtest: C-VGA1
[105.176476] Dynamic subtest C-VGA1: SUCCESS (0.788s)
[105.194638] Subtest basic-flip-vs-modeset: SUCCESS (2.432s)
[105.356570] [111/171] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[105.519684] Starting subtest: basic-flip-vs-wf_vblank
[105.539200] Starting dynamic subtest: A-VGA1
[106.640326] Dynamic subtest A-VGA1: SUCCESS (1.150s)
[106.668111] Starting dynamic subtest: B-VGA1
[107.765783] Dynamic subtest B-VGA1: SUCCESS (1.124s)
[107.791636] Starting dynamic subtest: C-VGA1
[108.890813] Dynamic subtest C-VGA1: SUCCESS (1.125s)
[108.910741] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.402s)
[109.087851] [112/171] (894s left) kms_flip (basic-plain-flip)
[109.250758] Starting subtest: basic-plain-flip
[109.269552] Starting dynamic subtest: A-VGA1
[110.090460] Dynamic subtest A-VGA1: SUCCESS (0.864s)
[110.115915] Starting dynamic subtest: B-VGA1
[110.931883] Dynamic subtest B-VGA1: SUCCESS (0.839s)
[110.958595] Starting dynamic subtest: C-VGA1
[111.779713] Dynamic subtest C-VGA1: SUCCESS (0.847s)
[111.798032] Subtest basic-plain-flip: SUCCESS (2.554s)
[111.996622] [113/171] (891s left) kms_force_connector_basic (force-connector-state)
[112.145258] Starting subtest: force-connector-state
[112.296321] Subtest force-connector-state: SUCCESS (0.145s)
[112.492717] [114/171] (891s left) kms_force_connector_basic (force-edid)
[112.630459] Starting subtest: force-edid
[112.691299] Subtest force-edid: SUCCESS (0.057s)
[112.810359] [115/171] (890s left) kms_force_connector_basic (force-load-detect)
[112.949207] Starting subtest: force-load-detect
[113.091162] Subtest force-load-detect: SUCCESS (0.138s)
[113.269827] [116/171] (890s left) kms_force_connector_basic (prune-stale-modes)
[113.410467] Starting subtest: prune-stale-modes
[113.428990] Subtest prune-stale-modes: SUCCESS (0.015s)
[113.546561] [117/171] (890s left) kms_frontbuffer_tracking (basic)
[113.750691] Starting subtest: basic
[115.521998] Subtest basic: SUCCESS (1.829s)
[115.647147] [118/171] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[115.795487] Starting subtest: compare-crc-sanitycheck
[115.816685] Starting dynamic subtest: pipe-A-VGA-1
[116.063564] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.263s)
[116.090523] Starting dynamic subtest: pipe-B-VGA-1
[116.330978] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.266s)
[116.357032] Starting dynamic subtest: pipe-C-VGA-1
[116.605340] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.273s)
[116.624751] Subtest compare-crc-sanitycheck: SUCCESS (0.804s)
[116.776177] [119/171] (887s left) kms_pipe_crc_basic (hang-read-crc)
[116.913845] Starting subtest: hang-read-crc
[116.932461] Starting dynamic subtest: pipe-A-VGA-1
[117.686472] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.763s)
[117.715412] Starting dynamic subtest: pipe-B-VGA-1
[118.475020] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.764s)
[118.508803] Starting dynamic subtest: pipe-C-VGA-1
[119.234199] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.774s)
[119.261189] Subtest hang-read-crc: SUCCESS (2.303s)
[119.402288] [120/171] (884s left) kms_pipe_crc_basic (nonblocking-crc)
[119.560169] Starting subtest: nonblocking-crc
[119.583843] Starting dynamic subtest: pipe-A-VGA-1
[120.036615] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.453s)
[120.065678] Starting dynamic subtest: pipe-B-VGA-1
[120.466923] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.446s)
[120.493883] Starting dynamic subtest: pipe-C-VGA-1
[120.913658] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.454s)
[120.932205] Subtest nonblocking-crc: SUCCESS (1.354s)
[121.071764] [121/171] (883s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[121.216030] Starting subtest: nonblocking-crc-frame-sequence
[121.236536] Starting dynamic subtest: pipe-A-VGA-1
[121.669601] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.453s)
[121.693735] Starting dynamic subtest: pipe-B-VGA-1
[122.122239] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.448s)
[122.148371] Starting dynamic subtest: pipe-C-VGA-1
[122.577040] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.451s)
[122.595747] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.353s)
[122.754254] [122/171] (881s left) kms_pipe_crc_basic (read-crc)
[122.895118] Starting subtest: read-crc
[122.923533] Starting dynamic subtest: pipe-A-VGA-1
[123.281938] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.382s)
[123.305957] Starting dynamic subtest: pipe-B-VGA-1
[123.658743] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.381s)
[123.686130] Starting dynamic subtest: pipe-C-VGA-1
[124.055637] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.388s)
[124.074250] Subtest read-crc: SUCCESS (1.153s)
[124.211338] [123/171] (880s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[124.347817] Starting subtest: read-crc-frame-sequence
[124.369329] Starting dynamic subtest: pipe-A-VGA-1
[124.744791] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.385s)
[124.771697] Starting dynamic subtest: pipe-B-VGA-1
[125.121877] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.380s)
[125.146165] Starting dynamic subtest: pipe-C-VGA-1
[125.511282] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.387s)
[125.531827] Subtest read-crc-frame-sequence: SUCCESS (1.154s)
[125.666429] [124/171] (878s left) kms_psr (primary_page_flip)
[125.837990] Subtest primary_page_flip: SKIP (0.000s)
[125.919120] [125/171] (878s left) kms_psr (cursor_plane_move)
[126.077869] Subtest cursor_plane_move: SKIP (0.000s)
[126.158281] [126/171] (878s left) kms_psr (sprite_plane_onoff)
[126.319467] Subtest sprite_plane_onoff: SKIP (0.000s)
[126.397201] [127/171] (878s left) kms_psr (primary_mmap_gtt)
[126.537380] Subtest primary_mmap_gtt: SKIP (0.000s)
[126.614208] [128/171] (878s left) kms_setmode (basic-clone-single-crtc)
[126.753115] Starting subtest: basic-clone-single-crtc
[126.819066] Subtest basic-clone-single-crtc: SKIP (0.000s)
[126.892783] [129/171] (877s left) i915_pm_backlight (basic-brightness)
[127.061834] Subtest basic-brightness: SKIP (0.000s)
[127.137810] [130/171] (877s left) i915_pm_rpm (basic-pci-d3-state)
[138.447052] Subtest basic-pci-d3-state: SKIP (0.000s)
[138.523563] [131/171] (866s left) i915_pm_rpm (basic-rte)
[138.663763] Starting subtest: basic-rte
[149.837851] Subtest basic-rte: SKIP (11.117s)
[149.957053] [132/171] (855s left) i915_pm_rps (basic-api)
[150.107439] Starting subtest: basic-api
[150.129303] Subtest basic-api: SUCCESS (0.002s)
[150.204257] [133/171] (854s left) prime_self_import (basic-llseek-bad)
[150.356150] Starting subtest: basic-llseek-bad
[150.375884] Subtest basic-llseek-bad: SUCCESS (0.001s)
[150.449749] [134/171] (854s left) prime_self_import (basic-llseek-size)
[150.573912] Starting subtest: basic-llseek-size
[150.593690] Subtest basic-llseek-size: SUCCESS (0.002s)
[150.666979] [135/171] (854s left) prime_self_import (basic-with_fd_dup)
[150.799545] Starting subtest: basic-with_fd_dup
[150.819210] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[150.893349] [136/171] (854s left) prime_self_import (basic-with_one_bo)
[151.037057] Starting subtest: basic-with_one_bo
[151.056308] Subtest basic-with_one_bo: SUCCESS (0.002s)
[151.132964] [137/171] (854s left) prime_self_import (basic-with_one_bo_two_files)
[151.274041] Starting subtest: basic-with_one_bo_two_files
[151.293439] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[151.372621] [138/171] (854s left) prime_self_import (basic-with_two_bos)
[151.510543] Starting subtest: basic-with_two_bos
[151.529656] Subtest basic-with_two_bos: SUCCESS (0.002s)
[151.610551] [139/171] (853s left) prime_vgem (basic-fence-flip)
[151.752097] Starting subtest: basic-fence-flip
[152.074220] Subtest basic-fence-flip: SUCCESS (0.314s)
[152.189804] [140/171] (853s left) prime_vgem (basic-fence-mmap)
[152.326923] Starting subtest: basic-fence-mmap
[152.346169] Subtest basic-fence-mmap: SUCCESS (0.022s)
[152.446474] [141/171] (853s left) prime_vgem (basic-fence-read)
[152.580590] Starting subtest: basic-fence-read
[152.624679] Subtest basic-fence-read: SUCCESS (0.039s)
[152.722857] [142/171] (852s left) prime_vgem (basic-gtt)
[152.865580] Starting subtest: basic-gtt
[152.886563] Subtest basic-gtt: SUCCESS (0.010s)
[152.979288] [143/171] (852s left) prime_vgem (basic-read)
[153.104306] Starting subtest: basic-read
[153.123821] Subtest basic-read: SUCCESS (0.015s)
[153.220380] [144/171] (852s left) prime_vgem (basic-write)
[153.359019] Starting subtest: basic-write
[153.377850] Subtest basic-write: SUCCESS (0.018s)
[153.479725] [145/171] (852s left) prime_vgem (basic-userptr)
[153.615232] Starting subtest: basic-userptr
[153.659027] Subtest basic-userptr: SKIP (0.007s)
[153.755914] [146/171] (852s left) vgem_basic (setversion)
[153.905619] Starting subtest: setversion
[153.946161] Subtest setversion: SUCCESS (0.000s)
[154.019978] [147/171] (852s left) vgem_basic (create)
[154.163775] Starting subtest: create
[154.182978] Subtest create: SUCCESS (0.000s)
[154.257830] [148/171] (851s left) vgem_basic (debugfs)
[154.390554] Starting subtest: debugfs
[154.416035] Subtest debugfs: SUCCESS (0.000s)
[154.510460] [149/171] (851s left) vgem_basic (dmabuf-export)
[154.640495] Starting subtest: dmabuf-export
[154.828257] Subtest dmabuf-export: SUCCESS (0.001s)
[154.930077] [150/171] (851s left) vgem_basic (dmabuf-fence)
[155.087066] Starting subtest: dmabuf-fence
[155.112488] Subtest dmabuf-fence: SUCCESS (0.001s)
[155.207685] [151/171] (851s left) vgem_basic (dmabuf-fence-before)
[155.368227] Starting subtest: dmabuf-fence-before
[155.398104] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[155.504067] [152/171] (850s left) vgem_basic (dmabuf-mmap)
[155.671657] Starting subtest: dmabuf-mmap
[155.699684] Subtest dmabuf-mmap: SUCCESS (0.014s)
[155.805466] [153/171] (850s left) vgem_basic (mmap)
[155.971434] Starting subtest: mmap
[155.998147] Subtest mmap: SUCCESS (0.010s)
[156.093174] [154/171] (850s left) vgem_basic (second-client)
[156.246254] Starting subtest: second-client
[156.272416] Subtest second-client: SUCCESS (0.049s)
[156.366443] [155/171] (850s left) vgem_basic (sysfs)
[156.527487] Starting subtest: sysfs
[156.551460] Subtest sysfs: SUCCESS (0.001s)
[156.647635] [156/171] (850s left) core_hotunplug (unbind-rebind)
[156.869594] Starting subtest: unbind-rebind
[157.614622] Subtest unbind-rebind: SUCCESS (0.738s)
[157.710241] [157/171] (849s left) vgem_basic (unload)
[157.835818] Starting subtest: unload
[186.761927] Subtest unload: SUCCESS (28.748s)
[186.842867] [158/171] (820s left) i915_module_load (reload)
[186.986536] Starting subtest: reload
[188.772530] Subtest reload: SUCCESS (1.796s)
[188.864919] [159/171] (818s left) gem_lmem_swapping (basic)
[189.061615] Subtest basic: SKIP (0.000s)
[189.160597] [160/171] (818s left) gem_lmem_swapping (parallel-random-engines)
[189.324277] Subtest parallel-random-engines: SKIP (0.000s)
[189.401131] [161/171] (817s left) gem_lmem_swapping (random-engines)
[189.564356] Subtest random-engines: SKIP (0.000s)
[189.638281] [162/171] (817s left) gem_lmem_swapping (verify-random)
[189.802351] Subtest verify-random: SKIP (0.000s)
[189.875988] [163/171] (817s left) i915_pm_rpm (module-reload)
[201.351318] Subtest module-reload: SKIP (0.000s)
[201.424452] [164/171] (806s left) i915_selftest (live)
[202.122673] Starting subtest: live
[202.144113] Starting dynamic subtest: sanitycheck
[202.712471] Dynamic subtest sanitycheck: SUCCESS (0.592s)
[202.738613] Starting dynamic subtest: uncore
[203.193891] Dynamic subtest uncore: SUCCESS (0.478s)
[203.222809] Starting dynamic subtest: workarounds
[203.806567] Dynamic subtest workarounds: SUCCESS (0.614s)
[203.834861] Starting dynamic subtest: gt_engines
[204.313454] Dynamic subtest gt_engines: SUCCESS (0.505s)
[204.339272] Starting dynamic subtest: gt_timelines
[209.233281] Dynamic subtest gt_timelines: SUCCESS (4.921s)
[209.260125] Starting dynamic subtest: gt_contexts
[209.811075] Dynamic subtest gt_contexts: SUCCESS (0.575s)
[209.838934] Starting dynamic subtest: gt_lrc
[210.375457] Dynamic subtest gt_lrc: SUCCESS (0.562s)
[210.404357] Starting dynamic subtest: gt_mocs
[210.924484] Dynamic subtest gt_mocs: SUCCESS (0.552s)
[210.950621] Starting dynamic subtest: gt_pm
[219.557611] Dynamic subtest gt_pm: SUCCESS (8.631s)
[219.584981] Starting dynamic subtest: gt_heartbeat
[220.163348] Dynamic subtest gt_heartbeat: SUCCESS (0.606s)
[220.189836] Starting dynamic subtest: requests
[225.354118] Dynamic subtest requests: SUCCESS (5.190s)
[225.380887] Starting dynamic subtest: migrate
[225.877973] Dynamic subtest migrate: SUCCESS (0.522s)
[225.903624] Starting dynamic subtest: active
[226.424284] Dynamic subtest active: SUCCESS (0.548s)
[226.450284] Starting dynamic subtest: objects
[227.335563] Dynamic subtest objects: SUCCESS (0.910s)
[227.360380] Starting dynamic subtest: mman
[231.225155] Dynamic subtest mman: SUCCESS (3.889s)
[231.253444] Starting dynamic subtest: dmabuf
[231.764991] Dynamic subtest dmabuf: SUCCESS (0.538s)
[231.791136] Starting dynamic subtest: vma
[232.304770] Dynamic subtest vma: SUCCESS (0.538s)
[232.332414] Starting dynamic subtest: coherency
[233.890088] Dynamic subtest coherency: SUCCESS (1.584s)
[233.915372] Starting dynamic subtest: gtt
[237.671613] Dynamic subtest gtt: SUCCESS (3.780s)
[237.699627] Starting dynamic subtest: gem
[238.270272] Dynamic subtest gem: SUCCESS (0.594s)
[238.305230] Starting dynamic subtest: evict
[238.825082] Dynamic subtest evict: SUCCESS (0.552s)
[238.858301] Starting dynamic subtest: hugepages
[240.455264] Dynamic subtest hugepages: SUCCESS (1.636s)
[240.482732] Starting dynamic subtest: gem_contexts
[244.737329] Dynamic subtest gem_contexts: SUCCESS (4.282s)
[244.765113] Starting dynamic subtest: client
[245.284598] Dynamic subtest client: SUCCESS (0.549s)
[245.309583] Starting dynamic subtest: gem_migrate
[245.829905] Dynamic subtest gem_migrate: SUCCESS (0.542s)
[245.856894] Starting dynamic subtest: reset
[246.369917] Dynamic subtest reset: SUCCESS (0.542s)
[246.395176] Starting dynamic subtest: memory_region
[246.912027] Dynamic subtest memory_region: SUCCESS (0.539s)
[246.938993] Starting dynamic subtest: hangcheck
[260.195833] Dynamic subtest hangcheck: SUCCESS (13.283s)
[260.223449] Starting dynamic subtest: execlists
[260.690492] Dynamic subtest execlists: SUCCESS (0.497s)
[260.716284] Starting dynamic subtest: ring_submission
[261.251317] Dynamic subtest ring_submission: SUCCESS (0.557s)
[261.278661] Starting dynamic subtest: perf
[261.755547] Dynamic subtest perf: SUCCESS (0.506s)
[261.782281] Starting dynamic subtest: slpc
[262.292387] Dynamic subtest slpc: SUCCESS (0.534s)
[262.320326] Starting dynamic subtest: guc
[262.828862] Dynamic subtest guc: SUCCESS (0.538s)
[262.855170] Starting dynamic subtest: guc_multi_lrc
[263.403247] Dynamic subtest guc_multi_lrc: SUCCESS (0.571s)
[263.431661] Starting dynamic subtest: guc_hang
[263.880424] Dynamic subtest guc_hang: SUCCESS (0.479s)
[263.906839] Starting dynamic subtest: late_gt_pm
[264.430383] Dynamic subtest late_gt_pm: SUCCESS (0.547s)
[264.451882] Subtest live: SUCCESS (62.308s)
[264.556651] [165/171] (743s left) dmabuf (all-tests)
[264.698452] Starting subtest: all-tests
[264.719668] Starting dynamic subtest: sanitycheck
[264.738852] Dynamic subtest sanitycheck: SUCCESS (0.039s)
[264.763190] Starting dynamic subtest: dma_fence
[264.870872] Dynamic subtest dma_fence: SUCCESS (0.131s)
[264.895295] Starting dynamic subtest: dma_fence_chain
[276.964329] Dynamic subtest dma_fence_chain: SUCCESS (11.983s)
[276.993416] Starting dynamic subtest: dma_fence_unwrap
[277.012649] Dynamic subtest dma_fence_unwrap: SUCCESS (0.022s)
[277.037949] Starting dynamic subtest: dma_resv
[277.059972] Dynamic subtest dma_resv: SUCCESS (0.026s)
[277.082054] Subtest all-tests: SUCCESS (12.204s)
[277.159983] [166/171] (730s left) i915_suspend (basic-s2idle-without-i915)
[277.289549] Starting subtest: basic-s2idle-without-i915
[294.288083] Subtest basic-s2idle-without-i915: SUCCESS (2.319s)
[297.352370] [167/171] (728s left) i915_suspend (basic-s3-without-i915)
[297.477865] Starting subtest: basic-s3-without-i915
[316.150553] Subtest basic-s3-without-i915: SUCCESS (1.864s)
[319.153183] [168/171] (726s left) gem_exec_suspend (basic-s0)
[319.307105] Starting subtest: basic-S0
[319.328184] Starting dynamic subtest: smem
[337.113010] Dynamic subtest smem: SUCCESS (1.803s)
[337.134378] Subtest basic-S0: SUCCESS (1.803s)
[340.007470] [169/171] (724s left) gem_exec_suspend (basic-s3)
[340.153078] Starting subtest: basic-S3
[340.172199] Starting dynamic subtest: smem
[358.955224] Dynamic subtest smem: SUCCESS (1.720s)
[358.976111] Subtest basic-S3: SUCCESS (1.721s)
[362.311240] [170/171] (722s left) kms_chamelium_hpd (common-hpd-after-suspend)
[362.512841] Subtest common-hpd-after-suspend: SKIP (0.000s)
[362.643787] [171/171] (721s left) kms_pipe_crc_basic (suspend-read-crc)
[362.784367] Starting subtest: suspend-read-crc
[362.805075] Starting dynamic subtest: pipe-A-VGA-1
[382.129778] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.797s)
[382.156756] Starting dynamic subtest: pipe-B-VGA-1
[401.149993] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.876s)
[401.179365] Starting dynamic subtest: pipe-C-VGA-1
[420.152031] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.874s)
[420.172458] Subtest suspend-read-crc: SUCCESS (5.550s)
[423.269358] Closing watchdogs
Done.