[109.722475] Initializing watchdogs
[109.724133]   /dev/watchdog0
[109.948671] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:a001 Intel Pineview (Gen3) Atom Processor D4xx/D5xx/N4xx/N5xx Integrated Graphics Controller (DeskTop Board D510MO)
[110.015279] [001/161] (960s left) i915_module_load (load)
[111.935511] Starting subtest: load
[120.929585] Subtest load: SUCCESS (9.007s)
[121.302707] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[121.314164] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[121.343118] [002/161] (949s left) core_auth (basic-auth)
[121.874522] Starting subtest: basic-auth
[121.880044] Subtest basic-auth: SUCCESS (0.004s)
[122.178439] [003/161] (949s left) debugfs_test (read_all_entries)
[122.646744] Starting subtest: read_all_entries
[122.858640] Subtest read_all_entries: SUCCESS (0.211s)
[123.203410] [004/161] (948s left) debugfs_test (basic-hwmon)
[123.668257] Starting subtest: basic-hwmon
[123.676592] Subtest basic-hwmon: SKIP (0.000s)
[124.057554] [005/161] (947s left) debugfs_test (sysfs)
[124.516330] Starting subtest: sysfs
[124.654808] Subtest sysfs: SUCCESS (0.140s)
[125.004721] [006/161] (947s left) fbdev (eof)
[125.521314] Starting subtest: eof
[125.525549] Subtest eof: SUCCESS (0.003s)
[125.812684] [007/161] (946s left) fbdev (info)
[126.252202] Starting subtest: info
[126.255893] Subtest info: SUCCESS (0.000s)
[126.562846] [008/161] (946s left) fbdev (nullptr)
[127.010824] Starting subtest: nullptr
[127.014775] Subtest nullptr: SUCCESS (0.001s)
[127.313338] [009/161] (945s left) fbdev (read)
[127.765939] Starting subtest: read
[128.067164] Subtest read: SUCCESS (0.304s)
[128.362665] [010/161] (944s left) fbdev (write)
[129.064782] Starting subtest: write
[129.275110] Subtest write: SUCCESS (0.223s)
[129.560588] [011/161] (943s left) gem_basic (bad-close)
[130.004104] Starting subtest: bad-close
[130.012536] Subtest bad-close: SUCCESS (0.000s)
[130.312111] [012/161] (943s left) gem_basic (create-close)
[130.796788] Starting subtest: create-close
[130.804727] Subtest create-close: SUCCESS (0.001s)
[131.147417] [013/161] (942s left) gem_basic (create-fd-close)
[131.592793] Starting subtest: create-fd-close
[131.601801] Subtest create-fd-close: SUCCESS (0.001s)
[131.897891] [014/161] (942s left) gem_busy (busy@all-engines)
[132.431175] Starting subtest: busy
[132.435759] Starting dynamic subtest: all-engines
[132.570355] Dynamic subtest all-engines: SUCCESS (0.140s)
[132.576099] Subtest busy: SUCCESS (0.146s)
[133.285509] [015/161] (941s left) gem_close_race (basic-process)
[133.817588] Starting subtest: basic-process
[134.024150] Subtest basic-process: SUCCESS (0.208s)
[134.467142] [016/161] (940s left) gem_close_race (basic-threads)
[135.006801] Starting subtest: basic-threads
[136.606516] Subtest basic-threads: SUCCESS (1.607s)
[137.051944] [017/161] (938s left) gem_ctx_create (basic)
[137.529126] Subtest basic: SKIP (0.000s)
[137.828225] [018/161] (937s left) gem_ctx_create (basic-files)
[138.304313] Subtest basic-files: SKIP (0.000s)
[138.606128] [019/161] (937s left) gem_ctx_exec (basic)
[139.077393] Subtest basic: SKIP (0.000s)
[139.396386] [020/161] (936s left) gem_exec_basic (basic)
[139.916961] Starting subtest: basic
[139.920635] Starting dynamic subtest: rcs0-smem
[139.923911] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[139.927628] Subtest basic: SUCCESS (0.007s)
[140.371905] [021/161] (935s left) gem_exec_create (basic)
[140.900586] Starting subtest: basic
[140.904504] Starting dynamic subtest: smem
[143.062453] Dynamic subtest smem: SUCCESS (2.167s)
[143.066882] Subtest basic: SUCCESS (2.170s)
[143.506779] [022/161] (932s left) gem_exec_fence (basic-busy)
[144.246593] Starting subtest: basic-busy
[144.251376] Starting dynamic subtest: rcs0
[144.290822] Dynamic subtest rcs0: SUCCESS (0.050s)
[144.294894] Subtest basic-busy: SUCCESS (0.054s)
[145.502928] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[145.515342] [023/161] (931s left) gem_exec_fence (basic-wait)
[146.333288] Starting subtest: basic-wait
[146.337477] Starting dynamic subtest: rcs0
[146.370223] Dynamic subtest rcs0: SUCCESS (0.040s)
[146.373817] Subtest basic-wait: SUCCESS (0.044s)
[147.329477] [024/161] (929s left) gem_exec_fence (basic-await)
[148.081521] Starting subtest: basic-await
[148.087334] Starting dynamic subtest: rcs0
[148.233936] Dynamic subtest rcs0: SUCCESS (0.155s)
[148.238939] Subtest basic-await: SUCCESS (0.160s)
[149.199385] [025/161] (928s left) gem_exec_fence (nb-await)
[149.944512] Starting subtest: nb-await
[149.950312] Starting dynamic subtest: rcs0
[150.009452] Dynamic subtest rcs0: SUCCESS (0.065s)
[150.013092] Subtest nb-await: SUCCESS (0.068s)
[150.976653] [026/161] (926s left) gem_exec_gttfill (basic)
[151.516215] Starting subtest: basic
[161.309315] Subtest basic: SUCCESS (9.794s)
[161.840074] [027/161] (916s left) gem_exec_parallel (engines)
[162.588544] Starting subtest: engines
[162.591831] Starting dynamic subtest: basic
[166.612504] Dynamic subtest basic: SUCCESS (4.027s)
[166.661247] Starting dynamic subtest: contexts
[166.668118] Dynamic subtest contexts: SKIP (0.004s)
[166.709708] Starting dynamic subtest: fds
[166.715753] Dynamic subtest fds: SKIP (0.004s)
[166.754889] Starting dynamic subtest: userptr
[170.756997] Dynamic subtest userptr: SUCCESS (4.124s)
[170.760530] Subtest engines: SUCCESS (8.174s)
[171.247481] [028/161] (907s left) gem_exec_store (basic)
[171.766183] Starting subtest: basic
[171.817231] Subtest basic: SUCCESS (0.056s)
[172.296412] [029/161] (906s left) gem_flink_basic (bad-flink)
[172.739331] Starting subtest: bad-flink
[172.744089] Subtest bad-flink: SUCCESS (0.000s)
[173.076985] [030/161] (905s left) gem_flink_basic (bad-open)
[173.517721] Starting subtest: bad-open
[173.522644] Subtest bad-open: SUCCESS (0.000s)
[173.873724] [031/161] (905s left) gem_flink_basic (basic)
[174.309805] Starting subtest: basic
[174.315220] Subtest basic: SUCCESS (0.001s)
[174.665145] [032/161] (904s left) gem_flink_basic (double-flink)
[175.111965] Starting subtest: double-flink
[175.115656] Subtest double-flink: SUCCESS (0.001s)
[175.467900] [033/161] (904s left) gem_flink_basic (flink-lifetime)
[175.987778] Starting subtest: flink-lifetime
[175.994334] Subtest flink-lifetime: SUCCESS (0.010s)
[176.349810] [034/161] (903s left) gem_huc_copy (huc-copy)
[176.819979] Subtest huc-copy: SKIP (0.000s)
[177.136096] [035/161] (903s left) gem_linear_blits (basic)
[177.933946] Starting subtest: basic
[177.973703] Subtest basic: SUCCESS (0.052s)
[178.407522] [036/161] (902s left) gem_mmap (basic)
[179.095399] Starting subtest: basic
[179.114102] Subtest basic: SUCCESS (0.002s)
[179.452972] [037/161] (901s left) gem_mmap_gtt (basic)
[179.900449] Starting subtest: basic
[179.905690] Subtest basic: SUCCESS (0.006s)
[180.243119] [038/161] (901s left) gem_render_linear_blits (basic)
[180.710107] Starting subtest: basic
[180.836606] Subtest basic: SUCCESS (0.131s)
[181.166988] [039/161] (900s left) gem_render_tiled_blits (basic)
[181.629912] Starting subtest: basic
[181.792225] Subtest basic: SUCCESS (0.164s)
[182.125620] [040/161] (899s left) gem_ringfill (basic-all)
[182.689878] Starting subtest: basic-all
[183.907274] Subtest basic-all: SUCCESS (1.220s)
[184.260385] [041/161] (898s left) gem_softpin (allocator-basic)
[184.729613] Subtest allocator-basic: SKIP (0.000s)
[185.070944] [042/161] (897s left) gem_softpin (allocator-basic-reserve)
[185.524584] Subtest allocator-basic-reserve: SKIP (0.000s)
[185.877776] [043/161] (897s left) gem_softpin (safe-alignment)
[186.337079] Starting subtest: safe-alignment
[186.355941] Subtest safe-alignment: SUCCESS (0.024s)
[186.721262] [044/161] (896s left) gem_sync (basic-all)
[187.260914] Starting subtest: basic-all
[189.451133] Subtest basic-all: SUCCESS (2.195s)
[189.942167] [045/161] (893s left) gem_sync (basic-each)
[190.468586] Starting subtest: basic-each
[192.731994] Subtest basic-each: SUCCESS (2.263s)
[193.227878] [046/161] (890s left) gem_tiled_blits (basic)
[194.053944] Starting subtest: basic
[194.160203] Subtest basic: SUCCESS (0.107s)
[194.606255] [047/161] (889s left) gem_tiled_fence_blits (basic)
[195.671958] Starting subtest: basic
[195.747528] Subtest basic: SUCCESS (0.072s)
[196.168877] [048/161] (888s left) gem_tiled_pread_basic
[199.054534] [049/161] (885s left) gem_wait (busy@all-engines)
[199.651943] Starting subtest: busy
[199.657471] Starting dynamic subtest: all-engines
[200.188803] Dynamic subtest all-engines: SUCCESS (0.537s)
[200.196139] Subtest busy: SUCCESS (0.541s)
[200.830144] [050/161] (884s left) gem_wait (wait@all-engines)
[201.429470] Starting subtest: wait
[201.433433] Starting dynamic subtest: all-engines
[202.472774] Dynamic subtest all-engines: SUCCESS (1.047s)
[202.478155] Subtest wait: SUCCESS (1.052s)
[203.137220] [051/161] (882s left) i915_getparams_basic (basic-eu-total)
[203.589310] Starting subtest: basic-eu-total
[203.597110] Subtest basic-eu-total: SUCCESS (0.000s)
[203.933940] [052/161] (881s left) i915_getparams_basic (basic-subslice-total)
[204.376515] Starting subtest: basic-subslice-total
[204.386488] Subtest basic-subslice-total: SUCCESS (0.000s)
[204.715907] [053/161] (881s left) i915_hangman (error-state-basic)
[205.190362] Starting subtest: error-state-basic
[205.606294] Subtest error-state-basic: SUCCESS (0.408s)
[206.072902] [054/161] (880s left) i915_pciid
[206.885145] [055/161] (880s left) kms_addfb_basic (addfb25-4-tiled)
[207.410819] Starting subtest: addfb25-4-tiled
[207.415568] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[207.774522] [056/161] (879s left) kms_addfb_basic (addfb25-bad-modifier)
[208.269725] Starting subtest: addfb25-bad-modifier
[208.274867] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[208.646443] [057/161] (878s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[209.152174] Starting subtest: addfb25-framebuffer-vs-set-tiling
[209.156811] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[209.506146] [058/161] (878s left) kms_addfb_basic (addfb25-modifier-no-flag)
[210.016788] Starting subtest: addfb25-modifier-no-flag
[210.021697] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[210.385637] [059/161] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[210.900422] Starting subtest: addfb25-x-tiled-legacy
[210.904497] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[211.260260] [060/161] (877s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[211.774541] Starting subtest: addfb25-x-tiled-mismatch-legacy
[211.779401] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[212.143393] [061/161] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[212.646860] Starting subtest: addfb25-yf-tiled-legacy
[212.652243] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[213.003083] [062/161] (876s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[213.496969] Starting subtest: addfb25-y-tiled-legacy
[213.501971] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[213.851325] [063/161] (875s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[214.399307] Starting subtest: addfb25-y-tiled-small-legacy
[214.407424] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[214.763714] [064/161] (875s left) kms_addfb_basic (bad-pitch-0)
[215.221786] Starting subtest: bad-pitch-0
[215.226506] Subtest bad-pitch-0: SUCCESS (0.000s)
[215.653364] [065/161] (874s left) kms_addfb_basic (bad-pitch-1024)
[216.104461] Starting subtest: bad-pitch-1024
[216.108706] Subtest bad-pitch-1024: SUCCESS (0.000s)
[216.528639] [066/161] (873s left) kms_addfb_basic (bad-pitch-128)
[216.976975] Starting subtest: bad-pitch-128
[216.981312] Subtest bad-pitch-128: SUCCESS (0.000s)
[217.413528] [067/161] (873s left) kms_addfb_basic (bad-pitch-256)
[217.850440] Starting subtest: bad-pitch-256
[217.855658] Subtest bad-pitch-256: SUCCESS (0.000s)
[218.265225] [068/161] (872s left) kms_addfb_basic (bad-pitch-32)
[218.716109] Starting subtest: bad-pitch-32
[218.720831] Subtest bad-pitch-32: SUCCESS (0.000s)
[219.122852] [069/161] (872s left) kms_addfb_basic (bad-pitch-63)
[219.572813] Starting subtest: bad-pitch-63
[219.577733] Subtest bad-pitch-63: SUCCESS (0.000s)
[219.997208] [070/161] (871s left) kms_addfb_basic (bad-pitch-65536)
[220.456858] Starting subtest: bad-pitch-65536
[220.461435] Subtest bad-pitch-65536: SUCCESS (0.002s)
[220.953520] [071/161] (871s left) kms_addfb_basic (bad-pitch-999)
[221.407453] Starting subtest: bad-pitch-999
[221.412099] Subtest bad-pitch-999: SUCCESS (0.000s)
[221.824440] [072/161] (870s left) kms_addfb_basic (basic)
[222.274520] Starting subtest: basic
[222.279678] Subtest basic: SUCCESS (0.000s)
[222.709913] [073/161] (870s left) kms_addfb_basic (basic-x-tiled-legacy)
[223.164234] Starting subtest: basic-x-tiled-legacy
[223.169253] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[223.578485] [074/161] (869s left) kms_addfb_basic (basic-y-tiled-legacy)
[224.032531] Starting subtest: basic-y-tiled-legacy
[224.036884] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[224.461410] [075/161] (869s left) kms_addfb_basic (bo-too-small)
[224.971708] Starting subtest: bo-too-small
[224.977195] Subtest bo-too-small: SUCCESS (0.002s)
[225.340442] [076/161] (868s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[225.831432] Starting subtest: bo-too-small-due-to-tiling
[225.837132] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[226.192377] [077/161] (867s left) kms_addfb_basic (clobberred-modifier)
[226.650989] Starting subtest: clobberred-modifier
[226.655066] Subtest clobberred-modifier: SUCCESS (0.001s)
[227.060344] [078/161] (867s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[227.526092] Starting subtest: framebuffer-vs-set-tiling
[227.529590] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[227.951102] [079/161] (866s left) kms_addfb_basic (invalid-get-prop)
[228.399292] Starting subtest: invalid-get-prop
[228.404564] Subtest invalid-get-prop: SUCCESS (0.000s)
[228.816805] [080/161] (866s left) kms_addfb_basic (invalid-get-prop-any)
[229.261057] Starting subtest: invalid-get-prop-any
[229.264227] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[229.700943] [081/161] (865s left) kms_addfb_basic (invalid-set-prop)
[230.147414] Starting subtest: invalid-set-prop
[230.152426] Subtest invalid-set-prop: SUCCESS (0.000s)
[230.581491] [082/161] (865s left) kms_addfb_basic (invalid-set-prop-any)
[231.031390] Starting subtest: invalid-set-prop-any
[231.036567] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[231.441551] [083/161] (864s left) kms_addfb_basic (no-handle)
[231.893914] Starting subtest: no-handle
[231.900238] Subtest no-handle: SUCCESS (0.000s)
[232.316811] [084/161] (864s left) kms_addfb_basic (size-max)
[232.820725] Starting subtest: size-max
[232.826270] Subtest size-max: SUCCESS (0.001s)
[233.182649] [085/161] (863s left) kms_addfb_basic (small-bo)
[233.668898] Starting subtest: small-bo
[233.673560] Subtest small-bo: SUCCESS (0.000s)
[234.032916] [086/161] (862s left) kms_addfb_basic (tile-pitch-mismatch)
[234.486570] Starting subtest: tile-pitch-mismatch
[234.491897] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[234.919135] [087/161] (862s left) kms_addfb_basic (too-high)
[235.427867] Starting subtest: too-high
[235.432155] Subtest too-high: SUCCESS (0.007s)
[235.888911] [088/161] (861s left) kms_addfb_basic (too-wide)
[236.426506] Starting subtest: too-wide
[236.431234] Subtest too-wide: SUCCESS (0.000s)
[236.781835] [089/161] (861s left) kms_addfb_basic (unused-handle)
[237.230483] Starting subtest: unused-handle
[237.234878] Subtest unused-handle: SUCCESS (0.000s)
[237.640172] [090/161] (860s left) kms_addfb_basic (unused-modifier)
[238.083142] Starting subtest: unused-modifier
[238.087703] Subtest unused-modifier: SUCCESS (0.000s)
[238.505844] [091/161] (860s left) kms_addfb_basic (unused-offsets)
[238.952769] Starting subtest: unused-offsets
[238.957869] Subtest unused-offsets: SUCCESS (0.000s)
[239.364148] [092/161] (859s left) kms_addfb_basic (unused-pitches)
[239.823674] Starting subtest: unused-pitches
[239.827883] Subtest unused-pitches: SUCCESS (0.001s)
[240.234669] [093/161] (859s left) kms_busy (basic)
[240.754573] Starting subtest: basic
[240.760598] Starting dynamic subtest: flip
[241.761520] Dynamic subtest flip: SUCCESS (0.999s)
[241.812282] Starting dynamic subtest: modeset
[241.818428] Dynamic subtest modeset: SKIP (0.000s)
[241.821468] Subtest basic: SUCCESS (1.010s)
[242.280629] [094/161] (857s left) kms_prop_blob (basic)
[242.742382] Starting subtest: basic
[242.748973] Subtest basic: SUCCESS (0.000s)
[243.098731] [095/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[243.595817] Starting subtest: basic-busy-flip-before-cursor-atomic
[243.616978] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.017s)
[243.967475] [096/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[244.462405] Starting subtest: basic-busy-flip-before-cursor-legacy
[245.566452] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.107s)
[246.060859] [097/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[246.557805] Starting subtest: basic-flip-after-cursor-atomic
[246.566457] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[246.910634] [098/161] (853s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[247.401978] Starting subtest: basic-flip-after-cursor-legacy
[248.491922] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.089s)
[249.038131] [099/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[249.517651] Starting subtest: basic-flip-after-cursor-varying-size
[250.608644] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.091s)
[251.200585] [100/161] (850s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[251.682095] Starting subtest: basic-flip-before-cursor-atomic
[251.690384] Subtest basic-flip-before-cursor-atomic: SKIP (0.001s)
[252.039677] [101/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[252.535258] Starting subtest: basic-flip-before-cursor-legacy
[253.620313] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.089s)
[254.132188] [102/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[254.628461] Starting subtest: basic-flip-before-cursor-varying-size
[255.720985] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.092s)
[256.238514] [103/161] (846s left) kms_dsc (dsc-basic)
[256.733385] Subtest dsc-basic: SKIP (0.000s)
[257.051969] [104/161] (845s left) kms_flip (basic-flip-vs-dpms)
[257.568641] Starting subtest: basic-flip-vs-dpms
[257.573303] Starting dynamic subtest: A-VGA1
[259.223331] Dynamic subtest A-VGA1: SUCCESS (1.658s)
[259.282769] Starting dynamic subtest: B-VGA1
[260.754920] Dynamic subtest B-VGA1: SUCCESS (1.520s)
[260.759127] Subtest basic-flip-vs-dpms: SUCCESS (3.190s)
[261.437507] [105/161] (841s left) kms_flip (basic-flip-vs-modeset)
[261.956699] Starting subtest: basic-flip-vs-modeset
[261.966693] Starting dynamic subtest: A-VGA1
[263.644178] Dynamic subtest A-VGA1: SUCCESS (1.678s)
[263.699118] Starting dynamic subtest: B-VGA1
[265.109233] Dynamic subtest B-VGA1: SUCCESS (1.459s)
[265.113690] Subtest basic-flip-vs-modeset: SUCCESS (3.148s)
[265.741652] [106/161] (837s left) kms_flip (basic-flip-vs-wf_vblank)
[266.339790] Starting subtest: basic-flip-vs-wf_vblank
[266.346612] Starting dynamic subtest: A-VGA1
[268.178222] Dynamic subtest A-VGA1: SUCCESS (1.827s)
[268.232887] Starting dynamic subtest: B-VGA1
[269.885855] Dynamic subtest B-VGA1: SUCCESS (1.703s)
[269.890420] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.541s)
[270.581284] [107/161] (833s left) kms_flip (basic-plain-flip)
[271.090336] Starting subtest: basic-plain-flip
[271.094574] Starting dynamic subtest: A-VGA1
[272.626329] Dynamic subtest A-VGA1: SUCCESS (1.537s)
[272.680652] Starting dynamic subtest: B-VGA1
[274.071756] Dynamic subtest B-VGA1: SUCCESS (1.441s)
[274.076180] Subtest basic-plain-flip: SUCCESS (2.988s)
[274.794699] [108/161] (829s left) kms_force_connector_basic (force-connector-state)
[275.317089] Starting subtest: force-connector-state
[275.599610] Subtest force-connector-state: SUCCESS (0.276s)
[276.281752] [109/161] (828s left) kms_force_connector_basic (force-edid)
[276.827114] Starting subtest: force-edid
[276.936752] Subtest force-edid: SUCCESS (0.114s)
[277.390926] [110/161] (827s left) kms_force_connector_basic (force-load-detect)
[277.941877] Starting subtest: force-load-detect
[278.454687] Subtest force-load-detect: SUCCESS (0.511s)
[279.069821] [111/161] (826s left) kms_force_connector_basic (prune-stale-modes)
[279.639866] Starting subtest: prune-stale-modes
[279.754821] Subtest prune-stale-modes: SUCCESS (0.114s)
[280.192654] [112/161] (825s left) kms_frontbuffer_tracking (basic)
[280.705889] Subtest basic: SKIP (0.000s)
[281.140847] [113/161] (824s left) kms_hdmi_inject (inject-audio)
[281.594519] Subtest inject-audio: SKIP (0.000s)
[281.911635] [114/161] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[282.415941] Starting subtest: compare-crc-sanitycheck-xr24
[282.420949] Starting dynamic subtest: pipe-A-VGA-1
[282.812679] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.394s)
[282.880301] Starting dynamic subtest: pipe-B-VGA-1
[283.354163] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.517s)
[283.359120] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.939s)
[283.858718] [115/161] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[284.359701] Starting subtest: compare-crc-sanitycheck-nv12
[284.371891] Starting dynamic subtest: pipe-A-VGA-1
[284.381449] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[284.431129] Starting dynamic subtest: pipe-B-VGA-1
[284.437210] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[284.444536] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[284.742313] [116/161] (822s left) kms_pipe_crc_basic (hang-read-crc)
[285.228921] Starting subtest: hang-read-crc
[285.234649] Starting dynamic subtest: pipe-A-VGA-1
[286.545500] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.307s)
[286.603765] Starting dynamic subtest: pipe-B-VGA-1
[287.986789] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.437s)
[287.990730] Subtest hang-read-crc: SUCCESS (2.761s)
[288.502334] [117/161] (818s left) kms_pipe_crc_basic (nonblocking-crc)
[288.993572] Starting subtest: nonblocking-crc
[288.998504] Starting dynamic subtest: pipe-A-VGA-1
[289.594959] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.592s)
[289.653533] Starting dynamic subtest: pipe-B-VGA-1
[290.332424] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.729s)
[290.337249] Subtest nonblocking-crc: SUCCESS (1.339s)
[290.833617] [118/161] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[291.332438] Starting subtest: nonblocking-crc-frame-sequence
[291.337670] Starting dynamic subtest: pipe-A-VGA-1
[291.927776] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.591s)
[291.981257] Starting dynamic subtest: pipe-B-VGA-1
[292.656420] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.715s)
[292.661115] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.325s)
[293.143677] [119/161] (814s left) kms_pipe_crc_basic (read-crc)
[293.634049] Starting subtest: read-crc
[293.643395] Starting dynamic subtest: pipe-A-VGA-1
[294.164255] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.521s)
[294.225652] Starting dynamic subtest: pipe-B-VGA-1
[294.815262] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.643s)
[294.820436] Subtest read-crc: SUCCESS (1.182s)
[295.315104] [120/161] (812s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[295.850616] Starting subtest: read-crc-frame-sequence
[295.858422] Starting dynamic subtest: pipe-A-VGA-1
[296.385499] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.540s)
[296.446824] Starting dynamic subtest: pipe-B-VGA-1
[297.034458] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.635s)
[297.038826] Subtest read-crc-frame-sequence: SUCCESS (1.196s)
[297.535591] [121/161] (810s left) kms_pm_backlight (basic-brightness)
[298.049573] Subtest basic-brightness: SKIP (0.000s)
[298.381832] [122/161] (810s left) kms_pm_rpm (basic-pci-d3-state)
[310.292838] Subtest basic-pci-d3-state: SKIP (0.000s)
[310.616870] [123/161] (798s left) kms_pm_rpm (basic-rte)
[311.138443] Starting subtest: basic-rte
[322.645115] Subtest basic-rte: SKIP (11.502s)
[322.980222] [124/161] (786s left) kms_psr (psr-primary-page-flip)
[323.473180] Subtest psr-primary-page-flip: SKIP (0.000s)
[323.793246] [125/161] (786s left) kms_psr (psr-cursor-plane-move)
[324.294102] Subtest psr-cursor-plane-move: SKIP (0.000s)
[324.644702] [126/161] (785s left) kms_psr (psr-sprite-plane-onoff)
[325.141343] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[325.489743] [127/161] (784s left) kms_psr (psr-primary-mmap-gtt)
[326.043929] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[326.361762] [128/161] (784s left) kms_setmode (basic-clone-single-crtc)
[326.808725] Starting subtest: basic-clone-single-crtc
[326.822529] Subtest basic-clone-single-crtc: SKIP (0.000s)
[327.153139] [129/161] (783s left) i915_pm_rps (basic-api)
[327.612588] Subtest basic-api: SKIP (0.000s)
[327.952464] [130/161] (783s left) prime_self_import (basic-llseek-bad)
[328.390468] Starting subtest: basic-llseek-bad
[328.408236] Subtest basic-llseek-bad: SUCCESS (0.013s)
[328.750179] [131/161] (783s left) prime_self_import (basic-llseek-size)
[329.186471] Starting subtest: basic-llseek-size
[329.205880] Subtest basic-llseek-size: SUCCESS (0.025s)
[329.550760] [132/161] (782s left) prime_self_import (basic-with_fd_dup)
[329.978368] Starting subtest: basic-with_fd_dup
[329.998514] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[330.353776] [133/161] (782s left) prime_self_import (basic-with_one_bo)
[330.786694] Starting subtest: basic-with_one_bo
[330.810719] Subtest basic-with_one_bo: SUCCESS (0.027s)
[331.170993] [134/161] (781s left) prime_self_import (basic-with_one_bo_two_files)
[331.596989] Starting subtest: basic-with_one_bo_two_files
[331.619454] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[331.973820] [135/161] (781s left) prime_self_import (basic-with_two_bos)
[332.410966] Starting subtest: basic-with_two_bos
[332.429314] Subtest basic-with_two_bos: SUCCESS (0.024s)
[332.789757] [136/161] (780s left) prime_vgem (basic-fence-flip)
[333.271937] Starting subtest: basic-fence-flip
[333.947795] Subtest basic-fence-flip: SUCCESS (0.675s)
[334.329574] [137/161] (779s left) prime_vgem (basic-fence-mmap)
[334.811344] Starting subtest: basic-fence-mmap
[335.011263] Subtest basic-fence-mmap: SUCCESS (0.202s)
[335.377566] [138/161] (778s left) prime_vgem (basic-fence-read)
[335.853551] Starting subtest: basic-fence-read
[336.117554] Subtest basic-fence-read: SUCCESS (0.262s)
[336.485549] [139/161] (777s left) prime_vgem (basic-gtt)
[336.957490] Starting subtest: basic-gtt
[337.030867] Subtest basic-gtt: SUCCESS (0.076s)
[337.390665] [140/161] (777s left) prime_vgem (basic-read)
[337.875800] Starting subtest: basic-read
[337.975095] Subtest basic-read: SUCCESS (0.104s)
[338.341355] [141/161] (776s left) prime_vgem (basic-write)
[338.808669] Starting subtest: basic-write
[338.916088] Subtest basic-write: SUCCESS (0.113s)
[339.275474] [142/161] (775s left) vgem_basic (setversion)
[339.734860] Starting subtest: setversion
[339.741737] Subtest setversion: SUCCESS (0.000s)
[340.074476] [143/161] (775s left) vgem_basic (create)
[340.533537] Starting subtest: create
[340.539447] Subtest create: SUCCESS (0.002s)
[340.968299] [144/161] (775s left) vgem_basic (debugfs)
[341.423554] Starting subtest: debugfs
[341.428598] Subtest debugfs: SUCCESS (0.004s)
[341.757951] [145/161] (774s left) vgem_basic (dmabuf-export)
[342.203983] Starting subtest: dmabuf-export
[342.217923] Subtest dmabuf-export: SUCCESS (0.016s)
[342.581900] [146/161] (774s left) vgem_basic (dmabuf-fence)
[343.021980] Starting subtest: dmabuf-fence
[343.027284] Subtest dmabuf-fence: SUCCESS (0.004s)
[343.358913] [147/161] (773s left) vgem_basic (dmabuf-fence-before)
[343.810959] Starting subtest: dmabuf-fence-before
[343.815396] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[344.146272] [148/161] (773s left) vgem_basic (dmabuf-mmap)
[344.605300] Starting subtest: dmabuf-mmap
[344.683872] Subtest dmabuf-mmap: SUCCESS (0.083s)
[345.033634] [149/161] (772s left) vgem_basic (mmap)
[345.487866] Starting subtest: mmap
[345.547898] Subtest mmap: SUCCESS (0.064s)
[345.893963] [150/161] (771s left) vgem_basic (second-client)
[346.357732] Starting subtest: second-client
[346.387325] Subtest second-client: SUCCESS (0.032s)
[346.730574] [151/161] (771s left) vgem_basic (sysfs)
[347.172402] Starting subtest: sysfs
[347.177171] Subtest sysfs: SUCCESS (0.005s)
[347.511215] [152/161] (770s left) core_hotunplug (unbind-rebind)
[348.237381] Starting subtest: unbind-rebind
[354.039214] Subtest unbind-rebind: SUCCESS (5.800s)
[354.370749] [153/161] (764s left) vgem_basic (unload)
[354.814997] Starting subtest: unload
[384.484349] Subtest unload: SUCCESS (29.673s)
[385.005946] [154/161] (734s left) i915_module_load (reload)
[385.454378] Starting subtest: reload
[395.341821] Subtest reload: SUCCESS (9.888s)
[396.031263] [155/161] (723s left) gem_lmem_swapping (basic)
[396.876581] Subtest basic: SKIP (0.000s)
[397.238261] [156/161] (722s left) gem_lmem_swapping (parallel-random-engines)
[397.695682] Subtest parallel-random-engines: SKIP (0.000s)
[398.009504] [157/161] (722s left) gem_lmem_swapping (random-engines)
[398.477180] Subtest random-engines: SKIP (0.000s)
[398.797958] [158/161] (721s left) gem_lmem_swapping (verify-random)
[399.267605] Subtest verify-random: SKIP (0.000s)
[399.586674] [159/161] (721s left) i915_pm_rpm (module-reload)
[411.569930] Subtest module-reload: SKIP (0.000s)
[411.894538] [160/161] (709s left) i915_selftest (live)
[414.808379] Starting subtest: live
[414.813119] Starting dynamic subtest: sanitycheck
[422.181855] Dynamic subtest sanitycheck: SUCCESS (7.371s)
[422.222576] Starting dynamic subtest: uncore
[429.479490] Dynamic subtest uncore: SUCCESS (7.291s)
[429.562704] Starting dynamic subtest: workarounds
[436.853130] Dynamic subtest workarounds: SUCCESS (7.370s)
[436.899467] Starting dynamic subtest: gt_engines
[444.240098] Dynamic subtest gt_engines: SUCCESS (7.378s)
[444.324875] Starting dynamic subtest: gt_timelines
[457.676957] Dynamic subtest gt_timelines: SUCCESS (13.433s)
[457.748896] Starting dynamic subtest: gt_contexts
[465.050395] Dynamic subtest gt_contexts: SUCCESS (7.370s)
[465.103387] Starting dynamic subtest: gt_lrc
[472.340224] Dynamic subtest gt_lrc: SUCCESS (7.282s)
[472.388853] Starting dynamic subtest: gt_mocs
[479.712085] Dynamic subtest gt_mocs: SUCCESS (7.365s)
[479.806466] Starting dynamic subtest: gt_pm
[487.337080] Dynamic subtest gt_pm: SUCCESS (7.618s)
[487.387954] Starting dynamic subtest: gt_heartbeat
[494.719374] Dynamic subtest gt_heartbeat: SUCCESS (7.373s)
[494.777584] Starting dynamic subtest: gt_tlb
[502.047470] Dynamic subtest gt_tlb: SUCCESS (7.323s)
[502.106458] Starting dynamic subtest: requests
[512.067653] Dynamic subtest requests: SUCCESS (10.015s)
[512.113824] Starting dynamic subtest: migrate
[519.299150] Dynamic subtest migrate: SUCCESS (7.223s)
[519.380463] Starting dynamic subtest: active
[526.627785] Dynamic subtest active: SUCCESS (7.325s)
[526.678225] Starting dynamic subtest: objects
[534.709099] Dynamic subtest objects: SUCCESS (8.074s)
[534.800410] Starting dynamic subtest: mman
[549.375623] Dynamic subtest mman: SUCCESS (14.661s)
[549.421132] Starting dynamic subtest: dmabuf
[557.010132] Dynamic subtest dmabuf: SUCCESS (7.625s)
[557.085741] Starting dynamic subtest: vma
[564.311336] Dynamic subtest vma: SUCCESS (7.298s)
[564.393131] Starting dynamic subtest: coherency
[577.146956] Dynamic subtest coherency: SUCCESS (12.830s)
[577.236479] Starting dynamic subtest: gtt
[587.244275] Dynamic subtest gtt: SUCCESS (10.091s)
[587.290666] Starting dynamic subtest: gem
[594.726479] Dynamic subtest gem: SUCCESS (7.476s)
[594.815494] Starting dynamic subtest: evict
[602.156784] Dynamic subtest evict: SUCCESS (7.424s)
[602.206063] Starting dynamic subtest: hugepages
[609.455370] Dynamic subtest hugepages: SUCCESS (7.290s)
[609.536683] Starting dynamic subtest: gem_contexts
[616.860306] Dynamic subtest gem_contexts: SUCCESS (7.400s)
[616.908340] Starting dynamic subtest: client
[624.206909] Dynamic subtest client: SUCCESS (7.340s)
[624.252898] Starting dynamic subtest: gem_migrate
[631.519866] Dynamic subtest gem_migrate: SUCCESS (7.307s)
[631.570201] Starting dynamic subtest: reset
[640.918830] Dynamic subtest reset: SUCCESS (9.392s)
[640.990646] Starting dynamic subtest: memory_region
[648.323350] Dynamic subtest memory_region: SUCCESS (7.397s)
[648.372238] Starting dynamic subtest: hangcheck
[656.809843] Dynamic subtest hangcheck: SUCCESS (8.479s)
[656.860609] Starting dynamic subtest: execlists
[664.173191] Dynamic subtest execlists: SUCCESS (7.356s)
[664.264216] Starting dynamic subtest: ring_submission
[671.584224] Dynamic subtest ring_submission: SUCCESS (7.404s)
[671.651944] Starting dynamic subtest: perf
[678.810227] Dynamic subtest perf: SUCCESS (7.219s)
[678.852108] Starting dynamic subtest: slpc
[686.103313] Dynamic subtest slpc: SUCCESS (7.288s)
[686.202522] Starting dynamic subtest: guc
[693.383649] Dynamic subtest guc: SUCCESS (7.272s)
[693.430459] Starting dynamic subtest: guc_multi_lrc
[701.548843] Dynamic subtest guc_multi_lrc: SUCCESS (8.157s)
[701.641617] Starting dynamic subtest: guc_hang
[709.018610] Dynamic subtest guc_hang: SUCCESS (7.461s)
[709.108347] Starting dynamic subtest: late_gt_pm
[716.384750] Dynamic subtest late_gt_pm: SUCCESS (7.357s)
[716.390682] Subtest live: SUCCESS (301.572s)
[716.631085] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[716.640832] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[716.653654] [161/161] (404s left) dmabuf (all-tests)
[717.116587] Starting subtest: all-tests
[717.120632] Starting dynamic subtest: sanitycheck
[717.252565] Dynamic subtest sanitycheck: SUCCESS (0.137s)
[717.310971] Starting dynamic subtest: dma_fence
[717.549839] Dynamic subtest dma_fence: SUCCESS (0.288s)
[717.602837] Starting dynamic subtest: dma_fence_chain