builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1467051378.77 results: success (0) buildid: 20160627083118 builduid: 68f55c1ee9ae4b7a8f5a97ed4a19b275 revision: 3c55e34b5259d9e656f93b18f2aebe46af09a732 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.768550) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.769006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.769303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.799035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.799482) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 11:16:18-- 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% 114M=0s 2016-06-27 11:16:18 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.927625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.927919) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015656 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.983927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:18.984346) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c55e34b5259d9e656f93b18f2aebe46af09a732 --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 3c55e34b5259d9e656f93b18f2aebe46af09a732 --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=4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 11:16:19,097 truncating revision to first 12 chars 2016-06-27 11:16:19,097 Setting DEBUG logging. 2016-06-27 11:16:19,097 attempt 1/10 2016-06-27 11:16:19,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c55e34b5259?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 11:16:19,394 unpacking tar archive at: fx-team-3c55e34b5259/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:19.635200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:19.635529) ========= script_repo_revision: 3c55e34b5259d9e656f93b18f2aebe46af09a732 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:19.635934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:19.636212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 11:16:19.650199) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-27 11:16:19.650532) ========= /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=4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:19 INFO - MultiFileLogger online at 20160627 11:16:19 in /builds/slave/test 11:16:19 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 11:16:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:19 INFO - {'append_to_log': False, 11:16:19 INFO - 'base_work_dir': '/builds/slave/test', 11:16:19 INFO - 'blob_upload_branch': 'Fx-Team', 11:16:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:19 INFO - 'branch': 'Fx-Team', 11:16:19 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:19 INFO - 'config_files': ('talos/linux_config.py',), 11:16:19 INFO - 'default_actions': ('clobber', 11:16:19 INFO - 'read-buildbot-config', 11:16:19 INFO - 'download-and-extract', 11:16:19 INFO - 'populate-webroot', 11:16:19 INFO - 'create-virtualenv', 11:16:19 INFO - 'install', 11:16:19 INFO - 'run-tests'), 11:16:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:19 INFO - 'download_minidump_stackwalk': True, 11:16:19 INFO - 'download_symbols': 'ondemand', 11:16:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:19 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:19 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:19 INFO - 'installer_path': 'installer.exe', 11:16:19 INFO - 'log_level': 'info', 11:16:19 INFO - 'log_name': 'talos', 11:16:19 INFO - 'log_to_console': True, 11:16:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:19 INFO - 'opt_config_files': (), 11:16:19 INFO - 'pip_index': False, 11:16:19 INFO - 'sps_profile': False, 11:16:19 INFO - 'sps_profile_interval': 0, 11:16:19 INFO - 'suite': 'dromaeojs-e10s', 11:16:19 INFO - 'system_bits': '32', 11:16:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:19 INFO - 'title': 'talos-linux64-ix-030', 11:16:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:19 INFO - 'use_talos_json': True, 11:16:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:19 INFO - 'work_dir': 'build'} 11:16:19 INFO - ##### 11:16:19 INFO - ##### Running clobber step. 11:16:19 INFO - ##### 11:16:19 INFO - Running pre-action listener: _resource_record_pre_action 11:16:19 INFO - Running main action method: clobber 11:16:19 INFO - rmtree: /builds/slave/test/build 11:16:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:20 INFO - Running post-action listener: _resource_record_post_action 11:16:20 INFO - ##### 11:16:20 INFO - ##### Finished clobber step (success) 11:16:20 INFO - ##### 11:16:20 INFO - ##### 11:16:20 INFO - ##### Running read-buildbot-config step. 11:16:20 INFO - ##### 11:16:20 INFO - Running pre-action listener: _resource_record_pre_action 11:16:20 INFO - Running main action method: read_buildbot_config 11:16:20 INFO - Using buildbot properties: 11:16:20 INFO - { 11:16:20 INFO - "project": "", 11:16:20 INFO - "product": "firefox", 11:16:20 INFO - "script_repo_revision": "production", 11:16:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:16:20 INFO - "repository": "", 11:16:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:16:20 INFO - "buildid": "20160627083118", 11:16:20 INFO - "pgo_build": "True", 11:16:20 INFO - "basedir": "/builds/slave/test", 11:16:20 INFO - "buildnumber": 578, 11:16:20 INFO - "slavename": "talos-linux64-ix-030", 11:16:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:16:20 INFO - "platform": "ubuntu64_hw", 11:16:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:16:20 INFO - "branch": "fx-team", 11:16:20 INFO - "repo_path": "integration/fx-team", 11:16:20 INFO - "revision": "3c55e34b5259d9e656f93b18f2aebe46af09a732", 11:16:20 INFO - "stage_platform": "linux64-pgo", 11:16:20 INFO - "builduid": "68f55c1ee9ae4b7a8f5a97ed4a19b275", 11:16:20 INFO - "slavebuilddir": "test" 11:16:20 INFO - } 11:16:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:16:20 INFO - Running post-action listener: _resource_record_post_action 11:16:20 INFO - ##### 11:16:20 INFO - ##### Finished read-buildbot-config step (success) 11:16:20 INFO - ##### 11:16:20 INFO - ##### 11:16:20 INFO - ##### Running download-and-extract step. 11:16:20 INFO - ##### 11:16:20 INFO - Running pre-action listener: _resource_record_pre_action 11:16:20 INFO - Running main action method: download_and_extract 11:16:20 INFO - mkdir: /builds/slave/test/build/tests 11:16:20 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')]} 11:16:20 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:21 INFO - Downloaded 1361 bytes. 11:16:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:16:21 INFO - Using the following test package requirements: 11:16:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:16:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:16:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'jsshell-linux-x86_64.zip'], 11:16:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:16:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:16:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:16:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:16:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:16:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:16: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')]} 11:16:21 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:22 INFO - Downloaded 24280069 bytes. 11:16:22 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'] 11:16:22 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 11:16:23 INFO - Return code: 0 11:16:23 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 11:16:23 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')]} 11:16:23 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:16:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:49 INFO - Downloaded 24280069 bytes. 11:16:49 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'] 11:16:49 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 11:16:50 INFO - Return code: 0 11:16:50 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')]} 11:16:50 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:53 INFO - Downloaded 14405245 bytes. 11:16:53 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'] 11:16:53 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 11:16:53 INFO - Return code: 0 11:16: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')]} 11:16:53 INFO - https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RmffnboYTqm-ok1Wx4LKWw/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 11:16:57 INFO - Downloaded 60200994 bytes. 11:16:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:57 INFO - mkdir: /builds/slave/test/properties 11:16:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:57 INFO - Contents: 11:16:57 INFO - build_url:https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:57 INFO - Running post-action listener: _resource_record_post_action 11:16:57 INFO - Running post-action listener: set_extra_try_arguments 11:16:57 INFO - ##### 11:16:57 INFO - ##### Finished download-and-extract step (success) 11:16:57 INFO - ##### 11:16:57 INFO - ##### 11:16:57 INFO - ##### Running populate-webroot step. 11:16:57 INFO - ##### 11:16:57 INFO - Running pre-action listener: _resource_record_pre_action 11:16:57 INFO - Running main action method: populate_webroot 11:16:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:57 INFO - '--tppagecycles', 11:16:57 INFO - '7'], 11:16:57 INFO - 'tests': ['tsvgm']}}, 11:16:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['damp', 'tps']}, 11:16:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'tests': ['damp', 'tps']}, 11:16:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['dromaeo_dom']}, 11:16:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['basic_compositor_video']}, 11:16:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:16:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['a11yr', 11:16:57 INFO - 'ts_paint', 11:16:57 INFO - 'tpaint', 11:16:57 INFO - 'sessionrestore', 11:16:57 INFO - 'sessionrestore_no_auto_restore', 11:16:57 INFO - 'tabpaint']}, 11:16:57 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:57 INFO - 'ts_paint', 11:16:57 INFO - 'tpaint', 11:16:57 INFO - 'sessionrestore', 11:16:57 INFO - 'sessionrestore_no_auto_restore', 11:16:57 INFO - 'tabpaint']}, 11:16:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:57 INFO - 'ts_paint', 11:16:57 INFO - 'tpaint', 11:16:57 INFO - 'sessionrestore', 11:16:57 INFO - 'sessionrestore_no_auto_restore', 11:16:57 INFO - 'tabpaint']}, 11:16:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:57 INFO - 'ts_paint', 11:16:57 INFO - 'tpaint', 11:16:57 INFO - 'sessionrestore', 11:16:57 INFO - 'sessionrestore_no_auto_restore', 11:16:57 INFO - 'tabpaint']}, 11:16:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['a11yr', 11:16:57 INFO - 'ts_paint', 11:16:57 INFO - 'tpaint', 11:16:57 INFO - 'sessionrestore', 11:16:57 INFO - 'sessionrestore_no_auto_restore', 11:16:57 INFO - 'tabpaint']}, 11:16:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['a11yr', 11:16:57 INFO - 'ts_paint', 11:16:57 INFO - 'tpaint', 11:16:57 INFO - 'sessionrestore', 11:16:57 INFO - 'sessionrestore_no_auto_restore', 11:16:57 INFO - 'tabpaint']}, 11:16:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['tsvgx', 11:16:57 INFO - 'tsvgr_opacity', 11:16:57 INFO - 'tart', 11:16:57 INFO - 'tscrollx', 11:16:57 INFO - 'cart']}, 11:16:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:57 INFO - 'tsvgr_opacity', 11:16:57 INFO - 'tart', 11:16:57 INFO - 'tscrollx', 11:16:57 INFO - 'cart']}, 11:16:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'talos_options': ['--disable-e10s'], 11:16:57 INFO - 'tests': ['tp5o']}, 11:16:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'tests': ['tp5o']}, 11:16:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'talos_options': ['--disable-e10s', 11:16:57 INFO - '--xperf_path', 11:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:57 INFO - 'tests': ['tp5n']}, 11:16:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:57 INFO - 'talos_options': ['--xperf_path', 11:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:57 INFO - 'tests': ['tp5n']}}, 11:16:57 INFO - 'talos.zip': {'path': '', 11:16:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:57 INFO - Running post-action listener: _resource_record_post_action 11:16:57 INFO - ##### 11:16:57 INFO - ##### Finished populate-webroot step (success) 11:16:57 INFO - ##### 11:16:57 INFO - ##### 11:16:57 INFO - ##### Running create-virtualenv step. 11:16:57 INFO - ##### 11:16:57 INFO - Running pre-action listener: _resource_record_pre_action 11:16:57 INFO - Running main action method: create_virtualenv 11:16:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:57 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 11:16:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:57 INFO - Using real prefix '/usr' 11:16:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:00 INFO - Installing pip.................done. 11:17:00 INFO - Return code: 0 11:17:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17: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', 'pip>=1.5'] in /builds/slave/test/build 11:17: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 pip>=1.5 11:17:00 INFO - Using env: {'DISPLAY': ':0', 11:17:00 INFO - 'HOME': '/home/cltbld', 11:17:00 INFO - 'LANG': 'en_US.UTF-8', 11:17:00 INFO - 'LANGUAGE': 'en_US:en', 11:17:00 INFO - 'LOGNAME': 'cltbld', 11:17:00 INFO - 'MAIL': '/var/mail/cltbld', 11:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:00 INFO - 'MOZ_NO_REMOTE': '1', 11:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:00 INFO - 'NO_EM_RESTART': '1', 11:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:00 INFO - 'PWD': '/builds/slave/test', 11:17:00 INFO - 'SHELL': '/bin/bash', 11:17:00 INFO - 'SHLVL': '1', 11:17:00 INFO - 'TERM': 'linux', 11:17:00 INFO - 'TMOUT': '86400', 11:17:00 INFO - 'USER': 'cltbld', 11:17:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:00 INFO - '_': '/tools/buildbot/bin/python'} 11:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:00 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 11:17:00 INFO - Cleaning up... 11:17:00 INFO - Return code: 0 11:17:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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', '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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:17: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 psutil>=3.1.1 11:17:00 INFO - Using env: {'DISPLAY': ':0', 11:17:00 INFO - 'HOME': '/home/cltbld', 11:17:00 INFO - 'LANG': 'en_US.UTF-8', 11:17:00 INFO - 'LANGUAGE': 'en_US:en', 11:17:00 INFO - 'LOGNAME': 'cltbld', 11:17:00 INFO - 'MAIL': '/var/mail/cltbld', 11:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:00 INFO - 'MOZ_NO_REMOTE': '1', 11:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:00 INFO - 'NO_EM_RESTART': '1', 11:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:00 INFO - 'PWD': '/builds/slave/test', 11:17:00 INFO - 'SHELL': '/bin/bash', 11:17:00 INFO - 'SHLVL': '1', 11:17:00 INFO - 'TERM': 'linux', 11:17:00 INFO - 'TMOUT': '86400', 11:17:00 INFO - 'USER': 'cltbld', 11:17:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:00 INFO - '_': '/tools/buildbot/bin/python'} 11:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:00 INFO - Downloading/unpacking psutil>=3.1.1 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:02 INFO - Installing collected packages: psutil 11:17:02 INFO - Running setup.py install for psutil 11:17:02 INFO - building 'psutil._psutil_linux' extension 11:17:02 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 11:17:03 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 11:17:03 INFO - building 'psutil._psutil_posix' extension 11:17:03 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 11:17:03 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 11:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:03 INFO - Successfully installed psutil 11:17:03 INFO - Cleaning up... 11:17:03 INFO - Return code: 0 11:17:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:03 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:03 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 11:17:03 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 11:17:03 INFO - Using env: {'DISPLAY': ':0', 11:17:03 INFO - 'HOME': '/home/cltbld', 11:17:03 INFO - 'LANG': 'en_US.UTF-8', 11:17:03 INFO - 'LANGUAGE': 'en_US:en', 11:17:03 INFO - 'LOGNAME': 'cltbld', 11:17:03 INFO - 'MAIL': '/var/mail/cltbld', 11:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:03 INFO - 'MOZ_NO_REMOTE': '1', 11:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:03 INFO - 'NO_EM_RESTART': '1', 11:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:03 INFO - 'PWD': '/builds/slave/test', 11:17:03 INFO - 'SHELL': '/bin/bash', 11:17:03 INFO - 'SHLVL': '1', 11:17:03 INFO - 'TERM': 'linux', 11:17:03 INFO - 'TMOUT': '86400', 11:17:03 INFO - 'USER': 'cltbld', 11:17:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:03 INFO - '_': '/tools/buildbot/bin/python'} 11:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:05 INFO - Installing collected packages: mozsystemmonitor 11:17:05 INFO - Running setup.py install for mozsystemmonitor 11:17:05 INFO - Successfully installed mozsystemmonitor 11:17:05 INFO - Cleaning up... 11:17:05 INFO - Return code: 0 11:17:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17:05 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')]} 11:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 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')]} 11:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:05 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:05 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 11:17:05 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 11:17:05 INFO - Using env: {'DISPLAY': ':0', 11:17:05 INFO - 'HOME': '/home/cltbld', 11:17:05 INFO - 'LANG': 'en_US.UTF-8', 11:17:05 INFO - 'LANGUAGE': 'en_US:en', 11:17:05 INFO - 'LOGNAME': 'cltbld', 11:17:05 INFO - 'MAIL': '/var/mail/cltbld', 11:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:05 INFO - 'MOZ_NO_REMOTE': '1', 11:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:05 INFO - 'NO_EM_RESTART': '1', 11:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:05 INFO - 'PWD': '/builds/slave/test', 11:17:05 INFO - 'SHELL': '/bin/bash', 11:17:05 INFO - 'SHLVL': '1', 11:17:05 INFO - 'TERM': 'linux', 11:17:05 INFO - 'TMOUT': '86400', 11:17:05 INFO - 'USER': 'cltbld', 11:17:05 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:05 INFO - '_': '/tools/buildbot/bin/python'} 11:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:05 INFO - Downloading/unpacking jsonschema==2.5.1 11:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:08 INFO - warning: no files found matching '*.txt' 11:17:08 INFO - no previously-included directories found matching 'build' 11:17:08 INFO - no previously-included directories found matching 'dist' 11:17:08 INFO - no previously-included directories found matching '.git*' 11:17:08 INFO - Installing collected packages: jsonschema, functools32 11:17:08 INFO - Running setup.py install for functools32 11:17:08 INFO - warning: no files found matching '*.txt' 11:17:08 INFO - no previously-included directories found matching 'build' 11:17:08 INFO - no previously-included directories found matching 'dist' 11:17:08 INFO - no previously-included directories found matching '.git*' 11:17:08 INFO - Successfully installed jsonschema functools32 11:17:08 INFO - Cleaning up... 11:17:08 INFO - Return code: 0 11:17:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:08 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')]} 11:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:08 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')]} 11:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:08 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:08 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 11:17:08 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 11:17:08 INFO - Using env: {'DISPLAY': ':0', 11:17:08 INFO - 'HOME': '/home/cltbld', 11:17:08 INFO - 'LANG': 'en_US.UTF-8', 11:17:08 INFO - 'LANGUAGE': 'en_US:en', 11:17:08 INFO - 'LOGNAME': 'cltbld', 11:17:08 INFO - 'MAIL': '/var/mail/cltbld', 11:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:08 INFO - 'MOZ_NO_REMOTE': '1', 11:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:08 INFO - 'NO_EM_RESTART': '1', 11:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:08 INFO - 'PWD': '/builds/slave/test', 11:17:08 INFO - 'SHELL': '/bin/bash', 11:17:08 INFO - 'SHLVL': '1', 11:17:08 INFO - 'TERM': 'linux', 11:17:08 INFO - 'TMOUT': '86400', 11:17:08 INFO - 'USER': 'cltbld', 11:17:08 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:08 INFO - '_': '/tools/buildbot/bin/python'} 11:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:08 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 11:17:08 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 11:17:08 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 11:17:08 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 11:17:08 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 11:17:08 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 11:17:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:11 INFO - Downloading docopt-0.6.1.tar.gz 11:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:11 INFO - Running setup.py install for blobuploader 11:17:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:11 INFO - Running setup.py install for requests 11:17:11 INFO - Running setup.py install for docopt 11:17:11 INFO - Successfully installed blobuploader requests docopt 11:17:11 INFO - Cleaning up... 11:17:11 INFO - Return code: 0 11:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:11 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')]} 11:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:11 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')]} 11:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:11 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:11 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 11:17:11 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 11:17:11 INFO - Using env: {'DISPLAY': ':0', 11:17:11 INFO - 'HOME': '/home/cltbld', 11:17:11 INFO - 'LANG': 'en_US.UTF-8', 11:17:11 INFO - 'LANGUAGE': 'en_US:en', 11:17:11 INFO - 'LOGNAME': 'cltbld', 11:17:11 INFO - 'MAIL': '/var/mail/cltbld', 11:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:11 INFO - 'MOZ_NO_REMOTE': '1', 11:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:11 INFO - 'NO_EM_RESTART': '1', 11:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:11 INFO - 'PWD': '/builds/slave/test', 11:17:11 INFO - 'SHELL': '/bin/bash', 11:17:11 INFO - 'SHLVL': '1', 11:17:11 INFO - 'TERM': 'linux', 11:17:11 INFO - 'TMOUT': '86400', 11:17:11 INFO - 'USER': 'cltbld', 11:17:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:11 INFO - '_': '/tools/buildbot/bin/python'} 11:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:11 INFO - Running setup.py (path:/tmp/pip-r2wQtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:11 INFO - Running setup.py (path:/tmp/pip-BTkwAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:12 INFO - Running setup.py (path:/tmp/pip-MEwLjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:12 INFO - Running setup.py (path:/tmp/pip-APOAJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:12 INFO - Running setup.py (path:/tmp/pip-FFqnmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:12 INFO - Running setup.py (path:/tmp/pip-SI5fz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:12 INFO - Running setup.py (path:/tmp/pip-0c0sVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:12 INFO - Running setup.py (path:/tmp/pip-3V6E64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:12 INFO - Running setup.py (path:/tmp/pip-tzNUOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:12 INFO - Running setup.py (path:/tmp/pip-b7j_l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:12 INFO - Running setup.py (path:/tmp/pip-9BUEfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:12 INFO - Running setup.py (path:/tmp/pip-TEGHx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:12 INFO - Running setup.py (path:/tmp/pip-UKL8oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:12 INFO - Running setup.py (path:/tmp/pip-mibMmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:12 INFO - Running setup.py (path:/tmp/pip-jEeB7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:12 INFO - Running setup.py (path:/tmp/pip-_XrsWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:13 INFO - Running setup.py (path:/tmp/pip-WPNP9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:13 INFO - Running setup.py install for manifestparser 11:17:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Running setup.py install for mozcrash 11:17:13 INFO - Running setup.py install for mozdebug 11:17:13 INFO - Running setup.py install for mozdevice 11:17:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Running setup.py install for mozfile 11:17:13 INFO - Running setup.py install for mozhttpd 11:17:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Running setup.py install for mozinfo 11:17:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Running setup.py install for mozInstall 11:17:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:13 INFO - Running setup.py install for mozleak 11:17:14 INFO - Running setup.py install for mozlog 11:17:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:14 INFO - Running setup.py install for moznetwork 11:17:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:14 INFO - Running setup.py install for mozprocess 11:17:14 INFO - Running setup.py install for mozprofile 11:17:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:14 INFO - Running setup.py install for mozrunner 11:17:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:14 INFO - Running setup.py install for mozscreenshot 11:17:14 INFO - Running setup.py install for moztest 11:17:14 INFO - Running setup.py install for mozversion 11:17:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:14 INFO - Cleaning up... 11:17:14 INFO - Return code: 0 11:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:14 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')]} 11:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:14 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')]} 11:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:14 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:14 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 11:17:14 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 11:17:14 INFO - Using env: {'DISPLAY': ':0', 11:17:14 INFO - 'HOME': '/home/cltbld', 11:17:14 INFO - 'LANG': 'en_US.UTF-8', 11:17:14 INFO - 'LANGUAGE': 'en_US:en', 11:17:14 INFO - 'LOGNAME': 'cltbld', 11:17:14 INFO - 'MAIL': '/var/mail/cltbld', 11:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:14 INFO - 'MOZ_NO_REMOTE': '1', 11:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:14 INFO - 'NO_EM_RESTART': '1', 11:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:14 INFO - 'PWD': '/builds/slave/test', 11:17:14 INFO - 'SHELL': '/bin/bash', 11:17:14 INFO - 'SHLVL': '1', 11:17:14 INFO - 'TERM': 'linux', 11:17:14 INFO - 'TMOUT': '86400', 11:17:14 INFO - 'USER': 'cltbld', 11:17:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:14 INFO - '_': '/tools/buildbot/bin/python'} 11:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:15 INFO - Running setup.py (path:/tmp/pip-sJsKsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:15 INFO - Running setup.py (path:/tmp/pip-cIteWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:15 INFO - Running setup.py (path:/tmp/pip-R4D2mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:15 INFO - Running setup.py (path:/tmp/pip-E7K0OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:15 INFO - Running setup.py (path:/tmp/pip-L1Gk2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:15 INFO - Running setup.py (path:/tmp/pip-gXTGS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:15 INFO - Running setup.py (path:/tmp/pip-R4EVkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:15 INFO - Running setup.py (path:/tmp/pip-soDGZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:15 INFO - Running setup.py (path:/tmp/pip-_r8en5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:15 INFO - Running setup.py (path:/tmp/pip-TrR8Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:15 INFO - Running setup.py (path:/tmp/pip-VA3rQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:15 INFO - Running setup.py (path:/tmp/pip-fu49D9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:15 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)) 11:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:15 INFO - Running setup.py (path:/tmp/pip-Pi_T8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:16 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)) 11:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:16 INFO - Running setup.py (path:/tmp/pip-4yiVvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:16 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)) 11:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:16 INFO - Running setup.py (path:/tmp/pip-Mb47h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:16 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)) 11:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:16 INFO - Running setup.py (path:/tmp/pip-Kkshio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:16 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)) 11:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:16 INFO - Running setup.py (path:/tmp/pip-L5IW5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 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)) 11:17:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:16 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 11:17:16 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 11:17:16 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 11:17:16 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 11:17:16 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 11:17:16 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 11:17:18 INFO - Downloading blessings-1.6.tar.gz 11:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:18 INFO - Installing collected packages: blessings 11:17:18 INFO - Running setup.py install for blessings 11:17:18 INFO - Successfully installed blessings 11:17:18 INFO - Cleaning up... 11:17:18 INFO - Return code: 0 11:17:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:18 INFO - Reading from file tmpfile_stdout 11:17:18 INFO - Current package versions: 11:17:18 INFO - argparse == 1.2.1 11:17:18 INFO - blessings == 1.6 11:17:18 INFO - blobuploader == 1.2.4 11:17:18 INFO - docopt == 0.6.1 11:17:18 INFO - functools32 == 3.2.3-2 11:17:18 INFO - jsonschema == 2.5.1 11:17:18 INFO - manifestparser == 1.1 11:17:18 INFO - mozInstall == 1.12 11:17:18 INFO - mozcrash == 0.17 11:17:18 INFO - mozdebug == 0.1 11:17:18 INFO - mozdevice == 0.48 11:17:18 INFO - mozfile == 1.2 11:17:18 INFO - mozhttpd == 0.7 11:17:18 INFO - mozinfo == 0.9 11:17:18 INFO - mozleak == 0.1 11:17:18 INFO - mozlog == 3.2 11:17:18 INFO - moznetwork == 0.27 11:17:18 INFO - mozprocess == 0.22 11:17:18 INFO - mozprofile == 0.28 11:17:18 INFO - mozrunner == 6.11 11:17:18 INFO - mozscreenshot == 0.1 11:17:18 INFO - mozsystemmonitor == 0.3 11:17:18 INFO - moztest == 0.7 11:17:18 INFO - mozversion == 1.4 11:17:18 INFO - psutil == 3.1.1 11:17:18 INFO - requests == 1.2.3 11:17:18 INFO - wsgiref == 0.1.2 11:17:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:18 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')]} 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:18 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')]} 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:18 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:18 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 11:17:18 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 11:17:18 INFO - Using env: {'DISPLAY': ':0', 11:17:18 INFO - 'HOME': '/home/cltbld', 11:17:18 INFO - 'LANG': 'en_US.UTF-8', 11:17:18 INFO - 'LANGUAGE': 'en_US:en', 11:17:18 INFO - 'LOGNAME': 'cltbld', 11:17:18 INFO - 'MAIL': '/var/mail/cltbld', 11:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:18 INFO - 'MOZ_NO_REMOTE': '1', 11:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:18 INFO - 'NO_EM_RESTART': '1', 11:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:18 INFO - 'PWD': '/builds/slave/test', 11:17:18 INFO - 'SHELL': '/bin/bash', 11:17:18 INFO - 'SHLVL': '1', 11:17:18 INFO - 'TERM': 'linux', 11:17:18 INFO - 'TMOUT': '86400', 11:17:18 INFO - 'USER': 'cltbld', 11:17:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:18 INFO - '_': '/tools/buildbot/bin/python'} 11:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 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)) 11:17:18 INFO - Cleaning up... 11:17:18 INFO - Return code: 0 11:17:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:18 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')]} 11:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:18 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')]} 11:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:18 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:18 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 11:17:18 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 11:17:18 INFO - Using env: {'DISPLAY': ':0', 11:17:18 INFO - 'HOME': '/home/cltbld', 11:17:18 INFO - 'LANG': 'en_US.UTF-8', 11:17:18 INFO - 'LANGUAGE': 'en_US:en', 11:17:18 INFO - 'LOGNAME': 'cltbld', 11:17:18 INFO - 'MAIL': '/var/mail/cltbld', 11:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:18 INFO - 'MOZ_NO_REMOTE': '1', 11:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:18 INFO - 'NO_EM_RESTART': '1', 11:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:18 INFO - 'PWD': '/builds/slave/test', 11:17:18 INFO - 'SHELL': '/bin/bash', 11:17:18 INFO - 'SHLVL': '1', 11:17:18 INFO - 'TERM': 'linux', 11:17:18 INFO - 'TMOUT': '86400', 11:17:18 INFO - 'USER': 'cltbld', 11:17:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:18 INFO - '_': '/tools/buildbot/bin/python'} 11:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:19 INFO - Cleaning up... 11:17:19 INFO - Return code: 0 11:17:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:19 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 0x7f4d1fbc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1144590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, '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': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', '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 11:17:19 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 11:17:19 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 11:17:19 INFO - Using env: {'DISPLAY': ':0', 11:17:19 INFO - 'HOME': '/home/cltbld', 11:17:19 INFO - 'LANG': 'en_US.UTF-8', 11:17:19 INFO - 'LANGUAGE': 'en_US:en', 11:17:19 INFO - 'LOGNAME': 'cltbld', 11:17:19 INFO - 'MAIL': '/var/mail/cltbld', 11:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:19 INFO - 'MOZ_NO_REMOTE': '1', 11:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:19 INFO - 'NO_EM_RESTART': '1', 11:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:19 INFO - 'PWD': '/builds/slave/test', 11:17:19 INFO - 'SHELL': '/bin/bash', 11:17:19 INFO - 'SHLVL': '1', 11:17:19 INFO - 'TERM': 'linux', 11:17:19 INFO - 'TMOUT': '86400', 11:17:19 INFO - 'USER': 'cltbld', 11:17:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:19 INFO - '_': '/tools/buildbot/bin/python'} 11:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:19 INFO - Downloading/unpacking flake8 11:17:19 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 11:17:19 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 11:17:19 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 11:17:19 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 11:17:19 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 11:17:19 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 11:17:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:17:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:17:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 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 11:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:21 INFO - no previously-included directories found matching 'docs/_build' 11:17:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:17:22 INFO - Running setup.py install for pep8 11:17:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:22 INFO - no previously-included directories found matching 'docs/_build' 11:17:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:17:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:17:22 INFO - Cleaning up... 11:17:22 INFO - Return code: 0 11:17:22 INFO - Running post-action listener: _resource_record_post_action 11:17:22 INFO - Running post-action listener: _start_resource_monitoring 11:17:22 INFO - Starting resource monitoring. 11:17:22 INFO - ##### 11:17:22 INFO - ##### Finished create-virtualenv step (success) 11:17:22 INFO - ##### 11:17:22 INFO - ##### 11:17:22 INFO - ##### Running install step. 11:17:22 INFO - ##### 11:17:22 INFO - Running pre-action listener: _resource_record_pre_action 11:17:22 INFO - Running main action method: install 11:17:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:22 INFO - Reading from file tmpfile_stdout 11:17:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:22 INFO - Reading from file tmpfile_stdout 11:17:22 INFO - Output received: 11:17:22 INFO - Usage: mozinstall [options] installer 11:17:22 INFO - Options: 11:17:22 INFO - -h, --help show this help message and exit 11:17:22 INFO - -d DEST, --destination=DEST 11:17:22 INFO - Directory to install application into. [default: 11:17:22 INFO - "/builds/slave/test"] 11:17:22 INFO - --app=APP Application being installed. [default: firefox] 11:17:22 INFO - mkdir: /builds/slave/test/build/application 11:17:22 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'] 11:17:22 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 11:17:39 INFO - Reading from file tmpfile_stdout 11:17:39 INFO - Output received: 11:17:39 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:39 INFO - Running post-action listener: _resource_record_post_action 11:17:39 INFO - ##### 11:17:39 INFO - ##### Finished install step (success) 11:17:39 INFO - ##### 11:17:39 INFO - ##### 11:17:39 INFO - ##### Running run-tests step. 11:17:39 INFO - ##### 11:17:39 INFO - Running pre-action listener: _resource_record_pre_action 11:17:39 INFO - Running main action method: run_tests 11:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:39 INFO - Python 2.7.3 11:17:39 INFO - Return code: 0 11:17:39 INFO - grabbing minidump binary from tooltool 11:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:39 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 0x11d3570>, '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 0x11d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d4920>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:39 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 11:17:39 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 11:17:39 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 11:17:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:39 INFO - Return code: 0 11:17:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:17:40 INFO - Return code: 0 11:17:40 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/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 11:17:40 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/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 11:17:40 INFO - Using env: {'DISPLAY': ':0', 11:17:40 INFO - 'HOME': '/home/cltbld', 11:17:40 INFO - 'LANG': 'en_US.UTF-8', 11:17:40 INFO - 'LANGUAGE': 'en_US:en', 11:17:40 INFO - 'LOGNAME': 'cltbld', 11:17:40 INFO - 'MAIL': '/var/mail/cltbld', 11:17:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:40 INFO - 'MOZ_NO_REMOTE': '1', 11:17:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:40 INFO - 'NO_EM_RESTART': '1', 11:17:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:40 INFO - 'PWD': '/builds/slave/test', 11:17:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:40 INFO - 'SHELL': '/bin/bash', 11:17:40 INFO - 'SHLVL': '1', 11:17:40 INFO - 'TERM': 'linux', 11:17:40 INFO - 'TMOUT': '86400', 11:17:40 INFO - 'USER': 'cltbld', 11:17:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792', 11:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:40 INFO - '_': '/tools/buildbot/bin/python'} 11:17:40 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/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 11:17:40 INFO - mozversion application_buildid: 20160627083118 11:17:40 INFO - mozversion application_changeset: 3c55e34b5259d9e656f93b18f2aebe46af09a732 11:17:40 INFO - mozversion application_display_name: Nightly 11:17:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:40 INFO - mozversion application_name: Firefox 11:17:40 INFO - mozversion application_remotingname: firefox 11:17:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:17:40 INFO - mozversion application_vendor: Mozilla 11:17:40 INFO - mozversion application_version: 50.0a1 11:17:40 INFO - mozversion platform_buildid: 20160627083118 11:17:40 INFO - mozversion platform_changeset: 3c55e34b5259d9e656f93b18f2aebe46af09a732 11:17:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:40 INFO - mozversion platform_version: 50.0a1 11:17:40 INFO - using testdate: 1467051460 11:17:40 INFO - actual date: 1467051460 11:17:40 INFO - starting webserver on 'localhost:59319' 11:17:40 INFO - SUITE-START | Running 2 tests 11:17:40 INFO - TEST-START | dromaeo_css 11:17:40 INFO - operating with platform_type : linux_ 11:17:40 INFO - Initialising browser for dromaeo_css test... 11:17:40 INFO - TEST-INFO | started process 20474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTixadV/profile http://localhost:59319/getInfo.html) 11:17:45 INFO - PROCESS | 20474 | __metrics Screen width/height:1600/1200 11:17:45 INFO - PROCESS | 20474 | colorDepth:24 11:17:45 INFO - PROCESS | 20474 | Browser inner width/height: 1024/697 11:17:45 INFO - PROCESS | 20474 | __metrics 11:17:46 ERROR - PROCESS | 20474 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:17:47 INFO - TEST-INFO | 20474: exit 0 11:17:47 INFO - Browser initialized. 11:17:47 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:47 INFO - TEST-INFO | started process 20592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTixadV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:59 INFO - PROCESS | 20592 | RSS: Main: 184455168 11:17:59 INFO - PROCESS | 20592 | 11:18:48 INFO - PROCESS | 20592 | 1467051528623 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] 11:20:57 INFO - PROCESS | 20592 | Cycle 1(1): loaded http://localhost:59319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59319/tests/dromaeo/cssquery-ext.html) 11:20:58 INFO - PROCESS | 20592 | RSS: Main: 188387328 11:20:58 INFO - PROCESS | 20592 | 11:24:00 INFO - PROCESS | 20592 | Cycle 1(1): loaded http://localhost:59319/tests/dromaeo/cssquery-ext.html (next: http://localhost:59319/tests/dromaeo/cssquery-jquery.html) 11:24:00 INFO - PROCESS | 20592 | RSS: Main: 187723776 11:24:00 INFO - PROCESS | 20592 | 11:27:02 INFO - PROCESS | 20592 | Cycle 1(1): loaded http://localhost:59319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59319/tests/dromaeo/cssquery-mootools.html) 11:27:03 INFO - PROCESS | 20592 | RSS: Main: 188940288 11:27:03 INFO - PROCESS | 20592 | 11:30:05 INFO - PROCESS | 20592 | Cycle 1(1): loaded http://localhost:59319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59319/tests/dromaeo/cssquery-prototype.html) 11:30:05 INFO - PROCESS | 20592 | RSS: Main: 185970688 11:30:05 INFO - PROCESS | 20592 | 11:33:08 INFO - PROCESS | 20592 | Cycle 1(1): loaded http://localhost:59319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59319/tests/dromaeo/cssquery-yui.html) 11:33:08 INFO - PROCESS | 20592 | RSS: Main: 188203008 11:33:08 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | Cycle 1(1): loaded http://localhost:59319/tests/dromaeo/cssquery-yui.html (next: http://localhost:59319/tests/dromaeo/cssquery-dojo.html) 11:36:11 INFO - PROCESS | 20592 | RSS: Main: 188952576 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | __start_tp_report 11:36:11 INFO - PROCESS | 20592 | _x_x_mozilla_page_load 11:36:11 INFO - PROCESS | 20592 | _x_x_mozilla_page_load_details 11:36:11 INFO - PROCESS | 20592 | |i|pagename|runs| 11:36:11 INFO - PROCESS | 20592 | |0;dojo.html;3113.206132436229;3167.8732850685974;3176.428242916274;3180.4911214205717;3182.7931184473;5469.07025805613;5525.861853453661;5532.419095994923;5559.638623489481;5583.35791383991;5386.569074474042;5477.726113694319;5555.444455554442;5577.888442231163;5585;4980.779708971298;4998.425181104165;5105.387353517564;5148.073346797575;5156.96860627876;5034.697918124906;5157;5183.377994640629;5186.118359878811;5186.7147306898105;4876.609871210312;4983.700977941335;5022.723750193738;5033.572146367563;5051.494850514938;5035.647504674675;5036.722980236085;5043.646944713872;5052.797888084472;5100.821471248526;5012.72430016349;5016.247562865563;5019.397672279313;5036.622253330978;5038.269450929632;5428.104362780136;5479.205515200313;5504.862378440531;5558.194061861048;5562.86092847678;5823.505002074829;5845.327787304472;5845.620034697774;5860.970695146497;5862.677552734598;5783.929972955017;5803.767849286066;5910.556708246856;5911.054231322968;5911.586188966774;5426.9185962210595;5457.045017122027;5474.698891561003;5480.616356855022;5516.696581688006;5932.762689492372;5941.316748573883;5942.970285148546;5948.613340132878;5959.880802383928;5655.293088363955;5721.942780572224;5728.513076388554;5736.397678243808;5764.913526297109;5891.941080589225;5893.086571581412;5895.941040589625;5896.1450589664255;5950.2264705587995;5645.95549823284;5838.153467747153;5844.736986835517;5863.70681465925;5880.2943646761805;5811.302643682785;5880.353161152269;5881.735321910439;5934.347221805598;5973.074173503114;4458.8439404620685;4472.619827314715;4502.842400515966;4507.774611269423;4518.9832287735;3967.563568007517;3977.622125898035;3997.480327557399;4021.658159056513;4037.232925744158;5541.501264886179;5596.832095037155;5604.411536788579;5617.438256174431;5638;5908.527317814564;5917.408259174048;5918.704064796743;5924.407559244041;5941.940580594225;5433.83698489038;5563.749631266603;5574.526165275997;5602.075657516546;5624.55003599711;5083.313752643346;5108.335916330928;5108.897822043538;5119;5176.19768935808;5892.086726557391;6094.0372997110835;6154.1999540059505;6157.96921015392;6162.876742465126;5863.472287494146;5880.470757631833;5942.732577033958;5977.193078934288;5980.641161530322;6116.785912493041;6157.199564056644;6164.599301045418;6166.075088736726;6169.383061693795;5577.6653400796085;5718.456746609066;5762.740676669644;5851.64890106595;5879.441453062123;5847.502962248086;5913.586048976703;5936.406359364029;5946.970265148647;5965.343812180743;5709.172170035405;5758.798442054675;5759.8560035999435;5774.855628609318;5787.710614469175;5591.21722958778;5652.095664693629;5664.235328230801;5742.626729262584;5783.624064435799;5513.338399392099;5517.117261238343;5569.888602227852;5590.217369568345;5687.687177205294;5747.942520574741;5765;5767;5782.45066718661;5802.274715660543;5486.91769623448;5577.581681373995;5648.745806438638;5661.66030038199;5666.943330566642 11:36:11 INFO - PROCESS | 20592 | |1;ext.html;586.2378907420352;619.4146531527707;641.3682522715122;641.5220660607846;652.0805664013742;40410;41675.16649667005;41815;41961.79019104904;45533.544664553425;43691.56308436923;43946.560534394644;44111;44114.779426102825;44164.11671766563;8785.077566855483;8987.37088403812;9064.637414503444;9064.77338066547;9069;8802.73591792244;8903.643854245822;8910.777230569223;8985.23625491834;8986.68546600869;8875.68935087272;8919.375643704943;8955.2835773138;8956.8656470153;9003.639854405816;8868.113188681113;8978.820423591524;8998.820023599525;9003.909960900373;9037;8919.42023768453;8923.553822308859;8962.327825413055;8976.41653292534;9000.099990000948;42660.3600945986;42704;42715.57284427147;42728.35907461391;42905.57094429078;3574.8391322390553;3640.8361623726732;4255.489341279066;4334.306510958231;4376.518582955872;32010.839945800122;32485.350292994244;32819;32889.83555082233;32936.505952410735;4262.126264115849;4272.145570885836;4380.78096095194;4459.531749166324;4488.371627972087;235618;235843;235961.3817378222;236014;236854.99999999828;48582.51417485851;48604;49206;56389.436105638415;58220.708896455246;62734;62845.37154628486;62894.37105628885;62904.685476572326;63051;17089.91455042717;17224.827751722572;17464.388746393815;17465;17484.912575437294;13370;13555.051146419655;13646.931765341109;13684.589462316146;13795.379207935666;17650.293988240326;17828.197731102133;17915.73126403105;17952.640947180982;18026.729599056023;6498.830210562144;6726.125603671491;6748.426383757337;6788.830279243059;6977.232504424509;1024.4979959819634;1049.4333060147587;1059.4755595979884;1103.707517507861;1125.5385292030392;31851.52222716661;32743.836280818443;32824.67175328264;32902.683892644025;33060.834695826365;1137.0960086731068;1144.4220668562323;1157.9942100289613;1179.6107284596062;1221.4747658506749;17257.56856078583;17302;17353.479395618153;17370.91314543419;17375.87056841301;521459;522320;525813;530018;531595;57637.71181144151;57755.42244577585;57761.42238577561;57845;57940.42059579435;1352.8579499152645;1355.7017456159629;1395.0931894268806;1399.8530154333853;1409.4010045730524;29706.257343566584;31917.36165276728;31973.520397193595;32042.51936220912;32830.17924551905;50919.490805091475;51237.48762512327;51270.74364628153;51364.22953655773;51466.74266628643;334492;337894;338557;338743;339470;42161.789191053846;42493.15013699647;42520.57479425166;42582.787086064374;43667.78166109149;47687;48680.756596216794;49456.25815612841;49782.50217497779;49972;39445.80277098596;41407.792961035004;41537.58462415458;42257;42770.144597108505;40807.59192408038;41122.1775564493;41169.38245926254;41577.37633935433;42223.366649500895;40728.185436290514;40814;41436.685065194106;41773.791131045364;43973;34428.82785586056;37206;37645;37745.62254377421;38136.80931595435;28364.43271134607;28521.28696782597;28545.857270714343;28755;28790.856045719636 11:36:11 INFO - PROCESS | 20592 | |2;jquery.html;394.97827619480955;396.3242671245526;396.8253968253968;398.5994075953667;419.4861294913731;13847.792283115761;18231.179596918137;18985.62028759424;19917.302894398697;20063.59872802545;18595.721064184047;18666.533336666555;18788.812111878877;19636.80363196371;19764.90117549414;5565.805196818102;5707.3721890592005;5767.653940763567;5899.174115623816;5924.052151655715;5758.280214973129;5824.068149096145;5857.209276747627;5891.381404952483;5902.173695682608;5662.348829884575;5759.856003599923;5841.503472204868;5845.5908086433965;5854.619449735775;5793.855153621151;5795.623284486516;5806.970965145189;5849.473547380713;5851.707414629252;4959.280904268897;5233.921491177635;5261.237120617528;5298.894022119574;5328.866778330573;13617.795733064011;13874.583762487142;14216.36026378805;14221.644458888508;14267.143971361751;2229.8662080275235;2295.9426014349606;2391.3782416571817;2462.258980618814;2474.616434452663;10169.135623472013;10174.898251017543;10229.386236825814;10298.639547615798;10371.585136594527;1801.5316017835326;1880.7837098733685;1909.8567607429359;1940.427573865713;2006.4081096076548;76860.23139768587;82060.58969705114;82645;83290.58354708248;85784;10633.308834925705;10875.401852898167;11113.777724445628;11635.88364116365;11801.29192248468;15607.297671604805;15673.84326156724;15693.293801778947;15750.68498630021;15784.605384865241;7907.051153861574;7940.325072368798;7967.482113662593;8100.270975612106;8140.674373025131;7768.8057798554355;7821.256980586835;7903.328217101496;7916.445848790529;8234.258916697527;4697.624190064855;4726.858194254178;4788.839366018481;4903.166461701519;4935.383077115361;1995.7747111970339;2004.3285499357878;2020.40398082566;2036.918523259053;2051.3333166720877;970.9514524273899;977.1791694976112;1012.7063151685928;1015.761296095417;1023.1712313026472;17024.489265321812;19287.903560482388;19733.210671573263;20062.598748024957;20112.79887201109;987.9703608891745;1008.2589296866797;1044.9831824578484;1049.3913530152493;1050.191352658464;10706.678799636024;11136.610218642309;11201.887981120084;11216.887831121747;11237.775244495064;462004;469148;491254;492296;494199;54679.453205468235;72802;93029.5348523253;96692.51653741686;98407;952.7141857442739;955.1833182628752;981.2444417798256;981.6809536900536;998.7652901568271;16033.438829640907;17942.480616314395;18154.90922545379;18169;18381.356652517097;32766;40695;43148.78425607852;44051.77974110237;44896;60091.69954150376;61082;62128.06807897795;62429.687851560455;62542.37457625366;8798.824023519366;8828.514431706319;8840.513771742615;8899.555022248991;9049.366544341832;9809.558569864515;13764.587062388144;13793.10344827583;13839.584812455643;14075.788863167265;12203.267803931793;12204.328761917825;12294.569690060805;12348.197367171106;12417.19288246261;12042;12108.334041627442;12189.75620487603;12319.199252048587;12815.16701414405;12218.144729868824;12353.876461235273;12430.627081187578;12449;12547.24716517012;8562.229399354088;8577.785555361166;8741.781455463664;8766.824663506823;9180.311476639412;9086.591103400231;11559.479823408135;12189.69525761863;12305.56930507428;12342.382880855741 11:36:11 INFO - PROCESS | 20592 | |3;mootools.html;1454.1638557829247;1464.8974571779977;1544.443945270577;1699.736540836171;1706.795184577851;7762.4178186635945;7770.494917830337;8382.329413646894;8426.241638252555;8464.746057618273;8442.366822488308;8646.870296945552;8797.428167169146;8798.120187981198;8798.912010879889;2212.7344718633744;2235.932922012334;2241.0587553227683;2253.4141123307977;2257.9887100564556;2240.4958884250996;2245.1692873636775;2273.2498275569023;2275.3628983884537;2302.827287953402;2269.706879302364;2273.2611901132113;2283.212291759349;2300.8389412741117;2304.3662992677064;2201.6587428948537;2206.6359050756605;2214.1918199857096;2218.4675677837286;2241.2491815241915;2159.719236499245;2187.114218741412;2191.495955930129;2191.616467118248;2199.274239500961;8690.522021288827;8735.462137834123;8790.604422800989;8830.735077947671;8886.155815197546;4915.9754201229125;4990.5508504234795;4994.450610432849;4997.575206107485;4999.42506611737;3080.845957702106;3227.80633162011;3322.1694576355912;3360.3615313090436;3449.4308439107517;1094.529352378477;1100.2463312630873;1109.5561775289868;1158.5887010111373;1166.749148932975;11697.12271579635;11742.941285293604;11759.58841440554;11805;11812.940935295355;4429.335599660077;4484.1255955088445;4517.887052823706;4577.267637178035;4577.679562430664;10000.449975251286;10076.69769906904;10085.092341689284;10090.596376145018;10130.544125514221;5163.586913046947;5174.24973378858;5179.249008893689;5186.273921650972;5193.636445448858;4147.460830092129;4614.838480653161;4752.596029337476;4777.522247775195;4840.00779840132;3796.8671096512044;3873.4189871519498;3928.5678575356687;3930.9213815723524;3950.4271880577157;1197.7125489882364;1208.655533173059;1217.1236709569096;1227.7360367521026;1228.2937311046005;848.4103548034057;998.201438848918;1014.1987829614669;1015.8120747661707;1020.1838529176629;5741;5780.797672081541;5837.474627283565;5837.88324233513;5904.143899134601;443.39698010705416;449.4763600405491;458.7820785127038;459.648368997717;460.6015796336212;4218.514870789899;4291.077418355007;4320.049589090458;4339.284018136972;4390.53899340571;10104.141148002354;10474.738131546772;10508.894911050791;10513.264071515074;10617.097546708463;9911.801763964824;10395.740106497398;10397;10481.266311358284;10521.3687178768;8194.795130121795;8226.341892648574;8375.664973401117;8427.536485493356;8442.240198382053;6021.458068773832;6291.8989176894775;6300.873982520232;6412.070249813844;6439.259485159079;10023.047810457994;10102.69691909244;10107.090361867467;10189.286749927434;10201.74495637615;9857.35927164732;10068.748281293027;10173.338732982333;10206.13247873939;10266;7011.404030657452;7620.3522700571075;7635.121960974559;7679;7887.921120788718;8637.395382323428;8651.610677519653;8691.739247822576;8731.69439069655;8752.956235218782;7376.225496323023;7600.771976840703;7718.614069296625;7772.650230739743;7797.142314345531;7500.399968002437;7532.246775322424;7630.961845190738;7634.389248859967;7838.843223135619;7145.1425828900865;7263.636818158965;7281.453890958093;7295;7313.049303590499;5111.5910727141;5215.843524694265;5289.894202116013;5355.946440535545;5392.5416339611575;5018.799248030038;5161.716105614228;5209.453007434165;5334.279872217201;5344.812931547377 11:36:11 INFO - PROCESS | 20592 | |4;prototype.html;335.3193018173109;337.05120086955225;337.37417091295646;338.5936875749102;342.8234459253485;5638.323401191858;5738.7417566209515;5740.8277751667465;5759.222504961834;5761.30864296284;5629.60592758507;5655.462731040545;5657.179708942201;5687.402822703619;5696.145578163278;4187.225363307783;4305.935410968838;4405.515393306734;4433.467983841943;4445.8221671133115;4352.825886964518;4387.539308372623;4401.845935392262;4416.425864637593;4435.246008178601;4374.934375984363;4407.603315701586;4438.334249862514;4442.511323754401;4452.220861349267;4285.243050349357;4311.33174357975;4323.956760432387;4324.783760811978;4371.256886329332;3769.5476542815036;3773.584905660375;3797;3797.6202379761803;3823.866164684223;5503.091989821674;5529.723513824292;5536;5554.555635549146;5562.553736028662;4896.926546101776;5008.7996480140755;5075.467075957045;5095.464976177485;5110;5957.970210148921;5976;6002.939970600281;6004.4595986361;6072.878542429171;4242.830286788556;4290.721103128287;4292.849750258726;4333.783310834446;4381.452318460192;5972.820815375546;6165.475934545569;6184.783532576338;6217.906731399033;6254.280757712831;4407.471103467605;4412.492563355255;4420.717991782411;4433.844815431445;4445.1998640245065;4445.688801783844;4480.820767169342;4481.596656300883;4496.460424749051;4497.145542346943;4884.755762211875;4998.600111991032;5036.6726162799305;5048.5203905628905;5078.21287700407;5951.583389162717;5980.43185897339;5983.491403230774;6011;6017.669028203403;1458.795768592398;1476.5496523560203;1502.301429835132;1507.758758598641;1509.8339182689895;972.5623469438781;980.7352014956065;993.4734590666958;1038.5741845843168;1058.4229498047853;5601.215829783833;5639.069553523705;5680.4319568042865;5710.71446427677;5744.368119506851;6053.303870054912;6061.605995610271;6063.393200801791;6087.873743357493;6099.756009759649;5511;5610.597350662334;5635.492805647511;5639.520640745583;5640.746166422521;3219.4365985952363;3228;3245.886393976247;3261.6575259597876;3262.8205448700073;5975.52195824333;6175.660338681416;6197.96901015492;6229.595076320024;6249.000159974473;6199;6202.5658203925295;6206.441420272107;6207.6585787782105;6221.160143380676;5985.730642121028;6230.283517395557;6252.781152659635;6265.592736472115;6268.780592679234;6009.849753756016;6010.188624535632;6028.854517641634;6036.879262414815;6044.455998960115;5930.733117009831;5931.7627294907725;5934.643921364732;5937.643741375531;5944.464998150187;5921.5558833086825;6175.413335733098;6177.722002509808;6183.660823155626;6199.132121503083;4304.956950430455;4306.913861722685;4325.070109926381;4339.284018136972;4370.650347972091;5874.324452687995;5941.9405805943115;5993.760249589967;5999.940000600112;6033.336333003454;5794.594378393641;5839.678817665069;5863.241027691761;5866.67733274674;5871;5764.654120752768;5862.7654893805475;5926.259217597801;5930.644161350333;5934.821955341346;5418.810341638182;5816.854578635568;5820.447057529528;5894.528437725057;5900.940990590039;5917.792877249448;6034.39656034393;6044.607100538451;6048.939510605013;6057.454829065406;5653.208550802973;5922.2597175353085;5937.732802023833;5985.6408615483215;5991.850203744942 11:36:11 INFO - PROCESS | 20592 | |5;yui.html;742.5915746339512;768.0591275687281;798.7044793426433;804.4891493901373;833.3874602167408;14188.290585470724;15185.392584296615;15824.920875395606;15853.365865365371;15911;15059.92470037651;15114.848851511482;15241.542753717406;15273;15282.312295946682;662.8276648071488;764.7361660227226;778.1440415542914;781.6677911887454;785.1128225105623;782.8629989751771;793.2067932067932;798.3254150243035;804.3163311185475;810.3274282345639;842.9620667069966;843.8101427178866;846.4667259626458;846.8856704344896;850.4387104511025;836.619338201117;838.7441830241773;840.2479780596362;841.486693117198;843.0599881132555;605.5579427018301;610.1397030187459;614.7479533391332;614.8247749391402;617.4720613875116;15298.388064477407;15349;15395.769063464057;15419.768703469344;15568.922155389151;15426.768598471032;15564.455244066516;15640.687186256326;15666.451674191349;15789.763153552705;11270.549178032868;11400.942995285053;11484.310941343547;11545.249558778736;12109.93945030278;3207.3745619604188;3235.9676403236135;3236.3203727217315;3300.93398132036;3366.192113892648;76176.61911690462;77125;77373.61313193454;79030.60484697597;79281.60359198166;11098.667039988813;11112.55549778016;11193.888061119447;11294;11413.086953043736;19885.701714474293;19907;19981.800181998286;20044.298449554197;20062.598748025248;8262.876056859152;8365.916340836513;8511.787205319917;8516.233538981398;8688.95655521731;4463.330500424962;4683.812647494062;4707.246840505502;4719.480857105716;4897.069556784271;3297.868085276562;3353.832308384571;3372.0052584487635;3398.6091599465885;3415.197428604276;560.3555910702725;577.9508741756914;588.7203578300273;592.9229200203946;595.2559300873908;741.6662501874071;746.6565379925295;753.4650398217327;769.7806125254276;775.3603277296253;9713.854292185622;9788.363756355815;10040;10054.899451005542;10304.381737095648;657.7073202424875;733.5891900535717;735.2096496266535;738.943311065182;757.526545908807;4907.681000735012;4966.255061740768;4972.378452693413;4992.126377883856;5041;108888;111816.44091779488;116431;117831;121361.39319303524;98750.50624746973;99805.00194998103;100605.49697251614;101732;102614.48692756488;55745.721271393384;56761;57041.42958570444;86492.56753716191;87295;9484.193843523102;9490.572924218288;9588.137067663665;9632.75918102025;9671.854922176033;51835.740821297164;52295.73852130715;52347.21479177739;53127.734361327944;54304.72847635736;71108;75094.62452687701;75264.69387145143;76251;76598.6170069146;12710.36448177606;12858.357082146042;13202;13219.339033048502;13263.867361326264;13908.582742517741;14327.864632323224;14351.425942962582;14367.353469094125;14655.413783448968;12205.328706921204;12328.568500102454;12682.175658582162;13026.804597931228;13040.217586944813;11967.461464233957;11997.40012999364;12554.497820087094;13289;13381.799273010718;11812.538209579556;11830.231034982698;11924.22492538017;12415.676036549432;12693.933713556622;9898.554565044446;10149.64476243328;10483.161347092062;10749.542233898525;11080.667579972614;10348.172146228435;10823.837642435212;10865.565377384815;10959.452027398438;10976.560937562408 11:36:11 INFO - PROCESS | 20592 | __end_tp_report 11:36:11 INFO - PROCESS | 20592 | __start_cc_report 11:36:11 INFO - PROCESS | 20592 | _x_x_mozilla_cycle_collect,365 11:36:11 INFO - PROCESS | 20592 | __end_cc_report 11:36:11 INFO - PROCESS | 20592 | __startTimestamp1467052571668__endTimestamp 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | ------- Summary: start ------- 11:36:11 INFO - PROCESS | 20592 | Number of tests: 6 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | [#0] dojo.html Cycles:165 Average:5467.81 Median:5638.00 stddev:615.35 (10.9%) stddev-sans-first:588.86 11:36:11 INFO - PROCESS | 20592 | Values: 3113.2 3167.9 3176.4 3180.5 3182.8 5469.1 5525.9 5532.4 5559.6 5583.4 5386.6 5477.7 5555.4 5577.9 5585.0 4980.8 4998.4 5105.4 5148.1 5157.0 5034.7 5157.0 5183.4 5186.1 5186.7 4876.6 4983.7 5022.7 5033.6 5051.5 5035.6 5036.7 5043.6 5052.8 5100.8 5012.7 5016.2 5019.4 5036.6 5038.3 5428.1 5479.2 5504.9 5558.2 5562.9 5823.5 5845.3 5845.6 5861.0 5862.7 5783.9 5803.8 5910.6 5911.1 5911.6 5426.9 5457.0 5474.7 5480.6 5516.7 5932.8 5941.3 5943.0 5948.6 5959.9 5655.3 5721.9 5728.5 5736.4 5764.9 5891.9 5893.1 5895.9 5896.1 5950.2 5646.0 5838.2 5844.7 5863.7 5880.3 5811.3 5880.4 5881.7 5934.3 5973.1 4458.8 4472.6 4502.8 4507.8 4519.0 3967.6 3977.6 3997.5 4021.7 4037.2 5541.5 5596.8 5604.4 5617.4 5638.0 5908.5 5917.4 5918.7 5924.4 5941.9 5433.8 5563.7 5574.5 5602.1 5624.6 5083.3 5108.3 5108.9 5119.0 5176.2 5892.1 6094.0 6154.2 6158.0 6162.9 5863.5 5880.5 5942.7 5977.2 5980.6 6116.8 6157.2 6164.6 6166.1 6169.4 5577.7 5718.5 5762.7 5851.6 5879.4 5847.5 5913.6 5936.4 5947.0 5965.3 5709.2 5758.8 5759.9 5774.9 5787.7 5591.2 5652.1 5664.2 5742.6 5783.6 5513.3 5517.1 5569.9 5590.2 5687.7 5747.9 5765.0 5767.0 5782.5 5802.3 5486.9 5577.6 5648.7 5661.7 5666.9 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | [#1] ext.html Cycles:180 Average:54518.88 Median:42506.86 stddev:102258.49 (240.6%) stddev-sans-first:102465.18 11:36:11 INFO - PROCESS | 20592 | Values: 586.2 619.4 641.4 641.5 652.1 40410.0 41675.2 41815.0 41961.8 45533.5 43691.6 43946.6 44111.0 44114.8 44164.1 8785.1 8987.4 9064.6 9064.8 9069.0 8802.7 8903.6 8910.8 8985.2 8986.7 8875.7 8919.4 8955.3 8956.9 9003.6 8868.1 8978.8 8998.8 9003.9 9037.0 8919.4 8923.6 8962.3 8976.4 9000.1 42660.4 42704.0 42715.6 42728.4 42905.6 3574.8 3640.8 4255.5 4334.3 4376.5 32010.8 32485.4 32819.0 32889.8 32936.5 4262.1 4272.1 4380.8 4459.5 4488.4 235618.0 235843.0 235961.4 236014.0 236855.0 48582.5 48604.0 49206.0 56389.4 58220.7 62734.0 62845.4 62894.4 62904.7 63051.0 17089.9 17224.8 17464.4 17465.0 17484.9 13370.0 13555.1 13646.9 13684.6 13795.4 17650.3 17828.2 17915.7 17952.6 18026.7 6498.8 6726.1 6748.4 6788.8 6977.2 1024.5 1049.4 1059.5 1103.7 1125.5 31851.5 32743.8 32824.7 32902.7 33060.8 1137.1 1144.4 1158.0 1179.6 1221.5 17257.6 17302.0 17353.5 17370.9 17375.9 521459.0 522320.0 525813.0 530018.0 531595.0 57637.7 57755.4 57761.4 57845.0 57940.4 1352.9 1355.7 1395.1 1399.9 1409.4 29706.3 31917.4 31973.5 32042.5 32830.2 50919.5 51237.5 51270.7 51364.2 51466.7 334492.0 337894.0 338557.0 338743.0 339470.0 42161.8 42493.2 42520.6 42582.8 43667.8 47687.0 48680.8 49456.3 49782.5 49972.0 39445.8 41407.8 41537.6 42257.0 42770.1 40807.6 41122.2 41169.4 41577.4 42223.4 40728.2 40814.0 41436.7 41773.8 43973.0 34428.8 37206.0 37645.0 37745.6 38136.8 28364.4 28521.3 28545.9 28755.0 28790.9 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | [#2] jquery.html Cycles:180 Average:28457.54 Median:16580.49 stddev:79459.46 (479.2%) stddev-sans-first:79654.42 11:36:11 INFO - PROCESS | 20592 | Values: 395.0 396.3 396.8 398.6 419.5 13847.8 18231.2 18985.6 19917.3 20063.6 18595.7 18666.5 18788.8 19636.8 19764.9 5565.8 5707.4 5767.7 5899.2 5924.1 5758.3 5824.1 5857.2 5891.4 5902.2 5662.3 5759.9 5841.5 5845.6 5854.6 5793.9 5795.6 5807.0 5849.5 5851.7 4959.3 5233.9 5261.2 5298.9 5328.9 13617.8 13874.6 14216.4 14221.6 14267.1 2229.9 2295.9 2391.4 2462.3 2474.6 10169.1 10174.9 10229.4 10298.6 10371.6 1801.5 1880.8 1909.9 1940.4 2006.4 76860.2 82060.6 82645.0 83290.6 85784.0 10633.3 10875.4 11113.8 11635.9 11801.3 15607.3 15673.8 15693.3 15750.7 15784.6 7907.1 7940.3 7967.5 8100.3 8140.7 7768.8 7821.3 7903.3 7916.4 8234.3 4697.6 4726.9 4788.8 4903.2 4935.4 1995.8 2004.3 2020.4 2036.9 2051.3 971.0 977.2 1012.7 1015.8 1023.2 17024.5 19287.9 19733.2 20062.6 20112.8 988.0 1008.3 1045.0 1049.4 1050.2 10706.7 11136.6 11201.9 11216.9 11237.8 462004.0 469148.0 491254.0 492296.0 494199.0 54679.5 72802.0 93029.5 96692.5 98407.0 952.7 955.2 981.2 981.7 998.8 16033.4 17942.5 18154.9 18169.0 18381.4 32766.0 40695.0 43148.8 44051.8 44896.0 60091.7 61082.0 62128.1 62429.7 62542.4 8798.8 8828.5 8840.5 8899.6 9049.4 9809.6 13764.6 13793.1 13839.6 14075.8 12203.3 12204.3 12294.6 12348.2 12417.2 12042.0 12108.3 12189.8 12319.2 12815.2 12218.1 12353.9 12430.6 12449.0 12547.2 8562.2 8577.8 8741.8 8766.8 9180.3 9086.6 11559.5 12189.7 12305.6 12342.4 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | [#3] mootools.html Cycles:180 Average:5710.76 Median:2483.68 stddev:3242.25 (130.5%) stddev-sans-first:3235.57 11:36:11 INFO - PROCESS | 20592 | Values: 1454.2 1464.9 1544.4 1699.7 1706.8 7762.4 7770.5 8382.3 8426.2 8464.7 8442.4 8646.9 8797.4 8798.1 8798.9 2212.7 2235.9 2241.1 2253.4 2258.0 2240.5 2245.2 2273.2 2275.4 2302.8 2269.7 2273.3 2283.2 2300.8 2304.4 2201.7 2206.6 2214.2 2218.5 2241.2 2159.7 2187.1 2191.5 2191.6 2199.3 8690.5 8735.5 8790.6 8830.7 8886.2 4916.0 4990.6 4994.5 4997.6 4999.4 3080.8 3227.8 3322.2 3360.4 3449.4 1094.5 1100.2 1109.6 1158.6 1166.7 11697.1 11742.9 11759.6 11805.0 11812.9 4429.3 4484.1 4517.9 4577.3 4577.7 10000.4 10076.7 10085.1 10090.6 10130.5 5163.6 5174.2 5179.2 5186.3 5193.6 4147.5 4614.8 4752.6 4777.5 4840.0 3796.9 3873.4 3928.6 3930.9 3950.4 1197.7 1208.7 1217.1 1227.7 1228.3 848.4 998.2 1014.2 1015.8 1020.2 5741.0 5780.8 5837.5 5837.9 5904.1 443.4 449.5 458.8 459.6 460.6 4218.5 4291.1 4320.0 4339.3 4390.5 10104.1 10474.7 10508.9 10513.3 10617.1 9911.8 10395.7 10397.0 10481.3 10521.4 8194.8 8226.3 8375.7 8427.5 8442.2 6021.5 6291.9 6300.9 6412.1 6439.3 10023.0 10102.7 10107.1 10189.3 10201.7 9857.4 10068.7 10173.3 10206.1 10266.0 7011.4 7620.4 7635.1 7679.0 7887.9 8637.4 8651.6 8691.7 8731.7 8753.0 7376.2 7600.8 7718.6 7772.7 7797.1 7500.4 7532.2 7631.0 7634.4 7838.8 7145.1 7263.6 7281.5 7295.0 7313.0 5111.6 5215.8 5289.9 5355.9 5392.5 5018.8 5161.7 5209.5 5334.3 5344.8 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | [#4] prototype.html Cycles:180 Average:4984.88 Median:5683.92 stddev:1463.31 (25.7%) stddev-sans-first:1425.20 11:36:11 INFO - PROCESS | 20592 | Values: 335.3 337.1 337.4 338.6 342.8 5638.3 5738.7 5740.8 5759.2 5761.3 5629.6 5655.5 5657.2 5687.4 5696.1 4187.2 4305.9 4405.5 4433.5 4445.8 4352.8 4387.5 4401.8 4416.4 4435.2 4374.9 4407.6 4438.3 4442.5 4452.2 4285.2 4311.3 4324.0 4324.8 4371.3 3769.5 3773.6 3797.0 3797.6 3823.9 5503.1 5529.7 5536.0 5554.6 5562.6 4896.9 5008.8 5075.5 5095.5 5110.0 5958.0 5976.0 6002.9 6004.5 6072.9 4242.8 4290.7 4292.8 4333.8 4381.5 5972.8 6165.5 6184.8 6217.9 6254.3 4407.5 4412.5 4420.7 4433.8 4445.2 4445.7 4480.8 4481.6 4496.5 4497.1 4884.8 4998.6 5036.7 5048.5 5078.2 5951.6 5980.4 5983.5 6011.0 6017.7 1458.8 1476.5 1502.3 1507.8 1509.8 972.6 980.7 993.5 1038.6 1058.4 5601.2 5639.1 5680.4 5710.7 5744.4 6053.3 6061.6 6063.4 6087.9 6099.8 5511.0 5610.6 5635.5 5639.5 5640.7 3219.4 3228.0 3245.9 3261.7 3262.8 5975.5 6175.7 6198.0 6229.6 6249.0 6199.0 6202.6 6206.4 6207.7 6221.2 5985.7 6230.3 6252.8 6265.6 6268.8 6009.8 6010.2 6028.9 6036.9 6044.5 5930.7 5931.8 5934.6 5937.6 5944.5 5921.6 6175.4 6177.7 6183.7 6199.1 4305.0 4306.9 4325.1 4339.3 4370.7 5874.3 5941.9 5993.8 5999.9 6033.3 5794.6 5839.7 5863.2 5866.7 5871.0 5764.7 5862.8 5926.3 5930.6 5934.8 5418.8 5816.9 5820.4 5894.5 5900.9 5917.8 6034.4 6044.6 6048.9 6057.5 5653.2 5922.3 5937.7 5985.6 5991.9 11:36:11 INFO - PROCESS | 20592 | 11:36:11 INFO - PROCESS | 20592 | [#5] yui.html Cycles:180 Average:20320.96 Median:4573.57 stddev:29418.65 (643.2%) stddev-sans-first:29464.44 11:36:11 INFO - PROCESS | 20592 | Values: 742.6 768.1 798.7 804.5 833.4 14188.3 15185.4 15824.9 15853.4 15911.0 15059.9 15114.8 15241.5 15273.0 15282.3 662.8 764.7 778.1 781.7 785.1 782.9 793.2 798.3 804.3 810.3 843.0 843.8 846.5 846.9 850.4 836.6 838.7 840.2 841.5 843.1 605.6 610.1 614.7 614.8 617.5 15298.4 15349.0 15395.8 15419.8 15568.9 15426.8 15564.5 15640.7 15666.5 15789.8 11270.5 11400.9 11484.3 11545.2 12109.9 3207.4 3236.0 3236.3 3300.9 3366.2 76176.6 77125.0 77373.6 79030.6 79281.6 11098.7 11112.6 11193.9 11294.0 11413.1 19885.7 19907.0 19981.8 20044.3 20062.6 8262.9 8365.9 8511.8 8516.2 8689.0 4463.3 4683.8 4707.2 4719.5 4897.1 3297.9 3353.8 3372.0 3398.6 3415.2 560.4 578.0 588.7 592.9 595.3 741.7 746.7 753.5 769.8 775.4 9713.9 9788.4 10040.0 10054.9 10304.4 657.7 733.6 735.2 738.9 757.5 4907.7 4966.3 4972.4 4992.1 5041.0 108888.0 111816.4 116431.0 117831.0 121361.4 98750.5 99805.0 100605.5 101732.0 102614.5 55745.7 56761.0 57041.4 86492.6 87295.0 9484.2 9490.6 9588.1 9632.8 9671.9 51835.7 52295.7 52347.2 53127.7 54304.7 71108.0 75094.6 75264.7 76251.0 76598.6 12710.4 12858.4 13202.0 13219.3 13263.9 13908.6 14327.9 14351.4 14367.4 14655.4 12205.3 12328.6 12682.2 13026.8 13040.2 11967.5 11997.4 12554.5 13289.0 13381.8 11812.5 11830.2 11924.2 12415.7 12693.9 9898.6 10149.6 10483.2 10749.5 11080.7 10348.2 10823.8 10865.6 10959.5 10976.6 11:36:11 INFO - PROCESS | 20592 | -------- Summary: end -------- 11:36:11 INFO - PROCESS | 20592 | 11:36:12 INFO - TEST-INFO | 20592: exit 0 11:36:12 INFO - TEST-OK | dromaeo_css | took 1111578ms 11:36:12 INFO - TEST-START | kraken 11:36:12 INFO - operating with platform_type : linux_ 11:36:12 INFO - Initialising browser for kraken test... 11:36:12 INFO - TEST-INFO | started process 20829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLSO25C/profile http://localhost:59319/getInfo.html) 11:36:17 INFO - PROCESS | 20829 | __metrics Screen width/height:1600/1200 11:36:17 INFO - PROCESS | 20829 | colorDepth:24 11:36:17 INFO - PROCESS | 20829 | Browser inner width/height: 1024/697 11:36:17 INFO - PROCESS | 20829 | __metrics 11:36:17 ERROR - PROCESS | 20829 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:36:18 INFO - TEST-INFO | 20829: exit 0 11:36:18 INFO - Browser initialized. 11:36:18 INFO - Running cycle 1/1 for kraken test... 11:36:18 INFO - TEST-INFO | started process 20949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLSO25C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:30 INFO - PROCESS | 20949 | RSS: Main: 184885248 11:36:30 INFO - PROCESS | 20949 | 11:36:33 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59319/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:34 INFO - PROCESS | 20949 | RSS: Main: 190627840 11:36:34 INFO - PROCESS | 20949 | 11:36:36 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59319/tests/kraken/driver.html?testName=audio-dft) 11:36:37 INFO - PROCESS | 20949 | RSS: Main: 189661184 11:36:37 INFO - PROCESS | 20949 | 11:36:40 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59319/tests/kraken/driver.html?testName=audio-fft) 11:36:40 INFO - PROCESS | 20949 | RSS: Main: 184401920 11:36:40 INFO - PROCESS | 20949 | 11:36:43 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59319/tests/kraken/driver.html?testName=audio-oscillator) 11:36:43 INFO - PROCESS | 20949 | RSS: Main: 185036800 11:36:43 INFO - PROCESS | 20949 | 11:36:45 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:46 INFO - PROCESS | 20949 | RSS: Main: 185393152 11:36:46 INFO - PROCESS | 20949 | 11:36:49 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59319/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:50 INFO - PROCESS | 20949 | RSS: Main: 185331712 11:36:50 INFO - PROCESS | 20949 | 11:36:53 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59319/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:54 INFO - PROCESS | 20949 | RSS: Main: 183271424 11:36:54 INFO - PROCESS | 20949 | 11:36:57 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59319/tests/kraken/driver.html?testName=json-parse-financial) 11:36:57 INFO - PROCESS | 20949 | RSS: Main: 185163776 11:36:57 INFO - PROCESS | 20949 | 11:36:59 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:59 INFO - PROCESS | 20949 | RSS: Main: 185454592 11:36:59 INFO - PROCESS | 20949 | 11:37:01 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:02 INFO - PROCESS | 20949 | RSS: Main: 185720832 11:37:02 INFO - PROCESS | 20949 | 11:37:04 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:05 INFO - PROCESS | 20949 | RSS: Main: 185991168 11:37:05 INFO - PROCESS | 20949 | 11:37:07 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:08 INFO - PROCESS | 20949 | RSS: Main: 186081280 11:37:08 INFO - PROCESS | 20949 | 11:37:11 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:11 INFO - PROCESS | 20949 | RSS: Main: 185692160 11:37:11 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | Cycle 1(1): loaded http://localhost:59319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59319/tests/kraken/driver.html?testName=ai-astar) 11:37:13 INFO - PROCESS | 20949 | RSS: Main: 185921536 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | __start_tp_report 11:37:13 INFO - PROCESS | 20949 | _x_x_mozilla_page_load 11:37:13 INFO - PROCESS | 20949 | _x_x_mozilla_page_load_details 11:37:13 INFO - PROCESS | 20949 | |i|pagename|runs| 11:37:13 INFO - PROCESS | 20949 | |0;ai-astar;102;111;105;111;110;112;112;110;111;112 11:37:13 INFO - PROCESS | 20949 | |1;audio-beat-detection;157;128;157;188;127;166;164;127;175;129 11:37:13 INFO - PROCESS | 20949 | |2;audio-dft;163;162;162;162;164;176;163;163;162;162 11:37:13 INFO - PROCESS | 20949 | |3;audio-fft;75;76;74;175;77;76;74;74;158;78 11:37:13 INFO - PROCESS | 20949 | |4;audio-oscillator;85;84;150;86;85;85;144;86;86;142 11:37:13 INFO - PROCESS | 20949 | |5;imaging-gaussian-blur;117;118;117;120;119;117;118;117;118;118 11:37:13 INFO - PROCESS | 20949 | |6;imaging-darkroom;148;170;147;147;147;147;146;146;147;147 11:37:13 INFO - PROCESS | 20949 | |7;imaging-desaturate;96;101;96;95;95;96;97;96;95;96 11:37:13 INFO - PROCESS | 20949 | |8;json-parse-financial;55;55;58;55;57;60;55;57;53;54 11:37:13 INFO - PROCESS | 20949 | |9;json-stringify-tinderbox;63;60;60;61;62;61;61;62;61;60 11:37:13 INFO - PROCESS | 20949 | |10;stanford-crypto-aes;79;81;79;78;78;81;85;79;95;82 11:37:13 INFO - PROCESS | 20949 | |11;stanford-crypto-ccm;136;123;126;134;130;129;129;126;129;124 11:37:13 INFO - PROCESS | 20949 | |12;stanford-crypto-pbkdf2;162;165;163;170;163;160;160;158;162;162 11:37:13 INFO - PROCESS | 20949 | |13;stanford-crypto-sha256-iterative;68;66;63;64;67;61;67;63;61;63 11:37:13 INFO - PROCESS | 20949 | __end_tp_report 11:37:13 INFO - PROCESS | 20949 | __start_cc_report 11:37:13 INFO - PROCESS | 20949 | _x_x_mozilla_cycle_collect,883 11:37:13 INFO - PROCESS | 20949 | __end_cc_report 11:37:13 INFO - PROCESS | 20949 | __startTimestamp1467052633588__endTimestamp 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | ------- Summary: start ------- 11:37:13 INFO - PROCESS | 20949 | Number of tests: 14 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.37 (3.0%) stddev-sans-first:2.19 11:37:13 INFO - PROCESS | 20949 | Values: 102.0 111.0 105.0 111.0 110.0 112.0 112.0 110.0 111.0 112.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:160.50 stddev:22.53 (14.0%) stddev-sans-first:23.82 11:37:13 INFO - PROCESS | 20949 | Values: 157.0 128.0 157.0 188.0 127.0 166.0 164.0 127.0 175.0 129.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:4.31 (2.6%) stddev-sans-first:4.56 11:37:13 INFO - PROCESS | 20949 | Values: 163.0 162.0 162.0 162.0 164.0 176.0 163.0 163.0 162.0 162.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.50 stddev:38.60 (51.1%) stddev-sans-first:40.34 11:37:13 INFO - PROCESS | 20949 | Values: 75.0 76.0 74.0 175.0 77.0 76.0 74.0 74.0 158.0 78.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:85.00 stddev:29.08 (34.2%) stddev-sans-first:30.08 11:37:13 INFO - PROCESS | 20949 | Values: 85.0 84.0 150.0 86.0 85.0 85.0 144.0 86.0 86.0 142.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 11:37:13 INFO - PROCESS | 20949 | Values: 117.0 118.0 117.0 120.0 119.0 117.0 118.0 117.0 118.0 118.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:147.00 stddev:7.33 (5.0%) stddev-sans-first:7.76 11:37:13 INFO - PROCESS | 20949 | Values: 148.0 170.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.77 (1.8%) stddev-sans-first:1.87 11:37:13 INFO - PROCESS | 20949 | Values: 96.0 101.0 96.0 95.0 95.0 96.0 97.0 96.0 95.0 96.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:2.08 (3.7%) stddev-sans-first:2.18 11:37:13 INFO - PROCESS | 20949 | Values: 55.0 55.0 58.0 55.0 57.0 60.0 55.0 57.0 53.0 54.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:0.78 11:37:13 INFO - PROCESS | 20949 | Values: 63.0 60.0 60.0 61.0 62.0 61.0 61.0 62.0 61.0 60.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:5.14 (6.3%) stddev-sans-first:5.36 11:37:13 INFO - PROCESS | 20949 | Values: 79.0 81.0 79.0 78.0 78.0 81.0 85.0 79.0 95.0 82.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:129.00 stddev:4.12 (3.2%) stddev-sans-first:3.38 11:37:13 INFO - PROCESS | 20949 | Values: 136.0 123.0 126.0 134.0 130.0 129.0 129.0 126.0 129.0 124.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.50 stddev:3.27 (2.0%) stddev-sans-first:3.47 11:37:13 INFO - PROCESS | 20949 | Values: 162.0 165.0 163.0 170.0 163.0 160.0 160.0 158.0 162.0 162.0 11:37:13 INFO - PROCESS | 20949 | 11:37:13 INFO - PROCESS | 20949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:2.54 (3.9%) stddev-sans-first:2.32 11:37:13 INFO - PROCESS | 20949 | Values: 68.0 66.0 63.0 64.0 67.0 61.0 67.0 63.0 61.0 63.0 11:37:13 INFO - PROCESS | 20949 | -------- Summary: end -------- 11:37:13 INFO - PROCESS | 20949 | 11:37:14 INFO - TEST-INFO | 20949: exit 0 11:37:14 INFO - TEST-OK | kraken | took 62230ms 11:37:14 INFO - SUITE-END | took 1173s 11:37:14 INFO - Completed test suite (00:19:33) 11:37:14 INFO - javascript benchmark 11:37:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7293.333340980435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.206132436229, 3167.8732850685974, 3176.428242916274, 3180.4911214205717, 3182.7931184473, 5469.07025805613, 5525.861853453661, 5532.419095994923, 5559.638623489481, 5583.35791383991, 5386.569074474042, 5477.726113694319, 5555.444455554442, 5577.888442231163, 5585.0, 4980.779708971298, 4998.425181104165, 5105.387353517564, 5148.073346797575, 5156.96860627876, 5034.697918124906, 5157.0, 5183.377994640629, 5186.118359878811, 5186.7147306898105, 4876.609871210312, 4983.700977941335, 5022.723750193738, 5033.572146367563, 5051.494850514938, 5035.647504674675, 5036.722980236085, 5043.646944713872, 5052.797888084472, 5100.821471248526, 5012.72430016349, 5016.247562865563, 5019.397672279313, 5036.622253330978, 5038.269450929632, 5428.104362780136, 5479.205515200313, 5504.862378440531, 5558.194061861048, 5562.86092847678, 5823.505002074829, 5845.327787304472, 5845.620034697774, 5860.970695146497, 5862.677552734598, 5783.929972955017, 5803.767849286066, 5910.556708246856, 5911.054231322968, 5911.586188966774, 5426.9185962210595, 5457.045017122027, 5474.698891561003, 5480.616356855022, 5516.696581688006, 5932.762689492372, 5941.316748573883, 5942.970285148546, 5948.613340132878, 5959.880802383928, 5655.293088363955, 5721.942780572224, 5728.513076388554, 5736.397678243808, 5764.913526297109, 5891.941080589225, 5893.086571581412, 5895.941040589625, 5896.1450589664255, 5950.2264705587995, 5645.95549823284, 5838.153467747153, 5844.736986835517, 5863.70681465925, 5880.2943646761805, 5811.302643682785, 5880.353161152269, 5881.735321910439, 5934.347221805598, 5973.074173503114, 4458.8439404620685, 4472.619827314715, 4502.842400515966, 4507.774611269423, 4518.9832287735, 3967.563568007517, 3977.622125898035, 3997.480327557399, 4021.658159056513, 4037.232925744158, 5541.501264886179, 5596.832095037155, 5604.411536788579, 5617.438256174431, 5638.0, 5908.527317814564, 5917.408259174048, 5918.704064796743, 5924.407559244041, 5941.940580594225, 5433.83698489038, 5563.749631266603, 5574.526165275997, 5602.075657516546, 5624.55003599711, 5083.313752643346, 5108.335916330928, 5108.897822043538, 5119.0, 5176.19768935808, 5892.086726557391, 6094.0372997110835, 6154.1999540059505, 6157.96921015392, 6162.876742465126, 5863.472287494146, 5880.470757631833, 5942.732577033958, 5977.193078934288, 5980.641161530322, 6116.785912493041, 6157.199564056644, 6164.599301045418, 6166.075088736726, 6169.383061693795, 5577.6653400796085, 5718.456746609066, 5762.740676669644, 5851.64890106595, 5879.441453062123, 5847.502962248086, 5913.586048976703, 5936.406359364029, 5946.970265148647, 5965.343812180743, 5709.172170035405, 5758.798442054675, 5759.8560035999435, 5774.855628609318, 5787.710614469175, 5591.21722958778, 5652.095664693629, 5664.235328230801, 5742.626729262584, 5783.624064435799, 5513.338399392099, 5517.117261238343, 5569.888602227852, 5590.217369568345, 5687.687177205294, 5747.942520574741, 5765.0, 5767.0, 5782.45066718661, 5802.274715660543, 5486.91769623448, 5577.581681373995, 5648.745806438638, 5661.66030038199, 5666.943330566642], "value": 5426.284871640568, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.2378907420352, 619.4146531527707, 641.3682522715122, 641.5220660607846, 652.0805664013742, 40410.0, 41675.16649667005, 41815.0, 41961.79019104904, 45533.544664553425, 43691.56308436923, 43946.560534394644, 44111.0, 44114.779426102825, 44164.11671766563, 8785.077566855483, 8987.37088403812, 9064.637414503444, 9064.77338066547, 9069.0, 8802.73591792244, 8903.643854245822, 8910.777230569223, 8985.23625491834, 8986.68546600869, 8875.68935087272, 8919.375643704943, 8955.2835773138, 8956.8656470153, 9003.639854405816, 8868.113188681113, 8978.820423591524, 8998.820023599525, 9003.909960900373, 9037.0, 8919.42023768453, 8923.553822308859, 8962.327825413055, 8976.41653292534, 9000.099990000948, 42660.3600945986, 42704.0, 42715.57284427147, 42728.35907461391, 42905.57094429078, 3574.8391322390553, 3640.8361623726732, 4255.489341279066, 4334.306510958231, 4376.518582955872, 32010.839945800122, 32485.350292994244, 32819.0, 32889.83555082233, 32936.505952410735, 4262.126264115849, 4272.145570885836, 4380.78096095194, 4459.531749166324, 4488.371627972087, 235618.0, 235843.0, 235961.3817378222, 236014.0, 236854.99999999828, 48582.51417485851, 48604.0, 49206.0, 56389.436105638415, 58220.708896455246, 62734.0, 62845.37154628486, 62894.37105628885, 62904.685476572326, 63051.0, 17089.91455042717, 17224.827751722572, 17464.388746393815, 17465.0, 17484.912575437294, 13370.0, 13555.051146419655, 13646.931765341109, 13684.589462316146, 13795.379207935666, 17650.293988240326, 17828.197731102133, 17915.73126403105, 17952.640947180982, 18026.729599056023, 6498.830210562144, 6726.125603671491, 6748.426383757337, 6788.830279243059, 6977.232504424509, 1024.4979959819634, 1049.4333060147587, 1059.4755595979884, 1103.707517507861, 1125.5385292030392, 31851.52222716661, 32743.836280818443, 32824.67175328264, 32902.683892644025, 33060.834695826365, 1137.0960086731068, 1144.4220668562323, 1157.9942100289613, 1179.6107284596062, 1221.4747658506749, 17257.56856078583, 17302.0, 17353.479395618153, 17370.91314543419, 17375.87056841301, 521459.0, 522320.0, 525813.0, 530018.0, 531595.0, 57637.71181144151, 57755.42244577585, 57761.42238577561, 57845.0, 57940.42059579435, 1352.8579499152645, 1355.7017456159629, 1395.0931894268806, 1399.8530154333853, 1409.4010045730524, 29706.257343566584, 31917.36165276728, 31973.520397193595, 32042.51936220912, 32830.17924551905, 50919.490805091475, 51237.48762512327, 51270.74364628153, 51364.22953655773, 51466.74266628643, 334492.0, 337894.0, 338557.0, 338743.0, 339470.0, 42161.789191053846, 42493.15013699647, 42520.57479425166, 42582.787086064374, 43667.78166109149, 47687.0, 48680.756596216794, 49456.25815612841, 49782.50217497779, 49972.0, 39445.80277098596, 41407.792961035004, 41537.58462415458, 42257.0, 42770.144597108505, 40807.59192408038, 41122.1775564493, 41169.38245926254, 41577.37633935433, 42223.366649500895, 40728.185436290514, 40814.0, 41436.685065194106, 41773.791131045364, 43973.0, 34428.82785586056, 37206.0, 37645.0, 37745.62254377421, 38136.80931595435, 28364.43271134607, 28521.28696782597, 28545.857270714343, 28755.0, 28790.856045719636], "value": 20185.048674282334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.97827619480955, 396.3242671245526, 396.8253968253968, 398.5994075953667, 419.4861294913731, 13847.792283115761, 18231.179596918137, 18985.62028759424, 19917.302894398697, 20063.59872802545, 18595.721064184047, 18666.533336666555, 18788.812111878877, 19636.80363196371, 19764.90117549414, 5565.805196818102, 5707.3721890592005, 5767.653940763567, 5899.174115623816, 5924.052151655715, 5758.280214973129, 5824.068149096145, 5857.209276747627, 5891.381404952483, 5902.173695682608, 5662.348829884575, 5759.856003599923, 5841.503472204868, 5845.5908086433965, 5854.619449735775, 5793.855153621151, 5795.623284486516, 5806.970965145189, 5849.473547380713, 5851.707414629252, 4959.280904268897, 5233.921491177635, 5261.237120617528, 5298.894022119574, 5328.866778330573, 13617.795733064011, 13874.583762487142, 14216.36026378805, 14221.644458888508, 14267.143971361751, 2229.8662080275235, 2295.9426014349606, 2391.3782416571817, 2462.258980618814, 2474.616434452663, 10169.135623472013, 10174.898251017543, 10229.386236825814, 10298.639547615798, 10371.585136594527, 1801.5316017835326, 1880.7837098733685, 1909.8567607429359, 1940.427573865713, 2006.4081096076548, 76860.23139768587, 82060.58969705114, 82645.0, 83290.58354708248, 85784.0, 10633.308834925705, 10875.401852898167, 11113.777724445628, 11635.88364116365, 11801.29192248468, 15607.297671604805, 15673.84326156724, 15693.293801778947, 15750.68498630021, 15784.605384865241, 7907.051153861574, 7940.325072368798, 7967.482113662593, 8100.270975612106, 8140.674373025131, 7768.8057798554355, 7821.256980586835, 7903.328217101496, 7916.445848790529, 8234.258916697527, 4697.624190064855, 4726.858194254178, 4788.839366018481, 4903.166461701519, 4935.383077115361, 1995.7747111970339, 2004.3285499357878, 2020.40398082566, 2036.918523259053, 2051.3333166720877, 970.9514524273899, 977.1791694976112, 1012.7063151685928, 1015.761296095417, 1023.1712313026472, 17024.489265321812, 19287.903560482388, 19733.210671573263, 20062.598748024957, 20112.79887201109, 987.9703608891745, 1008.2589296866797, 1044.9831824578484, 1049.3913530152493, 1050.191352658464, 10706.678799636024, 11136.610218642309, 11201.887981120084, 11216.887831121747, 11237.775244495064, 462004.0, 469148.0, 491254.0, 492296.0, 494199.0, 54679.453205468235, 72802.0, 93029.5348523253, 96692.51653741686, 98407.0, 952.7141857442739, 955.1833182628752, 981.2444417798256, 981.6809536900536, 998.7652901568271, 16033.438829640907, 17942.480616314395, 18154.90922545379, 18169.0, 18381.356652517097, 32766.0, 40695.0, 43148.78425607852, 44051.77974110237, 44896.0, 60091.69954150376, 61082.0, 62128.06807897795, 62429.687851560455, 62542.37457625366, 8798.824023519366, 8828.514431706319, 8840.513771742615, 8899.555022248991, 9049.366544341832, 9809.558569864515, 13764.587062388144, 13793.10344827583, 13839.584812455643, 14075.788863167265, 12203.267803931793, 12204.328761917825, 12294.569690060805, 12348.197367171106, 12417.19288246261, 12042.0, 12108.334041627442, 12189.75620487603, 12319.199252048587, 12815.16701414405, 12218.144729868824, 12353.876461235273, 12430.627081187578, 12449.0, 12547.24716517012, 8562.229399354088, 8577.785555361166, 8741.781455463664, 8766.824663506823, 9180.311476639412, 9086.591103400231, 11559.479823408135, 12189.69525761863, 12305.56930507428, 12342.382880855741], "value": 9149.864805295445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.1638557829247, 1464.8974571779977, 1544.443945270577, 1699.736540836171, 1706.795184577851, 7762.4178186635945, 7770.494917830337, 8382.329413646894, 8426.241638252555, 8464.746057618273, 8442.366822488308, 8646.870296945552, 8797.428167169146, 8798.120187981198, 8798.912010879889, 2212.7344718633744, 2235.932922012334, 2241.0587553227683, 2253.4141123307977, 2257.9887100564556, 2240.4958884250996, 2245.1692873636775, 2273.2498275569023, 2275.3628983884537, 2302.827287953402, 2269.706879302364, 2273.2611901132113, 2283.212291759349, 2300.8389412741117, 2304.3662992677064, 2201.6587428948537, 2206.6359050756605, 2214.1918199857096, 2218.4675677837286, 2241.2491815241915, 2159.719236499245, 2187.114218741412, 2191.495955930129, 2191.616467118248, 2199.274239500961, 8690.522021288827, 8735.462137834123, 8790.604422800989, 8830.735077947671, 8886.155815197546, 4915.9754201229125, 4990.5508504234795, 4994.450610432849, 4997.575206107485, 4999.42506611737, 3080.845957702106, 3227.80633162011, 3322.1694576355912, 3360.3615313090436, 3449.4308439107517, 1094.529352378477, 1100.2463312630873, 1109.5561775289868, 1158.5887010111373, 1166.749148932975, 11697.12271579635, 11742.941285293604, 11759.58841440554, 11805.0, 11812.940935295355, 4429.335599660077, 4484.1255955088445, 4517.887052823706, 4577.267637178035, 4577.679562430664, 10000.449975251286, 10076.69769906904, 10085.092341689284, 10090.596376145018, 10130.544125514221, 5163.586913046947, 5174.24973378858, 5179.249008893689, 5186.273921650972, 5193.636445448858, 4147.460830092129, 4614.838480653161, 4752.596029337476, 4777.522247775195, 4840.00779840132, 3796.8671096512044, 3873.4189871519498, 3928.5678575356687, 3930.9213815723524, 3950.4271880577157, 1197.7125489882364, 1208.655533173059, 1217.1236709569096, 1227.7360367521026, 1228.2937311046005, 848.4103548034057, 998.201438848918, 1014.1987829614669, 1015.8120747661707, 1020.1838529176629, 5741.0, 5780.797672081541, 5837.474627283565, 5837.88324233513, 5904.143899134601, 443.39698010705416, 449.4763600405491, 458.7820785127038, 459.648368997717, 460.6015796336212, 4218.514870789899, 4291.077418355007, 4320.049589090458, 4339.284018136972, 4390.53899340571, 10104.141148002354, 10474.738131546772, 10508.894911050791, 10513.264071515074, 10617.097546708463, 9911.801763964824, 10395.740106497398, 10397.0, 10481.266311358284, 10521.3687178768, 8194.795130121795, 8226.341892648574, 8375.664973401117, 8427.536485493356, 8442.240198382053, 6021.458068773832, 6291.8989176894775, 6300.873982520232, 6412.070249813844, 6439.259485159079, 10023.047810457994, 10102.69691909244, 10107.090361867467, 10189.286749927434, 10201.74495637615, 9857.35927164732, 10068.748281293027, 10173.338732982333, 10206.13247873939, 10266.0, 7011.404030657452, 7620.3522700571075, 7635.121960974559, 7679.0, 7887.921120788718, 8637.395382323428, 8651.610677519653, 8691.739247822576, 8731.69439069655, 8752.956235218782, 7376.225496323023, 7600.771976840703, 7718.614069296625, 7772.650230739743, 7797.142314345531, 7500.399968002437, 7532.246775322424, 7630.961845190738, 7634.389248859967, 7838.843223135619, 7145.1425828900865, 7263.636818158965, 7281.453890958093, 7295.0, 7313.049303590499, 5111.5910727141, 5215.843524694265, 5289.894202116013, 5355.946440535545, 5392.5416339611575, 5018.799248030038, 5161.716105614228, 5209.453007434165, 5334.279872217201, 5344.812931547377], "value": 4492.36900959951, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.3193018173109, 337.05120086955225, 337.37417091295646, 338.5936875749102, 342.8234459253485, 5638.323401191858, 5738.7417566209515, 5740.8277751667465, 5759.222504961834, 5761.30864296284, 5629.60592758507, 5655.462731040545, 5657.179708942201, 5687.402822703619, 5696.145578163278, 4187.225363307783, 4305.935410968838, 4405.515393306734, 4433.467983841943, 4445.8221671133115, 4352.825886964518, 4387.539308372623, 4401.845935392262, 4416.425864637593, 4435.246008178601, 4374.934375984363, 4407.603315701586, 4438.334249862514, 4442.511323754401, 4452.220861349267, 4285.243050349357, 4311.33174357975, 4323.956760432387, 4324.783760811978, 4371.256886329332, 3769.5476542815036, 3773.584905660375, 3797.0, 3797.6202379761803, 3823.866164684223, 5503.091989821674, 5529.723513824292, 5536.0, 5554.555635549146, 5562.553736028662, 4896.926546101776, 5008.7996480140755, 5075.467075957045, 5095.464976177485, 5110.0, 5957.970210148921, 5976.0, 6002.939970600281, 6004.4595986361, 6072.878542429171, 4242.830286788556, 4290.721103128287, 4292.849750258726, 4333.783310834446, 4381.452318460192, 5972.820815375546, 6165.475934545569, 6184.783532576338, 6217.906731399033, 6254.280757712831, 4407.471103467605, 4412.492563355255, 4420.717991782411, 4433.844815431445, 4445.1998640245065, 4445.688801783844, 4480.820767169342, 4481.596656300883, 4496.460424749051, 4497.145542346943, 4884.755762211875, 4998.600111991032, 5036.6726162799305, 5048.5203905628905, 5078.21287700407, 5951.583389162717, 5980.43185897339, 5983.491403230774, 6011.0, 6017.669028203403, 1458.795768592398, 1476.5496523560203, 1502.301429835132, 1507.758758598641, 1509.8339182689895, 972.5623469438781, 980.7352014956065, 993.4734590666958, 1038.5741845843168, 1058.4229498047853, 5601.215829783833, 5639.069553523705, 5680.4319568042865, 5710.71446427677, 5744.368119506851, 6053.303870054912, 6061.605995610271, 6063.393200801791, 6087.873743357493, 6099.756009759649, 5511.0, 5610.597350662334, 5635.492805647511, 5639.520640745583, 5640.746166422521, 3219.4365985952363, 3228.0, 3245.886393976247, 3261.6575259597876, 3262.8205448700073, 5975.52195824333, 6175.660338681416, 6197.96901015492, 6229.595076320024, 6249.000159974473, 6199.0, 6202.5658203925295, 6206.441420272107, 6207.6585787782105, 6221.160143380676, 5985.730642121028, 6230.283517395557, 6252.781152659635, 6265.592736472115, 6268.780592679234, 6009.849753756016, 6010.188624535632, 6028.854517641634, 6036.879262414815, 6044.455998960115, 5930.733117009831, 5931.7627294907725, 5934.643921364732, 5937.643741375531, 5944.464998150187, 5921.5558833086825, 6175.413335733098, 6177.722002509808, 6183.660823155626, 6199.132121503083, 4304.956950430455, 4306.913861722685, 4325.070109926381, 4339.284018136972, 4370.650347972091, 5874.324452687995, 5941.9405805943115, 5993.760249589967, 5999.940000600112, 6033.336333003454, 5794.594378393641, 5839.678817665069, 5863.241027691761, 5866.67733274674, 5871.0, 5764.654120752768, 5862.7654893805475, 5926.259217597801, 5930.644161350333, 5934.821955341346, 5418.810341638182, 5816.854578635568, 5820.447057529528, 5894.528437725057, 5900.940990590039, 5917.792877249448, 6034.39656034393, 6044.607100538451, 6048.939510605013, 6057.454829065406, 5653.208550802973, 5922.2597175353085, 5937.732802023833, 5985.6408615483215, 5991.850203744942], "value": 4512.135666865946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5915746339512, 768.0591275687281, 798.7044793426433, 804.4891493901373, 833.3874602167408, 14188.290585470724, 15185.392584296615, 15824.920875395606, 15853.365865365371, 15911.0, 15059.92470037651, 15114.848851511482, 15241.542753717406, 15273.0, 15282.312295946682, 662.8276648071488, 764.7361660227226, 778.1440415542914, 781.6677911887454, 785.1128225105623, 782.8629989751771, 793.2067932067932, 798.3254150243035, 804.3163311185475, 810.3274282345639, 842.9620667069966, 843.8101427178866, 846.4667259626458, 846.8856704344896, 850.4387104511025, 836.619338201117, 838.7441830241773, 840.2479780596362, 841.486693117198, 843.0599881132555, 605.5579427018301, 610.1397030187459, 614.7479533391332, 614.8247749391402, 617.4720613875116, 15298.388064477407, 15349.0, 15395.769063464057, 15419.768703469344, 15568.922155389151, 15426.768598471032, 15564.455244066516, 15640.687186256326, 15666.451674191349, 15789.763153552705, 11270.549178032868, 11400.942995285053, 11484.310941343547, 11545.249558778736, 12109.93945030278, 3207.3745619604188, 3235.9676403236135, 3236.3203727217315, 3300.93398132036, 3366.192113892648, 76176.61911690462, 77125.0, 77373.61313193454, 79030.60484697597, 79281.60359198166, 11098.667039988813, 11112.55549778016, 11193.888061119447, 11294.0, 11413.086953043736, 19885.701714474293, 19907.0, 19981.800181998286, 20044.298449554197, 20062.598748025248, 8262.876056859152, 8365.916340836513, 8511.787205319917, 8516.233538981398, 8688.95655521731, 4463.330500424962, 4683.812647494062, 4707.246840505502, 4719.480857105716, 4897.069556784271, 3297.868085276562, 3353.832308384571, 3372.0052584487635, 3398.6091599465885, 3415.197428604276, 560.3555910702725, 577.9508741756914, 588.7203578300273, 592.9229200203946, 595.2559300873908, 741.6662501874071, 746.6565379925295, 753.4650398217327, 769.7806125254276, 775.3603277296253, 9713.854292185622, 9788.363756355815, 10040.0, 10054.899451005542, 10304.381737095648, 657.7073202424875, 733.5891900535717, 735.2096496266535, 738.943311065182, 757.526545908807, 4907.681000735012, 4966.255061740768, 4972.378452693413, 4992.126377883856, 5041.0, 108888.0, 111816.44091779488, 116431.0, 117831.0, 121361.39319303524, 98750.50624746973, 99805.00194998103, 100605.49697251614, 101732.0, 102614.48692756488, 55745.721271393384, 56761.0, 57041.42958570444, 86492.56753716191, 87295.0, 9484.193843523102, 9490.572924218288, 9588.137067663665, 9632.75918102025, 9671.854922176033, 51835.740821297164, 52295.73852130715, 52347.21479177739, 53127.734361327944, 54304.72847635736, 71108.0, 75094.62452687701, 75264.69387145143, 76251.0, 76598.6170069146, 12710.36448177606, 12858.357082146042, 13202.0, 13219.339033048502, 13263.867361326264, 13908.582742517741, 14327.864632323224, 14351.425942962582, 14367.353469094125, 14655.413783448968, 12205.328706921204, 12328.568500102454, 12682.175658582162, 13026.804597931228, 13040.217586944813, 11967.461464233957, 11997.40012999364, 12554.497820087094, 13289.0, 13381.799273010718, 11812.538209579556, 11830.231034982698, 11924.22492538017, 12415.676036549432, 12693.933713556622, 9898.554565044446, 10149.64476243328, 10483.161347092062, 10749.542233898525, 11080.667579972614, 10348.172146228435, 10823.837642435212, 10865.565377384815, 10959.452027398438, 10976.560937562408], "value": 7408.127851658541, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 111.0, 110.0, 112.0, 112.0, 110.0, 111.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 157.0, 188.0, 127.0, 166.0, 164.0, 127.0, 175.0, 129.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 164.0, 176.0, 163.0, 163.0, 162.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 175.0, 77.0, 76.0, 74.0, 74.0, 158.0, 78.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 150.0, 86.0, 85.0, 85.0, 144.0, 86.0, 86.0, 142.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 120.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 170.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 101.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 58.0, 55.0, 57.0, 60.0, 55.0, 57.0, 53.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 78.0, 78.0, 81.0, 85.0, 79.0, 95.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 123.0, 126.0, 134.0, 130.0, 129.0, 129.0, 126.0, 129.0, 124.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 170.0, 163.0, 160.0, 160.0, 158.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 63.0, 64.0, 67.0, 61.0, 67.0, 63.0, 61.0, 63.0], "value": 64.3, "unit": "score"}]}]} 11:37:14 INFO - Return code: 0 11:37:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:14 ERROR - # TBPL SUCCESS # 11:37:14 INFO - Running post-action listener: _resource_record_post_action 11:37:14 INFO - ##### 11:37:14 INFO - ##### Finished run-tests step (success) 11:37:14 INFO - ##### 11:37:14 INFO - Running post-run listener: _resource_record_post_run 11:37:14 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553205760; Read time: 16; Write time: 693588 11:37:14 INFO - TinderboxPrint: CPU usage
13.5% 11:37:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:37:14 INFO - TinderboxPrint: I/O write bytes / time
553,205,760 / 693,588 11:37:14 INFO - TinderboxPrint: CPU idle
8,225.8 (86.5%) 11:37:14 INFO - TinderboxPrint: CPU user
1,224.7 (12.9%) 11:37:14 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:14 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263172096; Read time: 0; Write time: 292632 11:37:14 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289271808; Read time: 16; Write time: 400452 11:37:15 INFO - Running post-run listener: _upload_blobber_files 11:37:15 INFO - Blob upload gear active. 11:37:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:15 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 11:37:15 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'] 11:37:15 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 11:37:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:16 INFO - (blobuploader) - INFO - Done attempting. 11:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:37:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:17 INFO - (blobuploader) - INFO - Done attempting. 11:37:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:20 INFO - (blobuploader) - INFO - Done attempting. 11:37:20 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:20 INFO - Return code: 0 11:37:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/268fb1a67bf711dc791a7faf3603b8552512940c62fae70851eda20bb94bd50aab91fe8c3c07ef8c423065064e29ebe45efaeed7183745983222efd9e7520701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0b4b4c7006275ff3510bfb1c4be4c611e492edb00002be70a4d24d3063fdbe80bef6ed0c33100a13bf255b683cd6d0493fb4c4c529742bb0dc54e6300ade049", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a57a8fd02b482a3f83f34763ace0d4b1f6ba8377e1be43a04ab34d976b3c22b64b9efa6ff4ba169880179407ec9a4df8cf12e66a66f358c41c1c26d6c3bfc23"} 11:37:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:20 INFO - Contents: 11:37:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/268fb1a67bf711dc791a7faf3603b8552512940c62fae70851eda20bb94bd50aab91fe8c3c07ef8c423065064e29ebe45efaeed7183745983222efd9e7520701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0b4b4c7006275ff3510bfb1c4be4c611e492edb00002be70a4d24d3063fdbe80bef6ed0c33100a13bf255b683cd6d0493fb4c4c529742bb0dc54e6300ade049", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a57a8fd02b482a3f83f34763ace0d4b1f6ba8377e1be43a04ab34d976b3c22b64b9efa6ff4ba169880179407ec9a4df8cf12e66a66f358c41c1c26d6c3bfc23"} 11:37:20 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:20 INFO - Copying logs to upload dir... 11:37:20 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.300129 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-27 11:37:20.975849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:20.979843) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792 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/268fb1a67bf711dc791a7faf3603b8552512940c62fae70851eda20bb94bd50aab91fe8c3c07ef8c423065064e29ebe45efaeed7183745983222efd9e7520701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0b4b4c7006275ff3510bfb1c4be4c611e492edb00002be70a4d24d3063fdbe80bef6ed0c33100a13bf255b683cd6d0493fb4c4c529742bb0dc54e6300ade049", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a57a8fd02b482a3f83f34763ace0d4b1f6ba8377e1be43a04ab34d976b3c22b64b9efa6ff4ba169880179407ec9a4df8cf12e66a66f358c41c1c26d6c3bfc23"} build_url:https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/RmffnboYTqm-ok1Wx4LKWw/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/268fb1a67bf711dc791a7faf3603b8552512940c62fae70851eda20bb94bd50aab91fe8c3c07ef8c423065064e29ebe45efaeed7183745983222efd9e7520701", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0b4b4c7006275ff3510bfb1c4be4c611e492edb00002be70a4d24d3063fdbe80bef6ed0c33100a13bf255b683cd6d0493fb4c4c529742bb0dc54e6300ade049", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a57a8fd02b482a3f83f34763ace0d4b1f6ba8377e1be43a04ab34d976b3c22b64b9efa6ff4ba169880179407ec9a4df8cf12e66a66f358c41c1c26d6c3bfc23"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:21.005808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:21.006141) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467050497.564520-1197947792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 11:37:21.091401) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 11:37:21.091730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 11:37:21.092041) ========= ========= Total master_lag: 0.19 =========