builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1467874505.3 results: success (0) buildid: 20160706211421 builduid: 4a023f207eb44b7eb774067a8831ed6f revision: bf67cbd8360a4249d6bfa0d2c256ec4291e10fc3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.297741) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.298138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.298405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.327929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.328203) ========= 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=920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 23:55:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-06 23:55:05 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121668 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.467376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.467988) ========= 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=920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021134 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.519306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:05.519679) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf67cbd8360a4249d6bfa0d2c256ec4291e10fc3 --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 bf67cbd8360a4249d6bfa0d2c256ec4291e10fc3 --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=920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 23:55:05,753 truncating revision to first 12 chars 2016-07-06 23:55:05,753 Setting DEBUG logging. 2016-07-06 23:55:05,753 attempt 1/10 2016-07-06 23:55:05,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf67cbd8360a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 23:55:06,204 unpacking tar archive at: mozilla-aurora-bf67cbd8360a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.820378 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:06.360275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:06.360550) ========= script_repo_revision: bf67cbd8360a4249d6bfa0d2c256ec4291e10fc3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:06.360909) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:06.361202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 23:55:06.405992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-06 23:55:06.406728) ========= /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=920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:55:06 INFO - MultiFileLogger online at 20160706 23:55:06 in /builds/slave/test 23:55:06 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 23:55:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:55:06 INFO - {'append_to_log': False, 23:55:06 INFO - 'base_work_dir': '/builds/slave/test', 23:55:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:55:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:55:06 INFO - 'branch': 'Mozilla-Aurora', 23:55:06 INFO - 'buildbot_json_path': 'buildprops.json', 23:55:06 INFO - 'config_files': ('talos/linux_config.py',), 23:55:06 INFO - 'default_actions': ('clobber', 23:55:06 INFO - 'read-buildbot-config', 23:55:06 INFO - 'download-and-extract', 23:55:06 INFO - 'populate-webroot', 23:55:06 INFO - 'create-virtualenv', 23:55:06 INFO - 'install', 23:55:06 INFO - 'run-tests'), 23:55:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:55:06 INFO - 'download_minidump_stackwalk': True, 23:55:06 INFO - 'download_symbols': 'ondemand', 23:55:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:55:06 INFO - 'tooltool.py': '/tools/tooltool.py', 23:55:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:55:06 INFO - '/tools/misc-python/virtualenv.py')}, 23:55:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:55:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:55:06 INFO - 'installer_path': 'installer.exe', 23:55:06 INFO - 'log_level': 'info', 23:55:06 INFO - 'log_name': 'talos', 23:55:06 INFO - 'log_to_console': True, 23:55:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:55:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:55:06 INFO - 'opt_config_files': (), 23:55:06 INFO - 'pip_index': False, 23:55:06 INFO - 'sps_profile': False, 23:55:06 INFO - 'sps_profile_interval': 0, 23:55:06 INFO - 'suite': 'dromaeojs', 23:55:06 INFO - 'system_bits': '32', 23:55:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:55:06 INFO - 'title': 'talos-linux64-ix-053', 23:55:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:55:06 INFO - 'use_talos_json': True, 23:55:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:55:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:55:06 INFO - 'work_dir': 'build'} 23:55:06 INFO - ##### 23:55:06 INFO - ##### Running clobber step. 23:55:06 INFO - ##### 23:55:06 INFO - Running pre-action listener: _resource_record_pre_action 23:55:06 INFO - Running main action method: clobber 23:55:06 INFO - rmtree: /builds/slave/test/build 23:55:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:55:07 INFO - Running post-action listener: _resource_record_post_action 23:55:07 INFO - ##### 23:55:07 INFO - ##### Finished clobber step (success) 23:55:07 INFO - ##### 23:55:07 INFO - ##### 23:55:07 INFO - ##### Running read-buildbot-config step. 23:55:07 INFO - ##### 23:55:07 INFO - Running pre-action listener: _resource_record_pre_action 23:55:07 INFO - Running main action method: read_buildbot_config 23:55:07 INFO - Using buildbot properties: 23:55:07 INFO - { 23:55:07 INFO - "project": "", 23:55:07 INFO - "product": "firefox", 23:55:07 INFO - "script_repo_revision": "production", 23:55:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:55:07 INFO - "repository": "", 23:55:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:55:07 INFO - "buildid": "20160706211421", 23:55:07 INFO - "pgo_build": "True", 23:55:07 INFO - "basedir": "/builds/slave/test", 23:55:07 INFO - "buildnumber": 594, 23:55:07 INFO - "slavename": "talos-linux64-ix-053", 23:55:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:55:07 INFO - "platform": "ubuntu64_hw", 23:55:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:55:07 INFO - "branch": "mozilla-aurora", 23:55:07 INFO - "repo_path": "releases/mozilla-aurora", 23:55:07 INFO - "revision": "bf67cbd8360a4249d6bfa0d2c256ec4291e10fc3", 23:55:07 INFO - "stage_platform": "linux64-pgo", 23:55:07 INFO - "builduid": "4a023f207eb44b7eb774067a8831ed6f", 23:55:07 INFO - "slavebuilddir": "test" 23:55:07 INFO - } 23:55:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:55:07 INFO - Running post-action listener: _resource_record_post_action 23:55:07 INFO - ##### 23:55:07 INFO - ##### Finished read-buildbot-config step (success) 23:55:07 INFO - ##### 23:55:07 INFO - ##### 23:55:07 INFO - ##### Running download-and-extract step. 23:55:07 INFO - ##### 23:55:07 INFO - Running pre-action listener: _resource_record_pre_action 23:55:07 INFO - Running main action method: download_and_extract 23:55:07 INFO - mkdir: /builds/slave/test/build/tests 23:55:07 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')]} 23:55:07 INFO - https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:55:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:55:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:55:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:11 INFO - Downloaded 1361 bytes. 23:55:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:55:11 INFO - Using the following test package requirements: 23:55:11 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:55:11 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:55:11 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:55:11 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'jsshell-linux-x86_64.zip'], 23:55:11 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:55:11 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:55:11 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:55:11 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:55:11 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:55:11 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:55:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:55:11 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:11 INFO - https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:55:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:55:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:55:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:17 INFO - Downloaded 24526481 bytes. 23:55: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'] 23:55: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 23:55:19 INFO - Return code: 0 23:55:19 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 23:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:19 INFO - https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:55:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:55:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:55:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:28 INFO - Downloaded 24526481 bytes. 23:55:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:55:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:55:29 INFO - Return code: 0 23:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:29 INFO - https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:30 INFO - Downloaded 10833369 bytes. 23:55:30 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'] 23:55:30 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 23:55:31 INFO - Return code: 0 23:55:31 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')]} 23:55:31 INFO - https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:55:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:55:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:55:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GBAGl25dS0e-LFxcFgUQmw/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 23:55:34 INFO - Downloaded 63636050 bytes. 23:55:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:55:34 INFO - mkdir: /builds/slave/test/properties 23:55:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:55:34 INFO - Writing to file /builds/slave/test/properties/build_url 23:55:34 INFO - Contents: 23:55:34 INFO - build_url:https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:55:34 INFO - Running post-action listener: _resource_record_post_action 23:55:34 INFO - Running post-action listener: set_extra_try_arguments 23:55:34 INFO - ##### 23:55:34 INFO - ##### Finished download-and-extract step (success) 23:55:34 INFO - ##### 23:55:34 INFO - ##### 23:55:34 INFO - ##### Running populate-webroot step. 23:55:34 INFO - ##### 23:55:34 INFO - Running pre-action listener: _resource_record_pre_action 23:55:34 INFO - Running main action method: populate_webroot 23:55:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:55:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:55:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:55:34 INFO - '--tppagecycles', 23:55:34 INFO - '7'], 23:55:34 INFO - 'tests': ['tsvgm']}}, 23:55:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:55:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:55:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:55:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:55:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['damp', 'tps']}, 23:55:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'tests': ['damp', 'tps']}, 23:55:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['dromaeo_dom']}, 23:55:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:55:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['a11yr', 23:55:34 INFO - 'ts_paint', 23:55:34 INFO - 'tpaint', 23:55:34 INFO - 'sessionrestore', 23:55:34 INFO - 'sessionrestore_no_auto_restore', 23:55:34 INFO - 'tabpaint']}, 23:55:34 INFO - 'other-e10s': {'tests': ['a11yr', 23:55:34 INFO - 'ts_paint', 23:55:34 INFO - 'tpaint', 23:55:34 INFO - 'sessionrestore', 23:55:34 INFO - 'sessionrestore_no_auto_restore', 23:55:34 INFO - 'tabpaint']}, 23:55:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:55:34 INFO - 'ts_paint', 23:55:34 INFO - 'tpaint', 23:55:34 INFO - 'sessionrestore', 23:55:34 INFO - 'sessionrestore_no_auto_restore', 23:55:34 INFO - 'tabpaint']}, 23:55:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:55:34 INFO - 'ts_paint', 23:55:34 INFO - 'tpaint', 23:55:34 INFO - 'sessionrestore', 23:55:34 INFO - 'sessionrestore_no_auto_restore', 23:55:34 INFO - 'tabpaint']}, 23:55:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['a11yr', 23:55:34 INFO - 'ts_paint', 23:55:34 INFO - 'tpaint', 23:55:34 INFO - 'sessionrestore', 23:55:34 INFO - 'sessionrestore_no_auto_restore', 23:55:34 INFO - 'tabpaint']}, 23:55:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['a11yr', 23:55:34 INFO - 'ts_paint', 23:55:34 INFO - 'tpaint', 23:55:34 INFO - 'sessionrestore', 23:55:34 INFO - 'sessionrestore_no_auto_restore', 23:55:34 INFO - 'tabpaint']}, 23:55:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['tsvgx', 23:55:34 INFO - 'tsvgr_opacity', 23:55:34 INFO - 'tart', 23:55:34 INFO - 'tscrollx', 23:55:34 INFO - 'cart']}, 23:55:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:55:34 INFO - 'tsvgr_opacity', 23:55:34 INFO - 'tart', 23:55:34 INFO - 'tscrollx', 23:55:34 INFO - 'cart']}, 23:55:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'talos_options': ['--disable-e10s'], 23:55:34 INFO - 'tests': ['tp5o']}, 23:55:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'tests': ['tp5o']}, 23:55:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'talos_options': ['--disable-e10s', 23:55:34 INFO - '--xperf_path', 23:55:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:34 INFO - 'tests': ['tp5n']}, 23:55:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:34 INFO - 'talos_options': ['--xperf_path', 23:55:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:34 INFO - 'tests': ['tp5n']}}, 23:55:34 INFO - 'talos.zip': {'path': '', 23:55:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:55:34 INFO - Running post-action listener: _resource_record_post_action 23:55:34 INFO - ##### 23:55:34 INFO - ##### Finished populate-webroot step (success) 23:55:34 INFO - ##### 23:55:34 INFO - ##### 23:55:34 INFO - ##### Running create-virtualenv step. 23:55:34 INFO - ##### 23:55:34 INFO - Running pre-action listener: _resource_record_pre_action 23:55:34 INFO - Running main action method: create_virtualenv 23:55:34 INFO - Creating virtualenv /builds/slave/test/build/venv 23:55:34 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 23:55:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:55:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:55:34 INFO - Using real prefix '/usr' 23:55:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:55:35 INFO - Installing distribute.............................................................................................................................................................................................done. 23:55:37 INFO - Installing pip.................done. 23:55:37 INFO - Return code: 0 23:55:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:55:37 INFO - Using env: {'DISPLAY': ':0', 23:55:37 INFO - 'HOME': '/home/cltbld', 23:55:37 INFO - 'LANG': 'en_US.UTF-8', 23:55:37 INFO - 'LANGUAGE': 'en_US:en', 23:55:37 INFO - 'LOGNAME': 'cltbld', 23:55:37 INFO - 'MAIL': '/var/mail/cltbld', 23:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:37 INFO - 'MOZ_NO_REMOTE': '1', 23:55:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:37 INFO - 'NO_EM_RESTART': '1', 23:55:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:37 INFO - 'PWD': '/builds/slave/test', 23:55:37 INFO - 'SHELL': '/bin/bash', 23:55:37 INFO - 'SHLVL': '1', 23:55:37 INFO - 'TERM': 'linux', 23:55:37 INFO - 'TMOUT': '86400', 23:55:37 INFO - 'USER': 'cltbld', 23:55:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:37 INFO - '_': '/tools/buildbot/bin/python'} 23:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:37 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 23:55:37 INFO - Cleaning up... 23:55:37 INFO - Return code: 0 23:55:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:55:37 INFO - Using env: {'DISPLAY': ':0', 23:55:37 INFO - 'HOME': '/home/cltbld', 23:55:37 INFO - 'LANG': 'en_US.UTF-8', 23:55:37 INFO - 'LANGUAGE': 'en_US:en', 23:55:37 INFO - 'LOGNAME': 'cltbld', 23:55:37 INFO - 'MAIL': '/var/mail/cltbld', 23:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:37 INFO - 'MOZ_NO_REMOTE': '1', 23:55:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:37 INFO - 'NO_EM_RESTART': '1', 23:55:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:37 INFO - 'PWD': '/builds/slave/test', 23:55:37 INFO - 'SHELL': '/bin/bash', 23:55:37 INFO - 'SHLVL': '1', 23:55:37 INFO - 'TERM': 'linux', 23:55:37 INFO - 'TMOUT': '86400', 23:55:37 INFO - 'USER': 'cltbld', 23:55:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:37 INFO - '_': '/tools/buildbot/bin/python'} 23:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:37 INFO - Downloading/unpacking psutil>=3.1.1 23:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:55:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:39 INFO - Installing collected packages: psutil 23:55:39 INFO - Running setup.py install for psutil 23:55:39 INFO - building 'psutil._psutil_linux' extension 23:55:39 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 23:55:40 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 23:55:40 INFO - building 'psutil._psutil_posix' extension 23:55:40 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 23:55:40 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 23:55:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:40 INFO - Successfully installed psutil 23:55:40 INFO - Cleaning up... 23:55:40 INFO - Return code: 0 23:55:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:55:40 INFO - Using env: {'DISPLAY': ':0', 23:55:40 INFO - 'HOME': '/home/cltbld', 23:55:40 INFO - 'LANG': 'en_US.UTF-8', 23:55:40 INFO - 'LANGUAGE': 'en_US:en', 23:55:40 INFO - 'LOGNAME': 'cltbld', 23:55:40 INFO - 'MAIL': '/var/mail/cltbld', 23:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:40 INFO - 'MOZ_NO_REMOTE': '1', 23:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:40 INFO - 'NO_EM_RESTART': '1', 23:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:40 INFO - 'PWD': '/builds/slave/test', 23:55:40 INFO - 'SHELL': '/bin/bash', 23:55:40 INFO - 'SHLVL': '1', 23:55:40 INFO - 'TERM': 'linux', 23:55:40 INFO - 'TMOUT': '86400', 23:55:40 INFO - 'USER': 'cltbld', 23:55:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:40 INFO - '_': '/tools/buildbot/bin/python'} 23:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:55:42 INFO - Installing collected packages: mozsystemmonitor 23:55:42 INFO - Running setup.py install for mozsystemmonitor 23:55:42 INFO - Successfully installed mozsystemmonitor 23:55:42 INFO - Cleaning up... 23:55:42 INFO - Return code: 0 23:55:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:55:42 INFO - Using env: {'DISPLAY': ':0', 23:55:42 INFO - 'HOME': '/home/cltbld', 23:55:42 INFO - 'LANG': 'en_US.UTF-8', 23:55:42 INFO - 'LANGUAGE': 'en_US:en', 23:55:42 INFO - 'LOGNAME': 'cltbld', 23:55:42 INFO - 'MAIL': '/var/mail/cltbld', 23:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:42 INFO - 'MOZ_NO_REMOTE': '1', 23:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:42 INFO - 'NO_EM_RESTART': '1', 23:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:42 INFO - 'PWD': '/builds/slave/test', 23:55:42 INFO - 'SHELL': '/bin/bash', 23:55:42 INFO - 'SHLVL': '1', 23:55:42 INFO - 'TERM': 'linux', 23:55:42 INFO - 'TMOUT': '86400', 23:55:42 INFO - 'USER': 'cltbld', 23:55:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:42 INFO - '_': '/tools/buildbot/bin/python'} 23:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:42 INFO - Downloading/unpacking jsonschema==2.5.1 23:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:55:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:45 INFO - Downloading functools32-3.2.3-2.tar.gz 23:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:55:45 INFO - warning: no files found matching '*.txt' 23:55:45 INFO - no previously-included directories found matching 'build' 23:55:45 INFO - no previously-included directories found matching 'dist' 23:55:45 INFO - no previously-included directories found matching '.git*' 23:55:45 INFO - Installing collected packages: jsonschema, functools32 23:55:45 INFO - Running setup.py install for functools32 23:55:45 INFO - warning: no files found matching '*.txt' 23:55:45 INFO - no previously-included directories found matching 'build' 23:55:45 INFO - no previously-included directories found matching 'dist' 23:55:45 INFO - no previously-included directories found matching '.git*' 23:55:45 INFO - Successfully installed jsonschema functools32 23:55:45 INFO - Cleaning up... 23:55:45 INFO - Return code: 0 23:55:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:45 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 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:45 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 23:55:45 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 23:55:45 INFO - Using env: {'DISPLAY': ':0', 23:55:45 INFO - 'HOME': '/home/cltbld', 23:55:45 INFO - 'LANG': 'en_US.UTF-8', 23:55:45 INFO - 'LANGUAGE': 'en_US:en', 23:55:45 INFO - 'LOGNAME': 'cltbld', 23:55:45 INFO - 'MAIL': '/var/mail/cltbld', 23:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:45 INFO - 'MOZ_NO_REMOTE': '1', 23:55:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:45 INFO - 'NO_EM_RESTART': '1', 23:55:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:45 INFO - 'PWD': '/builds/slave/test', 23:55:45 INFO - 'SHELL': '/bin/bash', 23:55:45 INFO - 'SHLVL': '1', 23:55:45 INFO - 'TERM': 'linux', 23:55:45 INFO - 'TMOUT': '86400', 23:55:45 INFO - 'USER': 'cltbld', 23:55:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:45 INFO - '_': '/tools/buildbot/bin/python'} 23:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:45 INFO - Downloading/unpacking blobuploader==1.2.4 23:55:45 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 23:55:45 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 23:55:45 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 23:55:45 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 23:55:45 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 23:55:45 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 23:55:47 INFO - Downloading blobuploader-1.2.4.tar.gz 23:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:55:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:55:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:48 INFO - Downloading docopt-0.6.1.tar.gz 23:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:55:48 INFO - Installing collected packages: blobuploader, requests, docopt 23:55:48 INFO - Running setup.py install for blobuploader 23:55:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:55:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:55:48 INFO - Running setup.py install for requests 23:55:48 INFO - Running setup.py install for docopt 23:55:48 INFO - Successfully installed blobuploader requests docopt 23:55:48 INFO - Cleaning up... 23:55:48 INFO - Return code: 0 23:55:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:55:48 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')]} 23:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:48 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')]} 23:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:48 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 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:48 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 23:55:48 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 23:55:48 INFO - Using env: {'DISPLAY': ':0', 23:55:48 INFO - 'HOME': '/home/cltbld', 23:55:48 INFO - 'LANG': 'en_US.UTF-8', 23:55:48 INFO - 'LANGUAGE': 'en_US:en', 23:55:48 INFO - 'LOGNAME': 'cltbld', 23:55:48 INFO - 'MAIL': '/var/mail/cltbld', 23:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:48 INFO - 'MOZ_NO_REMOTE': '1', 23:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:48 INFO - 'NO_EM_RESTART': '1', 23:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:48 INFO - 'PWD': '/builds/slave/test', 23:55:48 INFO - 'SHELL': '/bin/bash', 23:55:48 INFO - 'SHLVL': '1', 23:55:48 INFO - 'TERM': 'linux', 23:55:48 INFO - 'TMOUT': '86400', 23:55:48 INFO - 'USER': 'cltbld', 23:55:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:48 INFO - '_': '/tools/buildbot/bin/python'} 23:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:55:49 INFO - Running setup.py (path:/tmp/pip-AdldtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:55:49 INFO - Running setup.py (path:/tmp/pip-Eb_VZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:55:49 INFO - Running setup.py (path:/tmp/pip-bddBJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:55:49 INFO - Running setup.py (path:/tmp/pip-STqORd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:55:49 INFO - Running setup.py (path:/tmp/pip-zxlsUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:55:49 INFO - Running setup.py (path:/tmp/pip-GY1uqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:55:49 INFO - Running setup.py (path:/tmp/pip-90S1Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:55:49 INFO - Running setup.py (path:/tmp/pip-N7P7BP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:55:49 INFO - Running setup.py (path:/tmp/pip-6JBELF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:55:49 INFO - Running setup.py (path:/tmp/pip-kTBaC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:55:49 INFO - Running setup.py (path:/tmp/pip-_Hr3hL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:55:49 INFO - Running setup.py (path:/tmp/pip-EWNmh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:55:49 INFO - Running setup.py (path:/tmp/pip-hhd64E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:55:50 INFO - Running setup.py (path:/tmp/pip-U7nvzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:50 INFO - Running setup.py (path:/tmp/pip-FocNpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:55:50 INFO - Running setup.py (path:/tmp/pip-W2qjx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:55:50 INFO - Running setup.py (path:/tmp/pip-Q6Lior-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:55:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:55:50 INFO - Running setup.py install for manifestparser 23:55:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:55:50 INFO - Running setup.py install for mozcrash 23:55:50 INFO - Running setup.py install for mozdebug 23:55:50 INFO - Running setup.py install for mozdevice 23:55:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:55:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:55:50 INFO - Running setup.py install for mozfile 23:55:50 INFO - Running setup.py install for mozhttpd 23:55:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:55:50 INFO - Running setup.py install for mozinfo 23:55:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:55:50 INFO - Running setup.py install for mozInstall 23:55:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Running setup.py install for mozleak 23:55:51 INFO - Running setup.py install for mozlog 23:55:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Running setup.py install for moznetwork 23:55:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Running setup.py install for mozprocess 23:55:51 INFO - Running setup.py install for mozprofile 23:55:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Running setup.py install for mozrunner 23:55:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:55:51 INFO - Running setup.py install for mozscreenshot 23:55:51 INFO - Running setup.py install for moztest 23:55:51 INFO - Running setup.py install for mozversion 23:55:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:55:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:55:52 INFO - Cleaning up... 23:55:52 INFO - Return code: 0 23:55:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:55:52 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')]} 23:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:52 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')]} 23:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:52 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 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:52 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 23:55:52 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 23:55:52 INFO - Using env: {'DISPLAY': ':0', 23:55:52 INFO - 'HOME': '/home/cltbld', 23:55:52 INFO - 'LANG': 'en_US.UTF-8', 23:55:52 INFO - 'LANGUAGE': 'en_US:en', 23:55:52 INFO - 'LOGNAME': 'cltbld', 23:55:52 INFO - 'MAIL': '/var/mail/cltbld', 23:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:52 INFO - 'MOZ_NO_REMOTE': '1', 23:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:52 INFO - 'NO_EM_RESTART': '1', 23:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:52 INFO - 'PWD': '/builds/slave/test', 23:55:52 INFO - 'SHELL': '/bin/bash', 23:55:52 INFO - 'SHLVL': '1', 23:55:52 INFO - 'TERM': 'linux', 23:55:52 INFO - 'TMOUT': '86400', 23:55:52 INFO - 'USER': 'cltbld', 23:55:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:52 INFO - '_': '/tools/buildbot/bin/python'} 23:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:55:52 INFO - Running setup.py (path:/tmp/pip-1eVW5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:55:52 INFO - Running setup.py (path:/tmp/pip-elG3_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:55:52 INFO - Running setup.py (path:/tmp/pip-ZJy5yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:55:52 INFO - Running setup.py (path:/tmp/pip-jb3NJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:55:52 INFO - Running setup.py (path:/tmp/pip-AxAUju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:55:52 INFO - Running setup.py (path:/tmp/pip-SBA6mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:55:52 INFO - Running setup.py (path:/tmp/pip-y3mkVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:55:52 INFO - Running setup.py (path:/tmp/pip-NF78OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:55:52 INFO - Running setup.py (path:/tmp/pip-47iMbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:55:52 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)) 23:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:55:52 INFO - Running setup.py (path:/tmp/pip-34_P9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:55:53 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)) 23:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:55:53 INFO - Running setup.py (path:/tmp/pip-79vXwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:55:53 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)) 23:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:55:53 INFO - Running setup.py (path:/tmp/pip-Lsjie3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:55:53 INFO - Running setup.py (path:/tmp/pip-0Y5Nvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:55:53 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)) 23:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:55:53 INFO - Running setup.py (path:/tmp/pip-5srNve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:53 INFO - Running setup.py (path:/tmp/pip-tKHgx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:53 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)) 23:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:55:53 INFO - Running setup.py (path:/tmp/pip-i1Lfeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:55:53 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)) 23:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:55:53 INFO - Running setup.py (path:/tmp/pip-6EnSjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:55:53 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)) 23:55:53 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)) 23:55:53 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)) 23:55:53 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)) 23:55:53 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)) 23:55:53 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)) 23:55:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:55 INFO - Downloading blessings-1.6.tar.gz 23:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:55:55 INFO - Installing collected packages: blessings 23:55:55 INFO - Running setup.py install for blessings 23:55:55 INFO - Successfully installed blessings 23:55:55 INFO - Cleaning up... 23:55:55 INFO - Return code: 0 23:55:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:55:55 INFO - Reading from file tmpfile_stdout 23:55:55 INFO - Current package versions: 23:55:55 INFO - argparse == 1.2.1 23:55:55 INFO - blessings == 1.6 23:55:55 INFO - blobuploader == 1.2.4 23:55:55 INFO - docopt == 0.6.1 23:55:55 INFO - functools32 == 3.2.3-2 23:55:55 INFO - jsonschema == 2.5.1 23:55:55 INFO - manifestparser == 1.1 23:55:55 INFO - mozInstall == 1.12 23:55:55 INFO - mozcrash == 0.17 23:55:55 INFO - mozdebug == 0.1 23:55:55 INFO - mozdevice == 0.48 23:55:55 INFO - mozfile == 1.2 23:55:55 INFO - mozhttpd == 0.7 23:55:55 INFO - mozinfo == 0.9 23:55:55 INFO - mozleak == 0.1 23:55:55 INFO - mozlog == 3.2 23:55:55 INFO - moznetwork == 0.27 23:55:55 INFO - mozprocess == 0.22 23:55:55 INFO - mozprofile == 0.28 23:55:55 INFO - mozrunner == 6.11 23:55:55 INFO - mozscreenshot == 0.1 23:55:55 INFO - mozsystemmonitor == 0.3 23:55:55 INFO - moztest == 0.7 23:55:55 INFO - mozversion == 1.4 23:55:55 INFO - psutil == 3.1.1 23:55:55 INFO - requests == 1.2.3 23:55:55 INFO - wsgiref == 0.1.2 23:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:55: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')]} 23:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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')]} 23:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55: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 23:55: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 23:55:55 INFO - Using env: {'DISPLAY': ':0', 23:55:55 INFO - 'HOME': '/home/cltbld', 23:55:55 INFO - 'LANG': 'en_US.UTF-8', 23:55:55 INFO - 'LANGUAGE': 'en_US:en', 23:55:55 INFO - 'LOGNAME': 'cltbld', 23:55:55 INFO - 'MAIL': '/var/mail/cltbld', 23:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:55 INFO - 'MOZ_NO_REMOTE': '1', 23:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:55 INFO - 'NO_EM_RESTART': '1', 23:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:55 INFO - 'PWD': '/builds/slave/test', 23:55:55 INFO - 'SHELL': '/bin/bash', 23:55:55 INFO - 'SHLVL': '1', 23:55:55 INFO - 'TERM': 'linux', 23:55:55 INFO - 'TMOUT': '86400', 23:55:55 INFO - 'USER': 'cltbld', 23:55:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:55 INFO - '_': '/tools/buildbot/bin/python'} 23:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 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)) 23:55:56 INFO - Cleaning up... 23:55:56 INFO - Return code: 0 23:55:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:55: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')]} 23:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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')]} 23:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:55:56 INFO - Using env: {'DISPLAY': ':0', 23:55:56 INFO - 'HOME': '/home/cltbld', 23:55:56 INFO - 'LANG': 'en_US.UTF-8', 23:55:56 INFO - 'LANGUAGE': 'en_US:en', 23:55:56 INFO - 'LOGNAME': 'cltbld', 23:55:56 INFO - 'MAIL': '/var/mail/cltbld', 23:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:56 INFO - 'MOZ_NO_REMOTE': '1', 23:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:56 INFO - 'NO_EM_RESTART': '1', 23:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:56 INFO - 'PWD': '/builds/slave/test', 23:55:56 INFO - 'SHELL': '/bin/bash', 23:55:56 INFO - 'SHLVL': '1', 23:55:56 INFO - 'TERM': 'linux', 23:55:56 INFO - 'TMOUT': '86400', 23:55:56 INFO - 'USER': 'cltbld', 23:55:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:56 INFO - '_': '/tools/buildbot/bin/python'} 23:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:55:56 INFO - Cleaning up... 23:55:56 INFO - Return code: 0 23:55:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:55: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')]} 23:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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')]} 23:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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 0x7f4330ae5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1954020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, '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': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', '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 23:55: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 23:55: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 23:55:56 INFO - Using env: {'DISPLAY': ':0', 23:55:56 INFO - 'HOME': '/home/cltbld', 23:55:56 INFO - 'LANG': 'en_US.UTF-8', 23:55:56 INFO - 'LANGUAGE': 'en_US:en', 23:55:56 INFO - 'LOGNAME': 'cltbld', 23:55:56 INFO - 'MAIL': '/var/mail/cltbld', 23:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:56 INFO - 'MOZ_NO_REMOTE': '1', 23:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:56 INFO - 'NO_EM_RESTART': '1', 23:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:56 INFO - 'PWD': '/builds/slave/test', 23:55:56 INFO - 'SHELL': '/bin/bash', 23:55:56 INFO - 'SHLVL': '1', 23:55:56 INFO - 'TERM': 'linux', 23:55:56 INFO - 'TMOUT': '86400', 23:55:56 INFO - 'USER': 'cltbld', 23:55:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:56 INFO - '_': '/tools/buildbot/bin/python'} 23:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:56 INFO - Downloading/unpacking flake8 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:55:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:55:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55: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 23:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:55:59 INFO - no previously-included directories found matching 'docs/_build' 23:55:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:55:59 INFO - Running setup.py install for pep8 23:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:55:59 INFO - no previously-included directories found matching 'docs/_build' 23:55:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:55:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:55:59 INFO - Cleaning up... 23:55:59 INFO - Return code: 0 23:55:59 INFO - Running post-action listener: _resource_record_post_action 23:55:59 INFO - Running post-action listener: _start_resource_monitoring 23:55:59 INFO - Starting resource monitoring. 23:55:59 INFO - ##### 23:55:59 INFO - ##### Finished create-virtualenv step (success) 23:55:59 INFO - ##### 23:55:59 INFO - ##### 23:55:59 INFO - ##### Running install step. 23:55:59 INFO - ##### 23:55:59 INFO - Running pre-action listener: _resource_record_pre_action 23:55:59 INFO - Running main action method: install 23:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:55:59 INFO - Reading from file tmpfile_stdout 23:55:59 INFO - Detecting whether we're running mozinstall >=1.0... 23:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:55:59 INFO - Reading from file tmpfile_stdout 23:55:59 INFO - Output received: 23:55:59 INFO - Usage: mozinstall [options] installer 23:55:59 INFO - Options: 23:55:59 INFO - -h, --help show this help message and exit 23:55:59 INFO - -d DEST, --destination=DEST 23:55:59 INFO - Directory to install application into. [default: 23:55:59 INFO - "/builds/slave/test"] 23:55:59 INFO - --app=APP Application being installed. [default: firefox] 23:55:59 INFO - mkdir: /builds/slave/test/build/application 23:55: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'] 23:55: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 23:56:15 INFO - Reading from file tmpfile_stdout 23:56:15 INFO - Output received: 23:56:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:56:15 INFO - Running post-action listener: _resource_record_post_action 23:56:15 INFO - ##### 23:56:15 INFO - ##### Finished install step (success) 23:56:15 INFO - ##### 23:56:15 INFO - ##### 23:56:15 INFO - ##### Running run-tests step. 23:56:15 INFO - ##### 23:56:15 INFO - Running pre-action listener: _resource_record_pre_action 23:56:15 INFO - Running main action method: run_tests 23:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:56:15 INFO - Python 2.7.3 23:56:15 INFO - Return code: 0 23:56:15 INFO - grabbing minidump binary from tooltool 23:56: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')]} 23:56: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 0x19e62e0>, '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 0x1952140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19525d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:56: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 23:56: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 23:56: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 23:56:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:56:15 INFO - Return code: 0 23:56:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:56:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:56:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:56:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:56:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:56:16 INFO - Return code: 0 23:56: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/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 23:56: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/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 23:56:16 INFO - Using env: {'DISPLAY': ':0', 23:56:16 INFO - 'HOME': '/home/cltbld', 23:56:16 INFO - 'LANG': 'en_US.UTF-8', 23:56:16 INFO - 'LANGUAGE': 'en_US:en', 23:56:16 INFO - 'LOGNAME': 'cltbld', 23:56:16 INFO - 'MAIL': '/var/mail/cltbld', 23:56:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:56:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:56:16 INFO - 'MOZ_NO_REMOTE': '1', 23:56:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:56:16 INFO - 'NO_EM_RESTART': '1', 23:56:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:56:16 INFO - 'PWD': '/builds/slave/test', 23:56:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:56:16 INFO - 'SHELL': '/bin/bash', 23:56:16 INFO - 'SHLVL': '1', 23:56:16 INFO - 'TERM': 'linux', 23:56:16 INFO - 'TMOUT': '86400', 23:56:16 INFO - 'USER': 'cltbld', 23:56:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554', 23:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:56:16 INFO - '_': '/tools/buildbot/bin/python'} 23:56: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/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 23:56:16 INFO - mozversion application_buildid: 20160706211421 23:56:16 INFO - mozversion application_changeset: bf67cbd8360a4249d6bfa0d2c256ec4291e10fc3 23:56:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:56:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:56:16 INFO - mozversion application_name: Firefox 23:56:16 INFO - mozversion application_remotingname: firefox-dev 23:56:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:56:16 INFO - mozversion application_vendor: Mozilla 23:56:16 INFO - mozversion application_version: 49.0a2 23:56:16 INFO - mozversion platform_buildid: 20160706211421 23:56:16 INFO - mozversion platform_changeset: bf67cbd8360a4249d6bfa0d2c256ec4291e10fc3 23:56:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:56:16 INFO - mozversion platform_version: 49.0a2 23:56:16 INFO - using testdate: 1467874576 23:56:16 INFO - actual date: 1467874576 23:56:16 INFO - starting webserver on 'localhost:47034' 23:56:16 INFO - SUITE-START | Running 2 tests 23:56:16 INFO - TEST-START | dromaeo_css 23:56:16 INFO - operating with platform_type : linux_ 23:56:16 INFO - Initialising browser for dromaeo_css test... 23:56:16 INFO - TEST-INFO | started process 10078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqnXiT9/profile http://localhost:47034/getInfo.html) 23:56:20 INFO - PROCESS | 10078 | __metrics Screen width/height:1600/1200 23:56:20 INFO - PROCESS | 10078 | colorDepth:24 23:56:20 INFO - PROCESS | 10078 | Browser inner width/height: 1024/697 23:56:20 INFO - PROCESS | 10078 | __metrics 23:56:22 ERROR - PROCESS | 10078 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:56:23 INFO - TEST-INFO | 10078: exit 0 23:56:23 INFO - Browser initialized. 23:56:23 INFO - Running cycle 1/1 for dromaeo_css test... 23:56:23 INFO - TEST-INFO | started process 10171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqnXiT9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:56:34 INFO - PROCESS | 10171 | RSS: Main: 149274624 23:56:34 INFO - PROCESS | 10171 | 23:57:26 INFO - PROCESS | 10171 | 1467874646049 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] 23:59:34 INFO - PROCESS | 10171 | Cycle 1(1): loaded http://localhost:47034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47034/tests/dromaeo/cssquery-ext.html) 23:59:35 INFO - PROCESS | 10171 | RSS: Main: 252878848 23:59:35 INFO - PROCESS | 10171 | 00:02:37 INFO - PROCESS | 10171 | Cycle 1(1): loaded http://localhost:47034/tests/dromaeo/cssquery-ext.html (next: http://localhost:47034/tests/dromaeo/cssquery-jquery.html) 00:02:38 INFO - PROCESS | 10171 | RSS: Main: 229150720 00:02:38 INFO - PROCESS | 10171 | 00:05:40 INFO - PROCESS | 10171 | Cycle 1(1): loaded http://localhost:47034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47034/tests/dromaeo/cssquery-mootools.html) 00:05:40 INFO - PROCESS | 10171 | RSS: Main: 228163584 00:05:40 INFO - PROCESS | 10171 | 00:08:42 INFO - PROCESS | 10171 | Cycle 1(1): loaded http://localhost:47034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47034/tests/dromaeo/cssquery-prototype.html) 00:08:43 INFO - PROCESS | 10171 | RSS: Main: 232366080 00:08:43 INFO - PROCESS | 10171 | 00:11:45 INFO - PROCESS | 10171 | Cycle 1(1): loaded http://localhost:47034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47034/tests/dromaeo/cssquery-yui.html) 00:11:46 INFO - PROCESS | 10171 | RSS: Main: 216969216 00:11:46 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | Cycle 1(1): loaded http://localhost:47034/tests/dromaeo/cssquery-yui.html (next: http://localhost:47034/tests/dromaeo/cssquery-dojo.html) 00:14:48 INFO - PROCESS | 10171 | RSS: Main: 238739456 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | __start_tp_report 00:14:48 INFO - PROCESS | 10171 | _x_x_mozilla_page_load 00:14:48 INFO - PROCESS | 10171 | _x_x_mozilla_page_load_details 00:14:48 INFO - PROCESS | 10171 | |i|pagename|runs| 00:14:48 INFO - PROCESS | 10171 | |0;dojo.html;3306.718928891044;3325.1188435064696;3330.666933306669;3341.799492030477;3367.579052618423;5304.522592966632;5388.865278368043;5399.7030163341;5405.18922161676;5415.864603384913;5361.51746342829;5398.379186393566;5430.647007944481;5434.429384914576;5447.319085114361;4839.298301746245;4903.092927808358;4929.630277729167;4962.0324036812835;5038.546530812227;4826.203676393391;4949.529794669518;4988.326575912241;4992.67547609406;4995.250712393134;4839.05638400512;4866.562009419152;4890.706557606555;4894.657373983805;4988.6009119270375;4960.70235785854;4972.453030166715;4973.030259099459;4984;4991.376077990251;4833.154198015333;4846.636502262344;4881.365422495089;4905.166121759309;4916;5249.527542521191;5261.053010458116;5274.947250527484;5313.574914006909;5315.840524784263;5715.114157305624;5829.88340233193;5830.970845145789;5831.300243970751;5836.270466191726;5688.232088668018;5749.913751293734;5757.625754325997;5774.797882074107;5847.590668653153;5438.347398312228;5439.646422982493;5448.891022179574;5471.37079235885;5475.178723191513;5725.627834190765;5932.021216499315;5938.584299099021;5944.108383742387;5946.10808378738;5577.525910297589;5619.8595035123635;5633.887322253532;5684.34630017545;5708.800191993343;5769.07694768835;5777.277840269966;5777.422257774273;5796.594238403271;5805.216295800013;5602.355729091125;5664.745086471119;5743.195952566561;5749.511291540182;5759.2512973313205;5683.658980461186;5790.189373487715;5801.245838041028;5803.100519419497;5834.533237341003;4491.663125265618;4497.707649002804;4500.482444518857;4502.594766471033;4525.977370113128;3899.66852817508;3903.7072219583647;3923.92152156961;4038.697097717683;4075.551689314173;5394.190871369326;5412.161115027177;5417.8103766367985;5427.620066595379;5438.945610543923;5700.486956173964;5710.7430165642645;5711.7144142792695;5713.885722285531;5740.741666625012;5283.762230699628;5373.489518495737;5408.0535906216255;5411.296531450965;5509.3664228614225;4969.428515720666;4975.303457515951;4978.228374601942;5017.9247311290355;5038.294638750504;6066.272047354346;6078.422549857756;6081.57428979976;6085.148079268817;6116;5633.549316054788;5720.456556627114;5738.684372359393;5753.395893431297;5868.882622347443;6085.756569737161;6093.786717464867;6097.75608975636;6098.146259523759;6110;5753;5761.827145185651;5766.5675074368755;5767.798127065533;5768.625039372428;5622.690752008679;5658.801941932013;5723.484886360081;5736.512396446349;5784.4504772046585;5614.045612245846;5623.465770751772;5623.550115990793;5625.128105143709;5627.718614069198;5440.7551660174595;5606.6916319602815;5617.382087970402;5618.073017951992;5621;5494.5054945055135;5560.443955604569;5565.9721701392855;5617.354004289559;5627.662340259598;5685.658860468385;5693.202951586698;5699.971500142473;5721.1990321354215;5740.368559458373;5398.352197736297;5462.808801691922;5573.916391254215;5583.804566840141;5599.664020158803 00:14:48 INFO - PROCESS | 10171 | |1;ext.html;610.8503416662916;631.3654776949163;638.0875348251998;647.2330288608;658.5850913924229;30942.690573094264;45177;46078.769606152004;46090.999999999956;46168.3074753879;48071.759641201745;48667;48748.26877596839;48793;48807;7775.650095745705;7926.8810967835525;7934.3652507799525;9052.1853033227;9218.723438296862;8204.466709663882;10389.32469389491;10615.150787936947;10669.413182274971;10934.398608076554;11031.669049928514;11046.779064418706;11091.72270693235;11107.944460277728;11109.888901111006;8161.95919020407;10923.617673381474;11008.064314533274;11065.225434219568;11092.057175140122;10690.091342235919;10763.13894888407;10996.560137594566;11087.667369978833;11105.222634415593;44659.776701116614;44965;45009.09981800346;45277.32084018742;45330;3704.907377315562;3802.657760801541;3863;3923.8430462781453;4399.38408622793;34808.6519134808;35530.46704299437;35745.28509429797;35797.28405431877;35846.46230306548;4667.6265898728025;4731.33761273422;4751.691140075884;4791.928121078186;4861.975690121562;378173;378737;379888.99999999726;381375;392013;70405.64797176083;71229.28770712331;71256;71307;71330.2866971334;40454.79772601118;41439;41526.584734152275;42907.570924290354;43026.569734302255;16428.83571164297;16443.67112657764;16546;16552;16556.6688666226;10430.843537346946;12901.354932253349;12919.095663303478;13018.869811301765;13160.473581056842;22092.779072209392;22135.225267115897;22252.221172258895;22331.330060098222;22424.887875560846;7660.846783064308;8136.1863813618165;8167.918320816834;8252.119226139022;8362.58187090643;1033.509083185496;1123.2081382625229;1132.11683924141;1143.7883991461606;1176.688177632928;34446.311073778386;34809.47785783215;35056.649433505845;35247.118822029144;35451;1158.9942050289862;1215.7811593913004;1236.4621389695512;1236.993815030919;1285.440833237526;18149.455516334532;18342.816571834377;18344.724829127576;18485.168167432497;18506.352277670216;538776;545567;545979;546487;547663;63966;64091.679541601996;64621.67689161618;64695.35304646987;64696.353036469976;1087.0434018064052;1183.4260383713893;1439.8632129947848;1454.5854431486975;1478.5638236719979;34293.48559771555;35303.823480882435;35621.82189089038;35899.82050089733;35921;54454;55223.44776552183;55248.72375638096;55249.17126243029;55299.723501382236;389007;398056;398146;398887;399156;25329.49341013206;30552.388952221274;31138;31494.212644684067;31494.527582086746;51503;51807.481925181775;52005.219921700445;52684;53133.734331329644;42984;43612;43657;43785.56214437815;44906;43636.12727745491;43892.56107438885;43973.78013109914;44393.778031109636;45556.544434556556;43526.34710479282;43787.78106109449;44726.77636611796;45026.77486612546;45377.09245814999;37937.24125517419;38709;38737.78007617877;38767;39006.80496597499;29473.263168420963;29612;29830.8508457465;29955.251118722208;30084 00:14:48 INFO - PROCESS | 10171 | |2;jquery.html;406.16127696307143;410.68582534361235;415.652929803614;415.8710799652108;438.7718386439052;18516.537086572844;19720.408387748354;20333;20379.796202037975;20638.071286792092;13092.345382730873;13104.213747175152;13148.868511314908;13209.669758256025;13445.66385840352;5117.462666420019;5263.210518422248;5312.73436328184;5344.305240318772;5403.675779453226;3959.5050618672667;5712.257406537145;6006.189164462807;6013.308469525995;6076.422739839731;6042.274927008765;6052.122442245894;6072.058830881198;6081.6351018939;6112.327643959161;6014.488768454687;6111.480524155474;6123.448889599935;6129.938700613004;6137.60105593135;5781.017227071408;5939.554533410012;5955.047192449188;6031.547633927473;6042.365551617105;15190.468333608382;15309.234538273153;15409.768853467207;21191.364259072252;24367.14714984967;2397.520495900827;2538.695356557225;2624.3176774038698;2795.3989892173076;2988.835614041227;10538.20963427746;10560.102391296672;10775.676729698122;10888.020078193;11183.32900026001;1944.9902750486299;2026.6858636911154;2030.5634288627869;2053.650879350514;2055.393658870637;83744.99999999939;83800;85916.57041714751;86045.56977215137;88384.5580772092;11668.591599294154;11825.704357390961;11968.700782480508;11997.460114294878;12048.759024819454;16800.83199168017;16966.49100526986;16972.151392430576;16993.830061699224;16995.23521441538;8520.446170998865;8558.400911936229;8667.783305417415;8701.825963480822;8792.109696415302;8209.055958564722;8217.753467395987;8386;8491.363147763943;8580.828383432421;5091.159958606862;5110.616703747234;5124.077666020152;5170.741462926839;5282.735863206824;1748.0309727160984;1999.5401057756796;2073.170731707299;2084.48930012148;2131.1901477438473;970.126885802769;993.2203220472039;1008.349614498659;1020.3929110594163;1087.1791797193068;18996.335128270443;19052.80947190538;19294.90352548228;19335.12991915367;19407.417777466697;1059.057438879398;1061.2836335473523;1089.3355053417408;1090.51472094917;1096.270979798441;10529.789404211873;10867.891321086689;10907.781844363068;11003.559857605605;11018.559257629766;481164;499808;500449;502844;507828;62024;91355.08644913598;96839;99760.501197495;101621.49189254154;1052.3054783842626;1052.9736756581146;1058.539535302146;1065.6430095917954;1070.5717712914895;17146.742798858275;17219.483415497554;17236.138193090545;17408.39070632522;17728.202230899384;38652.22695546017;39779.60220397759;39800.20399591934;40662.79668601638;44542;55553;55995.72002139963;61852;62027.37972620216;62054.0691889613;8775.648974040967;8792.47245165292;8902.510361930155;9078.773030674285;9103.998560158245;9550.904490955001;13030.218186908816;13131.212127272394;13215.074944753775;13270.86729132735;11613.245139065933;11707.531698731955;11877;12103.636890893287;12113.75772484563;11406.714832128931;11623.59317423886;11853.76292474163;11925.821112683143;11929.880701192877;11747.941260293645;12146.878531214576;12341.0744194184;12418;12674.683132921751;9031;9149.63401463934;9174.26605871542;9184;9449.858252126087;11866.694663586826;12094.818577721166;12118.151729378858;12146.39268036577;12162.209456385306 00:14:48 INFO - PROCESS | 10171 | |3;mootools.html;1554.6346608546994;1566.1073188282676;1758.9384371546998;1863.9440816775502;1900.0974537094874;9107.54462276886;9608.663696770614;9678.806423871518;9694.515274236286;9695.127438530531;8057.27484526394;8965.237954773836;9306.860397094031;9355.251579873611;9476.952615236914;2415.3961509622636;2456.152627343564;2460.938476538083;2461.113998960373;2461.7415171407015;2038.1439795286014;2405.144502633422;2468.90124395024;2481.5409149307434;2483.255023492954;2359.905603775847;2413.372523143986;2430.2101816909485;2437.6221685638666;2439.9146029888957;2346.5189636124637;2368.4078980254935;2372.727136379321;2372.905083796646;2411.011485291031;2329.8485598436046;2340.0639744102323;2341.613633750429;2372.608519594265;2419.6733440985595;9042.140996605312;9117.407368521091;9121.635134594608;9125.361224714272;9130.315226357983;5454.045542030129;5595.076812326002;5600.103983362683;5602.0196465618355;5605.047141985872;3280.96719032809;3281.949776071658;3377.628460869302;3482.181687303482;3553.928921421557;1073.0557109743454;1080.152080616712;1086.6631344283298;1091.2143256855131;1123.8145705958507;13103.999999999905;13117.409716562777;13144.802827957588;13149.605511834565;13154.210747355093;4847.975760121177;4880.975595122001;4890.315355850184;4891.486393928657;4958.727270000185;11011.28426652265;11033.724156895982;11038.889611103947;11042.227044106996;11046.061084807881;5490.313710786152;5513.035218836688;5522.779088836482;5524.14375771756;5524.58565607581;4801.4718380978065;4819.903601927942;4852.708837469763;4912.508749125131;5042.647014708935;4100.671946244293;4111.157212771374;4143.772092534879;4179.12238429927;4197.580241975778;1217.1297522271618;1264.121435602266;1296.4749276543016;1315.066302924915;1331.7336532693307;933.6965486217007;946.6970569417858;1016.6848277034143;1031.6595523477235;1051.8369652703843;6338.651374174465;6339.302676705559;6344.238691356974;6382.266039405435;6425.935740642533;987.7975015121883;993.7863359377768;1007.9949600251952;1039.2725092435326;1068.278911734576;4392.033752574429;4421.823127074946;4438.733675979452;4439.933400998988;4447.822087116479;10791.136709063256;10903.727406814893;11373.829392559119;11379.658610241706;11386.829197562043;10994.615188468526;11230.382328971986;11294.491747871201;11301.886981130248;11327.660170194908;8405.033421156646;8501.489910605384;8573.957130214309;8577.313814894793;8585.699500517452;6307.716152773044;6396.520260980538;6488.286288508355;6611.900821487778;6717.966410168114;10283.12593429567;10290.434026128634;10378.896211038094;10392.844107338246;10712.57149714034;10390.272680912263;10610.946945265225;10624.36253824742;10625.787484250426;10647.148228141576;8186.508809471213;8260.339172866035;8351.791205219919;8365.372597055124;8368.456050356708;8669.089745576624;8683.2185103341;8733.257673097858;8734.170253825876;8803.03166651655;6625.238097618835;7323.597202153933;7395.408367330709;8045.115037346004;8171.387145964195;7786.065672119155;7796.805079873048;7870.370370370242;7904.446688731734;8008.559529225949;7347.044884165238;7387.926120738939;7409.147947985835;7409.814754630962;7426.4058875288765;5290.232916227203;5393.649412788156;5518.586106041983;5527.198556209408;5638.182463542681;5620.634658747168;5655.858603534944;5662.235598194191;5717.571182161438;5769.394213607511 00:14:48 INFO - PROCESS | 10171 | |4;prototype.html;353.3322021379592;353.81601567185066;356.99999999999994;363.15566308333115;363.5491989932481;5462.754176062077;5464.6994415307145;5487.314085739283;5492.203630473584;5518.530924871386;5390.811321603745;5405.216243644669;5445.53712934401;5457.662872596209;5466.1527463243165;3833.252515759428;4027.778472184036;4220.53574106848;4256.680748943826;4265.104328091089;4226.091390351074;4245.872623821275;4251.171021650779;4267.4025636410925;4272.615464608185;3995.5205375354853;4222.97888510557;4242.9575704243025;4249.3413520904305;4264.616184543391;4139.317012692902;4257.531671516131;4266.87199384019;4276.893077673052;4289.935650965238;3828.846846126152;3830;3838.7120965927666;3839.3856982882885;3866.975251558339;5225.973870130625;5248.921266181011;5251.632385733;5254.264402983586;5254.553362964152;4888.144574699413;4915.705057696549;4922.926156107661;4948.529889660476;4983.90032199354;5365.275687782138;5461.18082287656;5525.696086715229;5569.10894256917;5677;3953.8220780064967;4041.4746083009313;4192.937105943413;4218.050938538835;4222.5566315536735;5776.826695199109;5780.161876527922;5782.479576838063;5835.883282334372;5848.97075514624;4007.238624661305;4196.664266858644;4199.874003779831;4216.894577635584;4222.514410842731;4231.280682284019;4247.426597409372;4248.150369926027;4259.148170365939;4260.8508702195895;4795.040991801654;4796.968651739892;4805.255185446262;4808.374911261513;4829.6860704054125;5470.452954704498;5622.156676498476;5636.351819540805;5682.602217844794;5695.914561281584;1447.985520144806;1451.5992067654554;1451.9274036298143;1460.3866376122055;1466.4940595494538;915.9882484445079;923.6397804856111;938.6104766521817;959.5154447004218;959.8032403357295;5021.59827213822;5035.525487413673;5045.823396181116;5046.293518907356;5085.2372144177925;5148.897022059537;5181.300524429229;5201.956855239651;5283.920741188886;5285.127953887565;4644.883877903079;4943.629227807929;4974.303597496353;4978.327925730053;4986.077575648516;2760.9447811043665;2775.9167224983285;2782.9981206765547;2793.399419124857;2799.8740056697497;5366.570674346043;5410.3507579090765;5426.620136590401;5432.70120143388;5490.505854473116;5285.392179899284;5328.200769884548;5502.147167189092;5983.311919129269;6009.879802404015;5905.527557795452;6000;6127.977767336679;6138.754449822047;6170.136180934583;5822.272215973004;5828.154917537018;5843.181954526284;5882.117682347682;5912.586118971631;5597.6641401516035;5734.340550836707;5744;5768.711564421846;5812.389699081705;6127.509799216141;6135.325114237341;6146.279041868284;6151;6159.784407545714;4160.729552579072;4208.158368326286;4223.767692776803;4230.725002874803;4231.788410579397;5614.915776263441;5890.764369425175;5892.204552385545;5922.348541660328;5933.554983376351;5698.31620205578;5709.914351284651;5721.713914304351;5738.282714660668;5759.136129580596;5642.463965923231;5754.4533269339345;5761.185226653591;5765.682887441231;5786.594938354275;5621.943780562306;5629.746661400165;5638.633488823213;5642.605017648725;5656.915146272891;5733.254676891977;5756.1941328214925;5786.681732504752;5814.94185058144;5828.746819433842;5449.754761035683;5653.575981801464;5671.234383358194;5673.886522269614;5708.686022268649 00:14:48 INFO - PROCESS | 10171 | |5;yui.html;755.7770457714973;760.9391248700101;842.995785021075;879.1252703559959;891.9331050171239;14119.294035298246;15471.38114475421;15596.298166582503;15710.607234819106;15751;15622.687546249068;15746.84253157471;15895.920520397382;15934.362625494967;15970.201489925486;860.2601762484259;866.7183165471215;866.9003064647583;874.038557586656;878.7100256915235;868.3053557154283;869.2741560796742;872.9432586881833;873.1486800369652;873.7902903303225;915.158054589779;916.8808054952847;918.5131880103522;918.9494577798218;919.1314208073373;914.2137761525083;914.4604683236889;917.8944421391559;918.1002617434951;918.2608000559546;671.5366397185975;673.5655502201101;673.6901025528263;673.7911247513238;673.9123913891162;14327.856721432756;14334.92832535841;14396.856031439656;14405.711885762226;14427.495037673736;13828.792568111487;13837.584872453843;13847.515336963157;13963.092398994033;14128.434862605483;11948.163628546004;12120.488639528805;12251.571195008131;12475.75048499034;12520.499180032788;3999.7200195986293;4035.8991025224605;4049.6355328020327;4060.776657283848;4198.9370159447635;58313;65441.345586544005;67885.66057169731;68193;72373;11288.661340159808;11545.249558778652;11593.594224202112;11740.29558226492;11874.76250475003;23395;23665.645015324782;23713.28860134199;23726.169584064475;23736.050557977487;9304.674336398193;9314.115159059878;9387.249020078514;9399.765005874908;9445.905540944503;4848.9757551212015;4896.608271338285;4980.427250866197;5008.549230569266;5077.796888124508;3724.1620635356826;3824.7513911595656;3826.5408151022057;3832.4442955771256;3832.827522761482;647.456136845043;660.8149718078946;665.4576520136073;667.3993405934698;681.7681988124061;621.1924498152384;683.6786710246176;742.769741380163;763.9236076392316;764.0792844622327;9872.60509579623;10283.640072597424;10410.531526081344;10417.791644167075;10433;728.9416846652255;729.1068441159643;737.9926200738031;741.2476336518438;767.8771396576633;4879.957212471775;5010.55035622969;5015.808638059663;5045.225126180586;5073.568746656576;115185.4240728791;116506;118562.99399580946;118990;121546;69630;100438;103790.48104759428;104575;105074.47462762638;89017.55491222502;89459;89907;90008.5499572498;90197;8925.285977121945;8949.59726812308;9087.2730181584;9598.808023839623;9795.363301385387;52868.206976896145;53244;53826;54182.18726719181;55332.170017450575;79066.20933790588;79740.60129699315;79771.60114199392;80242;81127;12357;12889;12911.806322905351;13023.6976302369;13118.540851070167;13765;14052.508162214273;14095.365708542935;14096.224707641179;14187;12036;12296.385180741107;12303.323317217639;12316.876831231932;12539.93730031344;12888.806667900177;13105;13256;13408.128471649312;13441.865581344062;12677.87322126767;13261.27063011505;13503.662408439868;13535.323233838466;13781.86218137846;10048;10324.741881452723;10554.261201715806;10644.361338319726;10855.620053298097;10050.748731281776;10236.896286557569;10633.787324253317;11008.614698485515;11078.279911805706 00:14:48 INFO - PROCESS | 10171 | __end_tp_report 00:14:48 INFO - PROCESS | 10171 | __start_cc_report 00:14:48 INFO - PROCESS | 10171 | _x_x_mozilla_cycle_collect,849 00:14:48 INFO - PROCESS | 10171 | __end_cc_report 00:14:48 INFO - PROCESS | 10171 | __startTimestamp1467875688844__endTimestamp 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | ------- Summary: start ------- 00:14:48 INFO - PROCESS | 10171 | Number of tests: 6 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | [#0] dojo.html Cycles:165 Average:5372.44 Median:5577.53 stddev:581.44 (10.4%) stddev-sans-first:560.19 00:14:48 INFO - PROCESS | 10171 | Values: 3306.7 3325.1 3330.7 3341.8 3367.6 5304.5 5388.9 5399.7 5405.2 5415.9 5361.5 5398.4 5430.6 5434.4 5447.3 4839.3 4903.1 4929.6 4962.0 5038.5 4826.2 4949.5 4988.3 4992.7 4995.3 4839.1 4866.6 4890.7 4894.7 4988.6 4960.7 4972.5 4973.0 4984.0 4991.4 4833.2 4846.6 4881.4 4905.2 4916.0 5249.5 5261.1 5274.9 5313.6 5315.8 5715.1 5829.9 5831.0 5831.3 5836.3 5688.2 5749.9 5757.6 5774.8 5847.6 5438.3 5439.6 5448.9 5471.4 5475.2 5725.6 5932.0 5938.6 5944.1 5946.1 5577.5 5619.9 5633.9 5684.3 5708.8 5769.1 5777.3 5777.4 5796.6 5805.2 5602.4 5664.7 5743.2 5749.5 5759.3 5683.7 5790.2 5801.2 5803.1 5834.5 4491.7 4497.7 4500.5 4502.6 4526.0 3899.7 3903.7 3923.9 4038.7 4075.6 5394.2 5412.2 5417.8 5427.6 5438.9 5700.5 5710.7 5711.7 5713.9 5740.7 5283.8 5373.5 5408.1 5411.3 5509.4 4969.4 4975.3 4978.2 5017.9 5038.3 6066.3 6078.4 6081.6 6085.1 6116.0 5633.5 5720.5 5738.7 5753.4 5868.9 6085.8 6093.8 6097.8 6098.1 6110.0 5753.0 5761.8 5766.6 5767.8 5768.6 5622.7 5658.8 5723.5 5736.5 5784.5 5614.0 5623.5 5623.6 5625.1 5627.7 5440.8 5606.7 5617.4 5618.1 5621.0 5494.5 5560.4 5566.0 5617.4 5627.7 5685.7 5693.2 5700.0 5721.2 5740.4 5398.4 5462.8 5573.9 5583.8 5599.7 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | [#1] ext.html Cycles:180 Average:61764.87 Median:214006.90 stddev:118261.03 (55.3%) stddev-sans-first:118503.64 00:14:48 INFO - PROCESS | 10171 | Values: 610.9 631.4 638.1 647.2 658.6 30942.7 45177.0 46078.8 46091.0 46168.3 48071.8 48667.0 48748.3 48793.0 48807.0 7775.7 7926.9 7934.4 9052.2 9218.7 8204.5 10389.3 10615.2 10669.4 10934.4 11031.7 11046.8 11091.7 11107.9 11109.9 8162.0 10923.6 11008.1 11065.2 11092.1 10690.1 10763.1 10996.6 11087.7 11105.2 44659.8 44965.0 45009.1 45277.3 45330.0 3704.9 3802.7 3863.0 3923.8 4399.4 34808.7 35530.5 35745.3 35797.3 35846.5 4667.6 4731.3 4751.7 4791.9 4862.0 378173.0 378737.0 379889.0 381375.0 392013.0 70405.6 71229.3 71256.0 71307.0 71330.3 40454.8 41439.0 41526.6 42907.6 43026.6 16428.8 16443.7 16546.0 16552.0 16556.7 10430.8 12901.4 12919.1 13018.9 13160.5 22092.8 22135.2 22252.2 22331.3 22424.9 7660.8 8136.2 8167.9 8252.1 8362.6 1033.5 1123.2 1132.1 1143.8 1176.7 34446.3 34809.5 35056.6 35247.1 35451.0 1159.0 1215.8 1236.5 1237.0 1285.4 18149.5 18342.8 18344.7 18485.2 18506.4 538776.0 545567.0 545979.0 546487.0 547663.0 63966.0 64091.7 64621.7 64695.4 64696.4 1087.0 1183.4 1439.9 1454.6 1478.6 34293.5 35303.8 35621.8 35899.8 35921.0 54454.0 55223.4 55248.7 55249.2 55299.7 389007.0 398056.0 398146.0 398887.0 399156.0 25329.5 30552.4 31138.0 31494.2 31494.5 51503.0 51807.5 52005.2 52684.0 53133.7 42984.0 43612.0 43657.0 43785.6 44906.0 43636.1 43892.6 43973.8 44393.8 45556.5 43526.3 43787.8 44726.8 45026.8 45377.1 37937.2 38709.0 38737.8 38767.0 39006.8 29473.3 29612.0 29830.9 29955.3 30084.0 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | [#2] jquery.html Cycles:180 Average:29248.36 Median:11661.28 stddev:82238.68 (705.2%) stddev-sans-first:82440.86 00:14:48 INFO - PROCESS | 10171 | Values: 406.2 410.7 415.7 415.9 438.8 18516.5 19720.4 20333.0 20379.8 20638.1 13092.3 13104.2 13148.9 13209.7 13445.7 5117.5 5263.2 5312.7 5344.3 5403.7 3959.5 5712.3 6006.2 6013.3 6076.4 6042.3 6052.1 6072.1 6081.6 6112.3 6014.5 6111.5 6123.4 6129.9 6137.6 5781.0 5939.6 5955.0 6031.5 6042.4 15190.5 15309.2 15409.8 21191.4 24367.1 2397.5 2538.7 2624.3 2795.4 2988.8 10538.2 10560.1 10775.7 10888.0 11183.3 1945.0 2026.7 2030.6 2053.7 2055.4 83745.0 83800.0 85916.6 86045.6 88384.6 11668.6 11825.7 11968.7 11997.5 12048.8 16800.8 16966.5 16972.2 16993.8 16995.2 8520.4 8558.4 8667.8 8701.8 8792.1 8209.1 8217.8 8386.0 8491.4 8580.8 5091.2 5110.6 5124.1 5170.7 5282.7 1748.0 1999.5 2073.2 2084.5 2131.2 970.1 993.2 1008.3 1020.4 1087.2 18996.3 19052.8 19294.9 19335.1 19407.4 1059.1 1061.3 1089.3 1090.5 1096.3 10529.8 10867.9 10907.8 11003.6 11018.6 481164.0 499808.0 500449.0 502844.0 507828.0 62024.0 91355.1 96839.0 99760.5 101621.5 1052.3 1053.0 1058.5 1065.6 1070.6 17146.7 17219.5 17236.1 17408.4 17728.2 38652.2 39779.6 39800.2 40662.8 44542.0 55553.0 55995.7 61852.0 62027.4 62054.1 8775.6 8792.5 8902.5 9078.8 9104.0 9550.9 13030.2 13131.2 13215.1 13270.9 11613.2 11707.5 11877.0 12103.6 12113.8 11406.7 11623.6 11853.8 11925.8 11929.9 11747.9 12146.9 12341.1 12418.0 12674.7 9031.0 9149.6 9174.3 9184.0 9449.9 11866.7 12094.8 12118.2 12146.4 12162.2 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | [#3] mootools.html Cycles:180 Average:6071.04 Median:4624.65 stddev:3447.71 (74.6%) stddev-sans-first:3440.68 00:14:48 INFO - PROCESS | 10171 | Values: 1554.6 1566.1 1758.9 1863.9 1900.1 9107.5 9608.7 9678.8 9694.5 9695.1 8057.3 8965.2 9306.9 9355.3 9477.0 2415.4 2456.2 2460.9 2461.1 2461.7 2038.1 2405.1 2468.9 2481.5 2483.3 2359.9 2413.4 2430.2 2437.6 2439.9 2346.5 2368.4 2372.7 2372.9 2411.0 2329.8 2340.1 2341.6 2372.6 2419.7 9042.1 9117.4 9121.6 9125.4 9130.3 5454.0 5595.1 5600.1 5602.0 5605.0 3281.0 3281.9 3377.6 3482.2 3553.9 1073.1 1080.2 1086.7 1091.2 1123.8 13104.0 13117.4 13144.8 13149.6 13154.2 4848.0 4881.0 4890.3 4891.5 4958.7 11011.3 11033.7 11038.9 11042.2 11046.1 5490.3 5513.0 5522.8 5524.1 5524.6 4801.5 4819.9 4852.7 4912.5 5042.6 4100.7 4111.2 4143.8 4179.1 4197.6 1217.1 1264.1 1296.5 1315.1 1331.7 933.7 946.7 1016.7 1031.7 1051.8 6338.7 6339.3 6344.2 6382.3 6425.9 987.8 993.8 1008.0 1039.3 1068.3 4392.0 4421.8 4438.7 4439.9 4447.8 10791.1 10903.7 11373.8 11379.7 11386.8 10994.6 11230.4 11294.5 11301.9 11327.7 8405.0 8501.5 8574.0 8577.3 8585.7 6307.7 6396.5 6488.3 6611.9 6718.0 10283.1 10290.4 10378.9 10392.8 10712.6 10390.3 10610.9 10624.4 10625.8 10647.1 8186.5 8260.3 8351.8 8365.4 8368.5 8669.1 8683.2 8733.3 8734.2 8803.0 6625.2 7323.6 7395.4 8045.1 8171.4 7786.1 7796.8 7870.4 7904.4 8008.6 7347.0 7387.9 7409.1 7409.8 7426.4 5290.2 5393.6 5518.6 5527.2 5638.2 5620.6 5655.9 5662.2 5717.6 5769.4 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | [#4] prototype.html Cycles:180 Average:4727.48 Median:5306.80 stddev:1388.49 (26.2%) stddev-sans-first:1353.01 00:14:48 INFO - PROCESS | 10171 | Values: 353.3 353.8 357.0 363.2 363.5 5462.8 5464.7 5487.3 5492.2 5518.5 5390.8 5405.2 5445.5 5457.7 5466.2 3833.3 4027.8 4220.5 4256.7 4265.1 4226.1 4245.9 4251.2 4267.4 4272.6 3995.5 4223.0 4243.0 4249.3 4264.6 4139.3 4257.5 4266.9 4276.9 4289.9 3828.8 3830.0 3838.7 3839.4 3867.0 5226.0 5248.9 5251.6 5254.3 5254.6 4888.1 4915.7 4922.9 4948.5 4983.9 5365.3 5461.2 5525.7 5569.1 5677.0 3953.8 4041.5 4192.9 4218.1 4222.6 5776.8 5780.2 5782.5 5835.9 5849.0 4007.2 4196.7 4199.9 4216.9 4222.5 4231.3 4247.4 4248.2 4259.1 4260.9 4795.0 4797.0 4805.3 4808.4 4829.7 5470.5 5622.2 5636.4 5682.6 5695.9 1448.0 1451.6 1451.9 1460.4 1466.5 916.0 923.6 938.6 959.5 959.8 5021.6 5035.5 5045.8 5046.3 5085.2 5148.9 5181.3 5202.0 5283.9 5285.1 4644.9 4943.6 4974.3 4978.3 4986.1 2760.9 2775.9 2783.0 2793.4 2799.9 5366.6 5410.4 5426.6 5432.7 5490.5 5285.4 5328.2 5502.1 5983.3 6009.9 5905.5 6000.0 6128.0 6138.8 6170.1 5822.3 5828.2 5843.2 5882.1 5912.6 5597.7 5734.3 5744.0 5768.7 5812.4 6127.5 6135.3 6146.3 6151.0 6159.8 4160.7 4208.2 4223.8 4230.7 4231.8 5614.9 5890.8 5892.2 5922.3 5933.6 5698.3 5709.9 5721.7 5738.3 5759.1 5642.5 5754.5 5761.2 5765.7 5786.6 5621.9 5629.7 5638.6 5642.6 5656.9 5733.3 5756.2 5786.7 5814.9 5828.7 5449.8 5653.6 5671.2 5673.9 5708.7 00:14:48 INFO - PROCESS | 10171 | 00:14:48 INFO - PROCESS | 10171 | [#5] yui.html Cycles:180 Average:20908.41 Median:4055.21 stddev:30241.78 (745.8%) stddev-sans-first:30288.76 00:14:48 INFO - PROCESS | 10171 | Values: 755.8 760.9 843.0 879.1 891.9 14119.3 15471.4 15596.3 15710.6 15751.0 15622.7 15746.8 15895.9 15934.4 15970.2 860.3 866.7 866.9 874.0 878.7 868.3 869.3 872.9 873.1 873.8 915.2 916.9 918.5 918.9 919.1 914.2 914.5 917.9 918.1 918.3 671.5 673.6 673.7 673.8 673.9 14327.9 14334.9 14396.9 14405.7 14427.5 13828.8 13837.6 13847.5 13963.1 14128.4 11948.2 12120.5 12251.6 12475.8 12520.5 3999.7 4035.9 4049.6 4060.8 4198.9 58313.0 65441.3 67885.7 68193.0 72373.0 11288.7 11545.2 11593.6 11740.3 11874.8 23395.0 23665.6 23713.3 23726.2 23736.1 9304.7 9314.1 9387.2 9399.8 9445.9 4849.0 4896.6 4980.4 5008.5 5077.8 3724.2 3824.8 3826.5 3832.4 3832.8 647.5 660.8 665.5 667.4 681.8 621.2 683.7 742.8 763.9 764.1 9872.6 10283.6 10410.5 10417.8 10433.0 728.9 729.1 738.0 741.2 767.9 4880.0 5010.6 5015.8 5045.2 5073.6 115185.4 116506.0 118563.0 118990.0 121546.0 69630.0 100438.0 103790.5 104575.0 105074.5 89017.6 89459.0 89907.0 90008.5 90197.0 8925.3 8949.6 9087.3 9598.8 9795.4 52868.2 53244.0 53826.0 54182.2 55332.2 79066.2 79740.6 79771.6 80242.0 81127.0 12357.0 12889.0 12911.8 13023.7 13118.5 13765.0 14052.5 14095.4 14096.2 14187.0 12036.0 12296.4 12303.3 12316.9 12539.9 12888.8 13105.0 13256.0 13408.1 13441.9 12677.9 13261.3 13503.7 13535.3 13781.9 10048.0 10324.7 10554.3 10644.4 10855.6 10050.7 10236.9 10633.8 11008.6 11078.3 00:14:48 INFO - PROCESS | 10171 | -------- Summary: end -------- 00:14:48 INFO - PROCESS | 10171 | 00:14:49 INFO - TEST-INFO | 10171: exit 0 00:14:49 INFO - TEST-OK | dromaeo_css | took 1112779ms 00:14:49 INFO - TEST-START | kraken 00:14:49 INFO - operating with platform_type : linux_ 00:14:49 INFO - Initialising browser for kraken test... 00:14:49 INFO - TEST-INFO | started process 10366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOVtNZw/profile http://localhost:47034/getInfo.html) 00:14:53 INFO - PROCESS | 10366 | __metrics Screen width/height:1600/1200 00:14:53 INFO - PROCESS | 10366 | colorDepth:24 00:14:53 INFO - PROCESS | 10366 | Browser inner width/height: 1024/697 00:14:53 INFO - PROCESS | 10366 | __metrics 00:14:54 ERROR - PROCESS | 10366 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:14:55 INFO - TEST-INFO | 10366: exit 0 00:14:55 INFO - Browser initialized. 00:14:55 INFO - Running cycle 1/1 for kraken test... 00:14:55 INFO - TEST-INFO | started process 10458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOVtNZw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:15:07 INFO - PROCESS | 10458 | RSS: Main: 145883136 00:15:07 INFO - PROCESS | 10458 | 00:15:09 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47034/tests/kraken/driver.html?testName=audio-beat-detection) 00:15:10 INFO - PROCESS | 10458 | RSS: Main: 194818048 00:15:10 INFO - PROCESS | 10458 | 00:15:13 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47034/tests/kraken/driver.html?testName=audio-dft) 00:15:13 INFO - PROCESS | 10458 | RSS: Main: 192552960 00:15:13 INFO - PROCESS | 10458 | 00:15:16 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47034/tests/kraken/driver.html?testName=audio-fft) 00:15:17 INFO - PROCESS | 10458 | RSS: Main: 277966848 00:15:17 INFO - PROCESS | 10458 | 00:15:19 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47034/tests/kraken/driver.html?testName=audio-oscillator) 00:15:19 INFO - PROCESS | 10458 | RSS: Main: 186281984 00:15:19 INFO - PROCESS | 10458 | 00:15:22 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:15:22 INFO - PROCESS | 10458 | RSS: Main: 186171392 00:15:22 INFO - PROCESS | 10458 | 00:15:25 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47034/tests/kraken/driver.html?testName=imaging-darkroom) 00:15:26 INFO - PROCESS | 10458 | RSS: Main: 221261824 00:15:26 INFO - PROCESS | 10458 | 00:15:29 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47034/tests/kraken/driver.html?testName=imaging-desaturate) 00:15:30 INFO - PROCESS | 10458 | RSS: Main: 221827072 00:15:30 INFO - PROCESS | 10458 | 00:15:33 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47034/tests/kraken/driver.html?testName=json-parse-financial) 00:15:33 INFO - PROCESS | 10458 | RSS: Main: 221769728 00:15:33 INFO - PROCESS | 10458 | 00:15:35 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:15:35 INFO - PROCESS | 10458 | RSS: Main: 200392704 00:15:35 INFO - PROCESS | 10458 | 00:15:37 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:15:38 INFO - PROCESS | 10458 | RSS: Main: 201248768 00:15:38 INFO - PROCESS | 10458 | 00:15:40 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:15:40 INFO - PROCESS | 10458 | RSS: Main: 209137664 00:15:40 INFO - PROCESS | 10458 | 00:15:43 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:15:43 INFO - PROCESS | 10458 | RSS: Main: 214769664 00:15:43 INFO - PROCESS | 10458 | 00:15:46 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:15:47 INFO - PROCESS | 10458 | RSS: Main: 214052864 00:15:47 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | Cycle 1(1): loaded http://localhost:47034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47034/tests/kraken/driver.html?testName=ai-astar) 00:15:48 INFO - PROCESS | 10458 | RSS: Main: 256823296 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | __start_tp_report 00:15:48 INFO - PROCESS | 10458 | _x_x_mozilla_page_load 00:15:48 INFO - PROCESS | 10458 | _x_x_mozilla_page_load_details 00:15:48 INFO - PROCESS | 10458 | |i|pagename|runs| 00:15:48 INFO - PROCESS | 10458 | |0;ai-astar;110;104;109;109;109;109;111;110;110;109 00:15:48 INFO - PROCESS | 10458 | |1;audio-beat-detection;164;128;124;183;125;126;157;123;153;130 00:15:48 INFO - PROCESS | 10458 | |2;audio-dft;161;160;161;160;162;162;159;159;162;160 00:15:48 INFO - PROCESS | 10458 | |3;audio-fft;75;77;75;125;74;75;74;74;100;75 00:15:48 INFO - PROCESS | 10458 | |4;audio-oscillator;85;85;111;85;85;85;117;85;85;131 00:15:48 INFO - PROCESS | 10458 | |5;imaging-gaussian-blur;116;117;116;118;118;117;117;116;117;116 00:15:48 INFO - PROCESS | 10458 | |6;imaging-darkroom;146;146;146;145;146;145;145;145;147;145 00:15:48 INFO - PROCESS | 10458 | |7;imaging-desaturate;94;95;95;94;95;95;96;95;96;95 00:15:48 INFO - PROCESS | 10458 | |8;json-parse-financial;49;49;51;50;51;51;53;51;51;51 00:15:48 INFO - PROCESS | 10458 | |9;json-stringify-tinderbox;60;61;59;59;60;59;59;59;61;60 00:15:48 INFO - PROCESS | 10458 | |10;stanford-crypto-aes;76;77;81;75;83;77;78;77;113;77 00:15:48 INFO - PROCESS | 10458 | |11;stanford-crypto-ccm;119;127;124;124;115;115;125;122;129;122 00:15:48 INFO - PROCESS | 10458 | |12;stanford-crypto-pbkdf2;156;153;153;152;155;156;151;154;156;151 00:15:48 INFO - PROCESS | 10458 | |13;stanford-crypto-sha256-iterative;61;64;62;61;60;60;63;60;61;59 00:15:48 INFO - PROCESS | 10458 | __end_tp_report 00:15:48 INFO - PROCESS | 10458 | __start_cc_report 00:15:48 INFO - PROCESS | 10458 | _x_x_mozilla_cycle_collect,1580 00:15:48 INFO - PROCESS | 10458 | __end_cc_report 00:15:48 INFO - PROCESS | 10458 | __startTimestamp1467875748908__endTimestamp 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | ------- Summary: start ------- 00:15:48 INFO - PROCESS | 10458 | Number of tests: 14 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:1.89 (1.7%) stddev-sans-first:1.96 00:15:48 INFO - PROCESS | 10458 | Values: 110.0 104.0 109.0 109.0 109.0 109.0 111.0 110.0 110.0 109.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:141.50 stddev:21.28 (15.0%) stddev-sans-first:20.93 00:15:48 INFO - PROCESS | 10458 | Values: 164.0 128.0 124.0 183.0 125.0 126.0 157.0 123.0 153.0 130.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 00:15:48 INFO - PROCESS | 10458 | Values: 161.0 160.0 161.0 160.0 162.0 162.0 159.0 159.0 162.0 160.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.95 (22.6%) stddev-sans-first:17.76 00:15:48 INFO - PROCESS | 10458 | Values: 75.0 77.0 75.0 125.0 74.0 75.0 74.0 74.0 100.0 75.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:17.43 (20.5%) stddev-sans-first:18.08 00:15:48 INFO - PROCESS | 10458 | Values: 85.0 85.0 111.0 85.0 85.0 85.0 117.0 85.0 85.0 131.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 00:15:48 INFO - PROCESS | 10458 | Values: 116.0 117.0 116.0 118.0 118.0 117.0 117.0 116.0 117.0 116.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 00:15:48 INFO - PROCESS | 10458 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 147.0 145.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 00:15:48 INFO - PROCESS | 10458 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 96.0 95.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:1.16 (2.3%) stddev-sans-first:1.05 00:15:48 INFO - PROCESS | 10458 | Values: 49.0 49.0 51.0 50.0 51.0 51.0 53.0 51.0 51.0 51.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 00:15:48 INFO - PROCESS | 10458 | Values: 60.0 61.0 59.0 59.0 60.0 59.0 59.0 59.0 61.0 60.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:77.00 stddev:11.35 (14.7%) stddev-sans-first:11.87 00:15:48 INFO - PROCESS | 10458 | Values: 76.0 77.0 81.0 75.0 83.0 77.0 78.0 77.0 113.0 77.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:124.00 stddev:4.69 (3.8%) stddev-sans-first:4.82 00:15:48 INFO - PROCESS | 10458 | Values: 119.0 127.0 124.0 124.0 115.0 115.0 125.0 122.0 129.0 122.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:154.50 stddev:2.00 (1.3%) stddev-sans-first:1.94 00:15:48 INFO - PROCESS | 10458 | Values: 156.0 153.0 153.0 152.0 155.0 156.0 151.0 154.0 156.0 151.0 00:15:48 INFO - PROCESS | 10458 | 00:15:48 INFO - PROCESS | 10458 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:1.52 (2.5%) stddev-sans-first:1.62 00:15:48 INFO - PROCESS | 10458 | Values: 61.0 64.0 62.0 61.0 60.0 60.0 63.0 60.0 61.0 59.0 00:15:48 INFO - PROCESS | 10458 | -------- Summary: end -------- 00:15:48 INFO - PROCESS | 10458 | 00:15:49 INFO - TEST-INFO | 10458: exit 0 00:15:49 INFO - TEST-OK | kraken | took 60282ms 00:15:49 INFO - SUITE-END | took 1173s 00:15:50 INFO - Completed test suite (00:19:33) 00:15:50 INFO - javascript benchmark 00:15:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.718928891044, 3325.1188435064696, 3330.666933306669, 3341.799492030477, 3367.579052618423, 5304.522592966632, 5388.865278368043, 5399.7030163341, 5405.18922161676, 5415.864603384913, 5361.51746342829, 5398.379186393566, 5430.647007944481, 5434.429384914576, 5447.319085114361, 4839.298301746245, 4903.092927808358, 4929.630277729167, 4962.0324036812835, 5038.546530812227, 4826.203676393391, 4949.529794669518, 4988.326575912241, 4992.67547609406, 4995.250712393134, 4839.05638400512, 4866.562009419152, 4890.706557606555, 4894.657373983805, 4988.6009119270375, 4960.70235785854, 4972.453030166715, 4973.030259099459, 4984.0, 4991.376077990251, 4833.154198015333, 4846.636502262344, 4881.365422495089, 4905.166121759309, 4916.0, 5249.527542521191, 5261.053010458116, 5274.947250527484, 5313.574914006909, 5315.840524784263, 5715.114157305624, 5829.88340233193, 5830.970845145789, 5831.300243970751, 5836.270466191726, 5688.232088668018, 5749.913751293734, 5757.625754325997, 5774.797882074107, 5847.590668653153, 5438.347398312228, 5439.646422982493, 5448.891022179574, 5471.37079235885, 5475.178723191513, 5725.627834190765, 5932.021216499315, 5938.584299099021, 5944.108383742387, 5946.10808378738, 5577.525910297589, 5619.8595035123635, 5633.887322253532, 5684.34630017545, 5708.800191993343, 5769.07694768835, 5777.277840269966, 5777.422257774273, 5796.594238403271, 5805.216295800013, 5602.355729091125, 5664.745086471119, 5743.195952566561, 5749.511291540182, 5759.2512973313205, 5683.658980461186, 5790.189373487715, 5801.245838041028, 5803.100519419497, 5834.533237341003, 4491.663125265618, 4497.707649002804, 4500.482444518857, 4502.594766471033, 4525.977370113128, 3899.66852817508, 3903.7072219583647, 3923.92152156961, 4038.697097717683, 4075.551689314173, 5394.190871369326, 5412.161115027177, 5417.8103766367985, 5427.620066595379, 5438.945610543923, 5700.486956173964, 5710.7430165642645, 5711.7144142792695, 5713.885722285531, 5740.741666625012, 5283.762230699628, 5373.489518495737, 5408.0535906216255, 5411.296531450965, 5509.3664228614225, 4969.428515720666, 4975.303457515951, 4978.228374601942, 5017.9247311290355, 5038.294638750504, 6066.272047354346, 6078.422549857756, 6081.57428979976, 6085.148079268817, 6116.0, 5633.549316054788, 5720.456556627114, 5738.684372359393, 5753.395893431297, 5868.882622347443, 6085.756569737161, 6093.786717464867, 6097.75608975636, 6098.146259523759, 6110.0, 5753.0, 5761.827145185651, 5766.5675074368755, 5767.798127065533, 5768.625039372428, 5622.690752008679, 5658.801941932013, 5723.484886360081, 5736.512396446349, 5784.4504772046585, 5614.045612245846, 5623.465770751772, 5623.550115990793, 5625.128105143709, 5627.718614069198, 5440.7551660174595, 5606.6916319602815, 5617.382087970402, 5618.073017951992, 5621.0, 5494.5054945055135, 5560.443955604569, 5565.9721701392855, 5617.354004289559, 5627.662340259598, 5685.658860468385, 5693.202951586698, 5699.971500142473, 5721.1990321354215, 5740.368559458373, 5398.352197736297, 5462.808801691922, 5573.916391254215, 5583.804566840141, 5599.664020158803], "value": 5336.143051249607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8503416662916, 631.3654776949163, 638.0875348251998, 647.2330288608, 658.5850913924229, 30942.690573094264, 45177.0, 46078.769606152004, 46090.999999999956, 46168.3074753879, 48071.759641201745, 48667.0, 48748.26877596839, 48793.0, 48807.0, 7775.650095745705, 7926.8810967835525, 7934.3652507799525, 9052.1853033227, 9218.723438296862, 8204.466709663882, 10389.32469389491, 10615.150787936947, 10669.413182274971, 10934.398608076554, 11031.669049928514, 11046.779064418706, 11091.72270693235, 11107.944460277728, 11109.888901111006, 8161.95919020407, 10923.617673381474, 11008.064314533274, 11065.225434219568, 11092.057175140122, 10690.091342235919, 10763.13894888407, 10996.560137594566, 11087.667369978833, 11105.222634415593, 44659.776701116614, 44965.0, 45009.09981800346, 45277.32084018742, 45330.0, 3704.907377315562, 3802.657760801541, 3863.0, 3923.8430462781453, 4399.38408622793, 34808.6519134808, 35530.46704299437, 35745.28509429797, 35797.28405431877, 35846.46230306548, 4667.6265898728025, 4731.33761273422, 4751.691140075884, 4791.928121078186, 4861.975690121562, 378173.0, 378737.0, 379888.99999999726, 381375.0, 392013.0, 70405.64797176083, 71229.28770712331, 71256.0, 71307.0, 71330.2866971334, 40454.79772601118, 41439.0, 41526.584734152275, 42907.570924290354, 43026.569734302255, 16428.83571164297, 16443.67112657764, 16546.0, 16552.0, 16556.6688666226, 10430.843537346946, 12901.354932253349, 12919.095663303478, 13018.869811301765, 13160.473581056842, 22092.779072209392, 22135.225267115897, 22252.221172258895, 22331.330060098222, 22424.887875560846, 7660.846783064308, 8136.1863813618165, 8167.918320816834, 8252.119226139022, 8362.58187090643, 1033.509083185496, 1123.2081382625229, 1132.11683924141, 1143.7883991461606, 1176.688177632928, 34446.311073778386, 34809.47785783215, 35056.649433505845, 35247.118822029144, 35451.0, 1158.9942050289862, 1215.7811593913004, 1236.4621389695512, 1236.993815030919, 1285.440833237526, 18149.455516334532, 18342.816571834377, 18344.724829127576, 18485.168167432497, 18506.352277670216, 538776.0, 545567.0, 545979.0, 546487.0, 547663.0, 63966.0, 64091.679541601996, 64621.67689161618, 64695.35304646987, 64696.353036469976, 1087.0434018064052, 1183.4260383713893, 1439.8632129947848, 1454.5854431486975, 1478.5638236719979, 34293.48559771555, 35303.823480882435, 35621.82189089038, 35899.82050089733, 35921.0, 54454.0, 55223.44776552183, 55248.72375638096, 55249.17126243029, 55299.723501382236, 389007.0, 398056.0, 398146.0, 398887.0, 399156.0, 25329.49341013206, 30552.388952221274, 31138.0, 31494.212644684067, 31494.527582086746, 51503.0, 51807.481925181775, 52005.219921700445, 52684.0, 53133.734331329644, 42984.0, 43612.0, 43657.0, 43785.56214437815, 44906.0, 43636.12727745491, 43892.56107438885, 43973.78013109914, 44393.778031109636, 45556.544434556556, 43526.34710479282, 43787.78106109449, 44726.77636611796, 45026.77486612546, 45377.09245814999, 37937.24125517419, 38709.0, 38737.78007617877, 38767.0, 39006.80496597499, 29473.263168420963, 29612.0, 29830.8508457465, 29955.251118722208, 30084.0], "value": 21486.44170521329, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.16127696307143, 410.68582534361235, 415.652929803614, 415.8710799652108, 438.7718386439052, 18516.537086572844, 19720.408387748354, 20333.0, 20379.796202037975, 20638.071286792092, 13092.345382730873, 13104.213747175152, 13148.868511314908, 13209.669758256025, 13445.66385840352, 5117.462666420019, 5263.210518422248, 5312.73436328184, 5344.305240318772, 5403.675779453226, 3959.5050618672667, 5712.257406537145, 6006.189164462807, 6013.308469525995, 6076.422739839731, 6042.274927008765, 6052.122442245894, 6072.058830881198, 6081.6351018939, 6112.327643959161, 6014.488768454687, 6111.480524155474, 6123.448889599935, 6129.938700613004, 6137.60105593135, 5781.017227071408, 5939.554533410012, 5955.047192449188, 6031.547633927473, 6042.365551617105, 15190.468333608382, 15309.234538273153, 15409.768853467207, 21191.364259072252, 24367.14714984967, 2397.520495900827, 2538.695356557225, 2624.3176774038698, 2795.3989892173076, 2988.835614041227, 10538.20963427746, 10560.102391296672, 10775.676729698122, 10888.020078193, 11183.32900026001, 1944.9902750486299, 2026.6858636911154, 2030.5634288627869, 2053.650879350514, 2055.393658870637, 83744.99999999939, 83800.0, 85916.57041714751, 86045.56977215137, 88384.5580772092, 11668.591599294154, 11825.704357390961, 11968.700782480508, 11997.460114294878, 12048.759024819454, 16800.83199168017, 16966.49100526986, 16972.151392430576, 16993.830061699224, 16995.23521441538, 8520.446170998865, 8558.400911936229, 8667.783305417415, 8701.825963480822, 8792.109696415302, 8209.055958564722, 8217.753467395987, 8386.0, 8491.363147763943, 8580.828383432421, 5091.159958606862, 5110.616703747234, 5124.077666020152, 5170.741462926839, 5282.735863206824, 1748.0309727160984, 1999.5401057756796, 2073.170731707299, 2084.48930012148, 2131.1901477438473, 970.126885802769, 993.2203220472039, 1008.349614498659, 1020.3929110594163, 1087.1791797193068, 18996.335128270443, 19052.80947190538, 19294.90352548228, 19335.12991915367, 19407.417777466697, 1059.057438879398, 1061.2836335473523, 1089.3355053417408, 1090.51472094917, 1096.270979798441, 10529.789404211873, 10867.891321086689, 10907.781844363068, 11003.559857605605, 11018.559257629766, 481164.0, 499808.0, 500449.0, 502844.0, 507828.0, 62024.0, 91355.08644913598, 96839.0, 99760.501197495, 101621.49189254154, 1052.3054783842626, 1052.9736756581146, 1058.539535302146, 1065.6430095917954, 1070.5717712914895, 17146.742798858275, 17219.483415497554, 17236.138193090545, 17408.39070632522, 17728.202230899384, 38652.22695546017, 39779.60220397759, 39800.20399591934, 40662.79668601638, 44542.0, 55553.0, 55995.72002139963, 61852.0, 62027.37972620216, 62054.0691889613, 8775.648974040967, 8792.47245165292, 8902.510361930155, 9078.773030674285, 9103.998560158245, 9550.904490955001, 13030.218186908816, 13131.212127272394, 13215.074944753775, 13270.86729132735, 11613.245139065933, 11707.531698731955, 11877.0, 12103.636890893287, 12113.75772484563, 11406.714832128931, 11623.59317423886, 11853.76292474163, 11925.821112683143, 11929.880701192877, 11747.941260293645, 12146.878531214576, 12341.0744194184, 12418.0, 12674.683132921751, 9031.0, 9149.63401463934, 9174.26605871542, 9184.0, 9449.858252126087, 11866.694663586826, 12094.818577721166, 12118.151729378858, 12146.39268036577, 12162.209456385306], "value": 9368.421829426876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.6346608546994, 1566.1073188282676, 1758.9384371546998, 1863.9440816775502, 1900.0974537094874, 9107.54462276886, 9608.663696770614, 9678.806423871518, 9694.515274236286, 9695.127438530531, 8057.27484526394, 8965.237954773836, 9306.860397094031, 9355.251579873611, 9476.952615236914, 2415.3961509622636, 2456.152627343564, 2460.938476538083, 2461.113998960373, 2461.7415171407015, 2038.1439795286014, 2405.144502633422, 2468.90124395024, 2481.5409149307434, 2483.255023492954, 2359.905603775847, 2413.372523143986, 2430.2101816909485, 2437.6221685638666, 2439.9146029888957, 2346.5189636124637, 2368.4078980254935, 2372.727136379321, 2372.905083796646, 2411.011485291031, 2329.8485598436046, 2340.0639744102323, 2341.613633750429, 2372.608519594265, 2419.6733440985595, 9042.140996605312, 9117.407368521091, 9121.635134594608, 9125.361224714272, 9130.315226357983, 5454.045542030129, 5595.076812326002, 5600.103983362683, 5602.0196465618355, 5605.047141985872, 3280.96719032809, 3281.949776071658, 3377.628460869302, 3482.181687303482, 3553.928921421557, 1073.0557109743454, 1080.152080616712, 1086.6631344283298, 1091.2143256855131, 1123.8145705958507, 13103.999999999905, 13117.409716562777, 13144.802827957588, 13149.605511834565, 13154.210747355093, 4847.975760121177, 4880.975595122001, 4890.315355850184, 4891.486393928657, 4958.727270000185, 11011.28426652265, 11033.724156895982, 11038.889611103947, 11042.227044106996, 11046.061084807881, 5490.313710786152, 5513.035218836688, 5522.779088836482, 5524.14375771756, 5524.58565607581, 4801.4718380978065, 4819.903601927942, 4852.708837469763, 4912.508749125131, 5042.647014708935, 4100.671946244293, 4111.157212771374, 4143.772092534879, 4179.12238429927, 4197.580241975778, 1217.1297522271618, 1264.121435602266, 1296.4749276543016, 1315.066302924915, 1331.7336532693307, 933.6965486217007, 946.6970569417858, 1016.6848277034143, 1031.6595523477235, 1051.8369652703843, 6338.651374174465, 6339.302676705559, 6344.238691356974, 6382.266039405435, 6425.935740642533, 987.7975015121883, 993.7863359377768, 1007.9949600251952, 1039.2725092435326, 1068.278911734576, 4392.033752574429, 4421.823127074946, 4438.733675979452, 4439.933400998988, 4447.822087116479, 10791.136709063256, 10903.727406814893, 11373.829392559119, 11379.658610241706, 11386.829197562043, 10994.615188468526, 11230.382328971986, 11294.491747871201, 11301.886981130248, 11327.660170194908, 8405.033421156646, 8501.489910605384, 8573.957130214309, 8577.313814894793, 8585.699500517452, 6307.716152773044, 6396.520260980538, 6488.286288508355, 6611.900821487778, 6717.966410168114, 10283.12593429567, 10290.434026128634, 10378.896211038094, 10392.844107338246, 10712.57149714034, 10390.272680912263, 10610.946945265225, 10624.36253824742, 10625.787484250426, 10647.148228141576, 8186.508809471213, 8260.339172866035, 8351.791205219919, 8365.372597055124, 8368.456050356708, 8669.089745576624, 8683.2185103341, 8733.257673097858, 8734.170253825876, 8803.03166651655, 6625.238097618835, 7323.597202153933, 7395.408367330709, 8045.115037346004, 8171.387145964195, 7786.065672119155, 7796.805079873048, 7870.370370370242, 7904.446688731734, 8008.559529225949, 7347.044884165238, 7387.926120738939, 7409.147947985835, 7409.814754630962, 7426.4058875288765, 5290.232916227203, 5393.649412788156, 5518.586106041983, 5527.198556209408, 5638.182463542681, 5620.634658747168, 5655.858603534944, 5662.235598194191, 5717.571182161438, 5769.394213607511], "value": 4850.702992862278, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3322021379592, 353.81601567185066, 356.99999999999994, 363.15566308333115, 363.5491989932481, 5462.754176062077, 5464.6994415307145, 5487.314085739283, 5492.203630473584, 5518.530924871386, 5390.811321603745, 5405.216243644669, 5445.53712934401, 5457.662872596209, 5466.1527463243165, 3833.252515759428, 4027.778472184036, 4220.53574106848, 4256.680748943826, 4265.104328091089, 4226.091390351074, 4245.872623821275, 4251.171021650779, 4267.4025636410925, 4272.615464608185, 3995.5205375354853, 4222.97888510557, 4242.9575704243025, 4249.3413520904305, 4264.616184543391, 4139.317012692902, 4257.531671516131, 4266.87199384019, 4276.893077673052, 4289.935650965238, 3828.846846126152, 3830.0, 3838.7120965927666, 3839.3856982882885, 3866.975251558339, 5225.973870130625, 5248.921266181011, 5251.632385733, 5254.264402983586, 5254.553362964152, 4888.144574699413, 4915.705057696549, 4922.926156107661, 4948.529889660476, 4983.90032199354, 5365.275687782138, 5461.18082287656, 5525.696086715229, 5569.10894256917, 5677.0, 3953.8220780064967, 4041.4746083009313, 4192.937105943413, 4218.050938538835, 4222.5566315536735, 5776.826695199109, 5780.161876527922, 5782.479576838063, 5835.883282334372, 5848.97075514624, 4007.238624661305, 4196.664266858644, 4199.874003779831, 4216.894577635584, 4222.514410842731, 4231.280682284019, 4247.426597409372, 4248.150369926027, 4259.148170365939, 4260.8508702195895, 4795.040991801654, 4796.968651739892, 4805.255185446262, 4808.374911261513, 4829.6860704054125, 5470.452954704498, 5622.156676498476, 5636.351819540805, 5682.602217844794, 5695.914561281584, 1447.985520144806, 1451.5992067654554, 1451.9274036298143, 1460.3866376122055, 1466.4940595494538, 915.9882484445079, 923.6397804856111, 938.6104766521817, 959.5154447004218, 959.8032403357295, 5021.59827213822, 5035.525487413673, 5045.823396181116, 5046.293518907356, 5085.2372144177925, 5148.897022059537, 5181.300524429229, 5201.956855239651, 5283.920741188886, 5285.127953887565, 4644.883877903079, 4943.629227807929, 4974.303597496353, 4978.327925730053, 4986.077575648516, 2760.9447811043665, 2775.9167224983285, 2782.9981206765547, 2793.399419124857, 2799.8740056697497, 5366.570674346043, 5410.3507579090765, 5426.620136590401, 5432.70120143388, 5490.505854473116, 5285.392179899284, 5328.200769884548, 5502.147167189092, 5983.311919129269, 6009.879802404015, 5905.527557795452, 6000.0, 6127.977767336679, 6138.754449822047, 6170.136180934583, 5822.272215973004, 5828.154917537018, 5843.181954526284, 5882.117682347682, 5912.586118971631, 5597.6641401516035, 5734.340550836707, 5744.0, 5768.711564421846, 5812.389699081705, 6127.509799216141, 6135.325114237341, 6146.279041868284, 6151.0, 6159.784407545714, 4160.729552579072, 4208.158368326286, 4223.767692776803, 4230.725002874803, 4231.788410579397, 5614.915776263441, 5890.764369425175, 5892.204552385545, 5922.348541660328, 5933.554983376351, 5698.31620205578, 5709.914351284651, 5721.713914304351, 5738.282714660668, 5759.136129580596, 5642.463965923231, 5754.4533269339345, 5761.185226653591, 5765.682887441231, 5786.594938354275, 5621.943780562306, 5629.746661400165, 5638.633488823213, 5642.605017648725, 5656.915146272891, 5733.254676891977, 5756.1941328214925, 5786.681732504752, 5814.94185058144, 5828.746819433842, 5449.754761035683, 5653.575981801464, 5671.234383358194, 5673.886522269614, 5708.686022268649], "value": 4290.038257016575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.7770457714973, 760.9391248700101, 842.995785021075, 879.1252703559959, 891.9331050171239, 14119.294035298246, 15471.38114475421, 15596.298166582503, 15710.607234819106, 15751.0, 15622.687546249068, 15746.84253157471, 15895.920520397382, 15934.362625494967, 15970.201489925486, 860.2601762484259, 866.7183165471215, 866.9003064647583, 874.038557586656, 878.7100256915235, 868.3053557154283, 869.2741560796742, 872.9432586881833, 873.1486800369652, 873.7902903303225, 915.158054589779, 916.8808054952847, 918.5131880103522, 918.9494577798218, 919.1314208073373, 914.2137761525083, 914.4604683236889, 917.8944421391559, 918.1002617434951, 918.2608000559546, 671.5366397185975, 673.5655502201101, 673.6901025528263, 673.7911247513238, 673.9123913891162, 14327.856721432756, 14334.92832535841, 14396.856031439656, 14405.711885762226, 14427.495037673736, 13828.792568111487, 13837.584872453843, 13847.515336963157, 13963.092398994033, 14128.434862605483, 11948.163628546004, 12120.488639528805, 12251.571195008131, 12475.75048499034, 12520.499180032788, 3999.7200195986293, 4035.8991025224605, 4049.6355328020327, 4060.776657283848, 4198.9370159447635, 58313.0, 65441.345586544005, 67885.66057169731, 68193.0, 72373.0, 11288.661340159808, 11545.249558778652, 11593.594224202112, 11740.29558226492, 11874.76250475003, 23395.0, 23665.645015324782, 23713.28860134199, 23726.169584064475, 23736.050557977487, 9304.674336398193, 9314.115159059878, 9387.249020078514, 9399.765005874908, 9445.905540944503, 4848.9757551212015, 4896.608271338285, 4980.427250866197, 5008.549230569266, 5077.796888124508, 3724.1620635356826, 3824.7513911595656, 3826.5408151022057, 3832.4442955771256, 3832.827522761482, 647.456136845043, 660.8149718078946, 665.4576520136073, 667.3993405934698, 681.7681988124061, 621.1924498152384, 683.6786710246176, 742.769741380163, 763.9236076392316, 764.0792844622327, 9872.60509579623, 10283.640072597424, 10410.531526081344, 10417.791644167075, 10433.0, 728.9416846652255, 729.1068441159643, 737.9926200738031, 741.2476336518438, 767.8771396576633, 4879.957212471775, 5010.55035622969, 5015.808638059663, 5045.225126180586, 5073.568746656576, 115185.4240728791, 116506.0, 118562.99399580946, 118990.0, 121546.0, 69630.0, 100438.0, 103790.48104759428, 104575.0, 105074.47462762638, 89017.55491222502, 89459.0, 89907.0, 90008.5499572498, 90197.0, 8925.285977121945, 8949.59726812308, 9087.2730181584, 9598.808023839623, 9795.363301385387, 52868.206976896145, 53244.0, 53826.0, 54182.18726719181, 55332.170017450575, 79066.20933790588, 79740.60129699315, 79771.60114199392, 80242.0, 81127.0, 12357.0, 12889.0, 12911.806322905351, 13023.6976302369, 13118.540851070167, 13765.0, 14052.508162214273, 14095.365708542935, 14096.224707641179, 14187.0, 12036.0, 12296.385180741107, 12303.323317217639, 12316.876831231932, 12539.93730031344, 12888.806667900177, 13105.0, 13256.0, 13408.128471649312, 13441.865581344062, 12677.87322126767, 13261.27063011505, 13503.662408439868, 13535.323233838466, 13781.86218137846, 10048.0, 10324.741881452723, 10554.261201715806, 10644.361338319726, 10855.620053298097, 10050.748731281776, 10236.896286557569, 10633.787324253317, 11008.614698485515, 11078.279911805706], "value": 7721.506261250504, "unit": "score"}], "name": "dromaeo_css", "value": 7461.8297628245455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 109.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 128.0, 124.0, 183.0, 125.0, 126.0, 157.0, 123.0, 153.0, 130.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 162.0, 162.0, 159.0, 159.0, 162.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 125.0, 74.0, 75.0, 74.0, 74.0, 100.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 111.0, 85.0, 85.0, 85.0, 117.0, 85.0, 85.0, 131.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 50.0, 51.0, 51.0, 53.0, 51.0, 51.0, 51.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 61.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 81.0, 75.0, 83.0, 77.0, 78.0, 77.0, 113.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 127.0, 124.0, 124.0, 115.0, 115.0, 125.0, 122.0, 129.0, 122.0], "value": 122.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 153.0, 152.0, 155.0, 156.0, 151.0, 154.0, 156.0, 151.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 62.0, 61.0, 60.0, 60.0, 63.0, 60.0, 61.0, 59.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1474.9, "alertThreshold": 2.0}]} 00:15:50 INFO - Return code: 0 00:15:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:15:50 ERROR - # TBPL SUCCESS # 00:15:50 INFO - Running post-action listener: _resource_record_post_action 00:15:50 INFO - ##### 00:15:50 INFO - ##### Finished run-tests step (success) 00:15:50 INFO - ##### 00:15:50 INFO - Running post-run listener: _resource_record_post_run 00:15:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 290816; Write bytes: 505384960; Read time: 36; Write time: 472808 00:15:50 INFO - TinderboxPrint: CPU usage
13.1% 00:15:50 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 36 00:15:50 INFO - TinderboxPrint: I/O write bytes / time
505,384,960 / 472,808 00:15:50 INFO - TinderboxPrint: CPU idle
8,253.8 (86.9%) 00:15:50 INFO - TinderboxPrint: CPU user
1,198.3 (12.6%) 00:15:50 INFO - TinderboxPrint: Swap in / out
0 / 0 00:15:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252661760; Read time: 0; Write time: 265404 00:15:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252723200; Read time: 28; Write time: 207404 00:15:50 INFO - Running post-run listener: _upload_blobber_files 00:15:50 INFO - Blob upload gear active. 00:15:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:15:50 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 00:15:50 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'] 00:15:50 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 00:15:51 INFO - (blobuploader) - INFO - Open directory for files ... 00:15:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:15:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:15:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:15:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:15:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:15:51 INFO - (blobuploader) - INFO - Done attempting. 00:15:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:15:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:15:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:15:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:15:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:15:56 INFO - (blobuploader) - INFO - Done attempting. 00:15:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:15:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:15:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:15:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:15:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:15:56 INFO - (blobuploader) - INFO - Done attempting. 00:15:56 INFO - (blobuploader) - INFO - Iteration through files over. 00:15:56 INFO - Return code: 0 00:15:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:15:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:15:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fbf095cf63e16a01b90201bebd5046fb7b7c9c5294ee11ba97d7549a9c290cf37909ee133ad11c80ff8d234a91a7296610d8b5429b004e0f4a72d7db55f1f7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bf15862a8da50ac427ac480614c6def802633d6a7ea30bed1696d14d56e3d80eed5c941eee324f71a608799476088edd4abd0f27445797c50fbbd0079fd1c53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffed0015f4b4522a3ed590529d8037f767f57bf80cebf0cd783c4d67ab09824953da8b24a8dff58e472fb4e83736278732913e704e854f761891f699dee0f1d0"} 00:15:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:15:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:15:56 INFO - Contents: 00:15:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fbf095cf63e16a01b90201bebd5046fb7b7c9c5294ee11ba97d7549a9c290cf37909ee133ad11c80ff8d234a91a7296610d8b5429b004e0f4a72d7db55f1f7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bf15862a8da50ac427ac480614c6def802633d6a7ea30bed1696d14d56e3d80eed5c941eee324f71a608799476088edd4abd0f27445797c50fbbd0079fd1c53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffed0015f4b4522a3ed590529d8037f767f57bf80cebf0cd783c4d67ab09824953da8b24a8dff58e472fb4e83736278732913e704e854f761891f699dee0f1d0"} 00:15:56 INFO - Running post-run listener: copy_logs_to_upload_dir 00:15:56 INFO - Copying logs to upload dir... 00:15:56 INFO - mkdir: /builds/slave/test/build/upload/logs 00:15:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.393117 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-07 00:15:56.807119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:15:56.810407) ========= 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=920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554 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/1fbf095cf63e16a01b90201bebd5046fb7b7c9c5294ee11ba97d7549a9c290cf37909ee133ad11c80ff8d234a91a7296610d8b5429b004e0f4a72d7db55f1f7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bf15862a8da50ac427ac480614c6def802633d6a7ea30bed1696d14d56e3d80eed5c941eee324f71a608799476088edd4abd0f27445797c50fbbd0079fd1c53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffed0015f4b4522a3ed590529d8037f767f57bf80cebf0cd783c4d67ab09824953da8b24a8dff58e472fb4e83736278732913e704e854f761891f699dee0f1d0"} build_url:https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/GBAGl25dS0e-LFxcFgUQmw/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/1fbf095cf63e16a01b90201bebd5046fb7b7c9c5294ee11ba97d7549a9c290cf37909ee133ad11c80ff8d234a91a7296610d8b5429b004e0f4a72d7db55f1f7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bf15862a8da50ac427ac480614c6def802633d6a7ea30bed1696d14d56e3d80eed5c941eee324f71a608799476088edd4abd0f27445797c50fbbd0079fd1c53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffed0015f4b4522a3ed590529d8037f767f57bf80cebf0cd783c4d67ab09824953da8b24a8dff58e472fb4e83736278732913e704e854f761891f699dee0f1d0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:15:56.835317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:15:56.835610) ========= 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=920470bf432669ad7e3a5387000001ca-1467873455.197889-1015617554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:15:56.921595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:15:56.921887) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:15:56.922166) ========= ========= Total master_lag: 0.17 =========