builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1469177159.61 results: success (0) buildid: 20160721230814 builduid: c16e90854a624e5c838f9fd4303a312d revision: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.613880) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.614309) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.614603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.660074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.660352) ========= 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=0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 01:45:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 23.3M=0s 2016-07-22 01:45:59 (23.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.760368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.760656) ========= 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=0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 01:45:59.809795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 01:45:59.810114) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 --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 f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 --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=0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 01:45:59,944 truncating revision to first 12 chars 2016-07-22 01:45:59,944 Setting DEBUG logging. 2016-07-22 01:45:59,944 attempt 1/10 2016-07-22 01:45:59,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f8e3b85fd772?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 01:46:01,190 unpacking tar archive at: mozilla-aurora-f8e3b85fd772/testing/mozharness/ program finished with exit code 0 elapsedTime=1.561236 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 01:46:01.386327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 01:46:01.386667) ========= script_repo_revision: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 01:46:01.387125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 01:46:01.387419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 01:46:01.398089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-22 01:46:01.398495) ========= /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=0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:46:01 INFO - MultiFileLogger online at 20160722 01:46:01 in /builds/slave/test 01:46:01 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 01:46:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:46:01 INFO - {'append_to_log': False, 01:46:01 INFO - 'base_work_dir': '/builds/slave/test', 01:46:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:46:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:46:01 INFO - 'branch': 'Mozilla-Aurora', 01:46:01 INFO - 'buildbot_json_path': 'buildprops.json', 01:46:01 INFO - 'config_files': ('talos/linux_config.py',), 01:46:01 INFO - 'default_actions': ('clobber', 01:46:01 INFO - 'read-buildbot-config', 01:46:01 INFO - 'download-and-extract', 01:46:01 INFO - 'populate-webroot', 01:46:01 INFO - 'create-virtualenv', 01:46:01 INFO - 'install', 01:46:01 INFO - 'run-tests'), 01:46:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:46:01 INFO - 'download_minidump_stackwalk': True, 01:46:01 INFO - 'download_symbols': 'ondemand', 01:46:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:46:01 INFO - 'tooltool.py': '/tools/tooltool.py', 01:46:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:46:01 INFO - '/tools/misc-python/virtualenv.py')}, 01:46:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:46:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:46:01 INFO - 'installer_path': 'installer.exe', 01:46:01 INFO - 'log_level': 'info', 01:46:01 INFO - 'log_name': 'talos', 01:46:01 INFO - 'log_to_console': True, 01:46:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:46:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:46:01 INFO - 'opt_config_files': (), 01:46:01 INFO - 'pip_index': False, 01:46:01 INFO - 'sps_profile': False, 01:46:01 INFO - 'sps_profile_interval': 0, 01:46:01 INFO - 'suite': 'dromaeojs', 01:46:01 INFO - 'system_bits': '32', 01:46:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:46:01 INFO - 'title': 'talos-linux64-ix-058', 01:46:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:46:01 INFO - 'use_talos_json': True, 01:46:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:46:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:46:01 INFO - 'work_dir': 'build'} 01:46:01 INFO - ##### 01:46:01 INFO - ##### Running clobber step. 01:46:01 INFO - ##### 01:46:01 INFO - Running pre-action listener: _resource_record_pre_action 01:46:01 INFO - Running main action method: clobber 01:46:01 INFO - rmtree: /builds/slave/test/build 01:46:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:46:02 INFO - Running post-action listener: _resource_record_post_action 01:46:02 INFO - ##### 01:46:02 INFO - ##### Finished clobber step (success) 01:46:02 INFO - ##### 01:46:02 INFO - ##### 01:46:02 INFO - ##### Running read-buildbot-config step. 01:46:02 INFO - ##### 01:46:02 INFO - Running pre-action listener: _resource_record_pre_action 01:46:02 INFO - Running main action method: read_buildbot_config 01:46:02 INFO - Using buildbot properties: 01:46:02 INFO - { 01:46:02 INFO - "project": "", 01:46:02 INFO - "product": "firefox", 01:46:02 INFO - "script_repo_revision": "production", 01:46:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:46:02 INFO - "repository": "", 01:46:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:46:02 INFO - "buildid": "20160721230814", 01:46:02 INFO - "pgo_build": "True", 01:46:02 INFO - "basedir": "/builds/slave/test", 01:46:02 INFO - "buildnumber": 621, 01:46:02 INFO - "slavename": "talos-linux64-ix-058", 01:46:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:46:02 INFO - "platform": "ubuntu64_hw", 01:46:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:46:02 INFO - "branch": "mozilla-aurora", 01:46:02 INFO - "repo_path": "releases/mozilla-aurora", 01:46:02 INFO - "revision": "f8e3b85fd772dddaf019197b359b6f82a9fb1bd3", 01:46:02 INFO - "stage_platform": "linux64-pgo", 01:46:02 INFO - "builduid": "c16e90854a624e5c838f9fd4303a312d", 01:46:02 INFO - "slavebuilddir": "test" 01:46:02 INFO - } 01:46:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 01:46:02 INFO - Running post-action listener: _resource_record_post_action 01:46:02 INFO - ##### 01:46:02 INFO - ##### Finished read-buildbot-config step (success) 01:46:02 INFO - ##### 01:46:02 INFO - ##### 01:46:02 INFO - ##### Running download-and-extract step. 01:46:02 INFO - ##### 01:46:02 INFO - Running pre-action listener: _resource_record_pre_action 01:46:02 INFO - Running main action method: download_and_extract 01:46:02 INFO - mkdir: /builds/slave/test/build/tests 01:46: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')]} 01:46:02 INFO - https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:46:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:46:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:46:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:09 INFO - Downloaded 1361 bytes. 01:46:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:46:09 INFO - Using the following test package requirements: 01:46:09 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:46:09 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:46:09 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:46:09 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'jsshell-linux-x86_64.zip'], 01:46:09 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:46:09 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:46:09 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:46:09 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:46:09 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:46:09 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:46:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:46:09 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:46: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')]} 01:46:09 INFO - https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:46:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:46:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:12 INFO - Downloaded 24489988 bytes. 01:46:12 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'] 01:46:12 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 01:46:13 INFO - Return code: 0 01:46:13 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 01:46:13 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')]} 01:46:13 INFO - https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:46:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:46:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:17 INFO - Downloaded 24489988 bytes. 01:46:17 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'] 01:46:17 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 01:46:18 INFO - Return code: 0 01:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:18 INFO - https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:19 INFO - Downloaded 10833369 bytes. 01:46:19 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'] 01:46:19 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 01:46:20 INFO - Return code: 0 01:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:20 INFO - https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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 01:46:21 INFO - Downloaded 63638894 bytes. 01:46:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:46:21 INFO - mkdir: /builds/slave/test/properties 01:46:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:46:21 INFO - Writing to file /builds/slave/test/properties/build_url 01:46:21 INFO - Contents: 01:46:21 INFO - build_url:https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:46:22 INFO - Running post-action listener: _resource_record_post_action 01:46:22 INFO - Running post-action listener: set_extra_try_arguments 01:46:22 INFO - ##### 01:46:22 INFO - ##### Finished download-and-extract step (success) 01:46:22 INFO - ##### 01:46:22 INFO - ##### 01:46:22 INFO - ##### Running populate-webroot step. 01:46:22 INFO - ##### 01:46:22 INFO - Running pre-action listener: _resource_record_pre_action 01:46:22 INFO - Running main action method: populate_webroot 01:46:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:22 INFO - '--tppagecycles', 01:46:22 INFO - '7'], 01:46:22 INFO - 'tests': ['tsvgm']}}, 01:46:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:46:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:46:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:46:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['damp', 'tps']}, 01:46:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'tests': ['damp', 'tps']}, 01:46:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['dromaeo_dom']}, 01:46:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['a11yr', 01:46:22 INFO - 'ts_paint', 01:46:22 INFO - 'tpaint', 01:46:22 INFO - 'sessionrestore', 01:46:22 INFO - 'sessionrestore_no_auto_restore', 01:46:22 INFO - 'tabpaint']}, 01:46:22 INFO - 'other-e10s': {'tests': ['a11yr', 01:46:22 INFO - 'ts_paint', 01:46:22 INFO - 'tpaint', 01:46:22 INFO - 'sessionrestore', 01:46:22 INFO - 'sessionrestore_no_auto_restore', 01:46:22 INFO - 'tabpaint']}, 01:46:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:46:22 INFO - 'ts_paint', 01:46:22 INFO - 'tpaint', 01:46:22 INFO - 'sessionrestore', 01:46:22 INFO - 'sessionrestore_no_auto_restore', 01:46:22 INFO - 'tabpaint']}, 01:46:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:46:22 INFO - 'ts_paint', 01:46:22 INFO - 'tpaint', 01:46:22 INFO - 'sessionrestore', 01:46:22 INFO - 'sessionrestore_no_auto_restore', 01:46:22 INFO - 'tabpaint']}, 01:46:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['a11yr', 01:46:22 INFO - 'ts_paint', 01:46:22 INFO - 'tpaint', 01:46:22 INFO - 'sessionrestore', 01:46:22 INFO - 'sessionrestore_no_auto_restore', 01:46:22 INFO - 'tabpaint']}, 01:46:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['a11yr', 01:46:22 INFO - 'ts_paint', 01:46:22 INFO - 'tpaint', 01:46:22 INFO - 'sessionrestore', 01:46:22 INFO - 'sessionrestore_no_auto_restore', 01:46:22 INFO - 'tabpaint']}, 01:46:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['tsvgx', 01:46:22 INFO - 'tsvgr_opacity', 01:46:22 INFO - 'tart', 01:46:22 INFO - 'tscrollx', 01:46:22 INFO - 'cart']}, 01:46:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:46:22 INFO - 'tsvgr_opacity', 01:46:22 INFO - 'tart', 01:46:22 INFO - 'tscrollx', 01:46:22 INFO - 'cart']}, 01:46:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'talos_options': ['--disable-e10s'], 01:46:22 INFO - 'tests': ['tp5o']}, 01:46:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'tests': ['tp5o']}, 01:46:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'talos_options': ['--disable-e10s', 01:46:22 INFO - '--xperf_path', 01:46:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:22 INFO - 'tests': ['tp5n']}, 01:46:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:22 INFO - 'talos_options': ['--xperf_path', 01:46:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:22 INFO - 'tests': ['tp5n']}}, 01:46:22 INFO - 'talos.zip': {'path': '', 01:46:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:22 INFO - Running post-action listener: _resource_record_post_action 01:46:22 INFO - ##### 01:46:22 INFO - ##### Finished populate-webroot step (success) 01:46:22 INFO - ##### 01:46:22 INFO - ##### 01:46:22 INFO - ##### Running create-virtualenv step. 01:46:22 INFO - ##### 01:46:22 INFO - Running pre-action listener: _resource_record_pre_action 01:46:22 INFO - Running main action method: create_virtualenv 01:46:22 INFO - Creating virtualenv /builds/slave/test/build/venv 01:46:22 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 01:46:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:46:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:22 INFO - Using real prefix '/usr' 01:46:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:46:22 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:24 INFO - Installing pip.................done. 01:46:24 INFO - Return code: 0 01:46:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:46:24 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')]} 01:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:24 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')]} 01:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:24 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:24 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 01:46:24 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 01:46:24 INFO - Using env: {'DISPLAY': ':0', 01:46:24 INFO - 'HOME': '/home/cltbld', 01:46:24 INFO - 'LANG': 'en_US.UTF-8', 01:46:24 INFO - 'LANGUAGE': 'en_US:en', 01:46:24 INFO - 'LOGNAME': 'cltbld', 01:46:24 INFO - 'MAIL': '/var/mail/cltbld', 01:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:24 INFO - 'MOZ_NO_REMOTE': '1', 01:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:24 INFO - 'NO_EM_RESTART': '1', 01:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:24 INFO - 'PWD': '/builds/slave/test', 01:46:24 INFO - 'SHELL': '/bin/bash', 01:46:24 INFO - 'SHLVL': '1', 01:46:24 INFO - 'TERM': 'linux', 01:46:24 INFO - 'TMOUT': '86400', 01:46:24 INFO - 'USER': 'cltbld', 01:46:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:24 INFO - '_': '/tools/buildbot/bin/python'} 01:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:24 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 01:46:24 INFO - Cleaning up... 01:46:24 INFO - Return code: 0 01:46:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:46:24 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')]} 01:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:24 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')]} 01:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:24 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:24 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 01:46:24 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 01:46:24 INFO - Using env: {'DISPLAY': ':0', 01:46:24 INFO - 'HOME': '/home/cltbld', 01:46:24 INFO - 'LANG': 'en_US.UTF-8', 01:46:24 INFO - 'LANGUAGE': 'en_US:en', 01:46:24 INFO - 'LOGNAME': 'cltbld', 01:46:24 INFO - 'MAIL': '/var/mail/cltbld', 01:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:24 INFO - 'MOZ_NO_REMOTE': '1', 01:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:24 INFO - 'NO_EM_RESTART': '1', 01:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:24 INFO - 'PWD': '/builds/slave/test', 01:46:24 INFO - 'SHELL': '/bin/bash', 01:46:24 INFO - 'SHLVL': '1', 01:46:24 INFO - 'TERM': 'linux', 01:46:24 INFO - 'TMOUT': '86400', 01:46:24 INFO - 'USER': 'cltbld', 01:46:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:24 INFO - '_': '/tools/buildbot/bin/python'} 01:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:25 INFO - Downloading/unpacking psutil>=3.1.1 01:46:25 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 01:46:25 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 01:46:25 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 01:46:25 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 01:46:25 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 01:46:25 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 01:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:27 INFO - Installing collected packages: psutil 01:46:27 INFO - Running setup.py install for psutil 01:46:27 INFO - building 'psutil._psutil_linux' extension 01:46:27 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 01:46:27 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 01:46:27 INFO - building 'psutil._psutil_posix' extension 01:46:27 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 01:46:27 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 01:46:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:27 INFO - Successfully installed psutil 01:46:27 INFO - Cleaning up... 01:46:27 INFO - Return code: 0 01:46:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:46:27 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')]} 01:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:27 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')]} 01:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:27 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:27 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 01:46:27 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 01:46:27 INFO - Using env: {'DISPLAY': ':0', 01:46:27 INFO - 'HOME': '/home/cltbld', 01:46:27 INFO - 'LANG': 'en_US.UTF-8', 01:46:27 INFO - 'LANGUAGE': 'en_US:en', 01:46:27 INFO - 'LOGNAME': 'cltbld', 01:46:27 INFO - 'MAIL': '/var/mail/cltbld', 01:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:27 INFO - 'MOZ_NO_REMOTE': '1', 01:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:27 INFO - 'NO_EM_RESTART': '1', 01:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:27 INFO - 'PWD': '/builds/slave/test', 01:46:27 INFO - 'SHELL': '/bin/bash', 01:46:27 INFO - 'SHLVL': '1', 01:46:27 INFO - 'TERM': 'linux', 01:46:27 INFO - 'TMOUT': '86400', 01:46:27 INFO - 'USER': 'cltbld', 01:46:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:27 INFO - '_': '/tools/buildbot/bin/python'} 01:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:46:27 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 01:46:27 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 01:46:27 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 01:46:27 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 01:46:27 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 01:46:27 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 01:46:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:46:29 INFO - Installing collected packages: mozsystemmonitor 01:46:29 INFO - Running setup.py install for mozsystemmonitor 01:46:29 INFO - Successfully installed mozsystemmonitor 01:46:29 INFO - Cleaning up... 01:46:30 INFO - Return code: 0 01:46:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:30 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:30 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 01:46:30 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 01:46:30 INFO - Using env: {'DISPLAY': ':0', 01:46:30 INFO - 'HOME': '/home/cltbld', 01:46:30 INFO - 'LANG': 'en_US.UTF-8', 01:46:30 INFO - 'LANGUAGE': 'en_US:en', 01:46:30 INFO - 'LOGNAME': 'cltbld', 01:46:30 INFO - 'MAIL': '/var/mail/cltbld', 01:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:30 INFO - 'MOZ_NO_REMOTE': '1', 01:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:30 INFO - 'NO_EM_RESTART': '1', 01:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:30 INFO - 'PWD': '/builds/slave/test', 01:46:30 INFO - 'SHELL': '/bin/bash', 01:46:30 INFO - 'SHLVL': '1', 01:46:30 INFO - 'TERM': 'linux', 01:46:30 INFO - 'TMOUT': '86400', 01:46:30 INFO - 'USER': 'cltbld', 01:46:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:30 INFO - '_': '/tools/buildbot/bin/python'} 01:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:30 INFO - Downloading/unpacking jsonschema==2.5.1 01:46:30 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 01:46:30 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 01:46:30 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 01:46:30 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 01:46:30 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 01:46:30 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 01:46:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:46:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:32 INFO - Downloading functools32-3.2.3-2.tar.gz 01:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:46:32 INFO - warning: no files found matching '*.txt' 01:46:32 INFO - no previously-included directories found matching 'build' 01:46:32 INFO - no previously-included directories found matching 'dist' 01:46:32 INFO - no previously-included directories found matching '.git*' 01:46:32 INFO - Installing collected packages: jsonschema, functools32 01:46:32 INFO - Running setup.py install for functools32 01:46:32 INFO - warning: no files found matching '*.txt' 01:46:32 INFO - no previously-included directories found matching 'build' 01:46:32 INFO - no previously-included directories found matching 'dist' 01:46:32 INFO - no previously-included directories found matching '.git*' 01:46:32 INFO - Successfully installed jsonschema functools32 01:46:32 INFO - Cleaning up... 01:46:32 INFO - Return code: 0 01:46:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:46:32 INFO - Using env: {'DISPLAY': ':0', 01:46:32 INFO - 'HOME': '/home/cltbld', 01:46:32 INFO - 'LANG': 'en_US.UTF-8', 01:46:32 INFO - 'LANGUAGE': 'en_US:en', 01:46:32 INFO - 'LOGNAME': 'cltbld', 01:46:32 INFO - 'MAIL': '/var/mail/cltbld', 01:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:32 INFO - 'MOZ_NO_REMOTE': '1', 01:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:32 INFO - 'NO_EM_RESTART': '1', 01:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:32 INFO - 'PWD': '/builds/slave/test', 01:46:32 INFO - 'SHELL': '/bin/bash', 01:46:32 INFO - 'SHLVL': '1', 01:46:32 INFO - 'TERM': 'linux', 01:46:32 INFO - 'TMOUT': '86400', 01:46:32 INFO - 'USER': 'cltbld', 01:46:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:32 INFO - '_': '/tools/buildbot/bin/python'} 01:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:32 INFO - Downloading/unpacking blobuploader==1.2.4 01:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:34 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46:34 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 01:46:34 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 01:46:34 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 01:46:34 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 01:46:34 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 01:46:34 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 01:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:46:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:35 INFO - Downloading docopt-0.6.1.tar.gz 01:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:46:35 INFO - Installing collected packages: blobuploader, requests, docopt 01:46:35 INFO - Running setup.py install for blobuploader 01:46:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:46:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:46:35 INFO - Running setup.py install for requests 01:46:35 INFO - Running setup.py install for docopt 01:46:36 INFO - Successfully installed blobuploader requests docopt 01:46:36 INFO - Cleaning up... 01:46:36 INFO - Return code: 0 01:46:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46: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')]} 01:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:36 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:36 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 01:46:36 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 01:46:36 INFO - Using env: {'DISPLAY': ':0', 01:46:36 INFO - 'HOME': '/home/cltbld', 01:46:36 INFO - 'LANG': 'en_US.UTF-8', 01:46:36 INFO - 'LANGUAGE': 'en_US:en', 01:46:36 INFO - 'LOGNAME': 'cltbld', 01:46:36 INFO - 'MAIL': '/var/mail/cltbld', 01:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:36 INFO - 'MOZ_NO_REMOTE': '1', 01:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:36 INFO - 'NO_EM_RESTART': '1', 01:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:36 INFO - 'PWD': '/builds/slave/test', 01:46:36 INFO - 'SHELL': '/bin/bash', 01:46:36 INFO - 'SHLVL': '1', 01:46:36 INFO - 'TERM': 'linux', 01:46:36 INFO - 'TMOUT': '86400', 01:46:36 INFO - 'USER': 'cltbld', 01:46:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:36 INFO - '_': '/tools/buildbot/bin/python'} 01:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:36 INFO - Running setup.py (path:/tmp/pip-IzSfZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:36 INFO - Running setup.py (path:/tmp/pip-HAknRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:46:36 INFO - Running setup.py (path:/tmp/pip-tBzhSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:46:36 INFO - Running setup.py (path:/tmp/pip-C73jaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:46:36 INFO - Running setup.py (path:/tmp/pip-EzbZZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:46:36 INFO - Running setup.py (path:/tmp/pip-maXQMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:46:36 INFO - Running setup.py (path:/tmp/pip-sHui5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:46:36 INFO - Running setup.py (path:/tmp/pip-jxn1St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:46:36 INFO - Running setup.py (path:/tmp/pip-vWRtIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:46:37 INFO - Running setup.py (path:/tmp/pip-f0evY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:46:37 INFO - Running setup.py (path:/tmp/pip-5pQVa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:46:37 INFO - Running setup.py (path:/tmp/pip-KXkJGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:46:37 INFO - Running setup.py (path:/tmp/pip-4kvcV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:46:37 INFO - Running setup.py (path:/tmp/pip-cStxsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:37 INFO - Running setup.py (path:/tmp/pip-QY6Irc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:46:37 INFO - Running setup.py (path:/tmp/pip-dhFZDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:46:37 INFO - Running setup.py (path:/tmp/pip-y7XGKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:46:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:46:37 INFO - Running setup.py install for manifestparser 01:46:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:46:37 INFO - Running setup.py install for mozcrash 01:46:37 INFO - Running setup.py install for mozdebug 01:46:37 INFO - Running setup.py install for mozdevice 01:46:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:46:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Running setup.py install for mozfile 01:46:38 INFO - Running setup.py install for mozhttpd 01:46:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Running setup.py install for mozinfo 01:46:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Running setup.py install for mozInstall 01:46:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Running setup.py install for mozleak 01:46:38 INFO - Running setup.py install for mozlog 01:46:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Running setup.py install for moznetwork 01:46:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Running setup.py install for mozprocess 01:46:38 INFO - Running setup.py install for mozprofile 01:46:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:46:38 INFO - Running setup.py install for mozrunner 01:46:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:46:39 INFO - Running setup.py install for mozscreenshot 01:46:39 INFO - Running setup.py install for moztest 01:46:39 INFO - Running setup.py install for mozversion 01:46:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:46:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:46:39 INFO - Cleaning up... 01:46:39 INFO - Return code: 0 01:46:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:39 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:39 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 01:46:39 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 01:46:39 INFO - Using env: {'DISPLAY': ':0', 01:46:39 INFO - 'HOME': '/home/cltbld', 01:46:39 INFO - 'LANG': 'en_US.UTF-8', 01:46:39 INFO - 'LANGUAGE': 'en_US:en', 01:46:39 INFO - 'LOGNAME': 'cltbld', 01:46:39 INFO - 'MAIL': '/var/mail/cltbld', 01:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:39 INFO - 'MOZ_NO_REMOTE': '1', 01:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:39 INFO - 'NO_EM_RESTART': '1', 01:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:39 INFO - 'PWD': '/builds/slave/test', 01:46:39 INFO - 'SHELL': '/bin/bash', 01:46:39 INFO - 'SHLVL': '1', 01:46:39 INFO - 'TERM': 'linux', 01:46:39 INFO - 'TMOUT': '86400', 01:46:39 INFO - 'USER': 'cltbld', 01:46:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:39 INFO - '_': '/tools/buildbot/bin/python'} 01:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:39 INFO - Running setup.py (path:/tmp/pip-3amJL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:39 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)) 01:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:39 INFO - Running setup.py (path:/tmp/pip-tqVExb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:46:39 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)) 01:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:46:39 INFO - Running setup.py (path:/tmp/pip-60oOQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:46:39 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)) 01:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:46:39 INFO - Running setup.py (path:/tmp/pip-ibbPE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:46:39 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)) 01:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:46:39 INFO - Running setup.py (path:/tmp/pip-PfJLPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:46:39 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)) 01:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:46:39 INFO - Running setup.py (path:/tmp/pip-Oue0Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:46:40 INFO - Running setup.py (path:/tmp/pip-5GPxMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:46:40 INFO - Running setup.py (path:/tmp/pip-OCanfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:46:40 INFO - Running setup.py (path:/tmp/pip-xhJQGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:46:40 INFO - Running setup.py (path:/tmp/pip-EZaCmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:46:40 INFO - Running setup.py (path:/tmp/pip-ZbHDpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:46:40 INFO - Running setup.py (path:/tmp/pip-OWoI3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:46:40 INFO - Running setup.py (path:/tmp/pip-YP8AUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:46:40 INFO - Running setup.py (path:/tmp/pip-VyOUy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:40 INFO - Running setup.py (path:/tmp/pip-FFFoF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:46:40 INFO - Running setup.py (path:/tmp/pip-X2A4Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:46:40 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)) 01:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:46:40 INFO - Running setup.py (path:/tmp/pip-hIJwui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:46:40 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)) 01:46:40 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)) 01:46:40 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)) 01:46:40 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)) 01:46:40 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)) 01:46:40 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)) 01:46:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:55 INFO - Downloading blessings-1.6.tar.gz 01:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:46:55 INFO - Installing collected packages: blessings 01:46:55 INFO - Running setup.py install for blessings 01:46:55 INFO - Successfully installed blessings 01:46:55 INFO - Cleaning up... 01:46:55 INFO - Return code: 0 01:46:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:46:55 INFO - Reading from file tmpfile_stdout 01:46:55 INFO - Current package versions: 01:46:55 INFO - argparse == 1.2.1 01:46:55 INFO - blessings == 1.6 01:46:55 INFO - blobuploader == 1.2.4 01:46:55 INFO - docopt == 0.6.1 01:46:55 INFO - functools32 == 3.2.3-2 01:46:55 INFO - jsonschema == 2.5.1 01:46:55 INFO - manifestparser == 1.1 01:46:55 INFO - mozInstall == 1.12 01:46:55 INFO - mozcrash == 0.17 01:46:55 INFO - mozdebug == 0.1 01:46:55 INFO - mozdevice == 0.48 01:46:55 INFO - mozfile == 1.2 01:46:55 INFO - mozhttpd == 0.7 01:46:55 INFO - mozinfo == 0.9 01:46:55 INFO - mozleak == 0.1 01:46:55 INFO - mozlog == 3.2 01:46:55 INFO - moznetwork == 0.27 01:46:55 INFO - mozprocess == 0.23 01:46:55 INFO - mozprofile == 0.28 01:46:55 INFO - mozrunner == 6.12 01:46:55 INFO - mozscreenshot == 0.1 01:46:55 INFO - mozsystemmonitor == 0.3 01:46:55 INFO - moztest == 0.7 01:46:55 INFO - mozversion == 1.4 01:46:55 INFO - psutil == 3.1.1 01:46:55 INFO - requests == 1.2.3 01:46:55 INFO - wsgiref == 0.1.2 01:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:55 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')]} 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 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')]} 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:55 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 01:46:55 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 01:46:55 INFO - Using env: {'DISPLAY': ':0', 01:46:55 INFO - 'HOME': '/home/cltbld', 01:46:55 INFO - 'LANG': 'en_US.UTF-8', 01:46:55 INFO - 'LANGUAGE': 'en_US:en', 01:46:55 INFO - 'LOGNAME': 'cltbld', 01:46:55 INFO - 'MAIL': '/var/mail/cltbld', 01:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:55 INFO - 'MOZ_NO_REMOTE': '1', 01:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:55 INFO - 'NO_EM_RESTART': '1', 01:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:55 INFO - 'PWD': '/builds/slave/test', 01:46:55 INFO - 'SHELL': '/bin/bash', 01:46:55 INFO - 'SHLVL': '1', 01:46:55 INFO - 'TERM': 'linux', 01:46:55 INFO - 'TMOUT': '86400', 01:46:55 INFO - 'USER': 'cltbld', 01:46:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:55 INFO - '_': '/tools/buildbot/bin/python'} 01:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 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)) 01:46:55 INFO - Cleaning up... 01:46:55 INFO - Return code: 0 01:46:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:46:55 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')]} 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 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')]} 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 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 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46:55 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 01:46:55 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 01:46:55 INFO - Using env: {'DISPLAY': ':0', 01:46:55 INFO - 'HOME': '/home/cltbld', 01:46:55 INFO - 'LANG': 'en_US.UTF-8', 01:46:55 INFO - 'LANGUAGE': 'en_US:en', 01:46:55 INFO - 'LOGNAME': 'cltbld', 01:46:55 INFO - 'MAIL': '/var/mail/cltbld', 01:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:55 INFO - 'MOZ_NO_REMOTE': '1', 01:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:55 INFO - 'NO_EM_RESTART': '1', 01:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:55 INFO - 'PWD': '/builds/slave/test', 01:46:55 INFO - 'SHELL': '/bin/bash', 01:46:55 INFO - 'SHLVL': '1', 01:46:55 INFO - 'TERM': 'linux', 01:46:55 INFO - 'TMOUT': '86400', 01:46:55 INFO - 'USER': 'cltbld', 01:46:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:55 INFO - '_': '/tools/buildbot/bin/python'} 01:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:46:55 INFO - Cleaning up... 01:46:56 INFO - Return code: 0 01:46:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:46: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')]} 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4b57e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, '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': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', '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 01:46: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', 'flake8'] in /builds/slave/test/build 01:46: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 flake8 01:46:56 INFO - Using env: {'DISPLAY': ':0', 01:46:56 INFO - 'HOME': '/home/cltbld', 01:46:56 INFO - 'LANG': 'en_US.UTF-8', 01:46:56 INFO - 'LANGUAGE': 'en_US:en', 01:46:56 INFO - 'LOGNAME': 'cltbld', 01:46:56 INFO - 'MAIL': '/var/mail/cltbld', 01:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:56 INFO - 'MOZ_NO_REMOTE': '1', 01:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:56 INFO - 'NO_EM_RESTART': '1', 01:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:56 INFO - 'PWD': '/builds/slave/test', 01:46:56 INFO - 'SHELL': '/bin/bash', 01:46:56 INFO - 'SHLVL': '1', 01:46:56 INFO - 'TERM': 'linux', 01:46:56 INFO - 'TMOUT': '86400', 01:46:56 INFO - 'USER': 'cltbld', 01:46:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:56 INFO - '_': '/tools/buildbot/bin/python'} 01:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:56 INFO - Downloading/unpacking flake8 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:46:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:46:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:46:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:58 INFO - no previously-included directories found matching 'docs/_build' 01:46:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:46:58 INFO - Running setup.py install for pep8 01:46:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:58 INFO - no previously-included directories found matching 'docs/_build' 01:46:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:46:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:46:59 INFO - Cleaning up... 01:46:59 INFO - Return code: 0 01:46:59 INFO - Running post-action listener: _resource_record_post_action 01:46:59 INFO - Running post-action listener: _start_resource_monitoring 01:46:59 INFO - Starting resource monitoring. 01:46:59 INFO - ##### 01:46:59 INFO - ##### Finished create-virtualenv step (success) 01:46:59 INFO - ##### 01:46:59 INFO - ##### 01:46:59 INFO - ##### Running install step. 01:46:59 INFO - ##### 01:46:59 INFO - Running pre-action listener: _resource_record_pre_action 01:46:59 INFO - Running main action method: install 01:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:46:59 INFO - Reading from file tmpfile_stdout 01:46:59 INFO - Detecting whether we're running mozinstall >=1.0... 01:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:46:59 INFO - Reading from file tmpfile_stdout 01:46:59 INFO - Output received: 01:46:59 INFO - Usage: mozinstall [options] installer 01:46:59 INFO - Options: 01:46:59 INFO - -h, --help show this help message and exit 01:46:59 INFO - -d DEST, --destination=DEST 01:46:59 INFO - Directory to install application into. [default: 01:46:59 INFO - "/builds/slave/test"] 01:46:59 INFO - --app=APP Application being installed. [default: firefox] 01:46:59 INFO - mkdir: /builds/slave/test/build/application 01:46:59 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'] 01:46:59 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 01:47:15 INFO - Reading from file tmpfile_stdout 01:47:15 INFO - Output received: 01:47:15 INFO - /builds/slave/test/build/application/firefox/firefox 01:47:15 INFO - Running post-action listener: _resource_record_post_action 01:47:15 INFO - ##### 01:47:15 INFO - ##### Finished install step (success) 01:47:15 INFO - ##### 01:47:15 INFO - ##### 01:47:15 INFO - ##### Running run-tests step. 01:47:15 INFO - ##### 01:47:15 INFO - Running pre-action listener: _resource_record_pre_action 01:47:15 INFO - Running main action method: run_tests 01:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:47:15 INFO - Python 2.7.3 01:47:15 INFO - Return code: 0 01:47:15 INFO - grabbing minidump binary from tooltool 01:47:15 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')]} 01:47:15 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 0x15772e0>, '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 0x14e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e35d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:47:15 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 01:47:15 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 01:47:15 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 01:47:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:47:15 INFO - Return code: 0 01:47:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:47:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:47:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:47:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:47:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:47:16 INFO - Return code: 0 01:47:16 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/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 01:47:16 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/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 01:47:16 INFO - Using env: {'DISPLAY': ':0', 01:47:16 INFO - 'HOME': '/home/cltbld', 01:47:16 INFO - 'LANG': 'en_US.UTF-8', 01:47:16 INFO - 'LANGUAGE': 'en_US:en', 01:47:16 INFO - 'LOGNAME': 'cltbld', 01:47:16 INFO - 'MAIL': '/var/mail/cltbld', 01:47:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:47:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:16 INFO - 'MOZ_NO_REMOTE': '1', 01:47:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:16 INFO - 'NO_EM_RESTART': '1', 01:47:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:16 INFO - 'PWD': '/builds/slave/test', 01:47:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:47:16 INFO - 'SHELL': '/bin/bash', 01:47:16 INFO - 'SHLVL': '1', 01:47:16 INFO - 'TERM': 'linux', 01:47:16 INFO - 'TMOUT': '86400', 01:47:16 INFO - 'USER': 'cltbld', 01:47:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637', 01:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:16 INFO - '_': '/tools/buildbot/bin/python'} 01:47:16 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/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 01:47:16 INFO - mozversion application_buildid: 20160721230814 01:47:16 INFO - mozversion application_changeset: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 01:47:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:47:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:47:16 INFO - mozversion application_name: Firefox 01:47:16 INFO - mozversion application_remotingname: firefox-dev 01:47:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:47:16 INFO - mozversion application_vendor: Mozilla 01:47:16 INFO - mozversion application_version: 49.0a2 01:47:16 INFO - mozversion platform_buildid: 20160721230814 01:47:16 INFO - mozversion platform_changeset: f8e3b85fd772dddaf019197b359b6f82a9fb1bd3 01:47:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:47:16 INFO - mozversion platform_version: 49.0a2 01:47:16 INFO - using testdate: 1469177236 01:47:16 INFO - actual date: 1469177236 01:47:16 INFO - starting webserver on 'localhost:60142' 01:47:16 INFO - SUITE-START | Running 2 tests 01:47:16 INFO - TEST-START | dromaeo_css 01:47:16 INFO - operating with platform_type : linux_ 01:47:16 INFO - Initialising browser for dromaeo_css test... 01:47:16 INFO - TEST-INFO | started process 14119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLQKTs/profile http://localhost:60142/getInfo.html) 01:47:20 INFO - PROCESS | 14119 | __metrics Screen width/height:1600/1200 01:47:20 INFO - PROCESS | 14119 | colorDepth:24 01:47:20 INFO - PROCESS | 14119 | Browser inner width/height: 1024/697 01:47:20 INFO - PROCESS | 14119 | __metrics 01:47:21 INFO - PROCESS | 14119 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:47:21 ERROR - PROCESS | 14119 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:47:22 INFO - TEST-INFO | 14119: exit 0 01:47:22 INFO - Browser initialized. 01:47:22 INFO - Running cycle 1/1 for dromaeo_css test... 01:47:22 INFO - TEST-INFO | started process 14217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLQKTs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:34 INFO - PROCESS | 14217 | RSS: Main: 145285120 01:47:34 INFO - PROCESS | 14217 | 01:48:24 INFO - PROCESS | 14217 | 1469177304799 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] 01:50:33 INFO - PROCESS | 14217 | Cycle 1(1): loaded http://localhost:60142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60142/tests/dromaeo/cssquery-ext.html) 01:50:34 INFO - PROCESS | 14217 | RSS: Main: 256188416 01:50:34 INFO - PROCESS | 14217 | 01:53:36 INFO - PROCESS | 14217 | Cycle 1(1): loaded http://localhost:60142/tests/dromaeo/cssquery-ext.html (next: http://localhost:60142/tests/dromaeo/cssquery-jquery.html) 01:53:37 INFO - PROCESS | 14217 | RSS: Main: 226181120 01:53:37 INFO - PROCESS | 14217 | 01:56:38 INFO - PROCESS | 14217 | Cycle 1(1): loaded http://localhost:60142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60142/tests/dromaeo/cssquery-mootools.html) 01:56:39 INFO - PROCESS | 14217 | RSS: Main: 221216768 01:56:39 INFO - PROCESS | 14217 | 01:59:41 INFO - PROCESS | 14217 | Cycle 1(1): loaded http://localhost:60142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60142/tests/dromaeo/cssquery-prototype.html) 01:59:42 INFO - PROCESS | 14217 | RSS: Main: 222736384 01:59:42 INFO - PROCESS | 14217 | 02:02:44 INFO - PROCESS | 14217 | Cycle 1(1): loaded http://localhost:60142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60142/tests/dromaeo/cssquery-yui.html) 02:02:45 INFO - PROCESS | 14217 | RSS: Main: 212549632 02:02:45 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | Cycle 1(1): loaded http://localhost:60142/tests/dromaeo/cssquery-yui.html (next: http://localhost:60142/tests/dromaeo/cssquery-dojo.html) 02:05:47 INFO - PROCESS | 14217 | RSS: Main: 259461120 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | __start_tp_report 02:05:47 INFO - PROCESS | 14217 | _x_x_mozilla_page_load 02:05:47 INFO - PROCESS | 14217 | _x_x_mozilla_page_load_details 02:05:47 INFO - PROCESS | 14217 | |i|pagename|runs| 02:05:47 INFO - PROCESS | 14217 | |0;dojo.html;3365.0241429985304;3385.2552438463545;3401.31973605279;3420.6066302375234;3437.6390478999706;5519.227308176858;5588.9939810834085;5601.635893666914;5602.831915042555;5627.409122042188;5527.778888844451;5535.086710692731;5562.9443705562935;5577.721113944307;5592.105263157896;4842.249451335031;4945.752712364385;5042.067217564744;5055.3933527976515;5101.20931255656;4912.410510738717;4927.1377508935975;4936.5063493650705;5006.148954677714;5103.055934652101;5066.645334826564;5082.466341034194;5100.285959965608;5141.203113517392;5159.509846564571;5083.034223497523;5156.741609449874;5157.922631160535;5158.097332966753;5190.584753219752;4889.731064791435;4891;4925.162722337175;4934.876628084291;5063.0380227756605;5406.864828379322;5450.645708028966;5454.945450545483;5472.179173124024;5498.752556134944;5864.091065884794;5870.882582348372;5922.881542369171;5923.992921203406;5925.822225333247;5862.736176872051;5889.146073819272;5930.1401296812155;5952.494038006775;6016.699165041774;5587.189857470726;5616.213730077792;5616.241807355996;5622.353429355677;5626.549876009909;5823.417658234142;6071.172391806838;6071.387524422961;6072.3088744523275;6083.391660833881;5681.914771278434;5688.345840228344;5707.885842283131;5781.682007489629;5781.739821708034;5798.304203495608;5798.391168927202;5823.70881455934;5840.3575606683235;5855.94144058554;5706.4864162225595;5780.1907732917425;5790.305163380422;5792;5844.386339434383;5829.5044921181325;5850.2102216200265;5877.52979761618;5926.140709597084;5959.970200148971;4578.587927086578;4597.241455159928;4613.008203236253;4618.399608050999;4638.79125439356;4044.69664775143;4045.0494133878515;4081.4490043844294;4119.876403707894;4162.1259535497275;5702.686352250583;5719.7712091516705;5726.169705392695;5739.110437882135;5746.109353050284;5900.970495147582;5953.761849526057;5964.194833697396;5966.940330596725;5990.9700451497465;5611.6352437091455;5614.9438505615235;5643.661380317194;5649.943500565024;5706.486416222477;5115.5396014358885;5118.641695081308;5118.923216151761;5122.897542049138;5123.410807757081;6233.096201050822;6243.843903902439;6244.562880598314;6249.625022498664;6251.12484252205;5802.187693722883;5837.620554663933;5872.207252020922;5899.882002360015;5978.163057172086;6228.875422491616;6261.874762504815;6263.3736626337;6264.561480696308;6277.12120303167;5692.459216374438;5829.970850145892;5834.124881267844;5836.533077353886;5869.325027621878;5939.851503712442;5960.910586341295;5981.342052374148;6044.123602077762;6046.90929636047;5873.236479257669;5882.264716910387;5896.17453556511;5904;5905.173275741486;5661.547076233809;5774.1916131740745;5856.355800861987;5898.616589921641;5901.852453688521;5714.342850572238;5778.219940308005;5794.594378393472;5797.739101740516;5828.70856457167;5884.0585506318785;5890.057590785454;5940.46535811779;5940.673262970406;5943.52451803846;5605.663660180402;5616.129499927518;5620.494155526022;5788.363280039276;5815.156802263733 02:05:47 INFO - PROCESS | 14217 | |1;ext.html;603.1224568253192;633.6799916042398;643.9710213040415;653.6862306093072;654.931232220617;33054.17364565884;45380.773096134515;46474.76762616186;46732.29901551479;46771.76614116933;49822;50332;50405.24392134121;50418.24372634413;50448;8365.58172091396;9209.447433153999;9359.719208423725;9364.204042656382;10890.292131011498;10599.258051936367;11051.115910727123;11052.944735276313;11058.447077646126;11061.723456913602;11135.832962505569;11186.161037922147;11194.720131996724;11201.271917325348;11206.271592346513;8545.871811922827;8738.73783786481;10711.143108551298;11046.558137674483;11080.279781814157;11041.447927603667;11124.666260012213;11127.165462590257;11139.888601114048;11158.051565616932;45312;45530.77234613839;45603.31595026044;45664.3150352745;45699.31451028237;3869.5743468218475;3905.7070719696135;3914.275858966072;3928.3125453045604;3941.7437866538585;34833.303333933436;35857;35868.820655896816;35895;36009;4608.700434471749;4669.117464170776;4673.135469938073;4717.348538560647;4727.580878321141;388100;390455;390737;391254;394151;63271.36728632747;63406.36593634097;63696.68151659212;63705;63874.680626597496;39030.68239199643;40033.59966400357;40035.79982100129;41990.790046050184;42008.369874451906;17353.479395618153;17375.131243437776;17410.651786964445;17412.21645025977;17412.91293543524;12854.228746275254;13104.80342794859;13165;13173.868261317455;13468.595942121752;21079.68380474294;21353.25263615766;21388.35834924955;21470.570588588453;21477;7264.600446975467;7460.993899910624;7493.475456717977;7631.503952243086;7694.307512323918;1078.1859695929522;1116.7989761842784;1148.8449059377044;1164.6738913104343;1167.6963989362828;33334.49998250028;33986.58227342649;34031.489527657104;34250;34260.82869585686;1133.7619099989095;1156.4384887474284;1178.031360970367;1186.0585747346456;1254.6612414648177;17933.820661793477;17940.461786146436;17977.1011449427;18062;18124.728129078074;630066;632961;634975;635717;636460;64674.676626617504;64811.351886481476;64935.35064649293;64946;65174.34825651683;1467.3690313165441;1491.9030263032869;1503.19579025221;1507.4196434372845;1510.33545240094;34133.65866341404;35151.82424087863;35269.29461410809;35411;35474.645253548166;54401.727991361375;54675.72662136664;55191;55244.44755552393;55268.170977434565;494824;500752;501044;501541;501926;26315.868420657775;29610.555841662823;30239.848800755855;30475.695243047285;31103.222419439695;51330.48669513257;51448.48551514587;51668;51935.96128077493;52811.20783188332;42752.78623606862;43182;43544.56455435405;43630.12739745251;44478;42598.512218934375;43200.56799432091;43233.3514997269;43893.78053109714;44319.55680443283;42419.57580424156;42539.14921701611;42584.78707606566;43192.56807431886;43665.56334436615;35862.820685896404;40111.1977760449;40251.39622905717;40693;40735.388969164895;29787.851060744557;29941;30119.247018824706;30193.547096793125;30687 02:05:47 INFO - PROCESS | 14217 | |2;jquery.html;426.2370357060861;432.6668465281735;434.9217140914636;442.54417949512015;447.39378142616755;18980.335688250878;19049.2380304788;19074.61850762984;19085.23659053638;20030.69953950692;15972.520824375259;17364.56588585286;17507.562310942234;17568.736468952975;17666.38167664129;5430.321209848769;5800.7679692812235;5836.708164591774;5845.2401187845735;5848.122781582754;4327.2643650579475;5663.915041274384;5752.741126649311;6251.624902505841;6522.478201743849;6662.93337066628;6678.232003319607;6680.331966803329;6681;6685.231198412196;6508.446782023534;6556.6066036037755;6676.26561078281;6684.665766711645;6688.4649228061635;3930.9017274568077;5552.972235138798;5856.32652244993;5937.465628093449;5943.435373639497;23182.53634927292;23405.297841064796;23712.170074047324;24150.396240093964;24241;2435.5737745894576;2463.987680061606;2602.1803132013356;2607.895684172631;2643.0220818297353;14735.336909839083;14920.552383428514;14966.326515306728;15240.314185861664;15375.615609609737;2014.3352693611073;2052.9486762830898;2104.736907886514;2182.7380714314227;2262.6266666000092;77467.22532774656;78306.21693783047;80367;81257;83671.16328836695;11450.255733377304;11597.826032609517;11670.766584668429;11690.181687281809;11700.590479333183;16429.096399697894;16519.587010324598;16545.09002004877;16570.917145414194;16618.75071873923;8438.409311348147;8478.660853565912;8517.531535765593;8574.3997920145;8640.351973602004;8176.182381761776;8213.671453141807;8235.8352832943;8239.505629662239;8326.209010144026;4930.457649658535;5006.74966251686;5006.974965125224;5047.520485553867;5095.770690318945;1807.2318724630325;1887.4432042547483;2047.129969762845;2068.6586713192155;2104.652732299184;1016.3038318751679;1024.3444195714749;1061.2571200159919;1090.5419723716059;1106.950187241576;18907.905460472608;18951;19050.61898762017;19257;19306.172004060256;1028.7376718936773;1058.3385384134915;1078.1805827570945;1080.1304949515559;1105.7069876482738;10458.68623941283;11022;11025.44872756359;11118.888811111947;11150.275232109887;454323;466571;490985;534353;536050;50073.749631252336;77668.61165694248;95022;95498.52250738702;96299.51850240704;1054.488573042074;1119.1941801902453;1120.915931305139;1125.5272785430138;1136.6533207371665;17753;17963.730544041588;18033.639327213645;18128.46041164954;18230.81769182291;41608.583914160474;41801.58198417977;42022.53707018068;43574.56425435705;44047.11905761931;55659;57551.136732949875;60831.69584152051;61295.69352153211;61298.387016129265;7861.213878612093;8188.426810123234;8817.426867253607;8931.776705582412;9008.324375671982;10626.36241825493;13006.349682516025;13083.542076027294;13156.342182891009;13263.204207747565;11560.30638161713;11671.3580753056;12029.4586743595;12046.939765301116;12093.455794489093;11699.590514332298;11780.70548236301;11784.70538236551;11784.882151178721;11901.702457438634;11701.239419437708;11752.177347585586;11771.47028383742;12214.877851221729;12236.388180591113;8311.584420778816;8366.748997530083;8409.873851892104;8567;8570.914290857261;11355.318680879174;11491.655250342503;11607.941960290145;11710.70723231926;11716.94141529321 02:05:47 INFO - PROCESS | 14217 | |3;mootools.html;1391.4225596377503;1550.1861522700585;1591.3952697974769;1777.7600023996756;1877.7371168036477;9094.954525227373;9533.046695330471;9540.570674319655;9944.403335799858;9963.252756043308;9672.129508344247;9867.506624668773;9875.358101723401;9884.456354900496;9892.258080643962;2172.283146561631;2416.347586151738;2474.740152284007;2509.6110102933985;2517.5216708825355;2499.7000359956833;2522.608995605675;2523.74762523748;2555.2334299710105;2564.7050589182295;2459.0901366494422;2482.2801387597665;2484.962725559118;2492.8379655322437;2494.725580186187;2104.4107649858065;2405.1581946318825;2462.963055554168;2463.963040554393;2471.888765005579;2425.369403954967;2429.2955043037673;2444.779969802726;2475.8885850136785;2477.1453848422266;9449.480278584675;9476.241900648001;9486.051394860528;9493.620255189784;9517.5717092731;5534.142207957773;5659.717014149317;5659.8585035374035;5664.065429204176;5664.801731939404;3554.3424466473784;3615.837287322077;3643.234920666663;3691.354013047706;3706.684931780802;1209.7822391969441;1223.7368965672424;1235.0983781839218;1264.2477725753254;1268.1313300389263;13336.066475346632;13727.725445491134;14241.572752817328;14250.429982800779;14253.358598863077;4895.388076490439;4981.178105612606;5008.12357837377;5022.673526220784;5085.982803439327;11809.822852657217;11809.88190118105;11815.822762658567;11818.586349477728;11842.407879605986;4993.6005119590345;5659.688717120598;5716.256886604798;5722.656640601577;5733.741981610838;4560.95439045612;4657.976710116428;4705.741184234831;5012.523810238022;5069.847904562869;4333.934990975138;4338.457692788402;4446.133004064176;4465;4479.776011199427;1277.5145444730942;1380.5720226729745;1387.3548799808138;1391.7842734376188;1393.3312010235145;1018.872640919885;1019.5717798524637;1020.9642662506776;1026.707388394304;1028.2596530498029;6108.877822443526;6112.908306375408;6183.196184496077;6218.502519798405;6227.408396202353;459.99080018399445;462.8472604040659;467.14978738695925;470.6305550143121;484.15998243048284;3868.6711629511806;3925.6074392560517;3979.6219359161414;3996.5803590623145;4006.7395619284653;11526.654200374001;12252.75494490123;12271.325077120844;12346.320952347527;12371.628851134481;11872.88127118735;12088.818667719992;12210.938945305217;12471.251724896536;12524.561640342545;8955.149260820212;9064.909350906539;9086.318526110568;9108.089191080839;9134.771630709285;6084.14821924922;6157.138000679998;6158.445739883432;6168.25980882297;6218.036204388327;11262.436878156223;11272.549098035986;11278.774424511299;11337.26307789991;11419.200655954004;10764.838527421938;11213.887861121611;11216.046636036028;11329.886701132884;11669.183157178915;7580.317771400601;7712.383009359126;7937.087234968052;8669.436486628349;8841.292696584387;9178.954105229432;9645.517724113626;9646.276529260474;9649.131578158;9656.179224765974;8293.33653307722;8425.95787021061;8438.240558349778;8508.617112230088;8719.956400217958;8163.877541836996;8409.789755256168;8423.747287581382;8570.700025499078;8583.65665373378;7428.442866785121;7430.4798664093;7584.54492730438;7685.654145563575;7686.538807671557;5282.788688452572;5328.333958255218;5388.54197393226;5417;5467.480589344006;5230.712310822789;5252.080885844885;5323.680579165262;5457.754401052041;5462.3445186577865 02:05:47 INFO - PROCESS | 14217 | |4;prototype.html;347.57769310287995;348.31555992474784;356.98793919238955;357.50307073168284;359.48414025872876;5233.450487698794;5357;5367.490088441592;5403.486668766466;5432;5283.6037297202765;5293.655912365703;5297.470252974701;5310.6017048721305;5339.813106541262;3967.1668949520636;3996.9800150999204;4198.538160802309;4218.11419601884;4219.535851056381;4138.668371960571;4166.8749937501925;4170.582941705836;4170.874873753793;4174.749515029092;4106.07613287011;4107.445494858186;4133.297339452301;4146.274401979656;4170.72890262132;3946.427767973628;4061.97969010156;4155.9817844628105;4160.54234034256;4177.874663760077;3697.574778900407;3698.260347930425;3704.9259014819554;3712.7401081924277;3726.2920045191327;5105.208692652608;5107.3360463139925;5117.33474648297;5137.7944882204665;5145.485451454862;4709.175894218498;4777.4267087949665;4778.522147785228;4782.641301902337;4783.832565860213;5490.917636235459;5502.504774570308;5538.9169162462595;5539.446055394468;5563.972180139073;4088.366303223005;4098.754074755524;4104.56902025289;4107.67138628909;4142.399352093959;5529.364123125852;5716.971415142898;5719.6854173020465;5749.683767392792;5805.854853628651;4126.896827579335;4154.729942553724;4156.231097247019;4164.209389962285;4191.517975432865;4258.5954334338185;4262.680298977589;4273.166732487197;4274.572542745701;4285.957140428618;4578.198815207325;4774.116788394089;4804.927926081112;4809;4820.421549414023;5466.453354664582;5525.336959564878;5528.253685752452;5534.146061069587;5544;1428.6428392901776;1446.3997441062052;1469.941202351894;1473.5652982370227;1475.5057055886184;908.3051465628799;953.1612181280428;962.6149540183842;968.7820240445843;978.5889926231;5381.7578208980685;5534.509470738184;5535.25274087993;5538.861528461821;5541.251930989345;5715.742791574389;5731.971340143273;5732.936142988521;5739.938111449395;5767.538596912237;5306.734663266821;5514.759179184652;5514.889702206014;5551.139573366135;5588.776448941997;3005.4590173768934;3015.20097174249;3030.9242268943012;3050.5119180930947;3077.1999280186865;5832.970835145882;5965.717370765306;6025.740347369736;6026.679728304634;6039.456448919618;5775.075987841925;5775.133729940542;5802.187693722883;5805;5810.82567522975;5919.822405327847;5945.970270148708;5947.494462970523;5950.761969521171;6007.8197654070445;5553.972230138985;5620.353659329229;5691.800786972436;5726.255586773693;5745.7988970387505;5545.223668686306;5579.497845193952;5586.229295225788;5595.804146855004;5646.971765141148;5760.452756988079;5973.970130149321;5988.401159883977;5988.520918326436;6040.365761595145;4145.875623731293;4158.355454904495;4159.7121583128555;4161.3978618231595;4163.479565054368;5660.830175094754;5700.030994730822;5706.572007099568;5711.685857277889;5776.913346299725;5319.509858705178;5545.3123672758775;5574.665520068809;5594.272744543184;5603.579731520071;5530.668159910419;5542.140968149944;5549.278593782782;5564.1931919870585;5565.248691426767;5258.158694608997;5311.336082989626;5471.425500322409;5495.477929596682;5495.862603434786;5590.791637303161;5596.860078497907;5612.158176273591;5613.764971706218;5632.155176723524;5450.645708028966;5491.643043202179;5502.9174562380795;5509.393966663744;5527.8894422112135 02:05:47 INFO - PROCESS | 14217 | |5;yui.html;810.3355248696068;832.2385017708793;864.7232885476647;884.5665623844314;887.2369762004679;16286;16847.494575162735;17002.319907203713;17021.063841488714;17027.148642567885;15250.771238431433;15273.38906443741;15357.385704571832;15381.769273460906;15392;707.049019069351;719.7157122936437;721.1454426504582;722.6856317501877;831.1024093978489;831.846108469935;831.8876951611516;834.7620928035511;834.9874751878726;835.7868743470437;886.6143227695941;893.2318206342541;894.2845723421269;895.2211575928951;895.5253715530779;879.8064425826308;889.5996801439313;890.5858775669312;890.9287257019423;891.131147131548;547.6960287040691;640.2764875690486;649.7076315657973;651.2510612795276;661.0579923608886;15688.137152456611;15732.606684832856;15773.369065237377;15785.131817750134;15795.052296862224;14617.70764584713;15005.24973751319;15203.391864325413;15453.768193477106;15562;13109.737805243936;13400;13488.460461581524;13575.660608484866;13767.586972390844;3993.4209539616595;4641.164590373732;4707.646926480527;4749.62003039756;4768.237082066853;78145.21854781437;79407.20592794057;79520.60239698764;80463.5976820118;80884.19115808826;10184.898151018395;10283;10751.247412681194;11167;11187.496562654538;17577.80277465317;17645.647087058187;17679.38122165718;17688.823111768976;17710.291588336324;8185.754427367069;8469.872951905727;8708.869366959501;8753.06772231297;8806.47161170319;4754.096721622881;4831.830885918976;4897.657163998486;4908.239222920453;5002.674826136289;3759.548854137466;3986.7807270600397;4014.5383280922483;4058.350663893763;4066.2274167908004;742.0798210219289;747.2602123897302;748.1807420874134;750.2272659161073;759.0549765541825;791.2483141016057;805.2189376304975;811.3955103447969;811.4725428471422;814.5357146426599;10393.272470926962;10895.182861285435;10974.890251097546;10985.945070274598;11057.723556911142;750.4634186556639;793.686493834932;803.1406395157126;806.4032615864219;814.9551774652332;4882.145624515695;4896;4974.303597496353;4993.875153121201;5019.42276638184;79297.20702793014;80025.19974800294;118975;122192;128929.35535322264;107381;111195;111206.44396778126;111507;113301.433492832;95039;97405;97519;98695;101744.49127754461;9647.565859536197;9763.85354219673;9822.165115964937;9826.919038905571;9898.307118501636;55282;55329.723351382985;56037.43962560322;57353;58166.41833581779;75172;81619;82437;82782.58608706918;83044;12249.632511024683;12302.630921072383;12312.322822244863;12389.194702344319;12431.254124752544;13650;13966;14009.789853152415;14290.35693393779;14337.713245735236;12804.807927881275;13219.66950826237;13235.338233088114;13269.203847769164;13293;12868.485260589472;12904.677383065498;13208.141470804367;13212.933935330262;13279.269640169883;12639.368031598568;12833.935830320788;12846.293453860128;13011.739765204833;13018.414171362501;10420.270581059556;10663.89336106629;10729.088027517437;10778.00860809321;10824.729381765519;10437.165026797686;10649.414282214553;10682.62610808618;10754.462276886281;10772 02:05:47 INFO - PROCESS | 14217 | __end_tp_report 02:05:47 INFO - PROCESS | 14217 | __start_cc_report 02:05:47 INFO - PROCESS | 14217 | _x_x_mozilla_cycle_collect,921 02:05:47 INFO - PROCESS | 14217 | __end_cc_report 02:05:47 INFO - PROCESS | 14217 | __startTimestamp1469178347781__endTimestamp 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | ------- Summary: start ------- 02:05:47 INFO - PROCESS | 14217 | Number of tests: 6 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | [#0] dojo.html Cycles:165 Average:5524.59 Median:5726.17 stddev:604.24 (10.6%) stddev-sans-first:581.86 02:05:47 INFO - PROCESS | 14217 | Values: 3365.0 3385.3 3401.3 3420.6 3437.6 5519.2 5589.0 5601.6 5602.8 5627.4 5527.8 5535.1 5562.9 5577.7 5592.1 4842.2 4945.8 5042.1 5055.4 5101.2 4912.4 4927.1 4936.5 5006.1 5103.1 5066.6 5082.5 5100.3 5141.2 5159.5 5083.0 5156.7 5157.9 5158.1 5190.6 4889.7 4891.0 4925.2 4934.9 5063.0 5406.9 5450.6 5454.9 5472.2 5498.8 5864.1 5870.9 5922.9 5924.0 5925.8 5862.7 5889.1 5930.1 5952.5 6016.7 5587.2 5616.2 5616.2 5622.4 5626.5 5823.4 6071.2 6071.4 6072.3 6083.4 5681.9 5688.3 5707.9 5781.7 5781.7 5798.3 5798.4 5823.7 5840.4 5855.9 5706.5 5780.2 5790.3 5792.0 5844.4 5829.5 5850.2 5877.5 5926.1 5960.0 4578.6 4597.2 4613.0 4618.4 4638.8 4044.7 4045.0 4081.4 4119.9 4162.1 5702.7 5719.8 5726.2 5739.1 5746.1 5901.0 5953.8 5964.2 5966.9 5991.0 5611.6 5614.9 5643.7 5649.9 5706.5 5115.5 5118.6 5118.9 5122.9 5123.4 6233.1 6243.8 6244.6 6249.6 6251.1 5802.2 5837.6 5872.2 5899.9 5978.2 6228.9 6261.9 6263.4 6264.6 6277.1 5692.5 5830.0 5834.1 5836.5 5869.3 5939.9 5960.9 5981.3 6044.1 6046.9 5873.2 5882.3 5896.2 5904.0 5905.2 5661.5 5774.2 5856.4 5898.6 5901.9 5714.3 5778.2 5794.6 5797.7 5828.7 5884.1 5890.1 5940.5 5940.7 5943.5 5605.7 5616.1 5620.5 5788.4 5815.2 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | [#1] ext.html Cycles:180 Average:67151.42 Median:199046.37 stddev:137742.96 (69.2%) stddev-sans-first:138038.74 02:05:47 INFO - PROCESS | 14217 | Values: 603.1 633.7 644.0 653.7 654.9 33054.2 45380.8 46474.8 46732.3 46771.8 49822.0 50332.0 50405.2 50418.2 50448.0 8365.6 9209.4 9359.7 9364.2 10890.3 10599.3 11051.1 11052.9 11058.4 11061.7 11135.8 11186.2 11194.7 11201.3 11206.3 8545.9 8738.7 10711.1 11046.6 11080.3 11041.4 11124.7 11127.2 11139.9 11158.1 45312.0 45530.8 45603.3 45664.3 45699.3 3869.6 3905.7 3914.3 3928.3 3941.7 34833.3 35857.0 35868.8 35895.0 36009.0 4608.7 4669.1 4673.1 4717.3 4727.6 388100.0 390455.0 390737.0 391254.0 394151.0 63271.4 63406.4 63696.7 63705.0 63874.7 39030.7 40033.6 40035.8 41990.8 42008.4 17353.5 17375.1 17410.7 17412.2 17412.9 12854.2 13104.8 13165.0 13173.9 13468.6 21079.7 21353.3 21388.4 21470.6 21477.0 7264.6 7461.0 7493.5 7631.5 7694.3 1078.2 1116.8 1148.8 1164.7 1167.7 33334.5 33986.6 34031.5 34250.0 34260.8 1133.8 1156.4 1178.0 1186.1 1254.7 17933.8 17940.5 17977.1 18062.0 18124.7 630066.0 632961.0 634975.0 635717.0 636460.0 64674.7 64811.4 64935.4 64946.0 65174.3 1467.4 1491.9 1503.2 1507.4 1510.3 34133.7 35151.8 35269.3 35411.0 35474.6 54401.7 54675.7 55191.0 55244.4 55268.2 494824.0 500752.0 501044.0 501541.0 501926.0 26315.9 29610.6 30239.8 30475.7 31103.2 51330.5 51448.5 51668.0 51936.0 52811.2 42752.8 43182.0 43544.6 43630.1 44478.0 42598.5 43200.6 43233.4 43893.8 44319.6 42419.6 42539.1 42584.8 43192.6 43665.6 35862.8 40111.2 40251.4 40693.0 40735.4 29787.9 29941.0 30119.2 30193.5 30687.0 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | [#2] jquery.html Cycles:180 Average:29225.95 Median:23293.92 stddev:81833.05 (351.3%) stddev-sans-first:82034.04 02:05:47 INFO - PROCESS | 14217 | Values: 426.2 432.7 434.9 442.5 447.4 18980.3 19049.2 19074.6 19085.2 20030.7 15972.5 17364.6 17507.6 17568.7 17666.4 5430.3 5800.8 5836.7 5845.2 5848.1 4327.3 5663.9 5752.7 6251.6 6522.5 6662.9 6678.2 6680.3 6681.0 6685.2 6508.4 6556.6 6676.3 6684.7 6688.5 3930.9 5553.0 5856.3 5937.5 5943.4 23182.5 23405.3 23712.2 24150.4 24241.0 2435.6 2464.0 2602.2 2607.9 2643.0 14735.3 14920.6 14966.3 15240.3 15375.6 2014.3 2052.9 2104.7 2182.7 2262.6 77467.2 78306.2 80367.0 81257.0 83671.2 11450.3 11597.8 11670.8 11690.2 11700.6 16429.1 16519.6 16545.1 16570.9 16618.8 8438.4 8478.7 8517.5 8574.4 8640.4 8176.2 8213.7 8235.8 8239.5 8326.2 4930.5 5006.7 5007.0 5047.5 5095.8 1807.2 1887.4 2047.1 2068.7 2104.7 1016.3 1024.3 1061.3 1090.5 1107.0 18907.9 18951.0 19050.6 19257.0 19306.2 1028.7 1058.3 1078.2 1080.1 1105.7 10458.7 11022.0 11025.4 11118.9 11150.3 454323.0 466571.0 490985.0 534353.0 536050.0 50073.7 77668.6 95022.0 95498.5 96299.5 1054.5 1119.2 1120.9 1125.5 1136.7 17753.0 17963.7 18033.6 18128.5 18230.8 41608.6 41801.6 42022.5 43574.6 44047.1 55659.0 57551.1 60831.7 61295.7 61298.4 7861.2 8188.4 8817.4 8931.8 9008.3 10626.4 13006.3 13083.5 13156.3 13263.2 11560.3 11671.4 12029.5 12046.9 12093.5 11699.6 11780.7 11784.7 11784.9 11901.7 11701.2 11752.2 11771.5 12214.9 12236.4 8311.6 8366.7 8409.9 8567.0 8570.9 11355.3 11491.7 11607.9 11710.7 11716.9 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | [#3] mootools.html Cycles:180 Average:6304.65 Median:2510.47 stddev:3758.93 (149.7%) stddev-sans-first:3751.34 02:05:47 INFO - PROCESS | 14217 | Values: 1391.4 1550.2 1591.4 1777.8 1877.7 9095.0 9533.0 9540.6 9944.4 9963.3 9672.1 9867.5 9875.4 9884.5 9892.3 2172.3 2416.3 2474.7 2509.6 2517.5 2499.7 2522.6 2523.7 2555.2 2564.7 2459.1 2482.3 2485.0 2492.8 2494.7 2104.4 2405.2 2463.0 2464.0 2471.9 2425.4 2429.3 2444.8 2475.9 2477.1 9449.5 9476.2 9486.1 9493.6 9517.6 5534.1 5659.7 5659.9 5664.1 5664.8 3554.3 3615.8 3643.2 3691.4 3706.7 1209.8 1223.7 1235.1 1264.2 1268.1 13336.1 13727.7 14241.6 14250.4 14253.4 4895.4 4981.2 5008.1 5022.7 5086.0 11809.8 11809.9 11815.8 11818.6 11842.4 4993.6 5659.7 5716.3 5722.7 5733.7 4561.0 4658.0 4705.7 5012.5 5069.8 4333.9 4338.5 4446.1 4465.0 4479.8 1277.5 1380.6 1387.4 1391.8 1393.3 1018.9 1019.6 1021.0 1026.7 1028.3 6108.9 6112.9 6183.2 6218.5 6227.4 460.0 462.8 467.1 470.6 484.2 3868.7 3925.6 3979.6 3996.6 4006.7 11526.7 12252.8 12271.3 12346.3 12371.6 11872.9 12088.8 12210.9 12471.3 12524.6 8955.1 9064.9 9086.3 9108.1 9134.8 6084.1 6157.1 6158.4 6168.3 6218.0 11262.4 11272.5 11278.8 11337.3 11419.2 10764.8 11213.9 11216.0 11329.9 11669.2 7580.3 7712.4 7937.1 8669.4 8841.3 9179.0 9645.5 9646.3 9649.1 9656.2 8293.3 8426.0 8438.2 8508.6 8720.0 8163.9 8409.8 8423.7 8570.7 8583.7 7428.4 7430.5 7584.5 7685.7 7686.5 5282.8 5328.3 5388.5 5417.0 5467.5 5230.7 5252.1 5323.7 5457.8 5462.3 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | [#4] prototype.html Cycles:180 Average:4715.58 Median:5458.55 stddev:1373.12 (25.2%) stddev-sans-first:1337.26 02:05:47 INFO - PROCESS | 14217 | Values: 347.6 348.3 357.0 357.5 359.5 5233.5 5357.0 5367.5 5403.5 5432.0 5283.6 5293.7 5297.5 5310.6 5339.8 3967.2 3997.0 4198.5 4218.1 4219.5 4138.7 4166.9 4170.6 4170.9 4174.7 4106.1 4107.4 4133.3 4146.3 4170.7 3946.4 4062.0 4156.0 4160.5 4177.9 3697.6 3698.3 3704.9 3712.7 3726.3 5105.2 5107.3 5117.3 5137.8 5145.5 4709.2 4777.4 4778.5 4782.6 4783.8 5490.9 5502.5 5538.9 5539.4 5564.0 4088.4 4098.8 4104.6 4107.7 4142.4 5529.4 5717.0 5719.7 5749.7 5805.9 4126.9 4154.7 4156.2 4164.2 4191.5 4258.6 4262.7 4273.2 4274.6 4286.0 4578.2 4774.1 4804.9 4809.0 4820.4 5466.5 5525.3 5528.3 5534.1 5544.0 1428.6 1446.4 1469.9 1473.6 1475.5 908.3 953.2 962.6 968.8 978.6 5381.8 5534.5 5535.3 5538.9 5541.3 5715.7 5732.0 5732.9 5739.9 5767.5 5306.7 5514.8 5514.9 5551.1 5588.8 3005.5 3015.2 3030.9 3050.5 3077.2 5833.0 5965.7 6025.7 6026.7 6039.5 5775.1 5775.1 5802.2 5805.0 5810.8 5919.8 5946.0 5947.5 5950.8 6007.8 5554.0 5620.4 5691.8 5726.3 5745.8 5545.2 5579.5 5586.2 5595.8 5647.0 5760.5 5974.0 5988.4 5988.5 6040.4 4145.9 4158.4 4159.7 4161.4 4163.5 5660.8 5700.0 5706.6 5711.7 5776.9 5319.5 5545.3 5574.7 5594.3 5603.6 5530.7 5542.1 5549.3 5564.2 5565.2 5258.2 5311.3 5471.4 5495.5 5495.9 5590.8 5596.9 5612.2 5613.8 5632.2 5450.6 5491.6 5502.9 5509.4 5527.9 02:05:47 INFO - PROCESS | 14217 | 02:05:47 INFO - PROCESS | 14217 | [#5] yui.html Cycles:180 Average:21628.20 Median:4674.41 stddev:31689.50 (677.9%) stddev-sans-first:31739.85 02:05:47 INFO - PROCESS | 14217 | Values: 810.3 832.2 864.7 884.6 887.2 16286.0 16847.5 17002.3 17021.1 17027.1 15250.8 15273.4 15357.4 15381.8 15392.0 707.0 719.7 721.1 722.7 831.1 831.8 831.9 834.8 835.0 835.8 886.6 893.2 894.3 895.2 895.5 879.8 889.6 890.6 890.9 891.1 547.7 640.3 649.7 651.3 661.1 15688.1 15732.6 15773.4 15785.1 15795.1 14617.7 15005.2 15203.4 15453.8 15562.0 13109.7 13400.0 13488.5 13575.7 13767.6 3993.4 4641.2 4707.6 4749.6 4768.2 78145.2 79407.2 79520.6 80463.6 80884.2 10184.9 10283.0 10751.2 11167.0 11187.5 17577.8 17645.6 17679.4 17688.8 17710.3 8185.8 8469.9 8708.9 8753.1 8806.5 4754.1 4831.8 4897.7 4908.2 5002.7 3759.5 3986.8 4014.5 4058.4 4066.2 742.1 747.3 748.2 750.2 759.1 791.2 805.2 811.4 811.5 814.5 10393.3 10895.2 10974.9 10985.9 11057.7 750.5 793.7 803.1 806.4 815.0 4882.1 4896.0 4974.3 4993.9 5019.4 79297.2 80025.2 118975.0 122192.0 128929.4 107381.0 111195.0 111206.4 111507.0 113301.4 95039.0 97405.0 97519.0 98695.0 101744.5 9647.6 9763.9 9822.2 9826.9 9898.3 55282.0 55329.7 56037.4 57353.0 58166.4 75172.0 81619.0 82437.0 82782.6 83044.0 12249.6 12302.6 12312.3 12389.2 12431.3 13650.0 13966.0 14009.8 14290.4 14337.7 12804.8 13219.7 13235.3 13269.2 13293.0 12868.5 12904.7 13208.1 13212.9 13279.3 12639.4 12833.9 12846.3 13011.7 13018.4 10420.3 10663.9 10729.1 10778.0 10824.7 10437.2 10649.4 10682.6 10754.5 10772.0 02:05:47 INFO - PROCESS | 14217 | -------- Summary: end -------- 02:05:47 INFO - PROCESS | 14217 | 02:05:48 INFO - TEST-INFO | 14217: exit 0 02:05:48 INFO - TEST-OK | dromaeo_css | took 1112056ms 02:05:48 INFO - TEST-START | kraken 02:05:48 INFO - operating with platform_type : linux_ 02:05:48 INFO - Initialising browser for kraken test... 02:05:48 INFO - TEST-INFO | started process 14408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIU7DWF/profile http://localhost:60142/getInfo.html) 02:05:52 INFO - PROCESS | 14408 | __metrics Screen width/height:1600/1200 02:05:52 INFO - PROCESS | 14408 | colorDepth:24 02:05:52 INFO - PROCESS | 14408 | Browser inner width/height: 1024/697 02:05:52 INFO - PROCESS | 14408 | __metrics 02:05:53 INFO - PROCESS | 14408 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:05:53 ERROR - PROCESS | 14408 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:05:54 INFO - TEST-INFO | 14408: exit 0 02:05:54 INFO - Browser initialized. 02:05:54 INFO - Running cycle 1/1 for kraken test... 02:05:54 INFO - TEST-INFO | started process 14502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIU7DWF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:06 INFO - PROCESS | 14502 | RSS: Main: 145432576 02:06:06 INFO - PROCESS | 14502 | 02:06:08 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60142/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:09 INFO - PROCESS | 14502 | RSS: Main: 194908160 02:06:09 INFO - PROCESS | 14502 | 02:06:11 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60142/tests/kraken/driver.html?testName=audio-dft) 02:06:12 INFO - PROCESS | 14502 | RSS: Main: 192147456 02:06:12 INFO - PROCESS | 14502 | 02:06:15 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60142/tests/kraken/driver.html?testName=audio-fft) 02:06:16 INFO - PROCESS | 14502 | RSS: Main: 279289856 02:06:16 INFO - PROCESS | 14502 | 02:06:18 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60142/tests/kraken/driver.html?testName=audio-oscillator) 02:06:18 INFO - PROCESS | 14502 | RSS: Main: 187154432 02:06:18 INFO - PROCESS | 14502 | 02:06:20 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:21 INFO - PROCESS | 14502 | RSS: Main: 188190720 02:06:21 INFO - PROCESS | 14502 | 02:06:24 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60142/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:25 INFO - PROCESS | 14502 | RSS: Main: 222969856 02:06:25 INFO - PROCESS | 14502 | 02:06:28 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60142/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:28 INFO - PROCESS | 14502 | RSS: Main: 223797248 02:06:28 INFO - PROCESS | 14502 | 02:06:31 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60142/tests/kraken/driver.html?testName=json-parse-financial) 02:06:32 INFO - PROCESS | 14502 | RSS: Main: 223477760 02:06:32 INFO - PROCESS | 14502 | 02:06:33 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:06:34 INFO - PROCESS | 14502 | RSS: Main: 201277440 02:06:34 INFO - PROCESS | 14502 | 02:06:36 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:06:36 INFO - PROCESS | 14502 | RSS: Main: 202350592 02:06:36 INFO - PROCESS | 14502 | 02:06:38 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:06:39 INFO - PROCESS | 14502 | RSS: Main: 210432000 02:06:39 INFO - PROCESS | 14502 | 02:06:41 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:06:42 INFO - PROCESS | 14502 | RSS: Main: 216051712 02:06:42 INFO - PROCESS | 14502 | 02:06:45 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:06:45 INFO - PROCESS | 14502 | RSS: Main: 215121920 02:06:45 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | Cycle 1(1): loaded http://localhost:60142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60142/tests/kraken/driver.html?testName=ai-astar) 02:06:47 INFO - PROCESS | 14502 | RSS: Main: 257585152 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | __start_tp_report 02:06:47 INFO - PROCESS | 14502 | _x_x_mozilla_page_load 02:06:47 INFO - PROCESS | 14502 | _x_x_mozilla_page_load_details 02:06:47 INFO - PROCESS | 14502 | |i|pagename|runs| 02:06:47 INFO - PROCESS | 14502 | |0;ai-astar;111;105;110;110;110;113;109;110;109;109 02:06:47 INFO - PROCESS | 14502 | |1;audio-beat-detection;146;124;130;169;128;126;158;122;162;124 02:06:47 INFO - PROCESS | 14502 | |2;audio-dft;159;163;162;161;162;159;160;158;159;159 02:06:47 INFO - PROCESS | 14502 | |3;audio-fft;75;74;76;118;76;76;75;75;99;74 02:06:47 INFO - PROCESS | 14502 | |4;audio-oscillator;83;85;113;85;84;87;114;84;85;128 02:06:47 INFO - PROCESS | 14502 | |5;imaging-gaussian-blur;117;118;117;118;117;117;116;116;117;116 02:06:47 INFO - PROCESS | 14502 | |6;imaging-darkroom;146;146;145;145;148;146;146;145;146;145 02:06:47 INFO - PROCESS | 14502 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 02:06:47 INFO - PROCESS | 14502 | |8;json-parse-financial;51;50;51;51;51;52;54;52;51;52 02:06:47 INFO - PROCESS | 14502 | |9;json-stringify-tinderbox;60;61;61;60;60;60;61;61;61;61 02:06:47 INFO - PROCESS | 14502 | |10;stanford-crypto-aes;82;78;75;75;77;78;77;76;102;77 02:06:47 INFO - PROCESS | 14502 | |11;stanford-crypto-ccm;127;118;115;130;116;121;114;123;129;122 02:06:47 INFO - PROCESS | 14502 | |12;stanford-crypto-pbkdf2;153;153;154;156;153;157;156;156;159;157 02:06:47 INFO - PROCESS | 14502 | |13;stanford-crypto-sha256-iterative;63;64;61;61;62;60;60;61;63;60 02:06:47 INFO - PROCESS | 14502 | __end_tp_report 02:06:47 INFO - PROCESS | 14502 | __start_cc_report 02:06:47 INFO - PROCESS | 14502 | _x_x_mozilla_cycle_collect,1586 02:06:47 INFO - PROCESS | 14502 | __end_cc_report 02:06:47 INFO - PROCESS | 14502 | __startTimestamp1469178407718__endTimestamp 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | ------- Summary: start ------- 02:06:47 INFO - PROCESS | 14502 | Number of tests: 14 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.01 (1.8%) stddev-sans-first:2.07 02:06:47 INFO - PROCESS | 14502 | Values: 111.0 105.0 110.0 110.0 110.0 113.0 109.0 110.0 109.0 109.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:138.00 stddev:18.10 (13.1%) stddev-sans-first:19.02 02:06:47 INFO - PROCESS | 14502 | Values: 146.0 124.0 130.0 169.0 128.0 126.0 158.0 122.0 162.0 124.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.69 (1.1%) stddev-sans-first:1.73 02:06:47 INFO - PROCESS | 14502 | Values: 159.0 163.0 162.0 161.0 162.0 159.0 160.0 158.0 159.0 159.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:14.79 (19.6%) stddev-sans-first:15.48 02:06:47 INFO - PROCESS | 14502 | Values: 75.0 74.0 76.0 118.0 76.0 76.0 75.0 75.0 99.0 74.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.50 stddev:16.75 (19.8%) stddev-sans-first:17.21 02:06:47 INFO - PROCESS | 14502 | Values: 83.0 85.0 113.0 85.0 84.0 87.0 114.0 84.0 85.0 128.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 02:06:47 INFO - PROCESS | 14502 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 116.0 116.0 117.0 116.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 02:06:47 INFO - PROCESS | 14502 | Values: 146.0 146.0 145.0 145.0 148.0 146.0 146.0 145.0 146.0 145.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:06:47 INFO - PROCESS | 14502 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.08 (2.1%) stddev-sans-first:1.13 02:06:47 INFO - PROCESS | 14502 | Values: 51.0 50.0 51.0 51.0 51.0 52.0 54.0 52.0 51.0 52.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 02:06:47 INFO - PROCESS | 14502 | Values: 60.0 61.0 61.0 60.0 60.0 60.0 61.0 61.0 61.0 61.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:77.00 stddev:8.08 (10.5%) stddev-sans-first:8.53 02:06:47 INFO - PROCESS | 14502 | Values: 82.0 78.0 75.0 75.0 77.0 78.0 77.0 76.0 102.0 77.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:5.80 (4.7%) stddev-sans-first:5.80 02:06:47 INFO - PROCESS | 14502 | Values: 127.0 118.0 115.0 130.0 116.0 121.0 114.0 123.0 129.0 122.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.00 stddev:2.07 (1.3%) stddev-sans-first:2.00 02:06:47 INFO - PROCESS | 14502 | Values: 153.0 153.0 154.0 156.0 153.0 157.0 156.0 156.0 159.0 157.0 02:06:47 INFO - PROCESS | 14502 | 02:06:47 INFO - PROCESS | 14502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.43 (2.3%) stddev-sans-first:1.41 02:06:47 INFO - PROCESS | 14502 | Values: 63.0 64.0 61.0 61.0 62.0 60.0 60.0 61.0 63.0 60.0 02:06:47 INFO - PROCESS | 14502 | -------- Summary: end -------- 02:06:47 INFO - PROCESS | 14502 | 02:06:48 INFO - TEST-INFO | 14502: exit 0 02:06:48 INFO - TEST-OK | kraken | took 60143ms 02:06:48 INFO - SUITE-END | took 1172s 02:06:48 INFO - Completed test suite (00:19:32) 02:06:48 INFO - javascript benchmark 02:06:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.0241429985304, 3385.2552438463545, 3401.31973605279, 3420.6066302375234, 3437.6390478999706, 5519.227308176858, 5588.9939810834085, 5601.635893666914, 5602.831915042555, 5627.409122042188, 5527.778888844451, 5535.086710692731, 5562.9443705562935, 5577.721113944307, 5592.105263157896, 4842.249451335031, 4945.752712364385, 5042.067217564744, 5055.3933527976515, 5101.20931255656, 4912.410510738717, 4927.1377508935975, 4936.5063493650705, 5006.148954677714, 5103.055934652101, 5066.645334826564, 5082.466341034194, 5100.285959965608, 5141.203113517392, 5159.509846564571, 5083.034223497523, 5156.741609449874, 5157.922631160535, 5158.097332966753, 5190.584753219752, 4889.731064791435, 4891.0, 4925.162722337175, 4934.876628084291, 5063.0380227756605, 5406.864828379322, 5450.645708028966, 5454.945450545483, 5472.179173124024, 5498.752556134944, 5864.091065884794, 5870.882582348372, 5922.881542369171, 5923.992921203406, 5925.822225333247, 5862.736176872051, 5889.146073819272, 5930.1401296812155, 5952.494038006775, 6016.699165041774, 5587.189857470726, 5616.213730077792, 5616.241807355996, 5622.353429355677, 5626.549876009909, 5823.417658234142, 6071.172391806838, 6071.387524422961, 6072.3088744523275, 6083.391660833881, 5681.914771278434, 5688.345840228344, 5707.885842283131, 5781.682007489629, 5781.739821708034, 5798.304203495608, 5798.391168927202, 5823.70881455934, 5840.3575606683235, 5855.94144058554, 5706.4864162225595, 5780.1907732917425, 5790.305163380422, 5792.0, 5844.386339434383, 5829.5044921181325, 5850.2102216200265, 5877.52979761618, 5926.140709597084, 5959.970200148971, 4578.587927086578, 4597.241455159928, 4613.008203236253, 4618.399608050999, 4638.79125439356, 4044.69664775143, 4045.0494133878515, 4081.4490043844294, 4119.876403707894, 4162.1259535497275, 5702.686352250583, 5719.7712091516705, 5726.169705392695, 5739.110437882135, 5746.109353050284, 5900.970495147582, 5953.761849526057, 5964.194833697396, 5966.940330596725, 5990.9700451497465, 5611.6352437091455, 5614.9438505615235, 5643.661380317194, 5649.943500565024, 5706.486416222477, 5115.5396014358885, 5118.641695081308, 5118.923216151761, 5122.897542049138, 5123.410807757081, 6233.096201050822, 6243.843903902439, 6244.562880598314, 6249.625022498664, 6251.12484252205, 5802.187693722883, 5837.620554663933, 5872.207252020922, 5899.882002360015, 5978.163057172086, 6228.875422491616, 6261.874762504815, 6263.3736626337, 6264.561480696308, 6277.12120303167, 5692.459216374438, 5829.970850145892, 5834.124881267844, 5836.533077353886, 5869.325027621878, 5939.851503712442, 5960.910586341295, 5981.342052374148, 6044.123602077762, 6046.90929636047, 5873.236479257669, 5882.264716910387, 5896.17453556511, 5904.0, 5905.173275741486, 5661.547076233809, 5774.1916131740745, 5856.355800861987, 5898.616589921641, 5901.852453688521, 5714.342850572238, 5778.219940308005, 5794.594378393472, 5797.739101740516, 5828.70856457167, 5884.0585506318785, 5890.057590785454, 5940.46535811779, 5940.673262970406, 5943.52451803846, 5605.663660180402, 5616.129499927518, 5620.494155526022, 5788.363280039276, 5815.156802263733], "value": 5486.321494685166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.1224568253192, 633.6799916042398, 643.9710213040415, 653.6862306093072, 654.931232220617, 33054.17364565884, 45380.773096134515, 46474.76762616186, 46732.29901551479, 46771.76614116933, 49822.0, 50332.0, 50405.24392134121, 50418.24372634413, 50448.0, 8365.58172091396, 9209.447433153999, 9359.719208423725, 9364.204042656382, 10890.292131011498, 10599.258051936367, 11051.115910727123, 11052.944735276313, 11058.447077646126, 11061.723456913602, 11135.832962505569, 11186.161037922147, 11194.720131996724, 11201.271917325348, 11206.271592346513, 8545.871811922827, 8738.73783786481, 10711.143108551298, 11046.558137674483, 11080.279781814157, 11041.447927603667, 11124.666260012213, 11127.165462590257, 11139.888601114048, 11158.051565616932, 45312.0, 45530.77234613839, 45603.31595026044, 45664.3150352745, 45699.31451028237, 3869.5743468218475, 3905.7070719696135, 3914.275858966072, 3928.3125453045604, 3941.7437866538585, 34833.303333933436, 35857.0, 35868.820655896816, 35895.0, 36009.0, 4608.700434471749, 4669.117464170776, 4673.135469938073, 4717.348538560647, 4727.580878321141, 388100.0, 390455.0, 390737.0, 391254.0, 394151.0, 63271.36728632747, 63406.36593634097, 63696.68151659212, 63705.0, 63874.680626597496, 39030.68239199643, 40033.59966400357, 40035.79982100129, 41990.790046050184, 42008.369874451906, 17353.479395618153, 17375.131243437776, 17410.651786964445, 17412.21645025977, 17412.91293543524, 12854.228746275254, 13104.80342794859, 13165.0, 13173.868261317455, 13468.595942121752, 21079.68380474294, 21353.25263615766, 21388.35834924955, 21470.570588588453, 21477.0, 7264.600446975467, 7460.993899910624, 7493.475456717977, 7631.503952243086, 7694.307512323918, 1078.1859695929522, 1116.7989761842784, 1148.8449059377044, 1164.6738913104343, 1167.6963989362828, 33334.49998250028, 33986.58227342649, 34031.489527657104, 34250.0, 34260.82869585686, 1133.7619099989095, 1156.4384887474284, 1178.031360970367, 1186.0585747346456, 1254.6612414648177, 17933.820661793477, 17940.461786146436, 17977.1011449427, 18062.0, 18124.728129078074, 630066.0, 632961.0, 634975.0, 635717.0, 636460.0, 64674.676626617504, 64811.351886481476, 64935.35064649293, 64946.0, 65174.34825651683, 1467.3690313165441, 1491.9030263032869, 1503.19579025221, 1507.4196434372845, 1510.33545240094, 34133.65866341404, 35151.82424087863, 35269.29461410809, 35411.0, 35474.645253548166, 54401.727991361375, 54675.72662136664, 55191.0, 55244.44755552393, 55268.170977434565, 494824.0, 500752.0, 501044.0, 501541.0, 501926.0, 26315.868420657775, 29610.555841662823, 30239.848800755855, 30475.695243047285, 31103.222419439695, 51330.48669513257, 51448.48551514587, 51668.0, 51935.96128077493, 52811.20783188332, 42752.78623606862, 43182.0, 43544.56455435405, 43630.12739745251, 44478.0, 42598.512218934375, 43200.56799432091, 43233.3514997269, 43893.78053109714, 44319.55680443283, 42419.57580424156, 42539.14921701611, 42584.78707606566, 43192.56807431886, 43665.56334436615, 35862.820685896404, 40111.1977760449, 40251.39622905717, 40693.0, 40735.388969164895, 29787.851060744557, 29941.0, 30119.247018824706, 30193.547096793125, 30687.0], "value": 21764.9551627339, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.2370357060861, 432.6668465281735, 434.9217140914636, 442.54417949512015, 447.39378142616755, 18980.335688250878, 19049.2380304788, 19074.61850762984, 19085.23659053638, 20030.69953950692, 15972.520824375259, 17364.56588585286, 17507.562310942234, 17568.736468952975, 17666.38167664129, 5430.321209848769, 5800.7679692812235, 5836.708164591774, 5845.2401187845735, 5848.122781582754, 4327.2643650579475, 5663.915041274384, 5752.741126649311, 6251.624902505841, 6522.478201743849, 6662.93337066628, 6678.232003319607, 6680.331966803329, 6681.0, 6685.231198412196, 6508.446782023534, 6556.6066036037755, 6676.26561078281, 6684.665766711645, 6688.4649228061635, 3930.9017274568077, 5552.972235138798, 5856.32652244993, 5937.465628093449, 5943.435373639497, 23182.53634927292, 23405.297841064796, 23712.170074047324, 24150.396240093964, 24241.0, 2435.5737745894576, 2463.987680061606, 2602.1803132013356, 2607.895684172631, 2643.0220818297353, 14735.336909839083, 14920.552383428514, 14966.326515306728, 15240.314185861664, 15375.615609609737, 2014.3352693611073, 2052.9486762830898, 2104.736907886514, 2182.7380714314227, 2262.6266666000092, 77467.22532774656, 78306.21693783047, 80367.0, 81257.0, 83671.16328836695, 11450.255733377304, 11597.826032609517, 11670.766584668429, 11690.181687281809, 11700.590479333183, 16429.096399697894, 16519.587010324598, 16545.09002004877, 16570.917145414194, 16618.75071873923, 8438.409311348147, 8478.660853565912, 8517.531535765593, 8574.3997920145, 8640.351973602004, 8176.182381761776, 8213.671453141807, 8235.8352832943, 8239.505629662239, 8326.209010144026, 4930.457649658535, 5006.74966251686, 5006.974965125224, 5047.520485553867, 5095.770690318945, 1807.2318724630325, 1887.4432042547483, 2047.129969762845, 2068.6586713192155, 2104.652732299184, 1016.3038318751679, 1024.3444195714749, 1061.2571200159919, 1090.5419723716059, 1106.950187241576, 18907.905460472608, 18951.0, 19050.61898762017, 19257.0, 19306.172004060256, 1028.7376718936773, 1058.3385384134915, 1078.1805827570945, 1080.1304949515559, 1105.7069876482738, 10458.68623941283, 11022.0, 11025.44872756359, 11118.888811111947, 11150.275232109887, 454323.0, 466571.0, 490985.0, 534353.0, 536050.0, 50073.749631252336, 77668.61165694248, 95022.0, 95498.52250738702, 96299.51850240704, 1054.488573042074, 1119.1941801902453, 1120.915931305139, 1125.5272785430138, 1136.6533207371665, 17753.0, 17963.730544041588, 18033.639327213645, 18128.46041164954, 18230.81769182291, 41608.583914160474, 41801.58198417977, 42022.53707018068, 43574.56425435705, 44047.11905761931, 55659.0, 57551.136732949875, 60831.69584152051, 61295.69352153211, 61298.387016129265, 7861.213878612093, 8188.426810123234, 8817.426867253607, 8931.776705582412, 9008.324375671982, 10626.36241825493, 13006.349682516025, 13083.542076027294, 13156.342182891009, 13263.204207747565, 11560.30638161713, 11671.3580753056, 12029.4586743595, 12046.939765301116, 12093.455794489093, 11699.590514332298, 11780.70548236301, 11784.70538236551, 11784.882151178721, 11901.702457438634, 11701.239419437708, 11752.177347585586, 11771.47028383742, 12214.877851221729, 12236.388180591113, 8311.584420778816, 8366.748997530083, 8409.873851892104, 8567.0, 8570.914290857261, 11355.318680879174, 11491.655250342503, 11607.941960290145, 11710.70723231926, 11716.94141529321], "value": 9574.935512749727, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.4225596377503, 1550.1861522700585, 1591.3952697974769, 1777.7600023996756, 1877.7371168036477, 9094.954525227373, 9533.046695330471, 9540.570674319655, 9944.403335799858, 9963.252756043308, 9672.129508344247, 9867.506624668773, 9875.358101723401, 9884.456354900496, 9892.258080643962, 2172.283146561631, 2416.347586151738, 2474.740152284007, 2509.6110102933985, 2517.5216708825355, 2499.7000359956833, 2522.608995605675, 2523.74762523748, 2555.2334299710105, 2564.7050589182295, 2459.0901366494422, 2482.2801387597665, 2484.962725559118, 2492.8379655322437, 2494.725580186187, 2104.4107649858065, 2405.1581946318825, 2462.963055554168, 2463.963040554393, 2471.888765005579, 2425.369403954967, 2429.2955043037673, 2444.779969802726, 2475.8885850136785, 2477.1453848422266, 9449.480278584675, 9476.241900648001, 9486.051394860528, 9493.620255189784, 9517.5717092731, 5534.142207957773, 5659.717014149317, 5659.8585035374035, 5664.065429204176, 5664.801731939404, 3554.3424466473784, 3615.837287322077, 3643.234920666663, 3691.354013047706, 3706.684931780802, 1209.7822391969441, 1223.7368965672424, 1235.0983781839218, 1264.2477725753254, 1268.1313300389263, 13336.066475346632, 13727.725445491134, 14241.572752817328, 14250.429982800779, 14253.358598863077, 4895.388076490439, 4981.178105612606, 5008.12357837377, 5022.673526220784, 5085.982803439327, 11809.822852657217, 11809.88190118105, 11815.822762658567, 11818.586349477728, 11842.407879605986, 4993.6005119590345, 5659.688717120598, 5716.256886604798, 5722.656640601577, 5733.741981610838, 4560.95439045612, 4657.976710116428, 4705.741184234831, 5012.523810238022, 5069.847904562869, 4333.934990975138, 4338.457692788402, 4446.133004064176, 4465.0, 4479.776011199427, 1277.5145444730942, 1380.5720226729745, 1387.3548799808138, 1391.7842734376188, 1393.3312010235145, 1018.872640919885, 1019.5717798524637, 1020.9642662506776, 1026.707388394304, 1028.2596530498029, 6108.877822443526, 6112.908306375408, 6183.196184496077, 6218.502519798405, 6227.408396202353, 459.99080018399445, 462.8472604040659, 467.14978738695925, 470.6305550143121, 484.15998243048284, 3868.6711629511806, 3925.6074392560517, 3979.6219359161414, 3996.5803590623145, 4006.7395619284653, 11526.654200374001, 12252.75494490123, 12271.325077120844, 12346.320952347527, 12371.628851134481, 11872.88127118735, 12088.818667719992, 12210.938945305217, 12471.251724896536, 12524.561640342545, 8955.149260820212, 9064.909350906539, 9086.318526110568, 9108.089191080839, 9134.771630709285, 6084.14821924922, 6157.138000679998, 6158.445739883432, 6168.25980882297, 6218.036204388327, 11262.436878156223, 11272.549098035986, 11278.774424511299, 11337.26307789991, 11419.200655954004, 10764.838527421938, 11213.887861121611, 11216.046636036028, 11329.886701132884, 11669.183157178915, 7580.317771400601, 7712.383009359126, 7937.087234968052, 8669.436486628349, 8841.292696584387, 9178.954105229432, 9645.517724113626, 9646.276529260474, 9649.131578158, 9656.179224765974, 8293.33653307722, 8425.95787021061, 8438.240558349778, 8508.617112230088, 8719.956400217958, 8163.877541836996, 8409.789755256168, 8423.747287581382, 8570.700025499078, 8583.65665373378, 7428.442866785121, 7430.4798664093, 7584.54492730438, 7685.654145563575, 7686.538807671557, 5282.788688452572, 5328.333958255218, 5388.54197393226, 5417.0, 5467.480589344006, 5230.712310822789, 5252.080885844885, 5323.680579165262, 5457.754401052041, 5462.3445186577865], "value": 4891.802178723408, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.57769310287995, 348.31555992474784, 356.98793919238955, 357.50307073168284, 359.48414025872876, 5233.450487698794, 5357.0, 5367.490088441592, 5403.486668766466, 5432.0, 5283.6037297202765, 5293.655912365703, 5297.470252974701, 5310.6017048721305, 5339.813106541262, 3967.1668949520636, 3996.9800150999204, 4198.538160802309, 4218.11419601884, 4219.535851056381, 4138.668371960571, 4166.8749937501925, 4170.582941705836, 4170.874873753793, 4174.749515029092, 4106.07613287011, 4107.445494858186, 4133.297339452301, 4146.274401979656, 4170.72890262132, 3946.427767973628, 4061.97969010156, 4155.9817844628105, 4160.54234034256, 4177.874663760077, 3697.574778900407, 3698.260347930425, 3704.9259014819554, 3712.7401081924277, 3726.2920045191327, 5105.208692652608, 5107.3360463139925, 5117.33474648297, 5137.7944882204665, 5145.485451454862, 4709.175894218498, 4777.4267087949665, 4778.522147785228, 4782.641301902337, 4783.832565860213, 5490.917636235459, 5502.504774570308, 5538.9169162462595, 5539.446055394468, 5563.972180139073, 4088.366303223005, 4098.754074755524, 4104.56902025289, 4107.67138628909, 4142.399352093959, 5529.364123125852, 5716.971415142898, 5719.6854173020465, 5749.683767392792, 5805.854853628651, 4126.896827579335, 4154.729942553724, 4156.231097247019, 4164.209389962285, 4191.517975432865, 4258.5954334338185, 4262.680298977589, 4273.166732487197, 4274.572542745701, 4285.957140428618, 4578.198815207325, 4774.116788394089, 4804.927926081112, 4809.0, 4820.421549414023, 5466.453354664582, 5525.336959564878, 5528.253685752452, 5534.146061069587, 5544.0, 1428.6428392901776, 1446.3997441062052, 1469.941202351894, 1473.5652982370227, 1475.5057055886184, 908.3051465628799, 953.1612181280428, 962.6149540183842, 968.7820240445843, 978.5889926231, 5381.7578208980685, 5534.509470738184, 5535.25274087993, 5538.861528461821, 5541.251930989345, 5715.742791574389, 5731.971340143273, 5732.936142988521, 5739.938111449395, 5767.538596912237, 5306.734663266821, 5514.759179184652, 5514.889702206014, 5551.139573366135, 5588.776448941997, 3005.4590173768934, 3015.20097174249, 3030.9242268943012, 3050.5119180930947, 3077.1999280186865, 5832.970835145882, 5965.717370765306, 6025.740347369736, 6026.679728304634, 6039.456448919618, 5775.075987841925, 5775.133729940542, 5802.187693722883, 5805.0, 5810.82567522975, 5919.822405327847, 5945.970270148708, 5947.494462970523, 5950.761969521171, 6007.8197654070445, 5553.972230138985, 5620.353659329229, 5691.800786972436, 5726.255586773693, 5745.7988970387505, 5545.223668686306, 5579.497845193952, 5586.229295225788, 5595.804146855004, 5646.971765141148, 5760.452756988079, 5973.970130149321, 5988.401159883977, 5988.520918326436, 6040.365761595145, 4145.875623731293, 4158.355454904495, 4159.7121583128555, 4161.3978618231595, 4163.479565054368, 5660.830175094754, 5700.030994730822, 5706.572007099568, 5711.685857277889, 5776.913346299725, 5319.509858705178, 5545.3123672758775, 5574.665520068809, 5594.272744543184, 5603.579731520071, 5530.668159910419, 5542.140968149944, 5549.278593782782, 5564.1931919870585, 5565.248691426767, 5258.158694608997, 5311.336082989626, 5471.425500322409, 5495.477929596682, 5495.862603434786, 5590.791637303161, 5596.860078497907, 5612.158176273591, 5613.764971706218, 5632.155176723524, 5450.645708028966, 5491.643043202179, 5502.9174562380795, 5509.393966663744, 5527.8894422112135], "value": 4283.587031583685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.3355248696068, 832.2385017708793, 864.7232885476647, 884.5665623844314, 887.2369762004679, 16286.0, 16847.494575162735, 17002.319907203713, 17021.063841488714, 17027.148642567885, 15250.771238431433, 15273.38906443741, 15357.385704571832, 15381.769273460906, 15392.0, 707.049019069351, 719.7157122936437, 721.1454426504582, 722.6856317501877, 831.1024093978489, 831.846108469935, 831.8876951611516, 834.7620928035511, 834.9874751878726, 835.7868743470437, 886.6143227695941, 893.2318206342541, 894.2845723421269, 895.2211575928951, 895.5253715530779, 879.8064425826308, 889.5996801439313, 890.5858775669312, 890.9287257019423, 891.131147131548, 547.6960287040691, 640.2764875690486, 649.7076315657973, 651.2510612795276, 661.0579923608886, 15688.137152456611, 15732.606684832856, 15773.369065237377, 15785.131817750134, 15795.052296862224, 14617.70764584713, 15005.24973751319, 15203.391864325413, 15453.768193477106, 15562.0, 13109.737805243936, 13400.0, 13488.460461581524, 13575.660608484866, 13767.586972390844, 3993.4209539616595, 4641.164590373732, 4707.646926480527, 4749.62003039756, 4768.237082066853, 78145.21854781437, 79407.20592794057, 79520.60239698764, 80463.5976820118, 80884.19115808826, 10184.898151018395, 10283.0, 10751.247412681194, 11167.0, 11187.496562654538, 17577.80277465317, 17645.647087058187, 17679.38122165718, 17688.823111768976, 17710.291588336324, 8185.754427367069, 8469.872951905727, 8708.869366959501, 8753.06772231297, 8806.47161170319, 4754.096721622881, 4831.830885918976, 4897.657163998486, 4908.239222920453, 5002.674826136289, 3759.548854137466, 3986.7807270600397, 4014.5383280922483, 4058.350663893763, 4066.2274167908004, 742.0798210219289, 747.2602123897302, 748.1807420874134, 750.2272659161073, 759.0549765541825, 791.2483141016057, 805.2189376304975, 811.3955103447969, 811.4725428471422, 814.5357146426599, 10393.272470926962, 10895.182861285435, 10974.890251097546, 10985.945070274598, 11057.723556911142, 750.4634186556639, 793.686493834932, 803.1406395157126, 806.4032615864219, 814.9551774652332, 4882.145624515695, 4896.0, 4974.303597496353, 4993.875153121201, 5019.42276638184, 79297.20702793014, 80025.19974800294, 118975.0, 122192.0, 128929.35535322264, 107381.0, 111195.0, 111206.44396778126, 111507.0, 113301.433492832, 95039.0, 97405.0, 97519.0, 98695.0, 101744.49127754461, 9647.565859536197, 9763.85354219673, 9822.165115964937, 9826.919038905571, 9898.307118501636, 55282.0, 55329.723351382985, 56037.43962560322, 57353.0, 58166.41833581779, 75172.0, 81619.0, 82437.0, 82782.58608706918, 83044.0, 12249.632511024683, 12302.630921072383, 12312.322822244863, 12389.194702344319, 12431.254124752544, 13650.0, 13966.0, 14009.789853152415, 14290.35693393779, 14337.713245735236, 12804.807927881275, 13219.66950826237, 13235.338233088114, 13269.203847769164, 13293.0, 12868.485260589472, 12904.677383065498, 13208.141470804367, 13212.933935330262, 13279.269640169883, 12639.368031598568, 12833.935830320788, 12846.293453860128, 13011.739765204833, 13018.414171362501, 10420.270581059556, 10663.89336106629, 10729.088027517437, 10778.00860809321, 10824.729381765519, 10437.165026797686, 10649.414282214553, 10682.62610808618, 10754.462276886281, 10772.0], "value": 7827.71875828731, "unit": "score"}], "name": "dromaeo_css", "value": 7565.809104320482, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 110.0, 113.0, 109.0, 110.0, 109.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 130.0, 169.0, 128.0, 126.0, 158.0, 122.0, 162.0, 124.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 162.0, 161.0, 162.0, 159.0, 160.0, 158.0, 159.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 118.0, 76.0, 76.0, 75.0, 75.0, 99.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 113.0, 85.0, 84.0, 87.0, 114.0, 84.0, 85.0, 128.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 148.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 51.0, 52.0, 54.0, 52.0, 51.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 75.0, 75.0, 77.0, 78.0, 77.0, 76.0, 102.0, 77.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 118.0, 115.0, 130.0, 116.0, 121.0, 114.0, 123.0, 129.0, 122.0], "value": 121.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 154.0, 156.0, 153.0, 157.0, 156.0, 156.0, 159.0, 157.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 61.0, 61.0, 62.0, 60.0, 60.0, 61.0, 63.0, 60.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1473.3000000000002, "alertThreshold": 2.0}]} 02:06:48 INFO - Return code: 0 02:06:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:06:49 ERROR - # TBPL SUCCESS # 02:06:49 INFO - Running post-action listener: _resource_record_post_action 02:06:49 INFO - ##### 02:06:49 INFO - ##### Finished run-tests step (success) 02:06:49 INFO - ##### 02:06:49 INFO - Running post-run listener: _resource_record_post_run 02:06:49 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 294912; Write bytes: 255348736; Read time: 68; Write time: 196364 02:06:49 INFO - TinderboxPrint: CPU usage
13.0% 02:06:49 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 68 02:06:49 INFO - TinderboxPrint: I/O write bytes / time
255,348,736 / 196,364 02:06:49 INFO - TinderboxPrint: CPU idle
8,251.4 (86.9%) 02:06:49 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 02:06:49 INFO - TinderboxPrint: Swap in / out
0 / 0 02:06:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7434240; Read time: 0; Write time: 884 02:06:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 270336; Write bytes: 247914496; Read time: 56; Write time: 195480 02:06:49 INFO - Running post-run listener: _upload_blobber_files 02:06:49 INFO - Blob upload gear active. 02:06:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:06:49 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 02:06:49 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'] 02:06:49 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 02:06:50 INFO - (blobuploader) - INFO - Open directory for files ... 02:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:50 INFO - (blobuploader) - INFO - Done attempting. 02:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:56 INFO - (blobuploader) - INFO - Done attempting. 02:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:06 INFO - (blobuploader) - INFO - Done attempting. 02:07:06 INFO - (blobuploader) - INFO - Iteration through files over. 02:07:06 INFO - Return code: 0 02:07:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:07:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:07:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8726581ee58da9a7d7a6b44d5d2361eff22a8322aa0bad0ef1253a44985cc0bfd2de1f0b8fc2ff2d39a5a3ea48cde65559aadfa25185185e0d69a0f0e448cd75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e788e89d1e7b9a90613637c9444d18003c75180cd1e943a584b92e18886c77fc57c460ab01bba9946426e129b1d162714f32eba846045d8d603b3166a2fedb1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54b6b3d52dd41387e7d2f21699b706f015b5d04c6da4dea4518751fa38a2ffb0403de2b8850eb2095688ce80df7952ec8a26aacfcd50db3c360c4e9f266b16d2"} 02:07:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:07:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:07:06 INFO - Contents: 02:07:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8726581ee58da9a7d7a6b44d5d2361eff22a8322aa0bad0ef1253a44985cc0bfd2de1f0b8fc2ff2d39a5a3ea48cde65559aadfa25185185e0d69a0f0e448cd75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e788e89d1e7b9a90613637c9444d18003c75180cd1e943a584b92e18886c77fc57c460ab01bba9946426e129b1d162714f32eba846045d8d603b3166a2fedb1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54b6b3d52dd41387e7d2f21699b706f015b5d04c6da4dea4518751fa38a2ffb0403de2b8850eb2095688ce80df7952ec8a26aacfcd50db3c360c4e9f266b16d2"} 02:07:06 INFO - Running post-run listener: copy_logs_to_upload_dir 02:07:06 INFO - Copying logs to upload dir... 02:07:06 INFO - mkdir: /builds/slave/test/build/upload/logs 02:07:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.280998 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-22 02:07:06.690874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 02:07:06.694706) ========= 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=0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637 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/8726581ee58da9a7d7a6b44d5d2361eff22a8322aa0bad0ef1253a44985cc0bfd2de1f0b8fc2ff2d39a5a3ea48cde65559aadfa25185185e0d69a0f0e448cd75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e788e89d1e7b9a90613637c9444d18003c75180cd1e943a584b92e18886c77fc57c460ab01bba9946426e129b1d162714f32eba846045d8d603b3166a2fedb1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54b6b3d52dd41387e7d2f21699b706f015b5d04c6da4dea4518751fa38a2ffb0403de2b8850eb2095688ce80df7952ec8a26aacfcd50db3c360c4e9f266b16d2"} build_url:https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/BKv_ou7rRaiwZdfo7FVJOw/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/8726581ee58da9a7d7a6b44d5d2361eff22a8322aa0bad0ef1253a44985cc0bfd2de1f0b8fc2ff2d39a5a3ea48cde65559aadfa25185185e0d69a0f0e448cd75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e788e89d1e7b9a90613637c9444d18003c75180cd1e943a584b92e18886c77fc57c460ab01bba9946426e129b1d162714f32eba846045d8d603b3166a2fedb1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54b6b3d52dd41387e7d2f21699b706f015b5d04c6da4dea4518751fa38a2ffb0403de2b8850eb2095688ce80df7952ec8a26aacfcd50db3c360c4e9f266b16d2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 02:07:06.719415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 02:07:06.719700) ========= 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=0e2a256762fed810e2f0f810000001b3-1469175677.44539-1501643637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 02:07:06.805376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 02:07:06.805706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 02:07:06.805987) ========= ========= Total master_lag: 0.16 =========