builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1464901945.38 results: success (0) buildid: 20160602113028 builduid: afa9f52536ef44fe991ffd37bd8e46a8 revision: 91879ebba4d61fde72af13223708faa01109a4d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.375727) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.376196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.376485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.390811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.391091) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 14:12:25-- 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% 81.4M=0s 2016-06-02 14:12:25 (81.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128902 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.534107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.534423) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020550 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:25.583302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 14:12:25.583668) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 14:12:25,604 truncating revision to first 12 chars 2016-06-02 14:12:25,604 Setting DEBUG logging. 2016-06-02 14:12:25,604 attempt 1/10 2016-06-02 14:12:25,604 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:12:26,850 unpacking tar archive at: fx-team-91879ebba4d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.574463 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 14:12:27.174550) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:27.174866) ========= script_repo_revision: 91879ebba4d61fde72af13223708faa01109a4d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:27.175262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:27.175621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 14:12:27.186817) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-02 14:12:27.187192) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:12:27 INFO - MultiFileLogger online at 20160602 14:12:27 in /builds/slave/test 14:12:27 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:12:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:12:27 INFO - {'append_to_log': False, 14:12:27 INFO - 'base_work_dir': '/builds/slave/test', 14:12:27 INFO - 'blob_upload_branch': 'Fx-Team', 14:12:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:12:27 INFO - 'branch': 'Fx-Team', 14:12:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:27 INFO - 'config_files': ('talos/linux_config.py',), 14:12:27 INFO - 'default_actions': ('clobber', 14:12:27 INFO - 'read-buildbot-config', 14:12:27 INFO - 'download-and-extract', 14:12:27 INFO - 'populate-webroot', 14:12:27 INFO - 'create-virtualenv', 14:12:27 INFO - 'install', 14:12:27 INFO - 'run-tests'), 14:12:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:27 INFO - 'download_minidump_stackwalk': True, 14:12:27 INFO - 'download_symbols': 'ondemand', 14:12:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:27 INFO - 'installer_path': 'installer.exe', 14:12:27 INFO - 'log_level': 'info', 14:12:27 INFO - 'log_name': 'talos', 14:12:27 INFO - 'log_to_console': True, 14:12:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:12:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:12:27 INFO - 'opt_config_files': (), 14:12:27 INFO - 'pip_index': False, 14:12:27 INFO - 'sps_profile': False, 14:12:27 INFO - 'sps_profile_interval': 0, 14:12:27 INFO - 'suite': 'dromaeojs', 14:12:27 INFO - 'system_bits': '32', 14:12:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:27 INFO - 'title': 'talos-linux64-ix-033', 14:12:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:27 INFO - 'use_talos_json': True, 14:12:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:12:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:27 INFO - 'work_dir': 'build'} 14:12:27 INFO - ##### 14:12:27 INFO - ##### Running clobber step. 14:12:27 INFO - ##### 14:12:27 INFO - Running pre-action listener: _resource_record_pre_action 14:12:27 INFO - Running main action method: clobber 14:12:27 INFO - rmtree: /builds/slave/test/build 14:12:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:12:28 INFO - Running post-action listener: _resource_record_post_action 14:12:28 INFO - ##### 14:12:28 INFO - ##### Finished clobber step (success) 14:12:28 INFO - ##### 14:12:28 INFO - ##### 14:12:28 INFO - ##### Running read-buildbot-config step. 14:12:28 INFO - ##### 14:12:28 INFO - Running pre-action listener: _resource_record_pre_action 14:12:28 INFO - Running main action method: read_buildbot_config 14:12:28 INFO - Using buildbot properties: 14:12:28 INFO - { 14:12:28 INFO - "project": "", 14:12:28 INFO - "product": "firefox", 14:12:28 INFO - "script_repo_revision": "production", 14:12:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:12:28 INFO - "repository": "", 14:12:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:12:28 INFO - "buildid": "20160602113028", 14:12:28 INFO - "pgo_build": "True", 14:12:28 INFO - "basedir": "/builds/slave/test", 14:12:28 INFO - "buildnumber": 758, 14:12:28 INFO - "slavename": "talos-linux64-ix-033", 14:12:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:12:28 INFO - "platform": "ubuntu64_hw", 14:12:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:12:28 INFO - "branch": "fx-team", 14:12:28 INFO - "repo_path": "integration/fx-team", 14:12:28 INFO - "revision": "91879ebba4d61fde72af13223708faa01109a4d9", 14:12:28 INFO - "stage_platform": "linux64-pgo", 14:12:28 INFO - "builduid": "afa9f52536ef44fe991ffd37bd8e46a8", 14:12:28 INFO - "slavebuilddir": "test" 14:12:28 INFO - } 14:12:28 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:12:28 INFO - Running post-action listener: _resource_record_post_action 14:12:28 INFO - ##### 14:12:28 INFO - ##### Finished read-buildbot-config step (success) 14:12:28 INFO - ##### 14:12:28 INFO - ##### 14:12:28 INFO - ##### Running download-and-extract step. 14:12:28 INFO - ##### 14:12:28 INFO - Running pre-action listener: _resource_record_pre_action 14:12:28 INFO - Running main action method: download_and_extract 14:12:28 INFO - mkdir: /builds/slave/test/build/tests 14:12:28 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:12:28 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:12:28 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:12:28 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:12:28 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:12:28 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:12:28 INFO - Downloaded 1361 bytes. 14:12:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:12:28 INFO - Using the following test package requirements: 14:12:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:12:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:12:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'jsshell-linux-x86_64.zip'], 14:12:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:12:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:12:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:12:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:12:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:12:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:12:28 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:12:28 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:12:28 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:12:28 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:12:28 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:12:28 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:12:30 INFO - Downloaded 24439699 bytes. 14:12:30 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:12:30 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:12:31 INFO - Return code: 0 14:12:31 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:12:31 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:12:31 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:12:31 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:12:31 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:12:31 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:12:31 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:12:32 INFO - Downloaded 24439699 bytes. 14:12:32 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:12:32 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:12:34 INFO - Return code: 0 14:12:34 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:12:34 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:12:34 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:12:34 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:12:34 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:12:34 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:12:35 INFO - Downloaded 10834055 bytes. 14:12:35 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:12:35 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:12:35 INFO - Return code: 0 14:12:35 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:12:35 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:12:35 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:12:35 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:12:35 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:12:35 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:12:36 INFO - Downloaded 59072825 bytes. 14:12:36 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:12:36 INFO - mkdir: /builds/slave/test/properties 14:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 14:12:36 INFO - Contents: 14:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/OVxqtbIETwqDOntHP21vtQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:12:37 INFO - Running post-action listener: _resource_record_post_action 14:12:37 INFO - Running post-action listener: set_extra_try_arguments 14:12:37 INFO - ##### 14:12:37 INFO - ##### Finished download-and-extract step (success) 14:12:37 INFO - ##### 14:12:37 INFO - ##### 14:12:37 INFO - ##### Running populate-webroot step. 14:12:37 INFO - ##### 14:12:37 INFO - Running pre-action listener: _resource_record_pre_action 14:12:37 INFO - Running main action method: populate_webroot 14:12:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:12:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:12:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:12:37 INFO - '--tppagecycles', 14:12:37 INFO - '7'], 14:12:37 INFO - 'tests': ['tsvgm']}}, 14:12:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:12:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:12:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:12:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:12:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['damp', 'tps']}, 14:12:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'tests': ['damp', 'tps']}, 14:12:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['dromaeo_dom']}, 14:12:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:12:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['a11yr', 14:12:37 INFO - 'ts_paint', 14:12:37 INFO - 'tpaint', 14:12:37 INFO - 'sessionrestore', 14:12:37 INFO - 'sessionrestore_no_auto_restore', 14:12:37 INFO - 'tabpaint']}, 14:12:37 INFO - 'other-e10s': {'tests': ['a11yr', 14:12:37 INFO - 'ts_paint', 14:12:37 INFO - 'tpaint', 14:12:37 INFO - 'sessionrestore', 14:12:37 INFO - 'sessionrestore_no_auto_restore', 14:12:37 INFO - 'tabpaint']}, 14:12:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:12:37 INFO - 'ts_paint', 14:12:37 INFO - 'tpaint', 14:12:37 INFO - 'sessionrestore', 14:12:37 INFO - 'sessionrestore_no_auto_restore', 14:12:37 INFO - 'tabpaint']}, 14:12:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:12:37 INFO - 'ts_paint', 14:12:37 INFO - 'tpaint', 14:12:37 INFO - 'sessionrestore', 14:12:37 INFO - 'sessionrestore_no_auto_restore', 14:12:37 INFO - 'tabpaint']}, 14:12:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['a11yr', 14:12:37 INFO - 'ts_paint', 14:12:37 INFO - 'tpaint', 14:12:37 INFO - 'sessionrestore', 14:12:37 INFO - 'sessionrestore_no_auto_restore', 14:12:37 INFO - 'tabpaint']}, 14:12:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['a11yr', 14:12:37 INFO - 'ts_paint', 14:12:37 INFO - 'tpaint', 14:12:37 INFO - 'sessionrestore', 14:12:37 INFO - 'sessionrestore_no_auto_restore', 14:12:37 INFO - 'tabpaint']}, 14:12:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['tsvgx', 14:12:37 INFO - 'tsvgr_opacity', 14:12:37 INFO - 'tart', 14:12:37 INFO - 'tscrollx', 14:12:37 INFO - 'cart']}, 14:12:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:12:37 INFO - 'tsvgr_opacity', 14:12:37 INFO - 'tart', 14:12:37 INFO - 'tscrollx', 14:12:37 INFO - 'cart']}, 14:12:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'talos_options': ['--disable-e10s'], 14:12:37 INFO - 'tests': ['tp5o']}, 14:12:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'tests': ['tp5o']}, 14:12:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'talos_options': ['--disable-e10s', 14:12:37 INFO - '--xperf_path', 14:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:37 INFO - 'tests': ['tp5n']}, 14:12:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:37 INFO - 'talos_options': ['--xperf_path', 14:12:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:37 INFO - 'tests': ['tp5n']}}, 14:12:37 INFO - 'talos.zip': {'path': '', 14:12:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:12:37 INFO - Running post-action listener: _resource_record_post_action 14:12:37 INFO - ##### 14:12:37 INFO - ##### Finished populate-webroot step (success) 14:12:37 INFO - ##### 14:12:37 INFO - ##### 14:12:37 INFO - ##### Running create-virtualenv step. 14:12:37 INFO - ##### 14:12:37 INFO - Running pre-action listener: _resource_record_pre_action 14:12:37 INFO - Running main action method: create_virtualenv 14:12:37 INFO - Creating virtualenv /builds/slave/test/build/venv 14:12:37 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:12:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:12:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:12:37 INFO - Using real prefix '/usr' 14:12:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:12:38 INFO - Installing distribute.............................................................................................................................................................................................done. 14:12:40 INFO - Installing pip.................done. 14:12:40 INFO - Return code: 0 14:12:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:12: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:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:40 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:40 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:12:40 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:12:40 INFO - Using env: {'DISPLAY': ':0', 14:12:40 INFO - 'HOME': '/home/cltbld', 14:12:40 INFO - 'LANG': 'en_US.UTF-8', 14:12:40 INFO - 'LANGUAGE': 'en_US:en', 14:12:40 INFO - 'LOGNAME': 'cltbld', 14:12:40 INFO - 'MAIL': '/var/mail/cltbld', 14:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:40 INFO - 'MOZ_NO_REMOTE': '1', 14:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:40 INFO - 'NO_EM_RESTART': '1', 14:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:40 INFO - 'PWD': '/builds/slave/test', 14:12:40 INFO - 'SHELL': '/bin/bash', 14:12:40 INFO - 'SHLVL': '1', 14:12:40 INFO - 'TERM': 'linux', 14:12:40 INFO - 'TMOUT': '86400', 14:12:40 INFO - 'USER': 'cltbld', 14:12:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:40 INFO - '_': '/tools/buildbot/bin/python'} 14:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:40 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:12:40 INFO - Cleaning up... 14:12:40 INFO - Return code: 0 14:12:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:12: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:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:40 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:40 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:12:40 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:12:40 INFO - Using env: {'DISPLAY': ':0', 14:12:40 INFO - 'HOME': '/home/cltbld', 14:12:40 INFO - 'LANG': 'en_US.UTF-8', 14:12:40 INFO - 'LANGUAGE': 'en_US:en', 14:12:40 INFO - 'LOGNAME': 'cltbld', 14:12:40 INFO - 'MAIL': '/var/mail/cltbld', 14:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:40 INFO - 'MOZ_NO_REMOTE': '1', 14:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:40 INFO - 'NO_EM_RESTART': '1', 14:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:40 INFO - 'PWD': '/builds/slave/test', 14:12:40 INFO - 'SHELL': '/bin/bash', 14:12:40 INFO - 'SHLVL': '1', 14:12:40 INFO - 'TERM': 'linux', 14:12:40 INFO - 'TMOUT': '86400', 14:12:40 INFO - 'USER': 'cltbld', 14:12:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:40 INFO - '_': '/tools/buildbot/bin/python'} 14:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:40 INFO - Downloading/unpacking psutil>=3.1.1 14:12:40 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:12:40 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:12:40 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:12:40 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:12:40 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:12:40 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:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:42 INFO - Installing collected packages: psutil 14:12:42 INFO - Running setup.py install for psutil 14:12:42 INFO - building 'psutil._psutil_linux' extension 14:12:42 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:12:42 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:12:42 INFO - building 'psutil._psutil_posix' extension 14:12:42 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:12:43 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:12:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:43 INFO - Successfully installed psutil 14:12:43 INFO - Cleaning up... 14:12:43 INFO - Return code: 0 14:12:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:12: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:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:43 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:43 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:12:43 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:12:43 INFO - Using env: {'DISPLAY': ':0', 14:12:43 INFO - 'HOME': '/home/cltbld', 14:12:43 INFO - 'LANG': 'en_US.UTF-8', 14:12:43 INFO - 'LANGUAGE': 'en_US:en', 14:12:43 INFO - 'LOGNAME': 'cltbld', 14:12:43 INFO - 'MAIL': '/var/mail/cltbld', 14:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:43 INFO - 'MOZ_NO_REMOTE': '1', 14:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:43 INFO - 'NO_EM_RESTART': '1', 14:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:43 INFO - 'PWD': '/builds/slave/test', 14:12:43 INFO - 'SHELL': '/bin/bash', 14:12:43 INFO - 'SHLVL': '1', 14:12:43 INFO - 'TERM': 'linux', 14:12:43 INFO - 'TMOUT': '86400', 14:12:43 INFO - 'USER': 'cltbld', 14:12:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:43 INFO - '_': '/tools/buildbot/bin/python'} 14:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:43 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:12:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:12:45 INFO - Installing collected packages: mozsystemmonitor 14:12:45 INFO - Running setup.py install for mozsystemmonitor 14:12:45 INFO - Successfully installed mozsystemmonitor 14:12:45 INFO - Cleaning up... 14:12:45 INFO - Return code: 0 14:12:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:12: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:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:45 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:45 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:12:45 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:12:45 INFO - Using env: {'DISPLAY': ':0', 14:12:45 INFO - 'HOME': '/home/cltbld', 14:12:45 INFO - 'LANG': 'en_US.UTF-8', 14:12:45 INFO - 'LANGUAGE': 'en_US:en', 14:12:45 INFO - 'LOGNAME': 'cltbld', 14:12:45 INFO - 'MAIL': '/var/mail/cltbld', 14:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:45 INFO - 'MOZ_NO_REMOTE': '1', 14:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:45 INFO - 'NO_EM_RESTART': '1', 14:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:45 INFO - 'PWD': '/builds/slave/test', 14:12:45 INFO - 'SHELL': '/bin/bash', 14:12:45 INFO - 'SHLVL': '1', 14:12:45 INFO - 'TERM': 'linux', 14:12:45 INFO - 'TMOUT': '86400', 14:12:45 INFO - 'USER': 'cltbld', 14:12:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:45 INFO - '_': '/tools/buildbot/bin/python'} 14:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:12:45 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:12:45 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:12:45 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:12:45 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:12:45 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:12:45 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:12:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:12:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:12:47 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:12:47 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:12:47 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:12:47 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:12:47 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:12:47 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:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:12:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:12:48 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:12:48 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:12:48 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:12:48 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:12:48 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:12:48 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:12:48 INFO - Downloading docopt-0.6.1.tar.gz 14:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:12:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:12:48 INFO - Running setup.py install for blobuploader 14:12:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:12:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:12:48 INFO - Running setup.py install for requests 14:12:48 INFO - Running setup.py install for docopt 14:12:48 INFO - Successfully installed blobuploader requests docopt 14:12:48 INFO - Cleaning up... 14:12:49 INFO - Return code: 0 14:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:49 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:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:49 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:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:49 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:49 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:12:49 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:12:49 INFO - Using env: {'DISPLAY': ':0', 14:12:49 INFO - 'HOME': '/home/cltbld', 14:12:49 INFO - 'LANG': 'en_US.UTF-8', 14:12:49 INFO - 'LANGUAGE': 'en_US:en', 14:12:49 INFO - 'LOGNAME': 'cltbld', 14:12:49 INFO - 'MAIL': '/var/mail/cltbld', 14:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:49 INFO - 'MOZ_NO_REMOTE': '1', 14:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:49 INFO - 'NO_EM_RESTART': '1', 14:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:49 INFO - 'PWD': '/builds/slave/test', 14:12:49 INFO - 'SHELL': '/bin/bash', 14:12:49 INFO - 'SHLVL': '1', 14:12:49 INFO - 'TERM': 'linux', 14:12:49 INFO - 'TMOUT': '86400', 14:12:49 INFO - 'USER': 'cltbld', 14:12:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:49 INFO - '_': '/tools/buildbot/bin/python'} 14:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:49 INFO - Running setup.py (path:/tmp/pip-w2sxCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:49 INFO - Running setup.py (path:/tmp/pip-sQ6X6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:49 INFO - Running setup.py (path:/tmp/pip-QOV6RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:49 INFO - Running setup.py (path:/tmp/pip-HFk7f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:49 INFO - Running setup.py (path:/tmp/pip-SIUTPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:49 INFO - Running setup.py (path:/tmp/pip-JN0Yfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:49 INFO - Running setup.py (path:/tmp/pip-_4sO2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:49 INFO - Running setup.py (path:/tmp/pip-FgGD9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:49 INFO - Running setup.py (path:/tmp/pip-e8r66O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:49 INFO - Running setup.py (path:/tmp/pip-qh2Jb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:49 INFO - Running setup.py (path:/tmp/pip-g_LEqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:50 INFO - Running setup.py (path:/tmp/pip-6vR_i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:50 INFO - Running setup.py (path:/tmp/pip-Itvopa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:50 INFO - Running setup.py (path:/tmp/pip-VA3y6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:50 INFO - Running setup.py (path:/tmp/pip-b9ev6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:50 INFO - Running setup.py (path:/tmp/pip-H1pbXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:50 INFO - Running setup.py (path:/tmp/pip-WZqW7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:12:50 INFO - Running setup.py install for manifestparser 14:12:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:12:50 INFO - Running setup.py install for mozcrash 14:12:50 INFO - Running setup.py install for mozdebug 14:12:50 INFO - Running setup.py install for mozdevice 14:12:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:12:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:12:50 INFO - Running setup.py install for mozfile 14:12:51 INFO - Running setup.py install for mozhttpd 14:12:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Running setup.py install for mozinfo 14:12:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Running setup.py install for mozInstall 14:12:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Running setup.py install for mozleak 14:12:51 INFO - Running setup.py install for mozlog 14:12:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Running setup.py install for moznetwork 14:12:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Running setup.py install for mozprocess 14:12:51 INFO - Running setup.py install for mozprofile 14:12:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Running setup.py install for mozrunner 14:12:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:12:51 INFO - Running setup.py install for mozscreenshot 14:12:52 INFO - Running setup.py install for moztest 14:12:52 INFO - Running setup.py install for mozversion 14:12:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:12:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:12:52 INFO - Cleaning up... 14:12:52 INFO - Return code: 0 14:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:52 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:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:52 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:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:52 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:52 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:12:52 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:12:52 INFO - Using env: {'DISPLAY': ':0', 14:12:52 INFO - 'HOME': '/home/cltbld', 14:12:52 INFO - 'LANG': 'en_US.UTF-8', 14:12:52 INFO - 'LANGUAGE': 'en_US:en', 14:12:52 INFO - 'LOGNAME': 'cltbld', 14:12:52 INFO - 'MAIL': '/var/mail/cltbld', 14:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:52 INFO - 'MOZ_NO_REMOTE': '1', 14:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:52 INFO - 'NO_EM_RESTART': '1', 14:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:52 INFO - 'PWD': '/builds/slave/test', 14:12:52 INFO - 'SHELL': '/bin/bash', 14:12:52 INFO - 'SHLVL': '1', 14:12:52 INFO - 'TERM': 'linux', 14:12:52 INFO - 'TMOUT': '86400', 14:12:52 INFO - 'USER': 'cltbld', 14:12:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:52 INFO - '_': '/tools/buildbot/bin/python'} 14:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:52 INFO - Running setup.py (path:/tmp/pip-DihfRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:52 INFO - Running setup.py (path:/tmp/pip-syubqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:52 INFO - Running setup.py (path:/tmp/pip-kV7vcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:52 INFO - Running setup.py (path:/tmp/pip-LDVxD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:52 INFO - Running setup.py (path:/tmp/pip-8656Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:52 INFO - Running setup.py (path:/tmp/pip-Cu4OG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:52 INFO - Running setup.py (path:/tmp/pip-I6N8bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:53 INFO - Running setup.py (path:/tmp/pip-oLrdzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:53 INFO - Running setup.py (path:/tmp/pip-cDh2sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:53 INFO - Running setup.py (path:/tmp/pip-VrXssg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:53 INFO - Running setup.py (path:/tmp/pip-un6vlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:53 INFO - Running setup.py (path:/tmp/pip-lCmdLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:53 INFO - Running setup.py (path:/tmp/pip-_j_uTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:53 INFO - Running setup.py (path:/tmp/pip-7xWgoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:53 INFO - Running setup.py (path:/tmp/pip-yi261L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:53 INFO - Running setup.py (path:/tmp/pip-8Ryckm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:53 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:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:53 INFO - Running setup.py (path:/tmp/pip-AONoSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:53 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:12:53 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:12:53 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:12:53 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:12:53 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:12:53 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:12:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:53 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:12:53 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:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:55 INFO - Downloading blessings-1.6.tar.gz 14:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:55 INFO - Installing collected packages: blessings 14:12:55 INFO - Running setup.py install for blessings 14:12:55 INFO - Successfully installed blessings 14:12:55 INFO - Cleaning up... 14:12:55 INFO - Return code: 0 14:12:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:56 INFO - Reading from file tmpfile_stdout 14:12:56 INFO - Current package versions: 14:12:56 INFO - argparse == 1.2.1 14:12:56 INFO - blessings == 1.6 14:12:56 INFO - blobuploader == 1.2.4 14:12:56 INFO - docopt == 0.6.1 14:12:56 INFO - manifestparser == 1.1 14:12:56 INFO - mozInstall == 1.12 14:12:56 INFO - mozcrash == 0.17 14:12:56 INFO - mozdebug == 0.1 14:12:56 INFO - mozdevice == 0.48 14:12:56 INFO - mozfile == 1.2 14:12:56 INFO - mozhttpd == 0.7 14:12:56 INFO - mozinfo == 0.9 14:12:56 INFO - mozleak == 0.1 14:12:56 INFO - mozlog == 3.2 14:12:56 INFO - moznetwork == 0.27 14:12:56 INFO - mozprocess == 0.22 14:12:56 INFO - mozprofile == 0.28 14:12:56 INFO - mozrunner == 6.11 14:12:56 INFO - mozscreenshot == 0.1 14:12:56 INFO - mozsystemmonitor == 0.3 14:12:56 INFO - moztest == 0.7 14:12:56 INFO - mozversion == 1.4 14:12:56 INFO - psutil == 3.1.1 14:12:56 INFO - requests == 1.2.3 14:12:56 INFO - wsgiref == 0.1.2 14:12:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12: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:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:56 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:56 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:12:56 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:12:56 INFO - Using env: {'DISPLAY': ':0', 14:12:56 INFO - 'HOME': '/home/cltbld', 14:12:56 INFO - 'LANG': 'en_US.UTF-8', 14:12:56 INFO - 'LANGUAGE': 'en_US:en', 14:12:56 INFO - 'LOGNAME': 'cltbld', 14:12:56 INFO - 'MAIL': '/var/mail/cltbld', 14:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:56 INFO - 'MOZ_NO_REMOTE': '1', 14:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:56 INFO - 'NO_EM_RESTART': '1', 14:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:56 INFO - 'PWD': '/builds/slave/test', 14:12:56 INFO - 'SHELL': '/bin/bash', 14:12:56 INFO - 'SHLVL': '1', 14:12:56 INFO - 'TERM': 'linux', 14:12:56 INFO - 'TMOUT': '86400', 14:12:56 INFO - 'USER': 'cltbld', 14:12:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:56 INFO - '_': '/tools/buildbot/bin/python'} 14:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 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:12:56 INFO - Cleaning up... 14:12:56 INFO - Return code: 0 14:12:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:12: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:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12: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', 'jsonschema'] in /builds/slave/test/build 14:12: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 jsonschema 14:12:56 INFO - Using env: {'DISPLAY': ':0', 14:12:56 INFO - 'HOME': '/home/cltbld', 14:12:56 INFO - 'LANG': 'en_US.UTF-8', 14:12:56 INFO - 'LANGUAGE': 'en_US:en', 14:12:56 INFO - 'LOGNAME': 'cltbld', 14:12:56 INFO - 'MAIL': '/var/mail/cltbld', 14:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:56 INFO - 'MOZ_NO_REMOTE': '1', 14:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:56 INFO - 'NO_EM_RESTART': '1', 14:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:56 INFO - 'PWD': '/builds/slave/test', 14:12:56 INFO - 'SHELL': '/bin/bash', 14:12:56 INFO - 'SHLVL': '1', 14:12:56 INFO - 'TERM': 'linux', 14:12:56 INFO - 'TMOUT': '86400', 14:12:56 INFO - 'USER': 'cltbld', 14:12:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:56 INFO - '_': '/tools/buildbot/bin/python'} 14:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:56 INFO - Downloading/unpacking jsonschema 14:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:56 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:12:56 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:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:12:58 INFO - Downloading/unpacking functools32 (from jsonschema) 14:12:58 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:12:58 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:12:58 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:12:58 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:12:58 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:12:58 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:12:58 INFO - Downloading functools32-3.2.3-2.tar.gz 14:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:12:58 INFO - warning: no files found matching '*.txt' 14:12:58 INFO - no previously-included directories found matching 'build' 14:12:58 INFO - no previously-included directories found matching 'dist' 14:12:58 INFO - no previously-included directories found matching '.git*' 14:12:58 INFO - Installing collected packages: jsonschema, functools32 14:12:58 INFO - Running setup.py install for functools32 14:12:58 INFO - warning: no files found matching '*.txt' 14:12:58 INFO - no previously-included directories found matching 'build' 14:12:58 INFO - no previously-included directories found matching 'dist' 14:12:58 INFO - no previously-included directories found matching '.git*' 14:12:58 INFO - Successfully installed jsonschema functools32 14:12:58 INFO - Cleaning up... 14:12:58 INFO - Return code: 0 14:12:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:12:58 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:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 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:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 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 0x7fa328ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', '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:12:58 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:12:58 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:12:58 INFO - Using env: {'DISPLAY': ':0', 14:12:58 INFO - 'HOME': '/home/cltbld', 14:12:58 INFO - 'LANG': 'en_US.UTF-8', 14:12:58 INFO - 'LANGUAGE': 'en_US:en', 14:12:58 INFO - 'LOGNAME': 'cltbld', 14:12:58 INFO - 'MAIL': '/var/mail/cltbld', 14:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:58 INFO - 'MOZ_NO_REMOTE': '1', 14:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:58 INFO - 'NO_EM_RESTART': '1', 14:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:58 INFO - 'PWD': '/builds/slave/test', 14:12:58 INFO - 'SHELL': '/bin/bash', 14:12:58 INFO - 'SHLVL': '1', 14:12:58 INFO - 'TERM': 'linux', 14:12:58 INFO - 'TMOUT': '86400', 14:12:58 INFO - 'USER': 'cltbld', 14:12:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:58 INFO - '_': '/tools/buildbot/bin/python'} 14:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:59 INFO - Downloading/unpacking flake8 14:12: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:12: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:12: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:12: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:12: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:12: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:13:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:13:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:13:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:13:01 INFO - no previously-included directories found matching 'docs/_build' 14:13:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:13:01 INFO - Running setup.py install for pep8 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:13:01 INFO - no previously-included directories found matching 'docs/_build' 14:13:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:13:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:13:01 INFO - Cleaning up... 14:13:01 INFO - Return code: 0 14:13:01 INFO - Running post-action listener: _resource_record_post_action 14:13:01 INFO - Running post-action listener: _start_resource_monitoring 14:13:01 INFO - Starting resource monitoring. 14:13:01 INFO - ##### 14:13:01 INFO - ##### Finished create-virtualenv step (success) 14:13:01 INFO - ##### 14:13:01 INFO - ##### 14:13:01 INFO - ##### Running install step. 14:13:01 INFO - ##### 14:13:01 INFO - Running pre-action listener: _resource_record_pre_action 14:13:01 INFO - Running main action method: install 14:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:13:02 INFO - Reading from file tmpfile_stdout 14:13:02 INFO - Detecting whether we're running mozinstall >=1.0... 14:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:13:02 INFO - Reading from file tmpfile_stdout 14:13:02 INFO - Output received: 14:13:02 INFO - Usage: mozinstall [options] installer 14:13:02 INFO - Options: 14:13:02 INFO - -h, --help show this help message and exit 14:13:02 INFO - -d DEST, --destination=DEST 14:13:02 INFO - Directory to install application into. [default: 14:13:02 INFO - "/builds/slave/test"] 14:13:02 INFO - --app=APP Application being installed. [default: firefox] 14:13:02 INFO - mkdir: /builds/slave/test/build/application 14:13:02 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:13:02 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:13:19 INFO - Reading from file tmpfile_stdout 14:13:19 INFO - Output received: 14:13:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:13:19 INFO - Running post-action listener: _resource_record_post_action 14:13:19 INFO - ##### 14:13:19 INFO - ##### Finished install step (success) 14:13:19 INFO - ##### 14:13:19 INFO - ##### 14:13:19 INFO - ##### Running run-tests step. 14:13:19 INFO - ##### 14:13:19 INFO - Running pre-action listener: _resource_record_pre_action 14:13:19 INFO - Running main action method: run_tests 14:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:13:19 INFO - Python 2.7.3 14:13:19 INFO - Return code: 0 14:13:19 INFO - grabbing minidump binary from tooltool 14:13:19 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:13:19 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 0x2b749c0>, '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 0x2b758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b75d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:13:19 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:13:19 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:13:19 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:13:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:13:20 INFO - Return code: 0 14:13:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:13:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:13:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:13:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:13:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:13:20 INFO - Return code: 0 14:13:20 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-033', '--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:13:20 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-033 --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:13:20 INFO - Using env: {'DISPLAY': ':0', 14:13:20 INFO - 'HOME': '/home/cltbld', 14:13:20 INFO - 'LANG': 'en_US.UTF-8', 14:13:20 INFO - 'LANGUAGE': 'en_US:en', 14:13:20 INFO - 'LOGNAME': 'cltbld', 14:13:20 INFO - 'MAIL': '/var/mail/cltbld', 14:13:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:13:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:20 INFO - 'MOZ_NO_REMOTE': '1', 14:13:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:20 INFO - 'NO_EM_RESTART': '1', 14:13:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:20 INFO - 'PWD': '/builds/slave/test', 14:13:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:13:20 INFO - 'SHELL': '/bin/bash', 14:13:20 INFO - 'SHLVL': '1', 14:13:20 INFO - 'TERM': 'linux', 14:13:20 INFO - 'TMOUT': '86400', 14:13:20 INFO - 'USER': 'cltbld', 14:13:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887', 14:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:20 INFO - '_': '/tools/buildbot/bin/python'} 14:13:20 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-033', '--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:13:21 INFO - mozversion application_buildid: 20160602113028 14:13:21 INFO - mozversion application_changeset: 91879ebba4d61fde72af13223708faa01109a4d9 14:13:21 INFO - mozversion application_display_name: Nightly 14:13:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:13:21 INFO - mozversion application_name: Firefox 14:13:21 INFO - mozversion application_remotingname: firefox 14:13:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:13:21 INFO - mozversion application_vendor: Mozilla 14:13:21 INFO - mozversion application_version: 49.0a1 14:13:21 INFO - mozversion platform_buildid: 20160602113028 14:13:21 INFO - mozversion platform_changeset: 91879ebba4d61fde72af13223708faa01109a4d9 14:13:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:13:21 INFO - mozversion platform_version: 49.0a1 14:13:21 INFO - using testdate: 1464902001 14:13:21 INFO - actual date: 1464902001 14:13:21 INFO - starting webserver on 'localhost:43320' 14:13:21 INFO - SUITE-START | Running 2 tests 14:13:21 INFO - TEST-START | dromaeo_css 14:13:21 INFO - operating with platform_type : linux_ 14:13:21 INFO - Initialising browser for dromaeo_css test... 14:13:21 INFO - TEST-INFO | started process 32079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcGbr95/profile http://localhost:43320/getInfo.html) 14:13:25 INFO - PROCESS | 32079 | __metrics Screen width/height:1600/1200 14:13:25 INFO - PROCESS | 32079 | colorDepth:24 14:13:25 INFO - PROCESS | 32079 | Browser inner width/height: 1024/697 14:13:25 INFO - PROCESS | 32079 | __metrics 14:13:27 ERROR - PROCESS | 32079 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:13:28 INFO - TEST-INFO | 32079: exit 0 14:13:28 INFO - Browser initialized. 14:13:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:13:28 INFO - TEST-INFO | started process 32161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcGbr95/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:40 INFO - PROCESS | 32161 | RSS: Main: 156463104 14:13:40 INFO - PROCESS | 32161 | 14:14:31 INFO - PROCESS | 32161 | 1464902071242 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:16:39 INFO - PROCESS | 32161 | Cycle 1(1): loaded http://localhost:43320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43320/tests/dromaeo/cssquery-ext.html) 14:16:40 INFO - PROCESS | 32161 | RSS: Main: 246165504 14:16:40 INFO - PROCESS | 32161 | 14:19:43 INFO - PROCESS | 32161 | Cycle 1(1): loaded http://localhost:43320/tests/dromaeo/cssquery-ext.html (next: http://localhost:43320/tests/dromaeo/cssquery-jquery.html) 14:19:43 INFO - PROCESS | 32161 | RSS: Main: 239157248 14:19:43 INFO - PROCESS | 32161 | 14:22:45 INFO - PROCESS | 32161 | Cycle 1(1): loaded http://localhost:43320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43320/tests/dromaeo/cssquery-mootools.html) 14:22:46 INFO - PROCESS | 32161 | RSS: Main: 236945408 14:22:46 INFO - PROCESS | 32161 | 14:25:48 INFO - PROCESS | 32161 | Cycle 1(1): loaded http://localhost:43320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43320/tests/dromaeo/cssquery-prototype.html) 14:25:49 INFO - PROCESS | 32161 | RSS: Main: 233336832 14:25:49 INFO - PROCESS | 32161 | 14:28:51 INFO - PROCESS | 32161 | Cycle 1(1): loaded http://localhost:43320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43320/tests/dromaeo/cssquery-yui.html) 14:28:52 INFO - PROCESS | 32161 | RSS: Main: 225759232 14:28:52 INFO - PROCESS | 32161 | 14:31:54 INFO - PROCESS | 32161 | Cycle 1(1): loaded http://localhost:43320/tests/dromaeo/cssquery-yui.html (next: http://localhost:43320/tests/dromaeo/cssquery-dojo.html) 14:31:55 INFO - PROCESS | 32161 | RSS: Main: 294801408 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | __start_tp_report 14:31:55 INFO - PROCESS | 32161 | _x_x_mozilla_page_load 14:31:55 INFO - PROCESS | 32161 | _x_x_mozilla_page_load_details 14:31:55 INFO - PROCESS | 32161 | |i|pagename|runs| 14:31:55 INFO - PROCESS | 32161 | |0;dojo.html;3089.7682673799463;3108.7668424868125;3130.217445638591;3149.4645910195263;3160.7945483543567;5177.119889618764;5253.86865328367;5320.441353657863;5430.1040328345825;5443.646162999407;5371.5165635092835;5375.408705042442;5379.6503227290195;5416.07926652469;5440.945590544094;4823.493533179018;4885.4381746099125;4922.0402021605805;4933.925991110136;5082.745862706868;4944.901101977976;5009.348784657989;5027.296178535008;5054.115529782273;5055.46917573655;4775.4985726498735;4826.855194344175;4834.154023045953;4853.757312134379;4891.633127515451;4820.276958456225;4846.5880400166025;4933.703977761345;4934.432540257844;4964.87587810304;4740.099381117577;4896.069746748142;4924.778384972649;4935.950640493621;4965.677230979974;5248.527632513092;5319.5478384337375;5340.065488539529;5400.405955344909;5412.404635490093;5750.223719797816;5795.1886735857015;5819.592628516006;5822.854428639275;5847.8245652630485;5555.2222688823595;5701.515371193454;5818.069108942549;5845.941540584625;5849.678267695275;5366;5476.644018138808;5489.34127904654;5491.066518691832;5494.752736126844;5975.910361344497;5983.6708981005595;5989.431004054608;5989.610675306091;5991.5206783457215;5435.402105768362;5559.27729395176;5576.7211639417865;5742.626729262584;5751.079827227707;5755.107958266475;5796.188533605298;5797.130430435468;5798.478136967693;5801.796937107181;5654.180143879197;5681.431856814368;5719;5719.971400142973;5727.541796656257;5566.860828479321;5644.915326270109;5698.31620205578;5712.942870571324;5729.512991395778;4407.977960110179;4408;4408.955910440919;4410.669199810027;4443;3917.373220284741;3932.8230229639735;3938.1926705025403;3970.3845903884367;3995.2409042281874;5224.059669259494;5325.973370133124;5378.381486129145;5434.646747961449;5447.373552041487;5854;5867.647941123546;5867.970660146672;5869.119632055141;5898.321693005273;5436.592255580847;5440.6735595864375;5446.21029950655;5448.45515448452;5456.236126942231;4766.594839438617;4922.532359425849;4943.505649435099;4950.727709975914;4990.451050384455;5993.580449368589;6027.698615069229;6028.969855150784;6029.728662210211;6035.939640603626;5567.860803479945;5831.300243970666;5847.561432892635;5851.093080572518;5852.209951656642;5857.150713146655;5908.852278693067;5918.467337939606;6006.579539432198;6006.849828754316;5634.436556344497;5681.630694004876;5682.176084467646;5692.601517893873;5695.544356451391;5753.194552762533;5777.162311464898;5788.247527821356;5797.797077102281;5805.535557155333;5458.5087342139395;5589.80435684749;5618.494335509824;5636.859078522905;5710;5690.317161940594;5704.657720536615;5705.372409035086;5706.885862282648;5713.314402271754;5305.151175811851;5598.1602759586385;5604.607677462538;5609.27079479665;5610.326760788732;5568.777248909998;5587.441255874543;5631.802886898939;5765.740541675718;5767.509761670305;5538.584606154635;5575.721213939368;5581.6930068846605;5583.41374155724;5619.100943848965 14:31:55 INFO - PROCESS | 32161 | |1;ext.html;615.5783288447413;619.6127420362274;630.8801327747726;645.7804346522181;647.7732793522265;31846.681533184663;34256.65743342566;34297.65702342976;34305.82847085764;34334.656653433456;34636;45324.54675453253;46350.536494635126;46420.30369544459;49851.501484985136;8721.86917196241;8865.246454051414;8887.911120888806;8891.68879089232;8901.643934242622;8600.22597966183;8791.47251164929;8810.823783524358;8811.074837142103;8818.647254109828;8836.955815220916;8890.199882010618;8902.287816974658;8905;8912.777180570505;8845.690400835972;8902.777430564223;8916.465012099296;8921.063288354695;8922.286217102648;8810.69162579313;8897.644094236222;8907.06475820036;8914;8914.50970196639;42281;42356.3646545302;42639.7868010658;42737.57262427367;42866.35700464464;3355.7818741781707;3520.3839328117733;3557.6442355764216;4159.542450330461;4293.549177336366;30100;30184.54723179154;30190.0942971709;30340.69659303401;30370.088897333117;3953.6639385652256;4210.179015092058;4389.890252743675;4482.641388688897;4491.887702807456;368748;368972;371508;372592;373374;60093.69953150206;60099;60534;60535;60592.69703651453;64452.67773661196;64519;64557;64611.67694161499;64746.352536474034;14738.189399582912;15905.840941590668;16082;16112;16584.50246492607;12538.749225015448;12730.23618582888;12806.103572750004;12877;12887.613371598867;13673.863261367458;14558.563243102511;14747;14811.333489992976;14871.47949821751;6948.27043160471;6958;7045.506814523037;7367.115946086504;7460.813479662943;968.3995922528078;1050.8142317662362;1057.4871187474068;1108.933463992163;1125.7523344864117;32787.3442531148;32957.3408531828;33361.49957750636;33395.16512087169;33396.3320733584;1137.9829302560468;1190.1966172833304;1198.26306821306;1212.4119801896074;1255.75512775008;16593.585160371087;16909.7463538047;16988.66022679564;17062.914685426495;17202.827971720373;558065;559168;565067;566048;567690;59253.407465924785;59716.70141649351;59866.401335986084;59867.70066149641;59901.700491497264;1292.3925754895183;1390.5272207449516;1401.5795261421736;1408.6971301170297;1421.3532842556613;30921;31360.372792544476;31783;31909.68090319067;32668.50997234996;51440;52051.47948520466;52184.73907630437;52207.477925220264;52252.73873630608;427180;437148;438578;438855;441897;24844.627330590418;26814.195574132806;27475;28018.159455216377;28061.438771224868;38628.6137138625;39956.20087598173;47831.5216847827;48475;49205.81750551243;34512.82743586266;35193.47209791906;35659.64340356667;35765.82117089502;36102.45846312255;41219.7939010303;41343;41868;42817.57182428136;42847.14305713931;42166.789166053975;42254.577454225066;42903.35644965265;43229.351559726;43374;34746.65253347434;36929.26141477102;36942.815285923396;37288.254234915694;37508.624913751606;28584.428311434072;28919;29002.129936101952;29006.854965725037;29012.709872901 14:31:55 INFO - PROCESS | 32161 | |2;jquery.html;385.6220903514555;390.9237698648765;398.9421533877586;405.4040560376247;412.8245495664342;14197.334394270942;15483.845161548381;17226.483205503824;18743.3439829606;18750.812491875062;12161.331126788024;14564.927175364108;14685.412583496674;15992.840071599281;16964.49106526803;5532.529734972532;5695.544356451494;5799.072148456248;5804.680742559158;5807.722301093752;5652.604317697763;5757.654540727549;5764.7982320618785;5812.157237200603;5813.418658134195;4159.3968874513175;5764.625299355549;6032.819015429544;6378.553501254914;6379.425851673349;5495.450454954513;6415.1339569158035;6453.515986301046;6460.806175814733;6482.124913136713;5624.437556244384;5679.772809087632;5710.114932185518;5713.228714123623;5718.142278658234;11971.461284242143;12126.818097728541;20064.398068057835;21250.449946006425;21282.46793830151;2323.46560291134;2337.696099507053;2434.403571125086;2756.9035083771973;2884.8990285340124;9954.5022748863;10249.590016399336;12213.816792748026;13056;13359;1818.4453741608804;1853.6478069166815;1867.766529183852;1867.9813201867944;1875.7092650639172;75634;78909.60545197295;81434;81876.59061704653;82699;10792.406417647106;11014.39420831862;11098.223124381217;11208.607698730506;11357.772844543228;15403.84596154024;15531.767023494656;15535.84464155344;15541.222938853238;15574.688506229812;7166.140063192451;7596.278353556403;7695.730649427355;7835.098963619257;7971.8405631887035;7814.804629884185;7842.137364889858;7896.921030789734;8003.839923201504;8024.799380015546;4727.669063165614;4742.264948932921;4785.401824771903;4790.760461976957;4840.2255639097575;1925.6726356519425;1931.2854243929555;1949.6783030800043;1995.082262159423;2052.887091209998;946.6024269806697;956.4213650741341;965.9661911833052;968.3463662028103;980.5048450532578;17568.29726810939;17881.37415190488;18476.630467390845;18774.812251877305;18875.528111797314;929.2380248196549;1009.6869970309081;1017.389566260238;1021.3361315145066;1043.426115636412;10033.949830250802;10252.38485690861;10369.325993810378;10374.533146008447;10391.116755075753;498923;502542;504005;504565;504594;84076;85531.57234213913;86533;87565;87753;979.7256768104942;982.4694664880884;1001.1890368801294;1002.5388321372104;1027.3938376357835;15636.68726625484;16347.509574712778;16536.338546458006;16746.83253167453;16932.40736574214;39922.846717505316;40909.315982848006;40940.38589421221;40977.77066688004;41843;42847.9288017802;43896.78051609721;51719.482805171465;51753;55117.44882551284;8110.471760929326;8420.873686894824;8472;8599.785005374666;8729.25801306896;11851.229670071418;12108;12383.566575169825;12490.125691201529;12677.8098328527;10315.226358023028;10747.516361763895;10837.512311945824;10989.835152472559;11126.666200014013;10380.169586432916;10440.477976101316;10540.57837686484;10661;10696.41169735672;10335.94832025865;10982.780344392908;11104.500297486795;11131.332120072822;11131.888681113085;7057.153141623038;8437.493750374751;8438.873416898874;8507.191816777397;8610.569471526273;10149.898501014895;10689.572417103229;10812.459377031275;10820.729481763019;11075.446227688744 14:31:55 INFO - PROCESS | 32161 | |3;mootools.html;1158.6813626252786;1440.8847292216624;1464.6631274806793;1604.6710424363007;1811.1487600827616;8548.48709077455;8941.374103812728;8952.910470895296;9265.90734092659;9288.164065234128;8979.730608081769;9171.266298696106;9180.357374983738;9180.495072770995;9182.494962777044;2078.5842831433697;2307.711536057993;2385.224801939368;2407.42221866752;2439.2682195341417;2408.349745568695;2413.6741539892064;2413.78275955164;2416;2417;2384.7257565380028;2394.580948334043;2424.054618698709;2426.7694569016003;2429.757024297574;1982.9900850495728;2239.2274665240466;2291.9770802292014;2307.261676263596;2317.4901521665206;2347.788699017097;2355.2698663414394;2363.976360236393;2369.206315884181;2372.3120295114395;8799.956000220021;8880.644774209024;8884.333674974338;8890.777730556723;8895.154960278764;5310.070737620939;5436.728163591844;5437.809676661298;5443.945560544384;5462.371827239878;3268.8692452302116;3312.867485300585;3332.266901281714;3363.814990175539;3520.295940811822;1037.1858091398292;1054.9894501054969;1059.3908502610952;1074.0816601805423;1093.9015488606065;13111.016673749411;13122.14706044104;13132.34338283082;13147.86852131476;13154.671133221651;4773.702518160322;4781.808727650855;4865.245886887538;4881.633877459205;4898.044881248194;10736.194785390971;10743.677689669323;10750.838737418788;10819.891801082045;10828.891711082946;5455.345358556999;5462.863428414242;5468.152436372368;5481.314835645544;5487.039768040577;4269.807858646368;4908.092002979461;5032.446430892599;5041.521055499722;5127.230915362726;4104.261232978033;4123.299039163349;4143.759416501219;4168.916621667549;4175.123224122907;1257.2330878164312;1272.9872701273055;1281.077624110639;1285.864984176648;1290.6321698315935;1002.1131298800614;1037.5331101004579;1050.2963014780116;1052.4211683574003;1052.9262951593314;6123.234595675541;6259.374062593704;6269.8746025079245;6316;6360.109584658151;465.26720415345966;469.23046204225096;471.80868307523093;475.7121941225578;483.99032019359413;4287.249731297011;4408.338749187647;4458.866234012985;4503.986603014361;4528.864134075983;11661.708457288465;11763.294202347886;11868.287902725864;11893.940530297466;11894.405279735978;11574.71063223426;11719.179657424069;11742.295462272292;11767;11780.528778848922;8115.918840811634;8452.57737113142;8461.2807911327;8663.176998185163;8675.175858293453;6179.721912513858;6449.5485316027425;6518.2504012037325;6558.967205164135;6577.408033277028;10395.636152734618;10667.253292269466;10680.198985076306;10680.786384272116;10693.251472396858;10341.689749307532;10642.73393165177;10725.892741072801;10843.132549395872;10862.293950893167;6984.685689144102;7767.961160194162;7946.721864734938;7950.801229969297;8167.836643266983;8584;8861.291096712119;8868.600912959062;8872.911270887467;8912.73261802147;7585.62071896414;7614.2766437188375;7743.148253691977;7819.569923654253;7857.096433909945;7419.629018548943;7444.143923448656;7468.365188958999;7487.138979017483;7664.846703066019;7084.25615310385;7151.60666163366;7155.785326440215;7176.820579485555;7180.281971802778;5121.180611102355;5218.139007063792;5329.920051199313;5374.4088150304215;5435.429279925709;5161.716105614228;5179.533841954242;5219.5041471060185;5312.203169524602;5361.624686271924 14:31:55 INFO - PROCESS | 32161 | |4;prototype.html;325.6661921530431;330.3937275100191;335.9953738322417;336.04060407536485;338.36049865753716;5246.711430871305;5273.604479664026;5285.550728188099;5297.602679799012;5341.786328546863;5230.267762513251;5251;5251.606129540281;5254.6847189168675;5260.605454590902;3902.590228026052;3976.2643910876436;4128.401381799637;4142.46148000761;4142.937855932163;4091.284025295576;4093.5292441369324;4101.835926562949;4112.97943510282;4118.290909272649;3894.279558281727;4081.653059489947;4091.3862920562005;4094.283500387435;4100.774457404841;3824.4836947012077;4010.3583426651594;4016.116454380032;4062;4099.241640296555;3649.94525082124;3652.3060618482405;3655.7935881159156;3672.889813305605;3675.6324367563298;5042.218456139304;5067.366579177603;5070.163423035195;5118.385793704742;5126.974365128188;4500.774961251925;4718.764061796896;4729.148753224418;4733.219018861883;4738.976305118486;5448.365490352879;5478.945210547883;5481.479259470344;5492.1212605982855;5499.477549632778;4021.698372622065;4024.3158663027357;4024.5975402459812;4027.939580906289;4032.507972050331;5392.325959255093;5707.800226992077;5709.486146246858;5750.3962083981;5769.971150144264;3972.5232972042963;3974.423708562242;4015.2371049500503;4024.6176613221696;4028.4964379452567;4075.5109386873764;4077.5922407758985;4079.8980025499004;4081.3469844824685;4083.734557253769;4453.665975051884;4679.251319788817;4689.273162659793;4690.812367505261;4702.365180700562;5472;5525.778968841201;5567.0216434207505;5575.0522411190195;5584.944150558524;1379.903406761517;1383.522684673786;1401.278341654049;1401.8107555480083;1402.7404930087762;850.2093053460218;868.8045189832237;891.6567121658209;904.8326059678981;906.7551761024487;5168.586513078944;5266.315379000705;5268.9736551317;5291.417944026154;5297.417284098746;5672.234248376499;5679.8864022720145;5682.261306030189;5703.144528320785;5706.971465142731;5007.122329126578;5269.894602107936;5292.788288468418;5302.575793936476;5320.866978325495;2961.659409167973;2998.9550156747664;3017.7887547871437;3027.409655117275;3034.4082903833983;5848.2689663792025;5857;5868.092869817327;5924.289085309791;5929.940700593025;5529.668219906818;5647.519960803378;5751.654900705971;5751.683657398883;5761.9135712964335;5803.142994241802;5809.564282678816;5829.038208695518;5858;5908.881822363614;5374.435684253097;5618.831435056954;5626.521745651502;5640.23856779346;5750.453706897838;5585;5607.102863541813;5615;5627.664519224476;5627.774889004558;5819.447152520504;5826.592138550261;5831.533477321889;5834.94165058344;5865.208196893535;3582.4206571268646;3631.2374401376005;3642.6357364263363;3732.1229511064334;3741.30785804627;5062.291279220838;5134.717590532557;5166.328377310925;5198.246254293031;5211.348581427322;4884.803223210336;4965.8013679452415;5015.824446144367;5055.545000949932;5060.443351231435;4774.779727426763;4881.804727810848;4903.53416425439;4985.351904252424;5035.5468007878;4899.603612970286;4923.704577725348;4948.960718249064;4969.900601988013;5270;5304.310439642822;5507.944920550904;5510.889782204254;5524.889502209853;5526.143447765603;5403;5430.375506816767;5455.618106732491;5470.370907345706;5522.723863806874 14:31:55 INFO - PROCESS | 32161 | |5;yui.html;766.2911806578917;795.7175202803002;796.5937371940311;809.5426084262396;817.7628487738556;13314.467421303149;13726.382312795924;13757.31213439329;13781.242031688253;13804.516841910548;14793;15220.086794792292;15579.065256084643;15693.21533923305;15720.213989300546;515.4973900447053;517.1208944793847;518.6758276077461;527.4857014410957;688.2463702246033;815.8857759913587;833.8707500337457;839.7774589733725;846.1538461538462;846.8010017645879;870.7170169694842;871.3813192633238;871.4335681806813;871.5075982070142;872.6814712629908;724.77169691547;739.4158614694385;864.1919804982361;865.3639574912435;865.4417900454204;547.3295213363638;612.9172561704157;631.2929518938772;631.4601016131234;638.1034646321879;15958.361665533364;15996.920015399848;16010.279537420844;16040.43858464948;16087.839121608751;14238.92880535601;14568.271586420637;14615.707685846224;14670.266486675624;14771.187584682839;12648.68378290541;12779.488820447172;12790.360481975864;12974.091813573054;13447.66380840477;4536.432945881765;4615.71393724582;4657.510961349078;4664.463586687507;4792.592629626486;77897;77928;78261.60869195675;78623.21376786217;78807.6059619704;11108.944455277671;11404.372759498307;11425.914538118865;11458.08335333188;11563.826542601868;20489.692654610193;20496.897515512326;20501.17995280202;20526.794732052786;20532.38402847917;8430.156984301644;8626.870596941051;8657.95671021641;8676.392652514389;8788.42875213109;4447.644188464915;4487.753173575485;4623.12160689468;4638.420197475316;4649.256119020941;3439.1574064354395;3531.258435728526;3535.1515636247113;3539.3629146753315;3539.5398598182073;618.6844709198251;618.8391018335266;627.9277883043417;645.7804346522205;655.7344275568403;607.7994261893565;657.5200103924162;681.655763839258;693.5214701855704;702.4591064880013;9353.532323383804;9624.951875240578;9642.71071867831;9674.274429417821;9789.46157961319;555.9210038231946;613.883362161188;647.3946859686114;658.325216652925;677.7221339250982;4261.744295342228;4374.365716971021;4378.299472084451;4460.620847227957;4473.172463094338;110691;112124.43937780258;116340.6311489694;117018.41490792492;117499;92934.53532732293;94567;95442;97485.51257243668;98873;86013.56993214994;86781.99999999873;86919.56540217258;86953.56523217344;86991.56504217438;7897.763067107996;7935;8042.758717238492;8108;8321.292690121165;50021.49978500314;51773;52004.739976299876;52331.476685234185;52978.18230491123;64293.35706642874;66736.99894501684;72378;73071.26928730645;74257.6287118561;13309.239393591353;13393.295906362911;13507.189568625914;13551.186928784304;13895.657980634294;15581.844181558039;15837.287322070304;15896.841031589998;16192;16426.096564689058;10018.699439016842;13452.192868427926;14366.897266175602;14532.200728960008;14626.634334141732;13020.47918083266;13439.529616463376;13697;14003.22982235946;14797.334119964842;13880.16718996823;13963.024777262153;13966.37151328213;14414.207218603078;14467.565973020826;11532.481038353462;11683.532658693557;11895.405229738652;11902.821457678316;12384.56654017105;11484.966353028267;11635.825462618237;11878.465469054086;12123.29449258035;12138.453769580214 14:31:55 INFO - PROCESS | 32161 | __end_tp_report 14:31:55 INFO - PROCESS | 32161 | __start_cc_report 14:31:55 INFO - PROCESS | 32161 | _x_x_mozilla_cycle_collect,822 14:31:55 INFO - PROCESS | 32161 | __end_cc_report 14:31:55 INFO - PROCESS | 32161 | __startTimestamp1464903115207__endTimestamp 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | ------- Summary: start ------- 14:31:55 INFO - PROCESS | 32161 | Number of tests: 6 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | [#0] dojo.html Cycles:165 Average:5358.36 Median:5567.86 stddev:611.87 (11.0%) stddev-sans-first:587.30 14:31:55 INFO - PROCESS | 32161 | Values: 3089.8 3108.8 3130.2 3149.5 3160.8 5177.1 5253.9 5320.4 5430.1 5443.6 5371.5 5375.4 5379.7 5416.1 5440.9 4823.5 4885.4 4922.0 4933.9 5082.7 4944.9 5009.3 5027.3 5054.1 5055.5 4775.5 4826.9 4834.2 4853.8 4891.6 4820.3 4846.6 4933.7 4934.4 4964.9 4740.1 4896.1 4924.8 4936.0 4965.7 5248.5 5319.5 5340.1 5400.4 5412.4 5750.2 5795.2 5819.6 5822.9 5847.8 5555.2 5701.5 5818.1 5845.9 5849.7 5366.0 5476.6 5489.3 5491.1 5494.8 5975.9 5983.7 5989.4 5989.6 5991.5 5435.4 5559.3 5576.7 5742.6 5751.1 5755.1 5796.2 5797.1 5798.5 5801.8 5654.2 5681.4 5719.0 5720.0 5727.5 5566.9 5644.9 5698.3 5712.9 5729.5 4408.0 4408.0 4409.0 4410.7 4443.0 3917.4 3932.8 3938.2 3970.4 3995.2 5224.1 5326.0 5378.4 5434.6 5447.4 5854.0 5867.6 5868.0 5869.1 5898.3 5436.6 5440.7 5446.2 5448.5 5456.2 4766.6 4922.5 4943.5 4950.7 4990.5 5993.6 6027.7 6029.0 6029.7 6035.9 5567.9 5831.3 5847.6 5851.1 5852.2 5857.2 5908.9 5918.5 6006.6 6006.8 5634.4 5681.6 5682.2 5692.6 5695.5 5753.2 5777.2 5788.2 5797.8 5805.5 5458.5 5589.8 5618.5 5636.9 5710.0 5690.3 5704.7 5705.4 5706.9 5713.3 5305.2 5598.2 5604.6 5609.3 5610.3 5568.8 5587.4 5631.8 5765.7 5767.5 5538.6 5575.7 5581.7 5583.4 5619.1 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | [#1] ext.html Cycles:180 Average:61260.39 Median:23188.48 stddev:123249.64 (531.5%) stddev-sans-first:123511.28 14:31:55 INFO - PROCESS | 32161 | Values: 615.6 619.6 630.9 645.8 647.8 31846.7 34256.7 34297.7 34305.8 34334.7 34636.0 45324.5 46350.5 46420.3 49851.5 8721.9 8865.2 8887.9 8891.7 8901.6 8600.2 8791.5 8810.8 8811.1 8818.6 8837.0 8890.2 8902.3 8905.0 8912.8 8845.7 8902.8 8916.5 8921.1 8922.3 8810.7 8897.6 8907.1 8914.0 8914.5 42281.0 42356.4 42639.8 42737.6 42866.4 3355.8 3520.4 3557.6 4159.5 4293.5 30100.0 30184.5 30190.1 30340.7 30370.1 3953.7 4210.2 4389.9 4482.6 4491.9 368748.0 368972.0 371508.0 372592.0 373374.0 60093.7 60099.0 60534.0 60535.0 60592.7 64452.7 64519.0 64557.0 64611.7 64746.4 14738.2 15905.8 16082.0 16112.0 16584.5 12538.7 12730.2 12806.1 12877.0 12887.6 13673.9 14558.6 14747.0 14811.3 14871.5 6948.3 6958.0 7045.5 7367.1 7460.8 968.4 1050.8 1057.5 1108.9 1125.8 32787.3 32957.3 33361.5 33395.2 33396.3 1138.0 1190.2 1198.3 1212.4 1255.8 16593.6 16909.7 16988.7 17062.9 17202.8 558065.0 559168.0 565067.0 566048.0 567690.0 59253.4 59716.7 59866.4 59867.7 59901.7 1292.4 1390.5 1401.6 1408.7 1421.4 30921.0 31360.4 31783.0 31909.7 32668.5 51440.0 52051.5 52184.7 52207.5 52252.7 427180.0 437148.0 438578.0 438855.0 441897.0 24844.6 26814.2 27475.0 28018.2 28061.4 38628.6 39956.2 47831.5 48475.0 49205.8 34512.8 35193.5 35659.6 35765.8 36102.5 41219.8 41343.0 41868.0 42817.6 42847.1 42166.8 42254.6 42903.4 43229.4 43374.0 34746.7 36929.3 36942.8 37288.3 37508.6 28584.4 28919.0 29002.1 29006.9 29012.7 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | [#2] jquery.html Cycles:180 Average:28418.51 Median:1635.26 stddev:82721.96 (5058.6%) stddev-sans-first:82927.23 14:31:55 INFO - PROCESS | 32161 | Values: 385.6 390.9 398.9 405.4 412.8 14197.3 15483.8 17226.5 18743.3 18750.8 12161.3 14564.9 14685.4 15992.8 16964.5 5532.5 5695.5 5799.1 5804.7 5807.7 5652.6 5757.7 5764.8 5812.2 5813.4 4159.4 5764.6 6032.8 6378.6 6379.4 5495.5 6415.1 6453.5 6460.8 6482.1 5624.4 5679.8 5710.1 5713.2 5718.1 11971.5 12126.8 20064.4 21250.4 21282.5 2323.5 2337.7 2434.4 2756.9 2884.9 9954.5 10249.6 12213.8 13056.0 13359.0 1818.4 1853.6 1867.8 1868.0 1875.7 75634.0 78909.6 81434.0 81876.6 82699.0 10792.4 11014.4 11098.2 11208.6 11357.8 15403.8 15531.8 15535.8 15541.2 15574.7 7166.1 7596.3 7695.7 7835.1 7971.8 7814.8 7842.1 7896.9 8003.8 8024.8 4727.7 4742.3 4785.4 4790.8 4840.2 1925.7 1931.3 1949.7 1995.1 2052.9 946.6 956.4 966.0 968.3 980.5 17568.3 17881.4 18476.6 18774.8 18875.5 929.2 1009.7 1017.4 1021.3 1043.4 10033.9 10252.4 10369.3 10374.5 10391.1 498923.0 502542.0 504005.0 504565.0 504594.0 84076.0 85531.6 86533.0 87565.0 87753.0 979.7 982.5 1001.2 1002.5 1027.4 15636.7 16347.5 16536.3 16746.8 16932.4 39922.8 40909.3 40940.4 40977.8 41843.0 42847.9 43896.8 51719.5 51753.0 55117.4 8110.5 8420.9 8472.0 8599.8 8729.3 11851.2 12108.0 12383.6 12490.1 12677.8 10315.2 10747.5 10837.5 10989.8 11126.7 10380.2 10440.5 10540.6 10661.0 10696.4 10335.9 10982.8 11104.5 11131.3 11131.9 7057.2 8437.5 8438.9 8507.2 8610.6 10149.9 10689.6 10812.5 10820.7 11075.4 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | [#3] mootools.html Cycles:180 Average:6002.34 Median:2497.07 stddev:3510.59 (140.6%) stddev-sans-first:3501.56 14:31:55 INFO - PROCESS | 32161 | Values: 1158.7 1440.9 1464.7 1604.7 1811.1 8548.5 8941.4 8952.9 9265.9 9288.2 8979.7 9171.3 9180.4 9180.5 9182.5 2078.6 2307.7 2385.2 2407.4 2439.3 2408.3 2413.7 2413.8 2416.0 2417.0 2384.7 2394.6 2424.1 2426.8 2429.8 1983.0 2239.2 2292.0 2307.3 2317.5 2347.8 2355.3 2364.0 2369.2 2372.3 8800.0 8880.6 8884.3 8890.8 8895.2 5310.1 5436.7 5437.8 5443.9 5462.4 3268.9 3312.9 3332.3 3363.8 3520.3 1037.2 1055.0 1059.4 1074.1 1093.9 13111.0 13122.1 13132.3 13147.9 13154.7 4773.7 4781.8 4865.2 4881.6 4898.0 10736.2 10743.7 10750.8 10819.9 10828.9 5455.3 5462.9 5468.2 5481.3 5487.0 4269.8 4908.1 5032.4 5041.5 5127.2 4104.3 4123.3 4143.8 4168.9 4175.1 1257.2 1273.0 1281.1 1285.9 1290.6 1002.1 1037.5 1050.3 1052.4 1052.9 6123.2 6259.4 6269.9 6316.0 6360.1 465.3 469.2 471.8 475.7 484.0 4287.2 4408.3 4458.9 4504.0 4528.9 11661.7 11763.3 11868.3 11893.9 11894.4 11574.7 11719.2 11742.3 11767.0 11780.5 8115.9 8452.6 8461.3 8663.2 8675.2 6179.7 6449.5 6518.3 6559.0 6577.4 10395.6 10667.3 10680.2 10680.8 10693.3 10341.7 10642.7 10725.9 10843.1 10862.3 6984.7 7768.0 7946.7 7950.8 8167.8 8584.0 8861.3 8868.6 8872.9 8912.7 7585.6 7614.3 7743.1 7819.6 7857.1 7419.6 7444.1 7468.4 7487.1 7664.8 7084.3 7151.6 7155.8 7176.8 7180.3 5121.2 5218.1 5329.9 5374.4 5435.4 5161.7 5179.5 5219.5 5312.2 5361.6 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | [#4] prototype.html Cycles:180 Average:4571.33 Median:5130.85 stddev:1347.36 (26.3%) stddev-sans-first:1312.92 14:31:55 INFO - PROCESS | 32161 | Values: 325.7 330.4 336.0 336.0 338.4 5246.7 5273.6 5285.6 5297.6 5341.8 5230.3 5251.0 5251.6 5254.7 5260.6 3902.6 3976.3 4128.4 4142.5 4142.9 4091.3 4093.5 4101.8 4113.0 4118.3 3894.3 4081.7 4091.4 4094.3 4100.8 3824.5 4010.4 4016.1 4062.0 4099.2 3649.9 3652.3 3655.8 3672.9 3675.6 5042.2 5067.4 5070.2 5118.4 5127.0 4500.8 4718.8 4729.1 4733.2 4739.0 5448.4 5478.9 5481.5 5492.1 5499.5 4021.7 4024.3 4024.6 4027.9 4032.5 5392.3 5707.8 5709.5 5750.4 5770.0 3972.5 3974.4 4015.2 4024.6 4028.5 4075.5 4077.6 4079.9 4081.3 4083.7 4453.7 4679.3 4689.3 4690.8 4702.4 5472.0 5525.8 5567.0 5575.1 5584.9 1379.9 1383.5 1401.3 1401.8 1402.7 850.2 868.8 891.7 904.8 906.8 5168.6 5266.3 5269.0 5291.4 5297.4 5672.2 5679.9 5682.3 5703.1 5707.0 5007.1 5269.9 5292.8 5302.6 5320.9 2961.7 2999.0 3017.8 3027.4 3034.4 5848.3 5857.0 5868.1 5924.3 5929.9 5529.7 5647.5 5751.7 5751.7 5761.9 5803.1 5809.6 5829.0 5858.0 5908.9 5374.4 5618.8 5626.5 5640.2 5750.5 5585.0 5607.1 5615.0 5627.7 5627.8 5819.4 5826.6 5831.5 5834.9 5865.2 3582.4 3631.2 3642.6 3732.1 3741.3 5062.3 5134.7 5166.3 5198.2 5211.3 4884.8 4965.8 5015.8 5055.5 5060.4 4774.8 4881.8 4903.5 4985.4 5035.5 4899.6 4923.7 4949.0 4969.9 5270.0 5304.3 5507.9 5510.9 5524.9 5526.1 5403.0 5430.4 5455.6 5470.4 5522.7 14:31:55 INFO - PROCESS | 32161 | 14:31:55 INFO - PROCESS | 32161 | [#5] yui.html Cycles:180 Average:20737.13 Median:4643.84 stddev:29604.77 (637.5%) stddev-sans-first:29649.84 14:31:55 INFO - PROCESS | 32161 | Values: 766.3 795.7 796.6 809.5 817.8 13314.5 13726.4 13757.3 13781.2 13804.5 14793.0 15220.1 15579.1 15693.2 15720.2 515.5 517.1 518.7 527.5 688.2 815.9 833.9 839.8 846.2 846.8 870.7 871.4 871.4 871.5 872.7 724.8 739.4 864.2 865.4 865.4 547.3 612.9 631.3 631.5 638.1 15958.4 15996.9 16010.3 16040.4 16087.8 14238.9 14568.3 14615.7 14670.3 14771.2 12648.7 12779.5 12790.4 12974.1 13447.7 4536.4 4615.7 4657.5 4664.5 4792.6 77897.0 77928.0 78261.6 78623.2 78807.6 11108.9 11404.4 11425.9 11458.1 11563.8 20489.7 20496.9 20501.2 20526.8 20532.4 8430.2 8626.9 8658.0 8676.4 8788.4 4447.6 4487.8 4623.1 4638.4 4649.3 3439.2 3531.3 3535.2 3539.4 3539.5 618.7 618.8 627.9 645.8 655.7 607.8 657.5 681.7 693.5 702.5 9353.5 9625.0 9642.7 9674.3 9789.5 555.9 613.9 647.4 658.3 677.7 4261.7 4374.4 4378.3 4460.6 4473.2 110691.0 112124.4 116340.6 117018.4 117499.0 92934.5 94567.0 95442.0 97485.5 98873.0 86013.6 86782.0 86919.6 86953.6 86991.6 7897.8 7935.0 8042.8 8108.0 8321.3 50021.5 51773.0 52004.7 52331.5 52978.2 64293.4 66737.0 72378.0 73071.3 74257.6 13309.2 13393.3 13507.2 13551.2 13895.7 15581.8 15837.3 15896.8 16192.0 16426.1 10018.7 13452.2 14366.9 14532.2 14626.6 13020.5 13439.5 13697.0 14003.2 14797.3 13880.2 13963.0 13966.4 14414.2 14467.6 11532.5 11683.5 11895.4 11902.8 12384.6 11485.0 11635.8 11878.5 12123.3 12138.5 14:31:55 INFO - PROCESS | 32161 | -------- Summary: end -------- 14:31:55 INFO - PROCESS | 32161 | 14:31:56 INFO - TEST-INFO | 32161: exit 0 14:31:56 INFO - TEST-OK | dromaeo_css | took 1114940ms 14:31:56 INFO - TEST-START | kraken 14:31:56 INFO - operating with platform_type : linux_ 14:31:56 INFO - Initialising browser for kraken test... 14:31:56 INFO - TEST-INFO | started process 32344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVk5e3w/profile http://localhost:43320/getInfo.html) 14:32:00 INFO - PROCESS | 32344 | __metrics Screen width/height:1600/1200 14:32:00 INFO - PROCESS | 32344 | colorDepth:24 14:32:00 INFO - PROCESS | 32344 | Browser inner width/height: 1024/697 14:32:00 INFO - PROCESS | 32344 | __metrics 14:32:02 ERROR - PROCESS | 32344 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:32:02 INFO - PROCESS | 32344 | console.error: PushService: 14:32:02 INFO - PROCESS | 32344 | stateChangeProcessEnqueue: Error transitioning state 14:32:02 INFO - PROCESS | 32344 | UnknownError 14:32:03 INFO - TEST-INFO | 32344: exit 0 14:32:03 INFO - Browser initialized. 14:32:03 INFO - Running cycle 1/1 for kraken test... 14:32:03 INFO - TEST-INFO | started process 32429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVk5e3w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:14 INFO - PROCESS | 32429 | RSS: Main: 155570176 14:32:14 INFO - PROCESS | 32429 | 14:32:17 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43320/tests/kraken/driver.html?testName=audio-beat-detection) 14:32:18 INFO - PROCESS | 32429 | RSS: Main: 214413312 14:32:18 INFO - PROCESS | 32429 | 14:32:20 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43320/tests/kraken/driver.html?testName=audio-dft) 14:32:21 INFO - PROCESS | 32429 | RSS: Main: 200429568 14:32:21 INFO - PROCESS | 32429 | 14:32:24 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43320/tests/kraken/driver.html?testName=audio-fft) 14:32:25 INFO - PROCESS | 32429 | RSS: Main: 267968512 14:32:25 INFO - PROCESS | 32429 | 14:32:27 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43320/tests/kraken/driver.html?testName=audio-oscillator) 14:32:27 INFO - PROCESS | 32429 | RSS: Main: 178962432 14:32:27 INFO - PROCESS | 32429 | 14:32:30 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:32:30 INFO - PROCESS | 32429 | RSS: Main: 182628352 14:32:30 INFO - PROCESS | 32429 | 14:32:33 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43320/tests/kraken/driver.html?testName=imaging-darkroom) 14:32:34 INFO - PROCESS | 32429 | RSS: Main: 219025408 14:32:34 INFO - PROCESS | 32429 | 14:32:37 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43320/tests/kraken/driver.html?testName=imaging-desaturate) 14:32:38 INFO - PROCESS | 32429 | RSS: Main: 219537408 14:32:38 INFO - PROCESS | 32429 | 14:32:41 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43320/tests/kraken/driver.html?testName=json-parse-financial) 14:32:41 INFO - PROCESS | 32429 | RSS: Main: 219656192 14:32:41 INFO - PROCESS | 32429 | 14:32:43 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:32:44 INFO - PROCESS | 32429 | RSS: Main: 206106624 14:32:44 INFO - PROCESS | 32429 | 14:32:45 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:32:46 INFO - PROCESS | 32429 | RSS: Main: 210194432 14:32:46 INFO - PROCESS | 32429 | 14:32:48 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:32:49 INFO - PROCESS | 32429 | RSS: Main: 217489408 14:32:49 INFO - PROCESS | 32429 | 14:32:51 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:32:52 INFO - PROCESS | 32429 | RSS: Main: 222085120 14:32:52 INFO - PROCESS | 32429 | 14:32:55 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:32:55 INFO - PROCESS | 32429 | RSS: Main: 221691904 14:32:55 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | Cycle 1(1): loaded http://localhost:43320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43320/tests/kraken/driver.html?testName=ai-astar) 14:32:57 INFO - PROCESS | 32429 | RSS: Main: 264318976 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | __start_tp_report 14:32:57 INFO - PROCESS | 32429 | _x_x_mozilla_page_load 14:32:57 INFO - PROCESS | 32429 | _x_x_mozilla_page_load_details 14:32:57 INFO - PROCESS | 32429 | |i|pagename|runs| 14:32:57 INFO - PROCESS | 32429 | |0;ai-astar;111;106;109;109;112;111;111;108;110;110 14:32:57 INFO - PROCESS | 32429 | |1;audio-beat-detection;153;126;126;175;125;129;157;124;160;123 14:32:57 INFO - PROCESS | 32429 | |2;audio-dft;162;162;160;162;163;161;161;160;161;160 14:32:57 INFO - PROCESS | 32429 | |3;audio-fft;75;75;74;117;75;75;73;75;102;75 14:32:57 INFO - PROCESS | 32429 | |4;audio-oscillator;84;85;115;83;85;85;120;83;83;132 14:32:57 INFO - PROCESS | 32429 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;116;118;118 14:32:57 INFO - PROCESS | 32429 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;146;146 14:32:57 INFO - PROCESS | 32429 | |7;imaging-desaturate;95;95;96;95;94;94;94;95;95;95 14:32:57 INFO - PROCESS | 32429 | |8;json-parse-financial;54;54;56;53;53;55;54;54;53;54 14:32:57 INFO - PROCESS | 32429 | |9;json-stringify-tinderbox;62;63;62;61;63;62;63;62;62;62 14:32:57 INFO - PROCESS | 32429 | |10;stanford-crypto-aes;80;79;79;79;81;81;80;86;145;80 14:32:57 INFO - PROCESS | 32429 | |11;stanford-crypto-ccm;123;120;121;119;126;129;136;121;137;125 14:32:57 INFO - PROCESS | 32429 | |12;stanford-crypto-pbkdf2;165;161;163;158;170;161;160;165;155;158 14:32:57 INFO - PROCESS | 32429 | |13;stanford-crypto-sha256-iterative;64;63;67;63;63;63;63;63;61;59 14:32:57 INFO - PROCESS | 32429 | __end_tp_report 14:32:57 INFO - PROCESS | 32429 | __start_cc_report 14:32:57 INFO - PROCESS | 32429 | _x_x_mozilla_cycle_collect,1601 14:32:57 INFO - PROCESS | 32429 | __end_cc_report 14:32:57 INFO - PROCESS | 32429 | __startTimestamp1464903177625__endTimestamp 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | ------- Summary: start ------- 14:32:57 INFO - PROCESS | 32429 | Number of tests: 14 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.77 (1.6%) stddev-sans-first:1.81 14:32:57 INFO - PROCESS | 32429 | Values: 111.0 106.0 109.0 109.0 112.0 111.0 111.0 108.0 110.0 110.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:141.00 stddev:19.34 (13.7%) stddev-sans-first:19.91 14:32:57 INFO - PROCESS | 32429 | Values: 153.0 126.0 126.0 175.0 125.0 129.0 157.0 124.0 160.0 123.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 14:32:57 INFO - PROCESS | 32429 | Values: 162.0 162.0 160.0 162.0 163.0 161.0 161.0 160.0 161.0 160.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:15.14 (20.2%) stddev-sans-first:15.87 14:32:57 INFO - PROCESS | 32429 | Values: 75.0 75.0 74.0 117.0 75.0 75.0 73.0 75.0 102.0 75.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:83.50 stddev:18.99 (22.7%) stddev-sans-first:19.68 14:32:57 INFO - PROCESS | 32429 | Values: 84.0 85.0 115.0 83.0 85.0 85.0 120.0 83.0 83.0 132.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 14:32:57 INFO - PROCESS | 32429 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 118.0 118.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:32:57 INFO - PROCESS | 32429 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:32:57 INFO - PROCESS | 32429 | Values: 95.0 95.0 96.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 14:32:57 INFO - PROCESS | 32429 | Values: 54.0 54.0 56.0 53.0 53.0 55.0 54.0 54.0 53.0 54.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 14:32:57 INFO - PROCESS | 32429 | Values: 62.0 63.0 62.0 61.0 63.0 62.0 63.0 62.0 62.0 62.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:80.00 stddev:20.48 (25.6%) stddev-sans-first:21.57 14:32:57 INFO - PROCESS | 32429 | Values: 80.0 79.0 79.0 79.0 81.0 81.0 80.0 86.0 145.0 80.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:125.50 stddev:6.45 (5.1%) stddev-sans-first:6.76 14:32:57 INFO - PROCESS | 32429 | Values: 123.0 120.0 121.0 119.0 126.0 129.0 136.0 121.0 137.0 125.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:4.33 (2.7%) stddev-sans-first:4.41 14:32:57 INFO - PROCESS | 32429 | Values: 165.0 161.0 163.0 158.0 170.0 161.0 160.0 165.0 155.0 158.0 14:32:57 INFO - PROCESS | 32429 | 14:32:57 INFO - PROCESS | 32429 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:2.02 (3.2%) stddev-sans-first:2.11 14:32:57 INFO - PROCESS | 32429 | Values: 64.0 63.0 67.0 63.0 63.0 63.0 63.0 63.0 61.0 59.0 14:32:57 INFO - PROCESS | 32429 | -------- Summary: end -------- 14:32:57 INFO - PROCESS | 32429 | 14:32:58 INFO - TEST-INFO | 32429: exit 0 14:32:58 INFO - TEST-OK | kraken | took 62684ms 14:32:58 INFO - SUITE-END | took 1177s 14:32:58 INFO - Completed test suite (00:19:37) 14:32:58 INFO - javascript benchmark 14:32:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.7682673799463, 3108.7668424868125, 3130.217445638591, 3149.4645910195263, 3160.7945483543567, 5177.119889618764, 5253.86865328367, 5320.441353657863, 5430.1040328345825, 5443.646162999407, 5371.5165635092835, 5375.408705042442, 5379.6503227290195, 5416.07926652469, 5440.945590544094, 4823.493533179018, 4885.4381746099125, 4922.0402021605805, 4933.925991110136, 5082.745862706868, 4944.901101977976, 5009.348784657989, 5027.296178535008, 5054.115529782273, 5055.46917573655, 4775.4985726498735, 4826.855194344175, 4834.154023045953, 4853.757312134379, 4891.633127515451, 4820.276958456225, 4846.5880400166025, 4933.703977761345, 4934.432540257844, 4964.87587810304, 4740.099381117577, 4896.069746748142, 4924.778384972649, 4935.950640493621, 4965.677230979974, 5248.527632513092, 5319.5478384337375, 5340.065488539529, 5400.405955344909, 5412.404635490093, 5750.223719797816, 5795.1886735857015, 5819.592628516006, 5822.854428639275, 5847.8245652630485, 5555.2222688823595, 5701.515371193454, 5818.069108942549, 5845.941540584625, 5849.678267695275, 5366.0, 5476.644018138808, 5489.34127904654, 5491.066518691832, 5494.752736126844, 5975.910361344497, 5983.6708981005595, 5989.431004054608, 5989.610675306091, 5991.5206783457215, 5435.402105768362, 5559.27729395176, 5576.7211639417865, 5742.626729262584, 5751.079827227707, 5755.107958266475, 5796.188533605298, 5797.130430435468, 5798.478136967693, 5801.796937107181, 5654.180143879197, 5681.431856814368, 5719.0, 5719.971400142973, 5727.541796656257, 5566.860828479321, 5644.915326270109, 5698.31620205578, 5712.942870571324, 5729.512991395778, 4407.977960110179, 4408.0, 4408.955910440919, 4410.669199810027, 4443.0, 3917.373220284741, 3932.8230229639735, 3938.1926705025403, 3970.3845903884367, 3995.2409042281874, 5224.059669259494, 5325.973370133124, 5378.381486129145, 5434.646747961449, 5447.373552041487, 5854.0, 5867.647941123546, 5867.970660146672, 5869.119632055141, 5898.321693005273, 5436.592255580847, 5440.6735595864375, 5446.21029950655, 5448.45515448452, 5456.236126942231, 4766.594839438617, 4922.532359425849, 4943.505649435099, 4950.727709975914, 4990.451050384455, 5993.580449368589, 6027.698615069229, 6028.969855150784, 6029.728662210211, 6035.939640603626, 5567.860803479945, 5831.300243970666, 5847.561432892635, 5851.093080572518, 5852.209951656642, 5857.150713146655, 5908.852278693067, 5918.467337939606, 6006.579539432198, 6006.849828754316, 5634.436556344497, 5681.630694004876, 5682.176084467646, 5692.601517893873, 5695.544356451391, 5753.194552762533, 5777.162311464898, 5788.247527821356, 5797.797077102281, 5805.535557155333, 5458.5087342139395, 5589.80435684749, 5618.494335509824, 5636.859078522905, 5710.0, 5690.317161940594, 5704.657720536615, 5705.372409035086, 5706.885862282648, 5713.314402271754, 5305.151175811851, 5598.1602759586385, 5604.607677462538, 5609.27079479665, 5610.326760788732, 5568.777248909998, 5587.441255874543, 5631.802886898939, 5765.740541675718, 5767.509761670305, 5538.584606154635, 5575.721213939368, 5581.6930068846605, 5583.41374155724, 5619.100943848965], "value": 5317.146500422307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.5783288447413, 619.6127420362274, 630.8801327747726, 645.7804346522181, 647.7732793522265, 31846.681533184663, 34256.65743342566, 34297.65702342976, 34305.82847085764, 34334.656653433456, 34636.0, 45324.54675453253, 46350.536494635126, 46420.30369544459, 49851.501484985136, 8721.86917196241, 8865.246454051414, 8887.911120888806, 8891.68879089232, 8901.643934242622, 8600.22597966183, 8791.47251164929, 8810.823783524358, 8811.074837142103, 8818.647254109828, 8836.955815220916, 8890.199882010618, 8902.287816974658, 8905.0, 8912.777180570505, 8845.690400835972, 8902.777430564223, 8916.465012099296, 8921.063288354695, 8922.286217102648, 8810.69162579313, 8897.644094236222, 8907.06475820036, 8914.0, 8914.50970196639, 42281.0, 42356.3646545302, 42639.7868010658, 42737.57262427367, 42866.35700464464, 3355.7818741781707, 3520.3839328117733, 3557.6442355764216, 4159.542450330461, 4293.549177336366, 30100.0, 30184.54723179154, 30190.0942971709, 30340.69659303401, 30370.088897333117, 3953.6639385652256, 4210.179015092058, 4389.890252743675, 4482.641388688897, 4491.887702807456, 368748.0, 368972.0, 371508.0, 372592.0, 373374.0, 60093.69953150206, 60099.0, 60534.0, 60535.0, 60592.69703651453, 64452.67773661196, 64519.0, 64557.0, 64611.67694161499, 64746.352536474034, 14738.189399582912, 15905.840941590668, 16082.0, 16112.0, 16584.50246492607, 12538.749225015448, 12730.23618582888, 12806.103572750004, 12877.0, 12887.613371598867, 13673.863261367458, 14558.563243102511, 14747.0, 14811.333489992976, 14871.47949821751, 6948.27043160471, 6958.0, 7045.506814523037, 7367.115946086504, 7460.813479662943, 968.3995922528078, 1050.8142317662362, 1057.4871187474068, 1108.933463992163, 1125.7523344864117, 32787.3442531148, 32957.3408531828, 33361.49957750636, 33395.16512087169, 33396.3320733584, 1137.9829302560468, 1190.1966172833304, 1198.26306821306, 1212.4119801896074, 1255.75512775008, 16593.585160371087, 16909.7463538047, 16988.66022679564, 17062.914685426495, 17202.827971720373, 558065.0, 559168.0, 565067.0, 566048.0, 567690.0, 59253.407465924785, 59716.70141649351, 59866.401335986084, 59867.70066149641, 59901.700491497264, 1292.3925754895183, 1390.5272207449516, 1401.5795261421736, 1408.6971301170297, 1421.3532842556613, 30921.0, 31360.372792544476, 31783.0, 31909.68090319067, 32668.50997234996, 51440.0, 52051.47948520466, 52184.73907630437, 52207.477925220264, 52252.73873630608, 427180.0, 437148.0, 438578.0, 438855.0, 441897.0, 24844.627330590418, 26814.195574132806, 27475.0, 28018.159455216377, 28061.438771224868, 38628.6137138625, 39956.20087598173, 47831.5216847827, 48475.0, 49205.81750551243, 34512.82743586266, 35193.47209791906, 35659.64340356667, 35765.82117089502, 36102.45846312255, 41219.7939010303, 41343.0, 41868.0, 42817.57182428136, 42847.14305713931, 42166.789166053975, 42254.577454225066, 42903.35644965265, 43229.351559726, 43374.0, 34746.65253347434, 36929.26141477102, 36942.815285923396, 37288.254234915694, 37508.624913751606, 28584.428311434072, 28919.0, 29002.129936101952, 29006.854965725037, 29012.709872901], "value": 19973.564431922234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6220903514555, 390.9237698648765, 398.9421533877586, 405.4040560376247, 412.8245495664342, 14197.334394270942, 15483.845161548381, 17226.483205503824, 18743.3439829606, 18750.812491875062, 12161.331126788024, 14564.927175364108, 14685.412583496674, 15992.840071599281, 16964.49106526803, 5532.529734972532, 5695.544356451494, 5799.072148456248, 5804.680742559158, 5807.722301093752, 5652.604317697763, 5757.654540727549, 5764.7982320618785, 5812.157237200603, 5813.418658134195, 4159.3968874513175, 5764.625299355549, 6032.819015429544, 6378.553501254914, 6379.425851673349, 5495.450454954513, 6415.1339569158035, 6453.515986301046, 6460.806175814733, 6482.124913136713, 5624.437556244384, 5679.772809087632, 5710.114932185518, 5713.228714123623, 5718.142278658234, 11971.461284242143, 12126.818097728541, 20064.398068057835, 21250.449946006425, 21282.46793830151, 2323.46560291134, 2337.696099507053, 2434.403571125086, 2756.9035083771973, 2884.8990285340124, 9954.5022748863, 10249.590016399336, 12213.816792748026, 13056.0, 13359.0, 1818.4453741608804, 1853.6478069166815, 1867.766529183852, 1867.9813201867944, 1875.7092650639172, 75634.0, 78909.60545197295, 81434.0, 81876.59061704653, 82699.0, 10792.406417647106, 11014.39420831862, 11098.223124381217, 11208.607698730506, 11357.772844543228, 15403.84596154024, 15531.767023494656, 15535.84464155344, 15541.222938853238, 15574.688506229812, 7166.140063192451, 7596.278353556403, 7695.730649427355, 7835.098963619257, 7971.8405631887035, 7814.804629884185, 7842.137364889858, 7896.921030789734, 8003.839923201504, 8024.799380015546, 4727.669063165614, 4742.264948932921, 4785.401824771903, 4790.760461976957, 4840.2255639097575, 1925.6726356519425, 1931.2854243929555, 1949.6783030800043, 1995.082262159423, 2052.887091209998, 946.6024269806697, 956.4213650741341, 965.9661911833052, 968.3463662028103, 980.5048450532578, 17568.29726810939, 17881.37415190488, 18476.630467390845, 18774.812251877305, 18875.528111797314, 929.2380248196549, 1009.6869970309081, 1017.389566260238, 1021.3361315145066, 1043.426115636412, 10033.949830250802, 10252.38485690861, 10369.325993810378, 10374.533146008447, 10391.116755075753, 498923.0, 502542.0, 504005.0, 504565.0, 504594.0, 84076.0, 85531.57234213913, 86533.0, 87565.0, 87753.0, 979.7256768104942, 982.4694664880884, 1001.1890368801294, 1002.5388321372104, 1027.3938376357835, 15636.68726625484, 16347.509574712778, 16536.338546458006, 16746.83253167453, 16932.40736574214, 39922.846717505316, 40909.315982848006, 40940.38589421221, 40977.77066688004, 41843.0, 42847.9288017802, 43896.78051609721, 51719.482805171465, 51753.0, 55117.44882551284, 8110.471760929326, 8420.873686894824, 8472.0, 8599.785005374666, 8729.25801306896, 11851.229670071418, 12108.0, 12383.566575169825, 12490.125691201529, 12677.8098328527, 10315.226358023028, 10747.516361763895, 10837.512311945824, 10989.835152472559, 11126.666200014013, 10380.169586432916, 10440.477976101316, 10540.57837686484, 10661.0, 10696.41169735672, 10335.94832025865, 10982.780344392908, 11104.500297486795, 11131.332120072822, 11131.888681113085, 7057.153141623038, 8437.493750374751, 8438.873416898874, 8507.191816777397, 8610.569471526273, 10149.898501014895, 10689.572417103229, 10812.459377031275, 10820.729481763019, 11075.446227688744], "value": 8904.572354079452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1158.6813626252786, 1440.8847292216624, 1464.6631274806793, 1604.6710424363007, 1811.1487600827616, 8548.48709077455, 8941.374103812728, 8952.910470895296, 9265.90734092659, 9288.164065234128, 8979.730608081769, 9171.266298696106, 9180.357374983738, 9180.495072770995, 9182.494962777044, 2078.5842831433697, 2307.711536057993, 2385.224801939368, 2407.42221866752, 2439.2682195341417, 2408.349745568695, 2413.6741539892064, 2413.78275955164, 2416.0, 2417.0, 2384.7257565380028, 2394.580948334043, 2424.054618698709, 2426.7694569016003, 2429.757024297574, 1982.9900850495728, 2239.2274665240466, 2291.9770802292014, 2307.261676263596, 2317.4901521665206, 2347.788699017097, 2355.2698663414394, 2363.976360236393, 2369.206315884181, 2372.3120295114395, 8799.956000220021, 8880.644774209024, 8884.333674974338, 8890.777730556723, 8895.154960278764, 5310.070737620939, 5436.728163591844, 5437.809676661298, 5443.945560544384, 5462.371827239878, 3268.8692452302116, 3312.867485300585, 3332.266901281714, 3363.814990175539, 3520.295940811822, 1037.1858091398292, 1054.9894501054969, 1059.3908502610952, 1074.0816601805423, 1093.9015488606065, 13111.016673749411, 13122.14706044104, 13132.34338283082, 13147.86852131476, 13154.671133221651, 4773.702518160322, 4781.808727650855, 4865.245886887538, 4881.633877459205, 4898.044881248194, 10736.194785390971, 10743.677689669323, 10750.838737418788, 10819.891801082045, 10828.891711082946, 5455.345358556999, 5462.863428414242, 5468.152436372368, 5481.314835645544, 5487.039768040577, 4269.807858646368, 4908.092002979461, 5032.446430892599, 5041.521055499722, 5127.230915362726, 4104.261232978033, 4123.299039163349, 4143.759416501219, 4168.916621667549, 4175.123224122907, 1257.2330878164312, 1272.9872701273055, 1281.077624110639, 1285.864984176648, 1290.6321698315935, 1002.1131298800614, 1037.5331101004579, 1050.2963014780116, 1052.4211683574003, 1052.9262951593314, 6123.234595675541, 6259.374062593704, 6269.8746025079245, 6316.0, 6360.109584658151, 465.26720415345966, 469.23046204225096, 471.80868307523093, 475.7121941225578, 483.99032019359413, 4287.249731297011, 4408.338749187647, 4458.866234012985, 4503.986603014361, 4528.864134075983, 11661.708457288465, 11763.294202347886, 11868.287902725864, 11893.940530297466, 11894.405279735978, 11574.71063223426, 11719.179657424069, 11742.295462272292, 11767.0, 11780.528778848922, 8115.918840811634, 8452.57737113142, 8461.2807911327, 8663.176998185163, 8675.175858293453, 6179.721912513858, 6449.5485316027425, 6518.2504012037325, 6558.967205164135, 6577.408033277028, 10395.636152734618, 10667.253292269466, 10680.198985076306, 10680.786384272116, 10693.251472396858, 10341.689749307532, 10642.73393165177, 10725.892741072801, 10843.132549395872, 10862.293950893167, 6984.685689144102, 7767.961160194162, 7946.721864734938, 7950.801229969297, 8167.836643266983, 8584.0, 8861.291096712119, 8868.600912959062, 8872.911270887467, 8912.73261802147, 7585.62071896414, 7614.2766437188375, 7743.148253691977, 7819.569923654253, 7857.096433909945, 7419.629018548943, 7444.143923448656, 7468.365188958999, 7487.138979017483, 7664.846703066019, 7084.25615310385, 7151.60666163366, 7155.785326440215, 7176.820579485555, 7180.281971802778, 5121.180611102355, 5218.139007063792, 5329.920051199313, 5374.4088150304215, 5435.429279925709, 5161.716105614228, 5179.533841954242, 5219.5041471060185, 5312.203169524602, 5361.624686271924], "value": 4680.642819716756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.6661921530431, 330.3937275100191, 335.9953738322417, 336.04060407536485, 338.36049865753716, 5246.711430871305, 5273.604479664026, 5285.550728188099, 5297.602679799012, 5341.786328546863, 5230.267762513251, 5251.0, 5251.606129540281, 5254.6847189168675, 5260.605454590902, 3902.590228026052, 3976.2643910876436, 4128.401381799637, 4142.46148000761, 4142.937855932163, 4091.284025295576, 4093.5292441369324, 4101.835926562949, 4112.97943510282, 4118.290909272649, 3894.279558281727, 4081.653059489947, 4091.3862920562005, 4094.283500387435, 4100.774457404841, 3824.4836947012077, 4010.3583426651594, 4016.116454380032, 4062.0, 4099.241640296555, 3649.94525082124, 3652.3060618482405, 3655.7935881159156, 3672.889813305605, 3675.6324367563298, 5042.218456139304, 5067.366579177603, 5070.163423035195, 5118.385793704742, 5126.974365128188, 4500.774961251925, 4718.764061796896, 4729.148753224418, 4733.219018861883, 4738.976305118486, 5448.365490352879, 5478.945210547883, 5481.479259470344, 5492.1212605982855, 5499.477549632778, 4021.698372622065, 4024.3158663027357, 4024.5975402459812, 4027.939580906289, 4032.507972050331, 5392.325959255093, 5707.800226992077, 5709.486146246858, 5750.3962083981, 5769.971150144264, 3972.5232972042963, 3974.423708562242, 4015.2371049500503, 4024.6176613221696, 4028.4964379452567, 4075.5109386873764, 4077.5922407758985, 4079.8980025499004, 4081.3469844824685, 4083.734557253769, 4453.665975051884, 4679.251319788817, 4689.273162659793, 4690.812367505261, 4702.365180700562, 5472.0, 5525.778968841201, 5567.0216434207505, 5575.0522411190195, 5584.944150558524, 1379.903406761517, 1383.522684673786, 1401.278341654049, 1401.8107555480083, 1402.7404930087762, 850.2093053460218, 868.8045189832237, 891.6567121658209, 904.8326059678981, 906.7551761024487, 5168.586513078944, 5266.315379000705, 5268.9736551317, 5291.417944026154, 5297.417284098746, 5672.234248376499, 5679.8864022720145, 5682.261306030189, 5703.144528320785, 5706.971465142731, 5007.122329126578, 5269.894602107936, 5292.788288468418, 5302.575793936476, 5320.866978325495, 2961.659409167973, 2998.9550156747664, 3017.7887547871437, 3027.409655117275, 3034.4082903833983, 5848.2689663792025, 5857.0, 5868.092869817327, 5924.289085309791, 5929.940700593025, 5529.668219906818, 5647.519960803378, 5751.654900705971, 5751.683657398883, 5761.9135712964335, 5803.142994241802, 5809.564282678816, 5829.038208695518, 5858.0, 5908.881822363614, 5374.435684253097, 5618.831435056954, 5626.521745651502, 5640.23856779346, 5750.453706897838, 5585.0, 5607.102863541813, 5615.0, 5627.664519224476, 5627.774889004558, 5819.447152520504, 5826.592138550261, 5831.533477321889, 5834.94165058344, 5865.208196893535, 3582.4206571268646, 3631.2374401376005, 3642.6357364263363, 3732.1229511064334, 3741.30785804627, 5062.291279220838, 5134.717590532557, 5166.328377310925, 5198.246254293031, 5211.348581427322, 4884.803223210336, 4965.8013679452415, 5015.824446144367, 5055.545000949932, 5060.443351231435, 4774.779727426763, 4881.804727810848, 4903.53416425439, 4985.351904252424, 5035.5468007878, 4899.603612970286, 4923.704577725348, 4948.960718249064, 4969.900601988013, 5270.0, 5304.310439642822, 5507.944920550904, 5510.889782204254, 5524.889502209853, 5526.143447765603, 5403.0, 5430.375506816767, 5455.618106732491, 5470.370907345706, 5522.723863806874], "value": 4142.3310518345315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2911806578917, 795.7175202803002, 796.5937371940311, 809.5426084262396, 817.7628487738556, 13314.467421303149, 13726.382312795924, 13757.31213439329, 13781.242031688253, 13804.516841910548, 14793.0, 15220.086794792292, 15579.065256084643, 15693.21533923305, 15720.213989300546, 515.4973900447053, 517.1208944793847, 518.6758276077461, 527.4857014410957, 688.2463702246033, 815.8857759913587, 833.8707500337457, 839.7774589733725, 846.1538461538462, 846.8010017645879, 870.7170169694842, 871.3813192633238, 871.4335681806813, 871.5075982070142, 872.6814712629908, 724.77169691547, 739.4158614694385, 864.1919804982361, 865.3639574912435, 865.4417900454204, 547.3295213363638, 612.9172561704157, 631.2929518938772, 631.4601016131234, 638.1034646321879, 15958.361665533364, 15996.920015399848, 16010.279537420844, 16040.43858464948, 16087.839121608751, 14238.92880535601, 14568.271586420637, 14615.707685846224, 14670.266486675624, 14771.187584682839, 12648.68378290541, 12779.488820447172, 12790.360481975864, 12974.091813573054, 13447.66380840477, 4536.432945881765, 4615.71393724582, 4657.510961349078, 4664.463586687507, 4792.592629626486, 77897.0, 77928.0, 78261.60869195675, 78623.21376786217, 78807.6059619704, 11108.944455277671, 11404.372759498307, 11425.914538118865, 11458.08335333188, 11563.826542601868, 20489.692654610193, 20496.897515512326, 20501.17995280202, 20526.794732052786, 20532.38402847917, 8430.156984301644, 8626.870596941051, 8657.95671021641, 8676.392652514389, 8788.42875213109, 4447.644188464915, 4487.753173575485, 4623.12160689468, 4638.420197475316, 4649.256119020941, 3439.1574064354395, 3531.258435728526, 3535.1515636247113, 3539.3629146753315, 3539.5398598182073, 618.6844709198251, 618.8391018335266, 627.9277883043417, 645.7804346522205, 655.7344275568403, 607.7994261893565, 657.5200103924162, 681.655763839258, 693.5214701855704, 702.4591064880013, 9353.532323383804, 9624.951875240578, 9642.71071867831, 9674.274429417821, 9789.46157961319, 555.9210038231946, 613.883362161188, 647.3946859686114, 658.325216652925, 677.7221339250982, 4261.744295342228, 4374.365716971021, 4378.299472084451, 4460.620847227957, 4473.172463094338, 110691.0, 112124.43937780258, 116340.6311489694, 117018.41490792492, 117499.0, 92934.53532732293, 94567.0, 95442.0, 97485.51257243668, 98873.0, 86013.56993214994, 86781.99999999873, 86919.56540217258, 86953.56523217344, 86991.56504217438, 7897.763067107996, 7935.0, 8042.758717238492, 8108.0, 8321.292690121165, 50021.49978500314, 51773.0, 52004.739976299876, 52331.476685234185, 52978.18230491123, 64293.35706642874, 66736.99894501684, 72378.0, 73071.26928730645, 74257.6287118561, 13309.239393591353, 13393.295906362911, 13507.189568625914, 13551.186928784304, 13895.657980634294, 15581.844181558039, 15837.287322070304, 15896.841031589998, 16192.0, 16426.096564689058, 10018.699439016842, 13452.192868427926, 14366.897266175602, 14532.200728960008, 14626.634334141732, 13020.47918083266, 13439.529616463376, 13697.0, 14003.22982235946, 14797.334119964842, 13880.16718996823, 13963.024777262153, 13966.37151328213, 14414.207218603078, 14467.565973020826, 11532.481038353462, 11683.532658693557, 11895.405229738652, 11902.821457678316, 12384.56654017105, 11484.966353028267, 11635.825462618237, 11878.465469054086, 12123.29449258035, 12138.453769580214], "value": 7490.919936283472, "unit": "score"}], "name": "dromaeo_css", "value": 7183.117304424759, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 109.0, 109.0, 112.0, 111.0, 111.0, 108.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 126.0, 175.0, 125.0, 129.0, 157.0, 124.0, 160.0, 123.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 162.0, 163.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 117.0, 75.0, 75.0, 73.0, 75.0, 102.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 115.0, 83.0, 85.0, 85.0, 120.0, 83.0, 83.0, 132.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 53.0, 53.0, 55.0, 54.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 81.0, 81.0, 80.0, 86.0, 145.0, 80.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 121.0, 119.0, 126.0, 129.0, 136.0, 121.0, 137.0, 125.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 163.0, 158.0, 170.0, 161.0, 160.0, 165.0, 155.0, 158.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 67.0, 63.0, 63.0, 63.0, 63.0, 63.0, 61.0, 59.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1498.6, "alertThreshold": 2.0}]} 14:32:58 INFO - Return code: 0 14:32:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:32:58 ERROR - # TBPL SUCCESS # 14:32:58 INFO - Running post-action listener: _resource_record_post_action 14:32:58 INFO - ##### 14:32:58 INFO - ##### Finished run-tests step (success) 14:32:58 INFO - ##### 14:32:58 INFO - Running post-run listener: _resource_record_post_run 14:32:59 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 539627520; Read time: 0; Write time: 1207380 14:32:59 INFO - TinderboxPrint: CPU usage
13.3% 14:32:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:32:59 INFO - TinderboxPrint: I/O write bytes / time
539,627,520 / 1,207,380 14:32:59 INFO - TinderboxPrint: CPU idle
8,278.5 (86.7%) 14:32:59 INFO - TinderboxPrint: CPU user
1,211.0 (12.7%) 14:32:59 INFO - TinderboxPrint: Swap in / out
0 / 0 14:32:59 INFO - install - Wall time: 18s; CPU: 16.0%; Read bytes: 0; Write bytes: 247873536; Read time: 0; Write time: 648780 14:32:59 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289419264; Read time: 0; Write time: 558360 14:32:59 INFO - Running post-run listener: _upload_blobber_files 14:32:59 INFO - Blob upload gear active. 14:32:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:59 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:32:59 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:32:59 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:33:00 INFO - (blobuploader) - INFO - Open directory for files ... 14:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:33:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:04 INFO - (blobuploader) - INFO - Done attempting. 14:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:33:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:05 INFO - (blobuploader) - INFO - Done attempting. 14:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:06 INFO - (blobuploader) - INFO - Done attempting. 14:33:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:33:06 INFO - Return code: 0 14:33:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:33:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:33:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7da3e4cf43fdbcedc27313a4980d4b5abe8a1c9321048a4cf93cfeccb78976edec0a91c0e860f024d2d442cf04e51d3e5b739d0e8f13817d93658fd54afe881a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdb3245691b89bb6c0a26fbab53953a22a7ad236b7b29b87bec2b171f81bd14496faf3472dfb9959deb86d34ea7dafe8dffc1208e89c3bb5ddba910d5510fe43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35e0149984435efac7648bd7deed83cfcd413c271f2b1724140e68adaff8144356f4bb701d756c5fcee48b336cae8e676c4bef68a213a193d33355c00e74318c"} 14:33:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:33:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:33:06 INFO - Contents: 14:33:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7da3e4cf43fdbcedc27313a4980d4b5abe8a1c9321048a4cf93cfeccb78976edec0a91c0e860f024d2d442cf04e51d3e5b739d0e8f13817d93658fd54afe881a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdb3245691b89bb6c0a26fbab53953a22a7ad236b7b29b87bec2b171f81bd14496faf3472dfb9959deb86d34ea7dafe8dffc1208e89c3bb5ddba910d5510fe43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35e0149984435efac7648bd7deed83cfcd413c271f2b1724140e68adaff8144356f4bb701d756c5fcee48b336cae8e676c4bef68a213a193d33355c00e74318c"} 14:33:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:33:06 INFO - Copying logs to upload dir... 14:33:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:33:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.999101 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-02 14:33:06.213036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 14:33:06.217542) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887 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/7da3e4cf43fdbcedc27313a4980d4b5abe8a1c9321048a4cf93cfeccb78976edec0a91c0e860f024d2d442cf04e51d3e5b739d0e8f13817d93658fd54afe881a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdb3245691b89bb6c0a26fbab53953a22a7ad236b7b29b87bec2b171f81bd14496faf3472dfb9959deb86d34ea7dafe8dffc1208e89c3bb5ddba910d5510fe43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35e0149984435efac7648bd7deed83cfcd413c271f2b1724140e68adaff8144356f4bb701d756c5fcee48b336cae8e676c4bef68a213a193d33355c00e74318c"} 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.011423 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/7da3e4cf43fdbcedc27313a4980d4b5abe8a1c9321048a4cf93cfeccb78976edec0a91c0e860f024d2d442cf04e51d3e5b739d0e8f13817d93658fd54afe881a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdb3245691b89bb6c0a26fbab53953a22a7ad236b7b29b87bec2b171f81bd14496faf3472dfb9959deb86d34ea7dafe8dffc1208e89c3bb5ddba910d5510fe43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35e0149984435efac7648bd7deed83cfcd413c271f2b1724140e68adaff8144356f4bb701d756c5fcee48b336cae8e676c4bef68a213a193d33355c00e74318c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 14:33:06.250699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:33:06.251062) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464901944.716398-666040887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 14:33:06.331506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 14:33:06.331841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 14:33:06.332211) ========= ========= Total master_lag: 0.18 =========