builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1466105678.98 results: success (0) buildid: 20160616094524 builduid: 68c0dcfd75a143579ce58ec5d8d60525 revision: 541035fe27cb71fd6fdcd273c5190edd688f0731 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:38.978391) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:38.979942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:38.980237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:38.995487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:38.996037) ========= 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=af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 12:34:39-- 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% 38.3M=0s 2016-06-16 12:34:39 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.102143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.102454) ========= 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=af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.152541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.152892) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 541035fe27cb71fd6fdcd273c5190edd688f0731 --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 541035fe27cb71fd6fdcd273c5190edd688f0731 --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=af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 12:34:39,553 truncating revision to first 12 chars 2016-06-16 12:34:39,553 Setting DEBUG logging. 2016-06-16 12:34:39,553 attempt 1/10 2016-06-16 12:34:39,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/541035fe27cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 12:34:39,857 unpacking tar archive at: mozilla-aurora-541035fe27cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.833378) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.833710) ========= script_repo_revision: 541035fe27cb71fd6fdcd273c5190edd688f0731 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.834099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.834362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:39.841991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-16 12:34:39.842252) ========= /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=af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:34:40 INFO - MultiFileLogger online at 20160616 12:34:40 in /builds/slave/test 12:34:40 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 12:34:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:40 INFO - {'append_to_log': False, 12:34:40 INFO - 'base_work_dir': '/builds/slave/test', 12:34:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:34:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:40 INFO - 'branch': 'Mozilla-Aurora', 12:34:40 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:40 INFO - 'config_files': ('talos/linux_config.py',), 12:34:40 INFO - 'default_actions': ('clobber', 12:34:40 INFO - 'read-buildbot-config', 12:34:40 INFO - 'download-and-extract', 12:34:40 INFO - 'populate-webroot', 12:34:40 INFO - 'create-virtualenv', 12:34:40 INFO - 'install', 12:34:40 INFO - 'run-tests'), 12:34:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:40 INFO - 'download_minidump_stackwalk': True, 12:34:40 INFO - 'download_symbols': 'ondemand', 12:34:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:40 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:40 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:40 INFO - 'installer_path': 'installer.exe', 12:34:40 INFO - 'log_level': 'info', 12:34:40 INFO - 'log_name': 'talos', 12:34:40 INFO - 'log_to_console': True, 12:34:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:34:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:34:40 INFO - 'opt_config_files': (), 12:34:40 INFO - 'pip_index': False, 12:34:40 INFO - 'sps_profile': False, 12:34:40 INFO - 'sps_profile_interval': 0, 12:34:40 INFO - 'suite': 'dromaeojs', 12:34:40 INFO - 'system_bits': '32', 12:34:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:40 INFO - 'title': 'talos-linux64-ix-020', 12:34:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:40 INFO - 'use_talos_json': True, 12:34:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:40 INFO - 'work_dir': 'build'} 12:34:40 INFO - ##### 12:34:40 INFO - ##### Running clobber step. 12:34:40 INFO - ##### 12:34:40 INFO - Running pre-action listener: _resource_record_pre_action 12:34:40 INFO - Running main action method: clobber 12:34:40 INFO - rmtree: /builds/slave/test/build 12:34:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:41 INFO - Running post-action listener: _resource_record_post_action 12:34:41 INFO - ##### 12:34:41 INFO - ##### Finished clobber step (success) 12:34:41 INFO - ##### 12:34:41 INFO - ##### 12:34:41 INFO - ##### Running read-buildbot-config step. 12:34:41 INFO - ##### 12:34:41 INFO - Running pre-action listener: _resource_record_pre_action 12:34:41 INFO - Running main action method: read_buildbot_config 12:34:41 INFO - Using buildbot properties: 12:34:41 INFO - { 12:34:41 INFO - "project": "", 12:34:41 INFO - "product": "firefox", 12:34:41 INFO - "script_repo_revision": "production", 12:34:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:34:41 INFO - "repository": "", 12:34:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:34:41 INFO - "buildid": "20160616094524", 12:34:41 INFO - "pgo_build": "True", 12:34:41 INFO - "basedir": "/builds/slave/test", 12:34:41 INFO - "buildnumber": 567, 12:34:41 INFO - "slavename": "talos-linux64-ix-020", 12:34:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:34:41 INFO - "platform": "ubuntu64_hw", 12:34:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:34:41 INFO - "branch": "mozilla-aurora", 12:34:41 INFO - "repo_path": "releases/mozilla-aurora", 12:34:41 INFO - "revision": "541035fe27cb71fd6fdcd273c5190edd688f0731", 12:34:41 INFO - "stage_platform": "linux64-pgo", 12:34:41 INFO - "builduid": "68c0dcfd75a143579ce58ec5d8d60525", 12:34:41 INFO - "slavebuilddir": "test" 12:34:41 INFO - } 12:34:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 12:34:41 INFO - Running post-action listener: _resource_record_post_action 12:34:41 INFO - ##### 12:34:41 INFO - ##### Finished read-buildbot-config step (success) 12:34:41 INFO - ##### 12:34:41 INFO - ##### 12:34:41 INFO - ##### Running download-and-extract step. 12:34:41 INFO - ##### 12:34:41 INFO - Running pre-action listener: _resource_record_pre_action 12:34:41 INFO - Running main action method: download_and_extract 12:34:41 INFO - mkdir: /builds/slave/test/build/tests 12:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:41 INFO - https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:34:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:34:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:34:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:42 INFO - Downloaded 1361 bytes. 12:34:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:34:42 INFO - Using the following test package requirements: 12:34:42 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:34:42 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:34:42 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:34:42 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'jsshell-linux-x86_64.zip'], 12:34:42 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:34:42 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:34:42 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:34:42 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:34:42 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:34:42 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:34:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:34:42 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:34: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')]} 12:34:42 INFO - https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:34:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:34:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:34:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:49 INFO - Downloaded 24472527 bytes. 12:34:49 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'] 12:34:49 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 12:34:50 INFO - Return code: 0 12:34:50 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 12:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:50 INFO - https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:34:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:34:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:34:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:51 INFO - Downloaded 24472527 bytes. 12:34:51 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'] 12:34:51 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 12:34:53 INFO - Return code: 0 12:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:53 INFO - https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:34:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:34:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:34:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:54 INFO - Downloaded 10833369 bytes. 12:34:54 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'] 12:34:54 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 12:34:54 INFO - Return code: 0 12:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:54 INFO - https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:34:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:34:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:34:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDGyjTWWTnyOYx9dG_XatA/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 12:34:58 INFO - Downloaded 63556530 bytes. 12:34:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:34:58 INFO - mkdir: /builds/slave/test/properties 12:34:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:58 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:58 INFO - Contents: 12:34:58 INFO - build_url:https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:34:59 INFO - Running post-action listener: _resource_record_post_action 12:34:59 INFO - Running post-action listener: set_extra_try_arguments 12:34:59 INFO - ##### 12:34:59 INFO - ##### Finished download-and-extract step (success) 12:34:59 INFO - ##### 12:34:59 INFO - ##### 12:34:59 INFO - ##### Running populate-webroot step. 12:34:59 INFO - ##### 12:34:59 INFO - Running pre-action listener: _resource_record_pre_action 12:34:59 INFO - Running main action method: populate_webroot 12:34:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:59 INFO - '--tppagecycles', 12:34:59 INFO - '7'], 12:34:59 INFO - 'tests': ['tsvgm']}}, 12:34:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:34:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:34:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['damp', 'tps']}, 12:34:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'tests': ['damp', 'tps']}, 12:34:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['dromaeo_dom']}, 12:34:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['a11yr', 12:34:59 INFO - 'ts_paint', 12:34:59 INFO - 'tpaint', 12:34:59 INFO - 'sessionrestore', 12:34:59 INFO - 'sessionrestore_no_auto_restore', 12:34:59 INFO - 'tabpaint']}, 12:34:59 INFO - 'other-e10s': {'tests': ['a11yr', 12:34:59 INFO - 'ts_paint', 12:34:59 INFO - 'tpaint', 12:34:59 INFO - 'sessionrestore', 12:34:59 INFO - 'sessionrestore_no_auto_restore', 12:34:59 INFO - 'tabpaint']}, 12:34:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:34:59 INFO - 'ts_paint', 12:34:59 INFO - 'tpaint', 12:34:59 INFO - 'sessionrestore', 12:34:59 INFO - 'sessionrestore_no_auto_restore', 12:34:59 INFO - 'tabpaint']}, 12:34:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:34:59 INFO - 'ts_paint', 12:34:59 INFO - 'tpaint', 12:34:59 INFO - 'sessionrestore', 12:34:59 INFO - 'sessionrestore_no_auto_restore', 12:34:59 INFO - 'tabpaint']}, 12:34:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['a11yr', 12:34:59 INFO - 'ts_paint', 12:34:59 INFO - 'tpaint', 12:34:59 INFO - 'sessionrestore', 12:34:59 INFO - 'sessionrestore_no_auto_restore', 12:34:59 INFO - 'tabpaint']}, 12:34:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['a11yr', 12:34:59 INFO - 'ts_paint', 12:34:59 INFO - 'tpaint', 12:34:59 INFO - 'sessionrestore', 12:34:59 INFO - 'sessionrestore_no_auto_restore', 12:34:59 INFO - 'tabpaint']}, 12:34:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['tsvgx', 12:34:59 INFO - 'tsvgr_opacity', 12:34:59 INFO - 'tart', 12:34:59 INFO - 'tscrollx', 12:34:59 INFO - 'cart']}, 12:34:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:34:59 INFO - 'tsvgr_opacity', 12:34:59 INFO - 'tart', 12:34:59 INFO - 'tscrollx', 12:34:59 INFO - 'cart']}, 12:34:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'talos_options': ['--disable-e10s'], 12:34:59 INFO - 'tests': ['tp5o']}, 12:34:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'tests': ['tp5o']}, 12:34:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'talos_options': ['--disable-e10s', 12:34:59 INFO - '--xperf_path', 12:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:59 INFO - 'tests': ['tp5n']}, 12:34:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:59 INFO - 'talos_options': ['--xperf_path', 12:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:59 INFO - 'tests': ['tp5n']}}, 12:34:59 INFO - 'talos.zip': {'path': '', 12:34:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:59 INFO - Running post-action listener: _resource_record_post_action 12:34:59 INFO - ##### 12:34:59 INFO - ##### Finished populate-webroot step (success) 12:34:59 INFO - ##### 12:34:59 INFO - ##### 12:34:59 INFO - ##### Running create-virtualenv step. 12:34:59 INFO - ##### 12:34:59 INFO - Running pre-action listener: _resource_record_pre_action 12:34:59 INFO - Running main action method: create_virtualenv 12:34:59 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:59 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 12:34:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:59 INFO - Using real prefix '/usr' 12:34:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:59 INFO - Installing distribute.............................................................................................................................................................................................done. 12:35:01 INFO - Installing pip.................done. 12:35:01 INFO - Return code: 0 12:35:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:01 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 12:35:01 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 12:35:01 INFO - Using env: {'DISPLAY': ':0', 12:35:01 INFO - 'HOME': '/home/cltbld', 12:35:01 INFO - 'LANG': 'en_US.UTF-8', 12:35:01 INFO - 'LANGUAGE': 'en_US:en', 12:35:01 INFO - 'LOGNAME': 'cltbld', 12:35:01 INFO - 'MAIL': '/var/mail/cltbld', 12:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:01 INFO - 'MOZ_NO_REMOTE': '1', 12:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:01 INFO - 'NO_EM_RESTART': '1', 12:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:01 INFO - 'PWD': '/builds/slave/test', 12:35:01 INFO - 'SHELL': '/bin/bash', 12:35:01 INFO - 'SHLVL': '1', 12:35:01 INFO - 'TERM': 'linux', 12:35:01 INFO - 'TMOUT': '86400', 12:35:01 INFO - 'USER': 'cltbld', 12:35:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:01 INFO - '_': '/tools/buildbot/bin/python'} 12:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:01 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 12:35:01 INFO - Cleaning up... 12:35:01 INFO - Return code: 0 12:35:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:01 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 12:35:01 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 12:35:01 INFO - Using env: {'DISPLAY': ':0', 12:35:01 INFO - 'HOME': '/home/cltbld', 12:35:01 INFO - 'LANG': 'en_US.UTF-8', 12:35:01 INFO - 'LANGUAGE': 'en_US:en', 12:35:01 INFO - 'LOGNAME': 'cltbld', 12:35:01 INFO - 'MAIL': '/var/mail/cltbld', 12:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:01 INFO - 'MOZ_NO_REMOTE': '1', 12:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:01 INFO - 'NO_EM_RESTART': '1', 12:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:01 INFO - 'PWD': '/builds/slave/test', 12:35:01 INFO - 'SHELL': '/bin/bash', 12:35:01 INFO - 'SHLVL': '1', 12:35:01 INFO - 'TERM': 'linux', 12:35:01 INFO - 'TMOUT': '86400', 12:35:01 INFO - 'USER': 'cltbld', 12:35:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:01 INFO - '_': '/tools/buildbot/bin/python'} 12:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:02 INFO - Downloading/unpacking psutil>=3.1.1 12:35:02 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 12:35:02 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 12:35:02 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 12:35:02 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 12:35:02 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 12:35:02 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 12:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:35:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:04 INFO - Installing collected packages: psutil 12:35:04 INFO - Running setup.py install for psutil 12:35:04 INFO - building 'psutil._psutil_linux' extension 12:35:04 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 12:35:04 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 12:35:04 INFO - building 'psutil._psutil_posix' extension 12:35:04 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 12:35:04 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 12:35:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:04 INFO - Successfully installed psutil 12:35:04 INFO - Cleaning up... 12:35:04 INFO - Return code: 0 12:35:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:04 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:04 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 12:35:04 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 12:35:04 INFO - Using env: {'DISPLAY': ':0', 12:35:04 INFO - 'HOME': '/home/cltbld', 12:35:04 INFO - 'LANG': 'en_US.UTF-8', 12:35:04 INFO - 'LANGUAGE': 'en_US:en', 12:35:04 INFO - 'LOGNAME': 'cltbld', 12:35:04 INFO - 'MAIL': '/var/mail/cltbld', 12:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:04 INFO - 'MOZ_NO_REMOTE': '1', 12:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:04 INFO - 'NO_EM_RESTART': '1', 12:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:04 INFO - 'PWD': '/builds/slave/test', 12:35:04 INFO - 'SHELL': '/bin/bash', 12:35:04 INFO - 'SHLVL': '1', 12:35:04 INFO - 'TERM': 'linux', 12:35:04 INFO - 'TMOUT': '86400', 12:35:04 INFO - 'USER': 'cltbld', 12:35:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:04 INFO - '_': '/tools/buildbot/bin/python'} 12:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:35:04 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 12:35:04 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 12:35:04 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 12:35:04 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 12:35:04 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 12:35:04 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 12:35:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:35:06 INFO - Installing collected packages: mozsystemmonitor 12:35:06 INFO - Running setup.py install for mozsystemmonitor 12:35:06 INFO - Successfully installed mozsystemmonitor 12:35:06 INFO - Cleaning up... 12:35:06 INFO - Return code: 0 12:35:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:35:06 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')]} 12:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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')]} 12:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:06 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 12:35:06 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 12:35:06 INFO - Using env: {'DISPLAY': ':0', 12:35:06 INFO - 'HOME': '/home/cltbld', 12:35:06 INFO - 'LANG': 'en_US.UTF-8', 12:35:06 INFO - 'LANGUAGE': 'en_US:en', 12:35:06 INFO - 'LOGNAME': 'cltbld', 12:35:06 INFO - 'MAIL': '/var/mail/cltbld', 12:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:06 INFO - 'MOZ_NO_REMOTE': '1', 12:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:06 INFO - 'NO_EM_RESTART': '1', 12:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:06 INFO - 'PWD': '/builds/slave/test', 12:35:06 INFO - 'SHELL': '/bin/bash', 12:35:06 INFO - 'SHLVL': '1', 12:35:06 INFO - 'TERM': 'linux', 12:35:06 INFO - 'TMOUT': '86400', 12:35:06 INFO - 'USER': 'cltbld', 12:35:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:06 INFO - '_': '/tools/buildbot/bin/python'} 12:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:07 INFO - Downloading/unpacking jsonschema==2.5.1 12:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:35:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:35:09 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 12:35:09 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 12:35:09 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 12:35:09 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 12:35:09 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 12:35:09 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 12:35:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:35:09 INFO - warning: no files found matching '*.txt' 12:35:09 INFO - no previously-included directories found matching 'build' 12:35:09 INFO - no previously-included directories found matching 'dist' 12:35:09 INFO - no previously-included directories found matching '.git*' 12:35:09 INFO - Installing collected packages: jsonschema, functools32 12:35:09 INFO - Running setup.py install for functools32 12:35:09 INFO - warning: no files found matching '*.txt' 12:35:09 INFO - no previously-included directories found matching 'build' 12:35:09 INFO - no previously-included directories found matching 'dist' 12:35:09 INFO - no previously-included directories found matching '.git*' 12:35:09 INFO - Successfully installed jsonschema functools32 12:35:09 INFO - Cleaning up... 12:35:09 INFO - Return code: 0 12:35:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:35:09 INFO - Using env: {'DISPLAY': ':0', 12:35:09 INFO - 'HOME': '/home/cltbld', 12:35:09 INFO - 'LANG': 'en_US.UTF-8', 12:35:09 INFO - 'LANGUAGE': 'en_US:en', 12:35:09 INFO - 'LOGNAME': 'cltbld', 12:35:09 INFO - 'MAIL': '/var/mail/cltbld', 12:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:09 INFO - 'MOZ_NO_REMOTE': '1', 12:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:09 INFO - 'NO_EM_RESTART': '1', 12:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:09 INFO - 'PWD': '/builds/slave/test', 12:35:09 INFO - 'SHELL': '/bin/bash', 12:35:09 INFO - 'SHLVL': '1', 12:35:09 INFO - 'TERM': 'linux', 12:35:09 INFO - 'TMOUT': '86400', 12:35:09 INFO - 'USER': 'cltbld', 12:35:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:09 INFO - '_': '/tools/buildbot/bin/python'} 12:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:09 INFO - Downloading/unpacking blobuploader==1.2.4 12:35:09 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 12:35:09 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 12:35:09 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 12:35:09 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 12:35:09 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 12:35:09 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 12:35:11 INFO - Downloading blobuploader-1.2.4.tar.gz 12:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:35:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:35:11 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 12:35:11 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 12:35:11 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 12:35:11 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 12:35:11 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 12:35:11 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 12:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:35:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:12 INFO - Downloading docopt-0.6.1.tar.gz 12:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:35:12 INFO - Installing collected packages: blobuploader, requests, docopt 12:35:12 INFO - Running setup.py install for blobuploader 12:35:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:35:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:35:12 INFO - Running setup.py install for requests 12:35:12 INFO - Running setup.py install for docopt 12:35:12 INFO - Successfully installed blobuploader requests docopt 12:35:12 INFO - Cleaning up... 12:35:13 INFO - Return code: 0 12:35:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:13 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:13 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 12:35:13 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 12:35:13 INFO - Using env: {'DISPLAY': ':0', 12:35:13 INFO - 'HOME': '/home/cltbld', 12:35:13 INFO - 'LANG': 'en_US.UTF-8', 12:35:13 INFO - 'LANGUAGE': 'en_US:en', 12:35:13 INFO - 'LOGNAME': 'cltbld', 12:35:13 INFO - 'MAIL': '/var/mail/cltbld', 12:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:13 INFO - 'MOZ_NO_REMOTE': '1', 12:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:13 INFO - 'NO_EM_RESTART': '1', 12:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:13 INFO - 'PWD': '/builds/slave/test', 12:35:13 INFO - 'SHELL': '/bin/bash', 12:35:13 INFO - 'SHLVL': '1', 12:35:13 INFO - 'TERM': 'linux', 12:35:13 INFO - 'TMOUT': '86400', 12:35:13 INFO - 'USER': 'cltbld', 12:35:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:13 INFO - '_': '/tools/buildbot/bin/python'} 12:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:13 INFO - Running setup.py (path:/tmp/pip-Nabfmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:13 INFO - Running setup.py (path:/tmp/pip-0BSsmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:13 INFO - Running setup.py (path:/tmp/pip-48ESLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:13 INFO - Running setup.py (path:/tmp/pip-ybVdJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:13 INFO - Running setup.py (path:/tmp/pip-LrWqsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:13 INFO - Running setup.py (path:/tmp/pip-aVxsRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:13 INFO - Running setup.py (path:/tmp/pip-OaucWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:13 INFO - Running setup.py (path:/tmp/pip-VdyxeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:13 INFO - Running setup.py (path:/tmp/pip-tkXArY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:13 INFO - Running setup.py (path:/tmp/pip-Fufs5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:13 INFO - Running setup.py (path:/tmp/pip-z9wFPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:14 INFO - Running setup.py (path:/tmp/pip-Eja5aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:14 INFO - Running setup.py (path:/tmp/pip-lUZ0DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:14 INFO - Running setup.py (path:/tmp/pip-cGzLum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:14 INFO - Running setup.py (path:/tmp/pip-zOsHWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:14 INFO - Running setup.py (path:/tmp/pip-9rH_j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:14 INFO - Running setup.py (path:/tmp/pip-3tXDOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:35:14 INFO - Running setup.py install for manifestparser 12:35:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:35:14 INFO - Running setup.py install for mozcrash 12:35:14 INFO - Running setup.py install for mozdebug 12:35:14 INFO - Running setup.py install for mozdevice 12:35:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:35:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:35:14 INFO - Running setup.py install for mozfile 12:35:15 INFO - Running setup.py install for mozhttpd 12:35:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Running setup.py install for mozinfo 12:35:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Running setup.py install for mozInstall 12:35:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Running setup.py install for mozleak 12:35:15 INFO - Running setup.py install for mozlog 12:35:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Running setup.py install for moznetwork 12:35:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Running setup.py install for mozprocess 12:35:15 INFO - Running setup.py install for mozprofile 12:35:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Running setup.py install for mozrunner 12:35:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:35:15 INFO - Running setup.py install for mozscreenshot 12:35:16 INFO - Running setup.py install for moztest 12:35:16 INFO - Running setup.py install for mozversion 12:35:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:35:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:35:16 INFO - Cleaning up... 12:35:16 INFO - Return code: 0 12:35:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:16 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:16 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 12:35:16 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 12:35:16 INFO - Using env: {'DISPLAY': ':0', 12:35:16 INFO - 'HOME': '/home/cltbld', 12:35:16 INFO - 'LANG': 'en_US.UTF-8', 12:35:16 INFO - 'LANGUAGE': 'en_US:en', 12:35:16 INFO - 'LOGNAME': 'cltbld', 12:35:16 INFO - 'MAIL': '/var/mail/cltbld', 12:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:16 INFO - 'MOZ_NO_REMOTE': '1', 12:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:16 INFO - 'NO_EM_RESTART': '1', 12:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:16 INFO - 'PWD': '/builds/slave/test', 12:35:16 INFO - 'SHELL': '/bin/bash', 12:35:16 INFO - 'SHLVL': '1', 12:35:16 INFO - 'TERM': 'linux', 12:35:16 INFO - 'TMOUT': '86400', 12:35:16 INFO - 'USER': 'cltbld', 12:35:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:16 INFO - '_': '/tools/buildbot/bin/python'} 12:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:16 INFO - Running setup.py (path:/tmp/pip-yXphbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:16 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)) 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:16 INFO - Running setup.py (path:/tmp/pip-pNqJAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:16 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)) 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:16 INFO - Running setup.py (path:/tmp/pip-moVWRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:16 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)) 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:16 INFO - Running setup.py (path:/tmp/pip-NFmDX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:16 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)) 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:16 INFO - Running setup.py (path:/tmp/pip-hPj8oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:16 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)) 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:16 INFO - Running setup.py (path:/tmp/pip-I8ia6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:16 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)) 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:16 INFO - Running setup.py (path:/tmp/pip-u_L76f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:16 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)) 12:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:17 INFO - Running setup.py (path:/tmp/pip-USM4GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:17 INFO - Running setup.py (path:/tmp/pip-GIZOjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:17 INFO - Running setup.py (path:/tmp/pip-BdwYr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:17 INFO - Running setup.py (path:/tmp/pip-E22eI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:17 INFO - Running setup.py (path:/tmp/pip-fA8vhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:17 INFO - Running setup.py (path:/tmp/pip-EGpga1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:17 INFO - Running setup.py (path:/tmp/pip-bISOz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:17 INFO - Running setup.py (path:/tmp/pip-bzVkUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:17 INFO - Running setup.py (path:/tmp/pip-rXsjRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:17 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)) 12:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:17 INFO - Running setup.py (path:/tmp/pip-5uh8Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:17 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)) 12:35:17 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)) 12:35:17 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)) 12:35:17 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)) 12:35:17 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)) 12:35:17 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)) 12:35:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:19 INFO - Downloading blessings-1.6.tar.gz 12:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:19 INFO - Installing collected packages: blessings 12:35:19 INFO - Running setup.py install for blessings 12:35:19 INFO - Successfully installed blessings 12:35:19 INFO - Cleaning up... 12:35:20 INFO - Return code: 0 12:35:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:20 INFO - Reading from file tmpfile_stdout 12:35:20 INFO - Current package versions: 12:35:20 INFO - argparse == 1.2.1 12:35:20 INFO - blessings == 1.6 12:35:20 INFO - blobuploader == 1.2.4 12:35:20 INFO - docopt == 0.6.1 12:35:20 INFO - functools32 == 3.2.3-2 12:35:20 INFO - jsonschema == 2.5.1 12:35:20 INFO - manifestparser == 1.1 12:35:20 INFO - mozInstall == 1.12 12:35:20 INFO - mozcrash == 0.17 12:35:20 INFO - mozdebug == 0.1 12:35:20 INFO - mozdevice == 0.48 12:35:20 INFO - mozfile == 1.2 12:35:20 INFO - mozhttpd == 0.7 12:35:20 INFO - mozinfo == 0.9 12:35:20 INFO - mozleak == 0.1 12:35:20 INFO - mozlog == 3.2 12:35:20 INFO - moznetwork == 0.27 12:35:20 INFO - mozprocess == 0.22 12:35:20 INFO - mozprofile == 0.28 12:35:20 INFO - mozrunner == 6.11 12:35:20 INFO - mozscreenshot == 0.1 12:35:20 INFO - mozsystemmonitor == 0.3 12:35:20 INFO - moztest == 0.7 12:35:20 INFO - mozversion == 1.4 12:35:20 INFO - psutil == 3.1.1 12:35:20 INFO - requests == 1.2.3 12:35:20 INFO - wsgiref == 0.1.2 12:35:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:20 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:20 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 12:35:20 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 12:35:20 INFO - Using env: {'DISPLAY': ':0', 12:35:20 INFO - 'HOME': '/home/cltbld', 12:35:20 INFO - 'LANG': 'en_US.UTF-8', 12:35:20 INFO - 'LANGUAGE': 'en_US:en', 12:35:20 INFO - 'LOGNAME': 'cltbld', 12:35:20 INFO - 'MAIL': '/var/mail/cltbld', 12:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:20 INFO - 'MOZ_NO_REMOTE': '1', 12:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:20 INFO - 'NO_EM_RESTART': '1', 12:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:20 INFO - 'PWD': '/builds/slave/test', 12:35:20 INFO - 'SHELL': '/bin/bash', 12:35:20 INFO - 'SHLVL': '1', 12:35:20 INFO - 'TERM': 'linux', 12:35:20 INFO - 'TMOUT': '86400', 12:35:20 INFO - 'USER': 'cltbld', 12:35:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:20 INFO - '_': '/tools/buildbot/bin/python'} 12:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 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)) 12:35:20 INFO - Cleaning up... 12:35:20 INFO - Return code: 0 12:35:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:20 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:20 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 12:35:20 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 12:35:20 INFO - Using env: {'DISPLAY': ':0', 12:35:20 INFO - 'HOME': '/home/cltbld', 12:35:20 INFO - 'LANG': 'en_US.UTF-8', 12:35:20 INFO - 'LANGUAGE': 'en_US:en', 12:35:20 INFO - 'LOGNAME': 'cltbld', 12:35:20 INFO - 'MAIL': '/var/mail/cltbld', 12:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:20 INFO - 'MOZ_NO_REMOTE': '1', 12:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:20 INFO - 'NO_EM_RESTART': '1', 12:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:20 INFO - 'PWD': '/builds/slave/test', 12:35:20 INFO - 'SHELL': '/bin/bash', 12:35:20 INFO - 'SHLVL': '1', 12:35:20 INFO - 'TERM': 'linux', 12:35:20 INFO - 'TMOUT': '86400', 12:35:20 INFO - 'USER': 'cltbld', 12:35:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:20 INFO - '_': '/tools/buildbot/bin/python'} 12:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:35:20 INFO - Cleaning up... 12:35:20 INFO - Return code: 0 12:35:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:20 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 0x7fa42dcf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', '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 12:35:20 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 12:35:20 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 12:35:20 INFO - Using env: {'DISPLAY': ':0', 12:35:20 INFO - 'HOME': '/home/cltbld', 12:35:20 INFO - 'LANG': 'en_US.UTF-8', 12:35:20 INFO - 'LANGUAGE': 'en_US:en', 12:35:20 INFO - 'LOGNAME': 'cltbld', 12:35:20 INFO - 'MAIL': '/var/mail/cltbld', 12:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:20 INFO - 'MOZ_NO_REMOTE': '1', 12:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:20 INFO - 'NO_EM_RESTART': '1', 12:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:20 INFO - 'PWD': '/builds/slave/test', 12:35:20 INFO - 'SHELL': '/bin/bash', 12:35:20 INFO - 'SHLVL': '1', 12:35:20 INFO - 'TERM': 'linux', 12:35:20 INFO - 'TMOUT': '86400', 12:35:20 INFO - 'USER': 'cltbld', 12:35:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:20 INFO - '_': '/tools/buildbot/bin/python'} 12:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:21 INFO - Downloading/unpacking flake8 12:35:21 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 12:35:21 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 12:35:21 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 12:35:21 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 12:35:21 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 12:35:21 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 12:35:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:35:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:35:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:35:23 INFO - no previously-included directories found matching 'docs/_build' 12:35:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:35:23 INFO - Running setup.py install for pep8 12:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:35:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:35:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:35:23 INFO - no previously-included directories found matching 'docs/_build' 12:35:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:35:23 INFO - Cleaning up... 12:35:23 INFO - Return code: 0 12:35:23 INFO - Running post-action listener: _resource_record_post_action 12:35:23 INFO - Running post-action listener: _start_resource_monitoring 12:35:24 INFO - Starting resource monitoring. 12:35:24 INFO - ##### 12:35:24 INFO - ##### Finished create-virtualenv step (success) 12:35:24 INFO - ##### 12:35:24 INFO - ##### 12:35:24 INFO - ##### Running install step. 12:35:24 INFO - ##### 12:35:24 INFO - Running pre-action listener: _resource_record_pre_action 12:35:24 INFO - Running main action method: install 12:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:24 INFO - Reading from file tmpfile_stdout 12:35:24 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:24 INFO - Reading from file tmpfile_stdout 12:35:24 INFO - Output received: 12:35:24 INFO - Usage: mozinstall [options] installer 12:35:24 INFO - Options: 12:35:24 INFO - -h, --help show this help message and exit 12:35:24 INFO - -d DEST, --destination=DEST 12:35:24 INFO - Directory to install application into. [default: 12:35:24 INFO - "/builds/slave/test"] 12:35:24 INFO - --app=APP Application being installed. [default: firefox] 12:35:24 INFO - mkdir: /builds/slave/test/build/application 12:35:24 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'] 12:35:24 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 12:35:40 INFO - Reading from file tmpfile_stdout 12:35:40 INFO - Output received: 12:35:40 INFO - /builds/slave/test/build/application/firefox/firefox 12:35:40 INFO - Running post-action listener: _resource_record_post_action 12:35:40 INFO - ##### 12:35:40 INFO - ##### Finished install step (success) 12:35:40 INFO - ##### 12:35:40 INFO - ##### 12:35:40 INFO - ##### Running run-tests step. 12:35:40 INFO - ##### 12:35:40 INFO - Running pre-action listener: _resource_record_pre_action 12:35:40 INFO - Running main action method: run_tests 12:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:40 INFO - Python 2.7.3 12:35:40 INFO - Return code: 0 12:35:40 INFO - grabbing minidump binary from tooltool 12:35: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')]} 12:35:40 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 0x11061c0>, '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 0x11070c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:40 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 12:35:40 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 12:35:40 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 12:35:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:40 INFO - Return code: 0 12:35:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:35:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:35:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:35:41 INFO - Return code: 0 12:35:41 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/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 12:35:41 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/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 12:35:41 INFO - Using env: {'DISPLAY': ':0', 12:35:41 INFO - 'HOME': '/home/cltbld', 12:35:41 INFO - 'LANG': 'en_US.UTF-8', 12:35:41 INFO - 'LANGUAGE': 'en_US:en', 12:35:41 INFO - 'LOGNAME': 'cltbld', 12:35:41 INFO - 'MAIL': '/var/mail/cltbld', 12:35:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:41 INFO - 'MOZ_NO_REMOTE': '1', 12:35:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:41 INFO - 'NO_EM_RESTART': '1', 12:35:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:41 INFO - 'PWD': '/builds/slave/test', 12:35:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:41 INFO - 'SHELL': '/bin/bash', 12:35:41 INFO - 'SHLVL': '1', 12:35:41 INFO - 'TERM': 'linux', 12:35:41 INFO - 'TMOUT': '86400', 12:35:41 INFO - 'USER': 'cltbld', 12:35:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773', 12:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:41 INFO - '_': '/tools/buildbot/bin/python'} 12:35:41 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/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 12:35:41 INFO - mozversion application_buildid: 20160616094524 12:35:41 INFO - mozversion application_changeset: 541035fe27cb71fd6fdcd273c5190edd688f0731 12:35:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:35:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:41 INFO - mozversion application_name: Firefox 12:35:41 INFO - mozversion application_remotingname: firefox-dev 12:35:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:35:41 INFO - mozversion application_vendor: Mozilla 12:35:41 INFO - mozversion application_version: 49.0a2 12:35:41 INFO - mozversion platform_buildid: 20160616094524 12:35:41 INFO - mozversion platform_changeset: 541035fe27cb71fd6fdcd273c5190edd688f0731 12:35:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:35:41 INFO - mozversion platform_version: 49.0a2 12:35:41 INFO - using testdate: 1466105741 12:35:41 INFO - actual date: 1466105741 12:35:41 INFO - starting webserver on 'localhost:56812' 12:35:41 INFO - SUITE-START | Running 2 tests 12:35:41 INFO - TEST-START | dromaeo_css 12:35:41 INFO - operating with platform_type : linux_ 12:35:41 INFO - Initialising browser for dromaeo_css test... 12:35:41 INFO - TEST-INFO | started process 20851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRurT7/profile http://localhost:56812/getInfo.html) 12:35:45 INFO - PROCESS | 20851 | __metrics Screen width/height:1600/1200 12:35:45 INFO - PROCESS | 20851 | colorDepth:24 12:35:45 INFO - PROCESS | 20851 | Browser inner width/height: 1024/697 12:35:45 INFO - PROCESS | 20851 | __metrics 12:35:46 ERROR - PROCESS | 20851 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:35:46 INFO - PROCESS | 20851 | console.error: PushService: 12:35:46 INFO - PROCESS | 20851 | stateChangeProcessEnqueue: Error transitioning state 12:35:46 INFO - PROCESS | 20851 | UnknownError 12:35:47 INFO - TEST-INFO | 20851: exit 0 12:35:47 INFO - Browser initialized. 12:35:47 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:47 INFO - TEST-INFO | started process 20943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRurT7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:59 INFO - PROCESS | 20943 | RSS: Main: 145616896 12:35:59 INFO - PROCESS | 20943 | 12:36:50 INFO - PROCESS | 20943 | 1466105810882 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] 12:38:58 INFO - PROCESS | 20943 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56812/tests/dromaeo/cssquery-ext.html) 12:39:00 INFO - PROCESS | 20943 | RSS: Main: 253628416 12:39:00 INFO - PROCESS | 20943 | 12:42:02 INFO - PROCESS | 20943 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-ext.html (next: http://localhost:56812/tests/dromaeo/cssquery-jquery.html) 12:42:03 INFO - PROCESS | 20943 | RSS: Main: 223596544 12:42:03 INFO - PROCESS | 20943 | 12:45:05 INFO - PROCESS | 20943 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56812/tests/dromaeo/cssquery-mootools.html) 12:45:05 INFO - PROCESS | 20943 | RSS: Main: 223490048 12:45:05 INFO - PROCESS | 20943 | 12:48:07 INFO - PROCESS | 20943 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56812/tests/dromaeo/cssquery-prototype.html) 12:48:08 INFO - PROCESS | 20943 | RSS: Main: 223006720 12:48:08 INFO - PROCESS | 20943 | 12:51:10 INFO - PROCESS | 20943 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56812/tests/dromaeo/cssquery-yui.html) 12:51:11 INFO - PROCESS | 20943 | RSS: Main: 215621632 12:51:11 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | Cycle 1(1): loaded http://localhost:56812/tests/dromaeo/cssquery-yui.html (next: http://localhost:56812/tests/dromaeo/cssquery-dojo.html) 12:54:14 INFO - PROCESS | 20943 | RSS: Main: 258940928 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | __start_tp_report 12:54:14 INFO - PROCESS | 20943 | _x_x_mozilla_page_load 12:54:14 INFO - PROCESS | 20943 | _x_x_mozilla_page_load_details 12:54:14 INFO - PROCESS | 20943 | |i|pagename|runs| 12:54:14 INFO - PROCESS | 20943 | |0;dojo.html;3340.5657264555603;3369.5114208439777;3375.628680845107;3393.592768867736;3405.114670185751;5520.91718624221;5571.749271282792;5642.15367694846;5648.4633959773755;5662.009148399029;5484.451554844513;5500.972495137518;5508.091164957787;5523.392426833055;5538.695371754552;4872.196087645552;4942.728149951751;4961.751912404384;4981.402231732179;5015.398152221738;4982.103221420143;5060.746962651852;5065;5065.873353166164;5066.822661206858;5041.1682072458;5041.521055499722;5069.518395752398;5100.668456550331;5101.362329708786;5192.844214673566;5205.817796377109;5207.6354655174155;5214.878801057753;5241.842744717665;4864.075825593126;4940.135476291634;4978.278149668314;5085.364329458817;5106.463821298785;5477.835664930059;5495.862603434946;5510.393856675762;5560.555155587544;5560.6941618210985;6092.625451065654;6096.786612468587;6110.249724550189;6117.541184411142;6121.74573130837;6014.2181516403025;6082.756689732405;6090.421409966046;6122.398130291537;6136.539759518054;5733.283339582552;5750.166225897222;5767.279090113736;5775.653460792366;5779.682117483579;5951.256092988377;6251.374862513803;6259.749610015549;6259.906101408483;6259.937400625936;5807.8548036299435;5835.299764028344;5848.970755146197;5910.320313163955;5942.940570594325;5968.671723055274;5990.64056156632;5992.221011268507;5995.700214989233;6020.789272375533;5677.205191273225;5867.618604790675;5969.31352894414;5972.850678733066;5980.312264089598;5863.208466857005;5973.432523910222;5974.820755377345;5975.312839023568;6003.849903752441;4542.205114105019;4560.110778398247;4568.063546972862;4572.199865023674;4598.2412901871485;3999.5800440953863;4033.274010678106;4062.2484840304637;4098;4144.41978123063;5686.9715651421475;5692;5694.772209111672;5723.627964182315;5747.48272655463;6042.577019608585;6052.818415447544;6057.727402266909;6068.21113255274;6111.755529778759;5497.147942068986;5543.833684989457;5583.469570390806;5611.494965453129;5637.802676906289;5173.275741396207;5173.767180476888;5179.04187725272;5182.507661772125;5185.559227465707;6183.412575805291;6248.31268560458;6252.374762523711;6253.937460625427;6254.74981000764;5716.256886604715;5798.75326804739;5914.3198532167635;5927.940720592739;6036.034234522455;6171.377388535103;6199.5660303780105;6202.038684003986;6208.975519039308;6209.441150296495;5863.355030946678;5868.67722275279;5869.6771677558145;5876.559258055578;5903.0555111182;5760.94239057604;5903.468687818117;5915.260592425947;5943.1679564861815;6015.187949626919;5816.70916454184;5849.883002340014;5851.707414629337;5853.619514731528;5861.0915308127305;5606.607537472338;5812.94187058124;5846.386129456346;5850.853728656818;5868.706564671835;5783;5801.3038435388025;5824.825255242349;5885.882282354414;5886.087656413263;6006.279246490274;6012.63924164534;6040.577159598786;6041.093835924647;6057.606255593372;5582.385937546947;5691.516221121085;5871.94128058714;5876.823695289148;5898.852528686817 12:54:14 INFO - PROCESS | 20943 | |1;ext.html;595.511680422054;644.2237104289331;645.883740926633;651.6318280171704;664.1996394344815;32721.67278327216;35631.28737425253;45935.31097033543;47167.52832471674;47384.76307618466;47716.284255736195;48441;48558.51441485593;48568.75715621417;48607;8354.081051084377;8894.421862578927;9074.228690561276;9086.954565227197;10859.619913303037;10505.6323028694;10674;10975.725606859813;10983.340999540012;11001.339919604809;11002.944985275062;11094.057005154571;11098.611548595802;11106.055985241264;11106.888931110667;8287.709930152447;10638.095761860252;10889.727756806064;10937.83593246102;10949.83575246372;10834.945825270823;10934.179936504714;10936.398498082603;10937.617183398623;10946.781064378747;46360;46655;46663.30005049927;46707.532924670995;46836.297455538195;4094.6724262058965;4283.250431174563;4368.541303163154;4469.888252793674;4620.745858977755;36205.81897090498;36663.816680916694;36673;37621.81189094037;38012.04969875775;4657.464391594976;4689.648276379286;4693.9530604693855;4799.400074990626;4849.466558678542;384264;387414;390033.0498347519;391279;394927;39711.60288397137;40733.59266407298;71043.28956710367;71246.287537125;71532;42133.15733685309;42178;42400;42474.36288455676;42509.78745106317;16835.15824208809;16860.241289142017;16934.06862622543;16934.49196524106;16946.491605251864;13109.541166059142;14032.929835350962;14158.29208539569;14429.711405771826;14674;9405.43567385959;9447.811043779086;9460.952695236618;9513.762155946019;9565.904340956502;3589.8743543975834;3658.2500587379523;3672.9632703673155;3673.1918977824835;3674.0814796300924;990.1435258501344;1092.781443711245;1116.843641890136;1139.4701463819363;1170.976580468386;34560.308793823984;35114.82442587822;35433.82283088568;35507.64492355095;35806;1199.5621598116625;1230.2987297240486;1253.0852477691337;1295.559509766665;1302.3227921480777;16699;17664.735028974577;17849.28602855897;17896.642067158584;18036.729449058275;641170;661105;663070;664834;970331;60788.69605651943;61205;61399.07901381483;61514.0772888407;61583;1325.8342707161605;1508.7359712050568;1535.646801235722;1545.5363390982661;1563.0699733658455;31268;34124.97625071252;34451.655483445844;34548;34918.825405872805;57141;57287.427125729875;57778.7111064442;57889;58017.419825801204;496851;496854;500834;503334;503553;40843;46412;47471;47537;49280.75359623179;54466.45533544614;54621.72689136688;54948;55363.723181385445;55765;44659.923403704466;45042.32436513389;45242.32136518021;45417.31874021826;45724;43599.78200108979;44300.55699443093;44668;45575.77212113918;45667.314990274506;43816.78091609522;44470.332945005204;44539.10921781611;45354.319685204086;45485;38101.237975240896;38917.6108238914;39714.80142599384;40328.39507407333;40760.3885941717;29612.111636650934;29639.036096390188;29644.703552964194;29807.403851923274;30121.09636710902 12:54:14 INFO - PROCESS | 20943 | |2;jquery.html;415.5325259083529;417.29060596985096;417.9247735407627;422.52677001758036;438.3556172426532;18420.539486512826;19182.712259316122;19852.90073549632;20023;20082.196712131496;19102.52243693908;19376.22495100198;19673.21307147716;20575.176992920264;20638.48403789906;5649.23735295734;5775.162601422791;5818.7963421280265;5820.854478638025;5825.679587622679;5552.639078459907;5726.083826587746;5759.625624334405;5769.0192667246665;5773.2494775679315;5703.714814259291;5727.541796656257;5735.942640573603;5739.339975902762;5744.31068271808;5529.087700529408;5666.8299951001745;5683.318001839764;5715.857103572403;5717.285339332583;5090.796368145269;5107.61692873036;5109.386873575158;5126.128558145124;5128.512791284822;22248;23001.53996920069;23470.647940280738;23496.295111146523;23830;2195.3413975807193;2288.8168946484407;2569.743025697434;3055.0987458699738;3153;9724.902750972471;14945.551633451014;15048.623784405368;15062.924685376503;15445.691086178325;1999.490130016851;2016.4253187841541;2037.2767667478129;2037.4702577330002;2104.6001259760596;78559;81986.59006704988;82531.5873420629;82655.58672206661;82721;11328.546858125583;11519.19365644397;11608.535658573732;11642.825357619642;11726.88273117275;16084.597885052968;16149.757753633705;16166.110863902599;16183.352665893468;16190.514284571482;8671.959364876255;8771.16673915977;8966.372353935161;8967.327450441113;8994.325425593106;8709.90962169075;8729.432586881832;8861.158189971942;8888.688895888743;8899.866502002475;4918.213085906309;4963.156263435225;4973.701577905337;5013.273075404046;5090.643654944119;1968.8228059474716;1995.960080798405;2016.8890711011036;2023.1603884388107;2115.6086124066787;982.7444864335324;1008.193445243802;1075.6235317638764;1079.2768844873797;1111.5109351885144;19321.613567728567;19932.402027939184;20261.493462663257;20399.490012749502;20421;1057.1754031855164;1070.2882583082164;1076.6554702495282;1088.3415533602215;1100.7853468573712;10742.355458672504;11291.54833806655;11370.829437558443;11454.770904582028;11601.709957250967;511870.20324492187;512830;525299;535357;544269;99488.50255748675;100588.49705751425;101594;103716;103822;1069.7379142110233;1072.871255449351;1089.6785448292774;1093.9671809845718;1098.7308109513222;17238.138093095546;17445.651086977934;17611.295548177928;17732.645347092726;18030.5492362692;41724;42432.15135697207;42715.5728442724;44151.55848441603;45189;59437.40562594319;60109.69945150246;60888.39111608827;60959;61886.38113618986;8561.657533698582;8669.6098675561;8725.301975842045;9008.144226298491;9049.185573298435;12426.75146497047;12764;12941.223526588436;13419.530316438877;13775.793363099761;10119.645812396531;10460.48322993177;11800.645980620595;12011.939940300243;12048.337341446304;11853.407329633656;11922.986546143675;12025.699357516132;12053.57812476559;12055.336956467478;11473.598424055119;11766.470508827295;11830.585929492427;12289.754204916031;12490.375481225721;7433.070866141732;8925.375223734276;9139.954300228455;9181.035991221093;9264.95367523158;9956.402615843073;11645.301281923112;11648.94175529117;11685.240459370114;11725.88274117248 12:54:14 INFO - PROCESS | 20943 | |3;mootools.html;1375.6973465837511;1600.4638446120548;1613.1127879666185;1863.161577290219;1965.7739359973607;9037.18665320121;9492.66775662852;9521.952390238057;9852.310338276324;9863.063009014133;9612.086851749073;9761.853572196424;9793.314467987244;9798;9806.754831129225;2179.8256139508803;2259.649754288088;2496.9250922472356;2513.434477242624;2550.6684131062934;2546.1597672767944;2574.3564108972755;2574.6524219230446;2575.1115865026536;2577.6262441945905;2498.800095992325;2581.6901971763414;2581.7160112387623;2581.7805486533666;2586.8835902384344;2095.245711543843;2380.2026321182425;2416.456297333095;2474.369035895853;2490.464550121714;2396.628522579003;2409.590369637166;2427.684401027873;2431.8662473563945;2447.3269850791;9515.857262141073;9546.474943878084;9602.567884445147;9610.75973100671;9618.422894626276;5590.832275031756;5670;5680.0627896397045;5680.687562184078;5682.204491371212;3476.6715048797673;3479.7738147020364;3522.6653467920505;3563.6436356364416;3577.3203091412547;1197.4731118308005;1221.9205751626116;1232.9815052774215;1254.3540076860425;1256.5539233572042;13705.040647154703;13926.860731392759;13983.300834958312;14008.29958502081;14035.859641403558;5132.769025393792;5222.791088356499;5233.267342571967;5270.367555893317;5304.946950530522;11730.648080557597;11805.586804461975;11812.645620631394;11827.763444731057;11833.290002599872;5809.448102430262;5810.854728631733;5815.825525234165;5821.79623713168;5826.883462330729;4715.81136754526;5210.47895210476;5326.92009619856;5337.759800808973;5423.457654234624;4493.887652808706;4520.344550040226;4558.247889098328;4582.9541704582525;4598.563136502027;1387.7710177820547;1444.7255021545873;1451.8911081668916;1462.8025216595836;1464.18005916687;968.6367612145305;1000.2797985450464;1057.931234469757;1062.1396668698223;1070.5396679427765;6624.635645039472;6742.190937087581;6831.180258369028;6886.621235831977;6904.4821638377325;1073.5544748929108;1116.268843907242;1157.2651366382408;1165.0446633760234;1187.074082215873;4544.091181763594;4697.154512187839;4767.427908650984;4800.66395352322;4807.351007613997;12121.757564848655;12419.565315213924;12456.439460224312;12517.812232816515;12523;11728.648140555626;12262.448189831479;12271.263724176579;12363.567275145328;12404.751904962031;8994.28045756338;9095.454272743656;9145.908540914506;9187.678431254873;9198.4480931143;6536.8365790855605;6707.731690732316;6773.153355830521;6777.390034896883;6804.149481314836;10656.89343106559;11076.39079850616;11124.555017799197;11248.268862524237;11259.605913793306;11351.262167959056;11357.375344355809;11405.600803971822;11415.543378265109;11540.711482213012;7776.261255180749;8477.830443390974;8683.305335573265;8787.077356877437;8972.28221742272;9796.118349348593;9798.31411801167;9808.362456440309;9880.110790028932;9884;8579.2707619853;8746.606402711766;8752.081031491602;8759.605817738344;8976.326775491994;8097.757067287991;8112.310453611509;8323.04285007232;8547.74356769298;8645.91354086451;7980.281774640311;8100.71647492335;8107.959460202897;8109.8378032440205;8110.918890811016;5758.596898217253;5856.677882716492;5904.405810431245;5977.790777322773;6079.878402432015;5896.734646940812;5947.929372712953;5950.047992321208;6027.879442411039;6120.663363515049 12:54:14 INFO - PROCESS | 20943 | |4;prototype.html;347.6975031722402;354.47714620934124;359.3083314619358;362.2176099624811;365.9121810765417;5301.7084060376665;5421.481985044194;5557.305336832896;5594.216809646648;5613.298337707792;5439.5104440600335;5443.2783608195905;5458.754356053977;5471.452854714536;5476.397596264408;4273.653799053303;4288.228118938589;4290.227759003378;4293.9694473326335;4302.569743025703;4031.334829753102;4159.500859896802;4248.702590818644;4255.765932873691;4296.742195468266;4240.151969606076;4258.425112609789;4272.679549033819;4275.187714334266;4297.462817147856;4240.830366785325;4241.257779888522;4267.317229243337;4279.630518234167;4296.656267498593;3684.8576941148062;3807;3855.74937629056;3858;3862.575116737157;5227.163653815372;5261.368635763694;5268.868278293035;5271.736413179326;5273.288106105665;4879.268109783561;4894.828680996184;4933.7286449245275;4935.901281974377;4940.160172770602;5460.290162278918;5645.5201307888465;5669.26299581056;5681.602287839853;5689.829305120853;4098.7950602469755;4102;4103.876883693494;4121.9381709274385;4126.958730412687;5839.014734990082;5916.881662366772;5936.910946335765;5947.910781338283;5968.522518198577;3956.742811717229;4163.2298024865495;4167.5207351155;4172.749635021908;4214.283571792803;4242.893927651771;4253.8723838284905;4257.829686812554;4259.424977628042;4269.658427325807;4844.95155048452;4856.95143048572;4866.659333846667;4867.172580661296;4871.147549178951;5583.720813959286;5679.154274860687;5711.200431939532;5713.428657134254;5812.88374232513;1383.7891844635944;1420.5383250443647;1464.1581090872792;1467.9724193064683;1470.029780344967;933.7385532051037;935.373299889076;943.6084025129632;947.6209516193439;952.7856232347805;4819.927701084486;4873.757191916039;4886.3403440535785;4936.777844996912;4959.8840260941;5183.0563538673;5205.947940520622;5208.244804503326;5248.895022099537;5249.317588713443;4710.29345598163;4942.678725882806;4942.777575009061;4949.48030456804;4998.100341938413;2771.390294135327;2790.776737860966;2792.6090347351387;2794.888204471839;2809.4521568293985;5331.866703332447;5351;5388.326459192601;5408.566729816602;5426.593005524602;5254.65844720092;5320.680759154463;5501.972490137604;5981.37195594465;6003.669798161056;6091.451769340692;6099.695015249308;6103.6032657877095;6142.447179753844;6163.489944963423;5597.608167428241;5912.940870591411;5940.811837632405;5983.444304480953;5989.940100598938;5806.158107074366;5826;5834.212381328636;5836.86181194663;5846.649201047951;6075.969620151871;6109.84725381869;6116.327204007466;6123.203983482119;6164.907526387018;4131.648809851196;4180.644645205191;4182.414461975265;4184.079502509443;4195.811188496586;5618.2134501170685;5803.9419605803405;5850.356460789395;5936.940630593639;5943.375945525658;5707.600467967369;5778.566607504538;5816.82549523515;5848.678322692293;5852.912206316993;5753.1945527627;5761.798337058183;5763.386251849489;5763.97118014424;5797.9420205797405;5493.423190565093;5615.859603509782;5662.348829884616;5706.343770466449;5729.656220626775;5772.480476757112;5797.565182611237;5828.2423284974375;5848.619839710405;5869.559783016376;5434.945650543444;5681;5718.712514994036;5753.683547404933;5772.134179873053 12:54:14 INFO - PROCESS | 20943 | |5;yui.html;765.3265126688517;782.1943398299753;799.7600719784064;873.4802792338559;898.7618281155495;14385.496507622236;15870.285837137328;16716.74924876126;16752.413665521708;16792.916035419836;15673.686526269468;15735.60660983476;15782.21088945551;15790.526284211463;15882.126483043428;732.8680837449257;849.613425891218;852.2713080316333;871.860502319629;872.0146234754718;870.7561882672861;872.9519876406795;875.3347455933473;876.5529579914257;878.565110270417;916.4592890194783;917.1149840404008;918.4168053286178;918.6922381002372;918.8667643191733;767.3439209475902;877.0484024833064;898.2768871058828;899.1053901368181;902.2421166220341;660.131926516629;661.5964261800347;662.2681936460191;662.3442791636245;662.4369286106771;15515.456959006493;15549.144797036159;15572;15597.454089106941;15614.453494127765;14977.400903963828;15007.699846003019;15263.694726105416;15320.846791532165;15461.845381546153;12878.935605321913;12913.483460661562;13079.084464087518;13118.344082795822;13183.802242966363;4624;4652.232381657022;4653.046125544255;4697.67116301859;4726.976365118187;81865.59067204685;82256.17743822605;83873;84237.57881210616;85685.57157214236;12040.879591204151;12151.635450936486;12160.756784864254;12243.816342754866;12467.940225080789;22077;22080;22143.667844982338;22190.556188876453;22210.444738881335;9052.954735226282;9092.454452732858;9186.219171370509;9229.676961306322;9333;4911.9754401227765;4983.8504844854715;5124.461931497139;5170.767315470813;5267.051930652443;3467.601225859008;3629.7840223524886;3636.254567813592;3636.3272794533095;3641.5630124385243;580.1413907416962;597.8087012156068;650.2359727320379;663.9136912201383;664.7872680742213;650.1190886348929;699.9475039371965;770.1605250277224;776.8329809091073;799.4044436894435;10513.316634418738;10528.894711052944;10726.892731072745;10741.51663175159;10836.0789332906;654.5679851298121;702.2696395748467;727.912650481935;745.4930647159983;842.6671464771381;4928.0390323886495;5064.670796398223;5084.542391184811;5223.660462069954;5233.319668443078;77754;79832;80359.59820200979;128676;129006.35496822456;73045.6347718258;101068.49465752624;109488.4525577367;118162;120849.39575302067;66029;99911;101517;101630.98369016363;102723.4863825691;9913.611514499662;10067.848982265125;10069.899301006895;10108.140808031105;10143.34068285559;58013.709931450074;58470.707646461495;58490.707546463695;59794.40205598062;60515;76013.61993189999;77560.61219693866;84813;86503.56748216218;88349.5582522109;11518.596849110241;11672.591459298883;11984.79801435302;13345.66635834112;14167.433302667778;14954.476593319181;15503.84496155024;15865.68268634644;15896.841031589536;17098.316067357166;14579.34392952341;14710.63223419423;14731.26343682833;14796.704065918837;15459.149746764037;13780.862191377957;13826.267216807128;13850.861491384958;14125;14215.147091174562;14360.640983975067;14429.278536073365;14582;14595.635109122357;14750.114993100447;11688.824667630162;12042.759144816879;12203.267803931793;12403;12915.806262906252;12262.26426414418;12298.569550065704;12555.87444125547;12561;12727.109102363116 12:54:14 INFO - PROCESS | 20943 | __end_tp_report 12:54:14 INFO - PROCESS | 20943 | __start_cc_report 12:54:14 INFO - PROCESS | 20943 | _x_x_mozilla_cycle_collect,901 12:54:14 INFO - PROCESS | 20943 | __end_cc_report 12:54:14 INFO - PROCESS | 20943 | __startTimestamp1466106854262__endTimestamp 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | ------- Summary: start ------- 12:54:14 INFO - PROCESS | 20943 | Number of tests: 6 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | [#0] dojo.html Cycles:165 Average:5567.52 Median:5798.75 stddev:631.45 (10.9%) stddev-sans-first:608.73 12:54:14 INFO - PROCESS | 20943 | Values: 3340.6 3369.5 3375.6 3393.6 3405.1 5520.9 5571.7 5642.2 5648.5 5662.0 5484.5 5501.0 5508.1 5523.4 5538.7 4872.2 4942.7 4961.8 4981.4 5015.4 4982.1 5060.7 5065.0 5065.9 5066.8 5041.2 5041.5 5069.5 5100.7 5101.4 5192.8 5205.8 5207.6 5214.9 5241.8 4864.1 4940.1 4978.3 5085.4 5106.5 5477.8 5495.9 5510.4 5560.6 5560.7 6092.6 6096.8 6110.2 6117.5 6121.7 6014.2 6082.8 6090.4 6122.4 6136.5 5733.3 5750.2 5767.3 5775.7 5779.7 5951.3 6251.4 6259.7 6259.9 6259.9 5807.9 5835.3 5849.0 5910.3 5942.9 5968.7 5990.6 5992.2 5995.7 6020.8 5677.2 5867.6 5969.3 5972.9 5980.3 5863.2 5973.4 5974.8 5975.3 6003.8 4542.2 4560.1 4568.1 4572.2 4598.2 3999.6 4033.3 4062.2 4098.0 4144.4 5687.0 5692.0 5694.8 5723.6 5747.5 6042.6 6052.8 6057.7 6068.2 6111.8 5497.1 5543.8 5583.5 5611.5 5637.8 5173.3 5173.8 5179.0 5182.5 5185.6 6183.4 6248.3 6252.4 6253.9 6254.7 5716.3 5798.8 5914.3 5927.9 6036.0 6171.4 6199.6 6202.0 6209.0 6209.4 5863.4 5868.7 5869.7 5876.6 5903.1 5760.9 5903.5 5915.3 5943.2 6015.2 5816.7 5849.9 5851.7 5853.6 5861.1 5606.6 5812.9 5846.4 5850.9 5868.7 5783.0 5801.3 5824.8 5885.9 5886.1 6006.3 6012.6 6040.6 6041.1 6057.6 5582.4 5691.5 5871.9 5876.8 5898.9 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | [#1] ext.html Cycles:180 Average:69616.86 Median:42155.58 stddev:149458.68 (354.5%) stddev-sans-first:149788.11 12:54:14 INFO - PROCESS | 20943 | Values: 595.5 644.2 645.9 651.6 664.2 32721.7 35631.3 45935.3 47167.5 47384.8 47716.3 48441.0 48558.5 48568.8 48607.0 8354.1 8894.4 9074.2 9087.0 10859.6 10505.6 10674.0 10975.7 10983.3 11001.3 11002.9 11094.1 11098.6 11106.1 11106.9 8287.7 10638.1 10889.7 10937.8 10949.8 10834.9 10934.2 10936.4 10937.6 10946.8 46360.0 46655.0 46663.3 46707.5 46836.3 4094.7 4283.3 4368.5 4469.9 4620.7 36205.8 36663.8 36673.0 37621.8 38012.0 4657.5 4689.6 4694.0 4799.4 4849.5 384264.0 387414.0 390033.0 391279.0 394927.0 39711.6 40733.6 71043.3 71246.3 71532.0 42133.2 42178.0 42400.0 42474.4 42509.8 16835.2 16860.2 16934.1 16934.5 16946.5 13109.5 14032.9 14158.3 14429.7 14674.0 9405.4 9447.8 9461.0 9513.8 9565.9 3589.9 3658.3 3673.0 3673.2 3674.1 990.1 1092.8 1116.8 1139.5 1171.0 34560.3 35114.8 35433.8 35507.6 35806.0 1199.6 1230.3 1253.1 1295.6 1302.3 16699.0 17664.7 17849.3 17896.6 18036.7 641170.0 661105.0 663070.0 664834.0 970331.0 60788.7 61205.0 61399.1 61514.1 61583.0 1325.8 1508.7 1535.6 1545.5 1563.1 31268.0 34125.0 34451.7 34548.0 34918.8 57141.0 57287.4 57778.7 57889.0 58017.4 496851.0 496854.0 500834.0 503334.0 503553.0 40843.0 46412.0 47471.0 47537.0 49280.8 54466.5 54621.7 54948.0 55363.7 55765.0 44659.9 45042.3 45242.3 45417.3 45724.0 43599.8 44300.6 44668.0 45575.8 45667.3 43816.8 44470.3 44539.1 45354.3 45485.0 38101.2 38917.6 39714.8 40328.4 40760.4 29612.1 29639.0 29644.7 29807.4 30121.1 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | [#2] jquery.html Cycles:180 Average:30693.16 Median:2155.48 stddev:86751.46 (4024.7%) stddev-sans-first:86965.03 12:54:14 INFO - PROCESS | 20943 | Values: 415.5 417.3 417.9 422.5 438.4 18420.5 19182.7 19852.9 20023.0 20082.2 19102.5 19376.2 19673.2 20575.2 20638.5 5649.2 5775.2 5818.8 5820.9 5825.7 5552.6 5726.1 5759.6 5769.0 5773.2 5703.7 5727.5 5735.9 5739.3 5744.3 5529.1 5666.8 5683.3 5715.9 5717.3 5090.8 5107.6 5109.4 5126.1 5128.5 22248.0 23001.5 23470.6 23496.3 23830.0 2195.3 2288.8 2569.7 3055.1 3153.0 9724.9 14945.6 15048.6 15062.9 15445.7 1999.5 2016.4 2037.3 2037.5 2104.6 78559.0 81986.6 82531.6 82655.6 82721.0 11328.5 11519.2 11608.5 11642.8 11726.9 16084.6 16149.8 16166.1 16183.4 16190.5 8672.0 8771.2 8966.4 8967.3 8994.3 8709.9 8729.4 8861.2 8888.7 8899.9 4918.2 4963.2 4973.7 5013.3 5090.6 1968.8 1996.0 2016.9 2023.2 2115.6 982.7 1008.2 1075.6 1079.3 1111.5 19321.6 19932.4 20261.5 20399.5 20421.0 1057.2 1070.3 1076.7 1088.3 1100.8 10742.4 11291.5 11370.8 11454.8 11601.7 511870.2 512830.0 525299.0 535357.0 544269.0 99488.5 100588.5 101594.0 103716.0 103822.0 1069.7 1072.9 1089.7 1094.0 1098.7 17238.1 17445.7 17611.3 17732.6 18030.5 41724.0 42432.2 42715.6 44151.6 45189.0 59437.4 60109.7 60888.4 60959.0 61886.4 8561.7 8669.6 8725.3 9008.1 9049.2 12426.8 12764.0 12941.2 13419.5 13775.8 10119.6 10460.5 11800.6 12011.9 12048.3 11853.4 11923.0 12025.7 12053.6 12055.3 11473.6 11766.5 11830.6 12289.8 12490.4 7433.1 8925.4 9140.0 9181.0 9265.0 9956.4 11645.3 11648.9 11685.2 11725.9 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | [#3] mootools.html Cycles:180 Average:6483.40 Median:4706.48 stddev:3724.87 (79.1%) stddev-sans-first:3715.54 12:54:14 INFO - PROCESS | 20943 | Values: 1375.7 1600.5 1613.1 1863.2 1965.8 9037.2 9492.7 9522.0 9852.3 9863.1 9612.1 9761.9 9793.3 9798.0 9806.8 2179.8 2259.6 2496.9 2513.4 2550.7 2546.2 2574.4 2574.7 2575.1 2577.6 2498.8 2581.7 2581.7 2581.8 2586.9 2095.2 2380.2 2416.5 2474.4 2490.5 2396.6 2409.6 2427.7 2431.9 2447.3 9515.9 9546.5 9602.6 9610.8 9618.4 5590.8 5670.0 5680.1 5680.7 5682.2 3476.7 3479.8 3522.7 3563.6 3577.3 1197.5 1221.9 1233.0 1254.4 1256.6 13705.0 13926.9 13983.3 14008.3 14035.9 5132.8 5222.8 5233.3 5270.4 5304.9 11730.6 11805.6 11812.6 11827.8 11833.3 5809.4 5810.9 5815.8 5821.8 5826.9 4715.8 5210.5 5326.9 5337.8 5423.5 4493.9 4520.3 4558.2 4583.0 4598.6 1387.8 1444.7 1451.9 1462.8 1464.2 968.6 1000.3 1057.9 1062.1 1070.5 6624.6 6742.2 6831.2 6886.6 6904.5 1073.6 1116.3 1157.3 1165.0 1187.1 4544.1 4697.2 4767.4 4800.7 4807.4 12121.8 12419.6 12456.4 12517.8 12523.0 11728.6 12262.4 12271.3 12363.6 12404.8 8994.3 9095.5 9145.9 9187.7 9198.4 6536.8 6707.7 6773.2 6777.4 6804.1 10656.9 11076.4 11124.6 11248.3 11259.6 11351.3 11357.4 11405.6 11415.5 11540.7 7776.3 8477.8 8683.3 8787.1 8972.3 9796.1 9798.3 9808.4 9880.1 9884.0 8579.3 8746.6 8752.1 8759.6 8976.3 8097.8 8112.3 8323.0 8547.7 8645.9 7980.3 8100.7 8108.0 8109.8 8110.9 5758.6 5856.7 5904.4 5977.8 6079.9 5896.7 5947.9 5950.0 6027.9 6120.7 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | [#4] prototype.html Cycles:180 Average:4744.40 Median:5287.50 stddev:1399.83 (26.5%) stddev-sans-first:1364.31 12:54:14 INFO - PROCESS | 20943 | Values: 347.7 354.5 359.3 362.2 365.9 5301.7 5421.5 5557.3 5594.2 5613.3 5439.5 5443.3 5458.8 5471.5 5476.4 4273.7 4288.2 4290.2 4294.0 4302.6 4031.3 4159.5 4248.7 4255.8 4296.7 4240.2 4258.4 4272.7 4275.2 4297.5 4240.8 4241.3 4267.3 4279.6 4296.7 3684.9 3807.0 3855.7 3858.0 3862.6 5227.2 5261.4 5268.9 5271.7 5273.3 4879.3 4894.8 4933.7 4935.9 4940.2 5460.3 5645.5 5669.3 5681.6 5689.8 4098.8 4102.0 4103.9 4121.9 4127.0 5839.0 5916.9 5936.9 5947.9 5968.5 3956.7 4163.2 4167.5 4172.7 4214.3 4242.9 4253.9 4257.8 4259.4 4269.7 4845.0 4857.0 4866.7 4867.2 4871.1 5583.7 5679.2 5711.2 5713.4 5812.9 1383.8 1420.5 1464.2 1468.0 1470.0 933.7 935.4 943.6 947.6 952.8 4819.9 4873.8 4886.3 4936.8 4959.9 5183.1 5205.9 5208.2 5248.9 5249.3 4710.3 4942.7 4942.8 4949.5 4998.1 2771.4 2790.8 2792.6 2794.9 2809.5 5331.9 5351.0 5388.3 5408.6 5426.6 5254.7 5320.7 5502.0 5981.4 6003.7 6091.5 6099.7 6103.6 6142.4 6163.5 5597.6 5912.9 5940.8 5983.4 5989.9 5806.2 5826.0 5834.2 5836.9 5846.6 6076.0 6109.8 6116.3 6123.2 6164.9 4131.6 4180.6 4182.4 4184.1 4195.8 5618.2 5803.9 5850.4 5936.9 5943.4 5707.6 5778.6 5816.8 5848.7 5852.9 5753.2 5761.8 5763.4 5764.0 5797.9 5493.4 5615.9 5662.3 5706.3 5729.7 5772.5 5797.6 5828.2 5848.6 5869.6 5434.9 5681.0 5718.7 5753.7 5772.1 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - PROCESS | 20943 | [#5] yui.html Cycles:180 Average:21813.89 Median:3636.29 stddev:31030.24 (853.3%) stddev-sans-first:31077.04 12:54:14 INFO - PROCESS | 20943 | Values: 765.3 782.2 799.8 873.5 898.8 14385.5 15870.3 16716.7 16752.4 16792.9 15673.7 15735.6 15782.2 15790.5 15882.1 732.9 849.6 852.3 871.9 872.0 870.8 873.0 875.3 876.6 878.6 916.5 917.1 918.4 918.7 918.9 767.3 877.0 898.3 899.1 902.2 660.1 661.6 662.3 662.3 662.4 15515.5 15549.1 15572.0 15597.5 15614.5 14977.4 15007.7 15263.7 15320.8 15461.8 12878.9 12913.5 13079.1 13118.3 13183.8 4624.0 4652.2 4653.0 4697.7 4727.0 81865.6 82256.2 83873.0 84237.6 85685.6 12040.9 12151.6 12160.8 12243.8 12467.9 22077.0 22080.0 22143.7 22190.6 22210.4 9053.0 9092.5 9186.2 9229.7 9333.0 4912.0 4983.9 5124.5 5170.8 5267.1 3467.6 3629.8 3636.3 3636.3 3641.6 580.1 597.8 650.2 663.9 664.8 650.1 699.9 770.2 776.8 799.4 10513.3 10528.9 10726.9 10741.5 10836.1 654.6 702.3 727.9 745.5 842.7 4928.0 5064.7 5084.5 5223.7 5233.3 77754.0 79832.0 80359.6 128676.0 129006.4 73045.6 101068.5 109488.5 118162.0 120849.4 66029.0 99911.0 101517.0 101631.0 102723.5 9913.6 10067.8 10069.9 10108.1 10143.3 58013.7 58470.7 58490.7 59794.4 60515.0 76013.6 77560.6 84813.0 86503.6 88349.6 11518.6 11672.6 11984.8 13345.7 14167.4 14954.5 15503.8 15865.7 15896.8 17098.3 14579.3 14710.6 14731.3 14796.7 15459.1 13780.9 13826.3 13850.9 14125.0 14215.1 14360.6 14429.3 14582.0 14595.6 14750.1 11688.8 12042.8 12203.3 12403.0 12915.8 12262.3 12298.6 12555.9 12561.0 12727.1 12:54:14 INFO - PROCESS | 20943 | -------- Summary: end -------- 12:54:14 INFO - PROCESS | 20943 | 12:54:14 INFO - TEST-INFO | 20943: exit 0 12:54:14 INFO - TEST-OK | dromaeo_css | took 1113571ms 12:54:14 INFO - TEST-START | kraken 12:54:14 INFO - operating with platform_type : linux_ 12:54:14 INFO - Initialising browser for kraken test... 12:54:14 INFO - TEST-INFO | started process 21140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSJ9j5c/profile http://localhost:56812/getInfo.html) 12:54:19 INFO - PROCESS | 21140 | __metrics Screen width/height:1600/1200 12:54:19 INFO - PROCESS | 21140 | colorDepth:24 12:54:19 INFO - PROCESS | 21140 | Browser inner width/height: 1024/697 12:54:19 INFO - PROCESS | 21140 | __metrics 12:54:20 ERROR - PROCESS | 21140 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:54:20 INFO - PROCESS | 21140 | console.error: PushService: 12:54:20 INFO - PROCESS | 21140 | stateChangeProcessEnqueue: Error transitioning state 12:54:20 INFO - PROCESS | 21140 | UnknownError 12:54:21 INFO - TEST-INFO | 21140: exit 0 12:54:21 INFO - Browser initialized. 12:54:21 INFO - Running cycle 1/1 for kraken test... 12:54:21 INFO - TEST-INFO | started process 21230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSJ9j5c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:33 INFO - PROCESS | 21230 | RSS: Main: 145678336 12:54:33 INFO - PROCESS | 21230 | 12:54:35 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:36 INFO - PROCESS | 21230 | RSS: Main: 194723840 12:54:36 INFO - PROCESS | 21230 | 12:54:38 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-dft) 12:54:39 INFO - PROCESS | 21230 | RSS: Main: 192561152 12:54:39 INFO - PROCESS | 21230 | 12:54:42 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-fft) 12:54:43 INFO - PROCESS | 21230 | RSS: Main: 277803008 12:54:43 INFO - PROCESS | 21230 | 12:54:45 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56812/tests/kraken/driver.html?testName=audio-oscillator) 12:54:45 INFO - PROCESS | 21230 | RSS: Main: 186621952 12:54:45 INFO - PROCESS | 21230 | 12:54:47 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:54:48 INFO - PROCESS | 21230 | RSS: Main: 187781120 12:54:48 INFO - PROCESS | 21230 | 12:54:51 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56812/tests/kraken/driver.html?testName=imaging-darkroom) 12:54:51 INFO - PROCESS | 21230 | RSS: Main: 222109696 12:54:51 INFO - PROCESS | 21230 | 12:54:55 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56812/tests/kraken/driver.html?testName=imaging-desaturate) 12:54:55 INFO - PROCESS | 21230 | RSS: Main: 221048832 12:54:55 INFO - PROCESS | 21230 | 12:54:58 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56812/tests/kraken/driver.html?testName=json-parse-financial) 12:54:59 INFO - PROCESS | 21230 | RSS: Main: 221720576 12:54:59 INFO - PROCESS | 21230 | 12:55:00 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:55:01 INFO - PROCESS | 21230 | RSS: Main: 199868416 12:55:01 INFO - PROCESS | 21230 | 12:55:03 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:55:03 INFO - PROCESS | 21230 | RSS: Main: 203005952 12:55:03 INFO - PROCESS | 21230 | 12:55:05 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:55:06 INFO - PROCESS | 21230 | RSS: Main: 210096128 12:55:06 INFO - PROCESS | 21230 | 12:55:08 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:55:09 INFO - PROCESS | 21230 | RSS: Main: 214999040 12:55:09 INFO - PROCESS | 21230 | 12:55:12 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:55:12 INFO - PROCESS | 21230 | RSS: Main: 214347776 12:55:12 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | Cycle 1(1): loaded http://localhost:56812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56812/tests/kraken/driver.html?testName=ai-astar) 12:55:14 INFO - PROCESS | 21230 | RSS: Main: 257097728 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | __start_tp_report 12:55:14 INFO - PROCESS | 21230 | _x_x_mozilla_page_load 12:55:14 INFO - PROCESS | 21230 | _x_x_mozilla_page_load_details 12:55:14 INFO - PROCESS | 21230 | |i|pagename|runs| 12:55:14 INFO - PROCESS | 21230 | |0;ai-astar;110;103;109;108;109;109;109;109;109;110 12:55:14 INFO - PROCESS | 21230 | |1;audio-beat-detection;156;124;129;185;125;131;150;128;172;126 12:55:14 INFO - PROCESS | 21230 | |2;audio-dft;161;161;162;162;161;162;162;163;166;162 12:55:14 INFO - PROCESS | 21230 | |3;audio-fft;75;80;75;118;75;76;77;75;97;76 12:55:14 INFO - PROCESS | 21230 | |4;audio-oscillator;83;85;114;84;84;83;115;85;85;121 12:55:14 INFO - PROCESS | 21230 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 12:55:14 INFO - PROCESS | 21230 | |6;imaging-darkroom;146;146;145;146;146;145;146;146;147;146 12:55:14 INFO - PROCESS | 21230 | |7;imaging-desaturate;94;94;95;95;95;95;95;94;95;94 12:55:14 INFO - PROCESS | 21230 | |8;json-parse-financial;52;50;52;52;53;52;53;52;51;52 12:55:14 INFO - PROCESS | 21230 | |9;json-stringify-tinderbox;61;59;60;61;60;59;59;60;59;60 12:55:14 INFO - PROCESS | 21230 | |10;stanford-crypto-aes;77;78;79;77;78;82;79;78;101;83 12:55:14 INFO - PROCESS | 21230 | |11;stanford-crypto-ccm;120;118;116;118;119;114;115;117;122;122 12:55:14 INFO - PROCESS | 21230 | |12;stanford-crypto-pbkdf2;159;159;166;159;154;155;157;159;155;156 12:55:14 INFO - PROCESS | 21230 | |13;stanford-crypto-sha256-iterative;63;62;66;63;63;63;64;61;63;64 12:55:14 INFO - PROCESS | 21230 | __end_tp_report 12:55:14 INFO - PROCESS | 21230 | __start_cc_report 12:55:14 INFO - PROCESS | 21230 | _x_x_mozilla_cycle_collect,1567 12:55:14 INFO - PROCESS | 21230 | __end_cc_report 12:55:14 INFO - PROCESS | 21230 | __startTimestamp1466106914635__endTimestamp 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | ------- Summary: start ------- 12:55:14 INFO - PROCESS | 21230 | Number of tests: 14 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:2.01 (1.8%) stddev-sans-first:2.06 12:55:14 INFO - PROCESS | 21230 | Values: 110.0 103.0 109.0 108.0 109.0 109.0 109.0 109.0 109.0 110.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:140.50 stddev:22.01 (15.7%) stddev-sans-first:22.81 12:55:14 INFO - PROCESS | 21230 | Values: 156.0 124.0 129.0 185.0 125.0 131.0 150.0 128.0 172.0 126.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 12:55:14 INFO - PROCESS | 21230 | Values: 161.0 161.0 162.0 162.0 161.0 162.0 162.0 163.0 166.0 162.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.21 (18.7%) stddev-sans-first:14.81 12:55:14 INFO - PROCESS | 21230 | Values: 75.0 80.0 75.0 118.0 75.0 76.0 77.0 75.0 97.0 76.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.00 stddev:15.83 (18.8%) stddev-sans-first:16.29 12:55:14 INFO - PROCESS | 21230 | Values: 83.0 85.0 114.0 84.0 84.0 83.0 115.0 85.0 85.0 121.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:55:14 INFO - PROCESS | 21230 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:55:14 INFO - PROCESS | 21230 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:55:14 INFO - PROCESS | 21230 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 12:55:14 INFO - PROCESS | 21230 | Values: 52.0 50.0 52.0 52.0 53.0 52.0 53.0 52.0 51.0 52.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 12:55:14 INFO - PROCESS | 21230 | Values: 61.0 59.0 60.0 61.0 60.0 59.0 59.0 60.0 59.0 60.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:78.50 stddev:7.24 (9.2%) stddev-sans-first:7.52 12:55:14 INFO - PROCESS | 21230 | Values: 77.0 78.0 79.0 77.0 78.0 82.0 79.0 78.0 101.0 83.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:118.50 stddev:2.73 (2.3%) stddev-sans-first:2.80 12:55:14 INFO - PROCESS | 21230 | Values: 120.0 118.0 116.0 118.0 119.0 114.0 115.0 117.0 122.0 122.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:159.00 stddev:3.45 (2.2%) stddev-sans-first:3.63 12:55:14 INFO - PROCESS | 21230 | Values: 159.0 159.0 166.0 159.0 154.0 155.0 157.0 159.0 155.0 156.0 12:55:14 INFO - PROCESS | 21230 | 12:55:14 INFO - PROCESS | 21230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:1.39 12:55:14 INFO - PROCESS | 21230 | Values: 63.0 62.0 66.0 63.0 63.0 63.0 64.0 61.0 63.0 64.0 12:55:14 INFO - PROCESS | 21230 | -------- Summary: end -------- 12:55:14 INFO - PROCESS | 21230 | 12:55:15 INFO - TEST-INFO | 21230: exit 0 12:55:15 INFO - TEST-OK | kraken | took 60705ms 12:55:15 INFO - SUITE-END | took 1174s 12:55:15 INFO - Completed test suite (00:19:34) 12:55:15 INFO - javascript benchmark 12:55:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.5657264555603, 3369.5114208439777, 3375.628680845107, 3393.592768867736, 3405.114670185751, 5520.91718624221, 5571.749271282792, 5642.15367694846, 5648.4633959773755, 5662.009148399029, 5484.451554844513, 5500.972495137518, 5508.091164957787, 5523.392426833055, 5538.695371754552, 4872.196087645552, 4942.728149951751, 4961.751912404384, 4981.402231732179, 5015.398152221738, 4982.103221420143, 5060.746962651852, 5065.0, 5065.873353166164, 5066.822661206858, 5041.1682072458, 5041.521055499722, 5069.518395752398, 5100.668456550331, 5101.362329708786, 5192.844214673566, 5205.817796377109, 5207.6354655174155, 5214.878801057753, 5241.842744717665, 4864.075825593126, 4940.135476291634, 4978.278149668314, 5085.364329458817, 5106.463821298785, 5477.835664930059, 5495.862603434946, 5510.393856675762, 5560.555155587544, 5560.6941618210985, 6092.625451065654, 6096.786612468587, 6110.249724550189, 6117.541184411142, 6121.74573130837, 6014.2181516403025, 6082.756689732405, 6090.421409966046, 6122.398130291537, 6136.539759518054, 5733.283339582552, 5750.166225897222, 5767.279090113736, 5775.653460792366, 5779.682117483579, 5951.256092988377, 6251.374862513803, 6259.749610015549, 6259.906101408483, 6259.937400625936, 5807.8548036299435, 5835.299764028344, 5848.970755146197, 5910.320313163955, 5942.940570594325, 5968.671723055274, 5990.64056156632, 5992.221011268507, 5995.700214989233, 6020.789272375533, 5677.205191273225, 5867.618604790675, 5969.31352894414, 5972.850678733066, 5980.312264089598, 5863.208466857005, 5973.432523910222, 5974.820755377345, 5975.312839023568, 6003.849903752441, 4542.205114105019, 4560.110778398247, 4568.063546972862, 4572.199865023674, 4598.2412901871485, 3999.5800440953863, 4033.274010678106, 4062.2484840304637, 4098.0, 4144.41978123063, 5686.9715651421475, 5692.0, 5694.772209111672, 5723.627964182315, 5747.48272655463, 6042.577019608585, 6052.818415447544, 6057.727402266909, 6068.21113255274, 6111.755529778759, 5497.147942068986, 5543.833684989457, 5583.469570390806, 5611.494965453129, 5637.802676906289, 5173.275741396207, 5173.767180476888, 5179.04187725272, 5182.507661772125, 5185.559227465707, 6183.412575805291, 6248.31268560458, 6252.374762523711, 6253.937460625427, 6254.74981000764, 5716.256886604715, 5798.75326804739, 5914.3198532167635, 5927.940720592739, 6036.034234522455, 6171.377388535103, 6199.5660303780105, 6202.038684003986, 6208.975519039308, 6209.441150296495, 5863.355030946678, 5868.67722275279, 5869.6771677558145, 5876.559258055578, 5903.0555111182, 5760.94239057604, 5903.468687818117, 5915.260592425947, 5943.1679564861815, 6015.187949626919, 5816.70916454184, 5849.883002340014, 5851.707414629337, 5853.619514731528, 5861.0915308127305, 5606.607537472338, 5812.94187058124, 5846.386129456346, 5850.853728656818, 5868.706564671835, 5783.0, 5801.3038435388025, 5824.825255242349, 5885.882282354414, 5886.087656413263, 6006.279246490274, 6012.63924164534, 6040.577159598786, 6041.093835924647, 6057.606255593372, 5582.385937546947, 5691.516221121085, 5871.94128058714, 5876.823695289148, 5898.852528686817], "value": 5525.95822453144, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.511680422054, 644.2237104289331, 645.883740926633, 651.6318280171704, 664.1996394344815, 32721.67278327216, 35631.28737425253, 45935.31097033543, 47167.52832471674, 47384.76307618466, 47716.284255736195, 48441.0, 48558.51441485593, 48568.75715621417, 48607.0, 8354.081051084377, 8894.421862578927, 9074.228690561276, 9086.954565227197, 10859.619913303037, 10505.6323028694, 10674.0, 10975.725606859813, 10983.340999540012, 11001.339919604809, 11002.944985275062, 11094.057005154571, 11098.611548595802, 11106.055985241264, 11106.888931110667, 8287.709930152447, 10638.095761860252, 10889.727756806064, 10937.83593246102, 10949.83575246372, 10834.945825270823, 10934.179936504714, 10936.398498082603, 10937.617183398623, 10946.781064378747, 46360.0, 46655.0, 46663.30005049927, 46707.532924670995, 46836.297455538195, 4094.6724262058965, 4283.250431174563, 4368.541303163154, 4469.888252793674, 4620.745858977755, 36205.81897090498, 36663.816680916694, 36673.0, 37621.81189094037, 38012.04969875775, 4657.464391594976, 4689.648276379286, 4693.9530604693855, 4799.400074990626, 4849.466558678542, 384264.0, 387414.0, 390033.0498347519, 391279.0, 394927.0, 39711.60288397137, 40733.59266407298, 71043.28956710367, 71246.287537125, 71532.0, 42133.15733685309, 42178.0, 42400.0, 42474.36288455676, 42509.78745106317, 16835.15824208809, 16860.241289142017, 16934.06862622543, 16934.49196524106, 16946.491605251864, 13109.541166059142, 14032.929835350962, 14158.29208539569, 14429.711405771826, 14674.0, 9405.43567385959, 9447.811043779086, 9460.952695236618, 9513.762155946019, 9565.904340956502, 3589.8743543975834, 3658.2500587379523, 3672.9632703673155, 3673.1918977824835, 3674.0814796300924, 990.1435258501344, 1092.781443711245, 1116.843641890136, 1139.4701463819363, 1170.976580468386, 34560.308793823984, 35114.82442587822, 35433.82283088568, 35507.64492355095, 35806.0, 1199.5621598116625, 1230.2987297240486, 1253.0852477691337, 1295.559509766665, 1302.3227921480777, 16699.0, 17664.735028974577, 17849.28602855897, 17896.642067158584, 18036.729449058275, 641170.0, 661105.0, 663070.0, 664834.0, 970331.0, 60788.69605651943, 61205.0, 61399.07901381483, 61514.0772888407, 61583.0, 1325.8342707161605, 1508.7359712050568, 1535.646801235722, 1545.5363390982661, 1563.0699733658455, 31268.0, 34124.97625071252, 34451.655483445844, 34548.0, 34918.825405872805, 57141.0, 57287.427125729875, 57778.7111064442, 57889.0, 58017.419825801204, 496851.0, 496854.0, 500834.0, 503334.0, 503553.0, 40843.0, 46412.0, 47471.0, 47537.0, 49280.75359623179, 54466.45533544614, 54621.72689136688, 54948.0, 55363.723181385445, 55765.0, 44659.923403704466, 45042.32436513389, 45242.32136518021, 45417.31874021826, 45724.0, 43599.78200108979, 44300.55699443093, 44668.0, 45575.77212113918, 45667.314990274506, 43816.78091609522, 44470.332945005204, 44539.10921781611, 45354.319685204086, 45485.0, 38101.237975240896, 38917.6108238914, 39714.80142599384, 40328.39507407333, 40760.3885941717, 29612.111636650934, 29639.036096390188, 29644.703552964194, 29807.403851923274, 30121.09636710902], "value": 21334.08926057742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.5325259083529, 417.29060596985096, 417.9247735407627, 422.52677001758036, 438.3556172426532, 18420.539486512826, 19182.712259316122, 19852.90073549632, 20023.0, 20082.196712131496, 19102.52243693908, 19376.22495100198, 19673.21307147716, 20575.176992920264, 20638.48403789906, 5649.23735295734, 5775.162601422791, 5818.7963421280265, 5820.854478638025, 5825.679587622679, 5552.639078459907, 5726.083826587746, 5759.625624334405, 5769.0192667246665, 5773.2494775679315, 5703.714814259291, 5727.541796656257, 5735.942640573603, 5739.339975902762, 5744.31068271808, 5529.087700529408, 5666.8299951001745, 5683.318001839764, 5715.857103572403, 5717.285339332583, 5090.796368145269, 5107.61692873036, 5109.386873575158, 5126.128558145124, 5128.512791284822, 22248.0, 23001.53996920069, 23470.647940280738, 23496.295111146523, 23830.0, 2195.3413975807193, 2288.8168946484407, 2569.743025697434, 3055.0987458699738, 3153.0, 9724.902750972471, 14945.551633451014, 15048.623784405368, 15062.924685376503, 15445.691086178325, 1999.490130016851, 2016.4253187841541, 2037.2767667478129, 2037.4702577330002, 2104.6001259760596, 78559.0, 81986.59006704988, 82531.5873420629, 82655.58672206661, 82721.0, 11328.546858125583, 11519.19365644397, 11608.535658573732, 11642.825357619642, 11726.88273117275, 16084.597885052968, 16149.757753633705, 16166.110863902599, 16183.352665893468, 16190.514284571482, 8671.959364876255, 8771.16673915977, 8966.372353935161, 8967.327450441113, 8994.325425593106, 8709.90962169075, 8729.432586881832, 8861.158189971942, 8888.688895888743, 8899.866502002475, 4918.213085906309, 4963.156263435225, 4973.701577905337, 5013.273075404046, 5090.643654944119, 1968.8228059474716, 1995.960080798405, 2016.8890711011036, 2023.1603884388107, 2115.6086124066787, 982.7444864335324, 1008.193445243802, 1075.6235317638764, 1079.2768844873797, 1111.5109351885144, 19321.613567728567, 19932.402027939184, 20261.493462663257, 20399.490012749502, 20421.0, 1057.1754031855164, 1070.2882583082164, 1076.6554702495282, 1088.3415533602215, 1100.7853468573712, 10742.355458672504, 11291.54833806655, 11370.829437558443, 11454.770904582028, 11601.709957250967, 511870.20324492187, 512830.0, 525299.0, 535357.0, 544269.0, 99488.50255748675, 100588.49705751425, 101594.0, 103716.0, 103822.0, 1069.7379142110233, 1072.871255449351, 1089.6785448292774, 1093.9671809845718, 1098.7308109513222, 17238.138093095546, 17445.651086977934, 17611.295548177928, 17732.645347092726, 18030.5492362692, 41724.0, 42432.15135697207, 42715.5728442724, 44151.55848441603, 45189.0, 59437.40562594319, 60109.69945150246, 60888.39111608827, 60959.0, 61886.38113618986, 8561.657533698582, 8669.6098675561, 8725.301975842045, 9008.144226298491, 9049.185573298435, 12426.75146497047, 12764.0, 12941.223526588436, 13419.530316438877, 13775.793363099761, 10119.645812396531, 10460.48322993177, 11800.645980620595, 12011.939940300243, 12048.337341446304, 11853.407329633656, 11922.986546143675, 12025.699357516132, 12053.57812476559, 12055.336956467478, 11473.598424055119, 11766.470508827295, 11830.585929492427, 12289.754204916031, 12490.375481225721, 7433.070866141732, 8925.375223734276, 9139.954300228455, 9181.035991221093, 9264.95367523158, 9956.402615843073, 11645.301281923112, 11648.94175529117, 11685.240459370114, 11725.88274117248], "value": 9617.463393829514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.6973465837511, 1600.4638446120548, 1613.1127879666185, 1863.161577290219, 1965.7739359973607, 9037.18665320121, 9492.66775662852, 9521.952390238057, 9852.310338276324, 9863.063009014133, 9612.086851749073, 9761.853572196424, 9793.314467987244, 9798.0, 9806.754831129225, 2179.8256139508803, 2259.649754288088, 2496.9250922472356, 2513.434477242624, 2550.6684131062934, 2546.1597672767944, 2574.3564108972755, 2574.6524219230446, 2575.1115865026536, 2577.6262441945905, 2498.800095992325, 2581.6901971763414, 2581.7160112387623, 2581.7805486533666, 2586.8835902384344, 2095.245711543843, 2380.2026321182425, 2416.456297333095, 2474.369035895853, 2490.464550121714, 2396.628522579003, 2409.590369637166, 2427.684401027873, 2431.8662473563945, 2447.3269850791, 9515.857262141073, 9546.474943878084, 9602.567884445147, 9610.75973100671, 9618.422894626276, 5590.832275031756, 5670.0, 5680.0627896397045, 5680.687562184078, 5682.204491371212, 3476.6715048797673, 3479.7738147020364, 3522.6653467920505, 3563.6436356364416, 3577.3203091412547, 1197.4731118308005, 1221.9205751626116, 1232.9815052774215, 1254.3540076860425, 1256.5539233572042, 13705.040647154703, 13926.860731392759, 13983.300834958312, 14008.29958502081, 14035.859641403558, 5132.769025393792, 5222.791088356499, 5233.267342571967, 5270.367555893317, 5304.946950530522, 11730.648080557597, 11805.586804461975, 11812.645620631394, 11827.763444731057, 11833.290002599872, 5809.448102430262, 5810.854728631733, 5815.825525234165, 5821.79623713168, 5826.883462330729, 4715.81136754526, 5210.47895210476, 5326.92009619856, 5337.759800808973, 5423.457654234624, 4493.887652808706, 4520.344550040226, 4558.247889098328, 4582.9541704582525, 4598.563136502027, 1387.7710177820547, 1444.7255021545873, 1451.8911081668916, 1462.8025216595836, 1464.18005916687, 968.6367612145305, 1000.2797985450464, 1057.931234469757, 1062.1396668698223, 1070.5396679427765, 6624.635645039472, 6742.190937087581, 6831.180258369028, 6886.621235831977, 6904.4821638377325, 1073.5544748929108, 1116.268843907242, 1157.2651366382408, 1165.0446633760234, 1187.074082215873, 4544.091181763594, 4697.154512187839, 4767.427908650984, 4800.66395352322, 4807.351007613997, 12121.757564848655, 12419.565315213924, 12456.439460224312, 12517.812232816515, 12523.0, 11728.648140555626, 12262.448189831479, 12271.263724176579, 12363.567275145328, 12404.751904962031, 8994.28045756338, 9095.454272743656, 9145.908540914506, 9187.678431254873, 9198.4480931143, 6536.8365790855605, 6707.731690732316, 6773.153355830521, 6777.390034896883, 6804.149481314836, 10656.89343106559, 11076.39079850616, 11124.555017799197, 11248.268862524237, 11259.605913793306, 11351.262167959056, 11357.375344355809, 11405.600803971822, 11415.543378265109, 11540.711482213012, 7776.261255180749, 8477.830443390974, 8683.305335573265, 8787.077356877437, 8972.28221742272, 9796.118349348593, 9798.31411801167, 9808.362456440309, 9880.110790028932, 9884.0, 8579.2707619853, 8746.606402711766, 8752.081031491602, 8759.605817738344, 8976.326775491994, 8097.757067287991, 8112.310453611509, 8323.04285007232, 8547.74356769298, 8645.91354086451, 7980.281774640311, 8100.71647492335, 8107.959460202897, 8109.8378032440205, 8110.918890811016, 5758.596898217253, 5856.677882716492, 5904.405810431245, 5977.790777322773, 6079.878402432015, 5896.734646940812, 5947.929372712953, 5950.047992321208, 6027.879442411039, 6120.663363515049], "value": 5158.856141807503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.6975031722402, 354.47714620934124, 359.3083314619358, 362.2176099624811, 365.9121810765417, 5301.7084060376665, 5421.481985044194, 5557.305336832896, 5594.216809646648, 5613.298337707792, 5439.5104440600335, 5443.2783608195905, 5458.754356053977, 5471.452854714536, 5476.397596264408, 4273.653799053303, 4288.228118938589, 4290.227759003378, 4293.9694473326335, 4302.569743025703, 4031.334829753102, 4159.500859896802, 4248.702590818644, 4255.765932873691, 4296.742195468266, 4240.151969606076, 4258.425112609789, 4272.679549033819, 4275.187714334266, 4297.462817147856, 4240.830366785325, 4241.257779888522, 4267.317229243337, 4279.630518234167, 4296.656267498593, 3684.8576941148062, 3807.0, 3855.74937629056, 3858.0, 3862.575116737157, 5227.163653815372, 5261.368635763694, 5268.868278293035, 5271.736413179326, 5273.288106105665, 4879.268109783561, 4894.828680996184, 4933.7286449245275, 4935.901281974377, 4940.160172770602, 5460.290162278918, 5645.5201307888465, 5669.26299581056, 5681.602287839853, 5689.829305120853, 4098.7950602469755, 4102.0, 4103.876883693494, 4121.9381709274385, 4126.958730412687, 5839.014734990082, 5916.881662366772, 5936.910946335765, 5947.910781338283, 5968.522518198577, 3956.742811717229, 4163.2298024865495, 4167.5207351155, 4172.749635021908, 4214.283571792803, 4242.893927651771, 4253.8723838284905, 4257.829686812554, 4259.424977628042, 4269.658427325807, 4844.95155048452, 4856.95143048572, 4866.659333846667, 4867.172580661296, 4871.147549178951, 5583.720813959286, 5679.154274860687, 5711.200431939532, 5713.428657134254, 5812.88374232513, 1383.7891844635944, 1420.5383250443647, 1464.1581090872792, 1467.9724193064683, 1470.029780344967, 933.7385532051037, 935.373299889076, 943.6084025129632, 947.6209516193439, 952.7856232347805, 4819.927701084486, 4873.757191916039, 4886.3403440535785, 4936.777844996912, 4959.8840260941, 5183.0563538673, 5205.947940520622, 5208.244804503326, 5248.895022099537, 5249.317588713443, 4710.29345598163, 4942.678725882806, 4942.777575009061, 4949.48030456804, 4998.100341938413, 2771.390294135327, 2790.776737860966, 2792.6090347351387, 2794.888204471839, 2809.4521568293985, 5331.866703332447, 5351.0, 5388.326459192601, 5408.566729816602, 5426.593005524602, 5254.65844720092, 5320.680759154463, 5501.972490137604, 5981.37195594465, 6003.669798161056, 6091.451769340692, 6099.695015249308, 6103.6032657877095, 6142.447179753844, 6163.489944963423, 5597.608167428241, 5912.940870591411, 5940.811837632405, 5983.444304480953, 5989.940100598938, 5806.158107074366, 5826.0, 5834.212381328636, 5836.86181194663, 5846.649201047951, 6075.969620151871, 6109.84725381869, 6116.327204007466, 6123.203983482119, 6164.907526387018, 4131.648809851196, 4180.644645205191, 4182.414461975265, 4184.079502509443, 4195.811188496586, 5618.2134501170685, 5803.9419605803405, 5850.356460789395, 5936.940630593639, 5943.375945525658, 5707.600467967369, 5778.566607504538, 5816.82549523515, 5848.678322692293, 5852.912206316993, 5753.1945527627, 5761.798337058183, 5763.386251849489, 5763.97118014424, 5797.9420205797405, 5493.423190565093, 5615.859603509782, 5662.348829884616, 5706.343770466449, 5729.656220626775, 5772.480476757112, 5797.565182611237, 5828.2423284974375, 5848.619839710405, 5869.559783016376, 5434.945650543444, 5681.0, 5718.712514994036, 5753.683547404933, 5772.134179873053], "value": 4302.616353530283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.3265126688517, 782.1943398299753, 799.7600719784064, 873.4802792338559, 898.7618281155495, 14385.496507622236, 15870.285837137328, 16716.74924876126, 16752.413665521708, 16792.916035419836, 15673.686526269468, 15735.60660983476, 15782.21088945551, 15790.526284211463, 15882.126483043428, 732.8680837449257, 849.613425891218, 852.2713080316333, 871.860502319629, 872.0146234754718, 870.7561882672861, 872.9519876406795, 875.3347455933473, 876.5529579914257, 878.565110270417, 916.4592890194783, 917.1149840404008, 918.4168053286178, 918.6922381002372, 918.8667643191733, 767.3439209475902, 877.0484024833064, 898.2768871058828, 899.1053901368181, 902.2421166220341, 660.131926516629, 661.5964261800347, 662.2681936460191, 662.3442791636245, 662.4369286106771, 15515.456959006493, 15549.144797036159, 15572.0, 15597.454089106941, 15614.453494127765, 14977.400903963828, 15007.699846003019, 15263.694726105416, 15320.846791532165, 15461.845381546153, 12878.935605321913, 12913.483460661562, 13079.084464087518, 13118.344082795822, 13183.802242966363, 4624.0, 4652.232381657022, 4653.046125544255, 4697.67116301859, 4726.976365118187, 81865.59067204685, 82256.17743822605, 83873.0, 84237.57881210616, 85685.57157214236, 12040.879591204151, 12151.635450936486, 12160.756784864254, 12243.816342754866, 12467.940225080789, 22077.0, 22080.0, 22143.667844982338, 22190.556188876453, 22210.444738881335, 9052.954735226282, 9092.454452732858, 9186.219171370509, 9229.676961306322, 9333.0, 4911.9754401227765, 4983.8504844854715, 5124.461931497139, 5170.767315470813, 5267.051930652443, 3467.601225859008, 3629.7840223524886, 3636.254567813592, 3636.3272794533095, 3641.5630124385243, 580.1413907416962, 597.8087012156068, 650.2359727320379, 663.9136912201383, 664.7872680742213, 650.1190886348929, 699.9475039371965, 770.1605250277224, 776.8329809091073, 799.4044436894435, 10513.316634418738, 10528.894711052944, 10726.892731072745, 10741.51663175159, 10836.0789332906, 654.5679851298121, 702.2696395748467, 727.912650481935, 745.4930647159983, 842.6671464771381, 4928.0390323886495, 5064.670796398223, 5084.542391184811, 5223.660462069954, 5233.319668443078, 77754.0, 79832.0, 80359.59820200979, 128676.0, 129006.35496822456, 73045.6347718258, 101068.49465752624, 109488.4525577367, 118162.0, 120849.39575302067, 66029.0, 99911.0, 101517.0, 101630.98369016363, 102723.4863825691, 9913.611514499662, 10067.848982265125, 10069.899301006895, 10108.140808031105, 10143.34068285559, 58013.709931450074, 58470.707646461495, 58490.707546463695, 59794.40205598062, 60515.0, 76013.61993189999, 77560.61219693866, 84813.0, 86503.56748216218, 88349.5582522109, 11518.596849110241, 11672.591459298883, 11984.79801435302, 13345.66635834112, 14167.433302667778, 14954.476593319181, 15503.84496155024, 15865.68268634644, 15896.841031589536, 17098.316067357166, 14579.34392952341, 14710.63223419423, 14731.26343682833, 14796.704065918837, 15459.149746764037, 13780.862191377957, 13826.267216807128, 13850.861491384958, 14125.0, 14215.147091174562, 14360.640983975067, 14429.278536073365, 14582.0, 14595.635109122357, 14750.114993100447, 11688.824667630162, 12042.759144816879, 12203.267803931793, 12403.0, 12915.806262906252, 12262.26426414418, 12298.569550065704, 12555.87444125547, 12561.0, 12727.109102363116], "value": 8027.837120451808, "unit": "score"}], "name": "dromaeo_css", "value": 7660.2862420379715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 129.0, 185.0, 125.0, 131.0, 150.0, 128.0, 172.0, 126.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 166.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 75.0, 118.0, 75.0, 76.0, 77.0, 75.0, 97.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 114.0, 84.0, 84.0, 83.0, 115.0, 85.0, 85.0, 121.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 52.0, 53.0, 52.0, 53.0, 52.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 61.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 79.0, 77.0, 78.0, 82.0, 79.0, 78.0, 101.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 116.0, 118.0, 119.0, 114.0, 115.0, 117.0, 122.0, 122.0], "value": 118.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 166.0, 159.0, 154.0, 155.0, 157.0, 159.0, 155.0, 156.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 63.0, 63.0, 63.0, 64.0, 61.0, 63.0, 64.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1479.1, "alertThreshold": 2.0}]} 12:55:15 INFO - Return code: 0 12:55:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:55:15 ERROR - # TBPL SUCCESS # 12:55:15 INFO - Running post-action listener: _resource_record_post_action 12:55:15 INFO - ##### 12:55:15 INFO - ##### Finished run-tests step (success) 12:55:15 INFO - ##### 12:55:15 INFO - Running post-run listener: _resource_record_post_run 12:55:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504418304; Read time: 32; Write time: 996344 12:55:16 INFO - TinderboxPrint: CPU usage
13.1% 12:55:16 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 12:55:16 INFO - TinderboxPrint: I/O write bytes / time
504,418,304 / 996,344 12:55:16 INFO - TinderboxPrint: CPU idle
8,256.0 (86.9%) 12:55:16 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 12:55:16 INFO - TinderboxPrint: Swap in / out
0 / 0 12:55:16 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 219893760; Read time: 0; Write time: 687264 12:55:16 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251838464; Read time: 32; Write time: 287396 12:55:16 INFO - Running post-run listener: _upload_blobber_files 12:55:16 INFO - Blob upload gear active. 12:55:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:55:16 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 12:55:16 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'] 12:55:16 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 12:55:16 INFO - (blobuploader) - INFO - Open directory for files ... 12:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:55:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:21 INFO - (blobuploader) - INFO - Done attempting. 12:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:22 INFO - (blobuploader) - INFO - Done attempting. 12:55:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:55:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:55:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:23 INFO - (blobuploader) - INFO - Done attempting. 12:55:23 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:23 INFO - Return code: 0 12:55:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35e079339df05b99bbe3247a00e8ee7692fdb1018d7a1f896a4b6aaba9cb92a33b209301f5692099b5ae16352b9ef40e7cf3eec1d8b780e53761956a1e485a54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b7f53ca4fc5e6cfb3ca6a77471f5651cc883e0c2df378dd6067bc209f1eb24bb87b901033d413ffd6ed0c69bcbaa6db9b3c86d56a589c1347e6a8cf86a925b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01d6b0c461d84a4d58b82642bceb80398419fcfbf017fb0ed25cf499ef77b2cef9bf6475805449ac182e2dfb4a144ea95a44517f0e01a8ec570dceef3b2b1efa"} 12:55:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:23 INFO - Contents: 12:55:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35e079339df05b99bbe3247a00e8ee7692fdb1018d7a1f896a4b6aaba9cb92a33b209301f5692099b5ae16352b9ef40e7cf3eec1d8b780e53761956a1e485a54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b7f53ca4fc5e6cfb3ca6a77471f5651cc883e0c2df378dd6067bc209f1eb24bb87b901033d413ffd6ed0c69bcbaa6db9b3c86d56a589c1347e6a8cf86a925b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01d6b0c461d84a4d58b82642bceb80398419fcfbf017fb0ed25cf499ef77b2cef9bf6475805449ac182e2dfb4a144ea95a44517f0e01a8ec570dceef3b2b1efa"} 12:55:23 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:23 INFO - Copying logs to upload dir... 12:55:23 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.272638 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-16 12:55:23.127634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:55:23.130974) ========= 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=af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773 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/35e079339df05b99bbe3247a00e8ee7692fdb1018d7a1f896a4b6aaba9cb92a33b209301f5692099b5ae16352b9ef40e7cf3eec1d8b780e53761956a1e485a54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b7f53ca4fc5e6cfb3ca6a77471f5651cc883e0c2df378dd6067bc209f1eb24bb87b901033d413ffd6ed0c69bcbaa6db9b3c86d56a589c1347e6a8cf86a925b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01d6b0c461d84a4d58b82642bceb80398419fcfbf017fb0ed25cf499ef77b2cef9bf6475805449ac182e2dfb4a144ea95a44517f0e01a8ec570dceef3b2b1efa"} build_url:https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/bDGyjTWWTnyOYx9dG_XatA/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/35e079339df05b99bbe3247a00e8ee7692fdb1018d7a1f896a4b6aaba9cb92a33b209301f5692099b5ae16352b9ef40e7cf3eec1d8b780e53761956a1e485a54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b7f53ca4fc5e6cfb3ca6a77471f5651cc883e0c2df378dd6067bc209f1eb24bb87b901033d413ffd6ed0c69bcbaa6db9b3c86d56a589c1347e6a8cf86a925b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01d6b0c461d84a4d58b82642bceb80398419fcfbf017fb0ed25cf499ef77b2cef9bf6475805449ac182e2dfb4a144ea95a44517f0e01a8ec570dceef3b2b1efa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:55:23.158744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:55:23.159132) ========= 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=af724c981e2a0f424dbabf99000001e7-1466102147.356825-810408773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:55:23.241450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:55:23.241825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:55:23.242117) ========= ========= Total master_lag: 0.17 =========