[104.956448] Initializing watchdogs
[104.956948]   /dev/watchdog0
[104.979896] [001/171] (960s left) i915_module_load (load)
[105.722599] Starting subtest: load
[110.740324] Subtest load: SUCCESS (4.918s)
[111.225221] [002/171] (954s left) core_auth (basic-auth)
[112.369275] Starting subtest: basic-auth
[112.436147] Subtest basic-auth: SUCCESS (0.001s)
[112.737219] [003/171] (953s left) debugfs_test (read_all_entries)
[113.497328] Starting subtest: read_all_entries
[113.539318] Subtest read_all_entries: SUCCESS (0.061s)
[113.985400] [004/171] (952s left) debugfs_test (basic-hwmon)
[114.687354] Starting subtest: basic-hwmon
[114.754588] Subtest basic-hwmon: SKIP (0.000s)
[115.066196] [005/171] (951s left) fbdev (eof)
[115.600512] Starting subtest: eof
[115.642382] Subtest eof: SUCCESS (0.000s)
[115.751870] [006/171] (951s left) fbdev (info)
[116.069091] Starting subtest: info
[116.110981] Subtest info: SUCCESS (0.000s)
[116.213559] [007/171] (950s left) fbdev (nullptr)
[116.547565] Starting subtest: nullptr
[116.580996] Subtest nullptr: SUCCESS (0.000s)
[116.673719] [008/171] (950s left) fbdev (read)
[117.057777] Starting subtest: read
[117.566950] Subtest read: SUCCESS (0.542s)
[117.676565] [009/171] (949s left) fbdev (write)
[118.060514] Starting subtest: write
[118.102356] Subtest write: SUCCESS (0.122s)
[118.211928] [010/171] (949s left) gem_basic (bad-close)
[118.679445] Starting subtest: bad-close
[118.746528] Subtest bad-close: SUCCESS (0.000s)
[118.847497] [011/171] (948s left) gem_basic (create-close)
[119.275293] Starting subtest: create-close
[119.359158] Subtest create-close: SUCCESS (0.000s)
[119.468606] [012/171] (948s left) gem_basic (create-fd-close)
[119.944322] Starting subtest: create-fd-close
[120.028384] Subtest create-fd-close: SUCCESS (0.000s)
[120.129352] [013/171] (948s left) gem_busy (busy@all-engines)
[120.646845] Starting subtest: busy
[120.730696] Starting dynamic subtest: all-engines
[120.763885] Dynamic subtest all-engines: SUCCESS (0.036s)
[120.797475] Subtest busy: SUCCESS (0.036s)
[120.965680] [014/171] (947s left) gem_close_race (basic-process)
[121.467477] Starting subtest: basic-process
[121.502253] Subtest basic-process: SUCCESS (0.053s)
[121.612407] [015/171] (946s left) gem_close_race (basic-threads)
[122.096276] Starting subtest: basic-threads
[123.134618] Subtest basic-threads: SUCCESS (1.159s)
[123.344548] [016/171] (945s left) gem_ctx_create (basic)
[123.861727] Starting subtest: basic
[123.895332] Subtest basic: SUCCESS (0.000s)
[124.004908] [017/171] (944s left) gem_ctx_create (basic-files)
[124.413749] Starting subtest: basic-files
[126.355715] Subtest basic-files: SUCCESS (2.016s)
[126.576402] [018/171] (942s left) gem_ctx_exec (basic)
[127.269881] Starting subtest: basic
[127.303252] Subtest basic: SUCCESS (0.001s)
[127.395986] [019/171] (941s left) gem_exec_basic (basic)
[127.872284] Starting subtest: basic
[127.914295] Starting dynamic subtest: rcs0-smem
[127.956309] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[128.006230] Starting dynamic subtest: bcs0-smem
[128.048234] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[128.098341] Starting dynamic subtest: vcs0-smem
[128.140463] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[128.182087] Subtest basic: SUCCESS (0.001s)
[128.291501] [020/171] (940s left) gem_exec_create (basic)
[128.775353] Starting subtest: basic
[128.810552] Starting dynamic subtest: smem
[130.737707] Dynamic subtest smem: SUCCESS (2.044s)
[130.771126] Subtest basic: SUCCESS (2.044s)
[130.956096] [021/171] (938s left) gem_exec_fence (basic-busy)
[131.682890] Subtest basic-busy: SKIP (0.000s)
[132.026774] [022/171] (937s left) gem_exec_fence (basic-wait)
[132.586836] Subtest basic-wait: SKIP (0.000s)
[132.813559] [023/171] (936s left) gem_exec_fence (basic-await)
[133.358298] Subtest basic-await: SKIP (0.000s)
[133.635779] [024/171] (935s left) gem_exec_fence (nb-await)
[134.220643] Subtest nb-await: SKIP (0.000s)
[134.455832] [025/171] (934s left) gem_exec_gttfill (basic)
[134.889761] Starting subtest: basic
[139.854042] Subtest basic: SUCCESS (5.082s)
[140.096918] [026/171] (929s left) gem_exec_parallel (engines)
[142.365949] Starting subtest: engines
[142.407797] Starting dynamic subtest: basic
[143.934126] Dynamic subtest basic: SUCCESS (1.623s)
[143.984333] Starting dynamic subtest: contexts
[145.735918] Dynamic subtest contexts: SUCCESS (1.876s)
[145.777833] Starting dynamic subtest: fds
[148.297839] Dynamic subtest fds: SUCCESS (2.558s)
[148.339801] Starting dynamic subtest: userptr
[150.083339] Dynamic subtest userptr: SUCCESS (1.751s)
[150.116486] Subtest engines: SUCCESS (7.808s)
[150.276639] [027/171] (919s left) gem_exec_store (basic)
[150.938589] Starting subtest: basic
[150.980412] Subtest basic: SUCCESS (0.033s)
[151.081738] [028/171] (918s left) gem_flink_basic (bad-flink)
[151.507492] Starting subtest: bad-flink
[151.541151] Subtest bad-flink: SUCCESS (0.000s)
[151.633867] [029/171] (918s left) gem_flink_basic (bad-open)
[152.084953] Starting subtest: bad-open
[152.118474] Subtest bad-open: SUCCESS (0.000s)
[152.219497] [030/171] (917s left) gem_flink_basic (basic)
[152.670927] Starting subtest: basic
[152.704249] Subtest basic: SUCCESS (0.000s)
[152.813420] [031/171] (917s left) gem_flink_basic (double-flink)
[153.223084] Starting subtest: double-flink
[153.264863] Subtest double-flink: SUCCESS (0.000s)
[153.375897] [032/171] (917s left) gem_flink_basic (flink-lifetime)
[153.776929] Starting subtest: flink-lifetime
[153.818849] Subtest flink-lifetime: SUCCESS (0.001s)
[153.919897] [033/171] (916s left) gem_huc_copy (huc-copy)
[154.337709] Subtest huc-copy: SKIP (0.000s)
[154.438751] [034/171] (916s left) gem_linear_blits (basic)
[154.948274] Starting subtest: basic
[155.107134] Subtest basic: SUCCESS (0.011s)
[155.599972] [035/171] (915s left) gem_mmap (basic)
[157.827086] Starting subtest: basic
[157.996153] Subtest basic: SUCCESS (0.000s)
[158.097236] [036/171] (913s left) gem_mmap_gtt (basic)
[158.598438] Starting subtest: basic
[158.640389] Subtest basic: SUCCESS (0.001s)
[158.749791] [037/171] (912s left) gem_render_linear_blits (basic)
[159.175951] Starting subtest: basic
[159.385232] Subtest basic: SUCCESS (0.022s)
[159.603188] [038/171] (912s left) gem_render_tiled_blits (basic)
[160.128951] Starting subtest: basic
[160.329936] Subtest basic: SUCCESS (0.102s)
[160.422814] [039/171] (911s left) gem_ringfill (basic-all)
[161.008732] Starting subtest: basic-all
[161.985105] Subtest basic-all: SUCCESS (1.163s)
[162.094446] [040/171] (910s left) gem_softpin (allocator-basic)
[162.596113] Subtest allocator-basic: SKIP (0.000s)
[162.705591] [041/171] (909s left) gem_softpin (allocator-basic-reserve)
[163.098136] Subtest allocator-basic-reserve: SKIP (0.000s)
[163.191117] [042/171] (909s left) gem_softpin (safe-alignment)
[163.633620] Starting subtest: safe-alignment
[163.667137] Subtest safe-alignment: SUCCESS (0.007s)
[163.778515] [043/171] (908s left) gem_sync (basic-all)
[164.354203] Starting subtest: basic-all
[166.356319] Subtest basic-all: SUCCESS (2.163s)
[166.549455] [044/171] (906s left) gem_sync (basic-each)
[167.042102] Starting subtest: basic-each
[168.994303] Subtest basic-each: SUCCESS (2.120s)
[169.187598] [045/171] (903s left) gem_tiled_blits (basic)
[169.655161] Starting subtest: basic
[169.788995] Subtest basic: SUCCESS (0.014s)
[170.283762] [046/171] (902s left) gem_tiled_fence_blits (basic)
[172.619358] Starting subtest: basic
[172.777914] Subtest basic: SUCCESS (0.008s)
[173.287764] [047/171] (899s left) gem_tiled_pread_basic
[175.891275] [048/171] (897s left) gem_wait (busy@all-engines)
[176.333842] Starting subtest: busy
[176.367344] Starting dynamic subtest: all-engines
[176.726974] Dynamic subtest all-engines: SUCCESS (0.510s)
[176.768710] Subtest busy: SUCCESS (0.511s)
[176.970360] [049/171] (896s left) gem_wait (wait@all-engines)
[177.297125] Starting subtest: wait
[177.330659] Starting dynamic subtest: all-engines
[178.323415] Dynamic subtest all-engines: SUCCESS (1.015s)
[178.357243] Subtest wait: SUCCESS (1.016s)
[178.491954] [050/171] (894s left) i915_getparams_basic (basic-eu-total)
[179.001754] Starting subtest: basic-eu-total
[179.085386] Subtest basic-eu-total: SUCCESS (0.000s)
[179.194860] [051/171] (894s left) i915_getparams_basic (basic-subslice-total)
[179.637737] Starting subtest: basic-subslice-total
[179.721353] Subtest basic-subslice-total: SUCCESS (0.000s)
[179.830653] [052/171] (893s left) i915_hangman (error-state-basic)
[180.440247] Starting subtest: error-state-basic
[180.532158] Subtest error-state-basic: SUCCESS (0.009s)
[180.843528] [053/171] (893s left) i915_pciid
[181.454192] [054/171] (892s left) kms_addfb_basic (addfb25-bad-modifier)
[182.030396] Starting subtest: addfb25-bad-modifier
[182.096869] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[182.660225] [055/171] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[183.171341] Starting subtest: addfb25-framebuffer-vs-set-tiling
[183.215066] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[183.591768] [056/171] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[184.067779] Starting subtest: addfb25-modifier-no-flag
[184.109752] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[184.437925] [057/171] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[184.940813] Starting subtest: addfb25-x-tiled-legacy
[184.974262] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[185.386307] [058/171] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[185.862497] Starting subtest: addfb25-x-tiled-mismatch-legacy
[185.895991] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[186.268296] [059/171] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[186.827890] Starting subtest: addfb25-yf-tiled-legacy
[186.861357] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[187.122676] [060/171] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[187.691062] Starting subtest: addfb25-y-tiled-legacy
[187.733056] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[188.029347] [061/171] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[188.597390] Starting subtest: addfb25-y-tiled-small-legacy
[188.664498] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[188.900645] [062/171] (886s left) kms_addfb_basic (bad-pitch-0)
[189.418247] Starting subtest: bad-pitch-0
[189.460193] Subtest bad-pitch-0: SUCCESS (0.000s)
[189.806684] [063/171] (885s left) kms_addfb_basic (bad-pitch-1024)
[190.291029] Starting subtest: bad-pitch-1024
[190.324659] Subtest bad-pitch-1024: SUCCESS (0.000s)
[190.703394] [064/171] (884s left) kms_addfb_basic (bad-pitch-128)
[191.237598] Starting subtest: bad-pitch-128
[191.279542] Subtest bad-pitch-128: SUCCESS (0.000s)
[191.617634] [065/171] (883s left) kms_addfb_basic (bad-pitch-256)
[192.093614] Starting subtest: bad-pitch-256
[192.135570] Subtest bad-pitch-256: SUCCESS (0.000s)
[192.472291] [066/171] (882s left) kms_addfb_basic (bad-pitch-32)
[192.989805] Starting subtest: bad-pitch-32
[193.031744] Subtest bad-pitch-32: SUCCESS (0.000s)
[193.360491] [067/171] (882s left) kms_addfb_basic (bad-pitch-63)
[193.879306] Starting subtest: bad-pitch-63
[193.971279] Subtest bad-pitch-63: SUCCESS (0.000s)
[194.265620] [068/171] (881s left) kms_addfb_basic (bad-pitch-65536)
[195.033889] Starting subtest: bad-pitch-65536
[195.117575] Subtest bad-pitch-65536: SUCCESS (0.000s)
[195.344492] [069/171] (880s left) kms_addfb_basic (bad-pitch-999)
[195.872549] Starting subtest: bad-pitch-999
[195.906137] Subtest bad-pitch-999: SUCCESS (0.000s)
[196.284733] [070/171] (879s left) kms_addfb_basic (basic)
[196.869259] Starting subtest: basic
[196.902873] Subtest basic: SUCCESS (0.000s)
[197.273344] [071/171] (878s left) kms_addfb_basic (basic-x-tiled-legacy)
[197.717830] Starting subtest: basic-x-tiled-legacy
[197.751451] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[198.138245] [072/171] (877s left) kms_addfb_basic (basic-y-tiled-legacy)
[198.664563] Starting subtest: basic-y-tiled-legacy
[198.698156] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[199.145381] [073/171] (876s left) kms_addfb_basic (bo-too-small)
[199.730116] Starting subtest: bo-too-small
[199.763667] Subtest bo-too-small: SUCCESS (0.000s)
[200.041760] [074/171] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[200.626710] Starting subtest: bo-too-small-due-to-tiling
[200.668619] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[200.973105] [075/171] (875s left) kms_addfb_basic (clobberred-modifier)
[201.557846] Starting subtest: clobberred-modifier
[201.599801] Subtest clobberred-modifier: SUCCESS (0.000s)
[201.944982] [076/171] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[202.471138] Starting subtest: framebuffer-vs-set-tiling
[202.513077] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[202.893447] [077/171] (873s left) kms_addfb_basic (invalid-get-prop)
[203.469729] Starting subtest: invalid-get-prop
[203.511694] Subtest invalid-get-prop: SUCCESS (0.000s)
[203.839879] [078/171] (872s left) kms_addfb_basic (invalid-get-prop-any)
[204.357746] Starting subtest: invalid-get-prop-any
[204.391303] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[204.763347] [079/171] (871s left) kms_addfb_basic (invalid-set-prop)
[205.297691] Starting subtest: invalid-set-prop
[205.339657] Subtest invalid-set-prop: SUCCESS (0.000s)
[205.676215] [080/171] (871s left) kms_addfb_basic (invalid-set-prop-any)
[206.218973] Starting subtest: invalid-set-prop-any
[206.302581] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[206.690742] [081/171] (870s left) kms_addfb_basic (no-handle)
[207.233549] Starting subtest: no-handle
[207.317253] Subtest no-handle: SUCCESS (0.000s)
[207.637826] [082/171] (869s left) kms_addfb_basic (size-max)
[208.222397] Starting subtest: size-max
[208.255854] Subtest size-max: SUCCESS (0.000s)
[208.552125] [083/171] (868s left) kms_addfb_basic (small-bo)
[209.175794] Starting subtest: small-bo
[209.212508] Subtest small-bo: SUCCESS (0.000s)
[209.465778] [084/171] (867s left) kms_addfb_basic (tile-pitch-mismatch)
[209.982909] Starting subtest: tile-pitch-mismatch
[210.024804] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[210.404853] [085/171] (866s left) kms_addfb_basic (too-high)
[211.014456] Starting subtest: too-high
[211.048053] Subtest too-high: SUCCESS (0.001s)
[211.375929] [086/171] (866s left) kms_addfb_basic (too-wide)
[212.012175] Starting subtest: too-wide
[212.045774] Subtest too-wide: SUCCESS (0.000s)
[212.340414] [087/171] (865s left) kms_addfb_basic (unused-handle)
[212.841028] Starting subtest: unused-handle
[212.882953] Subtest unused-handle: SUCCESS (0.000s)
[213.236530] [088/171] (864s left) kms_addfb_basic (unused-modifier)
[213.837048] Starting subtest: unused-modifier
[213.880529] Subtest unused-modifier: SUCCESS (0.000s)
[214.167639] [089/171] (863s left) kms_addfb_basic (unused-offsets)
[214.617635] Starting subtest: unused-offsets
[214.651254] Subtest unused-offsets: SUCCESS (0.000s)
[215.038347] [090/171] (862s left) kms_addfb_basic (unused-pitches)
[215.613782] Starting subtest: unused-pitches
[215.657246] Subtest unused-pitches: SUCCESS (0.000s)
[216.045000] [091/171] (861s left) kms_busy (basic)
[216.712677] Starting subtest: basic
[216.746203] Starting dynamic subtest: flip
[220.931418] Dynamic subtest flip: SUCCESS (4.327s)
[220.981724] Starting dynamic subtest: modeset
[223.146812] Dynamic subtest modeset: SUCCESS (2.179s)
[223.180502] Subtest basic: SUCCESS (6.507s)
[224.100836] [092/171] (853s left) kms_chamelium_hpd (dp-hpd-fast)
[225.079596] Subtest dp-hpd-fast: SKIP (0.000s)
[225.841097] [093/171] (852s left) kms_chamelium_edid (dp-edid-read)
[226.759523] Subtest dp-edid-read: SKIP (0.000s)
[227.556227] [094/171] (850s left) kms_chamelium_frames (dp-crc-fast)
[228.591165] Subtest dp-crc-fast: SKIP (0.000s)
[229.310523] [095/171] (848s left) kms_chamelium_hpd (hdmi-hpd-fast)
[230.221136] Subtest hdmi-hpd-fast: SKIP (0.000s)
[231.009446] [096/171] (847s left) kms_chamelium_edid (hdmi-edid-read)
[231.927784] Subtest hdmi-edid-read: SKIP (0.000s)
[232.648180] [097/171] (845s left) kms_chamelium_frames (hdmi-crc-fast)
[233.576456] Subtest hdmi-crc-fast: SKIP (0.000s)
[234.330525] [098/171] (844s left) kms_chamelium_hpd (vga-hpd-fast)
[235.173516] Subtest vga-hpd-fast: SKIP (0.000s)
[235.929087] [099/171] (842s left) kms_chamelium_edid (vga-edid-read)
[236.872109] Subtest vga-edid-read: SKIP (0.000s)
[237.642583] [100/171] (841s left) kms_prop_blob (basic)
[238.217978] Starting subtest: basic
[238.251472] Subtest basic: SUCCESS (0.000s)
[238.352780] [101/171] (840s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[238.997352] Starting subtest: basic-busy-flip-before-cursor-atomic
[240.157232] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.217s)
[241.044738] [102/171] (838s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[241.595172] Starting subtest: basic-busy-flip-before-cursor-legacy
[242.815091] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.235s)
[243.778288] [103/171] (835s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[244.387091] Starting subtest: basic-flip-after-cursor-atomic
[245.580213] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.201s)
[246.569455] [104/171] (832s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[247.153549] Starting subtest: basic-flip-after-cursor-legacy
[248.346795] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.185s)
[249.259886] [105/171] (830s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[249.778286] Starting subtest: basic-flip-after-cursor-varying-size
[250.979735] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.204s)
[251.959281] [106/171] (827s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[252.534354] Starting subtest: basic-flip-before-cursor-atomic
[253.737469] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.193s)
[254.632607] [107/171] (824s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[255.167443] Starting subtest: basic-flip-before-cursor-legacy
[256.343676] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.184s)
[257.292429] [108/171] (822s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[257.884396] Starting subtest: basic-flip-before-cursor-varying-size
[259.043916] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.176s)
[259.972983] [109/171] (819s left) kms_flip (basic-flip-vs-dpms)
[260.567087] Starting subtest: basic-flip-vs-dpms
[260.609211] Starting dynamic subtest: A-LVDS1
[262.253919] Dynamic subtest A-LVDS1: SUCCESS (1.768s)
[262.303921] Starting dynamic subtest: B-LVDS1
[263.751049] Dynamic subtest B-LVDS1: SUCCESS (1.482s)
[263.801256] Starting dynamic subtest: A-VGA1
[264.421934] Dynamic subtest A-VGA1: SUCCESS (0.702s)
[264.463887] Starting dynamic subtest: B-VGA1
[265.128821] Dynamic subtest B-VGA1: SUCCESS (0.695s)
[265.170688] Subtest basic-flip-vs-dpms: SUCCESS (4.657s)
[265.548775] [110/171] (814s left) kms_flip (basic-flip-vs-modeset)
[266.083326] Starting subtest: basic-flip-vs-modeset
[266.125151] Starting dynamic subtest: A-LVDS1
[267.722304] Dynamic subtest A-LVDS1: SUCCESS (1.753s)
[267.772247] Starting dynamic subtest: B-LVDS1
[269.233958] Dynamic subtest B-LVDS1: SUCCESS (1.502s)
[269.284084] Starting dynamic subtest: A-VGA1
[269.982425] Dynamic subtest A-VGA1: SUCCESS (0.736s)
[270.032730] Starting dynamic subtest: B-VGA1
[270.703808] Dynamic subtest B-VGA1: SUCCESS (0.723s)
[270.737338] Subtest basic-flip-vs-modeset: SUCCESS (4.723s)
[271.125852] [111/171] (808s left) kms_flip (basic-flip-vs-wf_vblank)
[271.760385] Starting subtest: basic-flip-vs-wf_vblank
[271.793929] Starting dynamic subtest: A-LVDS1
[273.637683] Dynamic subtest A-LVDS1: SUCCESS (1.923s)
[273.688130] Starting dynamic subtest: B-LVDS1
[275.540555] Dynamic subtest B-LVDS1: SUCCESS (1.897s)
[275.582557] Starting dynamic subtest: A-VGA1
[276.761155] Dynamic subtest A-VGA1: SUCCESS (1.214s)
[276.811429] Starting dynamic subtest: B-VGA1
[277.729902] Dynamic subtest B-VGA1: SUCCESS (0.968s)
[277.771229] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.011s)
[278.149782] [112/171] (801s left) kms_flip (basic-plain-flip)
[278.617255] Starting subtest: basic-plain-flip
[278.659395] Starting dynamic subtest: A-LVDS1
[280.104756] Dynamic subtest A-LVDS1: SUCCESS (1.552s)
[280.146632] Starting dynamic subtest: B-LVDS1
[281.599138] Dynamic subtest B-LVDS1: SUCCESS (1.510s)
[281.641047] Starting dynamic subtest: A-VGA1
[282.526064] Dynamic subtest A-VGA1: SUCCESS (0.915s)
[282.576345] Starting dynamic subtest: B-VGA1
[283.210729] Dynamic subtest B-VGA1: SUCCESS (0.682s)
[283.252633] Subtest basic-plain-flip: SUCCESS (4.673s)
[283.684385] [113/171] (796s left) kms_force_connector_basic (force-connector-state)
[284.233876] Starting subtest: force-connector-state
[284.668929] Subtest force-connector-state: SUCCESS (0.537s)
[285.885379] [114/171] (794s left) kms_force_connector_basic (force-edid)
[286.459977] Starting subtest: force-edid
[286.493554] Subtest force-edid: SUCCESS (0.261s)
[287.092104] [115/171] (793s left) kms_force_connector_basic (force-load-detect)
[287.640985] Starting subtest: force-load-detect
[287.918967] Subtest force-load-detect: SUCCESS (0.418s)
[288.532135] [116/171] (791s left) kms_force_connector_basic (prune-stale-modes)
[289.108081] Starting subtest: prune-stale-modes
[289.141588] Subtest prune-stale-modes: SUCCESS (0.020s)
[289.557334] [117/171] (791s left) kms_frontbuffer_tracking (basic)
[290.282139] Starting subtest: basic
[292.367149] Subtest basic: SUCCESS (2.200s)
[292.679788] [118/171] (787s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[293.271225] Starting subtest: compare-crc-sanitycheck-xr24
[293.313155] Starting dynamic subtest: pipe-A-LVDS-1
[293.757550] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.502s)
[293.799452] Starting dynamic subtest: pipe-B-LVDS-1
[294.685111] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.913s)
[294.727029] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.421s)
[295.649621] [119/171] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[296.258692] Starting subtest: compare-crc-sanitycheck-nv12
[296.292158] Starting dynamic subtest: pipe-A-LVDS-1
[296.359346] Dynamic subtest pipe-A-LVDS-1: SKIP (0.000s)
[296.401121] Starting dynamic subtest: pipe-B-LVDS-1
[296.468700] Dynamic subtest pipe-B-LVDS-1: SKIP (0.000s)
[296.535630] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[296.646108] [120/171] (784s left) kms_pipe_crc_basic (hang-read-crc)
[297.196549] Starting subtest: hang-read-crc
[297.238535] Starting dynamic subtest: pipe-A-LVDS-1
[298.986444] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.798s)
[299.028350] Starting dynamic subtest: pipe-B-LVDS-1
[301.400275] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.386s)
[301.442278] Subtest hang-read-crc: SUCCESS (4.187s)
[302.348975] [121/171] (778s left) kms_pipe_crc_basic (nonblocking-crc)
[302.990147] Starting subtest: nonblocking-crc
[303.031932] Starting dynamic subtest: pipe-A-LVDS-1
[303.625287] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.681s)
[303.675564] Starting dynamic subtest: pipe-B-LVDS-1
[304.886930] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.240s)
[304.920354] Subtest nonblocking-crc: SUCCESS (1.924s)
[305.811166] [122/171] (775s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[306.384978] Starting subtest: nonblocking-crc-frame-sequence
[306.418726] Starting dynamic subtest: pipe-A-LVDS-1
[307.070527] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.686s)
[307.112421] Starting dynamic subtest: pipe-B-LVDS-1
[308.425492] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.278s)
[308.467259] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.969s)
[309.355409] [123/171] (771s left) kms_pipe_crc_basic (read-crc)
[309.964230] Starting subtest: read-crc
[310.006089] Starting dynamic subtest: pipe-A-LVDS-1
[310.565648] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.621s)
[310.615850] Starting dynamic subtest: pipe-B-LVDS-1
[311.803527] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.225s)
[311.837064] Subtest read-crc: SUCCESS (1.849s)
[312.750830] [124/171] (768s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[313.375362] Starting subtest: read-crc-frame-sequence
[313.417219] Starting dynamic subtest: pipe-A-LVDS-1
[313.970196] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.628s)
[314.012075] Starting dynamic subtest: pipe-B-LVDS-1
[315.206797] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.208s)
[315.248394] Subtest read-crc-frame-sequence: SUCCESS (1.839s)
[316.145875] [125/171] (765s left) kms_psr (primary_page_flip)
[316.803214] Subtest primary_page_flip: SKIP (0.000s)
[316.915324] [126/171] (764s left) kms_psr (cursor_plane_move)
[317.398553] Subtest cursor_plane_move: SKIP (0.000s)
[317.508093] [127/171] (764s left) kms_psr (sprite_plane_onoff)
[318.050514] Subtest sprite_plane_onoff: SKIP (0.000s)
[318.160677] [128/171] (763s left) kms_psr (primary_mmap_gtt)
[318.619050] Subtest primary_mmap_gtt: SKIP (0.000s)
[318.730126] [129/171] (763s left) kms_setmode (basic-clone-single-crtc)
[319.245694] Starting subtest: basic-clone-single-crtc
[319.371143] Subtest basic-clone-single-crtc: SKIP (0.001s)
[319.482293] [130/171] (762s left) i915_pm_backlight (basic-brightness)
[320.158660] Subtest basic-brightness: SKIP (0.000s)
[320.270571] [131/171] (762s left) i915_pm_rpm (basic-pci-d3-state)
[322.330287] Subtest basic-pci-d3-state: SKIP (0.000s)
[322.431778] [132/171] (759s left) i915_pm_rpm (basic-rte)
[322.892132] Starting subtest: basic-rte
[324.353306] Subtest basic-rte: SKIP (1.381s)
[324.547917] [133/171] (757s left) i915_pm_rps (basic-api)
[325.122486] Starting subtest: basic-api
[325.164381] Subtest basic-api: SUCCESS (0.004s)
[325.275897] [134/171] (757s left) prime_self_import (basic-llseek-bad)
[325.778949] Starting subtest: basic-llseek-bad
[326.068815] Subtest basic-llseek-bad: SUCCESS (0.002s)
[326.322321] [135/171] (756s left) prime_self_import (basic-llseek-size)
[326.929134] Starting subtest: basic-llseek-size
[327.012701] Subtest basic-llseek-size: SUCCESS (0.003s)
[327.123567] [136/171] (756s left) prime_self_import (basic-with_fd_dup)
[327.731341] Starting subtest: basic-with_fd_dup
[327.814955] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[327.925722] [137/171] (755s left) prime_self_import (basic-with_one_bo)
[328.366565] Starting subtest: basic-with_one_bo
[328.450247] Subtest basic-with_one_bo: SUCCESS (0.004s)
[328.560606] [138/171] (755s left) prime_self_import (basic-with_one_bo_two_files)
[329.018835] Starting subtest: basic-with_one_bo_two_files
[329.102370] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[329.197779] [139/171] (754s left) prime_self_import (basic-with_two_bos)
[329.614141] Starting subtest: basic-with_two_bos
[329.697768] Subtest basic-with_two_bos: SUCCESS (0.002s)
[329.808815] [140/171] (754s left) prime_vgem (basic-fence-flip)
[330.332709] Starting subtest: basic-fence-flip
[330.466748] Subtest basic-fence-flip: SKIP (0.216s)
[330.746480] [141/171] (753s left) prime_vgem (basic-fence-mmap)
[331.279214] Starting subtest: basic-fence-mmap
[331.320959] Subtest basic-fence-mmap: SUCCESS (0.031s)
[331.475438] [142/171] (753s left) prime_vgem (basic-fence-read)
[331.966484] Starting subtest: basic-fence-read
[332.000071] Subtest basic-fence-read: SUCCESS (0.047s)
[332.135605] [143/171] (752s left) prime_vgem (basic-gtt)
[332.568404] Starting subtest: basic-gtt
[332.676889] Subtest basic-gtt: SUCCESS (0.013s)
[332.838156] [144/171] (752s left) prime_vgem (basic-read)
[333.320571] Starting subtest: basic-read
[333.362447] Subtest basic-read: SUCCESS (0.021s)
[333.515427] [145/171] (751s left) prime_vgem (basic-write)
[334.022761] Starting subtest: basic-write
[334.064820] Subtest basic-write: SUCCESS (0.022s)
[334.218935] [146/171] (750s left) vgem_basic (setversion)
[334.659883] Starting subtest: setversion
[334.743479] Subtest setversion: SUCCESS (0.000s)
[334.853934] [147/171] (750s left) vgem_basic (create)
[335.362175] Starting subtest: create
[335.404130] Subtest create: SUCCESS (0.001s)
[335.515184] [148/171] (749s left) vgem_basic (debugfs)
[335.955487] Starting subtest: debugfs
[335.997285] Subtest debugfs: SUCCESS (0.001s)
[336.158425] [149/171] (749s left) vgem_basic (dmabuf-export)
[336.574223] Starting subtest: dmabuf-export
[336.641219] Subtest dmabuf-export: SUCCESS (0.001s)
[336.743469] [150/171] (749s left) vgem_basic (dmabuf-fence)
[337.211322] Starting subtest: dmabuf-fence
[337.244868] Subtest dmabuf-fence: SUCCESS (0.001s)
[337.338905] [151/171] (748s left) vgem_basic (dmabuf-fence-before)
[337.730065] Starting subtest: dmabuf-fence-before
[337.763493] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[337.874332] [152/171] (748s left) vgem_basic (dmabuf-mmap)
[338.315441] Starting subtest: dmabuf-mmap
[338.357351] Subtest dmabuf-mmap: SUCCESS (0.018s)
[338.468784] [153/171] (747s left) vgem_basic (mmap)
[338.992478] Starting subtest: mmap
[339.026104] Subtest mmap: SUCCESS (0.011s)
[339.128608] [154/171] (747s left) vgem_basic (second-client)
[339.629785] Starting subtest: second-client
[339.713303] Subtest second-client: SUCCESS (0.048s)
[339.831689] [155/171] (746s left) vgem_basic (sysfs)
[340.256638] Starting subtest: sysfs
[340.298576] Subtest sysfs: SUCCESS (0.002s)
[340.393301] [156/171] (746s left) core_hotunplug (unbind-rebind)
[341.158430] Starting subtest: unbind-rebind
[343.157419] Subtest unbind-rebind: SUCCESS (1.882s)
[343.625931] [157/171] (743s left) vgem_basic (unload)
[344.418275] Starting subtest: unload
[373.314121] Subtest unload: SUCCESS (29.151s)
[373.442449] [158/171] (714s left) i915_module_load (reload)
[374.101265] Starting subtest: reload
[378.307716] Subtest reload: SUCCESS (4.294s)
[378.485355] [159/171] (709s left) gem_lmem_swapping (basic)
[379.262921] Subtest basic: SKIP (0.000s)
[379.365478] [160/171] (708s left) gem_lmem_swapping (parallel-random-engines)
[379.823282] Subtest parallel-random-engines: SKIP (0.000s)
[379.925931] [161/171] (707s left) gem_lmem_swapping (random-engines)
[380.400244] Subtest random-engines: SKIP (0.000s)
[380.511778] [162/171] (707s left) gem_lmem_swapping (verify-random)
[380.968737] Subtest verify-random: SKIP (0.000s)
[381.079955] [163/171] (707s left) i915_pm_rpm (module-reload)
[382.999876] Subtest module-reload: SKIP (0.000s)
[383.118222] [164/171] (705s left) i915_selftest (live)
[384.653403] Starting subtest: live
[384.686945] Starting dynamic subtest: sanitycheck
[385.491852] Dynamic subtest sanitycheck: SUCCESS (0.856s)
[385.541984] Starting dynamic subtest: uncore
[386.319918] Dynamic subtest uncore: SUCCESS (0.831s)
[386.361663] Starting dynamic subtest: workarounds
[387.148137] Dynamic subtest workarounds: SUCCESS (0.826s)
[387.189992] Starting dynamic subtest: gt_engines
[387.927875] Dynamic subtest gt_engines: SUCCESS (0.779s)
[387.969663] Starting dynamic subtest: gt_timelines
[392.291114] Dynamic subtest gt_timelines: SUCCESS (4.353s)
[392.341203] Starting dynamic subtest: gt_contexts
[393.062557] Dynamic subtest gt_contexts: SUCCESS (0.778s)
[393.104372] Starting dynamic subtest: gt_lrc
[394.007514] Dynamic subtest gt_lrc: SUCCESS (0.935s)
[394.057637] Starting dynamic subtest: gt_mocs
[394.843999] Dynamic subtest gt_mocs: SUCCESS (0.838s)
[394.895807] Starting dynamic subtest: gt_pm
[401.418357] Dynamic subtest gt_pm: SUCCESS (6.569s)
[401.468445] Starting dynamic subtest: gt_heartbeat
[402.288069] Dynamic subtest gt_heartbeat: SUCCESS (0.873s)
[402.331493] Starting dynamic subtest: gt_tlb
[403.084533] Dynamic subtest gt_tlb: SUCCESS (0.793s)
[403.134606] Starting dynamic subtest: requests
[408.584257] Dynamic subtest requests: SUCCESS (5.500s)
[408.634339] Starting dynamic subtest: migrate
[409.470637] Dynamic subtest migrate: SUCCESS (0.883s)
[409.512422] Starting dynamic subtest: active
[410.265219] Dynamic subtest active: SUCCESS (0.791s)
[410.307090] Starting dynamic subtest: objects
[411.753713] Dynamic subtest objects: SUCCESS (1.484s)
[411.803821] Starting dynamic subtest: mman
[416.460252] Dynamic subtest mman: SUCCESS (4.710s)
[416.510418] Starting dynamic subtest: dmabuf
[417.398754] Dynamic subtest dmabuf: SUCCESS (0.935s)
[417.440526] Starting dynamic subtest: vma
[418.159754] Dynamic subtest vma: SUCCESS (0.762s)
[418.209941] Starting dynamic subtest: coherency
[419.781178] Dynamic subtest coherency: SUCCESS (1.623s)
[419.823091] Starting dynamic subtest: gtt
[423.887316] Dynamic subtest gtt: SUCCESS (4.099s)
[423.937562] Starting dynamic subtest: gem
[424.901086] Dynamic subtest gem: SUCCESS (1.011s)
[424.942853] Starting dynamic subtest: evict
[425.745740] Dynamic subtest evict: SUCCESS (0.847s)
[425.795864] Starting dynamic subtest: hugepages
[427.141128] Dynamic subtest hugepages: SUCCESS (1.396s)
[427.191245] Starting dynamic subtest: gem_contexts
[431.524161] Dynamic subtest gem_contexts: SUCCESS (4.380s)
[431.565910] Starting dynamic subtest: client
[432.312170] Dynamic subtest client: SUCCESS (0.782s)
[432.362246] Starting dynamic subtest: gem_migrate
[433.131943] Dynamic subtest gem_migrate: SUCCESS (0.822s)
[433.173788] Starting dynamic subtest: reset
[434.260908] Dynamic subtest reset: SUCCESS (1.129s)
[434.311081] Starting dynamic subtest: memory_region
[435.081467] Dynamic subtest memory_region: SUCCESS (0.820s)
[435.123292] Starting dynamic subtest: hangcheck
[437.569972] Dynamic subtest hangcheck: SUCCESS (2.484s)
[437.620107] Starting dynamic subtest: execlists
[438.341182] Dynamic subtest execlists: SUCCESS (0.773s)
[438.383078] Starting dynamic subtest: ring_submission
[439.194755] Dynamic subtest ring_submission: SUCCESS (0.845s)
[439.244822] Starting dynamic subtest: perf
[440.031083] Dynamic subtest perf: SUCCESS (0.836s)
[440.081108] Starting dynamic subtest: slpc
[440.802262] Dynamic subtest slpc: SUCCESS (0.772s)
[440.844074] Starting dynamic subtest: guc
[441.638611] Dynamic subtest guc: SUCCESS (0.826s)
[441.688792] Starting dynamic subtest: guc_multi_lrc
[442.458371] Dynamic subtest guc_multi_lrc: SUCCESS (0.827s)
[442.500203] Starting dynamic subtest: guc_hang
[443.338274] Dynamic subtest guc_hang: SUCCESS (0.870s)
[443.388347] Starting dynamic subtest: late_gt_pm
[444.234397] Dynamic subtest late_gt_pm: SUCCESS (0.900s)
[444.266225] Subtest live: SUCCESS (59.600s)
[444.527409] [165/171] (643s left) dmabuf (all-tests)
[445.251879] Starting subtest: all-tests
[445.285254] Starting dynamic subtest: sanitycheck
[445.318715] Dynamic subtest sanitycheck: SUCCESS (0.113s)
[445.360600] Starting dynamic subtest: dma_fence
[445.504599] Dynamic subtest dma_fence: SUCCESS (0.180s)
[445.546449] Starting dynamic subtest: dma_fence_chain
[459.598809] Dynamic subtest dma_fence_chain: SUCCESS (14.090s)
[459.649074] Starting dynamic subtest: dma_fence_unwrap
[459.690960] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[459.741232] Starting dynamic subtest: dma_resv
[459.774718] Dynamic subtest dma_resv: SUCCESS (0.076s)
[459.808369] Subtest all-tests: SUCCESS (14.532s)
[459.910998] [166/171] (628s left) i915_suspend (basic-s2idle-without-i915)
[460.460092] Starting subtest: basic-s2idle-without-i915
[481.321779] Subtest basic-s2idle-without-i915: SUCCESS (6.549s)
[483.609777] [167/171] (621s left) i915_suspend (basic-s3-without-i915)
[484.225597] Starting subtest: basic-s3-without-i915
[504.414768] Subtest basic-s3-without-i915: SUCCESS (5.712s)
[506.369841] [168/171] (615s left) gem_exec_suspend (basic-s0)
[507.227683] Starting subtest: basic-S0
[507.269484] Starting dynamic subtest: smem
[527.033412] Dynamic subtest smem: SUCCESS (4.340s)
[527.067003] Subtest basic-S0: SUCCESS (4.341s)
[529.237297] [169/171] (609s left) gem_exec_suspend (basic-s3)
[529.794675] Starting subtest: basic-S3
[529.836477] Starting dynamic subtest: smem
[549.177834] Dynamic subtest smem: SUCCESS (4.564s)
[549.219754] Subtest basic-S3: SUCCESS (4.565s)
[551.407286] [170/171] (604s left) kms_chamelium_hpd (common-hpd-after-suspend)
[552.250362] Subtest common-hpd-after-suspend: SKIP (0.000s)
[552.803321] [171/171] (603s left) kms_pipe_crc_basic (suspend-read-crc)
[553.429581] Starting subtest: suspend-read-crc
[553.463475] Starting dynamic subtest: pipe-A-LVDS-1
[573.137534] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.591s)
[573.187797] Starting dynamic subtest: pipe-B-LVDS-1
[593.195350] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.115s)
[593.237184] Subtest suspend-read-crc: SUCCESS (9.710s)
[595.805118] Closing watchdogs
Done.