[85.459901] Initializing watchdogs
[85.460535]   /dev/watchdog0
[85.487760] [001/165] (960s left) i915_module_load (load)
[85.913560] Starting subtest: load
[90.138735] Subtest load: SUCCESS (4.222s)
[90.276710] [002/165] (955s left) core_auth (basic-auth)
[91.288511] Starting subtest: basic-auth
[91.293654] Subtest basic-auth: SUCCESS (0.004s)
[91.437203] [003/165] (954s left) debugfs_test (read_all_entries)
[91.865588] Starting subtest: read_all_entries
[92.026800] Subtest read_all_entries: SUCCESS (0.158s)
[92.209211] [004/165] (954s left) debugfs_test (basic-hwmon)
[92.626926] Starting subtest: basic-hwmon
[92.633571] Subtest basic-hwmon: SKIP (0.000s)
[92.817111] [005/165] (953s left) fbdev (eof)
[93.219474] Starting subtest: eof
[93.224748] Subtest eof: SUCCESS (0.006s)
[93.340923] [006/165] (953s left) fbdev (info)
[93.727244] Starting subtest: info
[93.730532] Subtest info: SUCCESS (0.000s)
[93.859247] [007/165] (952s left) fbdev (nullptr)
[94.265727] Starting subtest: nullptr
[94.270548] Subtest nullptr: SUCCESS (0.000s)
[94.373173] [008/165] (952s left) fbdev (read)
[94.836233] Starting subtest: read
[95.120273] Subtest read: SUCCESS (0.286s)
[95.241544] [009/165] (951s left) fbdev (write)
[95.651123] Starting subtest: write
[95.824859] Subtest write: SUCCESS (0.174s)
[95.944118] [010/165] (950s left) gem_basic (bad-close)
[96.348637] Starting subtest: bad-close
[96.354575] Subtest bad-close: SUCCESS (0.000s)
[96.476955] [011/165] (950s left) gem_basic (create-close)
[96.875311] Starting subtest: create-close
[96.882190] Subtest create-close: SUCCESS (0.002s)
[97.010349] [012/165] (949s left) gem_basic (create-fd-close)
[97.416239] Starting subtest: create-fd-close
[97.422100] Subtest create-fd-close: SUCCESS (0.001s)
[97.544217] [013/165] (949s left) gem_busy (busy@all-engines)
[98.008884] Starting subtest: busy
[98.013871] Starting dynamic subtest: all-engines
[98.183750] Dynamic subtest all-engines: SUCCESS (0.171s)
[98.200456] Subtest busy: SUCCESS (0.184s)
[98.829373] [014/165] (948s left) gem_close_race (basic-process)
[99.476614] Starting subtest: basic-process
[99.716996] Subtest basic-process: SUCCESS (0.244s)
[100.075964] [015/165] (947s left) gem_close_race (basic-threads)
[100.823530] Starting subtest: basic-threads
[102.295385] Subtest basic-threads: SUCCESS (1.471s)
[102.569512] [016/165] (944s left) gem_ctx_create (basic)
[102.980256] Subtest basic: SKIP (0.000s)
[103.086864] [017/165] (944s left) gem_ctx_create (basic-files)
[103.496919] Subtest basic-files: SKIP (0.000s)
[103.591702] [018/165] (943s left) gem_ctx_exec (basic)
[104.016255] Subtest basic: SKIP (0.000s)
[104.136424] [019/165] (943s left) gem_exec_basic (basic)
[104.588628] Starting subtest: basic
[104.591623] Starting dynamic subtest: rcs0-smem
[104.594527] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[104.597585] Subtest basic: SUCCESS (0.006s)
[104.866573] [020/165] (942s left) gem_exec_create (basic)
[105.311471] Starting subtest: basic
[105.315994] Starting dynamic subtest: smem
[107.444498] Dynamic subtest smem: SUCCESS (2.133s)
[107.447608] Subtest basic: SUCCESS (2.135s)
[107.717373] [021/165] (939s left) gem_exec_fence (basic-busy)
[108.379095] Starting subtest: basic-busy
[108.382337] Starting dynamic subtest: rcs0
[108.413312] Dynamic subtest rcs0: SUCCESS (0.037s)
[108.416256] Subtest basic-busy: SUCCESS (0.040s)
[109.287308] [022/165] (938s left) gem_exec_fence (basic-wait)
[109.935098] Starting subtest: basic-wait
[109.939446] Starting dynamic subtest: rcs0
[109.967788] Dynamic subtest rcs0: SUCCESS (0.031s)
[109.970668] Subtest basic-wait: SUCCESS (0.033s)
[110.657408] [023/165] (937s left) gem_exec_fence (basic-await)
[111.295329] Starting subtest: basic-await
[111.299662] Starting dynamic subtest: rcs0
[111.409669] Dynamic subtest rcs0: SUCCESS (0.112s)
[111.413507] Subtest basic-await: SUCCESS (0.115s)
[112.089348] [024/165] (935s left) gem_exec_fence (nb-await)
[112.759685] Starting subtest: nb-await
[112.763765] Starting dynamic subtest: rcs0
[112.823639] Dynamic subtest rcs0: SUCCESS (0.063s)
[112.826541] Subtest nb-await: SUCCESS (0.065s)
[113.489197] [025/165] (934s left) gem_exec_gttfill (basic)
[113.940926] Starting subtest: basic
[128.318114] Subtest basic: SUCCESS (14.377s)
[128.640481] [026/165] (919s left) gem_exec_parallel (engines)
[129.484747] Starting subtest: engines
[129.488748] Starting dynamic subtest: basic
[132.804487] Dynamic subtest basic: SUCCESS (3.318s)
[132.852302] Starting dynamic subtest: contexts
[132.859339] Dynamic subtest contexts: SKIP (0.003s)
[132.897746] Starting dynamic subtest: fds
[132.903679] Dynamic subtest fds: SKIP (0.003s)
[132.937285] Starting dynamic subtest: userptr
[136.253392] Dynamic subtest userptr: SUCCESS (3.440s)
[136.256529] Subtest engines: SUCCESS (6.771s)
[136.529490] [027/165] (911s left) gem_exec_store (basic)
[136.992389] Starting subtest: basic
[137.040343] Subtest basic: SUCCESS (0.050s)
[137.310580] [028/165] (910s left) gem_flink_basic (bad-flink)
[137.703882] Starting subtest: bad-flink
[137.708627] Subtest bad-flink: SUCCESS (0.000s)
[137.838914] [029/165] (910s left) gem_flink_basic (bad-open)
[138.237803] Starting subtest: bad-open
[138.242585] Subtest bad-open: SUCCESS (0.000s)
[138.373525] [030/165] (910s left) gem_flink_basic (basic)
[138.767735] Starting subtest: basic
[138.771770] Subtest basic: SUCCESS (0.000s)
[138.908866] [031/165] (909s left) gem_flink_basic (double-flink)
[139.319537] Starting subtest: double-flink
[139.323651] Subtest double-flink: SUCCESS (0.001s)
[139.459273] [032/165] (909s left) gem_flink_basic (flink-lifetime)
[139.871948] Starting subtest: flink-lifetime
[139.876974] Subtest flink-lifetime: SUCCESS (0.007s)
[140.026157] [033/165] (908s left) gem_huc_copy (huc-copy)
[140.444780] Subtest huc-copy: SKIP (0.000s)
[140.547112] [034/165] (908s left) gem_linear_blits (basic)
[141.368612] Starting subtest: basic
[141.421363] Subtest basic: SUCCESS (0.053s)
[141.650698] [035/165] (907s left) gem_mmap (basic)
[142.329453] Starting subtest: basic
[142.344906] Subtest basic: SUCCESS (0.004s)
[142.476130] [036/165] (906s left) gem_mmap_gtt (basic)
[142.883611] Starting subtest: basic
[142.886935] Subtest basic: SUCCESS (0.005s)
[143.032224] [037/165] (905s left) gem_render_linear_blits (basic)
[143.444250] Starting subtest: basic
[143.573137] Subtest basic: SUCCESS (0.128s)
[143.699137] [038/165] (905s left) gem_render_tiled_blits (basic)
[144.111639] Starting subtest: basic
[144.245528] Subtest basic: SUCCESS (0.133s)
[144.365304] [039/165] (904s left) gem_ringfill (basic-all)
[144.829190] Starting subtest: basic-all
[146.028665] Subtest basic-all: SUCCESS (1.195s)
[146.166793] [040/165] (903s left) gem_softpin (allocator-basic)
[146.582699] Subtest allocator-basic: SKIP (0.000s)
[146.714268] [041/165] (902s left) gem_softpin (allocator-basic-reserve)
[147.137501] Subtest allocator-basic-reserve: SKIP (0.000s)
[147.264773] [042/165] (902s left) gem_softpin (safe-alignment)
[147.683557] Starting subtest: safe-alignment
[147.708736] Subtest safe-alignment: SUCCESS (0.031s)
[147.864310] [043/165] (901s left) gem_sync (basic-all)
[148.321972] Starting subtest: basic-all
[150.645756] Subtest basic-all: SUCCESS (2.323s)
[150.917194] [044/165] (898s left) gem_sync (basic-each)
[151.378745] Starting subtest: basic-each
[153.692276] Subtest basic-each: SUCCESS (2.315s)
[153.970763] [045/165] (895s left) gem_tiled_blits (basic)
[154.637667] Starting subtest: basic
[154.729568] Subtest basic: SUCCESS (0.091s)
[154.953594] [046/165] (894s left) gem_tiled_fence_blits (basic)
[155.981630] Starting subtest: basic
[156.050527] Subtest basic: SUCCESS (0.072s)
[156.274218] [047/165] (893s left) gem_tiled_pread_basic
[158.791354] [048/165] (891s left) gem_wait (busy@all-engines)
[159.319295] Starting subtest: busy
[159.324775] Starting dynamic subtest: all-engines
[159.850432] Dynamic subtest all-engines: SUCCESS (0.532s)
[159.854688] Subtest busy: SUCCESS (0.535s)
[160.275150] [049/165] (889s left) gem_wait (wait@all-engines)
[160.786372] Starting subtest: wait
[160.790705] Starting dynamic subtest: all-engines
[161.825657] Dynamic subtest all-engines: SUCCESS (1.040s)
[161.829375] Subtest wait: SUCCESS (1.043s)
[162.245277] [050/165] (887s left) i915_getparams_basic (basic-eu-total)
[162.649813] Starting subtest: basic-eu-total
[162.657204] Subtest basic-eu-total: SUCCESS (0.000s)
[162.792973] [051/165] (887s left) i915_getparams_basic (basic-subslice-total)
[163.193411] Starting subtest: basic-subslice-total
[163.201609] Subtest basic-subslice-total: SUCCESS (0.000s)
[163.321691] [052/165] (887s left) i915_hangman (error-state-basic)
[163.751607] Starting subtest: error-state-basic
[164.102766] Subtest error-state-basic: SUCCESS (0.347s)
[164.239125] [053/165] (886s left) i915_pciid
[164.803819] [054/165] (885s left) kms_addfb_basic (addfb25-4-tiled)
[165.320607] Starting subtest: addfb25-4-tiled
[165.323650] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[165.469451] [055/165] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[165.893242] Starting subtest: addfb25-bad-modifier
[165.897400] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[166.103728] [056/165] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[166.537650] Starting subtest: addfb25-framebuffer-vs-set-tiling
[166.541735] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[166.724598] [057/165] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[167.155288] Starting subtest: addfb25-modifier-no-flag
[167.159147] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[167.336109] [058/165] (883s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[167.749655] Starting subtest: addfb25-x-tiled-legacy
[167.752748] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[167.957234] [059/165] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[168.368399] Starting subtest: addfb25-x-tiled-mismatch-legacy
[168.372392] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[168.557478] [060/165] (882s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[169.007801] Starting subtest: addfb25-yf-tiled-legacy
[169.011656] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[169.159306] [061/165] (882s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[169.617587] Starting subtest: addfb25-y-tiled-legacy
[169.621708] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[169.756895] [062/165] (881s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[170.203743] Starting subtest: addfb25-y-tiled-small-legacy
[170.210725] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[170.337717] [063/165] (881s left) kms_addfb_basic (bad-pitch-0)
[170.745543] Starting subtest: bad-pitch-0
[170.750184] Subtest bad-pitch-0: SUCCESS (0.000s)
[170.926276] [064/165] (880s left) kms_addfb_basic (bad-pitch-1024)
[171.330488] Starting subtest: bad-pitch-1024
[171.334528] Subtest bad-pitch-1024: SUCCESS (0.000s)
[171.526414] [065/165] (879s left) kms_addfb_basic (bad-pitch-128)
[171.923709] Starting subtest: bad-pitch-128
[171.927175] Subtest bad-pitch-128: SUCCESS (0.000s)
[172.143513] [066/165] (879s left) kms_addfb_basic (bad-pitch-256)
[172.552162] Starting subtest: bad-pitch-256
[172.557216] Subtest bad-pitch-256: SUCCESS (0.000s)
[172.741659] [067/165] (878s left) kms_addfb_basic (bad-pitch-32)
[173.146813] Starting subtest: bad-pitch-32
[173.151185] Subtest bad-pitch-32: SUCCESS (0.000s)
[173.342359] [068/165] (878s left) kms_addfb_basic (bad-pitch-63)
[173.743416] Starting subtest: bad-pitch-63
[173.747517] Subtest bad-pitch-63: SUCCESS (0.000s)
[173.932177] [069/165] (877s left) kms_addfb_basic (bad-pitch-65536)
[174.362395] Starting subtest: bad-pitch-65536
[174.366558] Subtest bad-pitch-65536: SUCCESS (0.001s)
[174.560918] [070/165] (877s left) kms_addfb_basic (bad-pitch-999)
[174.966696] Starting subtest: bad-pitch-999
[174.971795] Subtest bad-pitch-999: SUCCESS (0.000s)
[175.164325] [071/165] (876s left) kms_addfb_basic (basic)
[175.563819] Starting subtest: basic
[175.567843] Subtest basic: SUCCESS (0.000s)
[175.776555] [072/165] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[176.184903] Starting subtest: basic-x-tiled-legacy
[176.189467] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[176.361838] [073/165] (875s left) kms_addfb_basic (basic-y-tiled-legacy)
[176.778242] Starting subtest: basic-y-tiled-legacy
[176.782284] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[176.978403] [074/165] (875s left) kms_addfb_basic (bo-too-small)
[177.420219] Starting subtest: bo-too-small
[177.424561] Subtest bo-too-small: SUCCESS (0.001s)
[177.571691] [075/165] (874s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[178.031508] Starting subtest: bo-too-small-due-to-tiling
[178.035918] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[178.189392] [076/165] (874s left) kms_addfb_basic (clobberred-modifier)
[178.588315] Starting subtest: clobberred-modifier
[178.591712] Subtest clobberred-modifier: SUCCESS (0.001s)
[178.836528] [077/165] (873s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[179.240620] Starting subtest: framebuffer-vs-set-tiling
[179.244295] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[179.457079] [078/165] (873s left) kms_addfb_basic (invalid-get-prop)
[179.877316] Starting subtest: invalid-get-prop
[179.881592] Subtest invalid-get-prop: SUCCESS (0.000s)
[180.064606] [079/165] (872s left) kms_addfb_basic (invalid-get-prop-any)
[180.477571] Starting subtest: invalid-get-prop-any
[180.481711] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[180.660224] [080/165] (872s left) kms_addfb_basic (invalid-set-prop)
[181.068752] Starting subtest: invalid-set-prop
[181.073233] Subtest invalid-set-prop: SUCCESS (0.000s)
[181.267224] [081/165] (871s left) kms_addfb_basic (invalid-set-prop-any)
[181.674768] Starting subtest: invalid-set-prop-any
[181.678904] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[181.846376] [082/165] (871s left) kms_addfb_basic (no-handle)
[182.247140] Starting subtest: no-handle
[182.250865] Subtest no-handle: SUCCESS (0.000s)
[182.430801] [083/165] (870s left) kms_addfb_basic (size-max)
[182.876559] Starting subtest: size-max
[182.881120] Subtest size-max: SUCCESS (0.001s)
[183.014203] [084/165] (870s left) kms_addfb_basic (small-bo)
[183.455724] Starting subtest: small-bo
[183.459737] Subtest small-bo: SUCCESS (0.000s)
[183.611941] [085/165] (869s left) kms_addfb_basic (tile-pitch-mismatch)
[184.041690] Starting subtest: tile-pitch-mismatch
[184.045583] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[184.250718] [086/165] (869s left) kms_addfb_basic (too-high)
[184.711275] Starting subtest: too-high
[184.715199] Subtest too-high: SUCCESS (0.004s)
[184.865206] [087/165] (868s left) kms_addfb_basic (too-wide)
[185.311818] Starting subtest: too-wide
[185.315835] Subtest too-wide: SUCCESS (0.000s)
[185.448837] [088/165] (868s left) kms_addfb_basic (unused-handle)
[185.847630] Starting subtest: unused-handle
[185.852424] Subtest unused-handle: SUCCESS (0.000s)
[186.035462] [089/165] (867s left) kms_addfb_basic (unused-modifier)
[186.446192] Starting subtest: unused-modifier
[186.450832] Subtest unused-modifier: SUCCESS (0.000s)
[186.649713] [090/165] (867s left) kms_addfb_basic (unused-offsets)
[187.051732] Starting subtest: unused-offsets
[187.057289] Subtest unused-offsets: SUCCESS (0.000s)
[187.234798] [091/165] (866s left) kms_addfb_basic (unused-pitches)
[187.633857] Starting subtest: unused-pitches
[187.638472] Subtest unused-pitches: SUCCESS (0.000s)
[187.833142] [092/165] (866s left) kms_busy (basic)
[188.293416] Starting subtest: basic
[188.302212] Starting dynamic subtest: flip
[189.750643] Dynamic subtest flip: SUCCESS (1.449s)
[189.796821] Starting dynamic subtest: modeset
[189.804192] Dynamic subtest modeset: SKIP (0.000s)
[189.807911] Subtest basic: SUCCESS (1.456s)
[190.027302] [093/165] (864s left) kms_prop_blob (basic)
[190.441600] Starting subtest: basic
[190.445662] Subtest basic: SUCCESS (0.000s)
[190.576746] [094/165] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[191.024407] Starting subtest: basic-busy-flip-before-cursor-atomic
[191.038934] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.014s)
[191.192189] [095/165] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[191.643113] Starting subtest: basic-busy-flip-before-cursor-legacy
[192.914802] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.273s)
[193.185383] [096/165] (861s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[193.639572] Starting subtest: basic-flip-after-cursor-atomic
[193.645977] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[193.781680] [097/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[194.221335] Starting subtest: basic-flip-after-cursor-legacy
[195.474597] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.255s)
[195.737389] [098/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[196.177606] Starting subtest: basic-flip-after-cursor-varying-size
[197.434933] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.257s)
[197.724925] [099/165] (856s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[198.169275] Starting subtest: basic-flip-before-cursor-atomic
[198.176122] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[198.308649] [100/165] (856s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[198.756729] Starting subtest: basic-flip-before-cursor-legacy
[200.006611] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.253s)
[200.288548] [101/165] (854s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[200.744728] Starting subtest: basic-flip-before-cursor-varying-size
[202.003546] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.256s)
[202.272465] [102/165] (852s left) kms_dsc (dsc-basic)
[202.755973] Subtest dsc-basic: SKIP (0.000s)
[202.889522] [103/165] (852s left) kms_flip (basic-flip-vs-dpms)
[203.342480] Starting subtest: basic-flip-vs-dpms
[203.346849] Starting dynamic subtest: A-VGA1
[204.911829] Dynamic subtest A-VGA1: SUCCESS (1.572s)
[204.957831] Starting dynamic subtest: B-VGA1
[206.409307] Dynamic subtest B-VGA1: SUCCESS (1.490s)
[206.413148] Subtest basic-flip-vs-dpms: SUCCESS (3.069s)
[206.837479] [104/165] (848s left) kms_flip (basic-flip-vs-modeset)
[207.275886] Starting subtest: basic-flip-vs-modeset
[207.280163] Starting dynamic subtest: A-VGA1
[208.864683] Dynamic subtest A-VGA1: SUCCESS (1.584s)
[208.910847] Starting dynamic subtest: B-VGA1
[210.142887] Dynamic subtest B-VGA1: SUCCESS (1.276s)
[210.149511] Subtest basic-flip-vs-modeset: SUCCESS (2.866s)
[210.513351] [105/165] (844s left) kms_flip (basic-flip-vs-wf_vblank)
[210.963632] Starting subtest: basic-flip-vs-wf_vblank
[210.967797] Starting dynamic subtest: A-VGA1
[212.853665] Dynamic subtest A-VGA1: SUCCESS (1.894s)
[212.901591] Starting dynamic subtest: B-VGA1
[214.521469] Dynamic subtest B-VGA1: SUCCESS (1.663s)
[214.527094] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.563s)
[214.958376] [106/165] (840s left) kms_flip (basic-plain-flip)
[215.382761] Starting subtest: basic-plain-flip
[215.386205] Starting dynamic subtest: A-VGA1
[217.005536] Dynamic subtest A-VGA1: SUCCESS (1.600s)
[217.083787] Starting dynamic subtest: B-VGA1
[218.427419] Dynamic subtest B-VGA1: SUCCESS (1.429s)
[218.431420] Subtest basic-plain-flip: SUCCESS (3.036s)
[218.940354] [107/165] (836s left) kms_force_connector_basic (force-connector-state)
[219.538191] Starting subtest: force-connector-state
[219.837923] Subtest force-connector-state: SUCCESS (0.296s)
[220.291765] [108/165] (835s left) kms_force_connector_basic (force-edid)
[220.776954] Starting subtest: force-edid
[220.901488] Subtest force-edid: SUCCESS (0.129s)
[221.183600] [109/165] (834s left) kms_force_connector_basic (force-load-detect)
[221.657821] Starting subtest: force-load-detect
[222.073111] Subtest force-load-detect: SUCCESS (0.419s)
[222.451287] [110/165] (833s left) kms_force_connector_basic (prune-stale-modes)
[222.908768] Starting subtest: prune-stale-modes
[222.989152] Subtest prune-stale-modes: SUCCESS (0.083s)
[223.228912] [111/165] (832s left) kms_frontbuffer_tracking (basic)
[223.700371] Subtest basic: SKIP (0.000s)
[223.818801] [112/165] (832s left) kms_hdmi_inject (inject-audio)
[224.227216] Subtest inject-audio: SKIP (0.000s)
[224.341293] [113/165] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[224.795737] Starting subtest: compare-crc-sanitycheck-xr24
[224.800382] Starting dynamic subtest: pipe-A-VGA-1
[225.166787] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.367s)
[225.217271] Starting dynamic subtest: pipe-B-VGA-1
[225.654522] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.485s)
[225.658368] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.864s)
[225.929819] [114/165] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[226.364513] Starting subtest: compare-crc-sanitycheck-nv12
[226.368467] Starting dynamic subtest: pipe-A-VGA-1
[226.376468] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[226.421591] Starting dynamic subtest: pipe-B-VGA-1
[226.427950] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[226.435533] Subtest compare-crc-sanitycheck-nv12: SKIP (0.012s)
[226.530921] [115/165] (829s left) kms_pipe_crc_basic (hang-read-crc)
[226.968231] Starting subtest: hang-read-crc
[226.972844] Starting dynamic subtest: pipe-A-VGA-1
[228.153483] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.183s)
[228.206739] Starting dynamic subtest: pipe-B-VGA-1
[229.403603] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.244s)
[229.410123] Subtest hang-read-crc: SUCCESS (2.438s)
[229.664851] [116/165] (826s left) kms_pipe_crc_basic (nonblocking-crc)
[230.124389] Starting subtest: nonblocking-crc
[230.129449] Starting dynamic subtest: pipe-A-VGA-1
[230.696493] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.567s)
[230.746200] Starting dynamic subtest: pipe-B-VGA-1
[231.381929] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.677s)
[231.385838] Subtest nonblocking-crc: SUCCESS (1.255s)
[231.637512] [117/165] (824s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[232.099417] Starting subtest: nonblocking-crc-frame-sequence
[232.102868] Starting dynamic subtest: pipe-A-VGA-1
[232.683932] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.579s)
[232.733733] Starting dynamic subtest: pipe-B-VGA-1
[233.384362] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.696s)
[233.387515] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.286s)
[233.668638] [118/165] (822s left) kms_pipe_crc_basic (read-crc)
[234.145987] Starting subtest: read-crc
[234.149424] Starting dynamic subtest: pipe-A-VGA-1
[234.716833] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.561s)
[234.821691] Starting dynamic subtest: pipe-B-VGA-1
[235.346759] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.626s)
[235.351999] Subtest read-crc: SUCCESS (1.202s)
[235.604252] [119/165] (821s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[236.050399] Starting subtest: read-crc-frame-sequence
[236.054746] Starting dynamic subtest: pipe-A-VGA-1
[236.552217] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.499s)
[236.611793] Starting dynamic subtest: pipe-B-VGA-1
[237.158417] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.598s)
[237.162772] Subtest read-crc-frame-sequence: SUCCESS (1.109s)
[237.415834] [120/165] (819s left) kms_pm_backlight (basic-brightness)
[237.869617] Subtest basic-brightness: SKIP (0.000s)
[237.976684] [121/165] (818s left) kms_pm_rpm (basic-pci-d3-state)
[249.891272] Subtest basic-pci-d3-state: SKIP (0.000s)
[249.986508] [122/165] (806s left) kms_pm_rpm (basic-rte)
[250.390109] Starting subtest: basic-rte
[261.895422] Subtest basic-rte: SKIP (11.485s)
[261.993849] [123/165] (795s left) kms_psr (primary_page_flip)
[262.403580] Subtest primary_page_flip: SKIP (0.000s)
[262.524648] [124/165] (794s left) kms_psr (cursor_plane_move)
[262.933511] Subtest cursor_plane_move: SKIP (0.000s)
[263.041695] [125/165] (794s left) kms_psr (sprite_plane_onoff)
[263.446280] Subtest sprite_plane_onoff: SKIP (0.000s)
[263.559448] [126/165] (793s left) kms_psr (primary_mmap_gtt)
[263.969655] Subtest primary_mmap_gtt: SKIP (0.000s)
[264.074450] [127/165] (793s left) kms_setmode (basic-clone-single-crtc)
[264.477978] Starting subtest: basic-clone-single-crtc
[264.489605] Subtest basic-clone-single-crtc: SKIP (0.000s)
[264.617913] [128/165] (792s left) i915_pm_rps (basic-api)
[265.023364] Subtest basic-api: SKIP (0.000s)
[265.126274] [129/165] (792s left) prime_self_import (basic-llseek-bad)
[265.519266] Starting subtest: basic-llseek-bad
[265.529612] Subtest basic-llseek-bad: SUCCESS (0.010s)
[265.669528] [130/165] (791s left) prime_self_import (basic-llseek-size)
[266.060338] Starting subtest: basic-llseek-size
[266.076202] Subtest basic-llseek-size: SUCCESS (0.022s)
[266.220579] [131/165] (791s left) prime_self_import (basic-with_fd_dup)
[266.619965] Starting subtest: basic-with_fd_dup
[266.634810] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[266.771574] [132/165] (791s left) prime_self_import (basic-with_one_bo)
[267.163623] Starting subtest: basic-with_one_bo
[267.181985] Subtest basic-with_one_bo: SUCCESS (0.019s)
[267.327445] [133/165] (790s left) prime_self_import (basic-with_one_bo_two_files)
[267.721460] Starting subtest: basic-with_one_bo_two_files
[267.735542] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[267.871877] [134/165] (790s left) prime_self_import (basic-with_two_bos)
[268.261709] Starting subtest: basic-with_two_bos
[268.278653] Subtest basic-with_two_bos: SUCCESS (0.017s)
[268.422166] [135/165] (789s left) prime_vgem (basic-fence-flip)
[268.854582] Starting subtest: basic-fence-flip
[269.453623] Subtest basic-fence-flip: SUCCESS (0.597s)
[269.628356] [136/165] (788s left) prime_vgem (basic-fence-mmap)
[270.057472] Starting subtest: basic-fence-mmap
[270.249622] Subtest basic-fence-mmap: SUCCESS (0.190s)
[270.391648] [137/165] (787s left) prime_vgem (basic-fence-read)
[270.824494] Starting subtest: basic-fence-read
[271.132938] Subtest basic-fence-read: SUCCESS (0.307s)
[271.275859] [138/165] (787s left) prime_vgem (basic-gtt)
[271.705148] Starting subtest: basic-gtt
[271.782538] Subtest basic-gtt: SUCCESS (0.076s)
[271.939309] [139/165] (786s left) prime_vgem (basic-read)
[272.362294] Starting subtest: basic-read
[272.496464] Subtest basic-read: SUCCESS (0.136s)
[272.657679] [140/165] (785s left) prime_vgem (basic-write)
[273.092832] Starting subtest: basic-write
[273.228735] Subtest basic-write: SUCCESS (0.141s)
[273.375189] [141/165] (785s left) vgem_basic (setversion)
[273.775895] Starting subtest: setversion
[273.784638] Subtest setversion: SUCCESS (0.000s)
[273.893129] [142/165] (784s left) vgem_basic (create)
[274.298112] Starting subtest: create
[274.302142] Subtest create: SUCCESS (0.003s)
[274.409266] [143/165] (784s left) vgem_basic (debugfs)
[274.822812] Starting subtest: debugfs
[274.826976] Subtest debugfs: SUCCESS (0.003s)
[274.943504] [144/165] (783s left) vgem_basic (dmabuf-export)
[275.362516] Starting subtest: dmabuf-export
[275.371445] Subtest dmabuf-export: SUCCESS (0.010s)
[275.507706] [145/165] (783s left) vgem_basic (dmabuf-fence)
[275.924724] Starting subtest: dmabuf-fence
[275.928910] Subtest dmabuf-fence: SUCCESS (0.004s)
[276.041715] [146/165] (782s left) vgem_basic (dmabuf-fence-before)
[276.442248] Starting subtest: dmabuf-fence-before
[276.446588] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[276.562455] [147/165] (782s left) vgem_basic (dmabuf-mmap)
[276.984987] Starting subtest: dmabuf-mmap
[277.056180] Subtest dmabuf-mmap: SUCCESS (0.082s)
[277.178464] [148/165] (782s left) vgem_basic (mmap)
[277.578245] Starting subtest: mmap
[277.633557] Subtest mmap: SUCCESS (0.060s)
[277.760570] [149/165] (781s left) vgem_basic (second-client)
[278.160646] Starting subtest: second-client
[278.194924] Subtest second-client: SUCCESS (0.032s)
[278.311611] [150/165] (781s left) vgem_basic (sysfs)
[278.726565] Starting subtest: sysfs
[278.730634] Subtest sysfs: SUCCESS (0.005s)
[278.845277] [151/165] (780s left) core_hotunplug (unbind-rebind)
[279.407097] Starting subtest: unbind-rebind
[283.799284] Subtest unbind-rebind: SUCCESS (4.389s)
[283.935406] [152/165] (775s left) vgem_basic (unload)
[284.359832] Starting subtest: unload
[313.718757] Subtest unload: SUCCESS (29.359s)
[313.972667] [153/165] (745s left) i915_module_load (reload)
[314.393261] Starting subtest: reload
[319.294554] Subtest reload: SUCCESS (4.898s)
[319.459473] [154/165] (740s left) gem_lmem_swapping (basic)
[320.261152] Subtest basic: SKIP (0.000s)
[320.383720] [155/165] (739s left) gem_lmem_swapping (parallel-random-engines)
[320.792389] Subtest parallel-random-engines: SKIP (0.000s)
[320.902119] [156/165] (739s left) gem_lmem_swapping (random-engines)
[321.324674] Subtest random-engines: SKIP (0.000s)
[321.433944] [157/165] (738s left) gem_lmem_swapping (verify-random)
[321.853137] Subtest verify-random: SKIP (0.000s)
[321.951575] [158/165] (738s left) i915_pm_rpm (module-reload)
[333.860921] Subtest module-reload: SKIP (0.000s)
[333.962514] [159/165] (726s left) i915_selftest (live)
[336.337952] Starting subtest: live
[336.341139] Starting dynamic subtest: sanitycheck
[338.688241] Dynamic subtest sanitycheck: SUCCESS (2.348s)
[338.720138] Starting dynamic subtest: uncore
[340.713666] Dynamic subtest uncore: SUCCESS (2.021s)
[340.744514] Starting dynamic subtest: workarounds
[342.762495] Dynamic subtest workarounds: SUCCESS (2.046s)
[342.801864] Starting dynamic subtest: gt_engines
[344.861275] Dynamic subtest gt_engines: SUCCESS (2.095s)
[344.901859] Starting dynamic subtest: gt_timelines
[356.013982] Dynamic subtest gt_timelines: SUCCESS (11.150s)
[356.044505] Starting dynamic subtest: gt_contexts
[358.094687] Dynamic subtest gt_contexts: SUCCESS (2.077s)
[358.136814] Starting dynamic subtest: gt_lrc
[360.142139] Dynamic subtest gt_lrc: SUCCESS (2.045s)
[360.173730] Starting dynamic subtest: gt_mocs
[362.185950] Dynamic subtest gt_mocs: SUCCESS (2.040s)
[362.226543] Starting dynamic subtest: gt_pm
[364.677529] Dynamic subtest gt_pm: SUCCESS (2.487s)
[364.709541] Starting dynamic subtest: gt_heartbeat
[366.816105] Dynamic subtest gt_heartbeat: SUCCESS (2.137s)
[366.846830] Starting dynamic subtest: gt_tlb
[368.858235] Dynamic subtest gt_tlb: SUCCESS (2.038s)
[368.888607] Starting dynamic subtest: requests
[373.529821] Dynamic subtest requests: SUCCESS (4.669s)
[373.561778] Starting dynamic subtest: migrate
[375.556713] Dynamic subtest migrate: SUCCESS (2.024s)
[375.588286] Starting dynamic subtest: active
[377.622980] Dynamic subtest active: SUCCESS (2.063s)
[377.653628] Starting dynamic subtest: objects
[380.680140] Dynamic subtest objects: SUCCESS (3.052s)
[380.719828] Starting dynamic subtest: mman
[392.202486] Dynamic subtest mman: SUCCESS (11.520s)
[392.241280] Starting dynamic subtest: dmabuf
[394.425340] Dynamic subtest dmabuf: SUCCESS (2.219s)
[394.456963] Starting dynamic subtest: vma
[396.499130] Dynamic subtest vma: SUCCESS (2.070s)
[396.539504] Starting dynamic subtest: coherency
[403.504365] Dynamic subtest coherency: SUCCESS (7.001s)
[403.544577] Starting dynamic subtest: gtt
[409.074708] Dynamic subtest gtt: SUCCESS (5.567s)
[409.106430] Starting dynamic subtest: gem
[411.186124] Dynamic subtest gem: SUCCESS (2.108s)
[411.227209] Starting dynamic subtest: evict
[413.270299] Dynamic subtest evict: SUCCESS (2.079s)
[413.301340] Starting dynamic subtest: hugepages
[415.327562] Dynamic subtest hugepages: SUCCESS (2.054s)
[415.359081] Starting dynamic subtest: gem_contexts
[417.360504] Dynamic subtest gem_contexts: SUCCESS (2.030s)
[417.392315] Starting dynamic subtest: client
[419.420266] Dynamic subtest client: SUCCESS (2.055s)
[419.451274] Starting dynamic subtest: gem_migrate
[421.493937] Dynamic subtest gem_migrate: SUCCESS (2.070s)
[421.525411] Starting dynamic subtest: reset
[424.090575] Dynamic subtest reset: SUCCESS (2.593s)
[424.131371] Starting dynamic subtest: memory_region
[426.174994] Dynamic subtest memory_region: SUCCESS (2.081s)
[426.205993] Starting dynamic subtest: hangcheck
[429.309593] Dynamic subtest hangcheck: SUCCESS (3.128s)
[429.352279] Starting dynamic subtest: execlists
[431.360661] Dynamic subtest execlists: SUCCESS (2.049s)
[431.394564] Starting dynamic subtest: ring_submission
[433.458464] Dynamic subtest ring_submission: SUCCESS (2.093s)
[433.498438] Starting dynamic subtest: perf
[435.523750] Dynamic subtest perf: SUCCESS (2.059s)
[435.565196] Starting dynamic subtest: slpc
[437.629769] Dynamic subtest slpc: SUCCESS (2.104s)
[437.661393] Starting dynamic subtest: guc
[439.680125] Dynamic subtest guc: SUCCESS (2.046s)
[439.719520] Starting dynamic subtest: guc_multi_lrc
[441.720581] Dynamic subtest guc_multi_lrc: SUCCESS (2.037s)
[441.751971] Starting dynamic subtest: guc_hang
[443.758164] Dynamic subtest guc_hang: SUCCESS (2.032s)
[443.798505] Starting dynamic subtest: late_gt_pm
[445.863115] Dynamic subtest late_gt_pm: SUCCESS (2.102s)
[445.866337] Subtest live: SUCCESS (109.527s)
[445.962541] [160/165] (614s left) dmabuf (all-tests)
[446.477463] Starting subtest: all-tests
[446.481643] Starting dynamic subtest: sanitycheck
[446.567572] Dynamic subtest sanitycheck: SUCCESS (0.088s)
[446.610684] Starting dynamic subtest: dma_fence
[446.790371] Dynamic subtest dma_fence: SUCCESS (0.219s)
[446.831527] Starting dynamic subtest: dma_fence_chain
[498.377452] Dynamic subtest dma_fence_chain: SUCCESS (51.583s)
[498.411908] Starting dynamic subtest: dma_fence_unwrap
[498.480267] Dynamic subtest dma_fence_unwrap: SUCCESS (0.099s)
[498.519272] Starting dynamic subtest: dma_resv
[498.574337] Dynamic subtest dma_resv: SUCCESS (0.090s)
[498.578565] Subtest all-tests: SUCCESS (52.099s)
[498.665186] [161/165] (561s left) i915_suspend (basic-s2idle-without-i915)
[499.057900] Starting subtest: basic-s2idle-without-i915
[520.898936] Subtest basic-s2idle-without-i915: SUCCESS (6.475s)
[524.120565] [162/165] (554s left) i915_suspend (basic-s3-without-i915)
[524.536402] Starting subtest: basic-s3-without-i915
[545.055607] Subtest basic-s3-without-i915: SUCCESS (4.658s)
[549.943561] [163/165] (549s left) gem_exec_suspend (basic-s0)
[550.435780] Starting subtest: basic-S0
[550.440146] Starting dynamic subtest: smem
[570.958997] Dynamic subtest smem: SUCCESS (5.882s)
[570.962574] Subtest basic-S0: SUCCESS (5.887s)
[573.281807] [164/165] (543s left) gem_exec_suspend (basic-s3)
[573.782322] Starting subtest: basic-S3
[573.785808] Starting dynamic subtest: smem
[596.121973] Dynamic subtest smem: SUCCESS (6.086s)
[596.125511] Subtest basic-S3: SUCCESS (6.091s)
[600.422300] [165/165] (536s left) kms_pipe_crc_basic (suspend-read-crc)
[600.870931] Starting subtest: suspend-read-crc
[600.882250] Starting dynamic subtest: pipe-A-VGA-1
[619.087342] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.420s)
[619.146861] Starting dynamic subtest: pipe-B-VGA-1
[637.934192] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.419s)
[637.938202] Subtest suspend-read-crc: SUCCESS (4.855s)
[644.206834] Closing watchdogs
Done.