builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-088 starttime: 1506387982.18 results: success (0) revision: e6b3498a39b94616ba36798fe0b71a3090b1b14c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.183925) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.184374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.184653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.202376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.202736) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 18:06:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2017-09-25 18:06:22 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.382883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.383243) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017855 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.435960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:22.436329) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e6b3498a39b94616ba36798fe0b71a3090b1b14c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev e6b3498a39b94616ba36798fe0b71a3090b1b14c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 18:06:22,421 truncating revision to first 12 chars 2017-09-25 18:06:22,421 Setting DEBUG logging. 2017-09-25 18:06:22,421 attempt 1/10 2017-09-25 18:06:22,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e6b3498a39b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 18:06:22,883 unpacking tar archive at: mozilla-central-e6b3498a39b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:23.256504) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:23.256856) ========= script_repo_revision: e6b3498a39b94616ba36798fe0b71a3090b1b14c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:23.257283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:23.257553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 18:06:23.272308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-25 18:06:23.272720) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:06:23 INFO - MultiFileLogger online at 20170925 18:06:23 in /builds/slave/test 18:06:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:06:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:06:23 INFO - {'append_to_log': False, 18:06:23 INFO - 'base_work_dir': '/builds/slave/test', 18:06:23 INFO - 'blob_upload_branch': 'Firefox', 18:06:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:06:23 INFO - 'branch': 'Firefox', 18:06:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:06:23 INFO - 'code_coverage': False, 18:06:23 INFO - 'config_files': ('talos/linux_config.py',), 18:06:23 INFO - 'default_actions': ('clobber', 18:06:23 INFO - 'read-buildbot-config', 18:06:23 INFO - 'download-and-extract', 18:06:23 INFO - 'populate-webroot', 18:06:23 INFO - 'create-virtualenv', 18:06:23 INFO - 'install', 18:06:23 INFO - 'setup-mitmproxy', 18:06:23 INFO - 'run-tests'), 18:06:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:06:23 INFO - 'disable_ccov_upload': False, 18:06:23 INFO - 'disable_stylo': False, 18:06:23 INFO - 'download_minidump_stackwalk': True, 18:06:23 INFO - 'download_symbols': 'ondemand', 18:06:23 INFO - 'enable_stylo': False, 18:06:23 INFO - 'enable_webrender': False, 18:06:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:06:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:06:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:06:23 INFO - 'gecko_profile': False, 18:06:23 INFO - 'gecko_profile_interval': 0, 18:06:23 INFO - 'installer_path': 'installer.exe', 18:06:23 INFO - 'log_level': 'info', 18:06:23 INFO - 'log_name': 'talos', 18:06:23 INFO - 'log_to_console': True, 18:06:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:06:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:06:23 INFO - 'opt_config_files': (), 18:06:23 INFO - 'pip_index': False, 18:06:23 INFO - 'suite': 'dromaeojs-e10s', 18:06:23 INFO - 'system_bits': '32', 18:06:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:06:23 INFO - 'title': 'talos-linux64-ix-088', 18:06:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:06:23 INFO - 'use_talos_json': True, 18:06:23 INFO - 'verify': 'False', 18:06:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:06:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:06:23 INFO - 'work_dir': 'build'} 18:06:23 INFO - [mozharness: 2017-09-26 01:06:23.399544Z] Running clobber step. 18:06:23 INFO - Running pre-action listener: _resource_record_pre_action 18:06:23 INFO - Running main action method: clobber 18:06:23 INFO - rmtree: /builds/slave/test/build 18:06:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:06:24 INFO - Running post-action listener: _resource_record_post_action 18:06:24 INFO - [mozharness: 2017-09-26 01:06:24.964364Z] Finished clobber step (success) 18:06:24 INFO - [mozharness: 2017-09-26 01:06:24.964462Z] Running read-buildbot-config step. 18:06:24 INFO - Running pre-action listener: _resource_record_pre_action 18:06:24 INFO - Running main action method: read_buildbot_config 18:06:24 INFO - Using buildbot properties: 18:06:24 INFO - { 18:06:24 INFO - "project": "", 18:06:24 INFO - "product": "firefox", 18:06:24 INFO - "who": "kwierso@gmail.com", 18:06:24 INFO - "installer_path": "public/build/target.tar.bz2", 18:06:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:06:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:06:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:06:24 INFO - "stage_platform": "linux64-pgo", 18:06:24 INFO - "basedir": "/builds/slave/test", 18:06:24 INFO - "buildnumber": 208, 18:06:24 INFO - "platform": "ubuntu64_hw", 18:06:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:06:24 INFO - "slavebuilddir": "test", 18:06:24 INFO - "taskId": "AycK-snkSuq4tIIx85dmWw", 18:06:24 INFO - "branch": "mozilla-central", 18:06:24 INFO - "script_repo_revision": "production", 18:06:24 INFO - "revision": "e6b3498a39b94616ba36798fe0b71a3090b1b14c", 18:06:24 INFO - "slavename": "talos-linux64-ix-088", 18:06:24 INFO - "repo_path": "mozilla-central" 18:06:24 INFO - } 18:06:24 INFO - Finding installer, test and symbols from parent task. 18:06:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AycK-snkSuq4tIIx85dmWw'}, attempt #1 18:06:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AycK-snkSuq4tIIx85dmWw'}, attempt #1 18:06:26 INFO - Task dependencies: bcexkDXfTRu9BIWJfptH-Q 18:06:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q'}, attempt #1 18:06:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2 18:06:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.test_packages.json 18:06:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.crashreporter-symbols.zip 18:06:26 INFO - Running post-action listener: _resource_record_post_action 18:06:26 INFO - [mozharness: 2017-09-26 01:06:26.550959Z] Finished read-buildbot-config step (success) 18:06:26 INFO - [mozharness: 2017-09-26 01:06:26.551175Z] Running download-and-extract step. 18:06:26 INFO - Running pre-action listener: _resource_record_pre_action 18:06:26 INFO - Running main action method: download_and_extract 18:06:26 INFO - mkdir: /builds/slave/test/build/tests 18:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:26 INFO - trying https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.test_packages.json 18:06:26 INFO - Downloading https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:06:27 INFO - Downloaded 989 bytes. 18:06:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:06:27 INFO - Using the following test package requirements: 18:06:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:06:27 INFO - u'common': [u'target.common.tests.zip'], 18:06:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:06:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:06:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:06:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:06:27 INFO - u'mozbase': [u'target.common.tests.zip'], 18:06:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:06:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:06:27 INFO - u'web-platform': [u'target.common.tests.zip', 18:06:27 INFO - u'target.web-platform.tests.tar.gz'], 18:06:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:06:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:06:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.common.tests.zip 18:06:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:06:27 INFO - Fetch https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.common.tests.zip into memory 18:06:29 INFO - Content-Length response header: 55344029 18:06:29 INFO - Bytes received: 55344029 18:06:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.talos.tests.zip 18:06:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:06:40 INFO - Fetch https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.talos.tests.zip into memory 18:06:43 INFO - Content-Length response header: 14513823 18:06:43 INFO - Bytes received: 14513823 18:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:43 INFO - trying https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2 18:06:43 INFO - Downloading https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:06:47 INFO - Downloaded 62291504 bytes. 18:06:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2 18:06:47 INFO - mkdir: /builds/slave/test/properties 18:06:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:06:47 INFO - Writing to file /builds/slave/test/properties/build_url 18:06:47 INFO - Contents: 18:06:47 INFO - build_url:https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2 18:06:47 INFO - Running post-action listener: _resource_record_post_action 18:06:47 INFO - Running post-action listener: find_tests_for_verification 18:06:47 INFO - Running post-action listener: set_extra_try_arguments 18:06:47 INFO - [mozharness: 2017-09-26 01:06:47.060407Z] Finished download-and-extract step (success) 18:06:47 INFO - [mozharness: 2017-09-26 01:06:47.060505Z] Running populate-webroot step. 18:06:47 INFO - Running pre-action listener: _resource_record_pre_action 18:06:47 INFO - Running main action method: populate_webroot 18:06:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:06:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['tresize', 18:06:47 INFO - 'tcanvasmark']}, 18:06:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:06:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['dromaeo_css', 18:06:47 INFO - 'kraken']}, 18:06:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'tests': ['damp', 'tps']}, 18:06:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['damp', 'tps']}, 18:06:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:06:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['dromaeo_dom']}, 18:06:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:06:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['basic_compositor_video', 18:06:47 INFO - 'glvideo']}, 18:06:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:06:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['ts_paint_webext', 18:06:47 INFO - 'tp5o_webext']}, 18:06:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:06:47 INFO - 'ts_paint', 18:06:47 INFO - 'tpaint', 18:06:47 INFO - 'sessionrestore', 18:06:47 INFO - 'sessionrestore_many_windows', 18:06:47 INFO - 'sessionrestore_no_auto_restore', 18:06:47 INFO - 'tabpaint']}, 18:06:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['a11yr', 18:06:47 INFO - 'ts_paint', 18:06:47 INFO - 'tpaint', 18:06:47 INFO - 'sessionrestore', 18:06:47 INFO - 'sessionrestore_many_windows', 18:06:47 INFO - 'sessionrestore_no_auto_restore', 18:06:47 INFO - 'tabpaint']}, 18:06:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 18:06:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:06:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['perf_reftest_singletons']}, 18:06:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['perf_reftest']}, 18:06:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:06:47 INFO - 'tsvgr_opacity', 18:06:47 INFO - 'tart', 18:06:47 INFO - 'tscrollx', 18:06:47 INFO - 'tsvg_static']}, 18:06:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['tsvgx', 18:06:47 INFO - 'tsvgr_opacity', 18:06:47 INFO - 'tart', 18:06:47 INFO - 'tscrollx', 18:06:47 INFO - 'tsvg_static']}, 18:06:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:06:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'talos_options': ['--disable-stylo'], 18:06:47 INFO - 'tests': ['tp5o']}, 18:06:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:06:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:06:47 INFO - 'talos_options': ['--mitmproxy', 18:06:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:06:47 INFO - '--firstNonBlankPaint'], 18:06:47 INFO - 'tests': ['tp6_google', 18:06:47 INFO - 'tp6_youtube', 18:06:47 INFO - 'tp6_amazon', 18:06:47 INFO - 'tp6_facebook']}, 18:06:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:06:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:06:47 INFO - 'talos_options': ['--disable-stylo', 18:06:47 INFO - '--mitmproxy', 18:06:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:06:47 INFO - '--firstNonBlankPaint'], 18:06:47 INFO - 'tests': ['tp6_google', 18:06:47 INFO - 'tp6_youtube', 18:06:47 INFO - 'tp6_amazon', 18:06:47 INFO - 'tp6_facebook']}, 18:06:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:06:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 18:06:47 INFO - 'talos_options': ['--stylo-threads=1', 18:06:47 INFO - '--mitmproxy', 18:06:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:06:47 INFO - '--firstNonBlankPaint'], 18:06:47 INFO - 'tests': ['tp6_google', 18:06:47 INFO - 'tp6_youtube', 18:06:47 INFO - 'tp6_amazon', 18:06:47 INFO - 'tp6_facebook']}, 18:06:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'talos_options': ['--xperf_path', 18:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:47 INFO - 'tests': ['tp5n']}, 18:06:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:06:47 INFO - 'talos_options': ['--disable-stylo', 18:06:47 INFO - '--xperf_path', 18:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:47 INFO - 'tests': ['tp5n']}}} 18:06:47 INFO - Running post-action listener: _resource_record_post_action 18:06:47 INFO - [mozharness: 2017-09-26 01:06:47.075774Z] Finished populate-webroot step (success) 18:06:47 INFO - [mozharness: 2017-09-26 01:06:47.075875Z] Running create-virtualenv step. 18:06:47 INFO - Running pre-action listener: _resource_record_pre_action 18:06:47 INFO - Running main action method: create_virtualenv 18:06:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:06:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:06:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:06:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:06:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:06:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:06:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:06:47 INFO - Installing pip...............done. 18:06:47 INFO - Return code: 0 18:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:06:48 INFO - Reading from file tmpfile_stdout 18:06:48 INFO - Output received: 18:06:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:06:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:06:48 INFO - Using env: {'DISPLAY': ':0', 18:06:48 INFO - 'HOME': '/home/cltbld', 18:06:48 INFO - 'LANG': 'en_US.UTF-8', 18:06:48 INFO - 'LANGUAGE': 'en_US:en', 18:06:48 INFO - 'LOGNAME': 'cltbld', 18:06:48 INFO - 'MAIL': '/var/mail/cltbld', 18:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:48 INFO - 'MOZ_NO_REMOTE': '1', 18:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:48 INFO - 'NO_EM_RESTART': '1', 18:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:48 INFO - 'PWD': '/builds/slave/test', 18:06:48 INFO - 'SHELL': '/bin/bash', 18:06:48 INFO - 'SHLVL': '1', 18:06:48 INFO - 'TERM': 'linux', 18:06:48 INFO - 'TMOUT': '86400', 18:06:48 INFO - 'USER': 'cltbld', 18:06:48 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:48 INFO - '_': '/tools/buildbot/bin/python'} 18:06:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:06:49 INFO - Downloading/unpacking pip>=1.5 18:06:49 INFO - Running setup.py egg_info for package pip 18:06:49 INFO - warning: no files found matching 'pip/cacert.pem' 18:06:49 INFO - warning: no files found matching '*.html' under directory 'docs' 18:06:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:06:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:06:49 INFO - Installing collected packages: pip 18:06:49 INFO - Found existing installation: pip 1.1 18:06:49 INFO - Uninstalling pip: 18:06:49 INFO - Successfully uninstalled pip 18:06:49 INFO - Running setup.py install for pip 18:06:49 INFO - warning: no files found matching 'pip/cacert.pem' 18:06:49 INFO - warning: no files found matching '*.html' under directory 'docs' 18:06:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:06:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:06:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:06:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:06:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:06:49 INFO - Successfully installed pip 18:06:49 INFO - Cleaning up... 18:06:49 INFO - Return code: 0 18:06:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:06:49 INFO - Using env: {'DISPLAY': ':0', 18:06:49 INFO - 'HOME': '/home/cltbld', 18:06:49 INFO - 'LANG': 'en_US.UTF-8', 18:06:49 INFO - 'LANGUAGE': 'en_US:en', 18:06:49 INFO - 'LOGNAME': 'cltbld', 18:06:49 INFO - 'MAIL': '/var/mail/cltbld', 18:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:49 INFO - 'MOZ_NO_REMOTE': '1', 18:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:49 INFO - 'NO_EM_RESTART': '1', 18:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:49 INFO - 'PWD': '/builds/slave/test', 18:06:49 INFO - 'SHELL': '/bin/bash', 18:06:49 INFO - 'SHLVL': '1', 18:06:49 INFO - 'TERM': 'linux', 18:06:49 INFO - 'TMOUT': '86400', 18:06:49 INFO - 'USER': 'cltbld', 18:06:49 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:49 INFO - '_': '/tools/buildbot/bin/python'} 18:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:49 INFO - Downloading/unpacking psutil>=3.1.1 18:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:50 INFO - Installing collected packages: psutil 18:06:50 INFO - Running setup.py install for psutil 18:06:51 INFO - building 'psutil._psutil_linux' extension 18:06:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:06:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:06:51 INFO - building 'psutil._psutil_posix' extension 18:06:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:06:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:51 INFO - Successfully installed psutil 18:06:51 INFO - Cleaning up... 18:06:51 INFO - Return code: 0 18:06:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:06:51 INFO - Using env: {'DISPLAY': ':0', 18:06:51 INFO - 'HOME': '/home/cltbld', 18:06:51 INFO - 'LANG': 'en_US.UTF-8', 18:06:51 INFO - 'LANGUAGE': 'en_US:en', 18:06:51 INFO - 'LOGNAME': 'cltbld', 18:06:51 INFO - 'MAIL': '/var/mail/cltbld', 18:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:51 INFO - 'MOZ_NO_REMOTE': '1', 18:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:51 INFO - 'NO_EM_RESTART': '1', 18:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:51 INFO - 'PWD': '/builds/slave/test', 18:06:51 INFO - 'SHELL': '/bin/bash', 18:06:51 INFO - 'SHLVL': '1', 18:06:51 INFO - 'TERM': 'linux', 18:06:51 INFO - 'TMOUT': '86400', 18:06:51 INFO - 'USER': 'cltbld', 18:06:51 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:51 INFO - '_': '/tools/buildbot/bin/python'} 18:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:06:52 INFO - Installing collected packages: mozsystemmonitor 18:06:52 INFO - Running setup.py install for mozsystemmonitor 18:06:52 INFO - Successfully installed mozsystemmonitor 18:06:52 INFO - Cleaning up... 18:06:52 INFO - Return code: 0 18:06:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:06:52 INFO - Using env: {'DISPLAY': ':0', 18:06:52 INFO - 'HOME': '/home/cltbld', 18:06:52 INFO - 'LANG': 'en_US.UTF-8', 18:06:52 INFO - 'LANGUAGE': 'en_US:en', 18:06:52 INFO - 'LOGNAME': 'cltbld', 18:06:52 INFO - 'MAIL': '/var/mail/cltbld', 18:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:52 INFO - 'MOZ_NO_REMOTE': '1', 18:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:52 INFO - 'NO_EM_RESTART': '1', 18:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:52 INFO - 'PWD': '/builds/slave/test', 18:06:52 INFO - 'SHELL': '/bin/bash', 18:06:52 INFO - 'SHLVL': '1', 18:06:52 INFO - 'TERM': 'linux', 18:06:52 INFO - 'TMOUT': '86400', 18:06:52 INFO - 'USER': 'cltbld', 18:06:52 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:52 INFO - '_': '/tools/buildbot/bin/python'} 18:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:53 INFO - Downloading/unpacking jsonschema==2.5.1 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:06:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:06:54 INFO - warning: no files found matching '*.txt' 18:06:54 INFO - no previously-included directories found matching 'build' 18:06:54 INFO - no previously-included directories found matching 'dist' 18:06:54 INFO - no previously-included directories found matching '.git*' 18:06:54 INFO - Installing collected packages: jsonschema, functools32 18:06:54 INFO - Running setup.py install for functools32 18:06:54 INFO - warning: no files found matching '*.txt' 18:06:54 INFO - no previously-included directories found matching 'build' 18:06:54 INFO - no previously-included directories found matching 'dist' 18:06:54 INFO - no previously-included directories found matching '.git*' 18:06:54 INFO - Successfully installed jsonschema functools32 18:06:54 INFO - Cleaning up... 18:06:54 INFO - Return code: 0 18:06:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:06:54 INFO - Using env: {'DISPLAY': ':0', 18:06:54 INFO - 'HOME': '/home/cltbld', 18:06:54 INFO - 'LANG': 'en_US.UTF-8', 18:06:54 INFO - 'LANGUAGE': 'en_US:en', 18:06:54 INFO - 'LOGNAME': 'cltbld', 18:06:54 INFO - 'MAIL': '/var/mail/cltbld', 18:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:54 INFO - 'MOZ_NO_REMOTE': '1', 18:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:54 INFO - 'NO_EM_RESTART': '1', 18:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:54 INFO - 'PWD': '/builds/slave/test', 18:06:54 INFO - 'SHELL': '/bin/bash', 18:06:54 INFO - 'SHLVL': '1', 18:06:54 INFO - 'TERM': 'linux', 18:06:54 INFO - 'TMOUT': '86400', 18:06:54 INFO - 'USER': 'cltbld', 18:06:54 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:54 INFO - '_': '/tools/buildbot/bin/python'} 18:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:06:54 INFO - Cleaning up... 18:06:54 INFO - Return code: 0 18:06:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:06:54 INFO - Using env: {'DISPLAY': ':0', 18:06:54 INFO - 'HOME': '/home/cltbld', 18:06:54 INFO - 'LANG': 'en_US.UTF-8', 18:06:54 INFO - 'LANGUAGE': 'en_US:en', 18:06:54 INFO - 'LOGNAME': 'cltbld', 18:06:54 INFO - 'MAIL': '/var/mail/cltbld', 18:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:54 INFO - 'MOZ_NO_REMOTE': '1', 18:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:54 INFO - 'NO_EM_RESTART': '1', 18:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:54 INFO - 'PWD': '/builds/slave/test', 18:06:54 INFO - 'SHELL': '/bin/bash', 18:06:54 INFO - 'SHLVL': '1', 18:06:54 INFO - 'TERM': 'linux', 18:06:54 INFO - 'TMOUT': '86400', 18:06:54 INFO - 'USER': 'cltbld', 18:06:54 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:54 INFO - '_': '/tools/buildbot/bin/python'} 18:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:55 INFO - Downloading/unpacking blobuploader==1.2.4 18:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:06:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:06:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:57 INFO - Downloading docopt-0.6.1.tar.gz 18:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:06:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:06:57 INFO - Running setup.py install for blobuploader 18:06:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:06:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:06:57 INFO - Running setup.py install for requests 18:06:58 INFO - Running setup.py install for docopt 18:06:58 INFO - Successfully installed blobuploader requests docopt 18:06:58 INFO - Cleaning up... 18:06:58 INFO - Return code: 0 18:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:06:58 INFO - Using env: {'DISPLAY': ':0', 18:06:58 INFO - 'HOME': '/home/cltbld', 18:06:58 INFO - 'LANG': 'en_US.UTF-8', 18:06:58 INFO - 'LANGUAGE': 'en_US:en', 18:06:58 INFO - 'LOGNAME': 'cltbld', 18:06:58 INFO - 'MAIL': '/var/mail/cltbld', 18:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:58 INFO - 'MOZ_NO_REMOTE': '1', 18:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:58 INFO - 'NO_EM_RESTART': '1', 18:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:58 INFO - 'PWD': '/builds/slave/test', 18:06:58 INFO - 'SHELL': '/bin/bash', 18:06:58 INFO - 'SHLVL': '1', 18:06:58 INFO - 'TERM': 'linux', 18:06:58 INFO - 'TMOUT': '86400', 18:06:58 INFO - 'USER': 'cltbld', 18:06:58 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:58 INFO - '_': '/tools/buildbot/bin/python'} 18:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:06:58 INFO - Running setup.py (path:/tmp/pip-cLdXXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:06:58 INFO - Running setup.py (path:/tmp/pip-sVAG55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:06:58 INFO - Running setup.py (path:/tmp/pip-CjMhzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:06:58 INFO - Running setup.py (path:/tmp/pip-yEz8C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:06:58 INFO - Running setup.py (path:/tmp/pip-mi4iZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:06:58 INFO - Running setup.py (path:/tmp/pip-Ms7zHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:06:58 INFO - Running setup.py (path:/tmp/pip-JwcEbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:06:58 INFO - Running setup.py (path:/tmp/pip-Ko0zcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:06:59 INFO - Running setup.py (path:/tmp/pip-mraD1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:06:59 INFO - Running setup.py (path:/tmp/pip-il5_M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:06:59 INFO - Running setup.py (path:/tmp/pip-56TsJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:06:59 INFO - Running setup.py (path:/tmp/pip-bGCCpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:06:59 INFO - Running setup.py (path:/tmp/pip-t8zbID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:06:59 INFO - Running setup.py (path:/tmp/pip-1t21o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:59 INFO - Running setup.py (path:/tmp/pip-pNdaFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:06:59 INFO - Running setup.py (path:/tmp/pip-9AgKMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:06:59 INFO - Running setup.py (path:/tmp/pip-Y9pkAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:06:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:06:59 INFO - Running setup.py install for manifestparser 18:06:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:06:59 INFO - Running setup.py install for mozcrash 18:06:59 INFO - Running setup.py install for mozdebug 18:06:59 INFO - Running setup.py install for mozdevice 18:07:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Running setup.py install for mozfile 18:07:00 INFO - Running setup.py install for mozhttpd 18:07:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Running setup.py install for mozinfo 18:07:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Running setup.py install for mozInstall 18:07:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Running setup.py install for mozleak 18:07:00 INFO - Running setup.py install for mozlog 18:07:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Running setup.py install for moznetwork 18:07:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Running setup.py install for mozprocess 18:07:00 INFO - Running setup.py install for mozprofile 18:07:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:07:00 INFO - Running setup.py install for mozrunner 18:07:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:07:01 INFO - Running setup.py install for mozscreenshot 18:07:01 INFO - Running setup.py install for moztest 18:07:01 INFO - Running setup.py install for mozversion 18:07:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:07:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:07:01 INFO - Cleaning up... 18:07:01 INFO - Return code: 0 18:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:07:01 INFO - Using env: {'DISPLAY': ':0', 18:07:01 INFO - 'HOME': '/home/cltbld', 18:07:01 INFO - 'LANG': 'en_US.UTF-8', 18:07:01 INFO - 'LANGUAGE': 'en_US:en', 18:07:01 INFO - 'LOGNAME': 'cltbld', 18:07:01 INFO - 'MAIL': '/var/mail/cltbld', 18:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:01 INFO - 'MOZ_NO_REMOTE': '1', 18:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:01 INFO - 'NO_EM_RESTART': '1', 18:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:01 INFO - 'PWD': '/builds/slave/test', 18:07:01 INFO - 'SHELL': '/bin/bash', 18:07:01 INFO - 'SHLVL': '1', 18:07:01 INFO - 'TERM': 'linux', 18:07:01 INFO - 'TMOUT': '86400', 18:07:01 INFO - 'USER': 'cltbld', 18:07:01 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:01 INFO - '_': '/tools/buildbot/bin/python'} 18:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:01 INFO - Running setup.py (path:/tmp/pip-sSSeKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:01 INFO - Running setup.py (path:/tmp/pip-mIRi1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:01 INFO - Running setup.py (path:/tmp/pip-qTJXaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:01 INFO - Running setup.py (path:/tmp/pip-HhvkEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:01 INFO - Running setup.py (path:/tmp/pip-kV_Jyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:01 INFO - Running setup.py (path:/tmp/pip-8JuXz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:02 INFO - Running setup.py (path:/tmp/pip-cd5TT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:02 INFO - Running setup.py (path:/tmp/pip-Wtbs5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:02 INFO - Running setup.py (path:/tmp/pip-XWkJVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:02 INFO - Running setup.py (path:/tmp/pip-wlZQ5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:02 INFO - Running setup.py (path:/tmp/pip-O5Dh7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:02 INFO - Running setup.py (path:/tmp/pip-ZDYHav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:02 INFO - Running setup.py (path:/tmp/pip-AZ2jDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:02 INFO - Running setup.py (path:/tmp/pip-UX1ClX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:02 INFO - Running setup.py (path:/tmp/pip-Rd5MrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:02 INFO - Running setup.py (path:/tmp/pip-f7RsmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:02 INFO - Running setup.py (path:/tmp/pip-TDLFIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:07:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:03 INFO - Downloading blessings-1.6.tar.gz 18:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:07:04 INFO - Installing collected packages: blessings 18:07:04 INFO - Running setup.py install for blessings 18:07:04 INFO - Successfully installed blessings 18:07:04 INFO - Cleaning up... 18:07:04 INFO - Return code: 0 18:07:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:04 INFO - Reading from file tmpfile_stdout 18:07:04 INFO - Current package versions: 18:07:04 INFO - argparse == 1.2.1 18:07:04 INFO - blessings == 1.6 18:07:04 INFO - blobuploader == 1.2.4 18:07:04 INFO - docopt == 0.6.1 18:07:04 INFO - functools32 == 3.2.3-2 18:07:04 INFO - jsonschema == 2.5.1 18:07:04 INFO - manifestparser == 1.1 18:07:04 INFO - mozInstall == 1.13 18:07:04 INFO - mozcrash == 1.0 18:07:04 INFO - mozdebug == 0.1 18:07:04 INFO - mozdevice == 0.51 18:07:04 INFO - mozfile == 1.2 18:07:04 INFO - mozhttpd == 0.7 18:07:04 INFO - mozinfo == 0.10 18:07:04 INFO - mozleak == 0.1 18:07:04 INFO - mozlog == 3.5 18:07:04 INFO - moznetwork == 0.27 18:07:04 INFO - mozprocess == 0.25 18:07:04 INFO - mozprofile == 0.28 18:07:04 INFO - mozrunner == 6.13 18:07:04 INFO - mozscreenshot == 0.1 18:07:04 INFO - mozsystemmonitor == 0.3 18:07:04 INFO - moztest == 0.8 18:07:04 INFO - mozversion == 1.4 18:07:04 INFO - psutil == 3.1.1 18:07:04 INFO - requests == 1.2.3 18:07:04 INFO - wsgiref == 0.1.2 18:07:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:07:04 INFO - Using env: {'DISPLAY': ':0', 18:07:04 INFO - 'HOME': '/home/cltbld', 18:07:04 INFO - 'LANG': 'en_US.UTF-8', 18:07:04 INFO - 'LANGUAGE': 'en_US:en', 18:07:04 INFO - 'LOGNAME': 'cltbld', 18:07:04 INFO - 'MAIL': '/var/mail/cltbld', 18:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:04 INFO - 'MOZ_NO_REMOTE': '1', 18:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:04 INFO - 'NO_EM_RESTART': '1', 18:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:04 INFO - 'PWD': '/builds/slave/test', 18:07:04 INFO - 'SHELL': '/bin/bash', 18:07:04 INFO - 'SHLVL': '1', 18:07:04 INFO - 'TERM': 'linux', 18:07:04 INFO - 'TMOUT': '86400', 18:07:04 INFO - 'USER': 'cltbld', 18:07:04 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:04 INFO - '_': '/tools/buildbot/bin/python'} 18:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:07:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:07:05 INFO - Installing collected packages: simplejson 18:07:05 INFO - Running setup.py install for simplejson 18:07:05 INFO - building 'simplejson._speedups' extension 18:07:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:07:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:07:06 INFO - Successfully installed simplejson 18:07:06 INFO - Cleaning up... 18:07:06 INFO - Return code: 0 18:07:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1571b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17169c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:07:06 INFO - Using env: {'DISPLAY': ':0', 18:07:06 INFO - 'HOME': '/home/cltbld', 18:07:06 INFO - 'LANG': 'en_US.UTF-8', 18:07:06 INFO - 'LANGUAGE': 'en_US:en', 18:07:06 INFO - 'LOGNAME': 'cltbld', 18:07:06 INFO - 'MAIL': '/var/mail/cltbld', 18:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:06 INFO - 'MOZ_NO_REMOTE': '1', 18:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:06 INFO - 'NO_EM_RESTART': '1', 18:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:06 INFO - 'PWD': '/builds/slave/test', 18:07:06 INFO - 'SHELL': '/bin/bash', 18:07:06 INFO - 'SHLVL': '1', 18:07:06 INFO - 'TERM': 'linux', 18:07:06 INFO - 'TMOUT': '86400', 18:07:06 INFO - 'USER': 'cltbld', 18:07:06 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:06 INFO - '_': '/tools/buildbot/bin/python'} 18:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:07:07 INFO - Cleaning up... 18:07:07 INFO - Return code: 0 18:07:07 INFO - Running post-action listener: _resource_record_post_action 18:07:07 INFO - Running post-action listener: _start_resource_monitoring 18:07:07 INFO - Starting resource monitoring. 18:07:07 INFO - [mozharness: 2017-09-26 01:07:07.103298Z] Finished create-virtualenv step (success) 18:07:07 INFO - [mozharness: 2017-09-26 01:07:07.103894Z] Running install step. 18:07:07 INFO - Running pre-action listener: _resource_record_pre_action 18:07:07 INFO - Running main action method: install 18:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:07 INFO - Reading from file tmpfile_stdout 18:07:07 INFO - Detecting whether we're running mozinstall >=1.0... 18:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:07:07 INFO - Reading from file tmpfile_stdout 18:07:07 INFO - Output received: 18:07:07 INFO - Usage: mozinstall [options] installer 18:07:07 INFO - Options: 18:07:07 INFO - -h, --help show this help message and exit 18:07:07 INFO - -d DEST, --destination=DEST 18:07:07 INFO - Directory to install application into. [default: 18:07:07 INFO - "/builds/slave/test"] 18:07:07 INFO - --app=APP Application being installed. [default: firefox] 18:07:07 INFO - mkdir: /builds/slave/test/build/application 18:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:07:25 INFO - Reading from file tmpfile_stdout 18:07:25 INFO - Output received: 18:07:25 INFO - /builds/slave/test/build/application/firefox/firefox 18:07:25 INFO - Running post-action listener: _resource_record_post_action 18:07:25 INFO - [mozharness: 2017-09-26 01:07:25.059454Z] Finished install step (success) 18:07:25 INFO - [mozharness: 2017-09-26 01:07:25.059598Z] Running setup-mitmproxy step. 18:07:25 INFO - Running pre-action listener: _resource_record_pre_action 18:07:25 INFO - Running main action method: setup_mitmproxy 18:07:25 INFO - Skipping: mitmproxy is not required 18:07:25 INFO - Running post-action listener: _resource_record_post_action 18:07:25 INFO - [mozharness: 2017-09-26 01:07:25.060438Z] Finished setup-mitmproxy step (success) 18:07:25 INFO - [mozharness: 2017-09-26 01:07:25.060658Z] Running run-tests step. 18:07:25 INFO - Running pre-action listener: _resource_record_pre_action 18:07:25 INFO - Running pre-action listener: _set_gcov_prefix 18:07:25 INFO - Running main action method: run_tests 18:07:25 WARNING - Try message not found. 18:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:07:25 INFO - Python 2.7.3 18:07:25 INFO - Return code: 0 18:07:25 INFO - grabbing minidump binary from tooltool 18:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713d60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1714a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1714ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:07:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:07:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:07:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:07:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:25 INFO - Return code: 0 18:07:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:07:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:07:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:07:25 INFO - ENV: RUST_BACKTRACE is now full 18:07:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:07:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:07:25 INFO - Using env: {'DISPLAY': ':0', 18:07:25 INFO - 'HOME': '/home/cltbld', 18:07:25 INFO - 'LANG': 'en_US.UTF-8', 18:07:25 INFO - 'LANGUAGE': 'en_US:en', 18:07:25 INFO - 'LOGNAME': 'cltbld', 18:07:25 INFO - 'MAIL': '/var/mail/cltbld', 18:07:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:25 INFO - 'MOZ_NO_REMOTE': '1', 18:07:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:25 INFO - 'NO_EM_RESTART': '1', 18:07:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:25 INFO - 'PWD': '/builds/slave/test', 18:07:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:25 INFO - 'RUST_BACKTRACE': 'full', 18:07:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:07:25 INFO - 'SHELL': '/bin/bash', 18:07:25 INFO - 'SHLVL': '1', 18:07:25 INFO - 'TERM': 'linux', 18:07:25 INFO - 'TMOUT': '86400', 18:07:25 INFO - 'USER': 'cltbld', 18:07:25 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:25 INFO - '_': '/tools/buildbot/bin/python'} 18:07:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:07:25 INFO - mozversion application_buildid: 20170925234146 18:07:25 INFO - mozversion application_changeset: e6b3498a39b94616ba36798fe0b71a3090b1b14c 18:07:25 INFO - mozversion application_display_name: Nightly 18:07:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:25 INFO - mozversion application_name: Firefox 18:07:25 INFO - mozversion application_remotingname: firefox 18:07:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:07:25 INFO - mozversion application_vendor: Mozilla 18:07:25 INFO - mozversion application_version: 58.0a1 18:07:25 INFO - mozversion platform_buildid: 20170925234146 18:07:25 INFO - mozversion platform_changeset: e6b3498a39b94616ba36798fe0b71a3090b1b14c 18:07:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:07:25 INFO - mozversion platform_version: 58.0a1 18:07:25 INFO - using testdate: 1506388045 18:07:25 INFO - actual date: 1506388045 18:07:25 INFO - starting webserver on 'localhost:46374' 18:07:25 INFO - SUITE-START | Running 2 tests 18:07:25 INFO - TEST-START | dromaeo_css 18:07:25 INFO - Initialising browser for dromaeo_css test... 18:07:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46374/getInfo.html -profile /tmp/tmp0GAoSU/profile 18:07:25 INFO - TEST-INFO | started process 23047 (/builds/slave/test/build/application/firefox/firefox http://localhost:46374/getInfo.html) 18:07:29 INFO - TEST-INFO | 23047: exit 0 18:07:30 INFO - Browser initialized. 18:07:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:07:30 INFO - Using env: {'DISPLAY': ':0', 18:07:30 INFO - 'HOME': '/home/cltbld', 18:07:30 INFO - 'JSGC_DISABLE_POISONING': '1', 18:07:30 INFO - 'LANG': 'en_US.UTF-8', 18:07:30 INFO - 'LANGUAGE': 'en_US:en', 18:07:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:07:30 INFO - 'LOGNAME': 'cltbld', 18:07:30 INFO - 'MAIL': '/var/mail/cltbld', 18:07:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:07:30 INFO - 'MOZ_CRASHREPORTER': '1', 18:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:07:30 INFO - 'MOZ_NO_REMOTE': '1', 18:07:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:30 INFO - 'NO_EM_RESTART': '1', 18:07:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:30 INFO - 'PWD': '/builds/slave/test', 18:07:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:30 INFO - 'RUST_BACKTRACE': 'full', 18:07:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:07:30 INFO - 'SHELL': '/bin/bash', 18:07:30 INFO - 'SHLVL': '1', 18:07:30 INFO - 'TERM': 'linux', 18:07:30 INFO - 'TMOUT': '86400', 18:07:30 INFO - 'USER': 'cltbld', 18:07:30 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:30 INFO - '_': '/tools/buildbot/bin/python'} 18:07:30 INFO - TEST-INFO | started process 23283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0GAoSU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:07:30 INFO - PID 23283 | 18:07:30 INFO - PID 23283 | (/builds/slave/test/build/application/firefox/firefox:23333): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:07:30 INFO - PID 23283 | 18:07:41 INFO - PID 23283 | RSS: Main: 146702336 18:07:41 INFO - PID 23283 | 18:10:37 INFO - PID 23283 | Cycle 1(1): loaded http://localhost:46374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46374/tests/dromaeo/cssquery-ext.html) 18:10:39 INFO - PID 23283 | RSS: Main: 147546112 18:10:39 INFO - PID 23283 | 18:13:41 INFO - PID 23283 | Cycle 1(1): loaded http://localhost:46374/tests/dromaeo/cssquery-ext.html (next: http://localhost:46374/tests/dromaeo/cssquery-jquery.html) 18:13:41 INFO - PID 23283 | RSS: Main: 146935808 18:13:41 INFO - PID 23283 | 18:16:43 INFO - PID 23283 | Cycle 1(1): loaded http://localhost:46374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46374/tests/dromaeo/cssquery-mootools.html) 18:16:43 INFO - PID 23283 | RSS: Main: 149319680 18:16:43 INFO - PID 23283 | 18:19:45 INFO - PID 23283 | Cycle 1(1): loaded http://localhost:46374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46374/tests/dromaeo/cssquery-prototype.html) 18:19:45 INFO - PID 23283 | RSS: Main: 148336640 18:19:45 INFO - PID 23283 | 18:22:49 INFO - PID 23283 | Cycle 1(1): loaded http://localhost:46374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46374/tests/dromaeo/cssquery-yui.html) 18:22:49 INFO - PID 23283 | RSS: Main: 147763200 18:22:49 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | Cycle 1(1): loaded http://localhost:46374/tests/dromaeo/cssquery-yui.html (next: http://localhost:46374/tests/dromaeo/cssquery-dojo.html) 18:25:51 INFO - PID 23283 | RSS: Main: 151339008 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | __start_tp_report 18:25:51 INFO - PID 23283 | _x_x_mozilla_page_load 18:25:51 INFO - PID 23283 | _x_x_mozilla_page_load_details 18:25:51 INFO - PID 23283 | |i|pagename|runs| 18:25:51 INFO - PID 23283 | |0;dojo.html;3833.6549710526047;3854.1520865409607;3862.517185351831;3867.9226415471708;3908.3160446921784;6199.101130336098;6271.686415679209;6323;6324.81025569233;6419.165508483902;6295.087212354206;6312.495000399968;6327.620342779425;6340.778072767454;6355.650439225841;5631.465010823965;5749.993751093562;5750.942490575104;5756.222909907151;5779.595428320019;129.1278855368414;5742.368339482654;5751.971240143794;5821.359650438449;5822.243108395903;5645.491905728483;5652.349979752319;5659.915101273464;5763.049096899007;5788.392218817048;5640.887182256373;5671.06427439472;5746.683932383718;5754.913676294859;5756.971215143939;5638.351589567212;5650.6892120933335;5739.3399759027825;5739.426057394269;5740.282464691913;6259.843503912439;6269.122322874756;6306.87386252277;6310.1481300024825;6379.106925030499;6705.966470167618;6842.04211410403;6856.348646878539;6926.826829329257;6939.791806245821;6893.862122757567;6899.689513971884;6905.75829845953;6916.619585922772;6918.688659010306;6270.059491076329;6386.393292637192;6428.614283143073;6437.742490300382;6479.319671434526;7084.114485689289;7170.282971702788;7182.066331376992;7187.245339239409;7193.96403017992;6738.629375384303;6755;6764.898526522106;6862.279460656659;6876.037354770337;6752.561083529555;6849;6870.587764734132;6966.12923384577;6971.965140174267;6806.659667016629;6901.792946211622;6921.377076063179;6940.305969403019;6953.478489113337;6857.588544687334;6888.070110535014;6934.098567186234;6953.026576279325;6956.095707557985;4921.7785199666105;5014.323066385991;5022.648414610942;5095.566876815438;5100.285959965608;4520.52534483881;4584.289435137559;4631.560001799824;4659.347691323217;4687.9765601171775;6318.747250109944;6326.304106548276;6386.137871387396;6400.263969643457;6407.13503677007;6762.459003279726;6830.692618832164;6870.690818913161;6940.479464040217;6954.547954382949;6316.905246421307;6349.238091429058;6356.173697419306;6363.745450181941;6365.36346365369;5498.340199176045;5543.196236545678;5586.469285417878;5612.719364031782;5627.240322556402;6993.510454268152;7076.823079423056;7084;7113.679884405215;7235.638218089074;6727.730890764413;6735.730570777212;6798.116244888331;6884.759033433806;6904.3095690430555;7176.820579485555;7194.568325900463;7197.1723251824615;7204.0994875640545;7232.710691572489;6677.899831502628;6776.051352810709;6811.080504132077;6861.176658800976;6877.552959057845;6743.763968261087;6827.556208846409;6846.828829279308;6935.965320173367;6961.199462061928;6611.239707433707;6691.832704182434;6698.698558564974;6711.9328806713265;6718.294579069127;6586.407223349922;6629.6685165740555;6711.765088221889;6713.362230588282;6721.831954201184;6479.773207937699;6495.642739649365;6558.934410655832;6562.245341785756;6574.769883054261;6689.063531105552;6692.397684208445;6705.664716764045;6716.529842910949;6780.491463140185;6572.901406478811;6582.901256481061;6583.835404114744;6595.4393876521035;6614.834629134118 18:25:51 INFO - PID 23283 | |1;ext.html;969.7624082099884;993.344392700818;999.5601935148529;999.5601935148532;999.8700168978032;40760.796196019015;43920;43959.34060989084;44614;44717.10565788682;40992;41234;41258.58741412585;41297.17405651885;41449.79275103628;7631.160572337052;7727;7763.573003484806;8470.110638382974;8705.695300664478;8469.449485783434;8584.8712269316;8595;8599.140085991383;8603.5698215089;8534.658613655447;8605.096464871192;8626.439281446686;8639.222469977702;8640.956795216016;8546.61540230691;8565.886434763472;8592.785180370509;8612.224899759052;8619.784505387384;8515.574221288973;8552.5296108714;8554.18735220153;8558.358123140728;8572.271356934669;41621.1675766486;41847.1630567387;41992.58007419917;42119.36820947688;42271.7886410566;3752.8874133775757;3767.1335592813807;3777.527809023872;3806.0294624870758;3817.503724515795;34122.829385852914;34161;34242.31515369703;34246.48630270548;34261;5447.428020057877;5504.504594586507;5544.279243698334;5545.805896793593;5628.183913332585;223138;224702;225000;225482;225557;47661.285080723814;47975.5202447971;52904.47095529072;53027.469725303024;53340.46659533355;57536.712316438985;58216;58327.70836145877;58348;58471.41528584745;15422.305996230196;15474;15558.066516009076;15578;15579.532614021371;12243;12261.754764904652;12295.077869159848;12310.50757969689;12332.260064396165;15430.614234644;15671.059736415851;15781.605459863595;15844.52466426009;15880.682386352208;6061.908856405889;6085.330613632497;6085.391460853879;6114.53251219713;6143.911070236141;1091.2579445976812;1100.301308669001;1104.5747387255965;1121.9831702524468;1128.9548418063187;25512.872435638074;25847.870760646078;25861.612075818877;25878.353041173745;26045.869770651403;1206.4269472000906;1209.6854817747274;1210.6186551236333;1212.8665846756849;1219.9268043917393;13356.265405402795;13538.864611353958;13561.932190338985;13604.455821767018;13620.387082581308;267871;270836;271133;271301;271419;58855.70572147112;61619;61812.69093654503;62429;62534;1487.1746180869504;1512.3874830693367;1513.4475916290694;1537.4849425442378;1540.1452194032195;29912.70087299099;30267.243318917204;30454.543181852732;30472.23819404444;30888.845555772077;41645.79177104216;41777.79111104425;41786.1642767149;41802.58197417987;41839.37240941328;230108;231075;234172;234222;235066;32997.17507062342;33386.33227335391;35307.64692353044;36575.634243658285;37175.81412092922;47031.52968470271;47093.29360059533;47164.7641761789;47228.29157562708;47277.76361118173;34690.65309346874;35014.124646883014;35083.29833403369;35155.824220878734;35579.11052223715;34633;34655.13362165966;34737.30525389528;34745.65254347424;35044.82477587698;40519.98700032523;40521.79739101286;40629.1874162521;40715.18569628531;41038.589614103475;33450.66549334476;33494.66505335013;33694.157646059044;33759;34236.82881585676;25247.24258272255;25573.488530229664;25759.227223183334;25901.352466188495;26397.604035939094 18:25:51 INFO - PID 23283 | |2;jquery.html;609.2384519350811;613.2426453330137;613.8219916224296;623.3921926122028;636.1761518833111;22772.430689232777;23390.88304558479;23570.88214558927;23589.882050589724;23614;23593.528129437444;24051.75948240517;24406.389840254004;24481.265562033124;24486.510269794595;6393.840153996152;6480.4491618212505;6505.284418713938;6523.282438931714;6533.934660653404;6356.173697419352;6459.128017717619;6493.870122597569;6714.597124172541;6760.966195169017;6718.361755633207;6718.496112791536;6718.798436046926;6718.832029199285;6724.226713927912;6519.152510173647;6714.798556043326;6715.2613212546585;6728.259891411965;6835;6328;6334.429901308904;6374;6375.744970201186;6381.680915954184;29740.107796766133;30177.849110754527;30222.54666180009;30254;30271;2320.060375547906;2329.138218859016;2341.040173528845;2343.695319608457;2355.1639168095253;20074.197032118846;20607.381778546667;20948.266810661553;21142.89428552863;21178.682319765216;2506.5613517634342;2540.745925407463;2563.9487210255875;2626.3302857771146;2632.3682316244153;144410.27794861063;151244;152227;158599;159814.99999999884;15243.542693719206;16018.359265629244;16226.594335141715;16423.753643695352;16558.751618725728;25600.48799024009;25616.359591010372;25639.48721025569;25754.613680794802;25774.355641109123;10006.249531285037;10263.538140783534;10334.896651033543;10434.895651043544;10466.63366782159;9179.908200917906;9181.081891810765;9196.816063678689;9293.117153870371;9305.767355816159;9932.453715045742;10118.089371956412;10140.391576505433;10162.644307449204;10214.795704085876;2923.853807309626;2942.396808654221;2945.926351841178;2973.8810447581855;3056.679048699899;1026.38416949831;1037.8391349340864;1050.0497050169608;1059.8781140168978;1063.1069901282806;20816.06327715226;21138.15447382118;21208.15167393318;21257.89371053135;21282.255121070688;1082.2640604388935;1089.7711480589007;1092.071739021841;1102.614085070219;1115.341948250536;11710.590129345432;11713.941430292964;11756.823647645293;11766.352850593299;11860.584879529348;582064;587291;597612;598915;607061;123423;124038;126931;127334;128398;1179.8702142764462;1182.7161481244439;1219.2562536852513;1223.0582451512464;1233.9506419743288;18165.54586135357;18233.817661823214;18330.358437454626;18472.353467628567;18677;58042.4195758037;59116.40883591109;59512.70243648754;61117.38882611117;61351;75802.62098689692;76922.61538692271;77290.2270977283;77549;77666.2233377659;15614.45349412765;15644.296006679955;15710.685786284439;15745.291461884472;15821;23818.285451436484;24034.39914002164;24061;24142.155024574055;24334.26997190087;18907;19716.605667886273;19913.10391032378;20015.399538013884;20066.799332006492;17042.573935651708;17071.40250091241;17248.137593120544;17868.821311786716;17904.462866114038;19427.028648567797;19623.901880490506;19817.405477835688;19901.203951841766;20163.495912602302;15382.538523844303;15413;15561.610959726097;15574.065556066673;15578.9221053894;19550.31573894907;19594.02029898471;19632.214711411954;19679.114439850528;19703.211871524978 18:25:51 INFO - PID 23283 | |3;mootools.html;1388.5556621880996;1432.455666846599;1468.3319089814136;1477.2982833154247;1477.9113253204805;14019.719605607881;14633.195174265411;14647.121172729643;16881.91559042206;17345.7398139028;16978.40575579855;17239.82760172398;17253.654926901487;17272.740908886375;17278;2801.80387372884;2812.5078111330536;2820.4641118187583;2831.221414111126;2831.8017738758294;2804.3970546332534;2908.2874695699584;2909.636295463067;2910.1706013786074;2912.170031541011;2802.383475635367;2821.097248880359;2832.9291767705868;2834.716528347159;2835.9716402835916;2745.094118940755;2771.459565384751;2791.8883244670187;2792.8882844686186;2801.089645865102;2640.3003204150914;2663.706992230853;2677.4645070985684;2679.477501887133;2681.5173268811604;16261.430849920314;16636.33454661812;16666.33334666624;16667.166641667867;16667.91666041674;8024.277814996678;8254.752357429286;8306.584670766499;8312.501249925024;8315.293200078;5117.6161787865685;5230.895382092375;5336.17289320156;5373.570114390839;5399.83800485986;2042.7855075217185;2054.589082183554;2063.700763389315;2119.279444988711;2157.946051348729;29814.70185298141;30201.09396718102;30359.24101897448;30513.847430762926;30547.389052219052;7110.862262038049;7201.207867134611;7213.747518836815;7299.963500182465;7414.777556673308;19873.205071796965;19987.200511979358;19994.400167994983;19997.100130494164;20004.89997550003;8237.958810205912;8421.24208821209;8437.57812109392;8444.957775211085;8446.366522510836;7441.479096463196;7587.734429294948;7684.154742978268;7706.5761383123345;7720.884186737204;5549.528290095387;5711.286089238845;5738.913916291259;5781.335146458211;5797.884042319214;1581.2568092996273;1608.340580362046;1636.4272504623286;1638.721417359028;1639.7048531264486;901.6663834381321;913.3834661603391;920.2637889688223;929.702495201529;932.654917680449;7901.367890568741;7908.169642187488;7953.403494737918;7958.960205199052;8003.119656837744;785.7548325415995;794.7258195922398;799.7760627024443;802.835418739157;816.318374157585;4442.178197033559;4445.222086134913;4664.580187783048;5739.311282646109;5865.648061116347;24997.12510062139;25360.365990850376;25803.096891608704;25824.22527324183;25904.481910361686;24042.87978560131;25013.499730005296;25082.372940676265;25808.870955645478;25836.224913252634;11176;11497.59758408435;12646.620601381974;13011.479540818262;13086.934565327303;7930.563818990011;9265.629374824932;9282.443053416817;9344.439333640003;9442.622295108118;19936.90031549833;20299;20534.07596658124;20579.4855128623;20786.58426831485;20650.07074681673;20951;20989;21033.57932841304;21051;13679.931600341935;13702.766750992458;13852.72294554083;14007.859921400655;14009.369578368794;15717.056976581442;15773.842261577238;15902.443414480438;15913.761293580374;15940.123293218985;12308.138430309793;12591.307478088427;12669.113162078565;12745.235285882876;12807.80788288195;12403.937980310402;12512.124151309321;12676.492940282285;12922.095453318178;12948.15836970594;9763.658271960447;9809.803803923738;9819.754506137404;9858.063483969012;9890.604375825174;7321.890171647323;7347.88514451465;7356;7386.633472807548;7433.331000209791;7499.850003000019;7503.962480187564;7589.203133671106;7630.084389873251;7637.2362763725405 18:25:51 INFO - PID 23283 | |4;prototype.html;524.3419508516813;544.6187668631958;561.9325680918289;566.3402136510965;573.1574585359521;6194.411530904563;6337.968310158449;6350.206224221973;6368.235811702591;6398.968005159979;6201.720922558485;6221.968890155543;6226.9377306226925;6271;6279.529035322346;4919.60643148549;4956.975215123928;4962.379702537183;4981.9252711209365;4988.152014157584;4990.775415106311;5017.774200160983;5039.09296326661;5067.315912351823;5076.543111119999;4955.182394904837;5033.370828646419;5038.622103342264;5062.493750624945;5062.721550314731;4954.975225123887;4979.352684151074;5008.849734507952;5030.465707959071;5069.44236134025;4597.287420449836;4598.425196850394;4604.5165257647795;4608;4609.976950115261;6156.984097623887;6220.502359811249;6223;6236.6258024518675;6280.057991301295;5849.707514624251;5880.382559831199;5887.967696636236;5903.291605007384;5922.4077592240865;6672.2994085621285;6692.196936367618;6704.094947182166;6716.798496045078;6766.56017358875;5113.2330150477355;5120.590352771769;5121.564667003309;5126.820561280338;5147.2279158126585;6879.89680154793;6924.272951340137;6967.268436814163;7022.101434794746;7039.683214255371;5224.764885580158;5236.450172731885;5254.369475662868;5259.316288882421;5276.92084618731;5293.947060529423;5324.5740340772645;5335.119705248668;5360.624756267024;5367.4364191759305;5841.41585841421;5874.177615133799;5875.764969401176;5889.23439952812;5906.586538942232;6411.551191416649;6467.741290348427;6604.174478190226;6636;6767.661616919135;1816.6729988602178;1825.972610410845;1827.2782251010776;1836.9724454132931;1842.8986405747544;1297.3253907967803;1297.6172029251393;1303.1138825598493;1306.8954483641287;1317.4993502469192;6034;6136.509079273647;6187.721552530147;6237.875242495124;6261.342559031327;6711.832204194837;6758.526903116833;6765.255821859591;6781.897611740376;6840.879327408519;6127.571070025145;6192.195014648157;6212.1303017577575;6286.717097730613;6353.4599559038;3574.8391322390553;3588.2823435313044;3601.1897323102617;3615.493830863681;3639.7998110103667;6999.580025198505;7004.159500859828;7072.823179420556;7078.893816592756;7096.680649370791;6972.721091156297;7038.331358520933;7039.718411263594;7046.0054476847135;7066;6989.720411183495;7065.788026359115;7079.36285734276;7083.5041547091205;7093.467989900675;6736.427403670743;6756.69594868242;6852.897206542006;6871.828204294733;6880.415164711056;6593.703283352164;6619.536632435684;6703.229128650268;6774.627395493295;6790.966045169743;6904.516683832084;7034.261402552658;7048.189458212371;7056.54132481387;7063.82340441493;5122.615803814803;5156.303898973591;5173.793048278178;5248.317718696545;5260.368755749181;6683.68646925705;6764.188297404343;6777.593344399352;6844.555103918229;6868.278830722702;6271.3728627136925;6537.378948999837;6542.607443553402;6566.277709451861;6651.634160121046;6518.608883467007;6577.934220657924;6586.670666466754;6594.856671581851;6595.307492713196;6214.25428948529;6329.367063293634;6413.422791948747;6497.62123695685;6509.967450162719;6551.50863685216;6627.4698024158915;6648.368405001517;6684.197896252286;6700.731970721312;6428.55000149985;6449.193850768654;6516.348365163446;6549.672516374258;6575.079488871657 18:25:51 INFO - PID 23283 | |5;yui.html;915.4187091197088;967.148908960115;989.2045936625025;996.4917891875142;1007.1741172238765;19457;19575.119119639614;19579.412617621478;19809.50476238093;19937.800621993774;19304.613907721836;19478.513037174078;19668.508287292825;19728.802711972876;19753.802461975374;1027.7584767579613;1031.448175226254;1037.6264544763878;1038.6260946059413;1039.6153423233413;1051.984220236697;1054.2936232724055;1060.1306928318782;1061.060961049473;1062.654637242899;1116.6929094498996;1149.0290704354848;1153.5847095045776;1154.4631746237997;1154.7632735289287;1131.2081542919907;1135.5911871726173;1137.709883979584;1139.5612689114669;1140.1790710688292;792.4056957282038;809.0897740042452;813.1096449387911;814.311906439058;815.8776183572512;21651.133954641795;21778.34664960054;21791.128354865785;21835.454113647287;21866.781332186634;22782.886085569633;23000.309990700305;23408.414789630224;23609;23798;18591;18778.154983025797;18829.623407531773;19106.33127840519;19110.80889191104;3963.8810835674685;3974.960250397517;3991.7405368651234;3993.560708322082;4000.0399904023116;130230;147947;150492;151060;154005.2299738494;18526.536836579195;18766.53083672919;18844.717329240073;19070.809291907182;19128.23487060502;33879.49180762291;34512.82743586266;34772.30455390878;34778.478322825176;35226.47160292598;9983.900160998297;10106.545205465773;10107.797844043078;10131.08820206185;10146.137578305927;4799.736014519235;4877.829275975324;4880.097182021337;4892.559669629751;4901.436334821541;5918.822435326947;6006.609570377911;6050.183225264621;6077.848053798691;6088.6042407243385;1195.1753290229888;1228.3489750432286;1229.2071613809044;1233.1984210263222;1241.944112514939;744.4267913706416;751.8496300739874;757.9696812127563;770.8342706318168;774.2025713514976;12321.753564928651;13236.338183090807;13404.731905361838;13622;13846.376913038937;721.3183541553286;721.6499997501313;728.402709777977;732.9890051649229;747.2975403121048;6093.96953015241;6210.223722034746;6270.749170033238;6315.747370105236;6329.335419780857;148280;149409;151002;156883;159048;103499;105808.47095764472;127153;130632.3468382652;136530;104679.47660261803;106810;115498.42250788692;117789.4110529459;118270.40864795621;13132.212067275612;13410.39653215588;13635.795463067863;14049.859501404855;14307;53654;55100.448995511135;55973.44026559845;56560;56931.43068569427;71543.28456715366;73978.15054623462;74057;75075.24924750901;75405;20775.168993240102;20942.267020654202;21409.250676226256;21699.34901952944;22048.779512205314;23213.651795223424;24061.759382406653;24311.51376972486;24327.878360608083;24380.146694865594;21196.68204976896;21207.57584848325;21219.257325993516;21412.143514259256;21810;17090.57273568121;17211;17342.393016244372;17403.129843508028;17431.128443577516;18358.541036474195;18482;18515.259389624265;18542.629147417247;18618.44144675662;15563.221838907783;15680.686386272439;15752.133632649857;15814.446494372642;15895;14190.266304863668;14427.855721443071;14563.199024053778;14732.337044832793;14736.48422305214 18:25:51 INFO - PID 23283 | __end_tp_report 18:25:51 INFO - PID 23283 | __start_cc_report 18:25:51 INFO - PID 23283 | _x_x_mozilla_cycle_collect,254 18:25:51 INFO - PID 23283 | __end_cc_report 18:25:51 INFO - PID 23283 | __startTimestamp1506389151443__endTimestamp 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | ------- Summary: start ------- 18:25:51 INFO - PID 23283 | Number of tests: 6 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | [#0] dojo.html Cycles:165 Average:6300.75 Median:6583.84 stddev:893.51 (13.6%) stddev-sans-first:875.04 18:25:51 INFO - PID 23283 | Values: 3833.7 3854.2 3862.5 3867.9 3908.3 6199.1 6271.7 6323.0 6324.8 6419.2 6295.1 6312.5 6327.6 6340.8 6355.7 5631.5 5750.0 5750.9 5756.2 5779.6 129.1 5742.4 5752.0 5821.4 5822.2 5645.5 5652.3 5659.9 5763.0 5788.4 5640.9 5671.1 5746.7 5754.9 5757.0 5638.4 5650.7 5739.3 5739.4 5740.3 6259.8 6269.1 6306.9 6310.1 6379.1 6706.0 6842.0 6856.3 6926.8 6939.8 6893.9 6899.7 6905.8 6916.6 6918.7 6270.1 6386.4 6428.6 6437.7 6479.3 7084.1 7170.3 7182.1 7187.2 7194.0 6738.6 6755.0 6764.9 6862.3 6876.0 6752.6 6849.0 6870.6 6966.1 6972.0 6806.7 6901.8 6921.4 6940.3 6953.5 6857.6 6888.1 6934.1 6953.0 6956.1 4921.8 5014.3 5022.6 5095.6 5100.3 4520.5 4584.3 4631.6 4659.3 4688.0 6318.7 6326.3 6386.1 6400.3 6407.1 6762.5 6830.7 6870.7 6940.5 6954.5 6316.9 6349.2 6356.2 6363.7 6365.4 5498.3 5543.2 5586.5 5612.7 5627.2 6993.5 7076.8 7084.0 7113.7 7235.6 6727.7 6735.7 6798.1 6884.8 6904.3 7176.8 7194.6 7197.2 7204.1 7232.7 6677.9 6776.1 6811.1 6861.2 6877.6 6743.8 6827.6 6846.8 6936.0 6961.2 6611.2 6691.8 6698.7 6711.9 6718.3 6586.4 6629.7 6711.8 6713.4 6721.8 6479.8 6495.6 6558.9 6562.2 6574.8 6689.1 6692.4 6705.7 6716.5 6780.5 6572.9 6582.9 6583.8 6595.4 6614.8 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | [#1] ext.html Cycles:180 Average:42495.63 Median:3760.01 stddev:63249.59 (1682.2%) stddev-sans-first:63350.17 18:25:51 INFO - PID 23283 | Values: 969.8 993.3 999.6 999.6 999.9 40760.8 43920.0 43959.3 44614.0 44717.1 40992.0 41234.0 41258.6 41297.2 41449.8 7631.2 7727.0 7763.6 8470.1 8705.7 8469.4 8584.9 8595.0 8599.1 8603.6 8534.7 8605.1 8626.4 8639.2 8641.0 8546.6 8565.9 8592.8 8612.2 8619.8 8515.6 8552.5 8554.2 8558.4 8572.3 41621.2 41847.2 41992.6 42119.4 42271.8 3752.9 3767.1 3777.5 3806.0 3817.5 34122.8 34161.0 34242.3 34246.5 34261.0 5447.4 5504.5 5544.3 5545.8 5628.2 223138.0 224702.0 225000.0 225482.0 225557.0 47661.3 47975.5 52904.5 53027.5 53340.5 57536.7 58216.0 58327.7 58348.0 58471.4 15422.3 15474.0 15558.1 15578.0 15579.5 12243.0 12261.8 12295.1 12310.5 12332.3 15430.6 15671.1 15781.6 15844.5 15880.7 6061.9 6085.3 6085.4 6114.5 6143.9 1091.3 1100.3 1104.6 1122.0 1129.0 25512.9 25847.9 25861.6 25878.4 26045.9 1206.4 1209.7 1210.6 1212.9 1219.9 13356.3 13538.9 13561.9 13604.5 13620.4 267871.0 270836.0 271133.0 271301.0 271419.0 58855.7 61619.0 61812.7 62429.0 62534.0 1487.2 1512.4 1513.4 1537.5 1540.1 29912.7 30267.2 30454.5 30472.2 30888.8 41645.8 41777.8 41786.2 41802.6 41839.4 230108.0 231075.0 234172.0 234222.0 235066.0 32997.2 33386.3 35307.6 36575.6 37175.8 47031.5 47093.3 47164.8 47228.3 47277.8 34690.7 35014.1 35083.3 35155.8 35579.1 34633.0 34655.1 34737.3 34745.7 35044.8 40520.0 40521.8 40629.2 40715.2 41038.6 33450.7 33494.7 33694.2 33759.0 34236.8 25247.2 25573.5 25759.2 25901.4 26397.6 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | [#2] jquery.html Cycles:180 Average:39124.72 Median:2324.60 stddev:99554.40 (4282.6%) stddev-sans-first:99791.67 18:25:51 INFO - PID 23283 | Values: 609.2 613.2 613.8 623.4 636.2 22772.4 23390.9 23570.9 23589.9 23614.0 23593.5 24051.8 24406.4 24481.3 24486.5 6393.8 6480.4 6505.3 6523.3 6533.9 6356.2 6459.1 6493.9 6714.6 6761.0 6718.4 6718.5 6718.8 6718.8 6724.2 6519.2 6714.8 6715.3 6728.3 6835.0 6328.0 6334.4 6374.0 6375.7 6381.7 29740.1 30177.8 30222.5 30254.0 30271.0 2320.1 2329.1 2341.0 2343.7 2355.2 20074.2 20607.4 20948.3 21142.9 21178.7 2506.6 2540.7 2563.9 2626.3 2632.4 144410.3 151244.0 152227.0 158599.0 159815.0 15243.5 16018.4 16226.6 16423.8 16558.8 25600.5 25616.4 25639.5 25754.6 25774.4 10006.2 10263.5 10334.9 10434.9 10466.6 9179.9 9181.1 9196.8 9293.1 9305.8 9932.5 10118.1 10140.4 10162.6 10214.8 2923.9 2942.4 2945.9 2973.9 3056.7 1026.4 1037.8 1050.0 1059.9 1063.1 20816.1 21138.2 21208.2 21257.9 21282.3 1082.3 1089.8 1092.1 1102.6 1115.3 11710.6 11713.9 11756.8 11766.4 11860.6 582064.0 587291.0 597612.0 598915.0 607061.0 123423.0 124038.0 126931.0 127334.0 128398.0 1179.9 1182.7 1219.3 1223.1 1234.0 18165.5 18233.8 18330.4 18472.4 18677.0 58042.4 59116.4 59512.7 61117.4 61351.0 75802.6 76922.6 77290.2 77549.0 77666.2 15614.5 15644.3 15710.7 15745.3 15821.0 23818.3 24034.4 24061.0 24142.2 24334.3 18907.0 19716.6 19913.1 20015.4 20066.8 17042.6 17071.4 17248.1 17868.8 17904.5 19427.0 19623.9 19817.4 19901.2 20163.5 15382.5 15413.0 15561.6 15574.1 15578.9 19550.3 19594.0 19632.2 19679.1 19703.2 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | [#3] mootools.html Cycles:180 Average:10253.58 Median:2802.09 stddev:7735.00 (276.0%) stddev-sans-first:7728.03 18:25:51 INFO - PID 23283 | Values: 1388.6 1432.5 1468.3 1477.3 1477.9 14019.7 14633.2 14647.1 16881.9 17345.7 16978.4 17239.8 17253.7 17272.7 17278.0 2801.8 2812.5 2820.5 2831.2 2831.8 2804.4 2908.3 2909.6 2910.2 2912.2 2802.4 2821.1 2832.9 2834.7 2836.0 2745.1 2771.5 2791.9 2792.9 2801.1 2640.3 2663.7 2677.5 2679.5 2681.5 16261.4 16636.3 16666.3 16667.2 16667.9 8024.3 8254.8 8306.6 8312.5 8315.3 5117.6 5230.9 5336.2 5373.6 5399.8 2042.8 2054.6 2063.7 2119.3 2157.9 29814.7 30201.1 30359.2 30513.8 30547.4 7110.9 7201.2 7213.7 7300.0 7414.8 19873.2 19987.2 19994.4 19997.1 20004.9 8238.0 8421.2 8437.6 8445.0 8446.4 7441.5 7587.7 7684.2 7706.6 7720.9 5549.5 5711.3 5738.9 5781.3 5797.9 1581.3 1608.3 1636.4 1638.7 1639.7 901.7 913.4 920.3 929.7 932.7 7901.4 7908.2 7953.4 7959.0 8003.1 785.8 794.7 799.8 802.8 816.3 4442.2 4445.2 4664.6 5739.3 5865.6 24997.1 25360.4 25803.1 25824.2 25904.5 24042.9 25013.5 25082.4 25808.9 25836.2 11176.0 11497.6 12646.6 13011.5 13086.9 7930.6 9265.6 9282.4 9344.4 9442.6 19936.9 20299.0 20534.1 20579.5 20786.6 20650.1 20951.0 20989.0 21033.6 21051.0 13679.9 13702.8 13852.7 14007.9 14009.4 15717.1 15773.8 15902.4 15913.8 15940.1 12308.1 12591.3 12669.1 12745.2 12807.8 12403.9 12512.1 12676.5 12922.1 12948.2 9763.7 9809.8 9819.8 9858.1 9890.6 7321.9 7347.9 7356.0 7386.6 7433.3 7499.9 7504.0 7589.2 7630.1 7637.2 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | [#4] prototype.html Cycles:180 Average:5664.73 Median:6249.61 stddev:1580.47 (25.3%) stddev-sans-first:1537.09 18:25:51 INFO - PID 23283 | Values: 524.3 544.6 561.9 566.3 573.2 6194.4 6338.0 6350.2 6368.2 6399.0 6201.7 6222.0 6226.9 6271.0 6279.5 4919.6 4957.0 4962.4 4981.9 4988.2 4990.8 5017.8 5039.1 5067.3 5076.5 4955.2 5033.4 5038.6 5062.5 5062.7 4955.0 4979.4 5008.8 5030.5 5069.4 4597.3 4598.4 4604.5 4608.0 4610.0 6157.0 6220.5 6223.0 6236.6 6280.1 5849.7 5880.4 5888.0 5903.3 5922.4 6672.3 6692.2 6704.1 6716.8 6766.6 5113.2 5120.6 5121.6 5126.8 5147.2 6879.9 6924.3 6967.3 7022.1 7039.7 5224.8 5236.5 5254.4 5259.3 5276.9 5293.9 5324.6 5335.1 5360.6 5367.4 5841.4 5874.2 5875.8 5889.2 5906.6 6411.6 6467.7 6604.2 6636.0 6767.7 1816.7 1826.0 1827.3 1837.0 1842.9 1297.3 1297.6 1303.1 1306.9 1317.5 6034.0 6136.5 6187.7 6237.9 6261.3 6711.8 6758.5 6765.3 6781.9 6840.9 6127.6 6192.2 6212.1 6286.7 6353.5 3574.8 3588.3 3601.2 3615.5 3639.8 6999.6 7004.2 7072.8 7078.9 7096.7 6972.7 7038.3 7039.7 7046.0 7066.0 6989.7 7065.8 7079.4 7083.5 7093.5 6736.4 6756.7 6852.9 6871.8 6880.4 6593.7 6619.5 6703.2 6774.6 6791.0 6904.5 7034.3 7048.2 7056.5 7063.8 5122.6 5156.3 5173.8 5248.3 5260.4 6683.7 6764.2 6777.6 6844.6 6868.3 6271.4 6537.4 6542.6 6566.3 6651.6 6518.6 6577.9 6586.7 6594.9 6595.3 6214.3 6329.4 6413.4 6497.6 6510.0 6551.5 6627.5 6648.4 6684.2 6700.7 6428.6 6449.2 6516.3 6549.7 6575.1 18:25:51 INFO - PID 23283 | 18:25:51 INFO - PID 23283 | [#5] yui.html Cycles:180 Average:28315.91 Median:19380.81 stddev:40623.18 (209.6%) stddev-sans-first:40685.03 18:25:51 INFO - PID 23283 | Values: 915.4 967.1 989.2 996.5 1007.2 19457.0 19575.1 19579.4 19809.5 19937.8 19304.6 19478.5 19668.5 19728.8 19753.8 1027.8 1031.4 1037.6 1038.6 1039.6 1052.0 1054.3 1060.1 1061.1 1062.7 1116.7 1149.0 1153.6 1154.5 1154.8 1131.2 1135.6 1137.7 1139.6 1140.2 792.4 809.1 813.1 814.3 815.9 21651.1 21778.3 21791.1 21835.5 21866.8 22782.9 23000.3 23408.4 23609.0 23798.0 18591.0 18778.2 18829.6 19106.3 19110.8 3963.9 3975.0 3991.7 3993.6 4000.0 130230.0 147947.0 150492.0 151060.0 154005.2 18526.5 18766.5 18844.7 19070.8 19128.2 33879.5 34512.8 34772.3 34778.5 35226.5 9983.9 10106.5 10107.8 10131.1 10146.1 4799.7 4877.8 4880.1 4892.6 4901.4 5918.8 6006.6 6050.2 6077.8 6088.6 1195.2 1228.3 1229.2 1233.2 1241.9 744.4 751.8 758.0 770.8 774.2 12321.8 13236.3 13404.7 13622.0 13846.4 721.3 721.6 728.4 733.0 747.3 6094.0 6210.2 6270.7 6315.7 6329.3 148280.0 149409.0 151002.0 156883.0 159048.0 103499.0 105808.5 127153.0 130632.3 136530.0 104679.5 106810.0 115498.4 117789.4 118270.4 13132.2 13410.4 13635.8 14049.9 14307.0 53654.0 55100.4 55973.4 56560.0 56931.4 71543.3 73978.2 74057.0 75075.2 75405.0 20775.2 20942.3 21409.3 21699.3 22048.8 23213.7 24061.8 24311.5 24327.9 24380.1 21196.7 21207.6 21219.3 21412.1 21810.0 17090.6 17211.0 17342.4 17403.1 17431.1 18358.5 18482.0 18515.3 18542.6 18618.4 15563.2 15680.7 15752.1 15814.4 15895.0 14190.3 14427.9 14563.2 14732.3 14736.5 18:25:51 INFO - PID 23283 | -------- Summary: end -------- 18:25:51 INFO - PID 23283 | 18:25:52 INFO - TEST-INFO | 23283: exit 0 18:25:52 INFO - TEST-OK | dromaeo_css | took 1106701ms 18:25:52 INFO - TEST-START | kraken 18:25:52 INFO - Initialising browser for kraken test... 18:25:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46374/getInfo.html -profile /tmp/tmph6vq0f/profile 18:25:52 INFO - TEST-INFO | started process 23666 (/builds/slave/test/build/application/firefox/firefox http://localhost:46374/getInfo.html) 18:25:57 INFO - TEST-INFO | 23666: exit 0 18:25:57 INFO - Browser initialized. 18:25:57 INFO - Running cycle 1/1 for kraken test... 18:25:57 INFO - Using env: {'DISPLAY': ':0', 18:25:57 INFO - 'HOME': '/home/cltbld', 18:25:57 INFO - 'JSGC_DISABLE_POISONING': '1', 18:25:57 INFO - 'LANG': 'en_US.UTF-8', 18:25:57 INFO - 'LANGUAGE': 'en_US:en', 18:25:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:25:57 INFO - 'LOGNAME': 'cltbld', 18:25:57 INFO - 'MAIL': '/var/mail/cltbld', 18:25:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:25:57 INFO - 'MOZ_CRASHREPORTER': '1', 18:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:25:57 INFO - 'MOZ_NO_REMOTE': '1', 18:25:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:57 INFO - 'NO_EM_RESTART': '1', 18:25:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:57 INFO - 'PWD': '/builds/slave/test', 18:25:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:57 INFO - 'RUST_BACKTRACE': 'full', 18:25:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:25:57 INFO - 'SHELL': '/bin/bash', 18:25:57 INFO - 'SHLVL': '1', 18:25:57 INFO - 'TERM': 'linux', 18:25:57 INFO - 'TMOUT': '86400', 18:25:57 INFO - 'USER': 'cltbld', 18:25:57 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708', 18:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:57 INFO - '_': '/tools/buildbot/bin/python'} 18:25:57 INFO - TEST-INFO | started process 23906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph6vq0f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:58 INFO - PID 23906 | 18:25:58 INFO - PID 23906 | (/builds/slave/test/build/application/firefox/firefox:23955): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:25:58 INFO - PID 23906 | 18:26:08 INFO - PID 23906 | RSS: Main: 145129472 18:26:08 INFO - PID 23906 | 18:26:10 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46374/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:11 INFO - PID 23906 | RSS: Main: 151277568 18:26:11 INFO - PID 23906 | 18:26:14 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46374/tests/kraken/driver.html?testName=audio-dft) 18:26:15 INFO - PID 23906 | RSS: Main: 151584768 18:26:15 INFO - PID 23906 | 18:26:17 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46374/tests/kraken/driver.html?testName=audio-fft) 18:26:18 INFO - PID 23906 | RSS: Main: 147648512 18:26:18 INFO - PID 23906 | 18:26:20 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46374/tests/kraken/driver.html?testName=audio-oscillator) 18:26:21 INFO - PID 23906 | RSS: Main: 148918272 18:26:21 INFO - PID 23906 | 18:26:23 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:23 INFO - PID 23906 | RSS: Main: 148926464 18:26:23 INFO - PID 23906 | 18:26:27 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46374/tests/kraken/driver.html?testName=imaging-darkroom) 18:26:27 INFO - PID 23906 | RSS: Main: 148709376 18:26:27 INFO - PID 23906 | 18:26:31 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46374/tests/kraken/driver.html?testName=imaging-desaturate) 18:26:31 INFO - PID 23906 | RSS: Main: 149794816 18:26:31 INFO - PID 23906 | 18:26:34 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46374/tests/kraken/driver.html?testName=json-parse-financial) 18:26:35 INFO - PID 23906 | RSS: Main: 151863296 18:26:35 INFO - PID 23906 | 18:26:36 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:26:37 INFO - PID 23906 | RSS: Main: 150958080 18:26:37 INFO - PID 23906 | 18:26:38 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:26:39 INFO - PID 23906 | RSS: Main: 151031808 18:26:39 INFO - PID 23906 | 18:26:41 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:26:42 INFO - PID 23906 | RSS: Main: 148058112 18:26:42 INFO - PID 23906 | 18:26:44 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:26:45 INFO - PID 23906 | RSS: Main: 148467712 18:26:45 INFO - PID 23906 | 18:26:48 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:26:48 INFO - PID 23906 | RSS: Main: 149028864 18:26:48 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | Cycle 1(1): loaded http://localhost:46374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46374/tests/kraken/driver.html?testName=ai-astar) 18:26:50 INFO - PID 23906 | RSS: Main: 150777856 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | __start_tp_report 18:26:50 INFO - PID 23906 | _x_x_mozilla_page_load 18:26:50 INFO - PID 23906 | _x_x_mozilla_page_load_details 18:26:50 INFO - PID 23906 | |i|pagename|runs| 18:26:50 INFO - PID 23906 | |0;ai-astar;107;107;104;105;106;105;107;107;104;105 18:26:50 INFO - PID 23906 | |1;audio-beat-detection;115;112;113;113;116;112;112;114;113;125 18:26:50 INFO - PID 23906 | |2;audio-dft;162;163;161;163;162;162;162;161;167;163 18:26:50 INFO - PID 23906 | |3;audio-fft;73;80;76;75;74;73;79;74;76;75 18:26:50 INFO - PID 23906 | |4;audio-oscillator;79;79;77;82;78;78;78;82;79;78 18:26:50 INFO - PID 23906 | |5;imaging-gaussian-blur;113;114;113;113;114;113;114;114;114;113 18:26:50 INFO - PID 23906 | |6;imaging-darkroom;149;149;150;149;149;148;149;150;149;149 18:26:50 INFO - PID 23906 | |7;imaging-desaturate;98;94;94;94;95;94;93;94;94;94 18:26:50 INFO - PID 23906 | |8;json-parse-financial;44;46;45;45;46;53;45;56;46;48 18:26:50 INFO - PID 23906 | |9;json-stringify-tinderbox;38;38;39;39;39;40;39;39;41;39 18:26:50 INFO - PID 23906 | |10;stanford-crypto-aes;71;72;71;71;70;72;71;79;83;69 18:26:50 INFO - PID 23906 | |11;stanford-crypto-ccm;104;106;107;111;105;112;110;112;104;110 18:26:50 INFO - PID 23906 | |12;stanford-crypto-pbkdf2;151;154;154;150;152;157;150;154;147;159 18:26:50 INFO - PID 23906 | |13;stanford-crypto-sha256-iterative;61;61;60;60;64;61;63;63;63;63 18:26:50 INFO - PID 23906 | __end_tp_report 18:26:50 INFO - PID 23906 | __start_cc_report 18:26:50 INFO - PID 23906 | _x_x_mozilla_cycle_collect,716 18:26:50 INFO - PID 23906 | __end_cc_report 18:26:50 INFO - PID 23906 | __startTimestamp1506389210560__endTimestamp 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | ------- Summary: start ------- 18:26:50 INFO - PID 23906 | Number of tests: 14 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.50 stddev:1.25 (1.2%) stddev-sans-first:1.24 18:26:50 INFO - PID 23906 | Values: 107.0 107.0 104.0 105.0 106.0 105.0 107.0 107.0 104.0 105.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#1] audio-beat-detection Cycles:10 Average:114.50 Median:113.50 stddev:3.92 (3.5%) stddev-sans-first:4.16 18:26:50 INFO - PID 23906 | Values: 115.0 112.0 113.0 113.0 116.0 112.0 112.0 114.0 113.0 125.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.71 (1.1%) stddev-sans-first:1.80 18:26:50 INFO - PID 23906 | Values: 162.0 163.0 161.0 163.0 162.0 162.0 162.0 161.0 167.0 163.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#3] audio-fft Cycles:10 Average:75.50 Median:75.50 stddev:2.37 (3.1%) stddev-sans-first:2.33 18:26:50 INFO - PID 23906 | Values: 73.0 80.0 76.0 75.0 74.0 73.0 79.0 74.0 76.0 75.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:1.70 (2.2%) stddev-sans-first:1.80 18:26:50 INFO - PID 23906 | Values: 79.0 79.0 77.0 82.0 78.0 78.0 78.0 82.0 79.0 78.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:26:50 INFO - PID 23906 | Values: 113.0 114.0 113.0 113.0 114.0 113.0 114.0 114.0 114.0 113.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:26:50 INFO - PID 23906 | Values: 149.0 149.0 150.0 149.0 149.0 148.0 149.0 150.0 149.0 149.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.35 (1.4%) stddev-sans-first:0.50 18:26:50 INFO - PID 23906 | Values: 98.0 94.0 94.0 94.0 95.0 94.0 93.0 94.0 94.0 94.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#8] json-parse-financial Cycles:10 Average:47.40 Median:46.00 stddev:3.95 (8.6%) stddev-sans-first:3.99 18:26:50 INFO - PID 23906 | Values: 44.0 46.0 45.0 45.0 46.0 53.0 45.0 56.0 46.0 48.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:39.00 stddev:0.88 (2.2%) stddev-sans-first:0.83 18:26:50 INFO - PID 23906 | Values: 38.0 38.0 39.0 39.0 39.0 40.0 39.0 39.0 41.0 39.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:71.50 stddev:4.46 (6.2%) stddev-sans-first:4.68 18:26:50 INFO - PID 23906 | Values: 71.0 72.0 71.0 71.0 70.0 72.0 71.0 79.0 83.0 69.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#11] stanford-crypto-ccm Cycles:10 Average:108.10 Median:110.00 stddev:3.25 (3.0%) stddev-sans-first:3.09 18:26:50 INFO - PID 23906 | Values: 104.0 106.0 107.0 111.0 105.0 112.0 110.0 112.0 104.0 110.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:154.00 stddev:3.55 (2.3%) stddev-sans-first:3.71 18:26:50 INFO - PID 23906 | Values: 151.0 154.0 154.0 150.0 152.0 157.0 150.0 154.0 147.0 159.0 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.50 18:26:50 INFO - PID 23906 | Values: 61.0 61.0 60.0 60.0 64.0 61.0 63.0 63.0 63.0 63.0 18:26:50 INFO - PID 23906 | -------- Summary: end -------- 18:26:50 INFO - PID 23906 | 18:26:50 INFO - PID 23906 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:26:51 INFO - TEST-INFO | 23906: exit 0 18:26:51 INFO - TEST-OK | kraken | took 59054ms 18:26:51 INFO - SUITE-END | took 1165s 18:26:51 INFO - Completed test suite (00:19:25) 18:26:51 INFO - javascript benchmark 18:26:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9089.981707362813, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3833.6549710526047, 3854.1520865409607, 3862.517185351831, 3867.9226415471708, 3908.3160446921784, 6199.101130336098, 6271.686415679209, 6323.0, 6324.81025569233, 6419.165508483902, 6295.087212354206, 6312.495000399968, 6327.620342779425, 6340.778072767454, 6355.650439225841, 5631.465010823965, 5749.993751093562, 5750.942490575104, 5756.222909907151, 5779.595428320019, 129.1278855368414, 5742.368339482654, 5751.971240143794, 5821.359650438449, 5822.243108395903, 5645.491905728483, 5652.349979752319, 5659.915101273464, 5763.049096899007, 5788.392218817048, 5640.887182256373, 5671.06427439472, 5746.683932383718, 5754.913676294859, 5756.971215143939, 5638.351589567212, 5650.6892120933335, 5739.3399759027825, 5739.426057394269, 5740.282464691913, 6259.843503912439, 6269.122322874756, 6306.87386252277, 6310.1481300024825, 6379.106925030499, 6705.966470167618, 6842.04211410403, 6856.348646878539, 6926.826829329257, 6939.791806245821, 6893.862122757567, 6899.689513971884, 6905.75829845953, 6916.619585922772, 6918.688659010306, 6270.059491076329, 6386.393292637192, 6428.614283143073, 6437.742490300382, 6479.319671434526, 7084.114485689289, 7170.282971702788, 7182.066331376992, 7187.245339239409, 7193.96403017992, 6738.629375384303, 6755.0, 6764.898526522106, 6862.279460656659, 6876.037354770337, 6752.561083529555, 6849.0, 6870.587764734132, 6966.12923384577, 6971.965140174267, 6806.659667016629, 6901.792946211622, 6921.377076063179, 6940.305969403019, 6953.478489113337, 6857.588544687334, 6888.070110535014, 6934.098567186234, 6953.026576279325, 6956.095707557985, 4921.7785199666105, 5014.323066385991, 5022.648414610942, 5095.566876815438, 5100.285959965608, 4520.52534483881, 4584.289435137559, 4631.560001799824, 4659.347691323217, 4687.9765601171775, 6318.747250109944, 6326.304106548276, 6386.137871387396, 6400.263969643457, 6407.13503677007, 6762.459003279726, 6830.692618832164, 6870.690818913161, 6940.479464040217, 6954.547954382949, 6316.905246421307, 6349.238091429058, 6356.173697419306, 6363.745450181941, 6365.36346365369, 5498.340199176045, 5543.196236545678, 5586.469285417878, 5612.719364031782, 5627.240322556402, 6993.510454268152, 7076.823079423056, 7084.0, 7113.679884405215, 7235.638218089074, 6727.730890764413, 6735.730570777212, 6798.116244888331, 6884.759033433806, 6904.3095690430555, 7176.820579485555, 7194.568325900463, 7197.1723251824615, 7204.0994875640545, 7232.710691572489, 6677.899831502628, 6776.051352810709, 6811.080504132077, 6861.176658800976, 6877.552959057845, 6743.763968261087, 6827.556208846409, 6846.828829279308, 6935.965320173367, 6961.199462061928, 6611.239707433707, 6691.832704182434, 6698.698558564974, 6711.9328806713265, 6718.294579069127, 6586.407223349922, 6629.6685165740555, 6711.765088221889, 6713.362230588282, 6721.831954201184, 6479.773207937699, 6495.642739649365, 6558.934410655832, 6562.245341785756, 6574.769883054261, 6689.063531105552, 6692.397684208445, 6705.664716764045, 6716.529842910949, 6780.491463140185, 6572.901406478811, 6582.901256481061, 6583.835404114744, 6595.4393876521035, 6614.834629134118], "value": 6242.388908678939, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.7624082099884, 993.344392700818, 999.5601935148529, 999.5601935148532, 999.8700168978032, 40760.796196019015, 43920.0, 43959.34060989084, 44614.0, 44717.10565788682, 40992.0, 41234.0, 41258.58741412585, 41297.17405651885, 41449.79275103628, 7631.160572337052, 7727.0, 7763.573003484806, 8470.110638382974, 8705.695300664478, 8469.449485783434, 8584.8712269316, 8595.0, 8599.140085991383, 8603.5698215089, 8534.658613655447, 8605.096464871192, 8626.439281446686, 8639.222469977702, 8640.956795216016, 8546.61540230691, 8565.886434763472, 8592.785180370509, 8612.224899759052, 8619.784505387384, 8515.574221288973, 8552.5296108714, 8554.18735220153, 8558.358123140728, 8572.271356934669, 41621.1675766486, 41847.1630567387, 41992.58007419917, 42119.36820947688, 42271.7886410566, 3752.8874133775757, 3767.1335592813807, 3777.527809023872, 3806.0294624870758, 3817.503724515795, 34122.829385852914, 34161.0, 34242.31515369703, 34246.48630270548, 34261.0, 5447.428020057877, 5504.504594586507, 5544.279243698334, 5545.805896793593, 5628.183913332585, 223138.0, 224702.0, 225000.0, 225482.0, 225557.0, 47661.285080723814, 47975.5202447971, 52904.47095529072, 53027.469725303024, 53340.46659533355, 57536.712316438985, 58216.0, 58327.70836145877, 58348.0, 58471.41528584745, 15422.305996230196, 15474.0, 15558.066516009076, 15578.0, 15579.532614021371, 12243.0, 12261.754764904652, 12295.077869159848, 12310.50757969689, 12332.260064396165, 15430.614234644, 15671.059736415851, 15781.605459863595, 15844.52466426009, 15880.682386352208, 6061.908856405889, 6085.330613632497, 6085.391460853879, 6114.53251219713, 6143.911070236141, 1091.2579445976812, 1100.301308669001, 1104.5747387255965, 1121.9831702524468, 1128.9548418063187, 25512.872435638074, 25847.870760646078, 25861.612075818877, 25878.353041173745, 26045.869770651403, 1206.4269472000906, 1209.6854817747274, 1210.6186551236333, 1212.8665846756849, 1219.9268043917393, 13356.265405402795, 13538.864611353958, 13561.932190338985, 13604.455821767018, 13620.387082581308, 267871.0, 270836.0, 271133.0, 271301.0, 271419.0, 58855.70572147112, 61619.0, 61812.69093654503, 62429.0, 62534.0, 1487.1746180869504, 1512.3874830693367, 1513.4475916290694, 1537.4849425442378, 1540.1452194032195, 29912.70087299099, 30267.243318917204, 30454.543181852732, 30472.23819404444, 30888.845555772077, 41645.79177104216, 41777.79111104425, 41786.1642767149, 41802.58197417987, 41839.37240941328, 230108.0, 231075.0, 234172.0, 234222.0, 235066.0, 32997.17507062342, 33386.33227335391, 35307.64692353044, 36575.634243658285, 37175.81412092922, 47031.52968470271, 47093.29360059533, 47164.7641761789, 47228.29157562708, 47277.76361118173, 34690.65309346874, 35014.124646883014, 35083.29833403369, 35155.824220878734, 35579.11052223715, 34633.0, 34655.13362165966, 34737.30525389528, 34745.65254347424, 35044.82477587698, 40519.98700032523, 40521.79739101286, 40629.1874162521, 40715.18569628531, 41038.589614103475, 33450.66549334476, 33494.66505335013, 33694.157646059044, 33759.0, 34236.82881585676, 25247.24258272255, 25573.488530229664, 25759.227223183334, 25901.352466188495, 26397.604035939094], "value": 18783.900956782723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.2384519350811, 613.2426453330137, 613.8219916224296, 623.3921926122028, 636.1761518833111, 22772.430689232777, 23390.88304558479, 23570.88214558927, 23589.882050589724, 23614.0, 23593.528129437444, 24051.75948240517, 24406.389840254004, 24481.265562033124, 24486.510269794595, 6393.840153996152, 6480.4491618212505, 6505.284418713938, 6523.282438931714, 6533.934660653404, 6356.173697419352, 6459.128017717619, 6493.870122597569, 6714.597124172541, 6760.966195169017, 6718.361755633207, 6718.496112791536, 6718.798436046926, 6718.832029199285, 6724.226713927912, 6519.152510173647, 6714.798556043326, 6715.2613212546585, 6728.259891411965, 6835.0, 6328.0, 6334.429901308904, 6374.0, 6375.744970201186, 6381.680915954184, 29740.107796766133, 30177.849110754527, 30222.54666180009, 30254.0, 30271.0, 2320.060375547906, 2329.138218859016, 2341.040173528845, 2343.695319608457, 2355.1639168095253, 20074.197032118846, 20607.381778546667, 20948.266810661553, 21142.89428552863, 21178.682319765216, 2506.5613517634342, 2540.745925407463, 2563.9487210255875, 2626.3302857771146, 2632.3682316244153, 144410.27794861063, 151244.0, 152227.0, 158599.0, 159814.99999999884, 15243.542693719206, 16018.359265629244, 16226.594335141715, 16423.753643695352, 16558.751618725728, 25600.48799024009, 25616.359591010372, 25639.48721025569, 25754.613680794802, 25774.355641109123, 10006.249531285037, 10263.538140783534, 10334.896651033543, 10434.895651043544, 10466.63366782159, 9179.908200917906, 9181.081891810765, 9196.816063678689, 9293.117153870371, 9305.767355816159, 9932.453715045742, 10118.089371956412, 10140.391576505433, 10162.644307449204, 10214.795704085876, 2923.853807309626, 2942.396808654221, 2945.926351841178, 2973.8810447581855, 3056.679048699899, 1026.38416949831, 1037.8391349340864, 1050.0497050169608, 1059.8781140168978, 1063.1069901282806, 20816.06327715226, 21138.15447382118, 21208.15167393318, 21257.89371053135, 21282.255121070688, 1082.2640604388935, 1089.7711480589007, 1092.071739021841, 1102.614085070219, 1115.341948250536, 11710.590129345432, 11713.941430292964, 11756.823647645293, 11766.352850593299, 11860.584879529348, 582064.0, 587291.0, 597612.0, 598915.0, 607061.0, 123423.0, 124038.0, 126931.0, 127334.0, 128398.0, 1179.8702142764462, 1182.7161481244439, 1219.2562536852513, 1223.0582451512464, 1233.9506419743288, 18165.54586135357, 18233.817661823214, 18330.358437454626, 18472.353467628567, 18677.0, 58042.4195758037, 59116.40883591109, 59512.70243648754, 61117.38882611117, 61351.0, 75802.62098689692, 76922.61538692271, 77290.2270977283, 77549.0, 77666.2233377659, 15614.45349412765, 15644.296006679955, 15710.685786284439, 15745.291461884472, 15821.0, 23818.285451436484, 24034.39914002164, 24061.0, 24142.155024574055, 24334.26997190087, 18907.0, 19716.605667886273, 19913.10391032378, 20015.399538013884, 20066.799332006492, 17042.573935651708, 17071.40250091241, 17248.137593120544, 17868.821311786716, 17904.462866114038, 19427.028648567797, 19623.901880490506, 19817.405477835688, 19901.203951841766, 20163.495912602302, 15382.538523844303, 15413.0, 15561.610959726097, 15574.065556066673, 15578.9221053894, 19550.31573894907, 19594.02029898471, 19632.214711411954, 19679.114439850528, 19703.211871524978], "value": 12669.929442415623, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.5556621880996, 1432.455666846599, 1468.3319089814136, 1477.2982833154247, 1477.9113253204805, 14019.719605607881, 14633.195174265411, 14647.121172729643, 16881.91559042206, 17345.7398139028, 16978.40575579855, 17239.82760172398, 17253.654926901487, 17272.740908886375, 17278.0, 2801.80387372884, 2812.5078111330536, 2820.4641118187583, 2831.221414111126, 2831.8017738758294, 2804.3970546332534, 2908.2874695699584, 2909.636295463067, 2910.1706013786074, 2912.170031541011, 2802.383475635367, 2821.097248880359, 2832.9291767705868, 2834.716528347159, 2835.9716402835916, 2745.094118940755, 2771.459565384751, 2791.8883244670187, 2792.8882844686186, 2801.089645865102, 2640.3003204150914, 2663.706992230853, 2677.4645070985684, 2679.477501887133, 2681.5173268811604, 16261.430849920314, 16636.33454661812, 16666.33334666624, 16667.166641667867, 16667.91666041674, 8024.277814996678, 8254.752357429286, 8306.584670766499, 8312.501249925024, 8315.293200078, 5117.6161787865685, 5230.895382092375, 5336.17289320156, 5373.570114390839, 5399.83800485986, 2042.7855075217185, 2054.589082183554, 2063.700763389315, 2119.279444988711, 2157.946051348729, 29814.70185298141, 30201.09396718102, 30359.24101897448, 30513.847430762926, 30547.389052219052, 7110.862262038049, 7201.207867134611, 7213.747518836815, 7299.963500182465, 7414.777556673308, 19873.205071796965, 19987.200511979358, 19994.400167994983, 19997.100130494164, 20004.89997550003, 8237.958810205912, 8421.24208821209, 8437.57812109392, 8444.957775211085, 8446.366522510836, 7441.479096463196, 7587.734429294948, 7684.154742978268, 7706.5761383123345, 7720.884186737204, 5549.528290095387, 5711.286089238845, 5738.913916291259, 5781.335146458211, 5797.884042319214, 1581.2568092996273, 1608.340580362046, 1636.4272504623286, 1638.721417359028, 1639.7048531264486, 901.6663834381321, 913.3834661603391, 920.2637889688223, 929.702495201529, 932.654917680449, 7901.367890568741, 7908.169642187488, 7953.403494737918, 7958.960205199052, 8003.119656837744, 785.7548325415995, 794.7258195922398, 799.7760627024443, 802.835418739157, 816.318374157585, 4442.178197033559, 4445.222086134913, 4664.580187783048, 5739.311282646109, 5865.648061116347, 24997.12510062139, 25360.365990850376, 25803.096891608704, 25824.22527324183, 25904.481910361686, 24042.87978560131, 25013.499730005296, 25082.372940676265, 25808.870955645478, 25836.224913252634, 11176.0, 11497.59758408435, 12646.620601381974, 13011.479540818262, 13086.934565327303, 7930.563818990011, 9265.629374824932, 9282.443053416817, 9344.439333640003, 9442.622295108118, 19936.90031549833, 20299.0, 20534.07596658124, 20579.4855128623, 20786.58426831485, 20650.07074681673, 20951.0, 20989.0, 21033.57932841304, 21051.0, 13679.931600341935, 13702.766750992458, 13852.72294554083, 14007.859921400655, 14009.369578368794, 15717.056976581442, 15773.842261577238, 15902.443414480438, 15913.761293580374, 15940.123293218985, 12308.138430309793, 12591.307478088427, 12669.113162078565, 12745.235285882876, 12807.80788288195, 12403.937980310402, 12512.124151309321, 12676.492940282285, 12922.095453318178, 12948.15836970594, 9763.658271960447, 9809.803803923738, 9819.754506137404, 9858.063483969012, 9890.604375825174, 7321.890171647323, 7347.88514451465, 7356.0, 7386.633472807548, 7433.331000209791, 7499.850003000019, 7503.962480187564, 7589.203133671106, 7630.084389873251, 7637.2362763725405], "value": 7104.251915790225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.3419508516813, 544.6187668631958, 561.9325680918289, 566.3402136510965, 573.1574585359521, 6194.411530904563, 6337.968310158449, 6350.206224221973, 6368.235811702591, 6398.968005159979, 6201.720922558485, 6221.968890155543, 6226.9377306226925, 6271.0, 6279.529035322346, 4919.60643148549, 4956.975215123928, 4962.379702537183, 4981.9252711209365, 4988.152014157584, 4990.775415106311, 5017.774200160983, 5039.09296326661, 5067.315912351823, 5076.543111119999, 4955.182394904837, 5033.370828646419, 5038.622103342264, 5062.493750624945, 5062.721550314731, 4954.975225123887, 4979.352684151074, 5008.849734507952, 5030.465707959071, 5069.44236134025, 4597.287420449836, 4598.425196850394, 4604.5165257647795, 4608.0, 4609.976950115261, 6156.984097623887, 6220.502359811249, 6223.0, 6236.6258024518675, 6280.057991301295, 5849.707514624251, 5880.382559831199, 5887.967696636236, 5903.291605007384, 5922.4077592240865, 6672.2994085621285, 6692.196936367618, 6704.094947182166, 6716.798496045078, 6766.56017358875, 5113.2330150477355, 5120.590352771769, 5121.564667003309, 5126.820561280338, 5147.2279158126585, 6879.89680154793, 6924.272951340137, 6967.268436814163, 7022.101434794746, 7039.683214255371, 5224.764885580158, 5236.450172731885, 5254.369475662868, 5259.316288882421, 5276.92084618731, 5293.947060529423, 5324.5740340772645, 5335.119705248668, 5360.624756267024, 5367.4364191759305, 5841.41585841421, 5874.177615133799, 5875.764969401176, 5889.23439952812, 5906.586538942232, 6411.551191416649, 6467.741290348427, 6604.174478190226, 6636.0, 6767.661616919135, 1816.6729988602178, 1825.972610410845, 1827.2782251010776, 1836.9724454132931, 1842.8986405747544, 1297.3253907967803, 1297.6172029251393, 1303.1138825598493, 1306.8954483641287, 1317.4993502469192, 6034.0, 6136.509079273647, 6187.721552530147, 6237.875242495124, 6261.342559031327, 6711.832204194837, 6758.526903116833, 6765.255821859591, 6781.897611740376, 6840.879327408519, 6127.571070025145, 6192.195014648157, 6212.1303017577575, 6286.717097730613, 6353.4599559038, 3574.8391322390553, 3588.2823435313044, 3601.1897323102617, 3615.493830863681, 3639.7998110103667, 6999.580025198505, 7004.159500859828, 7072.823179420556, 7078.893816592756, 7096.680649370791, 6972.721091156297, 7038.331358520933, 7039.718411263594, 7046.0054476847135, 7066.0, 6989.720411183495, 7065.788026359115, 7079.36285734276, 7083.5041547091205, 7093.467989900675, 6736.427403670743, 6756.69594868242, 6852.897206542006, 6871.828204294733, 6880.415164711056, 6593.703283352164, 6619.536632435684, 6703.229128650268, 6774.627395493295, 6790.966045169743, 6904.516683832084, 7034.261402552658, 7048.189458212371, 7056.54132481387, 7063.82340441493, 5122.615803814803, 5156.303898973591, 5173.793048278178, 5248.317718696545, 5260.368755749181, 6683.68646925705, 6764.188297404343, 6777.593344399352, 6844.555103918229, 6868.278830722702, 6271.3728627136925, 6537.378948999837, 6542.607443553402, 6566.277709451861, 6651.634160121046, 6518.608883467007, 6577.934220657924, 6586.670666466754, 6594.856671581851, 6595.307492713196, 6214.25428948529, 6329.367063293634, 6413.422791948747, 6497.62123695685, 6509.967450162719, 6551.50863685216, 6627.4698024158915, 6648.368405001517, 6684.197896252286, 6700.731970721312, 6428.55000149985, 6449.193850768654, 6516.348365163446, 6549.672516374258, 6575.079488871657], "value": 5208.748214848863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.4187091197088, 967.148908960115, 989.2045936625025, 996.4917891875142, 1007.1741172238765, 19457.0, 19575.119119639614, 19579.412617621478, 19809.50476238093, 19937.800621993774, 19304.613907721836, 19478.513037174078, 19668.508287292825, 19728.802711972876, 19753.802461975374, 1027.7584767579613, 1031.448175226254, 1037.6264544763878, 1038.6260946059413, 1039.6153423233413, 1051.984220236697, 1054.2936232724055, 1060.1306928318782, 1061.060961049473, 1062.654637242899, 1116.6929094498996, 1149.0290704354848, 1153.5847095045776, 1154.4631746237997, 1154.7632735289287, 1131.2081542919907, 1135.5911871726173, 1137.709883979584, 1139.5612689114669, 1140.1790710688292, 792.4056957282038, 809.0897740042452, 813.1096449387911, 814.311906439058, 815.8776183572512, 21651.133954641795, 21778.34664960054, 21791.128354865785, 21835.454113647287, 21866.781332186634, 22782.886085569633, 23000.309990700305, 23408.414789630224, 23609.0, 23798.0, 18591.0, 18778.154983025797, 18829.623407531773, 19106.33127840519, 19110.80889191104, 3963.8810835674685, 3974.960250397517, 3991.7405368651234, 3993.560708322082, 4000.0399904023116, 130230.0, 147947.0, 150492.0, 151060.0, 154005.2299738494, 18526.536836579195, 18766.53083672919, 18844.717329240073, 19070.809291907182, 19128.23487060502, 33879.49180762291, 34512.82743586266, 34772.30455390878, 34778.478322825176, 35226.47160292598, 9983.900160998297, 10106.545205465773, 10107.797844043078, 10131.08820206185, 10146.137578305927, 4799.736014519235, 4877.829275975324, 4880.097182021337, 4892.559669629751, 4901.436334821541, 5918.822435326947, 6006.609570377911, 6050.183225264621, 6077.848053798691, 6088.6042407243385, 1195.1753290229888, 1228.3489750432286, 1229.2071613809044, 1233.1984210263222, 1241.944112514939, 744.4267913706416, 751.8496300739874, 757.9696812127563, 770.8342706318168, 774.2025713514976, 12321.753564928651, 13236.338183090807, 13404.731905361838, 13622.0, 13846.376913038937, 721.3183541553286, 721.6499997501313, 728.402709777977, 732.9890051649229, 747.2975403121048, 6093.96953015241, 6210.223722034746, 6270.749170033238, 6315.747370105236, 6329.335419780857, 148280.0, 149409.0, 151002.0, 156883.0, 159048.0, 103499.0, 105808.47095764472, 127153.0, 130632.3468382652, 136530.0, 104679.47660261803, 106810.0, 115498.42250788692, 117789.4110529459, 118270.40864795621, 13132.212067275612, 13410.39653215588, 13635.795463067863, 14049.859501404855, 14307.0, 53654.0, 55100.448995511135, 55973.44026559845, 56560.0, 56931.43068569427, 71543.28456715366, 73978.15054623462, 74057.0, 75075.24924750901, 75405.0, 20775.168993240102, 20942.267020654202, 21409.250676226256, 21699.34901952944, 22048.779512205314, 23213.651795223424, 24061.759382406653, 24311.51376972486, 24327.878360608083, 24380.146694865594, 21196.68204976896, 21207.57584848325, 21219.257325993516, 21412.143514259256, 21810.0, 17090.57273568121, 17211.0, 17342.393016244372, 17403.129843508028, 17431.128443577516, 18358.541036474195, 18482.0, 18515.259389624265, 18542.629147417247, 18618.44144675662, 15563.221838907783, 15680.686386272439, 15752.133632649857, 15814.446494372642, 15895.0, 14190.266304863668, 14427.855721443071, 14563.199024053778, 14732.337044832793, 14736.48422305214], "value": 10260.96945732196, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 104.0, 105.0, 106.0, 105.0, 107.0, 107.0, 104.0, 105.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 113.0, 113.0, 116.0, 112.0, 112.0, 114.0, 113.0, 125.0], "value": 114.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 162.0, 162.0, 162.0, 161.0, 167.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 76.0, 75.0, 74.0, 73.0, 79.0, 74.0, 76.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 82.0, 78.0, 78.0, 78.0, 82.0, 79.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 149.0, 149.0, 148.0, 149.0, 150.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 46.0, 45.0, 45.0, 46.0, 53.0, 45.0, 56.0, 46.0, 48.0], "value": 47.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 39.0, 39.0, 40.0, 39.0, 39.0, 41.0, 39.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 71.0, 70.0, 72.0, 71.0, 79.0, 83.0, 69.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 106.0, 107.0, 111.0, 105.0, 112.0, 110.0, 112.0, 104.0, 110.0], "value": 108.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 154.0, 154.0, 150.0, 152.0, 157.0, 150.0, 154.0, 147.0, 159.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 64.0, 61.0, 63.0, 63.0, 63.0, 63.0], "value": 61.9, "unit": "score"}]}]} 18:26:51 INFO - Return code: 0 18:26:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:26:51 INFO - # TBPL SUCCESS # 18:26:51 INFO - Running post-action listener: _package_coverage_data 18:26:51 INFO - Running post-action listener: _resource_record_post_action 18:26:51 INFO - [mozharness: 2017-09-26 01:26:51.342587Z] Finished run-tests step (success) 18:26:51 INFO - Running post-run listener: _resource_record_post_run 18:26:51 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 311148544; Read time: 32; Write time: 160440 18:26:51 INFO - TinderboxPrint: CPU usage
13.1% 18:26:51 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 32 18:26:51 INFO - TinderboxPrint: I/O write bytes / time
311,148,544 / 160,440 18:26:51 INFO - TinderboxPrint: CPU idle
8,205.8 (86.9%) 18:26:51 INFO - TinderboxPrint: CPU user
1,187.5 (12.6%) 18:26:51 INFO - TinderboxPrint: Swap in / out
0 / 0 18:26:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 2183168; Read time: 0; Write time: 116 18:26:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:26:51 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 308965376; Read time: 32; Write time: 160324 18:26:51 INFO - Running post-run listener: _upload_blobber_files 18:26:51 INFO - Blob upload gear active. 18:26:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:26:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:26:52 INFO - (blobuploader) - INFO - Open directory for files ... 18:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:26:53 INFO - (blobuploader) - INFO - Done attempting. 18:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:00 INFO - (blobuploader) - INFO - Done attempting. 18:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:01 INFO - (blobuploader) - INFO - Done attempting. 18:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:02 INFO - (blobuploader) - INFO - Done attempting. 18:27:02 INFO - (blobuploader) - INFO - Iteration through files over. 18:27:02 INFO - Return code: 0 18:27:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:27:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:27:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/009d57ce4d960ad4f41eeb82e3620b0b41391f1559f07e8572263b7ad04065eb39cbcd2b73c721a40c24dea23e5309f3411208f203c94428ee056985ede54aa2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e0c18b48e5f9a0f819efdc9cf89cf14b9645d55f335c39f91615642ab6dd2ab70c0b0557806a618b6bbc2004f688a8168958087ddaf880981ffdc2a569ca0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99d9c206931b943ff12aba6976fc3099d4e1d879a43dbee97ea5436fad46a86ade99c5dee2e6cc062bd7ca0295e40483a453d20a942f54fbcbd65c9fe29d7e3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddc572ffac4d8de9c8d4b8573b1d4305bc2ac08fcf7433e1171a37206667fc7d51287d11c8bbbdc6b1c6cc80f4f08c99acfb55364a0ef4a34943f1406da7e85"} 18:27:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:27:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:27:02 INFO - Contents: 18:27:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/009d57ce4d960ad4f41eeb82e3620b0b41391f1559f07e8572263b7ad04065eb39cbcd2b73c721a40c24dea23e5309f3411208f203c94428ee056985ede54aa2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e0c18b48e5f9a0f819efdc9cf89cf14b9645d55f335c39f91615642ab6dd2ab70c0b0557806a618b6bbc2004f688a8168958087ddaf880981ffdc2a569ca0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99d9c206931b943ff12aba6976fc3099d4e1d879a43dbee97ea5436fad46a86ade99c5dee2e6cc062bd7ca0295e40483a453d20a942f54fbcbd65c9fe29d7e3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddc572ffac4d8de9c8d4b8573b1d4305bc2ac08fcf7433e1171a37206667fc7d51287d11c8bbbdc6b1c6cc80f4f08c99acfb55364a0ef4a34943f1406da7e85"} 18:27:02 INFO - Running post-run listener: copy_logs_to_upload_dir 18:27:02 INFO - Copying logs to upload dir... 18:27:02 INFO - mkdir: /builds/slave/test/build/upload/logs 18:27:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.005244 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-25 18:27:02.367896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:27:02.375277) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/009d57ce4d960ad4f41eeb82e3620b0b41391f1559f07e8572263b7ad04065eb39cbcd2b73c721a40c24dea23e5309f3411208f203c94428ee056985ede54aa2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e0c18b48e5f9a0f819efdc9cf89cf14b9645d55f335c39f91615642ab6dd2ab70c0b0557806a618b6bbc2004f688a8168958087ddaf880981ffdc2a569ca0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99d9c206931b943ff12aba6976fc3099d4e1d879a43dbee97ea5436fad46a86ade99c5dee2e6cc062bd7ca0295e40483a453d20a942f54fbcbd65c9fe29d7e3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddc572ffac4d8de9c8d4b8573b1d4305bc2ac08fcf7433e1171a37206667fc7d51287d11c8bbbdc6b1c6cc80f4f08c99acfb55364a0ef4a34943f1406da7e85"} build_url:https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/bcexkDXfTRu9BIWJfptH-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/009d57ce4d960ad4f41eeb82e3620b0b41391f1559f07e8572263b7ad04065eb39cbcd2b73c721a40c24dea23e5309f3411208f203c94428ee056985ede54aa2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64e0c18b48e5f9a0f819efdc9cf89cf14b9645d55f335c39f91615642ab6dd2ab70c0b0557806a618b6bbc2004f688a8168958087ddaf880981ffdc2a569ca0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99d9c206931b943ff12aba6976fc3099d4e1d879a43dbee97ea5436fad46a86ade99c5dee2e6cc062bd7ca0295e40483a453d20a942f54fbcbd65c9fe29d7e3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ddc572ffac4d8de9c8d4b8573b1d4305bc2ac08fcf7433e1171a37206667fc7d51287d11c8bbbdc6b1c6cc80f4f08c99acfb55364a0ef4a34943f1406da7e85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:27:02.402844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:27:02.406172) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1506387980.991639-814378708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:27:02.455717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:27:02.459037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:27:02.459354) ========= ========= Total master_lag: 0.23 =========