builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1466821384.64 results: success (0) buildid: 20160624163014 builduid: 7ad6286885064645bf59e70f6c172b27 revision: 0e073f5ca38a002d43e92016ee40d686da4a0534 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.637844) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.638474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.638808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.673218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.673590) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 19:23:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-06-24 19:23:04 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121345 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.822007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.822403) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018895 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.873022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.873387) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e073f5ca38a002d43e92016ee40d686da4a0534 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0e073f5ca38a002d43e92016ee40d686da4a0534 --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=edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 19:23:05,057 truncating revision to first 12 chars 2016-06-24 19:23:05,057 Setting DEBUG logging. 2016-06-24 19:23:05,057 attempt 1/10 2016-06-24 19:23:05,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e073f5ca38a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 19:23:05,366 unpacking tar archive at: mozilla-central-0e073f5ca38a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.513650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.513944) ========= script_repo_revision: 0e073f5ca38a002d43e92016ee40d686da4a0534 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.514341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.514609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.525723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 19:23:05.526012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:23:05 INFO - MultiFileLogger online at 20160624 19:23:05 in /builds/slave/test 19:23:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:23:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:23:05 INFO - {'append_to_log': False, 19:23:05 INFO - 'base_work_dir': '/builds/slave/test', 19:23:05 INFO - 'blob_upload_branch': 'Firefox', 19:23:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:23:05 INFO - 'branch': 'Firefox', 19:23:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:23:05 INFO - 'config_files': ('talos/linux_config.py',), 19:23:05 INFO - 'default_actions': ('clobber', 19:23:05 INFO - 'read-buildbot-config', 19:23:05 INFO - 'download-and-extract', 19:23:05 INFO - 'populate-webroot', 19:23:05 INFO - 'create-virtualenv', 19:23:05 INFO - 'install', 19:23:05 INFO - 'run-tests'), 19:23:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:23:05 INFO - 'download_minidump_stackwalk': True, 19:23:05 INFO - 'download_symbols': 'ondemand', 19:23:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:23:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:23:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:23:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:23:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:23:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:23:05 INFO - 'installer_path': 'installer.exe', 19:23:05 INFO - 'log_level': 'info', 19:23:05 INFO - 'log_name': 'talos', 19:23:05 INFO - 'log_to_console': True, 19:23:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:23:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:23:05 INFO - 'opt_config_files': (), 19:23:05 INFO - 'pip_index': False, 19:23:05 INFO - 'sps_profile': False, 19:23:05 INFO - 'sps_profile_interval': 0, 19:23:05 INFO - 'suite': 'dromaeojs', 19:23:05 INFO - 'system_bits': '32', 19:23:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:23:05 INFO - 'title': 'talos-linux64-ix-033', 19:23:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:23:05 INFO - 'use_talos_json': True, 19:23:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:23:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:23:05 INFO - 'work_dir': 'build'} 19:23:05 INFO - ##### 19:23:05 INFO - ##### Running clobber step. 19:23:05 INFO - ##### 19:23:05 INFO - Running pre-action listener: _resource_record_pre_action 19:23:05 INFO - Running main action method: clobber 19:23:05 INFO - rmtree: /builds/slave/test/build 19:23:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:23:06 INFO - Running post-action listener: _resource_record_post_action 19:23:06 INFO - ##### 19:23:06 INFO - ##### Finished clobber step (success) 19:23:06 INFO - ##### 19:23:06 INFO - ##### 19:23:06 INFO - ##### Running read-buildbot-config step. 19:23:06 INFO - ##### 19:23:06 INFO - Running pre-action listener: _resource_record_pre_action 19:23:06 INFO - Running main action method: read_buildbot_config 19:23:06 INFO - Using buildbot properties: 19:23:06 INFO - { 19:23:06 INFO - "project": "", 19:23:06 INFO - "product": "firefox", 19:23:06 INFO - "script_repo_revision": "production", 19:23:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:23:06 INFO - "repository": "", 19:23:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:23:06 INFO - "buildid": "20160624163014", 19:23:06 INFO - "pgo_build": "True", 19:23:06 INFO - "basedir": "/builds/slave/test", 19:23:06 INFO - "buildnumber": 481, 19:23:06 INFO - "slavename": "talos-linux64-ix-033", 19:23:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:23:06 INFO - "platform": "ubuntu64_hw", 19:23:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:23:06 INFO - "branch": "mozilla-central", 19:23:06 INFO - "repo_path": "mozilla-central", 19:23:06 INFO - "revision": "0e073f5ca38a002d43e92016ee40d686da4a0534", 19:23:06 INFO - "stage_platform": "linux64-pgo", 19:23:06 INFO - "builduid": "7ad6286885064645bf59e70f6c172b27", 19:23:06 INFO - "slavebuilddir": "test" 19:23:06 INFO - } 19:23:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:23:06 INFO - Running post-action listener: _resource_record_post_action 19:23:06 INFO - ##### 19:23:06 INFO - ##### Finished read-buildbot-config step (success) 19:23:06 INFO - ##### 19:23:06 INFO - ##### 19:23:06 INFO - ##### Running download-and-extract step. 19:23:06 INFO - ##### 19:23:06 INFO - Running pre-action listener: _resource_record_pre_action 19:23:06 INFO - Running main action method: download_and_extract 19:23:06 INFO - mkdir: /builds/slave/test/build/tests 19:23: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')]} 19:23:06 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:23:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:23:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:23:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:23:08 INFO - Downloaded 1361 bytes. 19:23:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:23:08 INFO - Using the following test package requirements: 19:23:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:23:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:23:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:23:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'jsshell-linux-x86_64.zip'], 19:23:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:23:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:23:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:23:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:23:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:23:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:23:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:23:08 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')]} 19:23:08 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:23:09 INFO - Downloaded 24279771 bytes. 19:23:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:23:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:23:10 INFO - Return code: 0 19:23:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:10 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:23:12 INFO - Downloaded 24279771 bytes. 19:23:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:23:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:23:13 INFO - Return code: 0 19:23: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')]} 19:23:13 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:23:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:23:14 INFO - Downloaded 14405188 bytes. 19:23:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:23:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:23:15 INFO - Return code: 0 19:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:15 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:23:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:23:16 INFO - Downloaded 60188127 bytes. 19:23:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:16 INFO - mkdir: /builds/slave/test/properties 19:23:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:23:16 INFO - Writing to file /builds/slave/test/properties/build_url 19:23:16 INFO - Contents: 19:23:16 INFO - build_url:https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:17 INFO - Running post-action listener: _resource_record_post_action 19:23:17 INFO - Running post-action listener: set_extra_try_arguments 19:23:17 INFO - ##### 19:23:17 INFO - ##### Finished download-and-extract step (success) 19:23:17 INFO - ##### 19:23:17 INFO - ##### 19:23:17 INFO - ##### Running populate-webroot step. 19:23:17 INFO - ##### 19:23:17 INFO - Running pre-action listener: _resource_record_pre_action 19:23:17 INFO - Running main action method: populate_webroot 19:23:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:23:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:23:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:23:17 INFO - '--tppagecycles', 19:23:17 INFO - '7'], 19:23:17 INFO - 'tests': ['tsvgm']}}, 19:23:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:23:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:23:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:23:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:23:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['damp', 'tps']}, 19:23:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'tests': ['damp', 'tps']}, 19:23:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['dromaeo_dom']}, 19:23:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:23:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['basic_compositor_video']}, 19:23:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:23:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['a11yr', 19:23:17 INFO - 'ts_paint', 19:23:17 INFO - 'tpaint', 19:23:17 INFO - 'sessionrestore', 19:23:17 INFO - 'sessionrestore_no_auto_restore', 19:23:17 INFO - 'tabpaint']}, 19:23:17 INFO - 'other-e10s': {'tests': ['a11yr', 19:23:17 INFO - 'ts_paint', 19:23:17 INFO - 'tpaint', 19:23:17 INFO - 'sessionrestore', 19:23:17 INFO - 'sessionrestore_no_auto_restore', 19:23:17 INFO - 'tabpaint']}, 19:23:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:23:17 INFO - 'ts_paint', 19:23:17 INFO - 'tpaint', 19:23:17 INFO - 'sessionrestore', 19:23:17 INFO - 'sessionrestore_no_auto_restore', 19:23:17 INFO - 'tabpaint']}, 19:23:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:23:17 INFO - 'ts_paint', 19:23:17 INFO - 'tpaint', 19:23:17 INFO - 'sessionrestore', 19:23:17 INFO - 'sessionrestore_no_auto_restore', 19:23:17 INFO - 'tabpaint']}, 19:23:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['a11yr', 19:23:17 INFO - 'ts_paint', 19:23:17 INFO - 'tpaint', 19:23:17 INFO - 'sessionrestore', 19:23:17 INFO - 'sessionrestore_no_auto_restore', 19:23:17 INFO - 'tabpaint']}, 19:23:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['a11yr', 19:23:17 INFO - 'ts_paint', 19:23:17 INFO - 'tpaint', 19:23:17 INFO - 'sessionrestore', 19:23:17 INFO - 'sessionrestore_no_auto_restore', 19:23:17 INFO - 'tabpaint']}, 19:23:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['tsvgx', 19:23:17 INFO - 'tsvgr_opacity', 19:23:17 INFO - 'tart', 19:23:17 INFO - 'tscrollx', 19:23:17 INFO - 'cart']}, 19:23:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:23:17 INFO - 'tsvgr_opacity', 19:23:17 INFO - 'tart', 19:23:17 INFO - 'tscrollx', 19:23:17 INFO - 'cart']}, 19:23:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'talos_options': ['--disable-e10s'], 19:23:17 INFO - 'tests': ['tp5o']}, 19:23:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'tests': ['tp5o']}, 19:23:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'talos_options': ['--disable-e10s', 19:23:17 INFO - '--xperf_path', 19:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:17 INFO - 'tests': ['tp5n']}, 19:23:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:17 INFO - 'talos_options': ['--xperf_path', 19:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:17 INFO - 'tests': ['tp5n']}}, 19:23:17 INFO - 'talos.zip': {'path': '', 19:23:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:23:17 INFO - Running post-action listener: _resource_record_post_action 19:23:17 INFO - ##### 19:23:17 INFO - ##### Finished populate-webroot step (success) 19:23:17 INFO - ##### 19:23:17 INFO - ##### 19:23:17 INFO - ##### Running create-virtualenv step. 19:23:17 INFO - ##### 19:23:17 INFO - Running pre-action listener: _resource_record_pre_action 19:23:17 INFO - Running main action method: create_virtualenv 19:23:17 INFO - Creating virtualenv /builds/slave/test/build/venv 19:23:17 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 19:23:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:23:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:23:17 INFO - Using real prefix '/usr' 19:23:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:23:17 INFO - Installing distribute.............................................................................................................................................................................................done. 19:23:19 INFO - Installing pip.................done. 19:23:19 INFO - Return code: 0 19:23:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:19 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:19 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 19:23:19 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 19:23:19 INFO - Using env: {'DISPLAY': ':0', 19:23:19 INFO - 'HOME': '/home/cltbld', 19:23:19 INFO - 'LANG': 'en_US.UTF-8', 19:23:19 INFO - 'LANGUAGE': 'en_US:en', 19:23:19 INFO - 'LOGNAME': 'cltbld', 19:23:19 INFO - 'MAIL': '/var/mail/cltbld', 19:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:19 INFO - 'MOZ_NO_REMOTE': '1', 19:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:19 INFO - 'NO_EM_RESTART': '1', 19:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:19 INFO - 'PWD': '/builds/slave/test', 19:23:19 INFO - 'SHELL': '/bin/bash', 19:23:19 INFO - 'SHLVL': '1', 19:23:19 INFO - 'TERM': 'linux', 19:23:19 INFO - 'TMOUT': '86400', 19:23:19 INFO - 'USER': 'cltbld', 19:23:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:19 INFO - '_': '/tools/buildbot/bin/python'} 19:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:20 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 19:23:20 INFO - Cleaning up... 19:23:20 INFO - Return code: 0 19:23:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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', '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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:23: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 psutil>=3.1.1 19:23:20 INFO - Using env: {'DISPLAY': ':0', 19:23:20 INFO - 'HOME': '/home/cltbld', 19:23:20 INFO - 'LANG': 'en_US.UTF-8', 19:23:20 INFO - 'LANGUAGE': 'en_US:en', 19:23:20 INFO - 'LOGNAME': 'cltbld', 19:23:20 INFO - 'MAIL': '/var/mail/cltbld', 19:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:20 INFO - 'MOZ_NO_REMOTE': '1', 19:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:20 INFO - 'NO_EM_RESTART': '1', 19:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:20 INFO - 'PWD': '/builds/slave/test', 19:23:20 INFO - 'SHELL': '/bin/bash', 19:23:20 INFO - 'SHLVL': '1', 19:23:20 INFO - 'TERM': 'linux', 19:23:20 INFO - 'TMOUT': '86400', 19:23:20 INFO - 'USER': 'cltbld', 19:23:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:20 INFO - '_': '/tools/buildbot/bin/python'} 19:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:20 INFO - Downloading/unpacking psutil>=3.1.1 19:23:20 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 19:23:20 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 19:23:20 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 19:23:20 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 19:23:20 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 19:23:20 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 19:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:23:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:22 INFO - Installing collected packages: psutil 19:23:22 INFO - Running setup.py install for psutil 19:23:22 INFO - building 'psutil._psutil_linux' extension 19:23:22 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 19:23:22 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 19:23:22 INFO - building 'psutil._psutil_posix' extension 19:23:22 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 19:23:22 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 19:23:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:22 INFO - Successfully installed psutil 19:23:22 INFO - Cleaning up... 19:23:22 INFO - Return code: 0 19:23:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:23:22 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')]} 19:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:22 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')]} 19:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:22 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:22 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 19:23:22 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 19:23:22 INFO - Using env: {'DISPLAY': ':0', 19:23:22 INFO - 'HOME': '/home/cltbld', 19:23:22 INFO - 'LANG': 'en_US.UTF-8', 19:23:22 INFO - 'LANGUAGE': 'en_US:en', 19:23:22 INFO - 'LOGNAME': 'cltbld', 19:23:22 INFO - 'MAIL': '/var/mail/cltbld', 19:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:22 INFO - 'MOZ_NO_REMOTE': '1', 19:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:22 INFO - 'NO_EM_RESTART': '1', 19:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:22 INFO - 'PWD': '/builds/slave/test', 19:23:22 INFO - 'SHELL': '/bin/bash', 19:23:22 INFO - 'SHLVL': '1', 19:23:22 INFO - 'TERM': 'linux', 19:23:22 INFO - 'TMOUT': '86400', 19:23:22 INFO - 'USER': 'cltbld', 19:23:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:22 INFO - '_': '/tools/buildbot/bin/python'} 19:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:23:25 INFO - Installing collected packages: mozsystemmonitor 19:23:25 INFO - Running setup.py install for mozsystemmonitor 19:23:25 INFO - Successfully installed mozsystemmonitor 19:23:25 INFO - Cleaning up... 19:23:25 INFO - Return code: 0 19:23:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:23:25 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')]} 19:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:25 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')]} 19:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:25 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:25 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 19:23:25 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 19:23:25 INFO - Using env: {'DISPLAY': ':0', 19:23:25 INFO - 'HOME': '/home/cltbld', 19:23:25 INFO - 'LANG': 'en_US.UTF-8', 19:23:25 INFO - 'LANGUAGE': 'en_US:en', 19:23:25 INFO - 'LOGNAME': 'cltbld', 19:23:25 INFO - 'MAIL': '/var/mail/cltbld', 19:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:25 INFO - 'MOZ_NO_REMOTE': '1', 19:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:25 INFO - 'NO_EM_RESTART': '1', 19:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:25 INFO - 'PWD': '/builds/slave/test', 19:23:25 INFO - 'SHELL': '/bin/bash', 19:23:25 INFO - 'SHLVL': '1', 19:23:25 INFO - 'TERM': 'linux', 19:23:25 INFO - 'TMOUT': '86400', 19:23:25 INFO - 'USER': 'cltbld', 19:23:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:25 INFO - '_': '/tools/buildbot/bin/python'} 19:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:25 INFO - Downloading/unpacking jsonschema==2.5.1 19:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:23:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:27 INFO - Downloading functools32-3.2.3-2.tar.gz 19:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:23:27 INFO - warning: no files found matching '*.txt' 19:23:27 INFO - no previously-included directories found matching 'build' 19:23:27 INFO - no previously-included directories found matching 'dist' 19:23:27 INFO - no previously-included directories found matching '.git*' 19:23:27 INFO - Installing collected packages: jsonschema, functools32 19:23:27 INFO - Running setup.py install for functools32 19:23:27 INFO - warning: no files found matching '*.txt' 19:23:27 INFO - no previously-included directories found matching 'build' 19:23:27 INFO - no previously-included directories found matching 'dist' 19:23:27 INFO - no previously-included directories found matching '.git*' 19:23:27 INFO - Successfully installed jsonschema functools32 19:23:27 INFO - Cleaning up... 19:23:27 INFO - Return code: 0 19:23:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:23:27 INFO - Using env: {'DISPLAY': ':0', 19:23:27 INFO - 'HOME': '/home/cltbld', 19:23:27 INFO - 'LANG': 'en_US.UTF-8', 19:23:27 INFO - 'LANGUAGE': 'en_US:en', 19:23:27 INFO - 'LOGNAME': 'cltbld', 19:23:27 INFO - 'MAIL': '/var/mail/cltbld', 19:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:27 INFO - 'MOZ_NO_REMOTE': '1', 19:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:27 INFO - 'NO_EM_RESTART': '1', 19:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:27 INFO - 'PWD': '/builds/slave/test', 19:23:27 INFO - 'SHELL': '/bin/bash', 19:23:27 INFO - 'SHLVL': '1', 19:23:27 INFO - 'TERM': 'linux', 19:23:27 INFO - 'TMOUT': '86400', 19:23:27 INFO - 'USER': 'cltbld', 19:23:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:27 INFO - '_': '/tools/buildbot/bin/python'} 19:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:27 INFO - Downloading/unpacking blobuploader==1.2.4 19:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:29 INFO - Downloading blobuploader-1.2.4.tar.gz 19:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:23:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:23:29 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 19:23:29 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 19:23:29 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 19:23:29 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 19:23:29 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 19:23:29 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 19:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:23:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:30 INFO - Downloading docopt-0.6.1.tar.gz 19:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:23:30 INFO - Installing collected packages: blobuploader, requests, docopt 19:23:30 INFO - Running setup.py install for blobuploader 19:23:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:23:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:23:30 INFO - Running setup.py install for requests 19:23:31 INFO - Running setup.py install for docopt 19:23:31 INFO - Successfully installed blobuploader requests docopt 19:23:31 INFO - Cleaning up... 19:23:31 INFO - Return code: 0 19:23:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:31 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:31 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 19:23:31 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 19:23:31 INFO - Using env: {'DISPLAY': ':0', 19:23:31 INFO - 'HOME': '/home/cltbld', 19:23:31 INFO - 'LANG': 'en_US.UTF-8', 19:23:31 INFO - 'LANGUAGE': 'en_US:en', 19:23:31 INFO - 'LOGNAME': 'cltbld', 19:23:31 INFO - 'MAIL': '/var/mail/cltbld', 19:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:31 INFO - 'MOZ_NO_REMOTE': '1', 19:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:31 INFO - 'NO_EM_RESTART': '1', 19:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:31 INFO - 'PWD': '/builds/slave/test', 19:23:31 INFO - 'SHELL': '/bin/bash', 19:23:31 INFO - 'SHLVL': '1', 19:23:31 INFO - 'TERM': 'linux', 19:23:31 INFO - 'TMOUT': '86400', 19:23:31 INFO - 'USER': 'cltbld', 19:23:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:31 INFO - '_': '/tools/buildbot/bin/python'} 19:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:31 INFO - Running setup.py (path:/tmp/pip-uGZm58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:31 INFO - Running setup.py (path:/tmp/pip-VWU7QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:31 INFO - Running setup.py (path:/tmp/pip-QHl2s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:31 INFO - Running setup.py (path:/tmp/pip-TPKqPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:31 INFO - Running setup.py (path:/tmp/pip-J3izH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:31 INFO - Running setup.py (path:/tmp/pip-CDy03o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:31 INFO - Running setup.py (path:/tmp/pip-e2Mukg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:31 INFO - Running setup.py (path:/tmp/pip-qJHSMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:31 INFO - Running setup.py (path:/tmp/pip-BUgS32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:32 INFO - Running setup.py (path:/tmp/pip-hiWUM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:32 INFO - Running setup.py (path:/tmp/pip-ndTvYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:32 INFO - Running setup.py (path:/tmp/pip-yfR_RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:32 INFO - Running setup.py (path:/tmp/pip-12Z_3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:32 INFO - Running setup.py (path:/tmp/pip-i0whlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:32 INFO - Running setup.py (path:/tmp/pip-Zlbymd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:32 INFO - Running setup.py (path:/tmp/pip-86RS6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:32 INFO - Running setup.py (path:/tmp/pip-8K3WmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:23:32 INFO - Running setup.py install for manifestparser 19:23:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Running setup.py install for mozcrash 19:23:32 INFO - Running setup.py install for mozdebug 19:23:32 INFO - Running setup.py install for mozdevice 19:23:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Running setup.py install for mozfile 19:23:33 INFO - Running setup.py install for mozhttpd 19:23:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Running setup.py install for mozinfo 19:23:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Running setup.py install for mozInstall 19:23:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Running setup.py install for mozleak 19:23:33 INFO - Running setup.py install for mozlog 19:23:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Running setup.py install for moznetwork 19:23:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Running setup.py install for mozprocess 19:23:33 INFO - Running setup.py install for mozprofile 19:23:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Running setup.py install for mozrunner 19:23:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:23:34 INFO - Running setup.py install for mozscreenshot 19:23:34 INFO - Running setup.py install for moztest 19:23:34 INFO - Running setup.py install for mozversion 19:23:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:23:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:23:34 INFO - Cleaning up... 19:23:34 INFO - Return code: 0 19:23:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:34 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:34 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 19:23:34 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 19:23:34 INFO - Using env: {'DISPLAY': ':0', 19:23:34 INFO - 'HOME': '/home/cltbld', 19:23:34 INFO - 'LANG': 'en_US.UTF-8', 19:23:34 INFO - 'LANGUAGE': 'en_US:en', 19:23:34 INFO - 'LOGNAME': 'cltbld', 19:23:34 INFO - 'MAIL': '/var/mail/cltbld', 19:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:34 INFO - 'MOZ_NO_REMOTE': '1', 19:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:34 INFO - 'NO_EM_RESTART': '1', 19:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:34 INFO - 'PWD': '/builds/slave/test', 19:23:34 INFO - 'SHELL': '/bin/bash', 19:23:34 INFO - 'SHLVL': '1', 19:23:34 INFO - 'TERM': 'linux', 19:23:34 INFO - 'TMOUT': '86400', 19:23:34 INFO - 'USER': 'cltbld', 19:23:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:34 INFO - '_': '/tools/buildbot/bin/python'} 19:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:34 INFO - Running setup.py (path:/tmp/pip-8PNvtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:34 INFO - Running setup.py (path:/tmp/pip-CbVeRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:34 INFO - Running setup.py (path:/tmp/pip-LEFHhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:34 INFO - Running setup.py (path:/tmp/pip-g9KTz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:34 INFO - Running setup.py (path:/tmp/pip-o34Upz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:34 INFO - Running setup.py (path:/tmp/pip-DFQe0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:35 INFO - Running setup.py (path:/tmp/pip-qICuNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:35 INFO - Running setup.py (path:/tmp/pip-FrmMeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:35 INFO - Running setup.py (path:/tmp/pip-fcRlJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:35 INFO - Running setup.py (path:/tmp/pip-_uJWYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:35 INFO - Running setup.py (path:/tmp/pip-z2y7qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:35 INFO - Running setup.py (path:/tmp/pip-0yE0zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:35 INFO - Running setup.py (path:/tmp/pip-0V7o4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:35 INFO - Running setup.py (path:/tmp/pip-jWZPhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:35 INFO - Running setup.py (path:/tmp/pip-1GuCWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:35 INFO - Running setup.py (path:/tmp/pip-d1pfad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:35 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)) 19:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:35 INFO - Running setup.py (path:/tmp/pip-r3JQAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:35 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)) 19:23:35 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)) 19:23:35 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)) 19:23:35 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)) 19:23:35 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)) 19:23:35 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)) 19:23:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:37 INFO - Downloading blessings-1.6.tar.gz 19:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:23:37 INFO - Installing collected packages: blessings 19:23:37 INFO - Running setup.py install for blessings 19:23:37 INFO - Successfully installed blessings 19:23:37 INFO - Cleaning up... 19:23:38 INFO - Return code: 0 19:23:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:38 INFO - Reading from file tmpfile_stdout 19:23:38 INFO - Current package versions: 19:23:38 INFO - argparse == 1.2.1 19:23:38 INFO - blessings == 1.6 19:23:38 INFO - blobuploader == 1.2.4 19:23:38 INFO - docopt == 0.6.1 19:23:38 INFO - functools32 == 3.2.3-2 19:23:38 INFO - jsonschema == 2.5.1 19:23:38 INFO - manifestparser == 1.1 19:23:38 INFO - mozInstall == 1.12 19:23:38 INFO - mozcrash == 0.17 19:23:38 INFO - mozdebug == 0.1 19:23:38 INFO - mozdevice == 0.48 19:23:38 INFO - mozfile == 1.2 19:23:38 INFO - mozhttpd == 0.7 19:23:38 INFO - mozinfo == 0.9 19:23:38 INFO - mozleak == 0.1 19:23:38 INFO - mozlog == 3.2 19:23:38 INFO - moznetwork == 0.27 19:23:38 INFO - mozprocess == 0.22 19:23:38 INFO - mozprofile == 0.28 19:23:38 INFO - mozrunner == 6.11 19:23:38 INFO - mozscreenshot == 0.1 19:23:38 INFO - mozsystemmonitor == 0.3 19:23:38 INFO - moztest == 0.7 19:23:38 INFO - mozversion == 1.4 19:23:38 INFO - psutil == 3.1.1 19:23:38 INFO - requests == 1.2.3 19:23:38 INFO - wsgiref == 0.1.2 19:23:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:38 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')]} 19:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:38 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')]} 19:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:38 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:38 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 19:23:38 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 19:23:38 INFO - Using env: {'DISPLAY': ':0', 19:23:38 INFO - 'HOME': '/home/cltbld', 19:23:38 INFO - 'LANG': 'en_US.UTF-8', 19:23:38 INFO - 'LANGUAGE': 'en_US:en', 19:23:38 INFO - 'LOGNAME': 'cltbld', 19:23:38 INFO - 'MAIL': '/var/mail/cltbld', 19:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:38 INFO - 'MOZ_NO_REMOTE': '1', 19:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:38 INFO - 'NO_EM_RESTART': '1', 19:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:38 INFO - 'PWD': '/builds/slave/test', 19:23:38 INFO - 'SHELL': '/bin/bash', 19:23:38 INFO - 'SHLVL': '1', 19:23:38 INFO - 'TERM': 'linux', 19:23:38 INFO - 'TMOUT': '86400', 19:23:38 INFO - 'USER': 'cltbld', 19:23:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:38 INFO - '_': '/tools/buildbot/bin/python'} 19:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 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)) 19:23:38 INFO - Cleaning up... 19:23:38 INFO - Return code: 0 19:23:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:23:38 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')]} 19:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:38 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')]} 19:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:38 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:38 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 19:23:38 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 19:23:38 INFO - Using env: {'DISPLAY': ':0', 19:23:38 INFO - 'HOME': '/home/cltbld', 19:23:38 INFO - 'LANG': 'en_US.UTF-8', 19:23:38 INFO - 'LANGUAGE': 'en_US:en', 19:23:38 INFO - 'LOGNAME': 'cltbld', 19:23:38 INFO - 'MAIL': '/var/mail/cltbld', 19:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:38 INFO - 'MOZ_NO_REMOTE': '1', 19:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:38 INFO - 'NO_EM_RESTART': '1', 19:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:38 INFO - 'PWD': '/builds/slave/test', 19:23:38 INFO - 'SHELL': '/bin/bash', 19:23:38 INFO - 'SHLVL': '1', 19:23:38 INFO - 'TERM': 'linux', 19:23:38 INFO - 'TMOUT': '86400', 19:23:38 INFO - 'USER': 'cltbld', 19:23:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:38 INFO - '_': '/tools/buildbot/bin/python'} 19:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:23:38 INFO - Cleaning up... 19:23:38 INFO - Return code: 0 19:23:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:23:38 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')]} 19:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:38 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')]} 19:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:38 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 0x7f03de2d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', '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 19:23:38 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 19:23:38 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 19:23:38 INFO - Using env: {'DISPLAY': ':0', 19:23:38 INFO - 'HOME': '/home/cltbld', 19:23:38 INFO - 'LANG': 'en_US.UTF-8', 19:23:38 INFO - 'LANGUAGE': 'en_US:en', 19:23:38 INFO - 'LOGNAME': 'cltbld', 19:23:38 INFO - 'MAIL': '/var/mail/cltbld', 19:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:38 INFO - 'MOZ_NO_REMOTE': '1', 19:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:38 INFO - 'NO_EM_RESTART': '1', 19:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:38 INFO - 'PWD': '/builds/slave/test', 19:23:38 INFO - 'SHELL': '/bin/bash', 19:23:38 INFO - 'SHLVL': '1', 19:23:38 INFO - 'TERM': 'linux', 19:23:38 INFO - 'TMOUT': '86400', 19:23:38 INFO - 'USER': 'cltbld', 19:23:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:38 INFO - '_': '/tools/buildbot/bin/python'} 19:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:38 INFO - Downloading/unpacking flake8 19:23:38 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 19:23:38 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 19:23:38 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 19:23:38 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 19:23:38 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 19:23:38 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 19:23:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:23:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:23:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 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 19:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:23:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:41 INFO - no previously-included directories found matching 'docs/_build' 19:23:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:23:41 INFO - Running setup.py install for pep8 19:23:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:41 INFO - no previously-included directories found matching 'docs/_build' 19:23:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:23:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:23:41 INFO - Cleaning up... 19:23:41 INFO - Return code: 0 19:23:41 INFO - Running post-action listener: _resource_record_post_action 19:23:41 INFO - Running post-action listener: _start_resource_monitoring 19:23:41 INFO - Starting resource monitoring. 19:23:41 INFO - ##### 19:23:41 INFO - ##### Finished create-virtualenv step (success) 19:23:41 INFO - ##### 19:23:41 INFO - ##### 19:23:41 INFO - ##### Running install step. 19:23:41 INFO - ##### 19:23:41 INFO - Running pre-action listener: _resource_record_pre_action 19:23:41 INFO - Running main action method: install 19:23:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:42 INFO - Reading from file tmpfile_stdout 19:23:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:23:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:23:42 INFO - Reading from file tmpfile_stdout 19:23:42 INFO - Output received: 19:23:42 INFO - Usage: mozinstall [options] installer 19:23:42 INFO - Options: 19:23:42 INFO - -h, --help show this help message and exit 19:23:42 INFO - -d DEST, --destination=DEST 19:23:42 INFO - Directory to install application into. [default: 19:23:42 INFO - "/builds/slave/test"] 19:23:42 INFO - --app=APP Application being installed. [default: firefox] 19:23:42 INFO - mkdir: /builds/slave/test/build/application 19:23:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:23:59 INFO - Reading from file tmpfile_stdout 19:23:59 INFO - Output received: 19:23:59 INFO - /builds/slave/test/build/application/firefox/firefox 19:23:59 INFO - Running post-action listener: _resource_record_post_action 19:23:59 INFO - ##### 19:23:59 INFO - ##### Finished install step (success) 19:23:59 INFO - ##### 19:23:59 INFO - ##### 19:23:59 INFO - ##### Running run-tests step. 19:23:59 INFO - ##### 19:23:59 INFO - Running pre-action listener: _resource_record_pre_action 19:23:59 INFO - Running main action method: run_tests 19:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:59 INFO - Python 2.7.3 19:23:59 INFO - Return code: 0 19:23:59 INFO - grabbing minidump binary from tooltool 19:23:59 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')]} 19:23:59 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 0x2068110>, '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 0x1fd4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd46c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:59 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 19:23:59 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 19:23:59 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 19:24:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:24:00 INFO - Return code: 0 19:24:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:24:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:24:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:24:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:24:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:24:00 INFO - Return code: 0 19:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 19:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 19:24:00 INFO - Using env: {'DISPLAY': ':0', 19:24:00 INFO - 'HOME': '/home/cltbld', 19:24:00 INFO - 'LANG': 'en_US.UTF-8', 19:24:00 INFO - 'LANGUAGE': 'en_US:en', 19:24:00 INFO - 'LOGNAME': 'cltbld', 19:24:00 INFO - 'MAIL': '/var/mail/cltbld', 19:24:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:24:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:00 INFO - 'MOZ_NO_REMOTE': '1', 19:24:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:00 INFO - 'NO_EM_RESTART': '1', 19:24:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:00 INFO - 'PWD': '/builds/slave/test', 19:24:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:24:00 INFO - 'SHELL': '/bin/bash', 19:24:00 INFO - 'SHLVL': '1', 19:24:00 INFO - 'TERM': 'linux', 19:24:00 INFO - 'TMOUT': '86400', 19:24:00 INFO - 'USER': 'cltbld', 19:24:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613', 19:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:00 INFO - '_': '/tools/buildbot/bin/python'} 19:24:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 19:24:01 INFO - mozversion application_buildid: 20160624163014 19:24:01 INFO - mozversion application_changeset: 0e073f5ca38a002d43e92016ee40d686da4a0534 19:24:01 INFO - mozversion application_display_name: Nightly 19:24:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:24:01 INFO - mozversion application_name: Firefox 19:24:01 INFO - mozversion application_remotingname: firefox 19:24:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:24:01 INFO - mozversion application_vendor: Mozilla 19:24:01 INFO - mozversion application_version: 50.0a1 19:24:01 INFO - mozversion platform_buildid: 20160624163014 19:24:01 INFO - mozversion platform_changeset: 0e073f5ca38a002d43e92016ee40d686da4a0534 19:24:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:24:01 INFO - mozversion platform_version: 50.0a1 19:24:01 INFO - using testdate: 1466821441 19:24:01 INFO - actual date: 1466821441 19:24:01 INFO - starting webserver on 'localhost:33260' 19:24:01 INFO - SUITE-START | Running 2 tests 19:24:01 INFO - TEST-START | dromaeo_css 19:24:01 INFO - operating with platform_type : linux_ 19:24:01 INFO - Initialising browser for dromaeo_css test... 19:24:01 INFO - TEST-INFO | started process 20801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDHMuYq/profile http://localhost:33260/getInfo.html) 19:24:06 INFO - PROCESS | 20801 | __metrics Screen width/height:1600/1200 19:24:06 INFO - PROCESS | 20801 | colorDepth:24 19:24:06 INFO - PROCESS | 20801 | Browser inner width/height: 1024/697 19:24:06 INFO - PROCESS | 20801 | __metrics 19:24:07 INFO - PROCESS | 20801 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:24:07 INFO - PROCESS | 20801 | console.error: PushService: 19:24:07 INFO - PROCESS | 20801 | stateChangeProcessEnqueue: Error transitioning state 19:24:07 INFO - PROCESS | 20801 | UnknownError 19:24:08 INFO - TEST-INFO | 20801: exit 0 19:24:08 INFO - Browser initialized. 19:24:08 INFO - Running cycle 1/1 for dromaeo_css test... 19:24:08 INFO - TEST-INFO | started process 20884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDHMuYq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:20 INFO - PROCESS | 20884 | RSS: Main: 173838336 19:24:20 INFO - PROCESS | 20884 | 19:25:12 INFO - PROCESS | 20884 | 1466821512114 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] 19:27:20 INFO - PROCESS | 20884 | Cycle 1(1): loaded http://localhost:33260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33260/tests/dromaeo/cssquery-ext.html) 19:27:21 INFO - PROCESS | 20884 | RSS: Main: 306814976 19:27:21 INFO - PROCESS | 20884 | 19:30:24 INFO - PROCESS | 20884 | Cycle 1(1): loaded http://localhost:33260/tests/dromaeo/cssquery-ext.html (next: http://localhost:33260/tests/dromaeo/cssquery-jquery.html) 19:30:24 INFO - PROCESS | 20884 | RSS: Main: 266752000 19:30:24 INFO - PROCESS | 20884 | 19:33:26 INFO - PROCESS | 20884 | Cycle 1(1): loaded http://localhost:33260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33260/tests/dromaeo/cssquery-mootools.html) 19:33:27 INFO - PROCESS | 20884 | RSS: Main: 255807488 19:33:27 INFO - PROCESS | 20884 | 19:36:29 INFO - PROCESS | 20884 | Cycle 1(1): loaded http://localhost:33260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33260/tests/dromaeo/cssquery-prototype.html) 19:36:30 INFO - PROCESS | 20884 | RSS: Main: 254300160 19:36:30 INFO - PROCESS | 20884 | 19:39:32 INFO - PROCESS | 20884 | Cycle 1(1): loaded http://localhost:33260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33260/tests/dromaeo/cssquery-yui.html) 19:39:33 INFO - PROCESS | 20884 | RSS: Main: 240128000 19:39:33 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | Cycle 1(1): loaded http://localhost:33260/tests/dromaeo/cssquery-yui.html (next: http://localhost:33260/tests/dromaeo/cssquery-dojo.html) 19:42:36 INFO - PROCESS | 20884 | RSS: Main: 286384128 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | __start_tp_report 19:42:36 INFO - PROCESS | 20884 | _x_x_mozilla_page_load 19:42:36 INFO - PROCESS | 20884 | _x_x_mozilla_page_load_details 19:42:36 INFO - PROCESS | 20884 | |i|pagename|runs| 19:42:36 INFO - PROCESS | 20884 | |0;dojo.html;3116.9064928052157;3123.2504198992233;3135.9372812543756;3148.5906832111823;3185.824779637119;5243.161094224924;5336.813211537592;5353.437889021655;5403.567714582834;5420.485053919876;5409.648372855761;5431.891362172764;5441.183822426638;5500.28496295481;5520;4891.046245982035;4911.778969946343;4912.115819152551;5003.099442100421;5006.399232092154;4907.312976183337;5056.494350564951;5073.518015788494;5074.238864170367;5118.59051275897;4730.574248317634;4748.050389922029;4940.382452193476;4947.554720075174;4980.97509512452;4857.927131093001;4873.634477414208;4894.3147959285725;4912.361393018885;4917.0903382874285;4860.125177468054;4869.342638743759;4897.828575999859;4914.70511769295;4935.383077115361;5206.24509446132;5316.548093412064;5420.430854760233;5463.262459567947;5471.781128754885;5728;5813.82558523245;5830.067189249699;5831.446012628793;5834.6790926499025;5822.912656310116;5845.386234445365;5860.941390586125;5871.060630299175;5874.676892770896;5185.066687996159;5353.277307563468;5383.919241211385;5466.535344495723;5468;5942.168096466498;5985.610935289193;5998.070299103646;5998.3701711320555;6006.579539432285;5734.053881109654;5761.049426844607;5771.018926782457;5776.42235776419;5778.508826749689;5590.580706447033;5669.943300566942;5725.141228815711;5740.052891272977;5787.855303617359;5736.282964629421;5748;5765.135229715576;5767.04843700793;5782.7686892523825;5698.373178950312;5726.770929162787;5757.88484230313;5767.68277744728;5774.191613174159;4341.956580434218;4365.126974605092;4377.649788016951;4378.343248512685;4388.210122177975;3883.7475564088245;3890.0858298299877;3902.2585708715255;3925.1168487090176;3962.0689138052535;5392.352917649907;5399.892002159935;5402.594805389612;5407.594430417735;5414.377346605191;5596.748146333425;5660.066089095253;5676.375598684142;5692.715364231772;5756.798512052142;5357.544608708304;5381.2197231402015;5383;5387.838364849061;5388.272583201296;4850.854474365704;4945.406551213805;4958;4963.5780958618925;5003.824866129668;5928.962431574543;5987.850303742354;5992.40075992406;5998.880022399528;6020.698965051817;5827.82516524488;5841.386654401226;5842.1820945066875;5846.883062338815;5878.2064421302575;5804.65172089676;5942.286925568959;6017.06735456005;6033.18551995475;6033.78881739137;5687.971560142173;5690.118031705092;5721.284839395075;5725.65646061221;5741.311042674905;5751.9424805751405;5798.478136967693;5803.535717142703;5806.796762113306;5808.6224395414165;5519.448055194448;5529.474699903502;5536.169574563848;5684.516816070681;5686.829395118153;5531.280933478622;5582.218489411404;5588.692621905834;5606.523445507014;5630.239917611234;5500.834974950758;5504.119340905436;5504.9174262385295;5505.339359276913;5512.2558454608115;5498.367687715804;5589.580781441489;5608.523275521627;5650.802221922213;5669.34802497718;5516.779328826802;5547.472990065938;5585.69278689676;5600.131979543177;5610.803621873215 19:42:36 INFO - PROCESS | 20884 | |1;ext.html;573.819246937215;605.1558076483306;620.2649859915997;623.4420193926436;636.1539152926608;30343.393132137346;41596;42453.36319955203;42568;42588.574114258845;43157.136857262834;43760.562394376044;43764.781176094075;43771;43798.34302485465;7971.521708697468;8778.868316975235;8994;10623.946880265588;10869.782604347909;10678.305910115818;10770.838437423445;10780.514876830523;10804.13566914645;10806.621768238114;10632.521536530836;10718.410487423189;10800.837987430195;10809.405482698488;10821.945890270537;8041.517508949452;10505.422201778862;10734.570617175305;10749.892501074968;11135.498902549405;10634.20243481742;10704.357738535713;10711.678649640446;10728.249022568423;10730.248882578222;41367.586324136675;41726.37410438846;41736.582634173574;41798.37302440466;41816.581834181576;3494.318607871466;3813.3517302058717;3941.940870886939;4130.958690413087;4267.551907049778;32237.194070148435;33096.3380732384;33267.833660831784;33563.6643633563;33944.15139621504;4380.871219628222;4395.484755358251;4430.756308403036;4458.331250312479;4658.440987081538;234047;235048;235471;236363;236686;56960.71519642375;57872.42127578754;57961;57976;57978.42021579815;35078;36118.458223126676;36130.81934590363;37339.43990840139;37533.62466375356;15108.848911510744;16094.195290235675;16262.51212463628;16347.509574712778;16379.0172589645;11776;11902.642920712393;11941.70145746346;12198.512059517698;12207.328596927255;19068.71396929047;19110.71333929992;19204.327848525514;19236.210749441252;19316.71024934599;6832.45340372769;7037.964810176019;7147.106611673541;7222.349988501061;7339.7064117435775;989.8812142542942;1039.0752230514847;1106.6569363497342;1107.241539545398;1126.915481338903;32877.50683739698;33017.66982330194;33095.50356744651;33132;33346.66653333484;1054.6625079974488;1066.8079745645857;1072.940988245654;1091.317926296065;1111.1000089927186;17029.574260643334;17228.741568876478;17302.913485432746;17375.005623060024;17529.649407011788;550494;554443;557087;557097;557291;57791.711041445364;58427;58485;58607.120893186635;58631.70684146552;1260.3257257367447;1328.16325714801;1368.1654190943516;1379.1380387257964;1394.5676840179576;30883.536746949263;33181.50227746634;33430;33450.66549334476;34016.489752654226;44019.33970990374;44498.3325250128;44845.775771122244;44902.32646510239;45108.09783804371;386304;388910;389785;390011;392737;25050.74949250484;26803.19590412291;27719.445611088067;27738.306542336602;28922.27694307659;47032.52967470281;47809.28286075642;48060.7596962013;48972.75513622409;49165.75417122892;39734.09971260777;40238;40297.194056118125;40471.79764101161;40707.389389159776;38716;40160.12666736308;40897.795511022254;41261.38107928444;41337.79331103325;40267.39598906077;40575;40598.79700601478;41259;41385.58614413817;35338;36557.45163822491;36956.630433696395;37079.62920370762;37139.257214856094;27542.586861196698;27844;27922.581161283004;28159.43681126325;28173.71826281793 19:42:36 INFO - PROCESS | 20884 | |2;jquery.html;387.63368616657255;398.1261131815662;398.75875095567164;406.07820248036955;420.5941266677655;12682.545498961768;19295.99999999998;19621.215151393964;19959.301424450146;20008.099635516417;14614.926925365386;16834.663306733888;17773.28906843728;18950.62098758024;19266.325678601253;5566.248556444869;5808;5813.563982701293;5843.415658434144;5846.181534585162;5666.858328541778;5699.658020518761;5708.1152421374545;5708.77164913403;5709.371969083398;4137.855175068873;5923.526117910556;6310.716017779188;6314.431701146896;6314.589551679149;6213.937860621381;6244.500439964814;6262.2172228471445;6346.619202847844;6447.838804029937;5693.231413759172;5711.114777209497;5723.914141287884;5726.141078838166;5743.396943320933;22192.334229973127;23712.64431033536;23955.16156934499;24009.279721608378;24199;2416.6495858100475;2463.5811911975006;2473.8144639152138;2590.4171561398534;3029.5910052143117;14143.71712565743;14152.221627810466;14649.633759156;14708.779368309377;15103.697926041417;1862.9347972821022;1894.2707057782716;1935.8548108891748;2006.2576846566717;2028.5334373094272;80459.5977020117;81095;81702;82074.17925820785;83734.99999999939;10490.842637360445;10739.355638661706;10798.626556244733;10956.780864382668;11022.944885275523;15032.549023529311;15161.772573411408;15184.46854360092;15265.771013434807;15292.541223763305;8130.959345203354;8292.543910085004;8386.454880432751;8439.493630382196;8521.275691566163;8263;8323.708670196515;8436.156384361515;8460.619272132768;8497.830043399097;5739.196512488255;6128.203333566607;6701;6707.094542236736;6787;1875.3717504635827;1897.5256185953513;1911.5890083631807;1935.748352714138;1995.8103980121866;948.3029972969862;960.1502670136979;979.3389462113188;1001.7395477175987;1037.5071840875676;20331.593368132555;20400.0819963102;20459;20500.589988200154;20567.8971605141;1009.5154325923451;1033.6640591807693;1042.5412818359898;1056.4189695667505;1090.6400887707039;10612.893871061346;11486.138539609563;11513;11523.884761152449;11536.307821530734;444441;448484;454006;459369;461447;94634;97390;98104.50947745216;98304.50847745716;99439;1018.9286749927434;1041.3915781816195;1041.9010194031555;1067.765091679829;1071.769569542552;18081.638367232317;18144.546386340447;18304.90847545807;18435.446936591925;18690;40314.02885427391;40350.1929961405;40375.1924961505;41376.1724765497;42238.155236895705;58746;59791.40208598032;60096;60597.39402605918;60859;8263.380246481418;8811.206991370807;8879.334049946408;8921.553922303729;9046.547672616474;13693;13712.65718357049;13883.652908677364;14013.929930350283;14048.508302209373;11721.648350549498;11820.70448238801;11928.821067684165;12034.75930481403;12037.277763334228;11663.416829158678;11663.941680291544;11867.762644746885;11964.162508624313;12154.756904861677;11944.880551194377;12035.939820300842;12079.698007549881;12095.153339266168;12218.938905305773;8660.220580147818;8727.956360218159;8728.869066964127;8901.777455563662;8992.730218093468;11061.502232399722;11126.833097503706;11707.473163707484;11908.761824763284;12002.21985570935 19:42:36 INFO - PROCESS | 20884 | |3;mootools.html;1306.5949555637746;1452.0343971259113;1464.8828093752502;1581.304226140498;1729.8616110711143;7498;8475.110113438093;8836.646534138643;8841.602127904243;9050.63797448103;8400.243978041975;8444;8476.66093356265;8485.236328730412;8573.571321433934;1948.7661480622346;2184.770599087097;2263.0495192019307;2264.728232612081;2296.9655455168186;2332;2350.2949115265437;2354.75275096115;2355.5877721398774;2361.2325994051916;2264.1622599638076;2274.465500607356;2297.540491901618;2299.3906614747107;2300.838941274103;1876.934307299245;2106.947326316839;2174.065151984646;2174.5759576882515;2203.592335417945;2235.7540670526228;2252.40311317501;2272.3864556569633;2274.55646149001;2274.5678321118935;8345.374096942754;8372.079071302152;8436.072032076467;8440.198181172778;8444.915550844475;5047.066292735855;5220.765065572058;5223.582113430954;5225.817096401645;5230.267762513251;3175.8253296068706;3311.9668803311897;3355.7147642450423;3372.696457318853;3417.2311229973307;1138.7665528566624;1167.1421505193675;1181.291225264834;1185.7450648110612;1193;12458;12482.563110291187;12488;12499.437525311383;12516.186447880858;4332.4367832181615;4480.663950203748;4522.095580883836;4562.452505699337;4622.422197225347;10383.84424233637;10391.584336626602;10397.168226541859;10406.843897341547;10415.479226038668;5017.7491125443585;5021.874453138701;5033.496650335011;5034.697918124851;5034.874128146826;4138.089620283533;4502.144592527409;4661.557152070548;4685.929711054337;4823.493533179036;3895.53253609563;3944.4674968878835;3988.561258261589;4024.597540245952;4079.0618157823274;1193.8896825951947;1195.0857593940643;1199.5201919232202;1223.1254652923203;1238.13949305232;984.921206303494;992.1219720547367;994.8756405449319;1002.2433063037361;1006.7835415385728;5902.2327097477055;5920.230370051866;5945.791897283574;6018.488428483628;6102.603330783573;442.6856931578551;454.4206137175128;457.6544708744943;469.91541522526273;470.7528547512583;4105.938410923838;4244.0663054128045;4250.277452833026;4261.10516791471;4274.038341373228;10253.128484078788;10898.564057437614;11006.064484518745;11006.669799906016;11029.944850275857;9900;10247.795044099077;10247.795044099077;10255.58977640901;10945.781084378268;7796.532208067534;7902.091259505116;7929.801754956172;8149.918500814916;8153.836923261501;5743.282089738783;5945.31628862669;5976.551758618034;6104.786332478342;6126.754929802758;9853.310268281151;9988.400695958266;9994.150497207818;10049.899501004897;10081.949590252001;10130.246020260669;10184.439855807705;10215.438150901771;10336.534855931352;10337.431441270803;8275.50346979183;8286.212809783061;8394.45436046655;8496.065432802263;8504.489730616182;8061.556614386265;8068.273855353046;8096.959515202387;8122.390820688353;8124.471909325875;7230.060092187982;7431.591262480615;7502.174760776419;7575.772726818204;7714.922850771421;7088.2202957675645;7101.183363913009;7139.143302803697;7215.639218039182;7278.818029549304;6767.89848152288;6813.4889883257965;6856.9314306856295;6860.691268892812;6861.176658800976;4981.626378021735;5113.130767769414;5119.308893299357;5200.947990520046;5265.104932161618;5233.162693968947;5354.143337066051;5354.303940487712;5403.486668766461;5483.341998960151 19:42:36 INFO - PROCESS | 20884 | |4;prototype.html;331.5457822782788;332.0702034303948;338.4162319998005;340.2480518055099;342.76178056250916;5397.514223719864;5414.566834653228;5429.231092143006;5458.235846981426;5474.452554744524;5389.299391079154;5405.27028851105;5413.188021796733;5416.972915135419;5450.29146210992;3943.7830919299427;4083.53039400469;4116.197341518405;4172.70791044627;4209.5790420957965;4185.434966279559;4185.597824728704;4219.797357753041;4233.280342341794;4235.639970602502;4193.874183774492;4204.360299483204;4221.176870510251;4224.5353011168745;4237.533871274158;3900.8244628991765;4122.484689413824;4205.1169254456445;4212.7461807932605;4216.7680777557225;3678.1172518595613;3702.5742039665242;3708.9814550927344;3725.1990821973136;3735.4583585380237;5259.894802103937;5276.973615131899;5298.178782288713;5303.575713942875;5326.334208223972;4731;4784.449788274358;4804.495527969548;4813.855584332476;4818.927716084261;5591.916121258185;5612.242347283105;5646.26598542191;5676.3188417389765;5685.317761868561;4097.569755175693;4145.818441744119;4146.295129827907;4152.211079894811;4169.749815011079;5718.713289509868;5890.6171098878;5901.557383196277;5928.436798504135;5985.610935289193;4198.433211516406;4204.915901681949;4211.642010429086;4220.261454245556;4239.533651298355;4253.595908388698;4256.87229383119;4261.232978063917;4311.137772445523;4314;4719.551642593948;4728.802479178034;4806.735629540409;4827.517248275144;4924.138275801721;5592.356878958891;5599.468050535193;5635.154726790932;5680.801171958961;5696.493542841136;1468.5594321703447;1487.9181645009628;1492.3359105198083;1492.9178895160871;1493.402638944409;938.648006997376;959.5058544849409;973.3089506450499;992.265723364705;1011.7622358745689;5358.30342055538;5362.758675859595;5370.952664230437;5373.811916582979;5412.702301373462;5694.857628559319;5712.542996560265;5721.199032135504;5744.425557444306;5756.884862302814;5132.435432102466;5336.252924590561;5351.9464805351445;5375.16684913839;5381.869807340502;3027.1523973287512;3037.4988126958806;3047.162030441602;3099.1322429719717;3100.751939844807;5796.971015144897;5898.94101058984;5929.110633404937;5945.554083443759;5950.19672344228;5700.774333518313;5864.0031194697;5899.905533535619;5927.229460170151;5958.165856780054;5927.555433342516;6001.669908155093;6006.198140557903;6028.186194863637;6055.1522786810765;5532.834014979557;5732.770689172553;5792.391798861059;5819.592628516132;5885.588008839341;5630.88738225225;5659.773609055592;5667.518260947865;5721.656700597978;5721.885562288648;5851.297844258546;5941.287045554388;5943.554233432424;5945.702714864153;5999.660132548397;4167.74993500391;4179.307380510898;4199.349100889367;4203.453551038346;4205.726627769185;5693.914591281217;5789.913151302818;5815.621984570989;5889.234399528034;5893.499052580579;5557.305336832896;5570.721463926707;5742.511886489695;5765.077587585966;5800.24596802413;5601.943980560142;5680.2047713321;5717.628354156966;5725.770969161187;5734.311882574118;5355.892882142413;5590.776368945197;5592.748326325406;5601.495865372136;5618.719064046863;5680.7443665036;5730.169125476866;5750.281214848144;5769.634449875531;5782.710864456844;5530.225768392509;5588.944110559005;5602.243697100839;5640.843627056525;5649.915251271152 19:42:36 INFO - PROCESS | 20884 | |5;yui.html;714.8641758065967;748.7716246544802;763.2253262938123;776.9533827970322;784.9568273744943;15530.534083977485;16663.91668041658;16798.83201167988;16799.664006719857;16800;15277.312520936557;16146.03123812572;16182.433614823483;16651.916740416313;16731.49805505834;803.0082847683107;803.9196080391944;808.312934006096;809.1180613131685;809.6235250608465;672.5090683800828;789.2226157235119;807.289585165054;809.0251247247053;812.6424373275739;834.4367551902471;835.841190173865;837.2841220756258;839.6557411461303;841.7138173021171;696.1263614164242;826.499967519654;831.0692024932084;831.2477208126655;831.9584020798966;600.789723596742;613.2365205319406;616.9444749972524;618.2148671187566;618.4186864347499;14682.853171468256;14739.336729847182;14741.262936853114;14774.113553186844;14775.113493190443;12965.15726477776;13211.471541138342;13383;13501.2574308413;13903.235322057282;11860.881391186063;12337;12369.443375048144;12404.317762523058;12864.29246391448;3884.9028774280587;3910.569837317893;3970.3647416413237;4036.979815100906;4114.506259248909;78599.21400785976;79198.60400698017;79408.60295698485;81765.59117204435;82359.5882020586;10299.279050466545;10335.74160645975;10960.945195274133;11027.2280940335;11325.943370283096;21305.573888522453;21340.466488337916;21344.786552134592;21498.677519837216;21564.137434502758;8437.704680336159;8544.829103417896;8670.219680228684;8702.738917832476;8782.297416206688;4661.184292748823;4706.7411292378565;4745.596624286905;4754.95245047552;4872.634552408584;3448.2241495663775;3609.512715783336;3611.1513794258326;3614.1145419372424;3639.94540081899;604.2446941323345;609.6678756916152;614.3058344071171;616.5745635511572;627.6234259444296;601.1013534765466;612.874360756044;693.7537174303151;721.3435773446139;736.37408203027;9442.197413219816;9570.377925434825;9785.559649815776;9911.851322230172;10118.898811011943;561.7837132703856;603.7162533609196;668.4585485756553;707.38104158861;742.2874040920776;4364.388985541963;4587.08258348325;4608.308753686973;4629.166749985035;4651.20928442552;64547.35452645507;64945;103829;110048;111005;55437.44562554404;77092.2290777085;90195.54902225448;94491;95589.5220523893;84269.57865210634;85012;87392.56303718568;87696.56151719329;89106.55446722855;8478.74563763088;8766.860308159898;8809.383343165917;8840.425372350777;8954.558954559161;36298.8185059073;36321.45517817288;47030.529694702615;52166.73916630392;54605;49233.2615010768;49302.50697492979;53334.73332633467;70579;75313.24686753063;13377.331133443095;13589.32053397346;13736.244506552235;13944.4422223114;14202.218877961812;15187.772183417479;15516.456924007605;15522.767158492406;15548.533543993699;15847.128407937675;14028.649283767987;14600.97793154469;14892.702145957237;14911.177644710579;15341.769873452131;13103.868961310265;13338.466461341437;13533.79699304531;13672.384742686801;13881.305934703427;13621.591352259447;14202.928985355007;14648.560543183721;14666.413343466142;14698.265086745407;10887.78224435491;11244.493997769956;11489.310641361544;11607.419629018685;11620;9613.471259080818;9799.951000244953;9972.950135249568;10331.483425828828;10552.261341706315 19:42:36 INFO - PROCESS | 20884 | __end_tp_report 19:42:36 INFO - PROCESS | 20884 | __start_cc_report 19:42:36 INFO - PROCESS | 20884 | _x_x_mozilla_cycle_collect,1110 19:42:36 INFO - PROCESS | 20884 | __end_cc_report 19:42:36 INFO - PROCESS | 20884 | __startTimestamp1466822556371__endTimestamp 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | ------- Summary: start ------- 19:42:36 INFO - PROCESS | 20884 | Number of tests: 6 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | [#0] dojo.html Cycles:165 Average:5358.24 Median:5520.00 stddev:611.81 (11.1%) stddev-sans-first:587.87 19:42:36 INFO - PROCESS | 20884 | Values: 3116.9 3123.3 3135.9 3148.6 3185.8 5243.2 5336.8 5353.4 5403.6 5420.5 5409.6 5431.9 5441.2 5500.3 5520.0 4891.0 4911.8 4912.1 5003.1 5006.4 4907.3 5056.5 5073.5 5074.2 5118.6 4730.6 4748.1 4940.4 4947.6 4981.0 4857.9 4873.6 4894.3 4912.4 4917.1 4860.1 4869.3 4897.8 4914.7 4935.4 5206.2 5316.5 5420.4 5463.3 5471.8 5728.0 5813.8 5830.1 5831.4 5834.7 5822.9 5845.4 5860.9 5871.1 5874.7 5185.1 5353.3 5383.9 5466.5 5468.0 5942.2 5985.6 5998.1 5998.4 6006.6 5734.1 5761.0 5771.0 5776.4 5778.5 5590.6 5669.9 5725.1 5740.1 5787.9 5736.3 5748.0 5765.1 5767.0 5782.8 5698.4 5726.8 5757.9 5767.7 5774.2 4342.0 4365.1 4377.6 4378.3 4388.2 3883.7 3890.1 3902.3 3925.1 3962.1 5392.4 5399.9 5402.6 5407.6 5414.4 5596.7 5660.1 5676.4 5692.7 5756.8 5357.5 5381.2 5383.0 5387.8 5388.3 4850.9 4945.4 4958.0 4963.6 5003.8 5929.0 5987.9 5992.4 5998.9 6020.7 5827.8 5841.4 5842.2 5846.9 5878.2 5804.7 5942.3 6017.1 6033.2 6033.8 5688.0 5690.1 5721.3 5725.7 5741.3 5751.9 5798.5 5803.5 5806.8 5808.6 5519.4 5529.5 5536.2 5684.5 5686.8 5531.3 5582.2 5588.7 5606.5 5630.2 5500.8 5504.1 5504.9 5505.3 5512.3 5498.4 5589.6 5608.5 5650.8 5669.3 5516.8 5547.5 5585.7 5600.1 5610.8 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | [#1] ext.html Cycles:180 Average:55549.93 Median:36344.14 stddev:110220.67 (303.3%) stddev-sans-first:110452.58 19:42:36 INFO - PROCESS | 20884 | Values: 573.8 605.2 620.3 623.4 636.2 30343.4 41596.0 42453.4 42568.0 42588.6 43157.1 43760.6 43764.8 43771.0 43798.3 7971.5 8778.9 8994.0 10623.9 10869.8 10678.3 10770.8 10780.5 10804.1 10806.6 10632.5 10718.4 10800.8 10809.4 10821.9 8041.5 10505.4 10734.6 10749.9 11135.5 10634.2 10704.4 10711.7 10728.2 10730.2 41367.6 41726.4 41736.6 41798.4 41816.6 3494.3 3813.4 3941.9 4131.0 4267.6 32237.2 33096.3 33267.8 33563.7 33944.2 4380.9 4395.5 4430.8 4458.3 4658.4 234047.0 235048.0 235471.0 236363.0 236686.0 56960.7 57872.4 57961.0 57976.0 57978.4 35078.0 36118.5 36130.8 37339.4 37533.6 15108.8 16094.2 16262.5 16347.5 16379.0 11776.0 11902.6 11941.7 12198.5 12207.3 19068.7 19110.7 19204.3 19236.2 19316.7 6832.5 7038.0 7147.1 7222.3 7339.7 989.9 1039.1 1106.7 1107.2 1126.9 32877.5 33017.7 33095.5 33132.0 33346.7 1054.7 1066.8 1072.9 1091.3 1111.1 17029.6 17228.7 17302.9 17375.0 17529.6 550494.0 554443.0 557087.0 557097.0 557291.0 57791.7 58427.0 58485.0 58607.1 58631.7 1260.3 1328.2 1368.2 1379.1 1394.6 30883.5 33181.5 33430.0 33450.7 34016.5 44019.3 44498.3 44845.8 44902.3 45108.1 386304.0 388910.0 389785.0 390011.0 392737.0 25050.7 26803.2 27719.4 27738.3 28922.3 47032.5 47809.3 48060.8 48972.8 49165.8 39734.1 40238.0 40297.2 40471.8 40707.4 38716.0 40160.1 40897.8 41261.4 41337.8 40267.4 40575.0 40598.8 41259.0 41385.6 35338.0 36557.5 36956.6 37079.6 37139.3 27542.6 27844.0 27922.6 28159.4 28173.7 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | [#2] jquery.html Cycles:180 Average:28478.60 Median:13212.96 stddev:75112.79 (568.5%) stddev-sans-first:75293.89 19:42:36 INFO - PROCESS | 20884 | Values: 387.6 398.1 398.8 406.1 420.6 12682.5 19296.0 19621.2 19959.3 20008.1 14614.9 16834.7 17773.3 18950.6 19266.3 5566.2 5808.0 5813.6 5843.4 5846.2 5666.9 5699.7 5708.1 5708.8 5709.4 4137.9 5923.5 6310.7 6314.4 6314.6 6213.9 6244.5 6262.2 6346.6 6447.8 5693.2 5711.1 5723.9 5726.1 5743.4 22192.3 23712.6 23955.2 24009.3 24199.0 2416.6 2463.6 2473.8 2590.4 3029.6 14143.7 14152.2 14649.6 14708.8 15103.7 1862.9 1894.3 1935.9 2006.3 2028.5 80459.6 81095.0 81702.0 82074.2 83735.0 10490.8 10739.4 10798.6 10956.8 11022.9 15032.5 15161.8 15184.5 15265.8 15292.5 8131.0 8292.5 8386.5 8439.5 8521.3 8263.0 8323.7 8436.2 8460.6 8497.8 5739.2 6128.2 6701.0 6707.1 6787.0 1875.4 1897.5 1911.6 1935.7 1995.8 948.3 960.2 979.3 1001.7 1037.5 20331.6 20400.1 20459.0 20500.6 20567.9 1009.5 1033.7 1042.5 1056.4 1090.6 10612.9 11486.1 11513.0 11523.9 11536.3 444441.0 448484.0 454006.0 459369.0 461447.0 94634.0 97390.0 98104.5 98304.5 99439.0 1018.9 1041.4 1041.9 1067.8 1071.8 18081.6 18144.5 18304.9 18435.4 18690.0 40314.0 40350.2 40375.2 41376.2 42238.2 58746.0 59791.4 60096.0 60597.4 60859.0 8263.4 8811.2 8879.3 8921.6 9046.5 13693.0 13712.7 13883.7 14013.9 14048.5 11721.6 11820.7 11928.8 12034.8 12037.3 11663.4 11663.9 11867.8 11964.2 12154.8 11944.9 12035.9 12079.7 12095.2 12218.9 8660.2 8728.0 8728.9 8901.8 8992.7 11061.5 11126.8 11707.5 11908.8 12002.2 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | [#3] mootools.html Cycles:180 Average:5708.12 Median:2510.05 stddev:3284.33 (130.8%) stddev-sans-first:3276.89 19:42:36 INFO - PROCESS | 20884 | Values: 1306.6 1452.0 1464.9 1581.3 1729.9 7498.0 8475.1 8836.6 8841.6 9050.6 8400.2 8444.0 8476.7 8485.2 8573.6 1948.8 2184.8 2263.0 2264.7 2297.0 2332.0 2350.3 2354.8 2355.6 2361.2 2264.2 2274.5 2297.5 2299.4 2300.8 1876.9 2106.9 2174.1 2174.6 2203.6 2235.8 2252.4 2272.4 2274.6 2274.6 8345.4 8372.1 8436.1 8440.2 8444.9 5047.1 5220.8 5223.6 5225.8 5230.3 3175.8 3312.0 3355.7 3372.7 3417.2 1138.8 1167.1 1181.3 1185.7 1193.0 12458.0 12482.6 12488.0 12499.4 12516.2 4332.4 4480.7 4522.1 4562.5 4622.4 10383.8 10391.6 10397.2 10406.8 10415.5 5017.7 5021.9 5033.5 5034.7 5034.9 4138.1 4502.1 4661.6 4685.9 4823.5 3895.5 3944.5 3988.6 4024.6 4079.1 1193.9 1195.1 1199.5 1223.1 1238.1 984.9 992.1 994.9 1002.2 1006.8 5902.2 5920.2 5945.8 6018.5 6102.6 442.7 454.4 457.7 469.9 470.8 4105.9 4244.1 4250.3 4261.1 4274.0 10253.1 10898.6 11006.1 11006.7 11029.9 9900.0 10247.8 10247.8 10255.6 10945.8 7796.5 7902.1 7929.8 8149.9 8153.8 5743.3 5945.3 5976.6 6104.8 6126.8 9853.3 9988.4 9994.2 10049.9 10081.9 10130.2 10184.4 10215.4 10336.5 10337.4 8275.5 8286.2 8394.5 8496.1 8504.5 8061.6 8068.3 8097.0 8122.4 8124.5 7230.1 7431.6 7502.2 7575.8 7714.9 7088.2 7101.2 7139.1 7215.6 7278.8 6767.9 6813.5 6856.9 6860.7 6861.2 4981.6 5113.1 5119.3 5200.9 5265.1 5233.2 5354.1 5354.3 5403.5 5483.3 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | [#4] prototype.html Cycles:180 Average:4767.34 Median:5413.88 stddev:1392.50 (25.7%) stddev-sans-first:1356.02 19:42:36 INFO - PROCESS | 20884 | Values: 331.5 332.1 338.4 340.2 342.8 5397.5 5414.6 5429.2 5458.2 5474.5 5389.3 5405.3 5413.2 5417.0 5450.3 3943.8 4083.5 4116.2 4172.7 4209.6 4185.4 4185.6 4219.8 4233.3 4235.6 4193.9 4204.4 4221.2 4224.5 4237.5 3900.8 4122.5 4205.1 4212.7 4216.8 3678.1 3702.6 3709.0 3725.2 3735.5 5259.9 5277.0 5298.2 5303.6 5326.3 4731.0 4784.4 4804.5 4813.9 4818.9 5591.9 5612.2 5646.3 5676.3 5685.3 4097.6 4145.8 4146.3 4152.2 4169.7 5718.7 5890.6 5901.6 5928.4 5985.6 4198.4 4204.9 4211.6 4220.3 4239.5 4253.6 4256.9 4261.2 4311.1 4314.0 4719.6 4728.8 4806.7 4827.5 4924.1 5592.4 5599.5 5635.2 5680.8 5696.5 1468.6 1487.9 1492.3 1492.9 1493.4 938.6 959.5 973.3 992.3 1011.8 5358.3 5362.8 5371.0 5373.8 5412.7 5694.9 5712.5 5721.2 5744.4 5756.9 5132.4 5336.3 5351.9 5375.2 5381.9 3027.2 3037.5 3047.2 3099.1 3100.8 5797.0 5898.9 5929.1 5945.6 5950.2 5700.8 5864.0 5899.9 5927.2 5958.2 5927.6 6001.7 6006.2 6028.2 6055.2 5532.8 5732.8 5792.4 5819.6 5885.6 5630.9 5659.8 5667.5 5721.7 5721.9 5851.3 5941.3 5943.6 5945.7 5999.7 4167.7 4179.3 4199.3 4203.5 4205.7 5693.9 5789.9 5815.6 5889.2 5893.5 5557.3 5570.7 5742.5 5765.1 5800.2 5601.9 5680.2 5717.6 5725.8 5734.3 5355.9 5590.8 5592.7 5601.5 5618.7 5680.7 5730.2 5750.3 5769.6 5782.7 5530.2 5588.9 5602.2 5640.8 5649.9 19:42:36 INFO - PROCESS | 20884 | 19:42:36 INFO - PROCESS | 20884 | [#5] yui.html Cycles:180 Average:19294.18 Median:4726.17 stddev:26615.04 (563.1%) stddev-sans-first:26653.14 19:42:36 INFO - PROCESS | 20884 | Values: 714.9 748.8 763.2 777.0 785.0 15530.5 16663.9 16798.8 16799.7 16800.0 15277.3 16146.0 16182.4 16651.9 16731.5 803.0 803.9 808.3 809.1 809.6 672.5 789.2 807.3 809.0 812.6 834.4 835.8 837.3 839.7 841.7 696.1 826.5 831.1 831.2 832.0 600.8 613.2 616.9 618.2 618.4 14682.9 14739.3 14741.3 14774.1 14775.1 12965.2 13211.5 13383.0 13501.3 13903.2 11860.9 12337.0 12369.4 12404.3 12864.3 3884.9 3910.6 3970.4 4037.0 4114.5 78599.2 79198.6 79408.6 81765.6 82359.6 10299.3 10335.7 10960.9 11027.2 11325.9 21305.6 21340.5 21344.8 21498.7 21564.1 8437.7 8544.8 8670.2 8702.7 8782.3 4661.2 4706.7 4745.6 4755.0 4872.6 3448.2 3609.5 3611.2 3614.1 3639.9 604.2 609.7 614.3 616.6 627.6 601.1 612.9 693.8 721.3 736.4 9442.2 9570.4 9785.6 9911.9 10118.9 561.8 603.7 668.5 707.4 742.3 4364.4 4587.1 4608.3 4629.2 4651.2 64547.4 64945.0 103829.0 110048.0 111005.0 55437.4 77092.2 90195.5 94491.0 95589.5 84269.6 85012.0 87392.6 87696.6 89106.6 8478.7 8766.9 8809.4 8840.4 8954.6 36298.8 36321.5 47030.5 52166.7 54605.0 49233.3 49302.5 53334.7 70579.0 75313.2 13377.3 13589.3 13736.2 13944.4 14202.2 15187.8 15516.5 15522.8 15548.5 15847.1 14028.6 14601.0 14892.7 14911.2 15341.8 13103.9 13338.5 13533.8 13672.4 13881.3 13621.6 14202.9 14648.6 14666.4 14698.3 10887.8 11244.5 11489.3 11607.4 11620.0 9613.5 9800.0 9973.0 10331.5 10552.3 19:42:36 INFO - PROCESS | 20884 | -------- Summary: end -------- 19:42:36 INFO - PROCESS | 20884 | 19:42:37 INFO - TEST-INFO | 20884: exit 0 19:42:37 INFO - TEST-OK | dromaeo_css | took 1115966ms 19:42:37 INFO - TEST-START | kraken 19:42:37 INFO - operating with platform_type : linux_ 19:42:37 INFO - Initialising browser for kraken test... 19:42:37 INFO - TEST-INFO | started process 21070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP3hBhS/profile http://localhost:33260/getInfo.html) 19:42:42 INFO - PROCESS | 21070 | __metrics Screen width/height:1600/1200 19:42:42 INFO - PROCESS | 21070 | colorDepth:24 19:42:42 INFO - PROCESS | 21070 | Browser inner width/height: 1024/697 19:42:42 INFO - PROCESS | 21070 | __metrics 19:42:43 INFO - PROCESS | 21070 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:42:44 INFO - TEST-INFO | 21070: exit 0 19:42:44 INFO - Browser initialized. 19:42:44 INFO - Running cycle 1/1 for kraken test... 19:42:44 INFO - TEST-INFO | started process 21152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP3hBhS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:56 INFO - PROCESS | 21152 | RSS: Main: 174882816 19:42:56 INFO - PROCESS | 21152 | 19:42:58 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33260/tests/kraken/driver.html?testName=audio-beat-detection) 19:42:59 INFO - PROCESS | 21152 | RSS: Main: 231968768 19:42:59 INFO - PROCESS | 21152 | 19:43:02 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33260/tests/kraken/driver.html?testName=audio-dft) 19:43:02 INFO - PROCESS | 21152 | RSS: Main: 217640960 19:43:02 INFO - PROCESS | 21152 | 19:43:06 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33260/tests/kraken/driver.html?testName=audio-fft) 19:43:06 INFO - PROCESS | 21152 | RSS: Main: 286314496 19:43:06 INFO - PROCESS | 21152 | 19:43:08 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33260/tests/kraken/driver.html?testName=audio-oscillator) 19:43:09 INFO - PROCESS | 21152 | RSS: Main: 196308992 19:43:09 INFO - PROCESS | 21152 | 19:43:11 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:43:12 INFO - PROCESS | 21152 | RSS: Main: 201887744 19:43:12 INFO - PROCESS | 21152 | 19:43:15 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33260/tests/kraken/driver.html?testName=imaging-darkroom) 19:43:15 INFO - PROCESS | 21152 | RSS: Main: 235798528 19:43:15 INFO - PROCESS | 21152 | 19:43:19 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33260/tests/kraken/driver.html?testName=imaging-desaturate) 19:43:19 INFO - PROCESS | 21152 | RSS: Main: 238092288 19:43:19 INFO - PROCESS | 21152 | 19:43:22 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33260/tests/kraken/driver.html?testName=json-parse-financial) 19:43:23 INFO - PROCESS | 21152 | RSS: Main: 237895680 19:43:23 INFO - PROCESS | 21152 | 19:43:24 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:25 INFO - PROCESS | 21152 | RSS: Main: 226762752 19:43:25 INFO - PROCESS | 21152 | 19:43:27 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:27 INFO - PROCESS | 21152 | RSS: Main: 232108032 19:43:27 INFO - PROCESS | 21152 | 19:43:29 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:30 INFO - PROCESS | 21152 | RSS: Main: 237342720 19:43:30 INFO - PROCESS | 21152 | 19:43:32 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:43:33 INFO - PROCESS | 21152 | RSS: Main: 239591424 19:43:33 INFO - PROCESS | 21152 | 19:43:36 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:43:36 INFO - PROCESS | 21152 | RSS: Main: 239796224 19:43:36 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | Cycle 1(1): loaded http://localhost:33260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33260/tests/kraken/driver.html?testName=ai-astar) 19:43:38 INFO - PROCESS | 21152 | RSS: Main: 282443776 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | __start_tp_report 19:43:38 INFO - PROCESS | 21152 | _x_x_mozilla_page_load 19:43:38 INFO - PROCESS | 21152 | _x_x_mozilla_page_load_details 19:43:38 INFO - PROCESS | 21152 | |i|pagename|runs| 19:43:38 INFO - PROCESS | 21152 | |0;ai-astar;101;110;112;110;112;110;110;112;110;108 19:43:38 INFO - PROCESS | 21152 | |1;audio-beat-detection;154;125;130;190;128;129;155;128;164;127 19:43:38 INFO - PROCESS | 21152 | |2;audio-dft;163;161;160;159;162;161;162;161;160;165 19:43:38 INFO - PROCESS | 21152 | |3;audio-fft;74;75;75;107;77;77;75;75;116;74 19:43:38 INFO - PROCESS | 21152 | |4;audio-oscillator;84;85;118;86;85;85;118;85;85;129 19:43:38 INFO - PROCESS | 21152 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;118;117;117 19:43:38 INFO - PROCESS | 21152 | |6;imaging-darkroom;146;145;145;147;147;146;146;146;145;146 19:43:38 INFO - PROCESS | 21152 | |7;imaging-desaturate;95;96;96;96;96;96;95;95;95;95 19:43:38 INFO - PROCESS | 21152 | |8;json-parse-financial;56;56;57;54;55;55;57;55;56;56 19:43:38 INFO - PROCESS | 21152 | |9;json-stringify-tinderbox;62;64;62;62;61;62;62;62;61;62 19:43:38 INFO - PROCESS | 21152 | |10;stanford-crypto-aes;85;82;85;78;78;80;84;86;88;85 19:43:38 INFO - PROCESS | 21152 | |11;stanford-crypto-ccm;128;134;120;118;128;128;129;121;128;123 19:43:38 INFO - PROCESS | 21152 | |12;stanford-crypto-pbkdf2;162;161;159;167;160;162;164;169;159;165 19:43:38 INFO - PROCESS | 21152 | |13;stanford-crypto-sha256-iterative;64;62;63;61;62;61;61;61;61;64 19:43:38 INFO - PROCESS | 21152 | __end_tp_report 19:43:38 INFO - PROCESS | 21152 | __start_cc_report 19:43:38 INFO - PROCESS | 21152 | _x_x_mozilla_cycle_collect,1639 19:43:38 INFO - PROCESS | 21152 | __end_cc_report 19:43:38 INFO - PROCESS | 21152 | __startTimestamp1466822618791__endTimestamp 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | ------- Summary: start ------- 19:43:38 INFO - PROCESS | 21152 | Number of tests: 14 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:3.24 (2.9%) stddev-sans-first:1.33 19:43:38 INFO - PROCESS | 21152 | Values: 101.0 110.0 112.0 110.0 112.0 110.0 110.0 112.0 110.0 108.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:142.00 stddev:21.88 (15.4%) stddev-sans-first:22.85 19:43:38 INFO - PROCESS | 21152 | Values: 154.0 125.0 130.0 190.0 128.0 129.0 155.0 128.0 164.0 127.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.71 (1.1%) stddev-sans-first:1.72 19:43:38 INFO - PROCESS | 21152 | Values: 163.0 161.0 160.0 159.0 162.0 161.0 162.0 161.0 160.0 165.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:15.47 (20.6%) stddev-sans-first:16.09 19:43:38 INFO - PROCESS | 21152 | Values: 74.0 75.0 75.0 107.0 77.0 77.0 75.0 75.0 116.0 74.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:17.97 (21.1%) stddev-sans-first:18.53 19:43:38 INFO - PROCESS | 21152 | Values: 84.0 85.0 118.0 86.0 85.0 85.0 118.0 85.0 85.0 129.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:43:38 INFO - PROCESS | 21152 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 19:43:38 INFO - PROCESS | 21152 | Values: 146.0 145.0 145.0 147.0 147.0 146.0 146.0 146.0 145.0 146.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:43:38 INFO - PROCESS | 21152 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 19:43:38 INFO - PROCESS | 21152 | Values: 56.0 56.0 57.0 54.0 55.0 55.0 57.0 55.0 56.0 56.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 19:43:38 INFO - PROCESS | 21152 | Values: 62.0 64.0 62.0 62.0 61.0 62.0 62.0 62.0 61.0 62.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:85.00 stddev:3.45 (4.1%) stddev-sans-first:3.59 19:43:38 INFO - PROCESS | 21152 | Values: 85.0 82.0 85.0 78.0 78.0 80.0 84.0 86.0 88.0 85.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:128.00 stddev:4.97 (3.9%) stddev-sans-first:5.20 19:43:38 INFO - PROCESS | 21152 | Values: 128.0 134.0 120.0 118.0 128.0 128.0 129.0 121.0 128.0 123.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:3.39 (2.1%) stddev-sans-first:3.59 19:43:38 INFO - PROCESS | 21152 | Values: 162.0 161.0 159.0 167.0 160.0 162.0 164.0 169.0 159.0 165.0 19:43:38 INFO - PROCESS | 21152 | 19:43:38 INFO - PROCESS | 21152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.09 19:43:38 INFO - PROCESS | 21152 | Values: 64.0 62.0 63.0 61.0 62.0 61.0 61.0 61.0 61.0 64.0 19:43:38 INFO - PROCESS | 21152 | -------- Summary: end -------- 19:43:38 INFO - PROCESS | 21152 | 19:43:39 INFO - TEST-INFO | 21152: exit 0 19:43:39 INFO - TEST-OK | kraken | took 62697ms 19:43:39 INFO - SUITE-END | took 1178s 19:43:39 INFO - Completed test suite (00:19:38) 19:43:39 INFO - javascript benchmark 19:43:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.9064928052157, 3123.2504198992233, 3135.9372812543756, 3148.5906832111823, 3185.824779637119, 5243.161094224924, 5336.813211537592, 5353.437889021655, 5403.567714582834, 5420.485053919876, 5409.648372855761, 5431.891362172764, 5441.183822426638, 5500.28496295481, 5520.0, 4891.046245982035, 4911.778969946343, 4912.115819152551, 5003.099442100421, 5006.399232092154, 4907.312976183337, 5056.494350564951, 5073.518015788494, 5074.238864170367, 5118.59051275897, 4730.574248317634, 4748.050389922029, 4940.382452193476, 4947.554720075174, 4980.97509512452, 4857.927131093001, 4873.634477414208, 4894.3147959285725, 4912.361393018885, 4917.0903382874285, 4860.125177468054, 4869.342638743759, 4897.828575999859, 4914.70511769295, 4935.383077115361, 5206.24509446132, 5316.548093412064, 5420.430854760233, 5463.262459567947, 5471.781128754885, 5728.0, 5813.82558523245, 5830.067189249699, 5831.446012628793, 5834.6790926499025, 5822.912656310116, 5845.386234445365, 5860.941390586125, 5871.060630299175, 5874.676892770896, 5185.066687996159, 5353.277307563468, 5383.919241211385, 5466.535344495723, 5468.0, 5942.168096466498, 5985.610935289193, 5998.070299103646, 5998.3701711320555, 6006.579539432285, 5734.053881109654, 5761.049426844607, 5771.018926782457, 5776.42235776419, 5778.508826749689, 5590.580706447033, 5669.943300566942, 5725.141228815711, 5740.052891272977, 5787.855303617359, 5736.282964629421, 5748.0, 5765.135229715576, 5767.04843700793, 5782.7686892523825, 5698.373178950312, 5726.770929162787, 5757.88484230313, 5767.68277744728, 5774.191613174159, 4341.956580434218, 4365.126974605092, 4377.649788016951, 4378.343248512685, 4388.210122177975, 3883.7475564088245, 3890.0858298299877, 3902.2585708715255, 3925.1168487090176, 3962.0689138052535, 5392.352917649907, 5399.892002159935, 5402.594805389612, 5407.594430417735, 5414.377346605191, 5596.748146333425, 5660.066089095253, 5676.375598684142, 5692.715364231772, 5756.798512052142, 5357.544608708304, 5381.2197231402015, 5383.0, 5387.838364849061, 5388.272583201296, 4850.854474365704, 4945.406551213805, 4958.0, 4963.5780958618925, 5003.824866129668, 5928.962431574543, 5987.850303742354, 5992.40075992406, 5998.880022399528, 6020.698965051817, 5827.82516524488, 5841.386654401226, 5842.1820945066875, 5846.883062338815, 5878.2064421302575, 5804.65172089676, 5942.286925568959, 6017.06735456005, 6033.18551995475, 6033.78881739137, 5687.971560142173, 5690.118031705092, 5721.284839395075, 5725.65646061221, 5741.311042674905, 5751.9424805751405, 5798.478136967693, 5803.535717142703, 5806.796762113306, 5808.6224395414165, 5519.448055194448, 5529.474699903502, 5536.169574563848, 5684.516816070681, 5686.829395118153, 5531.280933478622, 5582.218489411404, 5588.692621905834, 5606.523445507014, 5630.239917611234, 5500.834974950758, 5504.119340905436, 5504.9174262385295, 5505.339359276913, 5512.2558454608115, 5498.367687715804, 5589.580781441489, 5608.523275521627, 5650.802221922213, 5669.34802497718, 5516.779328826802, 5547.472990065938, 5585.69278689676, 5600.131979543177, 5610.803621873215], "value": 5316.883705328572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.819246937215, 605.1558076483306, 620.2649859915997, 623.4420193926436, 636.1539152926608, 30343.393132137346, 41596.0, 42453.36319955203, 42568.0, 42588.574114258845, 43157.136857262834, 43760.562394376044, 43764.781176094075, 43771.0, 43798.34302485465, 7971.521708697468, 8778.868316975235, 8994.0, 10623.946880265588, 10869.782604347909, 10678.305910115818, 10770.838437423445, 10780.514876830523, 10804.13566914645, 10806.621768238114, 10632.521536530836, 10718.410487423189, 10800.837987430195, 10809.405482698488, 10821.945890270537, 8041.517508949452, 10505.422201778862, 10734.570617175305, 10749.892501074968, 11135.498902549405, 10634.20243481742, 10704.357738535713, 10711.678649640446, 10728.249022568423, 10730.248882578222, 41367.586324136675, 41726.37410438846, 41736.582634173574, 41798.37302440466, 41816.581834181576, 3494.318607871466, 3813.3517302058717, 3941.940870886939, 4130.958690413087, 4267.551907049778, 32237.194070148435, 33096.3380732384, 33267.833660831784, 33563.6643633563, 33944.15139621504, 4380.871219628222, 4395.484755358251, 4430.756308403036, 4458.331250312479, 4658.440987081538, 234047.0, 235048.0, 235471.0, 236363.0, 236686.0, 56960.71519642375, 57872.42127578754, 57961.0, 57976.0, 57978.42021579815, 35078.0, 36118.458223126676, 36130.81934590363, 37339.43990840139, 37533.62466375356, 15108.848911510744, 16094.195290235675, 16262.51212463628, 16347.509574712778, 16379.0172589645, 11776.0, 11902.642920712393, 11941.70145746346, 12198.512059517698, 12207.328596927255, 19068.71396929047, 19110.71333929992, 19204.327848525514, 19236.210749441252, 19316.71024934599, 6832.45340372769, 7037.964810176019, 7147.106611673541, 7222.349988501061, 7339.7064117435775, 989.8812142542942, 1039.0752230514847, 1106.6569363497342, 1107.241539545398, 1126.915481338903, 32877.50683739698, 33017.66982330194, 33095.50356744651, 33132.0, 33346.66653333484, 1054.6625079974488, 1066.8079745645857, 1072.940988245654, 1091.317926296065, 1111.1000089927186, 17029.574260643334, 17228.741568876478, 17302.913485432746, 17375.005623060024, 17529.649407011788, 550494.0, 554443.0, 557087.0, 557097.0, 557291.0, 57791.711041445364, 58427.0, 58485.0, 58607.120893186635, 58631.70684146552, 1260.3257257367447, 1328.16325714801, 1368.1654190943516, 1379.1380387257964, 1394.5676840179576, 30883.536746949263, 33181.50227746634, 33430.0, 33450.66549334476, 34016.489752654226, 44019.33970990374, 44498.3325250128, 44845.775771122244, 44902.32646510239, 45108.09783804371, 386304.0, 388910.0, 389785.0, 390011.0, 392737.0, 25050.74949250484, 26803.19590412291, 27719.445611088067, 27738.306542336602, 28922.27694307659, 47032.52967470281, 47809.28286075642, 48060.7596962013, 48972.75513622409, 49165.75417122892, 39734.09971260777, 40238.0, 40297.194056118125, 40471.79764101161, 40707.389389159776, 38716.0, 40160.12666736308, 40897.795511022254, 41261.38107928444, 41337.79331103325, 40267.39598906077, 40575.0, 40598.79700601478, 41259.0, 41385.58614413817, 35338.0, 36557.45163822491, 36956.630433696395, 37079.62920370762, 37139.257214856094, 27542.586861196698, 27844.0, 27922.581161283004, 28159.43681126325, 28173.71826281793], "value": 19928.032112900255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.63368616657255, 398.1261131815662, 398.75875095567164, 406.07820248036955, 420.5941266677655, 12682.545498961768, 19295.99999999998, 19621.215151393964, 19959.301424450146, 20008.099635516417, 14614.926925365386, 16834.663306733888, 17773.28906843728, 18950.62098758024, 19266.325678601253, 5566.248556444869, 5808.0, 5813.563982701293, 5843.415658434144, 5846.181534585162, 5666.858328541778, 5699.658020518761, 5708.1152421374545, 5708.77164913403, 5709.371969083398, 4137.855175068873, 5923.526117910556, 6310.716017779188, 6314.431701146896, 6314.589551679149, 6213.937860621381, 6244.500439964814, 6262.2172228471445, 6346.619202847844, 6447.838804029937, 5693.231413759172, 5711.114777209497, 5723.914141287884, 5726.141078838166, 5743.396943320933, 22192.334229973127, 23712.64431033536, 23955.16156934499, 24009.279721608378, 24199.0, 2416.6495858100475, 2463.5811911975006, 2473.8144639152138, 2590.4171561398534, 3029.5910052143117, 14143.71712565743, 14152.221627810466, 14649.633759156, 14708.779368309377, 15103.697926041417, 1862.9347972821022, 1894.2707057782716, 1935.8548108891748, 2006.2576846566717, 2028.5334373094272, 80459.5977020117, 81095.0, 81702.0, 82074.17925820785, 83734.99999999939, 10490.842637360445, 10739.355638661706, 10798.626556244733, 10956.780864382668, 11022.944885275523, 15032.549023529311, 15161.772573411408, 15184.46854360092, 15265.771013434807, 15292.541223763305, 8130.959345203354, 8292.543910085004, 8386.454880432751, 8439.493630382196, 8521.275691566163, 8263.0, 8323.708670196515, 8436.156384361515, 8460.619272132768, 8497.830043399097, 5739.196512488255, 6128.203333566607, 6701.0, 6707.094542236736, 6787.0, 1875.3717504635827, 1897.5256185953513, 1911.5890083631807, 1935.748352714138, 1995.8103980121866, 948.3029972969862, 960.1502670136979, 979.3389462113188, 1001.7395477175987, 1037.5071840875676, 20331.593368132555, 20400.0819963102, 20459.0, 20500.589988200154, 20567.8971605141, 1009.5154325923451, 1033.6640591807693, 1042.5412818359898, 1056.4189695667505, 1090.6400887707039, 10612.893871061346, 11486.138539609563, 11513.0, 11523.884761152449, 11536.307821530734, 444441.0, 448484.0, 454006.0, 459369.0, 461447.0, 94634.0, 97390.0, 98104.50947745216, 98304.50847745716, 99439.0, 1018.9286749927434, 1041.3915781816195, 1041.9010194031555, 1067.765091679829, 1071.769569542552, 18081.638367232317, 18144.546386340447, 18304.90847545807, 18435.446936591925, 18690.0, 40314.02885427391, 40350.1929961405, 40375.1924961505, 41376.1724765497, 42238.155236895705, 58746.0, 59791.40208598032, 60096.0, 60597.39402605918, 60859.0, 8263.380246481418, 8811.206991370807, 8879.334049946408, 8921.553922303729, 9046.547672616474, 13693.0, 13712.65718357049, 13883.652908677364, 14013.929930350283, 14048.508302209373, 11721.648350549498, 11820.70448238801, 11928.821067684165, 12034.75930481403, 12037.277763334228, 11663.416829158678, 11663.941680291544, 11867.762644746885, 11964.162508624313, 12154.756904861677, 11944.880551194377, 12035.939820300842, 12079.698007549881, 12095.153339266168, 12218.938905305773, 8660.220580147818, 8727.956360218159, 8728.869066964127, 8901.777455563662, 8992.730218093468, 11061.502232399722, 11126.833097503706, 11707.473163707484, 11908.761824763284, 12002.21985570935], "value": 9548.726088424904, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.5949555637746, 1452.0343971259113, 1464.8828093752502, 1581.304226140498, 1729.8616110711143, 7498.0, 8475.110113438093, 8836.646534138643, 8841.602127904243, 9050.63797448103, 8400.243978041975, 8444.0, 8476.66093356265, 8485.236328730412, 8573.571321433934, 1948.7661480622346, 2184.770599087097, 2263.0495192019307, 2264.728232612081, 2296.9655455168186, 2332.0, 2350.2949115265437, 2354.75275096115, 2355.5877721398774, 2361.2325994051916, 2264.1622599638076, 2274.465500607356, 2297.540491901618, 2299.3906614747107, 2300.838941274103, 1876.934307299245, 2106.947326316839, 2174.065151984646, 2174.5759576882515, 2203.592335417945, 2235.7540670526228, 2252.40311317501, 2272.3864556569633, 2274.55646149001, 2274.5678321118935, 8345.374096942754, 8372.079071302152, 8436.072032076467, 8440.198181172778, 8444.915550844475, 5047.066292735855, 5220.765065572058, 5223.582113430954, 5225.817096401645, 5230.267762513251, 3175.8253296068706, 3311.9668803311897, 3355.7147642450423, 3372.696457318853, 3417.2311229973307, 1138.7665528566624, 1167.1421505193675, 1181.291225264834, 1185.7450648110612, 1193.0, 12458.0, 12482.563110291187, 12488.0, 12499.437525311383, 12516.186447880858, 4332.4367832181615, 4480.663950203748, 4522.095580883836, 4562.452505699337, 4622.422197225347, 10383.84424233637, 10391.584336626602, 10397.168226541859, 10406.843897341547, 10415.479226038668, 5017.7491125443585, 5021.874453138701, 5033.496650335011, 5034.697918124851, 5034.874128146826, 4138.089620283533, 4502.144592527409, 4661.557152070548, 4685.929711054337, 4823.493533179036, 3895.53253609563, 3944.4674968878835, 3988.561258261589, 4024.597540245952, 4079.0618157823274, 1193.8896825951947, 1195.0857593940643, 1199.5201919232202, 1223.1254652923203, 1238.13949305232, 984.921206303494, 992.1219720547367, 994.8756405449319, 1002.2433063037361, 1006.7835415385728, 5902.2327097477055, 5920.230370051866, 5945.791897283574, 6018.488428483628, 6102.603330783573, 442.6856931578551, 454.4206137175128, 457.6544708744943, 469.91541522526273, 470.7528547512583, 4105.938410923838, 4244.0663054128045, 4250.277452833026, 4261.10516791471, 4274.038341373228, 10253.128484078788, 10898.564057437614, 11006.064484518745, 11006.669799906016, 11029.944850275857, 9900.0, 10247.795044099077, 10247.795044099077, 10255.58977640901, 10945.781084378268, 7796.532208067534, 7902.091259505116, 7929.801754956172, 8149.918500814916, 8153.836923261501, 5743.282089738783, 5945.31628862669, 5976.551758618034, 6104.786332478342, 6126.754929802758, 9853.310268281151, 9988.400695958266, 9994.150497207818, 10049.899501004897, 10081.949590252001, 10130.246020260669, 10184.439855807705, 10215.438150901771, 10336.534855931352, 10337.431441270803, 8275.50346979183, 8286.212809783061, 8394.45436046655, 8496.065432802263, 8504.489730616182, 8061.556614386265, 8068.273855353046, 8096.959515202387, 8122.390820688353, 8124.471909325875, 7230.060092187982, 7431.591262480615, 7502.174760776419, 7575.772726818204, 7714.922850771421, 7088.2202957675645, 7101.183363913009, 7139.143302803697, 7215.639218039182, 7278.818029549304, 6767.89848152288, 6813.4889883257965, 6856.9314306856295, 6860.691268892812, 6861.176658800976, 4981.626378021735, 5113.130767769414, 5119.308893299357, 5200.947990520046, 5265.104932161618, 5233.162693968947, 5354.143337066051, 5354.303940487712, 5403.486668766461, 5483.341998960151], "value": 4486.376979374323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.5457822782788, 332.0702034303948, 338.4162319998005, 340.2480518055099, 342.76178056250916, 5397.514223719864, 5414.566834653228, 5429.231092143006, 5458.235846981426, 5474.452554744524, 5389.299391079154, 5405.27028851105, 5413.188021796733, 5416.972915135419, 5450.29146210992, 3943.7830919299427, 4083.53039400469, 4116.197341518405, 4172.70791044627, 4209.5790420957965, 4185.434966279559, 4185.597824728704, 4219.797357753041, 4233.280342341794, 4235.639970602502, 4193.874183774492, 4204.360299483204, 4221.176870510251, 4224.5353011168745, 4237.533871274158, 3900.8244628991765, 4122.484689413824, 4205.1169254456445, 4212.7461807932605, 4216.7680777557225, 3678.1172518595613, 3702.5742039665242, 3708.9814550927344, 3725.1990821973136, 3735.4583585380237, 5259.894802103937, 5276.973615131899, 5298.178782288713, 5303.575713942875, 5326.334208223972, 4731.0, 4784.449788274358, 4804.495527969548, 4813.855584332476, 4818.927716084261, 5591.916121258185, 5612.242347283105, 5646.26598542191, 5676.3188417389765, 5685.317761868561, 4097.569755175693, 4145.818441744119, 4146.295129827907, 4152.211079894811, 4169.749815011079, 5718.713289509868, 5890.6171098878, 5901.557383196277, 5928.436798504135, 5985.610935289193, 4198.433211516406, 4204.915901681949, 4211.642010429086, 4220.261454245556, 4239.533651298355, 4253.595908388698, 4256.87229383119, 4261.232978063917, 4311.137772445523, 4314.0, 4719.551642593948, 4728.802479178034, 4806.735629540409, 4827.517248275144, 4924.138275801721, 5592.356878958891, 5599.468050535193, 5635.154726790932, 5680.801171958961, 5696.493542841136, 1468.5594321703447, 1487.9181645009628, 1492.3359105198083, 1492.9178895160871, 1493.402638944409, 938.648006997376, 959.5058544849409, 973.3089506450499, 992.265723364705, 1011.7622358745689, 5358.30342055538, 5362.758675859595, 5370.952664230437, 5373.811916582979, 5412.702301373462, 5694.857628559319, 5712.542996560265, 5721.199032135504, 5744.425557444306, 5756.884862302814, 5132.435432102466, 5336.252924590561, 5351.9464805351445, 5375.16684913839, 5381.869807340502, 3027.1523973287512, 3037.4988126958806, 3047.162030441602, 3099.1322429719717, 3100.751939844807, 5796.971015144897, 5898.94101058984, 5929.110633404937, 5945.554083443759, 5950.19672344228, 5700.774333518313, 5864.0031194697, 5899.905533535619, 5927.229460170151, 5958.165856780054, 5927.555433342516, 6001.669908155093, 6006.198140557903, 6028.186194863637, 6055.1522786810765, 5532.834014979557, 5732.770689172553, 5792.391798861059, 5819.592628516132, 5885.588008839341, 5630.88738225225, 5659.773609055592, 5667.518260947865, 5721.656700597978, 5721.885562288648, 5851.297844258546, 5941.287045554388, 5943.554233432424, 5945.702714864153, 5999.660132548397, 4167.74993500391, 4179.307380510898, 4199.349100889367, 4203.453551038346, 4205.726627769185, 5693.914591281217, 5789.913151302818, 5815.621984570989, 5889.234399528034, 5893.499052580579, 5557.305336832896, 5570.721463926707, 5742.511886489695, 5765.077587585966, 5800.24596802413, 5601.943980560142, 5680.2047713321, 5717.628354156966, 5725.770969161187, 5734.311882574118, 5355.892882142413, 5590.776368945197, 5592.748326325406, 5601.495865372136, 5618.719064046863, 5680.7443665036, 5730.169125476866, 5750.281214848144, 5769.634449875531, 5782.710864456844, 5530.225768392509, 5588.944110559005, 5602.243697100839, 5640.843627056525, 5649.915251271152], "value": 4324.499878849065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8641758065967, 748.7716246544802, 763.2253262938123, 776.9533827970322, 784.9568273744943, 15530.534083977485, 16663.91668041658, 16798.83201167988, 16799.664006719857, 16800.0, 15277.312520936557, 16146.03123812572, 16182.433614823483, 16651.916740416313, 16731.49805505834, 803.0082847683107, 803.9196080391944, 808.312934006096, 809.1180613131685, 809.6235250608465, 672.5090683800828, 789.2226157235119, 807.289585165054, 809.0251247247053, 812.6424373275739, 834.4367551902471, 835.841190173865, 837.2841220756258, 839.6557411461303, 841.7138173021171, 696.1263614164242, 826.499967519654, 831.0692024932084, 831.2477208126655, 831.9584020798966, 600.789723596742, 613.2365205319406, 616.9444749972524, 618.2148671187566, 618.4186864347499, 14682.853171468256, 14739.336729847182, 14741.262936853114, 14774.113553186844, 14775.113493190443, 12965.15726477776, 13211.471541138342, 13383.0, 13501.2574308413, 13903.235322057282, 11860.881391186063, 12337.0, 12369.443375048144, 12404.317762523058, 12864.29246391448, 3884.9028774280587, 3910.569837317893, 3970.3647416413237, 4036.979815100906, 4114.506259248909, 78599.21400785976, 79198.60400698017, 79408.60295698485, 81765.59117204435, 82359.5882020586, 10299.279050466545, 10335.74160645975, 10960.945195274133, 11027.2280940335, 11325.943370283096, 21305.573888522453, 21340.466488337916, 21344.786552134592, 21498.677519837216, 21564.137434502758, 8437.704680336159, 8544.829103417896, 8670.219680228684, 8702.738917832476, 8782.297416206688, 4661.184292748823, 4706.7411292378565, 4745.596624286905, 4754.95245047552, 4872.634552408584, 3448.2241495663775, 3609.512715783336, 3611.1513794258326, 3614.1145419372424, 3639.94540081899, 604.2446941323345, 609.6678756916152, 614.3058344071171, 616.5745635511572, 627.6234259444296, 601.1013534765466, 612.874360756044, 693.7537174303151, 721.3435773446139, 736.37408203027, 9442.197413219816, 9570.377925434825, 9785.559649815776, 9911.851322230172, 10118.898811011943, 561.7837132703856, 603.7162533609196, 668.4585485756553, 707.38104158861, 742.2874040920776, 4364.388985541963, 4587.08258348325, 4608.308753686973, 4629.166749985035, 4651.20928442552, 64547.35452645507, 64945.0, 103829.0, 110048.0, 111005.0, 55437.44562554404, 77092.2290777085, 90195.54902225448, 94491.0, 95589.5220523893, 84269.57865210634, 85012.0, 87392.56303718568, 87696.56151719329, 89106.55446722855, 8478.74563763088, 8766.860308159898, 8809.383343165917, 8840.425372350777, 8954.558954559161, 36298.8185059073, 36321.45517817288, 47030.529694702615, 52166.73916630392, 54605.0, 49233.2615010768, 49302.50697492979, 53334.73332633467, 70579.0, 75313.24686753063, 13377.331133443095, 13589.32053397346, 13736.244506552235, 13944.4422223114, 14202.218877961812, 15187.772183417479, 15516.456924007605, 15522.767158492406, 15548.533543993699, 15847.128407937675, 14028.649283767987, 14600.97793154469, 14892.702145957237, 14911.177644710579, 15341.769873452131, 13103.868961310265, 13338.466461341437, 13533.79699304531, 13672.384742686801, 13881.305934703427, 13621.591352259447, 14202.928985355007, 14648.560543183721, 14666.413343466142, 14698.265086745407, 10887.78224435491, 11244.493997769956, 11489.310641361544, 11607.419629018685, 11620.0, 9613.471259080818, 9799.951000244953, 9972.950135249568, 10331.483425828828, 10552.261341706315], "value": 7386.31746131611, "unit": "score"}], "name": "dromaeo_css", "value": 7248.175211418794, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 112.0, 110.0, 112.0, 110.0, 110.0, 112.0, 110.0, 108.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 130.0, 190.0, 128.0, 129.0, 155.0, 128.0, 164.0, 127.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 159.0, 162.0, 161.0, 162.0, 161.0, 160.0, 165.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 107.0, 77.0, 77.0, 75.0, 75.0, 116.0, 74.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 118.0, 86.0, 85.0, 85.0, 118.0, 85.0, 85.0, 129.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 54.0, 55.0, 55.0, 57.0, 55.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 78.0, 78.0, 80.0, 84.0, 86.0, 88.0, 85.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 134.0, 120.0, 118.0, 128.0, 128.0, 129.0, 121.0, 128.0, 123.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 167.0, 160.0, 162.0, 164.0, 169.0, 159.0, 165.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 64.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1502.6999999999998, "alertThreshold": 2.0}]} 19:43:40 INFO - Return code: 0 19:43:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:43:40 INFO - # TBPL SUCCESS # 19:43:40 INFO - Running post-action listener: _resource_record_post_action 19:43:40 INFO - ##### 19:43:40 INFO - ##### Finished run-tests step (success) 19:43:40 INFO - ##### 19:43:40 INFO - Running post-run listener: _resource_record_post_run 19:43:40 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558833664; Read time: 8; Write time: 1573404 19:43:40 INFO - TinderboxPrint: CPU usage
13.3% 19:43:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:43:40 INFO - TinderboxPrint: I/O write bytes / time
558,833,664 / 1,573,404 19:43:40 INFO - TinderboxPrint: CPU idle
8,285.4 (86.7%) 19:43:40 INFO - TinderboxPrint: CPU user
1,211.0 (12.7%) 19:43:40 INFO - TinderboxPrint: Swap in / out
0 / 0 19:43:40 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 269164544; Read time: 0; Write time: 792164 19:43:40 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289669120; Read time: 8; Write time: 781240 19:43:40 INFO - Running post-run listener: _upload_blobber_files 19:43:40 INFO - Blob upload gear active. 19:43:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:43:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:43:40 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:43:40 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:43:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:43:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:43:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:45 INFO - (blobuploader) - INFO - Done attempting. 19:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:43:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:46 INFO - (blobuploader) - INFO - Done attempting. 19:43:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:43:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:47 INFO - (blobuploader) - INFO - Done attempting. 19:43:47 INFO - (blobuploader) - INFO - Iteration through files over. 19:43:47 INFO - Return code: 0 19:43:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:43:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:43:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be53b6a66e34c2b8272b61769ae4678da207625f53fab3842e62a1802d1c670d4161ea0afa5ca794f29796a893b55583300a6be091b355d271911bcfc062249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2bb77d891a94a45be032f698969755ee724084a1ffcf303b1966a770db4f5ca41136d1aeeb3fbaa0f982ed8a2db0bc1be0b8730514705e8625a9a4822de4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1d08ab1a32c068c5815839aa36ece460d00f1866459561f1fc1ef2b64ef868147be3aa59eef77c948f36283f2b34b339ecb457ae72b557c11980e348d77d00"} 19:43:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:43:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:43:47 INFO - Contents: 19:43:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be53b6a66e34c2b8272b61769ae4678da207625f53fab3842e62a1802d1c670d4161ea0afa5ca794f29796a893b55583300a6be091b355d271911bcfc062249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2bb77d891a94a45be032f698969755ee724084a1ffcf303b1966a770db4f5ca41136d1aeeb3fbaa0f982ed8a2db0bc1be0b8730514705e8625a9a4822de4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1d08ab1a32c068c5815839aa36ece460d00f1866459561f1fc1ef2b64ef868147be3aa59eef77c948f36283f2b34b339ecb457ae72b557c11980e348d77d00"} 19:43:47 INFO - Running post-run listener: copy_logs_to_upload_dir 19:43:47 INFO - Copying logs to upload dir... 19:43:47 INFO - mkdir: /builds/slave/test/build/upload/logs 19:43:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.848207 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 19:43:47.398631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:47.403721) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be53b6a66e34c2b8272b61769ae4678da207625f53fab3842e62a1802d1c670d4161ea0afa5ca794f29796a893b55583300a6be091b355d271911bcfc062249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2bb77d891a94a45be032f698969755ee724084a1ffcf303b1966a770db4f5ca41136d1aeeb3fbaa0f982ed8a2db0bc1be0b8730514705e8625a9a4822de4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1d08ab1a32c068c5815839aa36ece460d00f1866459561f1fc1ef2b64ef868147be3aa59eef77c948f36283f2b34b339ecb457ae72b557c11980e348d77d00"} build_url:https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be53b6a66e34c2b8272b61769ae4678da207625f53fab3842e62a1802d1c670d4161ea0afa5ca794f29796a893b55583300a6be091b355d271911bcfc062249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c2bb77d891a94a45be032f698969755ee724084a1ffcf303b1966a770db4f5ca41136d1aeeb3fbaa0f982ed8a2db0bc1be0b8730514705e8625a9a4822de4ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1d08ab1a32c068c5815839aa36ece460d00f1866459561f1fc1ef2b64ef868147be3aa59eef77c948f36283f2b34b339ecb457ae72b557c11980e348d77d00"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:47.429489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:47.429816) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466811849.926241-1835425613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:47.514264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:43:47.514618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:43:47.514902) ========= ========= Total master_lag: 0.19 =========