[36.191270] Initializing watchdogs
[36.191457]   /dev/watchdog0
[36.217639] [001/171] (960s left) i915_module_load (load)
[36.368854] Starting subtest: load
[37.760103] Subtest load: SUCCESS (1.392s)
[37.894211] [002/171] (958s left) core_auth (basic-auth)
[38.068141] Starting subtest: basic-auth
[38.088337] Subtest basic-auth: SUCCESS (0.000s)
[38.158992] [003/171] (958s left) debugfs_test (read_all_entries)
[38.303696] Starting subtest: read_all_entries
[38.343062] Subtest read_all_entries: SUCCESS (0.039s)
[38.416951] [004/171] (958s left) debugfs_test (basic-hwmon)
[38.552795] Starting subtest: basic-hwmon
[38.590190] Subtest basic-hwmon: SKIP (0.000s)
[38.669753] [005/171] (958s left) fbdev (eof)
[38.813762] Starting subtest: eof
[38.836118] Subtest eof: SUCCESS (0.000s)
[38.913473] [006/171] (958s left) fbdev (info)
[39.057424] Starting subtest: info
[39.079718] Subtest info: SUCCESS (0.000s)
[39.154758] [007/171] (957s left) fbdev (nullptr)
[39.275204] Starting subtest: nullptr
[39.297440] Subtest nullptr: SUCCESS (0.000s)
[39.372682] [008/171] (957s left) fbdev (read)
[39.510474] Starting subtest: read
[39.631464] Subtest read: SUCCESS (0.130s)
[39.701929] [009/171] (957s left) fbdev (write)
[39.844462] Starting subtest: write
[39.898544] Subtest write: SUCCESS (0.065s)
[39.974905] [010/171] (957s left) gem_basic (bad-close)
[40.093999] Starting subtest: bad-close
[40.132737] Subtest bad-close: SUCCESS (0.000s)
[40.209199] [011/171] (957s left) gem_basic (create-close)
[40.345359] Starting subtest: create-close
[40.387053] Subtest create-close: SUCCESS (0.000s)
[40.464425] [012/171] (956s left) gem_basic (create-fd-close)
[40.603443] Starting subtest: create-fd-close
[40.647119] Subtest create-fd-close: SUCCESS (0.000s)
[40.720232] [013/171] (956s left) gem_busy (busy@all-engines)
[40.867057] Starting subtest: busy
[40.888408] Starting dynamic subtest: all-engines
[40.907820] Dynamic subtest all-engines: SUCCESS (0.019s)
[40.927130] Subtest busy: SUCCESS (0.019s)
[41.211727] [014/171] (956s left) gem_close_race (basic-process)
[41.362549] Starting subtest: basic-process
[41.406460] Subtest basic-process: SUCCESS (0.039s)
[41.590165] [015/171] (956s left) gem_close_race (basic-threads)
[41.727918] Starting subtest: basic-threads
[42.868866] Subtest basic-threads: SUCCESS (1.144s)
[43.052068] [016/171] (954s left) gem_ctx_create (basic)
[43.199027] Starting subtest: basic
[43.221374] Subtest basic: SUCCESS (0.000s)
[43.382246] [017/171] (954s left) gem_ctx_create (basic-files)
[43.523270] Starting subtest: basic-files
[45.542814] Subtest basic-files: SUCCESS (2.013s)
[45.812364] [018/171] (951s left) gem_ctx_exec (basic)
[45.964598] Starting subtest: basic
[45.986819] Subtest basic: SUCCESS (0.002s)
[46.063242] [019/171] (951s left) gem_exec_basic (basic)
[46.208587] Starting subtest: basic
[46.230372] Starting dynamic subtest: rcs0-smem
[46.251401] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[46.278028] Starting dynamic subtest: bcs0-smem
[46.297138] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[46.321258] Starting dynamic subtest: vcs0-smem
[46.340607] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[46.361235] Subtest basic: SUCCESS (0.002s)
[46.439947] [020/171] (951s left) gem_exec_create (basic)
[46.565043] Starting subtest: basic
[46.584954] Starting dynamic subtest: smem
[48.621352] Dynamic subtest smem: SUCCESS (2.047s)
[48.640788] Subtest basic: SUCCESS (2.047s)
[48.785582] [021/171] (949s left) gem_exec_fence (basic-busy)
[49.036239] Starting subtest: basic-busy
[49.057973] Starting dynamic subtest: rcs0
[49.099625] Dynamic subtest rcs0: SUCCESS (0.028s)
[49.122826] Starting dynamic subtest: bcs0
[49.161313] Dynamic subtest bcs0: SUCCESS (0.021s)
[49.185606] Starting dynamic subtest: vcs0
[49.229606] Dynamic subtest vcs0: SUCCESS (0.018s)
[49.250787] Subtest basic-busy: SUCCESS (0.067s)
[49.635529] [022/171] (948s left) gem_exec_fence (basic-wait)
[49.864083] Starting subtest: basic-wait
[49.892073] Starting dynamic subtest: rcs0
[49.916932] Dynamic subtest rcs0: SUCCESS (0.024s)
[49.944540] Starting dynamic subtest: bcs0
[49.968882] Dynamic subtest bcs0: SUCCESS (0.020s)
[49.997568] Starting dynamic subtest: vcs0
[50.022345] Dynamic subtest vcs0: SUCCESS (0.021s)
[50.043653] Subtest basic-wait: SUCCESS (0.065s)
[50.396383] [023/171] (947s left) gem_exec_fence (basic-await)
[50.650325] Starting subtest: basic-await
[50.674866] Starting dynamic subtest: rcs0
[50.717629] Dynamic subtest rcs0: SUCCESS (0.063s)
[50.744087] Starting dynamic subtest: bcs0
[50.833916] Dynamic subtest bcs0: SUCCESS (0.062s)
[50.863405] Starting dynamic subtest: vcs0
[50.886448] Dynamic subtest vcs0: SUCCESS (0.070s)
[50.909663] Subtest basic-await: SUCCESS (0.196s)
[51.297653] [024/171] (946s left) gem_exec_fence (nb-await)
[51.547921] Starting subtest: nb-await
[51.569877] Starting dynamic subtest: rcs0
[51.613406] Dynamic subtest rcs0: SUCCESS (0.053s)
[51.642515] Starting dynamic subtest: bcs0
[51.666040] Dynamic subtest bcs0: SUCCESS (0.052s)
[51.692528] Starting dynamic subtest: vcs0
[51.714462] Dynamic subtest vcs0: SUCCESS (0.053s)
[51.735861] Subtest nb-await: SUCCESS (0.158s)
[52.149641] [025/171] (946s left) gem_exec_gttfill (basic)
[52.312164] Starting subtest: basic
[54.756121] Subtest basic: SUCCESS (2.460s)
[54.954941] [026/171] (943s left) gem_exec_parallel (engines)
[55.188377] Starting subtest: engines
[55.209728] Starting dynamic subtest: basic
[56.583829] Dynamic subtest basic: SUCCESS (1.394s)
[56.610223] Starting dynamic subtest: contexts
[58.125996] Dynamic subtest contexts: SUCCESS (1.553s)
[58.152785] Starting dynamic subtest: fds
[59.828355] Dynamic subtest fds: SUCCESS (1.703s)
[59.852097] Starting dynamic subtest: userptr
[61.296293] Dynamic subtest userptr: SUCCESS (1.462s)
[61.317699] Subtest engines: SUCCESS (6.113s)
[61.477424] [027/171] (936s left) gem_exec_store (basic)
[61.686056] Starting subtest: basic
[61.707164] Subtest basic: SUCCESS (0.041s)
[61.861864] [028/171] (936s left) gem_flink_basic (bad-flink)
[62.002056] Starting subtest: bad-flink
[62.022431] Subtest bad-flink: SUCCESS (0.000s)
[62.094386] [029/171] (936s left) gem_flink_basic (bad-open)
[62.234035] Starting subtest: bad-open
[62.253244] Subtest bad-open: SUCCESS (0.000s)
[62.326664] [030/171] (936s left) gem_flink_basic (basic)
[62.446309] Starting subtest: basic
[62.465730] Subtest basic: SUCCESS (0.000s)
[62.539044] [031/171] (936s left) gem_flink_basic (double-flink)
[62.678455] Starting subtest: double-flink
[62.697938] Subtest double-flink: SUCCESS (0.000s)
[62.773881] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[62.910175] Starting subtest: flink-lifetime
[62.929391] Subtest flink-lifetime: SUCCESS (0.001s)
[63.007325] [033/171] (935s left) gem_huc_copy (huc-copy)
[63.165398] Subtest huc-copy: SKIP (0.000s)
[63.244835] [034/171] (935s left) gem_linear_blits (basic)
[63.458366] Starting subtest: basic
[63.479985] Subtest basic: SUCCESS (0.007s)
[63.603246] [035/171] (935s left) gem_mmap (basic)
[63.839479] Starting subtest: basic
[63.941036] Subtest basic: SUCCESS (0.000s)
[64.018400] [036/171] (934s left) gem_mmap_gtt (basic)
[64.159565] Starting subtest: basic
[64.181236] Subtest basic: SUCCESS (0.000s)
[64.256611] [037/171] (934s left) gem_render_linear_blits (basic)
[64.394250] Starting subtest: basic
[64.494592] Subtest basic: SUCCESS (0.018s)
[64.573134] [038/171] (934s left) gem_render_tiled_blits (basic)
[64.714234] Starting subtest: basic
[64.839437] Subtest basic: SUCCESS (0.024s)
[64.912453] [039/171] (934s left) gem_ringfill (basic-all)
[65.146807] Starting subtest: basic-all
[66.224052] Subtest basic-all: SUCCESS (1.107s)
[66.318910] [040/171] (932s left) gem_softpin (allocator-basic)
[66.486087] Subtest allocator-basic: SKIP (0.000s)
[66.559216] [041/171] (932s left) gem_softpin (allocator-basic-reserve)
[66.716192] Subtest allocator-basic-reserve: SKIP (0.000s)
[66.791895] [042/171] (932s left) gem_softpin (safe-alignment)
[66.945154] Starting subtest: safe-alignment
[66.965760] Subtest safe-alignment: SUCCESS (0.005s)
[67.044937] [043/171] (932s left) gem_sync (basic-all)
[67.226375] Starting subtest: basic-all
[69.557176] Subtest basic-all: SUCCESS (2.198s)
[69.653372] [044/171] (929s left) gem_sync (basic-each)
[69.828652] Starting subtest: basic-each
[71.883494] Subtest basic-each: SUCCESS (2.094s)
[72.073343] [045/171] (927s left) gem_tiled_blits (basic)
[72.274558] Starting subtest: basic
[72.296589] Subtest basic: SUCCESS (0.013s)
[72.430258] [046/171] (927s left) gem_tiled_fence_blits (basic)
[72.719535] Starting subtest: basic
[72.739162] Subtest basic: SUCCESS (0.007s)
[72.869604] [047/171] (926s left) gem_tiled_pread_basic
[73.267560] [048/171] (926s left) gem_wait (busy@all-engines)
[73.412614] Starting subtest: busy
[73.433337] Starting dynamic subtest: all-engines
[73.925097] Dynamic subtest all-engines: SUCCESS (0.517s)
[73.944604] Subtest busy: SUCCESS (0.517s)
[74.130458] [049/171] (925s left) gem_wait (wait@all-engines)
[74.265089] Starting subtest: wait
[74.286683] Starting dynamic subtest: all-engines
[75.284542] Dynamic subtest all-engines: SUCCESS (1.017s)
[75.304240] Subtest wait: SUCCESS (1.018s)
[75.482764] [050/171] (924s left) i915_getparams_basic (basic-eu-total)
[75.616258] Starting subtest: basic-eu-total
[75.657554] Subtest basic-eu-total: SUCCESS (0.000s)
[75.736215] [051/171] (924s left) i915_getparams_basic (basic-subslice-total)
[75.851104] Starting subtest: basic-subslice-total
[75.895466] Subtest basic-subslice-total: SUCCESS (0.000s)
[75.971272] [052/171] (923s left) i915_hangman (error-state-basic)
[76.115096] Starting subtest: error-state-basic
[76.136726] Subtest error-state-basic: SUCCESS (0.007s)
[76.209107] [053/171] (923s left) i915_pciid
[76.423691] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[76.616945] Starting subtest: addfb25-bad-modifier
[76.635623] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[76.756827] [055/171] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[76.887360] Starting subtest: addfb25-framebuffer-vs-set-tiling
[76.908775] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[77.024471] [056/171] (923s left) kms_addfb_basic (addfb25-modifier-no-flag)
[77.163053] Starting subtest: addfb25-modifier-no-flag
[77.183818] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[77.295556] [057/171] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[77.427160] Starting subtest: addfb25-x-tiled-legacy
[77.445124] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[77.562279] [058/171] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[77.694148] Starting subtest: addfb25-x-tiled-mismatch-legacy
[77.715235] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[77.835410] [059/171] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[77.993743] Starting subtest: addfb25-yf-tiled-legacy
[78.012291] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[78.108686] [060/171] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[78.267548] Starting subtest: addfb25-y-tiled-legacy
[78.286551] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[78.395250] [061/171] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[78.572746] Starting subtest: addfb25-y-tiled-small-legacy
[78.619989] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[78.723103] [062/171] (921s left) kms_addfb_basic (bad-pitch-0)
[78.885903] Starting subtest: bad-pitch-0
[78.910964] Subtest bad-pitch-0: SUCCESS (0.000s)
[79.037278] [063/171] (921s left) kms_addfb_basic (bad-pitch-1024)
[79.191657] Starting subtest: bad-pitch-1024
[79.216660] Subtest bad-pitch-1024: SUCCESS (0.000s)
[79.336239] [064/171] (921s left) kms_addfb_basic (bad-pitch-128)
[79.489599] Starting subtest: bad-pitch-128
[79.517871] Subtest bad-pitch-128: SUCCESS (0.000s)
[79.634345] [065/171] (921s left) kms_addfb_basic (bad-pitch-256)
[79.800133] Starting subtest: bad-pitch-256
[79.827758] Subtest bad-pitch-256: SUCCESS (0.000s)
[79.952718] [066/171] (921s left) kms_addfb_basic (bad-pitch-32)
[80.106044] Starting subtest: bad-pitch-32
[80.130479] Subtest bad-pitch-32: SUCCESS (0.000s)
[80.248412] [067/171] (920s left) kms_addfb_basic (bad-pitch-63)
[80.404749] Starting subtest: bad-pitch-63
[80.428910] Subtest bad-pitch-63: SUCCESS (0.000s)
[80.540851] [068/171] (920s left) kms_addfb_basic (bad-pitch-65536)
[80.709856] Starting subtest: bad-pitch-65536
[80.733912] Subtest bad-pitch-65536: SUCCESS (0.000s)
[80.836816] [069/171] (920s left) kms_addfb_basic (bad-pitch-999)
[80.966559] Starting subtest: bad-pitch-999
[80.986316] Subtest bad-pitch-999: SUCCESS (0.000s)
[81.119193] [070/171] (920s left) kms_addfb_basic (basic)
[81.256361] Starting subtest: basic
[81.276550] Subtest basic: SUCCESS (0.000s)
[81.398074] [071/171] (919s left) kms_addfb_basic (basic-x-tiled-legacy)
[81.572510] Starting subtest: basic-x-tiled-legacy
[81.592387] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[81.675494] [072/171] (919s left) kms_addfb_basic (basic-y-tiled-legacy)
[81.851435] Starting subtest: basic-y-tiled-legacy
[81.871796] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[81.942983] [073/171] (919s left) kms_addfb_basic (bo-too-small)
[82.081903] Starting subtest: bo-too-small
[82.101137] Subtest bo-too-small: SUCCESS (0.000s)
[82.220074] [074/171] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[82.352832] Starting subtest: bo-too-small-due-to-tiling
[82.371131] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[82.489991] [075/171] (919s left) kms_addfb_basic (clobberred-modifier)
[82.624566] Starting subtest: clobberred-modifier
[82.645887] Subtest clobberred-modifier: SUCCESS (0.000s)
[82.757421] [076/171] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[82.917949] Starting subtest: framebuffer-vs-set-tiling
[82.936516] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[83.031748] [077/171] (918s left) kms_addfb_basic (invalid-get-prop)
[83.186089] Starting subtest: invalid-get-prop
[83.207195] Subtest invalid-get-prop: SUCCESS (0.000s)
[83.282621] [078/171] (918s left) kms_addfb_basic (invalid-get-prop-any)
[83.441188] Starting subtest: invalid-get-prop-any
[83.461646] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[83.533111] [079/171] (918s left) kms_addfb_basic (invalid-set-prop)
[83.692859] Starting subtest: invalid-set-prop
[83.711721] Subtest invalid-set-prop: SUCCESS (0.000s)
[83.808051] [080/171] (918s left) kms_addfb_basic (invalid-set-prop-any)
[83.977510] Starting subtest: invalid-set-prop-any
[83.998544] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[84.074339] [081/171] (917s left) kms_addfb_basic (no-handle)
[84.208794] Starting subtest: no-handle
[84.229170] Subtest no-handle: SUCCESS (0.000s)
[84.343583] [082/171] (917s left) kms_addfb_basic (size-max)
[84.484058] Starting subtest: size-max
[84.502637] Subtest size-max: SUCCESS (0.000s)
[84.629921] [083/171] (917s left) kms_addfb_basic (small-bo)
[84.766403] Starting subtest: small-bo
[84.787374] Subtest small-bo: SUCCESS (0.000s)
[84.904216] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[85.084323] Starting subtest: tile-pitch-mismatch
[85.103147] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[85.198385] [085/171] (917s left) kms_addfb_basic (too-high)
[85.353960] Starting subtest: too-high
[85.375364] Subtest too-high: SUCCESS (0.001s)
[85.495722] [086/171] (916s left) kms_addfb_basic (too-wide)
[85.635210] Starting subtest: too-wide
[85.655912] Subtest too-wide: SUCCESS (0.000s)
[85.768661] [087/171] (916s left) kms_addfb_basic (unused-handle)
[85.903587] Starting subtest: unused-handle
[85.922030] Subtest unused-handle: SUCCESS (0.000s)
[86.053807] [088/171] (916s left) kms_addfb_basic (unused-modifier)
[86.187677] Starting subtest: unused-modifier
[86.208923] Subtest unused-modifier: SUCCESS (0.000s)
[86.329072] [089/171] (916s left) kms_addfb_basic (unused-offsets)
[86.467946] Starting subtest: unused-offsets
[86.486688] Subtest unused-offsets: SUCCESS (0.000s)
[86.602579] [090/171] (916s left) kms_addfb_basic (unused-pitches)
[86.735493] Starting subtest: unused-pitches
[86.754186] Subtest unused-pitches: SUCCESS (0.000s)
[86.875278] [091/171] (915s left) kms_busy (basic)
[87.021901] Starting subtest: basic
[87.043407] Starting dynamic subtest: flip
[87.621082] Dynamic subtest flip: SUCCESS (0.595s)
[87.645530] Starting dynamic subtest: modeset
[88.083399] Dynamic subtest modeset: SUCCESS (0.469s)
[88.102499] Subtest basic: SUCCESS (1.065s)
[88.256059] [092/171] (914s left) kms_chamelium_hpd (dp-hpd-fast)
[88.461544] Subtest dp-hpd-fast: SKIP (0.000s)
[88.584246] [093/171] (914s left) kms_chamelium_edid (dp-edid-read)
[88.798037] Subtest dp-edid-read: SKIP (0.000s)
[88.909141] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast)
[89.130867] Subtest dp-crc-fast: SKIP (0.000s)
[89.243366] [095/171] (913s left) kms_chamelium_hpd (hdmi-hpd-fast)
[89.439136] Subtest hdmi-hpd-fast: SKIP (0.000s)
[89.588335] [096/171] (913s left) kms_chamelium_edid (hdmi-edid-read)
[89.786181] Subtest hdmi-edid-read: SKIP (0.000s)
[89.910668] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast)
[90.105311] Subtest hdmi-crc-fast: SKIP (0.000s)
[90.218249] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast)
[90.413938] Subtest vga-hpd-fast: SKIP (0.000s)
[90.556620] [099/171] (912s left) kms_chamelium_edid (vga-edid-read)
[90.753081] Subtest vga-edid-read: SKIP (0.000s)
[90.866573] [100/171] (912s left) kms_prop_blob (basic)
[91.010221] Starting subtest: basic
[91.029175] Subtest basic: SUCCESS (0.000s)
[91.114923] [101/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[91.252234] Starting subtest: basic-busy-flip-before-cursor-atomic
[92.184127] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.927s)
[92.333644] [102/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[92.465111] Starting subtest: basic-busy-flip-before-cursor-legacy
[93.424128] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.932s)
[93.561986] [103/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[93.686643] Starting subtest: basic-flip-after-cursor-atomic
[94.616499] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.926s)
[94.771448] [104/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[94.914745] Starting subtest: basic-flip-after-cursor-legacy
[95.853205] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.929s)
[96.007633] [105/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[96.146383] Starting subtest: basic-flip-after-cursor-varying-size
[97.085338] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.932s)
[97.243484] [106/171] (906s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[97.407672] Starting subtest: basic-flip-before-cursor-atomic
[98.357761] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.941s)
[98.551561] [107/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[98.723692] Starting subtest: basic-flip-before-cursor-legacy
[99.642854] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.926s)
[99.818813] [108/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[99.967513] Starting subtest: basic-flip-before-cursor-varying-size
[100.914864] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.944s)
[101.085693] [109/171] (903s left) kms_flip (basic-flip-vs-dpms)
[101.260265] Starting subtest: basic-flip-vs-dpms
[101.280976] Starting dynamic subtest: A-VGA1
[102.174238] Dynamic subtest A-VGA1: SUCCESS (0.947s)
[102.200479] Starting dynamic subtest: B-VGA1
[103.070747] Dynamic subtest B-VGA1: SUCCESS (0.888s)
[103.095269] Starting dynamic subtest: C-VGA1
[103.950350] Dynamic subtest C-VGA1: SUCCESS (0.885s)
[103.970212] Subtest basic-flip-vs-dpms: SUCCESS (2.723s)
[104.124670] [110/171] (900s left) kms_flip (basic-flip-vs-modeset)
[104.291100] Starting subtest: basic-flip-vs-modeset
[104.310369] Starting dynamic subtest: A-VGA1
[105.115700] Dynamic subtest A-VGA1: SUCCESS (0.847s)
[105.141070] Starting dynamic subtest: B-VGA1
[105.908923] Dynamic subtest B-VGA1: SUCCESS (0.789s)
[105.935102] Starting dynamic subtest: C-VGA1
[106.701598] Dynamic subtest C-VGA1: SUCCESS (0.790s)
[106.721460] Subtest basic-flip-vs-modeset: SUCCESS (2.428s)
[106.884514] [111/171] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[107.042266] Starting subtest: basic-flip-vs-wf_vblank
[107.062791] Starting dynamic subtest: A-VGA1
[108.169633] Dynamic subtest A-VGA1: SUCCESS (1.150s)
[108.195465] Starting dynamic subtest: B-VGA1
[109.294217] Dynamic subtest B-VGA1: SUCCESS (1.125s)
[109.320392] Starting dynamic subtest: C-VGA1
[110.416916] Dynamic subtest C-VGA1: SUCCESS (1.123s)
[110.435573] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.402s)
[110.610450] [112/171] (893s left) kms_flip (basic-plain-flip)
[110.771085] Starting subtest: basic-plain-flip
[110.790036] Starting dynamic subtest: A-VGA1
[111.617700] Dynamic subtest A-VGA1: SUCCESS (0.872s)
[111.644380] Starting dynamic subtest: B-VGA1
[112.460110] Dynamic subtest B-VGA1: SUCCESS (0.840s)
[112.487570] Starting dynamic subtest: C-VGA1
[113.299781] Dynamic subtest C-VGA1: SUCCESS (0.839s)
[113.321365] Subtest basic-plain-flip: SUCCESS (2.555s)
[113.515713] [113/171] (891s left) kms_force_connector_basic (force-connector-state)
[113.656311] Starting subtest: force-connector-state
[113.784645] Subtest force-connector-state: SUCCESS (0.131s)
[114.003111] [114/171] (890s left) kms_force_connector_basic (force-edid)
[114.142267] Starting subtest: force-edid
[114.202527] Subtest force-edid: SUCCESS (0.062s)
[114.328430] [115/171] (890s left) kms_force_connector_basic (force-load-detect)
[114.457141] Starting subtest: force-load-detect
[114.613329] Subtest force-load-detect: SUCCESS (0.146s)
[114.797470] [116/171] (890s left) kms_force_connector_basic (prune-stale-modes)
[114.933099] Starting subtest: prune-stale-modes
[114.953558] Subtest prune-stale-modes: SUCCESS (0.015s)
[115.075368] [117/171] (889s left) kms_frontbuffer_tracking (basic)
[115.274545] Starting subtest: basic
[117.071731] Subtest basic: SUCCESS (1.843s)
[117.193769] [118/171] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[117.353920] Starting subtest: compare-crc-sanitycheck
[117.377957] Starting dynamic subtest: pipe-A-VGA-1
[117.644962] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.274s)
[117.674587] Starting dynamic subtest: pipe-B-VGA-1
[117.910704] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.267s)
[117.942081] Starting dynamic subtest: pipe-C-VGA-1
[118.185462] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.272s)
[118.210525] Subtest compare-crc-sanitycheck: SUCCESS (0.815s)
[118.331986] [119/171] (886s left) kms_pipe_crc_basic (hang-read-crc)
[118.499184] Starting subtest: hang-read-crc
[118.525764] Starting dynamic subtest: pipe-A-VGA-1
[119.242723] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.752s)
[119.275618] Starting dynamic subtest: pipe-B-VGA-1
[120.011502] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.761s)
[120.036460] Starting dynamic subtest: pipe-C-VGA-1
[120.782193] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.775s)
[120.803196] Subtest hang-read-crc: SUCCESS (2.291s)
[120.937920] [120/171] (884s left) kms_pipe_crc_basic (nonblocking-crc)
[121.077181] Starting subtest: nonblocking-crc
[121.095899] Starting dynamic subtest: pipe-A-VGA-1
[121.540707] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.453s)
[121.566521] Starting dynamic subtest: pipe-B-VGA-1
[121.987936] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[122.012088] Starting dynamic subtest: pipe-C-VGA-1
[122.440309] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.454s)
[122.462096] Subtest nonblocking-crc: SUCCESS (1.357s)
[122.595799] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[122.736028] Starting subtest: nonblocking-crc-frame-sequence
[122.754927] Starting dynamic subtest: pipe-A-VGA-1
[123.197621] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.456s)
[123.224197] Starting dynamic subtest: pipe-B-VGA-1
[123.653251] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.448s)
[123.677365] Starting dynamic subtest: pipe-C-VGA-1
[124.098217] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.455s)
[124.116315] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.360s)
[124.284582] [122/171] (881s left) kms_pipe_crc_basic (read-crc)
[124.447023] Starting subtest: read-crc
[124.466197] Starting dynamic subtest: pipe-A-VGA-1
[124.823786] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.387s)
[124.850555] Starting dynamic subtest: pipe-B-VGA-1
[125.214210] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.382s)
[125.238312] Starting dynamic subtest: pipe-C-VGA-1
[125.594294] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.387s)
[125.612954] Subtest read-crc: SUCCESS (1.160s)
[125.754531] [123/171] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[125.916886] Starting subtest: read-crc-frame-sequence
[125.936676] Starting dynamic subtest: pipe-A-VGA-1
[126.285886] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.381s)
[126.310111] Starting dynamic subtest: pipe-B-VGA-1
[126.671853] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.381s)
[126.697856] Starting dynamic subtest: pipe-C-VGA-1
[127.060150] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.387s)
[127.078937] Subtest read-crc-frame-sequence: SUCCESS (1.152s)
[127.218778] [124/171] (878s left) kms_psr (primary_page_flip)
[127.384914] Subtest primary_page_flip: SKIP (0.000s)
[127.463337] [125/171] (878s left) kms_psr (cursor_plane_move)
[127.622924] Subtest cursor_plane_move: SKIP (0.000s)
[127.699462] [126/171] (877s left) kms_psr (sprite_plane_onoff)
[127.860022] Subtest sprite_plane_onoff: SKIP (0.000s)
[127.933792] [127/171] (877s left) kms_psr (primary_mmap_gtt)
[128.093254] Subtest primary_mmap_gtt: SKIP (0.000s)
[128.167760] [128/171] (877s left) kms_setmode (basic-clone-single-crtc)
[128.319659] Starting subtest: basic-clone-single-crtc
[128.380639] Subtest basic-clone-single-crtc: SKIP (0.000s)
[128.460064] [129/171] (877s left) i915_pm_backlight (basic-brightness)
[128.603404] Subtest basic-brightness: SKIP (0.000s)
[128.684457] [130/171] (877s left) i915_pm_rpm (basic-pci-d3-state)
[140.174335] Subtest basic-pci-d3-state: SKIP (0.000s)
[140.252379] [131/171] (865s left) i915_pm_rpm (basic-rte)
[140.371572] Starting subtest: basic-rte
[151.548835] Subtest basic-rte: SKIP (11.101s)
[151.662933] [132/171] (854s left) i915_pm_rps (basic-api)
[151.810490] Starting subtest: basic-api
[151.830012] Subtest basic-api: SUCCESS (0.002s)
[151.906936] [133/171] (854s left) prime_self_import (basic-llseek-bad)
[152.051743] Starting subtest: basic-llseek-bad
[152.071163] Subtest basic-llseek-bad: SUCCESS (0.001s)
[152.151244] [134/171] (854s left) prime_self_import (basic-llseek-size)
[152.286051] Starting subtest: basic-llseek-size
[152.305528] Subtest basic-llseek-size: SUCCESS (0.002s)
[152.389386] [135/171] (853s left) prime_self_import (basic-with_fd_dup)
[152.510451] Starting subtest: basic-with_fd_dup
[152.531164] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[152.612964] [136/171] (853s left) prime_self_import (basic-with_one_bo)
[152.747720] Starting subtest: basic-with_one_bo
[152.769796] Subtest basic-with_one_bo: SUCCESS (0.002s)
[152.867328] [137/171] (853s left) prime_self_import (basic-with_one_bo_two_files)
[152.984912] Starting subtest: basic-with_one_bo_two_files
[153.006383] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[153.083581] [138/171] (853s left) prime_self_import (basic-with_two_bos)
[153.227669] Starting subtest: basic-with_two_bos
[153.247682] Subtest basic-with_two_bos: SUCCESS (0.002s)
[153.321591] [139/171] (853s left) prime_vgem (basic-fence-flip)
[153.485895] Starting subtest: basic-fence-flip
[153.786448] Subtest basic-fence-flip: SUCCESS (0.313s)
[153.907371] [140/171] (852s left) prime_vgem (basic-fence-mmap)
[154.045353] Starting subtest: basic-fence-mmap
[154.066110] Subtest basic-fence-mmap: SUCCESS (0.025s)
[154.181583] [141/171] (852s left) prime_vgem (basic-fence-read)
[154.320950] Starting subtest: basic-fence-read
[154.340322] Subtest basic-fence-read: SUCCESS (0.035s)
[154.454450] [142/171] (852s left) prime_vgem (basic-gtt)
[154.616569] Starting subtest: basic-gtt
[154.640819] Subtest basic-gtt: SUCCESS (0.010s)
[154.761149] [143/171] (852s left) prime_vgem (basic-read)
[154.900131] Starting subtest: basic-read
[154.925307] Subtest basic-read: SUCCESS (0.015s)
[155.045083] [144/171] (851s left) prime_vgem (basic-write)
[155.195334] Starting subtest: basic-write
[155.221774] Subtest basic-write: SUCCESS (0.017s)
[155.333720] [145/171] (851s left) prime_vgem (basic-userptr)
[155.460567] Starting subtest: basic-userptr
[155.506516] Subtest basic-userptr: SKIP (0.009s)
[155.631583] [146/171] (851s left) vgem_basic (setversion)
[155.795731] Starting subtest: setversion
[155.846071] Subtest setversion: SUCCESS (0.000s)
[155.946770] [147/171] (851s left) vgem_basic (create)
[156.107432] Starting subtest: create
[156.133110] Subtest create: SUCCESS (0.000s)
[156.235376] [148/171] (851s left) vgem_basic (debugfs)
[156.402371] Starting subtest: debugfs
[156.428283] Subtest debugfs: SUCCESS (0.001s)
[156.519290] [149/171] (850s left) vgem_basic (dmabuf-export)
[156.676171] Starting subtest: dmabuf-export
[156.699356] Subtest dmabuf-export: SUCCESS (0.002s)
[156.796169] [150/171] (850s left) vgem_basic (dmabuf-fence)
[156.925459] Starting subtest: dmabuf-fence
[156.955342] Subtest dmabuf-fence: SUCCESS (0.001s)
[157.055982] [151/171] (850s left) vgem_basic (dmabuf-fence-before)
[157.211652] Starting subtest: dmabuf-fence-before
[157.234285] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[157.314188] [152/171] (850s left) vgem_basic (dmabuf-mmap)
[157.461438] Starting subtest: dmabuf-mmap
[157.483134] Subtest dmabuf-mmap: SUCCESS (0.015s)
[157.559534] [153/171] (850s left) vgem_basic (mmap)
[157.686623] Starting subtest: mmap
[157.707806] Subtest mmap: SUCCESS (0.010s)
[157.784225] [154/171] (849s left) vgem_basic (second-client)
[157.925222] Starting subtest: second-client
[157.966804] Subtest second-client: SUCCESS (0.049s)
[158.041181] [155/171] (849s left) vgem_basic (sysfs)
[158.180483] Starting subtest: sysfs
[158.200130] Subtest sysfs: SUCCESS (0.001s)
[158.276910] [156/171] (849s left) core_hotunplug (unbind-rebind)
[158.453115] Starting subtest: unbind-rebind
[159.186819] Subtest unbind-rebind: SUCCESS (0.734s)
[159.281699] [157/171] (848s left) vgem_basic (unload)
[159.424883] Starting subtest: unload
[188.349332] Subtest unload: SUCCESS (28.746s)
[188.426507] [158/171] (819s left) i915_module_load (reload)
[188.553149] Starting subtest: reload
[190.311172] Subtest reload: SUCCESS (1.771s)
[190.403202] [159/171] (817s left) gem_lmem_swapping (basic)
[190.570760] Subtest basic: SKIP (0.000s)
[190.650763] [160/171] (817s left) gem_lmem_swapping (parallel-random-engines)
[190.806641] Subtest parallel-random-engines: SKIP (0.000s)
[190.889808] [161/171] (817s left) gem_lmem_swapping (random-engines)
[191.030723] Subtest random-engines: SKIP (0.000s)
[191.111422] [162/171] (817s left) gem_lmem_swapping (verify-random)
[191.251127] Subtest verify-random: SKIP (0.000s)
[191.332910] [163/171] (817s left) i915_pm_rpm (module-reload)
[202.609683] Subtest module-reload: SKIP (0.000s)
[202.690227] [164/171] (805s left) i915_selftest (live)
[203.400743] Starting subtest: live
[203.419876] Starting dynamic subtest: sanitycheck
[203.919715] Dynamic subtest sanitycheck: SUCCESS (0.515s)
[203.949779] Starting dynamic subtest: uncore
[204.498520] Dynamic subtest uncore: SUCCESS (0.580s)
[204.524107] Starting dynamic subtest: workarounds
[205.116314] Dynamic subtest workarounds: SUCCESS (0.616s)
[205.142238] Starting dynamic subtest: gt_engines
[205.676149] Dynamic subtest gt_engines: SUCCESS (0.561s)
[205.704801] Starting dynamic subtest: gt_timelines
[210.694867] Dynamic subtest gt_timelines: SUCCESS (5.016s)
[210.721565] Starting dynamic subtest: gt_contexts
[211.252536] Dynamic subtest gt_contexts: SUCCESS (0.559s)
[211.279427] Starting dynamic subtest: gt_lrc
[211.800852] Dynamic subtest gt_lrc: SUCCESS (0.547s)
[211.826509] Starting dynamic subtest: gt_mocs
[212.315568] Dynamic subtest gt_mocs: SUCCESS (0.511s)
[212.343148] Starting dynamic subtest: gt_pm
[220.516164] Dynamic subtest gt_pm: SUCCESS (8.202s)
[220.540892] Starting dynamic subtest: gt_heartbeat
[221.078875] Dynamic subtest gt_heartbeat: SUCCESS (0.562s)
[221.103899] Starting dynamic subtest: requests
[226.248472] Dynamic subtest requests: SUCCESS (5.169s)
[226.273275] Starting dynamic subtest: migrate
[226.778395] Dynamic subtest migrate: SUCCESS (0.528s)
[226.806036] Starting dynamic subtest: active
[227.325271] Dynamic subtest active: SUCCESS (0.547s)
[227.349943] Starting dynamic subtest: objects
[228.266654] Dynamic subtest objects: SUCCESS (0.939s)
[228.293341] Starting dynamic subtest: mman
[232.166043] Dynamic subtest mman: SUCCESS (3.895s)
[232.202925] Starting dynamic subtest: dmabuf
[232.776215] Dynamic subtest dmabuf: SUCCESS (0.607s)
[232.808875] Starting dynamic subtest: vma
[233.334064] Dynamic subtest vma: SUCCESS (0.560s)
[233.366026] Starting dynamic subtest: coherency
[234.953069] Dynamic subtest coherency: SUCCESS (1.621s)
[234.979787] Starting dynamic subtest: gtt
[238.792312] Dynamic subtest gtt: SUCCESS (3.839s)
[238.820730] Starting dynamic subtest: gem
[239.404116] Dynamic subtest gem: SUCCESS (0.610s)
[239.434490] Starting dynamic subtest: evict
[239.953608] Dynamic subtest evict: SUCCESS (0.551s)
[239.978524] Starting dynamic subtest: hugepages
[241.615301] Dynamic subtest hugepages: SUCCESS (1.661s)
[241.642934] Starting dynamic subtest: gem_contexts
[245.880842] Dynamic subtest gem_contexts: SUCCESS (4.265s)
[245.907203] Starting dynamic subtest: client
[246.426895] Dynamic subtest client: SUCCESS (0.543s)
[246.452871] Starting dynamic subtest: gem_migrate
[246.971830] Dynamic subtest gem_migrate: SUCCESS (0.546s)
[246.997857] Starting dynamic subtest: reset
[247.584499] Dynamic subtest reset: SUCCESS (0.611s)
[247.610831] Starting dynamic subtest: memory_region
[248.122208] Dynamic subtest memory_region: SUCCESS (0.534s)
[248.149842] Starting dynamic subtest: hangcheck
[261.335763] Dynamic subtest hangcheck: SUCCESS (13.212s)
[261.363748] Starting dynamic subtest: execlists
[261.879255] Dynamic subtest execlists: SUCCESS (0.545s)
[261.904506] Starting dynamic subtest: ring_submission
[262.446611] Dynamic subtest ring_submission: SUCCESS (0.564s)
[262.473843] Starting dynamic subtest: perf
[262.984701] Dynamic subtest perf: SUCCESS (0.541s)
[263.009571] Starting dynamic subtest: slpc
[263.485944] Dynamic subtest slpc: SUCCESS (0.498s)
[263.515303] Starting dynamic subtest: guc
[263.986978] Dynamic subtest guc: SUCCESS (0.503s)
[264.012340] Starting dynamic subtest: guc_multi_lrc
[264.502034] Dynamic subtest guc_multi_lrc: SUCCESS (0.512s)
[264.530535] Starting dynamic subtest: guc_hang
[265.065220] Dynamic subtest guc_hang: SUCCESS (0.565s)
[265.090997] Starting dynamic subtest: late_gt_pm
[265.572621] Dynamic subtest late_gt_pm: SUCCESS (0.504s)
[265.593888] Subtest live: SUCCESS (62.169s)
[265.710528] [165/171] (742s left) dmabuf (all-tests)
[265.841526] Starting subtest: all-tests
[265.862370] Starting dynamic subtest: sanitycheck
[265.881074] Dynamic subtest sanitycheck: SUCCESS (0.030s)
[265.903618] Starting dynamic subtest: dma_fence
[266.005509] Dynamic subtest dma_fence: SUCCESS (0.127s)
[266.030387] Starting dynamic subtest: dma_fence_chain
[277.927368] Dynamic subtest dma_fence_chain: SUCCESS (11.930s)
[277.950444] Starting dynamic subtest: dma_fence_unwrap
[277.972299] Dynamic subtest dma_fence_unwrap: SUCCESS (0.023s)
[277.998562] Starting dynamic subtest: dma_resv
[278.019590] Dynamic subtest dma_resv: SUCCESS (0.033s)
[278.040711] Subtest all-tests: SUCCESS (12.148s)
[278.113627] [166/171] (730s left) i915_suspend (basic-s2idle-without-i915)
[278.264015] Starting subtest: basic-s2idle-without-i915
[295.299080] Subtest basic-s2idle-without-i915: SUCCESS (2.289s)
[297.967426] [167/171] (728s left) i915_suspend (basic-s3-without-i915)
[298.098040] Starting subtest: basic-s3-without-i915
[316.170527] Subtest basic-s3-without-i915: SUCCESS (1.942s)
[319.440353] [168/171] (726s left) gem_exec_suspend (basic-s0)
[319.603810] Starting subtest: basic-S0
[319.622075] Starting dynamic subtest: smem
[336.122291] Dynamic subtest smem: SUCCESS (1.815s)
[336.143772] Subtest basic-S0: SUCCESS (1.815s)
[339.210145] [169/171] (723s left) gem_exec_suspend (basic-s3)
[339.352521] Starting subtest: basic-S3
[339.371469] Starting dynamic subtest: smem
[356.951785] Dynamic subtest smem: SUCCESS (1.704s)
[356.970359] Subtest basic-S3: SUCCESS (1.705s)
[360.336380] [170/171] (721s left) kms_chamelium_hpd (common-hpd-after-suspend)
[360.574856] Subtest common-hpd-after-suspend: SKIP (0.000s)
[360.715515] [171/171] (721s left) kms_pipe_crc_basic (suspend-read-crc)
[360.877530] Starting subtest: suspend-read-crc
[360.902171] Starting dynamic subtest: pipe-A-VGA-1
[379.125011] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.852s)
[379.152152] Starting dynamic subtest: pipe-B-VGA-1
[397.143840] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.829s)
[397.172129] Starting dynamic subtest: pipe-C-VGA-1
[415.139718] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.834s)
[415.159585] Subtest suspend-read-crc: SUCCESS (5.518s)
[418.266470] Closing watchdogs
Done.