builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1468374258.86 results: success (0) buildid: 20160712154725 builduid: c0c60fe5ab4d43c5b5f7a97b97864a74 revision: 1609e0acfe66720db5ac91b5cb5748f3c27a9468 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:18.856234) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:18.856882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:18.857173) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:18.872400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:18.872715) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 18:44:19-- 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-07-12 18:44:19 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:18.985590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:18.986132) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014663 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:19.039568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:19.040439) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1609e0acfe66720db5ac91b5cb5748f3c27a9468 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1609e0acfe66720db5ac91b5cb5748f3c27a9468 --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=9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 18:44:19,542 truncating revision to first 12 chars 2016-07-12 18:44:19,542 Setting DEBUG logging. 2016-07-12 18:44:19,542 attempt 1/10 2016-07-12 18:44:19,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1609e0acfe66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 18:44:19,866 unpacking tar archive at: mozilla-aurora-1609e0acfe66/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:19.754984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:19.755375) ========= script_repo_revision: 1609e0acfe66720db5ac91b5cb5748f3c27a9468 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:19.756307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:19.756647) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:44:19.768175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-12 18:44:19.768625) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:44:20 INFO - MultiFileLogger online at 20160712 18:44:20 in /builds/slave/test 18:44:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:44:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:44:20 INFO - {'append_to_log': False, 18:44:20 INFO - 'base_work_dir': '/builds/slave/test', 18:44:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:44:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:44:20 INFO - 'branch': 'Mozilla-Aurora', 18:44:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:20 INFO - 'config_files': ('talos/linux_config.py',), 18:44:20 INFO - 'default_actions': ('clobber', 18:44:20 INFO - 'read-buildbot-config', 18:44:20 INFO - 'download-and-extract', 18:44:20 INFO - 'populate-webroot', 18:44:20 INFO - 'create-virtualenv', 18:44:20 INFO - 'install', 18:44:20 INFO - 'run-tests'), 18:44:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:20 INFO - 'download_minidump_stackwalk': True, 18:44:20 INFO - 'download_symbols': 'ondemand', 18:44:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:20 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:20 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:20 INFO - 'installer_path': 'installer.exe', 18:44:20 INFO - 'log_level': 'info', 18:44:20 INFO - 'log_name': 'talos', 18:44:20 INFO - 'log_to_console': True, 18:44:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:44:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:44:20 INFO - 'opt_config_files': (), 18:44:20 INFO - 'pip_index': False, 18:44:20 INFO - 'sps_profile': False, 18:44:20 INFO - 'sps_profile_interval': 0, 18:44:20 INFO - 'suite': 'dromaeojs-e10s', 18:44:20 INFO - 'system_bits': '32', 18:44:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:20 INFO - 'title': 'talos-linux64-ix-029', 18:44:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:20 INFO - 'use_talos_json': True, 18:44:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:44:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:20 INFO - 'work_dir': 'build'} 18:44:20 INFO - ##### 18:44:20 INFO - ##### Running clobber step. 18:44:20 INFO - ##### 18:44:20 INFO - Running pre-action listener: _resource_record_pre_action 18:44:20 INFO - Running main action method: clobber 18:44:20 INFO - rmtree: /builds/slave/test/build 18:44:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:44:20 INFO - Running post-action listener: _resource_record_post_action 18:44:20 INFO - ##### 18:44:20 INFO - ##### Finished clobber step (success) 18:44:20 INFO - ##### 18:44:20 INFO - ##### 18:44:20 INFO - ##### Running read-buildbot-config step. 18:44:20 INFO - ##### 18:44:20 INFO - Running pre-action listener: _resource_record_pre_action 18:44:20 INFO - Running main action method: read_buildbot_config 18:44:20 INFO - Using buildbot properties: 18:44:20 INFO - { 18:44:20 INFO - "project": "", 18:44:20 INFO - "product": "firefox", 18:44:20 INFO - "script_repo_revision": "production", 18:44:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:44:20 INFO - "repository": "", 18:44:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:44:20 INFO - "buildid": "20160712154725", 18:44:20 INFO - "pgo_build": "True", 18:44:20 INFO - "basedir": "/builds/slave/test", 18:44:20 INFO - "buildnumber": 395, 18:44:20 INFO - "slavename": "talos-linux64-ix-029", 18:44:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:44:20 INFO - "platform": "ubuntu64_hw", 18:44:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:44:20 INFO - "branch": "mozilla-aurora", 18:44:20 INFO - "repo_path": "releases/mozilla-aurora", 18:44:20 INFO - "revision": "1609e0acfe66720db5ac91b5cb5748f3c27a9468", 18:44:20 INFO - "stage_platform": "linux64-pgo", 18:44:20 INFO - "builduid": "c0c60fe5ab4d43c5b5f7a97b97864a74", 18:44:20 INFO - "slavebuilddir": "test" 18:44:20 INFO - } 18:44:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 18:44:20 INFO - Running post-action listener: _resource_record_post_action 18:44:20 INFO - ##### 18:44:20 INFO - ##### Finished read-buildbot-config step (success) 18:44:20 INFO - ##### 18:44:20 INFO - ##### 18:44:20 INFO - ##### Running download-and-extract step. 18:44:20 INFO - ##### 18:44:20 INFO - Running pre-action listener: _resource_record_pre_action 18:44:20 INFO - Running main action method: download_and_extract 18:44:20 INFO - mkdir: /builds/slave/test/build/tests 18:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:20 INFO - https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:44:26 INFO - Downloaded 1361 bytes. 18:44:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:44:26 INFO - Using the following test package requirements: 18:44:26 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:44:26 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:44:26 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:44:26 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'jsshell-linux-x86_64.zip'], 18:44:26 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:44:26 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:44:26 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:44:26 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:44:26 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:44:26 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:44:26 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:44:26 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')]} 18:44:26 INFO - https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:44:28 INFO - Downloaded 24528244 bytes. 18:44:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:44:29 INFO - Return code: 0 18:44:29 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:29 INFO - https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:44:31 INFO - Downloaded 24528244 bytes. 18:44:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:44:33 INFO - Return code: 0 18:44:33 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')]} 18:44:33 INFO - https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:44:34 INFO - Downloaded 10833369 bytes. 18:44:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:44:34 INFO - Return code: 0 18:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:34 INFO - https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:44:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:44:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:44:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:44:35 INFO - Downloaded 63632512 bytes. 18:44:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:44:35 INFO - mkdir: /builds/slave/test/properties 18:44:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:44:35 INFO - Writing to file /builds/slave/test/properties/build_url 18:44:35 INFO - Contents: 18:44:35 INFO - build_url:https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:44:36 INFO - Running post-action listener: _resource_record_post_action 18:44:36 INFO - Running post-action listener: set_extra_try_arguments 18:44:36 INFO - ##### 18:44:36 INFO - ##### Finished download-and-extract step (success) 18:44:36 INFO - ##### 18:44:36 INFO - ##### 18:44:36 INFO - ##### Running populate-webroot step. 18:44:36 INFO - ##### 18:44:36 INFO - Running pre-action listener: _resource_record_pre_action 18:44:36 INFO - Running main action method: populate_webroot 18:44:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:36 INFO - '--tppagecycles', 18:44:36 INFO - '7'], 18:44:36 INFO - 'tests': ['tsvgm']}}, 18:44:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:44:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:44:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['damp', 'tps']}, 18:44:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'tests': ['damp', 'tps']}, 18:44:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['dromaeo_dom']}, 18:44:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['a11yr', 18:44:36 INFO - 'ts_paint', 18:44:36 INFO - 'tpaint', 18:44:36 INFO - 'sessionrestore', 18:44:36 INFO - 'sessionrestore_no_auto_restore', 18:44:36 INFO - 'tabpaint']}, 18:44:36 INFO - 'other-e10s': {'tests': ['a11yr', 18:44:36 INFO - 'ts_paint', 18:44:36 INFO - 'tpaint', 18:44:36 INFO - 'sessionrestore', 18:44:36 INFO - 'sessionrestore_no_auto_restore', 18:44:36 INFO - 'tabpaint']}, 18:44:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:44:36 INFO - 'ts_paint', 18:44:36 INFO - 'tpaint', 18:44:36 INFO - 'sessionrestore', 18:44:36 INFO - 'sessionrestore_no_auto_restore', 18:44:36 INFO - 'tabpaint']}, 18:44:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:44:36 INFO - 'ts_paint', 18:44:36 INFO - 'tpaint', 18:44:36 INFO - 'sessionrestore', 18:44:36 INFO - 'sessionrestore_no_auto_restore', 18:44:36 INFO - 'tabpaint']}, 18:44:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['a11yr', 18:44:36 INFO - 'ts_paint', 18:44:36 INFO - 'tpaint', 18:44:36 INFO - 'sessionrestore', 18:44:36 INFO - 'sessionrestore_no_auto_restore', 18:44:36 INFO - 'tabpaint']}, 18:44:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['a11yr', 18:44:36 INFO - 'ts_paint', 18:44:36 INFO - 'tpaint', 18:44:36 INFO - 'sessionrestore', 18:44:36 INFO - 'sessionrestore_no_auto_restore', 18:44:36 INFO - 'tabpaint']}, 18:44:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['tsvgx', 18:44:36 INFO - 'tsvgr_opacity', 18:44:36 INFO - 'tart', 18:44:36 INFO - 'tscrollx', 18:44:36 INFO - 'cart']}, 18:44:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:44:36 INFO - 'tsvgr_opacity', 18:44:36 INFO - 'tart', 18:44:36 INFO - 'tscrollx', 18:44:36 INFO - 'cart']}, 18:44:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'talos_options': ['--disable-e10s'], 18:44:36 INFO - 'tests': ['tp5o']}, 18:44:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'tests': ['tp5o']}, 18:44:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'talos_options': ['--disable-e10s', 18:44:36 INFO - '--xperf_path', 18:44:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:36 INFO - 'tests': ['tp5n']}, 18:44:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:36 INFO - 'talos_options': ['--xperf_path', 18:44:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:36 INFO - 'tests': ['tp5n']}}, 18:44:36 INFO - 'talos.zip': {'path': '', 18:44:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:36 INFO - Running post-action listener: _resource_record_post_action 18:44:36 INFO - ##### 18:44:36 INFO - ##### Finished populate-webroot step (success) 18:44:36 INFO - ##### 18:44:36 INFO - ##### 18:44:36 INFO - ##### Running create-virtualenv step. 18:44:36 INFO - ##### 18:44:36 INFO - Running pre-action listener: _resource_record_pre_action 18:44:36 INFO - Running main action method: create_virtualenv 18:44:36 INFO - Creating virtualenv /builds/slave/test/build/venv 18:44:36 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 18:44:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:44:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:36 INFO - Using real prefix '/usr' 18:44:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:44:37 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:39 INFO - Installing pip.................done. 18:44:39 INFO - Return code: 0 18:44:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:39 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:39 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 18:44:39 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 18:44:39 INFO - Using env: {'DISPLAY': ':0', 18:44:39 INFO - 'HOME': '/home/cltbld', 18:44:39 INFO - 'LANG': 'en_US.UTF-8', 18:44:39 INFO - 'LANGUAGE': 'en_US:en', 18:44:39 INFO - 'LOGNAME': 'cltbld', 18:44:39 INFO - 'MAIL': '/var/mail/cltbld', 18:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:39 INFO - 'MOZ_NO_REMOTE': '1', 18:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:39 INFO - 'NO_EM_RESTART': '1', 18:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:39 INFO - 'PWD': '/builds/slave/test', 18:44:39 INFO - 'SHELL': '/bin/bash', 18:44:39 INFO - 'SHLVL': '1', 18:44:39 INFO - 'TERM': 'linux', 18:44:39 INFO - 'TMOUT': '86400', 18:44:39 INFO - 'USER': 'cltbld', 18:44:39 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:39 INFO - '_': '/tools/buildbot/bin/python'} 18:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:39 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 18:44:39 INFO - Cleaning up... 18:44:39 INFO - Return code: 0 18:44:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:39 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:39 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 18:44:39 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 18:44:39 INFO - Using env: {'DISPLAY': ':0', 18:44:39 INFO - 'HOME': '/home/cltbld', 18:44:39 INFO - 'LANG': 'en_US.UTF-8', 18:44:39 INFO - 'LANGUAGE': 'en_US:en', 18:44:39 INFO - 'LOGNAME': 'cltbld', 18:44:39 INFO - 'MAIL': '/var/mail/cltbld', 18:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:39 INFO - 'MOZ_NO_REMOTE': '1', 18:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:39 INFO - 'NO_EM_RESTART': '1', 18:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:39 INFO - 'PWD': '/builds/slave/test', 18:44:39 INFO - 'SHELL': '/bin/bash', 18:44:39 INFO - 'SHLVL': '1', 18:44:39 INFO - 'TERM': 'linux', 18:44:39 INFO - 'TMOUT': '86400', 18:44:39 INFO - 'USER': 'cltbld', 18:44:39 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:39 INFO - '_': '/tools/buildbot/bin/python'} 18:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:39 INFO - Downloading/unpacking psutil>=3.1.1 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:41 INFO - Installing collected packages: psutil 18:44:41 INFO - Running setup.py install for psutil 18:44:41 INFO - building 'psutil._psutil_linux' extension 18:44:41 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 18:44:41 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 18:44:41 INFO - building 'psutil._psutil_posix' extension 18:44:41 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 18:44:41 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 18:44:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:41 INFO - Successfully installed psutil 18:44:41 INFO - Cleaning up... 18:44:42 INFO - Return code: 0 18:44:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:44:42 INFO - Using env: {'DISPLAY': ':0', 18:44:42 INFO - 'HOME': '/home/cltbld', 18:44:42 INFO - 'LANG': 'en_US.UTF-8', 18:44:42 INFO - 'LANGUAGE': 'en_US:en', 18:44:42 INFO - 'LOGNAME': 'cltbld', 18:44:42 INFO - 'MAIL': '/var/mail/cltbld', 18:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:42 INFO - 'MOZ_NO_REMOTE': '1', 18:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:42 INFO - 'NO_EM_RESTART': '1', 18:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:42 INFO - 'PWD': '/builds/slave/test', 18:44:42 INFO - 'SHELL': '/bin/bash', 18:44:42 INFO - 'SHLVL': '1', 18:44:42 INFO - 'TERM': 'linux', 18:44:42 INFO - 'TMOUT': '86400', 18:44:42 INFO - 'USER': 'cltbld', 18:44:42 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:42 INFO - '_': '/tools/buildbot/bin/python'} 18:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:44:44 INFO - Installing collected packages: mozsystemmonitor 18:44:44 INFO - Running setup.py install for mozsystemmonitor 18:44:44 INFO - Successfully installed mozsystemmonitor 18:44:44 INFO - Cleaning up... 18:44:44 INFO - Return code: 0 18:44:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:44:44 INFO - Using env: {'DISPLAY': ':0', 18:44:44 INFO - 'HOME': '/home/cltbld', 18:44:44 INFO - 'LANG': 'en_US.UTF-8', 18:44:44 INFO - 'LANGUAGE': 'en_US:en', 18:44:44 INFO - 'LOGNAME': 'cltbld', 18:44:44 INFO - 'MAIL': '/var/mail/cltbld', 18:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:44 INFO - 'MOZ_NO_REMOTE': '1', 18:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:44 INFO - 'NO_EM_RESTART': '1', 18:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:44 INFO - 'PWD': '/builds/slave/test', 18:44:44 INFO - 'SHELL': '/bin/bash', 18:44:44 INFO - 'SHLVL': '1', 18:44:44 INFO - 'TERM': 'linux', 18:44:44 INFO - 'TMOUT': '86400', 18:44:44 INFO - 'USER': 'cltbld', 18:44:44 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:44 INFO - '_': '/tools/buildbot/bin/python'} 18:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:44 INFO - Downloading/unpacking jsonschema==2.5.1 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:44 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 18:44:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:44:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:44:46 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 18:44:46 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 18:44:46 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 18:44:46 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 18:44:46 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 18:44:46 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 18:44:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:44:46 INFO - warning: no files found matching '*.txt' 18:44:46 INFO - no previously-included directories found matching 'build' 18:44:46 INFO - no previously-included directories found matching 'dist' 18:44:46 INFO - no previously-included directories found matching '.git*' 18:44:46 INFO - Installing collected packages: jsonschema, functools32 18:44:46 INFO - Running setup.py install for functools32 18:44:46 INFO - warning: no files found matching '*.txt' 18:44:46 INFO - no previously-included directories found matching 'build' 18:44:46 INFO - no previously-included directories found matching 'dist' 18:44:46 INFO - no previously-included directories found matching '.git*' 18:44:46 INFO - Successfully installed jsonschema functools32 18:44:46 INFO - Cleaning up... 18:44:46 INFO - Return code: 0 18:44:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:46 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:46 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 18:44:46 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 18:44:46 INFO - Using env: {'DISPLAY': ':0', 18:44:46 INFO - 'HOME': '/home/cltbld', 18:44:46 INFO - 'LANG': 'en_US.UTF-8', 18:44:46 INFO - 'LANGUAGE': 'en_US:en', 18:44:46 INFO - 'LOGNAME': 'cltbld', 18:44:46 INFO - 'MAIL': '/var/mail/cltbld', 18:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:46 INFO - 'MOZ_NO_REMOTE': '1', 18:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:46 INFO - 'NO_EM_RESTART': '1', 18:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:46 INFO - 'PWD': '/builds/slave/test', 18:44:46 INFO - 'SHELL': '/bin/bash', 18:44:46 INFO - 'SHLVL': '1', 18:44:46 INFO - 'TERM': 'linux', 18:44:46 INFO - 'TMOUT': '86400', 18:44:46 INFO - 'USER': 'cltbld', 18:44:46 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:46 INFO - '_': '/tools/buildbot/bin/python'} 18:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:44:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:44:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:49 INFO - Downloading docopt-0.6.1.tar.gz 18:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:44:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:44:49 INFO - Running setup.py install for blobuploader 18:44:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:44:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:44:49 INFO - Running setup.py install for requests 18:44:50 INFO - Running setup.py install for docopt 18:44:50 INFO - Successfully installed blobuploader requests docopt 18:44:50 INFO - Cleaning up... 18:44:50 INFO - Return code: 0 18:44:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:50 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:50 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 18:44:50 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 18:44:50 INFO - Using env: {'DISPLAY': ':0', 18:44:50 INFO - 'HOME': '/home/cltbld', 18:44:50 INFO - 'LANG': 'en_US.UTF-8', 18:44:50 INFO - 'LANGUAGE': 'en_US:en', 18:44:50 INFO - 'LOGNAME': 'cltbld', 18:44:50 INFO - 'MAIL': '/var/mail/cltbld', 18:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:50 INFO - 'MOZ_NO_REMOTE': '1', 18:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:50 INFO - 'NO_EM_RESTART': '1', 18:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:50 INFO - 'PWD': '/builds/slave/test', 18:44:50 INFO - 'SHELL': '/bin/bash', 18:44:50 INFO - 'SHLVL': '1', 18:44:50 INFO - 'TERM': 'linux', 18:44:50 INFO - 'TMOUT': '86400', 18:44:50 INFO - 'USER': 'cltbld', 18:44:50 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:50 INFO - '_': '/tools/buildbot/bin/python'} 18:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:50 INFO - Running setup.py (path:/tmp/pip-qiaML4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:50 INFO - Running setup.py (path:/tmp/pip-vnW5Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:50 INFO - Running setup.py (path:/tmp/pip-JXkLMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:50 INFO - Running setup.py (path:/tmp/pip-AVqJaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:50 INFO - Running setup.py (path:/tmp/pip-CtjJ4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:51 INFO - Running setup.py (path:/tmp/pip-SIslKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:51 INFO - Running setup.py (path:/tmp/pip-0ewHKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:51 INFO - Running setup.py (path:/tmp/pip-UEi3Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:51 INFO - Running setup.py (path:/tmp/pip-dEWVG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:51 INFO - Running setup.py (path:/tmp/pip-64ykj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:51 INFO - Running setup.py (path:/tmp/pip-sOUIs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:51 INFO - Running setup.py (path:/tmp/pip-2Xa193-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:51 INFO - Running setup.py (path:/tmp/pip-7t4igE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:51 INFO - Running setup.py (path:/tmp/pip-P6_XDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:51 INFO - Running setup.py (path:/tmp/pip-vchlis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:51 INFO - Running setup.py (path:/tmp/pip-lfxqfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:51 INFO - Running setup.py (path:/tmp/pip-NEyq2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:44:51 INFO - Running setup.py install for manifestparser 18:44:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozcrash 18:44:52 INFO - Running setup.py install for mozdebug 18:44:52 INFO - Running setup.py install for mozdevice 18:44:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozfile 18:44:52 INFO - Running setup.py install for mozhttpd 18:44:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozinfo 18:44:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozInstall 18:44:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for mozleak 18:44:52 INFO - Running setup.py install for mozlog 18:44:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:44:52 INFO - Running setup.py install for moznetwork 18:44:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:44:53 INFO - Running setup.py install for mozprocess 18:44:53 INFO - Running setup.py install for mozprofile 18:44:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:44:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:44:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:44:53 INFO - Running setup.py install for mozrunner 18:44:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:44:53 INFO - Running setup.py install for mozscreenshot 18:44:53 INFO - Running setup.py install for moztest 18:44:53 INFO - Running setup.py install for mozversion 18:44:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:44:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:44:53 INFO - Cleaning up... 18:44:53 INFO - Return code: 0 18:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:53 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 18:44:53 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 18:44:53 INFO - Using env: {'DISPLAY': ':0', 18:44:53 INFO - 'HOME': '/home/cltbld', 18:44:53 INFO - 'LANG': 'en_US.UTF-8', 18:44:53 INFO - 'LANGUAGE': 'en_US:en', 18:44:53 INFO - 'LOGNAME': 'cltbld', 18:44:53 INFO - 'MAIL': '/var/mail/cltbld', 18:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:53 INFO - 'MOZ_NO_REMOTE': '1', 18:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:53 INFO - 'NO_EM_RESTART': '1', 18:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:53 INFO - 'PWD': '/builds/slave/test', 18:44:53 INFO - 'SHELL': '/bin/bash', 18:44:53 INFO - 'SHLVL': '1', 18:44:53 INFO - 'TERM': 'linux', 18:44:53 INFO - 'TMOUT': '86400', 18:44:53 INFO - 'USER': 'cltbld', 18:44:53 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:53 INFO - '_': '/tools/buildbot/bin/python'} 18:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:53 INFO - Running setup.py (path:/tmp/pip-urXYX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:53 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)) 18:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:53 INFO - Running setup.py (path:/tmp/pip-kLufdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:54 INFO - Running setup.py (path:/tmp/pip-XUi1Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:54 INFO - Running setup.py (path:/tmp/pip-di4Y6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:54 INFO - Running setup.py (path:/tmp/pip-heKJuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:54 INFO - Running setup.py (path:/tmp/pip-CsQy8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:54 INFO - Running setup.py (path:/tmp/pip-YOzbMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:54 INFO - Running setup.py (path:/tmp/pip-Y0FPrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:54 INFO - Running setup.py (path:/tmp/pip-xtJNNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:54 INFO - Running setup.py (path:/tmp/pip-Lo2E_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:54 INFO - Running setup.py (path:/tmp/pip-EF74bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:54 INFO - Running setup.py (path:/tmp/pip-IRHa47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:54 INFO - Running setup.py (path:/tmp/pip-BiKhlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:54 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:54 INFO - Running setup.py (path:/tmp/pip-0X6ndJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:54 INFO - Running setup.py (path:/tmp/pip-_0yKlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:55 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)) 18:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:55 INFO - Running setup.py (path:/tmp/pip-Jqmft3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:55 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)) 18:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:55 INFO - Running setup.py (path:/tmp/pip-n3Na4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:55 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)) 18:44:55 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)) 18:44:55 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)) 18:44:55 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)) 18:44:55 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)) 18:44:55 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)) 18:44:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:55 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 18:44:55 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 18:44:55 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 18:44:55 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 18:44:55 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 18:44:55 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 18:44:57 INFO - Downloading blessings-1.6.tar.gz 18:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:44:57 INFO - Installing collected packages: blessings 18:44:57 INFO - Running setup.py install for blessings 18:44:57 INFO - Successfully installed blessings 18:44:57 INFO - Cleaning up... 18:44:57 INFO - Return code: 0 18:44:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:44:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:57 INFO - Reading from file tmpfile_stdout 18:44:57 INFO - Current package versions: 18:44:57 INFO - argparse == 1.2.1 18:44:57 INFO - blessings == 1.6 18:44:57 INFO - blobuploader == 1.2.4 18:44:57 INFO - docopt == 0.6.1 18:44:57 INFO - functools32 == 3.2.3-2 18:44:57 INFO - jsonschema == 2.5.1 18:44:57 INFO - manifestparser == 1.1 18:44:57 INFO - mozInstall == 1.12 18:44:57 INFO - mozcrash == 0.17 18:44:57 INFO - mozdebug == 0.1 18:44:57 INFO - mozdevice == 0.48 18:44:57 INFO - mozfile == 1.2 18:44:57 INFO - mozhttpd == 0.7 18:44:57 INFO - mozinfo == 0.9 18:44:57 INFO - mozleak == 0.1 18:44:57 INFO - mozlog == 3.2 18:44:57 INFO - moznetwork == 0.27 18:44:57 INFO - mozprocess == 0.23 18:44:57 INFO - mozprofile == 0.28 18:44:57 INFO - mozrunner == 6.12 18:44:57 INFO - mozscreenshot == 0.1 18:44:57 INFO - mozsystemmonitor == 0.3 18:44:57 INFO - moztest == 0.7 18:44:57 INFO - mozversion == 1.4 18:44:57 INFO - psutil == 3.1.1 18:44:57 INFO - requests == 1.2.3 18:44:57 INFO - wsgiref == 0.1.2 18:44:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:57 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')]} 18:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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')]} 18:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:57 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 18:44:57 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 18:44:57 INFO - Using env: {'DISPLAY': ':0', 18:44:57 INFO - 'HOME': '/home/cltbld', 18:44:57 INFO - 'LANG': 'en_US.UTF-8', 18:44:57 INFO - 'LANGUAGE': 'en_US:en', 18:44:57 INFO - 'LOGNAME': 'cltbld', 18:44:57 INFO - 'MAIL': '/var/mail/cltbld', 18:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:57 INFO - 'MOZ_NO_REMOTE': '1', 18:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:57 INFO - 'NO_EM_RESTART': '1', 18:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:57 INFO - 'PWD': '/builds/slave/test', 18:44:57 INFO - 'SHELL': '/bin/bash', 18:44:57 INFO - 'SHLVL': '1', 18:44:57 INFO - 'TERM': 'linux', 18:44:57 INFO - 'TMOUT': '86400', 18:44:57 INFO - 'USER': 'cltbld', 18:44:57 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:57 INFO - '_': '/tools/buildbot/bin/python'} 18:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 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)) 18:44:57 INFO - Cleaning up... 18:44:57 INFO - Return code: 0 18:44:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:44:57 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')]} 18:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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')]} 18:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:57 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 18:44:57 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 18:44:57 INFO - Using env: {'DISPLAY': ':0', 18:44:57 INFO - 'HOME': '/home/cltbld', 18:44:57 INFO - 'LANG': 'en_US.UTF-8', 18:44:57 INFO - 'LANGUAGE': 'en_US:en', 18:44:57 INFO - 'LOGNAME': 'cltbld', 18:44:57 INFO - 'MAIL': '/var/mail/cltbld', 18:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:57 INFO - 'MOZ_NO_REMOTE': '1', 18:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:57 INFO - 'NO_EM_RESTART': '1', 18:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:57 INFO - 'PWD': '/builds/slave/test', 18:44:57 INFO - 'SHELL': '/bin/bash', 18:44:57 INFO - 'SHLVL': '1', 18:44:57 INFO - 'TERM': 'linux', 18:44:57 INFO - 'TMOUT': '86400', 18:44:57 INFO - 'USER': 'cltbld', 18:44:57 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:57 INFO - '_': '/tools/buildbot/bin/python'} 18:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:44:57 INFO - Cleaning up... 18:44:57 INFO - Return code: 0 18:44:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:44:57 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')]} 18:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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')]} 18:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:57 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 0x7fbc42b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', '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 18:44:57 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 18:44:57 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 18:44:57 INFO - Using env: {'DISPLAY': ':0', 18:44:57 INFO - 'HOME': '/home/cltbld', 18:44:57 INFO - 'LANG': 'en_US.UTF-8', 18:44:57 INFO - 'LANGUAGE': 'en_US:en', 18:44:57 INFO - 'LOGNAME': 'cltbld', 18:44:57 INFO - 'MAIL': '/var/mail/cltbld', 18:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:57 INFO - 'MOZ_NO_REMOTE': '1', 18:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:57 INFO - 'NO_EM_RESTART': '1', 18:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:57 INFO - 'PWD': '/builds/slave/test', 18:44:57 INFO - 'SHELL': '/bin/bash', 18:44:57 INFO - 'SHLVL': '1', 18:44:57 INFO - 'TERM': 'linux', 18:44:57 INFO - 'TMOUT': '86400', 18:44:57 INFO - 'USER': 'cltbld', 18:44:57 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:57 INFO - '_': '/tools/buildbot/bin/python'} 18:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:58 INFO - Downloading/unpacking flake8 18:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:45:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:45:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:45:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:01 INFO - no previously-included directories found matching 'docs/_build' 18:45:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:45:01 INFO - Running setup.py install for pep8 18:45:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:01 INFO - no previously-included directories found matching 'docs/_build' 18:45:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:45:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:45:01 INFO - Cleaning up... 18:45:01 INFO - Return code: 0 18:45:01 INFO - Running post-action listener: _resource_record_post_action 18:45:01 INFO - Running post-action listener: _start_resource_monitoring 18:45:01 INFO - Starting resource monitoring. 18:45:01 INFO - ##### 18:45:01 INFO - ##### Finished create-virtualenv step (success) 18:45:01 INFO - ##### 18:45:01 INFO - ##### 18:45:01 INFO - ##### Running install step. 18:45:01 INFO - ##### 18:45:01 INFO - Running pre-action listener: _resource_record_pre_action 18:45:01 INFO - Running main action method: install 18:45:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:01 INFO - Reading from file tmpfile_stdout 18:45:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:45:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:45:01 INFO - Reading from file tmpfile_stdout 18:45:01 INFO - Output received: 18:45:01 INFO - Usage: mozinstall [options] installer 18:45:01 INFO - Options: 18:45:01 INFO - -h, --help show this help message and exit 18:45:01 INFO - -d DEST, --destination=DEST 18:45:01 INFO - Directory to install application into. [default: 18:45:01 INFO - "/builds/slave/test"] 18:45:01 INFO - --app=APP Application being installed. [default: firefox] 18:45:01 INFO - mkdir: /builds/slave/test/build/application 18:45:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:45:17 INFO - Reading from file tmpfile_stdout 18:45:17 INFO - Output received: 18:45:17 INFO - /builds/slave/test/build/application/firefox/firefox 18:45:17 INFO - Running post-action listener: _resource_record_post_action 18:45:17 INFO - ##### 18:45:17 INFO - ##### Finished install step (success) 18:45:17 INFO - ##### 18:45:17 INFO - ##### 18:45:17 INFO - ##### Running run-tests step. 18:45:17 INFO - ##### 18:45:17 INFO - Running pre-action listener: _resource_record_pre_action 18:45:17 INFO - Running main action method: run_tests 18:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:17 INFO - Python 2.7.3 18:45:17 INFO - Return code: 0 18:45:17 INFO - grabbing minidump binary from tooltool 18:45:17 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')]} 18:45:17 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 0x2d4e2e0>, '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 0x2cba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cba5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:17 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 18:45:17 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 18:45:17 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 18:45:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:17 INFO - Return code: 0 18:45:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:45:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:45:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:45:18 INFO - Return code: 0 18:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:45:18 INFO - Using env: {'DISPLAY': ':0', 18:45:18 INFO - 'HOME': '/home/cltbld', 18:45:18 INFO - 'LANG': 'en_US.UTF-8', 18:45:18 INFO - 'LANGUAGE': 'en_US:en', 18:45:18 INFO - 'LOGNAME': 'cltbld', 18:45:18 INFO - 'MAIL': '/var/mail/cltbld', 18:45:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:18 INFO - 'MOZ_NO_REMOTE': '1', 18:45:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:18 INFO - 'NO_EM_RESTART': '1', 18:45:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:18 INFO - 'PWD': '/builds/slave/test', 18:45:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:18 INFO - 'SHELL': '/bin/bash', 18:45:18 INFO - 'SHLVL': '1', 18:45:18 INFO - 'TERM': 'linux', 18:45:18 INFO - 'TMOUT': '86400', 18:45:18 INFO - 'USER': 'cltbld', 18:45:18 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037', 18:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:18 INFO - '_': '/tools/buildbot/bin/python'} 18:45:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:45:18 INFO - mozversion application_buildid: 20160712154725 18:45:18 INFO - mozversion application_changeset: 1609e0acfe66720db5ac91b5cb5748f3c27a9468 18:45:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:45:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:18 INFO - mozversion application_name: Firefox 18:45:18 INFO - mozversion application_remotingname: firefox-dev 18:45:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:18 INFO - mozversion application_vendor: Mozilla 18:45:18 INFO - mozversion application_version: 49.0a2 18:45:18 INFO - mozversion platform_buildid: 20160712154725 18:45:18 INFO - mozversion platform_changeset: 1609e0acfe66720db5ac91b5cb5748f3c27a9468 18:45:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:18 INFO - mozversion platform_version: 49.0a2 18:45:18 INFO - using testdate: 1468374318 18:45:18 INFO - actual date: 1468374318 18:45:18 INFO - starting webserver on 'localhost:48617' 18:45:18 INFO - SUITE-START | Running 2 tests 18:45:18 INFO - TEST-START | dromaeo_css 18:45:18 INFO - operating with platform_type : linux_ 18:45:18 INFO - Initialising browser for dromaeo_css test... 18:45:18 INFO - TEST-INFO | started process 6505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqmpIGm/profile http://localhost:48617/getInfo.html) 18:45:23 INFO - PROCESS | 6505 | __metrics Screen width/height:1600/1200 18:45:23 INFO - PROCESS | 6505 | colorDepth:24 18:45:23 INFO - PROCESS | 6505 | Browser inner width/height: 1024/697 18:45:23 INFO - PROCESS | 6505 | __metrics 18:45:24 ERROR - PROCESS | 6505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:45:25 INFO - TEST-INFO | 6505: exit 0 18:45:25 INFO - Browser initialized. 18:45:25 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:25 INFO - TEST-INFO | started process 6633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqmpIGm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:36 INFO - PROCESS | 6633 | RSS: Main: 156196864 18:45:36 INFO - PROCESS | 6633 | 18:46:26 INFO - PROCESS | 6633 | 1468374386498 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] 18:48:34 INFO - PROCESS | 6633 | Cycle 1(1): loaded http://localhost:48617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48617/tests/dromaeo/cssquery-ext.html) 18:48:35 INFO - PROCESS | 6633 | RSS: Main: 159330304 18:48:35 INFO - PROCESS | 6633 | 18:51:37 INFO - PROCESS | 6633 | Cycle 1(1): loaded http://localhost:48617/tests/dromaeo/cssquery-ext.html (next: http://localhost:48617/tests/dromaeo/cssquery-jquery.html) 18:51:38 INFO - PROCESS | 6633 | RSS: Main: 157831168 18:51:38 INFO - PROCESS | 6633 | 18:54:40 INFO - PROCESS | 6633 | Cycle 1(1): loaded http://localhost:48617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48617/tests/dromaeo/cssquery-mootools.html) 18:54:40 INFO - PROCESS | 6633 | RSS: Main: 157577216 18:54:40 INFO - PROCESS | 6633 | 18:57:42 INFO - PROCESS | 6633 | Cycle 1(1): loaded http://localhost:48617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48617/tests/dromaeo/cssquery-prototype.html) 18:57:43 INFO - PROCESS | 6633 | RSS: Main: 156729344 18:57:43 INFO - PROCESS | 6633 | 19:00:45 INFO - PROCESS | 6633 | Cycle 1(1): loaded http://localhost:48617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48617/tests/dromaeo/cssquery-yui.html) 19:00:46 INFO - PROCESS | 6633 | RSS: Main: 159170560 19:00:46 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | Cycle 1(1): loaded http://localhost:48617/tests/dromaeo/cssquery-yui.html (next: http://localhost:48617/tests/dromaeo/cssquery-dojo.html) 19:03:48 INFO - PROCESS | 6633 | RSS: Main: 159215616 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | __start_tp_report 19:03:48 INFO - PROCESS | 6633 | _x_x_mozilla_page_load 19:03:48 INFO - PROCESS | 6633 | _x_x_mozilla_page_load_details 19:03:48 INFO - PROCESS | 6633 | |i|pagename|runs| 19:03:48 INFO - PROCESS | 6633 | |0;dojo.html;3325.7173140283076;3387.830608469579;3393.355262500124;3414.1635299351665;3425.469052296895;5683.175939488771;5696.174054762052;5697.9999999999945;5700.515456186224;5724.5992780505385;5722.341930677973;5754.510866576346;5760.308762948452;5768.932747441726;5778.24882765241;5125.743712814363;5156.175011998081;5184.792608295664;5221.425643179247;5229.189475631283;5052.747362631872;5055.797768089272;5217;5222.9477705223035;5243.344581927259;5081.923771143417;5111.948880511184;5131.461196574362;5158.303629010074;5164.2253661950635;5131.358580177496;5149.201873709562;5157.406898206679;5159.6646217996085;5164.45773193813;5110.310108135392;5115.539601435851;5182.740862956837;5194.142966410575;5222.399424066243;5334.5732341412595;5445.428230035868;5510.9448905511235;5562.527185189264;5571.275734154534;6050.939490605082;6059.424354686298;6062.545309101835;6079;6083.9391606084255;6088.969555152196;6127.87744245117;6136.355682653347;6138.570300078996;6167.475764559973;5497.257870187514;5665.54675625953;5686.971565142189;5726.627769195031;5750.971245143747;6234.937650623527;6261.9373806262265;6281.497480201573;6285.182926219653;6292.905606415908;5713.22871412354;6029.698515074228;6033.5173186145;6040.426159514839;6051.939480605138;6016.608920420159;6039.486643635252;6071.423214794588;6128.724207410677;6135.969320153371;6048.848778780566;6054.243219597551;6054.3642917493025;6069.544784141207;6075.726592303357;5802.970985145132;6005.858886811579;6079.392060793885;6082.148499210114;6089.269287685506;4617.515160908123;4693.8969342204555;4695.460022097434;4699.365585645963;4707.940713339472;4141.772202528829;4159.500859896832;4161;4169.895752606149;4192;5789.160571717078;5791.623544469596;5799.159121927381;5874.089516125007;5907.350191478934;5939.910901336483;6039.969800150971;6069.937760891827;6100.420460056288;6153.292371377349;5852.063669812809;5899.233099697012;5900.321463031721;5910.940890591125;5913.852153696106;5125.103106956268;5216.843494695166;5245.082110630625;5245.816396426183;5316.521513063843;6336.17629708135;6339.334369891188;6398.360163983658;6414.839629009312;6418.967905160444;6153.600015998945;6157.96921015392;6169.259688837278;6172.4136207060255;6175.228096487939;6034.09488576717;6113.84715382119;6210.627362358273;6237.906431403442;6318.147050148355;5946.583739138392;5969.910451343147;5973.253343332083;5975.880482390241;6016.368281330398;5808.448197421239;6059.242594675666;6076.361981991828;6080.695965201634;6084.695765211633;5903.675297858487;5980.372060933713;5988.550858685703;6007.849803754941;6016.548758843017;5960.284765828128;5974.1934838796205;5982.4017598239825;6001.099835024781;6028.065649824284;5662.546996240373;5711.457411545896;5833.212516310244;5901.173835663097;5912.260967379078;5891.263592050994;5954.345022047658;5961.701914904324;5992.250968628921;5996.760129594767;5817.650940943557;5862.736176871966;5869.882602348014;5872.970635146797;5876.853078673067 19:03:48 INFO - PROCESS | 6633 | |1;ext.html;596.6807757849551;641.7080228496035;650.034698472768;663.1809715001972;663.2902794010408;44288.55711442885;45818.54181458185;46131.769341153245;46203.30695039569;51147.744261278734;48234.75882620582;48676.75661621696;48992.75503622477;49013;49073.75463122688;9090.54547272637;9170.220531254852;9179.219766319837;9220.262379009697;9240;9069.138431848964;9090.09099090089;9108.817823643523;9134.26925845934;9146.542672866364;9118.316126290521;9130.77173070672;9141.86287205689;9155.176034156924;9204.631814727403;9171.17459428648;9197.448153110801;9214.53927303639;9236.030216827203;9237.815243695122;8984.460932344015;8992.910070899337;9038.954805225998;9059.728208153765;9085.04607016267;44258;44699.77650111761;44786;44918.55081449176;44976.55023449756;3869.4776205212497;4039.454673619053;4167.229062623394;4169.541350451448;4365.628921541673;34237.486437703454;34636.13409664779;34662.65337346619;34762.13094672653;34784.6521534784;4659.553579882678;4724;4754.78603462845;4760.738159401231;4763.833265835679;385547;388540;388703;388889;389673;60665.69667151636;61018.69490652518;61505.38494614996;61583.6920815393;61705.691471542355;38692.80653596714;39423.60576394256;39614.60385396109;41747.791261044105;65358;15883.920580397255;15910.12494312824;15942.123183225034;15968.121753303447;15968.441104561285;11799.646010619696;11879.643610691694;11933.224340418019;11937.52249909994;11967.940160299142;20971.161153553687;21049.158033678483;21105.68341474879;21121.78878211229;21225.68161477579;7434.479586428898;7434.628268586549;7471.850562988819;7614.466987310946;7631.122420921554;1091.781643671269;1115.6597237842536;1141.4121727310442;1176.9583918232427;1250.3560666256885;33892.83053584716;33893.83053084719;34124.317513649585;34163.31673366519;35518.82240588832;1147.6212849759559;1265.7658333208385;1273.1279073834453;1282.0512820512754;1284.5760898903338;17320.826791732172;17661.11694415274;17714.432918190127;17808.821911780717;17905.7314140288;589923;590947;625595;987707;1010165;62994.68502657549;63298.0505292421;64032;64068;64146.679266603365;1415.2852809331428;1472.49935022093;1473.7715654073636;1500.2048914075558;1510.7129645367345;29024;29831.70168298376;29872;30036.549451757804;30333.696663033086;54390.18414723703;54617.45382546283;55016;55101.44898550963;55141.72429137828;511053;512477;516474;517596;517736;27848.443031138857;28262;28283.717162828107;28333.716662833107;30583.694163058084;51037;51233.48766512287;51553.22670160026;52260;52625;42887.571124288355;43035.78482107569;44150.55849441465;44231.55768442275;44754.3286850691;42342.78828605837;42895.57104428916;43200;44263.55736442723;44573.55426445824;42777.78611107049;43428.348574770775;43998;44298;44614.3307850389;36283.818580906925;37156.44265336076;37686.81156594199;37861.621383786915;38039.2392152161;28957.56563651589;29251.85374073116;29568.852155739085;29816.70183298139;29923.70076299209 19:03:48 INFO - PROCESS | 6633 | |2;jquery.html;417.1240395170143;417.1844044892236;420.8674267605706;424.27237288050986;438.59430027224806;18372.63254734906;19012;19923.900380498097;21246.362609121752;21335.359939201848;19276.710849337236;20053.699194512094;20127;20128.999999999964;20252.797472025275;5225.477452254772;5352.411234764173;5379.865503362408;5403.756830942617;5406.972965135169;5328.1474964005765;5917.5561832862495;5926.962781513218;5929.347771745104;5942.257217847769;5728.885422291552;5839.065749480084;5873.647581145145;5875.089361149029;5906.143609176666;5204.9479505204845;5352.090144675414;5354.330708661418;5365.114756065244;5375.516203541681;5023.397192336906;5172.301739265189;5191.0656081905245;5197.116490196638;5237.266782650432;13595.932020339835;14626.70746585073;14642.70714585713;14678.119312841263;19797.30709425163;2315.953680926372;2378.607529757588;2502.4869901670295;2566.409725763085;2623.34416395901;10250.384976901336;10437.530311136017;10819.459027048617;14090.436382544685;14930.402783888632;1961.4998175465307;1999.2802591067205;2005.8796472211714;2070.95858082839;2097.8216851567636;84330;85969;86585;86732.56633716854;87505.12494875034;10211.540480678388;11692.88307116935;11694.2983420995;11705;11730.530778768754;14510.637234069021;16773.161341932853;16798.244079016473;16809.579760506083;16838.91580542114;7633.6564854581675;7908.367330613537;8062.475939063942;8445.239928406472;8834.690785822466;7794.883076753853;7887.605619718991;7893.289603935674;7940.722074727357;7986.281234688906;4633.0733853229485;4797.304390863305;4997.350344455198;5080.847574572768;5103.7192954387865;2031.8069783370852;2061.2064355223347;2129.9041543130597;2130.6484430069177;2132.36029191242;950.919171870385;1111.8999290063932;1121.8485504456958;1127.622246547416;1132.6667065844388;19214.615707686047;19462.610747784965;19908.70136947947;20055.465334166147;20084.497887552636;1039.1271332081087;1074.6937122920087;1076.8330908709163;1091.2743025887696;1097.6597254851022;10660.093892019266;11085.83371249432;11173.441327933571;11188.272762270426;11276.154288428237;443701;449904;483437;505295;509737;59683.403165967786;66763.33236667668;86361;97770;99268.50365748125;1069.8181309177457;1070.528967254421;1072.790805792863;1104.4588151805717;1108.844761733358;17619.20713567867;18034.36879709204;18081.09594520295;18138.183781730117;18310.450686479428;41738.165236695706;41972;43132.35301470543;44001.77999109984;44117.77941110402;58883.11675324959;59302.40697592969;59968.70015649894;60560.394396057236;60562.39437605567;8878.422902511316;8916.73249802507;8960.596773145355;9063.274938005075;9177;11994.520219191134;13658.590242292747;13751.174929504261;13927.930360348133;13941;11627.825582616437;11847.348395838311;11896.643100706646;12049.397530123284;12635.74728505443;11822;11850.170488065753;11942.641720748392;12028.338441385458;12415.875841241472;11512.654620361403;12356.876431235572;12465.252084874937;12684;12706.34220274533;8980.595873185854;9101.908980910106;9123.042080581708;9200.26397888154;9320.72037838866;9255;11843.822342664695;11901.404929753304;11944.104192185794;12228.449719762453 19:03:48 INFO - PROCESS | 6633 | |3;mootools.html;1547.8065241844772;1588.2217713320472;1773.9733903991441;1861.7858946221172;1863.6272745450913;9348.85976710349;9729.124378805906;9981.650642227523;10008.549615267313;10017.04838040385;10127.037931396524;10238.48807559621;10274.691759247216;10275.537600807962;10299.124574411184;2467.099508679328;2506.4360518883286;2507.4107584717576;2508.4857604191097;2524.7853932415765;2457.7296497385273;2494.725580186178;2511.4977004599064;2512.849229046254;2515.5346260941783;2407.07327678844;2447.0945750072497;2473.2209354053507;2484.5527804995095;2489.4025433895918;2420.3344080377947;2441.9633705494343;2455.594826853567;2468.8888999994865;2469.370310570811;2480.231128350217;2489.8257122001287;2490.3276115448725;2516.496700659857;2521.042004038454;9928.255380846393;9950.80098398028;10019.148372388356;10025.799484010351;10064.949675251577;5534.584906132016;5607.887842243133;5646.265985421869;5698.857528561778;5709.914351284734;3469.340825243196;3514.894553163409;3565.893023209308;3621.9818900905325;3637.618050104754;1156.410230782307;1184.3486082654506;1194.581896336284;1205.2105870654648;1225.3628113380992;13881.930590346983;13901.304934753221;13944.302784860818;13990.230537320444;14073.577792666134;4584.6561507887045;4652.255639097728;4709.952900470951;4732.95267047332;4733.029728905566;10908.781824363468;10914.454277286104;10935.453227338601;10960.506777195045;10993.175511836644;5572.442755724395;5597.6641401516035;5627.8593035174445;5636.943630563724;5652.943470565324;4542.613877820422;5192.948070519246;5237.5548078413;5323.095073837457;5329.200619906967;4046.7571945683353;4066;4075.8369665213654;4100.686772766495;4112.753234805921;1128.198978725098;1170.9648710538697;1185.040117504824;1191.237607930925;1206.4269472000906;930.6742640076054;988.3970777825521;1092.5575142067476;1113.8440618313443;1133.4616057372848;6465.870682586322;6664.833379165462;6674;6869.381755642016;6877.6217308048535;1016.1515134862325;1053.4837929414532;1054.7890421915495;1074.6238816414193;1091.5197313182175;4473.46318441789;4590.219662657356;4629.1436084324505;4660.231061874752;4681.32120842476;12234.082443816571;12499.875001250053;12504.687382815502;12524.624261272176;12527.373631318398;11707.88292117068;12161.270323780602;12169.634910952685;12221.083418743452;12239.20445171061;9090.40912340709;9180.403273787182;9279.582418791306;9285.442873427615;9290.814183716422;6709;6756.763513277012;6816.965915170393;6982.301769823181;7111.359977602041;11211.439428028403;11382.804805495303;11428.885711142782;11559.595414160463;11709.473073711533;10902.945485272523;11249.49377278008;11488.080953523866;11571.537138514364;11727.061835053346;7733.072031356273;8195.139510351328;8441.029281632445;8698.086700896567;8883.689070882489;9184.448933064037;9251.982281948845;9323.440593564408;9358;9388.389754665925;7861.882071768814;8157.265846073882;8182.099969003524;8245.340372770284;8291.33669306442;8308.169183081643;8321.667133314842;8333.95833020831;8416.074231834617;8440.66237350499;7428.777136685908;7569.772906812805;7590.39276857839;7594.31651151399;7598.392128629807;5482.314710661168;5564.221009058654;5589.552646884872;5636.0418728815375;5708.600397972268;5798.333191682842;5827.329857066322;5909.349971503218;5938.079597662369;5946.286445626552 19:03:48 INFO - PROCESS | 6633 | |4;prototype.html;343.7765452455905;348.2286734882236;349.7569189413357;351.56581621697217;357.59055881016235;5652.915206271904;5757.193992841006;5760.559860034991;5789.334226563947;5799.289209683143;5675.148727690848;5676.716164191785;5687.289088863892;5699.145128230767;5702.287214098238;4063.7358571692744;4294.9570504295025;4375.7593332366705;4388.71473354231;4408.228560002003;4374.212641724488;4395.736255824645;4406.625436837857;4408.4709834819705;4424.203643344197;4377.146456440995;4403.735775853459;4406.383106365111;4412.426384570002;4412.82348706053;4316.244657184996;4371.366151907955;4381.408509851193;4394.4067550880545;4410.75740834254;3839.865604703822;3845.903852403684;3903.394973779069;3904.6876249899938;3907.9218415631813;5486.286782718221;5515.200295957104;5527.53015993637;5555.9443705695785;5568.99758043552;4941.703497790144;4952.653314268003;5063.721495317756;5071.1632580624155;5079.492050794928;5885.470307672287;5895.322037965646;5941.494972927307;5961.046232602763;5977.731002104916;4297.247981603207;4327.415798867176;4336.934945975813;4354.629856462205;4384.978075109636;5892.882142357129;6070.453659170696;6131.846703832395;6154.230721159855;6164.907526387108;4372.650187984954;4397.6042156206095;4410.610657642832;4414.823407063682;4417.668674849335;4457.286834106528;4481.865544033684;4509.864704058883;4525.751083690363;4528.864134075983;4836.685615434985;5029.899402012013;5041.596672266283;5050.1667224908215;5072.923906141411;5932.79235226765;5958.242318516048;5988.670623115683;6018.92347140236;6039.7282122304605;1505.4204131409485;1514.1999860442425;1520.6426489774894;1540.5224380442098;1558.5012795905427;917.7934964632905;933.295362001698;978.9461579613189;1034.4207243943415;1051.9684409467727;5690.857728556736;5754.625949313281;5803.245578074823;5838.970805146032;5850.23946886902;6128.479079278222;6139.969300153471;6151.96924015377;6176.011838105882;6179.682619017868;5634.887302253932;5762.164486149485;5764.798232061858;5773.711314434261;5782.855428614318;3280.917977050593;3281.3765384576855;3282.9658657522805;3289.851956661908;3300.455424854872;6080.908786368208;6353.237611486651;6359.745610175633;6373.74505019794;6381.489480841522;6214.533909956681;6234.657093859882;6241.594296370721;6266.749330026748;6276.112988025468;6120.479759220516;6194.225721784777;6308.432241098231;6364.936350636527;6376.7130479128555;6180.3201647817805;6201.317855036033;6215.285242197205;6233.693533392674;6259.3427690091885;6172.629642221481;6181.783637572664;6202.5658203925295;6223.284322302812;6238.282597501164;6297.527685423704;6446.935530644633;6495.382938620824;6504.544681872224;6528.510361722985;4364.468608207296;4372.6939114261695;4373.1253749249645;4401.713888597231;4405.9559404405545;6028.57799953999;6243.406876346739;6275.717592708248;6304.211973503312;6328.841778955563;6059.788177315337;6077.908831367445;6094.177286066324;6120.60216085953;6138.355472675484;6049.334573197033;6100.877982440237;6147.877042459037;6154.3845615438095;6164.815055548341;5688.658680479184;5776.855578610568;5894.911576326273;5973.641581505123;5973.894829456564;6088.756449741961;6125.203723515914;6132.9080063799975;6176.258848938156;6180.567360284737;5663.207150998781;5891.852703682443;5898.498627616529;5934.43622855828;6006.789762358297 19:03:48 INFO - PROCESS | 6633 | |5;yui.html;771.2942657468413;796.1560745609653;806.0810675829555;823.8352329534093;846.5344060766577;17814.376496822613;18280.177392017373;18284.542886427847;18315.725264121033;18350.541236469096;16318.83681163188;16543.83456165438;16613.91693041533;16703.415380461687;16756.83243167568;821.4126899267023;845.3364109174299;858.3176374782063;867.2065060469663;872.0668884293808;853.1468531468531;857.7126662568047;863.7883718488947;866.3632230310717;867.4968518259426;902.7562558109306;908.8863892013499;908.9363744537885;914.2959920860933;915.2860768600502;895.9372843900929;897.1790811407554;897.6768363389207;898.3172788680585;899.2895612466144;661.8676264747022;662.652107643491;663.2140913018089;665.5474277491304;666.6833254204263;16365.34538618454;16393.180340982904;16422.096784676836;16482.75275870863;16505.752413713803;13643.795343069862;14173.574792756132;14483.855161448357;15179.649609027087;15651.060936343856;12001.759964800654;12098.092643051717;12232.81650775239;12296.877031229662;12433.005359571303;3928.135810121769;4003.719739618228;4038.3942408638645;4048.2308361411533;4072.7759973201464;60965.390346096414;69493.65253173752;72078;72284.63857680731;81060;11816.645500634995;12142.75714485723;12170.330631815157;12265.877341226653;12436.81344779829;22825.543489130123;22897;23005.76994230036;23323.533529329317;23458.64812027821;8854.557272136368;9051.954740226256;9159.038300978435;9172.633094676272;9184.90815091854;5020.221865610836;5035.748212589356;5096.796128154906;5164.561012313995;5251.711155886386;3885.339492286318;4016.036151323661;4018.276710192135;4027.2549578327516;4028.113814960704;634.4575388043249;699.9720011199597;705.971761129549;706.9328413800681;709.7232079489004;757.0796372368138;786.5241528874948;809.2797410304834;819.332244220958;836.5315423362936;9991.600335986624;10323.225758068025;10463.895361046292;10500.737481563023;10704.625338113128;561.9185218143429;648.0376640688573;697.4281089506555;722.6765799256506;741.7478057460489;4902.7058376497525;4915.975420122948;4952.801887924443;4970.179920313108;4995.850124496271;98799;114391.42804286092;117323;118942;120238.3988080054;86692.56653716692;96366;99673.50163249137;101350.49324753329;102940.48529757453;87279;89509.55245223732;90261.54869225743;90458.99999999869;90654;9206.447613143233;9252.352335336462;9336.859947100664;9337.673181438617;9659.130678238993;38793.612063879;50333.74833125811;52016.479835201164;52608.73695631498;54482.72758636181;83693.16306837097;83868.58065709632;86372;88101.55949220213;88273.55863220643;12770.68073298175;12910.160839545399;12969.613053288233;13031.152975056591;13344.266065366499;13934.790978135134;14358.210298433687;14610.123392596479;14830.851691483378;15303.311350989456;13896.37466313998;14089.577312680636;14110.76803746974;14185.219812910389;14329.498467553585;12859.678508037374;13889.444422222998;14033.929830350782;14144.151350918977;14310.49913253031;13195.142315749446;13344;13470.461181552628;13553.86446135526;13881.791773123614;11141.832872506757;11235.494402751732;11740.58907938218;11762.117841161777;11843.58547450835;11666.358350290815;11770.52917883275;11954.58158964432;12011.519539218334;12142.271463712206 19:03:48 INFO - PROCESS | 6633 | __end_tp_report 19:03:48 INFO - PROCESS | 6633 | __start_cc_report 19:03:48 INFO - PROCESS | 6633 | _x_x_mozilla_cycle_collect,327 19:03:48 INFO - PROCESS | 6633 | __end_cc_report 19:03:48 INFO - PROCESS | 6633 | __startTimestamp1468375428728__endTimestamp 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | ------- Summary: start ------- 19:03:48 INFO - PROCESS | 6633 | Number of tests: 6 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | [#0] dojo.html Cycles:165 Average:5653.55 Median:5899.23 stddev:633.27 (10.7%) stddev-sans-first:608.31 19:03:48 INFO - PROCESS | 6633 | Values: 3325.7 3387.8 3393.4 3414.2 3425.5 5683.2 5696.2 5698.0 5700.5 5724.6 5722.3 5754.5 5760.3 5768.9 5778.2 5125.7 5156.2 5184.8 5221.4 5229.2 5052.7 5055.8 5217.0 5222.9 5243.3 5081.9 5111.9 5131.5 5158.3 5164.2 5131.4 5149.2 5157.4 5159.7 5164.5 5110.3 5115.5 5182.7 5194.1 5222.4 5334.6 5445.4 5510.9 5562.5 5571.3 6050.9 6059.4 6062.5 6079.0 6083.9 6089.0 6127.9 6136.4 6138.6 6167.5 5497.3 5665.5 5687.0 5726.6 5751.0 6234.9 6261.9 6281.5 6285.2 6292.9 5713.2 6029.7 6033.5 6040.4 6051.9 6016.6 6039.5 6071.4 6128.7 6136.0 6048.8 6054.2 6054.4 6069.5 6075.7 5803.0 6005.9 6079.4 6082.1 6089.3 4617.5 4693.9 4695.5 4699.4 4707.9 4141.8 4159.5 4161.0 4169.9 4192.0 5789.2 5791.6 5799.2 5874.1 5907.4 5939.9 6040.0 6069.9 6100.4 6153.3 5852.1 5899.2 5900.3 5910.9 5913.9 5125.1 5216.8 5245.1 5245.8 5316.5 6336.2 6339.3 6398.4 6414.8 6419.0 6153.6 6158.0 6169.3 6172.4 6175.2 6034.1 6113.8 6210.6 6237.9 6318.1 5946.6 5969.9 5973.3 5975.9 6016.4 5808.4 6059.2 6076.4 6080.7 6084.7 5903.7 5980.4 5988.6 6007.8 6016.5 5960.3 5974.2 5982.4 6001.1 6028.1 5662.5 5711.5 5833.2 5901.2 5912.3 5891.3 5954.3 5961.7 5992.3 5996.8 5817.7 5862.7 5869.9 5873.0 5876.9 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | [#1] ext.html Cycles:180 Average:70545.17 Median:44260.78 stddev:157652.02 (356.2%) stddev-sans-first:158006.80 19:03:48 INFO - PROCESS | 6633 | Values: 596.7 641.7 650.0 663.2 663.3 44288.6 45818.5 46131.8 46203.3 51147.7 48234.8 48676.8 48992.8 49013.0 49073.8 9090.5 9170.2 9179.2 9220.3 9240.0 9069.1 9090.1 9108.8 9134.3 9146.5 9118.3 9130.8 9141.9 9155.2 9204.6 9171.2 9197.4 9214.5 9236.0 9237.8 8984.5 8992.9 9039.0 9059.7 9085.0 44258.0 44699.8 44786.0 44918.6 44976.6 3869.5 4039.5 4167.2 4169.5 4365.6 34237.5 34636.1 34662.7 34762.1 34784.7 4659.6 4724.0 4754.8 4760.7 4763.8 385547.0 388540.0 388703.0 388889.0 389673.0 60665.7 61018.7 61505.4 61583.7 61705.7 38692.8 39423.6 39614.6 41747.8 65358.0 15883.9 15910.1 15942.1 15968.1 15968.4 11799.6 11879.6 11933.2 11937.5 11967.9 20971.2 21049.2 21105.7 21121.8 21225.7 7434.5 7434.6 7471.9 7614.5 7631.1 1091.8 1115.7 1141.4 1177.0 1250.4 33892.8 33893.8 34124.3 34163.3 35518.8 1147.6 1265.8 1273.1 1282.1 1284.6 17320.8 17661.1 17714.4 17808.8 17905.7 589923.0 590947.0 625595.0 987707.0 1010165.0 62994.7 63298.1 64032.0 64068.0 64146.7 1415.3 1472.5 1473.8 1500.2 1510.7 29024.0 29831.7 29872.0 30036.5 30333.7 54390.2 54617.5 55016.0 55101.4 55141.7 511053.0 512477.0 516474.0 517596.0 517736.0 27848.4 28262.0 28283.7 28333.7 30583.7 51037.0 51233.5 51553.2 52260.0 52625.0 42887.6 43035.8 44150.6 44231.6 44754.3 42342.8 42895.6 43200.0 44263.6 44573.6 42777.8 43428.3 43998.0 44298.0 44614.3 36283.8 37156.4 37686.8 37861.6 38039.2 28957.6 29251.9 29568.9 29816.7 29923.7 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | [#2] jquery.html Cycles:180 Average:28660.18 Median:2131.50 stddev:79026.86 (3707.6%) stddev-sans-first:79220.10 19:03:48 INFO - PROCESS | 6633 | Values: 417.1 417.2 420.9 424.3 438.6 18372.6 19012.0 19923.9 21246.4 21335.4 19276.7 20053.7 20127.0 20129.0 20252.8 5225.5 5352.4 5379.9 5403.8 5407.0 5328.1 5917.6 5927.0 5929.3 5942.3 5728.9 5839.1 5873.6 5875.1 5906.1 5204.9 5352.1 5354.3 5365.1 5375.5 5023.4 5172.3 5191.1 5197.1 5237.3 13595.9 14626.7 14642.7 14678.1 19797.3 2316.0 2378.6 2502.5 2566.4 2623.3 10250.4 10437.5 10819.5 14090.4 14930.4 1961.5 1999.3 2005.9 2071.0 2097.8 84330.0 85969.0 86585.0 86732.6 87505.1 10211.5 11692.9 11694.3 11705.0 11730.5 14510.6 16773.2 16798.2 16809.6 16838.9 7633.7 7908.4 8062.5 8445.2 8834.7 7794.9 7887.6 7893.3 7940.7 7986.3 4633.1 4797.3 4997.4 5080.8 5103.7 2031.8 2061.2 2129.9 2130.6 2132.4 950.9 1111.9 1121.8 1127.6 1132.7 19214.6 19462.6 19908.7 20055.5 20084.5 1039.1 1074.7 1076.8 1091.3 1097.7 10660.1 11085.8 11173.4 11188.3 11276.2 443701.0 449904.0 483437.0 505295.0 509737.0 59683.4 66763.3 86361.0 97770.0 99268.5 1069.8 1070.5 1072.8 1104.5 1108.8 17619.2 18034.4 18081.1 18138.2 18310.5 41738.2 41972.0 43132.4 44001.8 44117.8 58883.1 59302.4 59968.7 60560.4 60562.4 8878.4 8916.7 8960.6 9063.3 9177.0 11994.5 13658.6 13751.2 13927.9 13941.0 11627.8 11847.3 11896.6 12049.4 12635.7 11822.0 11850.2 11942.6 12028.3 12415.9 11512.7 12356.9 12465.3 12684.0 12706.3 8980.6 9101.9 9123.0 9200.3 9320.7 9255.0 11843.8 11901.4 11944.1 12228.4 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | [#3] mootools.html Cycles:180 Average:6398.50 Median:3593.94 stddev:3736.46 (104.0%) stddev-sans-first:3729.16 19:03:48 INFO - PROCESS | 6633 | Values: 1547.8 1588.2 1774.0 1861.8 1863.6 9348.9 9729.1 9981.7 10008.5 10017.0 10127.0 10238.5 10274.7 10275.5 10299.1 2467.1 2506.4 2507.4 2508.5 2524.8 2457.7 2494.7 2511.5 2512.8 2515.5 2407.1 2447.1 2473.2 2484.6 2489.4 2420.3 2442.0 2455.6 2468.9 2469.4 2480.2 2489.8 2490.3 2516.5 2521.0 9928.3 9950.8 10019.1 10025.8 10064.9 5534.6 5607.9 5646.3 5698.9 5709.9 3469.3 3514.9 3565.9 3622.0 3637.6 1156.4 1184.3 1194.6 1205.2 1225.4 13881.9 13901.3 13944.3 13990.2 14073.6 4584.7 4652.3 4710.0 4733.0 4733.0 10908.8 10914.5 10935.5 10960.5 10993.2 5572.4 5597.7 5627.9 5636.9 5652.9 4542.6 5192.9 5237.6 5323.1 5329.2 4046.8 4066.0 4075.8 4100.7 4112.8 1128.2 1171.0 1185.0 1191.2 1206.4 930.7 988.4 1092.6 1113.8 1133.5 6465.9 6664.8 6674.0 6869.4 6877.6 1016.2 1053.5 1054.8 1074.6 1091.5 4473.5 4590.2 4629.1 4660.2 4681.3 12234.1 12499.9 12504.7 12524.6 12527.4 11707.9 12161.3 12169.6 12221.1 12239.2 9090.4 9180.4 9279.6 9285.4 9290.8 6709.0 6756.8 6817.0 6982.3 7111.4 11211.4 11382.8 11428.9 11559.6 11709.5 10902.9 11249.5 11488.1 11571.5 11727.1 7733.1 8195.1 8441.0 8698.1 8883.7 9184.4 9252.0 9323.4 9358.0 9388.4 7861.9 8157.3 8182.1 8245.3 8291.3 8308.2 8321.7 8334.0 8416.1 8440.7 7428.8 7569.8 7590.4 7594.3 7598.4 5482.3 5564.2 5589.6 5636.0 5708.6 5798.3 5827.3 5909.3 5938.1 5946.3 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | [#4] prototype.html Cycles:180 Average:5052.07 Median:5763.48 stddev:1500.82 (26.0%) stddev-sans-first:1462.83 19:03:48 INFO - PROCESS | 6633 | Values: 343.8 348.2 349.8 351.6 357.6 5652.9 5757.2 5760.6 5789.3 5799.3 5675.1 5676.7 5687.3 5699.1 5702.3 4063.7 4295.0 4375.8 4388.7 4408.2 4374.2 4395.7 4406.6 4408.5 4424.2 4377.1 4403.7 4406.4 4412.4 4412.8 4316.2 4371.4 4381.4 4394.4 4410.8 3839.9 3845.9 3903.4 3904.7 3907.9 5486.3 5515.2 5527.5 5555.9 5569.0 4941.7 4952.7 5063.7 5071.2 5079.5 5885.5 5895.3 5941.5 5961.0 5977.7 4297.2 4327.4 4336.9 4354.6 4385.0 5892.9 6070.5 6131.8 6154.2 6164.9 4372.7 4397.6 4410.6 4414.8 4417.7 4457.3 4481.9 4509.9 4525.8 4528.9 4836.7 5029.9 5041.6 5050.2 5072.9 5932.8 5958.2 5988.7 6018.9 6039.7 1505.4 1514.2 1520.6 1540.5 1558.5 917.8 933.3 978.9 1034.4 1052.0 5690.9 5754.6 5803.2 5839.0 5850.2 6128.5 6140.0 6152.0 6176.0 6179.7 5634.9 5762.2 5764.8 5773.7 5782.9 3280.9 3281.4 3283.0 3289.9 3300.5 6080.9 6353.2 6359.7 6373.7 6381.5 6214.5 6234.7 6241.6 6266.7 6276.1 6120.5 6194.2 6308.4 6364.9 6376.7 6180.3 6201.3 6215.3 6233.7 6259.3 6172.6 6181.8 6202.6 6223.3 6238.3 6297.5 6446.9 6495.4 6504.5 6528.5 4364.5 4372.7 4373.1 4401.7 4406.0 6028.6 6243.4 6275.7 6304.2 6328.8 6059.8 6077.9 6094.2 6120.6 6138.4 6049.3 6100.9 6147.9 6154.4 6164.8 5688.7 5776.9 5894.9 5973.6 5973.9 6088.8 6125.2 6132.9 6176.3 6180.6 5663.2 5891.9 5898.5 5934.4 6006.8 19:03:48 INFO - PROCESS | 6633 | 19:03:48 INFO - PROCESS | 6633 | [#5] yui.html Cycles:180 Average:21327.81 Median:4487.74 stddev:30249.83 (674.1%) stddev-sans-first:30295.31 19:03:48 INFO - PROCESS | 6633 | Values: 771.3 796.2 806.1 823.8 846.5 17814.4 18280.2 18284.5 18315.7 18350.5 16318.8 16543.8 16613.9 16703.4 16756.8 821.4 845.3 858.3 867.2 872.1 853.1 857.7 863.8 866.4 867.5 902.8 908.9 908.9 914.3 915.3 895.9 897.2 897.7 898.3 899.3 661.9 662.7 663.2 665.5 666.7 16365.3 16393.2 16422.1 16482.8 16505.8 13643.8 14173.6 14483.9 15179.6 15651.1 12001.8 12098.1 12232.8 12296.9 12433.0 3928.1 4003.7 4038.4 4048.2 4072.8 60965.4 69493.7 72078.0 72284.6 81060.0 11816.6 12142.8 12170.3 12265.9 12436.8 22825.5 22897.0 23005.8 23323.5 23458.6 8854.6 9052.0 9159.0 9172.6 9184.9 5020.2 5035.7 5096.8 5164.6 5251.7 3885.3 4016.0 4018.3 4027.3 4028.1 634.5 700.0 706.0 706.9 709.7 757.1 786.5 809.3 819.3 836.5 9991.6 10323.2 10463.9 10500.7 10704.6 561.9 648.0 697.4 722.7 741.7 4902.7 4916.0 4952.8 4970.2 4995.9 98799.0 114391.4 117323.0 118942.0 120238.4 86692.6 96366.0 99673.5 101350.5 102940.5 87279.0 89509.6 90261.5 90459.0 90654.0 9206.4 9252.4 9336.9 9337.7 9659.1 38793.6 50333.7 52016.5 52608.7 54482.7 83693.2 83868.6 86372.0 88101.6 88273.6 12770.7 12910.2 12969.6 13031.2 13344.3 13934.8 14358.2 14610.1 14830.9 15303.3 13896.4 14089.6 14110.8 14185.2 14329.5 12859.7 13889.4 14033.9 14144.2 14310.5 13195.1 13344.0 13470.5 13553.9 13881.8 11141.8 11235.5 11740.6 11762.1 11843.6 11666.4 11770.5 11954.6 12011.5 12142.3 19:03:48 INFO - PROCESS | 6633 | -------- Summary: end -------- 19:03:48 INFO - PROCESS | 6633 | 19:03:49 INFO - TEST-INFO | 6633: exit 0 19:03:49 INFO - TEST-OK | dromaeo_css | took 1110600ms 19:03:49 INFO - TEST-START | kraken 19:03:49 INFO - operating with platform_type : linux_ 19:03:49 INFO - Initialising browser for kraken test... 19:03:49 INFO - TEST-INFO | started process 6880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppRuFfd/profile http://localhost:48617/getInfo.html) 19:03:53 INFO - PROCESS | 6880 | __metrics Screen width/height:1600/1200 19:03:53 INFO - PROCESS | 6880 | colorDepth:24 19:03:53 INFO - PROCESS | 6880 | Browser inner width/height: 1024/697 19:03:53 INFO - PROCESS | 6880 | __metrics 19:03:54 ERROR - PROCESS | 6880 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:03:55 INFO - TEST-INFO | 6880: exit 0 19:03:55 INFO - Browser initialized. 19:03:55 INFO - Running cycle 1/1 for kraken test... 19:03:55 INFO - TEST-INFO | started process 7005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppRuFfd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:07 INFO - PROCESS | 7005 | RSS: Main: 155783168 19:04:07 INFO - PROCESS | 7005 | 19:04:09 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48617/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:10 INFO - PROCESS | 7005 | RSS: Main: 160751616 19:04:10 INFO - PROCESS | 7005 | 19:04:13 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48617/tests/kraken/driver.html?testName=audio-dft) 19:04:13 INFO - PROCESS | 7005 | RSS: Main: 160096256 19:04:13 INFO - PROCESS | 7005 | 19:04:16 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48617/tests/kraken/driver.html?testName=audio-fft) 19:04:17 INFO - PROCESS | 7005 | RSS: Main: 160837632 19:04:17 INFO - PROCESS | 7005 | 19:04:19 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48617/tests/kraken/driver.html?testName=audio-oscillator) 19:04:20 INFO - PROCESS | 7005 | RSS: Main: 160911360 19:04:20 INFO - PROCESS | 7005 | 19:04:22 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:22 INFO - PROCESS | 7005 | RSS: Main: 160559104 19:04:22 INFO - PROCESS | 7005 | 19:04:25 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48617/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:26 INFO - PROCESS | 7005 | RSS: Main: 160481280 19:04:26 INFO - PROCESS | 7005 | 19:04:29 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48617/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:30 INFO - PROCESS | 7005 | RSS: Main: 161206272 19:04:30 INFO - PROCESS | 7005 | 19:04:33 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48617/tests/kraken/driver.html?testName=json-parse-financial) 19:04:33 INFO - PROCESS | 7005 | RSS: Main: 160665600 19:04:33 INFO - PROCESS | 7005 | 19:04:35 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:36 INFO - PROCESS | 7005 | RSS: Main: 160190464 19:04:36 INFO - PROCESS | 7005 | 19:04:37 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:38 INFO - PROCESS | 7005 | RSS: Main: 160751616 19:04:38 INFO - PROCESS | 7005 | 19:04:40 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:41 INFO - PROCESS | 7005 | RSS: Main: 161067008 19:04:41 INFO - PROCESS | 7005 | 19:04:43 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:44 INFO - PROCESS | 7005 | RSS: Main: 161464320 19:04:44 INFO - PROCESS | 7005 | 19:04:47 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:47 INFO - PROCESS | 7005 | RSS: Main: 160903168 19:04:47 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | Cycle 1(1): loaded http://localhost:48617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48617/tests/kraken/driver.html?testName=ai-astar) 19:04:49 INFO - PROCESS | 7005 | RSS: Main: 161554432 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | __start_tp_report 19:04:49 INFO - PROCESS | 7005 | _x_x_mozilla_page_load 19:04:49 INFO - PROCESS | 7005 | _x_x_mozilla_page_load_details 19:04:49 INFO - PROCESS | 7005 | |i|pagename|runs| 19:04:49 INFO - PROCESS | 7005 | |0;ai-astar;110;104;110;109;110;109;110;108;112;109 19:04:49 INFO - PROCESS | 7005 | |1;audio-beat-detection;152;124;150;171;128;164;155;130;193;125 19:04:49 INFO - PROCESS | 7005 | |2;audio-dft;164;161;162;163;162;162;163;164;163;161 19:04:49 INFO - PROCESS | 7005 | |3;audio-fft;75;76;76;174;76;75;74;77;174;75 19:04:49 INFO - PROCESS | 7005 | |4;audio-oscillator;86;85;142;85;86;87;139;86;84;145 19:04:49 INFO - PROCESS | 7005 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;118;117;118 19:04:49 INFO - PROCESS | 7005 | |6;imaging-darkroom;147;146;147;146;147;147;146;146;147;147 19:04:49 INFO - PROCESS | 7005 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 19:04:49 INFO - PROCESS | 7005 | |8;json-parse-financial;52;51;53;52;52;53;55;52;52;53 19:04:49 INFO - PROCESS | 7005 | |9;json-stringify-tinderbox;59;59;59;60;60;59;59;61;61;60 19:04:49 INFO - PROCESS | 7005 | |10;stanford-crypto-aes;77;76;83;78;79;80;77;77;101;78 19:04:49 INFO - PROCESS | 7005 | |11;stanford-crypto-ccm;135;128;139;120;137;117;117;133;130;126 19:04:49 INFO - PROCESS | 7005 | |12;stanford-crypto-pbkdf2;157;155;159;162;154;157;157;159;153;153 19:04:49 INFO - PROCESS | 7005 | |13;stanford-crypto-sha256-iterative;62;63;63;64;65;63;61;62;66;60 19:04:49 INFO - PROCESS | 7005 | __end_tp_report 19:04:49 INFO - PROCESS | 7005 | __start_cc_report 19:04:49 INFO - PROCESS | 7005 | _x_x_mozilla_cycle_collect,866 19:04:49 INFO - PROCESS | 7005 | __end_cc_report 19:04:49 INFO - PROCESS | 7005 | __startTimestamp1468375489584__endTimestamp 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | ------- Summary: start ------- 19:04:49 INFO - PROCESS | 7005 | Number of tests: 14 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.08 (1.9%) stddev-sans-first:2.18 19:04:49 INFO - PROCESS | 7005 | Values: 110.0 104.0 110.0 109.0 110.0 109.0 110.0 108.0 112.0 109.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:153.50 stddev:22.84 (14.9%) stddev-sans-first:24.20 19:04:49 INFO - PROCESS | 7005 | Values: 152.0 124.0 150.0 171.0 128.0 164.0 155.0 130.0 193.0 125.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 19:04:49 INFO - PROCESS | 7005 | Values: 164.0 161.0 162.0 163.0 162.0 162.0 163.0 164.0 163.0 161.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.50 stddev:41.54 (55.0%) stddev-sans-first:43.41 19:04:49 INFO - PROCESS | 7005 | Values: 75.0 76.0 76.0 174.0 76.0 75.0 74.0 77.0 174.0 75.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.50 stddev:27.31 (31.9%) stddev-sans-first:28.30 19:04:49 INFO - PROCESS | 7005 | Values: 86.0 85.0 142.0 85.0 86.0 87.0 139.0 86.0 84.0 145.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:04:49 INFO - PROCESS | 7005 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 118.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:04:49 INFO - PROCESS | 7005 | Values: 147.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 19:04:49 INFO - PROCESS | 7005 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:1.08 (2.1%) stddev-sans-first:1.13 19:04:49 INFO - PROCESS | 7005 | Values: 52.0 51.0 53.0 52.0 52.0 53.0 55.0 52.0 52.0 53.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 19:04:49 INFO - PROCESS | 7005 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 59.0 61.0 61.0 60.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:78.00 stddev:7.44 (9.5%) stddev-sans-first:7.78 19:04:49 INFO - PROCESS | 7005 | Values: 77.0 76.0 83.0 78.0 79.0 80.0 77.0 77.0 101.0 78.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:131.50 stddev:8.09 (6.2%) stddev-sans-first:8.20 19:04:49 INFO - PROCESS | 7005 | Values: 135.0 128.0 139.0 120.0 137.0 117.0 117.0 133.0 130.0 126.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.00 stddev:2.91 (1.9%) stddev-sans-first:3.09 19:04:49 INFO - PROCESS | 7005 | Values: 157.0 155.0 159.0 162.0 154.0 157.0 157.0 159.0 153.0 153.0 19:04:49 INFO - PROCESS | 7005 | 19:04:49 INFO - PROCESS | 7005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.79 (2.8%) stddev-sans-first:1.87 19:04:49 INFO - PROCESS | 7005 | Values: 62.0 63.0 63.0 64.0 65.0 63.0 61.0 62.0 66.0 60.0 19:04:49 INFO - PROCESS | 7005 | -------- Summary: end -------- 19:04:49 INFO - PROCESS | 7005 | 19:04:50 INFO - TEST-INFO | 7005: exit 0 19:04:50 INFO - TEST-OK | kraken | took 61153ms 19:04:50 INFO - SUITE-END | took 1171s 19:04:50 INFO - Completed test suite (00:19:31) 19:04:50 INFO - javascript benchmark 19:04:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7679.314265441013, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.7173140283076, 3387.830608469579, 3393.355262500124, 3414.1635299351665, 3425.469052296895, 5683.175939488771, 5696.174054762052, 5697.9999999999945, 5700.515456186224, 5724.5992780505385, 5722.341930677973, 5754.510866576346, 5760.308762948452, 5768.932747441726, 5778.24882765241, 5125.743712814363, 5156.175011998081, 5184.792608295664, 5221.425643179247, 5229.189475631283, 5052.747362631872, 5055.797768089272, 5217.0, 5222.9477705223035, 5243.344581927259, 5081.923771143417, 5111.948880511184, 5131.461196574362, 5158.303629010074, 5164.2253661950635, 5131.358580177496, 5149.201873709562, 5157.406898206679, 5159.6646217996085, 5164.45773193813, 5110.310108135392, 5115.539601435851, 5182.740862956837, 5194.142966410575, 5222.399424066243, 5334.5732341412595, 5445.428230035868, 5510.9448905511235, 5562.527185189264, 5571.275734154534, 6050.939490605082, 6059.424354686298, 6062.545309101835, 6079.0, 6083.9391606084255, 6088.969555152196, 6127.87744245117, 6136.355682653347, 6138.570300078996, 6167.475764559973, 5497.257870187514, 5665.54675625953, 5686.971565142189, 5726.627769195031, 5750.971245143747, 6234.937650623527, 6261.9373806262265, 6281.497480201573, 6285.182926219653, 6292.905606415908, 5713.22871412354, 6029.698515074228, 6033.5173186145, 6040.426159514839, 6051.939480605138, 6016.608920420159, 6039.486643635252, 6071.423214794588, 6128.724207410677, 6135.969320153371, 6048.848778780566, 6054.243219597551, 6054.3642917493025, 6069.544784141207, 6075.726592303357, 5802.970985145132, 6005.858886811579, 6079.392060793885, 6082.148499210114, 6089.269287685506, 4617.515160908123, 4693.8969342204555, 4695.460022097434, 4699.365585645963, 4707.940713339472, 4141.772202528829, 4159.500859896832, 4161.0, 4169.895752606149, 4192.0, 5789.160571717078, 5791.623544469596, 5799.159121927381, 5874.089516125007, 5907.350191478934, 5939.910901336483, 6039.969800150971, 6069.937760891827, 6100.420460056288, 6153.292371377349, 5852.063669812809, 5899.233099697012, 5900.321463031721, 5910.940890591125, 5913.852153696106, 5125.103106956268, 5216.843494695166, 5245.082110630625, 5245.816396426183, 5316.521513063843, 6336.17629708135, 6339.334369891188, 6398.360163983658, 6414.839629009312, 6418.967905160444, 6153.600015998945, 6157.96921015392, 6169.259688837278, 6172.4136207060255, 6175.228096487939, 6034.09488576717, 6113.84715382119, 6210.627362358273, 6237.906431403442, 6318.147050148355, 5946.583739138392, 5969.910451343147, 5973.253343332083, 5975.880482390241, 6016.368281330398, 5808.448197421239, 6059.242594675666, 6076.361981991828, 6080.695965201634, 6084.695765211633, 5903.675297858487, 5980.372060933713, 5988.550858685703, 6007.849803754941, 6016.548758843017, 5960.284765828128, 5974.1934838796205, 5982.4017598239825, 6001.099835024781, 6028.065649824284, 5662.546996240373, 5711.457411545896, 5833.212516310244, 5901.173835663097, 5912.260967379078, 5891.263592050994, 5954.345022047658, 5961.701914904324, 5992.250968628921, 5996.760129594767, 5817.650940943557, 5862.736176871966, 5869.882602348014, 5872.970635146797, 5876.853078673067], "value": 5612.058505584214, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6807757849551, 641.7080228496035, 650.034698472768, 663.1809715001972, 663.2902794010408, 44288.55711442885, 45818.54181458185, 46131.769341153245, 46203.30695039569, 51147.744261278734, 48234.75882620582, 48676.75661621696, 48992.75503622477, 49013.0, 49073.75463122688, 9090.54547272637, 9170.220531254852, 9179.219766319837, 9220.262379009697, 9240.0, 9069.138431848964, 9090.09099090089, 9108.817823643523, 9134.26925845934, 9146.542672866364, 9118.316126290521, 9130.77173070672, 9141.86287205689, 9155.176034156924, 9204.631814727403, 9171.17459428648, 9197.448153110801, 9214.53927303639, 9236.030216827203, 9237.815243695122, 8984.460932344015, 8992.910070899337, 9038.954805225998, 9059.728208153765, 9085.04607016267, 44258.0, 44699.77650111761, 44786.0, 44918.55081449176, 44976.55023449756, 3869.4776205212497, 4039.454673619053, 4167.229062623394, 4169.541350451448, 4365.628921541673, 34237.486437703454, 34636.13409664779, 34662.65337346619, 34762.13094672653, 34784.6521534784, 4659.553579882678, 4724.0, 4754.78603462845, 4760.738159401231, 4763.833265835679, 385547.0, 388540.0, 388703.0, 388889.0, 389673.0, 60665.69667151636, 61018.69490652518, 61505.38494614996, 61583.6920815393, 61705.691471542355, 38692.80653596714, 39423.60576394256, 39614.60385396109, 41747.791261044105, 65358.0, 15883.920580397255, 15910.12494312824, 15942.123183225034, 15968.121753303447, 15968.441104561285, 11799.646010619696, 11879.643610691694, 11933.224340418019, 11937.52249909994, 11967.940160299142, 20971.161153553687, 21049.158033678483, 21105.68341474879, 21121.78878211229, 21225.68161477579, 7434.479586428898, 7434.628268586549, 7471.850562988819, 7614.466987310946, 7631.122420921554, 1091.781643671269, 1115.6597237842536, 1141.4121727310442, 1176.9583918232427, 1250.3560666256885, 33892.83053584716, 33893.83053084719, 34124.317513649585, 34163.31673366519, 35518.82240588832, 1147.6212849759559, 1265.7658333208385, 1273.1279073834453, 1282.0512820512754, 1284.5760898903338, 17320.826791732172, 17661.11694415274, 17714.432918190127, 17808.821911780717, 17905.7314140288, 589923.0, 590947.0, 625595.0, 987707.0, 1010165.0, 62994.68502657549, 63298.0505292421, 64032.0, 64068.0, 64146.679266603365, 1415.2852809331428, 1472.49935022093, 1473.7715654073636, 1500.2048914075558, 1510.7129645367345, 29024.0, 29831.70168298376, 29872.0, 30036.549451757804, 30333.696663033086, 54390.18414723703, 54617.45382546283, 55016.0, 55101.44898550963, 55141.72429137828, 511053.0, 512477.0, 516474.0, 517596.0, 517736.0, 27848.443031138857, 28262.0, 28283.717162828107, 28333.716662833107, 30583.694163058084, 51037.0, 51233.48766512287, 51553.22670160026, 52260.0, 52625.0, 42887.571124288355, 43035.78482107569, 44150.55849441465, 44231.55768442275, 44754.3286850691, 42342.78828605837, 42895.57104428916, 43200.0, 44263.55736442723, 44573.55426445824, 42777.78611107049, 43428.348574770775, 43998.0, 44298.0, 44614.3307850389, 36283.818580906925, 37156.44265336076, 37686.81156594199, 37861.621383786915, 38039.2392152161, 28957.56563651589, 29251.85374073116, 29568.852155739085, 29816.70183298139, 29923.70076299209], "value": 21294.21809033201, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.1240395170143, 417.1844044892236, 420.8674267605706, 424.27237288050986, 438.59430027224806, 18372.63254734906, 19012.0, 19923.900380498097, 21246.362609121752, 21335.359939201848, 19276.710849337236, 20053.699194512094, 20127.0, 20128.999999999964, 20252.797472025275, 5225.477452254772, 5352.411234764173, 5379.865503362408, 5403.756830942617, 5406.972965135169, 5328.1474964005765, 5917.5561832862495, 5926.962781513218, 5929.347771745104, 5942.257217847769, 5728.885422291552, 5839.065749480084, 5873.647581145145, 5875.089361149029, 5906.143609176666, 5204.9479505204845, 5352.090144675414, 5354.330708661418, 5365.114756065244, 5375.516203541681, 5023.397192336906, 5172.301739265189, 5191.0656081905245, 5197.116490196638, 5237.266782650432, 13595.932020339835, 14626.70746585073, 14642.70714585713, 14678.119312841263, 19797.30709425163, 2315.953680926372, 2378.607529757588, 2502.4869901670295, 2566.409725763085, 2623.34416395901, 10250.384976901336, 10437.530311136017, 10819.459027048617, 14090.436382544685, 14930.402783888632, 1961.4998175465307, 1999.2802591067205, 2005.8796472211714, 2070.95858082839, 2097.8216851567636, 84330.0, 85969.0, 86585.0, 86732.56633716854, 87505.12494875034, 10211.540480678388, 11692.88307116935, 11694.2983420995, 11705.0, 11730.530778768754, 14510.637234069021, 16773.161341932853, 16798.244079016473, 16809.579760506083, 16838.91580542114, 7633.6564854581675, 7908.367330613537, 8062.475939063942, 8445.239928406472, 8834.690785822466, 7794.883076753853, 7887.605619718991, 7893.289603935674, 7940.722074727357, 7986.281234688906, 4633.0733853229485, 4797.304390863305, 4997.350344455198, 5080.847574572768, 5103.7192954387865, 2031.8069783370852, 2061.2064355223347, 2129.9041543130597, 2130.6484430069177, 2132.36029191242, 950.919171870385, 1111.8999290063932, 1121.8485504456958, 1127.622246547416, 1132.6667065844388, 19214.615707686047, 19462.610747784965, 19908.70136947947, 20055.465334166147, 20084.497887552636, 1039.1271332081087, 1074.6937122920087, 1076.8330908709163, 1091.2743025887696, 1097.6597254851022, 10660.093892019266, 11085.83371249432, 11173.441327933571, 11188.272762270426, 11276.154288428237, 443701.0, 449904.0, 483437.0, 505295.0, 509737.0, 59683.403165967786, 66763.33236667668, 86361.0, 97770.0, 99268.50365748125, 1069.8181309177457, 1070.528967254421, 1072.790805792863, 1104.4588151805717, 1108.844761733358, 17619.20713567867, 18034.36879709204, 18081.09594520295, 18138.183781730117, 18310.450686479428, 41738.165236695706, 41972.0, 43132.35301470543, 44001.77999109984, 44117.77941110402, 58883.11675324959, 59302.40697592969, 59968.70015649894, 60560.394396057236, 60562.39437605567, 8878.422902511316, 8916.73249802507, 8960.596773145355, 9063.274938005075, 9177.0, 11994.520219191134, 13658.590242292747, 13751.174929504261, 13927.930360348133, 13941.0, 11627.825582616437, 11847.348395838311, 11896.643100706646, 12049.397530123284, 12635.74728505443, 11822.0, 11850.170488065753, 11942.641720748392, 12028.338441385458, 12415.875841241472, 11512.654620361403, 12356.876431235572, 12465.252084874937, 12684.0, 12706.34220274533, 8980.595873185854, 9101.908980910106, 9123.042080581708, 9200.26397888154, 9320.72037838866, 9255.0, 11843.822342664695, 11901.404929753304, 11944.104192185794, 12228.449719762453], "value": 9374.718568244736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.8065241844772, 1588.2217713320472, 1773.9733903991441, 1861.7858946221172, 1863.6272745450913, 9348.85976710349, 9729.124378805906, 9981.650642227523, 10008.549615267313, 10017.04838040385, 10127.037931396524, 10238.48807559621, 10274.691759247216, 10275.537600807962, 10299.124574411184, 2467.099508679328, 2506.4360518883286, 2507.4107584717576, 2508.4857604191097, 2524.7853932415765, 2457.7296497385273, 2494.725580186178, 2511.4977004599064, 2512.849229046254, 2515.5346260941783, 2407.07327678844, 2447.0945750072497, 2473.2209354053507, 2484.5527804995095, 2489.4025433895918, 2420.3344080377947, 2441.9633705494343, 2455.594826853567, 2468.8888999994865, 2469.370310570811, 2480.231128350217, 2489.8257122001287, 2490.3276115448725, 2516.496700659857, 2521.042004038454, 9928.255380846393, 9950.80098398028, 10019.148372388356, 10025.799484010351, 10064.949675251577, 5534.584906132016, 5607.887842243133, 5646.265985421869, 5698.857528561778, 5709.914351284734, 3469.340825243196, 3514.894553163409, 3565.893023209308, 3621.9818900905325, 3637.618050104754, 1156.410230782307, 1184.3486082654506, 1194.581896336284, 1205.2105870654648, 1225.3628113380992, 13881.930590346983, 13901.304934753221, 13944.302784860818, 13990.230537320444, 14073.577792666134, 4584.6561507887045, 4652.255639097728, 4709.952900470951, 4732.95267047332, 4733.029728905566, 10908.781824363468, 10914.454277286104, 10935.453227338601, 10960.506777195045, 10993.175511836644, 5572.442755724395, 5597.6641401516035, 5627.8593035174445, 5636.943630563724, 5652.943470565324, 4542.613877820422, 5192.948070519246, 5237.5548078413, 5323.095073837457, 5329.200619906967, 4046.7571945683353, 4066.0, 4075.8369665213654, 4100.686772766495, 4112.753234805921, 1128.198978725098, 1170.9648710538697, 1185.040117504824, 1191.237607930925, 1206.4269472000906, 930.6742640076054, 988.3970777825521, 1092.5575142067476, 1113.8440618313443, 1133.4616057372848, 6465.870682586322, 6664.833379165462, 6674.0, 6869.381755642016, 6877.6217308048535, 1016.1515134862325, 1053.4837929414532, 1054.7890421915495, 1074.6238816414193, 1091.5197313182175, 4473.46318441789, 4590.219662657356, 4629.1436084324505, 4660.231061874752, 4681.32120842476, 12234.082443816571, 12499.875001250053, 12504.687382815502, 12524.624261272176, 12527.373631318398, 11707.88292117068, 12161.270323780602, 12169.634910952685, 12221.083418743452, 12239.20445171061, 9090.40912340709, 9180.403273787182, 9279.582418791306, 9285.442873427615, 9290.814183716422, 6709.0, 6756.763513277012, 6816.965915170393, 6982.301769823181, 7111.359977602041, 11211.439428028403, 11382.804805495303, 11428.885711142782, 11559.595414160463, 11709.473073711533, 10902.945485272523, 11249.49377278008, 11488.080953523866, 11571.537138514364, 11727.061835053346, 7733.072031356273, 8195.139510351328, 8441.029281632445, 8698.086700896567, 8883.689070882489, 9184.448933064037, 9251.982281948845, 9323.440593564408, 9358.0, 9388.389754665925, 7861.882071768814, 8157.265846073882, 8182.099969003524, 8245.340372770284, 8291.33669306442, 8308.169183081643, 8321.667133314842, 8333.95833020831, 8416.074231834617, 8440.66237350499, 7428.777136685908, 7569.772906812805, 7590.39276857839, 7594.31651151399, 7598.392128629807, 5482.314710661168, 5564.221009058654, 5589.552646884872, 5636.0418728815375, 5708.600397972268, 5798.333191682842, 5827.329857066322, 5909.349971503218, 5938.079597662369, 5946.286445626552], "value": 5058.252581928387, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7765452455905, 348.2286734882236, 349.7569189413357, 351.56581621697217, 357.59055881016235, 5652.915206271904, 5757.193992841006, 5760.559860034991, 5789.334226563947, 5799.289209683143, 5675.148727690848, 5676.716164191785, 5687.289088863892, 5699.145128230767, 5702.287214098238, 4063.7358571692744, 4294.9570504295025, 4375.7593332366705, 4388.71473354231, 4408.228560002003, 4374.212641724488, 4395.736255824645, 4406.625436837857, 4408.4709834819705, 4424.203643344197, 4377.146456440995, 4403.735775853459, 4406.383106365111, 4412.426384570002, 4412.82348706053, 4316.244657184996, 4371.366151907955, 4381.408509851193, 4394.4067550880545, 4410.75740834254, 3839.865604703822, 3845.903852403684, 3903.394973779069, 3904.6876249899938, 3907.9218415631813, 5486.286782718221, 5515.200295957104, 5527.53015993637, 5555.9443705695785, 5568.99758043552, 4941.703497790144, 4952.653314268003, 5063.721495317756, 5071.1632580624155, 5079.492050794928, 5885.470307672287, 5895.322037965646, 5941.494972927307, 5961.046232602763, 5977.731002104916, 4297.247981603207, 4327.415798867176, 4336.934945975813, 4354.629856462205, 4384.978075109636, 5892.882142357129, 6070.453659170696, 6131.846703832395, 6154.230721159855, 6164.907526387108, 4372.650187984954, 4397.6042156206095, 4410.610657642832, 4414.823407063682, 4417.668674849335, 4457.286834106528, 4481.865544033684, 4509.864704058883, 4525.751083690363, 4528.864134075983, 4836.685615434985, 5029.899402012013, 5041.596672266283, 5050.1667224908215, 5072.923906141411, 5932.79235226765, 5958.242318516048, 5988.670623115683, 6018.92347140236, 6039.7282122304605, 1505.4204131409485, 1514.1999860442425, 1520.6426489774894, 1540.5224380442098, 1558.5012795905427, 917.7934964632905, 933.295362001698, 978.9461579613189, 1034.4207243943415, 1051.9684409467727, 5690.857728556736, 5754.625949313281, 5803.245578074823, 5838.970805146032, 5850.23946886902, 6128.479079278222, 6139.969300153471, 6151.96924015377, 6176.011838105882, 6179.682619017868, 5634.887302253932, 5762.164486149485, 5764.798232061858, 5773.711314434261, 5782.855428614318, 3280.917977050593, 3281.3765384576855, 3282.9658657522805, 3289.851956661908, 3300.455424854872, 6080.908786368208, 6353.237611486651, 6359.745610175633, 6373.74505019794, 6381.489480841522, 6214.533909956681, 6234.657093859882, 6241.594296370721, 6266.749330026748, 6276.112988025468, 6120.479759220516, 6194.225721784777, 6308.432241098231, 6364.936350636527, 6376.7130479128555, 6180.3201647817805, 6201.317855036033, 6215.285242197205, 6233.693533392674, 6259.3427690091885, 6172.629642221481, 6181.783637572664, 6202.5658203925295, 6223.284322302812, 6238.282597501164, 6297.527685423704, 6446.935530644633, 6495.382938620824, 6504.544681872224, 6528.510361722985, 4364.468608207296, 4372.6939114261695, 4373.1253749249645, 4401.713888597231, 4405.9559404405545, 6028.57799953999, 6243.406876346739, 6275.717592708248, 6304.211973503312, 6328.841778955563, 6059.788177315337, 6077.908831367445, 6094.177286066324, 6120.60216085953, 6138.355472675484, 6049.334573197033, 6100.877982440237, 6147.877042459037, 6154.3845615438095, 6164.815055548341, 5688.658680479184, 5776.855578610568, 5894.911576326273, 5973.641581505123, 5973.894829456564, 6088.756449741961, 6125.203723515914, 6132.9080063799975, 6176.258848938156, 6180.567360284737, 5663.207150998781, 5891.852703682443, 5898.498627616529, 5934.43622855828, 6006.789762358297], "value": 4568.589917697433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.2942657468413, 796.1560745609653, 806.0810675829555, 823.8352329534093, 846.5344060766577, 17814.376496822613, 18280.177392017373, 18284.542886427847, 18315.725264121033, 18350.541236469096, 16318.83681163188, 16543.83456165438, 16613.91693041533, 16703.415380461687, 16756.83243167568, 821.4126899267023, 845.3364109174299, 858.3176374782063, 867.2065060469663, 872.0668884293808, 853.1468531468531, 857.7126662568047, 863.7883718488947, 866.3632230310717, 867.4968518259426, 902.7562558109306, 908.8863892013499, 908.9363744537885, 914.2959920860933, 915.2860768600502, 895.9372843900929, 897.1790811407554, 897.6768363389207, 898.3172788680585, 899.2895612466144, 661.8676264747022, 662.652107643491, 663.2140913018089, 665.5474277491304, 666.6833254204263, 16365.34538618454, 16393.180340982904, 16422.096784676836, 16482.75275870863, 16505.752413713803, 13643.795343069862, 14173.574792756132, 14483.855161448357, 15179.649609027087, 15651.060936343856, 12001.759964800654, 12098.092643051717, 12232.81650775239, 12296.877031229662, 12433.005359571303, 3928.135810121769, 4003.719739618228, 4038.3942408638645, 4048.2308361411533, 4072.7759973201464, 60965.390346096414, 69493.65253173752, 72078.0, 72284.63857680731, 81060.0, 11816.645500634995, 12142.75714485723, 12170.330631815157, 12265.877341226653, 12436.81344779829, 22825.543489130123, 22897.0, 23005.76994230036, 23323.533529329317, 23458.64812027821, 8854.557272136368, 9051.954740226256, 9159.038300978435, 9172.633094676272, 9184.90815091854, 5020.221865610836, 5035.748212589356, 5096.796128154906, 5164.561012313995, 5251.711155886386, 3885.339492286318, 4016.036151323661, 4018.276710192135, 4027.2549578327516, 4028.113814960704, 634.4575388043249, 699.9720011199597, 705.971761129549, 706.9328413800681, 709.7232079489004, 757.0796372368138, 786.5241528874948, 809.2797410304834, 819.332244220958, 836.5315423362936, 9991.600335986624, 10323.225758068025, 10463.895361046292, 10500.737481563023, 10704.625338113128, 561.9185218143429, 648.0376640688573, 697.4281089506555, 722.6765799256506, 741.7478057460489, 4902.7058376497525, 4915.975420122948, 4952.801887924443, 4970.179920313108, 4995.850124496271, 98799.0, 114391.42804286092, 117323.0, 118942.0, 120238.3988080054, 86692.56653716692, 96366.0, 99673.50163249137, 101350.49324753329, 102940.48529757453, 87279.0, 89509.55245223732, 90261.54869225743, 90458.99999999869, 90654.0, 9206.447613143233, 9252.352335336462, 9336.859947100664, 9337.673181438617, 9659.130678238993, 38793.612063879, 50333.74833125811, 52016.479835201164, 52608.73695631498, 54482.72758636181, 83693.16306837097, 83868.58065709632, 86372.0, 88101.55949220213, 88273.55863220643, 12770.68073298175, 12910.160839545399, 12969.613053288233, 13031.152975056591, 13344.266065366499, 13934.790978135134, 14358.210298433687, 14610.123392596479, 14830.851691483378, 15303.311350989456, 13896.37466313998, 14089.577312680636, 14110.76803746974, 14185.219812910389, 14329.498467553585, 12859.678508037374, 13889.444422222998, 14033.929830350782, 14144.151350918977, 14310.49913253031, 13195.142315749446, 13344.0, 13470.461181552628, 13553.86446135526, 13881.791773123614, 11141.832872506757, 11235.494402751732, 11740.58907938218, 11762.117841161777, 11843.58547450835, 11666.358350290815, 11770.52917883275, 11954.58158964432, 12011.519539218334, 12142.271463712206], "value": 7920.804724515649, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 110.0, 109.0, 110.0, 108.0, 112.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 150.0, 171.0, 128.0, 164.0, 155.0, 130.0, 193.0, 125.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 163.0, 162.0, 162.0, 163.0, 164.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 174.0, 76.0, 75.0, 74.0, 77.0, 174.0, 75.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 142.0, 85.0, 86.0, 87.0, 139.0, 86.0, 84.0, 145.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 52.0, 52.0, 53.0, 55.0, 52.0, 52.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 61.0, 61.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 83.0, 78.0, 79.0, 80.0, 77.0, 77.0, 101.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 139.0, 120.0, 137.0, 117.0, 117.0, 133.0, 130.0, 126.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 159.0, 162.0, 154.0, 157.0, 157.0, 159.0, 153.0, 153.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 65.0, 63.0, 61.0, 62.0, 66.0, 60.0], "value": 62.9, "unit": "score"}]}]} 19:04:50 INFO - Return code: 0 19:04:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:04:50 ERROR - # TBPL SUCCESS # 19:04:50 INFO - Running post-action listener: _resource_record_post_action 19:04:50 INFO - ##### 19:04:50 INFO - ##### Finished run-tests step (success) 19:04:50 INFO - ##### 19:04:50 INFO - Running post-run listener: _resource_record_post_run 19:04:50 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 286720; Write bytes: 505372672; Read time: 32; Write time: 490180 19:04:50 INFO - TinderboxPrint: CPU usage
13.3% 19:04:50 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 32 19:04:50 INFO - TinderboxPrint: I/O write bytes / time
505,372,672 / 490,180 19:04:50 INFO - TinderboxPrint: CPU idle
8,219.7 (86.6%) 19:04:50 INFO - TinderboxPrint: CPU user
1,210.2 (12.8%) 19:04:50 INFO - TinderboxPrint: Swap in / out
0 / 0 19:04:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252710912; Read time: 0; Write time: 326248 19:04:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252661760; Read time: 20; Write time: 163932 19:04:51 INFO - Running post-run listener: _upload_blobber_files 19:04:51 INFO - Blob upload gear active. 19:04:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:04:51 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 19:04:51 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:04:51 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:04:51 INFO - (blobuploader) - INFO - Open directory for files ... 19:04:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:04:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:52 INFO - (blobuploader) - INFO - Done attempting. 19:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:57 INFO - (blobuploader) - INFO - Done attempting. 19:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:59 INFO - (blobuploader) - INFO - Done attempting. 19:04:59 INFO - (blobuploader) - INFO - Iteration through files over. 19:04:59 INFO - Return code: 0 19:04:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:04:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:04:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997e3f20492a1200c4a06b9a19902cfad0fa1cc4b3f623dc102b67ccdb8d065c7699ea533070a4cb57c90d58cdefbcf9d4f742055f637fe01a9396bf936737a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/320e9d9d6ae31b00e7ae5423cce0fa6e1249600af4f5591bd91476ebd5853e7d6132cfc6a5662d37afcdc0660be510c7028bd55b1cfb149cc853b3416186f9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c621d265aeded58c3b341e95ff845b936da5928c8b804c2d3a2f16e41afc50d572a673e6e69792b7cd4c6aec832c55e00e7eea625be02da85430a23a22b61db"} 19:04:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:04:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:04:59 INFO - Contents: 19:04:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997e3f20492a1200c4a06b9a19902cfad0fa1cc4b3f623dc102b67ccdb8d065c7699ea533070a4cb57c90d58cdefbcf9d4f742055f637fe01a9396bf936737a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/320e9d9d6ae31b00e7ae5423cce0fa6e1249600af4f5591bd91476ebd5853e7d6132cfc6a5662d37afcdc0660be510c7028bd55b1cfb149cc853b3416186f9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c621d265aeded58c3b341e95ff845b936da5928c8b804c2d3a2f16e41afc50d572a673e6e69792b7cd4c6aec832c55e00e7eea625be02da85430a23a22b61db"} 19:04:59 INFO - Running post-run listener: copy_logs_to_upload_dir 19:04:59 INFO - Copying logs to upload dir... 19:04:59 INFO - mkdir: /builds/slave/test/build/upload/logs 19:04:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.117883 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-12 19:04:58.915728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:04:58.924747) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997e3f20492a1200c4a06b9a19902cfad0fa1cc4b3f623dc102b67ccdb8d065c7699ea533070a4cb57c90d58cdefbcf9d4f742055f637fe01a9396bf936737a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/320e9d9d6ae31b00e7ae5423cce0fa6e1249600af4f5591bd91476ebd5853e7d6132cfc6a5662d37afcdc0660be510c7028bd55b1cfb149cc853b3416186f9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c621d265aeded58c3b341e95ff845b936da5928c8b804c2d3a2f16e41afc50d572a673e6e69792b7cd4c6aec832c55e00e7eea625be02da85430a23a22b61db"} build_url:https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/SQcMbsZPSfi4FCcRgfYfpw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997e3f20492a1200c4a06b9a19902cfad0fa1cc4b3f623dc102b67ccdb8d065c7699ea533070a4cb57c90d58cdefbcf9d4f742055f637fe01a9396bf936737a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/320e9d9d6ae31b00e7ae5423cce0fa6e1249600af4f5591bd91476ebd5853e7d6132cfc6a5662d37afcdc0660be510c7028bd55b1cfb149cc853b3416186f9b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c621d265aeded58c3b341e95ff845b936da5928c8b804c2d3a2f16e41afc50d572a673e6e69792b7cd4c6aec832c55e00e7eea625be02da85430a23a22b61db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:04:58.952318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:04:58.952929) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468373988.145230-872598037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:04:59.006083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:04:59.006462) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:04:59.006911) ========= ========= Total master_lag: 0.17 =========