builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1467108898.64 results: success (0) buildid: 20160628024521 builduid: 49d2242aaeb1457ba365c1c373b06b84 revision: e283d1187054416e358b3a130512dd3fe85292c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.635932) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.636322) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.636590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.663183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.663464) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 03:14:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-06-28 03:14:59 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.781931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.782219) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017270 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:58.831577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 03:14:58.831896) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e283d1187054416e358b3a130512dd3fe85292c7 --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 e283d1187054416e358b3a130512dd3fe85292c7 --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=3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 03:14:59,878 truncating revision to first 12 chars 2016-06-28 03:14:59,878 Setting DEBUG logging. 2016-06-28 03:14:59,878 attempt 1/10 2016-06-28 03:14:59,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e283d1187054?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 03:15:00,591 unpacking tar archive at: fx-team-e283d1187054/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036748 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 03:14:59.882510) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:59.882816) ========= script_repo_revision: e283d1187054416e358b3a130512dd3fe85292c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:59.883272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:59.883548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 03:14:59.893016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-28 03:14:59.893367) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:01 INFO - MultiFileLogger online at 20160628 03:15:01 in /builds/slave/test 03:15:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:15:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:01 INFO - {'append_to_log': False, 03:15:01 INFO - 'base_work_dir': '/builds/slave/test', 03:15:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:15:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:01 INFO - 'branch': 'Fx-Team-Non-PGO', 03:15:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:01 INFO - 'config_files': ('talos/linux_config.py',), 03:15:01 INFO - 'default_actions': ('clobber', 03:15:01 INFO - 'read-buildbot-config', 03:15:01 INFO - 'download-and-extract', 03:15:01 INFO - 'populate-webroot', 03:15:01 INFO - 'create-virtualenv', 03:15:01 INFO - 'install', 03:15:01 INFO - 'run-tests'), 03:15:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:01 INFO - 'download_minidump_stackwalk': True, 03:15:01 INFO - 'download_symbols': 'ondemand', 03:15:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:01 INFO - 'installer_path': 'installer.exe', 03:15:01 INFO - 'log_level': 'info', 03:15:01 INFO - 'log_name': 'talos', 03:15:01 INFO - 'log_to_console': True, 03:15:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:01 INFO - 'opt_config_files': (), 03:15:01 INFO - 'pip_index': False, 03:15:01 INFO - 'sps_profile': False, 03:15:01 INFO - 'sps_profile_interval': 0, 03:15:01 INFO - 'suite': 'dromaeojs', 03:15:01 INFO - 'system_bits': '32', 03:15:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:01 INFO - 'title': 'talos-linux64-ix-059', 03:15:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:01 INFO - 'use_talos_json': True, 03:15:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:01 INFO - 'work_dir': 'build'} 03:15:01 INFO - ##### 03:15:01 INFO - ##### Running clobber step. 03:15:01 INFO - ##### 03:15:01 INFO - Running pre-action listener: _resource_record_pre_action 03:15:01 INFO - Running main action method: clobber 03:15:01 INFO - rmtree: /builds/slave/test/build 03:15:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:01 INFO - Running post-action listener: _resource_record_post_action 03:15:01 INFO - ##### 03:15:01 INFO - ##### Finished clobber step (success) 03:15:01 INFO - ##### 03:15:01 INFO - ##### 03:15:01 INFO - ##### Running read-buildbot-config step. 03:15:01 INFO - ##### 03:15:01 INFO - Running pre-action listener: _resource_record_pre_action 03:15:01 INFO - Running main action method: read_buildbot_config 03:15:01 INFO - Using buildbot properties: 03:15:01 INFO - { 03:15:01 INFO - "project": "", 03:15:01 INFO - "product": "firefox", 03:15:01 INFO - "script_repo_revision": "production", 03:15:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:15:01 INFO - "repository": "", 03:15:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:15:01 INFO - "buildid": "20160628024521", 03:15:01 INFO - "pgo_build": "False", 03:15:01 INFO - "basedir": "/builds/slave/test", 03:15:01 INFO - "buildnumber": 3122, 03:15:01 INFO - "slavename": "talos-linux64-ix-059", 03:15:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:15:01 INFO - "platform": "ubuntu64_hw", 03:15:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:15:01 INFO - "branch": "fx-team", 03:15:01 INFO - "repo_path": "integration/fx-team", 03:15:01 INFO - "revision": "e283d1187054416e358b3a130512dd3fe85292c7", 03:15:01 INFO - "stage_platform": "linux64", 03:15:01 INFO - "builduid": "49d2242aaeb1457ba365c1c373b06b84", 03:15:01 INFO - "slavebuilddir": "test" 03:15:01 INFO - } 03:15:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:15:01 INFO - Running post-action listener: _resource_record_post_action 03:15:01 INFO - ##### 03:15:01 INFO - ##### Finished read-buildbot-config step (success) 03:15:01 INFO - ##### 03:15:01 INFO - ##### 03:15:01 INFO - ##### Running download-and-extract step. 03:15:01 INFO - ##### 03:15:01 INFO - Running pre-action listener: _resource_record_pre_action 03:15:01 INFO - Running main action method: download_and_extract 03:15:01 INFO - mkdir: /builds/slave/test/build/tests 03:15:01 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')]} 03:15:01 INFO - https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:15:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:15:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:15:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:04 INFO - Downloaded 1361 bytes. 03:15:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:15:04 INFO - Using the following test package requirements: 03:15:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:15:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:15:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:15:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'jsshell-linux-x86_64.zip'], 03:15:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:15:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:15:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:15:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:15:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:15:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:15:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:15:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:15:04 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')]} 03:15:04 INFO - https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:15:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:15:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:06 INFO - Downloaded 22713331 bytes. 03:15:06 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'] 03:15:06 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 03:15:08 INFO - Return code: 0 03:15:08 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 03:15: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')]} 03:15:08 INFO - https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:15:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:15:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:15:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:15 INFO - Downloaded 22713331 bytes. 03:15:15 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'] 03:15:15 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 03:15:16 INFO - Return code: 0 03:15:16 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')]} 03:15:16 INFO - https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:15:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:15:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:15:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:19 INFO - Downloaded 14405245 bytes. 03:15:19 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'] 03:15:19 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 03:15:19 INFO - Return code: 0 03:15: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')]} 03:15:19 INFO - https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RptZXLgOTcaUiEyUA6G23w/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 03:15:28 INFO - Downloaded 56387509 bytes. 03:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:15:28 INFO - mkdir: /builds/slave/test/properties 03:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:28 INFO - Contents: 03:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:15:29 INFO - Running post-action listener: _resource_record_post_action 03:15:29 INFO - Running post-action listener: set_extra_try_arguments 03:15:29 INFO - ##### 03:15:29 INFO - ##### Finished download-and-extract step (success) 03:15:29 INFO - ##### 03:15:29 INFO - ##### 03:15:29 INFO - ##### Running populate-webroot step. 03:15:29 INFO - ##### 03:15:29 INFO - Running pre-action listener: _resource_record_pre_action 03:15:29 INFO - Running main action method: populate_webroot 03:15:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:29 INFO - '--tppagecycles', 03:15:29 INFO - '7'], 03:15:29 INFO - 'tests': ['tsvgm']}}, 03:15:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['damp', 'tps']}, 03:15:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'tests': ['damp', 'tps']}, 03:15:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['dromaeo_dom']}, 03:15:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['basic_compositor_video']}, 03:15:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:15:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['a11yr', 03:15:29 INFO - 'ts_paint', 03:15:29 INFO - 'tpaint', 03:15:29 INFO - 'sessionrestore', 03:15:29 INFO - 'sessionrestore_no_auto_restore', 03:15:29 INFO - 'tabpaint']}, 03:15:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:29 INFO - 'ts_paint', 03:15:29 INFO - 'tpaint', 03:15:29 INFO - 'sessionrestore', 03:15:29 INFO - 'sessionrestore_no_auto_restore', 03:15:29 INFO - 'tabpaint']}, 03:15:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:15:29 INFO - 'ts_paint', 03:15:29 INFO - 'tpaint', 03:15:29 INFO - 'sessionrestore', 03:15:29 INFO - 'sessionrestore_no_auto_restore', 03:15:29 INFO - 'tabpaint']}, 03:15:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:15:29 INFO - 'ts_paint', 03:15:29 INFO - 'tpaint', 03:15:29 INFO - 'sessionrestore', 03:15:29 INFO - 'sessionrestore_no_auto_restore', 03:15:29 INFO - 'tabpaint']}, 03:15:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['a11yr', 03:15:29 INFO - 'ts_paint', 03:15:29 INFO - 'tpaint', 03:15:29 INFO - 'sessionrestore', 03:15:29 INFO - 'sessionrestore_no_auto_restore', 03:15:29 INFO - 'tabpaint']}, 03:15:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['a11yr', 03:15:29 INFO - 'ts_paint', 03:15:29 INFO - 'tpaint', 03:15:29 INFO - 'sessionrestore', 03:15:29 INFO - 'sessionrestore_no_auto_restore', 03:15:29 INFO - 'tabpaint']}, 03:15:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['tsvgx', 03:15:29 INFO - 'tsvgr_opacity', 03:15:29 INFO - 'tart', 03:15:29 INFO - 'tscrollx', 03:15:29 INFO - 'cart']}, 03:15:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:29 INFO - 'tsvgr_opacity', 03:15:29 INFO - 'tart', 03:15:29 INFO - 'tscrollx', 03:15:29 INFO - 'cart']}, 03:15:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'talos_options': ['--disable-e10s'], 03:15:29 INFO - 'tests': ['tp5o']}, 03:15:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'tests': ['tp5o']}, 03:15:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'talos_options': ['--disable-e10s', 03:15:29 INFO - '--xperf_path', 03:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:29 INFO - 'tests': ['tp5n']}, 03:15:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:29 INFO - 'talos_options': ['--xperf_path', 03:15:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:29 INFO - 'tests': ['tp5n']}}, 03:15:29 INFO - 'talos.zip': {'path': '', 03:15:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:29 INFO - Running post-action listener: _resource_record_post_action 03:15:29 INFO - ##### 03:15:29 INFO - ##### Finished populate-webroot step (success) 03:15:29 INFO - ##### 03:15:29 INFO - ##### 03:15:29 INFO - ##### Running create-virtualenv step. 03:15:29 INFO - ##### 03:15:29 INFO - Running pre-action listener: _resource_record_pre_action 03:15:29 INFO - Running main action method: create_virtualenv 03:15:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:29 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 03:15:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:29 INFO - Using real prefix '/usr' 03:15:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:32 INFO - Installing pip.................done. 03:15:32 INFO - Return code: 0 03:15:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:32 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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:32 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 03:15:32 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 03:15:32 INFO - Using env: {'DISPLAY': ':0', 03:15:32 INFO - 'HOME': '/home/cltbld', 03:15:32 INFO - 'LANG': 'en_US.UTF-8', 03:15:32 INFO - 'LANGUAGE': 'en_US:en', 03:15:32 INFO - 'LOGNAME': 'cltbld', 03:15:32 INFO - 'MAIL': '/var/mail/cltbld', 03:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:32 INFO - 'MOZ_NO_REMOTE': '1', 03:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:32 INFO - 'NO_EM_RESTART': '1', 03:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:32 INFO - 'PWD': '/builds/slave/test', 03:15:32 INFO - 'SHELL': '/bin/bash', 03:15:32 INFO - 'SHLVL': '1', 03:15:32 INFO - 'TERM': 'linux', 03:15:32 INFO - 'TMOUT': '86400', 03:15:32 INFO - 'USER': 'cltbld', 03:15:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:32 INFO - '_': '/tools/buildbot/bin/python'} 03:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:32 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 03:15:32 INFO - Cleaning up... 03:15:32 INFO - Return code: 0 03:15:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:32 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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:32 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 03:15:32 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 03:15:32 INFO - Using env: {'DISPLAY': ':0', 03:15:32 INFO - 'HOME': '/home/cltbld', 03:15:32 INFO - 'LANG': 'en_US.UTF-8', 03:15:32 INFO - 'LANGUAGE': 'en_US:en', 03:15:32 INFO - 'LOGNAME': 'cltbld', 03:15:32 INFO - 'MAIL': '/var/mail/cltbld', 03:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:32 INFO - 'MOZ_NO_REMOTE': '1', 03:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:32 INFO - 'NO_EM_RESTART': '1', 03:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:32 INFO - 'PWD': '/builds/slave/test', 03:15:32 INFO - 'SHELL': '/bin/bash', 03:15:32 INFO - 'SHLVL': '1', 03:15:32 INFO - 'TERM': 'linux', 03:15:32 INFO - 'TMOUT': '86400', 03:15:32 INFO - 'USER': 'cltbld', 03:15:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:32 INFO - '_': '/tools/buildbot/bin/python'} 03:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:32 INFO - Downloading/unpacking psutil>=3.1.1 03:15:32 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 03:15:32 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 03:15:32 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 03:15:32 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 03:15:32 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 03:15:32 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 03:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:34 INFO - Installing collected packages: psutil 03:15:34 INFO - Running setup.py install for psutil 03:15:34 INFO - building 'psutil._psutil_linux' extension 03:15:34 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 03:15:34 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 03:15:34 INFO - building 'psutil._psutil_posix' extension 03:15:34 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 03:15:35 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 03:15:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:35 INFO - Successfully installed psutil 03:15:35 INFO - Cleaning up... 03:15:35 INFO - Return code: 0 03:15:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:35 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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:35 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 03:15:35 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 03:15:35 INFO - Using env: {'DISPLAY': ':0', 03:15:35 INFO - 'HOME': '/home/cltbld', 03:15:35 INFO - 'LANG': 'en_US.UTF-8', 03:15:35 INFO - 'LANGUAGE': 'en_US:en', 03:15:35 INFO - 'LOGNAME': 'cltbld', 03:15:35 INFO - 'MAIL': '/var/mail/cltbld', 03:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:35 INFO - 'MOZ_NO_REMOTE': '1', 03:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:35 INFO - 'NO_EM_RESTART': '1', 03:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:35 INFO - 'PWD': '/builds/slave/test', 03:15:35 INFO - 'SHELL': '/bin/bash', 03:15:35 INFO - 'SHLVL': '1', 03:15:35 INFO - 'TERM': 'linux', 03:15:35 INFO - 'TMOUT': '86400', 03:15:35 INFO - 'USER': 'cltbld', 03:15:35 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:35 INFO - '_': '/tools/buildbot/bin/python'} 03:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:15:35 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 03:15:35 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 03:15:35 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 03:15:35 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 03:15:35 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 03:15:35 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 03:15:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:15:37 INFO - Installing collected packages: mozsystemmonitor 03:15:37 INFO - Running setup.py install for mozsystemmonitor 03:15:37 INFO - Successfully installed mozsystemmonitor 03:15:37 INFO - Cleaning up... 03:15:37 INFO - Return code: 0 03:15:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:15:37 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')]} 03:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:37 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')]} 03:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:37 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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:37 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 03:15:37 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 03:15:37 INFO - Using env: {'DISPLAY': ':0', 03:15:37 INFO - 'HOME': '/home/cltbld', 03:15:37 INFO - 'LANG': 'en_US.UTF-8', 03:15:37 INFO - 'LANGUAGE': 'en_US:en', 03:15:37 INFO - 'LOGNAME': 'cltbld', 03:15:37 INFO - 'MAIL': '/var/mail/cltbld', 03:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:37 INFO - 'MOZ_NO_REMOTE': '1', 03:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:37 INFO - 'NO_EM_RESTART': '1', 03:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:37 INFO - 'PWD': '/builds/slave/test', 03:15:37 INFO - 'SHELL': '/bin/bash', 03:15:37 INFO - 'SHLVL': '1', 03:15:37 INFO - 'TERM': 'linux', 03:15:37 INFO - 'TMOUT': '86400', 03:15:37 INFO - 'USER': 'cltbld', 03:15:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:37 INFO - '_': '/tools/buildbot/bin/python'} 03:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 03:15:37 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 03:15:37 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 03:15:37 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 03:15:37 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 03:15:37 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 03:15:37 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 03:15:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:15:39 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 03:15:39 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 03:15:39 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 03:15:39 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 03:15:39 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 03:15:39 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 03:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:39 INFO - warning: no files found matching '*.txt' 03:15:39 INFO - no previously-included directories found matching 'build' 03:15:39 INFO - no previously-included directories found matching 'dist' 03:15:39 INFO - no previously-included directories found matching '.git*' 03:15:39 INFO - Installing collected packages: jsonschema, functools32 03:15:39 INFO - Running setup.py install for functools32 03:15:40 INFO - warning: no files found matching '*.txt' 03:15:40 INFO - no previously-included directories found matching 'build' 03:15:40 INFO - no previously-included directories found matching 'dist' 03:15:40 INFO - no previously-included directories found matching '.git*' 03:15:40 INFO - Successfully installed jsonschema functools32 03:15:40 INFO - Cleaning up... 03:15:40 INFO - Return code: 0 03:15:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:15:40 INFO - Using env: {'DISPLAY': ':0', 03:15:40 INFO - 'HOME': '/home/cltbld', 03:15:40 INFO - 'LANG': 'en_US.UTF-8', 03:15:40 INFO - 'LANGUAGE': 'en_US:en', 03:15:40 INFO - 'LOGNAME': 'cltbld', 03:15:40 INFO - 'MAIL': '/var/mail/cltbld', 03:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:40 INFO - 'MOZ_NO_REMOTE': '1', 03:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:40 INFO - 'NO_EM_RESTART': '1', 03:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:40 INFO - 'PWD': '/builds/slave/test', 03:15:40 INFO - 'SHELL': '/bin/bash', 03:15:40 INFO - 'SHLVL': '1', 03:15:40 INFO - 'TERM': 'linux', 03:15:40 INFO - 'TMOUT': '86400', 03:15:40 INFO - 'USER': 'cltbld', 03:15:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:40 INFO - '_': '/tools/buildbot/bin/python'} 03:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:15:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:42 INFO - Downloading docopt-0.6.1.tar.gz 03:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:15:42 INFO - Running setup.py install for blobuploader 03:15:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:15:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:15:43 INFO - Running setup.py install for requests 03:15:43 INFO - Running setup.py install for docopt 03:15:43 INFO - Successfully installed blobuploader requests docopt 03:15:43 INFO - Cleaning up... 03:15:43 INFO - Return code: 0 03:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:43 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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:43 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 03:15:43 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 03:15:43 INFO - Using env: {'DISPLAY': ':0', 03:15:43 INFO - 'HOME': '/home/cltbld', 03:15:43 INFO - 'LANG': 'en_US.UTF-8', 03:15:43 INFO - 'LANGUAGE': 'en_US:en', 03:15:43 INFO - 'LOGNAME': 'cltbld', 03:15:43 INFO - 'MAIL': '/var/mail/cltbld', 03:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:43 INFO - 'MOZ_NO_REMOTE': '1', 03:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:43 INFO - 'NO_EM_RESTART': '1', 03:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:43 INFO - 'PWD': '/builds/slave/test', 03:15:43 INFO - 'SHELL': '/bin/bash', 03:15:43 INFO - 'SHLVL': '1', 03:15:43 INFO - 'TERM': 'linux', 03:15:43 INFO - 'TMOUT': '86400', 03:15:43 INFO - 'USER': 'cltbld', 03:15:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:43 INFO - '_': '/tools/buildbot/bin/python'} 03:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:43 INFO - Running setup.py (path:/tmp/pip-TBifOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:43 INFO - Running setup.py (path:/tmp/pip-Aw5_t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:43 INFO - Running setup.py (path:/tmp/pip-lAmSSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:44 INFO - Running setup.py (path:/tmp/pip-nfATXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:44 INFO - Running setup.py (path:/tmp/pip-bxQk_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:44 INFO - Running setup.py (path:/tmp/pip-wInTCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:44 INFO - Running setup.py (path:/tmp/pip-47q7qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:44 INFO - Running setup.py (path:/tmp/pip-Jn4K_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:44 INFO - Running setup.py (path:/tmp/pip-dzM1C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:44 INFO - Running setup.py (path:/tmp/pip-olepfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:44 INFO - Running setup.py (path:/tmp/pip-uGHvWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:44 INFO - Running setup.py (path:/tmp/pip-cHOK6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:44 INFO - Running setup.py (path:/tmp/pip-Sc9cEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:44 INFO - Running setup.py (path:/tmp/pip-Ha6Awl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:44 INFO - Running setup.py (path:/tmp/pip-bfWyK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:44 INFO - Running setup.py (path:/tmp/pip-0a6h6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:44 INFO - Running setup.py (path:/tmp/pip-xJMbh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:15:45 INFO - Running setup.py install for manifestparser 03:15:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Running setup.py install for mozcrash 03:15:45 INFO - Running setup.py install for mozdebug 03:15:45 INFO - Running setup.py install for mozdevice 03:15:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Running setup.py install for mozfile 03:15:45 INFO - Running setup.py install for mozhttpd 03:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Running setup.py install for mozinfo 03:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Running setup.py install for mozInstall 03:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:15:45 INFO - Running setup.py install for mozleak 03:15:45 INFO - Running setup.py install for mozlog 03:15:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for moznetwork 03:15:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozprocess 03:15:46 INFO - Running setup.py install for mozprofile 03:15:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozrunner 03:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Running setup.py install for mozscreenshot 03:15:46 INFO - Running setup.py install for moztest 03:15:46 INFO - Running setup.py install for mozversion 03:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:15:46 INFO - Cleaning up... 03:15:46 INFO - Return code: 0 03:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:46 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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:46 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 03:15:46 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 03:15:46 INFO - Using env: {'DISPLAY': ':0', 03:15:46 INFO - 'HOME': '/home/cltbld', 03:15:46 INFO - 'LANG': 'en_US.UTF-8', 03:15:46 INFO - 'LANGUAGE': 'en_US:en', 03:15:46 INFO - 'LOGNAME': 'cltbld', 03:15:46 INFO - 'MAIL': '/var/mail/cltbld', 03:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:46 INFO - 'MOZ_NO_REMOTE': '1', 03:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:46 INFO - 'NO_EM_RESTART': '1', 03:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:46 INFO - 'PWD': '/builds/slave/test', 03:15:46 INFO - 'SHELL': '/bin/bash', 03:15:46 INFO - 'SHLVL': '1', 03:15:46 INFO - 'TERM': 'linux', 03:15:46 INFO - 'TMOUT': '86400', 03:15:46 INFO - 'USER': 'cltbld', 03:15:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:46 INFO - '_': '/tools/buildbot/bin/python'} 03:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:47 INFO - Running setup.py (path:/tmp/pip-n9X97I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:47 INFO - Running setup.py (path:/tmp/pip-UcJvbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:47 INFO - Running setup.py (path:/tmp/pip-yoOGqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:47 INFO - Running setup.py (path:/tmp/pip-kKADZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:47 INFO - Running setup.py (path:/tmp/pip-hGgb39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:47 INFO - Running setup.py (path:/tmp/pip-LDlPcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:47 INFO - Running setup.py (path:/tmp/pip-PhiCZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:47 INFO - Running setup.py (path:/tmp/pip-V8aZSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:47 INFO - Running setup.py (path:/tmp/pip-Z0A2Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:47 INFO - Running setup.py (path:/tmp/pip-EJ3dj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:47 INFO - Running setup.py (path:/tmp/pip-x_I8NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:47 INFO - Running setup.py (path:/tmp/pip-6uM7tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:47 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)) 03:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:47 INFO - Running setup.py (path:/tmp/pip-3RTtOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:48 INFO - Running setup.py (path:/tmp/pip-FFdKo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:48 INFO - Running setup.py (path:/tmp/pip-sC_7XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:48 INFO - Running setup.py (path:/tmp/pip-_J28db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:48 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)) 03:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:48 INFO - Running setup.py (path:/tmp/pip-Eszvf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 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)) 03:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:50 INFO - Downloading blessings-1.6.tar.gz 03:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:15:50 INFO - Installing collected packages: blessings 03:15:50 INFO - Running setup.py install for blessings 03:15:50 INFO - Successfully installed blessings 03:15:50 INFO - Cleaning up... 03:15:50 INFO - Return code: 0 03:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:50 INFO - Reading from file tmpfile_stdout 03:15:50 INFO - Current package versions: 03:15:50 INFO - argparse == 1.2.1 03:15:50 INFO - blessings == 1.6 03:15:50 INFO - blobuploader == 1.2.4 03:15:50 INFO - docopt == 0.6.1 03:15:50 INFO - functools32 == 3.2.3-2 03:15:50 INFO - jsonschema == 2.5.1 03:15:50 INFO - manifestparser == 1.1 03:15:50 INFO - mozInstall == 1.12 03:15:50 INFO - mozcrash == 0.17 03:15:50 INFO - mozdebug == 0.1 03:15:50 INFO - mozdevice == 0.48 03:15:50 INFO - mozfile == 1.2 03:15:50 INFO - mozhttpd == 0.7 03:15:50 INFO - mozinfo == 0.9 03:15:50 INFO - mozleak == 0.1 03:15:50 INFO - mozlog == 3.2 03:15:50 INFO - moznetwork == 0.27 03:15:50 INFO - mozprocess == 0.22 03:15:50 INFO - mozprofile == 0.28 03:15:50 INFO - mozrunner == 6.11 03:15:50 INFO - mozscreenshot == 0.1 03:15:50 INFO - mozsystemmonitor == 0.3 03:15:50 INFO - moztest == 0.7 03:15:50 INFO - mozversion == 1.4 03:15:50 INFO - psutil == 3.1.1 03:15:50 INFO - requests == 1.2.3 03:15:50 INFO - wsgiref == 0.1.2 03:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:50 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 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:50 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 03:15:50 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 03:15:50 INFO - Using env: {'DISPLAY': ':0', 03:15:50 INFO - 'HOME': '/home/cltbld', 03:15:50 INFO - 'LANG': 'en_US.UTF-8', 03:15:50 INFO - 'LANGUAGE': 'en_US:en', 03:15:50 INFO - 'LOGNAME': 'cltbld', 03:15:50 INFO - 'MAIL': '/var/mail/cltbld', 03:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:50 INFO - 'MOZ_NO_REMOTE': '1', 03:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:50 INFO - 'NO_EM_RESTART': '1', 03:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:50 INFO - 'PWD': '/builds/slave/test', 03:15:50 INFO - 'SHELL': '/bin/bash', 03:15:50 INFO - 'SHLVL': '1', 03:15:50 INFO - 'TERM': 'linux', 03:15:50 INFO - 'TMOUT': '86400', 03:15:50 INFO - 'USER': 'cltbld', 03:15:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:50 INFO - '_': '/tools/buildbot/bin/python'} 03:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 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)) 03:15:51 INFO - Cleaning up... 03:15:51 INFO - Return code: 0 03:15:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:15:51 INFO - Using env: {'DISPLAY': ':0', 03:15:51 INFO - 'HOME': '/home/cltbld', 03:15:51 INFO - 'LANG': 'en_US.UTF-8', 03:15:51 INFO - 'LANGUAGE': 'en_US:en', 03:15:51 INFO - 'LOGNAME': 'cltbld', 03:15:51 INFO - 'MAIL': '/var/mail/cltbld', 03:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:51 INFO - 'MOZ_NO_REMOTE': '1', 03:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:51 INFO - 'NO_EM_RESTART': '1', 03:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:51 INFO - 'PWD': '/builds/slave/test', 03:15:51 INFO - 'SHELL': '/bin/bash', 03:15:51 INFO - 'SHLVL': '1', 03:15:51 INFO - 'TERM': 'linux', 03:15:51 INFO - 'TMOUT': '86400', 03:15:51 INFO - 'USER': 'cltbld', 03:15:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:51 INFO - '_': '/tools/buildbot/bin/python'} 03:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:15:51 INFO - Cleaning up... 03:15:51 INFO - Return code: 0 03:15:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf531a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1728480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, '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': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', '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 03:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:15:51 INFO - Using env: {'DISPLAY': ':0', 03:15:51 INFO - 'HOME': '/home/cltbld', 03:15:51 INFO - 'LANG': 'en_US.UTF-8', 03:15:51 INFO - 'LANGUAGE': 'en_US:en', 03:15:51 INFO - 'LOGNAME': 'cltbld', 03:15:51 INFO - 'MAIL': '/var/mail/cltbld', 03:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:51 INFO - 'MOZ_NO_REMOTE': '1', 03:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:51 INFO - 'NO_EM_RESTART': '1', 03:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:51 INFO - 'PWD': '/builds/slave/test', 03:15:51 INFO - 'SHELL': '/bin/bash', 03:15:51 INFO - 'SHLVL': '1', 03:15:51 INFO - 'TERM': 'linux', 03:15:51 INFO - 'TMOUT': '86400', 03:15:51 INFO - 'USER': 'cltbld', 03:15:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:51 INFO - '_': '/tools/buildbot/bin/python'} 03:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:51 INFO - Downloading/unpacking flake8 03:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:15:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:15:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:15:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:15:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:15:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:15:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:15:54 INFO - no previously-included directories found matching 'docs/_build' 03:15:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:15:54 INFO - Running setup.py install for pep8 03:15:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:15:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:15:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:15:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:15:54 INFO - no previously-included directories found matching 'docs/_build' 03:15:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:15:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:15:54 INFO - Cleaning up... 03:15:54 INFO - Return code: 0 03:15:54 INFO - Running post-action listener: _resource_record_post_action 03:15:54 INFO - Running post-action listener: _start_resource_monitoring 03:15:54 INFO - Starting resource monitoring. 03:15:54 INFO - ##### 03:15:54 INFO - ##### Finished create-virtualenv step (success) 03:15:54 INFO - ##### 03:15:54 INFO - ##### 03:15:54 INFO - ##### Running install step. 03:15:54 INFO - ##### 03:15:54 INFO - Running pre-action listener: _resource_record_pre_action 03:15:54 INFO - Running main action method: install 03:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:54 INFO - Reading from file tmpfile_stdout 03:15:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:15:54 INFO - Reading from file tmpfile_stdout 03:15:54 INFO - Output received: 03:15:54 INFO - Usage: mozinstall [options] installer 03:15:54 INFO - Options: 03:15:54 INFO - -h, --help show this help message and exit 03:15:54 INFO - -d DEST, --destination=DEST 03:15:54 INFO - Directory to install application into. [default: 03:15:54 INFO - "/builds/slave/test"] 03:15:54 INFO - --app=APP Application being installed. [default: firefox] 03:15:54 INFO - mkdir: /builds/slave/test/build/application 03:15:54 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'] 03:15:54 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 03:16:11 INFO - Reading from file tmpfile_stdout 03:16:11 INFO - Output received: 03:16:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:11 INFO - Running post-action listener: _resource_record_post_action 03:16:11 INFO - ##### 03:16:11 INFO - ##### Finished install step (success) 03:16:11 INFO - ##### 03:16:11 INFO - ##### 03:16:11 INFO - ##### Running run-tests step. 03:16:11 INFO - ##### 03:16:11 INFO - Running pre-action listener: _resource_record_pre_action 03:16:11 INFO - Running main action method: run_tests 03:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:11 INFO - Python 2.7.3 03:16:11 INFO - Return code: 0 03:16:11 INFO - grabbing minidump binary from tooltool 03:16: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')]} 03:16:11 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 0x17b76f0>, '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 0x17b85f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b8aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:11 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 03:16:11 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 03:16:11 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 03:16:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:11 INFO - Return code: 0 03:16:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:16:12 INFO - Return code: 0 03:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:16:12 INFO - Using env: {'DISPLAY': ':0', 03:16:12 INFO - 'HOME': '/home/cltbld', 03:16:12 INFO - 'LANG': 'en_US.UTF-8', 03:16:12 INFO - 'LANGUAGE': 'en_US:en', 03:16:12 INFO - 'LOGNAME': 'cltbld', 03:16:12 INFO - 'MAIL': '/var/mail/cltbld', 03:16:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:12 INFO - 'MOZ_NO_REMOTE': '1', 03:16:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:12 INFO - 'NO_EM_RESTART': '1', 03:16:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:12 INFO - 'PWD': '/builds/slave/test', 03:16:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:12 INFO - 'SHELL': '/bin/bash', 03:16:12 INFO - 'SHLVL': '1', 03:16:12 INFO - 'TERM': 'linux', 03:16:12 INFO - 'TMOUT': '86400', 03:16:12 INFO - 'USER': 'cltbld', 03:16:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637', 03:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:12 INFO - '_': '/tools/buildbot/bin/python'} 03:16:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:16:12 INFO - mozversion application_buildid: 20160628024521 03:16:12 INFO - mozversion application_changeset: e283d1187054416e358b3a130512dd3fe85292c7 03:16:12 INFO - mozversion application_display_name: Nightly 03:16:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:12 INFO - mozversion application_name: Firefox 03:16:12 INFO - mozversion application_remotingname: firefox 03:16:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:16:12 INFO - mozversion application_vendor: Mozilla 03:16:12 INFO - mozversion application_version: 50.0a1 03:16:12 INFO - mozversion platform_buildid: 20160628024521 03:16:12 INFO - mozversion platform_changeset: e283d1187054416e358b3a130512dd3fe85292c7 03:16:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:16:12 INFO - mozversion platform_version: 50.0a1 03:16:12 INFO - using testdate: 1467108972 03:16:12 INFO - actual date: 1467108972 03:16:12 INFO - starting webserver on 'localhost:54370' 03:16:12 INFO - SUITE-START | Running 2 tests 03:16:12 INFO - TEST-START | dromaeo_css 03:16:12 INFO - operating with platform_type : linux_ 03:16:12 INFO - Initialising browser for dromaeo_css test... 03:16:12 INFO - TEST-INFO | started process 14892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3SSJnO/profile http://localhost:54370/getInfo.html) 03:16:16 INFO - PROCESS | 14892 | __metrics Screen width/height:1600/1200 03:16:16 INFO - PROCESS | 14892 | colorDepth:24 03:16:16 INFO - PROCESS | 14892 | Browser inner width/height: 1024/697 03:16:16 INFO - PROCESS | 14892 | __metrics 03:16:17 INFO - PROCESS | 14892 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:18 INFO - TEST-INFO | 14892: exit 0 03:16:18 INFO - Browser initialized. 03:16:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:18 INFO - TEST-INFO | started process 14971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3SSJnO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:30 INFO - PROCESS | 14971 | RSS: Main: 175710208 03:16:30 INFO - PROCESS | 14971 | 03:17:21 INFO - PROCESS | 14971 | 1467109041210 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] 03:19:33 INFO - PROCESS | 14971 | Cycle 1(1): loaded http://localhost:54370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54370/tests/dromaeo/cssquery-ext.html) 03:19:35 INFO - PROCESS | 14971 | RSS: Main: 290742272 03:19:35 INFO - PROCESS | 14971 | 03:22:38 INFO - PROCESS | 14971 | Cycle 1(1): loaded http://localhost:54370/tests/dromaeo/cssquery-ext.html (next: http://localhost:54370/tests/dromaeo/cssquery-jquery.html) 03:22:38 INFO - PROCESS | 14971 | RSS: Main: 260833280 03:22:38 INFO - PROCESS | 14971 | 03:25:40 INFO - PROCESS | 14971 | Cycle 1(1): loaded http://localhost:54370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54370/tests/dromaeo/cssquery-mootools.html) 03:25:41 INFO - PROCESS | 14971 | RSS: Main: 265469952 03:25:41 INFO - PROCESS | 14971 | 03:28:43 INFO - PROCESS | 14971 | Cycle 1(1): loaded http://localhost:54370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54370/tests/dromaeo/cssquery-prototype.html) 03:28:44 INFO - PROCESS | 14971 | RSS: Main: 254357504 03:28:44 INFO - PROCESS | 14971 | 03:31:47 INFO - PROCESS | 14971 | Cycle 1(1): loaded http://localhost:54370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54370/tests/dromaeo/cssquery-yui.html) 03:31:47 INFO - PROCESS | 14971 | RSS: Main: 243691520 03:31:47 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | Cycle 1(1): loaded http://localhost:54370/tests/dromaeo/cssquery-yui.html (next: http://localhost:54370/tests/dromaeo/cssquery-dojo.html) 03:34:50 INFO - PROCESS | 14971 | RSS: Main: 297242624 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | __start_tp_report 03:34:50 INFO - PROCESS | 14971 | _x_x_mozilla_page_load 03:34:50 INFO - PROCESS | 14971 | _x_x_mozilla_page_load_details 03:34:50 INFO - PROCESS | 14971 | |i|pagename|runs| 03:34:50 INFO - PROCESS | 14971 | |0;dojo.html;2657.6412184355113;2668.8799004044818;2696.487667343204;2714.063648041425;2718.225305787851;4729.668923175371;4789.161896668083;4811.2302031674935;4878.0975519528865;4909.386326709161;4852.9514704852945;4861.416630004404;4876.049170411762;4949.28235405866;4953.752312384385;4385.276429389147;4432.601065904068;4456.086502267044;4503.954960450403;4580.038191979672;4479.820807167709;4490.057088011522;4527.253003254459;4533.909321813562;4551.089782043588;4338.370936214263;4387.122575484916;4388.385626012361;4428.822847086113;4460.442444694413;4396.516383197845;4399.670024748125;4423.093265880487;4458.687891847572;4466.240739074366;4423.535528769465;4444.533324000998;4459.977700111479;4490.8877278067985;4501.23479008566;4785.880352991168;4800;4860.198067318888;4865.5134486551415;4868.561829435368;5168.638195326329;5192.92210616841;5230.633855630107;5245.239440281138;5252.737363131828;5191.558717509016;5240.161574148118;5243.632945693803;5262;5273.235380869753;4637.443506779175;4751.4535828379485;4878.634102442331;4881.365422495124;4952.678075925053;5405.054115529845;5441.129419292894;5443.891122177534;5446.291982042309;5448.101063324507;4976;5180;5183.326167598264;5204.0632686116105;5210.505002024802;5232.2674825524455;5243.659162154448;5248.160294352885;5296.09966305729;5322.467753224724;5212.973935130376;5216.295800067019;5222.4255331913455;5238.2404551340605;5272.894542109137;4990.6257030722845;5097.770600322994;5207.557357624644;5235.8429247121885;5238.2404551340605;4474.26174681174;4491.30384790358;4501.0547784964865;4537.319402089647;4539.795709193094;3845.538535375773;3879.3405121129476;3895.3962135868987;3903.8243279052513;3925.4700615417123;4454.910901781946;4474.172278128557;4492.348609451677;4556.544345565483;4598.195315819718;5159.922601160911;5233.110371236899;5253.579713622901;5261.631685782035;5306.363236411578;4508;4516.254817955067;4523.615492683159;4529.433820772403;4569.200389931815;4618.861434156981;4642.16441040616;4682.993156471375;4712.458067322234;4754.690945088558;4898.485659005895;4915.115279249626;4917.360743103373;4958.256261560723;4961.776720047678;5192.324997750268;5215.113430716711;5243.737813109406;5245.344331958505;5260.18467137579;4816.133096042606;4869.123557759637;4917.409910810726;4931.137051015986;4941.579965702956;5175.715335656424;5239.580833533232;5240.68555886648;5265.947340526545;5284.920726189033;5291.153415453509;5295.205719142159;5303.973480132575;5304.336957880265;5357.651752636066;4763.833265835679;4977.527134922177;5104.4129925057605;5119.74401279942;5126.615503837153;4927.211646136601;4995.525425084611;5004.049230646166;5012.223105418666;5057.949420505748;4987.401511818605;5050.116229659869;5055.216441451581;5069.1635880079375;5074.974625126851;4939.6542242042715;5066.290719299374;5113.181890897438;5113.948860511496;5141.768620412166;5004.17431123875;5016.448190698947;5022.899542009212;5029.597632189343;5062.82280120194 03:34:50 INFO - PROCESS | 14971 | |1;ext.html;541.174689676052;578.574747560543;579.2325169150873;582.595096407996;594.7502049139363;28117.437651246964;40406.59593404065;41528.37707434391;41569.37645935313;41675.791621041855;41854;42219.15561688764;42491.57508424915;42539.14921701572;42609;7571.545707257582;7940.602969851513;8061.596920153998;8069.636866340999;10268;10215.693529194135;10351;10351.844722329133;10360.067593916547;10363.948180259089;10337.37975721459;10348.482575871214;10361.637342693008;10375.42935138567;10389.740256493611;7587.430942679293;10185.694429167137;10268.794624107513;10422.374657520573;10437.11284540815;10268.075873171376;10335.638252661121;10338.53476593555;10351.171906247557;10359.378437293712;38494;38695.8065209675;39085;39104.60895391038;39120.41319380183;3076.8000079994727;3158.4314823331792;3763.8306276217636;3807.9809600951817;3812.1422679897078;29106.854465727534;29724.40551188964;29781.255468613457;29786.255343616365;29806.10581682553;3534.5581802274714;3537.575490941078;3722.8883133506038;3804.258169656918;3807.1053302473897;261478;263248;263529;263636;264591;47825.282620760714;54453.183202251996;56108.43891561032;56625;56733.14900276499;57414.7129264351;57558.13662795061;57846.710766445896;58156.709216453644;58164.12753808696;13383.397747101404;13493.932530337286;13518.459261629425;13573.321333933462;13584.049116561746;8689.435186712843;8809.867851982226;8828.38201325901;9096.681616143404;9316.580753866092;17664.381746638806;17737.290508379778;17759.733603995952;17762.733558996624;17805.287788488575;5815.3021637402935;5981.940180598225;6034.6982650867285;6034.818955431344;6046.758129674852;824.4558591329813;940.8823897012874;941.8210539997378;1006.4213077480332;1020.336781092296;27075.1877443677;28026.85986570095;28254;28306.85846570754;28595.71404285972;882.188386684252;892.3530440430636;892.8705337726124;902.9976725834318;921.4287141971886;13983.580492585239;14480.565583032527;14594.197319147548;14598.467160947948;14729.631759206106;186683;187462.06268968567;187838;188075;188143.65209913586;50120.74939625279;50237.24644130341;50261.49738502568;50284.74857625688;50475.74762126166;1074.2694967422228;1190.3274649822822;1220.341015851448;1241.6399244219256;1241.7951038078616;27791.583126252717;29024.274393140342;29032.419351613273;29259.7074029257;29278.70721292845;42615.14769704651;43260.35109473298;43352.78323608362;43404;43418.78290608527;289022;296116;297961;298068;298350;22808.885955570116;24851.87574062118;25521.48957020886;25565.616515752652;25992.220233392272;42333.153336933705;42836.357454638826;43381.56618433775;43785.78107109444;43873.12253754971;35334;36383.636163638024;36736.448953266256;36930;37042.629573704995;36219;36458.27083458369;36528;36628.45057324089;36851.8157409222;35548;36917;37980.62019379771;38086.80956595199;40599.1880162401;31469;33538.83230583832;34145.48781768226;34652.65347346494;34846.12884677802;25397;25873.482530349665;25926.87036564805;25941.610875837254;25952.351191219615 03:34:50 INFO - PROCESS | 14971 | |2;jquery.html;370.37961414630496;374.597307894014;379.39675915294674;386.83559487217946;388.86584128475664;16440.83559164408;16892.915535422322;17339.393121240726;17355.91322043391;18133.818661813377;10613.41626210558;11127.554897804099;11166.553337866475;11221.326720396783;11255.324680519174;4510.097980403916;4729.408823897013;4998.525140111684;5630.239917611131;5645.463680950304;5450.073487507114;5453.672779633215;5461.836144915659;5461.890762184754;5553.611597100725;5484;5609.80365687201;6018.608790428608;6026.939730602704;6027.156198132265;5649.745761440745;6049.939500604982;6068.180795592582;6068.302145253286;6091.390860913917;5370.516653501204;5408.215808707715;5409.107497262947;5415.6479828811;5443.292371991655;12020;12092.153549251556;12111.454984525717;12807.29559874216;12811.615651530468;1926.8362189213933;1962.5584243545231;1973.2304401283511;2003.3689387842783;2050.4258807533915;8840.911590884138;9008.729738107802;9115.361924665276;9370.67202647911;9498.715038548855;1833.193394906237;1882.105999650169;1934.1199754111844;1938.195648805744;1988.0854806788896;64422;64894.3510564893;67092;67131;67704;9847.60609575609;9861.950690246504;10061.195104391778;10178.847317290247;10183.898161018444;13888.4444622216;13972.860271397156;13979.720405591832;13993.3702983366;14004.089734167246;6651.767188148391;6716.529842910949;6717.899231511531;6767.1879374475375;7054.894176587355;6304.401081897213;6417.326180751047;6428.967855160694;6479.1901012373455;6679.398854103154;3975.860844870416;4185.811638476276;4263.59495847894;4463.933041004388;4587.9541204588195;1764.214924358648;1845.6954602490707;1846.9722954155698;1884.44408899375;1906.027261784047;656.701200953565;754.3663322808757;773.6595897804948;779.1585088104946;807.7092246791151;15372.538823835303;15839.841601584067;15921.522354329389;16056.839431605535;16327.510174694778;703.6411430170548;713.5468977199515;756.8221467955026;779.4738551477843;788.731831177391;8524.616392262364;8759.39980417601;9035.774105647411;9197.218236449977;9352.485613291334;369927;376353;377091;381975;383114;50972.490275097516;71314.64342678254;72088.63955680188;72227.63886180536;79016;814.267159556404;900.9054049324726;912.2610685344891;935.2471260635118;941.6252271683283;14580.708385832437;15176.392944282105;16396.508104756875;16579.253933572778;16710.66578668444;33473.163170920925;35477.645223547435;37367.6263237375;38365;39486.80256598699;51194.48805511897;51732;52030;52082.21876671777;53523.19715204197;6137.754489820536;6313.589616674902;6869.107016087876;7597.544147351176;7982.8802567960365;10208.642697505551;11258.774824503627;11299.943500282447;11306.152038596974;11424.885751142383;9200;9205.861912071457;9398.2951278653;9493.430394176372;9842.409455432697;9695.66065187715;9756.85364719544;9810.75473113178;9906.801863962537;9983.05161009732;9489.952550237205;9664.420134791935;9718.951405242928;9782.657606983721;9859;6805.2854450283985;6841.555298905555;6916.239213686591;6933.965330173317;7094.964525177341;9677.758056048655;9749.512524373895;9769.609215631295;9794.363366381162;9811.844048046461 03:34:50 INFO - PROCESS | 14971 | |3;mootools.html;1234.6296111166648;1398.8391334996475;1435.3110506956662;1514.7955026071477;1723.5691077230692;6709.966450167748;7749.457537972337;7992;7999.560024198667;8254.66981320748;8065.4354195206215;8086.191380861911;8136.552489613069;8147.796305092361;8160.061592916816;2232.174095584636;2260.3106052653934;2262.954740905181;2263.106073101124;2263.660450932357;2204.9228277010307;2229.108356657342;2229.6766968789516;2231.4532939429864;2231.85492942959;2168.035224325176;2178.16140785797;2194.1113848891223;2200.867947923122;2217.8558393704357;2129.4943946244216;2145.045454772619;2147.3450597567735;2152.9354119376444;2155.5581105873257;2159.0931808640407;2160.805527502532;2161.9567608647894;2167.5773224221284;2169.316665250441;7896.842063158705;8083.43415960883;8140;8143.063547692032;8146.674133034671;4552.658550608685;4664.650151238637;4725.503822098699;4728.6453515986095;4735.526447355272;2752.8898844046216;2882.654081510211;2962.274242810504;2974.048304542547;2976.880924763007;943.2218419803621;946.8532377481501;955.6511873166314;961.5528779117744;961.7884065505577;10758.838617420744;11019.504122314514;11021.173411994052;11040.447977601088;11064.225504214708;4327.545607711208;4386.232409328355;4494.07871386365;4515.525869783691;4515.864524064284;9420.95289523548;9502.90497095034;9503.334766566411;9515.191208747196;9525.333226674205;4840.273958906192;4908.533689299511;4910.582600478928;4911.68074075184;4915.238138088602;3566.7324950628285;3805.9048523786573;4223.535411104776;4421.9336709949375;4458.398116254329;3726.347889119393;3849.517935594816;3908.3160446921675;3936.271789718854;3939.2712348215673;1235.9073069519823;1247.6756043428775;1254.861965183829;1259.123905380994;1277.6167149855007;830.2942498875907;844.5903736687701;859.2009431228892;861.0657436681271;886.9866951995725;5115.56517696;5479.669316627309;5593.720313984284;5594.272744543184;5607.775688972395;403.76178054947724;417.09490405819446;417.47856827658796;419.83626385709596;420.61093488522994;3673.4673472346894;3753.5871054184017;3823.4264860271182;3844.788536630512;3869.129445874712;9152.90847091534;9621.615135394646;9624.566894489764;9689.41863488193;9972.950135249277;9765.658201962897;9788.510574471247;9807.117359437685;9855.655052073143;9855.852162217572;7350.52221605594;7367.336939675455;7613.695452181851;7616.69533218665;7629.694812207561;5731.340895797037;5864.354920958776;5889.617174883619;5945.970270148621;6005.309389420273;9212.49331286759;9338.159565639126;9360.20438262728;9361.204297634777;9371.344005919793;9170.174684278447;9253.67612133572;9617.519124043909;9627.855582166134;9628.18160456341;6235.875282494416;6396.232452105777;6421.389967953037;6529.053287273414;6530.902036469552;7348.889766653398;7519.060117485315;7545.207753185837;7719.691212351443;7725.845483090195;6535.085088087767;6719.697613607302;6781.525293229624;6954.165500140016;6969.059177011039;6683.866322673616;6758.2565917748025;6795.592264464148;6889.311068893071;6916.377526022682;6217.378262173746;6220.657863817533;6233.844153896189;6374.872502550016;6375.713092910737;4311.805968731477;4416.315471101984;4422.911541769082;4484.730916144911;4506.842260520866;4350.195213885441;4356.629686476685;4477.171723231213;4488.349189367589;4562.65780066503 03:34:50 INFO - PROCESS | 14971 | |4;prototype.html;301.4633951566213;309.95195744659577;312.39551467909587;315.68904628940504;321.8165645582018;4727.196376615975;4849.127157111719;4921.434035085967;4948.777305021269;4954.232094025428;4748.738819364934;4898.779554920028;4914.11545921734;4921.261810728392;4928.250471082768;3833.5783063862955;3834.482344883433;3838.865639702611;3843.693783729768;3882.320593896071;3660.7803531788177;3710.5361829771277;3877;3893.8637147699837;3899.8495443843995;3833.386658134699;3834.424836274567;3843.327417701905;3854.2869569129803;3860.4595356650093;3772.622737726233;3829.119302560413;3837.7889216093104;3840.7311488195837;3869.941950870739;3442.122258823984;3454;3458.515807786912;3458.7405944554007;3460.3079384123275;4685.6485763567525;4810.663253572251;4830.178869592178;4838.733869637169;4838.975805120987;4310.762908040057;4321.854708502218;4332.913341733148;4342.41501851825;4355.760433176174;4891.804327826882;5063.3417655704525;5081.237814327844;5083.440821509668;5096.770645320932;3623.4564815277654;3637.0907273181706;3643.544556930384;3652.652997965189;3655.5796083450214;5328.893422131575;5373.38206106295;5385.138377859563;5422.969635769191;5429.728513574345;3711.1278849470355;3734.3278209922473;3746.9625303747157;3756.2111956489443;3769.095417099876;3604.7830584191056;3800.9429858552144;3805.1058001369656;3832.620256707583;3846.3845784674318;4301.161273551627;4302.698811083257;4303.505096913832;4306.440162778818;4308.547602501692;5105.540501354822;5140.640155189101;5148.871278218075;5162.92255616166;5167.250748641426;1196.5393323570488;1240.460399726122;1286.9420876060599;1304.7390521895659;1309.561296965508;827.8137419080658;829.2578142562373;840.9369297302727;859.6518410043942;865.7619154732373;4084.8366065357054;4086.6730661547003;4093.529244136903;4103.179364127127;4115.855945041909;4687.273472611751;4706.7411292378565;4711.693739906895;4732.6687131900435;4735.431748190171;4035.7982100894837;4092.324766413568;4110.479122724611;4116.727201874517;4140.523839758466;2405.9639105413435;2469.876506174684;2493.962590561143;2507.8244522883224;2516.3709072731817;4402.713823601455;4442.533533978885;4446.19889469632;4459.44256967879;4473.7986790594505;4756.21522448799;4768.188088526338;4771.6898401603785;4802.039592081597;4831.4685384607665;4220.599043090901;4431.6261958792875;4446.6220371268155;4523.683342166017;4540.568645978561;4623.826801403335;4727.432708075053;4765.690230135169;4785.49752276006;4799.640026997919;4661.370714953574;4662.836800711959;4680.355599086505;4684.360473834131;4690.953090469052;4285.6785741068925;4428.490723566831;4435.780160455901;4497.123061003073;4501.819927202875;3375.291188850369;3387.491876218587;3430.1939044325063;3431.69114779671;3462.7402944779747;5074.289599456153;5085.516875896784;5251.842444726664;5294.602904782234;5313;5071.39143302806;5095.898082038264;5105.7191854448365;5118.616103792305;5148.794048238028;4766.833160839354;5021.744563859035;5040;5088.796448142181;5100.6429549931145;5096.923546146737;5125.564327032095;5129;5134.4352121267375;5138.4604616514725;5228.63399562027;5228.712420816892;5229.581633469389;5234.319538459976;5245.449227831023;4810.63920205979;5115.641905066758;5140.100482415488;5174.404943431554;5174.508421699932 03:34:50 INFO - PROCESS | 14971 | |5;yui.html;623.5603899251031;635.965021923794;714.1180641907243;743.3569961982886;762.6644276518333;11554.30674159551;12319.630411087659;12677;12692.428840702167;12698.682532936682;12111.636650900466;12152.817707734392;12272.447739851707;12291.078169137305;12292.508299668025;620.8882401167788;743.6133210730417;770.7957391291299;784.0434669702953;786.7521730654854;786.0959896119451;796.2037962037962;797.1470526536608;798.5767543202112;798.7763426240633;826.5123577089516;830.983380332393;831.8377916306323;831.8669012957897;832.1096426823301;650.5023656902473;792.7661339904741;819.3035919468464;826.1531929771971;826.3926014379426;587.9500242479394;591.136940067502;593.7832691067772;593.9584229103964;594.7472324262214;10564.418956957365;10566.207534434949;10573.995470430375;10580;10606.204534659932;13129.60611181666;13542.661433464242;13667.972184477596;13773.104748191336;13870.930645346809;9693.70918872435;9904.702858914172;10006.149477294439;10038.247131465168;10130.341527800669;3309.1396236978317;3434.9484757728655;3441.328940856534;3483.3207524532727;3608.278344331144;51543.226851597254;51742;51813.481865181246;53081.46918530804;53362.46637533614;10494.160467162608;10503.611457036115;10510.789784204273;10568.682939511673;10674.412907290174;19255.51861203453;19280.132394042022;19296.22815087409;19343.8065619342;19350.612987740165;6977.197622273402;7224.060872086595;7236;7265.382442492447;7291.8906216406795;3649.878022726007;3719.8698045568276;3755.887323380303;3792.994856363011;3796.772193668389;3040.9087727367773;3127.2807254331633;3179.078067360486;3181.0456862941023;3191.824449655291;499.48802477460896;501.0555103629612;504.9774207230388;532.808189051941;545.0706545340186;440.92724700424714;474.48281373303263;498.32476993673777;516.2462804305756;572.985675358111;7086;7461.515001524884;7636.274553917369;7726.536407815549;7774.2614451627005;497.1672448648499;520.7630528109701;521.817363922624;535.4966331648238;588.9381614930456;3401.795892246473;3406.5230867678547;3413.4879768034994;3456.5679290088738;3543.326767914088;52167.73916130395;52268.47731522636;53562.464375356525;55783;94178;47206.291905621445;47730.28404573934;55181;77537;81732;55746.88506229853;60749.39250607437;62314.899063121506;69958;71513;7806.946062281747;7853.7251196210145;8030.397720170894;8061.87907181381;8517.148285171434;40793.79603101966;40859.59140408558;41529.58470415378;41848.37227441652;43489.56510434855;57937;60806;62460;62508.37491625026;63444.682776585825;11103.16726245551;11107.44462776874;11216.327020378803;11330;11382.430878456209;12230.938845305716;12476.500939962663;12657.493700251887;13217.40521676546;13354.93322533381;10536.15710743154;10682.57269709203;10691.251612387057;10797.784044318912;10858.185636077484;12306.384680765746;12426;12544.749105017667;12577.496900123893;12955.417006234553;10324.48377581103;10481;10731.946340268249;10830.837537437103;11434.318890227936;9725.4650994196;9964.402135871871;10349.327293725884;10485.056344928993;10517.21120915919;8909;9685.806283874424;9829.803403932025;9896.802063958536;9906 03:34:50 INFO - PROCESS | 14971 | __end_tp_report 03:34:50 INFO - PROCESS | 14971 | __start_cc_report 03:34:50 INFO - PROCESS | 14971 | _x_x_mozilla_cycle_collect,1058 03:34:50 INFO - PROCESS | 14971 | __end_cc_report 03:34:50 INFO - PROCESS | 14971 | __startTimestamp1467110090970__endTimestamp 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | ------- Summary: start ------- 03:34:50 INFO - PROCESS | 14971 | Number of tests: 6 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | [#0] dojo.html Cycles:165 Average:4824.19 Median:4941.58 stddev:517.45 (10.5%) stddev-sans-first:490.33 03:34:50 INFO - PROCESS | 14971 | Values: 2657.6 2668.9 2696.5 2714.1 2718.2 4729.7 4789.2 4811.2 4878.1 4909.4 4853.0 4861.4 4876.0 4949.3 4953.8 4385.3 4432.6 4456.1 4504.0 4580.0 4479.8 4490.1 4527.3 4533.9 4551.1 4338.4 4387.1 4388.4 4428.8 4460.4 4396.5 4399.7 4423.1 4458.7 4466.2 4423.5 4444.5 4460.0 4490.9 4501.2 4785.9 4800.0 4860.2 4865.5 4868.6 5168.6 5192.9 5230.6 5245.2 5252.7 5191.6 5240.2 5243.6 5262.0 5273.2 4637.4 4751.5 4878.6 4881.4 4952.7 5405.1 5441.1 5443.9 5446.3 5448.1 4976.0 5180.0 5183.3 5204.1 5210.5 5232.3 5243.7 5248.2 5296.1 5322.5 5213.0 5216.3 5222.4 5238.2 5272.9 4990.6 5097.8 5207.6 5235.8 5238.2 4474.3 4491.3 4501.1 4537.3 4539.8 3845.5 3879.3 3895.4 3903.8 3925.5 4454.9 4474.2 4492.3 4556.5 4598.2 5159.9 5233.1 5253.6 5261.6 5306.4 4508.0 4516.3 4523.6 4529.4 4569.2 4618.9 4642.2 4683.0 4712.5 4754.7 4898.5 4915.1 4917.4 4958.3 4961.8 5192.3 5215.1 5243.7 5245.3 5260.2 4816.1 4869.1 4917.4 4931.1 4941.6 5175.7 5239.6 5240.7 5265.9 5284.9 5291.2 5295.2 5304.0 5304.3 5357.7 4763.8 4977.5 5104.4 5119.7 5126.6 4927.2 4995.5 5004.0 5012.2 5057.9 4987.4 5050.1 5055.2 5069.2 5075.0 4939.7 5066.3 5113.2 5113.9 5141.8 5004.2 5016.4 5022.9 5029.6 5062.8 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | [#1] ext.html Cycles:180 Average:42173.09 Median:19434.28 stddev:65980.44 (339.5%) stddev-sans-first:66091.48 03:34:50 INFO - PROCESS | 14971 | Values: 541.2 578.6 579.2 582.6 594.8 28117.4 40406.6 41528.4 41569.4 41675.8 41854.0 42219.2 42491.6 42539.1 42609.0 7571.5 7940.6 8061.6 8069.6 10268.0 10215.7 10351.0 10351.8 10360.1 10363.9 10337.4 10348.5 10361.6 10375.4 10389.7 7587.4 10185.7 10268.8 10422.4 10437.1 10268.1 10335.6 10338.5 10351.2 10359.4 38494.0 38695.8 39085.0 39104.6 39120.4 3076.8 3158.4 3763.8 3808.0 3812.1 29106.9 29724.4 29781.3 29786.3 29806.1 3534.6 3537.6 3722.9 3804.3 3807.1 261478.0 263248.0 263529.0 263636.0 264591.0 47825.3 54453.2 56108.4 56625.0 56733.1 57414.7 57558.1 57846.7 58156.7 58164.1 13383.4 13493.9 13518.5 13573.3 13584.0 8689.4 8809.9 8828.4 9096.7 9316.6 17664.4 17737.3 17759.7 17762.7 17805.3 5815.3 5981.9 6034.7 6034.8 6046.8 824.5 940.9 941.8 1006.4 1020.3 27075.2 28026.9 28254.0 28306.9 28595.7 882.2 892.4 892.9 903.0 921.4 13983.6 14480.6 14594.2 14598.5 14729.6 186683.0 187462.1 187838.0 188075.0 188143.7 50120.7 50237.2 50261.5 50284.7 50475.7 1074.3 1190.3 1220.3 1241.6 1241.8 27791.6 29024.3 29032.4 29259.7 29278.7 42615.1 43260.4 43352.8 43404.0 43418.8 289022.0 296116.0 297961.0 298068.0 298350.0 22808.9 24851.9 25521.5 25565.6 25992.2 42333.2 42836.4 43381.6 43785.8 43873.1 35334.0 36383.6 36736.4 36930.0 37042.6 36219.0 36458.3 36528.0 36628.5 36851.8 35548.0 36917.0 37980.6 38086.8 40599.2 31469.0 33538.8 34145.5 34652.7 34846.1 25397.0 25873.5 25926.9 25941.6 25952.4 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | [#2] jquery.html Cycles:180 Average:23172.63 Median:5472.95 stddev:62331.09 (1138.9%) stddev-sans-first:62482.43 03:34:50 INFO - PROCESS | 14971 | Values: 370.4 374.6 379.4 386.8 388.9 16440.8 16892.9 17339.4 17355.9 18133.8 10613.4 11127.6 11166.6 11221.3 11255.3 4510.1 4729.4 4998.5 5630.2 5645.5 5450.1 5453.7 5461.8 5461.9 5553.6 5484.0 5609.8 6018.6 6026.9 6027.2 5649.7 6049.9 6068.2 6068.3 6091.4 5370.5 5408.2 5409.1 5415.6 5443.3 12020.0 12092.2 12111.5 12807.3 12811.6 1926.8 1962.6 1973.2 2003.4 2050.4 8840.9 9008.7 9115.4 9370.7 9498.7 1833.2 1882.1 1934.1 1938.2 1988.1 64422.0 64894.4 67092.0 67131.0 67704.0 9847.6 9862.0 10061.2 10178.8 10183.9 13888.4 13972.9 13979.7 13993.4 14004.1 6651.8 6716.5 6717.9 6767.2 7054.9 6304.4 6417.3 6429.0 6479.2 6679.4 3975.9 4185.8 4263.6 4463.9 4588.0 1764.2 1845.7 1847.0 1884.4 1906.0 656.7 754.4 773.7 779.2 807.7 15372.5 15839.8 15921.5 16056.8 16327.5 703.6 713.5 756.8 779.5 788.7 8524.6 8759.4 9035.8 9197.2 9352.5 369927.0 376353.0 377091.0 381975.0 383114.0 50972.5 71314.6 72088.6 72227.6 79016.0 814.3 900.9 912.3 935.2 941.6 14580.7 15176.4 16396.5 16579.3 16710.7 33473.2 35477.6 37367.6 38365.0 39486.8 51194.5 51732.0 52030.0 52082.2 53523.2 6137.8 6313.6 6869.1 7597.5 7982.9 10208.6 11258.8 11299.9 11306.2 11424.9 9200.0 9205.9 9398.3 9493.4 9842.4 9695.7 9756.9 9810.8 9906.8 9983.1 9490.0 9664.4 9719.0 9782.7 9859.0 6805.3 6841.6 6916.2 6934.0 7095.0 9677.8 9749.5 9769.6 9794.4 9811.8 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | [#3] mootools.html Cycles:180 Average:5246.95 Median:5297.62 stddev:2979.56 (56.2%) stddev-sans-first:2972.66 03:34:50 INFO - PROCESS | 14971 | Values: 1234.6 1398.8 1435.3 1514.8 1723.6 6710.0 7749.5 7992.0 7999.6 8254.7 8065.4 8086.2 8136.6 8147.8 8160.1 2232.2 2260.3 2263.0 2263.1 2263.7 2204.9 2229.1 2229.7 2231.5 2231.9 2168.0 2178.2 2194.1 2200.9 2217.9 2129.5 2145.0 2147.3 2152.9 2155.6 2159.1 2160.8 2162.0 2167.6 2169.3 7896.8 8083.4 8140.0 8143.1 8146.7 4552.7 4664.7 4725.5 4728.6 4735.5 2752.9 2882.7 2962.3 2974.0 2976.9 943.2 946.9 955.7 961.6 961.8 10758.8 11019.5 11021.2 11040.4 11064.2 4327.5 4386.2 4494.1 4515.5 4515.9 9421.0 9502.9 9503.3 9515.2 9525.3 4840.3 4908.5 4910.6 4911.7 4915.2 3566.7 3805.9 4223.5 4421.9 4458.4 3726.3 3849.5 3908.3 3936.3 3939.3 1235.9 1247.7 1254.9 1259.1 1277.6 830.3 844.6 859.2 861.1 887.0 5115.6 5479.7 5593.7 5594.3 5607.8 403.8 417.1 417.5 419.8 420.6 3673.5 3753.6 3823.4 3844.8 3869.1 9152.9 9621.6 9624.6 9689.4 9973.0 9765.7 9788.5 9807.1 9855.7 9855.9 7350.5 7367.3 7613.7 7616.7 7629.7 5731.3 5864.4 5889.6 5946.0 6005.3 9212.5 9338.2 9360.2 9361.2 9371.3 9170.2 9253.7 9617.5 9627.9 9628.2 6235.9 6396.2 6421.4 6529.1 6530.9 7348.9 7519.1 7545.2 7719.7 7725.8 6535.1 6719.7 6781.5 6954.2 6969.1 6683.9 6758.3 6795.6 6889.3 6916.4 6217.4 6220.7 6233.8 6374.9 6375.7 4311.8 4416.3 4422.9 4484.7 4506.8 4350.2 4356.6 4477.2 4488.3 4562.7 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | [#4] prototype.html Cycles:180 Average:4117.33 Median:4485.46 stddev:1194.06 (26.6%) stddev-sans-first:1162.55 03:34:50 INFO - PROCESS | 14971 | Values: 301.5 310.0 312.4 315.7 321.8 4727.2 4849.1 4921.4 4948.8 4954.2 4748.7 4898.8 4914.1 4921.3 4928.3 3833.6 3834.5 3838.9 3843.7 3882.3 3660.8 3710.5 3877.0 3893.9 3899.8 3833.4 3834.4 3843.3 3854.3 3860.5 3772.6 3829.1 3837.8 3840.7 3869.9 3442.1 3454.0 3458.5 3458.7 3460.3 4685.6 4810.7 4830.2 4838.7 4839.0 4310.8 4321.9 4332.9 4342.4 4355.8 4891.8 5063.3 5081.2 5083.4 5096.8 3623.5 3637.1 3643.5 3652.7 3655.6 5328.9 5373.4 5385.1 5423.0 5429.7 3711.1 3734.3 3747.0 3756.2 3769.1 3604.8 3800.9 3805.1 3832.6 3846.4 4301.2 4302.7 4303.5 4306.4 4308.5 5105.5 5140.6 5148.9 5162.9 5167.3 1196.5 1240.5 1286.9 1304.7 1309.6 827.8 829.3 840.9 859.7 865.8 4084.8 4086.7 4093.5 4103.2 4115.9 4687.3 4706.7 4711.7 4732.7 4735.4 4035.8 4092.3 4110.5 4116.7 4140.5 2406.0 2469.9 2494.0 2507.8 2516.4 4402.7 4442.5 4446.2 4459.4 4473.8 4756.2 4768.2 4771.7 4802.0 4831.5 4220.6 4431.6 4446.6 4523.7 4540.6 4623.8 4727.4 4765.7 4785.5 4799.6 4661.4 4662.8 4680.4 4684.4 4691.0 4285.7 4428.5 4435.8 4497.1 4501.8 3375.3 3387.5 3430.2 3431.7 3462.7 5074.3 5085.5 5251.8 5294.6 5313.0 5071.4 5095.9 5105.7 5118.6 5148.8 4766.8 5021.7 5040.0 5088.8 5100.6 5096.9 5125.6 5129.0 5134.4 5138.5 5228.6 5228.7 5229.6 5234.3 5245.4 4810.6 5115.6 5140.1 5174.4 5174.5 03:34:50 INFO - PROCESS | 14971 | 03:34:50 INFO - PROCESS | 14971 | [#5] yui.html Cycles:180 Average:15334.37 Median:497.75 stddev:20000.79 (4018.3%) stddev-sans-first:20026.40 03:34:50 INFO - PROCESS | 14971 | Values: 623.6 636.0 714.1 743.4 762.7 11554.3 12319.6 12677.0 12692.4 12698.7 12111.6 12152.8 12272.4 12291.1 12292.5 620.9 743.6 770.8 784.0 786.8 786.1 796.2 797.1 798.6 798.8 826.5 831.0 831.8 831.9 832.1 650.5 792.8 819.3 826.2 826.4 588.0 591.1 593.8 594.0 594.7 10564.4 10566.2 10574.0 10580.0 10606.2 13129.6 13542.7 13668.0 13773.1 13870.9 9693.7 9904.7 10006.1 10038.2 10130.3 3309.1 3434.9 3441.3 3483.3 3608.3 51543.2 51742.0 51813.5 53081.5 53362.5 10494.2 10503.6 10510.8 10568.7 10674.4 19255.5 19280.1 19296.2 19343.8 19350.6 6977.2 7224.1 7236.0 7265.4 7291.9 3649.9 3719.9 3755.9 3793.0 3796.8 3040.9 3127.3 3179.1 3181.0 3191.8 499.5 501.1 505.0 532.8 545.1 440.9 474.5 498.3 516.2 573.0 7086.0 7461.5 7636.3 7726.5 7774.3 497.2 520.8 521.8 535.5 588.9 3401.8 3406.5 3413.5 3456.6 3543.3 52167.7 52268.5 53562.5 55783.0 94178.0 47206.3 47730.3 55181.0 77537.0 81732.0 55746.9 60749.4 62314.9 69958.0 71513.0 7806.9 7853.7 8030.4 8061.9 8517.1 40793.8 40859.6 41529.6 41848.4 43489.6 57937.0 60806.0 62460.0 62508.4 63444.7 11103.2 11107.4 11216.3 11330.0 11382.4 12230.9 12476.5 12657.5 13217.4 13354.9 10536.2 10682.6 10691.3 10797.8 10858.2 12306.4 12426.0 12544.7 12577.5 12955.4 10324.5 10481.0 10731.9 10830.8 11434.3 9725.5 9964.4 10349.3 10485.1 10517.2 8909.0 9685.8 9829.8 9896.8 9906.0 03:34:50 INFO - PROCESS | 14971 | -------- Summary: end -------- 03:34:50 INFO - PROCESS | 14971 | 03:34:51 INFO - TEST-INFO | 14971: exit 0 03:34:51 INFO - TEST-OK | dromaeo_css | took 1119565ms 03:34:51 INFO - TEST-START | kraken 03:34:51 INFO - operating with platform_type : linux_ 03:34:51 INFO - Initialising browser for kraken test... 03:34:51 INFO - TEST-INFO | started process 15153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5NYVt/profile http://localhost:54370/getInfo.html) 03:34:55 INFO - PROCESS | 15153 | __metrics Screen width/height:1600/1200 03:34:55 INFO - PROCESS | 15153 | colorDepth:24 03:34:55 INFO - PROCESS | 15153 | Browser inner width/height: 1024/697 03:34:55 INFO - PROCESS | 15153 | __metrics 03:34:56 INFO - PROCESS | 15153 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:34:57 INFO - TEST-INFO | 15153: exit 0 03:34:57 INFO - Browser initialized. 03:34:57 INFO - Running cycle 1/1 for kraken test... 03:34:57 INFO - TEST-INFO | started process 15235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5NYVt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:09 INFO - PROCESS | 15235 | RSS: Main: 175534080 03:35:09 INFO - PROCESS | 15235 | 03:35:12 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54370/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:13 INFO - PROCESS | 15235 | RSS: Main: 233574400 03:35:13 INFO - PROCESS | 15235 | 03:35:16 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54370/tests/kraken/driver.html?testName=audio-dft) 03:35:16 INFO - PROCESS | 15235 | RSS: Main: 222117888 03:35:16 INFO - PROCESS | 15235 | 03:35:20 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54370/tests/kraken/driver.html?testName=audio-fft) 03:35:20 INFO - PROCESS | 15235 | RSS: Main: 288329728 03:35:20 INFO - PROCESS | 15235 | 03:35:22 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54370/tests/kraken/driver.html?testName=audio-oscillator) 03:35:23 INFO - PROCESS | 15235 | RSS: Main: 198610944 03:35:23 INFO - PROCESS | 15235 | 03:35:25 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:26 INFO - PROCESS | 15235 | RSS: Main: 202342400 03:35:26 INFO - PROCESS | 15235 | 03:35:29 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54370/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:30 INFO - PROCESS | 15235 | RSS: Main: 238301184 03:35:30 INFO - PROCESS | 15235 | 03:35:33 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54370/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:34 INFO - PROCESS | 15235 | RSS: Main: 234442752 03:35:34 INFO - PROCESS | 15235 | 03:35:37 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54370/tests/kraken/driver.html?testName=json-parse-financial) 03:35:37 INFO - PROCESS | 15235 | RSS: Main: 237281280 03:35:37 INFO - PROCESS | 15235 | 03:35:39 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:40 INFO - PROCESS | 15235 | RSS: Main: 225173504 03:35:40 INFO - PROCESS | 15235 | 03:35:41 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:42 INFO - PROCESS | 15235 | RSS: Main: 229539840 03:35:42 INFO - PROCESS | 15235 | 03:35:44 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:45 INFO - PROCESS | 15235 | RSS: Main: 236630016 03:35:45 INFO - PROCESS | 15235 | 03:35:48 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:35:48 INFO - PROCESS | 15235 | RSS: Main: 239525888 03:35:48 INFO - PROCESS | 15235 | 03:35:51 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:35:52 INFO - PROCESS | 15235 | RSS: Main: 240619520 03:35:52 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | Cycle 1(1): loaded http://localhost:54370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54370/tests/kraken/driver.html?testName=ai-astar) 03:35:54 INFO - PROCESS | 15235 | RSS: Main: 283148288 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | __start_tp_report 03:35:54 INFO - PROCESS | 15235 | _x_x_mozilla_page_load 03:35:54 INFO - PROCESS | 15235 | _x_x_mozilla_page_load_details 03:35:54 INFO - PROCESS | 15235 | |i|pagename|runs| 03:35:54 INFO - PROCESS | 15235 | |0;ai-astar;103;115;112;113;114;113;113;114;113;114 03:35:54 INFO - PROCESS | 15235 | |1;audio-beat-detection;165;130;137;194;134;162;156;133;202;141 03:35:54 INFO - PROCESS | 15235 | |2;audio-dft;162;162;162;162;163;161;162;163;161;161 03:35:54 INFO - PROCESS | 15235 | |3;audio-fft;76;76;76;116;76;77;74;75;100;75 03:35:54 INFO - PROCESS | 15235 | |4;audio-oscillator;86;87;119;85;85;86;125;85;85;132 03:35:54 INFO - PROCESS | 15235 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;117 03:35:54 INFO - PROCESS | 15235 | |6;imaging-darkroom;147;146;146;146;145;145;146;147;146;146 03:35:54 INFO - PROCESS | 15235 | |7;imaging-desaturate;95;94;94;95;95;94;94;95;94;95 03:35:54 INFO - PROCESS | 15235 | |8;json-parse-financial;64;63;64;64;63;65;63;63;62;62 03:35:54 INFO - PROCESS | 15235 | |9;json-stringify-tinderbox;66;66;65;65;66;65;65;65;65;65 03:35:54 INFO - PROCESS | 15235 | |10;stanford-crypto-aes;82;84;89;83;82;86;83;84;97;83 03:35:54 INFO - PROCESS | 15235 | |11;stanford-crypto-ccm;136;132;132;130;138;133;138;140;154;132 03:35:54 INFO - PROCESS | 15235 | |12;stanford-crypto-pbkdf2;168;171;171;167;165;165;167;166;164;168 03:35:54 INFO - PROCESS | 15235 | |13;stanford-crypto-sha256-iterative;66;67;67;70;66;65;68;68;65;66 03:35:54 INFO - PROCESS | 15235 | __end_tp_report 03:35:54 INFO - PROCESS | 15235 | __start_cc_report 03:35:54 INFO - PROCESS | 15235 | _x_x_mozilla_cycle_collect,1880 03:35:54 INFO - PROCESS | 15235 | __end_cc_report 03:35:54 INFO - PROCESS | 15235 | __startTimestamp1467110154322__endTimestamp 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | ------- Summary: start ------- 03:35:54 INFO - PROCESS | 15235 | Number of tests: 14 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.41 (3.0%) stddev-sans-first:0.88 03:35:54 INFO - PROCESS | 15235 | Values: 103.0 115.0 112.0 113.0 114.0 113.0 113.0 114.0 113.0 114.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:159.00 stddev:25.71 (16.2%) stddev-sans-first:27.03 03:35:54 INFO - PROCESS | 15235 | Values: 165.0 130.0 137.0 194.0 134.0 162.0 156.0 133.0 202.0 141.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:35:54 INFO - PROCESS | 15235 | Values: 162.0 162.0 162.0 162.0 163.0 161.0 162.0 163.0 161.0 161.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:14.18 (18.7%) stddev-sans-first:14.87 03:35:54 INFO - PROCESS | 15235 | Values: 76.0 76.0 76.0 116.0 76.0 77.0 74.0 75.0 100.0 75.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:19.46 (22.9%) stddev-sans-first:20.19 03:35:54 INFO - PROCESS | 15235 | Values: 86.0 87.0 119.0 85.0 85.0 86.0 125.0 85.0 85.0 132.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:35:54 INFO - PROCESS | 15235 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 03:35:54 INFO - PROCESS | 15235 | Values: 147.0 146.0 146.0 146.0 145.0 145.0 146.0 147.0 146.0 146.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:35:54 INFO - PROCESS | 15235 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 03:35:54 INFO - PROCESS | 15235 | Values: 64.0 63.0 64.0 64.0 63.0 65.0 63.0 63.0 62.0 62.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 03:35:54 INFO - PROCESS | 15235 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:4.62 (5.5%) stddev-sans-first:4.74 03:35:54 INFO - PROCESS | 15235 | Values: 82.0 84.0 89.0 83.0 82.0 86.0 83.0 84.0 97.0 83.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:137.00 stddev:6.98 (5.1%) stddev-sans-first:7.40 03:35:54 INFO - PROCESS | 15235 | Values: 136.0 132.0 132.0 130.0 138.0 133.0 138.0 140.0 154.0 132.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.50 stddev:2.39 (1.4%) stddev-sans-first:2.52 03:35:54 INFO - PROCESS | 15235 | Values: 168.0 171.0 171.0 167.0 165.0 165.0 167.0 166.0 164.0 168.0 03:35:54 INFO - PROCESS | 15235 | 03:35:54 INFO - PROCESS | 15235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.62 03:35:54 INFO - PROCESS | 15235 | Values: 66.0 67.0 67.0 70.0 66.0 65.0 68.0 68.0 65.0 66.0 03:35:54 INFO - PROCESS | 15235 | -------- Summary: end -------- 03:35:54 INFO - PROCESS | 15235 | 03:35:55 INFO - TEST-INFO | 15235: exit 0 03:35:55 INFO - TEST-OK | kraken | took 63523ms 03:35:55 INFO - SUITE-END | took 1183s 03:35:55 INFO - Completed test suite (00:19:43) 03:35:55 INFO - javascript benchmark 03:35:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.6412184355113, 2668.8799004044818, 2696.487667343204, 2714.063648041425, 2718.225305787851, 4729.668923175371, 4789.161896668083, 4811.2302031674935, 4878.0975519528865, 4909.386326709161, 4852.9514704852945, 4861.416630004404, 4876.049170411762, 4949.28235405866, 4953.752312384385, 4385.276429389147, 4432.601065904068, 4456.086502267044, 4503.954960450403, 4580.038191979672, 4479.820807167709, 4490.057088011522, 4527.253003254459, 4533.909321813562, 4551.089782043588, 4338.370936214263, 4387.122575484916, 4388.385626012361, 4428.822847086113, 4460.442444694413, 4396.516383197845, 4399.670024748125, 4423.093265880487, 4458.687891847572, 4466.240739074366, 4423.535528769465, 4444.533324000998, 4459.977700111479, 4490.8877278067985, 4501.23479008566, 4785.880352991168, 4800.0, 4860.198067318888, 4865.5134486551415, 4868.561829435368, 5168.638195326329, 5192.92210616841, 5230.633855630107, 5245.239440281138, 5252.737363131828, 5191.558717509016, 5240.161574148118, 5243.632945693803, 5262.0, 5273.235380869753, 4637.443506779175, 4751.4535828379485, 4878.634102442331, 4881.365422495124, 4952.678075925053, 5405.054115529845, 5441.129419292894, 5443.891122177534, 5446.291982042309, 5448.101063324507, 4976.0, 5180.0, 5183.326167598264, 5204.0632686116105, 5210.505002024802, 5232.2674825524455, 5243.659162154448, 5248.160294352885, 5296.09966305729, 5322.467753224724, 5212.973935130376, 5216.295800067019, 5222.4255331913455, 5238.2404551340605, 5272.894542109137, 4990.6257030722845, 5097.770600322994, 5207.557357624644, 5235.8429247121885, 5238.2404551340605, 4474.26174681174, 4491.30384790358, 4501.0547784964865, 4537.319402089647, 4539.795709193094, 3845.538535375773, 3879.3405121129476, 3895.3962135868987, 3903.8243279052513, 3925.4700615417123, 4454.910901781946, 4474.172278128557, 4492.348609451677, 4556.544345565483, 4598.195315819718, 5159.922601160911, 5233.110371236899, 5253.579713622901, 5261.631685782035, 5306.363236411578, 4508.0, 4516.254817955067, 4523.615492683159, 4529.433820772403, 4569.200389931815, 4618.861434156981, 4642.16441040616, 4682.993156471375, 4712.458067322234, 4754.690945088558, 4898.485659005895, 4915.115279249626, 4917.360743103373, 4958.256261560723, 4961.776720047678, 5192.324997750268, 5215.113430716711, 5243.737813109406, 5245.344331958505, 5260.18467137579, 4816.133096042606, 4869.123557759637, 4917.409910810726, 4931.137051015986, 4941.579965702956, 5175.715335656424, 5239.580833533232, 5240.68555886648, 5265.947340526545, 5284.920726189033, 5291.153415453509, 5295.205719142159, 5303.973480132575, 5304.336957880265, 5357.651752636066, 4763.833265835679, 4977.527134922177, 5104.4129925057605, 5119.74401279942, 5126.615503837153, 4927.211646136601, 4995.525425084611, 5004.049230646166, 5012.223105418666, 5057.949420505748, 4987.401511818605, 5050.116229659869, 5055.216441451581, 5069.1635880079375, 5074.974625126851, 4939.6542242042715, 5066.290719299374, 5113.181890897438, 5113.948860511496, 5141.768620412166, 5004.17431123875, 5016.448190698947, 5022.899542009212, 5029.597632189343, 5062.82280120194], "value": 4790.440835246062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.174689676052, 578.574747560543, 579.2325169150873, 582.595096407996, 594.7502049139363, 28117.437651246964, 40406.59593404065, 41528.37707434391, 41569.37645935313, 41675.791621041855, 41854.0, 42219.15561688764, 42491.57508424915, 42539.14921701572, 42609.0, 7571.545707257582, 7940.602969851513, 8061.596920153998, 8069.636866340999, 10268.0, 10215.693529194135, 10351.0, 10351.844722329133, 10360.067593916547, 10363.948180259089, 10337.37975721459, 10348.482575871214, 10361.637342693008, 10375.42935138567, 10389.740256493611, 7587.430942679293, 10185.694429167137, 10268.794624107513, 10422.374657520573, 10437.11284540815, 10268.075873171376, 10335.638252661121, 10338.53476593555, 10351.171906247557, 10359.378437293712, 38494.0, 38695.8065209675, 39085.0, 39104.60895391038, 39120.41319380183, 3076.8000079994727, 3158.4314823331792, 3763.8306276217636, 3807.9809600951817, 3812.1422679897078, 29106.854465727534, 29724.40551188964, 29781.255468613457, 29786.255343616365, 29806.10581682553, 3534.5581802274714, 3537.575490941078, 3722.8883133506038, 3804.258169656918, 3807.1053302473897, 261478.0, 263248.0, 263529.0, 263636.0, 264591.0, 47825.282620760714, 54453.183202251996, 56108.43891561032, 56625.0, 56733.14900276499, 57414.7129264351, 57558.13662795061, 57846.710766445896, 58156.709216453644, 58164.12753808696, 13383.397747101404, 13493.932530337286, 13518.459261629425, 13573.321333933462, 13584.049116561746, 8689.435186712843, 8809.867851982226, 8828.38201325901, 9096.681616143404, 9316.580753866092, 17664.381746638806, 17737.290508379778, 17759.733603995952, 17762.733558996624, 17805.287788488575, 5815.3021637402935, 5981.940180598225, 6034.6982650867285, 6034.818955431344, 6046.758129674852, 824.4558591329813, 940.8823897012874, 941.8210539997378, 1006.4213077480332, 1020.336781092296, 27075.1877443677, 28026.85986570095, 28254.0, 28306.85846570754, 28595.71404285972, 882.188386684252, 892.3530440430636, 892.8705337726124, 902.9976725834318, 921.4287141971886, 13983.580492585239, 14480.565583032527, 14594.197319147548, 14598.467160947948, 14729.631759206106, 186683.0, 187462.06268968567, 187838.0, 188075.0, 188143.65209913586, 50120.74939625279, 50237.24644130341, 50261.49738502568, 50284.74857625688, 50475.74762126166, 1074.2694967422228, 1190.3274649822822, 1220.341015851448, 1241.6399244219256, 1241.7951038078616, 27791.583126252717, 29024.274393140342, 29032.419351613273, 29259.7074029257, 29278.70721292845, 42615.14769704651, 43260.35109473298, 43352.78323608362, 43404.0, 43418.78290608527, 289022.0, 296116.0, 297961.0, 298068.0, 298350.0, 22808.885955570116, 24851.87574062118, 25521.48957020886, 25565.616515752652, 25992.220233392272, 42333.153336933705, 42836.357454638826, 43381.56618433775, 43785.78107109444, 43873.12253754971, 35334.0, 36383.636163638024, 36736.448953266256, 36930.0, 37042.629573704995, 36219.0, 36458.27083458369, 36528.0, 36628.45057324089, 36851.8157409222, 35548.0, 36917.0, 37980.62019379771, 38086.80956595199, 40599.1880162401, 31469.0, 33538.83230583832, 34145.48781768226, 34652.65347346494, 34846.12884677802, 25397.0, 25873.482530349665, 25926.87036564805, 25941.610875837254, 25952.351191219615], "value": 17745.407309055456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.37961414630496, 374.597307894014, 379.39675915294674, 386.83559487217946, 388.86584128475664, 16440.83559164408, 16892.915535422322, 17339.393121240726, 17355.91322043391, 18133.818661813377, 10613.41626210558, 11127.554897804099, 11166.553337866475, 11221.326720396783, 11255.324680519174, 4510.097980403916, 4729.408823897013, 4998.525140111684, 5630.239917611131, 5645.463680950304, 5450.073487507114, 5453.672779633215, 5461.836144915659, 5461.890762184754, 5553.611597100725, 5484.0, 5609.80365687201, 6018.608790428608, 6026.939730602704, 6027.156198132265, 5649.745761440745, 6049.939500604982, 6068.180795592582, 6068.302145253286, 6091.390860913917, 5370.516653501204, 5408.215808707715, 5409.107497262947, 5415.6479828811, 5443.292371991655, 12020.0, 12092.153549251556, 12111.454984525717, 12807.29559874216, 12811.615651530468, 1926.8362189213933, 1962.5584243545231, 1973.2304401283511, 2003.3689387842783, 2050.4258807533915, 8840.911590884138, 9008.729738107802, 9115.361924665276, 9370.67202647911, 9498.715038548855, 1833.193394906237, 1882.105999650169, 1934.1199754111844, 1938.195648805744, 1988.0854806788896, 64422.0, 64894.3510564893, 67092.0, 67131.0, 67704.0, 9847.60609575609, 9861.950690246504, 10061.195104391778, 10178.847317290247, 10183.898161018444, 13888.4444622216, 13972.860271397156, 13979.720405591832, 13993.3702983366, 14004.089734167246, 6651.767188148391, 6716.529842910949, 6717.899231511531, 6767.1879374475375, 7054.894176587355, 6304.401081897213, 6417.326180751047, 6428.967855160694, 6479.1901012373455, 6679.398854103154, 3975.860844870416, 4185.811638476276, 4263.59495847894, 4463.933041004388, 4587.9541204588195, 1764.214924358648, 1845.6954602490707, 1846.9722954155698, 1884.44408899375, 1906.027261784047, 656.701200953565, 754.3663322808757, 773.6595897804948, 779.1585088104946, 807.7092246791151, 15372.538823835303, 15839.841601584067, 15921.522354329389, 16056.839431605535, 16327.510174694778, 703.6411430170548, 713.5468977199515, 756.8221467955026, 779.4738551477843, 788.731831177391, 8524.616392262364, 8759.39980417601, 9035.774105647411, 9197.218236449977, 9352.485613291334, 369927.0, 376353.0, 377091.0, 381975.0, 383114.0, 50972.490275097516, 71314.64342678254, 72088.63955680188, 72227.63886180536, 79016.0, 814.267159556404, 900.9054049324726, 912.2610685344891, 935.2471260635118, 941.6252271683283, 14580.708385832437, 15176.392944282105, 16396.508104756875, 16579.253933572778, 16710.66578668444, 33473.163170920925, 35477.645223547435, 37367.6263237375, 38365.0, 39486.80256598699, 51194.48805511897, 51732.0, 52030.0, 52082.21876671777, 53523.19715204197, 6137.754489820536, 6313.589616674902, 6869.107016087876, 7597.544147351176, 7982.8802567960365, 10208.642697505551, 11258.774824503627, 11299.943500282447, 11306.152038596974, 11424.885751142383, 9200.0, 9205.861912071457, 9398.2951278653, 9493.430394176372, 9842.409455432697, 9695.66065187715, 9756.85364719544, 9810.75473113178, 9906.801863962537, 9983.05161009732, 9489.952550237205, 9664.420134791935, 9718.951405242928, 9782.657606983721, 9859.0, 6805.2854450283985, 6841.555298905555, 6916.239213686591, 6933.965330173317, 7094.964525177341, 9677.758056048655, 9749.512524373895, 9769.609215631295, 9794.363366381162, 9811.844048046461], "value": 7824.076688554174, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.6296111166648, 1398.8391334996475, 1435.3110506956662, 1514.7955026071477, 1723.5691077230692, 6709.966450167748, 7749.457537972337, 7992.0, 7999.560024198667, 8254.66981320748, 8065.4354195206215, 8086.191380861911, 8136.552489613069, 8147.796305092361, 8160.061592916816, 2232.174095584636, 2260.3106052653934, 2262.954740905181, 2263.106073101124, 2263.660450932357, 2204.9228277010307, 2229.108356657342, 2229.6766968789516, 2231.4532939429864, 2231.85492942959, 2168.035224325176, 2178.16140785797, 2194.1113848891223, 2200.867947923122, 2217.8558393704357, 2129.4943946244216, 2145.045454772619, 2147.3450597567735, 2152.9354119376444, 2155.5581105873257, 2159.0931808640407, 2160.805527502532, 2161.9567608647894, 2167.5773224221284, 2169.316665250441, 7896.842063158705, 8083.43415960883, 8140.0, 8143.063547692032, 8146.674133034671, 4552.658550608685, 4664.650151238637, 4725.503822098699, 4728.6453515986095, 4735.526447355272, 2752.8898844046216, 2882.654081510211, 2962.274242810504, 2974.048304542547, 2976.880924763007, 943.2218419803621, 946.8532377481501, 955.6511873166314, 961.5528779117744, 961.7884065505577, 10758.838617420744, 11019.504122314514, 11021.173411994052, 11040.447977601088, 11064.225504214708, 4327.545607711208, 4386.232409328355, 4494.07871386365, 4515.525869783691, 4515.864524064284, 9420.95289523548, 9502.90497095034, 9503.334766566411, 9515.191208747196, 9525.333226674205, 4840.273958906192, 4908.533689299511, 4910.582600478928, 4911.68074075184, 4915.238138088602, 3566.7324950628285, 3805.9048523786573, 4223.535411104776, 4421.9336709949375, 4458.398116254329, 3726.347889119393, 3849.517935594816, 3908.3160446921675, 3936.271789718854, 3939.2712348215673, 1235.9073069519823, 1247.6756043428775, 1254.861965183829, 1259.123905380994, 1277.6167149855007, 830.2942498875907, 844.5903736687701, 859.2009431228892, 861.0657436681271, 886.9866951995725, 5115.56517696, 5479.669316627309, 5593.720313984284, 5594.272744543184, 5607.775688972395, 403.76178054947724, 417.09490405819446, 417.47856827658796, 419.83626385709596, 420.61093488522994, 3673.4673472346894, 3753.5871054184017, 3823.4264860271182, 3844.788536630512, 3869.129445874712, 9152.90847091534, 9621.615135394646, 9624.566894489764, 9689.41863488193, 9972.950135249277, 9765.658201962897, 9788.510574471247, 9807.117359437685, 9855.655052073143, 9855.852162217572, 7350.52221605594, 7367.336939675455, 7613.695452181851, 7616.69533218665, 7629.694812207561, 5731.340895797037, 5864.354920958776, 5889.617174883619, 5945.970270148621, 6005.309389420273, 9212.49331286759, 9338.159565639126, 9360.20438262728, 9361.204297634777, 9371.344005919793, 9170.174684278447, 9253.67612133572, 9617.519124043909, 9627.855582166134, 9628.18160456341, 6235.875282494416, 6396.232452105777, 6421.389967953037, 6529.053287273414, 6530.902036469552, 7348.889766653398, 7519.060117485315, 7545.207753185837, 7719.691212351443, 7725.845483090195, 6535.085088087767, 6719.697613607302, 6781.525293229624, 6954.165500140016, 6969.059177011039, 6683.866322673616, 6758.2565917748025, 6795.592264464148, 6889.311068893071, 6916.377526022682, 6217.378262173746, 6220.657863817533, 6233.844153896189, 6374.872502550016, 6375.713092910737, 4311.805968731477, 4416.315471101984, 4422.911541769082, 4484.730916144911, 4506.842260520866, 4350.195213885441, 4356.629686476685, 4477.171723231213, 4488.349189367589, 4562.65780066503], "value": 4144.656063530365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4633951566213, 309.95195744659577, 312.39551467909587, 315.68904628940504, 321.8165645582018, 4727.196376615975, 4849.127157111719, 4921.434035085967, 4948.777305021269, 4954.232094025428, 4748.738819364934, 4898.779554920028, 4914.11545921734, 4921.261810728392, 4928.250471082768, 3833.5783063862955, 3834.482344883433, 3838.865639702611, 3843.693783729768, 3882.320593896071, 3660.7803531788177, 3710.5361829771277, 3877.0, 3893.8637147699837, 3899.8495443843995, 3833.386658134699, 3834.424836274567, 3843.327417701905, 3854.2869569129803, 3860.4595356650093, 3772.622737726233, 3829.119302560413, 3837.7889216093104, 3840.7311488195837, 3869.941950870739, 3442.122258823984, 3454.0, 3458.515807786912, 3458.7405944554007, 3460.3079384123275, 4685.6485763567525, 4810.663253572251, 4830.178869592178, 4838.733869637169, 4838.975805120987, 4310.762908040057, 4321.854708502218, 4332.913341733148, 4342.41501851825, 4355.760433176174, 4891.804327826882, 5063.3417655704525, 5081.237814327844, 5083.440821509668, 5096.770645320932, 3623.4564815277654, 3637.0907273181706, 3643.544556930384, 3652.652997965189, 3655.5796083450214, 5328.893422131575, 5373.38206106295, 5385.138377859563, 5422.969635769191, 5429.728513574345, 3711.1278849470355, 3734.3278209922473, 3746.9625303747157, 3756.2111956489443, 3769.095417099876, 3604.7830584191056, 3800.9429858552144, 3805.1058001369656, 3832.620256707583, 3846.3845784674318, 4301.161273551627, 4302.698811083257, 4303.505096913832, 4306.440162778818, 4308.547602501692, 5105.540501354822, 5140.640155189101, 5148.871278218075, 5162.92255616166, 5167.250748641426, 1196.5393323570488, 1240.460399726122, 1286.9420876060599, 1304.7390521895659, 1309.561296965508, 827.8137419080658, 829.2578142562373, 840.9369297302727, 859.6518410043942, 865.7619154732373, 4084.8366065357054, 4086.6730661547003, 4093.529244136903, 4103.179364127127, 4115.855945041909, 4687.273472611751, 4706.7411292378565, 4711.693739906895, 4732.6687131900435, 4735.431748190171, 4035.7982100894837, 4092.324766413568, 4110.479122724611, 4116.727201874517, 4140.523839758466, 2405.9639105413435, 2469.876506174684, 2493.962590561143, 2507.8244522883224, 2516.3709072731817, 4402.713823601455, 4442.533533978885, 4446.19889469632, 4459.44256967879, 4473.7986790594505, 4756.21522448799, 4768.188088526338, 4771.6898401603785, 4802.039592081597, 4831.4685384607665, 4220.599043090901, 4431.6261958792875, 4446.6220371268155, 4523.683342166017, 4540.568645978561, 4623.826801403335, 4727.432708075053, 4765.690230135169, 4785.49752276006, 4799.640026997919, 4661.370714953574, 4662.836800711959, 4680.355599086505, 4684.360473834131, 4690.953090469052, 4285.6785741068925, 4428.490723566831, 4435.780160455901, 4497.123061003073, 4501.819927202875, 3375.291188850369, 3387.491876218587, 3430.1939044325063, 3431.69114779671, 3462.7402944779747, 5074.289599456153, 5085.516875896784, 5251.842444726664, 5294.602904782234, 5313.0, 5071.39143302806, 5095.898082038264, 5105.7191854448365, 5118.616103792305, 5148.794048238028, 4766.833160839354, 5021.744563859035, 5040.0, 5088.796448142181, 5100.6429549931145, 5096.923546146737, 5125.564327032095, 5129.0, 5134.4352121267375, 5138.4604616514725, 5228.63399562027, 5228.712420816892, 5229.581633469389, 5234.319538459976, 5245.449227831023, 4810.63920205979, 5115.641905066758, 5140.100482415488, 5174.404943431554, 5174.508421699932], "value": 3743.034511759874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5603899251031, 635.965021923794, 714.1180641907243, 743.3569961982886, 762.6644276518333, 11554.30674159551, 12319.630411087659, 12677.0, 12692.428840702167, 12698.682532936682, 12111.636650900466, 12152.817707734392, 12272.447739851707, 12291.078169137305, 12292.508299668025, 620.8882401167788, 743.6133210730417, 770.7957391291299, 784.0434669702953, 786.7521730654854, 786.0959896119451, 796.2037962037962, 797.1470526536608, 798.5767543202112, 798.7763426240633, 826.5123577089516, 830.983380332393, 831.8377916306323, 831.8669012957897, 832.1096426823301, 650.5023656902473, 792.7661339904741, 819.3035919468464, 826.1531929771971, 826.3926014379426, 587.9500242479394, 591.136940067502, 593.7832691067772, 593.9584229103964, 594.7472324262214, 10564.418956957365, 10566.207534434949, 10573.995470430375, 10580.0, 10606.204534659932, 13129.60611181666, 13542.661433464242, 13667.972184477596, 13773.104748191336, 13870.930645346809, 9693.70918872435, 9904.702858914172, 10006.149477294439, 10038.247131465168, 10130.341527800669, 3309.1396236978317, 3434.9484757728655, 3441.328940856534, 3483.3207524532727, 3608.278344331144, 51543.226851597254, 51742.0, 51813.481865181246, 53081.46918530804, 53362.46637533614, 10494.160467162608, 10503.611457036115, 10510.789784204273, 10568.682939511673, 10674.412907290174, 19255.51861203453, 19280.132394042022, 19296.22815087409, 19343.8065619342, 19350.612987740165, 6977.197622273402, 7224.060872086595, 7236.0, 7265.382442492447, 7291.8906216406795, 3649.878022726007, 3719.8698045568276, 3755.887323380303, 3792.994856363011, 3796.772193668389, 3040.9087727367773, 3127.2807254331633, 3179.078067360486, 3181.0456862941023, 3191.824449655291, 499.48802477460896, 501.0555103629612, 504.9774207230388, 532.808189051941, 545.0706545340186, 440.92724700424714, 474.48281373303263, 498.32476993673777, 516.2462804305756, 572.985675358111, 7086.0, 7461.515001524884, 7636.274553917369, 7726.536407815549, 7774.2614451627005, 497.1672448648499, 520.7630528109701, 521.817363922624, 535.4966331648238, 588.9381614930456, 3401.795892246473, 3406.5230867678547, 3413.4879768034994, 3456.5679290088738, 3543.326767914088, 52167.73916130395, 52268.47731522636, 53562.464375356525, 55783.0, 94178.0, 47206.291905621445, 47730.28404573934, 55181.0, 77537.0, 81732.0, 55746.88506229853, 60749.39250607437, 62314.899063121506, 69958.0, 71513.0, 7806.946062281747, 7853.7251196210145, 8030.397720170894, 8061.87907181381, 8517.148285171434, 40793.79603101966, 40859.59140408558, 41529.58470415378, 41848.37227441652, 43489.56510434855, 57937.0, 60806.0, 62460.0, 62508.37491625026, 63444.682776585825, 11103.16726245551, 11107.44462776874, 11216.327020378803, 11330.0, 11382.430878456209, 12230.938845305716, 12476.500939962663, 12657.493700251887, 13217.40521676546, 13354.93322533381, 10536.15710743154, 10682.57269709203, 10691.251612387057, 10797.784044318912, 10858.185636077484, 12306.384680765746, 12426.0, 12544.749105017667, 12577.496900123893, 12955.417006234553, 10324.48377581103, 10481.0, 10731.946340268249, 10830.837537437103, 11434.318890227936, 9725.4650994196, 9964.402135871871, 10349.327293725884, 10485.056344928993, 10517.21120915919, 8909.0, 9685.806283874424, 9829.803403932025, 9896.802063958536, 9906.0], "value": 6229.664158520929, "unit": "score"}], "name": "dromaeo_css", "value": 6329.26812497352, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 112.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 130.0, 137.0, 194.0, 134.0, 162.0, 156.0, 133.0, 202.0, 141.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 163.0, 161.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 116.0, 76.0, 77.0, 74.0, 75.0, 100.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 119.0, 85.0, 85.0, 86.0, 125.0, 85.0, 85.0, 132.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 65.0, 63.0, 63.0, 62.0, 62.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 89.0, 83.0, 82.0, 86.0, 83.0, 84.0, 97.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 132.0, 130.0, 138.0, 133.0, 138.0, 140.0, 154.0, 132.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 171.0, 167.0, 165.0, 165.0, 167.0, 166.0, 164.0, 168.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 70.0, 66.0, 65.0, 68.0, 68.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1551.1, "alertThreshold": 2.0}]} 03:35:55 INFO - Return code: 0 03:35:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:35:55 INFO - # TBPL SUCCESS # 03:35:55 INFO - Running post-action listener: _resource_record_post_action 03:35:55 INFO - ##### 03:35:55 INFO - ##### Finished run-tests step (success) 03:35:55 INFO - ##### 03:35:55 INFO - Running post-run listener: _resource_record_post_run 03:35:55 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360943616; Read time: 12; Write time: 187200 03:35:55 INFO - TinderboxPrint: CPU usage
13.2% 03:35:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:35:55 INFO - TinderboxPrint: I/O write bytes / time
360,943,616 / 187,200 03:35:55 INFO - TinderboxPrint: CPU idle
8,315.1 (86.8%) 03:35:55 INFO - TinderboxPrint: CPU user
1,224.8 (12.8%) 03:35:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:35:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 46989312; Read time: 0; Write time: 24512 03:35:55 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283545600; Read time: 12; Write time: 154436 03:35:56 INFO - Running post-run listener: _upload_blobber_files 03:35:56 INFO - Blob upload gear active. 03:35:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:35:56 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 03:35:56 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:35:56 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:35:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:00 INFO - (blobuploader) - INFO - Done attempting. 03:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:00 INFO - (blobuploader) - INFO - Done attempting. 03:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:01 INFO - (blobuploader) - INFO - Done attempting. 03:36:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:01 INFO - Return code: 0 03:36:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/542a8c60b565bf566d8d15850efc6bab737573d81d9ad07bd24ec38723974a8b90dfd5451868f7ab3ec1d94b760db9ab13e48c1882fb1f6106d9340b18564f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b0ed39a9533ccda5e79e5344d5150b13c7280040483d4013270b34f7336a53a8cf0a4fddff071e13509bb2f21a1754d7359071c914f18a1afe3a50af2b74f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/985d051c8003b38176ffc7e7cb0b5455aa1a157e6c1dc4f63308bd73e9413144d5ed84243a2b1ff153256e0dcf5189e13fd1017b5ffff7c6ca9b9325bb751615"} 03:36:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:01 INFO - Contents: 03:36:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/542a8c60b565bf566d8d15850efc6bab737573d81d9ad07bd24ec38723974a8b90dfd5451868f7ab3ec1d94b760db9ab13e48c1882fb1f6106d9340b18564f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b0ed39a9533ccda5e79e5344d5150b13c7280040483d4013270b34f7336a53a8cf0a4fddff071e13509bb2f21a1754d7359071c914f18a1afe3a50af2b74f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/985d051c8003b38176ffc7e7cb0b5455aa1a157e6c1dc4f63308bd73e9413144d5ed84243a2b1ff153256e0dcf5189e13fd1017b5ffff7c6ca9b9325bb751615"} 03:36:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:01 INFO - Copying logs to upload dir... 03:36:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.907771 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-28 03:36:00.812541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 03:36:00.816515) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/542a8c60b565bf566d8d15850efc6bab737573d81d9ad07bd24ec38723974a8b90dfd5451868f7ab3ec1d94b760db9ab13e48c1882fb1f6106d9340b18564f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b0ed39a9533ccda5e79e5344d5150b13c7280040483d4013270b34f7336a53a8cf0a4fddff071e13509bb2f21a1754d7359071c914f18a1afe3a50af2b74f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/985d051c8003b38176ffc7e7cb0b5455aa1a157e6c1dc4f63308bd73e9413144d5ed84243a2b1ff153256e0dcf5189e13fd1017b5ffff7c6ca9b9325bb751615"} build_url:https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/RptZXLgOTcaUiEyUA6G23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/542a8c60b565bf566d8d15850efc6bab737573d81d9ad07bd24ec38723974a8b90dfd5451868f7ab3ec1d94b760db9ab13e48c1882fb1f6106d9340b18564f34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/306b0ed39a9533ccda5e79e5344d5150b13c7280040483d4013270b34f7336a53a8cf0a4fddff071e13509bb2f21a1754d7359071c914f18a1afe3a50af2b74f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/985d051c8003b38176ffc7e7cb0b5455aa1a157e6c1dc4f63308bd73e9413144d5ed84243a2b1ff153256e0dcf5189e13fd1017b5ffff7c6ca9b9325bb751615"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 03:36:00.844277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:36:00.844620) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467108887.396854-1069410637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:36:00.894423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 03:36:00.894830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 03:36:00.895248) ========= ========= Total master_lag: 0.13 =========