[86.447133] Initializing watchdogs
[86.447526]   /dev/watchdog0
[86.496070] [001/171] (960s left) i915_module_load (load)
[87.446340] Starting subtest: load
[92.209234] Subtest load: SUCCESS (4.752s)
[92.744434] [002/171] (954s left) core_auth (basic-auth)
[94.028800] Starting subtest: basic-auth
[94.120558] Subtest basic-auth: SUCCESS (0.001s)
[94.430102] [003/171] (953s left) debugfs_test (read_all_entries)
[95.230253] Starting subtest: read_all_entries
[95.272115] Subtest read_all_entries: SUCCESS (0.055s)
[95.576188] [004/171] (952s left) debugfs_test (basic-hwmon)
[96.010071] Starting subtest: basic-hwmon
[96.077131] Subtest basic-hwmon: SKIP (0.000s)
[96.212245] [005/171] (951s left) fbdev (eof)
[96.696170] Starting subtest: eof
[96.738232] Subtest eof: SUCCESS (0.000s)
[96.846864] [006/171] (951s left) fbdev (info)
[97.264139] Starting subtest: info
[97.297584] Subtest info: SUCCESS (0.000s)
[97.398404] [007/171] (951s left) fbdev (nullptr)
[97.892762] Starting subtest: nullptr
[97.934602] Subtest nullptr: SUCCESS (0.000s)
[98.035461] [008/171] (950s left) fbdev (read)
[98.410566] Starting subtest: read
[98.794048] Subtest read: SUCCESS (0.481s)
[98.895518] [009/171] (949s left) fbdev (write)
[99.287419] Starting subtest: write
[99.337844] Subtest write: SUCCESS (0.108s)
[99.447220] [010/171] (949s left) gem_basic (bad-close)
[99.897606] Starting subtest: bad-close
[99.997780] Subtest bad-close: SUCCESS (0.000s)
[100.115708] [011/171] (948s left) gem_basic (create-close)
[100.516070] Starting subtest: create-close
[100.582875] Subtest create-close: SUCCESS (0.000s)
[100.694059] [012/171] (948s left) gem_basic (create-fd-close)
[101.152370] Starting subtest: create-fd-close
[101.235974] Subtest create-fd-close: SUCCESS (0.000s)
[101.345116] [013/171] (947s left) gem_busy (busy@all-engines)
[101.796103] Starting subtest: busy
[101.838128] Starting dynamic subtest: all-engines
[101.879927] Dynamic subtest all-engines: SUCCESS (0.030s)
[101.921544] Subtest busy: SUCCESS (0.030s)
[102.081550] [014/171] (947s left) gem_close_race (basic-process)
[102.531574] Starting subtest: basic-process
[102.565341] Subtest basic-process: SUCCESS (0.044s)
[102.658127] [015/171] (946s left) gem_close_race (basic-threads)
[103.068400] Starting subtest: basic-threads
[104.214425] Subtest basic-threads: SUCCESS (1.151s)
[104.390568] [016/171] (945s left) gem_ctx_create (basic)
[104.991361] Starting subtest: basic
[105.033397] Subtest basic: SUCCESS (0.000s)
[105.142701] [017/171] (944s left) gem_ctx_create (basic-files)
[105.616867] Starting subtest: basic-files
[107.620216] Subtest basic-files: SUCCESS (2.014s)
[107.899553] [018/171] (941s left) gem_ctx_exec (basic)
[108.619049] Starting subtest: basic
[108.660913] Subtest basic: SUCCESS (0.001s)
[108.778518] [019/171] (940s left) gem_exec_basic (basic)
[109.237470] Starting subtest: basic
[109.279269] Starting dynamic subtest: rcs0-smem
[109.321050] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[109.371346] Starting dynamic subtest: bcs0-smem
[109.413087] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[109.463258] Starting dynamic subtest: vcs0-smem
[109.504942] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[109.546763] Subtest basic: SUCCESS (0.002s)
[109.656116] [020/171] (940s left) gem_exec_create (basic)
[110.139600] Starting subtest: basic
[110.181390] Starting dynamic subtest: smem
[112.139577] Dynamic subtest smem: SUCCESS (2.049s)
[112.181381] Subtest basic: SUCCESS (2.050s)
[112.332777] [021/171] (937s left) gem_exec_fence (basic-busy)
[113.169076] Subtest basic-busy: SKIP (0.000s)
[113.529416] [022/171] (936s left) gem_exec_fence (basic-wait)
[114.054904] Subtest basic-wait: SKIP (0.000s)
[114.331804] [023/171] (935s left) gem_exec_fence (basic-await)
[114.807239] Subtest basic-await: SKIP (0.000s)
[115.109348] [024/171] (935s left) gem_exec_fence (nb-await)
[115.636862] Subtest nb-await: SKIP (0.000s)
[115.871854] [025/171] (934s left) gem_exec_gttfill (basic)
[116.255188] Starting subtest: basic
[121.046257] Subtest basic: SUCCESS (4.871s)
[121.288960] [026/171] (929s left) gem_exec_parallel (engines)
[123.497667] Starting subtest: engines
[123.539480] Starting dynamic subtest: basic
[124.989498] Dynamic subtest basic: SUCCESS (1.587s)
[125.039731] Starting dynamic subtest: contexts
[126.774416] Dynamic subtest contexts: SUCCESS (1.823s)
[126.816345] Starting dynamic subtest: fds
[129.171324] Dynamic subtest fds: SUCCESS (2.389s)
[129.221441] Starting dynamic subtest: userptr
[130.896619] Dynamic subtest userptr: SUCCESS (1.695s)
[130.938193] Subtest engines: SUCCESS (7.495s)
[131.091457] [027/171] (919s left) gem_exec_store (basic)
[131.834250] Starting subtest: basic
[131.884444] Subtest basic: SUCCESS (0.039s)
[132.002202] [028/171] (918s left) gem_flink_basic (bad-flink)
[132.427890] Starting subtest: bad-flink
[132.461330] Subtest bad-flink: SUCCESS (0.000s)
[132.553961] [029/171] (918s left) gem_flink_basic (bad-open)
[132.971391] Starting subtest: bad-open
[133.012945] Subtest bad-open: SUCCESS (0.000s)
[133.122324] [030/171] (917s left) gem_flink_basic (basic)
[133.497773] Starting subtest: basic
[133.539563] Subtest basic: SUCCESS (0.000s)
[133.642181] [031/171] (917s left) gem_flink_basic (double-flink)
[134.017880] Starting subtest: double-flink
[134.059664] Subtest double-flink: SUCCESS (0.000s)
[134.169175] [032/171] (916s left) gem_flink_basic (flink-lifetime)
[134.569575] Starting subtest: flink-lifetime
[134.611350] Subtest flink-lifetime: SUCCESS (0.001s)
[134.720816] [033/171] (916s left) gem_huc_copy (huc-copy)
[135.162780] Subtest huc-copy: SKIP (0.000s)
[135.264124] [034/171] (916s left) gem_linear_blits (basic)
[135.772833] Starting subtest: basic
[135.806520] Subtest basic: SUCCESS (0.009s)
[136.225836] [035/171] (915s left) gem_mmap (basic)
[138.300443] Starting subtest: basic
[138.492974] Subtest basic: SUCCESS (0.001s)
[138.585820] [036/171] (913s left) gem_mmap_gtt (basic)
[139.027755] Starting subtest: basic
[139.069625] Subtest basic: SUCCESS (0.001s)
[139.179146] [037/171] (912s left) gem_render_linear_blits (basic)
[139.704580] Starting subtest: basic
[139.946783] Subtest basic: SUCCESS (0.029s)
[140.072980] [038/171] (912s left) gem_render_tiled_blits (basic)
[140.589843] Starting subtest: basic
[140.867184] Subtest basic: SUCCESS (0.035s)
[140.968307] [039/171] (911s left) gem_ringfill (basic-all)
[141.560274] Starting subtest: basic-all
[142.643838] Subtest basic-all: SUCCESS (1.158s)
[142.744968] [040/171] (909s left) gem_softpin (allocator-basic)
[143.287219] Subtest allocator-basic: SKIP (0.000s)
[143.404690] [041/171] (909s left) gem_softpin (allocator-basic-reserve)
[143.888906] Subtest allocator-basic-reserve: SKIP (0.000s)
[144.006652] [042/171] (909s left) gem_softpin (safe-alignment)
[144.508878] Starting subtest: safe-alignment
[144.550687] Subtest safe-alignment: SUCCESS (0.006s)
[144.651672] [043/171] (908s left) gem_sync (basic-all)
[145.135296] Starting subtest: basic-all
[147.168579] Subtest basic-all: SUCCESS (2.186s)
[147.345100] [044/171] (906s left) gem_sync (basic-each)
[147.978821] Starting subtest: basic-each
[149.854222] Subtest basic-each: SUCCESS (2.113s)
[150.013986] [045/171] (903s left) gem_tiled_blits (basic)
[150.490863] Starting subtest: basic
[150.557864] Subtest basic: SUCCESS (0.064s)
[150.925558] [046/171] (902s left) gem_tiled_fence_blits (basic)
[153.092102] Starting subtest: basic
[153.175666] Subtest basic: SUCCESS (0.007s)
[153.592916] [047/171] (900s left) gem_tiled_pread_basic
[155.835810] [048/171] (897s left) gem_wait (busy@all-engines)
[156.352900] Starting subtest: busy
[156.394702] Starting dynamic subtest: all-engines
[156.870391] Dynamic subtest all-engines: SUCCESS (0.512s)
[156.911994] Subtest busy: SUCCESS (0.513s)
[157.131833] [049/171] (896s left) gem_wait (wait@all-engines)
[157.548822] Starting subtest: wait
[157.590654] Starting dynamic subtest: all-engines
[158.474490] Dynamic subtest all-engines: SUCCESS (1.019s)
[158.515947] Subtest wait: SUCCESS (1.019s)
[158.667374] [050/171] (895s left) i915_getparams_basic (basic-eu-total)
[159.143178] Starting subtest: basic-eu-total
[159.226691] Subtest basic-eu-total: SUCCESS (0.000s)
[159.335849] [051/171] (894s left) i915_getparams_basic (basic-subslice-total)
[159.728234] Starting subtest: basic-subslice-total
[159.795408] Subtest basic-subslice-total: SUCCESS (0.000s)
[159.887730] [052/171] (894s left) i915_hangman (error-state-basic)
[160.379818] Starting subtest: error-state-basic
[160.446427] Subtest error-state-basic: SUCCESS (0.009s)
[160.782879] [053/171] (894s left) i915_pciid
[161.451345] [054/171] (893s left) kms_addfb_basic (addfb25-bad-modifier)
[161.960179] Starting subtest: addfb25-bad-modifier
[162.043557] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[162.588909] [055/171] (892s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[163.199406] Starting subtest: addfb25-framebuffer-vs-set-tiling
[163.241246] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[163.443325] [056/171] (891s left) kms_addfb_basic (addfb25-modifier-no-flag)
[163.935612] Starting subtest: addfb25-modifier-no-flag
[163.977434] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[164.204529] [057/171] (891s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[164.655298] Starting subtest: addfb25-x-tiled-legacy
[164.697173] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[164.867466] [058/171] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[165.376286] Starting subtest: addfb25-x-tiled-mismatch-legacy
[165.418136] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[165.594995] [059/171] (889s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[166.254758] Starting subtest: addfb25-yf-tiled-legacy
[166.297029] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[166.406287] [060/171] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[166.934505] Starting subtest: addfb25-y-tiled-legacy
[166.968393] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[167.077860] [061/171] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[167.670830] Starting subtest: addfb25-y-tiled-small-legacy
[167.754783] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[167.872435] [062/171] (887s left) kms_addfb_basic (bad-pitch-0)
[168.348127] Starting subtest: bad-pitch-0
[168.381685] Subtest bad-pitch-0: SUCCESS (0.000s)
[168.585241] [063/171] (887s left) kms_addfb_basic (bad-pitch-1024)
[169.061019] Starting subtest: bad-pitch-1024
[169.111280] Subtest bad-pitch-1024: SUCCESS (0.000s)
[169.329684] [064/171] (886s left) kms_addfb_basic (bad-pitch-128)
[169.780497] Starting subtest: bad-pitch-128
[169.822329] Subtest bad-pitch-128: SUCCESS (0.000s)
[170.032687] [065/171] (886s left) kms_addfb_basic (bad-pitch-256)
[170.483260] Starting subtest: bad-pitch-256
[170.516783] Subtest bad-pitch-256: SUCCESS (0.000s)
[170.720539] [066/171] (885s left) kms_addfb_basic (bad-pitch-32)
[171.212680] Starting subtest: bad-pitch-32
[171.254546] Subtest bad-pitch-32: SUCCESS (0.000s)
[171.422874] [067/171] (884s left) kms_addfb_basic (bad-pitch-63)
[171.881972] Starting subtest: bad-pitch-63
[171.915499] Subtest bad-pitch-63: SUCCESS (0.000s)
[172.125989] [068/171] (884s left) kms_addfb_basic (bad-pitch-65536)
[172.628305] Starting subtest: bad-pitch-65536
[172.670123] Subtest bad-pitch-65536: SUCCESS (0.000s)
[172.955915] [069/171] (883s left) kms_addfb_basic (bad-pitch-999)
[173.431432] Starting subtest: bad-pitch-999
[173.473278] Subtest bad-pitch-999: SUCCESS (0.000s)
[173.650371] [070/171] (882s left) kms_addfb_basic (basic)
[174.134113] Starting subtest: basic
[174.184335] Subtest basic: SUCCESS (0.000s)
[174.310934] [071/171] (882s left) kms_addfb_basic (basic-x-tiled-legacy)
[174.771600] Starting subtest: basic-x-tiled-legacy
[174.805109] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[174.973692] [072/171] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[175.465908] Starting subtest: basic-y-tiled-legacy
[175.507739] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[175.692825] [073/171] (881s left) kms_addfb_basic (bo-too-small)
[176.235890] Starting subtest: bo-too-small
[176.269445] Subtest bo-too-small: SUCCESS (0.000s)
[176.397945] [074/171] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[176.998771] Starting subtest: bo-too-small-due-to-tiling
[177.041218] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[177.183824] [075/171] (879s left) kms_addfb_basic (clobberred-modifier)
[177.626058] Starting subtest: clobberred-modifier
[177.667913] Subtest clobberred-modifier: SUCCESS (0.000s)
[177.853271] [076/171] (879s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[178.280643] Starting subtest: framebuffer-vs-set-tiling
[178.322397] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[178.557981] [077/171] (878s left) kms_addfb_basic (invalid-get-prop)
[179.000362] Starting subtest: invalid-get-prop
[179.050488] Subtest invalid-get-prop: SUCCESS (0.000s)
[179.168576] [078/171] (878s left) kms_addfb_basic (invalid-get-prop-any)
[179.644342] Starting subtest: invalid-get-prop-any
[179.686166] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[179.896611] [079/171] (877s left) kms_addfb_basic (invalid-set-prop)
[180.357105] Starting subtest: invalid-set-prop
[180.398987] Subtest invalid-set-prop: SUCCESS (0.000s)
[180.576239] [080/171] (876s left) kms_addfb_basic (invalid-set-prop-any)
[181.009859] Starting subtest: invalid-set-prop-any
[181.043389] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[181.236542] [081/171] (876s left) kms_addfb_basic (no-handle)
[181.737558] Starting subtest: no-handle
[181.779410] Subtest no-handle: SUCCESS (0.000s)
[181.931502] [082/171] (875s left) kms_addfb_basic (size-max)
[182.534116] Starting subtest: size-max
[182.576301] Subtest size-max: SUCCESS (0.000s)
[182.710855] [083/171] (874s left) kms_addfb_basic (small-bo)
[183.195323] Starting subtest: small-bo
[183.237110] Subtest small-bo: SUCCESS (0.000s)
[183.388951] [084/171] (874s left) kms_addfb_basic (tile-pitch-mismatch)
[183.831110] Starting subtest: tile-pitch-mismatch
[183.873025] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[184.051455] [085/171] (873s left) kms_addfb_basic (too-high)
[184.611250] Starting subtest: too-high
[184.644758] Subtest too-high: SUCCESS (0.001s)
[184.746387] [086/171] (873s left) kms_addfb_basic (too-wide)
[185.339273] Starting subtest: too-wide
[185.381404] Subtest too-wide: SUCCESS (0.000s)
[185.490663] [087/171] (872s left) kms_addfb_basic (unused-handle)
[185.943099] Starting subtest: unused-handle
[185.976745] Subtest unused-handle: SUCCESS (0.000s)
[186.170415] [088/171] (871s left) kms_addfb_basic (unused-modifier)
[186.679328] Starting subtest: unused-modifier
[186.721093] Subtest unused-modifier: SUCCESS (0.000s)
[186.906070] [089/171] (871s left) kms_addfb_basic (unused-offsets)
[187.306835] Starting subtest: unused-offsets
[187.348636] Subtest unused-offsets: SUCCESS (0.000s)
[187.508893] [090/171] (870s left) kms_addfb_basic (unused-pitches)
[187.919451] Starting subtest: unused-pitches
[187.953012] Subtest unused-pitches: SUCCESS (0.000s)
[188.121381] [091/171] (870s left) kms_busy (basic)
[188.772820] Starting subtest: basic
[188.814551] Starting dynamic subtest: flip
[193.054236] Dynamic subtest flip: SUCCESS (4.308s)
[193.104462] Starting dynamic subtest: modeset
[195.235203] Dynamic subtest modeset: SUCCESS (2.177s)
[195.285407] Subtest basic: SUCCESS (6.485s)
[196.230282] [092/171] (862s left) kms_chamelium_hpd (dp-hpd-fast)
[197.498194] Subtest dp-hpd-fast: SKIP (0.000s)
[198.225275] [093/171] (860s left) kms_chamelium_edid (dp-edid-read)
[199.178759] Subtest dp-edid-read: SKIP (0.000s)
[199.855979] [094/171] (858s left) kms_chamelium_frames (dp-crc-fast)
[200.799279] Subtest dp-crc-fast: SKIP (0.000s)
[201.401445] [095/171] (857s left) kms_chamelium_hpd (hdmi-hpd-fast)
[202.313071] Subtest hdmi-hpd-fast: SKIP (0.000s)
[202.940535] [096/171] (855s left) kms_chamelium_edid (hdmi-edid-read)
[203.842248] Subtest hdmi-edid-read: SKIP (0.000s)
[204.496368] [097/171] (854s left) kms_chamelium_frames (hdmi-crc-fast)
[205.397764] Subtest hdmi-crc-fast: SKIP (0.000s)
[206.042076] [098/171] (852s left) kms_chamelium_hpd (vga-hpd-fast)
[206.987059] Subtest vga-hpd-fast: SKIP (0.000s)
[207.722994] [099/171] (851s left) kms_chamelium_edid (vga-edid-read)
[208.532394] Subtest vga-edid-read: SKIP (0.000s)
[209.209955] [100/171] (849s left) kms_prop_blob (basic)
[209.793562] Starting subtest: basic
[209.835509] Subtest basic: SUCCESS (0.000s)
[209.947081] [101/171] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[210.580838] Starting subtest: basic-busy-flip-before-cursor-atomic
[211.781772] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.221s)
[212.542538] [102/171] (846s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[213.201672] Starting subtest: basic-busy-flip-before-cursor-legacy
[214.395941] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.216s)
[215.140394] [103/171] (844s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[215.773821] Starting subtest: basic-flip-after-cursor-atomic
[216.966347] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.193s)
[217.888827] [104/171] (841s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[218.514152] Starting subtest: basic-flip-after-cursor-legacy
[219.690139] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.160s)
[220.467480] [105/171] (839s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[221.084995] Starting subtest: basic-flip-after-cursor-varying-size
[222.253886] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.181s)
[222.948248] [106/171] (836s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[223.665690] Starting subtest: basic-flip-before-cursor-atomic
[224.858276] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.187s)
[225.543958] [107/171] (834s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[226.113062] Starting subtest: basic-flip-before-cursor-legacy
[227.297142] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.200s)
[228.158639] [108/171] (831s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[228.784119] Starting subtest: basic-flip-before-cursor-varying-size
[230.009980] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.232s)
[230.856899] [109/171] (829s left) kms_flip (basic-flip-vs-dpms)
[231.389981] Starting subtest: basic-flip-vs-dpms
[231.431901] Starting dynamic subtest: A-LVDS1
[233.035264] Dynamic subtest A-LVDS1: SUCCESS (1.726s)
[233.076844] Starting dynamic subtest: B-LVDS1
[234.530932] Dynamic subtest B-LVDS1: SUCCESS (1.483s)
[234.581180] Starting dynamic subtest: A-VGA1
[235.235528] Dynamic subtest A-VGA1: SUCCESS (0.699s)
[235.285779] Starting dynamic subtest: B-VGA1
[235.941926] Dynamic subtest B-VGA1: SUCCESS (0.700s)
[235.975452] Subtest basic-flip-vs-dpms: SUCCESS (4.614s)
[236.151956] [110/171] (824s left) kms_flip (basic-flip-vs-modeset)
[236.702994] Starting subtest: basic-flip-vs-modeset
[236.736491] Starting dynamic subtest: A-LVDS1
[238.449462] Dynamic subtest A-LVDS1: SUCCESS (1.753s)
[238.499701] Starting dynamic subtest: B-LVDS1
[239.843923] Dynamic subtest B-LVDS1: SUCCESS (1.408s)
[239.885822] Starting dynamic subtest: A-VGA1
[240.550443] Dynamic subtest A-VGA1: SUCCESS (0.729s)
[240.592295] Starting dynamic subtest: B-VGA1
[241.305129] Dynamic subtest B-VGA1: SUCCESS (0.714s)
[241.346883] Subtest basic-flip-vs-modeset: SUCCESS (4.614s)
[241.685108] [111/171] (818s left) kms_flip (basic-flip-vs-wf_vblank)
[242.269259] Starting subtest: basic-flip-vs-wf_vblank
[242.311060] Starting dynamic subtest: A-LVDS1
[244.154083] Dynamic subtest A-LVDS1: SUCCESS (1.973s)
[244.195974] Starting dynamic subtest: B-LVDS1
[246.107541] Dynamic subtest B-LVDS1: SUCCESS (1.902s)
[246.157954] Starting dynamic subtest: A-VGA1
[247.275902] Dynamic subtest A-VGA1: SUCCESS (1.205s)
[247.317783] Starting dynamic subtest: B-VGA1
[248.243911] Dynamic subtest B-VGA1: SUCCESS (0.973s)
[248.277442] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.061s)
[248.506276] [112/171] (811s left) kms_flip (basic-plain-flip)
[249.038609] Starting subtest: basic-plain-flip
[249.082208] Starting dynamic subtest: A-LVDS1
[250.517057] Dynamic subtest A-LVDS1: SUCCESS (1.512s)
[250.558932] Starting dynamic subtest: B-LVDS1
[252.077147] Dynamic subtest B-LVDS1: SUCCESS (1.514s)
[252.119339] Starting dynamic subtest: A-VGA1
[252.970387] Dynamic subtest A-VGA1: SUCCESS (0.931s)
[253.020619] Starting dynamic subtest: B-VGA1
[253.646457] Dynamic subtest B-VGA1: SUCCESS (0.681s)
[253.688429] Subtest basic-plain-flip: SUCCESS (4.645s)
[254.111535] [113/171] (806s left) kms_force_connector_basic (force-connector-state)
[254.668849] Starting subtest: force-connector-state
[255.153860] Subtest force-connector-state: SUCCESS (0.533s)
[256.252133] [114/171] (804s left) kms_force_connector_basic (force-edid)
[256.818141] Starting subtest: force-edid
[256.851648] Subtest force-edid: SUCCESS (0.228s)
[257.365062] [115/171] (803s left) kms_force_connector_basic (force-load-detect)
[257.872850] Starting subtest: force-load-detect
[258.175399] Subtest force-load-detect: SUCCESS (0.404s)
[259.272127] [116/171] (801s left) kms_force_connector_basic (prune-stale-modes)
[259.755018] Starting subtest: prune-stale-modes
[259.796862] Subtest prune-stale-modes: SUCCESS (0.024s)
[260.168170] [117/171] (800s left) kms_frontbuffer_tracking (basic)
[260.919829] Starting subtest: basic
[263.045549] Subtest basic: SUCCESS (2.203s)
[263.198281] [118/171] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[263.848458] Starting subtest: compare-crc-sanitycheck
[263.882079] Starting dynamic subtest: pipe-A-LVDS-1
[264.333178] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.509s)
[264.375048] Starting dynamic subtest: pipe-B-LVDS-1
[265.228438] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.881s)
[265.270238] Subtest compare-crc-sanitycheck: SUCCESS (1.393s)
[266.165714] [119/171] (794s left) kms_pipe_crc_basic (hang-read-crc)
[266.632115] Starting subtest: hang-read-crc
[266.682389] Starting dynamic subtest: pipe-A-LVDS-1
[268.453888] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.812s)
[268.503984] Starting dynamic subtest: pipe-B-LVDS-1
[270.849871] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.415s)
[270.891722] Subtest hang-read-crc: SUCCESS (4.229s)
[271.571793] [120/171] (789s left) kms_pipe_crc_basic (nonblocking-crc)
[272.146836] Starting subtest: nonblocking-crc
[272.180362] Starting dynamic subtest: pipe-A-LVDS-1
[272.831677] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.693s)
[272.873570] Starting dynamic subtest: pipe-B-LVDS-1
[274.142537] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.292s)
[274.184306] Subtest nonblocking-crc: SUCCESS (1.987s)
[274.873222] [121/171] (786s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[275.555820] Starting subtest: nonblocking-crc-frame-sequence
[275.598131] Starting dynamic subtest: pipe-A-LVDS-1
[276.257738] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.696s)
[276.307944] Starting dynamic subtest: pipe-B-LVDS-1
[277.536809] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.264s)
[277.570443] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.963s)
[278.481734] [122/171] (782s left) kms_pipe_crc_basic (read-crc)
[279.040954] Starting subtest: read-crc
[279.083169] Starting dynamic subtest: pipe-A-LVDS-1
[279.676202] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.624s)
[279.718126] Starting dynamic subtest: pipe-B-LVDS-1
[280.863818] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.170s)
[280.905677] Subtest read-crc: SUCCESS (1.797s)
[281.593199] [123/171] (779s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[282.191769] Starting subtest: read-crc-frame-sequence
[282.225715] Starting dynamic subtest: pipe-A-LVDS-1
[282.793705] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.610s)
[282.835554] Starting dynamic subtest: pipe-B-LVDS-1
[284.072644] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.242s)
[284.114489] Subtest read-crc-frame-sequence: SUCCESS (1.854s)
[284.784322] [124/171] (776s left) kms_psr (primary_page_flip)
[285.392224] Subtest primary_page_flip: SKIP (0.000s)
[285.494853] [125/171] (776s left) kms_psr (cursor_plane_move)
[285.918859] Subtest cursor_plane_move: SKIP (0.000s)
[286.030166] [126/171] (775s left) kms_psr (sprite_plane_onoff)
[286.480398] Subtest sprite_plane_onoff: SKIP (0.000s)
[286.599710] [127/171] (775s left) kms_psr (primary_mmap_gtt)
[287.031918] Subtest primary_mmap_gtt: SKIP (0.000s)
[287.159609] [128/171] (775s left) kms_setmode (basic-clone-single-crtc)
[287.666882] Starting subtest: basic-clone-single-crtc
[287.817233] Subtest basic-clone-single-crtc: SKIP (0.001s)
[287.936572] [129/171] (774s left) i915_pm_backlight (basic-brightness)
[288.511076] Subtest basic-brightness: SKIP (0.000s)
[288.638781] [130/171] (774s left) i915_pm_rpm (basic-pci-d3-state)
[290.557951] Subtest basic-pci-d3-state: SKIP (0.000s)
[290.677708] [131/171] (772s left) i915_pm_rpm (basic-rte)
[291.151284] Starting subtest: basic-rte
[292.611239] Subtest basic-rte: SKIP (1.358s)
[292.805532] [132/171] (770s left) i915_pm_rps (basic-api)
[293.356644] Starting subtest: basic-api
[293.406771] Subtest basic-api: SUCCESS (0.003s)
[293.526352] [133/171] (769s left) prime_self_import (basic-llseek-bad)
[294.025175] Starting subtest: basic-llseek-bad
[294.066970] Subtest basic-llseek-bad: SUCCESS (0.001s)
[294.177876] [134/171] (769s left) prime_self_import (basic-llseek-size)
[294.543254] Starting subtest: basic-llseek-size
[294.585088] Subtest basic-llseek-size: SUCCESS (0.002s)
[294.696069] [135/171] (768s left) prime_self_import (basic-with_fd_dup)
[295.220224] Starting subtest: basic-with_fd_dup
[295.253487] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[295.364680] [136/171] (768s left) prime_self_import (basic-with_one_bo)
[295.731474] Starting subtest: basic-with_one_bo
[295.773294] Subtest basic-with_one_bo: SUCCESS (0.004s)
[295.884240] [137/171] (768s left) prime_self_import (basic-with_one_bo_two_files)
[296.274926] Starting subtest: basic-with_one_bo_two_files
[296.316788] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[296.427487] [138/171] (767s left) prime_self_import (basic-with_two_bos)
[296.860137] Starting subtest: basic-with_two_bos
[296.901967] Subtest basic-with_two_bos: SUCCESS (0.003s)
[296.996391] [139/171] (767s left) prime_vgem (basic-fence-flip)
[297.436385] Starting subtest: basic-fence-flip
[297.603943] Subtest basic-fence-flip: SKIP (0.216s)
[297.757112] [140/171] (766s left) prime_vgem (basic-fence-mmap)
[298.241076] Starting subtest: basic-fence-mmap
[298.282777] Subtest basic-fence-mmap: SUCCESS (0.025s)
[298.435062] [141/171] (766s left) prime_vgem (basic-fence-read)
[298.901246] Starting subtest: basic-fence-read
[298.942991] Subtest basic-fence-read: SUCCESS (0.049s)
[299.104319] [142/171] (765s left) prime_vgem (basic-gtt)
[299.444291] Starting subtest: basic-gtt
[299.478490] Subtest basic-gtt: SUCCESS (0.013s)
[299.731590] [143/171] (765s left) prime_vgem (basic-read)
[300.188747] Starting subtest: basic-read
[300.240843] Subtest basic-read: SUCCESS (0.020s)
[300.392733] [144/171] (764s left) prime_vgem (basic-write)
[300.767453] Starting subtest: basic-write
[300.809220] Subtest basic-write: SUCCESS (0.022s)
[300.961170] [145/171] (764s left) prime_vgem (basic-userptr)
[301.327480] Starting subtest: basic-userptr
[301.394389] Subtest basic-userptr: SKIP (0.009s)
[301.529941] [146/171] (763s left) vgem_basic (setversion)
[301.945968] Starting subtest: setversion
[302.029482] Subtest setversion: SUCCESS (0.000s)
[302.140432] [147/171] (763s left) vgem_basic (create)
[302.514217] Starting subtest: create
[302.555979] Subtest create: SUCCESS (0.001s)
[302.668762] [148/171] (763s left) vgem_basic (debugfs)
[303.059061] Starting subtest: debugfs
[303.100900] Subtest debugfs: SUCCESS (0.001s)
[303.220654] [149/171] (762s left) vgem_basic (dmabuf-export)
[303.618985] Starting subtest: dmabuf-export
[303.669136] Subtest dmabuf-export: SUCCESS (0.002s)
[303.788440] [150/171] (762s left) vgem_basic (dmabuf-fence)
[304.228951] Starting subtest: dmabuf-fence
[304.270808] Subtest dmabuf-fence: SUCCESS (0.001s)
[304.389945] [151/171] (761s left) vgem_basic (dmabuf-fence-before)
[304.747177] Starting subtest: dmabuf-fence-before
[304.788922] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[304.900060] [152/171] (761s left) vgem_basic (dmabuf-mmap)
[305.275441] Starting subtest: dmabuf-mmap
[305.308944] Subtest dmabuf-mmap: SUCCESS (0.018s)
[305.411673] [153/171] (760s left) vgem_basic (mmap)
[305.810393] Starting subtest: mmap
[305.843832] Subtest mmap: SUCCESS (0.012s)
[305.954331] [154/171] (760s left) vgem_basic (second-client)
[306.337082] Starting subtest: second-client
[306.378842] Subtest second-client: SUCCESS (0.048s)
[306.490303] [155/171] (760s left) vgem_basic (sysfs)
[306.846866] Starting subtest: sysfs
[306.888671] Subtest sysfs: SUCCESS (0.001s)
[307.041465] [156/171] (759s left) core_hotunplug (unbind-rebind)
[307.698243] Starting subtest: unbind-rebind
[309.419852] Subtest unbind-rebind: SUCCESS (1.530s)
[309.996392] [157/171] (757s left) vgem_basic (unload)
[311.021935] Starting subtest: unload
[339.912598] Subtest unload: SUCCESS (29.147s)
[340.114226] [158/171] (727s left) i915_module_load (reload)
[340.799491] Starting subtest: reload
[344.669611] Subtest reload: SUCCESS (3.910s)
[344.989586] [159/171] (723s left) gem_lmem_swapping (basic)
[345.973837] Subtest basic: SKIP (0.000s)
[346.210282] [160/171] (722s left) gem_lmem_swapping (parallel-random-engines)
[346.683966] Subtest parallel-random-engines: SKIP (0.000s)
[346.910984] [161/171] (721s left) gem_lmem_swapping (random-engines)
[347.435642] Subtest random-engines: SKIP (0.000s)
[347.603516] [162/171] (721s left) gem_lmem_swapping (verify-random)
[348.095421] Subtest verify-random: SKIP (0.000s)
[348.356480] [163/171] (720s left) i915_pm_rpm (module-reload)
[350.433316] Subtest module-reload: SKIP (0.000s)
[350.718289] [164/171] (718s left) i915_selftest (live)
[352.269577] Starting subtest: live
[352.344700] Starting dynamic subtest: sanitycheck
[353.073021] Dynamic subtest sanitycheck: SUCCESS (0.775s)
[353.156593] Starting dynamic subtest: uncore
[353.825228] Dynamic subtest uncore: SUCCESS (0.757s)
[353.908757] Starting dynamic subtest: workarounds
[354.510964] Dynamic subtest workarounds: SUCCESS (0.725s)
[354.577854] Starting dynamic subtest: gt_engines
[355.215373] Dynamic subtest gt_engines: SUCCESS (0.691s)
[355.290456] Starting dynamic subtest: gt_timelines
[359.476063] Dynamic subtest gt_timelines: SUCCESS (4.271s)
[359.526118] Starting dynamic subtest: gt_contexts
[360.253322] Dynamic subtest gt_contexts: SUCCESS (0.726s)
[360.311857] Starting dynamic subtest: gt_lrc
[360.907131] Dynamic subtest gt_lrc: SUCCESS (0.705s)
[360.965532] Starting dynamic subtest: gt_mocs
[361.642846] Dynamic subtest gt_mocs: SUCCESS (0.724s)
[361.717888] Starting dynamic subtest: gt_pm
[368.405925] Dynamic subtest gt_pm: SUCCESS (6.774s)
[368.464329] Starting dynamic subtest: gt_heartbeat
[369.216956] Dynamic subtest gt_heartbeat: SUCCESS (0.779s)
[369.300418] Starting dynamic subtest: requests
[374.631056] Dynamic subtest requests: SUCCESS (5.439s)
[374.689389] Starting dynamic subtest: migrate
[375.424540] Dynamic subtest migrate: SUCCESS (0.767s)
[375.499755] Starting dynamic subtest: active
[376.159791] Dynamic subtest active: SUCCESS (0.744s)
[376.243214] Starting dynamic subtest: objects
[377.422222] Dynamic subtest objects: SUCCESS (1.255s)
[377.497373] Starting dynamic subtest: mman
[382.258168] Dynamic subtest mman: SUCCESS (4.682s)
[382.603800] Starting dynamic subtest: dmabuf
[382.929465] Dynamic subtest dmabuf: SUCCESS (0.858s)
[382.979529] Starting dynamic subtest: vma
[383.665419] Dynamic subtest vma: SUCCESS (0.732s)
[383.715535] Starting dynamic subtest: coherency
[385.401427] Dynamic subtest coherency: SUCCESS (1.731s)
[385.451544] Starting dynamic subtest: gtt
[389.549058] Dynamic subtest gtt: SUCCESS (4.151s)
[389.607513] Starting dynamic subtest: gem
[390.528782] Dynamic subtest gem: SUCCESS (0.985s)
[390.578983] Starting dynamic subtest: evict
[391.323267] Dynamic subtest evict: SUCCESS (0.789s)
[391.373347] Starting dynamic subtest: hugepages
[392.709670] Dynamic subtest hugepages: SUCCESS (1.391s)
[392.759759] Starting dynamic subtest: gem_contexts
[397.148763] Dynamic subtest gem_contexts: SUCCESS (4.441s)
[397.198818] Starting dynamic subtest: client
[397.951703] Dynamic subtest client: SUCCESS (0.800s)
[398.001760] Starting dynamic subtest: gem_migrate
[398.706077] Dynamic subtest gem_migrate: SUCCESS (0.757s)
[398.756164] Starting dynamic subtest: reset
[399.717038] Dynamic subtest reset: SUCCESS (1.004s)
[399.767098] Starting dynamic subtest: memory_region
[400.513057] Dynamic subtest memory_region: SUCCESS (0.793s)
[400.571553] Starting dynamic subtest: hangcheck
[402.999776] Dynamic subtest hangcheck: SUCCESS (2.491s)
[403.058155] Starting dynamic subtest: execlists
[403.852148] Dynamic subtest execlists: SUCCESS (0.851s)
[403.910524] Starting dynamic subtest: ring_submission
[404.631677] Dynamic subtest ring_submission: SUCCESS (0.779s)
[404.681753] Starting dynamic subtest: perf
[405.425944] Dynamic subtest perf: SUCCESS (0.793s)
[405.475981] Starting dynamic subtest: slpc
[406.195170] Dynamic subtest slpc: SUCCESS (0.775s)
[406.246951] Starting dynamic subtest: guc
[406.974424] Dynamic subtest guc: SUCCESS (0.773s)
[407.032839] Starting dynamic subtest: guc_multi_lrc
[407.810671] Dynamic subtest guc_multi_lrc: SUCCESS (0.839s)
[407.860860] Starting dynamic subtest: guc_hang
[408.523265] Dynamic subtest guc_hang: SUCCESS (0.713s)
[408.573449] Starting dynamic subtest: late_gt_pm
[409.342590] Dynamic subtest late_gt_pm: SUCCESS (0.816s)
[409.392868] Subtest live: SUCCESS (57.109s)
[409.520378] [165/171] (659s left) dmabuf (all-tests)
[410.494697] Starting subtest: all-tests
[410.536306] Starting dynamic subtest: sanitycheck
[410.578170] Dynamic subtest sanitycheck: SUCCESS (0.087s)
[410.628534] Starting dynamic subtest: dma_fence
[410.712177] Dynamic subtest dma_fence: SUCCESS (0.136s)
[410.762279] Starting dynamic subtest: dma_fence_chain
[424.875875] Dynamic subtest dma_fence_chain: SUCCESS (14.204s)
[424.918167] Starting dynamic subtest: dma_fence_unwrap
[424.951553] Dynamic subtest dma_fence_unwrap: SUCCESS (0.023s)
[424.993319] Starting dynamic subtest: dma_resv
[425.026823] Dynamic subtest dma_resv: SUCCESS (0.026s)
[425.060306] Subtest all-tests: SUCCESS (14.482s)
[425.179592] [166/171] (644s left) i915_suspend (basic-s2idle-without-i915)
[425.703523] Starting subtest: basic-s2idle-without-i915
[447.344259] Subtest basic-s2idle-without-i915: SUCCESS (6.822s)
[449.597491] [167/171] (636s left) i915_suspend (basic-s3-without-i915)
[450.655629] Starting subtest: basic-s3-without-i915
[471.282872] Subtest basic-s3-without-i915: SUCCESS (5.843s)
[472.636167] [168/171] (630s left) gem_exec_suspend (basic-s0)
[473.701439] Starting subtest: basic-S0
[473.734861] Starting dynamic subtest: smem
[493.750093] Dynamic subtest smem: SUCCESS (4.228s)
[493.783578] Subtest basic-S0: SUCCESS (4.229s)
[495.528405] [169/171] (624s left) gem_exec_suspend (basic-s3)
[496.201792] Starting subtest: basic-S3
[496.243570] Starting dynamic subtest: smem
[514.841913] Dynamic subtest smem: SUCCESS (4.502s)
[514.883672] Subtest basic-S3: SUCCESS (4.503s)
[517.076917] [170/171] (619s left) kms_chamelium_hpd (common-hpd-after-suspend)
[518.202859] Subtest common-hpd-after-suspend: SKIP (0.000s)
[518.782217] [171/171] (617s left) kms_pipe_crc_basic (suspend-read-crc)
[519.391209] Starting subtest: suspend-read-crc
[519.433390] Starting dynamic subtest: pipe-A-LVDS-1
[538.942081] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.599s)
[538.992071] Starting dynamic subtest: pipe-B-LVDS-1
[559.936405] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.244s)
[559.978201] Subtest suspend-read-crc: SUCCESS (9.845s)
[562.579208] Closing watchdogs
Done.