builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1466181146.87 results: success (0) buildid: 20160617062337 builduid: d6c13d86140e4680b93364e2a96ef394 revision: 535a13bd2bf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:26.868378) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:26.868885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:26.869171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:26.883866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:26.884202) ========= 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=1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 09:32:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.8M=0s 2016-06-17 09:32:27 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:27.025084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:27.025401) ========= 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=1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019142 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:27.081297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-17 09:32:27.084717) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 535a13bd2bf9 --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 535a13bd2bf9 --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=1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 09:32:27,222 Setting DEBUG logging. 2016-06-17 09:32:27,222 attempt 1/10 2016-06-17 09:32:27,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/535a13bd2bf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 09:32:28,316 unpacking tar archive at: fx-team-535a13bd2bf9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.450760 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-17 09:32:28.549098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:28.552333) ========= script_repo_revision: 535a13bd2bf9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:28.552934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:28.553225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 09:32:28.571918) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-17 09:32:28.572359) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:28 INFO - MultiFileLogger online at 20160617 09:32:28 in /builds/slave/test 09:32:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:32:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:28 INFO - {'append_to_log': False, 09:32:28 INFO - 'base_work_dir': '/builds/slave/test', 09:32:28 INFO - 'blob_upload_branch': 'Fx-Team', 09:32:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:28 INFO - 'branch': 'Fx-Team', 09:32:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:28 INFO - 'config_files': ('talos/linux_config.py',), 09:32:28 INFO - 'default_actions': ('clobber', 09:32:28 INFO - 'read-buildbot-config', 09:32:28 INFO - 'download-and-extract', 09:32:28 INFO - 'populate-webroot', 09:32:28 INFO - 'create-virtualenv', 09:32:28 INFO - 'install', 09:32:28 INFO - 'run-tests'), 09:32:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:28 INFO - 'download_minidump_stackwalk': True, 09:32:28 INFO - 'download_symbols': 'ondemand', 09:32:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:28 INFO - 'installer_path': 'installer.exe', 09:32:28 INFO - 'log_level': 'info', 09:32:28 INFO - 'log_name': 'talos', 09:32:28 INFO - 'log_to_console': True, 09:32:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:28 INFO - 'opt_config_files': (), 09:32:28 INFO - 'pip_index': False, 09:32:28 INFO - 'sps_profile': False, 09:32:28 INFO - 'sps_profile_interval': 0, 09:32:28 INFO - 'suite': 'dromaeojs-e10s', 09:32:28 INFO - 'system_bits': '32', 09:32:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:28 INFO - 'title': 'talos-linux64-ix-027', 09:32:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:28 INFO - 'use_talos_json': True, 09:32:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:28 INFO - 'work_dir': 'build'} 09:32:28 INFO - ##### 09:32:28 INFO - ##### Running clobber step. 09:32:28 INFO - ##### 09:32:28 INFO - Running pre-action listener: _resource_record_pre_action 09:32:28 INFO - Running main action method: clobber 09:32:28 INFO - rmtree: /builds/slave/test/build 09:32:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:29 INFO - Running post-action listener: _resource_record_post_action 09:32:29 INFO - ##### 09:32:29 INFO - ##### Finished clobber step (success) 09:32:29 INFO - ##### 09:32:29 INFO - ##### 09:32:29 INFO - ##### Running read-buildbot-config step. 09:32:29 INFO - ##### 09:32:29 INFO - Running pre-action listener: _resource_record_pre_action 09:32:29 INFO - Running main action method: read_buildbot_config 09:32:29 INFO - Using buildbot properties: 09:32:29 INFO - { 09:32:29 INFO - "project": "", 09:32:29 INFO - "product": "firefox", 09:32:29 INFO - "script_repo_revision": "production", 09:32:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:32:29 INFO - "repository": "", 09:32:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:32:29 INFO - "buildid": "20160617062337", 09:32:29 INFO - "pgo_build": "True", 09:32:29 INFO - "basedir": "/builds/slave/test", 09:32:29 INFO - "buildnumber": 840, 09:32:29 INFO - "slavename": "talos-linux64-ix-027", 09:32:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:32:29 INFO - "platform": "ubuntu64_hw", 09:32:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:32:29 INFO - "branch": "fx-team", 09:32:29 INFO - "repo_path": "integration/fx-team", 09:32:29 INFO - "revision": "535a13bd2bf9", 09:32:29 INFO - "stage_platform": "linux64-pgo", 09:32:29 INFO - "builduid": "d6c13d86140e4680b93364e2a96ef394", 09:32:29 INFO - "slavebuilddir": "test" 09:32:29 INFO - } 09:32:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:32:29 INFO - Running post-action listener: _resource_record_post_action 09:32:29 INFO - ##### 09:32:29 INFO - ##### Finished read-buildbot-config step (success) 09:32:29 INFO - ##### 09:32:29 INFO - ##### 09:32:29 INFO - ##### Running download-and-extract step. 09:32:29 INFO - ##### 09:32:29 INFO - Running pre-action listener: _resource_record_pre_action 09:32:29 INFO - Running main action method: download_and_extract 09:32:29 INFO - mkdir: /builds/slave/test/build/tests 09:32:29 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')]} 09:32:29 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:32:30 INFO - Downloaded 1361 bytes. 09:32:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:32:30 INFO - Using the following test package requirements: 09:32:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:32:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:32:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'jsshell-linux-x86_64.zip'], 09:32:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:32:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:32:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:32:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:32:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:32:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:30 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:31 INFO - Downloaded 24220995 bytes. 09:32:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:32:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:32:32 INFO - Return code: 0 09:32:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:32:32 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')]} 09:32:32 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:34 INFO - Downloaded 24220995 bytes. 09:32:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:32:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:32:35 INFO - Return code: 0 09:32: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')]} 09:32:35 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:32:36 INFO - Downloaded 14405384 bytes. 09:32:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:32:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:32:36 INFO - Return code: 0 09:32:36 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')]} 09:32:36 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:32:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:32:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:32:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:32:38 INFO - Downloaded 59389271 bytes. 09:32:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:32:38 INFO - mkdir: /builds/slave/test/properties 09:32:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:38 INFO - Contents: 09:32:38 INFO - build_url:https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:32:39 INFO - Running post-action listener: _resource_record_post_action 09:32:39 INFO - Running post-action listener: set_extra_try_arguments 09:32:39 INFO - ##### 09:32:39 INFO - ##### Finished download-and-extract step (success) 09:32:39 INFO - ##### 09:32:39 INFO - ##### 09:32:39 INFO - ##### Running populate-webroot step. 09:32:39 INFO - ##### 09:32:39 INFO - Running pre-action listener: _resource_record_pre_action 09:32:39 INFO - Running main action method: populate_webroot 09:32:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:39 INFO - '--tppagecycles', 09:32:39 INFO - '7'], 09:32:39 INFO - 'tests': ['tsvgm']}}, 09:32:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['damp', 'tps']}, 09:32:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'tests': ['damp', 'tps']}, 09:32:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['dromaeo_dom']}, 09:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['basic_compositor_video']}, 09:32:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:32:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tsvgx', 09:32:39 INFO - 'tsvgr_opacity', 09:32:39 INFO - 'tart', 09:32:39 INFO - 'tscrollx', 09:32:39 INFO - 'cart']}, 09:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:39 INFO - 'tsvgr_opacity', 09:32:39 INFO - 'tart', 09:32:39 INFO - 'tscrollx', 09:32:39 INFO - 'cart']}, 09:32:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tp5o']}, 09:32:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'tests': ['tp5o']}, 09:32:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s', 09:32:39 INFO - '--xperf_path', 09:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:39 INFO - 'tests': ['tp5n']}, 09:32:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--xperf_path', 09:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:39 INFO - 'tests': ['tp5n']}}, 09:32:39 INFO - 'talos.zip': {'path': '', 09:32:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:39 INFO - Running post-action listener: _resource_record_post_action 09:32:39 INFO - ##### 09:32:39 INFO - ##### Finished populate-webroot step (success) 09:32:39 INFO - ##### 09:32:39 INFO - ##### 09:32:39 INFO - ##### Running create-virtualenv step. 09:32:39 INFO - ##### 09:32:39 INFO - Running pre-action listener: _resource_record_pre_action 09:32:39 INFO - Running main action method: create_virtualenv 09:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:39 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 09:32:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:39 INFO - Using real prefix '/usr' 09:32:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:41 INFO - Installing pip.................done. 09:32:41 INFO - Return code: 0 09:32:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:41 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')]} 09:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:41 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')]} 09:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:41 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:32:41 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 09:32:41 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 09:32:41 INFO - Using env: {'DISPLAY': ':0', 09:32:41 INFO - 'HOME': '/home/cltbld', 09:32:41 INFO - 'LANG': 'en_US.UTF-8', 09:32:41 INFO - 'LANGUAGE': 'en_US:en', 09:32:41 INFO - 'LOGNAME': 'cltbld', 09:32:41 INFO - 'MAIL': '/var/mail/cltbld', 09:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:41 INFO - 'MOZ_NO_REMOTE': '1', 09:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:42 INFO - 'NO_EM_RESTART': '1', 09:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:42 INFO - 'PWD': '/builds/slave/test', 09:32:42 INFO - 'SHELL': '/bin/bash', 09:32:42 INFO - 'SHLVL': '1', 09:32:42 INFO - 'TERM': 'linux', 09:32:42 INFO - 'TMOUT': '86400', 09:32:42 INFO - 'USER': 'cltbld', 09:32:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:42 INFO - '_': '/tools/buildbot/bin/python'} 09:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:42 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 09:32:42 INFO - Cleaning up... 09:32:42 INFO - Return code: 0 09:32:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:42 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')]} 09:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:42 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')]} 09:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:42 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:32:42 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 09:32:42 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 09:32:42 INFO - Using env: {'DISPLAY': ':0', 09:32:42 INFO - 'HOME': '/home/cltbld', 09:32:42 INFO - 'LANG': 'en_US.UTF-8', 09:32:42 INFO - 'LANGUAGE': 'en_US:en', 09:32:42 INFO - 'LOGNAME': 'cltbld', 09:32:42 INFO - 'MAIL': '/var/mail/cltbld', 09:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:42 INFO - 'MOZ_NO_REMOTE': '1', 09:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:42 INFO - 'NO_EM_RESTART': '1', 09:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:42 INFO - 'PWD': '/builds/slave/test', 09:32:42 INFO - 'SHELL': '/bin/bash', 09:32:42 INFO - 'SHLVL': '1', 09:32:42 INFO - 'TERM': 'linux', 09:32:42 INFO - 'TMOUT': '86400', 09:32:42 INFO - 'USER': 'cltbld', 09:32:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:42 INFO - '_': '/tools/buildbot/bin/python'} 09:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:42 INFO - Downloading/unpacking psutil>=3.1.1 09:32:42 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 09:32:42 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 09:32:42 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 09:32:42 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 09:32:42 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 09:32:42 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 09:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:44 INFO - Installing collected packages: psutil 09:32:44 INFO - Running setup.py install for psutil 09:32:44 INFO - building 'psutil._psutil_linux' extension 09:32:44 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 09:32:44 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 09:32:44 INFO - building 'psutil._psutil_posix' extension 09:32:44 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 09:32:44 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 09:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:44 INFO - Successfully installed psutil 09:32:44 INFO - Cleaning up... 09:32:44 INFO - Return code: 0 09:32:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32:44 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')]} 09:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:44 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')]} 09:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:44 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:32:44 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 09:32:44 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 09:32:44 INFO - Using env: {'DISPLAY': ':0', 09:32:44 INFO - 'HOME': '/home/cltbld', 09:32:44 INFO - 'LANG': 'en_US.UTF-8', 09:32:44 INFO - 'LANGUAGE': 'en_US:en', 09:32:44 INFO - 'LOGNAME': 'cltbld', 09:32:44 INFO - 'MAIL': '/var/mail/cltbld', 09:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:44 INFO - 'MOZ_NO_REMOTE': '1', 09:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:44 INFO - 'NO_EM_RESTART': '1', 09:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:44 INFO - 'PWD': '/builds/slave/test', 09:32:44 INFO - 'SHELL': '/bin/bash', 09:32:44 INFO - 'SHLVL': '1', 09:32:44 INFO - 'TERM': 'linux', 09:32:44 INFO - 'TMOUT': '86400', 09:32:44 INFO - 'USER': 'cltbld', 09:32:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:44 INFO - '_': '/tools/buildbot/bin/python'} 09:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:47 INFO - Installing collected packages: mozsystemmonitor 09:32:47 INFO - Running setup.py install for mozsystemmonitor 09:32:47 INFO - Successfully installed mozsystemmonitor 09:32:47 INFO - Cleaning up... 09:32:47 INFO - Return code: 0 09:32:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:47 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')]} 09:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:47 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')]} 09:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:47 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:32:47 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==2.5.1'] in /builds/slave/test/build 09:32:47 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==2.5.1 09:32:47 INFO - Using env: {'DISPLAY': ':0', 09:32:47 INFO - 'HOME': '/home/cltbld', 09:32:47 INFO - 'LANG': 'en_US.UTF-8', 09:32:47 INFO - 'LANGUAGE': 'en_US:en', 09:32:47 INFO - 'LOGNAME': 'cltbld', 09:32:47 INFO - 'MAIL': '/var/mail/cltbld', 09:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:47 INFO - 'MOZ_NO_REMOTE': '1', 09:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:47 INFO - 'NO_EM_RESTART': '1', 09:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:47 INFO - 'PWD': '/builds/slave/test', 09:32:47 INFO - 'SHELL': '/bin/bash', 09:32:47 INFO - 'SHLVL': '1', 09:32:47 INFO - 'TERM': 'linux', 09:32:47 INFO - 'TMOUT': '86400', 09:32:47 INFO - 'USER': 'cltbld', 09:32:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:47 INFO - '_': '/tools/buildbot/bin/python'} 09:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:47 INFO - Downloading/unpacking jsonschema==2.5.1 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:49 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 09:32:49 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 09:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:49 INFO - warning: no files found matching '*.txt' 09:32:49 INFO - no previously-included directories found matching 'build' 09:32:49 INFO - no previously-included directories found matching 'dist' 09:32:49 INFO - no previously-included directories found matching '.git*' 09:32:49 INFO - Installing collected packages: jsonschema, functools32 09:32:49 INFO - Running setup.py install for functools32 09:32:49 INFO - warning: no files found matching '*.txt' 09:32:49 INFO - no previously-included directories found matching 'build' 09:32:49 INFO - no previously-included directories found matching 'dist' 09:32:49 INFO - no previously-included directories found matching '.git*' 09:32:49 INFO - Successfully installed jsonschema functools32 09:32:49 INFO - Cleaning up... 09:32:49 INFO - Return code: 0 09:32:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:32:49 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 09:32:49 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 09:32:49 INFO - Using env: {'DISPLAY': ':0', 09:32:49 INFO - 'HOME': '/home/cltbld', 09:32:49 INFO - 'LANG': 'en_US.UTF-8', 09:32:49 INFO - 'LANGUAGE': 'en_US:en', 09:32:49 INFO - 'LOGNAME': 'cltbld', 09:32:49 INFO - 'MAIL': '/var/mail/cltbld', 09:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:49 INFO - 'MOZ_NO_REMOTE': '1', 09:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:49 INFO - 'NO_EM_RESTART': '1', 09:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:49 INFO - 'PWD': '/builds/slave/test', 09:32:49 INFO - 'SHELL': '/bin/bash', 09:32:49 INFO - 'SHLVL': '1', 09:32:49 INFO - 'TERM': 'linux', 09:32:49 INFO - 'TMOUT': '86400', 09:32:49 INFO - 'USER': 'cltbld', 09:32:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:49 INFO - '_': '/tools/buildbot/bin/python'} 09:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:50 INFO - Downloading/unpacking blobuploader==1.2.4 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:50 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 09:32:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:51 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 09:32:51 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 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:52 INFO - Downloading docopt-0.6.1.tar.gz 09:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:52 INFO - Running setup.py install for blobuploader 09:32:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:52 INFO - Running setup.py install for requests 09:32:53 INFO - Running setup.py install for docopt 09:32:53 INFO - Successfully installed blobuploader requests docopt 09:32:53 INFO - Cleaning up... 09:32:53 INFO - Return code: 0 09:32:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:53 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')]} 09:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:53 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')]} 09:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:53 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:32:53 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 09:32:53 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 09:32:53 INFO - Using env: {'DISPLAY': ':0', 09:32:53 INFO - 'HOME': '/home/cltbld', 09:32:53 INFO - 'LANG': 'en_US.UTF-8', 09:32:53 INFO - 'LANGUAGE': 'en_US:en', 09:32:53 INFO - 'LOGNAME': 'cltbld', 09:32:53 INFO - 'MAIL': '/var/mail/cltbld', 09:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:53 INFO - 'MOZ_NO_REMOTE': '1', 09:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:53 INFO - 'NO_EM_RESTART': '1', 09:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:53 INFO - 'PWD': '/builds/slave/test', 09:32:53 INFO - 'SHELL': '/bin/bash', 09:32:53 INFO - 'SHLVL': '1', 09:32:53 INFO - 'TERM': 'linux', 09:32:53 INFO - 'TMOUT': '86400', 09:32:53 INFO - 'USER': 'cltbld', 09:32:53 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:53 INFO - '_': '/tools/buildbot/bin/python'} 09:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:53 INFO - Running setup.py (path:/tmp/pip-81kcGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:53 INFO - Running setup.py (path:/tmp/pip-hYaTGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:53 INFO - Running setup.py (path:/tmp/pip-sW4wEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:53 INFO - Running setup.py (path:/tmp/pip-1ZtsK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:53 INFO - Running setup.py (path:/tmp/pip-58g3Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:53 INFO - Running setup.py (path:/tmp/pip-rkWQD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:53 INFO - Running setup.py (path:/tmp/pip-hlbBKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:54 INFO - Running setup.py (path:/tmp/pip-Yo5eVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:54 INFO - Running setup.py (path:/tmp/pip-QOTCER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:54 INFO - Running setup.py (path:/tmp/pip-BfrG5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:54 INFO - Running setup.py (path:/tmp/pip-LPFrxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:54 INFO - Running setup.py (path:/tmp/pip-EgsqKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:54 INFO - Running setup.py (path:/tmp/pip-sZ9LYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:54 INFO - Running setup.py (path:/tmp/pip-EeHTjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:54 INFO - Running setup.py (path:/tmp/pip-AnaXZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:54 INFO - Running setup.py (path:/tmp/pip-XeERZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:54 INFO - Running setup.py (path:/tmp/pip-uoolOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:54 INFO - Running setup.py install for manifestparser 09:32:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:54 INFO - Running setup.py install for mozcrash 09:32:54 INFO - Running setup.py install for mozdebug 09:32:55 INFO - Running setup.py install for mozdevice 09:32:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Running setup.py install for mozfile 09:32:55 INFO - Running setup.py install for mozhttpd 09:32:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Running setup.py install for mozinfo 09:32:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Running setup.py install for mozInstall 09:32:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Running setup.py install for mozleak 09:32:55 INFO - Running setup.py install for mozlog 09:32:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Running setup.py install for moznetwork 09:32:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:55 INFO - Running setup.py install for mozprocess 09:32:55 INFO - Running setup.py install for mozprofile 09:32:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:56 INFO - Running setup.py install for mozrunner 09:32:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:56 INFO - Running setup.py install for mozscreenshot 09:32:56 INFO - Running setup.py install for moztest 09:32:56 INFO - Running setup.py install for mozversion 09:32:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:56 INFO - Cleaning up... 09:32:56 INFO - Return code: 0 09:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:56 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:32:56 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 09:32:56 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 09:32:56 INFO - Using env: {'DISPLAY': ':0', 09:32:56 INFO - 'HOME': '/home/cltbld', 09:32:56 INFO - 'LANG': 'en_US.UTF-8', 09:32:56 INFO - 'LANGUAGE': 'en_US:en', 09:32:56 INFO - 'LOGNAME': 'cltbld', 09:32:56 INFO - 'MAIL': '/var/mail/cltbld', 09:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:56 INFO - 'MOZ_NO_REMOTE': '1', 09:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:56 INFO - 'NO_EM_RESTART': '1', 09:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:56 INFO - 'PWD': '/builds/slave/test', 09:32:56 INFO - 'SHELL': '/bin/bash', 09:32:56 INFO - 'SHLVL': '1', 09:32:56 INFO - 'TERM': 'linux', 09:32:56 INFO - 'TMOUT': '86400', 09:32:56 INFO - 'USER': 'cltbld', 09:32:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:56 INFO - '_': '/tools/buildbot/bin/python'} 09:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:56 INFO - Running setup.py (path:/tmp/pip-TbFyKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:56 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)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:56 INFO - Running setup.py (path:/tmp/pip-79iV4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:56 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)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:56 INFO - Running setup.py (path:/tmp/pip-wSud2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:56 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)) 09:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:56 INFO - Running setup.py (path:/tmp/pip-JAfHZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:57 INFO - Running setup.py (path:/tmp/pip-yvOM6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:57 INFO - Running setup.py (path:/tmp/pip-917bYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:57 INFO - Running setup.py (path:/tmp/pip-2HNwIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:57 INFO - Running setup.py (path:/tmp/pip-gtQXhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:57 INFO - Running setup.py (path:/tmp/pip-RWnzci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:57 INFO - Running setup.py (path:/tmp/pip-RAQn15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:57 INFO - Running setup.py (path:/tmp/pip-WA3CcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:57 INFO - Running setup.py (path:/tmp/pip-8T6PRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:57 INFO - Running setup.py (path:/tmp/pip-eInDSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:57 INFO - Running setup.py (path:/tmp/pip-WKngaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:57 INFO - Running setup.py (path:/tmp/pip-I0mGXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:57 INFO - Running setup.py (path:/tmp/pip-5smPiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:57 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)) 09:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:57 INFO - Running setup.py (path:/tmp/pip-HW5woA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:57 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)) 09:32:57 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)) 09:32:57 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)) 09:32:57 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)) 09:32:57 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)) 09:32:57 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)) 09:32:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:59 INFO - Downloading blessings-1.6.tar.gz 09:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:59 INFO - Installing collected packages: blessings 09:32:59 INFO - Running setup.py install for blessings 09:33:00 INFO - Successfully installed blessings 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:00 INFO - Reading from file tmpfile_stdout 09:33:00 INFO - Current package versions: 09:33:00 INFO - argparse == 1.2.1 09:33:00 INFO - blessings == 1.6 09:33:00 INFO - blobuploader == 1.2.4 09:33:00 INFO - docopt == 0.6.1 09:33:00 INFO - functools32 == 3.2.3-2 09:33:00 INFO - jsonschema == 2.5.1 09:33:00 INFO - manifestparser == 1.1 09:33:00 INFO - mozInstall == 1.12 09:33:00 INFO - mozcrash == 0.17 09:33:00 INFO - mozdebug == 0.1 09:33:00 INFO - mozdevice == 0.48 09:33:00 INFO - mozfile == 1.2 09:33:00 INFO - mozhttpd == 0.7 09:33:00 INFO - mozinfo == 0.9 09:33:00 INFO - mozleak == 0.1 09:33:00 INFO - mozlog == 3.2 09:33:00 INFO - moznetwork == 0.27 09:33:00 INFO - mozprocess == 0.22 09:33:00 INFO - mozprofile == 0.28 09:33:00 INFO - mozrunner == 6.11 09:33:00 INFO - mozscreenshot == 0.1 09:33:00 INFO - mozsystemmonitor == 0.3 09:33:00 INFO - moztest == 0.7 09:33:00 INFO - mozversion == 1.4 09:33:00 INFO - psutil == 3.1.1 09:33:00 INFO - requests == 1.2.3 09:33:00 INFO - wsgiref == 0.1.2 09:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'DISPLAY': ':0', 09:33:00 INFO - 'HOME': '/home/cltbld', 09:33:00 INFO - 'LANG': 'en_US.UTF-8', 09:33:00 INFO - 'LANGUAGE': 'en_US:en', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MAIL': '/var/mail/cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SHLVL': '1', 09:33:00 INFO - 'TERM': 'linux', 09:33:00 INFO - 'TMOUT': '86400', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - '_': '/tools/buildbot/bin/python'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 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)) 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'DISPLAY': ':0', 09:33:00 INFO - 'HOME': '/home/cltbld', 09:33:00 INFO - 'LANG': 'en_US.UTF-8', 09:33:00 INFO - 'LANGUAGE': 'en_US:en', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MAIL': '/var/mail/cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SHLVL': '1', 09:33:00 INFO - 'TERM': 'linux', 09:33:00 INFO - 'TMOUT': '86400', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - '_': '/tools/buildbot/bin/python'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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 0x7fdfa28e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, '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': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', '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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'DISPLAY': ':0', 09:33:00 INFO - 'HOME': '/home/cltbld', 09:33:00 INFO - 'LANG': 'en_US.UTF-8', 09:33:00 INFO - 'LANGUAGE': 'en_US:en', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MAIL': '/var/mail/cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SHLVL': '1', 09:33:00 INFO - 'TERM': 'linux', 09:33:00 INFO - 'TMOUT': '86400', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - '_': '/tools/buildbot/bin/python'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 INFO - Downloading/unpacking flake8 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:33:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:02 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 09:33:02 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 09:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:33:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:03 INFO - no previously-included directories found matching 'docs/_build' 09:33:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:33:03 INFO - Running setup.py install for pep8 09:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:03 INFO - no previously-included directories found matching 'docs/_build' 09:33:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:33:03 INFO - Cleaning up... 09:33:03 INFO - Return code: 0 09:33:03 INFO - Running post-action listener: _resource_record_post_action 09:33:03 INFO - Running post-action listener: _start_resource_monitoring 09:33:03 INFO - Starting resource monitoring. 09:33:03 INFO - ##### 09:33:03 INFO - ##### Finished create-virtualenv step (success) 09:33:03 INFO - ##### 09:33:03 INFO - ##### 09:33:03 INFO - ##### Running install step. 09:33:03 INFO - ##### 09:33:03 INFO - Running pre-action listener: _resource_record_pre_action 09:33:03 INFO - Running main action method: install 09:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:04 INFO - Reading from file tmpfile_stdout 09:33:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:04 INFO - Reading from file tmpfile_stdout 09:33:04 INFO - Output received: 09:33:04 INFO - Usage: mozinstall [options] installer 09:33:04 INFO - Options: 09:33:04 INFO - -h, --help show this help message and exit 09:33:04 INFO - -d DEST, --destination=DEST 09:33:04 INFO - Directory to install application into. [default: 09:33:04 INFO - "/builds/slave/test"] 09:33:04 INFO - --app=APP Application being installed. [default: firefox] 09:33:04 INFO - mkdir: /builds/slave/test/build/application 09:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:33:21 INFO - Reading from file tmpfile_stdout 09:33:21 INFO - Output received: 09:33:21 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:21 INFO - Running post-action listener: _resource_record_post_action 09:33:21 INFO - ##### 09:33:21 INFO - ##### Finished install step (success) 09:33:21 INFO - ##### 09:33:21 INFO - ##### 09:33:21 INFO - ##### Running run-tests step. 09:33:21 INFO - ##### 09:33:21 INFO - Running pre-action listener: _resource_record_pre_action 09:33:21 INFO - Running main action method: run_tests 09:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:21 INFO - Python 2.7.3 09:33:21 INFO - Return code: 0 09:33:21 INFO - grabbing minidump binary from tooltool 09:33:21 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')]} 09:33:21 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 0x292d1c0>, '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 0x292e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:21 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 09:33:21 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 09:33:21 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 09:33:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:21 INFO - Return code: 0 09:33:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:33:22 INFO - Return code: 0 09:33:22 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:33:22 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:33:22 INFO - Using env: {'DISPLAY': ':0', 09:33:22 INFO - 'HOME': '/home/cltbld', 09:33:22 INFO - 'LANG': 'en_US.UTF-8', 09:33:22 INFO - 'LANGUAGE': 'en_US:en', 09:33:22 INFO - 'LOGNAME': 'cltbld', 09:33:22 INFO - 'MAIL': '/var/mail/cltbld', 09:33:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:22 INFO - 'MOZ_NO_REMOTE': '1', 09:33:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:22 INFO - 'NO_EM_RESTART': '1', 09:33:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:22 INFO - 'PWD': '/builds/slave/test', 09:33:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:22 INFO - 'SHELL': '/bin/bash', 09:33:22 INFO - 'SHLVL': '1', 09:33:22 INFO - 'TERM': 'linux', 09:33:22 INFO - 'TMOUT': '86400', 09:33:22 INFO - 'USER': 'cltbld', 09:33:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872', 09:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:22 INFO - '_': '/tools/buildbot/bin/python'} 09:33:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:33:22 INFO - mozversion application_buildid: 20160617062337 09:33:22 INFO - mozversion application_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 09:33:22 INFO - mozversion application_display_name: Nightly 09:33:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:22 INFO - mozversion application_name: Firefox 09:33:22 INFO - mozversion application_remotingname: firefox 09:33:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:33:22 INFO - mozversion application_vendor: Mozilla 09:33:22 INFO - mozversion application_version: 50.0a1 09:33:22 INFO - mozversion platform_buildid: 20160617062337 09:33:22 INFO - mozversion platform_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 09:33:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:33:22 INFO - mozversion platform_version: 50.0a1 09:33:22 INFO - using testdate: 1466181202 09:33:22 INFO - actual date: 1466181202 09:33:22 INFO - starting webserver on 'localhost:57356' 09:33:22 INFO - SUITE-START | Running 2 tests 09:33:22 INFO - TEST-START | dromaeo_css 09:33:22 INFO - operating with platform_type : linux_ 09:33:22 INFO - Initialising browser for dromaeo_css test... 09:33:22 INFO - TEST-INFO | started process 18466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Ga7wP/profile http://localhost:57356/getInfo.html) 09:33:27 INFO - PROCESS | 18466 | __metrics Screen width/height:1600/1200 09:33:27 INFO - PROCESS | 18466 | colorDepth:24 09:33:27 INFO - PROCESS | 18466 | Browser inner width/height: 1024/697 09:33:27 INFO - PROCESS | 18466 | __metrics 09:33:27 ERROR - PROCESS | 18466 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:33:28 INFO - TEST-INFO | 18466: exit 0 09:33:28 INFO - Browser initialized. 09:33:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:28 INFO - TEST-INFO | started process 18585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Ga7wP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:40 INFO - PROCESS | 18585 | RSS: Main: 185368576 09:33:40 INFO - PROCESS | 18585 | 09:34:30 INFO - PROCESS | 18585 | 1466181270289 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] 09:36:38 INFO - PROCESS | 18585 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57356/tests/dromaeo/cssquery-ext.html) 09:36:39 INFO - PROCESS | 18585 | RSS: Main: 188911616 09:36:39 INFO - PROCESS | 18585 | 09:39:41 INFO - PROCESS | 18585 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-ext.html (next: http://localhost:57356/tests/dromaeo/cssquery-jquery.html) 09:39:42 INFO - PROCESS | 18585 | RSS: Main: 188055552 09:39:42 INFO - PROCESS | 18585 | 09:42:43 INFO - PROCESS | 18585 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57356/tests/dromaeo/cssquery-mootools.html) 09:42:44 INFO - PROCESS | 18585 | RSS: Main: 189800448 09:42:44 INFO - PROCESS | 18585 | 09:45:46 INFO - PROCESS | 18585 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57356/tests/dromaeo/cssquery-prototype.html) 09:45:46 INFO - PROCESS | 18585 | RSS: Main: 186978304 09:45:46 INFO - PROCESS | 18585 | 09:48:49 INFO - PROCESS | 18585 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57356/tests/dromaeo/cssquery-yui.html) 09:48:49 INFO - PROCESS | 18585 | RSS: Main: 189186048 09:48:49 INFO - PROCESS | 18585 | 09:51:52 INFO - PROCESS | 18585 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-yui.html (next: http://localhost:57356/tests/dromaeo/cssquery-dojo.html) 09:51:52 INFO - PROCESS | 18585 | RSS: Main: 189906944 09:51:52 INFO - PROCESS | 18585 | 09:51:52 INFO - PROCESS | 18585 | __start_tp_report 09:51:52 INFO - PROCESS | 18585 | _x_x_mozilla_page_load 09:51:52 INFO - PROCESS | 18585 | _x_x_mozilla_page_load_details 09:51:52 INFO - PROCESS | 18585 | |i|pagename|runs| 09:51:52 INFO - PROCESS | 18585 | |0;dojo.html;3051.099925521971;3106.642736085348;3145.323755392591;3149.370125974804;3151.873925042997;5262.921056184151;5272.340957380327;5323.893522129565;5328.733563321833;5355.651882627626;5194.246834209038;5289.047971365153;5310.256564081032;5350.491703288191;5375.43557926418;4784.067106914154;4835.806567737286;4905.533974272438;4949.579285760697;5011.599072074226;721.7772512112206;4743.525647435264;4768.785404656799;4885.120678277926;4953.752312384385;4783.210770222909;4829.396325459317;4844.813020809889;4866.416030076378;4916.58209052231;4840.733759643218;4875.634327425421;4878.658493905428;4880.755962201875;4940.5059494050665;4759.214729569617;4774.976125119387;4805.111054454937;4837.61299096075;4848.636352273594;5283.55089817366;5308.840734777963;5346;5351;5355.544778693816;5534.52956498694;5650.265465489501;5690.374058853523;5698.772049118031;5703.230063941356;5729.828105156852;5811.070228763419;5814.854628634275;5832.62087964281;5862.70686465675;5437.918431223535;5446.945530544723;5449.182622606601;5451.3458384993655;5452.6455780374545;5789.102689083199;5844.152597873284;5905.675187864708;5914.4381283777975;5922.49658779;5619.072852979294;5669.262995810601;5702.7433765480655;5711.7144142792695;5767.394423585463;5751.281089863767;5755.1367294906095;5787.1319302104175;5791.218185544897;5796.739146738322;5577.637453565505;5635.971820140955;5652.0674088774895;5714.857128571736;5739.397363276879;5713.628614140068;5745.88508229833;5746.798862039808;5770.336411312753;5816;4413.360062790942;4445.911081778347;4456.46522417312;4457.710248833815;4479.776011199427;3858.749181303206;3939.7045221607923;3949.6445319921345;3994.3009973254566;4019.718619696652;5336.252924590561;5437.809676661298;5489.286392768994;5502.2296878437055;5550.5282051026115;5710.5146062585145;5733.283339582552;5754.108113242454;5769.221155144086;5801.593888427769;5346.8663283417445;5400.621956463088;5439.265699130646;5466.535344495683;5492.681756378441;4984.925226121611;5005.89988200234;5009.949900501021;5026.472220416804;5071.54356107952;6026.789062382795;6033.7586496540525;6035.849103772353;6041.214642096587;6049.455549000611;5601.971990139942;5700.315962084576;5722.570807189394;5722.599418040697;5782.392848750821;6047.9395206047375;6050.818475445743;6055.303640081447;6058.485028772604;6060.090986352083;5541.307336582927;5669.971650141723;5679.432056794288;5685.147227915846;5685.403032681509;5698.116791897262;5734.885302294014;5768.971155144198;5803.390643982321;5813.3605303417435;5589.720513974204;5663.065594176915;5669.34802497718;5670.092785154356;5672.149177623224;5420.078586640202;5528.6406383586545;5605.103183490622;5638.577106716931;5664.178694089416;5457.536109430743;5459.07195776711;5516.255305533701;5545.528630066489;5593.524550413261;5537.9169312459535;5544.473275038865;5594.804181853616;5600.159976003632;5606.551475882001;5302.2576839241765;5354.143337066051;5396.325459317585;5441.319835020622;5512.448755124616 09:51:52 INFO - PROCESS | 18585 | |1;ext.html;573.4351663611342;622.3403192615826;641.5573254454426;643.6845945486712;646.5474168082344;37200.81399593002;41035;41348.793256033714;41431.378529322086;41432.17135657292;42318;42401;43034.35448468276;43089.56910430895;43092;8801.42790718603;8918.420302680304;8927.107289271085;8945.55272236389;8986.415882967618;8748.431351962134;8837.690680826172;8932.196102350787;8959.37284390093;8976.506292153928;8893.599788009555;8931.77670558238;8948.284137269004;8999.055099214587;9014.233790127848;8932.598033088527;8933.240674542672;8942.463452192856;8952.59713312896;8987.056359082268;8826.779330516723;8845;8866.778330541789;8904.688335908211;8907.688230911886;33498.49752253718;39884.60115398867;40181.79909100465;40198.397024044665;40320.193596127916;3087.6294844618787;3108.1918701137865;3261.951070733941;3567.1973805893726;3679.300932822755;30835;30928;31032.689673103207;31284.53073203904;32186;4254.765987870697;4279.465066866642;4369.213541562517;4402.779861006937;4456.19788438081;279550;281408;281754;282786;283108;33350;33378.666213338045;33516.329673406886;33550.83224583862;33554.328913421596;32247.838760806517;34144.82927585396;34296.82851585726;35019.82490087584;36604.81697591495;14631.85368146305;14736.115833050051;14775.556733298019;14785.926070369795;14841.332140053508;12196.756064878653;12238.388080595934;12273.93863030697;12319.568815091428;12361.690957726129;8063.354931605458;8100.71647492335;8152.347812175011;8209.261166495044;8221.260086592236;3224.8387580620874;3265.8856940006985;3269.9509507357407;3272.592785102429;3280.343931213719;1031.747221930632;1071.266182664877;1071.6784964510616;1095.1239008793093;1105.1103861391657;32398;32736.836315818746;32770.508442373386;33217.3356532868;33470;1071.7588542577857;1096.983545246822;1107.1640911112058;1138.2771939818274;1188.6493484422117;16580.962746253004;16938.661226775643;17046.403375881786;17151.65696686059;17171.828281717273;550090;552862;555838;557927;560100;55644;55701.44298557044;56607.71696141493;56612;56949.71525142348;1314.3231235913513;1337.4716986790163;1350.1696456679072;1351.1015174908575;1359.1165742267606;30343.696563034086;31772.68227317697;32074.839625802655;32278.515822263154;32603;46862.29706554473;47615.52384476111;47919;47942.760286199744;48361.516384835704;475607;475720;476314.23685764085;477545;479051;27014.864925675247;27358.863205683843;28091.859540702164;29034.709652904046;29191.85404073051;47421.76951790967;48185.51814481951;48213.51786482231;48800.5119948796;48871.266930996775;40421.1915761689;40435;41585.792071039454;41596.792016040934;42345.364819527116;39700.80149599349;39921.2015759689;40459.39310910398;41389.793051034554;41478.79260603798;40368.3944740835;40496.162416439714;41268.174636507705;41312.1737565253;41523.37714934339;34024.65975340215;35625.64374356327;36001.81999089988;36412.635873641986;36431.27137457289;27978.860105699343;28015;28169.718302817528;28283.292917677223;28401.573976390784 09:51:52 INFO - PROCESS | 18585 | |2;jquery.html;385.1123161113632;385.51144027270266;386.7872670031482;391.5497178245018;409.8585987834198;13804.171749695026;15454.381824726997;18133.637327253447;19468.902655486738;19620.215191392344;16131.596710082255;18611.441656750318;19086.995865434103;19165.1375688094;19201;5743.913841292384;5863.912041319362;5922.4077592240865;5939.524838012971;5977.88044239115;5747.568932330071;5813.331466881321;5827.533797296227;5846.619969701956;5866.589338746289;5759.4816466518005;5838.095095260242;5838.948989181946;5846.298444186704;5872.823815285548;5693.914591281134;5740.311162660508;5752.079667253241;5776.046952252873;5817.214676018747;4990.326305948687;5094.133997220444;5191.091558977201;5196.376434827807;5238.68567885928;22062.66905996395;22451.663225051638;22527;22798.316050518344;22934.426639333982;2359.7876191142877;2429.757024297574;2511.1462102884925;2569.8586577738215;2869.569564565311;9224.40041397307;9931.55308011134;10071.093601575893;10348.430836304;14663.853361466356;1947.805219478055;1978.8219060284644;1985.265451782835;1990.4028791362678;2004.8295894848955;82229.58885205536;84791.5760421194;84918.5754071232;84945;86698.56650716769;10446.373217606968;10470.214733894989;10631.574737010433;10693.358398496115;10735.89264107349;14860.777088343684;14934.32795524204;14941.402343906122;14946.252687365588;14987.700245995236;7512.812179695442;7881.133075361706;7971.40214483916;8017.559034253172;8047.718329858427;7484.588347640932;7567.735129270449;7637.236276372319;7696.923030769733;7776.222377762178;4581.931271030937;4643.164230438553;4693.366395536559;4749.435304935365;4783.784729687172;1968.4980330015753;1992.432156835295;1996.4509759816167;2020.2424090965887;2020.706747681485;920.30516959695;959.2661613865398;976.1409959235828;1010.5705075343096;1060.0459586372172;18805.81194188068;19247.90376048111;19374.80625193758;19449.4165175045;19668.606627867364;935.4434111703525;966.2028826218258;974.6637410093506;976.1848856205148;1003.6637726361605;9346.392484488622;10121.848172277421;10624.893751062546;10723.517441715141;11362.147838912115;443862;445794;446124;452850;456985;94491.52754236184;95796;96101;96126;96207.51896240473;1033.5452400943561;1054.446415631784;1085.218642577343;1102.9062529685066;1104.8563686720674;17536;17557.297708092043;17585.736213956545;17786.46640600784;18115.094245287946;41838;42965.78517107519;43527.129457411305;45207.09585808331;46048.8487787808;58753.4124658748;59230.40769592249;60199.39800602113;60229.0965635507;60809;7580.507267027626;7841.607919604111;7875.369970402468;7930.9603451982375;8278.751637450887;9567.808643827224;13781;13929.721405572034;14032.158070515801;14183.43266269379;12039.699007524881;12281.324527151093;12370.75258494843;12372.62882113538;12515.812262815884;11963.401829908296;12015.879841201826;12061.879381206076;12118.091143164122;12223.388830558259;12184.57353992606;12189.988651872696;12285;12327.630171094881;12446.81329780036;7972.880406793786;8011.719589814328;8034.196580341919;8120.309773669304;8163;10773.730656733644;11833.349165795964;12312.692182695146;12422.627321180378;12450.875491244971 09:51:52 INFO - PROCESS | 18585 | |3;mootools.html;1448.4568286892415;1486.5391728564146;1540.6379500817307;1696.787901512311;1713.9973115727298;7729;8113.675452981874;8394.24451799338;8957.10428957104;8980.326475514337;8419;8624.698135565257;8678.305735541157;8764.91235087649;8769.868451973225;2162.5782972320444;2169.707089542915;2201.2405720026563;2205.3383984804573;2207.94480137997;2020.1111510935216;2026.3110542415575;2183.410479170631;2184.4102092435032;2186.3113119367426;2102.8633138846003;2107.2413930984835;2107.7154584131176;2122.7983341582526;2141.6787481877764;2081.55246621977;2109.862858914166;2114.7990940860595;2117.237794394017;2117.4388786971463;1964.636542239676;2115.661494160927;2121.1091341636397;2127.4574983379293;2131.8720876747443;8734.606942687595;8795.296376289882;8813.1186881312;8822.985356683936;8824.205821476098;5087.694738315676;5196.896062078775;5211.452797456251;5221.556167725748;5222.373315202162;3211.550382946389;3250.089974807058;3258.3157536917274;3267.3791979524053;3284.3759685659647;1098.1105304703217;1148.9023433008203;1157.9826302605468;1162.8081366574504;1163.941802909851;11876.762464750744;11951.22317049389;11982.400879956054;11993.640190794204;12031.93984030083;4263.70154089217;4284.228838808982;4353.151135528541;4358.128374325084;4459.910801783946;9875.60497580103;9957.103860652576;9969.750756231007;9999.800003999879;10038.096571308617;4947.35684361038;4990.401151861727;4994.101061808837;5027.899442011212;5042.546170844568;4553.954460455353;4644.86065418038;4685.039566888848;4736.621070314367;4757.500462451462;3543.989962860572;3588.4258518637416;3638.4542318651884;3645.1616128290643;3672.9081772955356;1088.7604726960055;1100.658795773313;1106.2090605217147;1111.0833562310963;1123.9887601124049;866.8483015472393;938.6292414496236;960.5053397500293;962.9807403851884;1008.3546530220665;5749.626274292241;5885.293764748258;6028.849278768066;6138.7237574309265;6203.16257305258;909.0500427053745;912.8630705394244;944.4474982135528;948.8102379523984;953.9379940303858;4097.651699605507;4280.229558679405;4295.613394794421;4356.259435895905;4391.912161756811;10440.582376704846;10885.83671244932;10889.346639201673;10898.291611045257;10980;10780.568777248978;10843.07833834117;10844.837327440095;10857.782844343068;10863.076638485818;7638.274363935418;7920.960395198103;7976.322012628992;8096.190380961857;8187.672493100328;5920.940790592039;6122.785702500391;6158.168647232566;6253.124562561154;6332.746690132343;9924.15644670211;10029.849552256868;10098.091171794575;10157.593696252066;10223.488825558841;9028.729138125867;10189.898101019191;10204.795904081728;10276;10341.069303762697;7767.728129515666;7834.843303134019;7887.64505597261;7928.920710792819;7933.127355990951;8461.95769021151;8473.364497662576;8473.66105355779;8517.574121294034;8565.186307300797;7572.962135189288;7580.810479738051;7589.772306830804;7629.2752188542;7833.373330133461;7450.478466507509;7526.209747976383;7585.279398457138;7587.317141457295;7613.352865006536;6631.602103873783;6644.83387915306;6676.165479315086;6677.732890684319;6698.7320507179165;5203.895922081461;5213.478652134908;5221.973890130677;5379.811706590251;5422.674639521483;5160.174372100446;5183.948160518346;5235.3717553893775;5241.371035475768;5266.183741520071 09:51:52 INFO - PROCESS | 18585 | |4;prototype.html;295.1470250974684;306.0832805746789;308.2694015184014;317.6950127877238;320.55282880381867;5530.142827861683;5541.445855414457;5548;5549.223108764776;5555.916661250085;5464.644798088131;5472.671639701621;5485.533729632976;5501.284832971718;5525.944740552593;4239.724417912841;4276.273033584298;4280.5291417944;4284.6786491013145;4316.287812510932;3969.24584328978;4229.534751177368;4250.596193361641;4269.9538613039695;4287.31402975524;4236.385724070008;4265.573442655741;4272.444582204309;4281.935770963438;4299.634531064863;4045.393191021341;4060.330045542482;4273.7392469221495;4276.25165596021;4281;3643.7631553949172;3649.59854416014;3664.0656632558525;3669.1744357519347;3677.6322367763278;5384.865378365533;5409.648372855751;5431.131019036975;5432.375276843174;5440.075187218183;4696.859094227145;4774.949511107586;4824.445188803297;4858.149823780825;4888.828890988798;5648.181013752983;5669.206311116406;5685.147227915804;5729.312482502085;5746.856328591777;4046.271671099201;4055.229506393776;4060.6954478414236;4070.206309769596;4079.0822065035427;5668.26312579362;5972.731227094748;5983.820485385445;6063.969680151615;6077.453029227347;4100.118474527991;4100.36444351126;4118.114605359862;4126.319157339006;4148.357004664282;4201.306784380604;4202.810873510699;4210.2842516772225;4219;4223.282042052859;4606.631469482433;4837.975810120927;4854.805807767721;4875.07373599015;4875.536824001785;5711.7144142792695;5736.852629474122;5770.538356931435;5787.971060144757;5801.970990145107;1410.16095423223;1438.8561143885527;1439.6400899775056;1446.8046813680019;1451.796748455217;862.254150160107;901.1394118616705;902.7833320003152;912.4570880326328;916.1571354354011;4982.90034199314;5043.621728370387;5062.417821950449;5062.860856307301;5074.314967479343;5273.894522109536;5276.683398995996;5281.494773989394;5326.627136100513;5336;5016.197408414636;5021.548060674484;5115.693058416507;5254.842354729364;5731.254936858265;3104.177392990859;3194.99357702323;3213.775035747522;3214.533892585562;3233.7413006959387;6253.499720022387;6297.433231009231;6314.9684251579365;6324.494040476751;6326.652034138075;5741.224934633855;5998.940010599926;6094.512439004869;6097.878042439126;6118.449339559461;6196;6239.313675495692;6288.371162883766;6289.874202516015;6308.7476500940365;5704.344000440003;5911.55663325261;5942.376050514807;5976.193213916065;5979.5814292999075;5870.5010074142465;5877.706114694162;5893.174955506147;5919.644821310735;5945.435183657545;6178.5366097543765;6207.96896015517;6218.284897236876;6220.315765265726;6248.718807653758;3591.676749092594;3632.7648599476306;3714.2200137971327;3729.328720830277;3738;5403.675779453245;5411.404745478073;5414.485623865727;5484.670919744828;5492.308768703387;5167.302414174038;5246.344206974129;5284.357821089456;5318.149096144598;5354.3842458117815;4980.252962055721;5142.665726727751;5148.819791307286;5150.0472412603785;5196.948030519647;5055.216441451581;5074.3657042869645;5117.368781252972;5122.769475373542;5141.640085194001;5009.87277862478;5142.820001300086;5159.251908473176;5173.689578625294;5197.428282888804;5078.314427552233;5105.872353191051;5112.769925353294;5130.435652078194;5156.871078223075 09:51:52 INFO - PROCESS | 18585 | |5;yui.html;710.9608971506568;765.9119201291853;788.8106854354954;795.9562224077677;797.4059325802276;14703.33834977426;15681.686366272668;15965.361385544578;15977.121258330788;15977.201139943;14020.298985050758;14079.436822527086;14079.92960035201;14487.92756036221;14753.336099875505;655.7967030220623;788.2866006264326;792.3819420851745;798.664560884427;799.1369321133192;782.6399856066216;808.1474044882647;808.4825711544587;808.7614153824636;811.2131232704268;845.9069502354736;847.5973912391627;849.7110982266029;853.8377708235415;856.0540602634093;831.4055450352996;836.8535506286375;838.6058552480324;839.4082172068677;839.8740188971642;608.6104892868568;609.7560975609791;611.0620197996054;611.4710775179482;612.7059011674421;15195.848041519554;15258.313375898;15313.61715957099;15316.923415382964;15333.769993450107;14857;15047.473338433212;15117;15176.772348414783;15368.615784605363;11685;11685.699777974698;11732.64802055931;11856;11971.281723096643;3864.3816989281863;3876.263509933132;3965.4448377227213;4034.8386064557676;4043.757374557536;73376.26623733748;74012.62993684997;74559.62720186364;74598.25401745968;76530;12057.397130143634;12064.70500669865;12113;12187.025037996938;12248;22854;22878;22932.4266893329;22949;22987.425314367276;8355.749327520183;8510.957445212734;8533.146685331418;8544.61549230286;8873.955630221937;4471.083427897273;4538.682292239511;4604.861854144381;4614.146382919171;4654.464736555272;3420.743444241692;3511.3504001759757;3513.3675938330834;3520.0495866116007;3522.682958533744;568.8805350876362;580.7386675995818;584.3572070722256;586.7007826008767;598.7994071885842;676.7631329034798;698.8637215742983;711.661960568736;714.2500374606747;745.5675708089295;9310.813783724288;9644.855327170098;9952.950235248778;10070.899291007143;10446.320989135682;631.924169099711;681.7421856674428;713.4399496395305;719.8812195987708;721.2354903801987;4967.776450059684;5042.96911889696;5046.318746969112;5066.569341606005;5067.239914012927;109364;112119.4394028041;112204;115460;116276;102534.48732756438;102778.48610757048;102869;105764;106974;54052.72973635185;54637;73678.99999999892;89313.55343223372;91991;9469.337146399686;9473.100055494717;9523.904750953729;9564.330496865152;9630;44345.55654443414;52052.739736301075;52105.739471302404;52833.7358313206;53075.73462132664;52620.73689631528;54622;72216;74750.62624686841;77230;13141.354476905852;13277.336133193496;13369.732605347644;13548.661283467993;13632.522861699794;15240.466583669519;15406.460773872861;15430.614234644223;15526;15715.842841571895;13230.735385292048;13858.376373063034;14429.49496767608;14433.92783036078;14665.56003319902;14121.6469588257;14348.282585870873;14450.927745361207;14616.049956753202;15100.24498775035;13283.468661253442;13411.664708382368;13532.93233533826;13615.659608509866;14169.574912752634;11303.491342889425;11519.42402879836;11545.076393888301;11699.2980421175;12143.453544590338;10971.890281097087;11204.943975280072;11359.602413915472;11378.886211138113;11485.655430337103 09:51:52 INFO - PROCESS | 18585 | __end_tp_report 09:51:52 INFO - PROCESS | 18585 | __start_cc_report 09:51:52 INFO - PROCESS | 18585 | _x_x_mozilla_cycle_collect,349 09:51:52 INFO - PROCESS | 18585 | __end_cc_report 09:51:52 INFO - PROCESS | 18585 | __startTimestamp1466182312985__endTimestamp 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - PROCESS | 18585 | ------- Summary: start ------- 09:51:53 INFO - PROCESS | 18585 | Number of tests: 6 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - PROCESS | 18585 | [#0] dojo.html Cycles:165 Average:5308.84 Median:5528.64 stddev:703.89 (12.7%) stddev-sans-first:683.40 09:51:53 INFO - PROCESS | 18585 | Values: 3051.1 3106.6 3145.3 3149.4 3151.9 5262.9 5272.3 5323.9 5328.7 5355.7 5194.2 5289.0 5310.3 5350.5 5375.4 4784.1 4835.8 4905.5 4949.6 5011.6 721.8 4743.5 4768.8 4885.1 4953.8 4783.2 4829.4 4844.8 4866.4 4916.6 4840.7 4875.6 4878.7 4880.8 4940.5 4759.2 4775.0 4805.1 4837.6 4848.6 5283.6 5308.8 5346.0 5351.0 5355.5 5534.5 5650.3 5690.4 5698.8 5703.2 5729.8 5811.1 5814.9 5832.6 5862.7 5437.9 5446.9 5449.2 5451.3 5452.6 5789.1 5844.2 5905.7 5914.4 5922.5 5619.1 5669.3 5702.7 5711.7 5767.4 5751.3 5755.1 5787.1 5791.2 5796.7 5577.6 5636.0 5652.1 5714.9 5739.4 5713.6 5745.9 5746.8 5770.3 5816.0 4413.4 4445.9 4456.5 4457.7 4479.8 3858.7 3939.7 3949.6 3994.3 4019.7 5336.3 5437.8 5489.3 5502.2 5550.5 5710.5 5733.3 5754.1 5769.2 5801.6 5346.9 5400.6 5439.3 5466.5 5492.7 4984.9 5005.9 5009.9 5026.5 5071.5 6026.8 6033.8 6035.8 6041.2 6049.5 5602.0 5700.3 5722.6 5722.6 5782.4 6047.9 6050.8 6055.3 6058.5 6060.1 5541.3 5670.0 5679.4 5685.1 5685.4 5698.1 5734.9 5769.0 5803.4 5813.4 5589.7 5663.1 5669.3 5670.1 5672.1 5420.1 5528.6 5605.1 5638.6 5664.2 5457.5 5459.1 5516.3 5545.5 5593.5 5537.9 5544.5 5594.8 5600.2 5606.6 5302.3 5354.1 5396.3 5441.3 5512.4 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - PROCESS | 18585 | [#1] ext.html Cycles:180 Average:57750.47 Median:40190.10 stddev:120791.63 (300.6%) stddev-sans-first:121054.20 09:51:53 INFO - PROCESS | 18585 | Values: 573.4 622.3 641.6 643.7 646.5 37200.8 41035.0 41348.8 41431.4 41432.2 42318.0 42401.0 43034.4 43089.6 43092.0 8801.4 8918.4 8927.1 8945.6 8986.4 8748.4 8837.7 8932.2 8959.4 8976.5 8893.6 8931.8 8948.3 8999.1 9014.2 8932.6 8933.2 8942.5 8952.6 8987.1 8826.8 8845.0 8866.8 8904.7 8907.7 33498.5 39884.6 40181.8 40198.4 40320.2 3087.6 3108.2 3262.0 3567.2 3679.3 30835.0 30928.0 31032.7 31284.5 32186.0 4254.8 4279.5 4369.2 4402.8 4456.2 279550.0 281408.0 281754.0 282786.0 283108.0 33350.0 33378.7 33516.3 33550.8 33554.3 32247.8 34144.8 34296.8 35019.8 36604.8 14631.9 14736.1 14775.6 14785.9 14841.3 12196.8 12238.4 12273.9 12319.6 12361.7 8063.4 8100.7 8152.3 8209.3 8221.3 3224.8 3265.9 3270.0 3272.6 3280.3 1031.7 1071.3 1071.7 1095.1 1105.1 32398.0 32736.8 32770.5 33217.3 33470.0 1071.8 1097.0 1107.2 1138.3 1188.6 16581.0 16938.7 17046.4 17151.7 17171.8 550090.0 552862.0 555838.0 557927.0 560100.0 55644.0 55701.4 56607.7 56612.0 56949.7 1314.3 1337.5 1350.2 1351.1 1359.1 30343.7 31772.7 32074.8 32278.5 32603.0 46862.3 47615.5 47919.0 47942.8 48361.5 475607.0 475720.0 476314.2 477545.0 479051.0 27014.9 27358.9 28091.9 29034.7 29191.9 47421.8 48185.5 48213.5 48800.5 48871.3 40421.2 40435.0 41585.8 41596.8 42345.4 39700.8 39921.2 40459.4 41389.8 41478.8 40368.4 40496.2 41268.2 41312.2 41523.4 34024.7 35625.6 36001.8 36412.6 36431.3 27978.9 28015.0 28169.7 28283.3 28401.6 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - PROCESS | 18585 | [#2] jquery.html Cycles:180 Average:28104.86 Median:386.15 stddev:74515.89 (19297.2%) stddev-sans-first:74695.86 09:51:53 INFO - PROCESS | 18585 | Values: 385.1 385.5 386.8 391.5 409.9 13804.2 15454.4 18133.6 19468.9 19620.2 16131.6 18611.4 19087.0 19165.1 19201.0 5743.9 5863.9 5922.4 5939.5 5977.9 5747.6 5813.3 5827.5 5846.6 5866.6 5759.5 5838.1 5838.9 5846.3 5872.8 5693.9 5740.3 5752.1 5776.0 5817.2 4990.3 5094.1 5191.1 5196.4 5238.7 22062.7 22451.7 22527.0 22798.3 22934.4 2359.8 2429.8 2511.1 2569.9 2869.6 9224.4 9931.6 10071.1 10348.4 14663.9 1947.8 1978.8 1985.3 1990.4 2004.8 82229.6 84791.6 84918.6 84945.0 86698.6 10446.4 10470.2 10631.6 10693.4 10735.9 14860.8 14934.3 14941.4 14946.3 14987.7 7512.8 7881.1 7971.4 8017.6 8047.7 7484.6 7567.7 7637.2 7696.9 7776.2 4581.9 4643.2 4693.4 4749.4 4783.8 1968.5 1992.4 1996.5 2020.2 2020.7 920.3 959.3 976.1 1010.6 1060.0 18805.8 19247.9 19374.8 19449.4 19668.6 935.4 966.2 974.7 976.2 1003.7 9346.4 10121.8 10624.9 10723.5 11362.1 443862.0 445794.0 446124.0 452850.0 456985.0 94491.5 95796.0 96101.0 96126.0 96207.5 1033.5 1054.4 1085.2 1102.9 1104.9 17536.0 17557.3 17585.7 17786.5 18115.1 41838.0 42965.8 43527.1 45207.1 46048.8 58753.4 59230.4 60199.4 60229.1 60809.0 7580.5 7841.6 7875.4 7931.0 8278.8 9567.8 13781.0 13929.7 14032.2 14183.4 12039.7 12281.3 12370.8 12372.6 12515.8 11963.4 12015.9 12061.9 12118.1 12223.4 12184.6 12190.0 12285.0 12327.6 12446.8 7972.9 8011.7 8034.2 8120.3 8163.0 10773.7 11833.3 12312.7 12422.6 12450.9 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - PROCESS | 18585 | [#3] mootools.html Cycles:180 Average:5698.04 Median:4968.88 stddev:3278.93 (66.0%) stddev-sans-first:3272.58 09:51:53 INFO - PROCESS | 18585 | Values: 1448.5 1486.5 1540.6 1696.8 1714.0 7729.0 8113.7 8394.2 8957.1 8980.3 8419.0 8624.7 8678.3 8764.9 8769.9 2162.6 2169.7 2201.2 2205.3 2207.9 2020.1 2026.3 2183.4 2184.4 2186.3 2102.9 2107.2 2107.7 2122.8 2141.7 2081.6 2109.9 2114.8 2117.2 2117.4 1964.6 2115.7 2121.1 2127.5 2131.9 8734.6 8795.3 8813.1 8823.0 8824.2 5087.7 5196.9 5211.5 5221.6 5222.4 3211.6 3250.1 3258.3 3267.4 3284.4 1098.1 1148.9 1158.0 1162.8 1163.9 11876.8 11951.2 11982.4 11993.6 12031.9 4263.7 4284.2 4353.2 4358.1 4459.9 9875.6 9957.1 9969.8 9999.8 10038.1 4947.4 4990.4 4994.1 5027.9 5042.5 4554.0 4644.9 4685.0 4736.6 4757.5 3544.0 3588.4 3638.5 3645.2 3672.9 1088.8 1100.7 1106.2 1111.1 1124.0 866.8 938.6 960.5 963.0 1008.4 5749.6 5885.3 6028.8 6138.7 6203.2 909.1 912.9 944.4 948.8 953.9 4097.7 4280.2 4295.6 4356.3 4391.9 10440.6 10885.8 10889.3 10898.3 10980.0 10780.6 10843.1 10844.8 10857.8 10863.1 7638.3 7921.0 7976.3 8096.2 8187.7 5920.9 6122.8 6158.2 6253.1 6332.7 9924.2 10029.8 10098.1 10157.6 10223.5 9028.7 10189.9 10204.8 10276.0 10341.1 7767.7 7834.8 7887.6 7928.9 7933.1 8462.0 8473.4 8473.7 8517.6 8565.2 7573.0 7580.8 7589.8 7629.3 7833.4 7450.5 7526.2 7585.3 7587.3 7613.4 6631.6 6644.8 6676.2 6677.7 6698.7 5203.9 5213.5 5222.0 5379.8 5422.7 5160.2 5183.9 5235.4 5241.4 5266.2 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - PROCESS | 18585 | [#4] prototype.html Cycles:180 Average:4704.44 Median:5145.82 stddev:1404.73 (27.3%) stddev-sans-first:1369.13 09:51:53 INFO - PROCESS | 18585 | Values: 295.1 306.1 308.3 317.7 320.6 5530.1 5541.4 5548.0 5549.2 5555.9 5464.6 5472.7 5485.5 5501.3 5525.9 4239.7 4276.3 4280.5 4284.7 4316.3 3969.2 4229.5 4250.6 4270.0 4287.3 4236.4 4265.6 4272.4 4281.9 4299.6 4045.4 4060.3 4273.7 4276.3 4281.0 3643.8 3649.6 3664.1 3669.2 3677.6 5384.9 5409.6 5431.1 5432.4 5440.1 4696.9 4774.9 4824.4 4858.1 4888.8 5648.2 5669.2 5685.1 5729.3 5746.9 4046.3 4055.2 4060.7 4070.2 4079.1 5668.3 5972.7 5983.8 6064.0 6077.5 4100.1 4100.4 4118.1 4126.3 4148.4 4201.3 4202.8 4210.3 4219.0 4223.3 4606.6 4838.0 4854.8 4875.1 4875.5 5711.7 5736.9 5770.5 5788.0 5802.0 1410.2 1438.9 1439.6 1446.8 1451.8 862.3 901.1 902.8 912.5 916.2 4982.9 5043.6 5062.4 5062.9 5074.3 5273.9 5276.7 5281.5 5326.6 5336.0 5016.2 5021.5 5115.7 5254.8 5731.3 3104.2 3195.0 3213.8 3214.5 3233.7 6253.5 6297.4 6315.0 6324.5 6326.7 5741.2 5998.9 6094.5 6097.9 6118.4 6196.0 6239.3 6288.4 6289.9 6308.7 5704.3 5911.6 5942.4 5976.2 5979.6 5870.5 5877.7 5893.2 5919.6 5945.4 6178.5 6208.0 6218.3 6220.3 6248.7 3591.7 3632.8 3714.2 3729.3 3738.0 5403.7 5411.4 5414.5 5484.7 5492.3 5167.3 5246.3 5284.4 5318.1 5354.4 4980.3 5142.7 5148.8 5150.0 5196.9 5055.2 5074.4 5117.4 5122.8 5141.6 5009.9 5142.8 5159.3 5173.7 5197.4 5078.3 5105.9 5112.8 5130.4 5156.9 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - PROCESS | 18585 | [#5] yui.html Cycles:180 Average:20407.89 Median:4039.30 stddev:29057.85 (719.4%) stddev-sans-first:29101.72 09:51:53 INFO - PROCESS | 18585 | Values: 711.0 765.9 788.8 796.0 797.4 14703.3 15681.7 15965.4 15977.1 15977.2 14020.3 14079.4 14079.9 14487.9 14753.3 655.8 788.3 792.4 798.7 799.1 782.6 808.1 808.5 808.8 811.2 845.9 847.6 849.7 853.8 856.1 831.4 836.9 838.6 839.4 839.9 608.6 609.8 611.1 611.5 612.7 15195.8 15258.3 15313.6 15316.9 15333.8 14857.0 15047.5 15117.0 15176.8 15368.6 11685.0 11685.7 11732.6 11856.0 11971.3 3864.4 3876.3 3965.4 4034.8 4043.8 73376.3 74012.6 74559.6 74598.3 76530.0 12057.4 12064.7 12113.0 12187.0 12248.0 22854.0 22878.0 22932.4 22949.0 22987.4 8355.7 8511.0 8533.1 8544.6 8874.0 4471.1 4538.7 4604.9 4614.1 4654.5 3420.7 3511.4 3513.4 3520.0 3522.7 568.9 580.7 584.4 586.7 598.8 676.8 698.9 711.7 714.3 745.6 9310.8 9644.9 9953.0 10070.9 10446.3 631.9 681.7 713.4 719.9 721.2 4967.8 5043.0 5046.3 5066.6 5067.2 109364.0 112119.4 112204.0 115460.0 116276.0 102534.5 102778.5 102869.0 105764.0 106974.0 54052.7 54637.0 73679.0 89313.6 91991.0 9469.3 9473.1 9523.9 9564.3 9630.0 44345.6 52052.7 52105.7 52833.7 53075.7 52620.7 54622.0 72216.0 74750.6 77230.0 13141.4 13277.3 13369.7 13548.7 13632.5 15240.5 15406.5 15430.6 15526.0 15715.8 13230.7 13858.4 14429.5 14433.9 14665.6 14121.6 14348.3 14450.9 14616.0 15100.2 13283.5 13411.7 13532.9 13615.7 14169.6 11303.5 11519.4 11545.1 11699.3 12143.5 10971.9 11204.9 11359.6 11378.9 11485.7 09:51:53 INFO - PROCESS | 18585 | -------- Summary: end -------- 09:51:53 INFO - PROCESS | 18585 | 09:51:53 INFO - TEST-INFO | 18585: exit 0 09:51:53 INFO - TEST-OK | dromaeo_css | took 1111422ms 09:51:53 INFO - TEST-START | kraken 09:51:53 INFO - operating with platform_type : linux_ 09:51:53 INFO - Initialising browser for kraken test... 09:51:53 INFO - TEST-INFO | started process 18823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbuVrfm/profile http://localhost:57356/getInfo.html) 09:51:58 INFO - PROCESS | 18823 | __metrics Screen width/height:1600/1200 09:51:58 INFO - PROCESS | 18823 | colorDepth:24 09:51:58 INFO - PROCESS | 18823 | Browser inner width/height: 1024/697 09:51:58 INFO - PROCESS | 18823 | __metrics 09:51:59 ERROR - PROCESS | 18823 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:52:00 INFO - TEST-INFO | 18823: exit 0 09:52:00 INFO - Browser initialized. 09:52:00 INFO - Running cycle 1/1 for kraken test... 09:52:00 INFO - TEST-INFO | started process 18943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbuVrfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:12 INFO - PROCESS | 18943 | RSS: Main: 185237504 09:52:12 INFO - PROCESS | 18943 | 09:52:14 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:15 INFO - PROCESS | 18943 | RSS: Main: 191365120 09:52:15 INFO - PROCESS | 18943 | 09:52:18 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-dft) 09:52:18 INFO - PROCESS | 18943 | RSS: Main: 190029824 09:52:18 INFO - PROCESS | 18943 | 09:52:21 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-fft) 09:52:22 INFO - PROCESS | 18943 | RSS: Main: 184942592 09:52:22 INFO - PROCESS | 18943 | 09:52:24 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-oscillator) 09:52:25 INFO - PROCESS | 18943 | RSS: Main: 185511936 09:52:25 INFO - PROCESS | 18943 | 09:52:27 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:27 INFO - PROCESS | 18943 | RSS: Main: 185745408 09:52:27 INFO - PROCESS | 18943 | 09:52:31 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:31 INFO - PROCESS | 18943 | RSS: Main: 185835520 09:52:31 INFO - PROCESS | 18943 | 09:52:35 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:35 INFO - PROCESS | 18943 | RSS: Main: 183672832 09:52:35 INFO - PROCESS | 18943 | 09:52:38 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57356/tests/kraken/driver.html?testName=json-parse-financial) 09:52:39 INFO - PROCESS | 18943 | RSS: Main: 185024512 09:52:39 INFO - PROCESS | 18943 | 09:52:40 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:41 INFO - PROCESS | 18943 | RSS: Main: 185389056 09:52:41 INFO - PROCESS | 18943 | 09:52:43 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:43 INFO - PROCESS | 18943 | RSS: Main: 186023936 09:52:43 INFO - PROCESS | 18943 | 09:52:46 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:46 INFO - PROCESS | 18943 | RSS: Main: 186368000 09:52:46 INFO - PROCESS | 18943 | 09:52:49 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:49 INFO - PROCESS | 18943 | RSS: Main: 186908672 09:52:49 INFO - PROCESS | 18943 | 09:52:52 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:53 INFO - PROCESS | 18943 | RSS: Main: 186454016 09:52:53 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57356/tests/kraken/driver.html?testName=ai-astar) 09:52:55 INFO - PROCESS | 18943 | RSS: Main: 187494400 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | __start_tp_report 09:52:55 INFO - PROCESS | 18943 | _x_x_mozilla_page_load 09:52:55 INFO - PROCESS | 18943 | _x_x_mozilla_page_load_details 09:52:55 INFO - PROCESS | 18943 | |i|pagename|runs| 09:52:55 INFO - PROCESS | 18943 | |0;ai-astar;112;105;111;110;111;111;109;110;110;111 09:52:55 INFO - PROCESS | 18943 | |1;audio-beat-detection;153;128;152;191;133;160;163;127;183;128 09:52:55 INFO - PROCESS | 18943 | |2;audio-dft;165;162;161;161;165;175;164;164;162;163 09:52:55 INFO - PROCESS | 18943 | |3;audio-fft;74;75;75;158;75;75;74;75;160;76 09:52:55 INFO - PROCESS | 18943 | |4;audio-oscillator;85;85;146;86;86;84;131;85;85;140 09:52:55 INFO - PROCESS | 18943 | |5;imaging-gaussian-blur;118;117;119;118;119;118;117;117;118;117 09:52:55 INFO - PROCESS | 18943 | |6;imaging-darkroom;148;148;148;147;148;148;147;148;146;147 09:52:55 INFO - PROCESS | 18943 | |7;imaging-desaturate;96;97;95;95;95;95;97;95;95;96 09:52:55 INFO - PROCESS | 18943 | |8;json-parse-financial;54;56;56;54;57;54;55;59;55;57 09:52:55 INFO - PROCESS | 18943 | |9;json-stringify-tinderbox;65;63;63;68;63;70;62;63;62;62 09:52:55 INFO - PROCESS | 18943 | |10;stanford-crypto-aes;78;81;79;87;86;80;82;80;103;85 09:52:55 INFO - PROCESS | 18943 | |11;stanford-crypto-ccm;125;135;125;123;129;122;123;129;127;132 09:52:55 INFO - PROCESS | 18943 | |12;stanford-crypto-pbkdf2;159;164;167;160;172;161;162;162;161;159 09:52:55 INFO - PROCESS | 18943 | |13;stanford-crypto-sha256-iterative;76;64;65;63;64;67;66;65;63;63 09:52:55 INFO - PROCESS | 18943 | __end_tp_report 09:52:55 INFO - PROCESS | 18943 | __start_cc_report 09:52:55 INFO - PROCESS | 18943 | _x_x_mozilla_cycle_collect,886 09:52:55 INFO - PROCESS | 18943 | __end_cc_report 09:52:55 INFO - PROCESS | 18943 | __startTimestamp1466182375268__endTimestamp 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | ------- Summary: start ------- 09:52:55 INFO - PROCESS | 18943 | Number of tests: 14 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.94 (1.8%) stddev-sans-first:1.92 09:52:55 INFO - PROCESS | 18943 | Values: 112.0 105.0 111.0 110.0 111.0 111.0 109.0 110.0 110.0 111.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:156.50 stddev:23.11 (14.8%) stddev-sans-first:24.51 09:52:55 INFO - PROCESS | 18943 | Values: 153.0 128.0 152.0 191.0 133.0 160.0 163.0 127.0 183.0 128.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:4.08 (2.5%) stddev-sans-first:4.31 09:52:55 INFO - PROCESS | 18943 | Values: 165.0 162.0 161.0 161.0 165.0 175.0 164.0 164.0 162.0 163.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.00 stddev:35.48 (47.3%) stddev-sans-first:37.05 09:52:55 INFO - PROCESS | 18943 | Values: 74.0 75.0 75.0 158.0 75.0 75.0 74.0 75.0 160.0 76.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:85.00 stddev:26.26 (30.9%) stddev-sans-first:27.19 09:52:55 INFO - PROCESS | 18943 | Values: 85.0 85.0 146.0 86.0 86.0 84.0 131.0 85.0 85.0 140.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:52:55 INFO - PROCESS | 18943 | Values: 118.0 117.0 119.0 118.0 119.0 118.0 117.0 117.0 118.0 117.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:52:55 INFO - PROCESS | 18943 | Values: 148.0 148.0 148.0 147.0 148.0 148.0 147.0 148.0 146.0 147.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 09:52:55 INFO - PROCESS | 18943 | Values: 96.0 97.0 95.0 95.0 95.0 95.0 97.0 95.0 95.0 96.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.64 (2.9%) stddev-sans-first:1.62 09:52:55 INFO - PROCESS | 18943 | Values: 54.0 56.0 56.0 54.0 57.0 54.0 55.0 59.0 55.0 57.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:63.00 stddev:2.77 (4.4%) stddev-sans-first:2.92 09:52:55 INFO - PROCESS | 18943 | Values: 65.0 63.0 63.0 68.0 63.0 70.0 62.0 63.0 62.0 62.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:81.50 stddev:7.31 (9.0%) stddev-sans-first:7.41 09:52:55 INFO - PROCESS | 18943 | Values: 78.0 81.0 79.0 87.0 86.0 80.0 82.0 80.0 103.0 85.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.00 stddev:4.24 (3.3%) stddev-sans-first:4.44 09:52:55 INFO - PROCESS | 18943 | Values: 125.0 135.0 125.0 123.0 129.0 122.0 123.0 129.0 127.0 132.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:162.00 stddev:4.06 (2.5%) stddev-sans-first:4.08 09:52:55 INFO - PROCESS | 18943 | Values: 159.0 164.0 167.0 160.0 172.0 161.0 162.0 162.0 161.0 159.0 09:52:55 INFO - PROCESS | 18943 | 09:52:55 INFO - PROCESS | 18943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:3.89 (6.0%) stddev-sans-first:1.42 09:52:55 INFO - PROCESS | 18943 | Values: 76.0 64.0 65.0 63.0 64.0 67.0 66.0 65.0 63.0 63.0 09:52:55 INFO - PROCESS | 18943 | -------- Summary: end -------- 09:52:55 INFO - PROCESS | 18943 | 09:52:56 INFO - TEST-INFO | 18943: exit 0 09:52:56 INFO - TEST-OK | kraken | took 62569ms 09:52:56 INFO - SUITE-END | took 1173s 09:52:56 INFO - Completed test suite (00:19:34) 09:52:56 INFO - javascript benchmark 09:52:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7112.480088795002, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3051.099925521971, 3106.642736085348, 3145.323755392591, 3149.370125974804, 3151.873925042997, 5262.921056184151, 5272.340957380327, 5323.893522129565, 5328.733563321833, 5355.651882627626, 5194.246834209038, 5289.047971365153, 5310.256564081032, 5350.491703288191, 5375.43557926418, 4784.067106914154, 4835.806567737286, 4905.533974272438, 4949.579285760697, 5011.599072074226, 721.7772512112206, 4743.525647435264, 4768.785404656799, 4885.120678277926, 4953.752312384385, 4783.210770222909, 4829.396325459317, 4844.813020809889, 4866.416030076378, 4916.58209052231, 4840.733759643218, 4875.634327425421, 4878.658493905428, 4880.755962201875, 4940.5059494050665, 4759.214729569617, 4774.976125119387, 4805.111054454937, 4837.61299096075, 4848.636352273594, 5283.55089817366, 5308.840734777963, 5346.0, 5351.0, 5355.544778693816, 5534.52956498694, 5650.265465489501, 5690.374058853523, 5698.772049118031, 5703.230063941356, 5729.828105156852, 5811.070228763419, 5814.854628634275, 5832.62087964281, 5862.70686465675, 5437.918431223535, 5446.945530544723, 5449.182622606601, 5451.3458384993655, 5452.6455780374545, 5789.102689083199, 5844.152597873284, 5905.675187864708, 5914.4381283777975, 5922.49658779, 5619.072852979294, 5669.262995810601, 5702.7433765480655, 5711.7144142792695, 5767.394423585463, 5751.281089863767, 5755.1367294906095, 5787.1319302104175, 5791.218185544897, 5796.739146738322, 5577.637453565505, 5635.971820140955, 5652.0674088774895, 5714.857128571736, 5739.397363276879, 5713.628614140068, 5745.88508229833, 5746.798862039808, 5770.336411312753, 5816.0, 4413.360062790942, 4445.911081778347, 4456.46522417312, 4457.710248833815, 4479.776011199427, 3858.749181303206, 3939.7045221607923, 3949.6445319921345, 3994.3009973254566, 4019.718619696652, 5336.252924590561, 5437.809676661298, 5489.286392768994, 5502.2296878437055, 5550.5282051026115, 5710.5146062585145, 5733.283339582552, 5754.108113242454, 5769.221155144086, 5801.593888427769, 5346.8663283417445, 5400.621956463088, 5439.265699130646, 5466.535344495683, 5492.681756378441, 4984.925226121611, 5005.89988200234, 5009.949900501021, 5026.472220416804, 5071.54356107952, 6026.789062382795, 6033.7586496540525, 6035.849103772353, 6041.214642096587, 6049.455549000611, 5601.971990139942, 5700.315962084576, 5722.570807189394, 5722.599418040697, 5782.392848750821, 6047.9395206047375, 6050.818475445743, 6055.303640081447, 6058.485028772604, 6060.090986352083, 5541.307336582927, 5669.971650141723, 5679.432056794288, 5685.147227915846, 5685.403032681509, 5698.116791897262, 5734.885302294014, 5768.971155144198, 5803.390643982321, 5813.3605303417435, 5589.720513974204, 5663.065594176915, 5669.34802497718, 5670.092785154356, 5672.149177623224, 5420.078586640202, 5528.6406383586545, 5605.103183490622, 5638.577106716931, 5664.178694089416, 5457.536109430743, 5459.07195776711, 5516.255305533701, 5545.528630066489, 5593.524550413261, 5537.9169312459535, 5544.473275038865, 5594.804181853616, 5600.159976003632, 5606.551475882001, 5302.2576839241765, 5354.143337066051, 5396.325459317585, 5441.319835020622, 5512.448755124616], "value": 5263.256608068624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4351663611342, 622.3403192615826, 641.5573254454426, 643.6845945486712, 646.5474168082344, 37200.81399593002, 41035.0, 41348.793256033714, 41431.378529322086, 41432.17135657292, 42318.0, 42401.0, 43034.35448468276, 43089.56910430895, 43092.0, 8801.42790718603, 8918.420302680304, 8927.107289271085, 8945.55272236389, 8986.415882967618, 8748.431351962134, 8837.690680826172, 8932.196102350787, 8959.37284390093, 8976.506292153928, 8893.599788009555, 8931.77670558238, 8948.284137269004, 8999.055099214587, 9014.233790127848, 8932.598033088527, 8933.240674542672, 8942.463452192856, 8952.59713312896, 8987.056359082268, 8826.779330516723, 8845.0, 8866.778330541789, 8904.688335908211, 8907.688230911886, 33498.49752253718, 39884.60115398867, 40181.79909100465, 40198.397024044665, 40320.193596127916, 3087.6294844618787, 3108.1918701137865, 3261.951070733941, 3567.1973805893726, 3679.300932822755, 30835.0, 30928.0, 31032.689673103207, 31284.53073203904, 32186.0, 4254.765987870697, 4279.465066866642, 4369.213541562517, 4402.779861006937, 4456.19788438081, 279550.0, 281408.0, 281754.0, 282786.0, 283108.0, 33350.0, 33378.666213338045, 33516.329673406886, 33550.83224583862, 33554.328913421596, 32247.838760806517, 34144.82927585396, 34296.82851585726, 35019.82490087584, 36604.81697591495, 14631.85368146305, 14736.115833050051, 14775.556733298019, 14785.926070369795, 14841.332140053508, 12196.756064878653, 12238.388080595934, 12273.93863030697, 12319.568815091428, 12361.690957726129, 8063.354931605458, 8100.71647492335, 8152.347812175011, 8209.261166495044, 8221.260086592236, 3224.8387580620874, 3265.8856940006985, 3269.9509507357407, 3272.592785102429, 3280.343931213719, 1031.747221930632, 1071.266182664877, 1071.6784964510616, 1095.1239008793093, 1105.1103861391657, 32398.0, 32736.836315818746, 32770.508442373386, 33217.3356532868, 33470.0, 1071.7588542577857, 1096.983545246822, 1107.1640911112058, 1138.2771939818274, 1188.6493484422117, 16580.962746253004, 16938.661226775643, 17046.403375881786, 17151.65696686059, 17171.828281717273, 550090.0, 552862.0, 555838.0, 557927.0, 560100.0, 55644.0, 55701.44298557044, 56607.71696141493, 56612.0, 56949.71525142348, 1314.3231235913513, 1337.4716986790163, 1350.1696456679072, 1351.1015174908575, 1359.1165742267606, 30343.696563034086, 31772.68227317697, 32074.839625802655, 32278.515822263154, 32603.0, 46862.29706554473, 47615.52384476111, 47919.0, 47942.760286199744, 48361.516384835704, 475607.0, 475720.0, 476314.23685764085, 477545.0, 479051.0, 27014.864925675247, 27358.863205683843, 28091.859540702164, 29034.709652904046, 29191.85404073051, 47421.76951790967, 48185.51814481951, 48213.51786482231, 48800.5119948796, 48871.266930996775, 40421.1915761689, 40435.0, 41585.792071039454, 41596.792016040934, 42345.364819527116, 39700.80149599349, 39921.2015759689, 40459.39310910398, 41389.793051034554, 41478.79260603798, 40368.3944740835, 40496.162416439714, 41268.174636507705, 41312.1737565253, 41523.37714934339, 34024.65975340215, 35625.64374356327, 36001.81999089988, 36412.635873641986, 36431.27137457289, 27978.860105699343, 28015.0, 28169.718302817528, 28283.292917677223, 28401.573976390784], "value": 18375.346013490107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1123161113632, 385.51144027270266, 386.7872670031482, 391.5497178245018, 409.8585987834198, 13804.171749695026, 15454.381824726997, 18133.637327253447, 19468.902655486738, 19620.215191392344, 16131.596710082255, 18611.441656750318, 19086.995865434103, 19165.1375688094, 19201.0, 5743.913841292384, 5863.912041319362, 5922.4077592240865, 5939.524838012971, 5977.88044239115, 5747.568932330071, 5813.331466881321, 5827.533797296227, 5846.619969701956, 5866.589338746289, 5759.4816466518005, 5838.095095260242, 5838.948989181946, 5846.298444186704, 5872.823815285548, 5693.914591281134, 5740.311162660508, 5752.079667253241, 5776.046952252873, 5817.214676018747, 4990.326305948687, 5094.133997220444, 5191.091558977201, 5196.376434827807, 5238.68567885928, 22062.66905996395, 22451.663225051638, 22527.0, 22798.316050518344, 22934.426639333982, 2359.7876191142877, 2429.757024297574, 2511.1462102884925, 2569.8586577738215, 2869.569564565311, 9224.40041397307, 9931.55308011134, 10071.093601575893, 10348.430836304, 14663.853361466356, 1947.805219478055, 1978.8219060284644, 1985.265451782835, 1990.4028791362678, 2004.8295894848955, 82229.58885205536, 84791.5760421194, 84918.5754071232, 84945.0, 86698.56650716769, 10446.373217606968, 10470.214733894989, 10631.574737010433, 10693.358398496115, 10735.89264107349, 14860.777088343684, 14934.32795524204, 14941.402343906122, 14946.252687365588, 14987.700245995236, 7512.812179695442, 7881.133075361706, 7971.40214483916, 8017.559034253172, 8047.718329858427, 7484.588347640932, 7567.735129270449, 7637.236276372319, 7696.923030769733, 7776.222377762178, 4581.931271030937, 4643.164230438553, 4693.366395536559, 4749.435304935365, 4783.784729687172, 1968.4980330015753, 1992.432156835295, 1996.4509759816167, 2020.2424090965887, 2020.706747681485, 920.30516959695, 959.2661613865398, 976.1409959235828, 1010.5705075343096, 1060.0459586372172, 18805.81194188068, 19247.90376048111, 19374.80625193758, 19449.4165175045, 19668.606627867364, 935.4434111703525, 966.2028826218258, 974.6637410093506, 976.1848856205148, 1003.6637726361605, 9346.392484488622, 10121.848172277421, 10624.893751062546, 10723.517441715141, 11362.147838912115, 443862.0, 445794.0, 446124.0, 452850.0, 456985.0, 94491.52754236184, 95796.0, 96101.0, 96126.0, 96207.51896240473, 1033.5452400943561, 1054.446415631784, 1085.218642577343, 1102.9062529685066, 1104.8563686720674, 17536.0, 17557.297708092043, 17585.736213956545, 17786.46640600784, 18115.094245287946, 41838.0, 42965.78517107519, 43527.129457411305, 45207.09585808331, 46048.8487787808, 58753.4124658748, 59230.40769592249, 60199.39800602113, 60229.0965635507, 60809.0, 7580.507267027626, 7841.607919604111, 7875.369970402468, 7930.9603451982375, 8278.751637450887, 9567.808643827224, 13781.0, 13929.721405572034, 14032.158070515801, 14183.43266269379, 12039.699007524881, 12281.324527151093, 12370.75258494843, 12372.62882113538, 12515.812262815884, 11963.401829908296, 12015.879841201826, 12061.879381206076, 12118.091143164122, 12223.388830558259, 12184.57353992606, 12189.988651872696, 12285.0, 12327.630171094881, 12446.81329780036, 7972.880406793786, 8011.719589814328, 8034.196580341919, 8120.309773669304, 8163.0, 10773.730656733644, 11833.349165795964, 12312.692182695146, 12422.627321180378, 12450.875491244971], "value": 9214.717944006748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.4568286892415, 1486.5391728564146, 1540.6379500817307, 1696.787901512311, 1713.9973115727298, 7729.0, 8113.675452981874, 8394.24451799338, 8957.10428957104, 8980.326475514337, 8419.0, 8624.698135565257, 8678.305735541157, 8764.91235087649, 8769.868451973225, 2162.5782972320444, 2169.707089542915, 2201.2405720026563, 2205.3383984804573, 2207.94480137997, 2020.1111510935216, 2026.3110542415575, 2183.410479170631, 2184.4102092435032, 2186.3113119367426, 2102.8633138846003, 2107.2413930984835, 2107.7154584131176, 2122.7983341582526, 2141.6787481877764, 2081.55246621977, 2109.862858914166, 2114.7990940860595, 2117.237794394017, 2117.4388786971463, 1964.636542239676, 2115.661494160927, 2121.1091341636397, 2127.4574983379293, 2131.8720876747443, 8734.606942687595, 8795.296376289882, 8813.1186881312, 8822.985356683936, 8824.205821476098, 5087.694738315676, 5196.896062078775, 5211.452797456251, 5221.556167725748, 5222.373315202162, 3211.550382946389, 3250.089974807058, 3258.3157536917274, 3267.3791979524053, 3284.3759685659647, 1098.1105304703217, 1148.9023433008203, 1157.9826302605468, 1162.8081366574504, 1163.941802909851, 11876.762464750744, 11951.22317049389, 11982.400879956054, 11993.640190794204, 12031.93984030083, 4263.70154089217, 4284.228838808982, 4353.151135528541, 4358.128374325084, 4459.910801783946, 9875.60497580103, 9957.103860652576, 9969.750756231007, 9999.800003999879, 10038.096571308617, 4947.35684361038, 4990.401151861727, 4994.101061808837, 5027.899442011212, 5042.546170844568, 4553.954460455353, 4644.86065418038, 4685.039566888848, 4736.621070314367, 4757.500462451462, 3543.989962860572, 3588.4258518637416, 3638.4542318651884, 3645.1616128290643, 3672.9081772955356, 1088.7604726960055, 1100.658795773313, 1106.2090605217147, 1111.0833562310963, 1123.9887601124049, 866.8483015472393, 938.6292414496236, 960.5053397500293, 962.9807403851884, 1008.3546530220665, 5749.626274292241, 5885.293764748258, 6028.849278768066, 6138.7237574309265, 6203.16257305258, 909.0500427053745, 912.8630705394244, 944.4474982135528, 948.8102379523984, 953.9379940303858, 4097.651699605507, 4280.229558679405, 4295.613394794421, 4356.259435895905, 4391.912161756811, 10440.582376704846, 10885.83671244932, 10889.346639201673, 10898.291611045257, 10980.0, 10780.568777248978, 10843.07833834117, 10844.837327440095, 10857.782844343068, 10863.076638485818, 7638.274363935418, 7920.960395198103, 7976.322012628992, 8096.190380961857, 8187.672493100328, 5920.940790592039, 6122.785702500391, 6158.168647232566, 6253.124562561154, 6332.746690132343, 9924.15644670211, 10029.849552256868, 10098.091171794575, 10157.593696252066, 10223.488825558841, 9028.729138125867, 10189.898101019191, 10204.795904081728, 10276.0, 10341.069303762697, 7767.728129515666, 7834.843303134019, 7887.64505597261, 7928.920710792819, 7933.127355990951, 8461.95769021151, 8473.364497662576, 8473.66105355779, 8517.574121294034, 8565.186307300797, 7572.962135189288, 7580.810479738051, 7589.772306830804, 7629.2752188542, 7833.373330133461, 7450.478466507509, 7526.209747976383, 7585.279398457138, 7587.317141457295, 7613.352865006536, 6631.602103873783, 6644.83387915306, 6676.165479315086, 6677.732890684319, 6698.7320507179165, 5203.895922081461, 5213.478652134908, 5221.973890130677, 5379.811706590251, 5422.674639521483, 5160.174372100446, 5183.948160518346, 5235.3717553893775, 5241.371035475768, 5266.183741520071], "value": 4520.818479041168, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.1470250974684, 306.0832805746789, 308.2694015184014, 317.6950127877238, 320.55282880381867, 5530.142827861683, 5541.445855414457, 5548.0, 5549.223108764776, 5555.916661250085, 5464.644798088131, 5472.671639701621, 5485.533729632976, 5501.284832971718, 5525.944740552593, 4239.724417912841, 4276.273033584298, 4280.5291417944, 4284.6786491013145, 4316.287812510932, 3969.24584328978, 4229.534751177368, 4250.596193361641, 4269.9538613039695, 4287.31402975524, 4236.385724070008, 4265.573442655741, 4272.444582204309, 4281.935770963438, 4299.634531064863, 4045.393191021341, 4060.330045542482, 4273.7392469221495, 4276.25165596021, 4281.0, 3643.7631553949172, 3649.59854416014, 3664.0656632558525, 3669.1744357519347, 3677.6322367763278, 5384.865378365533, 5409.648372855751, 5431.131019036975, 5432.375276843174, 5440.075187218183, 4696.859094227145, 4774.949511107586, 4824.445188803297, 4858.149823780825, 4888.828890988798, 5648.181013752983, 5669.206311116406, 5685.147227915804, 5729.312482502085, 5746.856328591777, 4046.271671099201, 4055.229506393776, 4060.6954478414236, 4070.206309769596, 4079.0822065035427, 5668.26312579362, 5972.731227094748, 5983.820485385445, 6063.969680151615, 6077.453029227347, 4100.118474527991, 4100.36444351126, 4118.114605359862, 4126.319157339006, 4148.357004664282, 4201.306784380604, 4202.810873510699, 4210.2842516772225, 4219.0, 4223.282042052859, 4606.631469482433, 4837.975810120927, 4854.805807767721, 4875.07373599015, 4875.536824001785, 5711.7144142792695, 5736.852629474122, 5770.538356931435, 5787.971060144757, 5801.970990145107, 1410.16095423223, 1438.8561143885527, 1439.6400899775056, 1446.8046813680019, 1451.796748455217, 862.254150160107, 901.1394118616705, 902.7833320003152, 912.4570880326328, 916.1571354354011, 4982.90034199314, 5043.621728370387, 5062.417821950449, 5062.860856307301, 5074.314967479343, 5273.894522109536, 5276.683398995996, 5281.494773989394, 5326.627136100513, 5336.0, 5016.197408414636, 5021.548060674484, 5115.693058416507, 5254.842354729364, 5731.254936858265, 3104.177392990859, 3194.99357702323, 3213.775035747522, 3214.533892585562, 3233.7413006959387, 6253.499720022387, 6297.433231009231, 6314.9684251579365, 6324.494040476751, 6326.652034138075, 5741.224934633855, 5998.940010599926, 6094.512439004869, 6097.878042439126, 6118.449339559461, 6196.0, 6239.313675495692, 6288.371162883766, 6289.874202516015, 6308.7476500940365, 5704.344000440003, 5911.55663325261, 5942.376050514807, 5976.193213916065, 5979.5814292999075, 5870.5010074142465, 5877.706114694162, 5893.174955506147, 5919.644821310735, 5945.435183657545, 6178.5366097543765, 6207.96896015517, 6218.284897236876, 6220.315765265726, 6248.718807653758, 3591.676749092594, 3632.7648599476306, 3714.2200137971327, 3729.328720830277, 3738.0, 5403.675779453245, 5411.404745478073, 5414.485623865727, 5484.670919744828, 5492.308768703387, 5167.302414174038, 5246.344206974129, 5284.357821089456, 5318.149096144598, 5354.3842458117815, 4980.252962055721, 5142.665726727751, 5148.819791307286, 5150.0472412603785, 5196.948030519647, 5055.216441451581, 5074.3657042869645, 5117.368781252972, 5122.769475373542, 5141.640085194001, 5009.87277862478, 5142.820001300086, 5159.251908473176, 5173.689578625294, 5197.428282888804, 5078.314427552233, 5105.872353191051, 5112.769925353294, 5130.435652078194, 5156.871078223075], "value": 4248.342185936811, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9608971506568, 765.9119201291853, 788.8106854354954, 795.9562224077677, 797.4059325802276, 14703.33834977426, 15681.686366272668, 15965.361385544578, 15977.121258330788, 15977.201139943, 14020.298985050758, 14079.436822527086, 14079.92960035201, 14487.92756036221, 14753.336099875505, 655.7967030220623, 788.2866006264326, 792.3819420851745, 798.664560884427, 799.1369321133192, 782.6399856066216, 808.1474044882647, 808.4825711544587, 808.7614153824636, 811.2131232704268, 845.9069502354736, 847.5973912391627, 849.7110982266029, 853.8377708235415, 856.0540602634093, 831.4055450352996, 836.8535506286375, 838.6058552480324, 839.4082172068677, 839.8740188971642, 608.6104892868568, 609.7560975609791, 611.0620197996054, 611.4710775179482, 612.7059011674421, 15195.848041519554, 15258.313375898, 15313.61715957099, 15316.923415382964, 15333.769993450107, 14857.0, 15047.473338433212, 15117.0, 15176.772348414783, 15368.615784605363, 11685.0, 11685.699777974698, 11732.64802055931, 11856.0, 11971.281723096643, 3864.3816989281863, 3876.263509933132, 3965.4448377227213, 4034.8386064557676, 4043.757374557536, 73376.26623733748, 74012.62993684997, 74559.62720186364, 74598.25401745968, 76530.0, 12057.397130143634, 12064.70500669865, 12113.0, 12187.025037996938, 12248.0, 22854.0, 22878.0, 22932.4266893329, 22949.0, 22987.425314367276, 8355.749327520183, 8510.957445212734, 8533.146685331418, 8544.61549230286, 8873.955630221937, 4471.083427897273, 4538.682292239511, 4604.861854144381, 4614.146382919171, 4654.464736555272, 3420.743444241692, 3511.3504001759757, 3513.3675938330834, 3520.0495866116007, 3522.682958533744, 568.8805350876362, 580.7386675995818, 584.3572070722256, 586.7007826008767, 598.7994071885842, 676.7631329034798, 698.8637215742983, 711.661960568736, 714.2500374606747, 745.5675708089295, 9310.813783724288, 9644.855327170098, 9952.950235248778, 10070.899291007143, 10446.320989135682, 631.924169099711, 681.7421856674428, 713.4399496395305, 719.8812195987708, 721.2354903801987, 4967.776450059684, 5042.96911889696, 5046.318746969112, 5066.569341606005, 5067.239914012927, 109364.0, 112119.4394028041, 112204.0, 115460.0, 116276.0, 102534.48732756438, 102778.48610757048, 102869.0, 105764.0, 106974.0, 54052.72973635185, 54637.0, 73678.99999999892, 89313.55343223372, 91991.0, 9469.337146399686, 9473.100055494717, 9523.904750953729, 9564.330496865152, 9630.0, 44345.55654443414, 52052.739736301075, 52105.739471302404, 52833.7358313206, 53075.73462132664, 52620.73689631528, 54622.0, 72216.0, 74750.62624686841, 77230.0, 13141.354476905852, 13277.336133193496, 13369.732605347644, 13548.661283467993, 13632.522861699794, 15240.466583669519, 15406.460773872861, 15430.614234644223, 15526.0, 15715.842841571895, 13230.735385292048, 13858.376373063034, 14429.49496767608, 14433.92783036078, 14665.56003319902, 14121.6469588257, 14348.282585870873, 14450.927745361207, 14616.049956753202, 15100.24498775035, 13283.468661253442, 13411.664708382368, 13532.93233533826, 13615.659608509866, 14169.574912752634, 11303.491342889425, 11519.42402879836, 11545.076393888301, 11699.2980421175, 12143.453544590338, 10971.890281097087, 11204.943975280072, 11359.602413915472, 11378.886211138113, 11485.655430337103], "value": 7562.668863211659, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 111.0, 111.0, 109.0, 110.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 152.0, 191.0, 133.0, 160.0, 163.0, 127.0, 183.0, 128.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 161.0, 165.0, 175.0, 164.0, 164.0, 162.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 158.0, 75.0, 75.0, 74.0, 75.0, 160.0, 76.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 86.0, 86.0, 84.0, 131.0, 85.0, 85.0, 140.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 54.0, 57.0, 54.0, 55.0, 59.0, 55.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 68.0, 63.0, 70.0, 62.0, 63.0, 62.0, 62.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 79.0, 87.0, 86.0, 80.0, 82.0, 80.0, 103.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 135.0, 125.0, 123.0, 129.0, 122.0, 123.0, 129.0, 127.0, 132.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 164.0, 167.0, 160.0, 172.0, 161.0, 162.0, 162.0, 161.0, 159.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 64.0, 65.0, 63.0, 64.0, 67.0, 66.0, 65.0, 63.0, 63.0], "value": 65.6, "unit": "score"}]}]} 09:52:56 INFO - Return code: 0 09:52:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:56 ERROR - # TBPL SUCCESS # 09:52:56 INFO - Running post-action listener: _resource_record_post_action 09:52:56 INFO - ##### 09:52:56 INFO - ##### Finished run-tests step (success) 09:52:56 INFO - ##### 09:52:56 INFO - Running post-run listener: _resource_record_post_run 09:52:56 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 4096; Write bytes: 549093376; Read time: 20; Write time: 406912 09:52:56 INFO - TinderboxPrint: CPU usage
13.5% 09:52:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:52:56 INFO - TinderboxPrint: I/O write bytes / time
549,093,376 / 406,912 09:52:56 INFO - TinderboxPrint: CPU idle
8,220.4 (86.5%) 09:52:56 INFO - TinderboxPrint: CPU user
1,230.0 (12.9%) 09:52:56 INFO - TinderboxPrint: Swap in / out
0 / 0 09:52:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255897600; Read time: 0; Write time: 248372 09:52:56 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 4096; Write bytes: 293191680; Read time: 20; Write time: 158540 09:52:57 INFO - Running post-run listener: _upload_blobber_files 09:52:57 INFO - Blob upload gear active. 09:52:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:57 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 09:52:57 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'] 09:52:57 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 09:52:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:52:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:01 INFO - (blobuploader) - INFO - Done attempting. 09:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:02 INFO - (blobuploader) - INFO - Done attempting. 09:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:02 INFO - (blobuploader) - INFO - Done attempting. 09:53:02 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:02 INFO - Return code: 0 09:53:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97ef782fe2b8d3aa87ef3da105bee4336671c64bb3ac94a180e048c2703b54a8f508b6aef32d9c0630881de6304c21ec607d06e9058d0c91bfc750b99db91d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c61255b138a8accb2b7170bd15332531d85e12da329004a5fa5a13d13d13c937f24d14ad878e1d824f208c6915cd364ab2c263fd9e0868d30544124323b907b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158fe06f0f7a1465bb944ed1360aabcf45dfab5d70cd50b4674268f7a712b3e203dafa3158a7cb9958dbb29501d7c77cdd4269944788e0f34c314cbb0809e33d"} 09:53:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:02 INFO - Contents: 09:53:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97ef782fe2b8d3aa87ef3da105bee4336671c64bb3ac94a180e048c2703b54a8f508b6aef32d9c0630881de6304c21ec607d06e9058d0c91bfc750b99db91d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c61255b138a8accb2b7170bd15332531d85e12da329004a5fa5a13d13d13c937f24d14ad878e1d824f208c6915cd364ab2c263fd9e0868d30544124323b907b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158fe06f0f7a1465bb944ed1360aabcf45dfab5d70cd50b4674268f7a712b3e203dafa3158a7cb9958dbb29501d7c77cdd4269944788e0f34c314cbb0809e33d"} 09:53:02 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:02 INFO - Copying logs to upload dir... 09:53:02 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.076766 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-17 09:53:02.677134) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:53:02.681166) ========= 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=1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97ef782fe2b8d3aa87ef3da105bee4336671c64bb3ac94a180e048c2703b54a8f508b6aef32d9c0630881de6304c21ec607d06e9058d0c91bfc750b99db91d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c61255b138a8accb2b7170bd15332531d85e12da329004a5fa5a13d13d13c937f24d14ad878e1d824f208c6915cd364ab2c263fd9e0868d30544124323b907b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158fe06f0f7a1465bb944ed1360aabcf45dfab5d70cd50b4674268f7a712b3e203dafa3158a7cb9958dbb29501d7c77cdd4269944788e0f34c314cbb0809e33d"} build_url:https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011582 build_url: 'https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97ef782fe2b8d3aa87ef3da105bee4336671c64bb3ac94a180e048c2703b54a8f508b6aef32d9c0630881de6304c21ec607d06e9058d0c91bfc750b99db91d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c61255b138a8accb2b7170bd15332531d85e12da329004a5fa5a13d13d13c937f24d14ad878e1d824f208c6915cd364ab2c263fd9e0868d30544124323b907b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/158fe06f0f7a1465bb944ed1360aabcf45dfab5d70cd50b4674268f7a712b3e203dafa3158a7cb9958dbb29501d7c77cdd4269944788e0f34c314cbb0809e33d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:53:02.709128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:53:02.709535) ========= 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=1f5564757af27664ca02d71f000001b0-1466180721.591851-1109233872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:53:02.792032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:53:02.792355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:53:02.792726) ========= ========= Total master_lag: 0.19 =========