[87.058968] Initializing watchdogs
[87.059464]   /dev/watchdog0
[87.132609] [001/171] (960s left) i915_module_load (load)
[87.942274] Starting subtest: load
[92.551101] Subtest load: SUCCESS (4.611s)
[93.244715] [002/171] (954s left) core_auth (basic-auth)
[94.230143] Starting subtest: basic-auth
[94.322054] Subtest basic-auth: SUCCESS (0.001s)
[94.631589] [003/171] (954s left) debugfs_test (read_all_entries)
[95.366575] Starting subtest: read_all_entries
[95.408525] Subtest read_all_entries: SUCCESS (0.051s)
[95.822329] [004/171] (952s left) debugfs_test (basic-hwmon)
[96.364995] Starting subtest: basic-hwmon
[96.457109] Subtest basic-hwmon: SKIP (0.000s)
[96.835203] [005/171] (952s left) fbdev (eof)
[97.353241] Starting subtest: eof
[97.395241] Subtest eof: SUCCESS (0.001s)
[97.546362] [006/171] (951s left) fbdev (info)
[97.923788] Starting subtest: info
[97.957278] Subtest info: SUCCESS (0.000s)
[98.100624] [007/171] (951s left) fbdev (nullptr)
[98.542964] Starting subtest: nullptr
[98.593195] Subtest nullptr: SUCCESS (0.000s)
[98.752622] [008/171] (950s left) fbdev (read)
[99.119810] Starting subtest: read
[99.512399] Subtest read: SUCCESS (0.471s)
[99.688669] [009/171] (950s left) fbdev (write)
[100.164974] Starting subtest: write
[100.206879] Subtest write: SUCCESS (0.118s)
[100.349713] [010/171] (949s left) gem_basic (bad-close)
[100.810697] Starting subtest: bad-close
[100.894374] Subtest bad-close: SUCCESS (0.000s)
[101.003894] [011/171] (949s left) gem_basic (create-close)
[101.421544] Starting subtest: create-close
[101.505175] Subtest create-close: SUCCESS (0.000s)
[101.614415] [012/171] (948s left) gem_basic (create-fd-close)
[102.057321] Starting subtest: create-fd-close
[102.157750] Subtest create-fd-close: SUCCESS (0.000s)
[102.267144] [013/171] (948s left) gem_busy (busy@all-engines)
[102.826973] Starting subtest: busy
[102.877101] Starting dynamic subtest: all-engines
[102.927416] Dynamic subtest all-engines: SUCCESS (0.037s)
[102.977716] Subtest busy: SUCCESS (0.038s)
[103.180946] [014/171] (947s left) gem_close_race (basic-process)
[103.748703] Starting subtest: basic-process
[103.799257] Subtest basic-process: SUCCESS (0.048s)
[103.925248] [015/171] (947s left) gem_close_race (basic-threads)
[104.384266] Starting subtest: basic-threads
[105.481257] Subtest basic-threads: SUCCESS (1.159s)
[105.692781] [016/171] (945s left) gem_ctx_create (basic)
[106.252809] Starting subtest: basic
[106.286268] Subtest basic: SUCCESS (0.000s)
[106.379104] [017/171] (944s left) gem_ctx_create (basic-files)
[106.779812] Starting subtest: basic-files
[108.755745] Subtest basic-files: SUCCESS (2.016s)
[108.960349] [018/171] (942s left) gem_ctx_exec (basic)
[109.559087] Starting subtest: basic
[109.600845] Subtest basic: SUCCESS (0.001s)
[109.710438] [019/171] (941s left) gem_exec_basic (basic)
[110.228102] Starting subtest: basic
[110.270196] Starting dynamic subtest: rcs0-smem
[110.312109] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[110.362055] Starting dynamic subtest: bcs0-smem
[110.404251] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[110.454227] Starting dynamic subtest: vcs0-smem
[110.496264] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[110.537809] Subtest basic: SUCCESS (0.002s)
[110.647472] [020/171] (940s left) gem_exec_create (basic)
[111.191505] Starting subtest: basic
[111.233266] Starting dynamic subtest: smem
[113.143558] Dynamic subtest smem: SUCCESS (2.040s)
[113.185089] Subtest basic: SUCCESS (2.041s)
[113.336897] [021/171] (938s left) gem_exec_fence (basic-busy)
[114.281174] Subtest basic-busy: SKIP (0.000s)
[114.558276] [022/171] (937s left) gem_exec_fence (basic-wait)
[115.368151] Subtest basic-wait: SKIP (0.000s)
[115.646907] [023/171] (936s left) gem_exec_fence (basic-await)
[116.215069] Subtest basic-await: SKIP (0.000s)
[116.449831] [024/171] (935s left) gem_exec_fence (nb-await)
[117.093451] Subtest nb-await: SKIP (0.000s)
[117.337064] [025/171] (934s left) gem_exec_gttfill (basic)
[117.770823] Starting subtest: basic
[122.668442] Subtest basic: SUCCESS (4.975s)
[122.878310] [026/171] (929s left) gem_exec_parallel (engines)
[125.280842] Starting subtest: engines
[125.322693] Starting dynamic subtest: basic
[126.765737] Dynamic subtest basic: SUCCESS (1.589s)
[126.824265] Starting dynamic subtest: contexts
[128.650835] Dynamic subtest contexts: SUCCESS (1.914s)
[128.709433] Starting dynamic subtest: fds
[131.243368] Dynamic subtest fds: SUCCESS (2.590s)
[131.293690] Starting dynamic subtest: userptr
[133.012195] Dynamic subtest userptr: SUCCESS (1.727s)
[133.062160] Subtest engines: SUCCESS (7.821s)
[133.230481] [027/171] (918s left) gem_exec_store (basic)
[133.957511] Starting subtest: basic
[133.999204] Subtest basic: SUCCESS (0.037s)
[134.108746] [028/171] (918s left) gem_flink_basic (bad-flink)
[134.534619] Starting subtest: bad-flink
[134.569731] Subtest bad-flink: SUCCESS (0.000s)
[134.670947] [029/171] (917s left) gem_flink_basic (bad-open)
[135.113807] Starting subtest: bad-open
[135.155637] Subtest bad-open: SUCCESS (0.000s)
[135.265165] [030/171] (917s left) gem_flink_basic (basic)
[135.807673] Starting subtest: basic
[135.849706] Subtest basic: SUCCESS (0.000s)
[135.959070] [031/171] (916s left) gem_flink_basic (double-flink)
[136.368430] Starting subtest: double-flink
[136.410156] Subtest double-flink: SUCCESS (0.000s)
[136.511252] [032/171] (916s left) gem_flink_basic (flink-lifetime)
[136.995866] Starting subtest: flink-lifetime
[137.046061] Subtest flink-lifetime: SUCCESS (0.001s)
[137.157244] [033/171] (916s left) gem_huc_copy (huc-copy)
[137.683403] Subtest huc-copy: SKIP (0.000s)
[137.792839] [034/171] (915s left) gem_linear_blits (basic)
[138.310700] Starting subtest: basic
[138.377595] Subtest basic: SUCCESS (0.009s)
[138.870812] [035/171] (914s left) gem_mmap (basic)
[141.231075] Starting subtest: basic
[141.423416] Subtest basic: SUCCESS (0.000s)
[141.516140] [036/171] (912s left) gem_mmap_gtt (basic)
[142.069078] Starting subtest: basic
[142.111097] Subtest basic: SUCCESS (0.001s)
[142.220459] [037/171] (912s left) gem_render_linear_blits (basic)
[142.654731] Starting subtest: basic
[142.863829] Subtest basic: SUCCESS (0.023s)
[142.973241] [038/171] (911s left) gem_render_tiled_blits (basic)
[143.449291] Starting subtest: basic
[143.649941] Subtest basic: SUCCESS (0.030s)
[143.759550] [039/171] (911s left) gem_ringfill (basic-all)
[144.310430] Starting subtest: basic-all
[145.294817] Subtest basic-all: SUCCESS (1.103s)
[145.448211] [040/171] (909s left) gem_softpin (allocator-basic)
[146.057672] Subtest allocator-basic: SKIP (0.000s)
[146.217763] [041/171] (909s left) gem_softpin (allocator-basic-reserve)
[146.743795] Subtest allocator-basic-reserve: SKIP (0.000s)
[146.870129] [042/171] (908s left) gem_softpin (safe-alignment)
[147.371197] Starting subtest: safe-alignment
[147.404710] Subtest safe-alignment: SUCCESS (0.008s)
[147.514338] [043/171] (908s left) gem_sync (basic-all)
[148.131884] Starting subtest: basic-all
[150.152196] Subtest basic-all: SUCCESS (2.187s)
[150.328778] [044/171] (905s left) gem_sync (basic-each)
[150.854628] Starting subtest: basic-each
[152.806534] Subtest basic-each: SUCCESS (2.115s)
[152.958417] [045/171] (903s left) gem_tiled_blits (basic)
[153.501025] Starting subtest: basic
[153.609775] Subtest basic: SUCCESS (0.013s)
[154.019382] [046/171] (902s left) gem_tiled_fence_blits (basic)
[156.563614] Starting subtest: basic
[156.663909] Subtest basic: SUCCESS (0.010s)
[157.083432] [047/171] (899s left) gem_tiled_pread_basic
[159.487415] [048/171] (896s left) gem_wait (busy@all-engines)
[160.137935] Starting subtest: busy
[160.179790] Starting dynamic subtest: all-engines
[160.522394] Dynamic subtest all-engines: SUCCESS (0.516s)
[160.564150] Subtest busy: SUCCESS (0.516s)
[160.715749] [049/171] (895s left) gem_wait (wait@all-engines)
[161.133051] Starting subtest: wait
[161.174867] Starting dynamic subtest: all-engines
[162.026411] Dynamic subtest all-engines: SUCCESS (1.015s)
[162.059749] Subtest wait: SUCCESS (1.015s)
[162.246334] [050/171] (894s left) i915_getparams_basic (basic-eu-total)
[162.764186] Starting subtest: basic-eu-total
[162.847804] Subtest basic-eu-total: SUCCESS (0.000s)
[162.965888] [051/171] (893s left) i915_getparams_basic (basic-subslice-total)
[163.424916] Starting subtest: basic-subslice-total
[163.508610] Subtest basic-subslice-total: SUCCESS (0.000s)
[163.618210] [052/171] (893s left) i915_hangman (error-state-basic)
[164.219283] Starting subtest: error-state-basic
[164.327680] Subtest error-state-basic: SUCCESS (0.005s)
[164.562464] [053/171] (893s left) i915_pciid
[165.124959] [054/171] (892s left) kms_addfb_basic (addfb25-bad-modifier)
[165.667306] Starting subtest: addfb25-bad-modifier
[165.709222] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[166.296705] [055/171] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[166.864616] Starting subtest: addfb25-framebuffer-vs-set-tiling
[166.898166] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[167.269455] [056/171] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[167.787432] Starting subtest: addfb25-modifier-no-flag
[167.829364] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[168.166252] [057/171] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[168.650536] Starting subtest: addfb25-x-tiled-legacy
[168.684120] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[169.080849] [058/171] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[169.632207] Starting subtest: addfb25-x-tiled-mismatch-legacy
[169.673990] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[170.052616] [059/171] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[170.612806] Starting subtest: addfb25-yf-tiled-legacy
[170.654681] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[170.958865] [060/171] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[171.544390] Starting subtest: addfb25-y-tiled-legacy
[171.577894] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[171.914356] [061/171] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[172.517949] Starting subtest: addfb25-y-tiled-small-legacy
[172.585033] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[172.846162] [062/171] (885s left) kms_addfb_basic (bad-pitch-0)
[173.314174] Starting subtest: bad-pitch-0
[173.356096] Subtest bad-pitch-0: SUCCESS (0.000s)
[173.709601] [063/171] (885s left) kms_addfb_basic (bad-pitch-1024)
[174.287378] Starting subtest: bad-pitch-1024
[174.337641] Subtest bad-pitch-1024: SUCCESS (0.000s)
[174.765988] [064/171] (884s left) kms_addfb_basic (bad-pitch-128)
[175.342188] Starting subtest: bad-pitch-128
[175.384142] Subtest bad-pitch-128: SUCCESS (0.000s)
[175.737120] [065/171] (883s left) kms_addfb_basic (bad-pitch-256)
[176.265114] Starting subtest: bad-pitch-256
[176.307046] Subtest bad-pitch-256: SUCCESS (0.000s)
[176.718938] [066/171] (882s left) kms_addfb_basic (bad-pitch-32)
[177.270213] Starting subtest: bad-pitch-32
[177.312117] Subtest bad-pitch-32: SUCCESS (0.000s)
[177.698947] [067/171] (881s left) kms_addfb_basic (bad-pitch-63)
[178.201824] Starting subtest: bad-pitch-63
[178.243717] Subtest bad-pitch-63: SUCCESS (0.000s)
[178.605099] [068/171] (880s left) kms_addfb_basic (bad-pitch-65536)
[179.114788] Starting subtest: bad-pitch-65536
[179.148382] Subtest bad-pitch-65536: SUCCESS (0.000s)
[179.509867] [069/171] (879s left) kms_addfb_basic (bad-pitch-999)
[180.062936] Starting subtest: bad-pitch-999
[180.104781] Subtest bad-pitch-999: SUCCESS (0.000s)
[180.432368] [070/171] (879s left) kms_addfb_basic (basic)
[180.967186] Starting subtest: basic
[181.009100] Subtest basic: SUCCESS (0.000s)
[181.404532] [071/171] (878s left) kms_addfb_basic (basic-x-tiled-legacy)
[181.940453] Starting subtest: basic-x-tiled-legacy
[181.982425] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[182.293708] [072/171] (877s left) kms_addfb_basic (basic-y-tiled-legacy)
[182.828398] Starting subtest: basic-y-tiled-legacy
[182.870295] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[183.197815] [073/171] (876s left) kms_addfb_basic (bo-too-small)
[183.859965] Starting subtest: bo-too-small
[183.893560] Subtest bo-too-small: SUCCESS (0.000s)
[184.213250] [074/171] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[184.798122] Starting subtest: bo-too-small-due-to-tiling
[184.840038] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[185.134427] [075/171] (874s left) kms_addfb_basic (clobberred-modifier)
[185.603971] Starting subtest: clobberred-modifier
[185.637604] Subtest clobberred-modifier: SUCCESS (0.000s)
[186.023991] [076/171] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[186.583517] Starting subtest: framebuffer-vs-set-tiling
[186.625388] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[187.028988] [077/171] (873s left) kms_addfb_basic (invalid-get-prop)
[187.556699] Starting subtest: invalid-get-prop
[187.590210] Subtest invalid-get-prop: SUCCESS (0.000s)
[187.977170] [078/171] (872s left) kms_addfb_basic (invalid-get-prop-any)
[188.511577] Starting subtest: invalid-get-prop-any
[188.553489] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[188.873660] [079/171] (871s left) kms_addfb_basic (invalid-set-prop)
[189.401201] Starting subtest: invalid-set-prop
[189.443109] Subtest invalid-set-prop: SUCCESS (0.000s)
[189.813088] [080/171] (870s left) kms_addfb_basic (invalid-set-prop-any)
[190.314110] Starting subtest: invalid-set-prop-any
[190.414393] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[190.732906] [081/171] (870s left) kms_addfb_basic (no-handle)
[191.242604] Starting subtest: no-handle
[191.276196] Subtest no-handle: SUCCESS (0.000s)
[191.605724] [082/171] (869s left) kms_addfb_basic (size-max)
[192.215548] Starting subtest: size-max
[192.257509] Subtest size-max: SUCCESS (0.000s)
[192.518356] [083/171] (868s left) kms_addfb_basic (small-bo)
[193.019681] Starting subtest: small-bo
[193.053250] Subtest small-bo: SUCCESS (0.000s)
[193.349336] [084/171] (867s left) kms_addfb_basic (tile-pitch-mismatch)
[193.883957] Starting subtest: tile-pitch-mismatch
[193.925897] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[194.262594] [085/171] (866s left) kms_addfb_basic (too-high)
[194.897142] Starting subtest: too-high
[194.930661] Subtest too-high: SUCCESS (0.001s)
[195.251953] [086/171] (865s left) kms_addfb_basic (too-wide)
[195.912074] Starting subtest: too-wide
[195.945658] Subtest too-wide: SUCCESS (0.000s)
[196.189937] [087/171] (865s left) kms_addfb_basic (unused-handle)
[196.732614] Starting subtest: unused-handle
[196.774507] Subtest unused-handle: SUCCESS (0.000s)
[197.236573] [088/171] (864s left) kms_addfb_basic (unused-modifier)
[197.788927] Starting subtest: unused-modifier
[197.830840] Subtest unused-modifier: SUCCESS (0.000s)
[198.209290] [089/171] (863s left) kms_addfb_basic (unused-offsets)
[198.751827] Starting subtest: unused-offsets
[198.793726] Subtest unused-offsets: SUCCESS (0.000s)
[199.180884] [090/171] (862s left) kms_addfb_basic (unused-pitches)
[199.708056] Starting subtest: unused-pitches
[199.749931] Subtest unused-pitches: SUCCESS (0.000s)
[200.112304] [091/171] (861s left) kms_busy (basic)
[200.896757] Starting subtest: basic
[200.972122] Starting dynamic subtest: flip
[205.190790] Dynamic subtest flip: SUCCESS (4.410s)
[205.241090] Starting dynamic subtest: modeset
[207.515334] Dynamic subtest modeset: SUCCESS (2.300s)
[207.557227] Subtest basic: SUCCESS (6.712s)
[208.419946] [092/171] (853s left) kms_chamelium_hpd (dp-hpd-fast)
[209.747462] Subtest dp-hpd-fast: SKIP (0.000s)
[210.560998] [093/171] (851s left) kms_chamelium_edid (dp-edid-read)
[211.530104] Subtest dp-edid-read: SKIP (0.000s)
[212.350591] [094/171] (849s left) kms_chamelium_frames (dp-crc-fast)
[213.352941] Subtest dp-crc-fast: SKIP (0.000s)
[214.175748] [095/171] (848s left) kms_chamelium_hpd (hdmi-hpd-fast)
[215.194170] Subtest hdmi-hpd-fast: SKIP (0.000s)
[216.023462] [096/171] (846s left) kms_chamelium_edid (hdmi-edid-read)
[216.876529] Subtest hdmi-edid-read: SKIP (0.000s)
[217.714085] [097/171] (844s left) kms_chamelium_frames (hdmi-crc-fast)
[218.632408] Subtest hdmi-crc-fast: SKIP (0.000s)
[219.455162] [098/171] (843s left) kms_chamelium_hpd (vga-hpd-fast)
[220.406897] Subtest vga-hpd-fast: SKIP (0.000s)
[221.235936] [099/171] (841s left) kms_chamelium_edid (vga-edid-read)
[222.162511] Subtest vga-edid-read: SKIP (0.000s)
[222.909657] [100/171] (840s left) kms_prop_blob (basic)
[223.518758] Starting subtest: basic
[223.560542] Subtest basic: SUCCESS (0.000s)
[223.671319] [101/171] (839s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[224.288026] Starting subtest: basic-busy-flip-before-cursor-atomic
[225.481765] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.194s)
[226.463899] [102/171] (836s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[226.980884] Starting subtest: basic-busy-flip-before-cursor-legacy
[228.208032] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.232s)
[229.196293] [103/171] (834s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[229.849140] Starting subtest: basic-flip-after-cursor-atomic
[231.042559] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.192s)
[231.964071] [104/171] (831s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[232.564755] Starting subtest: basic-flip-after-cursor-legacy
[233.793505] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.212s)
[234.749079] [105/171] (828s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[235.324845] Starting subtest: basic-flip-after-cursor-varying-size
[236.509780] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.197s)
[237.466126] [106/171] (826s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[238.041998] Starting subtest: basic-flip-before-cursor-atomic
[239.277628] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.233s)
[240.274144] [107/171] (823s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[240.885068] Starting subtest: basic-flip-before-cursor-legacy
[242.087183] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.187s)
[243.068113] [108/171] (820s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[243.701530] Starting subtest: basic-flip-before-cursor-varying-size
[244.921907] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.216s)
[245.860215] [109/171] (818s left) kms_flip (basic-flip-vs-dpms)
[246.593870] Starting subtest: basic-flip-vs-dpms
[246.644346] Starting dynamic subtest: A-LVDS1
[248.233763] Dynamic subtest A-LVDS1: SUCCESS (1.746s)
[248.283986] Starting dynamic subtest: B-LVDS1
[249.721371] Dynamic subtest B-LVDS1: SUCCESS (1.492s)
[249.771733] Starting dynamic subtest: A-VGA1
[250.453276] Dynamic subtest A-VGA1: SUCCESS (0.714s)
[250.511920] Starting dynamic subtest: B-VGA1
[251.183321] Dynamic subtest B-VGA1: SUCCESS (0.709s)
[251.225236] Subtest basic-flip-vs-dpms: SUCCESS (4.674s)
[251.611872] [110/171] (812s left) kms_flip (basic-flip-vs-modeset)
[252.231835] Starting subtest: basic-flip-vs-modeset
[252.273685] Starting dynamic subtest: A-LVDS1
[254.028339] Dynamic subtest A-LVDS1: SUCCESS (1.860s)
[254.078633] Starting dynamic subtest: B-LVDS1
[255.559615] Dynamic subtest B-LVDS1: SUCCESS (1.489s)
[255.609888] Starting dynamic subtest: A-VGA1
[256.256060] Dynamic subtest A-VGA1: SUCCESS (0.722s)
[256.306373] Starting dynamic subtest: B-VGA1
[257.013056] Dynamic subtest B-VGA1: SUCCESS (0.746s)
[257.054907] Subtest basic-flip-vs-modeset: SUCCESS (4.832s)
[257.433776] [111/171] (806s left) kms_flip (basic-flip-vs-wf_vblank)
[258.001445] Starting subtest: basic-flip-vs-wf_vblank
[258.035043] Starting dynamic subtest: A-LVDS1
[259.754677] Dynamic subtest A-LVDS1: SUCCESS (1.819s)
[259.806592] Starting dynamic subtest: B-LVDS1
[261.476278] Dynamic subtest B-LVDS1: SUCCESS (1.711s)
[261.518188] Starting dynamic subtest: A-VGA1
[262.687496] Dynamic subtest A-VGA1: SUCCESS (1.213s)
[262.729489] Starting dynamic subtest: B-VGA1
[263.689802] Dynamic subtest B-VGA1: SUCCESS (0.991s)
[263.731652] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.752s)
[264.120402] [112/171] (800s left) kms_flip (basic-plain-flip)
[264.730143] Starting subtest: basic-plain-flip
[264.772122] Starting dynamic subtest: A-LVDS1
[266.191591] Dynamic subtest A-LVDS1: SUCCESS (1.512s)
[266.241831] Starting dynamic subtest: B-LVDS1
[267.703234] Dynamic subtest B-LVDS1: SUCCESS (1.505s)
[267.753472] Starting dynamic subtest: A-VGA1
[268.640834] Dynamic subtest A-VGA1: SUCCESS (0.931s)
[268.691119] Starting dynamic subtest: B-VGA1
[269.342668] Dynamic subtest B-VGA1: SUCCESS (0.698s)
[269.384498] Subtest basic-plain-flip: SUCCESS (4.663s)
[269.823847] [113/171] (794s left) kms_force_connector_basic (force-connector-state)
[270.456337] Starting subtest: force-connector-state
[270.960417] Subtest force-connector-state: SUCCESS (0.558s)
[272.143254] [114/171] (792s left) kms_force_connector_basic (force-edid)
[272.809307] Starting subtest: force-edid
[272.859583] Subtest force-edid: SUCCESS (0.284s)
[273.509293] [115/171] (791s left) kms_force_connector_basic (force-load-detect)
[274.042352] Starting subtest: force-load-detect
[274.318551] Subtest force-load-detect: SUCCESS (0.414s)
[274.866428] [116/171] (789s left) kms_force_connector_basic (prune-stale-modes)
[275.426094] Starting subtest: prune-stale-modes
[275.467980] Subtest prune-stale-modes: SUCCESS (0.026s)
[275.982640] [117/171] (788s left) kms_frontbuffer_tracking (basic)
[276.866249] Starting subtest: basic
[278.985513] Subtest basic: SUCCESS (2.265s)
[279.349577] [118/171] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[279.933366] Starting subtest: compare-crc-sanitycheck-xr24
[279.967304] Starting dynamic subtest: pipe-A-LVDS-1
[280.452291] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.524s)
[280.494215] Starting dynamic subtest: pipe-B-LVDS-1
[281.413622] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.932s)
[281.455499] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.460s)
[282.380249] [119/171] (782s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[283.012509] Starting subtest: compare-crc-sanitycheck-nv12
[283.054422] Starting dynamic subtest: pipe-A-LVDS-1
[283.138251] Dynamic subtest pipe-A-LVDS-1: SKIP (0.000s)
[283.188559] Starting dynamic subtest: pipe-B-LVDS-1
[283.272697] Dynamic subtest pipe-B-LVDS-1: SKIP (0.000s)
[283.356316] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[283.484239] [120/171] (781s left) kms_pipe_crc_basic (hang-read-crc)
[284.052623] Starting subtest: hang-read-crc
[284.094901] Starting dynamic subtest: pipe-A-LVDS-1
[285.917253] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.859s)
[285.959184] Starting dynamic subtest: pipe-B-LVDS-1
[288.326178] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.409s)
[288.359679] Subtest hang-read-crc: SUCCESS (4.272s)
[289.265447] [121/171] (776s left) kms_pipe_crc_basic (nonblocking-crc)
[289.856856] Starting subtest: nonblocking-crc
[289.900815] Starting dynamic subtest: pipe-A-LVDS-1
[290.561177] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.699s)
[290.603090] Starting dynamic subtest: pipe-B-LVDS-1
[291.898413] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.309s)
[291.940289] Subtest nonblocking-crc: SUCCESS (2.012s)
[292.846303] [122/171] (772s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[293.498737] Starting subtest: nonblocking-crc-frame-sequence
[293.541084] Starting dynamic subtest: pipe-A-LVDS-1
[294.192882] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.695s)
[294.251448] Starting dynamic subtest: pipe-B-LVDS-1
[295.496481] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.310s)
[295.538263] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.010s)
[296.462746] [123/171] (768s left) kms_pipe_crc_basic (read-crc)
[297.137956] Starting subtest: read-crc
[297.179691] Starting dynamic subtest: pipe-A-LVDS-1
[297.731474] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.627s)
[297.781735] Starting dynamic subtest: pipe-B-LVDS-1
[298.926591] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.197s)
[298.968423] Subtest read-crc: SUCCESS (1.829s)
[299.899619] [124/171] (765s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[300.509393] Starting subtest: read-crc-frame-sequence
[300.551647] Starting dynamic subtest: pipe-A-LVDS-1
[301.128456] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.630s)
[301.178723] Starting dynamic subtest: pipe-B-LVDS-1
[302.317133] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.177s)
[302.358920] Subtest read-crc-frame-sequence: SUCCESS (1.811s)
[303.264561] [125/171] (762s left) kms_psr (primary_page_flip)
[303.872546] Subtest primary_page_flip: SKIP (0.000s)
[304.000310] [126/171] (761s left) kms_psr (cursor_plane_move)
[304.474846] Subtest cursor_plane_move: SKIP (0.000s)
[304.588240] [127/171] (761s left) kms_psr (sprite_plane_onoff)
[305.053890] Subtest sprite_plane_onoff: SKIP (0.000s)
[305.148042] [128/171] (761s left) kms_psr (primary_mmap_gtt)
[305.706354] Subtest primary_mmap_gtt: SKIP (0.000s)
[305.816559] [129/171] (760s left) kms_setmode (basic-clone-single-crtc)
[306.283549] Starting subtest: basic-clone-single-crtc
[306.408952] Subtest basic-clone-single-crtc: SKIP (0.001s)
[306.519991] [130/171] (759s left) i915_pm_backlight (basic-brightness)
[307.169774] Subtest basic-brightness: SKIP (0.000s)
[307.333068] [131/171] (759s left) i915_pm_rpm (basic-pci-d3-state)
[309.252526] Subtest basic-pci-d3-state: SKIP (0.000s)
[309.380533] [132/171] (757s left) i915_pm_rpm (basic-rte)
[309.863130] Starting subtest: basic-rte
[311.309683] Subtest basic-rte: SKIP (1.403s)
[311.529352] [133/171] (755s left) i915_pm_rps (basic-api)
[312.071341] Starting subtest: basic-api
[312.104845] Subtest basic-api: SUCCESS (0.003s)
[312.241075] [134/171] (754s left) prime_self_import (basic-llseek-bad)
[312.682161] Starting subtest: basic-llseek-bad
[312.765824] Subtest basic-llseek-bad: SUCCESS (0.002s)
[312.901706] [135/171] (754s left) prime_self_import (basic-llseek-size)
[313.342803] Starting subtest: basic-llseek-size
[313.409626] Subtest basic-llseek-size: SUCCESS (0.003s)
[313.521389] [136/171] (753s left) prime_self_import (basic-with_fd_dup)
[313.904977] Starting subtest: basic-with_fd_dup
[314.005309] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[314.106774] [137/171] (753s left) prime_self_import (basic-with_one_bo)
[314.607602] Starting subtest: basic-with_one_bo
[314.691238] Subtest basic-with_one_bo: SUCCESS (0.004s)
[314.802402] [138/171] (752s left) prime_self_import (basic-with_one_bo_two_files)
[315.243197] Starting subtest: basic-with_one_bo_two_files
[315.343434] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[315.470852] [139/171] (751s left) prime_self_import (basic-with_two_bos)
[315.870534] Starting subtest: basic-with_two_bos
[315.954204] Subtest basic-with_two_bos: SUCCESS (0.004s)
[316.065447] [140/171] (751s left) prime_vgem (basic-fence-flip)
[316.624736] Starting subtest: basic-fence-flip
[316.750562] Subtest basic-fence-flip: SKIP (0.221s)
[317.070755] [141/171] (750s left) prime_vgem (basic-fence-mmap)
[317.613192] Starting subtest: basic-fence-mmap
[317.654607] Subtest basic-fence-mmap: SUCCESS (0.032s)
[317.807940] [142/171] (750s left) prime_vgem (basic-fence-read)
[318.257220] Starting subtest: basic-fence-read
[318.299095] Subtest basic-fence-read: SUCCESS (0.052s)
[318.450994] [143/171] (749s left) prime_vgem (basic-gtt)
[319.061926] Starting subtest: basic-gtt
[319.103674] Subtest basic-gtt: SUCCESS (0.014s)
[319.239875] [144/171] (749s left) prime_vgem (basic-read)
[319.730965] Starting subtest: basic-read
[319.772838] Subtest basic-read: SUCCESS (0.021s)
[319.925574] [145/171] (748s left) prime_vgem (basic-write)
[320.383330] Starting subtest: basic-write
[320.425124] Subtest basic-write: SUCCESS (0.023s)
[320.586688] [146/171] (747s left) vgem_basic (setversion)
[321.102294] Starting subtest: setversion
[321.185924] Subtest setversion: SUCCESS (0.000s)
[321.296719] [147/171] (747s left) vgem_basic (create)
[321.748183] Starting subtest: create
[321.781688] Subtest create: SUCCESS (0.001s)
[321.884382] [148/171] (747s left) vgem_basic (debugfs)
[322.300400] Starting subtest: debugfs
[322.342322] Subtest debugfs: SUCCESS (0.001s)
[322.453106] [149/171] (746s left) vgem_basic (dmabuf-export)
[322.894663] Starting subtest: dmabuf-export
[322.978153] Subtest dmabuf-export: SUCCESS (0.002s)
[323.096744] [150/171] (746s left) vgem_basic (dmabuf-fence)
[323.605377] Starting subtest: dmabuf-fence
[323.647254] Subtest dmabuf-fence: SUCCESS (0.001s)
[323.758315] [151/171] (745s left) vgem_basic (dmabuf-fence-before)
[324.209261] Starting subtest: dmabuf-fence-before
[324.251249] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[324.362064] [152/171] (745s left) vgem_basic (dmabuf-mmap)
[324.861888] Starting subtest: dmabuf-mmap
[324.903738] Subtest dmabuf-mmap: SUCCESS (0.018s)
[325.015235] [153/171] (744s left) vgem_basic (mmap)
[325.722671] Starting subtest: mmap
[325.839731] Subtest mmap: SUCCESS (0.011s)
[326.383781] [154/171] (744s left) vgem_basic (second-client)
[327.370964] Starting subtest: second-client
[327.588112] Subtest second-client: SUCCESS (0.033s)
[327.873682] [155/171] (743s left) vgem_basic (sysfs)
[328.523591] Starting subtest: sysfs
[328.607302] Subtest sysfs: SUCCESS (0.001s)
[328.808583] [156/171] (742s left) core_hotunplug (unbind-rebind)
[329.934941] Starting subtest: unbind-rebind
[331.941872] Subtest unbind-rebind: SUCCESS (1.925s)
[332.544913] [157/171] (739s left) vgem_basic (unload)
[333.671748] Starting subtest: unload
[362.729287] Subtest unload: SUCCESS (29.315s)
[362.881666] [158/171] (709s left) i915_module_load (reload)
[363.664798] Starting subtest: reload
[368.224480] Subtest reload: SUCCESS (4.568s)
[368.426313] [159/171] (704s left) gem_lmem_swapping (basic)
[369.236680] Subtest basic: SKIP (0.000s)
[369.380277] [160/171] (703s left) gem_lmem_swapping (parallel-random-engines)
[369.847512] Subtest parallel-random-engines: SKIP (0.000s)
[369.999734] [161/171] (703s left) gem_lmem_swapping (random-engines)
[370.508140] Subtest random-engines: SKIP (0.000s)
[370.611387] [162/171] (702s left) gem_lmem_swapping (verify-random)
[371.170398] Subtest verify-random: SKIP (0.000s)
[371.380692] [163/171] (702s left) i915_pm_rpm (module-reload)
[373.217333] Subtest module-reload: SKIP (0.000s)
[373.502901] [164/171] (700s left) i915_selftest (live)
[375.032486] Starting subtest: live
[375.074322] Starting dynamic subtest: sanitycheck
[375.902180] Dynamic subtest sanitycheck: SUCCESS (0.907s)
[375.952294] Starting dynamic subtest: uncore
[376.772104] Dynamic subtest uncore: SUCCESS (0.874s)
[376.813998] Starting dynamic subtest: workarounds
[377.693919] Dynamic subtest workarounds: SUCCESS (0.903s)
[377.752456] Starting dynamic subtest: gt_engines
[378.563551] Dynamic subtest gt_engines: SUCCESS (0.854s)
[378.613796] Starting dynamic subtest: gt_timelines
[383.039051] Dynamic subtest gt_timelines: SUCCESS (4.499s)
[383.089279] Starting dynamic subtest: gt_contexts
[383.909590] Dynamic subtest gt_contexts: SUCCESS (0.869s)
[383.951365] Starting dynamic subtest: gt_lrc
[384.746153] Dynamic subtest gt_lrc: SUCCESS (0.834s)
[384.796309] Starting dynamic subtest: gt_mocs
[385.617993] Dynamic subtest gt_mocs: SUCCESS (0.861s)
[385.659860] Starting dynamic subtest: gt_pm
[392.293844] Dynamic subtest gt_pm: SUCCESS (6.671s)
[392.344097] Starting dynamic subtest: gt_heartbeat
[393.249301] Dynamic subtest gt_heartbeat: SUCCESS (0.959s)
[393.291123] Starting dynamic subtest: gt_tlb
[394.111129] Dynamic subtest gt_tlb: SUCCESS (0.857s)
[394.161223] Starting dynamic subtest: requests
[399.546629] Dynamic subtest requests: SUCCESS (5.433s)
[399.596768] Starting dynamic subtest: migrate
[400.500540] Dynamic subtest migrate: SUCCESS (0.939s)
[400.550611] Starting dynamic subtest: active
[401.389297] Dynamic subtest active: SUCCESS (0.894s)
[401.431142] Starting dynamic subtest: objects
[402.884865] Dynamic subtest objects: SUCCESS (1.489s)
[402.935038] Starting dynamic subtest: mman
[407.428880] Dynamic subtest mman: SUCCESS (4.535s)
[407.479043] Starting dynamic subtest: dmabuf
[408.257425] Dynamic subtest dmabuf: SUCCESS (0.829s)
[408.299194] Starting dynamic subtest: vma
[409.103163] Dynamic subtest vma: SUCCESS (0.841s)
[409.203314] Starting dynamic subtest: coherency
[410.099923] Dynamic subtest coherency: SUCCESS (0.999s)
[410.141697] Starting dynamic subtest: gtt
[414.132749] Dynamic subtest gtt: SUCCESS (4.020s)
[414.182862] Starting dynamic subtest: gem
[415.088877] Dynamic subtest gem: SUCCESS (0.959s)
[415.138958] Starting dynamic subtest: evict
[416.042238] Dynamic subtest evict: SUCCESS (0.950s)
[416.092360] Starting dynamic subtest: hugepages
[417.406578] Dynamic subtest hugepages: SUCCESS (1.362s)
[417.456727] Starting dynamic subtest: gem_contexts
[422.157187] Dynamic subtest gem_contexts: SUCCESS (4.751s)
[422.199028] Starting dynamic subtest: client
[422.995786] Dynamic subtest client: SUCCESS (0.824s)
[423.045927] Starting dynamic subtest: gem_migrate
[423.857914] Dynamic subtest gem_migrate: SUCCESS (0.866s)
[423.899730] Starting dynamic subtest: reset
[424.980198] Dynamic subtest reset: SUCCESS (1.115s)
[425.030320] Starting dynamic subtest: memory_region
[425.883773] Dynamic subtest memory_region: SUCCESS (0.906s)
[425.925557] Starting dynamic subtest: hangcheck
[428.439750] Dynamic subtest hangcheck: SUCCESS (2.546s)
[428.541537] Starting dynamic subtest: execlists
[429.394498] Dynamic subtest execlists: SUCCESS (0.957s)
[429.436312] Starting dynamic subtest: ring_submission
[430.297883] Dynamic subtest ring_submission: SUCCESS (0.901s)
[430.348107] Starting dynamic subtest: perf
[431.186686] Dynamic subtest perf: SUCCESS (0.885s)
[431.228464] Starting dynamic subtest: slpc
[432.031661] Dynamic subtest slpc: SUCCESS (0.842s)
[432.081873] Starting dynamic subtest: guc
[433.002031] Dynamic subtest guc: SUCCESS (0.963s)
[433.052292] Starting dynamic subtest: guc_multi_lrc
[433.915751] Dynamic subtest guc_multi_lrc: SUCCESS (0.919s)
[433.966037] Starting dynamic subtest: guc_hang
[434.902525] Dynamic subtest guc_hang: SUCCESS (0.978s)
[434.952658] Starting dynamic subtest: late_gt_pm
[435.822049] Dynamic subtest late_gt_pm: SUCCESS (0.922s)
[435.855824] Subtest live: SUCCESS (60.808s)
[436.049559] [165/171] (637s left) dmabuf (all-tests)
[436.843572] Starting subtest: all-tests
[436.885275] Starting dynamic subtest: sanitycheck
[436.927116] Dynamic subtest sanitycheck: SUCCESS (0.229s)
[436.977413] Starting dynamic subtest: dma_fence
[437.103070] Dynamic subtest dma_fence: SUCCESS (0.175s)
[437.153274] Starting dynamic subtest: dma_fence_chain
[450.887692] Dynamic subtest dma_fence_chain: SUCCESS (13.770s)
[450.937732] Starting dynamic subtest: dma_fence_unwrap
[450.979821] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s)
[451.030125] Starting dynamic subtest: dma_resv
[451.080326] Dynamic subtest dma_resv: SUCCESS (0.075s)
[451.130542] Subtest all-tests: SUCCESS (14.344s)
[451.274999] [166/171] (622s left) i915_suspend (basic-s2idle-without-i915)
[451.807598] Starting subtest: basic-s2idle-without-i915
[472.574361] Subtest basic-s2idle-without-i915: SUCCESS (4.761s)
[474.752307] [167/171] (616s left) i915_suspend (basic-s3-without-i915)
[475.438185] Starting subtest: basic-s3-without-i915
[495.479067] Subtest basic-s3-without-i915: SUCCESS (4.138s)
[497.399945] [168/171] (610s left) gem_exec_suspend (basic-s0)
[498.241423] Starting subtest: basic-S0
[498.274915] Starting dynamic subtest: smem
[517.521016] Dynamic subtest smem: SUCCESS (2.479s)
[517.563090] Subtest basic-S0: SUCCESS (2.480s)
[520.726073] [169/171] (605s left) gem_exec_suspend (basic-s3)
[521.308752] Starting subtest: basic-S3
[521.342306] Starting dynamic subtest: smem
[540.338009] Dynamic subtest smem: SUCCESS (2.799s)
[540.379849] Subtest basic-S3: SUCCESS (2.801s)
[543.501299] [170/171] (600s left) kms_chamelium_hpd (common-hpd-after-suspend)
[544.495239] Subtest common-hpd-after-suspend: SKIP (0.000s)
[545.015924] [171/171] (599s left) kms_pipe_crc_basic (suspend-read-crc)
[545.608280] Starting subtest: suspend-read-crc
[545.650710] Starting dynamic subtest: pipe-A-LVDS-1
[565.748522] Dynamic subtest pipe-A-LVDS-1: SUCCESS (2.793s)
[565.915768] Starting dynamic subtest: pipe-B-LVDS-1
[584.362101] Dynamic subtest pipe-B-LVDS-1: SUCCESS (3.919s)
[584.428965] Subtest suspend-read-crc: SUCCESS (6.717s)
[589.597041] Closing watchdogs
Done.