[96.996059] Initializing watchdogs
[96.996425]   /dev/watchdog0
[97.019678] [001/171] (960s left) i915_module_load (load)
[97.845137] Starting subtest: load
[102.673519] Subtest load: SUCCESS (4.828s)
[103.143240] [002/171] (954s left) core_auth (basic-auth)
[104.177571] Starting subtest: basic-auth
[104.294400] Subtest basic-auth: SUCCESS (0.001s)
[104.478874] [003/171] (953s left) debugfs_test (read_all_entries)
[105.237647] Starting subtest: read_all_entries
[105.279448] Subtest read_all_entries: SUCCESS (0.057s)
[105.666291] [004/171] (952s left) debugfs_test (basic-hwmon)
[106.218362] Starting subtest: basic-hwmon
[106.285402] Subtest basic-hwmon: SKIP (0.000s)
[106.638226] [005/171] (951s left) fbdev (eof)
[107.155832] Starting subtest: eof
[107.189182] Subtest eof: SUCCESS (0.000s)
[107.315644] [006/171] (951s left) fbdev (info)
[107.749379] Starting subtest: info
[107.791078] Subtest info: SUCCESS (0.000s)
[107.933884] [007/171] (951s left) fbdev (nullptr)
[108.361099] Starting subtest: nullptr
[108.402826] Subtest nullptr: SUCCESS (0.000s)
[108.553646] [008/171] (950s left) fbdev (read)
[108.953977] Starting subtest: read
[109.446072] Subtest read: SUCCESS (0.545s)
[109.580475] [009/171] (949s left) fbdev (write)
[109.964097] Starting subtest: write
[110.039376] Subtest write: SUCCESS (0.124s)
[110.174242] [010/171] (949s left) gem_basic (bad-close)
[110.616458] Starting subtest: bad-close
[110.691682] Subtest bad-close: SUCCESS (0.000s)
[110.800968] [011/171] (948s left) gem_basic (create-close)
[111.228148] Starting subtest: create-close
[111.311694] Subtest create-close: SUCCESS (0.000s)
[111.421269] [012/171] (948s left) gem_basic (create-fd-close)
[111.847094] Starting subtest: create-fd-close
[111.930598] Subtest create-fd-close: SUCCESS (0.000s)
[112.031462] [013/171] (948s left) gem_busy (busy@all-engines)
[112.498857] Starting subtest: busy
[112.540580] Starting dynamic subtest: all-engines
[112.582221] Dynamic subtest all-engines: SUCCESS (0.040s)
[112.615965] Subtest busy: SUCCESS (0.040s)
[112.850967] [014/171] (947s left) gem_close_race (basic-process)
[113.402898] Starting subtest: basic-process
[113.444825] Subtest basic-process: SUCCESS (0.042s)
[113.554507] [015/171] (946s left) gem_close_race (basic-threads)
[114.014630] Starting subtest: basic-threads
[115.100758] Subtest basic-threads: SUCCESS (1.165s)
[115.277218] [016/171] (945s left) gem_ctx_create (basic)
[115.787852] Starting subtest: basic
[115.829977] Subtest basic: SUCCESS (0.000s)
[115.931345] [017/171] (944s left) gem_ctx_create (basic-files)
[116.414560] Starting subtest: basic-files
[118.380610] Subtest basic-files: SUCCESS (2.019s)
[118.573471] [018/171] (941s left) gem_ctx_exec (basic)
[119.358105] Starting subtest: basic
[119.399888] Subtest basic: SUCCESS (0.002s)
[119.500967] [019/171] (941s left) gem_exec_basic (basic)
[120.035104] Starting subtest: basic
[120.076910] Starting dynamic subtest: rcs0-smem
[120.118715] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[120.168935] Starting dynamic subtest: bcs0-smem
[120.210610] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[120.260874] Starting dynamic subtest: vcs0-smem
[120.302645] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[120.344469] Subtest basic: SUCCESS (0.001s)
[120.469988] [020/171] (940s left) gem_exec_create (basic)
[120.945767] Starting subtest: basic
[120.987522] Starting dynamic subtest: smem
[122.947539] Dynamic subtest smem: SUCCESS (2.051s)
[122.980742] Subtest basic: SUCCESS (2.052s)
[123.107594] [021/171] (937s left) gem_exec_fence (basic-busy)
[123.791351] Subtest basic-busy: SKIP (0.000s)
[124.235492] [022/171] (936s left) gem_exec_fence (basic-wait)
[124.853459] Subtest basic-wait: SKIP (0.000s)
[125.088398] [023/171] (935s left) gem_exec_fence (basic-await)
[125.649199] Subtest basic-await: SKIP (0.000s)
[125.925836] [024/171] (935s left) gem_exec_fence (nb-await)
[126.451782] Subtest nb-await: SKIP (0.000s)
[126.770614] [025/171] (934s left) gem_exec_gttfill (basic)
[127.303907] Starting subtest: basic
[132.254999] Subtest basic: SUCCESS (5.070s)
[132.506202] [026/171] (928s left) gem_exec_parallel (engines)
[134.839593] Starting subtest: engines
[134.881430] Starting dynamic subtest: basic
[136.464665] Dynamic subtest basic: SUCCESS (1.748s)
[136.506518] Starting dynamic subtest: contexts
[138.339563] Dynamic subtest contexts: SUCCESS (1.891s)
[138.381469] Starting dynamic subtest: fds
[140.981145] Dynamic subtest fds: SUCCESS (2.638s)
[141.023051] Starting dynamic subtest: userptr
[142.731595] Dynamic subtest userptr: SUCCESS (1.694s)
[142.772954] Subtest engines: SUCCESS (7.972s)
[142.890985] [027/171] (918s left) gem_exec_store (basic)
[143.534094] Starting subtest: basic
[143.575791] Subtest basic: SUCCESS (0.040s)
[143.685173] [028/171] (917s left) gem_flink_basic (bad-flink)
[144.204255] Starting subtest: bad-flink
[144.237608] Subtest bad-flink: SUCCESS (0.000s)
[144.338561] [029/171] (917s left) gem_flink_basic (bad-open)
[144.730559] Starting subtest: bad-open
[144.764261] Subtest bad-open: SUCCESS (0.000s)
[144.873557] [030/171] (916s left) gem_flink_basic (basic)
[145.291233] Starting subtest: basic
[145.324471] Subtest basic: SUCCESS (0.000s)
[145.425535] [031/171] (916s left) gem_flink_basic (double-flink)
[145.826244] Starting subtest: double-flink
[145.859589] Subtest double-flink: SUCCESS (0.000s)
[145.960222] [032/171] (916s left) gem_flink_basic (flink-lifetime)
[146.405553] Starting subtest: flink-lifetime
[146.447383] Subtest flink-lifetime: SUCCESS (0.001s)
[146.548429] [033/171] (915s left) gem_huc_copy (huc-copy)
[147.049172] Subtest huc-copy: SKIP (0.000s)
[147.158422] [034/171] (915s left) gem_linear_blits (basic)
[147.675846] Starting subtest: basic
[147.775880] Subtest basic: SUCCESS (0.009s)
[148.226693] [035/171] (914s left) gem_mmap (basic)
[150.526465] Starting subtest: basic
[150.693895] Subtest basic: SUCCESS (0.000s)
[150.786442] [036/171] (912s left) gem_mmap_gtt (basic)
[151.330246] Starting subtest: basic
[151.363556] Subtest basic: SUCCESS (0.001s)
[151.464930] [037/171] (911s left) gem_render_linear_blits (basic)
[151.973720] Starting subtest: basic
[152.182572] Subtest basic: SUCCESS (0.023s)
[152.292222] [038/171] (911s left) gem_render_tiled_blits (basic)
[152.784066] Starting subtest: basic
[153.034700] Subtest basic: SUCCESS (0.030s)
[153.144182] [039/171] (910s left) gem_ringfill (basic-all)
[153.819516] Starting subtest: basic-all
[154.878147] Subtest basic-all: SUCCESS (1.183s)
[154.980793] [040/171] (909s left) gem_softpin (allocator-basic)
[155.564836] Subtest allocator-basic: SKIP (0.000s)
[155.682525] [041/171] (908s left) gem_softpin (allocator-basic-reserve)
[156.224982] Subtest allocator-basic-reserve: SKIP (0.000s)
[156.325986] [042/171] (908s left) gem_softpin (safe-alignment)
[156.793193] Starting subtest: safe-alignment
[156.835132] Subtest safe-alignment: SUCCESS (0.007s)
[156.944232] [043/171] (907s left) gem_sync (basic-all)
[157.536427] Starting subtest: basic-all
[159.554827] Subtest basic-all: SUCCESS (2.186s)
[159.748093] [044/171] (905s left) gem_sync (basic-each)
[160.265082] Starting subtest: basic-each
[162.257076] Subtest basic-each: SUCCESS (2.121s)
[162.441619] [045/171] (902s left) gem_tiled_blits (basic)
[163.033965] Starting subtest: basic
[163.125815] Subtest basic: SUCCESS (0.013s)
[163.568497] [046/171] (901s left) gem_tiled_fence_blits (basic)
[165.876661] Starting subtest: basic
[165.968471] Subtest basic: SUCCESS (0.008s)
[166.545720] [047/171] (898s left) gem_tiled_pread_basic
[169.005419] [048/171] (896s left) gem_wait (busy@all-engines)
[169.497422] Starting subtest: busy
[169.539242] Starting dynamic subtest: all-engines
[169.906753] Dynamic subtest all-engines: SUCCESS (0.515s)
[169.948157] Subtest busy: SUCCESS (0.515s)
[170.149923] [049/171] (895s left) gem_wait (wait@all-engines)
[170.650237] Starting subtest: wait
[170.692073] Starting dynamic subtest: all-engines
[171.592686] Dynamic subtest all-engines: SUCCESS (1.018s)
[171.634047] Subtest wait: SUCCESS (1.019s)
[171.795418] [050/171] (893s left) i915_getparams_basic (basic-eu-total)
[172.237687] Starting subtest: basic-eu-total
[172.312929] Subtest basic-eu-total: SUCCESS (0.000s)
[172.414206] [051/171] (893s left) i915_getparams_basic (basic-subslice-total)
[172.956392] Starting subtest: basic-subslice-total
[173.040188] Subtest basic-subslice-total: SUCCESS (0.000s)
[173.149413] [052/171] (892s left) i915_hangman (error-state-basic)
[173.799333] Starting subtest: error-state-basic
[173.908093] Subtest error-state-basic: SUCCESS (0.009s)
[174.159388] [053/171] (892s left) i915_pciid
[174.787666] [054/171] (891s left) kms_addfb_basic (addfb25-bad-modifier)
[175.396444] Starting subtest: addfb25-bad-modifier
[175.479709] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[176.058374] [055/171] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[176.683843] Starting subtest: addfb25-framebuffer-vs-set-tiling
[176.725740] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[177.096862] [056/171] (889s left) kms_addfb_basic (addfb25-modifier-no-flag)
[177.630866] Starting subtest: addfb25-modifier-no-flag
[177.672650] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[178.034093] [057/171] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[178.542870] Starting subtest: addfb25-x-tiled-legacy
[178.576296] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[178.972976] [058/171] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[179.515238] Starting subtest: addfb25-x-tiled-mismatch-legacy
[179.548784] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[179.910065] [059/171] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[180.544525] Starting subtest: addfb25-yf-tiled-legacy
[180.586325] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[180.932282] [060/171] (886s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[181.658404] Starting subtest: addfb25-y-tiled-legacy
[181.700322] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[181.935870] [061/171] (885s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[182.570319] Starting subtest: addfb25-y-tiled-small-legacy
[182.670729] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[182.899615] [062/171] (884s left) kms_addfb_basic (bad-pitch-0)
[183.383251] Starting subtest: bad-pitch-0
[183.426597] Subtest bad-pitch-0: SUCCESS (0.000s)
[183.794705] [063/171] (883s left) kms_addfb_basic (bad-pitch-1024)
[184.336803] Starting subtest: bad-pitch-1024
[184.387097] Subtest bad-pitch-1024: SUCCESS (0.000s)
[184.732918] [064/171] (882s left) kms_addfb_basic (bad-pitch-128)
[185.258333] Starting subtest: bad-pitch-128
[185.291869] Subtest bad-pitch-128: SUCCESS (0.000s)
[185.661337] [065/171] (882s left) kms_addfb_basic (bad-pitch-256)
[186.228276] Starting subtest: bad-pitch-256
[186.303421] Subtest bad-pitch-256: SUCCESS (0.000s)
[186.656397] [066/171] (881s left) kms_addfb_basic (bad-pitch-32)
[187.183440] Starting subtest: bad-pitch-32
[187.225169] Subtest bad-pitch-32: SUCCESS (0.000s)
[187.653350] [067/171] (880s left) kms_addfb_basic (bad-pitch-63)
[188.228823] Starting subtest: bad-pitch-63
[188.270754] Subtest bad-pitch-63: SUCCESS (0.000s)
[188.598730] [068/171] (879s left) kms_addfb_basic (bad-pitch-65536)
[189.134322] Starting subtest: bad-pitch-65536
[189.176199] Subtest bad-pitch-65536: SUCCESS (0.000s)
[189.545709] [069/171] (878s left) kms_addfb_basic (bad-pitch-999)
[190.063023] Starting subtest: bad-pitch-999
[190.104919] Subtest bad-pitch-999: SUCCESS (0.000s)
[190.640590] [070/171] (877s left) kms_addfb_basic (basic)
[191.184676] Starting subtest: basic
[191.235045] Subtest basic: SUCCESS (0.000s)
[191.578893] [071/171] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[192.054461] Starting subtest: basic-x-tiled-legacy
[192.087904] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[192.507903] [072/171] (875s left) kms_addfb_basic (basic-y-tiled-legacy)
[193.135192] Starting subtest: basic-y-tiled-legacy
[193.177074] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[193.530094] [073/171] (875s left) kms_addfb_basic (bo-too-small)
[194.131267] Starting subtest: bo-too-small
[194.173054] Subtest bo-too-small: SUCCESS (0.000s)
[194.467362] [074/171] (874s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[195.086857] Starting subtest: bo-too-small-due-to-tiling
[195.120396] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[195.431497] [075/171] (873s left) kms_addfb_basic (clobberred-modifier)
[195.932390] Starting subtest: clobberred-modifier
[195.965924] Subtest clobberred-modifier: SUCCESS (0.000s)
[196.344155] [076/171] (872s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[196.854937] Starting subtest: framebuffer-vs-set-tiling
[196.896835] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[197.266484] [077/171] (871s left) kms_addfb_basic (invalid-get-prop)
[197.808605] Starting subtest: invalid-get-prop
[197.850427] Subtest invalid-get-prop: SUCCESS (0.000s)
[198.169950] [078/171] (870s left) kms_addfb_basic (invalid-get-prop-any)
[198.672504] Starting subtest: invalid-get-prop-any
[198.714339] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[199.133921] [079/171] (869s left) kms_addfb_basic (invalid-set-prop)
[199.659678] Starting subtest: invalid-set-prop
[199.701655] Subtest invalid-set-prop: SUCCESS (0.000s)
[200.056669] [080/171] (869s left) kms_addfb_basic (invalid-set-prop-any)
[200.598826] Starting subtest: invalid-set-prop-any
[200.649085] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[200.977130] [081/171] (868s left) kms_addfb_basic (no-handle)
[201.477516] Starting subtest: no-handle
[201.511077] Subtest no-handle: SUCCESS (0.000s)
[201.882062] [082/171] (867s left) kms_addfb_basic (size-max)
[202.525112] Starting subtest: size-max
[202.558706] Subtest size-max: SUCCESS (0.000s)
[202.844884] [083/171] (866s left) kms_addfb_basic (small-bo)
[203.554135] Starting subtest: small-bo
[203.596041] Subtest small-bo: SUCCESS (0.000s)
[203.842165] [084/171] (865s left) kms_addfb_basic (tile-pitch-mismatch)
[204.379231] Starting subtest: tile-pitch-mismatch
[204.417438] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[204.803955] [085/171] (864s left) kms_addfb_basic (too-high)
[205.371359] Starting subtest: too-high
[205.413208] Subtest too-high: SUCCESS (0.001s)
[205.709461] [086/171] (864s left) kms_addfb_basic (too-wide)
[206.326914] Starting subtest: too-wide
[206.360489] Subtest too-wide: SUCCESS (0.000s)
[206.621763] [087/171] (863s left) kms_addfb_basic (unused-handle)
[207.188746] Starting subtest: unused-handle
[207.230673] Subtest unused-handle: SUCCESS (0.000s)
[207.560587] [088/171] (862s left) kms_addfb_basic (unused-modifier)
[208.119135] Starting subtest: unused-modifier
[208.152581] Subtest unused-modifier: SUCCESS (0.000s)
[208.548128] [089/171] (861s left) kms_addfb_basic (unused-offsets)
[209.073130] Starting subtest: unused-offsets
[209.114967] Subtest unused-offsets: SUCCESS (0.000s)
[209.503779] [090/171] (860s left) kms_addfb_basic (unused-pitches)
[210.003741] Starting subtest: unused-pitches
[210.045808] Subtest unused-pitches: SUCCESS (0.000s)
[210.365623] [091/171] (859s left) kms_busy (basic)
[211.158062] Starting subtest: basic
[211.224788] Starting dynamic subtest: flip
[215.351354] Dynamic subtest flip: SUCCESS (4.283s)
[215.409862] Starting dynamic subtest: modeset
[217.705335] Dynamic subtest modeset: SUCCESS (2.363s)
[217.747176] Subtest basic: SUCCESS (6.648s)
[218.627347] [092/171] (851s left) kms_chamelium_hpd (dp-hpd-fast)
[219.695249] Subtest dp-hpd-fast: SKIP (0.000s)
[220.481820] [093/171] (850s left) kms_chamelium_edid (dp-edid-read)
[221.407429] Subtest dp-edid-read: SKIP (0.000s)
[222.187356] [094/171] (848s left) kms_chamelium_frames (dp-crc-fast)
[223.171851] Subtest dp-crc-fast: SKIP (0.000s)
[224.008605] [095/171] (846s left) kms_chamelium_hpd (hdmi-hpd-fast)
[224.961109] Subtest hdmi-hpd-fast: SKIP (0.000s)
[225.755804] [096/171] (845s left) kms_chamelium_edid (hdmi-edid-read)
[226.690539] Subtest hdmi-edid-read: SKIP (0.000s)
[227.487547] [097/171] (843s left) kms_chamelium_frames (hdmi-crc-fast)
[228.354872] Subtest hdmi-crc-fast: SKIP (0.000s)
[229.275255] [098/171] (841s left) kms_chamelium_hpd (vga-hpd-fast)
[230.250771] Subtest vga-hpd-fast: SKIP (0.000s)
[231.072443] [099/171] (840s left) kms_chamelium_edid (vga-edid-read)
[232.022952] Subtest vga-edid-read: SKIP (0.000s)
[232.793345] [100/171] (838s left) kms_prop_blob (basic)
[233.368059] Starting subtest: basic
[233.401637] Subtest basic: SUCCESS (0.000s)
[233.496309] [101/171] (838s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[234.180260] Starting subtest: basic-busy-flip-before-cursor-atomic
[235.347652] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.210s)
[236.334618] [102/171] (835s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[236.886910] Starting subtest: basic-busy-flip-before-cursor-legacy
[238.079656] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.187s)
[239.016373] [103/171] (832s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[239.592031] Starting subtest: basic-flip-after-cursor-atomic
[240.819892] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.216s)
[241.790768] [104/171] (830s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[242.407247] Starting subtest: basic-flip-after-cursor-legacy
[243.608125] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.195s)
[244.505667] [105/171] (827s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[245.064196] Starting subtest: basic-flip-after-cursor-varying-size
[246.281865] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.200s)
[247.227678] [106/171] (824s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[247.880139] Starting subtest: basic-flip-before-cursor-atomic
[249.072195] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.197s)
[249.993587] [107/171] (822s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[250.484425] Starting subtest: basic-flip-before-cursor-legacy
[251.670339] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.179s)
[252.598733] [108/171] (819s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[253.182605] Starting subtest: basic-flip-before-cursor-varying-size
[254.366899] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.186s)
[255.314735] [109/171] (816s left) kms_flip (basic-flip-vs-dpms)
[255.897662] Starting subtest: basic-flip-vs-dpms
[255.939278] Starting dynamic subtest: A-LVDS1
[257.658751] Dynamic subtest A-LVDS1: SUCCESS (1.808s)
[257.708877] Starting dynamic subtest: B-LVDS1
[259.154953] Dynamic subtest B-LVDS1: SUCCESS (1.496s)
[259.205064] Starting dynamic subtest: A-VGA1
[259.909311] Dynamic subtest A-VGA1: SUCCESS (0.723s)
[259.951215] Starting dynamic subtest: B-VGA1
[260.640537] Dynamic subtest B-VGA1: SUCCESS (0.722s)
[260.682370] Subtest basic-flip-vs-dpms: SUCCESS (4.764s)
[261.094330] [110/171] (811s left) kms_flip (basic-flip-vs-modeset)
[261.678045] Starting subtest: basic-flip-vs-modeset
[261.711522] Starting dynamic subtest: A-LVDS1
[263.357777] Dynamic subtest A-LVDS1: SUCCESS (1.797s)
[263.408013] Starting dynamic subtest: B-LVDS1
[264.843666] Dynamic subtest B-LVDS1: SUCCESS (1.490s)
[264.893909] Starting dynamic subtest: A-VGA1
[265.600173] Dynamic subtest A-VGA1: SUCCESS (0.734s)
[265.642047] Starting dynamic subtest: B-VGA1
[266.330345] Dynamic subtest B-VGA1: SUCCESS (0.719s)
[266.372146] Subtest basic-flip-vs-modeset: SUCCESS (4.751s)
[266.725148] [111/171] (805s left) kms_flip (basic-flip-vs-wf_vblank)
[267.277640] Starting subtest: basic-flip-vs-wf_vblank
[267.319389] Starting dynamic subtest: A-LVDS1
[268.971112] Dynamic subtest A-LVDS1: SUCCESS (1.768s)
[269.012974] Starting dynamic subtest: B-LVDS1
[270.989619] Dynamic subtest B-LVDS1: SUCCESS (1.984s)
[271.031381] Starting dynamic subtest: A-VGA1
[272.191261] Dynamic subtest A-VGA1: SUCCESS (1.214s)
[272.241517] Starting dynamic subtest: B-VGA1
[273.152444] Dynamic subtest B-VGA1: SUCCESS (0.967s)
[273.185909] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.944s)
[273.648468] [112/171] (798s left) kms_flip (basic-plain-flip)
[274.132231] Starting subtest: basic-plain-flip
[274.174273] Starting dynamic subtest: A-LVDS1
[275.618749] Dynamic subtest A-LVDS1: SUCCESS (1.544s)
[275.677274] Starting dynamic subtest: B-LVDS1
[277.120414] Dynamic subtest B-LVDS1: SUCCESS (1.497s)
[277.170624] Starting dynamic subtest: A-VGA1
[278.055561] Dynamic subtest A-VGA1: SUCCESS (0.934s)
[278.105833] Starting dynamic subtest: B-VGA1
[278.739901] Dynamic subtest B-VGA1: SUCCESS (0.682s)
[278.781681] Subtest basic-plain-flip: SUCCESS (4.670s)
[279.221905] [113/171] (793s left) kms_force_connector_basic (force-connector-state)
[279.762386] Starting subtest: force-connector-state
[280.197158] Subtest force-connector-state: SUCCESS (0.553s)
[281.369491] [114/171] (791s left) kms_force_connector_basic (force-edid)
[281.970465] Starting subtest: force-edid
[282.012325] Subtest force-edid: SUCCESS (0.268s)
[282.593340] [115/171] (790s left) kms_force_connector_basic (force-load-detect)
[283.117119] Starting subtest: force-load-detect
[283.426201] Subtest force-load-detect: SUCCESS (0.409s)
[284.049958] [116/171] (789s left) kms_force_connector_basic (prune-stale-modes)
[284.574752] Starting subtest: prune-stale-modes
[284.624938] Subtest prune-stale-modes: SUCCESS (0.020s)
[285.021703] [117/171] (788s left) kms_frontbuffer_tracking (basic)
[285.739523] Starting subtest: basic
[287.879308] Subtest basic: SUCCESS (2.268s)
[288.217280] [118/171] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[288.849536] Starting subtest: compare-crc-sanitycheck-xr24
[288.891621] Starting dynamic subtest: pipe-A-LVDS-1
[289.434614] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.544s)
[289.484746] Starting dynamic subtest: pipe-B-LVDS-1
[290.321595] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.901s)
[290.371785] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.451s)
[291.242226] [119/171] (782s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[291.883610] Starting subtest: compare-crc-sanitycheck-nv12
[291.925382] Starting dynamic subtest: pipe-A-LVDS-1
[292.009145] Dynamic subtest pipe-A-LVDS-1: SKIP (0.000s)
[292.059351] Starting dynamic subtest: pipe-B-LVDS-1
[292.143452] Dynamic subtest pipe-B-LVDS-1: SKIP (0.000s)
[292.227152] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[292.370988] [120/171] (781s left) kms_pipe_crc_basic (hang-read-crc)
[292.972552] Starting subtest: hang-read-crc
[293.006270] Starting dynamic subtest: pipe-A-LVDS-1
[294.835329] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.833s)
[294.885496] Starting dynamic subtest: pipe-B-LVDS-1
[297.224973] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.409s)
[297.266739] Subtest hang-read-crc: SUCCESS (4.247s)
[298.154415] [121/171] (775s left) kms_pipe_crc_basic (nonblocking-crc)
[298.805873] Starting subtest: nonblocking-crc
[298.847807] Starting dynamic subtest: pipe-A-LVDS-1
[299.507504] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.696s)
[299.557699] Starting dynamic subtest: pipe-B-LVDS-1
[300.793408] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.278s)
[300.835403] Subtest nonblocking-crc: SUCCESS (1.978s)
[301.731864] [122/171] (771s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[302.299081] Starting subtest: nonblocking-crc-frame-sequence
[302.341285] Starting dynamic subtest: pipe-A-LVDS-1
[303.000999] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.694s)
[303.042850] Starting dynamic subtest: pipe-B-LVDS-1
[304.270256] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.261s)
[304.311951] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.958s)
[305.243203] [123/171] (768s left) kms_pipe_crc_basic (read-crc)
[305.851059] Starting subtest: read-crc
[305.892940] Starting dynamic subtest: pipe-A-LVDS-1
[306.485998] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.640s)
[306.536196] Starting dynamic subtest: pipe-B-LVDS-1
[307.706602] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.211s)
[307.798522] Subtest read-crc: SUCCESS (1.854s)
[308.644500] [124/171] (765s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[309.177169] Starting subtest: read-crc-frame-sequence
[309.219390] Starting dynamic subtest: pipe-A-LVDS-1
[309.795606] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.632s)
[309.845815] Starting dynamic subtest: pipe-B-LVDS-1
[310.999732] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.193s)
[311.033346] Subtest read-crc-frame-sequence: SUCCESS (1.828s)
[311.921375] [125/171] (761s left) kms_psr (primary_page_flip)
[312.562278] Subtest primary_page_flip: SKIP (0.000s)
[312.714727] [126/171] (761s left) kms_psr (cursor_plane_move)
[313.222303] Subtest cursor_plane_move: SKIP (0.000s)
[313.334967] [127/171] (761s left) kms_psr (sprite_plane_onoff)
[313.792384] Subtest sprite_plane_onoff: SKIP (0.000s)
[313.894715] [128/171] (760s left) kms_psr (primary_mmap_gtt)
[314.368862] Subtest primary_mmap_gtt: SKIP (0.000s)
[314.479846] [129/171] (760s left) kms_setmode (basic-clone-single-crtc)
[314.978934] Starting subtest: basic-clone-single-crtc
[315.104301] Subtest basic-clone-single-crtc: SKIP (0.001s)
[315.222976] [130/171] (759s left) i915_pm_backlight (basic-brightness)
[315.832664] Subtest basic-brightness: SKIP (0.000s)
[316.059743] [131/171] (759s left) i915_pm_rpm (basic-pci-d3-state)
[317.961955] Subtest basic-pci-d3-state: SKIP (0.000s)
[318.081477] [132/171] (757s left) i915_pm_rpm (basic-rte)
[318.597144] Starting subtest: basic-rte
[320.000565] Subtest basic-rte: SKIP (1.382s)
[320.186944] [133/171] (755s left) i915_pm_rps (basic-api)
[320.752865] Starting subtest: basic-api
[320.794660] Subtest basic-api: SUCCESS (0.004s)
[320.947705] [134/171] (754s left) prime_self_import (basic-llseek-bad)
[321.413055] Starting subtest: basic-llseek-bad
[321.479743] Subtest basic-llseek-bad: SUCCESS (0.002s)
[321.598298] [135/171] (754s left) prime_self_import (basic-llseek-size)
[321.981159] Starting subtest: basic-llseek-size
[322.064683] Subtest basic-llseek-size: SUCCESS (0.003s)
[322.177544] [136/171] (753s left) prime_self_import (basic-with_fd_dup)
[322.626631] Starting subtest: basic-with_fd_dup
[322.710090] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[322.820653] [137/171] (753s left) prime_self_import (basic-with_one_bo)
[323.219887] Starting subtest: basic-with_one_bo
[323.303379] Subtest basic-with_one_bo: SUCCESS (0.004s)
[323.414513] [138/171] (752s left) prime_self_import (basic-with_one_bo_two_files)
[323.804555] Starting subtest: basic-with_one_bo_two_files
[323.888181] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[324.066041] [139/171] (752s left) prime_self_import (basic-with_two_bos)
[324.472983] Starting subtest: basic-with_two_bos
[324.556462] Subtest basic-with_two_bos: SUCCESS (0.003s)
[324.659898] [140/171] (751s left) prime_vgem (basic-fence-flip)
[325.151427] Starting subtest: basic-fence-flip
[325.293667] Subtest basic-fence-flip: SKIP (0.220s)
[325.913560] [141/171] (750s left) prime_vgem (basic-fence-mmap)
[326.714682] Starting subtest: basic-fence-mmap
[326.756396] Subtest basic-fence-mmap: SUCCESS (0.037s)
[326.908803] [142/171] (750s left) prime_vgem (basic-fence-read)
[327.693824] Starting subtest: basic-fence-read
[327.727348] Subtest basic-fence-read: SUCCESS (0.049s)
[327.871857] [143/171] (749s left) prime_vgem (basic-gtt)
[328.362107] Starting subtest: basic-gtt
[328.403737] Subtest basic-gtt: SUCCESS (0.014s)
[328.556220] [144/171] (748s left) prime_vgem (basic-read)
[329.005471] Starting subtest: basic-read
[329.047204] Subtest basic-read: SUCCESS (0.021s)
[329.199798] [145/171] (748s left) prime_vgem (basic-write)
[329.674150] Starting subtest: basic-write
[329.707567] Subtest basic-write: SUCCESS (0.025s)
[329.835347] [146/171] (747s left) vgem_basic (setversion)
[330.319298] Starting subtest: setversion
[330.402984] Subtest setversion: SUCCESS (0.000s)
[330.522379] [147/171] (747s left) vgem_basic (create)
[330.929303] Starting subtest: create
[330.971096] Subtest create: SUCCESS (0.001s)
[331.082281] [148/171] (746s left) vgem_basic (debugfs)
[331.531109] Starting subtest: debugfs
[331.572866] Subtest debugfs: SUCCESS (0.000s)
[331.683937] [149/171] (746s left) vgem_basic (dmabuf-export)
[332.157557] Starting subtest: dmabuf-export
[332.257754] Subtest dmabuf-export: SUCCESS (0.002s)
[332.384933] [150/171] (745s left) vgem_basic (dmabuf-fence)
[332.911264] Starting subtest: dmabuf-fence
[332.952835] Subtest dmabuf-fence: SUCCESS (0.001s)
[333.164954] [151/171] (745s left) vgem_basic (dmabuf-fence-before)
[333.629805] Starting subtest: dmabuf-fence-before
[333.713399] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[333.824321] [152/171] (744s left) vgem_basic (dmabuf-mmap)
[334.298477] Starting subtest: dmabuf-mmap
[334.340207] Subtest dmabuf-mmap: SUCCESS (0.019s)
[334.459323] [153/171] (744s left) vgem_basic (mmap)
[334.891847] Starting subtest: mmap
[334.991969] Subtest mmap: SUCCESS (0.012s)
[335.094313] [154/171] (743s left) vgem_basic (second-client)
[335.511799] Starting subtest: second-client
[335.595354] Subtest second-client: SUCCESS (0.033s)
[335.706522] [155/171] (743s left) vgem_basic (sysfs)
[336.180573] Starting subtest: sysfs
[336.230322] Subtest sysfs: SUCCESS (0.001s)
[336.349953] [156/171] (742s left) core_hotunplug (unbind-rebind)
[337.164820] Starting subtest: unbind-rebind
[338.979161] Subtest unbind-rebind: SUCCESS (1.617s)
[339.506831] [157/171] (740s left) vgem_basic (unload)
[340.547263] Starting subtest: unload
[369.619881] Subtest unload: SUCCESS (29.298s)
[369.764587] [158/171] (710s left) i915_module_load (reload)
[370.271617] Starting subtest: reload
[374.819947] Subtest reload: SUCCESS (4.597s)
[374.946768] [159/171] (705s left) gem_lmem_swapping (basic)
[375.891402] Subtest basic: SKIP (0.000s)
[376.002278] [160/171] (704s left) gem_lmem_swapping (parallel-random-engines)
[376.451115] Subtest parallel-random-engines: SKIP (0.000s)
[376.570157] [161/171] (704s left) gem_lmem_swapping (random-engines)
[377.019363] Subtest random-engines: SKIP (0.000s)
[377.121948] [162/171] (703s left) gem_lmem_swapping (verify-random)
[377.629473] Subtest verify-random: SKIP (0.000s)
[377.748668] [163/171] (703s left) i915_pm_rpm (module-reload)
[379.533928] Subtest module-reload: SKIP (0.000s)
[379.644698] [164/171] (701s left) i915_selftest (live)
[381.119619] Starting subtest: live
[381.161362] Starting dynamic subtest: sanitycheck
[381.913610] Dynamic subtest sanitycheck: SUCCESS (0.865s)
[381.955367] Starting dynamic subtest: uncore
[382.767968] Dynamic subtest uncore: SUCCESS (0.844s)
[382.818094] Starting dynamic subtest: workarounds
[383.562376] Dynamic subtest workarounds: SUCCESS (0.798s)
[383.604245] Starting dynamic subtest: gt_engines
[384.391988] Dynamic subtest gt_engines: SUCCESS (0.818s)
[384.442075] Starting dynamic subtest: gt_timelines
[388.877599] Dynamic subtest gt_timelines: SUCCESS (4.491s)
[388.927717] Starting dynamic subtest: gt_contexts
[389.738768] Dynamic subtest gt_contexts: SUCCESS (0.855s)
[389.788845] Starting dynamic subtest: gt_lrc
[390.601679] Dynamic subtest gt_lrc: SUCCESS (0.866s)
[390.643321] Starting dynamic subtest: gt_mocs
[391.479449] Dynamic subtest gt_mocs: SUCCESS (0.873s)
[391.529562] Starting dynamic subtest: gt_pm
[398.425934] Dynamic subtest gt_pm: SUCCESS (6.947s)
[398.467690] Starting dynamic subtest: gt_heartbeat
[399.328921] Dynamic subtest gt_heartbeat: SUCCESS (0.897s)
[399.379046] Starting dynamic subtest: gt_tlb
[400.216566] Dynamic subtest gt_tlb: SUCCESS (0.890s)
[400.266680] Starting dynamic subtest: requests
[405.695321] Dynamic subtest requests: SUCCESS (5.483s)
[405.737104] Starting dynamic subtest: migrate
[406.641239] Dynamic subtest migrate: SUCCESS (0.936s)
[406.691298] Starting dynamic subtest: active
[407.485874] Dynamic subtest active: SUCCESS (0.852s)
[407.527628] Starting dynamic subtest: objects
[408.923739] Dynamic subtest objects: SUCCESS (1.429s)
[408.973849] Starting dynamic subtest: mman
[413.619670] Dynamic subtest mman: SUCCESS (4.691s)
[413.661366] Starting dynamic subtest: dmabuf
[414.457417] Dynamic subtest dmabuf: SUCCESS (0.845s)
[414.499169] Starting dynamic subtest: vma
[415.301750] Dynamic subtest vma: SUCCESS (0.838s)
[415.343707] Starting dynamic subtest: coherency
[416.454197] Dynamic subtest coherency: SUCCESS (1.146s)
[416.504195] Starting dynamic subtest: gtt
[420.701612] Dynamic subtest gtt: SUCCESS (4.250s)
[420.751671] Starting dynamic subtest: gem
[421.639909] Dynamic subtest gem: SUCCESS (0.941s)
[421.681652] Starting dynamic subtest: evict
[422.567438] Dynamic subtest evict: SUCCESS (0.918s)
[422.617568] Starting dynamic subtest: hugepages
[423.978454] Dynamic subtest hugepages: SUCCESS (1.421s)
[424.020255] Starting dynamic subtest: gem_contexts
[428.567153] Dynamic subtest gem_contexts: SUCCESS (4.580s)
[428.617253] Starting dynamic subtest: client
[429.403168] Dynamic subtest client: SUCCESS (0.836s)
[429.453215] Starting dynamic subtest: gem_migrate
[430.257674] Dynamic subtest gem_migrate: SUCCESS (0.851s)
[430.307697] Starting dynamic subtest: reset
[431.210762] Dynamic subtest reset: SUCCESS (0.954s)
[431.252552] Starting dynamic subtest: memory_region
[432.115167] Dynamic subtest memory_region: SUCCESS (0.892s)
[432.165302] Starting dynamic subtest: hangcheck
[434.593434] Dynamic subtest hangcheck: SUCCESS (2.482s)
[434.635208] Starting dynamic subtest: execlists
[435.396253] Dynamic subtest execlists: SUCCESS (0.804s)
[435.446333] Starting dynamic subtest: ring_submission
[436.192285] Dynamic subtest ring_submission: SUCCESS (0.792s)
[436.234018] Starting dynamic subtest: perf
[437.111473] Dynamic subtest perf: SUCCESS (0.914s)
[437.161597] Starting dynamic subtest: slpc
[437.882720] Dynamic subtest slpc: SUCCESS (0.775s)
[437.924484] Starting dynamic subtest: guc
[438.710266] Dynamic subtest guc: SUCCESS (0.818s)
[438.760318] Starting dynamic subtest: guc_multi_lrc
[439.596414] Dynamic subtest guc_multi_lrc: SUCCESS (0.889s)
[439.638224] Starting dynamic subtest: guc_hang
[440.417141] Dynamic subtest guc_hang: SUCCESS (0.819s)
[440.467165] Starting dynamic subtest: late_gt_pm
[441.344605] Dynamic subtest late_gt_pm: SUCCESS (0.850s)
[441.386796] Subtest live: SUCCESS (60.247s)
[441.531723] [165/171] (639s left) dmabuf (all-tests)
[442.405236] Starting subtest: all-tests
[442.447107] Starting dynamic subtest: sanitycheck
[442.530610] Dynamic subtest sanitycheck: SUCCESS (0.134s)
[442.580966] Starting dynamic subtest: dma_fence
[442.681097] Dynamic subtest dma_fence: SUCCESS (0.184s)
[442.722975] Starting dynamic subtest: dma_fence_chain
[457.678465] Dynamic subtest dma_fence_chain: SUCCESS (15.007s)
[457.720200] Starting dynamic subtest: dma_fence_unwrap
[457.762301] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s)
[457.812356] Starting dynamic subtest: dma_resv
[457.854275] Dynamic subtest dma_resv: SUCCESS (0.081s)
[457.896121] Subtest all-tests: SUCCESS (15.483s)
[458.017319] [166/171] (623s left) i915_suspend (basic-s2idle-without-i915)
[458.539384] Starting subtest: basic-s2idle-without-i915
[480.038206] Subtest basic-s2idle-without-i915: SUCCESS (6.878s)
[482.350972] [167/171] (615s left) i915_suspend (basic-s3-without-i915)
[483.059008] Starting subtest: basic-s3-without-i915
[503.228741] Subtest basic-s3-without-i915: SUCCESS (6.061s)
[505.256429] [168/171] (608s left) gem_exec_suspend (basic-s0)
[506.272988] Starting subtest: basic-S0
[506.323129] Starting dynamic subtest: smem
[525.665912] Dynamic subtest smem: SUCCESS (4.359s)
[525.707733] Subtest basic-S0: SUCCESS (4.360s)
[527.892314] [169/171] (603s left) gem_exec_suspend (basic-s3)
[528.458865] Starting subtest: basic-S3
[528.500736] Starting dynamic subtest: smem
[547.782766] Dynamic subtest smem: SUCCESS (4.475s)
[547.816181] Subtest basic-S3: SUCCESS (4.476s)
[550.009636] [170/171] (598s left) kms_chamelium_hpd (common-hpd-after-suspend)
[550.978915] Subtest common-hpd-after-suspend: SKIP (0.000s)
[551.650230] [171/171] (596s left) kms_pipe_crc_basic (suspend-read-crc)
[552.241100] Starting subtest: suspend-read-crc
[552.283157] Starting dynamic subtest: pipe-A-LVDS-1
[571.814966] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.401s)
[571.865299] Starting dynamic subtest: pipe-B-LVDS-1
[592.809000] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.175s)
[592.850792] Subtest suspend-read-crc: SUCCESS (9.579s)
[595.428464] Closing watchdogs
Done.