builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1466072732.04 results: success (0) buildid: 20160616004032 builduid: 1487ee6a222b4e2aba2c40fbd902205e revision: 23c56144e51c56304df9620bb18fb8786e087e40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.043498) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.043987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.044276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.060584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.060954) ========= 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=4300f881736b422476174874000001bc-1466071466.88756-247803195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 03:25:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-06-16 03:25:33 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126896 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.203000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.203323) ========= 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=4300f881736b422476174874000001bc-1466071466.88756-247803195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022317 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:32.255258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 03:25:32.255668) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 23c56144e51c56304df9620bb18fb8786e087e40 --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 23c56144e51c56304df9620bb18fb8786e087e40 --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=4300f881736b422476174874000001bc-1466071466.88756-247803195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 03:25:33,216 truncating revision to first 12 chars 2016-06-16 03:25:33,216 Setting DEBUG logging. 2016-06-16 03:25:33,216 attempt 1/10 2016-06-16 03:25:33,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/23c56144e51c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 03:25:34,531 unpacking tar archive at: mozilla-aurora-23c56144e51c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.671328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 03:25:33.947064) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:33.947729) ========= script_repo_revision: 23c56144e51c56304df9620bb18fb8786e087e40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:33.948569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:33.949133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 03:25:33.961721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-16 03:25:33.962153) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=4300f881736b422476174874000001bc-1466071466.88756-247803195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:35 INFO - MultiFileLogger online at 20160616 03:25:35 in /builds/slave/test 03:25:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:25:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:35 INFO - {'append_to_log': False, 03:25:35 INFO - 'base_work_dir': '/builds/slave/test', 03:25:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:25:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:35 INFO - 'branch': 'Mozilla-Aurora', 03:25:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:35 INFO - 'config_files': ('talos/linux_config.py',), 03:25:35 INFO - 'default_actions': ('clobber', 03:25:35 INFO - 'read-buildbot-config', 03:25:35 INFO - 'download-and-extract', 03:25:35 INFO - 'populate-webroot', 03:25:35 INFO - 'create-virtualenv', 03:25:35 INFO - 'install', 03:25:35 INFO - 'run-tests'), 03:25:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:35 INFO - 'download_minidump_stackwalk': True, 03:25:35 INFO - 'download_symbols': 'ondemand', 03:25:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:35 INFO - 'installer_path': 'installer.exe', 03:25:35 INFO - 'log_level': 'info', 03:25:35 INFO - 'log_name': 'talos', 03:25:35 INFO - 'log_to_console': True, 03:25:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:35 INFO - 'opt_config_files': (), 03:25:35 INFO - 'pip_index': False, 03:25:35 INFO - 'sps_profile': False, 03:25:35 INFO - 'sps_profile_interval': 0, 03:25:35 INFO - 'suite': 'dromaeojs', 03:25:35 INFO - 'system_bits': '32', 03:25:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:35 INFO - 'title': 'talos-linux64-ix-045', 03:25:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:35 INFO - 'use_talos_json': True, 03:25:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:35 INFO - 'work_dir': 'build'} 03:25:35 INFO - ##### 03:25:35 INFO - ##### Running clobber step. 03:25:35 INFO - ##### 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: clobber 03:25:35 INFO - rmtree: /builds/slave/test/build 03:25:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:35 INFO - Running post-action listener: _resource_record_post_action 03:25:35 INFO - ##### 03:25:35 INFO - ##### Finished clobber step (success) 03:25:35 INFO - ##### 03:25:35 INFO - ##### 03:25:35 INFO - ##### Running read-buildbot-config step. 03:25:35 INFO - ##### 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: read_buildbot_config 03:25:35 INFO - Using buildbot properties: 03:25:35 INFO - { 03:25:35 INFO - "project": "", 03:25:35 INFO - "product": "firefox", 03:25:35 INFO - "script_repo_revision": "production", 03:25:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:25:35 INFO - "repository": "", 03:25:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:25:35 INFO - "buildid": "20160616004032", 03:25:35 INFO - "stage_platform": "linux64-pgo", 03:25:35 INFO - "basedir": "/builds/slave/test", 03:25:35 INFO - "nightly_build": "True", 03:25:35 INFO - "buildnumber": 566, 03:25:35 INFO - "slavename": "talos-linux64-ix-045", 03:25:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:25:35 INFO - "platform": "ubuntu64_hw", 03:25:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:25:35 INFO - "branch": "mozilla-aurora", 03:25:35 INFO - "repo_path": "releases/mozilla-aurora", 03:25:35 INFO - "revision": "23c56144e51c56304df9620bb18fb8786e087e40", 03:25:35 INFO - "pgo_build": "True", 03:25:35 INFO - "builduid": "1487ee6a222b4e2aba2c40fbd902205e", 03:25:35 INFO - "slavebuilddir": "test" 03:25:35 INFO - } 03:25:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:25:35 INFO - Running post-action listener: _resource_record_post_action 03:25:35 INFO - ##### 03:25:35 INFO - ##### Finished read-buildbot-config step (success) 03:25:35 INFO - ##### 03:25:35 INFO - ##### 03:25:35 INFO - ##### Running download-and-extract step. 03:25:35 INFO - ##### 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: download_and_extract 03:25:35 INFO - mkdir: /builds/slave/test/build/tests 03:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:35 INFO - https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:36 INFO - Downloaded 1361 bytes. 03:25:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - Using the following test package requirements: 03:25:36 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:36 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:36 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:25:36 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'jsshell-linux-x86_64.zip'], 03:25:36 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:36 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:36 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:25:36 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:25:36 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:36 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:36 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:36 INFO - https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:40 INFO - Downloaded 24473965 bytes. 03:25:40 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'] 03:25:40 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 03:25:41 INFO - Return code: 0 03:25:41 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 03:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:41 INFO - https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:25:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:43 INFO - Downloaded 24473965 bytes. 03:25:43 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'] 03:25:43 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 03:25:45 INFO - Return code: 0 03:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:45 INFO - https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:46 INFO - Downloaded 10833369 bytes. 03:25:46 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'] 03:25:46 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 03:25:46 INFO - Return code: 0 03:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:46 INFO - https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5jHKm6aQkmRIwHHxEzrNg/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 03:25:47 INFO - Downloaded 63563928 bytes. 03:25:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:47 INFO - mkdir: /builds/slave/test/properties 03:25:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:47 INFO - Contents: 03:25:47 INFO - build_url:https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:25:48 INFO - Running post-action listener: _resource_record_post_action 03:25:48 INFO - Running post-action listener: set_extra_try_arguments 03:25:48 INFO - ##### 03:25:48 INFO - ##### Finished download-and-extract step (success) 03:25:48 INFO - ##### 03:25:48 INFO - ##### 03:25:48 INFO - ##### Running populate-webroot step. 03:25:48 INFO - ##### 03:25:48 INFO - Running pre-action listener: _resource_record_pre_action 03:25:48 INFO - Running main action method: populate_webroot 03:25:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:48 INFO - '--tppagecycles', 03:25:48 INFO - '7'], 03:25:48 INFO - 'tests': ['tsvgm']}}, 03:25:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['damp', 'tps']}, 03:25:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'tests': ['damp', 'tps']}, 03:25:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['dromaeo_dom']}, 03:25:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['a11yr', 03:25:48 INFO - 'ts_paint', 03:25:48 INFO - 'tpaint', 03:25:48 INFO - 'sessionrestore', 03:25:48 INFO - 'sessionrestore_no_auto_restore', 03:25:48 INFO - 'tabpaint']}, 03:25:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:48 INFO - 'ts_paint', 03:25:48 INFO - 'tpaint', 03:25:48 INFO - 'sessionrestore', 03:25:48 INFO - 'sessionrestore_no_auto_restore', 03:25:48 INFO - 'tabpaint']}, 03:25:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:48 INFO - 'ts_paint', 03:25:48 INFO - 'tpaint', 03:25:48 INFO - 'sessionrestore', 03:25:48 INFO - 'sessionrestore_no_auto_restore', 03:25:48 INFO - 'tabpaint']}, 03:25:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:48 INFO - 'ts_paint', 03:25:48 INFO - 'tpaint', 03:25:48 INFO - 'sessionrestore', 03:25:48 INFO - 'sessionrestore_no_auto_restore', 03:25:48 INFO - 'tabpaint']}, 03:25:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['a11yr', 03:25:48 INFO - 'ts_paint', 03:25:48 INFO - 'tpaint', 03:25:48 INFO - 'sessionrestore', 03:25:48 INFO - 'sessionrestore_no_auto_restore', 03:25:48 INFO - 'tabpaint']}, 03:25:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['a11yr', 03:25:48 INFO - 'ts_paint', 03:25:48 INFO - 'tpaint', 03:25:48 INFO - 'sessionrestore', 03:25:48 INFO - 'sessionrestore_no_auto_restore', 03:25:48 INFO - 'tabpaint']}, 03:25:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['tsvgx', 03:25:48 INFO - 'tsvgr_opacity', 03:25:48 INFO - 'tart', 03:25:48 INFO - 'tscrollx', 03:25:48 INFO - 'cart']}, 03:25:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:48 INFO - 'tsvgr_opacity', 03:25:48 INFO - 'tart', 03:25:48 INFO - 'tscrollx', 03:25:48 INFO - 'cart']}, 03:25:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'talos_options': ['--disable-e10s'], 03:25:48 INFO - 'tests': ['tp5o']}, 03:25:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'tests': ['tp5o']}, 03:25:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'talos_options': ['--disable-e10s', 03:25:48 INFO - '--xperf_path', 03:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:48 INFO - 'tests': ['tp5n']}, 03:25:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:48 INFO - 'talos_options': ['--xperf_path', 03:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:48 INFO - 'tests': ['tp5n']}}, 03:25:48 INFO - 'talos.zip': {'path': '', 03:25:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:48 INFO - Running post-action listener: _resource_record_post_action 03:25:48 INFO - ##### 03:25:48 INFO - ##### Finished populate-webroot step (success) 03:25:48 INFO - ##### 03:25:48 INFO - ##### 03:25:48 INFO - ##### Running create-virtualenv step. 03:25:48 INFO - ##### 03:25:48 INFO - Running pre-action listener: _resource_record_pre_action 03:25:48 INFO - Running main action method: create_virtualenv 03:25:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:48 INFO - Using real prefix '/usr' 03:25:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:51 INFO - Installing pip.................done. 03:25:51 INFO - Return code: 0 03:25:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:51 INFO - Using env: {'DISPLAY': ':0', 03:25:51 INFO - 'HOME': '/home/cltbld', 03:25:51 INFO - 'LANG': 'en_US.UTF-8', 03:25:51 INFO - 'LANGUAGE': 'en_US:en', 03:25:51 INFO - 'LOGNAME': 'cltbld', 03:25:51 INFO - 'MAIL': '/var/mail/cltbld', 03:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:51 INFO - 'MOZ_NO_REMOTE': '1', 03:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:51 INFO - 'NO_EM_RESTART': '1', 03:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:51 INFO - 'PWD': '/builds/slave/test', 03:25:51 INFO - 'SHELL': '/bin/bash', 03:25:51 INFO - 'SHLVL': '1', 03:25:51 INFO - 'TERM': 'linux', 03:25:51 INFO - 'TMOUT': '86400', 03:25:51 INFO - 'USER': 'cltbld', 03:25:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:51 INFO - '_': '/tools/buildbot/bin/python'} 03:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:25:51 INFO - Cleaning up... 03:25:51 INFO - Return code: 0 03:25:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:25:51 INFO - Using env: {'DISPLAY': ':0', 03:25:51 INFO - 'HOME': '/home/cltbld', 03:25:51 INFO - 'LANG': 'en_US.UTF-8', 03:25:51 INFO - 'LANGUAGE': 'en_US:en', 03:25:51 INFO - 'LOGNAME': 'cltbld', 03:25:51 INFO - 'MAIL': '/var/mail/cltbld', 03:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:51 INFO - 'MOZ_NO_REMOTE': '1', 03:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:51 INFO - 'NO_EM_RESTART': '1', 03:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:51 INFO - 'PWD': '/builds/slave/test', 03:25:51 INFO - 'SHELL': '/bin/bash', 03:25:51 INFO - 'SHLVL': '1', 03:25:51 INFO - 'TERM': 'linux', 03:25:51 INFO - 'TMOUT': '86400', 03:25:51 INFO - 'USER': 'cltbld', 03:25:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:51 INFO - '_': '/tools/buildbot/bin/python'} 03:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:51 INFO - Downloading/unpacking psutil>=3.1.1 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:53 INFO - Installing collected packages: psutil 03:25:53 INFO - Running setup.py install for psutil 03:25:53 INFO - building 'psutil._psutil_linux' extension 03:25:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:25:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:25:53 INFO - building 'psutil._psutil_posix' extension 03:25:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:25:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:54 INFO - Successfully installed psutil 03:25:54 INFO - Cleaning up... 03:25:54 INFO - Return code: 0 03:25:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:54 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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:25:54 INFO - Using env: {'DISPLAY': ':0', 03:25:54 INFO - 'HOME': '/home/cltbld', 03:25:54 INFO - 'LANG': 'en_US.UTF-8', 03:25:54 INFO - 'LANGUAGE': 'en_US:en', 03:25:54 INFO - 'LOGNAME': 'cltbld', 03:25:54 INFO - 'MAIL': '/var/mail/cltbld', 03:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:54 INFO - 'MOZ_NO_REMOTE': '1', 03:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:54 INFO - 'NO_EM_RESTART': '1', 03:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:54 INFO - 'PWD': '/builds/slave/test', 03:25:54 INFO - 'SHELL': '/bin/bash', 03:25:54 INFO - 'SHLVL': '1', 03:25:54 INFO - 'TERM': 'linux', 03:25:54 INFO - 'TMOUT': '86400', 03:25:54 INFO - 'USER': 'cltbld', 03:25:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:54 INFO - '_': '/tools/buildbot/bin/python'} 03:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:56 INFO - Installing collected packages: mozsystemmonitor 03:25:56 INFO - Running setup.py install for mozsystemmonitor 03:25:56 INFO - Successfully installed mozsystemmonitor 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:58 INFO - warning: no files found matching '*.txt' 03:25:58 INFO - no previously-included directories found matching 'build' 03:25:58 INFO - no previously-included directories found matching 'dist' 03:25:58 INFO - no previously-included directories found matching '.git*' 03:25:58 INFO - Installing collected packages: jsonschema, functools32 03:25:58 INFO - Running setup.py install for functools32 03:25:58 INFO - warning: no files found matching '*.txt' 03:25:58 INFO - no previously-included directories found matching 'build' 03:25:58 INFO - no previously-included directories found matching 'dist' 03:25:58 INFO - no previously-included directories found matching '.git*' 03:25:58 INFO - Successfully installed jsonschema functools32 03:25:58 INFO - Cleaning up... 03:25:58 INFO - Return code: 0 03:25:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:25:58 INFO - Using env: {'DISPLAY': ':0', 03:25:58 INFO - 'HOME': '/home/cltbld', 03:25:58 INFO - 'LANG': 'en_US.UTF-8', 03:25:58 INFO - 'LANGUAGE': 'en_US:en', 03:25:58 INFO - 'LOGNAME': 'cltbld', 03:25:58 INFO - 'MAIL': '/var/mail/cltbld', 03:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:58 INFO - 'MOZ_NO_REMOTE': '1', 03:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:58 INFO - 'NO_EM_RESTART': '1', 03:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:58 INFO - 'PWD': '/builds/slave/test', 03:25:58 INFO - 'SHELL': '/bin/bash', 03:25:58 INFO - 'SHLVL': '1', 03:25:58 INFO - 'TERM': 'linux', 03:25:58 INFO - 'TMOUT': '86400', 03:25:58 INFO - 'USER': 'cltbld', 03:25:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:58 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - Downloading docopt-0.6.1.tar.gz 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:02 INFO - Running setup.py install for blobuploader 03:26:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:02 INFO - Running setup.py install for requests 03:26:02 INFO - Running setup.py install for docopt 03:26:02 INFO - Successfully installed blobuploader requests docopt 03:26:02 INFO - Cleaning up... 03:26:02 INFO - Return code: 0 03:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:02 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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:02 INFO - Using env: {'DISPLAY': ':0', 03:26:02 INFO - 'HOME': '/home/cltbld', 03:26:02 INFO - 'LANG': 'en_US.UTF-8', 03:26:02 INFO - 'LANGUAGE': 'en_US:en', 03:26:02 INFO - 'LOGNAME': 'cltbld', 03:26:02 INFO - 'MAIL': '/var/mail/cltbld', 03:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:02 INFO - 'MOZ_NO_REMOTE': '1', 03:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:02 INFO - 'NO_EM_RESTART': '1', 03:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:02 INFO - 'PWD': '/builds/slave/test', 03:26:02 INFO - 'SHELL': '/bin/bash', 03:26:02 INFO - 'SHLVL': '1', 03:26:02 INFO - 'TERM': 'linux', 03:26:02 INFO - 'TMOUT': '86400', 03:26:02 INFO - 'USER': 'cltbld', 03:26:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:02 INFO - '_': '/tools/buildbot/bin/python'} 03:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 INFO - Running setup.py (path:/tmp/pip-oFACzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 INFO - Running setup.py (path:/tmp/pip-MAWIes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 INFO - Running setup.py (path:/tmp/pip-RYRmJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:03 INFO - Running setup.py (path:/tmp/pip-nS3oDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:03 INFO - Running setup.py (path:/tmp/pip-QsGxq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:03 INFO - Running setup.py (path:/tmp/pip-xyDVlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:03 INFO - Running setup.py (path:/tmp/pip-t2GKH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 INFO - Running setup.py (path:/tmp/pip-AEEqBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:03 INFO - Running setup.py (path:/tmp/pip-S0R5gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:03 INFO - Running setup.py (path:/tmp/pip-Bm9Etj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 INFO - Running setup.py (path:/tmp/pip-gUUIgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 INFO - Running setup.py (path:/tmp/pip-gfLwDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 INFO - Running setup.py (path:/tmp/pip-A2Vfem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 INFO - Running setup.py (path:/tmp/pip-bROZnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 INFO - Running setup.py (path:/tmp/pip-tc1Bpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:03 INFO - Running setup.py (path:/tmp/pip-nq_2BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:03 INFO - Running setup.py (path:/tmp/pip-wmKkM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:04 INFO - Running setup.py install for manifestparser 03:26:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozcrash 03:26:04 INFO - Running setup.py install for mozdebug 03:26:04 INFO - Running setup.py install for mozdevice 03:26:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozfile 03:26:04 INFO - Running setup.py install for mozhttpd 03:26:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozinfo 03:26:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozInstall 03:26:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozleak 03:26:04 INFO - Running setup.py install for mozlog 03:26:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Running setup.py install for moznetwork 03:26:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Running setup.py install for mozprocess 03:26:05 INFO - Running setup.py install for mozprofile 03:26:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Running setup.py install for mozrunner 03:26:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Running setup.py install for mozscreenshot 03:26:05 INFO - Running setup.py install for moztest 03:26:05 INFO - Running setup.py install for mozversion 03:26:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:05 INFO - Using env: {'DISPLAY': ':0', 03:26:05 INFO - 'HOME': '/home/cltbld', 03:26:05 INFO - 'LANG': 'en_US.UTF-8', 03:26:05 INFO - 'LANGUAGE': 'en_US:en', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MAIL': '/var/mail/cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SHLVL': '1', 03:26:05 INFO - 'TERM': 'linux', 03:26:05 INFO - 'TMOUT': '86400', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - '_': '/tools/buildbot/bin/python'} 03:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:06 INFO - Running setup.py (path:/tmp/pip-28YJhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:06 INFO - Running setup.py (path:/tmp/pip-QB4td5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:06 INFO - Running setup.py (path:/tmp/pip-9NY2SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:06 INFO - Running setup.py (path:/tmp/pip-tfpb6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:06 INFO - Running setup.py (path:/tmp/pip-QMosb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:06 INFO - Running setup.py (path:/tmp/pip-IORtCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:06 INFO - Running setup.py (path:/tmp/pip-G9GbFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:06 INFO - Running setup.py (path:/tmp/pip-LRe9Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:06 INFO - Running setup.py (path:/tmp/pip-HRolaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:06 INFO - Running setup.py (path:/tmp/pip-VNzuIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 INFO - Running setup.py (path:/tmp/pip-59q6Tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 INFO - Running setup.py (path:/tmp/pip-LATUm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:06 INFO - Running setup.py (path:/tmp/pip-CagETt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:07 INFO - Running setup.py (path:/tmp/pip-i0eYvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:07 INFO - Running setup.py (path:/tmp/pip-CKJSkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:07 INFO - Running setup.py (path:/tmp/pip-LxyaZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:07 INFO - Running setup.py (path:/tmp/pip-QKdjzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:09 INFO - Downloading blessings-1.6.tar.gz 03:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:09 INFO - Installing collected packages: blessings 03:26:09 INFO - Running setup.py install for blessings 03:26:09 INFO - Successfully installed blessings 03:26:09 INFO - Cleaning up... 03:26:09 INFO - Return code: 0 03:26:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:09 INFO - Reading from file tmpfile_stdout 03:26:09 INFO - Current package versions: 03:26:09 INFO - argparse == 1.2.1 03:26:09 INFO - blessings == 1.6 03:26:09 INFO - blobuploader == 1.2.4 03:26:09 INFO - docopt == 0.6.1 03:26:09 INFO - functools32 == 3.2.3-2 03:26:09 INFO - jsonschema == 2.5.1 03:26:09 INFO - manifestparser == 1.1 03:26:09 INFO - mozInstall == 1.12 03:26:09 INFO - mozcrash == 0.17 03:26:09 INFO - mozdebug == 0.1 03:26:09 INFO - mozdevice == 0.48 03:26:09 INFO - mozfile == 1.2 03:26:09 INFO - mozhttpd == 0.7 03:26:09 INFO - mozinfo == 0.9 03:26:09 INFO - mozleak == 0.1 03:26:09 INFO - mozlog == 3.2 03:26:09 INFO - moznetwork == 0.27 03:26:09 INFO - mozprocess == 0.22 03:26:09 INFO - mozprofile == 0.28 03:26:09 INFO - mozrunner == 6.11 03:26:09 INFO - mozscreenshot == 0.1 03:26:09 INFO - mozsystemmonitor == 0.3 03:26:09 INFO - moztest == 0.7 03:26:09 INFO - mozversion == 1.4 03:26:09 INFO - psutil == 3.1.1 03:26:09 INFO - requests == 1.2.3 03:26:09 INFO - wsgiref == 0.1.2 03:26:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:09 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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:09 INFO - Using env: {'DISPLAY': ':0', 03:26:09 INFO - 'HOME': '/home/cltbld', 03:26:09 INFO - 'LANG': 'en_US.UTF-8', 03:26:09 INFO - 'LANGUAGE': 'en_US:en', 03:26:09 INFO - 'LOGNAME': 'cltbld', 03:26:09 INFO - 'MAIL': '/var/mail/cltbld', 03:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:09 INFO - 'MOZ_NO_REMOTE': '1', 03:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:09 INFO - 'NO_EM_RESTART': '1', 03:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:09 INFO - 'PWD': '/builds/slave/test', 03:26:09 INFO - 'SHELL': '/bin/bash', 03:26:09 INFO - 'SHLVL': '1', 03:26:09 INFO - 'TERM': 'linux', 03:26:09 INFO - 'TMOUT': '86400', 03:26:09 INFO - 'USER': 'cltbld', 03:26:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:09 INFO - '_': '/tools/buildbot/bin/python'} 03:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:09 INFO - Cleaning up... 03:26:09 INFO - Return code: 0 03:26:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:09 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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:09 INFO - Using env: {'DISPLAY': ':0', 03:26:09 INFO - 'HOME': '/home/cltbld', 03:26:09 INFO - 'LANG': 'en_US.UTF-8', 03:26:09 INFO - 'LANGUAGE': 'en_US:en', 03:26:09 INFO - 'LOGNAME': 'cltbld', 03:26:09 INFO - 'MAIL': '/var/mail/cltbld', 03:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:09 INFO - 'MOZ_NO_REMOTE': '1', 03:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:09 INFO - 'NO_EM_RESTART': '1', 03:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:09 INFO - 'PWD': '/builds/slave/test', 03:26:09 INFO - 'SHELL': '/bin/bash', 03:26:09 INFO - 'SHLVL': '1', 03:26:09 INFO - 'TERM': 'linux', 03:26:09 INFO - 'TMOUT': '86400', 03:26:09 INFO - 'USER': 'cltbld', 03:26:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:09 INFO - '_': '/tools/buildbot/bin/python'} 03:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:10 INFO - Cleaning up... 03:26:10 INFO - Return code: 0 03:26:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:10 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 0x7f5032d0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f62e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, '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': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:26:10 INFO - Using env: {'DISPLAY': ':0', 03:26:10 INFO - 'HOME': '/home/cltbld', 03:26:10 INFO - 'LANG': 'en_US.UTF-8', 03:26:10 INFO - 'LANGUAGE': 'en_US:en', 03:26:10 INFO - 'LOGNAME': 'cltbld', 03:26:10 INFO - 'MAIL': '/var/mail/cltbld', 03:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:10 INFO - 'MOZ_NO_REMOTE': '1', 03:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:10 INFO - 'NO_EM_RESTART': '1', 03:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:10 INFO - 'PWD': '/builds/slave/test', 03:26:10 INFO - 'SHELL': '/bin/bash', 03:26:10 INFO - 'SHLVL': '1', 03:26:10 INFO - 'TERM': 'linux', 03:26:10 INFO - 'TMOUT': '86400', 03:26:10 INFO - 'USER': 'cltbld', 03:26:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:10 INFO - '_': '/tools/buildbot/bin/python'} 03:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:10 INFO - Downloading/unpacking flake8 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:12 INFO - no previously-included directories found matching 'docs/_build' 03:26:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:13 INFO - Running setup.py install for pep8 03:26:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:13 INFO - no previously-included directories found matching 'docs/_build' 03:26:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:13 INFO - Cleaning up... 03:26:13 INFO - Return code: 0 03:26:13 INFO - Running post-action listener: _resource_record_post_action 03:26:13 INFO - Running post-action listener: _start_resource_monitoring 03:26:13 INFO - Starting resource monitoring. 03:26:13 INFO - ##### 03:26:13 INFO - ##### Finished create-virtualenv step (success) 03:26:13 INFO - ##### 03:26:13 INFO - ##### 03:26:13 INFO - ##### Running install step. 03:26:13 INFO - ##### 03:26:13 INFO - Running pre-action listener: _resource_record_pre_action 03:26:13 INFO - Running main action method: install 03:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:13 INFO - Reading from file tmpfile_stdout 03:26:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:13 INFO - Reading from file tmpfile_stdout 03:26:13 INFO - Output received: 03:26:13 INFO - Usage: mozinstall [options] installer 03:26:13 INFO - Options: 03:26:13 INFO - -h, --help show this help message and exit 03:26:13 INFO - -d DEST, --destination=DEST 03:26:13 INFO - Directory to install application into. [default: 03:26:13 INFO - "/builds/slave/test"] 03:26:13 INFO - --app=APP Application being installed. [default: firefox] 03:26:13 INFO - mkdir: /builds/slave/test/build/application 03:26:13 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'] 03:26:13 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 03:26:29 INFO - Reading from file tmpfile_stdout 03:26:29 INFO - Output received: 03:26:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:29 INFO - Running post-action listener: _resource_record_post_action 03:26:29 INFO - ##### 03:26:29 INFO - ##### Finished install step (success) 03:26:29 INFO - ##### 03:26:29 INFO - ##### 03:26:29 INFO - ##### Running run-tests step. 03:26:29 INFO - ##### 03:26:29 INFO - Running pre-action listener: _resource_record_pre_action 03:26:29 INFO - Running main action method: run_tests 03:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:29 INFO - Python 2.7.3 03:26:29 INFO - Return code: 0 03:26:29 INFO - grabbing minidump binary from tooltool 03:26: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')]} 03:26:29 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 0x13f0e20>, '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 0x13f43a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:26:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:26:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:26:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:29 INFO - Return code: 0 03:26:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:26:30 INFO - Return code: 0 03:26:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:26:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:26:30 INFO - Using env: {'DISPLAY': ':0', 03:26:30 INFO - 'HOME': '/home/cltbld', 03:26:30 INFO - 'LANG': 'en_US.UTF-8', 03:26:30 INFO - 'LANGUAGE': 'en_US:en', 03:26:30 INFO - 'LOGNAME': 'cltbld', 03:26:30 INFO - 'MAIL': '/var/mail/cltbld', 03:26:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:30 INFO - 'MOZ_NO_REMOTE': '1', 03:26:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:30 INFO - 'NO_EM_RESTART': '1', 03:26:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:30 INFO - 'PWD': '/builds/slave/test', 03:26:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:30 INFO - 'SHELL': '/bin/bash', 03:26:30 INFO - 'SHLVL': '1', 03:26:30 INFO - 'TERM': 'linux', 03:26:30 INFO - 'TMOUT': '86400', 03:26:30 INFO - 'USER': 'cltbld', 03:26:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1466071466.88756-247803195', 03:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:30 INFO - '_': '/tools/buildbot/bin/python'} 03:26:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:26:30 INFO - mozversion application_buildid: 20160616004032 03:26:30 INFO - mozversion application_changeset: 23c56144e51c56304df9620bb18fb8786e087e40 03:26:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:26:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:30 INFO - mozversion application_name: Firefox 03:26:30 INFO - mozversion application_remotingname: firefox-dev 03:26:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:30 INFO - mozversion application_vendor: Mozilla 03:26:30 INFO - mozversion application_version: 49.0a2 03:26:30 INFO - mozversion platform_buildid: 20160616004032 03:26:30 INFO - mozversion platform_changeset: 23c56144e51c56304df9620bb18fb8786e087e40 03:26:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:30 INFO - mozversion platform_version: 49.0a2 03:26:30 INFO - using testdate: 1466072790 03:26:30 INFO - actual date: 1466072790 03:26:30 INFO - starting webserver on 'localhost:57456' 03:26:30 INFO - SUITE-START | Running 2 tests 03:26:30 INFO - TEST-START | dromaeo_css 03:26:30 INFO - operating with platform_type : linux_ 03:26:30 INFO - Initialising browser for dromaeo_css test... 03:26:30 INFO - TEST-INFO | started process 31733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqlNNmK/profile http://localhost:57456/getInfo.html) 03:26:34 INFO - PROCESS | 31733 | __metrics Screen width/height:1600/1200 03:26:34 INFO - PROCESS | 31733 | colorDepth:24 03:26:34 INFO - PROCESS | 31733 | Browser inner width/height: 1024/697 03:26:34 INFO - PROCESS | 31733 | __metrics 03:26:36 ERROR - PROCESS | 31733 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:26:36 INFO - PROCESS | 31733 | console.error: PushService: 03:26:36 INFO - PROCESS | 31733 | stateChangeProcessEnqueue: Error transitioning state 03:26:36 INFO - PROCESS | 31733 | UnknownError 03:26:36 INFO - TEST-INFO | 31733: exit 0 03:26:36 INFO - Browser initialized. 03:26:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:36 INFO - TEST-INFO | started process 31824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqlNNmK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:48 INFO - PROCESS | 31824 | RSS: Main: 145387520 03:26:48 INFO - PROCESS | 31824 | 03:27:40 INFO - PROCESS | 31824 | 1466072860020 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:29:48 INFO - PROCESS | 31824 | Cycle 1(1): loaded http://localhost:57456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57456/tests/dromaeo/cssquery-ext.html) 03:29:49 INFO - PROCESS | 31824 | RSS: Main: 255971328 03:29:49 INFO - PROCESS | 31824 | 03:32:51 INFO - PROCESS | 31824 | Cycle 1(1): loaded http://localhost:57456/tests/dromaeo/cssquery-ext.html (next: http://localhost:57456/tests/dromaeo/cssquery-jquery.html) 03:32:52 INFO - PROCESS | 31824 | RSS: Main: 222662656 03:32:52 INFO - PROCESS | 31824 | 03:35:54 INFO - PROCESS | 31824 | Cycle 1(1): loaded http://localhost:57456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57456/tests/dromaeo/cssquery-mootools.html) 03:35:54 INFO - PROCESS | 31824 | RSS: Main: 230510592 03:35:54 INFO - PROCESS | 31824 | 03:38:56 INFO - PROCESS | 31824 | Cycle 1(1): loaded http://localhost:57456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57456/tests/dromaeo/cssquery-prototype.html) 03:38:57 INFO - PROCESS | 31824 | RSS: Main: 220061696 03:38:57 INFO - PROCESS | 31824 | 03:42:00 INFO - PROCESS | 31824 | Cycle 1(1): loaded http://localhost:57456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57456/tests/dromaeo/cssquery-yui.html) 03:42:00 INFO - PROCESS | 31824 | RSS: Main: 218112000 03:42:00 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | Cycle 1(1): loaded http://localhost:57456/tests/dromaeo/cssquery-yui.html (next: http://localhost:57456/tests/dromaeo/cssquery-dojo.html) 03:45:03 INFO - PROCESS | 31824 | RSS: Main: 245633024 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | __start_tp_report 03:45:03 INFO - PROCESS | 31824 | _x_x_mozilla_page_load 03:45:03 INFO - PROCESS | 31824 | _x_x_mozilla_page_load_details 03:45:03 INFO - PROCESS | 31824 | |i|pagename|runs| 03:45:03 INFO - PROCESS | 31824 | |0;dojo.html;3353.2119951811324;3386.729061675066;3390.559227300449;3408.130926613713;3433.8798142065034;5637.746301416436;5720.256366672332;5736.942630573693;5740.339860915996;5744.5117165040965;5700.686462244575;5745.798897038604;5759.942400575993;5762.1068734346245;5764.654120752758;5008.84973450797;5094.363204599425;5156.329677141966;5218.269442278065;5240.082985477546;5150.27896094547;5197.168453047494;5199.168133098705;5201.583873290147;5206.557442617382;5134.2812006319145;5177.715225662587;5200.843974680747;5224.033553792541;5238.109521381374;5295.682259064469;5305.336832895888;5315.282436871012;5319.042572336978;5349.786008559633;4959.603231741488;5005.224190250517;5008.398992120932;5208.817691380784;5212.452692467275;5510.173473978935;5514.035043867307;5518.668879867221;5558.861028474321;5578;6094.414199418284;6095.451409373178;6096.96951515244;6104.3839667506;6115.87768244637;6105.755769769204;6127.433875357673;6136.447719705203;6142.723577439026;6239.937600623981;5793.420657934215;5845.064789633639;5846.795362162304;5852.444017818343;5854.356020837789;6080.726367313481;6339.778107766206;6344.460720838781;6355.173827402408;6356.332585078592;5978.5814992950945;6041.909371359433;6070.453659170696;6112.419320164578;6118.418750218722;6193.411625895533;6194.5044396448175;6195.411435913581;6198;6199.1011303361665;5947.6431414115295;6012.068129439944;6105.206323177958;6120.755169793248;6122.510199184055;6071.089336599457;6146.5390095743;6146.969265153645;6147.66187859672;6154.753809847645;4639.257718764981;4680.859574212779;4684.484706682262;4696.201645720235;4709.293605959065;4059.188162367538;4077.347624380085;4106.281400754856;4167.4790651168605;4174.791260436966;5748.511376532958;5754.798582049608;5756.5682573807135;5757.913631295534;5782.7686892523825;6098.14625952367;6108.517419168856;6112.442689633878;6112.446322032932;6125.387461253928;5637.633553818989;5661.830145095653;5665.915011274834;5728.971355143281;5736.282964629421;5213.348331458567;5221.712805795718;5228.6862788232065;5228.869278268074;5230.450802665741;6261.906071408933;6267.780627678009;6270.843228919222;6271.184745982993;6272.059191121369;5985.790497332572;6064.818055458343;6114.571104522668;6116.031445915052;6176.7838125665385;6387.425131738166;6401.263854656588;6405.0392441132335;6405.263394709668;6413.518986075969;5815.651060936358;6094.908576371269;6105.114758360101;6108.205933228652;6116.694165291807;5935.109733539831;6008.309044459943;6038.969805151122;6095.481884039729;6101.938980610137;5945.672987985702;5950.047992321208;5956.285245770535;5958.821235362946;5961.791337303173;5776.104703770922;5828.825135245949;5871.6183448075735;5938.168656388196;5943.7028148591535;5792.102224155263;5807.390224026416;5848;5859.794907178229;5885.087811389241;5996.190514280691;6027.6986150693165;6039.335673075871;6041.969790151021;6044.788432405021;5730;5824.825255242349;5858.94141058584;5863.061910094364;5878.911816322673 03:45:03 INFO - PROCESS | 31824 | |1;ext.html;605.4702135631322;633.0346222011433;647.964361960092;657.1686816177534;664.0172544633941;32205.51691724626;39632.603673963255;40461.190776184456;40533.39199912004;40928.38607420884;48028;48410.27384589234;48539.27191092128;48555.757221213935;48684;8510.148985101472;8979.640814367434;9174.128457796498;9179;10904.890951090467;10624.521896514676;10772.892271077306;11032.393218372987;11035.172362072837;11038.889611103907;11058.889411105907;11163.386013769239;11163.386013769239;11164.274322169074;11174;8553.572321383968;10875.673729788119;10915.126789856831;11109.666709998713;11118.944405277922;10929.781404371868;10932.289401188977;10941.452927353681;10950.507227174796;11044.834327485094;45541.31688024682;45799.77100114511;45902;45925.244485330986;45937.77031114857;3374.898753037413;3443.6900678938764;3589.964100359015;3680.190358121236;3757.605451427588;35046.64953350459;35250.07085216516;35734;35965;36201.63798362009;4627.375304333906;4658.138244424758;4676.672632915697;4679.251319788851;4685.1566717990745;362069;362688;364196;364906.1754691236;366232;39565;40764.38853417201;70033.64983175052;70940;71053.644731776;41770.164596707895;41810.16379672389;41821.37267940983;41908.79045604752;42032.57967420287;17529.824701753074;17786.37747678825;17787.110644467724;17796.46610601684;17833.732494012602;11598.768024639628;14661.120332780067;14795.482158124414;14829.629259268604;15273.465428709942;9370.718878433658;9389.906100938902;9414.435133891988;9442.622295108256;9474.242060635133;3493.737969652286;3575.6245594212755;3598.2623562169692;3603.2973570153567;3605.387084195693;1046.3408052926607;1097.7310558912957;1105.723569107723;1135.8580177477816;1190.7023244188954;34617.653823461944;35155.824220878734;35247.82376088103;35256;35363.36633663366;1159.7680463907252;1166.988330116705;1180.557291015869;1254.5797157952006;1254.730232999891;18301.7254741179;18394.724079138825;18607.720884186747;18625.906870465562;18653.160607772683;555481;560689;562417;562948;563903;65016;65933.67033164899;65962;66012.66993665001;66073.33926660672;1376.2224343246035;1442.8629280218363;1493.126520985214;1503.7894694742745;1505.9322330494936;33229.83385083059;34342;35072;35239.47140792941;35387.82306088453;54644.45355546553;54729.45270547244;54991.725041374535;55076.17385739137;55228;390508;392310;394668;395213;767555;30915.84542077365;31183.064508064796;31245.375092498478;32841.83579082089;32887.67112328846;52092;52995;53291;54385.184222235905;54440.45559544354;43693.9884209691;44135;48608.756956214995;48986.75506622444;49217.50782492129;44247.77876110728;44729.10541789211;45523.772381139206;45570.31644525401;46146.07707845891;43600.78199608982;43718.125637487705;44267.33598995953;44859.55140448554;45021.32468012917;38359;40504.3924341141;40832.79583602063;40967;40972.59027409807;29842.70157298399;29947.550786737782;30264.54603180998;30284.5457318136;30513.694863051085 03:45:03 INFO - PROCESS | 31824 | |2;jquery.html;421.93038148705466;431.6417373579927;432.1184783042593;433.3110354536287;443.81138016343044;18710.251589936404;19341.516462088453;19634.607307853836;20283.49291267719;20465.48836279092;19587.412377628658;19679;19695.5076123097;20437.897810510964;20451.590968180626;5781.739821708013;5946.316173640022;5954.196183515213;5957.821265362046;5967.940320596782;5871.324797648261;5874.88250234995;5899.115132730103;5947.791827286046;6210.472109870667;6174.289956654975;6190.195274614316;6194.039923811816;6205.720742566573;6217.751289948396;5763.423657634203;6151.661658608775;6181.505479561647;6229.283632382243;6240.126382306504;5669.0646043402785;5691.260136182311;5699.088145896637;5699.515541179005;5740.052891272935;14042.087264327785;14755.40978360875;14770.113793172337;14907.54025585777;15149.848501515064;2448.571499987495;2515.157422263544;2516.509280690266;2625.3961588834486;3057.541368794676;9883.258755593359;10562.841557376645;10783.13734901206;12821.653726358785;14271;1975.3580086471811;2014.717939488473;2018.1221168791476;2021.4542073640182;2105.3473423238843;76863.23136768672;82732;87899;91408.99999999933;93264.53367733186;11647.59233426826;11666.533338666528;11844.644660660195;12016.339101349335;12054.457549410297;16199.595010124842;16435.506934791974;16540.503784886474;16572.834271657128;16600;8601.612927418157;8795;8967.596458159398;9003.954980225057;9397.624095036123;8313.459625124347;8500.27747641445;8788.648454061766;8888.73333799987;9147.176754092163;5023.321851549994;5051.772670229849;5084.711879654171;5107.61692873036;5167.767450464738;1845.8463460337289;2061.4846288427893;2068.555260618944;2074.201432448518;2101.0965284927324;931.2689538712078;1000.6247657128577;1037.5953378182364;1045.6131231444263;1068.7702144038913;19268.614627707368;19500.902495487433;19714.309999149962;19742.802571974098;20225.797742022685;1031.5358088860044;1040.9687709368732;1043.5147656339839;1048.984265236022;1063.5798859450629;10716.785664286826;11186;11271.943640281746;11301.830472542919;11368.317900925971;471274;472137;486030;522618;546246;90965;95312.52343738376;96245.51877240709;96915.51542242244;97226.51386743021;986.8421052631544;997.9501024948869;1014.1126514299988;1033.34382667007;1034.813733527957;17800.55498612545;17840.55398615045;17849.37527186542;18068.277268909096;18231.817681823013;39941.80029099952;41348.58651413568;41430;42510.288270131154;43848;57888.421115788304;59247.703761480916;59435.70282148562;60307;60360;9284.350095493252;9350.859737103812;9362.719118426457;9411.811763764823;9449.763755906157;9677.758056048655;14051;14125.293735312987;14140.929295353457;14256.501022464165;12040.096992725756;12140.817887731868;12141.514339426323;12224.44989975471;12321.691957701129;12018.579349723068;12123.81814272769;12179.208351457128;12381.071419643382;12523.686907827378;12307.384630768605;12344.938275308567;12526.373681315716;12730.872691272969;12875;9172.908270917205;9222.815543689223;9263.861042084509;9300.11648893354;9524.761880952754;11850.229735067192;12072.879271207526;12106.394680266128;12199.939000305296;12370.70107638721 03:45:03 INFO - PROCESS | 31824 | |3;mootools.html;1420.19049141989;1557.1124459058335;1588.7219736546106;1768.4252617899185;1908.2367053178718;9066.863997040042;9504.619815207392;9532.237421006328;9794.559244833981;9808.16630586401;9485.241180705545;9701.854472182922;9703.514824258795;9710.56302466389;9716;2242.5739109569213;2299.4021554395895;2479.1818699829105;2560.6031065184925;2592.1445922845414;2585.31489155374;2608.2957601447597;2609.8173127881055;2614.4117573545896;2615.0585789116;2554.9233522994246;2569.9486010279784;2580.0711743772226;2581.6127580862835;2592.792576593868;2191.9561608767735;2414.7826695597305;2508.83692559983;2520.0549793827313;2553.6041913503345;2545.376382786211;2547.261294224673;2568.5119827232766;2570.884310206045;2578.6647735794227;9393.71818845429;9449;9455.52722363879;9471.242300616002;9474.668386606505;5814.97092514539;5931.110333449974;5942.940570594282;5951.851203719898;5960.940390596082;3796.8291426885858;3819.6753275971296;3828.674562662177;3867.7872717000555;3880.476135721698;1195.121585634558;1196.3838623109107;1204.2172587817902;1205.7287110400177;1233.3524899427782;13362.331883405888;13722.588322350346;13739.931300343535;13764.242966636832;13769.655758606015;5124.385073791094;5231.555317797954;5290.153575427913;5294.655847369909;5308.177232528964;11507.942460287644;11562.826557601642;11568.537258509734;11574;11581.536738530533;5968.134620480006;5976.491998180117;5979.701014949323;5982.551308651781;5987;4806.975965120152;5193.1171700810955;5248;5337.332833395825;5372.140457526777;4413.183561041217;4419.624331931757;4513.1650644630845;4530.77346132692;4571.1086338164405;1383.9100458470168;1418.035735699734;1430.1919415530192;1433.5555977646964;1435.8277006759047;976.7948730766618;993.8161440133598;1006.1900170362782;1007.0433088565892;1007.1439276614818;6653.234877988996;6706.362895525015;6709.094272273278;6756.594604323756;6827.556208846409;512.2521119166059;518.2071430711018;520.5341219608505;524.8661591294195;531.5428731291087;4367.881577434941;4384.802683879233;4436.3567282743825;4444.1111777643955;4539.931901021488;11862;12200.633980980585;12229.755404891852;12283.140180187302;12286.815697764541;11737.41312934367;12153.270803751626;12232.082593805322;12252.877471225353;12265.938670306592;8916.598753056129;8948.10518948113;8960.327975401871;9042.728718138334;9084.318676099187;6526.869462610816;6591.110200123114;6640.734370625121;6692.732290708317;6710;10651.520681569193;11096.722581935515;11336.263142895685;11348;11438.771224575628;11202.66392008241;11390.25963312382;11541.422928853355;11577.6526704199;11588.072954163477;7668.884966725615;7873.921260787548;7897.447178697666;8454.957725211334;8593.95703021481;8528.189821966904;9304.95347523258;9320.161185493338;9556.904430955601;9564.95217523908;8383.41316107891;8544.102869198645;8568.314534837322;8699.043105258543;8744.78138046554;8121.675132994614;8308.169183081643;8317.293030092509;8455.788605284917;8560.058393576826;7878.290953814184;7947.682092716226;7977.321927636216;7980.8802867955865;7983.2415920487465;5541;5774.39368866263;5844.240248767633;5900.734466948912;5938.554608404301;5708.5147762439;5733.426657334233;5765.7693692253515;5784.4504772046585;5881.882362352814 03:45:03 INFO - PROCESS | 31824 | |4;prototype.html;353.9487721467243;363.7890023786204;369.22462828061066;371.5949614919737;372.6925286638524;5561.86095347616;5592.664440133595;5607;5641.661500309984;5675.829725108243;5271.603025198316;5381.031414345416;5520.475554822286;5532.917006244909;5539.41836107209;4331.371951067109;4340.500842403132;4390.319500477431;4391.36325232841;4394.099209662011;4354.956450435487;4361.3457981302745;4370.2789039808395;4382.233109205877;4391.143726973241;3989.441478193041;4148.522919864209;4231.682623803227;4268.295731204363;4288.185244803477;4243.787810609457;4247.7026608137285;4249.660027197817;4265.509466411356;4289.6997210195295;3778.792166430845;3782.884049205491;3805.2579746949355;3806.9340584636348;3819.1216020315483;5106.412762532319;5266.736663166865;5269.86825329366;5275.920861187047;5333.386660534011;4868.440129385131;4872.585830204437;4888.73111978841;4901.362822833044;4958.900821983576;5722.742476588522;5732.140178973187;5758.769649214027;5760.337561180434;5791.797287094932;4042.4744783178294;4202.201581699467;4203.873883783461;4203.936940945889;4206.831726730927;5951.851203719898;5984.880302393971;5996.460318571306;6010.248718910137;6056.42463965927;4319.784010799511;4321.719088259253;4324.983628847219;4338.262495375794;4349.978250108729;4221.936670949938;4322.5735507282525;4329.220740266719;4340.848070317524;4357.869263922087;4902.975485122552;4916.418880087983;4917.262410638433;4936.062148191832;4941.629377796679;5719.685417302005;5782.190493330937;5787.797427090031;5794.942050579524;5803.984302747002;1447.2040377792173;1461.203644014015;1502.0762231227716;1525.313608875988;1530.4490383461946;979.1285755677453;987.8419452887504;990.9157721593601;995.6714284286168;1012.8278192707257;4918.967016926414;4956.776945037482;4965.379327584052;4973.955469351405;4977.282837421084;5162.399656106619;5219.451957544403;5222.869428264248;5242.18746094356;5243.872567398028;4831.661783675179;4964.280179373971;5012.699238045729;5019.598432125495;5019.745063734066;2805.0322638689618;2822.4214036122544;2832.1928250448523;2842.474142283643;2854.386306944017;5366.2755528004;5376.354837419534;5405.540529054996;5406.432324605859;5413.2692086568595;5255.948810237967;5326;5705.2012718219485;6122.336783499192;6232.158658581034;6205.193324867739;6247.718852651642;6249.031400132987;6260.123582698426;6264.404881536247;5923.703814809329;6030.849228769316;6050.031994880798;6076.513878889767;6090.817275481742;6010.519158467225;6011.519078473799;6023.186869772525;6025.78909738157;6035.973884439568;6278.780242691484;6287.182666253358;6299.370062993664;6326.956052251327;6330.145430367026;4225.722175126451;4250.298700714347;4360.302351623725;4364.498082720528;4375.7374557526655;5689.6586204827845;6052.394760523913;6057.939420605738;6097;6116.3272040076445;5747.971260143672;5851.912221316598;5883.94116058834;5912.438318359749;5944.851378715567;5748;5834.329052159056;5837.94162058374;5850.327212370632;5866.560007999332;5576.275084239023;5694.316681998187;5700.429957004267;5712.429082002483;5724.8282551523525;5789.45000224978;5839.912401313899;5846.210761547307;5864.853378665397;5871.1486834409625;5639.605227634026;5695.487406133468;5778.306603207642;5802.071668533014;5808.7095645218415 03:45:03 INFO - PROCESS | 31824 | |5;yui.html;801.9077806052302;805.6294104711832;829.3862541719126;855.5294587976613;869.452245085596;14549.781753273695;15274.465393711222;15297;15312.157831319273;15332.846671533282;15302.540923772305;15525.767113493306;16429.589260268498;17041.91479042606;17055.91472042638;728.5373787644858;855.285836326668;875.3872289397448;879.8152387998528;884.9469031858109;873.1355957601992;878.7232021913109;880.6257340630239;880.8326417980563;882.5102068352062;772.6021099133923;893.258595365848;918.7657147427396;920.1534588178891;922.2529750901791;906.7778394293407;910.517425764346;911.0024523147143;911.0889110889111;911.1708345405715;665.7503436211421;667.86308806695;668.9966550167267;669.2872091222832;669.6183175589915;15941;16027.839721602752;16031.83968160315;16086.436974705946;16095.114768687718;15236.985469140602;15317.923410382877;15351.846481535265;15477.22613869302;15559.988600740915;13924.791128133085;14026.649333766636;14136.151830890076;14252.358643861051;14298.142111473346;4680.227762419197;4692.741899195543;4734.4081989751285;4770.189067858472;4879.072976134558;81236;83524.58237708833;84162.15837841605;84471.57764211201;84851.5757421209;12180.451879665436;12185.036826463283;12228.144029917998;12370.257784532956;12513.874861251454;20132.698009529577;20745.688814667792;22106.115755369607;22167.556648866932;22263.554728905656;8453.112423195598;8576.957115214384;8632.35257355701;8687.869681954775;8787.91212087871;4864.173090574611;5100.591952643779;5107.182850743938;5204.167333226741;5211.374635043819;3906.4726261954274;4065.8576949806616;4068.959310406917;4069.084455997377;4072.898177545526;669.7722774256679;673.0879658063352;785.4698078796789;797.178905727102;815.9428839981263;673.639602812493;729.4091785653637;735.301463609573;785.3351291396016;801.286854699318;10024;10082.092611664839;10236.692899213036;10473.37159770401;10535.789284214427;688.3082502085472;734.8787450070786;753.4273951796674;756.029707520279;795.0975642645524;5299.258103865462;5376.623636345418;5392.191171324333;5412.675239485643;5570.136628822539;126024.36987815003;126926;128071;128191;130572.3471382637;65770;99023;99762.50118749504;100180.84266687883;105943.47028264964;89599;90987.99999999868;92305;92554;92597.53701231585;9295.349325547417;10237.9488102559;10919.890801091888;11221.382823944761;11289.491972861406;46670.29994550152;48031.519684802704;51865.22202166895;52510;54357.18464222961;69241.30758692349;73221;74792.62603686946;75242.62378688072;75800.24199757932;12277.447514861675;12708;13065;13214.273214972884;13246.735065298833;14844.62888427798;15481.84518154804;16566;16829.242684079;17008;14653.560393188221;14799.630009249855;14996;15510.612234694223;15723.685526289639;13918.58244252674;14475.203863787592;15045.172515511751;15087.396504139711;15398;14293.142411455347;14547.490837820626;14617.269136543344;14680.926595366955;14987;11853.525858965544;12142.514299427923;12245.571405000783;12375.195612285173;12397.814032789696;12412.937935310265;12511.061670374576;12544.560940367044;12691.175073620185;12935.870641293466 03:45:03 INFO - PROCESS | 31824 | __end_tp_report 03:45:03 INFO - PROCESS | 31824 | __start_cc_report 03:45:03 INFO - PROCESS | 31824 | _x_x_mozilla_cycle_collect,898 03:45:03 INFO - PROCESS | 31824 | __end_cc_report 03:45:03 INFO - PROCESS | 31824 | __startTimestamp1466073903533__endTimestamp 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | ------- Summary: start ------- 03:45:03 INFO - PROCESS | 31824 | Number of tests: 6 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | [#0] dojo.html Cycles:165 Average:5670.11 Median:5854.36 stddev:643.29 (11.0%) stddev-sans-first:619.06 03:45:03 INFO - PROCESS | 31824 | Values: 3353.2 3386.7 3390.6 3408.1 3433.9 5637.7 5720.3 5736.9 5740.3 5744.5 5700.7 5745.8 5759.9 5762.1 5764.7 5008.8 5094.4 5156.3 5218.3 5240.1 5150.3 5197.2 5199.2 5201.6 5206.6 5134.3 5177.7 5200.8 5224.0 5238.1 5295.7 5305.3 5315.3 5319.0 5349.8 4959.6 5005.2 5008.4 5208.8 5212.5 5510.2 5514.0 5518.7 5558.9 5578.0 6094.4 6095.5 6097.0 6104.4 6115.9 6105.8 6127.4 6136.4 6142.7 6239.9 5793.4 5845.1 5846.8 5852.4 5854.4 6080.7 6339.8 6344.5 6355.2 6356.3 5978.6 6041.9 6070.5 6112.4 6118.4 6193.4 6194.5 6195.4 6198.0 6199.1 5947.6 6012.1 6105.2 6120.8 6122.5 6071.1 6146.5 6147.0 6147.7 6154.8 4639.3 4680.9 4684.5 4696.2 4709.3 4059.2 4077.3 4106.3 4167.5 4174.8 5748.5 5754.8 5756.6 5757.9 5782.8 6098.1 6108.5 6112.4 6112.4 6125.4 5637.6 5661.8 5665.9 5729.0 5736.3 5213.3 5221.7 5228.7 5228.9 5230.5 6261.9 6267.8 6270.8 6271.2 6272.1 5985.8 6064.8 6114.6 6116.0 6176.8 6387.4 6401.3 6405.0 6405.3 6413.5 5815.7 6094.9 6105.1 6108.2 6116.7 5935.1 6008.3 6039.0 6095.5 6101.9 5945.7 5950.0 5956.3 5958.8 5961.8 5776.1 5828.8 5871.6 5938.2 5943.7 5792.1 5807.4 5848.0 5859.8 5885.1 5996.2 6027.7 6039.3 6042.0 6044.8 5730.0 5824.8 5858.9 5863.1 5878.9 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | [#1] ext.html Cycles:180 Average:63164.02 Median:21058.30 stddev:127482.12 (605.4%) stddev-sans-first:127753.21 03:45:03 INFO - PROCESS | 31824 | Values: 605.5 633.0 648.0 657.2 664.0 32205.5 39632.6 40461.2 40533.4 40928.4 48028.0 48410.3 48539.3 48555.8 48684.0 8510.1 8979.6 9174.1 9179.0 10904.9 10624.5 10772.9 11032.4 11035.2 11038.9 11058.9 11163.4 11163.4 11164.3 11174.0 8553.6 10875.7 10915.1 11109.7 11118.9 10929.8 10932.3 10941.5 10950.5 11044.8 45541.3 45799.8 45902.0 45925.2 45937.8 3374.9 3443.7 3590.0 3680.2 3757.6 35046.6 35250.1 35734.0 35965.0 36201.6 4627.4 4658.1 4676.7 4679.3 4685.2 362069.0 362688.0 364196.0 364906.2 366232.0 39565.0 40764.4 70033.6 70940.0 71053.6 41770.2 41810.2 41821.4 41908.8 42032.6 17529.8 17786.4 17787.1 17796.5 17833.7 11598.8 14661.1 14795.5 14829.6 15273.5 9370.7 9389.9 9414.4 9442.6 9474.2 3493.7 3575.6 3598.3 3603.3 3605.4 1046.3 1097.7 1105.7 1135.9 1190.7 34617.7 35155.8 35247.8 35256.0 35363.4 1159.8 1167.0 1180.6 1254.6 1254.7 18301.7 18394.7 18607.7 18625.9 18653.2 555481.0 560689.0 562417.0 562948.0 563903.0 65016.0 65933.7 65962.0 66012.7 66073.3 1376.2 1442.9 1493.1 1503.8 1505.9 33229.8 34342.0 35072.0 35239.5 35387.8 54644.5 54729.5 54991.7 55076.2 55228.0 390508.0 392310.0 394668.0 395213.0 767555.0 30915.8 31183.1 31245.4 32841.8 32887.7 52092.0 52995.0 53291.0 54385.2 54440.5 43694.0 44135.0 48608.8 48986.8 49217.5 44247.8 44729.1 45523.8 45570.3 46146.1 43600.8 43718.1 44267.3 44859.6 45021.3 38359.0 40504.4 40832.8 40967.0 40972.6 29842.7 29947.6 30264.5 30284.5 30513.7 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | [#2] jquery.html Cycles:180 Average:29715.11 Median:2481.86 stddev:82620.01 (3328.9%) stddev-sans-first:82822.50 03:45:03 INFO - PROCESS | 31824 | Values: 421.9 431.6 432.1 433.3 443.8 18710.3 19341.5 19634.6 20283.5 20465.5 19587.4 19679.0 19695.5 20437.9 20451.6 5781.7 5946.3 5954.2 5957.8 5967.9 5871.3 5874.9 5899.1 5947.8 6210.5 6174.3 6190.2 6194.0 6205.7 6217.8 5763.4 6151.7 6181.5 6229.3 6240.1 5669.1 5691.3 5699.1 5699.5 5740.1 14042.1 14755.4 14770.1 14907.5 15149.8 2448.6 2515.2 2516.5 2625.4 3057.5 9883.3 10562.8 10783.1 12821.7 14271.0 1975.4 2014.7 2018.1 2021.5 2105.3 76863.2 82732.0 87899.0 91409.0 93264.5 11647.6 11666.5 11844.6 12016.3 12054.5 16199.6 16435.5 16540.5 16572.8 16600.0 8601.6 8795.0 8967.6 9004.0 9397.6 8313.5 8500.3 8788.6 8888.7 9147.2 5023.3 5051.8 5084.7 5107.6 5167.8 1845.8 2061.5 2068.6 2074.2 2101.1 931.3 1000.6 1037.6 1045.6 1068.8 19268.6 19500.9 19714.3 19742.8 20225.8 1031.5 1041.0 1043.5 1049.0 1063.6 10716.8 11186.0 11271.9 11301.8 11368.3 471274.0 472137.0 486030.0 522618.0 546246.0 90965.0 95312.5 96245.5 96915.5 97226.5 986.8 998.0 1014.1 1033.3 1034.8 17800.6 17840.6 17849.4 18068.3 18231.8 39941.8 41348.6 41430.0 42510.3 43848.0 57888.4 59247.7 59435.7 60307.0 60360.0 9284.4 9350.9 9362.7 9411.8 9449.8 9677.8 14051.0 14125.3 14140.9 14256.5 12040.1 12140.8 12141.5 12224.4 12321.7 12018.6 12123.8 12179.2 12381.1 12523.7 12307.4 12344.9 12526.4 12730.9 12875.0 9172.9 9222.8 9263.9 9300.1 9524.8 11850.2 12072.9 12106.4 12199.9 12370.7 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | [#3] mootools.html Cycles:180 Average:6403.06 Median:2821.30 stddev:3679.79 (130.4%) stddev-sans-first:3671.06 03:45:03 INFO - PROCESS | 31824 | Values: 1420.2 1557.1 1588.7 1768.4 1908.2 9066.9 9504.6 9532.2 9794.6 9808.2 9485.2 9701.9 9703.5 9710.6 9716.0 2242.6 2299.4 2479.2 2560.6 2592.1 2585.3 2608.3 2609.8 2614.4 2615.1 2554.9 2569.9 2580.1 2581.6 2592.8 2192.0 2414.8 2508.8 2520.1 2553.6 2545.4 2547.3 2568.5 2570.9 2578.7 9393.7 9449.0 9455.5 9471.2 9474.7 5815.0 5931.1 5942.9 5951.9 5960.9 3796.8 3819.7 3828.7 3867.8 3880.5 1195.1 1196.4 1204.2 1205.7 1233.4 13362.3 13722.6 13739.9 13764.2 13769.7 5124.4 5231.6 5290.2 5294.7 5308.2 11507.9 11562.8 11568.5 11574.0 11581.5 5968.1 5976.5 5979.7 5982.6 5987.0 4807.0 5193.1 5248.0 5337.3 5372.1 4413.2 4419.6 4513.2 4530.8 4571.1 1383.9 1418.0 1430.2 1433.6 1435.8 976.8 993.8 1006.2 1007.0 1007.1 6653.2 6706.4 6709.1 6756.6 6827.6 512.3 518.2 520.5 524.9 531.5 4367.9 4384.8 4436.4 4444.1 4539.9 11862.0 12200.6 12229.8 12283.1 12286.8 11737.4 12153.3 12232.1 12252.9 12265.9 8916.6 8948.1 8960.3 9042.7 9084.3 6526.9 6591.1 6640.7 6692.7 6710.0 10651.5 11096.7 11336.3 11348.0 11438.8 11202.7 11390.3 11541.4 11577.7 11588.1 7668.9 7873.9 7897.4 8455.0 8594.0 8528.2 9305.0 9320.2 9556.9 9565.0 8383.4 8544.1 8568.3 8699.0 8744.8 8121.7 8308.2 8317.3 8455.8 8560.1 7878.3 7947.7 7977.3 7980.9 7983.2 5541.0 5774.4 5844.2 5900.7 5938.6 5708.5 5733.4 5765.8 5784.5 5881.9 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | [#4] prototype.html Cycles:180 Average:4814.14 Median:5273.76 stddev:1419.79 (26.9%) stddev-sans-first:1383.75 03:45:03 INFO - PROCESS | 31824 | Values: 353.9 363.8 369.2 371.6 372.7 5561.9 5592.7 5607.0 5641.7 5675.8 5271.6 5381.0 5520.5 5532.9 5539.4 4331.4 4340.5 4390.3 4391.4 4394.1 4355.0 4361.3 4370.3 4382.2 4391.1 3989.4 4148.5 4231.7 4268.3 4288.2 4243.8 4247.7 4249.7 4265.5 4289.7 3778.8 3782.9 3805.3 3806.9 3819.1 5106.4 5266.7 5269.9 5275.9 5333.4 4868.4 4872.6 4888.7 4901.4 4958.9 5722.7 5732.1 5758.8 5760.3 5791.8 4042.5 4202.2 4203.9 4203.9 4206.8 5951.9 5984.9 5996.5 6010.2 6056.4 4319.8 4321.7 4325.0 4338.3 4350.0 4221.9 4322.6 4329.2 4340.8 4357.9 4903.0 4916.4 4917.3 4936.1 4941.6 5719.7 5782.2 5787.8 5794.9 5804.0 1447.2 1461.2 1502.1 1525.3 1530.4 979.1 987.8 990.9 995.7 1012.8 4919.0 4956.8 4965.4 4974.0 4977.3 5162.4 5219.5 5222.9 5242.2 5243.9 4831.7 4964.3 5012.7 5019.6 5019.7 2805.0 2822.4 2832.2 2842.5 2854.4 5366.3 5376.4 5405.5 5406.4 5413.3 5255.9 5326.0 5705.2 6122.3 6232.2 6205.2 6247.7 6249.0 6260.1 6264.4 5923.7 6030.8 6050.0 6076.5 6090.8 6010.5 6011.5 6023.2 6025.8 6036.0 6278.8 6287.2 6299.4 6327.0 6330.1 4225.7 4250.3 4360.3 4364.5 4375.7 5689.7 6052.4 6057.9 6097.0 6116.3 5748.0 5851.9 5883.9 5912.4 5944.9 5748.0 5834.3 5837.9 5850.3 5866.6 5576.3 5694.3 5700.4 5712.4 5724.8 5789.5 5839.9 5846.2 5864.9 5871.1 5639.6 5695.5 5778.3 5802.1 5808.7 03:45:03 INFO - PROCESS | 31824 | 03:45:03 INFO - PROCESS | 31824 | [#5] yui.html Cycles:180 Average:21858.77 Median:25371.60 stddev:31373.36 (123.7%) stddev-sans-first:31421.53 03:45:03 INFO - PROCESS | 31824 | Values: 801.9 805.6 829.4 855.5 869.5 14549.8 15274.5 15297.0 15312.2 15332.8 15302.5 15525.8 16429.6 17041.9 17055.9 728.5 855.3 875.4 879.8 884.9 873.1 878.7 880.6 880.8 882.5 772.6 893.3 918.8 920.2 922.3 906.8 910.5 911.0 911.1 911.2 665.8 667.9 669.0 669.3 669.6 15941.0 16027.8 16031.8 16086.4 16095.1 15237.0 15317.9 15351.8 15477.2 15560.0 13924.8 14026.6 14136.2 14252.4 14298.1 4680.2 4692.7 4734.4 4770.2 4879.1 81236.0 83524.6 84162.2 84471.6 84851.6 12180.5 12185.0 12228.1 12370.3 12513.9 20132.7 20745.7 22106.1 22167.6 22263.6 8453.1 8577.0 8632.4 8687.9 8787.9 4864.2 5100.6 5107.2 5204.2 5211.4 3906.5 4065.9 4069.0 4069.1 4072.9 669.8 673.1 785.5 797.2 815.9 673.6 729.4 735.3 785.3 801.3 10024.0 10082.1 10236.7 10473.4 10535.8 688.3 734.9 753.4 756.0 795.1 5299.3 5376.6 5392.2 5412.7 5570.1 126024.4 126926.0 128071.0 128191.0 130572.3 65770.0 99023.0 99762.5 100180.8 105943.5 89599.0 90988.0 92305.0 92554.0 92597.5 9295.3 10237.9 10919.9 11221.4 11289.5 46670.3 48031.5 51865.2 52510.0 54357.2 69241.3 73221.0 74792.6 75242.6 75800.2 12277.4 12708.0 13065.0 13214.3 13246.7 14844.6 15481.8 16566.0 16829.2 17008.0 14653.6 14799.6 14996.0 15510.6 15723.7 13918.6 14475.2 15045.2 15087.4 15398.0 14293.1 14547.5 14617.3 14680.9 14987.0 11853.5 12142.5 12245.6 12375.2 12397.8 12412.9 12511.1 12544.6 12691.2 12935.9 03:45:03 INFO - PROCESS | 31824 | -------- Summary: end -------- 03:45:03 INFO - PROCESS | 31824 | 03:45:04 INFO - TEST-INFO | 31824: exit 0 03:45:04 INFO - TEST-OK | dromaeo_css | took 1113540ms 03:45:04 INFO - TEST-START | kraken 03:45:04 INFO - operating with platform_type : linux_ 03:45:04 INFO - Initialising browser for kraken test... 03:45:04 INFO - TEST-INFO | started process 32009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnPwjO/profile http://localhost:57456/getInfo.html) 03:45:08 INFO - PROCESS | 32009 | __metrics Screen width/height:1600/1200 03:45:08 INFO - PROCESS | 32009 | colorDepth:24 03:45:08 INFO - PROCESS | 32009 | Browser inner width/height: 1024/697 03:45:08 INFO - PROCESS | 32009 | __metrics 03:45:09 ERROR - PROCESS | 32009 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:45:09 INFO - PROCESS | 32009 | console.error: PushService: 03:45:09 INFO - PROCESS | 32009 | stateChangeProcessEnqueue: Error transitioning state 03:45:09 INFO - PROCESS | 32009 | UnknownError 03:45:10 INFO - TEST-INFO | 32009: exit 0 03:45:10 INFO - Browser initialized. 03:45:10 INFO - Running cycle 1/1 for kraken test... 03:45:10 INFO - TEST-INFO | started process 32104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnPwjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:22 INFO - PROCESS | 32104 | RSS: Main: 145936384 03:45:22 INFO - PROCESS | 32104 | 03:45:24 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57456/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:25 INFO - PROCESS | 32104 | RSS: Main: 194842624 03:45:25 INFO - PROCESS | 32104 | 03:45:27 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57456/tests/kraken/driver.html?testName=audio-dft) 03:45:28 INFO - PROCESS | 32104 | RSS: Main: 193097728 03:45:28 INFO - PROCESS | 32104 | 03:45:31 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57456/tests/kraken/driver.html?testName=audio-fft) 03:45:32 INFO - PROCESS | 32104 | RSS: Main: 278994944 03:45:32 INFO - PROCESS | 32104 | 03:45:34 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57456/tests/kraken/driver.html?testName=audio-oscillator) 03:45:34 INFO - PROCESS | 32104 | RSS: Main: 187318272 03:45:34 INFO - PROCESS | 32104 | 03:45:36 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:37 INFO - PROCESS | 32104 | RSS: Main: 187957248 03:45:37 INFO - PROCESS | 32104 | 03:45:40 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57456/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:41 INFO - PROCESS | 32104 | RSS: Main: 222863360 03:45:41 INFO - PROCESS | 32104 | 03:45:44 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57456/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:44 INFO - PROCESS | 32104 | RSS: Main: 222019584 03:45:44 INFO - PROCESS | 32104 | 03:45:47 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57456/tests/kraken/driver.html?testName=json-parse-financial) 03:45:48 INFO - PROCESS | 32104 | RSS: Main: 222384128 03:45:48 INFO - PROCESS | 32104 | 03:45:49 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:50 INFO - PROCESS | 32104 | RSS: Main: 200835072 03:45:50 INFO - PROCESS | 32104 | 03:45:52 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:52 INFO - PROCESS | 32104 | RSS: Main: 204337152 03:45:52 INFO - PROCESS | 32104 | 03:45:54 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:55 INFO - PROCESS | 32104 | RSS: Main: 209170432 03:45:55 INFO - PROCESS | 32104 | 03:45:57 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:58 INFO - PROCESS | 32104 | RSS: Main: 212176896 03:45:58 INFO - PROCESS | 32104 | 03:46:01 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:01 INFO - PROCESS | 32104 | RSS: Main: 212598784 03:46:01 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | Cycle 1(1): loaded http://localhost:57456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57456/tests/kraken/driver.html?testName=ai-astar) 03:46:03 INFO - PROCESS | 32104 | RSS: Main: 255582208 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | __start_tp_report 03:46:03 INFO - PROCESS | 32104 | _x_x_mozilla_page_load 03:46:03 INFO - PROCESS | 32104 | _x_x_mozilla_page_load_details 03:46:03 INFO - PROCESS | 32104 | |i|pagename|runs| 03:46:03 INFO - PROCESS | 32104 | |0;ai-astar;110;103;108;108;111;110;108;109;109;108 03:46:03 INFO - PROCESS | 32104 | |1;audio-beat-detection;153;124;132;176;123;127;157;125;160;124 03:46:03 INFO - PROCESS | 32104 | |2;audio-dft;162;162;159;162;163;161;162;162;162;162 03:46:03 INFO - PROCESS | 32104 | |3;audio-fft;76;74;75;134;75;76;75;76;98;75 03:46:03 INFO - PROCESS | 32104 | |4;audio-oscillator;84;84;114;84;84;84;116;84;83;136 03:46:03 INFO - PROCESS | 32104 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 03:46:03 INFO - PROCESS | 32104 | |6;imaging-darkroom;146;145;145;145;147;146;146;146;145;145 03:46:03 INFO - PROCESS | 32104 | |7;imaging-desaturate;94;94;95;95;95;95;95;94;95;95 03:46:03 INFO - PROCESS | 32104 | |8;json-parse-financial;51;50;51;52;53;51;53;51;51;53 03:46:03 INFO - PROCESS | 32104 | |9;json-stringify-tinderbox;61;60;59;59;59;58;59;59;60;60 03:46:03 INFO - PROCESS | 32104 | |10;stanford-crypto-aes;76;80;77;75;76;78;76;76;132;81 03:46:03 INFO - PROCESS | 32104 | |11;stanford-crypto-ccm;121;128;124;117;117;140;125;120;127;126 03:46:03 INFO - PROCESS | 32104 | |12;stanford-crypto-pbkdf2;161;156;161;158;153;156;159;152;151;152 03:46:03 INFO - PROCESS | 32104 | |13;stanford-crypto-sha256-iterative;62;65;64;60;61;62;61;61;61;60 03:46:03 INFO - PROCESS | 32104 | __end_tp_report 03:46:03 INFO - PROCESS | 32104 | __start_cc_report 03:46:03 INFO - PROCESS | 32104 | _x_x_mozilla_cycle_collect,1569 03:46:03 INFO - PROCESS | 32104 | __end_cc_report 03:46:03 INFO - PROCESS | 32104 | __startTimestamp1466073963728__endTimestamp 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | ------- Summary: start ------- 03:46:03 INFO - PROCESS | 32104 | Number of tests: 14 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:2.17 (2.0%) stddev-sans-first:2.22 03:46:03 INFO - PROCESS | 32104 | Values: 110.0 103.0 108.0 108.0 111.0 110.0 108.0 109.0 109.0 108.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:142.50 stddev:19.47 (13.7%) stddev-sans-first:20.09 03:46:03 INFO - PROCESS | 32104 | Values: 153.0 124.0 132.0 176.0 123.0 127.0 157.0 125.0 160.0 124.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 03:46:03 INFO - PROCESS | 32104 | Values: 162.0 162.0 159.0 162.0 163.0 161.0 162.0 162.0 162.0 162.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.50 stddev:19.17 (25.4%) stddev-sans-first:20.15 03:46:03 INFO - PROCESS | 32104 | Values: 76.0 74.0 75.0 134.0 75.0 76.0 75.0 76.0 98.0 75.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:19.30 (23.0%) stddev-sans-first:20.03 03:46:03 INFO - PROCESS | 32104 | Values: 84.0 84.0 114.0 84.0 84.0 84.0 116.0 84.0 83.0 136.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:46:03 INFO - PROCESS | 32104 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:46:03 INFO - PROCESS | 32104 | Values: 146.0 145.0 145.0 145.0 147.0 146.0 146.0 146.0 145.0 145.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:46:03 INFO - PROCESS | 32104 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:1.07 (2.1%) stddev-sans-first:1.12 03:46:03 INFO - PROCESS | 32104 | Values: 51.0 50.0 51.0 52.0 53.0 51.0 53.0 51.0 51.0 53.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 03:46:03 INFO - PROCESS | 32104 | Values: 61.0 60.0 59.0 59.0 59.0 58.0 59.0 59.0 60.0 60.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:76.50 stddev:17.43 (22.8%) stddev-sans-first:18.32 03:46:03 INFO - PROCESS | 32104 | Values: 76.0 80.0 77.0 75.0 76.0 78.0 76.0 76.0 132.0 81.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:125.50 stddev:6.72 (5.4%) stddev-sans-first:7.01 03:46:03 INFO - PROCESS | 32104 | Values: 121.0 128.0 124.0 117.0 117.0 140.0 125.0 120.0 127.0 126.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:157.00 stddev:3.78 (2.4%) stddev-sans-first:3.54 03:46:03 INFO - PROCESS | 32104 | Values: 161.0 156.0 161.0 158.0 153.0 156.0 159.0 152.0 151.0 152.0 03:46:03 INFO - PROCESS | 32104 | 03:46:03 INFO - PROCESS | 32104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.64 (2.7%) stddev-sans-first:1.73 03:46:03 INFO - PROCESS | 32104 | Values: 62.0 65.0 64.0 60.0 61.0 62.0 61.0 61.0 61.0 60.0 03:46:03 INFO - PROCESS | 32104 | -------- Summary: end -------- 03:46:03 INFO - PROCESS | 32104 | 03:46:04 INFO - TEST-INFO | 32104: exit 0 03:46:04 INFO - TEST-OK | kraken | took 60423ms 03:46:04 INFO - SUITE-END | took 1173s 03:46:04 INFO - Completed test suite (00:19:34) 03:46:04 INFO - javascript benchmark 03:46:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.2119951811324, 3386.729061675066, 3390.559227300449, 3408.130926613713, 3433.8798142065034, 5637.746301416436, 5720.256366672332, 5736.942630573693, 5740.339860915996, 5744.5117165040965, 5700.686462244575, 5745.798897038604, 5759.942400575993, 5762.1068734346245, 5764.654120752758, 5008.84973450797, 5094.363204599425, 5156.329677141966, 5218.269442278065, 5240.082985477546, 5150.27896094547, 5197.168453047494, 5199.168133098705, 5201.583873290147, 5206.557442617382, 5134.2812006319145, 5177.715225662587, 5200.843974680747, 5224.033553792541, 5238.109521381374, 5295.682259064469, 5305.336832895888, 5315.282436871012, 5319.042572336978, 5349.786008559633, 4959.603231741488, 5005.224190250517, 5008.398992120932, 5208.817691380784, 5212.452692467275, 5510.173473978935, 5514.035043867307, 5518.668879867221, 5558.861028474321, 5578.0, 6094.414199418284, 6095.451409373178, 6096.96951515244, 6104.3839667506, 6115.87768244637, 6105.755769769204, 6127.433875357673, 6136.447719705203, 6142.723577439026, 6239.937600623981, 5793.420657934215, 5845.064789633639, 5846.795362162304, 5852.444017818343, 5854.356020837789, 6080.726367313481, 6339.778107766206, 6344.460720838781, 6355.173827402408, 6356.332585078592, 5978.5814992950945, 6041.909371359433, 6070.453659170696, 6112.419320164578, 6118.418750218722, 6193.411625895533, 6194.5044396448175, 6195.411435913581, 6198.0, 6199.1011303361665, 5947.6431414115295, 6012.068129439944, 6105.206323177958, 6120.755169793248, 6122.510199184055, 6071.089336599457, 6146.5390095743, 6146.969265153645, 6147.66187859672, 6154.753809847645, 4639.257718764981, 4680.859574212779, 4684.484706682262, 4696.201645720235, 4709.293605959065, 4059.188162367538, 4077.347624380085, 4106.281400754856, 4167.4790651168605, 4174.791260436966, 5748.511376532958, 5754.798582049608, 5756.5682573807135, 5757.913631295534, 5782.7686892523825, 6098.14625952367, 6108.517419168856, 6112.442689633878, 6112.446322032932, 6125.387461253928, 5637.633553818989, 5661.830145095653, 5665.915011274834, 5728.971355143281, 5736.282964629421, 5213.348331458567, 5221.712805795718, 5228.6862788232065, 5228.869278268074, 5230.450802665741, 6261.906071408933, 6267.780627678009, 6270.843228919222, 6271.184745982993, 6272.059191121369, 5985.790497332572, 6064.818055458343, 6114.571104522668, 6116.031445915052, 6176.7838125665385, 6387.425131738166, 6401.263854656588, 6405.0392441132335, 6405.263394709668, 6413.518986075969, 5815.651060936358, 6094.908576371269, 6105.114758360101, 6108.205933228652, 6116.694165291807, 5935.109733539831, 6008.309044459943, 6038.969805151122, 6095.481884039729, 6101.938980610137, 5945.672987985702, 5950.047992321208, 5956.285245770535, 5958.821235362946, 5961.791337303173, 5776.104703770922, 5828.825135245949, 5871.6183448075735, 5938.168656388196, 5943.7028148591535, 5792.102224155263, 5807.390224026416, 5848.0, 5859.794907178229, 5885.087811389241, 5996.190514280691, 6027.6986150693165, 6039.335673075871, 6041.969790151021, 6044.788432405021, 5730.0, 5824.825255242349, 5858.94141058584, 5863.061910094364, 5878.911816322673], "value": 5627.314871141587, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.4702135631322, 633.0346222011433, 647.964361960092, 657.1686816177534, 664.0172544633941, 32205.51691724626, 39632.603673963255, 40461.190776184456, 40533.39199912004, 40928.38607420884, 48028.0, 48410.27384589234, 48539.27191092128, 48555.757221213935, 48684.0, 8510.148985101472, 8979.640814367434, 9174.128457796498, 9179.0, 10904.890951090467, 10624.521896514676, 10772.892271077306, 11032.393218372987, 11035.172362072837, 11038.889611103907, 11058.889411105907, 11163.386013769239, 11163.386013769239, 11164.274322169074, 11174.0, 8553.572321383968, 10875.673729788119, 10915.126789856831, 11109.666709998713, 11118.944405277922, 10929.781404371868, 10932.289401188977, 10941.452927353681, 10950.507227174796, 11044.834327485094, 45541.31688024682, 45799.77100114511, 45902.0, 45925.244485330986, 45937.77031114857, 3374.898753037413, 3443.6900678938764, 3589.964100359015, 3680.190358121236, 3757.605451427588, 35046.64953350459, 35250.07085216516, 35734.0, 35965.0, 36201.63798362009, 4627.375304333906, 4658.138244424758, 4676.672632915697, 4679.251319788851, 4685.1566717990745, 362069.0, 362688.0, 364196.0, 364906.1754691236, 366232.0, 39565.0, 40764.38853417201, 70033.64983175052, 70940.0, 71053.644731776, 41770.164596707895, 41810.16379672389, 41821.37267940983, 41908.79045604752, 42032.57967420287, 17529.824701753074, 17786.37747678825, 17787.110644467724, 17796.46610601684, 17833.732494012602, 11598.768024639628, 14661.120332780067, 14795.482158124414, 14829.629259268604, 15273.465428709942, 9370.718878433658, 9389.906100938902, 9414.435133891988, 9442.622295108256, 9474.242060635133, 3493.737969652286, 3575.6245594212755, 3598.2623562169692, 3603.2973570153567, 3605.387084195693, 1046.3408052926607, 1097.7310558912957, 1105.723569107723, 1135.8580177477816, 1190.7023244188954, 34617.653823461944, 35155.824220878734, 35247.82376088103, 35256.0, 35363.36633663366, 1159.7680463907252, 1166.988330116705, 1180.557291015869, 1254.5797157952006, 1254.730232999891, 18301.7254741179, 18394.724079138825, 18607.720884186747, 18625.906870465562, 18653.160607772683, 555481.0, 560689.0, 562417.0, 562948.0, 563903.0, 65016.0, 65933.67033164899, 65962.0, 66012.66993665001, 66073.33926660672, 1376.2224343246035, 1442.8629280218363, 1493.126520985214, 1503.7894694742745, 1505.9322330494936, 33229.83385083059, 34342.0, 35072.0, 35239.47140792941, 35387.82306088453, 54644.45355546553, 54729.45270547244, 54991.725041374535, 55076.17385739137, 55228.0, 390508.0, 392310.0, 394668.0, 395213.0, 767555.0, 30915.84542077365, 31183.064508064796, 31245.375092498478, 32841.83579082089, 32887.67112328846, 52092.0, 52995.0, 53291.0, 54385.184222235905, 54440.45559544354, 43693.9884209691, 44135.0, 48608.756956214995, 48986.75506622444, 49217.50782492129, 44247.77876110728, 44729.10541789211, 45523.772381139206, 45570.31644525401, 46146.07707845891, 43600.78199608982, 43718.125637487705, 44267.33598995953, 44859.55140448554, 45021.32468012917, 38359.0, 40504.3924341141, 40832.79583602063, 40967.0, 40972.59027409807, 29842.70157298399, 29947.550786737782, 30264.54603180998, 30284.5457318136, 30513.694863051085], "value": 20768.17959803437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.93038148705466, 431.6417373579927, 432.1184783042593, 433.3110354536287, 443.81138016343044, 18710.251589936404, 19341.516462088453, 19634.607307853836, 20283.49291267719, 20465.48836279092, 19587.412377628658, 19679.0, 19695.5076123097, 20437.897810510964, 20451.590968180626, 5781.739821708013, 5946.316173640022, 5954.196183515213, 5957.821265362046, 5967.940320596782, 5871.324797648261, 5874.88250234995, 5899.115132730103, 5947.791827286046, 6210.472109870667, 6174.289956654975, 6190.195274614316, 6194.039923811816, 6205.720742566573, 6217.751289948396, 5763.423657634203, 6151.661658608775, 6181.505479561647, 6229.283632382243, 6240.126382306504, 5669.0646043402785, 5691.260136182311, 5699.088145896637, 5699.515541179005, 5740.052891272935, 14042.087264327785, 14755.40978360875, 14770.113793172337, 14907.54025585777, 15149.848501515064, 2448.571499987495, 2515.157422263544, 2516.509280690266, 2625.3961588834486, 3057.541368794676, 9883.258755593359, 10562.841557376645, 10783.13734901206, 12821.653726358785, 14271.0, 1975.3580086471811, 2014.717939488473, 2018.1221168791476, 2021.4542073640182, 2105.3473423238843, 76863.23136768672, 82732.0, 87899.0, 91408.99999999933, 93264.53367733186, 11647.59233426826, 11666.533338666528, 11844.644660660195, 12016.339101349335, 12054.457549410297, 16199.595010124842, 16435.506934791974, 16540.503784886474, 16572.834271657128, 16600.0, 8601.612927418157, 8795.0, 8967.596458159398, 9003.954980225057, 9397.624095036123, 8313.459625124347, 8500.27747641445, 8788.648454061766, 8888.73333799987, 9147.176754092163, 5023.321851549994, 5051.772670229849, 5084.711879654171, 5107.61692873036, 5167.767450464738, 1845.8463460337289, 2061.4846288427893, 2068.555260618944, 2074.201432448518, 2101.0965284927324, 931.2689538712078, 1000.6247657128577, 1037.5953378182364, 1045.6131231444263, 1068.7702144038913, 19268.614627707368, 19500.902495487433, 19714.309999149962, 19742.802571974098, 20225.797742022685, 1031.5358088860044, 1040.9687709368732, 1043.5147656339839, 1048.984265236022, 1063.5798859450629, 10716.785664286826, 11186.0, 11271.943640281746, 11301.830472542919, 11368.317900925971, 471274.0, 472137.0, 486030.0, 522618.0, 546246.0, 90965.0, 95312.52343738376, 96245.51877240709, 96915.51542242244, 97226.51386743021, 986.8421052631544, 997.9501024948869, 1014.1126514299988, 1033.34382667007, 1034.813733527957, 17800.55498612545, 17840.55398615045, 17849.37527186542, 18068.277268909096, 18231.817681823013, 39941.80029099952, 41348.58651413568, 41430.0, 42510.288270131154, 43848.0, 57888.421115788304, 59247.703761480916, 59435.70282148562, 60307.0, 60360.0, 9284.350095493252, 9350.859737103812, 9362.719118426457, 9411.811763764823, 9449.763755906157, 9677.758056048655, 14051.0, 14125.293735312987, 14140.929295353457, 14256.501022464165, 12040.096992725756, 12140.817887731868, 12141.514339426323, 12224.44989975471, 12321.691957701129, 12018.579349723068, 12123.81814272769, 12179.208351457128, 12381.071419643382, 12523.686907827378, 12307.384630768605, 12344.938275308567, 12526.373681315716, 12730.872691272969, 12875.0, 9172.908270917205, 9222.815543689223, 9263.861042084509, 9300.11648893354, 9524.761880952754, 11850.229735067192, 12072.879271207526, 12106.394680266128, 12199.939000305296, 12370.70107638721], "value": 9581.408793793005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.19049141989, 1557.1124459058335, 1588.7219736546106, 1768.4252617899185, 1908.2367053178718, 9066.863997040042, 9504.619815207392, 9532.237421006328, 9794.559244833981, 9808.16630586401, 9485.241180705545, 9701.854472182922, 9703.514824258795, 9710.56302466389, 9716.0, 2242.5739109569213, 2299.4021554395895, 2479.1818699829105, 2560.6031065184925, 2592.1445922845414, 2585.31489155374, 2608.2957601447597, 2609.8173127881055, 2614.4117573545896, 2615.0585789116, 2554.9233522994246, 2569.9486010279784, 2580.0711743772226, 2581.6127580862835, 2592.792576593868, 2191.9561608767735, 2414.7826695597305, 2508.83692559983, 2520.0549793827313, 2553.6041913503345, 2545.376382786211, 2547.261294224673, 2568.5119827232766, 2570.884310206045, 2578.6647735794227, 9393.71818845429, 9449.0, 9455.52722363879, 9471.242300616002, 9474.668386606505, 5814.97092514539, 5931.110333449974, 5942.940570594282, 5951.851203719898, 5960.940390596082, 3796.8291426885858, 3819.6753275971296, 3828.674562662177, 3867.7872717000555, 3880.476135721698, 1195.121585634558, 1196.3838623109107, 1204.2172587817902, 1205.7287110400177, 1233.3524899427782, 13362.331883405888, 13722.588322350346, 13739.931300343535, 13764.242966636832, 13769.655758606015, 5124.385073791094, 5231.555317797954, 5290.153575427913, 5294.655847369909, 5308.177232528964, 11507.942460287644, 11562.826557601642, 11568.537258509734, 11574.0, 11581.536738530533, 5968.134620480006, 5976.491998180117, 5979.701014949323, 5982.551308651781, 5987.0, 4806.975965120152, 5193.1171700810955, 5248.0, 5337.332833395825, 5372.140457526777, 4413.183561041217, 4419.624331931757, 4513.1650644630845, 4530.77346132692, 4571.1086338164405, 1383.9100458470168, 1418.035735699734, 1430.1919415530192, 1433.5555977646964, 1435.8277006759047, 976.7948730766618, 993.8161440133598, 1006.1900170362782, 1007.0433088565892, 1007.1439276614818, 6653.234877988996, 6706.362895525015, 6709.094272273278, 6756.594604323756, 6827.556208846409, 512.2521119166059, 518.2071430711018, 520.5341219608505, 524.8661591294195, 531.5428731291087, 4367.881577434941, 4384.802683879233, 4436.3567282743825, 4444.1111777643955, 4539.931901021488, 11862.0, 12200.633980980585, 12229.755404891852, 12283.140180187302, 12286.815697764541, 11737.41312934367, 12153.270803751626, 12232.082593805322, 12252.877471225353, 12265.938670306592, 8916.598753056129, 8948.10518948113, 8960.327975401871, 9042.728718138334, 9084.318676099187, 6526.869462610816, 6591.110200123114, 6640.734370625121, 6692.732290708317, 6710.0, 10651.520681569193, 11096.722581935515, 11336.263142895685, 11348.0, 11438.771224575628, 11202.66392008241, 11390.25963312382, 11541.422928853355, 11577.6526704199, 11588.072954163477, 7668.884966725615, 7873.921260787548, 7897.447178697666, 8454.957725211334, 8593.95703021481, 8528.189821966904, 9304.95347523258, 9320.161185493338, 9556.904430955601, 9564.95217523908, 8383.41316107891, 8544.102869198645, 8568.314534837322, 8699.043105258543, 8744.78138046554, 8121.675132994614, 8308.169183081643, 8317.293030092509, 8455.788605284917, 8560.058393576826, 7878.290953814184, 7947.682092716226, 7977.321927636216, 7980.8802867955865, 7983.2415920487465, 5541.0, 5774.39368866263, 5844.240248767633, 5900.734466948912, 5938.554608404301, 5708.5147762439, 5733.426657334233, 5765.7693692253515, 5784.4504772046585, 5881.882362352814], "value": 5018.523687412986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9487721467243, 363.7890023786204, 369.22462828061066, 371.5949614919737, 372.6925286638524, 5561.86095347616, 5592.664440133595, 5607.0, 5641.661500309984, 5675.829725108243, 5271.603025198316, 5381.031414345416, 5520.475554822286, 5532.917006244909, 5539.41836107209, 4331.371951067109, 4340.500842403132, 4390.319500477431, 4391.36325232841, 4394.099209662011, 4354.956450435487, 4361.3457981302745, 4370.2789039808395, 4382.233109205877, 4391.143726973241, 3989.441478193041, 4148.522919864209, 4231.682623803227, 4268.295731204363, 4288.185244803477, 4243.787810609457, 4247.7026608137285, 4249.660027197817, 4265.509466411356, 4289.6997210195295, 3778.792166430845, 3782.884049205491, 3805.2579746949355, 3806.9340584636348, 3819.1216020315483, 5106.412762532319, 5266.736663166865, 5269.86825329366, 5275.920861187047, 5333.386660534011, 4868.440129385131, 4872.585830204437, 4888.73111978841, 4901.362822833044, 4958.900821983576, 5722.742476588522, 5732.140178973187, 5758.769649214027, 5760.337561180434, 5791.797287094932, 4042.4744783178294, 4202.201581699467, 4203.873883783461, 4203.936940945889, 4206.831726730927, 5951.851203719898, 5984.880302393971, 5996.460318571306, 6010.248718910137, 6056.42463965927, 4319.784010799511, 4321.719088259253, 4324.983628847219, 4338.262495375794, 4349.978250108729, 4221.936670949938, 4322.5735507282525, 4329.220740266719, 4340.848070317524, 4357.869263922087, 4902.975485122552, 4916.418880087983, 4917.262410638433, 4936.062148191832, 4941.629377796679, 5719.685417302005, 5782.190493330937, 5787.797427090031, 5794.942050579524, 5803.984302747002, 1447.2040377792173, 1461.203644014015, 1502.0762231227716, 1525.313608875988, 1530.4490383461946, 979.1285755677453, 987.8419452887504, 990.9157721593601, 995.6714284286168, 1012.8278192707257, 4918.967016926414, 4956.776945037482, 4965.379327584052, 4973.955469351405, 4977.282837421084, 5162.399656106619, 5219.451957544403, 5222.869428264248, 5242.18746094356, 5243.872567398028, 4831.661783675179, 4964.280179373971, 5012.699238045729, 5019.598432125495, 5019.745063734066, 2805.0322638689618, 2822.4214036122544, 2832.1928250448523, 2842.474142283643, 2854.386306944017, 5366.2755528004, 5376.354837419534, 5405.540529054996, 5406.432324605859, 5413.2692086568595, 5255.948810237967, 5326.0, 5705.2012718219485, 6122.336783499192, 6232.158658581034, 6205.193324867739, 6247.718852651642, 6249.031400132987, 6260.123582698426, 6264.404881536247, 5923.703814809329, 6030.849228769316, 6050.031994880798, 6076.513878889767, 6090.817275481742, 6010.519158467225, 6011.519078473799, 6023.186869772525, 6025.78909738157, 6035.973884439568, 6278.780242691484, 6287.182666253358, 6299.370062993664, 6326.956052251327, 6330.145430367026, 4225.722175126451, 4250.298700714347, 4360.302351623725, 4364.498082720528, 4375.7374557526655, 5689.6586204827845, 6052.394760523913, 6057.939420605738, 6097.0, 6116.3272040076445, 5747.971260143672, 5851.912221316598, 5883.94116058834, 5912.438318359749, 5944.851378715567, 5748.0, 5834.329052159056, 5837.94162058374, 5850.327212370632, 5866.560007999332, 5576.275084239023, 5694.316681998187, 5700.429957004267, 5712.429082002483, 5724.8282551523525, 5789.45000224978, 5839.912401313899, 5846.210761547307, 5864.853378665397, 5871.1486834409625, 5639.605227634026, 5695.487406133468, 5778.306603207642, 5802.071668533014, 5808.7095645218415], "value": 4371.327930249605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.9077806052302, 805.6294104711832, 829.3862541719126, 855.5294587976613, 869.452245085596, 14549.781753273695, 15274.465393711222, 15297.0, 15312.157831319273, 15332.846671533282, 15302.540923772305, 15525.767113493306, 16429.589260268498, 17041.91479042606, 17055.91472042638, 728.5373787644858, 855.285836326668, 875.3872289397448, 879.8152387998528, 884.9469031858109, 873.1355957601992, 878.7232021913109, 880.6257340630239, 880.8326417980563, 882.5102068352062, 772.6021099133923, 893.258595365848, 918.7657147427396, 920.1534588178891, 922.2529750901791, 906.7778394293407, 910.517425764346, 911.0024523147143, 911.0889110889111, 911.1708345405715, 665.7503436211421, 667.86308806695, 668.9966550167267, 669.2872091222832, 669.6183175589915, 15941.0, 16027.839721602752, 16031.83968160315, 16086.436974705946, 16095.114768687718, 15236.985469140602, 15317.923410382877, 15351.846481535265, 15477.22613869302, 15559.988600740915, 13924.791128133085, 14026.649333766636, 14136.151830890076, 14252.358643861051, 14298.142111473346, 4680.227762419197, 4692.741899195543, 4734.4081989751285, 4770.189067858472, 4879.072976134558, 81236.0, 83524.58237708833, 84162.15837841605, 84471.57764211201, 84851.5757421209, 12180.451879665436, 12185.036826463283, 12228.144029917998, 12370.257784532956, 12513.874861251454, 20132.698009529577, 20745.688814667792, 22106.115755369607, 22167.556648866932, 22263.554728905656, 8453.112423195598, 8576.957115214384, 8632.35257355701, 8687.869681954775, 8787.91212087871, 4864.173090574611, 5100.591952643779, 5107.182850743938, 5204.167333226741, 5211.374635043819, 3906.4726261954274, 4065.8576949806616, 4068.959310406917, 4069.084455997377, 4072.898177545526, 669.7722774256679, 673.0879658063352, 785.4698078796789, 797.178905727102, 815.9428839981263, 673.639602812493, 729.4091785653637, 735.301463609573, 785.3351291396016, 801.286854699318, 10024.0, 10082.092611664839, 10236.692899213036, 10473.37159770401, 10535.789284214427, 688.3082502085472, 734.8787450070786, 753.4273951796674, 756.029707520279, 795.0975642645524, 5299.258103865462, 5376.623636345418, 5392.191171324333, 5412.675239485643, 5570.136628822539, 126024.36987815003, 126926.0, 128071.0, 128191.0, 130572.3471382637, 65770.0, 99023.0, 99762.50118749504, 100180.84266687883, 105943.47028264964, 89599.0, 90987.99999999868, 92305.0, 92554.0, 92597.53701231585, 9295.349325547417, 10237.9488102559, 10919.890801091888, 11221.382823944761, 11289.491972861406, 46670.29994550152, 48031.519684802704, 51865.22202166895, 52510.0, 54357.18464222961, 69241.30758692349, 73221.0, 74792.62603686946, 75242.62378688072, 75800.24199757932, 12277.447514861675, 12708.0, 13065.0, 13214.273214972884, 13246.735065298833, 14844.62888427798, 15481.84518154804, 16566.0, 16829.242684079, 17008.0, 14653.560393188221, 14799.630009249855, 14996.0, 15510.612234694223, 15723.685526289639, 13918.58244252674, 14475.203863787592, 15045.172515511751, 15087.396504139711, 15398.0, 14293.142411455347, 14547.490837820626, 14617.269136543344, 14680.926595366955, 14987.0, 11853.525858965544, 12142.514299427923, 12245.571405000783, 12375.195612285173, 12397.814032789696, 12412.937935310265, 12511.061670374576, 12544.560940367044, 12691.175073620185, 12935.870641293466], "value": 8125.980051670168, "unit": "score"}], "name": "dromaeo_css", "value": 7644.9151669420535, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 108.0, 108.0, 111.0, 110.0, 108.0, 109.0, 109.0, 108.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 132.0, 176.0, 123.0, 127.0, 157.0, 125.0, 160.0, 124.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 159.0, 162.0, 163.0, 161.0, 162.0, 162.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 134.0, 75.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 84.0, 84.0, 116.0, 84.0, 83.0, 136.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 52.0, 53.0, 51.0, 53.0, 51.0, 51.0, 53.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 77.0, 75.0, 76.0, 78.0, 76.0, 76.0, 132.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 124.0, 117.0, 117.0, 140.0, 125.0, 120.0, 127.0, 126.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 161.0, 158.0, 153.0, 156.0, 159.0, 152.0, 151.0, 152.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 60.0, 61.0, 62.0, 61.0, 61.0, 61.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1482.0000000000002, "alertThreshold": 2.0}]} 03:46:04 INFO - Return code: 0 03:46:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:05 ERROR - # TBPL SUCCESS # 03:46:05 INFO - Running post-action listener: _resource_record_post_action 03:46:05 INFO - ##### 03:46:05 INFO - ##### Finished run-tests step (success) 03:46:05 INFO - ##### 03:46:05 INFO - Running post-run listener: _resource_record_post_run 03:46:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 504807424; Read time: 0; Write time: 411960 03:46:05 INFO - TinderboxPrint: CPU usage
13.1% 03:46:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:46:05 INFO - TinderboxPrint: I/O write bytes / time
504,807,424 / 411,960 03:46:05 INFO - TinderboxPrint: CPU idle
8,258.9 (86.9%) 03:46:05 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 03:46:05 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252239872; Read time: 0; Write time: 279016 03:46:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 251981824; Read time: 0; Write time: 132928 03:46:05 INFO - Running post-run listener: _upload_blobber_files 03:46:05 INFO - Blob upload gear active. 03:46:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:46:05 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'] 03:46:05 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 03:46:06 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:07 INFO - (blobuploader) - INFO - Done attempting. 03:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:10 INFO - (blobuploader) - INFO - Done attempting. 03:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:11 INFO - (blobuploader) - INFO - Done attempting. 03:46:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:11 INFO - Return code: 0 03:46:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/187beaa96975aca41ca9f9cb8f9296eb76238e19a50882af633b48e0f5d4e949f8923079bcffa5f2aee9f9c90c2979e1df193c1de7e450489afba0809ac321de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b709476995cd4cb5cc77628be0ce4a5220548ce8332468fbc3fa900726f2996591237cfbf545922f71c143b835f3d779c3abf091508ddae05607203e8605809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/283baf9b47a1e43ac3b675fad1a6834be735d34ccdc8d8ab9d572fee60cf416eefd046a2ee74534302116d0e128cec4635f02e89906a4cf8f450ff33d66045f9"} 03:46:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:11 INFO - Contents: 03:46:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/187beaa96975aca41ca9f9cb8f9296eb76238e19a50882af633b48e0f5d4e949f8923079bcffa5f2aee9f9c90c2979e1df193c1de7e450489afba0809ac321de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b709476995cd4cb5cc77628be0ce4a5220548ce8332468fbc3fa900726f2996591237cfbf545922f71c143b835f3d779c3abf091508ddae05607203e8605809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/283baf9b47a1e43ac3b675fad1a6834be735d34ccdc8d8ab9d572fee60cf416eefd046a2ee74534302116d0e128cec4635f02e89906a4cf8f450ff33d66045f9"} 03:46:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:11 INFO - Copying logs to upload dir... 03:46:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.749718 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-16 03:46:10.732286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 03:46:10.735974) ========= 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=4300f881736b422476174874000001bc-1466071466.88756-247803195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/187beaa96975aca41ca9f9cb8f9296eb76238e19a50882af633b48e0f5d4e949f8923079bcffa5f2aee9f9c90c2979e1df193c1de7e450489afba0809ac321de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b709476995cd4cb5cc77628be0ce4a5220548ce8332468fbc3fa900726f2996591237cfbf545922f71c143b835f3d779c3abf091508ddae05607203e8605809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/283baf9b47a1e43ac3b675fad1a6834be735d34ccdc8d8ab9d572fee60cf416eefd046a2ee74534302116d0e128cec4635f02e89906a4cf8f450ff33d66045f9"} build_url:https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/C5jHKm6aQkmRIwHHxEzrNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/187beaa96975aca41ca9f9cb8f9296eb76238e19a50882af633b48e0f5d4e949f8923079bcffa5f2aee9f9c90c2979e1df193c1de7e450489afba0809ac321de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b709476995cd4cb5cc77628be0ce4a5220548ce8332468fbc3fa900726f2996591237cfbf545922f71c143b835f3d779c3abf091508ddae05607203e8605809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/283baf9b47a1e43ac3b675fad1a6834be735d34ccdc8d8ab9d572fee60cf416eefd046a2ee74534302116d0e128cec4635f02e89906a4cf8f450ff33d66045f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 03:46:10.762075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:46:10.762398) ========= 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=4300f881736b422476174874000001bc-1466071466.88756-247803195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:46:10.844956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 03:46:10.845265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 03:46:10.845596) ========= ========= Total master_lag: 0.18 =========