[98.877965] Initializing watchdogs [98.878207] /dev/watchdog0 [98.902447] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [98.908588] [001/162] (960s left) i915_module_load (load) [98.976598] Starting subtest: load [101.208968] Subtest load: SUCCESS (2.232s) [101.290037] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [101.292362] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [101.310886] [002/162] (958s left) core_auth (basic-auth) [101.388275] Starting subtest: basic-auth [101.389253] Subtest basic-auth: SUCCESS (0.001s) [101.436963] [003/162] (958s left) core_debugfs (read-all-entries) [101.494191] Starting subtest: read-all-entries [101.496574] Subtest read-all-entries: SUCCESS (0.003s) [101.545467] [004/162] (958s left) core_sysfs (read-all-entries) [101.605298] Starting subtest: read-all-entries [101.610563] Subtest read-all-entries: SUCCESS (0.006s) [101.660973] [005/162] (958s left) fbdev (eof) [101.730771] Subtest eof: SKIP (0.000s) [101.777592] [006/162] (957s left) fbdev (info) [101.844793] Subtest info: SKIP (0.000s) [101.890347] [007/162] (957s left) fbdev (nullptr) [101.960036] Subtest nullptr: SKIP (0.000s) [102.005822] [008/162] (957s left) fbdev (read) [102.073923] Subtest read: SKIP (0.000s) [102.119296] [009/162] (957s left) fbdev (write) [102.186511] Subtest write: SKIP (0.000s) [102.232107] [010/162] (957s left) gem_basic (bad-close) [102.288454] Starting subtest: bad-close [102.290332] Subtest bad-close: SUCCESS (0.000s) [102.336241] [011/162] (957s left) gem_basic (create-close) [102.394045] Starting subtest: create-close [102.396858] Subtest create-close: SUCCESS (0.000s) [102.461954] [012/162] (957s left) gem_basic (create-fd-close) [102.519789] Starting subtest: create-fd-close [102.521808] Subtest create-fd-close: SUCCESS (0.000s) [102.585791] [013/162] (957s left) gem_busy (busy@all-engines) [102.664847] Starting subtest: busy [102.665868] Starting dynamic subtest: all-engines [102.748448] Dynamic subtest all-engines: SUCCESS (0.083s) [102.749410] Subtest busy: SUCCESS (0.084s) [103.142970] [014/162] (956s left) gem_close_race (basic-process) [103.228833] Starting subtest: basic-process [103.296678] Subtest basic-process: SUCCESS (0.068s) [103.540606] [015/162] (956s left) gem_close_race (basic-threads) [103.621137] Starting subtest: basic-threads [104.888870] Subtest basic-threads: SUCCESS (1.238s) [105.061164] [016/162] (955s left) gem_ctx_create (basic) [105.140207] Starting subtest: basic [105.141420] Subtest basic: SUCCESS (0.000s) [105.333082] [017/162] (955s left) gem_ctx_create (basic-files) [105.410679] Starting subtest: basic-files [107.428598] Subtest basic-files: SUCCESS (2.018s) [107.672885] [018/162] (952s left) gem_ctx_exec (basic) [107.740770] Starting subtest: basic [107.746690] Subtest basic: SUCCESS (0.006s) [107.851461] [019/162] (952s left) gem_exec_basic (basic) [107.922537] Starting subtest: basic [107.923630] Starting dynamic subtest: rcs0-smem [107.925890] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [107.937516] Starting dynamic subtest: bcs0-smem [107.938665] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [107.948250] Starting dynamic subtest: vcs0-smem [107.950292] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [107.960582] Starting dynamic subtest: vcs1-smem [107.962279] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [107.971813] Starting dynamic subtest: vecs0-smem [107.972998] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [107.974264] Subtest basic: SUCCESS (0.012s) [108.149409] [020/162] (952s left) gem_exec_create (basic) [108.298709] Starting subtest: basic [108.299752] Starting dynamic subtest: smem [110.310630] Dynamic subtest smem: SUCCESS (2.044s) [110.312798] Subtest basic: SUCCESS (2.044s) [110.450432] [021/162] (950s left) gem_exec_fence (basic-busy) [110.685968] Starting subtest: basic-busy [110.687362] Starting dynamic subtest: rcs0 [110.722514] Dynamic subtest rcs0: SUCCESS (0.036s) [110.733341] Starting dynamic subtest: bcs0 [110.748509] Dynamic subtest bcs0: SUCCESS (0.026s) [110.758417] Starting dynamic subtest: vcs0 [110.771425] Dynamic subtest vcs0: SUCCESS (0.023s) [110.782599] Starting dynamic subtest: vcs1 [110.793428] Dynamic subtest vcs1: SUCCESS (0.022s) [110.803824] Starting dynamic subtest: vecs0 [110.812399] Dynamic subtest vecs0: SUCCESS (0.019s) [110.813569] Subtest basic-busy: SUCCESS (0.127s) [111.497208] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [111.499795] [022/162] (949s left) gem_exec_fence (basic-wait) [111.730469] Starting subtest: basic-wait [111.732417] Starting dynamic subtest: rcs0 [111.762733] Dynamic subtest rcs0: SUCCESS (0.033s) [111.777689] Starting dynamic subtest: bcs0 [111.785388] Dynamic subtest bcs0: SUCCESS (0.022s) [111.800555] Starting dynamic subtest: vcs0 [111.805541] Dynamic subtest vcs0: SUCCESS (0.019s) [111.820504] Starting dynamic subtest: vcs1 [111.832608] Dynamic subtest vcs1: SUCCESS (0.026s) [111.844355] Starting dynamic subtest: vecs0 [111.852418] Dynamic subtest vecs0: SUCCESS (0.020s) [111.853770] Subtest basic-wait: SUCCESS (0.124s) [112.477644] [023/162] (948s left) gem_exec_fence (basic-await) [112.695934] Starting subtest: basic-await [112.697770] Starting dynamic subtest: rcs0 [112.808349] Dynamic subtest rcs0: SUCCESS (0.109s) [112.822497] Starting dynamic subtest: bcs0 [112.916339] Dynamic subtest bcs0: SUCCESS (0.109s) [112.935181] Starting dynamic subtest: vcs0 [113.032638] Dynamic subtest vcs0: SUCCESS (0.116s) [113.045464] Starting dynamic subtest: vcs1 [113.145466] Dynamic subtest vcs1: SUCCESS (0.113s) [113.159706] Starting dynamic subtest: vecs0 [113.269837] Dynamic subtest vecs0: SUCCESS (0.117s) [113.271341] Subtest basic-await: SUCCESS (0.568s) [113.972268] [024/162] (946s left) gem_exec_fence (nb-await) [114.201315] Starting subtest: nb-await [114.202890] Starting dynamic subtest: rcs0 [114.271580] Dynamic subtest rcs0: SUCCESS (0.070s) [114.287436] Starting dynamic subtest: bcs0 [114.343170] Dynamic subtest bcs0: SUCCESS (0.070s) [114.377095] Starting dynamic subtest: vcs0 [114.435904] Dynamic subtest vcs0: SUCCESS (0.091s) [114.466195] Starting dynamic subtest: vcs1 [114.527230] Dynamic subtest vcs1: SUCCESS (0.090s) [114.558656] Starting dynamic subtest: vecs0 [114.618126] Dynamic subtest vecs0: SUCCESS (0.089s) [114.619972] Subtest nb-await: SUCCESS (0.417s) [115.353556] [025/162] (945s left) gem_exec_gttfill (basic) [115.436976] Starting subtest: basic [120.250177] Subtest basic: SUCCESS (4.812s) [120.521294] [026/162] (940s left) gem_exec_parallel (engines) [120.678968] Starting subtest: engines [120.680107] Starting dynamic subtest: basic [123.030059] Dynamic subtest basic: SUCCESS (2.306s) [123.041441] Starting dynamic subtest: contexts [132.719562] Dynamic subtest contexts: SUCCESS (9.732s) [132.737041] Starting dynamic subtest: fds [138.764654] Dynamic subtest fds: SUCCESS (6.022s) [138.779912] Starting dynamic subtest: userptr [141.130870] Dynamic subtest userptr: SUCCESS (2.341s) [141.133061] Subtest engines: SUCCESS (20.404s) [141.297558] [027/162] (919s left) gem_exec_store (basic) [141.378562] Starting subtest: basic [141.440589] Subtest basic: SUCCESS (0.063s) [141.633348] [028/162] (919s left) gem_flink_basic (bad-flink) [141.692288] Starting subtest: bad-flink [141.693441] Subtest bad-flink: SUCCESS (0.000s) [141.745917] [029/162] (919s left) gem_flink_basic (bad-open) [141.803344] Starting subtest: bad-open [141.804452] Subtest bad-open: SUCCESS (0.000s) [141.858148] [030/162] (919s left) gem_flink_basic (basic) [142.087777] Starting subtest: basic [142.089440] Subtest basic: SUCCESS (0.000s) [142.165185] [031/162] (919s left) gem_flink_basic (double-flink) [142.264939] Starting subtest: double-flink [142.266195] Subtest double-flink: SUCCESS (0.000s) [142.343331] [032/162] (919s left) gem_flink_basic (flink-lifetime) [142.400460] Starting subtest: flink-lifetime [142.402511] Subtest flink-lifetime: SUCCESS (0.002s) [142.477949] [033/162] (918s left) gem_huc_copy (huc-copy) [142.547904] Starting subtest: huc-copy [142.549960] Subtest huc-copy: SKIP (0.000s) [142.631780] [034/162] (918s left) gem_linear_blits (basic) [142.801407] Starting subtest: basic [142.809839] Subtest basic: SUCCESS (0.009s) [142.988072] [035/162] (918s left) gem_mmap (basic) [143.146111] Starting subtest: basic [143.151455] Subtest basic: SUCCESS (0.001s) [143.244440] [036/162] (918s left) gem_mmap_gtt (basic) [143.301364] Starting subtest: basic [143.302280] Subtest basic: SUCCESS (0.001s) [143.359618] [037/162] (918s left) gem_render_linear_blits (basic) [143.426606] Starting subtest: basic [143.460863] Subtest basic: SUCCESS (0.035s) [143.526432] [038/162] (918s left) gem_render_tiled_blits (basic) [143.592770] Starting subtest: basic [143.634953] Subtest basic: SUCCESS (0.042s) [143.702873] [039/162] (918s left) gem_ringfill (basic-all) [143.992153] Starting subtest: basic-all [145.169996] Subtest basic-all: SUCCESS (1.173s) [145.251893] [040/162] (916s left) gem_softpin (allocator-basic) [145.328148] Starting subtest: allocator-basic [145.532742] Subtest allocator-basic: SUCCESS (0.148s) [145.586333] [041/162] (916s left) gem_softpin (allocator-basic-reserve) [145.657730] Starting subtest: allocator-basic-reserve [145.867959] Subtest allocator-basic-reserve: SUCCESS (0.154s) [145.926245] [042/162] (916s left) gem_softpin (safe-alignment) [146.005401] Starting subtest: safe-alignment [146.024156] Subtest safe-alignment: SUCCESS (0.019s) [146.114238] [043/162] (915s left) gem_sync (basic-all) [146.192434] Starting subtest: basic-all [148.807742] Subtest basic-all: SUCCESS (2.576s) [148.955094] [044/162] (913s left) gem_sync (basic-each) [149.038248] Starting subtest: basic-each [151.207517] Subtest basic-each: SUCCESS (2.158s) [151.502570] [045/162] (910s left) gem_tiled_blits (basic) [151.663681] Starting subtest: basic [151.682613] Subtest basic: SUCCESS (0.018s) [151.825943] [046/162] (910s left) gem_tiled_fence_blits (basic) [152.403163] Starting subtest: basic [152.414280] Subtest basic: SUCCESS (0.011s) [152.523774] [047/162] (909s left) gem_tiled_pread_basic (basic) [152.632133] Starting subtest: basic [152.810206] Subtest basic: SUCCESS (0.122s) [152.870820] [048/162] (909s left) gem_wait (busy@all-engines) [152.960891] Starting subtest: busy [152.962259] Starting dynamic subtest: all-engines [153.543435] Dynamic subtest all-engines: SUCCESS (0.581s) [153.545333] Subtest busy: SUCCESS (0.582s) [153.841701] [049/162] (908s left) gem_wait (wait@all-engines) [153.931841] Starting subtest: wait [153.932950] Starting dynamic subtest: all-engines [155.020781] Dynamic subtest all-engines: SUCCESS (1.039s) [155.023610] Subtest wait: SUCCESS (1.040s) [155.187839] [050/162] (907s left) i915_getparams_basic (basic-eu-total) [155.252660] Starting subtest: basic-eu-total [155.254871] Subtest basic-eu-total: SUCCESS (0.000s) [155.308820] [051/162] (907s left) i915_getparams_basic (basic-subslice-total) [155.366514] Starting subtest: basic-subslice-total [155.368695] Subtest basic-subslice-total: SUCCESS (0.000s) [155.424544] [052/162] (907s left) i915_hangman (error-state-basic) [155.503373] Starting subtest: error-state-basic [155.510126] Subtest error-state-basic: SUCCESS (0.007s) [155.677155] [053/162] (907s left) i915_pciid [155.958971] [054/162] (907s left) intel_hwmon (hwmon-read) [156.017669] Subtest hwmon-read: SKIP (0.000s) [156.069833] [055/162] (907s left) intel_hwmon (hwmon-write) [156.126305] Subtest hwmon-write: SKIP (0.000s) [156.182669] [056/162] (906s left) kms_addfb_basic (addfb25-4-tiled) [156.465584] Starting subtest: addfb25-4-tiled [156.466945] Subtest addfb25-4-tiled: SUCCESS (0.001s) [156.566616] [057/162] (906s left) kms_addfb_basic (addfb25-bad-modifier) [156.842497] Starting subtest: addfb25-bad-modifier [156.843649] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [156.925405] [058/162] (906s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [157.200769] Starting subtest: addfb25-framebuffer-vs-set-tiling [157.202142] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [157.289706] [059/162] (906s left) kms_addfb_basic (addfb25-modifier-no-flag) [157.561735] Starting subtest: addfb25-modifier-no-flag [157.563424] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [157.655631] [060/162] (905s left) kms_addfb_basic (addfb25-x-tiled-legacy) [157.928502] Starting subtest: addfb25-x-tiled-legacy [157.929577] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [158.016709] [061/162] (905s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [158.293472] Starting subtest: addfb25-x-tiled-mismatch-legacy [158.294644] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [158.382711] [062/162] (905s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [158.660623] Starting subtest: addfb25-yf-tiled-legacy [158.661702] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [158.748436] [063/162] (904s left) kms_addfb_basic (addfb25-y-tiled-legacy) [159.014397] Starting subtest: addfb25-y-tiled-legacy [159.015501] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [159.097144] [064/162] (904s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [159.378724] Starting subtest: addfb25-y-tiled-small-legacy [159.380148] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [159.468029] [065/162] (904s left) kms_addfb_basic (bad-pitch-0) [159.527312] Starting subtest: bad-pitch-0 [159.528733] Subtest bad-pitch-0: SUCCESS (0.000s) [159.816881] [066/162] (904s left) kms_addfb_basic (bad-pitch-1024) [159.874890] Starting subtest: bad-pitch-1024 [159.875912] Subtest bad-pitch-1024: SUCCESS (0.000s) [160.174636] [067/162] (903s left) kms_addfb_basic (bad-pitch-128) [160.231521] Starting subtest: bad-pitch-128 [160.232470] Subtest bad-pitch-128: SUCCESS (0.000s) [160.537594] [068/162] (903s left) kms_addfb_basic (bad-pitch-256) [160.595054] Starting subtest: bad-pitch-256 [160.595965] Subtest bad-pitch-256: SUCCESS (0.000s) [160.892140] [069/162] (903s left) kms_addfb_basic (bad-pitch-32) [160.950221] Starting subtest: bad-pitch-32 [160.951137] Subtest bad-pitch-32: SUCCESS (0.000s) [161.251596] [070/162] (902s left) kms_addfb_basic (bad-pitch-63) [161.310896] Starting subtest: bad-pitch-63 [161.311887] Subtest bad-pitch-63: SUCCESS (0.000s) [161.611093] [071/162] (902s left) kms_addfb_basic (bad-pitch-65536) [161.668456] Starting subtest: bad-pitch-65536 [161.669466] Subtest bad-pitch-65536: SUCCESS (0.000s) [161.968180] [072/162] (902s left) kms_addfb_basic (bad-pitch-999) [162.025260] Starting subtest: bad-pitch-999 [162.026219] Subtest bad-pitch-999: SUCCESS (0.000s) [162.325405] [073/162] (901s left) kms_addfb_basic (basic) [162.383280] Starting subtest: basic [162.384235] Subtest basic: SUCCESS (0.000s) [162.676468] [074/162] (901s left) kms_addfb_basic (basic-x-tiled-legacy) [162.744579] Starting subtest: basic-x-tiled-legacy [162.746045] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [163.044829] [075/162] (901s left) kms_addfb_basic (basic-y-tiled-legacy) [163.105415] Starting subtest: basic-y-tiled-legacy [163.106355] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [163.409962] [076/162] (901s left) kms_addfb_basic (bo-too-small) [163.680699] Starting subtest: bo-too-small [163.682406] Subtest bo-too-small: SUCCESS (0.001s) [163.778468] [077/162] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling) [164.042636] Starting subtest: bo-too-small-due-to-tiling [164.043730] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [164.129832] [078/162] (900s left) kms_addfb_basic (clobberred-modifier) [164.187559] Starting subtest: clobberred-modifier [164.188509] Subtest clobberred-modifier: SUCCESS (0.000s) [164.508718] [079/162] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling) [164.568466] Starting subtest: framebuffer-vs-set-tiling [164.569727] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [164.874266] [080/162] (899s left) kms_addfb_basic (invalid-get-prop) [164.931925] Starting subtest: invalid-get-prop [164.932972] Subtest invalid-get-prop: SUCCESS (0.000s) [165.240213] [081/162] (899s left) kms_addfb_basic (invalid-get-prop-any) [165.298392] Starting subtest: invalid-get-prop-any [165.299374] Subtest invalid-get-prop-any: SUCCESS (0.000s) [165.592247] [082/162] (899s left) kms_addfb_basic (invalid-set-prop) [165.650992] Starting subtest: invalid-set-prop [165.651950] Subtest invalid-set-prop: SUCCESS (0.000s) [165.952616] [083/162] (899s left) kms_addfb_basic (invalid-set-prop-any) [166.011277] Starting subtest: invalid-set-prop-any [166.012459] Subtest invalid-set-prop-any: SUCCESS (0.000s) [166.322037] [084/162] (898s left) kms_addfb_basic (no-handle) [166.380971] Starting subtest: no-handle [166.381980] Subtest no-handle: SUCCESS (0.000s) [166.692096] [085/162] (898s left) kms_addfb_basic (size-max) [166.976070] Starting subtest: size-max [166.977395] Subtest size-max: SUCCESS (0.000s) [167.073269] [086/162] (898s left) kms_addfb_basic (small-bo) [167.351952] Starting subtest: small-bo [167.353207] Subtest small-bo: SUCCESS (0.000s) [167.432760] [087/162] (897s left) kms_addfb_basic (tile-pitch-mismatch) [167.491494] Starting subtest: tile-pitch-mismatch [167.492908] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [167.794619] [088/162] (897s left) kms_addfb_basic (too-high) [168.068144] Starting subtest: too-high [168.069544] Subtest too-high: SUCCESS (0.002s) [168.155042] [089/162] (897s left) kms_addfb_basic (too-wide) [168.431988] Starting subtest: too-wide [168.433483] Subtest too-wide: SUCCESS (0.000s) [168.527662] [090/162] (896s left) kms_addfb_basic (unused-handle) [168.584844] Starting subtest: unused-handle [168.585888] Subtest unused-handle: SUCCESS (0.000s) [168.892137] [091/162] (896s left) kms_addfb_basic (unused-modifier) [168.950854] Starting subtest: unused-modifier [168.951893] Subtest unused-modifier: SUCCESS (0.000s) [169.244074] [092/162] (896s left) kms_addfb_basic (unused-offsets) [169.301706] Starting subtest: unused-offsets [169.302862] Subtest unused-offsets: SUCCESS (0.000s) [169.599165] [093/162] (896s left) kms_addfb_basic (unused-pitches) [169.656485] Starting subtest: unused-pitches [169.657445] Subtest unused-pitches: SUCCESS (0.000s) [169.956833] [094/162] (895s left) kms_busy (basic) [170.239921] Subtest basic: SKIP (0.000s) [170.306609] [095/162] (895s left) kms_prop_blob (basic) [170.367590] Starting subtest: basic [170.368511] Subtest basic: SUCCESS (0.000s) [170.421844] [096/162] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [170.692969] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [170.751494] [097/162] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [171.033892] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [171.092831] [098/162] (894s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [171.367646] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [171.424451] [099/162] (894s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [171.703998] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [171.762208] [100/162] (894s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [172.041749] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [172.102212] [101/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [172.383064] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [172.441548] [102/162] (893s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [172.725536] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [172.787852] [103/162] (893s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [173.066388] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [173.133464] [104/162] (893s left) kms_dsc (dsc-basic) [173.397852] Subtest dsc-basic: SKIP (0.000s) [173.461827] [105/162] (892s left) kms_flip (basic-flip-vs-dpms) [173.731763] Starting subtest: basic-flip-vs-dpms [173.735637] Subtest basic-flip-vs-dpms: SKIP (0.002s) [173.811545] [106/162] (892s left) kms_flip (basic-flip-vs-modeset) [174.089203] Starting subtest: basic-flip-vs-modeset [174.091832] Subtest basic-flip-vs-modeset: SKIP (0.003s) [174.169996] [107/162] (892s left) kms_flip (basic-flip-vs-wf_vblank) [174.439891] Starting subtest: basic-flip-vs-wf_vblank [174.443774] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s) [174.521886] [108/162] (892s left) kms_flip (basic-plain-flip) [174.787847] Starting subtest: basic-plain-flip [174.793316] Subtest basic-plain-flip: SKIP (0.003s) [174.876778] [109/162] (891s left) kms_force_connector_basic (force-connector-state) [175.265163] Starting subtest: force-connector-state [176.053324] Subtest force-connector-state: SUCCESS (0.788s) [176.639118] [110/162] (890s left) kms_force_connector_basic (force-edid) [177.033088] Starting subtest: force-edid [177.705306] Subtest force-edid: SUCCESS (0.672s) [178.216977] [111/162] (888s left) kms_force_connector_basic (force-load-detect) [178.605454] Starting subtest: force-load-detect [178.608028] Subtest force-load-detect: SKIP (0.000s) [178.992158] [112/162] (887s left) kms_force_connector_basic (prune-stale-modes) [179.384808] Starting subtest: prune-stale-modes [180.124365] Subtest prune-stale-modes: SUCCESS (0.740s) [180.616450] [113/162] (886s left) kms_frontbuffer_tracking (basic) [180.887136] Subtest basic: SKIP (0.000s) [180.962346] [114/162] (886s left) kms_hdmi_inject (inject-audio) [181.024238] Starting subtest: inject-audio [181.654594] Subtest inject-audio: SUCCESS (0.630s) [181.920353] [115/162] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [182.187079] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [182.261714] [116/162] (884s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [182.530539] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [182.603451] [117/162] (884s left) kms_pipe_crc_basic (hang-read-crc) [182.873209] Subtest hang-read-crc: SKIP (0.000s) [182.939576] [118/162] (884s left) kms_pipe_crc_basic (nonblocking-crc) [183.206731] Subtest nonblocking-crc: SKIP (0.000s) [183.284727] [119/162] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [183.559755] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [183.629702] [120/162] (883s left) kms_pipe_crc_basic (read-crc) [183.903845] Subtest read-crc: SKIP (0.000s) [183.969835] [121/162] (883s left) kms_pipe_crc_basic (read-crc-frame-sequence) [184.240571] Subtest read-crc-frame-sequence: SKIP (0.000s) [184.312652] [122/162] (883s left) kms_pm_backlight (basic-brightness) [184.586080] Subtest basic-brightness: SKIP (0.000s) [184.659782] [123/162] (882s left) kms_pm_rpm (basic-pci-d3-state) [186.305732] Starting subtest: basic-pci-d3-state [186.620067] Subtest basic-pci-d3-state: SUCCESS (0.318s) [186.793352] [124/162] (880s left) kms_pm_rpm (basic-rte) [186.848940] Starting subtest: basic-rte [188.708477] Subtest basic-rte: SUCCESS (1.856s) [189.176526] [125/162] (878s left) kms_psr (psr-primary-page-flip) [189.455212] Subtest psr-primary-page-flip: SKIP (0.000s) [189.533269] [126/162] (878s left) kms_psr (psr-cursor-plane-move) [189.794094] Subtest psr-cursor-plane-move: SKIP (0.000s) [189.869083] [127/162] (877s left) kms_psr (psr-sprite-plane-onoff) [190.135445] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [190.219098] [128/162] (877s left) kms_psr (psr-primary-mmap-gtt) [190.485153] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [190.553713] [129/162] (877s left) kms_setmode (basic-clone-single-crtc) [190.612453] Starting subtest: basic-clone-single-crtc [190.615755] Subtest basic-clone-single-crtc: SKIP (0.000s) [190.676088] [130/162] (877s left) i915_pm_rps (basic-api) [190.747086] Starting subtest: basic-api [190.751480] Subtest basic-api: SUCCESS (0.005s) [190.835078] [131/162] (877s left) prime_self_import (basic-llseek-bad) [190.891980] Starting subtest: basic-llseek-bad [190.895918] Subtest basic-llseek-bad: SUCCESS (0.003s) [190.981540] [132/162] (877s left) prime_self_import (basic-llseek-size) [191.036441] Starting subtest: basic-llseek-size [191.040500] Subtest basic-llseek-size: SUCCESS (0.004s) [191.121678] [133/162] (877s left) prime_self_import (basic-with_fd_dup) [191.181376] Starting subtest: basic-with_fd_dup [191.183416] Subtest basic-with_fd_dup: SUCCESS (0.004s) [191.260940] [134/162] (877s left) prime_self_import (basic-with_one_bo) [191.317286] Starting subtest: basic-with_one_bo [191.320479] Subtest basic-with_one_bo: SUCCESS (0.004s) [191.383670] [135/162] (876s left) prime_self_import (basic-with_one_bo_two_files) [191.440154] Starting subtest: basic-with_one_bo_two_files [191.443553] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [191.527374] [136/162] (876s left) prime_self_import (basic-with_two_bos) [191.581322] Starting subtest: basic-with_two_bos [191.586130] Subtest basic-with_two_bos: SUCCESS (0.005s) [191.671991] [137/162] (876s left) prime_vgem (basic-fence-flip) [191.738478] Starting subtest: basic-fence-flip [191.948433] Subtest basic-fence-flip: SKIP (0.207s) [192.027700] [138/162] (876s left) prime_vgem (basic-fence-mmap) [192.095837] Starting subtest: basic-fence-mmap [192.126943] Subtest basic-fence-mmap: SUCCESS (0.031s) [192.210028] [139/162] (876s left) prime_vgem (basic-fence-read) [192.278682] Starting subtest: basic-fence-read [192.350581] Subtest basic-fence-read: SUCCESS (0.070s) [192.414471] [140/162] (876s left) prime_vgem (basic-gtt) [192.481672] Starting subtest: basic-gtt [192.495785] Subtest basic-gtt: SUCCESS (0.015s) [192.579029] [141/162] (876s left) prime_vgem (basic-read) [192.651509] Starting subtest: basic-read [192.686911] Subtest basic-read: SUCCESS (0.035s) [192.780457] [142/162] (875s left) prime_vgem (basic-write) [192.850184] Starting subtest: basic-write [192.885877] Subtest basic-write: SUCCESS (0.037s) [192.953545] [143/162] (875s left) vgem_basic (setversion) [193.013687] Starting subtest: setversion [193.015426] Subtest setversion: SUCCESS (0.000s) [193.075166] [144/162] (875s left) vgem_basic (create) [193.134046] Starting subtest: create [193.134971] Subtest create: SUCCESS (0.000s) [193.193374] [145/162] (875s left) vgem_basic (debugfs) [193.252331] Starting subtest: debugfs [193.253278] Subtest debugfs: SUCCESS (0.001s) [193.313611] [146/162] (875s left) vgem_basic (dmabuf-export) [193.371924] Starting subtest: dmabuf-export [193.375896] Subtest dmabuf-export: SUCCESS (0.003s) [193.454730] [147/162] (875s left) vgem_basic (dmabuf-fence) [193.514529] Starting subtest: dmabuf-fence [193.515936] Subtest dmabuf-fence: SUCCESS (0.002s) [193.577994] [148/162] (875s left) vgem_basic (dmabuf-fence-before) [193.639692] Starting subtest: dmabuf-fence-before [193.640640] Subtest dmabuf-fence-before: SUCCESS (0.001s) [193.699319] [149/162] (875s left) vgem_basic (dmabuf-mmap) [193.756335] Starting subtest: dmabuf-mmap [193.767469] Subtest dmabuf-mmap: SUCCESS (0.012s) [193.829151] [150/162] (875s left) vgem_basic (mmap) [193.890437] Starting subtest: mmap [193.899387] Subtest mmap: SUCCESS (0.011s) [193.962232] [151/162] (875s left) vgem_basic (second-client) [194.021360] Starting subtest: second-client [194.024576] Subtest second-client: SUCCESS (0.004s) [194.083267] [152/162] (875s left) vgem_basic (sysfs) [194.143256] Starting subtest: sysfs [194.144221] Subtest sysfs: SUCCESS (0.001s) [194.202973] [153/162] (875s left) core_hotunplug (unbind-rebind) [194.309688] Starting subtest: unbind-rebind [198.428413] Subtest unbind-rebind: SUCCESS (4.119s) [198.488287] [154/162] (871s left) vgem_basic (unload) [198.547465] Starting subtest: unload [227.502147] Subtest unload: SUCCESS (28.900s) [227.558301] [155/162] (841s left) i915_module_load (reload) [227.621423] Starting subtest: reload [230.986024] Subtest reload: SUCCESS (3.364s) [231.078058] [156/162] (838s left) gem_lmem_swapping (basic) [231.308511] Subtest basic: SKIP (0.000s) [231.401241] [157/162] (838s left) gem_lmem_swapping (parallel-random-engines) [231.466061] Subtest parallel-random-engines: SKIP (0.000s) [231.521374] [158/162] (838s left) gem_lmem_swapping (random-engines) [231.585868] Subtest random-engines: SKIP (0.000s) [231.642198] [159/162] (838s left) gem_lmem_swapping (verify-random) [231.706279] Subtest verify-random: SKIP (0.000s) [231.761468] [160/162] (838s left) i915_pm_rpm (module-reload) [234.866684] Starting subtest: module-reload [249.263829] Subtest module-reload: SUCCESS (14.346s) [249.328999] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [249.330497] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [249.333291] [161/162] (820s left) i915_selftest (live) [249.405431] Starting subtest: live [249.406665] Starting dynamic subtest: sanitycheck [251.933148] Dynamic subtest sanitycheck: SUCCESS (2.471s) [251.943847] Starting dynamic subtest: uncore [254.395341] Dynamic subtest uncore: SUCCESS (2.461s) [254.409259] Starting dynamic subtest: workarounds [257.254060] Dynamic subtest workarounds: SUCCESS (2.858s) [257.264773] Starting dynamic subtest: gt_engines [260.269274] Dynamic subtest gt_engines: SUCCESS (3.014s) [260.279985] Starting dynamic subtest: gt_timelines [276.821881] Dynamic subtest gt_timelines: SUCCESS (16.551s) [276.832607] Starting dynamic subtest: gt_contexts [279.441169] Dynamic subtest gt_contexts: SUCCESS (2.619s) [279.451946] Starting dynamic subtest: gt_lrc [285.031873] Dynamic subtest gt_lrc: SUCCESS (5.589s) [285.045949] Starting dynamic subtest: gt_mocs [287.600873] Dynamic subtest gt_mocs: SUCCESS (2.569s) [287.611562] Starting dynamic subtest: gt_pm [298.820177] Dynamic subtest gt_pm: SUCCESS (11.218s) [298.834284] Starting dynamic subtest: gt_heartbeat [301.322264] Dynamic subtest gt_heartbeat: SUCCESS (2.501s) [301.333033] Starting dynamic subtest: gt_tlb [305.504059] Dynamic subtest gt_tlb: SUCCESS (4.181s) [305.514806] Starting dynamic subtest: requests [315.367055] Dynamic subtest requests: SUCCESS (9.860s) [315.377949] Starting dynamic subtest: migrate [320.771507] Dynamic subtest migrate: SUCCESS (5.403s) [320.784646] Starting dynamic subtest: active [323.239299] Dynamic subtest active: SUCCESS (2.466s) [323.253343] Starting dynamic subtest: objects [326.614339] Dynamic subtest objects: SUCCESS (3.373s) [326.628420] Starting dynamic subtest: mman [332.673292] Dynamic subtest mman: SUCCESS (6.057s) [332.684216] Starting dynamic subtest: dmabuf [335.201092] Dynamic subtest dmabuf: SUCCESS (2.527s) [335.211927] Starting dynamic subtest: vma [337.626731] Dynamic subtest vma: SUCCESS (2.454s) [337.639768] Starting dynamic subtest: coherency [342.456138] Dynamic subtest coherency: SUCCESS (4.797s) [342.466989] Starting dynamic subtest: gtt [351.992962] Dynamic subtest gtt: SUCCESS (9.565s) [352.006054] Starting dynamic subtest: gem [354.995324] Dynamic subtest gem: SUCCESS (2.970s) [355.006266] Starting dynamic subtest: evict [359.772709] Dynamic subtest evict: SUCCESS (4.775s) [359.783546] Starting dynamic subtest: hugepages [368.748898] Dynamic subtest hugepages: SUCCESS (8.974s) [368.759743] Starting dynamic subtest: gem_contexts [388.297968] Dynamic subtest gem_contexts: SUCCESS (19.547s) [388.312411] Starting dynamic subtest: client [390.828868] Dynamic subtest client: SUCCESS (2.529s) [390.839733] Starting dynamic subtest: gem_migrate [393.291206] Dynamic subtest gem_migrate: SUCCESS (2.461s) [393.302184] Starting dynamic subtest: reset [396.217285] Dynamic subtest reset: SUCCESS (2.924s) [396.228150] Starting dynamic subtest: memory_region [398.699504] Dynamic subtest memory_region: SUCCESS (2.480s) [398.713627] Starting dynamic subtest: hangcheck [429.893013] Dynamic subtest hangcheck: SUCCESS (31.191s) [429.907210] Starting dynamic subtest: execlists [445.583252] Dynamic subtest execlists: SUCCESS (15.688s) [445.594128] Starting dynamic subtest: ring_submission [448.071214] Dynamic subtest ring_submission: SUCCESS (2.486s) [448.082075] Starting dynamic subtest: perf [450.600986] Dynamic subtest perf: SUCCESS (2.528s) [450.611928] Starting dynamic subtest: slpc [453.058149] Dynamic subtest slpc: SUCCESS (2.455s) [453.069096] Starting dynamic subtest: guc [455.526011] Dynamic subtest guc: SUCCESS (2.466s) [455.536928] Starting dynamic subtest: guc_multi_lrc [458.006768] Dynamic subtest guc_multi_lrc: SUCCESS (2.478s) [458.020955] Starting dynamic subtest: guc_hang [460.463059] Dynamic subtest guc_hang: SUCCESS (2.455s) [460.473959] Starting dynamic subtest: late_gt_pm [462.998228] Dynamic subtest late_gt_pm: SUCCESS (2.533s) [463.000305] Subtest live: SUCCESS (213.530s) [463.066630] [162/162] (606s left) dmabuf (all-tests) [463.137982] Starting subtest: all-tests [463.141153] Starting dynamic subtest: sanitycheck [463.207997] Dynamic subtest sanitycheck: SUCCESS (0.068s) [463.236519] Starting dynamic subtest: dma_fence [463.384723] Dynamic subtest dma_fence: SUCCESS (0.172s) [463.399136] Starting dynamic subtest: dma_fence_chain [463.401252] Dynamic subtest dma_fence_chain: SKIP (0.000s) [463.413754] Starting dynamic subtest: dma_fence_unwrap [463.454818] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s) [463.475506] Starting dynamic subtest: dma_resv [463.525267] Dynamic subtest dma_resv: SUCCESS (0.067s) [463.532814] Subtest all-tests: SUCCESS (0.390s) [463.608680] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.