[84.054125] Initializing watchdogs
[84.054345]   /dev/watchdog0
[84.111920] [001/162] (960s left) i915_module_load (load)
[84.713311] Starting subtest: load
[89.597817] Subtest load: SUCCESS (4.786s)
[90.216293] [002/162] (954s left) core_auth (basic-auth)
[91.101539] Starting subtest: basic-auth
[91.226761] Subtest basic-auth: SUCCESS (0.001s)
[91.469822] [003/162] (954s left) debugfs_test (read_all_entries)
[92.154462] Starting subtest: read_all_entries
[92.196384] Subtest read_all_entries: SUCCESS (0.050s)
[92.610391] [004/162] (953s left) debugfs_test (basic-hwmon)
[93.102704] Starting subtest: basic-hwmon
[93.186537] Subtest basic-hwmon: SKIP (0.000s)
[93.548303] [005/162] (952s left) fbdev (eof)
[94.024702] Starting subtest: eof
[94.066593] Subtest eof: SUCCESS (0.001s)
[94.234656] [006/162] (951s left) fbdev (info)
[94.603599] Starting subtest: info
[94.637083] Subtest info: SUCCESS (0.000s)
[94.779954] [007/162] (951s left) fbdev (nullptr)
[95.155901] Starting subtest: nullptr
[95.197761] Subtest nullptr: SUCCESS (0.000s)
[95.349159] [008/162] (951s left) fbdev (read)
[95.724412] Starting subtest: read
[96.150461] Subtest read: SUCCESS (0.472s)
[96.326719] [009/162] (950s left) fbdev (write)
[96.710399] Starting subtest: write
[96.802869] Subtest write: SUCCESS (0.108s)
[96.945412] [010/162] (949s left) gem_basic (bad-close)
[97.380238] Starting subtest: bad-close
[97.465395] Subtest bad-close: SUCCESS (0.000s)
[97.574758] [011/162] (949s left) gem_basic (create-close)
[98.034506] Starting subtest: create-close
[98.134849] Subtest create-close: SUCCESS (0.000s)
[98.260693] [012/162] (948s left) gem_basic (create-fd-close)
[98.737070] Starting subtest: create-fd-close
[98.804143] Subtest create-fd-close: SUCCESS (0.000s)
[98.905192] [013/162] (948s left) gem_busy (busy@all-engines)
[99.398059] Starting subtest: busy
[99.439688] Starting dynamic subtest: all-engines
[99.481729] Dynamic subtest all-engines: SUCCESS (0.038s)
[99.523613] Subtest busy: SUCCESS (0.038s)
[99.716942] [014/162] (947s left) gem_close_race (basic-process)
[100.245113] Starting subtest: basic-process
[100.278047] Subtest basic-process: SUCCESS (0.052s)
[100.437678] [015/162] (947s left) gem_close_race (basic-threads)
[100.880463] Starting subtest: basic-threads
[101.985827] Subtest basic-threads: SUCCESS (1.170s)
[102.247699] [016/162] (945s left) gem_ctx_create (basic)
[102.882243] Starting subtest: basic
[102.924327] Subtest basic: SUCCESS (0.000s)
[103.025403] [017/162] (944s left) gem_ctx_create (basic-files)
[103.459773] Starting subtest: basic-files
[105.411592] Subtest basic-files: SUCCESS (2.016s)
[105.679801] [018/162] (942s left) gem_ctx_exec (basic)
[106.264599] Starting subtest: basic
[106.306932] Subtest basic: SUCCESS (0.001s)
[106.416323] [019/162] (941s left) gem_exec_basic (basic)
[106.917677] Starting subtest: basic
[106.951206] Starting dynamic subtest: rcs0-smem
[106.984825] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[107.026676] Starting dynamic subtest: bcs0-smem
[107.060180] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[107.101968] Starting dynamic subtest: vcs0-smem
[107.135510] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[107.169106] Subtest basic: SUCCESS (0.001s)
[107.321819] [020/162] (941s left) gem_exec_create (basic)
[107.764171] Starting subtest: basic
[107.797591] Starting dynamic subtest: smem
[109.766620] Dynamic subtest smem: SUCCESS (2.057s)
[109.800211] Subtest basic: SUCCESS (2.058s)
[109.968650] [021/162] (938s left) gem_exec_fence (basic-busy)
[110.970567] Subtest basic-busy: SKIP (0.000s)
[111.389680] [022/162] (937s left) gem_exec_fence (basic-wait)
[111.926694] Subtest basic-wait: SKIP (0.000s)
[112.153370] [023/162] (936s left) gem_exec_fence (basic-await)
[112.654822] Subtest basic-await: SKIP (0.000s)
[112.965534] [024/162] (935s left) gem_exec_fence (nb-await)
[113.500197] Subtest nb-await: SKIP (0.000s)
[113.762366] [025/162] (935s left) gem_exec_gttfill (basic)
[114.263209] Starting subtest: basic
[119.401588] Subtest basic: SUCCESS (5.254s)
[119.669752] [026/162] (929s left) gem_exec_parallel (engines)
[121.480447] Starting subtest: engines
[121.522227] Starting dynamic subtest: basic
[123.015311] Dynamic subtest basic: SUCCESS (1.615s)
[123.065450] Starting dynamic subtest: contexts
[124.858676] Dynamic subtest contexts: SUCCESS (1.895s)
[124.908908] Starting dynamic subtest: fds
[127.436422] Dynamic subtest fds: SUCCESS (2.569s)
[127.478296] Starting dynamic subtest: userptr
[129.265064] Dynamic subtest userptr: SUCCESS (1.779s)
[129.298474] Subtest engines: SUCCESS (7.859s)
[129.466704] [027/162] (919s left) gem_exec_store (basic)
[130.085401] Starting subtest: basic
[130.119393] Subtest basic: SUCCESS (0.038s)
[130.220056] [028/162] (918s left) gem_flink_basic (bad-flink)
[130.704901] Starting subtest: bad-flink
[130.746788] Subtest bad-flink: SUCCESS (0.000s)
[130.856327] [029/162] (918s left) gem_flink_basic (bad-open)
[131.315806] Starting subtest: bad-open
[131.349464] Subtest bad-open: SUCCESS (0.000s)
[131.443870] [030/162] (918s left) gem_flink_basic (basic)
[131.903309] Starting subtest: basic
[131.945077] Subtest basic: SUCCESS (0.000s)
[132.046391] [031/162] (917s left) gem_flink_basic (double-flink)
[132.430442] Starting subtest: double-flink
[132.472413] Subtest double-flink: SUCCESS (0.000s)
[132.581911] [032/162] (917s left) gem_flink_basic (flink-lifetime)
[133.024638] Starting subtest: flink-lifetime
[133.066331] Subtest flink-lifetime: SUCCESS (0.001s)
[133.175909] [033/162] (916s left) gem_huc_copy (huc-copy)
[133.735738] Subtest huc-copy: SKIP (0.000s)
[133.846830] [034/162] (916s left) gem_linear_blits (basic)
[134.322925] Starting subtest: basic
[134.431535] Subtest basic: SUCCESS (0.009s)
[134.924522] [035/162] (915s left) gem_mmap (basic)
[137.268456] Starting subtest: basic
[137.477542] Subtest basic: SUCCESS (0.001s)
[137.587233] [036/162] (913s left) gem_mmap_gtt (basic)
[138.113330] Starting subtest: basic
[138.146729] Subtest basic: SUCCESS (0.001s)
[138.264546] [037/162] (912s left) gem_render_linear_blits (basic)
[138.682220] Starting subtest: basic
[138.892943] Subtest basic: SUCCESS (0.023s)
[138.993947] [038/162] (912s left) gem_render_tiled_blits (basic)
[139.503663] Starting subtest: basic
[139.704623] Subtest basic: SUCCESS (0.032s)
[139.805768] [039/162] (912s left) gem_ringfill (basic-all)
[140.389972] Starting subtest: basic-all
[141.382541] Subtest basic-all: SUCCESS (1.101s)
[141.492564] [040/162] (910s left) gem_softpin (allocator-basic)
[142.135925] Subtest allocator-basic: SKIP (0.000s)
[142.297172] [041/162] (909s left) gem_softpin (allocator-basic-reserve)
[142.789902] Subtest allocator-basic-reserve: SKIP (0.000s)
[142.924557] [042/162] (909s left) gem_softpin (safe-alignment)
[143.500987] Starting subtest: safe-alignment
[143.542777] Subtest safe-alignment: SUCCESS (0.007s)
[143.652449] [043/162] (908s left) gem_sync (basic-all)
[144.186812] Starting subtest: basic-all
[146.130550] Subtest basic-all: SUCCESS (2.051s)
[146.325541] [044/162] (906s left) gem_sync (basic-each)
[146.876366] Starting subtest: basic-each
[148.870047] Subtest basic-each: SUCCESS (2.129s)
[149.121713] [045/162] (903s left) gem_tiled_blits (basic)
[149.614254] Starting subtest: basic
[149.681323] Subtest basic: SUCCESS (0.013s)
[150.175133] [046/162] (902s left) gem_tiled_fence_blits (basic)
[152.526972] Starting subtest: basic
[152.602396] Subtest basic: SUCCESS (0.008s)
[153.103603] [047/162] (899s left) gem_tiled_pread_basic
[155.592595] [048/162] (897s left) gem_wait (busy@all-engines)
[156.076649] Starting subtest: busy
[156.110154] Starting dynamic subtest: all-engines
[156.519693] Dynamic subtest all-engines: SUCCESS (0.516s)
[156.553177] Subtest busy: SUCCESS (0.516s)
[156.729741] [049/162] (896s left) gem_wait (wait@all-engines)
[157.180728] Starting subtest: wait
[157.222577] Starting dynamic subtest: all-engines
[158.115634] Dynamic subtest all-engines: SUCCESS (1.017s)
[158.157194] Subtest wait: SUCCESS (1.018s)
[158.327639] [050/162] (894s left) i915_getparams_basic (basic-eu-total)
[158.794844] Starting subtest: basic-eu-total
[158.878733] Subtest basic-eu-total: SUCCESS (0.000s)
[158.988255] [051/162] (894s left) i915_getparams_basic (basic-subslice-total)
[159.472832] Starting subtest: basic-subslice-total
[159.539820] Subtest basic-subslice-total: SUCCESS (0.000s)
[159.640805] [052/162] (893s left) i915_hangman (error-state-basic)
[160.267142] Starting subtest: error-state-basic
[160.375923] Subtest error-state-basic: SUCCESS (0.008s)
[160.610713] [053/162] (893s left) i915_pciid
[161.239358] [054/162] (893s left) kms_addfb_basic (addfb25-bad-modifier)
[161.848985] Starting subtest: addfb25-bad-modifier
[161.907363] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[162.478703] [055/162] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[162.971674] Starting subtest: addfb25-framebuffer-vs-set-tiling
[163.005185] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[163.401850] [056/162] (891s left) kms_addfb_basic (addfb25-modifier-no-flag)
[163.961574] Starting subtest: addfb25-modifier-no-flag
[164.020268] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[164.339986] [057/162] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[164.882668] Starting subtest: addfb25-x-tiled-legacy
[164.924459] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[165.329912] [058/162] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[165.789333] Starting subtest: addfb25-x-tiled-mismatch-legacy
[165.831241] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[166.234301] [059/162] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[166.752522] Starting subtest: addfb25-yf-tiled-legacy
[166.786065] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[167.082308] [060/162] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[167.700661] Starting subtest: addfb25-y-tiled-legacy
[167.742616] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[168.003562] [061/162] (887s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[168.665803] Starting subtest: addfb25-y-tiled-small-legacy
[168.749697] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[168.977187] [062/162] (886s left) kms_addfb_basic (bad-pitch-0)
[169.494965] Starting subtest: bad-pitch-0
[169.536852] Subtest bad-pitch-0: SUCCESS (0.000s)
[169.931601] [063/162] (885s left) kms_addfb_basic (bad-pitch-1024)
[170.457894] Starting subtest: bad-pitch-1024
[170.499785] Subtest bad-pitch-1024: SUCCESS (0.000s)
[170.871581] [064/162] (884s left) kms_addfb_basic (bad-pitch-128)
[171.439397] Starting subtest: bad-pitch-128
[171.472876] Subtest bad-pitch-128: SUCCESS (0.000s)
[171.868428] [065/162] (883s left) kms_addfb_basic (bad-pitch-256)
[172.386145] Starting subtest: bad-pitch-256
[172.429754] Subtest bad-pitch-256: SUCCESS (0.000s)
[172.782804] [066/162] (882s left) kms_addfb_basic (bad-pitch-32)
[173.292615] Starting subtest: bad-pitch-32
[173.326111] Subtest bad-pitch-32: SUCCESS (0.000s)
[173.804459] [067/162] (881s left) kms_addfb_basic (bad-pitch-63)
[174.391286] Starting subtest: bad-pitch-63
[174.424796] Subtest bad-pitch-63: SUCCESS (0.000s)
[174.727731] [068/162] (881s left) kms_addfb_basic (bad-pitch-65536)
[175.195686] Starting subtest: bad-pitch-65536
[175.229196] Subtest bad-pitch-65536: SUCCESS (0.000s)
[175.632557] [069/162] (880s left) kms_addfb_basic (bad-pitch-999)
[176.177195] Starting subtest: bad-pitch-999
[176.252476] Subtest bad-pitch-999: SUCCESS (0.000s)
[176.572318] [070/162] (879s left) kms_addfb_basic (basic)
[177.048326] Starting subtest: basic
[177.090204] Subtest basic: SUCCESS (0.000s)
[177.426616] [071/162] (878s left) kms_addfb_basic (basic-x-tiled-legacy)
[177.887912] Starting subtest: basic-x-tiled-legacy
[177.929844] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[178.316449] [072/162] (877s left) kms_addfb_basic (basic-y-tiled-legacy)
[178.842791] Starting subtest: basic-y-tiled-legacy
[178.876470] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[179.254502] [073/162] (877s left) kms_addfb_basic (bo-too-small)
[179.933070] Starting subtest: bo-too-small
[179.974933] Subtest bo-too-small: SUCCESS (0.000s)
[180.202534] [074/162] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[180.753723] Starting subtest: bo-too-small-due-to-tiling
[180.787394] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[181.098592] [075/162] (875s left) kms_addfb_basic (clobberred-modifier)
[181.666096] Starting subtest: clobberred-modifier
[181.707993] Subtest clobberred-modifier: SUCCESS (0.000s)
[182.088094] [076/162] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[182.680742] Starting subtest: framebuffer-vs-set-tiling
[182.722688] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[183.075618] [077/162] (873s left) kms_addfb_basic (invalid-get-prop)
[183.576754] Starting subtest: invalid-get-prop
[183.618677] Subtest invalid-get-prop: SUCCESS (0.000s)
[184.015619] [078/162] (872s left) kms_addfb_basic (invalid-get-prop-any)
[184.600054] Starting subtest: invalid-get-prop-any
[184.641938] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[185.004344] [079/162] (871s left) kms_addfb_basic (invalid-set-prop)
[185.513521] Starting subtest: invalid-set-prop
[185.547040] Subtest invalid-set-prop: SUCCESS (0.000s)
[185.960766] [080/162] (870s left) kms_addfb_basic (invalid-set-prop-any)
[186.528140] Starting subtest: invalid-set-prop-any
[186.620165] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[187.006855] [081/162] (870s left) kms_addfb_basic (no-handle)
[187.574468] Starting subtest: no-handle
[187.607915] Subtest no-handle: SUCCESS (0.000s)
[187.995996] [082/162] (869s left) kms_addfb_basic (size-max)
[188.597672] Starting subtest: size-max
[188.639566] Subtest size-max: SUCCESS (0.000s)
[188.918317] [083/162] (868s left) kms_addfb_basic (small-bo)
[189.504555] Starting subtest: small-bo
[189.546449] Subtest small-bo: SUCCESS (0.000s)
[189.858386] [084/162] (867s left) kms_addfb_basic (tile-pitch-mismatch)
[190.609329] Starting subtest: tile-pitch-mismatch
[190.676286] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[190.978433] [085/162] (866s left) kms_addfb_basic (too-high)
[191.563460] Starting subtest: too-high
[191.605405] Subtest too-high: SUCCESS (0.001s)
[191.876972] [086/162] (865s left) kms_addfb_basic (too-wide)
[192.578276] Starting subtest: too-wide
[192.611933] Subtest too-wide: SUCCESS (0.000s)
[192.839667] [087/162] (864s left) kms_addfb_basic (unused-handle)
[193.340562] Starting subtest: unused-handle
[193.382632] Subtest unused-handle: SUCCESS (0.000s)
[193.779634] [088/162] (863s left) kms_addfb_basic (unused-modifier)
[194.305402] Starting subtest: unused-modifier
[194.405694] Subtest unused-modifier: SUCCESS (0.000s)
[194.709816] [089/162] (863s left) kms_addfb_basic (unused-offsets)
[195.234719] Starting subtest: unused-offsets
[195.276645] Subtest unused-offsets: SUCCESS (0.000s)
[195.615104] [090/162] (862s left) kms_addfb_basic (unused-pitches)
[196.166039] Starting subtest: unused-pitches
[196.207917] Subtest unused-pitches: SUCCESS (0.000s)
[196.578451] [091/162] (861s left) kms_busy (basic)
[197.271956] Starting subtest: basic
[197.322050] Starting dynamic subtest: flip
[201.486163] Dynamic subtest flip: SUCCESS (4.302s)
[201.536380] Starting dynamic subtest: modeset
[203.842842] Dynamic subtest modeset: SUCCESS (2.350s)
[203.876409] Subtest basic: SUCCESS (6.655s)
[204.791384] [092/162] (853s left) kms_prop_blob (basic)
[205.400110] Starting subtest: basic
[205.441949] Subtest basic: SUCCESS (0.000s)
[205.552460] [093/162] (852s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[206.119573] Starting subtest: basic-busy-flip-before-cursor-atomic
[207.254691] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.176s)
[208.186744] [094/162] (850s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[208.812865] Starting subtest: basic-busy-flip-before-cursor-legacy
[209.964616] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.179s)
[210.871516] [095/162] (847s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[211.506050] Starting subtest: basic-flip-after-cursor-atomic
[212.708136] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.205s)
[213.696585] [096/162] (844s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[214.299722] Starting subtest: basic-flip-after-cursor-legacy
[215.484720] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.207s)
[216.414881] [097/162] (842s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[217.007431] Starting subtest: basic-flip-after-cursor-varying-size
[218.211206] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.187s)
[219.191284] [098/162] (839s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[219.758753] Starting subtest: basic-flip-before-cursor-atomic
[220.960887] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.198s)
[221.909591] [099/162] (836s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[222.535530] Starting subtest: basic-flip-before-cursor-legacy
[223.704224] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.188s)
[224.709304] [100/162] (834s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[225.303507] Starting subtest: basic-flip-before-cursor-varying-size
[226.455303] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.181s)
[227.410349] [101/162] (831s left) kms_flip (basic-flip-vs-dpms)
[227.927742] Starting subtest: basic-flip-vs-dpms
[227.961360] Starting dynamic subtest: A-LVDS1
[229.667537] Dynamic subtest A-LVDS1: SUCCESS (1.802s)
[229.717801] Starting dynamic subtest: B-LVDS1
[231.180192] Dynamic subtest B-LVDS1: SUCCESS (1.497s)
[231.230496] Starting dynamic subtest: A-VGA1
[231.878637] Dynamic subtest A-VGA1: SUCCESS (0.706s)
[231.920570] Starting dynamic subtest: B-VGA1
[232.602611] Dynamic subtest B-VGA1: SUCCESS (0.703s)
[232.644528] Subtest basic-flip-vs-dpms: SUCCESS (4.716s)
[233.022747] [102/162] (826s left) kms_flip (basic-flip-vs-modeset)
[233.591085] Starting subtest: basic-flip-vs-modeset
[233.624682] Starting dynamic subtest: A-LVDS1
[235.255949] Dynamic subtest A-LVDS1: SUCCESS (1.718s)
[235.306233] Starting dynamic subtest: B-LVDS1
[236.777349] Dynamic subtest B-LVDS1: SUCCESS (1.492s)
[236.819262] Starting dynamic subtest: A-VGA1
[237.509584] Dynamic subtest A-VGA1: SUCCESS (0.739s)
[237.559816] Starting dynamic subtest: B-VGA1
[238.265211] Dynamic subtest B-VGA1: SUCCESS (0.738s)
[238.307026] Subtest basic-flip-vs-modeset: SUCCESS (4.699s)
[238.678666] [103/162] (820s left) kms_flip (basic-flip-vs-wf_vblank)
[239.180077] Starting subtest: basic-flip-vs-wf_vblank
[239.213588] Starting dynamic subtest: A-LVDS1
[240.891723] Dynamic subtest A-LVDS1: SUCCESS (1.781s)
[240.942037] Starting dynamic subtest: B-LVDS1
[242.711785] Dynamic subtest B-LVDS1: SUCCESS (1.795s)
[242.762045] Starting dynamic subtest: A-VGA1
[243.933515] Dynamic subtest A-VGA1: SUCCESS (1.226s)
[243.975431] Starting dynamic subtest: B-VGA1
[244.910933] Dynamic subtest B-VGA1: SUCCESS (0.980s)
[244.944644] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.797s)
[245.407176] [104/162] (814s left) kms_flip (basic-plain-flip)
[245.958389] Starting subtest: basic-plain-flip
[246.002037] Starting dynamic subtest: A-LVDS1
[247.438277] Dynamic subtest A-LVDS1: SUCCESS (1.521s)
[247.497239] Starting dynamic subtest: B-LVDS1
[248.941593] Dynamic subtest B-LVDS1: SUCCESS (1.508s)
[248.991836] Starting dynamic subtest: A-VGA1
[249.869045] Dynamic subtest A-VGA1: SUCCESS (0.931s)
[249.919315] Starting dynamic subtest: B-VGA1
[250.570658] Dynamic subtest B-VGA1: SUCCESS (0.696s)
[250.612650] Subtest basic-plain-flip: SUCCESS (4.671s)
[251.009602] [105/162] (808s left) kms_force_connector_basic (force-connector-state)
[251.485701] Starting subtest: force-connector-state
[251.928962] Subtest force-connector-state: SUCCESS (0.542s)
[253.088639] [106/162] (806s left) kms_force_connector_basic (force-edid)
[253.737831] Starting subtest: force-edid
[253.779578] Subtest force-edid: SUCCESS (0.257s)
[254.418546] [107/162] (805s left) kms_force_connector_basic (force-load-detect)
[254.893712] Starting subtest: force-load-detect
[255.188640] Subtest force-load-detect: SUCCESS (0.411s)
[255.727157] [108/162] (804s left) kms_force_connector_basic (prune-stale-modes)
[256.252978] Starting subtest: prune-stale-modes
[256.294890] Subtest prune-stale-modes: SUCCESS (0.025s)
[256.743342] [109/162] (803s left) kms_frontbuffer_tracking (basic)
[257.452819] Starting subtest: basic
[259.605500] Subtest basic: SUCCESS (2.251s)
[259.935430] [110/162] (800s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[260.578901] Starting subtest: compare-crc-sanitycheck-xr24
[260.612521] Starting dynamic subtest: pipe-A-LVDS-1
[261.139430] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.555s)
[261.189673] Starting dynamic subtest: pipe-B-LVDS-1
[262.058729] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.922s)
[262.100478] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.482s)
[262.997143] [111/162] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[263.549211] Starting subtest: compare-crc-sanitycheck-nv12
[263.591144] Starting dynamic subtest: pipe-A-LVDS-1
[263.675036] Dynamic subtest pipe-A-LVDS-1: SKIP (0.000s)
[263.725226] Starting dynamic subtest: pipe-B-LVDS-1
[263.809347] Dynamic subtest pipe-B-LVDS-1: SKIP (0.000s)
[263.892951] Subtest compare-crc-sanitycheck-nv12: SKIP (0.007s)
[264.029287] [112/162] (796s left) kms_pipe_crc_basic (hang-read-crc)
[264.562574] Starting subtest: hang-read-crc
[264.596281] Starting dynamic subtest: pipe-A-LVDS-1
[266.395194] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.814s)
[266.445391] Starting dynamic subtest: pipe-B-LVDS-1
[268.793691] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.412s)
[268.835494] Subtest hang-read-crc: SUCCESS (4.230s)
[269.759317] [113/162] (790s left) kms_pipe_crc_basic (nonblocking-crc)
[270.317638] Starting subtest: nonblocking-crc
[270.359959] Starting dynamic subtest: pipe-A-LVDS-1
[271.028574] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.697s)
[271.078830] Starting dynamic subtest: pipe-B-LVDS-1
[272.350545] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.309s)
[272.392448] Subtest nonblocking-crc: SUCCESS (2.010s)
[273.313555] [114/162] (787s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[273.965310] Starting subtest: nonblocking-crc-frame-sequence
[274.007342] Starting dynamic subtest: pipe-A-LVDS-1
[274.659461] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.713s)
[274.701343] Starting dynamic subtest: pipe-B-LVDS-1
[275.939851] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.264s)
[275.981747] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.982s)
[276.929602] [115/162] (783s left) kms_pipe_crc_basic (read-crc)
[277.570857] Starting subtest: read-crc
[277.604754] Starting dynamic subtest: pipe-A-LVDS-1
[278.216728] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.646s)
[278.266897] Starting dynamic subtest: pipe-B-LVDS-1
[279.470464] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.245s)
[279.512393] Subtest read-crc: SUCCESS (1.895s)
[280.384402] [116/162] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[280.961061] Starting subtest: read-crc-frame-sequence
[281.003359] Starting dynamic subtest: pipe-A-LVDS-1
[281.596922] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.633s)
[281.647210] Starting dynamic subtest: pipe-B-LVDS-1
[282.767164] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.160s)
[282.809370] Subtest read-crc-frame-sequence: SUCCESS (1.797s)
[283.709438] [117/162] (777s left) kms_psr (primary_page_flip)
[284.251233] Subtest primary_page_flip: SKIP (0.000s)
[284.361881] [118/162] (776s left) kms_psr (cursor_plane_move)
[284.786524] Subtest cursor_plane_move: SKIP (0.000s)
[284.897673] [119/162] (776s left) kms_psr (sprite_plane_onoff)
[285.372124] Subtest sprite_plane_onoff: SKIP (0.000s)
[285.474845] [120/162] (775s left) kms_psr (primary_mmap_gtt)
[285.899361] Subtest primary_mmap_gtt: SKIP (0.000s)
[286.003630] [121/162] (775s left) kms_setmode (basic-clone-single-crtc)
[286.436383] Starting subtest: basic-clone-single-crtc
[286.561490] Subtest basic-clone-single-crtc: SKIP (0.001s)
[286.673302] [122/162] (774s left) i915_pm_backlight (basic-brightness)
[287.322641] Subtest basic-brightness: SKIP (0.000s)
[287.510092] [123/162] (774s left) i915_pm_rpm (basic-pci-d3-state)
[289.480995] Subtest basic-pci-d3-state: SKIP (0.000s)
[289.616149] [124/162] (772s left) i915_pm_rpm (basic-rte)
[290.074393] Starting subtest: basic-rte
[291.553232] Subtest basic-rte: SKIP (1.397s)
[291.756220] [125/162] (770s left) i915_pm_rps (basic-api)
[292.281376] Starting subtest: basic-api
[292.314821] Subtest basic-api: SUCCESS (0.004s)
[292.461418] [126/162] (769s left) prime_self_import (basic-llseek-bad)
[292.910307] Starting subtest: basic-llseek-bad
[292.993974] Subtest basic-llseek-bad: SUCCESS (0.002s)
[293.104894] [127/162] (768s left) prime_self_import (basic-llseek-size)
[293.495779] Starting subtest: basic-llseek-size
[293.562757] Subtest basic-llseek-size: SUCCESS (0.003s)
[293.657201] [128/162] (768s left) prime_self_import (basic-with_fd_dup)
[294.047985] Starting subtest: basic-with_fd_dup
[294.115087] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[294.225948] [129/162] (768s left) prime_self_import (basic-with_one_bo)
[294.600483] Starting subtest: basic-with_one_bo
[294.684126] Subtest basic-with_one_bo: SUCCESS (0.004s)
[294.795062] [130/162] (767s left) prime_self_import (basic-with_one_bo_two_files)
[295.204413] Starting subtest: basic-with_one_bo_two_files
[295.288113] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[295.399312] [131/162] (767s left) prime_self_import (basic-with_two_bos)
[295.756704] Starting subtest: basic-with_two_bos
[295.823649] Subtest basic-with_two_bos: SUCCESS (0.003s)
[295.926382] [132/162] (767s left) prime_vgem (basic-fence-flip)
[296.434024] Starting subtest: basic-fence-flip
[296.584885] Subtest basic-fence-flip: SKIP (0.225s)
[296.830500] [133/162] (766s left) prime_vgem (basic-fence-mmap)
[297.357121] Starting subtest: basic-fence-mmap
[297.390769] Subtest basic-fence-mmap: SUCCESS (0.033s)
[297.534886] [134/162] (765s left) prime_vgem (basic-fence-read)
[297.993209] Starting subtest: basic-fence-read
[298.035119] Subtest basic-fence-read: SUCCESS (0.052s)
[298.195860] [135/162] (765s left) prime_vgem (basic-gtt)
[298.687331] Starting subtest: basic-gtt
[298.729053] Subtest basic-gtt: SUCCESS (0.013s)
[298.881959] [136/162] (764s left) prime_vgem (basic-read)
[299.331275] Starting subtest: basic-read
[299.373192] Subtest basic-read: SUCCESS (0.021s)
[299.526068] [137/162] (764s left) prime_vgem (basic-write)
[300.060677] Starting subtest: basic-write
[300.094292] Subtest basic-write: SUCCESS (0.022s)
[300.238815] [138/162] (763s left) vgem_basic (setversion)
[300.754767] Starting subtest: setversion
[300.838353] Subtest setversion: SUCCESS (0.000s)
[300.949376] [139/162] (763s left) vgem_basic (create)
[301.373735] Starting subtest: create
[301.415574] Subtest create: SUCCESS (0.001s)
[301.526751] [140/162] (762s left) vgem_basic (debugfs)
[301.934391] Starting subtest: debugfs
[301.976118] Subtest debugfs: SUCCESS (0.001s)
[302.129341] [141/162] (762s left) vgem_basic (dmabuf-export)
[302.529620] Starting subtest: dmabuf-export
[302.613296] Subtest dmabuf-export: SUCCESS (0.004s)
[302.765813] [142/162] (761s left) vgem_basic (dmabuf-fence)
[303.240556] Starting subtest: dmabuf-fence
[303.282531] Subtest dmabuf-fence: SUCCESS (0.001s)
[303.393221] [143/162] (761s left) vgem_basic (dmabuf-fence-before)
[303.817821] Starting subtest: dmabuf-fence-before
[303.859733] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[303.970601] [144/162] (760s left) vgem_basic (dmabuf-mmap)
[304.386744] Starting subtest: dmabuf-mmap
[304.428596] Subtest dmabuf-mmap: SUCCESS (0.019s)
[304.598272] [145/162] (760s left) vgem_basic (mmap)
[305.005623] Starting subtest: mmap
[305.047306] Subtest mmap: SUCCESS (0.012s)
[305.160557] [146/162] (760s left) vgem_basic (second-client)
[305.634498] Starting subtest: second-client
[305.718140] Subtest second-client: SUCCESS (0.032s)
[305.879643] [147/162] (759s left) vgem_basic (sysfs)
[306.320151] Starting subtest: sysfs
[306.353886] Subtest sysfs: SUCCESS (0.001s)
[306.455612] [148/162] (759s left) core_hotunplug (unbind-rebind)
[307.114190] Starting subtest: unbind-rebind
[310.806470] Subtest unbind-rebind: SUCCESS (3.612s)
[311.091744] [149/162] (754s left) vgem_basic (unload)
[311.909418] Starting subtest: unload
[340.820920] Subtest unload: SUCCESS (29.083s)
[340.932883] [150/162] (725s left) i915_module_load (reload)
[341.641884] Starting subtest: reload
[346.027709] Subtest reload: SUCCESS (4.496s)
[346.146311] [151/162] (720s left) gem_lmem_swapping (basic)
[347.006322] Subtest basic: SKIP (0.000s)
[347.125341] [152/162] (719s left) gem_lmem_swapping (parallel-random-engines)
[347.633666] Subtest parallel-random-engines: SKIP (0.000s)
[347.744384] [153/162] (718s left) gem_lmem_swapping (random-engines)
[348.244129] Subtest random-engines: SKIP (0.000s)
[348.355450] [154/162] (718s left) gem_lmem_swapping (verify-random)
[348.789724] Subtest verify-random: SKIP (0.000s)
[348.900622] [155/162] (718s left) i915_pm_rpm (module-reload)
[350.660879] Subtest module-reload: SKIP (0.000s)
[350.764481] [156/162] (716s left) i915_selftest (live)
[352.256773] Starting subtest: live
[352.290245] Starting dynamic subtest: sanitycheck
[353.178733] Dynamic subtest sanitycheck: SUCCESS (0.926s)
[353.228820] Starting dynamic subtest: uncore
[354.015566] Dynamic subtest uncore: SUCCESS (0.832s)
[354.065695] Starting dynamic subtest: workarounds
[354.810541] Dynamic subtest workarounds: SUCCESS (0.795s)
[354.852347] Starting dynamic subtest: gt_engines
[355.690580] Dynamic subtest gt_engines: SUCCESS (0.875s)
[355.740803] Starting dynamic subtest: gt_timelines
[360.139849] Dynamic subtest gt_timelines: SUCCESS (4.453s)
[360.181756] Starting dynamic subtest: gt_contexts
[360.986799] Dynamic subtest gt_contexts: SUCCESS (0.835s)
[361.036928] Starting dynamic subtest: gt_lrc
[361.865223] Dynamic subtest gt_lrc: SUCCESS (0.881s)
[361.907033] Starting dynamic subtest: gt_mocs
[362.693696] Dynamic subtest gt_mocs: SUCCESS (0.823s)
[362.745533] Starting dynamic subtest: gt_pm
[369.304613] Dynamic subtest gt_pm: SUCCESS (6.607s)
[369.354734] Starting dynamic subtest: gt_heartbeat
[370.143127] Dynamic subtest gt_heartbeat: SUCCESS (0.830s)
[370.184990] Starting dynamic subtest: gt_tlb
[371.046937] Dynamic subtest gt_tlb: SUCCESS (0.905s)
[371.097056] Starting dynamic subtest: requests
[376.499428] Dynamic subtest requests: SUCCESS (5.448s)
[376.541286] Starting dynamic subtest: migrate
[377.419686] Dynamic subtest migrate: SUCCESS (0.916s)
[377.469737] Starting dynamic subtest: active
[378.264999] Dynamic subtest active: SUCCESS (0.845s)
[378.306779] Starting dynamic subtest: objects
[379.570805] Dynamic subtest objects: SUCCESS (1.298s)
[379.620951] Starting dynamic subtest: mman
[384.156158] Dynamic subtest mman: SUCCESS (4.581s)
[384.206400] Starting dynamic subtest: dmabuf
[384.959873] Dynamic subtest dmabuf: SUCCESS (0.807s)
[385.001625] Starting dynamic subtest: vma
[385.788488] Dynamic subtest vma: SUCCESS (0.819s)
[385.838638] Starting dynamic subtest: coherency
[387.402380] Dynamic subtest coherency: SUCCESS (1.620s)
[387.444257] Starting dynamic subtest: gtt
[391.660633] Dynamic subtest gtt: SUCCESS (4.246s)
[391.710799] Starting dynamic subtest: gem
[392.708214] Dynamic subtest gem: SUCCESS (1.050s)
[392.750084] Starting dynamic subtest: evict
[393.636875] Dynamic subtest evict: SUCCESS (0.917s)
[393.686982] Starting dynamic subtest: hugepages
[395.000886] Dynamic subtest hugepages: SUCCESS (1.370s)
[395.042697] Starting dynamic subtest: gem_contexts
[399.651657] Dynamic subtest gem_contexts: SUCCESS (4.643s)
[399.693443] Starting dynamic subtest: client
[400.473378] Dynamic subtest client: SUCCESS (0.816s)
[400.523543] Starting dynamic subtest: gem_migrate
[401.318452] Dynamic subtest gem_migrate: SUCCESS (0.849s)
[401.360302] Starting dynamic subtest: reset
[402.272366] Dynamic subtest reset: SUCCESS (0.942s)
[402.314118] Starting dynamic subtest: memory_region
[403.094105] Dynamic subtest memory_region: SUCCESS (0.817s)
[403.144205] Starting dynamic subtest: hangcheck
[405.625087] Dynamic subtest hangcheck: SUCCESS (2.529s)
[405.675166] Starting dynamic subtest: execlists
[406.480345] Dynamic subtest execlists: SUCCESS (0.852s)
[406.522139] Starting dynamic subtest: ring_submission
[407.317058] Dynamic subtest ring_submission: SUCCESS (0.838s)
[407.367194] Starting dynamic subtest: perf
[408.170564] Dynamic subtest perf: SUCCESS (0.845s)
[408.220782] Starting dynamic subtest: slpc
[409.067378] Dynamic subtest slpc: SUCCESS (0.897s)
[409.109242] Starting dynamic subtest: guc
[409.912224] Dynamic subtest guc: SUCCESS (0.838s)
[409.962522] Starting dynamic subtest: guc_multi_lrc
[410.740734] Dynamic subtest guc_multi_lrc: SUCCESS (0.834s)
[410.782577] Starting dynamic subtest: guc_hang
[411.670813] Dynamic subtest guc_hang: SUCCESS (0.919s)
[411.720939] Starting dynamic subtest: late_gt_pm
[412.557757] Dynamic subtest late_gt_pm: SUCCESS (0.880s)
[412.599512] Subtest live: SUCCESS (60.273s)
[412.793883] [157/162] (654s left) dmabuf (all-tests)
[413.477400] Starting subtest: all-tests
[413.510893] Starting dynamic subtest: sanitycheck
[413.586081] Dynamic subtest sanitycheck: SUCCESS (0.204s)
[413.629656] Starting dynamic subtest: dma_fence
[413.755282] Dynamic subtest dma_fence: SUCCESS (0.182s)
[413.805551] Starting dynamic subtest: dma_fence_chain
[428.465247] Dynamic subtest dma_fence_chain: SUCCESS (14.711s)
[428.507175] Starting dynamic subtest: dma_fence_unwrap
[428.549384] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s)
[428.599616] Starting dynamic subtest: dma_resv
[428.641440] Dynamic subtest dma_resv: SUCCESS (0.064s)
[428.683354] Subtest all-tests: SUCCESS (15.240s)
[428.810756] [158/162] (638s left) i915_suspend (basic-s2idle-without-i915)
[429.360412] Starting subtest: basic-s2idle-without-i915
[449.660693] Subtest basic-s2idle-without-i915: SUCCESS (4.636s)
[451.806312] [159/162] (632s left) i915_suspend (basic-s3-without-i915)
[452.473585] Starting subtest: basic-s3-without-i915
[472.504815] Subtest basic-s3-without-i915: SUCCESS (4.306s)
[476.100749] [160/162] (626s left) gem_exec_suspend (basic-s0)
[476.851607] Starting subtest: basic-S0
[476.893463] Starting dynamic subtest: smem
[496.552526] Dynamic subtest smem: SUCCESS (2.300s)
[496.594691] Subtest basic-S0: SUCCESS (2.301s)
[499.726003] [161/162] (621s left) gem_exec_suspend (basic-s3)
[500.283381] Starting subtest: basic-S3
[500.316941] Starting dynamic subtest: smem
[518.407607] Dynamic subtest smem: SUCCESS (2.682s)
[518.449318] Subtest basic-S3: SUCCESS (2.683s)
[521.871053] [162/162] (617s left) kms_pipe_crc_basic (suspend-read-crc)
[522.629153] Starting subtest: suspend-read-crc
[522.671355] Starting dynamic subtest: pipe-A-LVDS-1
[542.818798] Dynamic subtest pipe-A-LVDS-1: SUCCESS (2.895s)
[543.002056] Starting dynamic subtest: pipe-B-LVDS-1
[561.411203] Dynamic subtest pipe-B-LVDS-1: SUCCESS (3.854s)
[561.453094] Subtest suspend-read-crc: SUCCESS (6.753s)
[564.572665] Closing watchdogs
Done.