[84.377540] Initializing watchdogs
[84.378251]   /dev/watchdog0
[84.407350] [001/165] (960s left) i915_module_load (load)
[84.842845] Starting subtest: load
[89.235858] Subtest load: SUCCESS (4.392s)
[89.391636] [002/165] (955s left) core_auth (basic-auth)
[90.286763] Starting subtest: basic-auth
[90.291998] Subtest basic-auth: SUCCESS (0.004s)
[90.414511] [003/165] (954s left) debugfs_test (read_all_entries)
[90.838657] Starting subtest: read_all_entries
[91.004163] Subtest read_all_entries: SUCCESS (0.164s)
[91.186597] [004/165] (953s left) debugfs_test (basic-hwmon)
[91.606974] Starting subtest: basic-hwmon
[91.613113] Subtest basic-hwmon: SKIP (0.000s)
[91.789094] [005/165] (953s left) fbdev (eof)
[92.214310] Starting subtest: eof
[92.218736] Subtest eof: SUCCESS (0.004s)
[92.338580] [006/165] (952s left) fbdev (info)
[92.734979] Starting subtest: info
[92.738501] Subtest info: SUCCESS (0.000s)
[92.853397] [007/165] (952s left) fbdev (nullptr)
[93.262462] Starting subtest: nullptr
[93.267294] Subtest nullptr: SUCCESS (0.000s)
[93.371125] [008/165] (952s left) fbdev (read)
[93.778527] Starting subtest: read
[94.076218] Subtest read: SUCCESS (0.297s)
[94.187783] [009/165] (951s left) fbdev (write)
[94.645874] Starting subtest: write
[94.821779] Subtest write: SUCCESS (0.176s)
[94.940575] [010/165] (950s left) gem_basic (bad-close)
[95.343704] Starting subtest: bad-close
[95.349354] Subtest bad-close: SUCCESS (0.000s)
[95.471129] [011/165] (950s left) gem_basic (create-close)
[95.883597] Starting subtest: create-close
[95.890283] Subtest create-close: SUCCESS (0.002s)
[96.018081] [012/165] (949s left) gem_basic (create-fd-close)
[96.434830] Starting subtest: create-fd-close
[96.443298] Subtest create-fd-close: SUCCESS (0.001s)
[96.570489] [013/165] (949s left) gem_busy (busy@all-engines)
[97.054199] Starting subtest: busy
[97.057441] Starting dynamic subtest: all-engines
[97.169778] Dynamic subtest all-engines: SUCCESS (0.117s)
[97.173832] Subtest busy: SUCCESS (0.120s)
[97.653809] [014/165] (948s left) gem_close_race (basic-process)
[98.141468] Starting subtest: basic-process
[98.308450] Subtest basic-process: SUCCESS (0.173s)
[98.575939] [015/165] (947s left) gem_close_race (basic-threads)
[99.064688] Starting subtest: basic-threads
[100.476380] Subtest basic-threads: SUCCESS (1.415s)
[100.741289] [016/165] (945s left) gem_ctx_create (basic)
[101.177147] Subtest basic: SKIP (0.000s)
[101.278141] [017/165] (944s left) gem_ctx_create (basic-files)
[101.691737] Subtest basic-files: SKIP (0.000s)
[101.793368] [018/165] (944s left) gem_ctx_exec (basic)
[102.211261] Subtest basic: SKIP (0.000s)
[102.327271] [019/165] (944s left) gem_exec_basic (basic)
[102.785154] Starting subtest: basic
[102.788604] Starting dynamic subtest: rcs0-smem
[102.791691] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[102.794580] Subtest basic: SUCCESS (0.006s)
[103.055536] [020/165] (943s left) gem_exec_create (basic)
[103.534635] Starting subtest: basic
[103.538869] Starting dynamic subtest: smem
[105.679945] Dynamic subtest smem: SUCCESS (2.143s)
[105.684947] Subtest basic: SUCCESS (2.145s)
[105.977944] [021/165] (940s left) gem_exec_fence (basic-busy)
[106.923373] Starting subtest: basic-busy
[106.927757] Starting dynamic subtest: rcs0
[106.960889] Dynamic subtest rcs0: SUCCESS (0.033s)
[106.964904] Subtest basic-busy: SUCCESS (0.036s)
[107.941834] [022/165] (938s left) gem_exec_fence (basic-wait)
[108.609616] Starting subtest: basic-wait
[108.613654] Starting dynamic subtest: rcs0
[108.654401] Dynamic subtest rcs0: SUCCESS (0.043s)
[108.657366] Subtest basic-wait: SUCCESS (0.046s)
[109.342318] [023/165] (937s left) gem_exec_fence (basic-await)
[110.047595] Starting subtest: basic-await
[110.053175] Starting dynamic subtest: rcs0
[110.166743] Dynamic subtest rcs0: SUCCESS (0.119s)
[110.170865] Subtest basic-await: SUCCESS (0.122s)
[110.896463] [024/165] (935s left) gem_exec_fence (nb-await)
[111.607259] Starting subtest: nb-await
[111.611752] Starting dynamic subtest: rcs0
[111.672577] Dynamic subtest rcs0: SUCCESS (0.064s)
[111.675512] Subtest nb-await: SUCCESS (0.066s)
[112.341994] [025/165] (934s left) gem_exec_gttfill (basic)
[112.808985] Starting subtest: basic
[125.668720] Subtest basic: SUCCESS (12.865s)
[125.981453] [026/165] (920s left) gem_exec_parallel (engines)
[126.866710] Starting subtest: engines
[126.870185] Starting dynamic subtest: basic
[130.227498] Dynamic subtest basic: SUCCESS (3.361s)
[130.274419] Starting dynamic subtest: contexts
[130.281689] Dynamic subtest contexts: SKIP (0.003s)
[130.316755] Starting dynamic subtest: fds
[130.322131] Dynamic subtest fds: SKIP (0.002s)
[130.354957] Starting dynamic subtest: userptr
[133.694307] Dynamic subtest userptr: SUCCESS (3.459s)
[133.697352] Subtest engines: SUCCESS (6.832s)
[133.974950] [027/165] (913s left) gem_exec_store (basic)
[134.444747] Starting subtest: basic
[134.492637] Subtest basic: SUCCESS (0.049s)
[134.770908] [028/165] (912s left) gem_flink_basic (bad-flink)
[135.175313] Starting subtest: bad-flink
[135.179298] Subtest bad-flink: SUCCESS (0.000s)
[135.314872] [029/165] (911s left) gem_flink_basic (bad-open)
[135.715335] Starting subtest: bad-open
[135.719531] Subtest bad-open: SUCCESS (0.000s)
[135.849354] [030/165] (911s left) gem_flink_basic (basic)
[136.249681] Starting subtest: basic
[136.253914] Subtest basic: SUCCESS (0.001s)
[136.380363] [031/165] (911s left) gem_flink_basic (double-flink)
[136.779483] Starting subtest: double-flink
[136.782976] Subtest double-flink: SUCCESS (0.000s)
[136.914487] [032/165] (910s left) gem_flink_basic (flink-lifetime)
[137.323240] Starting subtest: flink-lifetime
[137.334145] Subtest flink-lifetime: SUCCESS (0.007s)
[137.479269] [033/165] (910s left) gem_huc_copy (huc-copy)
[137.894603] Subtest huc-copy: SKIP (0.000s)
[138.004587] [034/165] (909s left) gem_linear_blits (basic)
[138.887985] Starting subtest: basic
[138.943090] Subtest basic: SUCCESS (0.053s)
[139.165146] [035/165] (908s left) gem_mmap (basic)
[139.865607] Starting subtest: basic
[139.884612] Subtest basic: SUCCESS (0.002s)
[140.002678] [036/165] (907s left) gem_mmap_gtt (basic)
[140.423672] Starting subtest: basic
[140.428683] Subtest basic: SUCCESS (0.005s)
[140.552504] [037/165] (907s left) gem_render_linear_blits (basic)
[140.963455] Starting subtest: basic
[141.089919] Subtest basic: SUCCESS (0.125s)
[141.220215] [038/165] (906s left) gem_render_tiled_blits (basic)
[141.632605] Starting subtest: basic
[141.769728] Subtest basic: SUCCESS (0.133s)
[141.904387] [039/165] (906s left) gem_ringfill (basic-all)
[142.374635] Starting subtest: basic-all
[143.564641] Subtest basic-all: SUCCESS (1.189s)
[143.702148] [040/165] (904s left) gem_softpin (allocator-basic)
[144.127229] Subtest allocator-basic: SKIP (0.000s)
[144.268316] [041/165] (904s left) gem_softpin (allocator-basic-reserve)
[144.696729] Subtest allocator-basic-reserve: SKIP (0.000s)
[144.832251] [042/165] (903s left) gem_softpin (safe-alignment)
[145.264722] Starting subtest: safe-alignment
[145.290658] Subtest safe-alignment: SUCCESS (0.030s)
[145.449882] [043/165] (902s left) gem_sync (basic-all)
[145.930978] Starting subtest: basic-all
[148.262190] Subtest basic-all: SUCCESS (2.332s)
[148.544224] [044/165] (899s left) gem_sync (basic-each)
[149.023574] Starting subtest: basic-each
[151.345495] Subtest basic-each: SUCCESS (2.320s)
[151.616470] [045/165] (897s left) gem_tiled_blits (basic)
[152.293234] Starting subtest: basic
[152.391535] Subtest basic: SUCCESS (0.099s)
[152.653469] [046/165] (896s left) gem_tiled_fence_blits (basic)
[153.676632] Starting subtest: basic
[153.752787] Subtest basic: SUCCESS (0.077s)
[153.971301] [047/165] (894s left) gem_tiled_pread_basic
[156.452108] [048/165] (892s left) gem_wait (busy@all-engines)
[156.955565] Starting subtest: busy
[156.959960] Starting dynamic subtest: all-engines
[157.488687] Dynamic subtest all-engines: SUCCESS (0.533s)
[157.491723] Subtest busy: SUCCESS (0.536s)
[157.904139] [049/165] (891s left) gem_wait (wait@all-engines)
[158.402993] Starting subtest: wait
[158.407650] Starting dynamic subtest: all-engines
[159.438577] Dynamic subtest all-engines: SUCCESS (1.036s)
[159.443394] Subtest wait: SUCCESS (1.039s)
[159.835232] [050/165] (889s left) i915_getparams_basic (basic-eu-total)
[160.258744] Starting subtest: basic-eu-total
[160.265394] Subtest basic-eu-total: SUCCESS (0.000s)
[160.402546] [051/165] (888s left) i915_getparams_basic (basic-subslice-total)
[160.811258] Starting subtest: basic-subslice-total
[160.817602] Subtest basic-subslice-total: SUCCESS (0.000s)
[160.952778] [052/165] (888s left) i915_hangman (error-state-basic)
[161.382873] Starting subtest: error-state-basic
[161.729242] Subtest error-state-basic: SUCCESS (0.325s)
[161.847718] [053/165] (887s left) i915_pciid
[162.409083] [054/165] (887s left) kms_addfb_basic (addfb25-4-tiled)
[162.913339] Starting subtest: addfb25-4-tiled
[162.922210] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[163.102829] [055/165] (886s left) kms_addfb_basic (addfb25-bad-modifier)
[163.547284] Starting subtest: addfb25-bad-modifier
[163.551748] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[163.795928] [056/165] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[164.247609] Starting subtest: addfb25-framebuffer-vs-set-tiling
[164.251805] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[164.454428] [057/165] (885s left) kms_addfb_basic (addfb25-modifier-no-flag)
[164.883892] Starting subtest: addfb25-modifier-no-flag
[164.887792] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[165.061381] [058/165] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[165.491680] Starting subtest: addfb25-x-tiled-legacy
[165.495518] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[165.713329] [059/165] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[166.138236] Starting subtest: addfb25-x-tiled-mismatch-legacy
[166.142368] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[166.349214] [060/165] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[166.811085] Starting subtest: addfb25-yf-tiled-legacy
[166.814621] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[166.966485] [061/165] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[167.448311] Starting subtest: addfb25-y-tiled-legacy
[167.451734] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[167.593692] [062/165] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[168.062856] Starting subtest: addfb25-y-tiled-small-legacy
[168.070343] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[168.236319] [063/165] (882s left) kms_addfb_basic (bad-pitch-0)
[168.647546] Starting subtest: bad-pitch-0
[168.652541] Subtest bad-pitch-0: SUCCESS (0.000s)
[168.834760] [064/165] (881s left) kms_addfb_basic (bad-pitch-1024)
[169.253813] Starting subtest: bad-pitch-1024
[169.257753] Subtest bad-pitch-1024: SUCCESS (0.000s)
[169.461718] [065/165] (881s left) kms_addfb_basic (bad-pitch-128)
[169.893498] Starting subtest: bad-pitch-128
[169.897571] Subtest bad-pitch-128: SUCCESS (0.000s)
[170.079168] [066/165] (880s left) kms_addfb_basic (bad-pitch-256)
[170.488536] Starting subtest: bad-pitch-256
[170.493314] Subtest bad-pitch-256: SUCCESS (0.000s)
[170.677492] [067/165] (880s left) kms_addfb_basic (bad-pitch-32)
[171.087472] Starting subtest: bad-pitch-32
[171.091462] Subtest bad-pitch-32: SUCCESS (0.000s)
[171.264870] [068/165] (879s left) kms_addfb_basic (bad-pitch-63)
[171.682511] Starting subtest: bad-pitch-63
[171.686839] Subtest bad-pitch-63: SUCCESS (0.000s)
[171.881484] [069/165] (879s left) kms_addfb_basic (bad-pitch-65536)
[172.301585] Starting subtest: bad-pitch-65536
[172.306282] Subtest bad-pitch-65536: SUCCESS (0.002s)
[172.496970] [070/165] (878s left) kms_addfb_basic (bad-pitch-999)
[172.904629] Starting subtest: bad-pitch-999
[172.907835] Subtest bad-pitch-999: SUCCESS (0.000s)
[173.097907] [071/165] (878s left) kms_addfb_basic (basic)
[173.516307] Starting subtest: basic
[173.520482] Subtest basic: SUCCESS (0.000s)
[173.703256] [072/165] (877s left) kms_addfb_basic (basic-x-tiled-legacy)
[174.112080] Starting subtest: basic-x-tiled-legacy
[174.115229] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[174.383510] [073/165] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[174.841620] Starting subtest: basic-y-tiled-legacy
[174.845568] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[175.044807] [074/165] (876s left) kms_addfb_basic (bo-too-small)
[175.506895] Starting subtest: bo-too-small
[175.511394] Subtest bo-too-small: SUCCESS (0.002s)
[175.660806] [075/165] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[176.125465] Starting subtest: bo-too-small-due-to-tiling
[176.130480] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[176.281920] [076/165] (875s left) kms_addfb_basic (clobberred-modifier)
[176.691333] Starting subtest: clobberred-modifier
[176.695440] Subtest clobberred-modifier: SUCCESS (0.001s)
[176.899952] [077/165] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[177.313788] Starting subtest: framebuffer-vs-set-tiling
[177.317568] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[177.515439] [078/165] (874s left) kms_addfb_basic (invalid-get-prop)
[177.931328] Starting subtest: invalid-get-prop
[177.935779] Subtest invalid-get-prop: SUCCESS (0.000s)
[178.130910] [079/165] (873s left) kms_addfb_basic (invalid-get-prop-any)
[178.551111] Starting subtest: invalid-get-prop-any
[178.554896] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[178.742233] [080/165] (873s left) kms_addfb_basic (invalid-set-prop)
[179.168472] Starting subtest: invalid-set-prop
[179.172407] Subtest invalid-set-prop: SUCCESS (0.000s)
[179.375512] [081/165] (872s left) kms_addfb_basic (invalid-set-prop-any)
[179.814331] Starting subtest: invalid-set-prop-any
[179.818634] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[180.007757] [082/165] (872s left) kms_addfb_basic (no-handle)
[180.424913] Starting subtest: no-handle
[180.429332] Subtest no-handle: SUCCESS (0.000s)
[180.610313] [083/165] (871s left) kms_addfb_basic (size-max)
[181.060669] Starting subtest: size-max
[181.064483] Subtest size-max: SUCCESS (0.001s)
[181.219255] [084/165] (871s left) kms_addfb_basic (small-bo)
[181.697836] Starting subtest: small-bo
[181.702427] Subtest small-bo: SUCCESS (0.000s)
[181.881758] [085/165] (870s left) kms_addfb_basic (tile-pitch-mismatch)
[182.318904] Starting subtest: tile-pitch-mismatch
[182.322717] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[182.500741] [086/165] (870s left) kms_addfb_basic (too-high)
[182.959826] Starting subtest: too-high
[182.964872] Subtest too-high: SUCCESS (0.004s)
[183.111922] [087/165] (869s left) kms_addfb_basic (too-wide)
[183.573352] Starting subtest: too-wide
[183.577785] Subtest too-wide: SUCCESS (0.000s)
[183.711215] [088/165] (869s left) kms_addfb_basic (unused-handle)
[184.127395] Starting subtest: unused-handle
[184.132964] Subtest unused-handle: SUCCESS (0.000s)
[184.338368] [089/165] (868s left) kms_addfb_basic (unused-modifier)
[184.748781] Starting subtest: unused-modifier
[184.752782] Subtest unused-modifier: SUCCESS (0.000s)
[184.931911] [090/165] (868s left) kms_addfb_basic (unused-offsets)
[185.352603] Starting subtest: unused-offsets
[185.356441] Subtest unused-offsets: SUCCESS (0.000s)
[185.534278] [091/165] (867s left) kms_addfb_basic (unused-pitches)
[185.942990] Starting subtest: unused-pitches
[185.946377] Subtest unused-pitches: SUCCESS (0.000s)
[186.130356] [092/165] (867s left) kms_busy (basic)
[186.607412] Starting subtest: basic
[186.611770] Starting dynamic subtest: flip
[188.051482] Dynamic subtest flip: SUCCESS (1.436s)
[188.097674] Starting dynamic subtest: modeset
[188.104794] Dynamic subtest modeset: SKIP (0.000s)
[188.108554] Subtest basic: SUCCESS (1.443s)
[188.329309] [093/165] (864s left) kms_prop_blob (basic)
[188.754390] Starting subtest: basic
[188.758444] Subtest basic: SUCCESS (0.000s)
[188.893947] [094/165] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[189.337447] Starting subtest: basic-busy-flip-before-cursor-atomic
[189.352322] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.012s)
[189.492353] [095/165] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[189.942364] Starting subtest: basic-busy-flip-before-cursor-legacy
[191.208556] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.270s)
[191.498225] [096/165] (862s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[191.970274] Starting subtest: basic-flip-after-cursor-atomic
[191.977927] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[192.114386] [097/165] (861s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[192.553747] Starting subtest: basic-flip-after-cursor-legacy
[193.830646] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.272s)
[194.099843] [098/165] (859s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[194.542585] Starting subtest: basic-flip-after-cursor-varying-size
[195.812350] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.272s)
[196.094814] [099/165] (857s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[196.552459] Starting subtest: basic-flip-before-cursor-atomic
[196.560821] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[196.690775] [100/165] (857s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[197.155523] Starting subtest: basic-flip-before-cursor-legacy
[198.428643] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.272s)
[198.699497] [101/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[199.167899] Starting subtest: basic-flip-before-cursor-varying-size
[200.454979] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.289s)
[200.724851] [102/165] (853s left) kms_dsc (dsc-basic)
[201.182750] Subtest dsc-basic: SKIP (0.000s)
[201.294427] [103/165] (852s left) kms_flip (basic-flip-vs-dpms)
[201.737183] Starting subtest: basic-flip-vs-dpms
[201.741579] Starting dynamic subtest: A-VGA1
[203.492219] Dynamic subtest A-VGA1: SUCCESS (1.757s)
[203.545230] Starting dynamic subtest: B-VGA1
[204.834549] Dynamic subtest B-VGA1: SUCCESS (1.332s)
[204.838477] Subtest basic-flip-vs-dpms: SUCCESS (3.101s)
[205.278702] [104/165] (848s left) kms_flip (basic-flip-vs-modeset)
[205.729771] Starting subtest: basic-flip-vs-modeset
[205.733569] Starting dynamic subtest: A-VGA1
[207.315705] Dynamic subtest A-VGA1: SUCCESS (1.583s)
[207.358153] Starting dynamic subtest: B-VGA1
[208.615897] Dynamic subtest B-VGA1: SUCCESS (1.298s)
[208.622467] Subtest basic-flip-vs-modeset: SUCCESS (2.887s)
[208.983085] [105/165] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[209.461703] Starting subtest: basic-flip-vs-wf_vblank
[209.466353] Starting dynamic subtest: A-VGA1
[211.356615] Dynamic subtest A-VGA1: SUCCESS (1.890s)
[211.403105] Starting dynamic subtest: B-VGA1
[213.032943] Dynamic subtest B-VGA1: SUCCESS (1.675s)
[213.041154] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.571s)
[213.485232] [106/165] (840s left) kms_flip (basic-plain-flip)
[213.937536] Starting subtest: basic-plain-flip
[213.941225] Starting dynamic subtest: A-VGA1
[215.574520] Dynamic subtest A-VGA1: SUCCESS (1.632s)
[215.613919] Starting dynamic subtest: B-VGA1
[216.969525] Dynamic subtest B-VGA1: SUCCESS (1.391s)
[216.972726] Subtest basic-plain-flip: SUCCESS (3.030s)
[217.408779] [107/165] (837s left) kms_force_connector_basic (force-connector-state)
[217.891326] Starting subtest: force-connector-state
[218.148417] Subtest force-connector-state: SUCCESS (0.249s)
[218.577651] [108/165] (836s left) kms_force_connector_basic (force-edid)
[219.052200] Starting subtest: force-edid
[219.150559] Subtest force-edid: SUCCESS (0.100s)
[219.402993] [109/165] (835s left) kms_force_connector_basic (force-load-detect)
[219.891524] Starting subtest: force-load-detect
[220.249433] Subtest force-load-detect: SUCCESS (0.366s)
[220.637889] [110/165] (834s left) kms_force_connector_basic (prune-stale-modes)
[221.115792] Starting subtest: prune-stale-modes
[221.194664] Subtest prune-stale-modes: SUCCESS (0.082s)
[221.475498] [111/165] (833s left) kms_frontbuffer_tracking (basic)
[221.939895] Subtest basic: SKIP (0.000s)
[222.058189] [112/165] (832s left) kms_hdmi_inject (inject-audio)
[222.468886] Subtest inject-audio: SKIP (0.000s)
[222.578142] [113/165] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[223.032385] Starting subtest: compare-crc-sanitycheck-xr24
[223.036761] Starting dynamic subtest: pipe-A-VGA-1
[223.402398] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.368s)
[223.445170] Starting dynamic subtest: pipe-B-VGA-1
[223.902734] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.491s)
[223.912357] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.872s)
[224.185300] [114/165] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[224.634532] Starting subtest: compare-crc-sanitycheck-nv12
[224.638783] Starting dynamic subtest: pipe-A-VGA-1
[224.646656] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[224.686976] Starting dynamic subtest: pipe-B-VGA-1
[224.692506] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[224.697845] Subtest compare-crc-sanitycheck-nv12: SKIP (0.014s)
[224.799228] [115/165] (830s left) kms_pipe_crc_basic (hang-read-crc)
[225.254677] Starting subtest: hang-read-crc
[225.258944] Starting dynamic subtest: pipe-A-VGA-1
[226.435455] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.178s)
[226.486357] Starting dynamic subtest: pipe-B-VGA-1
[227.738307] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.299s)
[227.741894] Subtest hang-read-crc: SUCCESS (2.488s)
[228.013610] [116/165] (827s left) kms_pipe_crc_basic (nonblocking-crc)
[228.462988] Starting subtest: nonblocking-crc
[228.466575] Starting dynamic subtest: pipe-A-VGA-1
[229.049353] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.582s)
[229.096986] Starting dynamic subtest: pipe-B-VGA-1
[229.706156] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.651s)
[229.710209] Subtest nonblocking-crc: SUCCESS (1.245s)
[229.965742] [117/165] (825s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[230.405660] Starting subtest: nonblocking-crc-frame-sequence
[230.414389] Starting dynamic subtest: pipe-A-VGA-1
[230.987762] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.577s)
[231.030878] Starting dynamic subtest: pipe-B-VGA-1
[231.684330] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.690s)
[231.687712] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.280s)
[231.951182] [118/165] (823s left) kms_pipe_crc_basic (read-crc)
[232.395693] Starting subtest: read-crc
[232.401927] Starting dynamic subtest: pipe-A-VGA-1
[232.878406] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.482s)
[232.926160] Starting dynamic subtest: pipe-B-VGA-1
[233.465096] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.583s)
[233.468252] Subtest read-crc: SUCCESS (1.077s)
[233.720131] [119/165] (821s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[234.165562] Starting subtest: read-crc-frame-sequence
[234.169661] Starting dynamic subtest: pipe-A-VGA-1
[234.648211] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.482s)
[234.699529] Starting dynamic subtest: pipe-B-VGA-1
[235.253623] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.600s)
[235.257650] Subtest read-crc-frame-sequence: SUCCESS (1.093s)
[235.512820] [120/165] (820s left) kms_pm_backlight (basic-brightness)
[235.975766] Subtest basic-brightness: SKIP (0.000s)
[236.086541] [121/165] (819s left) kms_pm_rpm (basic-pci-d3-state)
[247.983930] Subtest basic-pci-d3-state: SKIP (0.000s)
[248.087532] [122/165] (807s left) kms_pm_rpm (basic-rte)
[248.497758] Starting subtest: basic-rte
[260.002529] Subtest basic-rte: SKIP (11.490s)
[260.099438] [123/165] (795s left) kms_psr (primary_page_flip)
[260.510215] Subtest primary_page_flip: SKIP (0.000s)
[260.614473] [124/165] (795s left) kms_psr (cursor_plane_move)
[261.021642] Subtest cursor_plane_move: SKIP (0.000s)
[261.133959] [125/165] (795s left) kms_psr (sprite_plane_onoff)
[261.540299] Subtest sprite_plane_onoff: SKIP (0.000s)
[261.645683] [126/165] (794s left) kms_psr (primary_mmap_gtt)
[262.055865] Subtest primary_mmap_gtt: SKIP (0.000s)
[262.163475] [127/165] (794s left) kms_setmode (basic-clone-single-crtc)
[262.584391] Starting subtest: basic-clone-single-crtc
[262.593910] Subtest basic-clone-single-crtc: SKIP (0.000s)
[262.724378] [128/165] (793s left) i915_pm_rps (basic-api)
[263.140868] Subtest basic-api: SKIP (0.000s)
[263.247558] [129/165] (793s left) prime_self_import (basic-llseek-bad)
[263.637380] Starting subtest: basic-llseek-bad
[263.646376] Subtest basic-llseek-bad: SUCCESS (0.010s)
[263.792855] [130/165] (792s left) prime_self_import (basic-llseek-size)
[264.193825] Starting subtest: basic-llseek-size
[264.213724] Subtest basic-llseek-size: SUCCESS (0.019s)
[264.360393] [131/165] (792s left) prime_self_import (basic-with_fd_dup)
[264.759280] Starting subtest: basic-with_fd_dup
[264.775756] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[264.926316] [132/165] (791s left) prime_self_import (basic-with_one_bo)
[265.319742] Starting subtest: basic-with_one_bo
[265.337275] Subtest basic-with_one_bo: SUCCESS (0.018s)
[265.464509] [133/165] (791s left) prime_self_import (basic-with_one_bo_two_files)
[265.876512] Starting subtest: basic-with_one_bo_two_files
[265.883875] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[266.025916] [134/165] (791s left) prime_self_import (basic-with_two_bos)
[266.420429] Starting subtest: basic-with_two_bos
[266.438472] Subtest basic-with_two_bos: SUCCESS (0.016s)
[266.574654] [135/165] (790s left) prime_vgem (basic-fence-flip)
[267.012849] Starting subtest: basic-fence-flip
[267.628876] Subtest basic-fence-flip: SUCCESS (0.614s)
[267.792504] [136/165] (789s left) prime_vgem (basic-fence-mmap)
[268.226527] Starting subtest: basic-fence-mmap
[268.407469] Subtest basic-fence-mmap: SUCCESS (0.180s)
[268.560741] [137/165] (788s left) prime_vgem (basic-fence-read)
[268.991746] Starting subtest: basic-fence-read
[269.279431] Subtest basic-fence-read: SUCCESS (0.289s)
[269.427676] [138/165] (787s left) prime_vgem (basic-gtt)
[269.856886] Starting subtest: basic-gtt
[269.932398] Subtest basic-gtt: SUCCESS (0.075s)
[270.076452] [139/165] (787s left) prime_vgem (basic-read)
[270.491119] Starting subtest: basic-read
[270.624476] Subtest basic-read: SUCCESS (0.133s)
[270.775425] [140/165] (786s left) prime_vgem (basic-write)
[271.191674] Starting subtest: basic-write
[271.336167] Subtest basic-write: SUCCESS (0.144s)
[271.493313] [141/165] (786s left) vgem_basic (setversion)
[271.907861] Starting subtest: setversion
[271.915233] Subtest setversion: SUCCESS (0.000s)
[272.026294] [142/165] (785s left) vgem_basic (create)
[272.441614] Starting subtest: create
[272.445743] Subtest create: SUCCESS (0.003s)
[272.600578] [143/165] (785s left) vgem_basic (debugfs)
[273.024933] Starting subtest: debugfs
[273.029214] Subtest debugfs: SUCCESS (0.003s)
[273.140967] [144/165] (784s left) vgem_basic (dmabuf-export)
[273.559896] Starting subtest: dmabuf-export
[273.569345] Subtest dmabuf-export: SUCCESS (0.011s)
[273.707534] [145/165] (784s left) vgem_basic (dmabuf-fence)
[274.107405] Starting subtest: dmabuf-fence
[274.111133] Subtest dmabuf-fence: SUCCESS (0.004s)
[274.242600] [146/165] (783s left) vgem_basic (dmabuf-fence-before)
[274.711375] Starting subtest: dmabuf-fence-before
[274.715752] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[274.878497] [147/165] (783s left) vgem_basic (dmabuf-mmap)
[275.329749] Starting subtest: dmabuf-mmap
[275.412686] Subtest dmabuf-mmap: SUCCESS (0.087s)
[275.543808] [148/165] (782s left) vgem_basic (mmap)
[275.978725] Starting subtest: mmap
[276.038614] Subtest mmap: SUCCESS (0.064s)
[276.164773] [149/165] (782s left) vgem_basic (second-client)
[276.593248] Starting subtest: second-client
[276.625827] Subtest second-client: SUCCESS (0.031s)
[276.753871] [150/165] (781s left) vgem_basic (sysfs)
[277.192945] Starting subtest: sysfs
[277.198154] Subtest sysfs: SUCCESS (0.005s)
[277.330852] [151/165] (781s left) core_hotunplug (unbind-rebind)
[277.888662] Starting subtest: unbind-rebind
[282.312099] Subtest unbind-rebind: SUCCESS (4.425s)
[282.510650] [152/165] (776s left) vgem_basic (unload)
[282.946610] Starting subtest: unload
[312.274731] Subtest unload: SUCCESS (29.342s)
[312.536805] [153/165] (746s left) i915_module_load (reload)
[312.945737] Starting subtest: reload
[317.959565] Subtest reload: SUCCESS (5.004s)
[318.081332] [154/165] (740s left) gem_lmem_swapping (basic)
[319.073902] Subtest basic: SKIP (0.000s)
[319.217704] [155/165] (739s left) gem_lmem_swapping (parallel-random-engines)
[319.646284] Subtest parallel-random-engines: SKIP (0.000s)
[319.750807] [156/165] (739s left) gem_lmem_swapping (random-engines)
[320.175181] Subtest random-engines: SKIP (0.000s)
[320.284710] [157/165] (738s left) gem_lmem_swapping (verify-random)
[320.703569] Subtest verify-random: SKIP (0.000s)
[320.802698] [158/165] (738s left) i915_pm_rpm (module-reload)
[332.758248] Subtest module-reload: SKIP (0.000s)
[332.870726] [159/165] (726s left) i915_selftest (live)
[335.015604] Starting subtest: live
[335.019297] Starting dynamic subtest: sanitycheck
[337.566539] Dynamic subtest sanitycheck: SUCCESS (2.551s)
[337.598096] Starting dynamic subtest: uncore
[339.632461] Dynamic subtest uncore: SUCCESS (2.063s)
[339.670400] Starting dynamic subtest: workarounds
[341.727943] Dynamic subtest workarounds: SUCCESS (2.093s)
[341.760223] Starting dynamic subtest: gt_engines
[343.793123] Dynamic subtest gt_engines: SUCCESS (2.063s)
[343.825767] Starting dynamic subtest: gt_timelines
[354.871491] Dynamic subtest gt_timelines: SUCCESS (11.081s)
[354.907464] Starting dynamic subtest: gt_contexts
[356.993730] Dynamic subtest gt_contexts: SUCCESS (2.120s)
[357.030194] Starting dynamic subtest: gt_lrc
[359.046333] Dynamic subtest gt_lrc: SUCCESS (2.051s)
[359.087222] Starting dynamic subtest: gt_mocs
[361.092923] Dynamic subtest gt_mocs: SUCCESS (2.044s)
[361.127994] Starting dynamic subtest: gt_pm
[363.604461] Dynamic subtest gt_pm: SUCCESS (2.509s)
[363.636948] Starting dynamic subtest: gt_heartbeat
[365.721287] Dynamic subtest gt_heartbeat: SUCCESS (2.115s)
[365.754215] Starting dynamic subtest: gt_tlb
[367.807456] Dynamic subtest gt_tlb: SUCCESS (2.083s)
[367.844847] Starting dynamic subtest: requests
[372.528332] Dynamic subtest requests: SUCCESS (4.719s)
[372.565812] Starting dynamic subtest: migrate
[374.575188] Dynamic subtest migrate: SUCCESS (2.046s)
[374.607095] Starting dynamic subtest: active
[376.671661] Dynamic subtest active: SUCCESS (2.094s)
[376.704906] Starting dynamic subtest: objects
[379.801936] Dynamic subtest objects: SUCCESS (3.128s)
[379.834417] Starting dynamic subtest: mman
[391.540726] Dynamic subtest mman: SUCCESS (11.741s)
[391.572910] Starting dynamic subtest: dmabuf
[393.727672] Dynamic subtest dmabuf: SUCCESS (2.185s)
[393.760320] Starting dynamic subtest: vma
[395.868477] Dynamic subtest vma: SUCCESS (2.136s)
[395.904281] Starting dynamic subtest: coherency
[402.977545] Dynamic subtest coherency: SUCCESS (7.110s)
[403.015333] Starting dynamic subtest: gtt
[408.075328] Dynamic subtest gtt: SUCCESS (5.096s)
[408.113778] Starting dynamic subtest: gem
[410.219891] Dynamic subtest gem: SUCCESS (2.142s)
[410.252555] Starting dynamic subtest: evict
[412.276604] Dynamic subtest evict: SUCCESS (2.054s)
[412.309478] Starting dynamic subtest: hugepages
[414.352677] Dynamic subtest hugepages: SUCCESS (2.071s)
[414.390549] Starting dynamic subtest: gem_contexts
[416.429368] Dynamic subtest gem_contexts: SUCCESS (2.075s)
[416.460961] Starting dynamic subtest: client
[418.493357] Dynamic subtest client: SUCCESS (2.058s)
[418.525294] Starting dynamic subtest: gem_migrate
[420.544206] Dynamic subtest gem_migrate: SUCCESS (2.051s)
[420.576559] Starting dynamic subtest: reset
[423.221817] Dynamic subtest reset: SUCCESS (2.672s)
[423.257877] Starting dynamic subtest: memory_region
[425.299616] Dynamic subtest memory_region: SUCCESS (2.079s)
[425.333309] Starting dynamic subtest: hangcheck
[428.498561] Dynamic subtest hangcheck: SUCCESS (3.197s)
[428.537690] Starting dynamic subtest: execlists
[430.592838] Dynamic subtest execlists: SUCCESS (2.090s)
[430.625416] Starting dynamic subtest: ring_submission
[432.713676] Dynamic subtest ring_submission: SUCCESS (2.116s)
[432.748776] Starting dynamic subtest: perf
[434.772361] Dynamic subtest perf: SUCCESS (2.058s)
[434.804609] Starting dynamic subtest: slpc
[436.824743] Dynamic subtest slpc: SUCCESS (2.049s)
[436.861305] Starting dynamic subtest: guc
[438.882904] Dynamic subtest guc: SUCCESS (2.055s)
[438.915974] Starting dynamic subtest: guc_multi_lrc
[440.969476] Dynamic subtest guc_multi_lrc: SUCCESS (2.083s)
[441.007819] Starting dynamic subtest: guc_hang
[443.085431] Dynamic subtest guc_hang: SUCCESS (2.113s)
[443.123771] Starting dynamic subtest: late_gt_pm
[445.203756] Dynamic subtest late_gt_pm: SUCCESS (2.115s)
[445.207598] Subtest live: SUCCESS (110.245s)
[445.301192] [160/165] (614s left) dmabuf (all-tests)
[445.711268] Starting subtest: all-tests
[445.715488] Starting dynamic subtest: sanitycheck
[445.805144] Dynamic subtest sanitycheck: SUCCESS (0.091s)
[445.849182] Starting dynamic subtest: dma_fence
[446.024934] Dynamic subtest dma_fence: SUCCESS (0.215s)
[446.065195] Starting dynamic subtest: dma_fence_chain
[497.606421] Dynamic subtest dma_fence_chain: SUCCESS (51.591s)
[497.645748] Starting dynamic subtest: dma_fence_unwrap
[497.709759] Dynamic subtest dma_fence_unwrap: SUCCESS (0.099s)
[497.750322] Starting dynamic subtest: dma_resv
[497.811646] Dynamic subtest dma_resv: SUCCESS (0.098s)
[497.815698] Subtest all-tests: SUCCESS (52.116s)
[497.906162] [161/165] (561s left) i915_suspend (basic-s2idle-without-i915)
[498.312644] Starting subtest: basic-s2idle-without-i915
[520.527707] Subtest basic-s2idle-without-i915: SUCCESS (6.504s)
[523.750533] [162/165] (554s left) i915_suspend (basic-s3-without-i915)
[524.188162] Starting subtest: basic-s3-without-i915
[544.745798] Subtest basic-s3-without-i915: SUCCESS (4.734s)
[549.932072] [163/165] (549s left) gem_exec_suspend (basic-s0)
[550.438278] Starting subtest: basic-S0
[550.442449] Starting dynamic subtest: smem
[571.648390] Dynamic subtest smem: SUCCESS (6.344s)
[571.652257] Subtest basic-S0: SUCCESS (6.350s)
[573.962783] [164/165] (542s left) gem_exec_suspend (basic-s3)
[574.441950] Starting subtest: basic-S3
[574.446326] Starting dynamic subtest: smem
[596.751398] Dynamic subtest smem: SUCCESS (6.236s)
[596.755890] Subtest basic-S3: SUCCESS (6.241s)
[602.061024] [165/165] (535s left) kms_pipe_crc_basic (suspend-read-crc)
[602.527860] Starting subtest: suspend-read-crc
[602.531849] Starting dynamic subtest: pipe-A-VGA-1
[620.655555] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.390s)
[620.709409] Starting dynamic subtest: pipe-B-VGA-1
[639.647713] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.509s)
[639.651667] Subtest suspend-read-crc: SUCCESS (4.918s)
[646.926820] Closing watchdogs
Done.