builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1464902557.43 results: success (0) buildid: 20160602113028 builduid: afa9f52536ef44fe991ffd37bd8e46a8 revision: 91879ebba4d61fde72af13223708faa01109a4d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.433002) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.433482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.433828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.448751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.449069) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 14:22:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-06-02 14:22:38 (101 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154332 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.618409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.618942) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018242 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:37.670233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 14:22:37.670830) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 91879ebba4d61fde72af13223708faa01109a4d9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 91879ebba4d61fde72af13223708faa01109a4d9 --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=934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 14:22:38,170 truncating revision to first 12 chars 2016-06-02 14:22:38,171 Setting DEBUG logging. 2016-06-02 14:22:38,171 attempt 1/10 2016-06-02 14:22:38,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/91879ebba4d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 14:22:38,952 unpacking tar archive at: fx-team-91879ebba4d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.124552 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 14:22:38.809855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:38.810202) ========= script_repo_revision: 91879ebba4d61fde72af13223708faa01109a4d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:38.810631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:38.810915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 14:22:38.821205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-02 14:22:38.821524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:22:39 INFO - MultiFileLogger online at 20160602 14:22:39 in /builds/slave/test 14:22:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:22:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:22:39 INFO - {'append_to_log': False, 14:22:39 INFO - 'base_work_dir': '/builds/slave/test', 14:22:39 INFO - 'blob_upload_branch': 'Fx-Team', 14:22:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:22:39 INFO - 'branch': 'Fx-Team', 14:22:39 INFO - 'buildbot_json_path': 'buildprops.json', 14:22:39 INFO - 'config_files': ('talos/linux_config.py',), 14:22:39 INFO - 'default_actions': ('clobber', 14:22:39 INFO - 'read-buildbot-config', 14:22:39 INFO - 'download-and-extract', 14:22:39 INFO - 'populate-webroot', 14:22:39 INFO - 'create-virtualenv', 14:22:39 INFO - 'install', 14:22:39 INFO - 'run-tests'), 14:22:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:22:39 INFO - 'download_minidump_stackwalk': True, 14:22:39 INFO - 'download_symbols': 'ondemand', 14:22:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:22:39 INFO - 'tooltool.py': '/tools/tooltool.py', 14:22:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:22:39 INFO - '/tools/misc-python/virtualenv.py')}, 14:22:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:22:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:22:39 INFO - 'installer_path': 'installer.exe', 14:22:39 INFO - 'log_level': 'info', 14:22:39 INFO - 'log_name': 'talos', 14:22:39 INFO - 'log_to_console': True, 14:22:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:22:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:22:39 INFO - 'opt_config_files': (), 14:22:39 INFO - 'pip_index': False, 14:22:39 INFO - 'sps_profile': False, 14:22:39 INFO - 'sps_profile_interval': 0, 14:22:39 INFO - 'suite': 'dromaeojs', 14:22:39 INFO - 'system_bits': '32', 14:22:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:22:39 INFO - 'title': 'talos-linux64-ix-057', 14:22:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:22:39 INFO - 'use_talos_json': True, 14:22:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:22:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:22:39 INFO - 'work_dir': 'build'} 14:22:39 INFO - ##### 14:22:39 INFO - ##### Running clobber step. 14:22:39 INFO - ##### 14:22:39 INFO - Running pre-action listener: _resource_record_pre_action 14:22:39 INFO - Running main action method: clobber 14:22:39 INFO - rmtree: /builds/slave/test/build 14:22:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:22:39 INFO - Running post-action listener: _resource_record_post_action 14:22:39 INFO - ##### 14:22:39 INFO - ##### Finished clobber step (success) 14:22:39 INFO - ##### 14:22:39 INFO - ##### 14:22:39 INFO - ##### Running read-buildbot-config step. 14:22:39 INFO - ##### 14:22:39 INFO - Running pre-action listener: _resource_record_pre_action 14:22:39 INFO - Running main action method: read_buildbot_config 14:22:39 INFO - Using buildbot properties: 14:22:39 INFO - { 14:22:39 INFO - "project": "", 14:22:39 INFO - "product": "firefox", 14:22:39 INFO - "script_repo_revision": "production", 14:22:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:22:39 INFO - "repository": "", 14:22:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:22:39 INFO - "buildid": "20160602113028", 14:22:39 INFO - "pgo_build": "True", 14:22:39 INFO - "basedir": "/builds/slave/test", 14:22:39 INFO - "buildnumber": 759, 14:22:39 INFO - "slavename": "talos-linux64-ix-057", 14:22:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:22:39 INFO - "platform": "ubuntu64_hw", 14:22:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:22:39 INFO - "branch": "fx-team", 14:22:39 INFO - "repo_path": "integration/fx-team", 14:22:39 INFO - "revision": "91879ebba4d61fde72af13223708faa01109a4d9", 14:22:39 INFO - "stage_platform": "linux64-pgo", 14:22:39 INFO - "builduid": "afa9f52536ef44fe991ffd37bd8e46a8", 14:22:39 INFO - "slavebuilddir": "test" 14:22:39 INFO - } 14:22:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:22:39 INFO - Running post-action listener: _resource_record_post_action 14:22:39 INFO - ##### 14:22:39 INFO - ##### Finished read-buildbot-config step (success) 14:22:39 INFO - ##### 14:22:39 INFO - ##### 14:22:39 INFO - ##### Running download-and-extract step. 14:22:39 INFO - ##### 14:22:39 INFO - Running pre-action listener: _resource_record_pre_action 14:22:39 INFO - Running main action method: download_and_extract 14:22:39 INFO - mkdir: /builds/slave/test/build/tests 14:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:39 INFO - https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:22:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:22:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:22:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:22:40 INFO - Downloaded 1361 bytes. 14:22:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:22:40 INFO - Using the following test package requirements: 14:22:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:22:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:22:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:22:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'jsshell-linux-x86_64.zip'], 14:22:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:22:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:22:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:22:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:22:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:22:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:22:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:22:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:40 INFO - https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:22:41 INFO - Downloaded 24439699 bytes. 14:22:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:22:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:22:43 INFO - Return code: 0 14:22:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:43 INFO - https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:22:44 INFO - Downloaded 24439699 bytes. 14:22:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:22:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:22:45 INFO - Return code: 0 14:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:45 INFO - https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:22:46 INFO - Downloaded 10834055 bytes. 14:22:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:22:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:22:46 INFO - Return code: 0 14:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:46 INFO - https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:22:48 INFO - Downloaded 59072825 bytes. 14:22:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:22:48 INFO - mkdir: /builds/slave/test/properties 14:22:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:22:48 INFO - Writing to file /builds/slave/test/properties/build_url 14:22:48 INFO - Contents: 14:22:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:22:48 INFO - Running post-action listener: _resource_record_post_action 14:22:48 INFO - Running post-action listener: set_extra_try_arguments 14:22:48 INFO - ##### 14:22:48 INFO - ##### Finished download-and-extract step (success) 14:22:48 INFO - ##### 14:22:48 INFO - ##### 14:22:48 INFO - ##### Running populate-webroot step. 14:22:48 INFO - ##### 14:22:48 INFO - Running pre-action listener: _resource_record_pre_action 14:22:48 INFO - Running main action method: populate_webroot 14:22:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:22:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:22:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:22:48 INFO - '--tppagecycles', 14:22:48 INFO - '7'], 14:22:48 INFO - 'tests': ['tsvgm']}}, 14:22:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:22:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:22:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:22:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:22:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['damp', 'tps']}, 14:22:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'tests': ['damp', 'tps']}, 14:22:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['dromaeo_dom']}, 14:22:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:22:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['a11yr', 14:22:48 INFO - 'ts_paint', 14:22:48 INFO - 'tpaint', 14:22:48 INFO - 'sessionrestore', 14:22:48 INFO - 'sessionrestore_no_auto_restore', 14:22:48 INFO - 'tabpaint']}, 14:22:48 INFO - 'other-e10s': {'tests': ['a11yr', 14:22:48 INFO - 'ts_paint', 14:22:48 INFO - 'tpaint', 14:22:48 INFO - 'sessionrestore', 14:22:48 INFO - 'sessionrestore_no_auto_restore', 14:22:48 INFO - 'tabpaint']}, 14:22:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:22:48 INFO - 'ts_paint', 14:22:48 INFO - 'tpaint', 14:22:48 INFO - 'sessionrestore', 14:22:48 INFO - 'sessionrestore_no_auto_restore', 14:22:48 INFO - 'tabpaint']}, 14:22:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:22:48 INFO - 'ts_paint', 14:22:48 INFO - 'tpaint', 14:22:48 INFO - 'sessionrestore', 14:22:48 INFO - 'sessionrestore_no_auto_restore', 14:22:48 INFO - 'tabpaint']}, 14:22:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['a11yr', 14:22:48 INFO - 'ts_paint', 14:22:48 INFO - 'tpaint', 14:22:48 INFO - 'sessionrestore', 14:22:48 INFO - 'sessionrestore_no_auto_restore', 14:22:48 INFO - 'tabpaint']}, 14:22:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['a11yr', 14:22:48 INFO - 'ts_paint', 14:22:48 INFO - 'tpaint', 14:22:48 INFO - 'sessionrestore', 14:22:48 INFO - 'sessionrestore_no_auto_restore', 14:22:48 INFO - 'tabpaint']}, 14:22:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['tsvgx', 14:22:48 INFO - 'tsvgr_opacity', 14:22:48 INFO - 'tart', 14:22:48 INFO - 'tscrollx', 14:22:48 INFO - 'cart']}, 14:22:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:22:48 INFO - 'tsvgr_opacity', 14:22:48 INFO - 'tart', 14:22:48 INFO - 'tscrollx', 14:22:48 INFO - 'cart']}, 14:22:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'talos_options': ['--disable-e10s'], 14:22:48 INFO - 'tests': ['tp5o']}, 14:22:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'tests': ['tp5o']}, 14:22:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'talos_options': ['--disable-e10s', 14:22:48 INFO - '--xperf_path', 14:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:48 INFO - 'tests': ['tp5n']}, 14:22:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:48 INFO - 'talos_options': ['--xperf_path', 14:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:48 INFO - 'tests': ['tp5n']}}, 14:22:48 INFO - 'talos.zip': {'path': '', 14:22:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:22:48 INFO - Running post-action listener: _resource_record_post_action 14:22:48 INFO - ##### 14:22:48 INFO - ##### Finished populate-webroot step (success) 14:22:48 INFO - ##### 14:22:48 INFO - ##### 14:22:48 INFO - ##### Running create-virtualenv step. 14:22:48 INFO - ##### 14:22:48 INFO - Running pre-action listener: _resource_record_pre_action 14:22:48 INFO - Running main action method: create_virtualenv 14:22:48 INFO - Creating virtualenv /builds/slave/test/build/venv 14:22:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:22:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:22:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:22:49 INFO - Using real prefix '/usr' 14:22:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:22:51 INFO - Installing pip.................done. 14:22:51 INFO - Return code: 0 14:22:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:22:51 INFO - Using env: {'DISPLAY': ':0', 14:22:51 INFO - 'HOME': '/home/cltbld', 14:22:51 INFO - 'LANG': 'en_US.UTF-8', 14:22:51 INFO - 'LANGUAGE': 'en_US:en', 14:22:51 INFO - 'LOGNAME': 'cltbld', 14:22:51 INFO - 'MAIL': '/var/mail/cltbld', 14:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:51 INFO - 'MOZ_NO_REMOTE': '1', 14:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:51 INFO - 'NO_EM_RESTART': '1', 14:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:51 INFO - 'PWD': '/builds/slave/test', 14:22:51 INFO - 'SHELL': '/bin/bash', 14:22:51 INFO - 'SHLVL': '1', 14:22:51 INFO - 'TERM': 'linux', 14:22:51 INFO - 'TMOUT': '86400', 14:22:51 INFO - 'USER': 'cltbld', 14:22:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:51 INFO - '_': '/tools/buildbot/bin/python'} 14:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:22:51 INFO - Cleaning up... 14:22:51 INFO - Return code: 0 14:22:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:22:51 INFO - Using env: {'DISPLAY': ':0', 14:22:51 INFO - 'HOME': '/home/cltbld', 14:22:51 INFO - 'LANG': 'en_US.UTF-8', 14:22:51 INFO - 'LANGUAGE': 'en_US:en', 14:22:51 INFO - 'LOGNAME': 'cltbld', 14:22:51 INFO - 'MAIL': '/var/mail/cltbld', 14:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:51 INFO - 'MOZ_NO_REMOTE': '1', 14:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:51 INFO - 'NO_EM_RESTART': '1', 14:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:51 INFO - 'PWD': '/builds/slave/test', 14:22:51 INFO - 'SHELL': '/bin/bash', 14:22:51 INFO - 'SHLVL': '1', 14:22:51 INFO - 'TERM': 'linux', 14:22:51 INFO - 'TMOUT': '86400', 14:22:51 INFO - 'USER': 'cltbld', 14:22:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:51 INFO - '_': '/tools/buildbot/bin/python'} 14:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:52 INFO - Downloading/unpacking psutil>=3.1.1 14:22:52 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 14:22:52 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 14:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:52 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 14:22:52 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 14:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:54 INFO - Installing collected packages: psutil 14:22:54 INFO - Running setup.py install for psutil 14:22:54 INFO - building 'psutil._psutil_linux' extension 14:22:54 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 14:22:54 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 14:22:54 INFO - building 'psutil._psutil_posix' extension 14:22:54 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 14:22:54 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 14:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:54 INFO - Successfully installed psutil 14:22:54 INFO - Cleaning up... 14:22:54 INFO - Return code: 0 14:22:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:22:54 INFO - Using env: {'DISPLAY': ':0', 14:22:54 INFO - 'HOME': '/home/cltbld', 14:22:54 INFO - 'LANG': 'en_US.UTF-8', 14:22:54 INFO - 'LANGUAGE': 'en_US:en', 14:22:54 INFO - 'LOGNAME': 'cltbld', 14:22:54 INFO - 'MAIL': '/var/mail/cltbld', 14:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:54 INFO - 'MOZ_NO_REMOTE': '1', 14:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:54 INFO - 'NO_EM_RESTART': '1', 14:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:54 INFO - 'PWD': '/builds/slave/test', 14:22:54 INFO - 'SHELL': '/bin/bash', 14:22:54 INFO - 'SHLVL': '1', 14:22:54 INFO - 'TERM': 'linux', 14:22:54 INFO - 'TMOUT': '86400', 14:22:54 INFO - 'USER': 'cltbld', 14:22:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:54 INFO - '_': '/tools/buildbot/bin/python'} 14:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:22: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 14:22: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 14:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22: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 14:22: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 14:22:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:22:56 INFO - Installing collected packages: mozsystemmonitor 14:22:56 INFO - Running setup.py install for mozsystemmonitor 14:22:56 INFO - Successfully installed mozsystemmonitor 14:22:56 INFO - Cleaning up... 14:22:56 INFO - Return code: 0 14:22:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:22:56 INFO - Using env: {'DISPLAY': ':0', 14:22:56 INFO - 'HOME': '/home/cltbld', 14:22:56 INFO - 'LANG': 'en_US.UTF-8', 14:22:56 INFO - 'LANGUAGE': 'en_US:en', 14:22:56 INFO - 'LOGNAME': 'cltbld', 14:22:56 INFO - 'MAIL': '/var/mail/cltbld', 14:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:56 INFO - 'MOZ_NO_REMOTE': '1', 14:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:56 INFO - 'NO_EM_RESTART': '1', 14:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:56 INFO - 'PWD': '/builds/slave/test', 14:22:56 INFO - 'SHELL': '/bin/bash', 14:22:56 INFO - 'SHLVL': '1', 14:22:56 INFO - 'TERM': 'linux', 14:22:56 INFO - 'TMOUT': '86400', 14:22:56 INFO - 'USER': 'cltbld', 14:22:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:56 INFO - '_': '/tools/buildbot/bin/python'} 14:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:57 INFO - Downloading/unpacking blobuploader==1.2.4 14:22: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 14:22: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 14:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22: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 14:22: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 14:22:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22:59 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 14:22:59 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 14:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:59 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 14:22:59 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 14:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22:59 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 14:22:59 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 14:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:59 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 14:22:59 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 14:22:59 INFO - Downloading docopt-0.6.1.tar.gz 14:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:59 INFO - Running setup.py install for blobuploader 14:22:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:59 INFO - Running setup.py install for requests 14:23:00 INFO - Running setup.py install for docopt 14:23:00 INFO - Successfully installed blobuploader requests docopt 14:23:00 INFO - Cleaning up... 14:23:00 INFO - Return code: 0 14:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:00 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:23:00 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:23:00 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:00 INFO - Using env: {'DISPLAY': ':0', 14:23:00 INFO - 'HOME': '/home/cltbld', 14:23:00 INFO - 'LANG': 'en_US.UTF-8', 14:23:00 INFO - 'LANGUAGE': 'en_US:en', 14:23:00 INFO - 'LOGNAME': 'cltbld', 14:23:00 INFO - 'MAIL': '/var/mail/cltbld', 14:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:00 INFO - 'MOZ_NO_REMOTE': '1', 14:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:00 INFO - 'NO_EM_RESTART': '1', 14:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:00 INFO - 'PWD': '/builds/slave/test', 14:23:00 INFO - 'SHELL': '/bin/bash', 14:23:00 INFO - 'SHLVL': '1', 14:23:00 INFO - 'TERM': 'linux', 14:23:00 INFO - 'TMOUT': '86400', 14:23:00 INFO - 'USER': 'cltbld', 14:23:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:00 INFO - '_': '/tools/buildbot/bin/python'} 14:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:00 INFO - Running setup.py (path:/tmp/pip-9lQkm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:00 INFO - Running setup.py (path:/tmp/pip-9fDJqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:00 INFO - Running setup.py (path:/tmp/pip-tjJC1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:00 INFO - Running setup.py (path:/tmp/pip-nxxFQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:00 INFO - Running setup.py (path:/tmp/pip-VBnY6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:00 INFO - Running setup.py (path:/tmp/pip-KA_dZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:00 INFO - Running setup.py (path:/tmp/pip-gAEdC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:01 INFO - Running setup.py (path:/tmp/pip-_tMIre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:01 INFO - Running setup.py (path:/tmp/pip-UXyLOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:01 INFO - Running setup.py (path:/tmp/pip-NXIvXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:01 INFO - Running setup.py (path:/tmp/pip-hZk5DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:01 INFO - Running setup.py (path:/tmp/pip-UOhJ5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:01 INFO - Running setup.py (path:/tmp/pip-C9MgBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:01 INFO - Running setup.py (path:/tmp/pip-UdtL2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:01 INFO - Running setup.py (path:/tmp/pip-o3jStN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:01 INFO - Running setup.py (path:/tmp/pip-cIRD05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:01 INFO - Running setup.py (path:/tmp/pip-iLjRJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:01 INFO - Running setup.py install for manifestparser 14:23:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:01 INFO - Running setup.py install for mozcrash 14:23:01 INFO - Running setup.py install for mozdebug 14:23:02 INFO - Running setup.py install for mozdevice 14:23:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Running setup.py install for mozfile 14:23:02 INFO - Running setup.py install for mozhttpd 14:23:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Running setup.py install for mozinfo 14:23:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Running setup.py install for mozInstall 14:23:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Running setup.py install for mozleak 14:23:02 INFO - Running setup.py install for mozlog 14:23:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Running setup.py install for moznetwork 14:23:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:02 INFO - Running setup.py install for mozprocess 14:23:03 INFO - Running setup.py install for mozprofile 14:23:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:03 INFO - Running setup.py install for mozrunner 14:23:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:03 INFO - Running setup.py install for mozscreenshot 14:23:03 INFO - Running setup.py install for moztest 14:23:03 INFO - Running setup.py install for mozversion 14:23:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:03 INFO - Cleaning up... 14:23:03 INFO - Return code: 0 14:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:23:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:23:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:03 INFO - Using env: {'DISPLAY': ':0', 14:23:03 INFO - 'HOME': '/home/cltbld', 14:23:03 INFO - 'LANG': 'en_US.UTF-8', 14:23:03 INFO - 'LANGUAGE': 'en_US:en', 14:23:03 INFO - 'LOGNAME': 'cltbld', 14:23:03 INFO - 'MAIL': '/var/mail/cltbld', 14:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:03 INFO - 'MOZ_NO_REMOTE': '1', 14:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:03 INFO - 'NO_EM_RESTART': '1', 14:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:03 INFO - 'PWD': '/builds/slave/test', 14:23:03 INFO - 'SHELL': '/bin/bash', 14:23:03 INFO - 'SHLVL': '1', 14:23:03 INFO - 'TERM': 'linux', 14:23:03 INFO - 'TMOUT': '86400', 14:23:03 INFO - 'USER': 'cltbld', 14:23:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:03 INFO - '_': '/tools/buildbot/bin/python'} 14:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:03 INFO - Running setup.py (path:/tmp/pip-0aQzJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:03 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)) 14:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:03 INFO - Running setup.py (path:/tmp/pip-pa3T6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 14:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:03 INFO - Running setup.py (path:/tmp/pip-ciMRql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:03 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)) 14:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:04 INFO - Running setup.py (path:/tmp/pip-mwoTnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:04 INFO - Running setup.py (path:/tmp/pip-ZI2RH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:04 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:04 INFO - Running setup.py (path:/tmp/pip-EMn_NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:04 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:04 INFO - Running setup.py (path:/tmp/pip-HD8z_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:04 INFO - Running setup.py (path:/tmp/pip-Qcgp75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:04 INFO - Running setup.py (path:/tmp/pip-oTpriT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:04 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:04 INFO - Running setup.py (path:/tmp/pip-BSEJm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:04 INFO - Running setup.py (path:/tmp/pip-vKHnFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:04 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:04 INFO - Running setup.py (path:/tmp/pip-7myRyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:04 INFO - Running setup.py (path:/tmp/pip-T41jbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:04 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:04 INFO - Running setup.py (path:/tmp/pip-_nv6M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:04 INFO - Running setup.py (path:/tmp/pip-MqERsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:04 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:04 INFO - Running setup.py (path:/tmp/pip-JRsGH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 14:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:04 INFO - Running setup.py (path:/tmp/pip-jpT7l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:05 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)) 14:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:05 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)) 14:23:05 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:05 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:05 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 14:23:05 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 14:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:05 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 14:23:05 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 14:23:06 INFO - Downloading blessings-1.6.tar.gz 14:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:06 INFO - Installing collected packages: blessings 14:23:06 INFO - Running setup.py install for blessings 14:23:07 INFO - Successfully installed blessings 14:23:07 INFO - Cleaning up... 14:23:07 INFO - Return code: 0 14:23:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:07 INFO - Reading from file tmpfile_stdout 14:23:07 INFO - Current package versions: 14:23:07 INFO - argparse == 1.2.1 14:23:07 INFO - blessings == 1.6 14:23:07 INFO - blobuploader == 1.2.4 14:23:07 INFO - docopt == 0.6.1 14:23:07 INFO - manifestparser == 1.1 14:23:07 INFO - mozInstall == 1.12 14:23:07 INFO - mozcrash == 0.17 14:23:07 INFO - mozdebug == 0.1 14:23:07 INFO - mozdevice == 0.48 14:23:07 INFO - mozfile == 1.2 14:23:07 INFO - mozhttpd == 0.7 14:23:07 INFO - mozinfo == 0.9 14:23:07 INFO - mozleak == 0.1 14:23:07 INFO - mozlog == 3.2 14:23:07 INFO - moznetwork == 0.27 14:23:07 INFO - mozprocess == 0.22 14:23:07 INFO - mozprofile == 0.28 14:23:07 INFO - mozrunner == 6.11 14:23:07 INFO - mozscreenshot == 0.1 14:23:07 INFO - mozsystemmonitor == 0.3 14:23:07 INFO - moztest == 0.7 14:23:07 INFO - mozversion == 1.4 14:23:07 INFO - psutil == 3.1.1 14:23:07 INFO - requests == 1.2.3 14:23:07 INFO - wsgiref == 0.1.2 14:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:23:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 14:23:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:07 INFO - Using env: {'DISPLAY': ':0', 14:23:07 INFO - 'HOME': '/home/cltbld', 14:23:07 INFO - 'LANG': 'en_US.UTF-8', 14:23:07 INFO - 'LANGUAGE': 'en_US:en', 14:23:07 INFO - 'LOGNAME': 'cltbld', 14:23:07 INFO - 'MAIL': '/var/mail/cltbld', 14:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:07 INFO - 'MOZ_NO_REMOTE': '1', 14:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:07 INFO - 'NO_EM_RESTART': '1', 14:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:07 INFO - 'PWD': '/builds/slave/test', 14:23:07 INFO - 'SHELL': '/bin/bash', 14:23:07 INFO - 'SHLVL': '1', 14:23:07 INFO - 'TERM': 'linux', 14:23:07 INFO - 'TMOUT': '86400', 14:23:07 INFO - 'USER': 'cltbld', 14:23:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:07 INFO - '_': '/tools/buildbot/bin/python'} 14:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 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)) 14:23:07 INFO - Cleaning up... 14:23:07 INFO - Return code: 0 14:23:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:23:07 INFO - Using env: {'DISPLAY': ':0', 14:23:07 INFO - 'HOME': '/home/cltbld', 14:23:07 INFO - 'LANG': 'en_US.UTF-8', 14:23:07 INFO - 'LANGUAGE': 'en_US:en', 14:23:07 INFO - 'LOGNAME': 'cltbld', 14:23:07 INFO - 'MAIL': '/var/mail/cltbld', 14:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:07 INFO - 'MOZ_NO_REMOTE': '1', 14:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:07 INFO - 'NO_EM_RESTART': '1', 14:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:07 INFO - 'PWD': '/builds/slave/test', 14:23:07 INFO - 'SHELL': '/bin/bash', 14:23:07 INFO - 'SHLVL': '1', 14:23:07 INFO - 'TERM': 'linux', 14:23:07 INFO - 'TMOUT': '86400', 14:23:07 INFO - 'USER': 'cltbld', 14:23:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:07 INFO - '_': '/tools/buildbot/bin/python'} 14:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:07 INFO - Downloading/unpacking jsonschema 14:23:07 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 14:23:07 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 14:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:07 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 14:23:07 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 14:23:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:09 INFO - Downloading/unpacking functools32 (from jsonschema) 14:23:09 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 14:23:09 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 14:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:09 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 14:23:09 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 14:23:09 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:09 INFO - warning: no files found matching '*.txt' 14:23:09 INFO - no previously-included directories found matching 'build' 14:23:09 INFO - no previously-included directories found matching 'dist' 14:23:09 INFO - no previously-included directories found matching '.git*' 14:23:09 INFO - Installing collected packages: jsonschema, functools32 14:23:10 INFO - Running setup.py install for functools32 14:23:10 INFO - warning: no files found matching '*.txt' 14:23:10 INFO - no previously-included directories found matching 'build' 14:23:10 INFO - no previously-included directories found matching 'dist' 14:23:10 INFO - no previously-included directories found matching '.git*' 14:23:10 INFO - Successfully installed jsonschema functools32 14:23:10 INFO - Cleaning up... 14:23:10 INFO - Return code: 0 14:23:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:10 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa30e6b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', '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 14:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:23:10 INFO - Using env: {'DISPLAY': ':0', 14:23:10 INFO - 'HOME': '/home/cltbld', 14:23:10 INFO - 'LANG': 'en_US.UTF-8', 14:23:10 INFO - 'LANGUAGE': 'en_US:en', 14:23:10 INFO - 'LOGNAME': 'cltbld', 14:23:10 INFO - 'MAIL': '/var/mail/cltbld', 14:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:10 INFO - 'MOZ_NO_REMOTE': '1', 14:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:10 INFO - 'NO_EM_RESTART': '1', 14:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:10 INFO - 'PWD': '/builds/slave/test', 14:23:10 INFO - 'SHELL': '/bin/bash', 14:23:10 INFO - 'SHLVL': '1', 14:23:10 INFO - 'TERM': 'linux', 14:23:10 INFO - 'TMOUT': '86400', 14:23:10 INFO - 'USER': 'cltbld', 14:23:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:10 INFO - '_': '/tools/buildbot/bin/python'} 14:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:10 INFO - Downloading/unpacking flake8 14:23:10 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 14:23:10 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 14:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:10 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 14:23:10 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 14:23:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:23:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:23:12 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 14:23:12 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 14:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 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 14:23:12 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 14:23:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:23:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:23:12 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 14:23:12 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 14:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 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 14:23:12 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 14:23:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:23:12 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 14:23:12 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 14:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:12 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 14:23:12 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 14:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:23:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:23:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:23:12 INFO - no previously-included directories found matching 'docs/_build' 14:23:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:23:13 INFO - Running setup.py install for pep8 14:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:23:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:23:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:23:13 INFO - no previously-included directories found matching 'docs/_build' 14:23:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:23:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:23:13 INFO - Cleaning up... 14:23:13 INFO - Return code: 0 14:23:13 INFO - Running post-action listener: _resource_record_post_action 14:23:13 INFO - Running post-action listener: _start_resource_monitoring 14:23:13 INFO - Starting resource monitoring. 14:23:13 INFO - ##### 14:23:13 INFO - ##### Finished create-virtualenv step (success) 14:23:13 INFO - ##### 14:23:13 INFO - ##### 14:23:13 INFO - ##### Running install step. 14:23:13 INFO - ##### 14:23:13 INFO - Running pre-action listener: _resource_record_pre_action 14:23:13 INFO - Running main action method: install 14:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:13 INFO - Reading from file tmpfile_stdout 14:23:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:13 INFO - Reading from file tmpfile_stdout 14:23:13 INFO - Output received: 14:23:13 INFO - Usage: mozinstall [options] installer 14:23:13 INFO - Options: 14:23:13 INFO - -h, --help show this help message and exit 14:23:13 INFO - -d DEST, --destination=DEST 14:23:13 INFO - Directory to install application into. [default: 14:23:13 INFO - "/builds/slave/test"] 14:23:13 INFO - --app=APP Application being installed. [default: firefox] 14:23:13 INFO - mkdir: /builds/slave/test/build/application 14:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:23:30 INFO - Reading from file tmpfile_stdout 14:23:30 INFO - Output received: 14:23:30 INFO - /builds/slave/test/build/application/firefox/firefox 14:23:30 INFO - Running post-action listener: _resource_record_post_action 14:23:30 INFO - ##### 14:23:30 INFO - ##### Finished install step (success) 14:23:30 INFO - ##### 14:23:30 INFO - ##### 14:23:30 INFO - ##### Running run-tests step. 14:23:30 INFO - ##### 14:23:30 INFO - Running pre-action listener: _resource_record_pre_action 14:23:30 INFO - Running main action method: run_tests 14:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:30 INFO - Python 2.7.3 14:23:30 INFO - Return code: 0 14:23:30 INFO - grabbing minidump binary from tooltool 14:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x20539c0>, '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 0x20548c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2054d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 14:23:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:23:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 14:23:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:30 INFO - Return code: 0 14:23:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:23:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:23:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:23:31 INFO - Return code: 0 14:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:23:31 INFO - Using env: {'DISPLAY': ':0', 14:23:31 INFO - 'HOME': '/home/cltbld', 14:23:31 INFO - 'LANG': 'en_US.UTF-8', 14:23:31 INFO - 'LANGUAGE': 'en_US:en', 14:23:31 INFO - 'LOGNAME': 'cltbld', 14:23:31 INFO - 'MAIL': '/var/mail/cltbld', 14:23:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:31 INFO - 'MOZ_NO_REMOTE': '1', 14:23:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:31 INFO - 'NO_EM_RESTART': '1', 14:23:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:31 INFO - 'PWD': '/builds/slave/test', 14:23:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:31 INFO - 'SHELL': '/bin/bash', 14:23:31 INFO - 'SHLVL': '1', 14:23:31 INFO - 'TERM': 'linux', 14:23:31 INFO - 'TMOUT': '86400', 14:23:31 INFO - 'USER': 'cltbld', 14:23:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305', 14:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:31 INFO - '_': '/tools/buildbot/bin/python'} 14:23:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:23:31 INFO - mozversion application_buildid: 20160602113028 14:23:31 INFO - mozversion application_changeset: 91879ebba4d61fde72af13223708faa01109a4d9 14:23:31 INFO - mozversion application_display_name: Nightly 14:23:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:31 INFO - mozversion application_name: Firefox 14:23:31 INFO - mozversion application_remotingname: firefox 14:23:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:23:31 INFO - mozversion application_vendor: Mozilla 14:23:31 INFO - mozversion application_version: 49.0a1 14:23:31 INFO - mozversion platform_buildid: 20160602113028 14:23:31 INFO - mozversion platform_changeset: 91879ebba4d61fde72af13223708faa01109a4d9 14:23:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:23:31 INFO - mozversion platform_version: 49.0a1 14:23:31 INFO - using testdate: 1464902611 14:23:31 INFO - actual date: 1464902611 14:23:31 INFO - starting webserver on 'localhost:33790' 14:23:31 INFO - SUITE-START | Running 2 tests 14:23:31 INFO - TEST-START | dromaeo_css 14:23:31 INFO - operating with platform_type : linux_ 14:23:31 INFO - Initialising browser for dromaeo_css test... 14:23:31 INFO - TEST-INFO | started process 823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gmu2c/profile http://localhost:33790/getInfo.html) 14:23:35 INFO - PROCESS | 823 | __metrics Screen width/height:1600/1200 14:23:35 INFO - PROCESS | 823 | colorDepth:24 14:23:35 INFO - PROCESS | 823 | Browser inner width/height: 1024/697 14:23:35 INFO - PROCESS | 823 | __metrics 14:23:36 ERROR - PROCESS | 823 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:23:37 INFO - TEST-INFO | 823: exit 0 14:23:37 INFO - Browser initialized. 14:23:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:23:37 INFO - TEST-INFO | started process 911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0gmu2c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:49 INFO - PROCESS | 911 | RSS: Main: 155594752 14:23:49 INFO - PROCESS | 911 | 14:24:40 INFO - PROCESS | 911 | 1464902680622 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:26:48 INFO - PROCESS | 911 | Cycle 1(1): loaded http://localhost:33790/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33790/tests/dromaeo/cssquery-ext.html) 14:26:49 INFO - PROCESS | 911 | RSS: Main: 253513728 14:26:49 INFO - PROCESS | 911 | 14:29:52 INFO - PROCESS | 911 | Cycle 1(1): loaded http://localhost:33790/tests/dromaeo/cssquery-ext.html (next: http://localhost:33790/tests/dromaeo/cssquery-jquery.html) 14:29:52 INFO - PROCESS | 911 | RSS: Main: 241700864 14:29:52 INFO - PROCESS | 911 | 14:32:55 INFO - PROCESS | 911 | Cycle 1(1): loaded http://localhost:33790/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33790/tests/dromaeo/cssquery-mootools.html) 14:32:55 INFO - PROCESS | 911 | RSS: Main: 243499008 14:32:55 INFO - PROCESS | 911 | 14:35:57 INFO - PROCESS | 911 | Cycle 1(1): loaded http://localhost:33790/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33790/tests/dromaeo/cssquery-prototype.html) 14:35:58 INFO - PROCESS | 911 | RSS: Main: 236912640 14:35:58 INFO - PROCESS | 911 | 14:39:01 INFO - PROCESS | 911 | Cycle 1(1): loaded http://localhost:33790/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33790/tests/dromaeo/cssquery-yui.html) 14:39:01 INFO - PROCESS | 911 | RSS: Main: 210575360 14:39:01 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | Cycle 1(1): loaded http://localhost:33790/tests/dromaeo/cssquery-yui.html (next: http://localhost:33790/tests/dromaeo/cssquery-dojo.html) 14:42:04 INFO - PROCESS | 911 | RSS: Main: 272351232 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | __start_tp_report 14:42:04 INFO - PROCESS | 911 | _x_x_mozilla_page_load 14:42:04 INFO - PROCESS | 911 | _x_x_mozilla_page_load_details 14:42:04 INFO - PROCESS | 911 | |i|pagename|runs| 14:42:04 INFO - PROCESS | 911 | |0;dojo.html;3089.2894634234126;3097.6282846058475;3113.7976031557946;3140.842957852107;3159.6208454985403;5210.9478905210935;5292.967871265105;5336.226247194155;5404.513593776559;5436.537894278981;5203.063448579254;5263.289455923449;5324.600654950885;5356.11624082026;5365.248865158881;4783.832565860187;4792;4865.4161500619975;4881.4874438184015;5053.191489361703;4944.87637809054;4978.576820970222;5013.298138260647;5034.370703662043;5038.168702164138;4765.189917713997;4795.376601041859;4816.373871396713;4832.4684284728655;4894.828680996148;4788;4822.445418776851;4827.734474603895;4921.360223171001;4959.181735013718;4850.466448690677;4874.0251949609865;4875.658703890729;4879.706877677419;4894.1679914414635;5165.457626949154;5242.370915490127;5307.124324486455;5370.946290537084;5381.730913454312;5784.652920824764;5796.101604251306;5815.534757219412;5816.505597024258;5821.476067153934;5554.444555544454;5788.189653448479;5824.330202026778;5845.064789633639;5853.1220316952795;5343.839684809462;5400.648957817769;5402.864928376822;5490.203920431555;5493.587980901449;5979.282486101695;5979.4618484336615;5986.042233242747;5990.371011043778;5994.910076348859;5474.644148130359;5580.079286917613;5675.2054712340305;5676.262085928885;5708.628939118944;5703.030484817591;5761.798337058183;5820.738066787005;5831.591788574844;5834.533237341003;5689.601727879091;5741.712914354265;5744.885102298014;5745.540356771448;5748.45389687979;5498.120300751861;5656.038473459522;5698.914516282259;5766.509846662997;5775.913361299584;4382.233109205877;4391.077873646506;4398.318260669601;4431.889202769957;4442.622377097983;3883.3204189266767;3901.0247438140464;3905.824237909301;3929.6070392961046;3940.802959851996;5152.124138896396;5248.921266181011;5277.709725965032;5386.8383948481605;5434;5780.277465316835;5809.477147056785;5812.070068789058;5819.476247137778;5851.561132915049;5430.728463576806;5431.619786614978;5434.809781657623;5448.754806033738;5453.100238460689;4816.614670826326;4885;4946.159152944008;4953.380827396575;5018.799248030111;5948.464638182584;5958.463738263577;5963.5825492216;5963.7912673056235;5966.522678185735;5758.193852860687;5783.103618939072;5784.074548072456;5798.94201057984;5802.82591522255;5765.884682306414;5880.735366908414;5947.762089516544;5985.461308482083;6050.7277172526465;5685.34618518859;5715.685637289989;5719.28508936383;5720.313562372542;5724.284464441945;5596.748146333506;5808.070708686759;5817.476427121579;5823.5923485355615;5837.824865254049;5557.805476808292;5622.437756224344;5627.380988091225;5678.886422271614;5695.800646977502;5616.634918730269;5653.491185793298;5660.915086273627;5661.2923384576925;5667.4615911488345;5337.759800808895;5445.53712934405;5590.496855282881;5591.105423132442;5605.131204663121;5584.916226256691;5730.283714535683;5745.597808153389;5757.165211044459;5758.193852860519;5515.917261241005;5519.31008623922;5564.944350556604;5578.972105139448;5619.466150715675 14:42:04 INFO - PROCESS | 911 | |1;ext.html;568.7554351628801;595.627732667083;599.67018140023;622.9345918678541;624.5191202773862;28464;30894.53658195126;30943.38113237734;42295.94260143498;43580.782096089555;43402.782986085105;43506.347404788954;43680.126397472035;43727.78136109323;43975.340369894475;8411.95794021029;8547.273481754059;8561.229489345958;8572.528510931896;8592.312614990786;8321.375896807733;8420.915790842106;8421.789455263637;8432;8459.223563051766;8719.869201961945;8770.079141690127;8780.209781119698;8780.25367843734;8794;8677.219050285474;8718.651253949834;8726.738197854074;8733;8747.868781968276;8619.65521379144;8687.478751274944;8688.435251708619;8692.956535217347;8697.565121743888;39893.40159897604;40312.59687403118;40314.395284070764;40357;40375.59624403748;3315.5689760331;3338.1821453743746;3350.6051775751193;3527.3298073365977;3540.451230059345;27684;27845.721542784515;27930.581041284193;27947.161585152273;28923;4034.9394759078637;4250.0437401584395;4279.700420970534;4351.956480435187;4470.195364834329;370886;370893;374572;375799;376330;35285.64714352875;36097.639023609954;36364.636353636655;64261.35738642554;65095;37782.62217377846;38229.61770382316;38350.61649383526;38367.232655346736;38371.6162838368;14765.261736913111;14992.175430351217;14993.475228366955;15002.324895379734;15042.473513427196;12521.186122901981;12708.872911270953;12717.491300347883;12720;12727.872721272854;8524.70163544273;8555.187257210555;8568.271696905707;8622.741317760478;8645.654173832976;3208.3904058228864;3208.871645134215;3225.967740322567;3240.9837950810097;3250.333681595267;1032.8759262740246;1046.858674079005;1060.867391576053;1109.290054365207;1133.1557989298026;33094.66905330964;33141.3371732564;33355;33368.66631333704;33466.226334632454;1141.931484110956;1145.7479354541988;1174.2484809721784;1203.296071798008;1254.3978890132605;17282.567935801704;17292;17485.30058797659;17494;17547;573121;573606;576898;578950;582109;60578;61055;61102;61156.38843611507;61198.082028769604;1257.5912828330647;1338.6519504928788;1380.5720226729745;1386.182152529992;1399.7270532246114;32797.86813857091;34602;34643.307133857685;34682.30635387329;35066.824665876506;50051.749741251064;50537;50685.23972140495;50709.74645126751;50795.4125046252;422559;424002;424377;424915;424917;24510.509789804462;24640.876795615906;26181.869090654425;26601;26604.201873943814;42827.357589635554;43524.56475435332;48731.512684872694;49052.75473622609;50412;40762.59237407588;41817.37273940954;42017.57982420137;42264.577354226065;42732.14535709331;40614.79692601518;40793;40932;41783.37324940189;42126.36810447784;42010;42389;42498.36252456154;42510.78744606381;42895.1420971585;35841.64158358383;37403.81298093492;38455.61544384521;38506.229875401776;38875.416868746426;28513.28716782097;28891.711082889742;29074.20508783622;29305.85347073251;29493.557596635637 14:42:04 INFO - PROCESS | 911 | |2;jquery.html;396.99404508932355;401.63451259353957;401.6465510350891;406.743751436595;413.00107479797794;12935.850000721706;18151;18921.432357029313;19757.110930008148;19773.40679779607;17256.482305530822;17301.39445119418;17466.214020369083;17769.37807176749;18278.908605456953;5574.693391863456;5728.455796699307;5767.452092051249;5773.797917072903;5780.53755699543;5668.858278543049;5682.403347648499;5718.71406429679;5720.141978703207;5723.51350135239;4168.5623009584015;6042.425969532887;6338.112664226989;6342.87314253717;6477.449416799578;5517.5585953123655;5849.093390524476;6410.262819775716;6459.6447195404235;6462.483001359903;5721.256236689245;5728.25532680753;5730.570207234474;5753.338366087912;5759.48164665178;13564.389602467912;15807;21046.473838154016;23306.184283550163;23340.183093591644;2292.4727312718;2353.329301149164;2378.108209421467;2478.120267305099;2482.3669964159026;9880.604775808959;9960.904300526936;10042.096211341015;10392.480375981246;10450.425226612533;1834.660587791263;1951.7755458122215;1986.4437957371815;2011.9195232190696;2016.3043749906258;59749;62209;75808.62095689487;82999.5850020746;84069;10958.232923695265;10967.725806854733;11281.94359028216;11353.432328383547;11376.772464550662;15539;15590.688186236212;15628.062316261061;15652.92173539125;15662.373505059897;7933.563653999086;8090.757277281691;8196.34429245659;8342.082370939192;8398.664053437917;7652.120006199359;7696.807579810549;7804.492707973964;7861.842763144705;8032.1164671886045;4247.447831781848;4251.59609837065;4720.221163508051;4749.26386410107;4861.927071093936;1867.1784414857418;1975.5851271232914;1991.3727175939532;1995.4512509060125;2001.5296405344732;951.3340661536813;959.8800149981253;975.707287813653;1006.7785087280787;1012.4684540616236;18504.259829606934;18550;18659.81340186581;19083.04584770756;19279.710804337945;915.4919019943862;1015.1878497202356;1030.5002073994108;1058.25921854702;1072.3619446429361;10319.48402579868;10885.129189664965;10955.616553420592;10976.067034302174;10994.560217591366;388002;391589;501153;508341;508493;96193;97257.51371243098;98719.50640246752;100292.4985375083;100821;1036.1762398892747;1052.7736536644659;1073.8765042020268;1079.1959989807644;1086.1962148010573;15844.76232856485;16398.508044758677;16399.672006559562;16443.177841108136;16514.339426422808;34661.826690866386;37748.2450350986;39032;40712.38931415972;42946.78526607347;51484;52224.738876306896;54285.45714542962;55727.16409253945;58784.4121558796;8044.919550804417;8115.715949941724;8271.95864020676;8276.586170691562;8581.914180858112;12289.938550307548;12787.936060319638;12853.42159602839;12958.416871241005;13000.349982500647;10932.56269749201;11095.389753563632;11341.432928353714;11505.482253298454;11778;10914.181436392144;11172.944135279271;11185.72035699114;11633.59282425111;11736.941315293368;11379.374134422686;11502.48238829238;11581.536738530702;11827.231229970368;12218.14472986918;8275.462094963808;8340.833183336177;8380.12008739098;8382.958085209535;8418.158184181533;8580.828383432172;11793.11551633648;11823.467943942715;11887.405629718653;11917.880821192024 14:42:04 INFO - PROCESS | 911 | |3;mootools.html;1261.9684507887307;1468.2438544149759;1510.3958416633345;1681.9243134058966;1811.5018369948264;8421.621027053781;8732.30141588673;8784.736457906258;9071.183593476586;9073.092690730924;9081.545922703855;9292.767680807983;9299.48852813095;9301.209397201246;9301.488418137;2108.8629239099487;2361.645753137026;2387.594109001474;2426.8665223412704;2427.890744916474;2452.852828830267;2462.5444292805887;2465.3220364399754;2468.1854987853967;2468.456939473322;2375.5605213035556;2379.95240095198;2422.7456117107713;2435.768601982809;2439.743826898177;2016.3950814755588;2275.3515248154195;2329.4292898239955;2334.043042352644;2344.788968992782;2378.595638741418;2382.6187809950325;2384.5588566115325;2392.9282121536207;2397.7722116398913;9264.907350926473;9321.813563728756;9350.392224505385;9350.67272645454;9354.20489258407;5424.213489044067;5567.721613919288;5584.106542953149;5585.2459917910965;5586.804461843856;3267.558879551254;3419.9316013679836;3441.1913200397885;3486.3027394521196;3488.354654388946;1147.7302833834042;1155.4684844971239;1188.1860925266221;1202.1044321980094;1208.3354155214686;13372.665683357995;13382.063255572113;13392.799108013387;13393.06248562601;13413.66465838352;4825.348577942003;4965.379327584052;4995.500449955048;4997.900041999213;5041.546260836542;11042.392668403316;11069.778604428027;11085.224034317682;11086.22396432242;11091;5616.9157462638095;5619.129034999582;5623.606347555632;5627.634203776742;5627.662340259598;4438.689291749611;4945.579625731853;5055.570276526537;5071.746412679351;5182.378114626269;4102.425660407545;4167.395727619539;4174.019105510202;4262.573742625713;4263.744175349489;1283.4224598930518;1314.6056183145017;1315.7171208190284;1327.4491086199118;1332.7534406134896;877.5042101212795;976.9546585153818;1023.3655133817081;1031.3296357367772;1066.914646828252;6135.14108024868;6309.92731235691;6332.176817013851;6341.904871426932;6499.675016249169;909.6178713158279;937.3906960475746;949.2548349545574;955.9808803823885;968.2060710217554;4170.124273902515;4262.808173632132;4285.785710714452;4319.956800431955;4327.978360108179;11437.885621143849;11536.365499897585;11929.463174157183;11935.045196384268;11962.521499140112;11591.710207244887;11720.648380548597;11737.589184378507;11741.29552226869;11742.765144697058;8453.070162282267;8463.66145354179;8529.488230706178;8712.0416754157;8787.077356877437;5880.294364676266;5918.940810592011;6019.4883434908525;6091.0558863376245;6106.938930610637;10368.637097701545;10720.839187412352;10809.67570972872;10851.620193293196;10874.67375978722;10934.45327733626;11005.609847959218;11057.115430765358;11129.387883666475;11146.88853111491;6900.551464154814;7419.740309089156;7524.962375188089;7632;7647.847043059219;9045.819083618422;9051.637934482547;9131.858517685288;9143.497107659143;9144.679936202201;7709.8843517348405;7715.92284077152;7974.681012759656;8029.59852007409;8080.232377924088;7830.804229894298;7885.6845726172605;7993.8401231976195;8019.799505012421;8049.114597394165;7255.782326530212;7350.19147893742;7354.117505899327;7448.9627551861895;7465.888011679937;5330.920036199538;5344.35867695879;5416.75624596902;5467.617266791445;5600.047991841316;5240.737963101754;5299.576033917355;5443.455654434525;5471.589630777628;5712.914306285326 14:42:04 INFO - PROCESS | 911 | |4;prototype.html;322.5307178055929;328.6155198417851;334.1362577736551;335.55538910943005;338.5395861628187;5258.815941442051;5303.310569625953;5319.255304257402;5355.6610847288175;5397.46025397461;5232.895342093156;5284.365876094874;5310.964361949422;5317.867053323669;5334.146536554152;4193.517745459273;4197.223513649985;4208.431861698662;4210.3684447332835;4226.619604235618;3966.6909919726563;4045.5145382554133;4183.7489750614905;4205.179989901971;4205.5794420558;4128.21563902859;4134.855280065199;4139.461869956916;4150.896227594304;4162.83348666053;3969.384745364473;4148.066684995867;4159.147374788176;4174.290370636969;4176.436181115571;3626.165981824195;3713.6100709425664;3719.609441008682;3739.691108112166;3745.4194599836796;5108.565771909392;5109.135165664543;5129.692218466904;5141.151709967889;5179.585633149339;4567.794449249792;4769;4789.425268967711;4799.904001919977;4812.494688057774;5511.22842802008;5526.889462210734;5531.921275351308;5536.806211782608;5544.251526043973;3995.900102497432;4018.819153138116;4058.817353219112;4060.533038700558;4073.368627862686;5491.395946445888;5701.315842098933;5735.050082971809;5743.2246646703;5754;4026.939595906064;4028.2749105160765;4033.9798301008896;4040.5150832237964;4054.4729185205733;4063.6139566741113;4074.3277359235985;4081.3673880548563;4130.896727581834;4135.8966025848995;4688.249880019181;4705.482396936334;4728.1252968201;4731.101090792738;4736.644751643572;5413.945860541423;5512.33851937762;5533.750981205855;5547.278853748987;5570.554355651539;1389.423389293432;1406.1703594878866;1419.936102875373;1424.480064776349;1425.7790042543422;881.316979341003;907.0974380491454;921.8432866412726;922.064104933493;926.935114541989;4708.246680531099;4778.331033655291;4782.760861956888;5030.346055012825;5116.441779110445;5660.490555849993;5703.600747947687;5719.828405147852;5744.396838331915;5770.701592141734;5293.8088929990445;5340.626156169109;5347.919781203207;5364.570834333244;5366.946330536644;2914.9271268218463;3011.488047031966;3039;3051.3897220555978;3055.8777648893797;5899.911501327483;5928.4960778334325;5930.005347299586;5932.525397968238;5936.5250779937505;5542.584306177053;5754.906567752114;5811.15738217956;5848.502877255481;5861.5603829712945;5883.235179426647;5885.6468611882565;5888.735006924699;5896.233489646404;5923.555733319932;5670.894175635712;5675.318961724454;5717.285339332583;5722.313322401338;5736.110902810071;5373.6238463308755;5608.327000759772;5697.521578113534;5725.971370143289;5727.599068065362;5870.677112758839;5901.259128557172;5907.940920590739;5910.349861515144;5913.704314784158;4038.273110840077;4046.765736450293;4052.7163098582814;4052.8986775330854;4090.4682391288943;5521.503064724034;5759.107338362561;5767.8558036049435;5769.740361683818;5790.363060063305;5570.303712035996;5586.4916472552995;5603.355614104267;5621.943780562142;5643.35101463337;5410.540104091197;5461.235427040297;5551.056320425457;5583.35791383996;5608.943910561005;5469.808556700496;5494.2582751328055;5508.44915508446;5512.448755124456;5523.530499907552;5383.519532128696;5409.404965453718;5590.413006634245;5621.775128994958;5631.915521267102;5458.2904222450825;5461.754221060141;5493.835184944458;5507.981023510663;5528.640638358494 14:42:04 INFO - PROCESS | 911 | |5;yui.html;728.2389902551832;756.1870988687162;766.7515853979512;798.8442253760517;833.7415401225622;14678.192699401528;14689.706205875877;14708.411663533472;14739.336729847157;14764.261786910653;14471.34878930448;14798.556043318718;14962.551123466286;15002.624934376647;15186.54440366788;799.5442597719288;807.9272865442109;813.7070654564352;814.1329484099415;815.0830315894618;460.07065727230975;530.8805518758287;533.3972610949621;822.8683410654296;827.7433995461427;869.7782065573301;871.4161511787117;872.2062922740307;873.2577309287087;873.7771868173638;870.5603670146598;871.2072014466836;871.4379225399614;871.877937088808;872.0233338660709;526.557691539109;618.8421952402109;621.4065567383138;623.0342968398963;629.3423372575669;14732.705345893022;14810.185439800807;14925.701485970329;14931.626709332246;14991;13088.738225235442;14076.225807580578;14090.154590724487;14268.785968210484;14502.782458263135;12167.695807604792;12748;12821.871781282161;12919.483220671162;13053;4353.456616767797;4390.978045109786;4459.888502787424;4489.865304040884;4497.775111244425;74090.62954685192;74114.25885741127;74783;74982.62508687422;80694.19305806926;10827.404492752818;10879.347239165676;10965.780684386267;11177.83233251502;11242;20396;20575.176992920417;20590.897045514677;20642.483937901674;20976.685349719766;8099.554524501209;8155.10293867674;8200.26197642215;8368.24685778283;8809.42738721981;4703.811847526061;4835.105505481427;4839.128956787812;4841.201201801734;4941.357623508921;3495.7727747696317;3593.407087830531;3603.4955106285142;3604.6395360463744;3606.4590311452966;603.9449805131081;628.8773689130667;642.7686033028106;652.9934700653027;672.8385187554951;569.9344575373885;632.2318383164477;632.8987362022146;674.1909708349999;697.052009267396;9083.45499270046;9249.385253056347;9255;9346.48594327305;9528.571214295234;536.5948708724966;548.5666323604388;575.2952633024595;601.6931365003879;702.5714314268292;4406.62543683784;4446.533114022981;4467.530909254547;4485.932711009337;4542.545745425431;99906.5004674972;106860.87004038833;113420.43289783664;114740.42629786965;114905.4254728721;94921;97589.51205244071;98057.50971245098;98697.50651246698;98750;82611;84417.57791211005;85833.5708321467;85936.57031714926;86632;8442.246029181282;8741.737747867573;8776;8796.340274479568;8831.602577883883;36382.454263186606;44887;50600.49399505958;52334.47665523296;52636.73681631567;69073;73275.26724732897;74325;74661;76870.84693729486;10729;11563.826542602035;11641.126915481203;11975.520979160736;12009;12189.14675972709;12336.691582710504;12681.873181268069;12699.365031748192;13280.203187808762;7865.410094243069;12565.497380105058;12656.43046062911;12659.81010284828;12682.809757853824;13471.797923030967;14144.292785360896;14171.64570885736;14234.786478203043;14256.358463868943;13041;13471.393787279792;13516.662083447993;13760.31198440094;14152.646183845074;10481.475926203811;10604.310719803496;10676.252662313875;10880.183986201226;11068.169887258327;11190.272632278877;11216;11524.13568982313;11644.41777911118;11682.76634467323 14:42:04 INFO - PROCESS | 911 | __end_tp_report 14:42:04 INFO - PROCESS | 911 | __start_cc_report 14:42:04 INFO - PROCESS | 911 | _x_x_mozilla_cycle_collect,873 14:42:04 INFO - PROCESS | 911 | __end_cc_report 14:42:04 INFO - PROCESS | 911 | __startTimestamp1464903724374__endTimestamp 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | ------- Summary: start ------- 14:42:04 INFO - PROCESS | 911 | Number of tests: 6 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | [#0] dojo.html Cycles:165 Average:5343.82 Median:5557.81 stddev:616.30 (11.1%) stddev-sans-first:592.27 14:42:04 INFO - PROCESS | 911 | Values: 3089.3 3097.6 3113.8 3140.8 3159.6 5210.9 5293.0 5336.2 5404.5 5436.5 5203.1 5263.3 5324.6 5356.1 5365.2 4783.8 4792.0 4865.4 4881.5 5053.2 4944.9 4978.6 5013.3 5034.4 5038.2 4765.2 4795.4 4816.4 4832.5 4894.8 4788.0 4822.4 4827.7 4921.4 4959.2 4850.5 4874.0 4875.7 4879.7 4894.2 5165.5 5242.4 5307.1 5370.9 5381.7 5784.7 5796.1 5815.5 5816.5 5821.5 5554.4 5788.2 5824.3 5845.1 5853.1 5343.8 5400.6 5402.9 5490.2 5493.6 5979.3 5979.5 5986.0 5990.4 5994.9 5474.6 5580.1 5675.2 5676.3 5708.6 5703.0 5761.8 5820.7 5831.6 5834.5 5689.6 5741.7 5744.9 5745.5 5748.5 5498.1 5656.0 5698.9 5766.5 5775.9 4382.2 4391.1 4398.3 4431.9 4442.6 3883.3 3901.0 3905.8 3929.6 3940.8 5152.1 5248.9 5277.7 5386.8 5434.0 5780.3 5809.5 5812.1 5819.5 5851.6 5430.7 5431.6 5434.8 5448.8 5453.1 4816.6 4885.0 4946.2 4953.4 5018.8 5948.5 5958.5 5963.6 5963.8 5966.5 5758.2 5783.1 5784.1 5798.9 5802.8 5765.9 5880.7 5947.8 5985.5 6050.7 5685.3 5715.7 5719.3 5720.3 5724.3 5596.7 5808.1 5817.5 5823.6 5837.8 5557.8 5622.4 5627.4 5678.9 5695.8 5616.6 5653.5 5660.9 5661.3 5667.5 5337.8 5445.5 5590.5 5591.1 5605.1 5584.9 5730.3 5745.6 5757.2 5758.2 5515.9 5519.3 5564.9 5579.0 5619.5 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | [#1] ext.html Cycles:180 Average:60107.39 Median:40366.30 stddev:124176.20 (307.6%) stddev-sans-first:124444.09 14:42:04 INFO - PROCESS | 911 | Values: 568.8 595.6 599.7 622.9 624.5 28464.0 30894.5 30943.4 42295.9 43580.8 43402.8 43506.3 43680.1 43727.8 43975.3 8412.0 8547.3 8561.2 8572.5 8592.3 8321.4 8420.9 8421.8 8432.0 8459.2 8719.9 8770.1 8780.2 8780.3 8794.0 8677.2 8718.7 8726.7 8733.0 8747.9 8619.7 8687.5 8688.4 8693.0 8697.6 39893.4 40312.6 40314.4 40357.0 40375.6 3315.6 3338.2 3350.6 3527.3 3540.5 27684.0 27845.7 27930.6 27947.2 28923.0 4034.9 4250.0 4279.7 4352.0 4470.2 370886.0 370893.0 374572.0 375799.0 376330.0 35285.6 36097.6 36364.6 64261.4 65095.0 37782.6 38229.6 38350.6 38367.2 38371.6 14765.3 14992.2 14993.5 15002.3 15042.5 12521.2 12708.9 12717.5 12720.0 12727.9 8524.7 8555.2 8568.3 8622.7 8645.7 3208.4 3208.9 3226.0 3241.0 3250.3 1032.9 1046.9 1060.9 1109.3 1133.2 33094.7 33141.3 33355.0 33368.7 33466.2 1141.9 1145.7 1174.2 1203.3 1254.4 17282.6 17292.0 17485.3 17494.0 17547.0 573121.0 573606.0 576898.0 578950.0 582109.0 60578.0 61055.0 61102.0 61156.4 61198.1 1257.6 1338.7 1380.6 1386.2 1399.7 32797.9 34602.0 34643.3 34682.3 35066.8 50051.7 50537.0 50685.2 50709.7 50795.4 422559.0 424002.0 424377.0 424915.0 424917.0 24510.5 24640.9 26181.9 26601.0 26604.2 42827.4 43524.6 48731.5 49052.8 50412.0 40762.6 41817.4 42017.6 42264.6 42732.1 40614.8 40793.0 40932.0 41783.4 42126.4 42010.0 42389.0 42498.4 42510.8 42895.1 35841.6 37403.8 38455.6 38506.2 38875.4 28513.3 28891.7 29074.2 29305.9 29493.6 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | [#2] jquery.html Cycles:180 Average:27694.52 Median:12846.76 stddev:76564.60 (596.0%) stddev-sans-first:76751.95 14:42:04 INFO - PROCESS | 911 | Values: 397.0 401.6 401.6 406.7 413.0 12935.9 18151.0 18921.4 19757.1 19773.4 17256.5 17301.4 17466.2 17769.4 18278.9 5574.7 5728.5 5767.5 5773.8 5780.5 5668.9 5682.4 5718.7 5720.1 5723.5 4168.6 6042.4 6338.1 6342.9 6477.4 5517.6 5849.1 6410.3 6459.6 6462.5 5721.3 5728.3 5730.6 5753.3 5759.5 13564.4 15807.0 21046.5 23306.2 23340.2 2292.5 2353.3 2378.1 2478.1 2482.4 9880.6 9960.9 10042.1 10392.5 10450.4 1834.7 1951.8 1986.4 2011.9 2016.3 59749.0 62209.0 75808.6 82999.6 84069.0 10958.2 10967.7 11281.9 11353.4 11376.8 15539.0 15590.7 15628.1 15652.9 15662.4 7933.6 8090.8 8196.3 8342.1 8398.7 7652.1 7696.8 7804.5 7861.8 8032.1 4247.4 4251.6 4720.2 4749.3 4861.9 1867.2 1975.6 1991.4 1995.5 2001.5 951.3 959.9 975.7 1006.8 1012.5 18504.3 18550.0 18659.8 19083.0 19279.7 915.5 1015.2 1030.5 1058.3 1072.4 10319.5 10885.1 10955.6 10976.1 10994.6 388002.0 391589.0 501153.0 508341.0 508493.0 96193.0 97257.5 98719.5 100292.5 100821.0 1036.2 1052.8 1073.9 1079.2 1086.2 15844.8 16398.5 16399.7 16443.2 16514.3 34661.8 37748.2 39032.0 40712.4 42946.8 51484.0 52224.7 54285.5 55727.2 58784.4 8044.9 8115.7 8272.0 8276.6 8581.9 12289.9 12787.9 12853.4 12958.4 13000.3 10932.6 11095.4 11341.4 11505.5 11778.0 10914.2 11172.9 11185.7 11633.6 11736.9 11379.4 11502.5 11581.5 11827.2 12218.1 8275.5 8340.8 8380.1 8383.0 8418.2 8580.8 11793.1 11823.5 11887.4 11917.9 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | [#3] mootools.html Cycles:180 Average:6096.28 Median:4955.48 stddev:3541.88 (71.5%) stddev-sans-first:3533.18 14:42:04 INFO - PROCESS | 911 | Values: 1262.0 1468.2 1510.4 1681.9 1811.5 8421.6 8732.3 8784.7 9071.2 9073.1 9081.5 9292.8 9299.5 9301.2 9301.5 2108.9 2361.6 2387.6 2426.9 2427.9 2452.9 2462.5 2465.3 2468.2 2468.5 2375.6 2380.0 2422.7 2435.8 2439.7 2016.4 2275.4 2329.4 2334.0 2344.8 2378.6 2382.6 2384.6 2392.9 2397.8 9264.9 9321.8 9350.4 9350.7 9354.2 5424.2 5567.7 5584.1 5585.2 5586.8 3267.6 3419.9 3441.2 3486.3 3488.4 1147.7 1155.5 1188.2 1202.1 1208.3 13372.7 13382.1 13392.8 13393.1 13413.7 4825.3 4965.4 4995.5 4997.9 5041.5 11042.4 11069.8 11085.2 11086.2 11091.0 5616.9 5619.1 5623.6 5627.6 5627.7 4438.7 4945.6 5055.6 5071.7 5182.4 4102.4 4167.4 4174.0 4262.6 4263.7 1283.4 1314.6 1315.7 1327.4 1332.8 877.5 977.0 1023.4 1031.3 1066.9 6135.1 6309.9 6332.2 6341.9 6499.7 909.6 937.4 949.3 956.0 968.2 4170.1 4262.8 4285.8 4320.0 4328.0 11437.9 11536.4 11929.5 11935.0 11962.5 11591.7 11720.6 11737.6 11741.3 11742.8 8453.1 8463.7 8529.5 8712.0 8787.1 5880.3 5918.9 6019.5 6091.1 6106.9 10368.6 10720.8 10809.7 10851.6 10874.7 10934.5 11005.6 11057.1 11129.4 11146.9 6900.6 7419.7 7525.0 7632.0 7647.8 9045.8 9051.6 9131.9 9143.5 9144.7 7709.9 7715.9 7974.7 8029.6 8080.2 7830.8 7885.7 7993.8 8019.8 8049.1 7255.8 7350.2 7354.1 7449.0 7465.9 5330.9 5344.4 5416.8 5467.6 5600.0 5240.7 5299.6 5443.5 5471.6 5712.9 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | [#4] prototype.html Cycles:180 Average:4674.83 Median:5351.79 stddev:1374.71 (25.7%) stddev-sans-first:1339.19 14:42:04 INFO - PROCESS | 911 | Values: 322.5 328.6 334.1 335.6 338.5 5258.8 5303.3 5319.3 5355.7 5397.5 5232.9 5284.4 5311.0 5317.9 5334.1 4193.5 4197.2 4208.4 4210.4 4226.6 3966.7 4045.5 4183.7 4205.2 4205.6 4128.2 4134.9 4139.5 4150.9 4162.8 3969.4 4148.1 4159.1 4174.3 4176.4 3626.2 3713.6 3719.6 3739.7 3745.4 5108.6 5109.1 5129.7 5141.2 5179.6 4567.8 4769.0 4789.4 4799.9 4812.5 5511.2 5526.9 5531.9 5536.8 5544.3 3995.9 4018.8 4058.8 4060.5 4073.4 5491.4 5701.3 5735.1 5743.2 5754.0 4026.9 4028.3 4034.0 4040.5 4054.5 4063.6 4074.3 4081.4 4130.9 4135.9 4688.2 4705.5 4728.1 4731.1 4736.6 5413.9 5512.3 5533.8 5547.3 5570.6 1389.4 1406.2 1419.9 1424.5 1425.8 881.3 907.1 921.8 922.1 926.9 4708.2 4778.3 4782.8 5030.3 5116.4 5660.5 5703.6 5719.8 5744.4 5770.7 5293.8 5340.6 5347.9 5364.6 5366.9 2914.9 3011.5 3039.0 3051.4 3055.9 5899.9 5928.5 5930.0 5932.5 5936.5 5542.6 5754.9 5811.2 5848.5 5861.6 5883.2 5885.6 5888.7 5896.2 5923.6 5670.9 5675.3 5717.3 5722.3 5736.1 5373.6 5608.3 5697.5 5726.0 5727.6 5870.7 5901.3 5907.9 5910.3 5913.7 4038.3 4046.8 4052.7 4052.9 4090.5 5521.5 5759.1 5767.9 5769.7 5790.4 5570.3 5586.5 5603.4 5621.9 5643.4 5410.5 5461.2 5551.1 5583.4 5608.9 5469.8 5494.3 5508.4 5512.4 5523.5 5383.5 5409.4 5590.4 5621.8 5631.9 5458.3 5461.8 5493.8 5508.0 5528.6 14:42:04 INFO - PROCESS | 911 | 14:42:04 INFO - PROCESS | 911 | [#5] yui.html Cycles:180 Average:20225.70 Median:2581.94 stddev:29219.13 (1131.7%) stddev-sans-first:29264.42 14:42:04 INFO - PROCESS | 911 | Values: 728.2 756.2 766.8 798.8 833.7 14678.2 14689.7 14708.4 14739.3 14764.3 14471.3 14798.6 14962.6 15002.6 15186.5 799.5 807.9 813.7 814.1 815.1 460.1 530.9 533.4 822.9 827.7 869.8 871.4 872.2 873.3 873.8 870.6 871.2 871.4 871.9 872.0 526.6 618.8 621.4 623.0 629.3 14732.7 14810.2 14925.7 14931.6 14991.0 13088.7 14076.2 14090.2 14268.8 14502.8 12167.7 12748.0 12821.9 12919.5 13053.0 4353.5 4391.0 4459.9 4489.9 4497.8 74090.6 74114.3 74783.0 74982.6 80694.2 10827.4 10879.3 10965.8 11177.8 11242.0 20396.0 20575.2 20590.9 20642.5 20976.7 8099.6 8155.1 8200.3 8368.2 8809.4 4703.8 4835.1 4839.1 4841.2 4941.4 3495.8 3593.4 3603.5 3604.6 3606.5 603.9 628.9 642.8 653.0 672.8 569.9 632.2 632.9 674.2 697.1 9083.5 9249.4 9255.0 9346.5 9528.6 536.6 548.6 575.3 601.7 702.6 4406.6 4446.5 4467.5 4485.9 4542.5 99906.5 106860.9 113420.4 114740.4 114905.4 94921.0 97589.5 98057.5 98697.5 98750.0 82611.0 84417.6 85833.6 85936.6 86632.0 8442.2 8741.7 8776.0 8796.3 8831.6 36382.5 44887.0 50600.5 52334.5 52636.7 69073.0 73275.3 74325.0 74661.0 76870.8 10729.0 11563.8 11641.1 11975.5 12009.0 12189.1 12336.7 12681.9 12699.4 13280.2 7865.4 12565.5 12656.4 12659.8 12682.8 13471.8 14144.3 14171.6 14234.8 14256.4 13041.0 13471.4 13516.7 13760.3 14152.6 10481.5 10604.3 10676.3 10880.2 11068.2 11190.3 11216.0 11524.1 11644.4 11682.8 14:42:04 INFO - PROCESS | 911 | -------- Summary: end -------- 14:42:04 INFO - PROCESS | 911 | 14:42:05 INFO - TEST-INFO | 911: exit 0 14:42:05 INFO - TEST-OK | dromaeo_css | took 1113547ms 14:42:05 INFO - TEST-START | kraken 14:42:05 INFO - operating with platform_type : linux_ 14:42:05 INFO - Initialising browser for kraken test... 14:42:05 INFO - TEST-INFO | started process 1106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphRbnps/profile http://localhost:33790/getInfo.html) 14:42:09 INFO - PROCESS | 1106 | __metrics Screen width/height:1600/1200 14:42:09 INFO - PROCESS | 1106 | colorDepth:24 14:42:09 INFO - PROCESS | 1106 | Browser inner width/height: 1024/697 14:42:09 INFO - PROCESS | 1106 | __metrics 14:42:10 ERROR - PROCESS | 1106 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:42:11 INFO - TEST-INFO | 1106: exit 0 14:42:11 INFO - Browser initialized. 14:42:11 INFO - Running cycle 1/1 for kraken test... 14:42:11 INFO - TEST-INFO | started process 1257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphRbnps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:22 INFO - PROCESS | 1257 | RSS: Main: 156561408 14:42:22 INFO - PROCESS | 1257 | 14:42:25 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33790/tests/kraken/driver.html?testName=audio-beat-detection) 14:42:26 INFO - PROCESS | 1257 | RSS: Main: 214261760 14:42:26 INFO - PROCESS | 1257 | 14:42:28 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33790/tests/kraken/driver.html?testName=audio-dft) 14:42:29 INFO - PROCESS | 1257 | RSS: Main: 201449472 14:42:29 INFO - PROCESS | 1257 | 14:42:32 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33790/tests/kraken/driver.html?testName=audio-fft) 14:42:33 INFO - PROCESS | 1257 | RSS: Main: 268558336 14:42:33 INFO - PROCESS | 1257 | 14:42:35 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33790/tests/kraken/driver.html?testName=audio-oscillator) 14:42:35 INFO - PROCESS | 1257 | RSS: Main: 178823168 14:42:35 INFO - PROCESS | 1257 | 14:42:38 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33790/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:42:38 INFO - PROCESS | 1257 | RSS: Main: 183267328 14:42:38 INFO - PROCESS | 1257 | 14:42:41 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33790/tests/kraken/driver.html?testName=imaging-darkroom) 14:42:42 INFO - PROCESS | 1257 | RSS: Main: 218370048 14:42:42 INFO - PROCESS | 1257 | 14:42:45 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33790/tests/kraken/driver.html?testName=imaging-desaturate) 14:42:46 INFO - PROCESS | 1257 | RSS: Main: 220295168 14:42:46 INFO - PROCESS | 1257 | 14:42:49 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33790/tests/kraken/driver.html?testName=json-parse-financial) 14:42:49 INFO - PROCESS | 1257 | RSS: Main: 220647424 14:42:49 INFO - PROCESS | 1257 | 14:42:51 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33790/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:42:51 INFO - PROCESS | 1257 | RSS: Main: 206139392 14:42:51 INFO - PROCESS | 1257 | 14:42:53 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:42:54 INFO - PROCESS | 1257 | RSS: Main: 210771968 14:42:54 INFO - PROCESS | 1257 | 14:42:56 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:42:57 INFO - PROCESS | 1257 | RSS: Main: 217497600 14:42:57 INFO - PROCESS | 1257 | 14:42:59 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:00 INFO - PROCESS | 1257 | RSS: Main: 223813632 14:43:00 INFO - PROCESS | 1257 | 14:43:02 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:03 INFO - PROCESS | 1257 | RSS: Main: 225189888 14:43:03 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | Cycle 1(1): loaded http://localhost:33790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33790/tests/kraken/driver.html?testName=ai-astar) 14:43:05 INFO - PROCESS | 1257 | RSS: Main: 266997760 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | __start_tp_report 14:43:05 INFO - PROCESS | 1257 | _x_x_mozilla_page_load 14:43:05 INFO - PROCESS | 1257 | _x_x_mozilla_page_load_details 14:43:05 INFO - PROCESS | 1257 | |i|pagename|runs| 14:43:05 INFO - PROCESS | 1257 | |0;ai-astar;110;104;110;110;110;112;110;109;111;110 14:43:05 INFO - PROCESS | 1257 | |1;audio-beat-detection;156;132;126;182;126;127;163;129;186;125 14:43:05 INFO - PROCESS | 1257 | |2;audio-dft;161;162;161;161;161;160;161;162;160;160 14:43:05 INFO - PROCESS | 1257 | |3;audio-fft;75;75;76;124;75;75;75;74;99;75 14:43:05 INFO - PROCESS | 1257 | |4;audio-oscillator;85;84;110;83;84;85;124;83;84;127 14:43:05 INFO - PROCESS | 1257 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;117;117 14:43:05 INFO - PROCESS | 1257 | |6;imaging-darkroom;147;146;145;146;146;145;147;147;146;145 14:43:05 INFO - PROCESS | 1257 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 14:43:05 INFO - PROCESS | 1257 | |8;json-parse-financial;55;54;54;53;54;53;54;54;54;54 14:43:05 INFO - PROCESS | 1257 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;62;62 14:43:05 INFO - PROCESS | 1257 | |10;stanford-crypto-aes;81;80;84;83;79;80;82;84;109;81 14:43:05 INFO - PROCESS | 1257 | |11;stanford-crypto-ccm;121;132;122;128;119;140;130;123;135;133 14:43:05 INFO - PROCESS | 1257 | |12;stanford-crypto-pbkdf2;165;158;173;162;163;163;158;160;160;160 14:43:05 INFO - PROCESS | 1257 | |13;stanford-crypto-sha256-iterative;65;63;63;64;63;64;63;62;61;62 14:43:05 INFO - PROCESS | 1257 | __end_tp_report 14:43:05 INFO - PROCESS | 1257 | __start_cc_report 14:43:05 INFO - PROCESS | 1257 | _x_x_mozilla_cycle_collect,1639 14:43:05 INFO - PROCESS | 1257 | __end_cc_report 14:43:05 INFO - PROCESS | 1257 | __startTimestamp1464903785419__endTimestamp 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | ------- Summary: start ------- 14:43:05 INFO - PROCESS | 1257 | Number of tests: 14 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 14:43:05 INFO - PROCESS | 1257 | Values: 110.0 104.0 110.0 110.0 110.0 112.0 110.0 109.0 111.0 110.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:144.00 stddev:24.42 (17.0%) stddev-sans-first:25.58 14:43:05 INFO - PROCESS | 1257 | Values: 156.0 132.0 126.0 182.0 126.0 127.0 163.0 129.0 186.0 125.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:43:05 INFO - PROCESS | 1257 | Values: 161.0 162.0 161.0 161.0 161.0 160.0 161.0 162.0 160.0 160.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:16.49 (22.0%) stddev-sans-first:17.27 14:43:05 INFO - PROCESS | 1257 | Values: 75.0 75.0 76.0 124.0 75.0 75.0 75.0 74.0 99.0 75.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:18.08 (21.5%) stddev-sans-first:18.81 14:43:05 INFO - PROCESS | 1257 | Values: 85.0 84.0 110.0 83.0 84.0 85.0 124.0 83.0 84.0 127.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:43:05 INFO - PROCESS | 1257 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 14:43:05 INFO - PROCESS | 1257 | Values: 147.0 146.0 145.0 146.0 146.0 145.0 147.0 147.0 146.0 145.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:43:05 INFO - PROCESS | 1257 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.44 14:43:05 INFO - PROCESS | 1257 | Values: 55.0 54.0 54.0 53.0 54.0 53.0 54.0 54.0 54.0 54.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:43:05 INFO - PROCESS | 1257 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.50 stddev:8.84 (10.9%) stddev-sans-first:9.30 14:43:05 INFO - PROCESS | 1257 | Values: 81.0 80.0 84.0 83.0 79.0 80.0 82.0 84.0 109.0 81.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:131.00 stddev:6.90 (5.3%) stddev-sans-first:6.79 14:43:05 INFO - PROCESS | 1257 | Values: 121.0 132.0 122.0 128.0 119.0 140.0 130.0 123.0 135.0 133.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:4.42 (2.7%) stddev-sans-first:4.57 14:43:05 INFO - PROCESS | 1257 | Values: 165.0 158.0 173.0 162.0 163.0 163.0 158.0 160.0 160.0 160.0 14:43:05 INFO - PROCESS | 1257 | 14:43:05 INFO - PROCESS | 1257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.15 (1.8%) stddev-sans-first:0.97 14:43:05 INFO - PROCESS | 1257 | Values: 65.0 63.0 63.0 64.0 63.0 64.0 63.0 62.0 61.0 62.0 14:43:05 INFO - PROCESS | 1257 | -------- Summary: end -------- 14:43:05 INFO - PROCESS | 1257 | 14:43:06 INFO - TEST-INFO | 1257: exit 0 14:43:06 INFO - TEST-OK | kraken | took 61312ms 14:43:06 INFO - SUITE-END | took 1174s 14:43:06 INFO - Completed test suite (00:19:35) 14:43:06 INFO - javascript benchmark 14:43:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.2894634234126, 3097.6282846058475, 3113.7976031557946, 3140.842957852107, 3159.6208454985403, 5210.9478905210935, 5292.967871265105, 5336.226247194155, 5404.513593776559, 5436.537894278981, 5203.063448579254, 5263.289455923449, 5324.600654950885, 5356.11624082026, 5365.248865158881, 4783.832565860187, 4792.0, 4865.4161500619975, 4881.4874438184015, 5053.191489361703, 4944.87637809054, 4978.576820970222, 5013.298138260647, 5034.370703662043, 5038.168702164138, 4765.189917713997, 4795.376601041859, 4816.373871396713, 4832.4684284728655, 4894.828680996148, 4788.0, 4822.445418776851, 4827.734474603895, 4921.360223171001, 4959.181735013718, 4850.466448690677, 4874.0251949609865, 4875.658703890729, 4879.706877677419, 4894.1679914414635, 5165.457626949154, 5242.370915490127, 5307.124324486455, 5370.946290537084, 5381.730913454312, 5784.652920824764, 5796.101604251306, 5815.534757219412, 5816.505597024258, 5821.476067153934, 5554.444555544454, 5788.189653448479, 5824.330202026778, 5845.064789633639, 5853.1220316952795, 5343.839684809462, 5400.648957817769, 5402.864928376822, 5490.203920431555, 5493.587980901449, 5979.282486101695, 5979.4618484336615, 5986.042233242747, 5990.371011043778, 5994.910076348859, 5474.644148130359, 5580.079286917613, 5675.2054712340305, 5676.262085928885, 5708.628939118944, 5703.030484817591, 5761.798337058183, 5820.738066787005, 5831.591788574844, 5834.533237341003, 5689.601727879091, 5741.712914354265, 5744.885102298014, 5745.540356771448, 5748.45389687979, 5498.120300751861, 5656.038473459522, 5698.914516282259, 5766.509846662997, 5775.913361299584, 4382.233109205877, 4391.077873646506, 4398.318260669601, 4431.889202769957, 4442.622377097983, 3883.3204189266767, 3901.0247438140464, 3905.824237909301, 3929.6070392961046, 3940.802959851996, 5152.124138896396, 5248.921266181011, 5277.709725965032, 5386.8383948481605, 5434.0, 5780.277465316835, 5809.477147056785, 5812.070068789058, 5819.476247137778, 5851.561132915049, 5430.728463576806, 5431.619786614978, 5434.809781657623, 5448.754806033738, 5453.100238460689, 4816.614670826326, 4885.0, 4946.159152944008, 4953.380827396575, 5018.799248030111, 5948.464638182584, 5958.463738263577, 5963.5825492216, 5963.7912673056235, 5966.522678185735, 5758.193852860687, 5783.103618939072, 5784.074548072456, 5798.94201057984, 5802.82591522255, 5765.884682306414, 5880.735366908414, 5947.762089516544, 5985.461308482083, 6050.7277172526465, 5685.34618518859, 5715.685637289989, 5719.28508936383, 5720.313562372542, 5724.284464441945, 5596.748146333506, 5808.070708686759, 5817.476427121579, 5823.5923485355615, 5837.824865254049, 5557.805476808292, 5622.437756224344, 5627.380988091225, 5678.886422271614, 5695.800646977502, 5616.634918730269, 5653.491185793298, 5660.915086273627, 5661.2923384576925, 5667.4615911488345, 5337.759800808895, 5445.53712934405, 5590.496855282881, 5591.105423132442, 5605.131204663121, 5584.916226256691, 5730.283714535683, 5745.597808153389, 5757.165211044459, 5758.193852860519, 5515.917261241005, 5519.31008623922, 5564.944350556604, 5578.972105139448, 5619.466150715675], "value": 5301.9466090874785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7554351628801, 595.627732667083, 599.67018140023, 622.9345918678541, 624.5191202773862, 28464.0, 30894.53658195126, 30943.38113237734, 42295.94260143498, 43580.782096089555, 43402.782986085105, 43506.347404788954, 43680.126397472035, 43727.78136109323, 43975.340369894475, 8411.95794021029, 8547.273481754059, 8561.229489345958, 8572.528510931896, 8592.312614990786, 8321.375896807733, 8420.915790842106, 8421.789455263637, 8432.0, 8459.223563051766, 8719.869201961945, 8770.079141690127, 8780.209781119698, 8780.25367843734, 8794.0, 8677.219050285474, 8718.651253949834, 8726.738197854074, 8733.0, 8747.868781968276, 8619.65521379144, 8687.478751274944, 8688.435251708619, 8692.956535217347, 8697.565121743888, 39893.40159897604, 40312.59687403118, 40314.395284070764, 40357.0, 40375.59624403748, 3315.5689760331, 3338.1821453743746, 3350.6051775751193, 3527.3298073365977, 3540.451230059345, 27684.0, 27845.721542784515, 27930.581041284193, 27947.161585152273, 28923.0, 4034.9394759078637, 4250.0437401584395, 4279.700420970534, 4351.956480435187, 4470.195364834329, 370886.0, 370893.0, 374572.0, 375799.0, 376330.0, 35285.64714352875, 36097.639023609954, 36364.636353636655, 64261.35738642554, 65095.0, 37782.62217377846, 38229.61770382316, 38350.61649383526, 38367.232655346736, 38371.6162838368, 14765.261736913111, 14992.175430351217, 14993.475228366955, 15002.324895379734, 15042.473513427196, 12521.186122901981, 12708.872911270953, 12717.491300347883, 12720.0, 12727.872721272854, 8524.70163544273, 8555.187257210555, 8568.271696905707, 8622.741317760478, 8645.654173832976, 3208.3904058228864, 3208.871645134215, 3225.967740322567, 3240.9837950810097, 3250.333681595267, 1032.8759262740246, 1046.858674079005, 1060.867391576053, 1109.290054365207, 1133.1557989298026, 33094.66905330964, 33141.3371732564, 33355.0, 33368.66631333704, 33466.226334632454, 1141.931484110956, 1145.7479354541988, 1174.2484809721784, 1203.296071798008, 1254.3978890132605, 17282.567935801704, 17292.0, 17485.30058797659, 17494.0, 17547.0, 573121.0, 573606.0, 576898.0, 578950.0, 582109.0, 60578.0, 61055.0, 61102.0, 61156.38843611507, 61198.082028769604, 1257.5912828330647, 1338.6519504928788, 1380.5720226729745, 1386.182152529992, 1399.7270532246114, 32797.86813857091, 34602.0, 34643.307133857685, 34682.30635387329, 35066.824665876506, 50051.749741251064, 50537.0, 50685.23972140495, 50709.74645126751, 50795.4125046252, 422559.0, 424002.0, 424377.0, 424915.0, 424917.0, 24510.509789804462, 24640.876795615906, 26181.869090654425, 26601.0, 26604.201873943814, 42827.357589635554, 43524.56475435332, 48731.512684872694, 49052.75473622609, 50412.0, 40762.59237407588, 41817.37273940954, 42017.57982420137, 42264.577354226065, 42732.14535709331, 40614.79692601518, 40793.0, 40932.0, 41783.37324940189, 42126.36810447784, 42010.0, 42389.0, 42498.36252456154, 42510.78744606381, 42895.1420971585, 35841.64158358383, 37403.81298093492, 38455.61544384521, 38506.229875401776, 38875.416868746426, 28513.28716782097, 28891.711082889742, 29074.20508783622, 29305.85347073251, 29493.557596635637], "value": 18737.12340537365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.99404508932355, 401.63451259353957, 401.6465510350891, 406.743751436595, 413.00107479797794, 12935.850000721706, 18151.0, 18921.432357029313, 19757.110930008148, 19773.40679779607, 17256.482305530822, 17301.39445119418, 17466.214020369083, 17769.37807176749, 18278.908605456953, 5574.693391863456, 5728.455796699307, 5767.452092051249, 5773.797917072903, 5780.53755699543, 5668.858278543049, 5682.403347648499, 5718.71406429679, 5720.141978703207, 5723.51350135239, 4168.5623009584015, 6042.425969532887, 6338.112664226989, 6342.87314253717, 6477.449416799578, 5517.5585953123655, 5849.093390524476, 6410.262819775716, 6459.6447195404235, 6462.483001359903, 5721.256236689245, 5728.25532680753, 5730.570207234474, 5753.338366087912, 5759.48164665178, 13564.389602467912, 15807.0, 21046.473838154016, 23306.184283550163, 23340.183093591644, 2292.4727312718, 2353.329301149164, 2378.108209421467, 2478.120267305099, 2482.3669964159026, 9880.604775808959, 9960.904300526936, 10042.096211341015, 10392.480375981246, 10450.425226612533, 1834.660587791263, 1951.7755458122215, 1986.4437957371815, 2011.9195232190696, 2016.3043749906258, 59749.0, 62209.0, 75808.62095689487, 82999.5850020746, 84069.0, 10958.232923695265, 10967.725806854733, 11281.94359028216, 11353.432328383547, 11376.772464550662, 15539.0, 15590.688186236212, 15628.062316261061, 15652.92173539125, 15662.373505059897, 7933.563653999086, 8090.757277281691, 8196.34429245659, 8342.082370939192, 8398.664053437917, 7652.120006199359, 7696.807579810549, 7804.492707973964, 7861.842763144705, 8032.1164671886045, 4247.447831781848, 4251.59609837065, 4720.221163508051, 4749.26386410107, 4861.927071093936, 1867.1784414857418, 1975.5851271232914, 1991.3727175939532, 1995.4512509060125, 2001.5296405344732, 951.3340661536813, 959.8800149981253, 975.707287813653, 1006.7785087280787, 1012.4684540616236, 18504.259829606934, 18550.0, 18659.81340186581, 19083.04584770756, 19279.710804337945, 915.4919019943862, 1015.1878497202356, 1030.5002073994108, 1058.25921854702, 1072.3619446429361, 10319.48402579868, 10885.129189664965, 10955.616553420592, 10976.067034302174, 10994.560217591366, 388002.0, 391589.0, 501153.0, 508341.0, 508493.0, 96193.0, 97257.51371243098, 98719.50640246752, 100292.4985375083, 100821.0, 1036.1762398892747, 1052.7736536644659, 1073.8765042020268, 1079.1959989807644, 1086.1962148010573, 15844.76232856485, 16398.508044758677, 16399.672006559562, 16443.177841108136, 16514.339426422808, 34661.826690866386, 37748.2450350986, 39032.0, 40712.38931415972, 42946.78526607347, 51484.0, 52224.738876306896, 54285.45714542962, 55727.16409253945, 58784.4121558796, 8044.919550804417, 8115.715949941724, 8271.95864020676, 8276.586170691562, 8581.914180858112, 12289.938550307548, 12787.936060319638, 12853.42159602839, 12958.416871241005, 13000.349982500647, 10932.56269749201, 11095.389753563632, 11341.432928353714, 11505.482253298454, 11778.0, 10914.181436392144, 11172.944135279271, 11185.72035699114, 11633.59282425111, 11736.941315293368, 11379.374134422686, 11502.48238829238, 11581.536738530702, 11827.231229970368, 12218.14472986918, 8275.462094963808, 8340.833183336177, 8380.12008739098, 8382.958085209535, 8418.158184181533, 8580.828383432172, 11793.11551633648, 11823.467943942715, 11887.405629718653, 11917.880821192024], "value": 9069.45971004716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.9684507887307, 1468.2438544149759, 1510.3958416633345, 1681.9243134058966, 1811.5018369948264, 8421.621027053781, 8732.30141588673, 8784.736457906258, 9071.183593476586, 9073.092690730924, 9081.545922703855, 9292.767680807983, 9299.48852813095, 9301.209397201246, 9301.488418137, 2108.8629239099487, 2361.645753137026, 2387.594109001474, 2426.8665223412704, 2427.890744916474, 2452.852828830267, 2462.5444292805887, 2465.3220364399754, 2468.1854987853967, 2468.456939473322, 2375.5605213035556, 2379.95240095198, 2422.7456117107713, 2435.768601982809, 2439.743826898177, 2016.3950814755588, 2275.3515248154195, 2329.4292898239955, 2334.043042352644, 2344.788968992782, 2378.595638741418, 2382.6187809950325, 2384.5588566115325, 2392.9282121536207, 2397.7722116398913, 9264.907350926473, 9321.813563728756, 9350.392224505385, 9350.67272645454, 9354.20489258407, 5424.213489044067, 5567.721613919288, 5584.106542953149, 5585.2459917910965, 5586.804461843856, 3267.558879551254, 3419.9316013679836, 3441.1913200397885, 3486.3027394521196, 3488.354654388946, 1147.7302833834042, 1155.4684844971239, 1188.1860925266221, 1202.1044321980094, 1208.3354155214686, 13372.665683357995, 13382.063255572113, 13392.799108013387, 13393.06248562601, 13413.66465838352, 4825.348577942003, 4965.379327584052, 4995.500449955048, 4997.900041999213, 5041.546260836542, 11042.392668403316, 11069.778604428027, 11085.224034317682, 11086.22396432242, 11091.0, 5616.9157462638095, 5619.129034999582, 5623.606347555632, 5627.634203776742, 5627.662340259598, 4438.689291749611, 4945.579625731853, 5055.570276526537, 5071.746412679351, 5182.378114626269, 4102.425660407545, 4167.395727619539, 4174.019105510202, 4262.573742625713, 4263.744175349489, 1283.4224598930518, 1314.6056183145017, 1315.7171208190284, 1327.4491086199118, 1332.7534406134896, 877.5042101212795, 976.9546585153818, 1023.3655133817081, 1031.3296357367772, 1066.914646828252, 6135.14108024868, 6309.92731235691, 6332.176817013851, 6341.904871426932, 6499.675016249169, 909.6178713158279, 937.3906960475746, 949.2548349545574, 955.9808803823885, 968.2060710217554, 4170.124273902515, 4262.808173632132, 4285.785710714452, 4319.956800431955, 4327.978360108179, 11437.885621143849, 11536.365499897585, 11929.463174157183, 11935.045196384268, 11962.521499140112, 11591.710207244887, 11720.648380548597, 11737.589184378507, 11741.29552226869, 11742.765144697058, 8453.070162282267, 8463.66145354179, 8529.488230706178, 8712.0416754157, 8787.077356877437, 5880.294364676266, 5918.940810592011, 6019.4883434908525, 6091.0558863376245, 6106.938930610637, 10368.637097701545, 10720.839187412352, 10809.67570972872, 10851.620193293196, 10874.67375978722, 10934.45327733626, 11005.609847959218, 11057.115430765358, 11129.387883666475, 11146.88853111491, 6900.551464154814, 7419.740309089156, 7524.962375188089, 7632.0, 7647.847043059219, 9045.819083618422, 9051.637934482547, 9131.858517685288, 9143.497107659143, 9144.679936202201, 7709.8843517348405, 7715.92284077152, 7974.681012759656, 8029.59852007409, 8080.232377924088, 7830.804229894298, 7885.6845726172605, 7993.8401231976195, 8019.799505012421, 8049.114597394165, 7255.782326530212, 7350.19147893742, 7354.117505899327, 7448.9627551861895, 7465.888011679937, 5330.920036199538, 5344.35867695879, 5416.75624596902, 5467.617266791445, 5600.047991841316, 5240.737963101754, 5299.576033917355, 5443.455654434525, 5471.589630777628, 5712.914306285326], "value": 4837.408608264854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.5307178055929, 328.6155198417851, 334.1362577736551, 335.55538910943005, 338.5395861628187, 5258.815941442051, 5303.310569625953, 5319.255304257402, 5355.6610847288175, 5397.46025397461, 5232.895342093156, 5284.365876094874, 5310.964361949422, 5317.867053323669, 5334.146536554152, 4193.517745459273, 4197.223513649985, 4208.431861698662, 4210.3684447332835, 4226.619604235618, 3966.6909919726563, 4045.5145382554133, 4183.7489750614905, 4205.179989901971, 4205.5794420558, 4128.21563902859, 4134.855280065199, 4139.461869956916, 4150.896227594304, 4162.83348666053, 3969.384745364473, 4148.066684995867, 4159.147374788176, 4174.290370636969, 4176.436181115571, 3626.165981824195, 3713.6100709425664, 3719.609441008682, 3739.691108112166, 3745.4194599836796, 5108.565771909392, 5109.135165664543, 5129.692218466904, 5141.151709967889, 5179.585633149339, 4567.794449249792, 4769.0, 4789.425268967711, 4799.904001919977, 4812.494688057774, 5511.22842802008, 5526.889462210734, 5531.921275351308, 5536.806211782608, 5544.251526043973, 3995.900102497432, 4018.819153138116, 4058.817353219112, 4060.533038700558, 4073.368627862686, 5491.395946445888, 5701.315842098933, 5735.050082971809, 5743.2246646703, 5754.0, 4026.939595906064, 4028.2749105160765, 4033.9798301008896, 4040.5150832237964, 4054.4729185205733, 4063.6139566741113, 4074.3277359235985, 4081.3673880548563, 4130.896727581834, 4135.8966025848995, 4688.249880019181, 4705.482396936334, 4728.1252968201, 4731.101090792738, 4736.644751643572, 5413.945860541423, 5512.33851937762, 5533.750981205855, 5547.278853748987, 5570.554355651539, 1389.423389293432, 1406.1703594878866, 1419.936102875373, 1424.480064776349, 1425.7790042543422, 881.316979341003, 907.0974380491454, 921.8432866412726, 922.064104933493, 926.935114541989, 4708.246680531099, 4778.331033655291, 4782.760861956888, 5030.346055012825, 5116.441779110445, 5660.490555849993, 5703.600747947687, 5719.828405147852, 5744.396838331915, 5770.701592141734, 5293.8088929990445, 5340.626156169109, 5347.919781203207, 5364.570834333244, 5366.946330536644, 2914.9271268218463, 3011.488047031966, 3039.0, 3051.3897220555978, 3055.8777648893797, 5899.911501327483, 5928.4960778334325, 5930.005347299586, 5932.525397968238, 5936.5250779937505, 5542.584306177053, 5754.906567752114, 5811.15738217956, 5848.502877255481, 5861.5603829712945, 5883.235179426647, 5885.6468611882565, 5888.735006924699, 5896.233489646404, 5923.555733319932, 5670.894175635712, 5675.318961724454, 5717.285339332583, 5722.313322401338, 5736.110902810071, 5373.6238463308755, 5608.327000759772, 5697.521578113534, 5725.971370143289, 5727.599068065362, 5870.677112758839, 5901.259128557172, 5907.940920590739, 5910.349861515144, 5913.704314784158, 4038.273110840077, 4046.765736450293, 4052.7163098582814, 4052.8986775330854, 4090.4682391288943, 5521.503064724034, 5759.107338362561, 5767.8558036049435, 5769.740361683818, 5790.363060063305, 5570.303712035996, 5586.4916472552995, 5603.355614104267, 5621.943780562142, 5643.35101463337, 5410.540104091197, 5461.235427040297, 5551.056320425457, 5583.35791383996, 5608.943910561005, 5469.808556700496, 5494.2582751328055, 5508.44915508446, 5512.448755124456, 5523.530499907552, 5383.519532128696, 5409.404965453718, 5590.413006634245, 5621.775128994958, 5631.915521267102, 5458.2904222450825, 5461.754221060141, 5493.835184944458, 5507.981023510663, 5528.640638358494], "value": 4233.757689892375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.2389902551832, 756.1870988687162, 766.7515853979512, 798.8442253760517, 833.7415401225622, 14678.192699401528, 14689.706205875877, 14708.411663533472, 14739.336729847157, 14764.261786910653, 14471.34878930448, 14798.556043318718, 14962.551123466286, 15002.624934376647, 15186.54440366788, 799.5442597719288, 807.9272865442109, 813.7070654564352, 814.1329484099415, 815.0830315894618, 460.07065727230975, 530.8805518758287, 533.3972610949621, 822.8683410654296, 827.7433995461427, 869.7782065573301, 871.4161511787117, 872.2062922740307, 873.2577309287087, 873.7771868173638, 870.5603670146598, 871.2072014466836, 871.4379225399614, 871.877937088808, 872.0233338660709, 526.557691539109, 618.8421952402109, 621.4065567383138, 623.0342968398963, 629.3423372575669, 14732.705345893022, 14810.185439800807, 14925.701485970329, 14931.626709332246, 14991.0, 13088.738225235442, 14076.225807580578, 14090.154590724487, 14268.785968210484, 14502.782458263135, 12167.695807604792, 12748.0, 12821.871781282161, 12919.483220671162, 13053.0, 4353.456616767797, 4390.978045109786, 4459.888502787424, 4489.865304040884, 4497.775111244425, 74090.62954685192, 74114.25885741127, 74783.0, 74982.62508687422, 80694.19305806926, 10827.404492752818, 10879.347239165676, 10965.780684386267, 11177.83233251502, 11242.0, 20396.0, 20575.176992920417, 20590.897045514677, 20642.483937901674, 20976.685349719766, 8099.554524501209, 8155.10293867674, 8200.26197642215, 8368.24685778283, 8809.42738721981, 4703.811847526061, 4835.105505481427, 4839.128956787812, 4841.201201801734, 4941.357623508921, 3495.7727747696317, 3593.407087830531, 3603.4955106285142, 3604.6395360463744, 3606.4590311452966, 603.9449805131081, 628.8773689130667, 642.7686033028106, 652.9934700653027, 672.8385187554951, 569.9344575373885, 632.2318383164477, 632.8987362022146, 674.1909708349999, 697.052009267396, 9083.45499270046, 9249.385253056347, 9255.0, 9346.48594327305, 9528.571214295234, 536.5948708724966, 548.5666323604388, 575.2952633024595, 601.6931365003879, 702.5714314268292, 4406.62543683784, 4446.533114022981, 4467.530909254547, 4485.932711009337, 4542.545745425431, 99906.5004674972, 106860.87004038833, 113420.43289783664, 114740.42629786965, 114905.4254728721, 94921.0, 97589.51205244071, 98057.50971245098, 98697.50651246698, 98750.0, 82611.0, 84417.57791211005, 85833.5708321467, 85936.57031714926, 86632.0, 8442.246029181282, 8741.737747867573, 8776.0, 8796.340274479568, 8831.602577883883, 36382.454263186606, 44887.0, 50600.49399505958, 52334.47665523296, 52636.73681631567, 69073.0, 73275.26724732897, 74325.0, 74661.0, 76870.84693729486, 10729.0, 11563.826542602035, 11641.126915481203, 11975.520979160736, 12009.0, 12189.14675972709, 12336.691582710504, 12681.873181268069, 12699.365031748192, 13280.203187808762, 7865.410094243069, 12565.497380105058, 12656.43046062911, 12659.81010284828, 12682.809757853824, 13471.797923030967, 14144.292785360896, 14171.64570885736, 14234.786478203043, 14256.358463868943, 13041.0, 13471.393787279792, 13516.662083447993, 13760.31198440094, 14152.646183845074, 10481.475926203811, 10604.310719803496, 10676.252662313875, 10880.183986201226, 11068.169887258327, 11190.272632278877, 11216.0, 11524.13568982313, 11644.41777911118, 11682.76634467323], "value": 7322.063710734988, "unit": "score"}], "name": "dromaeo_css", "value": 7163.448436196379, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 110.0, 110.0, 112.0, 110.0, 109.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 126.0, 182.0, 126.0, 127.0, 163.0, 129.0, 186.0, 125.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 124.0, 75.0, 75.0, 75.0, 74.0, 99.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 110.0, 83.0, 84.0, 85.0, 124.0, 83.0, 84.0, 127.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 84.0, 83.0, 79.0, 80.0, 82.0, 84.0, 109.0, 81.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 132.0, 122.0, 128.0, 119.0, 140.0, 130.0, 123.0, 135.0, 133.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 158.0, 173.0, 162.0, 163.0, 163.0, 158.0, 160.0, 160.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 62.0, 61.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1504.7, "alertThreshold": 2.0}]} 14:43:06 INFO - Return code: 0 14:43:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:43:06 ERROR - # TBPL SUCCESS # 14:43:06 INFO - Running post-action listener: _resource_record_post_action 14:43:06 INFO - ##### 14:43:06 INFO - ##### Finished run-tests step (success) 14:43:06 INFO - ##### 14:43:06 INFO - Running post-run listener: _resource_record_post_run 14:43:06 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539881472; Read time: 12; Write time: 443976 14:43:06 INFO - TinderboxPrint: CPU usage
13.2% 14:43:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:43:06 INFO - TinderboxPrint: I/O write bytes / time
539,881,472 / 443,976 14:43:06 INFO - TinderboxPrint: CPU idle
8,267.4 (86.8%) 14:43:06 INFO - TinderboxPrint: CPU user
1,208.9 (12.7%) 14:43:06 INFO - TinderboxPrint: Swap in / out
0 / 0 14:43:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247906304; Read time: 0; Write time: 239836 14:43:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291794944; Read time: 12; Write time: 204112 14:43:07 INFO - Running post-run listener: _upload_blobber_files 14:43:07 INFO - Blob upload gear active. 14:43:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:07 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 14:43:07 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:43:07 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:43:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:08 INFO - (blobuploader) - INFO - Done attempting. 14:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:13 INFO - (blobuploader) - INFO - Done attempting. 14:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:14 INFO - (blobuploader) - INFO - Done attempting. 14:43:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:14 INFO - Return code: 0 14:43:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f218627460d9268c74abccffb02e65e0a2abc589a9a4bdfced0328aca649b71ee2ad6f1bbddd4b077d229e086522bc46fd5b39780f26ffbfada39a91c8391420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b44155960b48dc79a170f84c52d9d9d832ba7576856ccbec89d93389dea1a0fc9b1d0e96c02c25ce31a6b3e2ed8092d086b58ea6225cd2b260361ab5494e74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e095e02bce1482ff1ff953c8b7736809e9091f174c022aa0d7554b3affa7f7ddec92d71bd0c6a4401b5ae04c00d04d1eb3be64605b69b7b55a144556fd2227b9"} 14:43:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:14 INFO - Contents: 14:43:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f218627460d9268c74abccffb02e65e0a2abc589a9a4bdfced0328aca649b71ee2ad6f1bbddd4b077d229e086522bc46fd5b39780f26ffbfada39a91c8391420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b44155960b48dc79a170f84c52d9d9d832ba7576856ccbec89d93389dea1a0fc9b1d0e96c02c25ce31a6b3e2ed8092d086b58ea6225cd2b260361ab5494e74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e095e02bce1482ff1ff953c8b7736809e9091f174c022aa0d7554b3affa7f7ddec92d71bd0c6a4401b5ae04c00d04d1eb3be64605b69b7b55a144556fd2227b9"} 14:43:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:14 INFO - Copying logs to upload dir... 14:43:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.777887 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-02 14:43:13.624096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 14:43:13.628300) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f218627460d9268c74abccffb02e65e0a2abc589a9a4bdfced0328aca649b71ee2ad6f1bbddd4b077d229e086522bc46fd5b39780f26ffbfada39a91c8391420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b44155960b48dc79a170f84c52d9d9d832ba7576856ccbec89d93389dea1a0fc9b1d0e96c02c25ce31a6b3e2ed8092d086b58ea6225cd2b260361ab5494e74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e095e02bce1482ff1ff953c8b7736809e9091f174c022aa0d7554b3affa7f7ddec92d71bd0c6a4401b5ae04c00d04d1eb3be64605b69b7b55a144556fd2227b9"} build_url:https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f218627460d9268c74abccffb02e65e0a2abc589a9a4bdfced0328aca649b71ee2ad6f1bbddd4b077d229e086522bc46fd5b39780f26ffbfada39a91c8391420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b44155960b48dc79a170f84c52d9d9d832ba7576856ccbec89d93389dea1a0fc9b1d0e96c02c25ce31a6b3e2ed8092d086b58ea6225cd2b260361ab5494e74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e095e02bce1482ff1ff953c8b7736809e9091f174c022aa0d7554b3affa7f7ddec92d71bd0c6a4401b5ae04c00d04d1eb3be64605b69b7b55a144556fd2227b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 14:43:13.661003) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:43:13.661586) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464902556.958367-1122961305 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:43:13.747011) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 14:43:13.747534) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 14:43:13.748047) ========= ========= Total master_lag: 0.19 =========