[42.966819] Initializing watchdogs [42.967189] /dev/watchdog0 [42.999245] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0042 Intel Ironlake (Gen5) Core Processor Integrated Graphics Controller [43.028193] [001/162] (960s left) i915_module_load (load) [43.201573] Starting subtest: load [45.206355] Subtest load: SUCCESS (1.999s) [45.336445] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [45.339112] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [45.363459] [002/162] (958s left) core_auth (basic-auth) [45.540143] Starting subtest: basic-auth [45.562858] Subtest basic-auth: SUCCESS (0.002s) [45.717571] [003/162] (958s left) core_debugfs (read-all-entries) [45.886954] Starting subtest: read-all-entries [45.929340] Subtest read-all-entries: SUCCESS (0.076s) [46.104179] [004/162] (957s left) core_sysfs (read-all-entries) [46.275558] Starting subtest: read-all-entries [46.295529] Subtest read-all-entries: SUCCESS (0.006s) [46.455675] [005/162] (957s left) fbdev (eof) [46.612523] Starting subtest: eof [46.634276] Subtest eof: SUCCESS (0.000s) [46.796636] [006/162] (957s left) fbdev (info) [46.947245] Starting subtest: info [46.969110] Subtest info: SUCCESS (0.000s) [47.121461] [007/162] (957s left) fbdev (nullptr) [47.292077] Starting subtest: nullptr [47.312669] Subtest nullptr: SUCCESS (0.000s) [47.463754] [008/162] (957s left) fbdev (read) [47.628534] Starting subtest: read [47.924972] Subtest read: SUCCESS (0.292s) [48.080882] [009/162] (956s left) fbdev (write) [48.226916] Starting subtest: write [48.341842] Subtest write: SUCCESS (0.145s) [48.498852] [010/162] (956s left) gem_basic (bad-close) [48.689942] Starting subtest: bad-close [48.728721] Subtest bad-close: SUCCESS (0.000s) [48.893790] [011/162] (956s left) gem_basic (create-close) [49.059168] Starting subtest: create-close [49.102660] Subtest create-close: SUCCESS (0.000s) [49.260583] [012/162] (955s left) gem_basic (create-fd-close) [49.428338] Starting subtest: create-fd-close [49.469159] Subtest create-fd-close: SUCCESS (0.000s) [49.621269] [013/162] (955s left) gem_busy (busy@all-engines) [49.796883] Starting subtest: busy [49.816433] Starting dynamic subtest: all-engines [49.837438] Dynamic subtest all-engines: SUCCESS (0.034s) [49.859323] Subtest busy: SUCCESS (0.035s) [50.261241] [014/162] (955s left) gem_close_race (basic-process) [50.453444] Starting subtest: basic-process [50.497634] Subtest basic-process: SUCCESS (0.063s) [50.763999] [015/162] (954s left) gem_close_race (basic-threads) [50.933265] Starting subtest: basic-threads [52.161335] Subtest basic-threads: SUCCESS (1.273s) [52.447314] [016/162] (953s left) gem_ctx_create (basic) [52.619330] Starting subtest: basic [52.640109] Subtest basic: SUCCESS (0.000s) [52.884360] [017/162] (953s left) gem_ctx_create (basic-files) [53.047779] Starting subtest: basic-files [55.072271] Subtest basic-files: SUCCESS (2.054s) [55.367120] [018/162] (950s left) gem_ctx_exec (basic) [55.540572] Starting subtest: basic [55.560508] Subtest basic: SUCCESS (0.001s) [55.718710] [019/162] (950s left) gem_exec_basic (basic) [55.889460] Starting subtest: basic [55.910760] Starting dynamic subtest: rcs0-smem [55.931494] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.964561] Starting dynamic subtest: vcs0-smem [55.983488] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [56.002467] Subtest basic: SUCCESS (0.003s) [56.156687] [020/162] (950s left) gem_exec_create (basic) [56.349427] Starting subtest: basic [56.370881] Starting dynamic subtest: smem [58.350880] Dynamic subtest smem: SUCCESS (2.067s) [58.369927] Subtest basic: SUCCESS (2.068s) [58.640262] [021/162] (947s left) gem_exec_fence (basic-busy) [58.917324] Starting subtest: basic-busy [58.936451] Starting dynamic subtest: rcs0 [58.978651] Dynamic subtest rcs0: SUCCESS (0.026s) [59.011835] Starting dynamic subtest: vcs0 [59.054086] Dynamic subtest vcs0: SUCCESS (0.021s) [59.073203] Subtest basic-busy: SUCCESS (0.049s) [59.619794] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [59.645592] [022/162] (947s left) gem_exec_fence (basic-wait) [59.906637] Starting subtest: basic-wait [59.931362] Starting dynamic subtest: rcs0 [59.955595] Dynamic subtest rcs0: SUCCESS (0.017s) [59.989707] Starting dynamic subtest: vcs0 [60.011965] Dynamic subtest vcs0: SUCCESS (0.020s) [60.035421] Subtest basic-wait: SUCCESS (0.038s) [60.541794] [023/162] (946s left) gem_exec_fence (basic-await) [60.833307] Starting subtest: basic-await [60.857367] Starting dynamic subtest: rcs0 [60.901768] Dynamic subtest rcs0: SUCCESS (0.074s) [60.939772] Starting dynamic subtest: vcs0 [60.989626] Dynamic subtest vcs0: SUCCESS (0.072s) [61.014176] Subtest basic-await: SUCCESS (0.149s) [61.545428] [024/162] (945s left) gem_exec_fence (nb-await) [61.828775] Starting subtest: nb-await [61.850431] Starting dynamic subtest: rcs0 [61.892674] Dynamic subtest rcs0: SUCCESS (0.055s) [61.924105] Starting dynamic subtest: vcs0 [61.943756] Dynamic subtest vcs0: SUCCESS (0.054s) [61.963605] Subtest nb-await: SUCCESS (0.111s) [62.507819] [025/162] (944s left) gem_exec_gttfill (basic) [62.698395] Starting subtest: basic [72.690975] Subtest basic: SUCCESS (10.059s) [73.000298] [026/162] (934s left) gem_exec_parallel (engines) [73.288797] Starting subtest: engines [73.307642] Starting dynamic subtest: basic [77.919326] Dynamic subtest basic: SUCCESS (4.649s) [77.949985] Starting dynamic subtest: contexts [79.995231] Dynamic subtest contexts: SUCCESS (2.086s) [80.028352] Starting dynamic subtest: fds [80.069828] Dynamic subtest fds: SKIP (0.001s) [80.102326] Starting dynamic subtest: userptr [86.541148] Dynamic subtest userptr: SUCCESS (6.355s) [86.561546] Subtest engines: SUCCESS (13.095s) [86.725365] [027/162] (920s left) gem_exec_store (basic) [86.984196] Starting subtest: basic [87.003829] Subtest basic: SUCCESS (0.047s) [87.227650] [028/162] (920s left) gem_flink_basic (bad-flink) [87.396438] Starting subtest: bad-flink [87.417845] Subtest bad-flink: SUCCESS (0.000s) [87.578467] [029/162] (920s left) gem_flink_basic (bad-open) [87.765812] Starting subtest: bad-open [87.785598] Subtest bad-open: SUCCESS (0.000s) [87.946507] [030/162] (920s left) gem_flink_basic (basic) [88.115908] Starting subtest: basic [88.135601] Subtest basic: SUCCESS (0.000s) [88.299724] [031/162] (919s left) gem_flink_basic (double-flink) [88.444974] Starting subtest: double-flink [88.466501] Subtest double-flink: SUCCESS (0.000s) [88.630933] [032/162] (919s left) gem_flink_basic (flink-lifetime) [88.795633] Starting subtest: flink-lifetime [88.817348] Subtest flink-lifetime: SUCCESS (0.002s) [88.979570] [033/162] (919s left) gem_huc_copy (huc-copy) [89.152665] Subtest huc-copy: SKIP (0.000s) [89.311583] [034/162] (919s left) gem_linear_blits (basic) [89.531927] Starting subtest: basic [89.552164] Subtest basic: SUCCESS (0.021s) [89.766276] [035/162] (919s left) gem_mmap (basic) [90.059491] Starting subtest: basic [90.160524] Subtest basic: SUCCESS (0.001s) [90.322440] [036/162] (918s left) gem_mmap_gtt (basic) [90.491438] Starting subtest: basic [90.513250] Subtest basic: SUCCESS (0.001s) [90.678334] [037/162] (918s left) gem_render_linear_blits (basic) [90.851989] Starting subtest: basic [90.952162] Subtest basic: SUCCESS (0.037s) [91.113391] [038/162] (918s left) gem_render_tiled_blits (basic) [91.281528] Starting subtest: basic [91.405306] Subtest basic: SUCCESS (0.044s) [91.566159] [039/162] (917s left) gem_ringfill (basic-all) [91.800030] Starting subtest: basic-all [92.882142] Subtest basic-all: SUCCESS (1.104s) [93.069382] [040/162] (916s left) gem_softpin (allocator-basic) [93.278798] Subtest allocator-basic: SKIP (0.000s) [93.463518] [041/162] (916s left) gem_softpin (allocator-basic-reserve) [93.650457] Subtest allocator-basic-reserve: SKIP (0.000s) [93.831826] [042/162] (916s left) gem_softpin (safe-alignment) [94.030144] Starting subtest: safe-alignment [94.049913] Subtest safe-alignment: SUCCESS (0.008s) [94.215618] [043/162] (915s left) gem_sync (basic-all) [94.423480] Starting subtest: basic-all [96.435916] Subtest basic-all: SUCCESS (2.063s) [96.725728] [044/162] (913s left) gem_sync (basic-each) [96.928180] Starting subtest: basic-each [98.952336] Subtest basic-each: SUCCESS (2.076s) [99.236194] [045/162] (911s left) gem_tiled_blits (basic) [99.460706] Starting subtest: basic [99.502949] Subtest basic: SUCCESS (0.036s) [99.709579] [046/162] (910s left) gem_tiled_fence_blits (basic) [100.055529] Starting subtest: basic [100.075363] Subtest basic: SUCCESS (0.016s) [100.289063] [047/162] (910s left) gem_tiled_pread_basic (basic) [100.579488] Starting subtest: basic [100.781457] Subtest basic: SUCCESS (0.236s) [100.978762] [048/162] (909s left) gem_wait (busy@all-engines) [101.146595] Starting subtest: busy [101.165088] Starting dynamic subtest: all-engines [101.643667] Dynamic subtest all-engines: SUCCESS (0.515s) [101.665483] Subtest busy: SUCCESS (0.516s) [101.952149] [049/162] (909s left) gem_wait (wait@all-engines) [102.114815] Starting subtest: wait [102.136297] Starting dynamic subtest: all-engines [103.142311] Dynamic subtest all-engines: SUCCESS (1.028s) [103.161806] Subtest wait: SUCCESS (1.028s) [103.461388] [050/162] (907s left) i915_getparams_basic (basic-eu-total) [103.645940] Starting subtest: basic-eu-total [103.689292] Subtest basic-eu-total: SUCCESS (0.000s) [103.847095] [051/162] (907s left) i915_getparams_basic (basic-subslice-total) [104.018741] Starting subtest: basic-subslice-total [104.057664] Subtest basic-subslice-total: SUCCESS (0.000s) [104.226322] [052/162] (907s left) i915_hangman (error-state-basic) [104.395821] Starting subtest: error-state-basic [104.416232] Subtest error-state-basic: SUCCESS (0.006s) [104.611424] [053/162] (907s left) i915_pciid [104.961432] [054/162] (906s left) intel_hwmon (hwmon-read) [105.133551] Subtest hwmon-read: SKIP (0.000s) [105.292337] [055/162] (906s left) intel_hwmon (hwmon-write) [105.473579] Subtest hwmon-write: SKIP (0.000s) [105.654801] [056/162] (906s left) kms_addfb_basic (addfb25-4-tiled) [105.964712] Starting subtest: addfb25-4-tiled [105.988498] Subtest addfb25-4-tiled: SUCCESS (0.000s) [106.175977] [057/162] (906s left) kms_addfb_basic (addfb25-bad-modifier) [106.385926] Starting subtest: addfb25-bad-modifier [106.408407] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [106.604230] [058/162] (905s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [106.790782] Starting subtest: addfb25-framebuffer-vs-set-tiling [106.816049] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [107.008975] [059/162] (905s left) kms_addfb_basic (addfb25-modifier-no-flag) [107.181723] Starting subtest: addfb25-modifier-no-flag [107.208832] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [107.376086] [060/162] (905s left) kms_addfb_basic (addfb25-x-tiled-legacy) [107.527106] Starting subtest: addfb25-x-tiled-legacy [107.546423] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [107.707121] [061/162] (905s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [107.892284] Starting subtest: addfb25-x-tiled-mismatch-legacy [107.918134] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [108.089874] [062/162] (905s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [108.280689] Starting subtest: addfb25-yf-tiled-legacy [108.302566] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [108.463487] [063/162] (904s left) kms_addfb_basic (addfb25-y-tiled-legacy) [108.634134] Starting subtest: addfb25-y-tiled-legacy [108.653302] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [108.814694] [064/162] (904s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [108.985288] Starting subtest: addfb25-y-tiled-small-legacy [109.026260] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [109.193357] [065/162] (904s left) kms_addfb_basic (bad-pitch-0) [109.361050] Starting subtest: bad-pitch-0 [109.382385] Subtest bad-pitch-0: SUCCESS (0.000s) [109.565203] [066/162] (904s left) kms_addfb_basic (bad-pitch-1024) [109.736648] Starting subtest: bad-pitch-1024 [109.756108] Subtest bad-pitch-1024: SUCCESS (0.000s) [109.922628] [067/162] (904s left) kms_addfb_basic (bad-pitch-128) [110.086351] Starting subtest: bad-pitch-128 [110.105138] Subtest bad-pitch-128: SUCCESS (0.000s) [110.302415] [068/162] (903s left) kms_addfb_basic (bad-pitch-256) [110.470427] Starting subtest: bad-pitch-256 [110.491671] Subtest bad-pitch-256: SUCCESS (0.000s) [110.657382] [069/162] (903s left) kms_addfb_basic (bad-pitch-32) [110.849802] Starting subtest: bad-pitch-32 [110.869128] Subtest bad-pitch-32: SUCCESS (0.000s) [111.034705] [070/162] (903s left) kms_addfb_basic (bad-pitch-63) [111.222990] Starting subtest: bad-pitch-63 [111.244604] Subtest bad-pitch-63: SUCCESS (0.000s) [111.422600] [071/162] (903s left) kms_addfb_basic (bad-pitch-65536) [111.588262] Starting subtest: bad-pitch-65536 [111.609294] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.771327] [072/162] (903s left) kms_addfb_basic (bad-pitch-999) [111.945581] Starting subtest: bad-pitch-999 [111.964312] Subtest bad-pitch-999: SUCCESS (0.000s) [112.126445] [073/162] (902s left) kms_addfb_basic (basic) [112.294469] Starting subtest: basic [112.313688] Subtest basic: SUCCESS (0.000s) [112.479591] [074/162] (902s left) kms_addfb_basic (basic-x-tiled-legacy) [112.667115] Starting subtest: basic-x-tiled-legacy [112.688702] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.856369] [075/162] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [113.025808] Starting subtest: basic-y-tiled-legacy [113.046632] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [113.205749] [076/162] (902s left) kms_addfb_basic (bo-too-small) [113.398828] Starting subtest: bo-too-small [113.418167] Subtest bo-too-small: SUCCESS (0.001s) [113.586141] [077/162] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.755116] Starting subtest: bo-too-small-due-to-tiling [113.776285] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [113.942760] [078/162] (901s left) kms_addfb_basic (clobberred-modifier) [114.111692] Starting subtest: clobberred-modifier [114.132827] Subtest clobberred-modifier: SUCCESS (0.000s) [114.296610] [079/162] (901s left) kms_addfb_basic (framebuffer-vs-set-tiling) [114.467856] Starting subtest: framebuffer-vs-set-tiling [114.486608] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [114.651689] [080/162] (901s left) kms_addfb_basic (invalid-get-prop) [114.823068] Starting subtest: invalid-get-prop [114.842116] Subtest invalid-get-prop: SUCCESS (0.000s) [115.011966] [081/162] (901s left) kms_addfb_basic (invalid-get-prop-any) [115.156692] Starting subtest: invalid-get-prop-any [115.178346] Subtest invalid-get-prop-any: SUCCESS (0.000s) [115.346967] [082/162] (901s left) kms_addfb_basic (invalid-set-prop) [115.534620] Starting subtest: invalid-set-prop [115.555615] Subtest invalid-set-prop: SUCCESS (0.000s) [115.718588] [083/162] (900s left) kms_addfb_basic (invalid-set-prop-any) [115.886191] Starting subtest: invalid-set-prop-any [115.905938] Subtest invalid-set-prop-any: SUCCESS (0.000s) [116.070140] [084/162] (900s left) kms_addfb_basic (no-handle) [116.252499] Starting subtest: no-handle [116.274271] Subtest no-handle: SUCCESS (0.000s) [116.439098] [085/162] (900s left) kms_addfb_basic (size-max) [116.626816] Starting subtest: size-max [116.647476] Subtest size-max: SUCCESS (0.000s) [116.809461] [086/162] (900s left) kms_addfb_basic (small-bo) [116.998659] Starting subtest: small-bo [117.017855] Subtest small-bo: SUCCESS (0.000s) [117.185355] [087/162] (900s left) kms_addfb_basic (tile-pitch-mismatch) [117.375621] Starting subtest: tile-pitch-mismatch [117.396385] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [117.559579] [088/162] (899s left) kms_addfb_basic (too-high) [117.751999] Starting subtest: too-high [117.771571] Subtest too-high: SUCCESS (0.002s) [117.935756] [089/162] (899s left) kms_addfb_basic (too-wide) [118.119297] Starting subtest: too-wide [118.141061] Subtest too-wide: SUCCESS (0.000s) [118.317889] [090/162] (899s left) kms_addfb_basic (unused-handle) [118.507064] Starting subtest: unused-handle [118.527494] Subtest unused-handle: SUCCESS (0.000s) [118.688575] [091/162] (899s left) kms_addfb_basic (unused-modifier) [118.853176] Starting subtest: unused-modifier [118.872962] Subtest unused-modifier: SUCCESS (0.000s) [119.039048] [092/162] (898s left) kms_addfb_basic (unused-offsets) [119.224037] Starting subtest: unused-offsets [119.246054] Subtest unused-offsets: SUCCESS (0.000s) [119.410673] [093/162] (898s left) kms_addfb_basic (unused-pitches) [119.576755] Starting subtest: unused-pitches [119.597795] Subtest unused-pitches: SUCCESS (0.000s) [119.761255] [094/162] (898s left) kms_busy (basic) [119.955231] Starting subtest: basic [119.974835] Starting dynamic subtest: flip [120.529246] Dynamic subtest flip: SUCCESS (0.575s) [120.566984] Starting dynamic subtest: modeset [121.164714] Dynamic subtest modeset: SUCCESS (0.649s) [121.187310] Subtest basic: SUCCESS (1.227s) [121.435261] [095/162] (897s left) kms_prop_blob (basic) [121.613729] Starting subtest: basic [121.633789] Subtest basic: SUCCESS (0.000s) [121.792612] [096/162] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [121.987816] Starting subtest: basic-busy-flip-before-cursor-atomic [122.904563] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.939s) [123.174570] [097/162] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [123.336350] Starting subtest: basic-busy-flip-before-cursor-legacy [124.296882] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.953s) [124.562065] [098/162] (894s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [124.748246] Starting subtest: basic-flip-after-cursor-atomic [125.674423] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.951s) [125.956953] [099/162] (893s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [126.144602] Starting subtest: basic-flip-after-cursor-legacy [127.071032] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.945s) [127.360292] [100/162] (891s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [127.524396] Starting subtest: basic-flip-after-cursor-varying-size [128.444307] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.936s) [128.705359] [101/162] (890s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [128.884936] Starting subtest: basic-flip-before-cursor-atomic [129.818272] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.933s) [130.058797] [102/162] (889s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [130.224180] Starting subtest: basic-flip-before-cursor-legacy [131.162881] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.928s) [131.404860] [103/162] (888s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [131.594233] Starting subtest: basic-flip-before-cursor-varying-size [132.521780] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.944s) [132.776760] [104/162] (887s left) kms_dsc (dsc-basic) [132.972669] Subtest dsc-basic: SKIP (0.000s) [133.136343] [105/162] (886s left) kms_flip (basic-flip-vs-dpms) [133.331255] Starting subtest: basic-flip-vs-dpms [133.350664] Starting dynamic subtest: A-VGA1 [134.602777] Dynamic subtest A-VGA1: SUCCESS (1.286s) [134.639338] Starting dynamic subtest: B-VGA1 [135.842135] Dynamic subtest B-VGA1: SUCCESS (1.236s) [135.862763] Subtest basic-flip-vs-dpms: SUCCESS (2.525s) [136.098523] [106/162] (884s left) kms_flip (basic-flip-vs-modeset) [136.287972] Starting subtest: basic-flip-vs-modeset [136.309789] Starting dynamic subtest: A-VGA1 [137.555858] Dynamic subtest A-VGA1: SUCCESS (1.270s) [137.591413] Starting dynamic subtest: B-VGA1 [138.751871] Dynamic subtest B-VGA1: SUCCESS (1.198s) [138.776941] Subtest basic-flip-vs-modeset: SUCCESS (2.472s) [139.024623] [107/162] (881s left) kms_flip (basic-flip-vs-wf_vblank) [139.235673] Starting subtest: basic-flip-vs-wf_vblank [139.254465] Starting dynamic subtest: A-VGA1 [140.716031] Dynamic subtest A-VGA1: SUCCESS (1.510s) [140.751751] Starting dynamic subtest: B-VGA1 [142.227985] Dynamic subtest B-VGA1: SUCCESS (1.503s) [142.247429] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.017s) [142.511557] [108/162] (878s left) kms_flip (basic-plain-flip) [142.718886] Starting subtest: basic-plain-flip [142.741965] Starting dynamic subtest: A-VGA1 [143.904167] Dynamic subtest A-VGA1: SUCCESS (1.226s) [143.940179] Starting dynamic subtest: B-VGA1 [145.126556] Dynamic subtest B-VGA1: SUCCESS (1.218s) [145.148914] Subtest basic-plain-flip: SUCCESS (2.450s) [145.427949] [109/162] (875s left) kms_force_connector_basic (force-connector-state) [145.620385] Starting subtest: force-connector-state [145.724971] Subtest force-connector-state: SUCCESS (0.137s) [146.023407] [110/162] (874s left) kms_force_connector_basic (force-edid) [146.190362] Starting subtest: force-edid [146.208584] Subtest force-edid: SUCCESS (0.028s) [146.439818] [111/162] (874s left) kms_force_connector_basic (force-load-detect) [146.614573] Starting subtest: force-load-detect [146.768102] Subtest force-load-detect: SUCCESS (0.175s) [147.064147] [112/162] (874s left) kms_force_connector_basic (prune-stale-modes) [147.249376] Starting subtest: prune-stale-modes [147.270219] Subtest prune-stale-modes: SUCCESS (0.025s) [147.477461] [113/162] (873s left) kms_frontbuffer_tracking (basic) [147.711959] Starting subtest: basic [149.948023] Subtest basic: SUCCESS (2.282s) [150.185600] [114/162] (871s left) kms_hdmi_inject (inject-audio) [150.404580] Starting subtest: inject-audio [150.450062] Subtest inject-audio: SKIP (0.000s) [150.670968] [115/162] (871s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [150.862561] Starting subtest: compare-crc-sanitycheck-xr24 [150.890096] Starting dynamic subtest: pipe-A-VGA-1 [151.150868] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.313s) [151.192522] Starting dynamic subtest: pipe-B-VGA-1 [151.488659] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.343s) [151.515960] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.661s) [151.790417] [116/162] (870s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [151.998445] Starting subtest: compare-crc-sanitycheck-nv12 [152.020274] Starting dynamic subtest: pipe-A-VGA-1 [152.063610] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [152.098912] Starting dynamic subtest: pipe-B-VGA-1 [152.137809] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [152.176403] Subtest compare-crc-sanitycheck-nv12: SKIP (0.006s) [152.352523] [117/162] (869s left) kms_pipe_crc_basic (hang-read-crc) [152.515793] Starting subtest: hang-read-crc [152.538098] Starting dynamic subtest: pipe-A-VGA-1 [153.440596] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.908s) [153.477640] Starting dynamic subtest: pipe-B-VGA-1 [154.301347] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.871s) [154.321874] Subtest hang-read-crc: SUCCESS (1.784s) [154.542366] [118/162] (867s left) kms_pipe_crc_basic (nonblocking-crc) [154.708921] Starting subtest: nonblocking-crc [154.727614] Starting dynamic subtest: pipe-A-VGA-1 [155.253072] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.533s) [155.285071] Starting dynamic subtest: pipe-B-VGA-1 [155.805251] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.548s) [155.825842] Subtest nonblocking-crc: SUCCESS (1.085s) [156.048983] [119/162] (866s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [156.216725] Starting subtest: nonblocking-crc-frame-sequence [156.236096] Starting dynamic subtest: pipe-A-VGA-1 [156.717414] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s) [156.754327] Starting dynamic subtest: pipe-B-VGA-1 [157.217200] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.497s) [157.235987] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.996s) [157.464148] [120/162] (865s left) kms_pipe_crc_basic (read-crc) [157.653973] Starting subtest: read-crc [157.673661] Starting dynamic subtest: pipe-A-VGA-1 [158.059185] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.428s) [158.094566] Starting dynamic subtest: pipe-B-VGA-1 [158.497940] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.436s) [158.518388] Subtest read-crc: SUCCESS (0.868s) [158.752788] [121/162] (863s left) kms_pipe_crc_basic (read-crc-frame-sequence) [158.935097] Starting subtest: read-crc-frame-sequence [158.956999] Starting dynamic subtest: pipe-A-VGA-1 [159.351803] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.428s) [159.389131] Starting dynamic subtest: pipe-B-VGA-1 [159.785341] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.435s) [159.805430] Subtest read-crc-frame-sequence: SUCCESS (0.868s) [160.049121] [122/162] (862s left) kms_pm_backlight (basic-brightness) [160.262573] Subtest basic-brightness: SKIP (0.000s) [160.429221] [123/162] (862s left) kms_pm_rpm (basic-pci-d3-state) [171.940164] Subtest basic-pci-d3-state: SKIP (0.000s) [172.106395] [124/162] (851s left) kms_pm_rpm (basic-rte) [172.254695] Starting subtest: basic-rte [183.625243] Subtest basic-rte: SKIP (11.145s) [183.831916] [125/162] (839s left) kms_psr (psr-primary-page-flip) [184.022623] Subtest psr-primary-page-flip: SKIP (0.000s) [184.188228] [126/162] (839s left) kms_psr (psr-cursor-plane-move) [184.398081] Subtest psr-cursor-plane-move: SKIP (0.000s) [184.565248] [127/162] (839s left) kms_psr (psr-sprite-plane-onoff) [184.775083] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [184.950932] [128/162] (838s left) kms_psr (psr-primary-mmap-gtt) [185.158606] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [185.325289] [129/162] (838s left) kms_setmode (basic-clone-single-crtc) [185.516968] Starting subtest: basic-clone-single-crtc [185.574701] Subtest basic-clone-single-crtc: SKIP (0.000s) [185.747142] [130/162] (838s left) i915_pm_rps (basic-api) [185.961522] Subtest basic-api: SKIP (0.000s) [186.124042] [131/162] (838s left) prime_self_import (basic-llseek-bad) [186.281233] Starting subtest: basic-llseek-bad [186.320714] Subtest basic-llseek-bad: SUCCESS (0.002s) [186.483295] [132/162] (838s left) prime_self_import (basic-llseek-size) [186.635138] Starting subtest: basic-llseek-size [186.673253] Subtest basic-llseek-size: SUCCESS (0.004s) [186.842681] [133/162] (837s left) prime_self_import (basic-with_fd_dup) [187.007688] Starting subtest: basic-with_fd_dup [187.050743] Subtest basic-with_fd_dup: SUCCESS (0.005s) [187.214199] [134/162] (837s left) prime_self_import (basic-with_one_bo) [187.386910] Starting subtest: basic-with_one_bo [187.425928] Subtest basic-with_one_bo: SUCCESS (0.004s) [187.618288] [135/162] (837s left) prime_self_import (basic-with_one_bo_two_files) [187.763173] Starting subtest: basic-with_one_bo_two_files [187.805094] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [187.971958] [136/162] (837s left) prime_self_import (basic-with_two_bos) [188.147597] Starting subtest: basic-with_two_bos [188.191412] Subtest basic-with_two_bos: SUCCESS (0.005s) [188.352176] [137/162] (837s left) prime_vgem (basic-fence-flip) [188.549357] Starting subtest: basic-fence-flip [188.863235] Subtest basic-fence-flip: SUCCESS (0.357s) [189.070767] [138/162] (836s left) prime_vgem (basic-fence-mmap) [189.271439] Starting subtest: basic-fence-mmap [189.290669] Subtest basic-fence-mmap: SUCCESS (0.045s) [189.478575] [139/162] (836s left) prime_vgem (basic-fence-read) [189.681420] Starting subtest: basic-fence-read [189.702963] Subtest basic-fence-read: SUCCESS (0.063s) [189.888665] [140/162] (836s left) prime_vgem (basic-gtt) [190.110876] Starting subtest: basic-gtt [190.135973] Subtest basic-gtt: SUCCESS (0.028s) [190.346569] [141/162] (835s left) prime_vgem (basic-read) [190.564377] Starting subtest: basic-read [190.587682] Subtest basic-read: SUCCESS (0.031s) [190.805636] [142/162] (835s left) prime_vgem (basic-write) [191.021810] Starting subtest: basic-write [191.048236] Subtest basic-write: SUCCESS (0.032s) [191.259227] [143/162] (835s left) vgem_basic (setversion) [191.457523] Starting subtest: setversion [191.505104] Subtest setversion: SUCCESS (0.000s) [191.696745] [144/162] (835s left) vgem_basic (create) [191.903797] Starting subtest: create [191.929389] Subtest create: SUCCESS (0.000s) [192.113607] [145/162] (834s left) vgem_basic (debugfs) [192.286563] Starting subtest: debugfs [192.306341] Subtest debugfs: SUCCESS (0.000s) [192.466354] [146/162] (834s left) vgem_basic (dmabuf-export) [192.651883] Starting subtest: dmabuf-export [192.693060] Subtest dmabuf-export: SUCCESS (0.004s) [192.867816] [147/162] (834s left) vgem_basic (dmabuf-fence) [193.035083] Starting subtest: dmabuf-fence [193.056655] Subtest dmabuf-fence: SUCCESS (0.002s) [193.221115] [148/162] (834s left) vgem_basic (dmabuf-fence-before) [193.414806] Starting subtest: dmabuf-fence-before [193.434548] Subtest dmabuf-fence-before: SUCCESS (0.001s) [193.598504] [149/162] (834s left) vgem_basic (dmabuf-mmap) [193.763757] Starting subtest: dmabuf-mmap [193.783165] Subtest dmabuf-mmap: SUCCESS (0.025s) [193.957282] [150/162] (833s left) vgem_basic (mmap) [194.121748] Starting subtest: mmap [194.143795] Subtest mmap: SUCCESS (0.019s) [194.311673] [151/162] (833s left) vgem_basic (second-client) [194.484190] Starting subtest: second-client [194.524577] Subtest second-client: SUCCESS (0.031s) [194.687296] [152/162] (833s left) vgem_basic (sysfs) [194.862078] Starting subtest: sysfs [194.881409] Subtest sysfs: SUCCESS (0.001s) [195.047537] [153/162] (833s left) core_hotunplug (unbind-rebind) [195.337118] Starting subtest: unbind-rebind [196.924946] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2053 [max: 8192] dynamic-keys: 294 direct dependencies: 21656 [max: 524288] indirect dependencies: 179009 all direct dependencies: 434082 dependency chains: 30448 [max: 524288] dependency chain hlocks used: 129354 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 171 in-softirq chains: 729 in-process chains: 29548 stack-trace entries: 239244 [max: 524288] number of stack traces: 11131 number of stack hash chains: 8079 combined max dependencies: 3710172440 hardirq-safe locks: 82 hardirq-unsafe locks: 1246 softirq-safe locks: 236 softirq-unsafe locks: 1141 irq-safe locks: 249 irq-unsafe locks: 1246 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 373 softirq-read-safe locks: 8 softirq-read-unsafe locks: 371 irq-read-safe locks: 8 irq-read-unsafe locks: 373 uncategorized locks: 341 unused locks: 1 max locking depth: 18 max bfs queue depth: 408 max lock class index: 2056 debug_locks: 0 zapped classes: 13 zapped lock chains: 1146 large chain blocks: 1 [196.964882] [FACT core_hotunplug (unbind-rebind)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [196.965203] [FACT core_hotunplug (unbind-rebind)] new: kernel.is_tainted.taint_die: true [196.966527] 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: no output, setting notrun results: parsing output: 154/ for test: i915_module_load results: no output, setting notrun results: parsing output: 155/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 156/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 157/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 158/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 159/ for test: i915_pm_rpm results: no output, setting notrun results: parsing output: 160/ for test: i915_selftest results: no output, setting notrun results: parsing output: 161/ for test: dmabuf results: no output, setting notrun Done.