[96.223105] Initializing watchdogs
[96.223503]   /dev/watchdog0
[96.330110] [001/171] (960s left) i915_module_load (load)
[97.280814] Starting subtest: load
[102.689259] Subtest load: SUCCESS (5.434s)
[103.257919] [002/171] (954s left) core_auth (basic-auth)
[104.075912] Starting subtest: basic-auth
[104.186109] Subtest basic-auth: SUCCESS (0.001s)
[104.495693] [003/171] (953s left) debugfs_test (read_all_entries)
[105.112985] Starting subtest: read_all_entries
[105.188318] Subtest read_all_entries: SUCCESS (0.058s)
[105.608684] [004/171] (952s left) debugfs_test (basic-hwmon)
[106.159468] Starting subtest: basic-hwmon
[106.226526] Subtest basic-hwmon: SKIP (0.000s)
[106.589626] [005/171] (951s left) fbdev (eof)
[107.098679] Starting subtest: eof
[107.140491] Subtest eof: SUCCESS (0.001s)
[107.292121] [006/171] (950s left) fbdev (info)
[107.733938] Starting subtest: info
[107.775854] Subtest info: SUCCESS (0.000s)
[107.918733] [007/171] (950s left) fbdev (nullptr)
[108.344214] Starting subtest: nullptr
[108.377724] Subtest nullptr: SUCCESS (0.000s)
[108.520782] [008/171] (950s left) fbdev (read)
[108.945907] Starting subtest: read
[109.314750] Subtest read: SUCCESS (0.474s)
[109.474371] [009/171] (949s left) fbdev (write)
[109.924895] Starting subtest: write
[109.966759] Subtest write: SUCCESS (0.130s)
[110.126634] [010/171] (948s left) gem_basic (bad-close)
[110.594228] Starting subtest: bad-close
[110.694582] Subtest bad-close: SUCCESS (0.000s)
[110.811905] [011/171] (948s left) gem_basic (create-close)
[111.204505] Starting subtest: create-close
[111.288083] Subtest create-close: SUCCESS (0.000s)
[111.405891] [012/171] (948s left) gem_basic (create-fd-close)
[111.941680] Starting subtest: create-fd-close
[112.025262] Subtest create-fd-close: SUCCESS (0.000s)
[112.126592] [013/171] (947s left) gem_busy (busy@all-engines)
[112.685893] Starting subtest: busy
[112.736131] Starting dynamic subtest: all-engines
[112.786294] Dynamic subtest all-engines: SUCCESS (0.037s)
[112.836484] Subtest busy: SUCCESS (0.037s)
[113.088299] [014/171] (946s left) gem_close_race (basic-process)
[113.705272] Starting subtest: basic-process
[113.747426] Subtest basic-process: SUCCESS (0.042s)
[113.856916] [015/171] (946s left) gem_close_race (basic-threads)
[114.324324] Starting subtest: basic-threads
[115.346670] Subtest basic-threads: SUCCESS (1.156s)
[115.548261] [016/171] (944s left) gem_ctx_create (basic)
[116.090473] Starting subtest: basic
[116.132814] Subtest basic: SUCCESS (0.000s)
[116.250546] [017/171] (943s left) gem_ctx_create (basic-files)
[116.717630] Starting subtest: basic-files
[118.616870] Subtest basic-files: SUCCESS (2.018s)
[118.910534] [018/171] (941s left) gem_ctx_exec (basic)
[119.569982] Starting subtest: basic
[119.603363] Subtest basic: SUCCESS (0.001s)
[119.696276] [019/171] (940s left) gem_exec_basic (basic)
[120.180421] Starting subtest: basic
[120.215716] Starting dynamic subtest: rcs0-smem
[120.257510] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[120.307651] Starting dynamic subtest: bcs0-smem
[120.349472] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[120.399562] Starting dynamic subtest: vcs0-smem
[120.441431] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[120.483280] Subtest basic: SUCCESS (0.001s)
[120.634506] [020/171] (939s left) gem_exec_create (basic)
[121.251528] Starting subtest: basic
[121.293370] Starting dynamic subtest: smem
[123.252579] Dynamic subtest smem: SUCCESS (2.053s)
[123.294560] Subtest basic: SUCCESS (2.053s)
[123.412339] [021/171] (937s left) gem_exec_fence (basic-busy)
[124.155470] Subtest basic-busy: SKIP (0.000s)
[124.541220] [022/171] (936s left) gem_exec_fence (basic-wait)
[125.185778] Subtest basic-wait: SKIP (0.000s)
[125.453973] [023/171] (935s left) gem_exec_fence (basic-await)
[126.013556] Subtest basic-await: SKIP (0.000s)
[126.290288] [024/171] (934s left) gem_exec_fence (nb-await)
[126.866731] Subtest nb-await: SKIP (0.000s)
[127.111661] [025/171] (933s left) gem_exec_gttfill (basic)
[127.637316] Starting subtest: basic
[132.564256] Subtest basic: SUCCESS (5.037s)
[132.782235] [026/171] (928s left) gem_exec_parallel (engines)
[135.133410] Starting subtest: engines
[135.175188] Starting dynamic subtest: basic
[136.675964] Dynamic subtest basic: SUCCESS (1.623s)
[136.726122] Starting dynamic subtest: contexts
[138.460141] Dynamic subtest contexts: SUCCESS (1.828s)
[138.510341] Starting dynamic subtest: fds
[141.061338] Dynamic subtest fds: SUCCESS (2.595s)
[141.111540] Starting dynamic subtest: userptr
[142.845933] Dynamic subtest userptr: SUCCESS (1.737s)
[142.895952] Subtest engines: SUCCESS (7.785s)
[143.064359] [027/171] (918s left) gem_exec_store (basic)
[143.800867] Starting subtest: basic
[143.842698] Subtest basic: SUCCESS (0.038s)
[143.952309] [028/171] (917s left) gem_flink_basic (bad-flink)
[144.461127] Starting subtest: bad-flink
[144.502946] Subtest bad-flink: SUCCESS (0.000s)
[144.612505] [029/171] (916s left) gem_flink_basic (bad-open)
[145.071610] Starting subtest: bad-open
[145.113466] Subtest bad-open: SUCCESS (0.000s)
[145.214275] [030/171] (916s left) gem_flink_basic (basic)
[145.615268] Starting subtest: basic
[145.648786] Subtest basic: SUCCESS (0.000s)
[145.751508] [031/171] (916s left) gem_flink_basic (double-flink)
[146.218866] Starting subtest: double-flink
[146.260670] Subtest double-flink: SUCCESS (0.000s)
[146.370265] [032/171] (915s left) gem_flink_basic (flink-lifetime)
[146.837630] Starting subtest: flink-lifetime
[146.871141] Subtest flink-lifetime: SUCCESS (0.001s)
[146.972398] [033/171] (915s left) gem_huc_copy (huc-copy)
[147.514833] Subtest huc-copy: SKIP (0.000s)
[147.640934] [034/171] (914s left) gem_linear_blits (basic)
[148.191736] Starting subtest: basic
[148.333546] Subtest basic: SUCCESS (0.009s)
[148.768302] [035/171] (913s left) gem_mmap (basic)
[151.087510] Starting subtest: basic
[151.304688] Subtest basic: SUCCESS (0.000s)
[151.405772] [036/171] (911s left) gem_mmap_gtt (basic)
[151.914873] Starting subtest: basic
[151.956717] Subtest basic: SUCCESS (0.001s)
[152.074518] [037/171] (911s left) gem_render_linear_blits (basic)
[152.600564] Starting subtest: basic
[152.809444] Subtest basic: SUCCESS (0.023s)
[152.918974] [038/171] (910s left) gem_render_tiled_blits (basic)
[153.436289] Starting subtest: basic
[153.697118] Subtest basic: SUCCESS (0.030s)
[153.806596] [039/171] (910s left) gem_ringfill (basic-all)
[154.340470] Starting subtest: basic-all
[155.416460] Subtest basic-all: SUCCESS (1.102s)
[155.525664] [040/171] (908s left) gem_softpin (allocator-basic)
[156.026596] Subtest allocator-basic: SKIP (0.000s)
[156.177852] [041/171] (908s left) gem_softpin (allocator-basic-reserve)
[156.653938] Subtest allocator-basic-reserve: SKIP (0.000s)
[156.821889] [042/171] (908s left) gem_softpin (safe-alignment)
[157.299480] Starting subtest: safe-alignment
[157.332756] Subtest safe-alignment: SUCCESS (0.008s)
[157.433782] [043/171] (907s left) gem_sync (basic-all)
[158.043045] Starting subtest: basic-all
[159.860880] Subtest basic-all: SUCCESS (2.026s)
[160.053911] [044/171] (905s left) gem_sync (basic-each)
[160.637964] Starting subtest: basic-each
[162.655939] Subtest basic-each: SUCCESS (2.100s)
[162.798794] [045/171] (902s left) gem_tiled_blits (basic)
[163.409685] Starting subtest: basic
[163.484988] Subtest basic: SUCCESS (0.015s)
[163.969422] [046/171] (901s left) gem_tiled_fence_blits (basic)
[166.404096] Starting subtest: basic
[166.537503] Subtest basic: SUCCESS (0.008s)
[166.980421] [047/171] (898s left) gem_tiled_pread_basic
[169.340665] [048/171] (896s left) gem_wait (busy@all-engines)
[169.832777] Starting subtest: busy
[169.874559] Starting dynamic subtest: all-engines
[170.242164] Dynamic subtest all-engines: SUCCESS (0.514s)
[170.283697] Subtest busy: SUCCESS (0.514s)
[170.520597] [049/171] (895s left) gem_wait (wait@all-engines)
[171.029556] Starting subtest: wait
[171.071390] Starting dynamic subtest: all-engines
[171.980732] Dynamic subtest all-engines: SUCCESS (1.034s)
[172.022137] Subtest wait: SUCCESS (1.034s)
[172.173462] [050/171] (893s left) i915_getparams_basic (basic-eu-total)
[172.707889] Starting subtest: basic-eu-total
[172.791587] Subtest basic-eu-total: SUCCESS (0.000s)
[172.884443] [051/171] (893s left) i915_getparams_basic (basic-subslice-total)
[173.368303] Starting subtest: basic-subslice-total
[173.468616] Subtest basic-subslice-total: SUCCESS (0.000s)
[173.586408] [052/171] (892s left) i915_hangman (error-state-basic)
[174.163379] Starting subtest: error-state-basic
[174.263879] Subtest error-state-basic: SUCCESS (0.005s)
[174.473533] [053/171] (892s left) i915_pciid
[175.141928] [054/171] (891s left) kms_addfb_basic (addfb25-bad-modifier)
[175.701063] Starting subtest: addfb25-bad-modifier
[175.734640] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[176.313478] [055/171] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[176.832600] Starting subtest: addfb25-framebuffer-vs-set-tiling
[176.866026] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[177.252753] [056/171] (889s left) kms_addfb_basic (addfb25-modifier-no-flag)
[177.761712] Starting subtest: addfb25-modifier-no-flag
[177.803620] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[178.189907] [057/171] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[178.700620] Starting subtest: addfb25-x-tiled-legacy
[178.734181] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[179.179112] [058/171] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[179.679890] Starting subtest: addfb25-x-tiled-mismatch-legacy
[179.721792] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[180.091491] [059/171] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[180.736348] Starting subtest: addfb25-yf-tiled-legacy
[180.778243] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[181.089232] [060/171] (886s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[181.698772] Starting subtest: addfb25-y-tiled-legacy
[181.740698] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[182.009952] [061/171] (885s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[182.579266] Starting subtest: addfb25-y-tiled-small-legacy
[182.663045] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[182.898643] [062/171] (884s left) kms_addfb_basic (bad-pitch-0)
[183.441312] Starting subtest: bad-pitch-0
[183.475384] Subtest bad-pitch-0: SUCCESS (0.000s)
[183.844053] [063/171] (884s left) kms_addfb_basic (bad-pitch-1024)
[184.363910] Starting subtest: bad-pitch-1024
[184.405849] Subtest bad-pitch-1024: SUCCESS (0.000s)
[184.750399] [064/171] (883s left) kms_addfb_basic (bad-pitch-128)
[185.301207] Starting subtest: bad-pitch-128
[185.343103] Subtest bad-pitch-128: SUCCESS (0.000s)
[185.712641] [065/171] (882s left) kms_addfb_basic (bad-pitch-256)
[186.215654] Starting subtest: bad-pitch-256
[186.257523] Subtest bad-pitch-256: SUCCESS (0.000s)
[186.635368] [066/171] (881s left) kms_addfb_basic (bad-pitch-32)
[187.153259] Starting subtest: bad-pitch-32
[187.195170] Subtest bad-pitch-32: SUCCESS (0.000s)
[187.556798] [067/171] (880s left) kms_addfb_basic (bad-pitch-63)
[188.142510] Starting subtest: bad-pitch-63
[188.184450] Subtest bad-pitch-63: SUCCESS (0.000s)
[188.554252] [068/171] (879s left) kms_addfb_basic (bad-pitch-65536)
[189.063623] Starting subtest: bad-pitch-65536
[189.105384] Subtest bad-pitch-65536: SUCCESS (0.000s)
[189.524880] [069/171] (879s left) kms_addfb_basic (bad-pitch-999)
[190.044455] Starting subtest: bad-pitch-999
[190.086367] Subtest bad-pitch-999: SUCCESS (0.000s)
[190.563708] [070/171] (878s left) kms_addfb_basic (basic)
[191.114575] Starting subtest: basic
[191.164857] Subtest basic: SUCCESS (0.000s)
[191.517490] [071/171] (877s left) kms_addfb_basic (basic-x-tiled-legacy)
[192.068252] Starting subtest: basic-x-tiled-legacy
[192.111620] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[192.498399] [072/171] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[193.049318] Starting subtest: basic-y-tiled-legacy
[193.099588] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[193.469269] [073/171] (875s left) kms_addfb_basic (bo-too-small)
[194.106035] Starting subtest: bo-too-small
[194.147917] Subtest bo-too-small: SUCCESS (0.000s)
[194.466838] [074/171] (874s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[195.184787] Starting subtest: bo-too-small-due-to-tiling
[195.226701] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[195.487321] [075/171] (874s left) kms_addfb_basic (clobberred-modifier)
[195.988194] Starting subtest: clobberred-modifier
[196.021608] Subtest clobberred-modifier: SUCCESS (0.000s)
[196.426348] [076/171] (873s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[196.985809] Starting subtest: framebuffer-vs-set-tiling
[197.027759] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[197.422580] [077/171] (872s left) kms_addfb_basic (invalid-get-prop)
[197.915183] Starting subtest: invalid-get-prop
[197.957091] Subtest invalid-get-prop: SUCCESS (0.000s)
[198.387088] [078/171] (871s left) kms_addfb_basic (invalid-get-prop-any)
[198.888086] Starting subtest: invalid-get-prop-any
[198.921534] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[199.357580] [079/171] (870s left) kms_addfb_basic (invalid-set-prop)
[199.900480] Starting subtest: invalid-set-prop
[199.942365] Subtest invalid-set-prop: SUCCESS (0.000s)
[200.297292] [080/171] (869s left) kms_addfb_basic (invalid-set-prop-any)
[200.730858] Starting subtest: invalid-set-prop-any
[200.772734] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[201.151433] [081/171] (869s left) kms_addfb_basic (no-handle)
[201.701968] Starting subtest: no-handle
[201.743852] Subtest no-handle: SUCCESS (0.000s)
[202.115742] [082/171] (868s left) kms_addfb_basic (size-max)
[202.733370] Starting subtest: size-max
[202.775268] Subtest size-max: SUCCESS (0.000s)
[203.086514] [083/171] (867s left) kms_addfb_basic (small-bo)
[203.779267] Starting subtest: small-bo
[203.821130] Subtest small-bo: SUCCESS (0.000s)
[204.108827] [084/171] (866s left) kms_addfb_basic (tile-pitch-mismatch)
[204.618275] Starting subtest: tile-pitch-mismatch
[204.660179] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[205.013486] [085/171] (865s left) kms_addfb_basic (too-high)
[205.648048] Starting subtest: too-high
[205.681664] Subtest too-high: SUCCESS (0.001s)
[205.928222] [086/171] (864s left) kms_addfb_basic (too-wide)
[206.645992] Starting subtest: too-wide
[206.687818] Subtest too-wide: SUCCESS (0.000s)
[206.949192] [087/171] (863s left) kms_addfb_basic (unused-handle)
[207.457931] Starting subtest: unused-handle
[207.491707] Subtest unused-handle: SUCCESS (0.000s)
[207.912843] [088/171] (862s left) kms_addfb_basic (unused-modifier)
[208.447043] Starting subtest: unused-modifier
[208.480565] Subtest unused-modifier: SUCCESS (0.000s)
[208.850880] [089/171] (862s left) kms_addfb_basic (unused-offsets)
[209.443373] Starting subtest: unused-offsets
[209.485251] Subtest unused-offsets: SUCCESS (0.000s)
[209.841348] [090/171] (861s left) kms_addfb_basic (unused-pitches)
[210.391714] Starting subtest: unused-pitches
[210.433631] Subtest unused-pitches: SUCCESS (0.000s)
[210.795083] [091/171] (860s left) kms_busy (basic)
[211.529860] Starting subtest: basic
[211.588274] Starting dynamic subtest: flip
[215.816973] Dynamic subtest flip: SUCCESS (4.368s)
[215.867147] Starting dynamic subtest: modeset
[218.172389] Dynamic subtest modeset: SUCCESS (2.314s)
[218.222648] Subtest basic: SUCCESS (6.684s)
[219.103252] [092/171] (852s left) kms_chamelium_hpd (dp-hpd-fast)
[220.104322] Subtest dp-hpd-fast: SKIP (0.000s)
[220.882820] [093/171] (850s left) kms_chamelium_edid (dp-edid-read)
[221.852704] Subtest dp-edid-read: SKIP (0.000s)
[222.664549] [094/171] (848s left) kms_chamelium_frames (dp-crc-fast)
[223.632700] Subtest dp-crc-fast: SKIP (0.000s)
[224.453317] [095/171] (847s left) kms_chamelium_hpd (hdmi-hpd-fast)
[225.405813] Subtest hdmi-hpd-fast: SKIP (0.000s)
[226.183644] [096/171] (845s left) kms_chamelium_edid (hdmi-edid-read)
[227.044244] Subtest hdmi-edid-read: SKIP (0.000s)
[227.899953] [097/171] (843s left) kms_chamelium_frames (hdmi-crc-fast)
[228.851159] Subtest hdmi-crc-fast: SKIP (0.000s)
[229.655138] [098/171] (842s left) kms_chamelium_hpd (vga-hpd-fast)
[230.589405] Subtest vga-hpd-fast: SKIP (0.000s)
[231.352898] [099/171] (840s left) kms_chamelium_edid (vga-edid-read)
[232.271227] Subtest vga-edid-read: SKIP (0.000s)
[233.099532] [100/171] (839s left) kms_prop_blob (basic)
[233.808129] Starting subtest: basic
[233.850236] Subtest basic: SUCCESS (0.000s)
[233.961981] [101/171] (838s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[234.529137] Starting subtest: basic-busy-flip-before-cursor-atomic
[235.721977] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.196s)
[236.709772] [102/171] (835s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[237.276931] Starting subtest: basic-busy-flip-before-cursor-legacy
[238.471680] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.179s)
[239.393203] [103/171] (833s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[240.002129] Starting subtest: basic-flip-after-cursor-atomic
[241.161620] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.194s)
[242.109497] [104/171] (830s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[242.710106] Starting subtest: basic-flip-after-cursor-legacy
[243.953371] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.225s)
[244.868480] [105/171] (828s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[245.476615] Starting subtest: basic-flip-after-cursor-varying-size
[246.694791] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.196s)
[247.699174] [106/171] (825s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[248.368273] Starting subtest: basic-flip-before-cursor-atomic
[249.594777] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.212s)
[250.483472] [107/171] (822s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[251.075101] Starting subtest: basic-flip-before-cursor-legacy
[252.259603] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.203s)
[253.183409] [108/171] (819s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[253.858847] Starting subtest: basic-flip-before-cursor-varying-size
[255.009920] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.183s)
[255.983441] [109/171] (817s left) kms_flip (basic-flip-vs-dpms)
[256.515948] Starting subtest: basic-flip-vs-dpms
[256.557794] Starting dynamic subtest: A-LVDS1
[258.269757] Dynamic subtest A-LVDS1: SUCCESS (1.817s)
[258.328339] Starting dynamic subtest: B-LVDS1
[259.741809] Dynamic subtest B-LVDS1: SUCCESS (1.491s)
[259.792090] Starting dynamic subtest: A-VGA1
[260.472472] Dynamic subtest A-VGA1: SUCCESS (0.707s)
[260.522762] Starting dynamic subtest: B-VGA1
[261.204411] Dynamic subtest B-VGA1: SUCCESS (0.711s)
[261.254597] Subtest basic-flip-vs-dpms: SUCCESS (4.741s)
[261.641326] [110/171] (811s left) kms_flip (basic-flip-vs-modeset)
[262.244223] Starting subtest: basic-flip-vs-modeset
[262.286056] Starting dynamic subtest: A-LVDS1
[263.948115] Dynamic subtest A-LVDS1: SUCCESS (1.789s)
[263.990058] Starting dynamic subtest: B-LVDS1
[265.442949] Dynamic subtest B-LVDS1: SUCCESS (1.486s)
[265.493194] Starting dynamic subtest: A-VGA1
[266.207930] Dynamic subtest A-VGA1: SUCCESS (0.739s)
[266.249860] Starting dynamic subtest: B-VGA1
[266.912145] Dynamic subtest B-VGA1: SUCCESS (0.738s)
[266.954051] Subtest basic-flip-vs-modeset: SUCCESS (4.764s)
[267.367481] [111/171] (806s left) kms_flip (basic-flip-vs-wf_vblank)
[267.976968] Starting subtest: basic-flip-vs-wf_vblank
[268.018826] Starting dynamic subtest: A-LVDS1
[269.704568] Dynamic subtest A-LVDS1: SUCCESS (1.796s)
[269.754788] Starting dynamic subtest: B-LVDS1
[271.683606] Dynamic subtest B-LVDS1: SUCCESS (1.961s)
[271.734067] Starting dynamic subtest: A-VGA1
[272.869181] Dynamic subtest A-VGA1: SUCCESS (1.224s)
[272.919481] Starting dynamic subtest: B-VGA1
[273.879342] Dynamic subtest B-VGA1: SUCCESS (0.993s)
[273.929576] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.987s)
[274.375167] [112/171] (799s left) kms_flip (basic-plain-flip)
[275.002553] Starting subtest: basic-plain-flip
[275.044416] Starting dynamic subtest: A-LVDS1
[276.529584] Dynamic subtest A-LVDS1: SUCCESS (1.565s)
[276.588361] Starting dynamic subtest: B-LVDS1
[278.015124] Dynamic subtest B-LVDS1: SUCCESS (1.496s)
[278.065370] Starting dynamic subtest: A-VGA1
[278.950385] Dynamic subtest A-VGA1: SUCCESS (0.932s)
[279.000645] Starting dynamic subtest: B-VGA1
[279.635075] Dynamic subtest B-VGA1: SUCCESS (0.685s)
[279.678617] Subtest basic-plain-flip: SUCCESS (4.692s)
[280.115405] [113/171] (793s left) kms_force_connector_basic (force-connector-state)
[280.691378] Starting subtest: force-connector-state
[281.151085] Subtest force-connector-state: SUCCESS (0.554s)
[282.368427] [114/171] (791s left) kms_force_connector_basic (force-edid)
[282.975350] Starting subtest: force-edid
[283.084201] Subtest force-edid: SUCCESS (0.225s)
[283.648804] [115/171] (790s left) kms_force_connector_basic (force-load-detect)
[284.241431] Starting subtest: force-load-detect
[284.525705] Subtest force-load-detect: SUCCESS (0.411s)
[285.105300] [116/171] (788s left) kms_force_connector_basic (prune-stale-modes)
[285.714443] Starting subtest: prune-stale-modes
[285.764656] Subtest prune-stale-modes: SUCCESS (0.022s)
[286.287106] [117/171] (787s left) kms_frontbuffer_tracking (basic)
[287.030176] Starting subtest: basic
[289.173461] Subtest basic: SUCCESS (2.270s)
[289.544217] [118/171] (784s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[290.229545] Starting subtest: compare-crc-sanitycheck-xr24
[290.271730] Starting dynamic subtest: pipe-A-LVDS-1
[290.797900] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.527s)
[290.848100] Starting dynamic subtest: pipe-B-LVDS-1
[291.641807] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.867s)
[291.675386] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.401s)
[292.563474] [119/171] (781s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[293.231553] Starting subtest: compare-crc-sanitycheck-nv12
[293.273479] Starting dynamic subtest: pipe-A-LVDS-1
[293.357261] Dynamic subtest pipe-A-LVDS-1: SKIP (0.000s)
[293.407481] Starting dynamic subtest: pipe-B-LVDS-1
[293.491622] Dynamic subtest pipe-B-LVDS-1: SKIP (0.000s)
[293.575256] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[293.728543] [120/171] (780s left) kms_pipe_crc_basic (hang-read-crc)
[294.277486] Starting subtest: hang-read-crc
[294.319404] Starting dynamic subtest: pipe-A-LVDS-1
[296.141885] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.879s)
[296.192145] Starting dynamic subtest: pipe-B-LVDS-1
[298.539617] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.414s)
[298.581397] Subtest hang-read-crc: SUCCESS (4.298s)
[299.487671] [121/171] (774s left) kms_pipe_crc_basic (nonblocking-crc)
[300.196751] Starting subtest: nonblocking-crc
[300.238945] Starting dynamic subtest: pipe-A-LVDS-1
[300.915681] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.702s)
[300.965852] Starting dynamic subtest: pipe-B-LVDS-1
[302.185169] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.279s)
[302.220340] Subtest nonblocking-crc: SUCCESS (1.985s)
[303.233817] [122/171] (771s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[303.808539] Starting subtest: nonblocking-crc-frame-sequence
[303.858701] Starting dynamic subtest: pipe-A-LVDS-1
[304.527178] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.723s)
[304.585714] Starting dynamic subtest: pipe-B-LVDS-1
[305.798561] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.276s)
[305.840421] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.004s)
[306.770328] [123/171] (767s left) kms_pipe_crc_basic (read-crc)
[307.412146] Starting subtest: read-crc
[307.454071] Starting dynamic subtest: pipe-A-LVDS-1
[308.049196] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.641s)
[308.107737] Starting dynamic subtest: pipe-B-LVDS-1
[309.227068] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.179s)
[309.268815] Subtest read-crc: SUCCESS (1.825s)
[310.165527] [124/171] (764s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[310.807234] Starting subtest: read-crc-frame-sequence
[310.849126] Starting dynamic subtest: pipe-A-LVDS-1
[311.452497] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.635s)
[311.494395] Starting dynamic subtest: pipe-B-LVDS-1
[312.622095] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.175s)
[312.755637] Subtest read-crc-frame-sequence: SUCCESS (1.815s)
[313.560400] [125/171] (761s left) kms_psr (primary_page_flip)
[314.228585] Subtest primary_page_flip: SKIP (0.000s)
[314.330367] [126/171] (760s left) kms_psr (cursor_plane_move)
[314.805637] Subtest cursor_plane_move: SKIP (0.000s)
[314.925359] [127/171] (760s left) kms_psr (sprite_plane_onoff)
[315.399314] Subtest sprite_plane_onoff: SKIP (0.000s)
[315.519311] [128/171] (759s left) kms_psr (primary_mmap_gtt)
[316.001307] Subtest primary_mmap_gtt: SKIP (0.000s)
[316.120660] [129/171] (759s left) kms_setmode (basic-clone-single-crtc)
[316.636466] Starting subtest: basic-clone-single-crtc
[316.755200] Subtest basic-clone-single-crtc: SKIP (0.001s)
[316.857757] [130/171] (759s left) i915_pm_backlight (basic-brightness)
[317.457355] Subtest basic-brightness: SKIP (0.000s)
[317.676054] [131/171] (758s left) i915_pm_rpm (basic-pci-d3-state)
[319.679323] Subtest basic-pci-d3-state: SKIP (0.000s)
[319.807808] [132/171] (756s left) i915_pm_rpm (basic-rte)
[320.249456] Starting subtest: basic-rte
[321.677058] Subtest basic-rte: SKIP (1.386s)
[321.912680] [133/171] (754s left) i915_pm_rps (basic-api)
[322.387511] Starting subtest: basic-api
[322.429481] Subtest basic-api: SUCCESS (0.004s)
[322.590510] [134/171] (753s left) prime_self_import (basic-llseek-bad)
[323.056185] Starting subtest: basic-llseek-bad
[323.139833] Subtest basic-llseek-bad: SUCCESS (0.002s)
[323.250271] [135/171] (753s left) prime_self_import (basic-llseek-size)
[323.651554] Starting subtest: basic-llseek-size
[323.751877] Subtest basic-llseek-size: SUCCESS (0.003s)
[323.871415] [136/171] (753s left) prime_self_import (basic-with_fd_dup)
[324.528762] Starting subtest: basic-with_fd_dup
[324.762316] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[325.155678] [137/171] (752s left) prime_self_import (basic-with_one_bo)
[325.914990] Starting subtest: basic-with_one_bo
[326.157162] Subtest basic-with_one_bo: SUCCESS (0.005s)
[326.443986] [138/171] (751s left) prime_self_import (basic-with_one_bo_two_files)
[327.261431] Starting subtest: basic-with_one_bo_two_files
[327.411675] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[327.671835] [139/171] (751s left) prime_self_import (basic-with_two_bos)
[328.171789] Starting subtest: basic-with_two_bos
[328.330431] Subtest basic-with_two_bos: SUCCESS (0.003s)
[328.699274] [140/171] (750s left) prime_vgem (basic-fence-flip)
[329.774219] Starting subtest: basic-fence-flip
[329.966494] Subtest basic-fence-flip: SKIP (0.228s)
[330.327725] [141/171] (749s left) prime_vgem (basic-fence-mmap)
[331.152387] Starting subtest: basic-fence-mmap
[331.304752] Subtest basic-fence-mmap: SUCCESS (0.031s)
[331.590615] [142/171] (748s left) prime_vgem (basic-fence-read)
[332.273838] Starting subtest: basic-fence-read
[332.349056] Subtest basic-fence-read: SUCCESS (0.045s)
[332.650473] [143/171] (747s left) prime_vgem (basic-gtt)
[333.267503] Starting subtest: basic-gtt
[333.367807] Subtest basic-gtt: SUCCESS (0.014s)
[333.737736] [144/171] (746s left) prime_vgem (basic-read)
[334.536642] Starting subtest: basic-read
[334.611780] Subtest basic-read: SUCCESS (0.021s)
[334.946925] [145/171] (745s left) prime_vgem (basic-write)
[335.657629] Starting subtest: basic-write
[335.741182] Subtest basic-write: SUCCESS (0.022s)
[336.027848] [146/171] (744s left) vgem_basic (setversion)
[336.660187] Starting subtest: setversion
[336.777120] Subtest setversion: SUCCESS (0.000s)
[337.030375] [147/171] (743s left) vgem_basic (create)
[337.629265] Starting subtest: create
[337.721188] Subtest create: SUCCESS (0.000s)
[337.982789] [148/171] (742s left) vgem_basic (debugfs)
[338.473096] Starting subtest: debugfs
[338.606664] Subtest debugfs: SUCCESS (0.000s)
[338.801144] [149/171] (742s left) vgem_basic (dmabuf-export)
[339.401808] Starting subtest: dmabuf-export
[339.535418] Subtest dmabuf-export: SUCCESS (0.002s)
[339.820768] [150/171] (742s left) vgem_basic (dmabuf-fence)
[340.354071] Starting subtest: dmabuf-fence
[340.420970] Subtest dmabuf-fence: SUCCESS (0.001s)
[340.714947] [151/171] (741s left) vgem_basic (dmabuf-fence-before)
[341.232232] Starting subtest: dmabuf-fence-before
[341.265578] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[341.477080] [152/171] (741s left) vgem_basic (dmabuf-mmap)
[341.976184] Starting subtest: dmabuf-mmap
[342.026302] Subtest dmabuf-mmap: SUCCESS (0.018s)
[342.269949] [153/171] (740s left) vgem_basic (mmap)
[342.761655] Starting subtest: mmap
[342.820369] Subtest mmap: SUCCESS (0.011s)
[343.040179] [154/171] (740s left) vgem_basic (second-client)
[343.590729] Starting subtest: second-client
[343.657689] Subtest second-client: SUCCESS (0.034s)
[343.844452] [155/171] (739s left) vgem_basic (sysfs)
[344.393383] Starting subtest: sysfs
[344.451898] Subtest sysfs: SUCCESS (0.001s)
[344.662256] [156/171] (739s left) core_hotunplug (unbind-rebind)
[345.537114] Starting subtest: unbind-rebind
[347.126506] Subtest unbind-rebind: SUCCESS (1.512s)
[347.753579] [157/171] (736s left) vgem_basic (unload)
[348.538108] Starting subtest: unload
[377.442240] Subtest unload: SUCCESS (29.193s)
[377.688464] [158/171] (707s left) i915_module_load (reload)
[378.413343] Starting subtest: reload
[383.409954] Subtest reload: SUCCESS (5.151s)
[383.695541] [159/171] (701s left) gem_lmem_swapping (basic)
[384.598561] Subtest basic: SKIP (0.000s)
[384.732927] [160/171] (700s left) gem_lmem_swapping (parallel-random-engines)
[385.358858] Subtest parallel-random-engines: SKIP (0.000s)
[385.526928] [161/171] (699s left) gem_lmem_swapping (random-engines)
[386.286156] Subtest random-engines: SKIP (0.000s)
[386.479649] [162/171] (699s left) gem_lmem_swapping (verify-random)
[387.088288] Subtest verify-random: SKIP (0.000s)
[387.292683] [163/171] (698s left) i915_pm_rpm (module-reload)
[389.343554] Subtest module-reload: SKIP (0.000s)
[389.596901] [164/171] (696s left) i915_selftest (live)
[391.072519] Starting subtest: live
[391.114385] Starting dynamic subtest: sanitycheck
[391.942995] Dynamic subtest sanitycheck: SUCCESS (0.876s)
[391.993110] Starting dynamic subtest: uncore
[392.770572] Dynamic subtest uncore: SUCCESS (0.823s)
[392.820726] Starting dynamic subtest: workarounds
[393.631544] Dynamic subtest workarounds: SUCCESS (0.870s)
[393.731980] Starting dynamic subtest: gt_engines
[394.461588] Dynamic subtest gt_engines: SUCCESS (0.839s)
[394.511773] Starting dynamic subtest: gt_timelines
[398.807887] Dynamic subtest gt_timelines: SUCCESS (4.340s)
[398.866270] Starting dynamic subtest: gt_contexts
[399.727327] Dynamic subtest gt_contexts: SUCCESS (0.914s)
[399.777374] Starting dynamic subtest: gt_lrc
[400.580438] Dynamic subtest gt_lrc: SUCCESS (0.857s)
[400.630577] Starting dynamic subtest: gt_mocs
[401.492146] Dynamic subtest gt_mocs: SUCCESS (0.911s)
[401.550148] Starting dynamic subtest: gt_pm
[408.408885] Dynamic subtest gt_pm: SUCCESS (6.907s)
[408.467274] Starting dynamic subtest: gt_heartbeat
[409.287265] Dynamic subtest gt_heartbeat: SUCCESS (0.884s)
[409.337369] Starting dynamic subtest: gt_tlb
[410.208476] Dynamic subtest gt_tlb: SUCCESS (0.919s)
[410.266953] Starting dynamic subtest: requests
[415.856282] Dynamic subtest requests: SUCCESS (5.637s)
[415.906360] Starting dynamic subtest: migrate
[416.786205] Dynamic subtest migrate: SUCCESS (0.943s)
[416.836235] Starting dynamic subtest: active
[417.680700] Dynamic subtest active: SUCCESS (0.884s)
[417.730997] Starting dynamic subtest: objects
[419.327864] Dynamic subtest objects: SUCCESS (1.645s)
[419.377978] Starting dynamic subtest: mman
[424.042533] Dynamic subtest mman: SUCCESS (4.710s)
[424.100977] Starting dynamic subtest: dmabuf
[424.897825] Dynamic subtest dmabuf: SUCCESS (0.855s)
[424.956229] Starting dynamic subtest: vma
[425.751230] Dynamic subtest vma: SUCCESS (0.850s)
[425.809681] Starting dynamic subtest: coherency
[427.604260] Dynamic subtest coherency: SUCCESS (1.854s)
[427.656054] Starting dynamic subtest: gtt
[431.945438] Dynamic subtest gtt: SUCCESS (4.337s)
[431.995604] Starting dynamic subtest: gem
[433.034298] Dynamic subtest gem: SUCCESS (1.081s)
[433.084558] Starting dynamic subtest: evict
[433.953934] Dynamic subtest evict: SUCCESS (0.921s)
[434.004080] Starting dynamic subtest: hugepages
[435.407502] Dynamic subtest hugepages: SUCCESS (1.453s)
[435.457576] Starting dynamic subtest: gem_contexts
[440.090551] Dynamic subtest gem_contexts: SUCCESS (4.676s)
[440.140642] Starting dynamic subtest: client
[441.045619] Dynamic subtest client: SUCCESS (0.948s)
[441.095676] Starting dynamic subtest: gem_migrate
[441.965624] Dynamic subtest gem_migrate: SUCCESS (0.920s)
[442.015707] Starting dynamic subtest: reset
[443.094074] Dynamic subtest reset: SUCCESS (1.129s)
[443.144120] Starting dynamic subtest: memory_region
[444.007372] Dynamic subtest memory_region: SUCCESS (0.915s)
[444.057488] Starting dynamic subtest: hangcheck
[446.545371] Dynamic subtest hangcheck: SUCCESS (2.532s)
[446.603850] Starting dynamic subtest: execlists
[447.407983] Dynamic subtest execlists: SUCCESS (0.860s)
[447.466343] Starting dynamic subtest: ring_submission
[448.335956] Dynamic subtest ring_submission: SUCCESS (0.926s)
[448.386027] Starting dynamic subtest: perf
[449.172724] Dynamic subtest perf: SUCCESS (0.839s)
[449.222857] Starting dynamic subtest: slpc
[450.019292] Dynamic subtest slpc: SUCCESS (0.834s)
[450.069394] Starting dynamic subtest: guc
[450.947790] Dynamic subtest guc: SUCCESS (0.929s)
[450.997884] Starting dynamic subtest: guc_multi_lrc
[452.000748] Dynamic subtest guc_multi_lrc: SUCCESS (0.945s)
[452.051023] Starting dynamic subtest: guc_hang
[452.772167] Dynamic subtest guc_hang: SUCCESS (0.880s)
[452.822172] Starting dynamic subtest: late_gt_pm
[453.583620] Dynamic subtest late_gt_pm: SUCCESS (0.806s)
[453.625424] Subtest live: SUCCESS (62.541s)
[453.820186] [165/171] (632s left) dmabuf (all-tests)
[454.577999] Starting subtest: all-tests
[454.613194] Starting dynamic subtest: sanitycheck
[454.696765] Dynamic subtest sanitycheck: SUCCESS (0.118s)
[454.738819] Starting dynamic subtest: dma_fence
[454.830689] Dynamic subtest dma_fence: SUCCESS (0.173s)
[454.872557] Starting dynamic subtest: dma_fence_chain
[468.974887] Dynamic subtest dma_fence_chain: SUCCESS (14.141s)
[469.024963] Starting dynamic subtest: dma_fence_unwrap
[469.067068] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s)
[469.117297] Starting dynamic subtest: dma_resv
[469.159218] Dynamic subtest dma_resv: SUCCESS (0.066s)
[469.200942] Subtest all-tests: SUCCESS (14.586s)
[469.311968] [166/171] (617s left) i915_suspend (basic-s2idle-without-i915)
[469.861179] Starting subtest: basic-s2idle-without-i915
[490.760767] Subtest basic-s2idle-without-i915: SUCCESS (6.753s)
[493.090847] [167/171] (609s left) i915_suspend (basic-s3-without-i915)
[493.741270] Starting subtest: basic-s3-without-i915
[513.730510] Subtest basic-s3-without-i915: SUCCESS (5.689s)
[516.075624] [168/171] (603s left) gem_exec_suspend (basic-s0)
[516.876405] Starting subtest: basic-S0
[516.918231] Starting dynamic subtest: smem
[536.301117] Dynamic subtest smem: SUCCESS (4.389s)
[536.334646] Subtest basic-S0: SUCCESS (4.391s)
[537.987595] [169/171] (598s left) gem_exec_suspend (basic-s3)
[538.554046] Starting subtest: basic-S3
[538.595792] Starting dynamic subtest: smem
[557.365043] Dynamic subtest smem: SUCCESS (4.524s)
[557.406814] Subtest basic-S3: SUCCESS (4.525s)
[559.594139] [170/171] (593s left) kms_chamelium_hpd (common-hpd-after-suspend)
[560.420681] Subtest common-hpd-after-suspend: SKIP (0.000s)
[561.000036] [171/171] (591s left) kms_pipe_crc_basic (suspend-read-crc)
[561.574687] Starting subtest: suspend-read-crc
[561.616874] Starting dynamic subtest: pipe-A-LVDS-1
[581.373564] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.570s)
[581.423688] Starting dynamic subtest: pipe-B-LVDS-1
[601.451905] Dynamic subtest pipe-B-LVDS-1: SUCCESS (4.984s)
[601.493759] Subtest suspend-read-crc: SUCCESS (9.559s)
[603.798078] Closing watchdogs
Done.