builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1465580391.45 results: success (0) buildid: 20160610073042 builduid: 92e5e021ca5144cdb36ff288a7d519a2 revision: 1f20c27e6db6631b5ec774a2f5139505754e2416 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.452028) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.452565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.452883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.467719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.468053) ========= 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=41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 10:39:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-10 10:39:52 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.607635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.608000) ========= 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=41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021502 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.658538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:51.658939) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1f20c27e6db6631b5ec774a2f5139505754e2416 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1f20c27e6db6631b5ec774a2f5139505754e2416 --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=41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 10:39:52,164 truncating revision to first 12 chars 2016-06-10 10:39:52,164 Setting DEBUG logging. 2016-06-10 10:39:52,164 attempt 1/10 2016-06-10 10:39:52,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1f20c27e6db6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 10:39:52,510 unpacking tar archive at: mozilla-inbound-1f20c27e6db6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711203 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:52.384256) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:52.384694) ========= script_repo_revision: 1f20c27e6db6631b5ec774a2f5139505754e2416 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:52.385412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:52.385735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 10:39:52.396789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-10 10:39:52.397115) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:39:52 INFO - MultiFileLogger online at 20160610 10:39:52 in /builds/slave/test 10:39:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:39:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:39:52 INFO - {'append_to_log': False, 10:39:52 INFO - 'base_work_dir': '/builds/slave/test', 10:39:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:39:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:39:52 INFO - 'branch': 'Mozilla-Inbound', 10:39:52 INFO - 'buildbot_json_path': 'buildprops.json', 10:39:52 INFO - 'config_files': ('talos/linux_config.py',), 10:39:52 INFO - 'default_actions': ('clobber', 10:39:52 INFO - 'read-buildbot-config', 10:39:52 INFO - 'download-and-extract', 10:39:52 INFO - 'populate-webroot', 10:39:52 INFO - 'create-virtualenv', 10:39:52 INFO - 'install', 10:39:52 INFO - 'run-tests'), 10:39:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:39:52 INFO - 'download_minidump_stackwalk': True, 10:39:52 INFO - 'download_symbols': 'ondemand', 10:39:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:39:52 INFO - 'tooltool.py': '/tools/tooltool.py', 10:39:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:39:52 INFO - '/tools/misc-python/virtualenv.py')}, 10:39:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:39:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:39:52 INFO - 'installer_path': 'installer.exe', 10:39:52 INFO - 'log_level': 'info', 10:39:52 INFO - 'log_name': 'talos', 10:39:52 INFO - 'log_to_console': True, 10:39:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:39:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:39:52 INFO - 'opt_config_files': (), 10:39:52 INFO - 'pip_index': False, 10:39:52 INFO - 'sps_profile': False, 10:39:52 INFO - 'sps_profile_interval': 0, 10:39:52 INFO - 'suite': 'dromaeojs', 10:39:52 INFO - 'system_bits': '32', 10:39:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:39:52 INFO - 'title': 'talos-linux64-ix-026', 10:39:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:39:52 INFO - 'use_talos_json': True, 10:39:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:39:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:39:52 INFO - 'work_dir': 'build'} 10:39:52 INFO - ##### 10:39:52 INFO - ##### Running clobber step. 10:39:52 INFO - ##### 10:39:52 INFO - Running pre-action listener: _resource_record_pre_action 10:39:52 INFO - Running main action method: clobber 10:39:52 INFO - rmtree: /builds/slave/test/build 10:39:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:39:53 INFO - Running post-action listener: _resource_record_post_action 10:39:53 INFO - ##### 10:39:53 INFO - ##### Finished clobber step (success) 10:39:53 INFO - ##### 10:39:53 INFO - ##### 10:39:53 INFO - ##### Running read-buildbot-config step. 10:39:53 INFO - ##### 10:39:53 INFO - Running pre-action listener: _resource_record_pre_action 10:39:53 INFO - Running main action method: read_buildbot_config 10:39:53 INFO - Using buildbot properties: 10:39:53 INFO - { 10:39:53 INFO - "project": "", 10:39:53 INFO - "product": "firefox", 10:39:53 INFO - "script_repo_revision": "production", 10:39:53 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:39:53 INFO - "repository": "", 10:39:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:39:53 INFO - "buildid": "20160610073042", 10:39:53 INFO - "pgo_build": "True", 10:39:53 INFO - "basedir": "/builds/slave/test", 10:39:53 INFO - "buildnumber": 1162, 10:39:53 INFO - "slavename": "talos-linux64-ix-026", 10:39:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:39:53 INFO - "platform": "ubuntu64_hw", 10:39:53 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:39:53 INFO - "branch": "mozilla-inbound", 10:39:53 INFO - "repo_path": "integration/mozilla-inbound", 10:39:53 INFO - "revision": "1f20c27e6db6631b5ec774a2f5139505754e2416", 10:39:53 INFO - "stage_platform": "linux64-pgo", 10:39:53 INFO - "builduid": "92e5e021ca5144cdb36ff288a7d519a2", 10:39:53 INFO - "slavebuilddir": "test" 10:39:53 INFO - } 10:39:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:39:53 INFO - Running post-action listener: _resource_record_post_action 10:39:53 INFO - ##### 10:39:53 INFO - ##### Finished read-buildbot-config step (success) 10:39:53 INFO - ##### 10:39:53 INFO - ##### 10:39:53 INFO - ##### Running download-and-extract step. 10:39:53 INFO - ##### 10:39:53 INFO - Running pre-action listener: _resource_record_pre_action 10:39:53 INFO - Running main action method: download_and_extract 10:39:53 INFO - mkdir: /builds/slave/test/build/tests 10:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:53 INFO - https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:39:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:39:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:39:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:39:54 INFO - Downloaded 1361 bytes. 10:39:54 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:39:54 INFO - Using the following test package requirements: 10:39:54 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:39:54 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:39:54 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:39:54 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'jsshell-linux-x86_64.zip'], 10:39:54 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:39:54 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:39:54 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:39:54 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:39:54 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:39:54 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:39:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:39:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:54 INFO - https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:39:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:39:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:39:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:39:55 INFO - Downloaded 24463030 bytes. 10:39:55 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'] 10:39:55 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 10:39:57 INFO - Return code: 0 10:39:57 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 10:39:57 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')]} 10:39:57 INFO - https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:39:58 INFO - Downloaded 24463030 bytes. 10:39:58 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'] 10:39:58 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 10:39:59 INFO - Return code: 0 10:39: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')]} 10:39:59 INFO - https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:39:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:39:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:39:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:40:00 INFO - Downloaded 10833377 bytes. 10:40:00 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'] 10:40:00 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 10:40:01 INFO - Return code: 0 10:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:01 INFO - https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:40:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:40:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:40:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HAKOQGLETuqxwsCvRwFfAg/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 10:40:02 INFO - Downloaded 59306054 bytes. 10:40:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:40:02 INFO - mkdir: /builds/slave/test/properties 10:40:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:40:02 INFO - Writing to file /builds/slave/test/properties/build_url 10:40:02 INFO - Contents: 10:40:02 INFO - build_url:https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:40:03 INFO - Running post-action listener: _resource_record_post_action 10:40:03 INFO - Running post-action listener: set_extra_try_arguments 10:40:03 INFO - ##### 10:40:03 INFO - ##### Finished download-and-extract step (success) 10:40:03 INFO - ##### 10:40:03 INFO - ##### 10:40:03 INFO - ##### Running populate-webroot step. 10:40:03 INFO - ##### 10:40:03 INFO - Running pre-action listener: _resource_record_pre_action 10:40:03 INFO - Running main action method: populate_webroot 10:40:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:40:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:40:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:40:03 INFO - '--tppagecycles', 10:40:03 INFO - '7'], 10:40:03 INFO - 'tests': ['tsvgm']}}, 10:40:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:40:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:40:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:40:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:40:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['damp', 'tps']}, 10:40:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'tests': ['damp', 'tps']}, 10:40:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['dromaeo_dom']}, 10:40:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:40:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['a11yr', 10:40:03 INFO - 'ts_paint', 10:40:03 INFO - 'tpaint', 10:40:03 INFO - 'sessionrestore', 10:40:03 INFO - 'sessionrestore_no_auto_restore', 10:40:03 INFO - 'tabpaint']}, 10:40:03 INFO - 'other-e10s': {'tests': ['a11yr', 10:40:03 INFO - 'ts_paint', 10:40:03 INFO - 'tpaint', 10:40:03 INFO - 'sessionrestore', 10:40:03 INFO - 'sessionrestore_no_auto_restore', 10:40:03 INFO - 'tabpaint']}, 10:40:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:40:03 INFO - 'ts_paint', 10:40:03 INFO - 'tpaint', 10:40:03 INFO - 'sessionrestore', 10:40:03 INFO - 'sessionrestore_no_auto_restore', 10:40:03 INFO - 'tabpaint']}, 10:40:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:40:03 INFO - 'ts_paint', 10:40:03 INFO - 'tpaint', 10:40:03 INFO - 'sessionrestore', 10:40:03 INFO - 'sessionrestore_no_auto_restore', 10:40:03 INFO - 'tabpaint']}, 10:40:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['a11yr', 10:40:03 INFO - 'ts_paint', 10:40:03 INFO - 'tpaint', 10:40:03 INFO - 'sessionrestore', 10:40:03 INFO - 'sessionrestore_no_auto_restore', 10:40:03 INFO - 'tabpaint']}, 10:40:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['a11yr', 10:40:03 INFO - 'ts_paint', 10:40:03 INFO - 'tpaint', 10:40:03 INFO - 'sessionrestore', 10:40:03 INFO - 'sessionrestore_no_auto_restore', 10:40:03 INFO - 'tabpaint']}, 10:40:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['tsvgx', 10:40:03 INFO - 'tsvgr_opacity', 10:40:03 INFO - 'tart', 10:40:03 INFO - 'tscrollx', 10:40:03 INFO - 'cart']}, 10:40:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:40:03 INFO - 'tsvgr_opacity', 10:40:03 INFO - 'tart', 10:40:03 INFO - 'tscrollx', 10:40:03 INFO - 'cart']}, 10:40:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'talos_options': ['--disable-e10s'], 10:40:03 INFO - 'tests': ['tp5o']}, 10:40:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'tests': ['tp5o']}, 10:40:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'talos_options': ['--disable-e10s', 10:40:03 INFO - '--xperf_path', 10:40:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:03 INFO - 'tests': ['tp5n']}, 10:40:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:03 INFO - 'talos_options': ['--xperf_path', 10:40:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:03 INFO - 'tests': ['tp5n']}}, 10:40:03 INFO - 'talos.zip': {'path': '', 10:40:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:40:03 INFO - Running post-action listener: _resource_record_post_action 10:40:03 INFO - ##### 10:40:03 INFO - ##### Finished populate-webroot step (success) 10:40:03 INFO - ##### 10:40:03 INFO - ##### 10:40:03 INFO - ##### Running create-virtualenv step. 10:40:03 INFO - ##### 10:40:03 INFO - Running pre-action listener: _resource_record_pre_action 10:40:03 INFO - Running main action method: create_virtualenv 10:40:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:40:03 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 10:40:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:40:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:40:03 INFO - Using real prefix '/usr' 10:40:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:40:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:40:05 INFO - Installing pip.................done. 10:40:05 INFO - Return code: 0 10:40:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:05 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:05 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 10:40:05 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 10:40:05 INFO - Using env: {'DISPLAY': ':0', 10:40:05 INFO - 'HOME': '/home/cltbld', 10:40:05 INFO - 'LANG': 'en_US.UTF-8', 10:40:05 INFO - 'LANGUAGE': 'en_US:en', 10:40:05 INFO - 'LOGNAME': 'cltbld', 10:40:05 INFO - 'MAIL': '/var/mail/cltbld', 10:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:05 INFO - 'MOZ_NO_REMOTE': '1', 10:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:05 INFO - 'NO_EM_RESTART': '1', 10:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:05 INFO - 'PWD': '/builds/slave/test', 10:40:05 INFO - 'SHELL': '/bin/bash', 10:40:05 INFO - 'SHLVL': '1', 10:40:05 INFO - 'TERM': 'linux', 10:40:05 INFO - 'TMOUT': '86400', 10:40:05 INFO - 'USER': 'cltbld', 10:40:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:05 INFO - '_': '/tools/buildbot/bin/python'} 10:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:05 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 10:40:05 INFO - Cleaning up... 10:40:05 INFO - Return code: 0 10:40:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:05 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:05 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 10:40:05 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 10:40:05 INFO - Using env: {'DISPLAY': ':0', 10:40:05 INFO - 'HOME': '/home/cltbld', 10:40:05 INFO - 'LANG': 'en_US.UTF-8', 10:40:05 INFO - 'LANGUAGE': 'en_US:en', 10:40:05 INFO - 'LOGNAME': 'cltbld', 10:40:05 INFO - 'MAIL': '/var/mail/cltbld', 10:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:05 INFO - 'MOZ_NO_REMOTE': '1', 10:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:05 INFO - 'NO_EM_RESTART': '1', 10:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:05 INFO - 'PWD': '/builds/slave/test', 10:40:05 INFO - 'SHELL': '/bin/bash', 10:40:05 INFO - 'SHLVL': '1', 10:40:05 INFO - 'TERM': 'linux', 10:40:05 INFO - 'TMOUT': '86400', 10:40:05 INFO - 'USER': 'cltbld', 10:40:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:05 INFO - '_': '/tools/buildbot/bin/python'} 10:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:06 INFO - Downloading/unpacking psutil>=3.1.1 10:40:06 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 10:40:06 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 10:40:06 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 10:40:06 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 10:40:06 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 10:40:06 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 10:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:40:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:40:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:40:08 INFO - Installing collected packages: psutil 10:40:08 INFO - Running setup.py install for psutil 10:40:08 INFO - building 'psutil._psutil_linux' extension 10:40:08 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 10:40:08 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 10:40:08 INFO - building 'psutil._psutil_posix' extension 10:40:08 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 10:40:08 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 10:40:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:40:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:40:08 INFO - Successfully installed psutil 10:40:08 INFO - Cleaning up... 10:40:08 INFO - Return code: 0 10:40:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:40: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')]} 10:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:08 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:08 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 10:40:08 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 10:40:08 INFO - Using env: {'DISPLAY': ':0', 10:40:08 INFO - 'HOME': '/home/cltbld', 10:40:08 INFO - 'LANG': 'en_US.UTF-8', 10:40:08 INFO - 'LANGUAGE': 'en_US:en', 10:40:08 INFO - 'LOGNAME': 'cltbld', 10:40:08 INFO - 'MAIL': '/var/mail/cltbld', 10:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:08 INFO - 'MOZ_NO_REMOTE': '1', 10:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:08 INFO - 'NO_EM_RESTART': '1', 10:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:08 INFO - 'PWD': '/builds/slave/test', 10:40:08 INFO - 'SHELL': '/bin/bash', 10:40:08 INFO - 'SHLVL': '1', 10:40:08 INFO - 'TERM': 'linux', 10:40:08 INFO - 'TMOUT': '86400', 10:40:08 INFO - 'USER': 'cltbld', 10:40:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:08 INFO - '_': '/tools/buildbot/bin/python'} 10:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:40:08 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 10:40:08 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 10:40:08 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 10:40:08 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 10:40:08 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 10:40:08 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 10:40:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:40:10 INFO - Installing collected packages: mozsystemmonitor 10:40:10 INFO - Running setup.py install for mozsystemmonitor 10:40:11 INFO - Successfully installed mozsystemmonitor 10:40:11 INFO - Cleaning up... 10:40:11 INFO - Return code: 0 10:40:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:11 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:11 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 10:40:11 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 10:40:11 INFO - Using env: {'DISPLAY': ':0', 10:40:11 INFO - 'HOME': '/home/cltbld', 10:40:11 INFO - 'LANG': 'en_US.UTF-8', 10:40:11 INFO - 'LANGUAGE': 'en_US:en', 10:40:11 INFO - 'LOGNAME': 'cltbld', 10:40:11 INFO - 'MAIL': '/var/mail/cltbld', 10:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:11 INFO - 'MOZ_NO_REMOTE': '1', 10:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:11 INFO - 'NO_EM_RESTART': '1', 10:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:11 INFO - 'PWD': '/builds/slave/test', 10:40:11 INFO - 'SHELL': '/bin/bash', 10:40:11 INFO - 'SHLVL': '1', 10:40:11 INFO - 'TERM': 'linux', 10:40:11 INFO - 'TMOUT': '86400', 10:40:11 INFO - 'USER': 'cltbld', 10:40:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:11 INFO - '_': '/tools/buildbot/bin/python'} 10:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:11 INFO - Downloading/unpacking jsonschema==2.5.1 10:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:40:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:40:13 INFO - warning: no files found matching '*.txt' 10:40:13 INFO - no previously-included directories found matching 'build' 10:40:13 INFO - no previously-included directories found matching 'dist' 10:40:13 INFO - no previously-included directories found matching '.git*' 10:40:13 INFO - Installing collected packages: jsonschema, functools32 10:40:13 INFO - Running setup.py install for functools32 10:40:13 INFO - warning: no files found matching '*.txt' 10:40:13 INFO - no previously-included directories found matching 'build' 10:40:13 INFO - no previously-included directories found matching 'dist' 10:40:13 INFO - no previously-included directories found matching '.git*' 10:40:13 INFO - Successfully installed jsonschema functools32 10:40:13 INFO - Cleaning up... 10:40:13 INFO - Return code: 0 10:40:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:40: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')]} 10:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:13 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:13 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 10:40:13 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 10:40:13 INFO - Using env: {'DISPLAY': ':0', 10:40:13 INFO - 'HOME': '/home/cltbld', 10:40:13 INFO - 'LANG': 'en_US.UTF-8', 10:40:13 INFO - 'LANGUAGE': 'en_US:en', 10:40:13 INFO - 'LOGNAME': 'cltbld', 10:40:13 INFO - 'MAIL': '/var/mail/cltbld', 10:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:13 INFO - 'MOZ_NO_REMOTE': '1', 10:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:13 INFO - 'NO_EM_RESTART': '1', 10:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:13 INFO - 'PWD': '/builds/slave/test', 10:40:13 INFO - 'SHELL': '/bin/bash', 10:40:13 INFO - 'SHLVL': '1', 10:40:13 INFO - 'TERM': 'linux', 10:40:13 INFO - 'TMOUT': '86400', 10:40:13 INFO - 'USER': 'cltbld', 10:40:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:13 INFO - '_': '/tools/buildbot/bin/python'} 10:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:13 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 10:40:15 INFO - Downloading blobuploader-1.2.4.tar.gz 10:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:40:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:40:15 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 10:40:15 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 10:40:15 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 10:40:15 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 10:40:15 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 10:40:15 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 10:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:40:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:40:16 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 10:40:16 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 10:40:16 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 10:40:16 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 10:40:16 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 10:40:16 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 10:40:16 INFO - Downloading docopt-0.6.1.tar.gz 10:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:40:16 INFO - Installing collected packages: blobuploader, requests, docopt 10:40:16 INFO - Running setup.py install for blobuploader 10:40:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:40:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:40:16 INFO - Running setup.py install for requests 10:40:16 INFO - Running setup.py install for docopt 10:40:17 INFO - Successfully installed blobuploader requests docopt 10:40:17 INFO - Cleaning up... 10:40:17 INFO - Return code: 0 10:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:17 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')]} 10:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:17 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')]} 10:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:17 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:17 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 10:40:17 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 10:40:17 INFO - Using env: {'DISPLAY': ':0', 10:40:17 INFO - 'HOME': '/home/cltbld', 10:40:17 INFO - 'LANG': 'en_US.UTF-8', 10:40:17 INFO - 'LANGUAGE': 'en_US:en', 10:40:17 INFO - 'LOGNAME': 'cltbld', 10:40:17 INFO - 'MAIL': '/var/mail/cltbld', 10:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:17 INFO - 'MOZ_NO_REMOTE': '1', 10:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:17 INFO - 'NO_EM_RESTART': '1', 10:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:17 INFO - 'PWD': '/builds/slave/test', 10:40:17 INFO - 'SHELL': '/bin/bash', 10:40:17 INFO - 'SHLVL': '1', 10:40:17 INFO - 'TERM': 'linux', 10:40:17 INFO - 'TMOUT': '86400', 10:40:17 INFO - 'USER': 'cltbld', 10:40:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:17 INFO - '_': '/tools/buildbot/bin/python'} 10:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:40:17 INFO - Running setup.py (path:/tmp/pip-8BlH0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:40:17 INFO - Running setup.py (path:/tmp/pip-HVvYqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:40:17 INFO - Running setup.py (path:/tmp/pip-bM7Uwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:40:17 INFO - Running setup.py (path:/tmp/pip-A1zDx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:40:17 INFO - Running setup.py (path:/tmp/pip-QMACCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:40:17 INFO - Running setup.py (path:/tmp/pip-_HkAcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:40:17 INFO - Running setup.py (path:/tmp/pip-hwhOP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:40:17 INFO - Running setup.py (path:/tmp/pip-BJtp6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:40:17 INFO - Running setup.py (path:/tmp/pip-4Lq3BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:40:18 INFO - Running setup.py (path:/tmp/pip-7y8z6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:40:18 INFO - Running setup.py (path:/tmp/pip-Zg_AGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:40:18 INFO - Running setup.py (path:/tmp/pip-MNPRUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:40:18 INFO - Running setup.py (path:/tmp/pip-xkQKBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:40:18 INFO - Running setup.py (path:/tmp/pip-zXnfvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:18 INFO - Running setup.py (path:/tmp/pip-NChc2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:40:18 INFO - Running setup.py (path:/tmp/pip-9weavg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:40:18 INFO - Running setup.py (path:/tmp/pip-pSvZTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:40:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:40:18 INFO - Running setup.py install for manifestparser 10:40:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:40:18 INFO - Running setup.py install for mozcrash 10:40:18 INFO - Running setup.py install for mozdebug 10:40:18 INFO - Running setup.py install for mozdevice 10:40:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Running setup.py install for mozfile 10:40:19 INFO - Running setup.py install for mozhttpd 10:40:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Running setup.py install for mozinfo 10:40:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Running setup.py install for mozInstall 10:40:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Running setup.py install for mozleak 10:40:19 INFO - Running setup.py install for mozlog 10:40:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Running setup.py install for moznetwork 10:40:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Running setup.py install for mozprocess 10:40:19 INFO - Running setup.py install for mozprofile 10:40:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:40:19 INFO - Running setup.py install for mozrunner 10:40:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:40:20 INFO - Running setup.py install for mozscreenshot 10:40:20 INFO - Running setup.py install for moztest 10:40:20 INFO - Running setup.py install for mozversion 10:40:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:40:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:40:20 INFO - Cleaning up... 10:40:20 INFO - Return code: 0 10:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40: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')]} 10:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:20 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:20 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 10:40:20 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 10:40:20 INFO - Using env: {'DISPLAY': ':0', 10:40:20 INFO - 'HOME': '/home/cltbld', 10:40:20 INFO - 'LANG': 'en_US.UTF-8', 10:40:20 INFO - 'LANGUAGE': 'en_US:en', 10:40:20 INFO - 'LOGNAME': 'cltbld', 10:40:20 INFO - 'MAIL': '/var/mail/cltbld', 10:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:20 INFO - 'MOZ_NO_REMOTE': '1', 10:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:20 INFO - 'NO_EM_RESTART': '1', 10:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:20 INFO - 'PWD': '/builds/slave/test', 10:40:20 INFO - 'SHELL': '/bin/bash', 10:40:20 INFO - 'SHLVL': '1', 10:40:20 INFO - 'TERM': 'linux', 10:40:20 INFO - 'TMOUT': '86400', 10:40:20 INFO - 'USER': 'cltbld', 10:40:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:20 INFO - '_': '/tools/buildbot/bin/python'} 10:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:40:20 INFO - Running setup.py (path:/tmp/pip-nyFtRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:40:20 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)) 10:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:40:20 INFO - Running setup.py (path:/tmp/pip-AeRKqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:40:20 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)) 10:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:40:20 INFO - Running setup.py (path:/tmp/pip-ng5u3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:40:20 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)) 10:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:40:20 INFO - Running setup.py (path:/tmp/pip-qWcLTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:40:20 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)) 10:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:40:20 INFO - Running setup.py (path:/tmp/pip-4gppjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:40:21 INFO - Running setup.py (path:/tmp/pip-bW0lLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:40:21 INFO - Running setup.py (path:/tmp/pip-QzDtOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:40:21 INFO - Running setup.py (path:/tmp/pip-o9GLlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:40:21 INFO - Running setup.py (path:/tmp/pip-ACAKYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:40:21 INFO - Running setup.py (path:/tmp/pip-rXXrvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:40:21 INFO - Running setup.py (path:/tmp/pip-w7P3iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:40:21 INFO - Running setup.py (path:/tmp/pip-oAnEg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:40:21 INFO - Running setup.py (path:/tmp/pip-mObfnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:40:21 INFO - Running setup.py (path:/tmp/pip-QaJU94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:21 INFO - Running setup.py (path:/tmp/pip-JxmRoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:40:21 INFO - Running setup.py (path:/tmp/pip-4jWPcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:40:21 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)) 10:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:40:21 INFO - Running setup.py (path:/tmp/pip-rlrLKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:40:21 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)) 10:40:21 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)) 10:40:21 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)) 10:40:21 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)) 10:40:21 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)) 10:40:21 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)) 10:40:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:23 INFO - Downloading blessings-1.6.tar.gz 10:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:40:23 INFO - Installing collected packages: blessings 10:40:23 INFO - Running setup.py install for blessings 10:40:23 INFO - Successfully installed blessings 10:40:23 INFO - Cleaning up... 10:40:24 INFO - Return code: 0 10:40:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:24 INFO - Reading from file tmpfile_stdout 10:40:24 INFO - Current package versions: 10:40:24 INFO - argparse == 1.2.1 10:40:24 INFO - blessings == 1.6 10:40:24 INFO - blobuploader == 1.2.4 10:40:24 INFO - docopt == 0.6.1 10:40:24 INFO - functools32 == 3.2.3-2 10:40:24 INFO - jsonschema == 2.5.1 10:40:24 INFO - manifestparser == 1.1 10:40:24 INFO - mozInstall == 1.12 10:40:24 INFO - mozcrash == 0.17 10:40:24 INFO - mozdebug == 0.1 10:40:24 INFO - mozdevice == 0.48 10:40:24 INFO - mozfile == 1.2 10:40:24 INFO - mozhttpd == 0.7 10:40:24 INFO - mozinfo == 0.9 10:40:24 INFO - mozleak == 0.1 10:40:24 INFO - mozlog == 3.2 10:40:24 INFO - moznetwork == 0.27 10:40:24 INFO - mozprocess == 0.22 10:40:24 INFO - mozprofile == 0.28 10:40:24 INFO - mozrunner == 6.11 10:40:24 INFO - mozscreenshot == 0.1 10:40:24 INFO - mozsystemmonitor == 0.3 10:40:24 INFO - moztest == 0.7 10:40:24 INFO - mozversion == 1.4 10:40:24 INFO - psutil == 3.1.1 10:40:24 INFO - requests == 1.2.3 10:40:24 INFO - wsgiref == 0.1.2 10:40:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:24 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 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:24 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 10:40:24 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 10:40:24 INFO - Using env: {'DISPLAY': ':0', 10:40:24 INFO - 'HOME': '/home/cltbld', 10:40:24 INFO - 'LANG': 'en_US.UTF-8', 10:40:24 INFO - 'LANGUAGE': 'en_US:en', 10:40:24 INFO - 'LOGNAME': 'cltbld', 10:40:24 INFO - 'MAIL': '/var/mail/cltbld', 10:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:24 INFO - 'MOZ_NO_REMOTE': '1', 10:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:24 INFO - 'NO_EM_RESTART': '1', 10:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:24 INFO - 'PWD': '/builds/slave/test', 10:40:24 INFO - 'SHELL': '/bin/bash', 10:40:24 INFO - 'SHLVL': '1', 10:40:24 INFO - 'TERM': 'linux', 10:40:24 INFO - 'TMOUT': '86400', 10:40:24 INFO - 'USER': 'cltbld', 10:40:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:24 INFO - '_': '/tools/buildbot/bin/python'} 10:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 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)) 10:40:24 INFO - Cleaning up... 10:40:24 INFO - Return code: 0 10:40:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:40:24 INFO - Using env: {'DISPLAY': ':0', 10:40:24 INFO - 'HOME': '/home/cltbld', 10:40:24 INFO - 'LANG': 'en_US.UTF-8', 10:40:24 INFO - 'LANGUAGE': 'en_US:en', 10:40:24 INFO - 'LOGNAME': 'cltbld', 10:40:24 INFO - 'MAIL': '/var/mail/cltbld', 10:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:24 INFO - 'MOZ_NO_REMOTE': '1', 10:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:24 INFO - 'NO_EM_RESTART': '1', 10:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:24 INFO - 'PWD': '/builds/slave/test', 10:40:24 INFO - 'SHELL': '/bin/bash', 10:40:24 INFO - 'SHLVL': '1', 10:40:24 INFO - 'TERM': 'linux', 10:40:24 INFO - 'TMOUT': '86400', 10:40:24 INFO - 'USER': 'cltbld', 10:40:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:24 INFO - '_': '/tools/buildbot/bin/python'} 10:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:40:24 INFO - Cleaning up... 10:40:24 INFO - Return code: 0 10:40:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e6cec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, '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': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', '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 10:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:40:24 INFO - Using env: {'DISPLAY': ':0', 10:40:24 INFO - 'HOME': '/home/cltbld', 10:40:24 INFO - 'LANG': 'en_US.UTF-8', 10:40:24 INFO - 'LANGUAGE': 'en_US:en', 10:40:24 INFO - 'LOGNAME': 'cltbld', 10:40:24 INFO - 'MAIL': '/var/mail/cltbld', 10:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:24 INFO - 'MOZ_NO_REMOTE': '1', 10:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:24 INFO - 'NO_EM_RESTART': '1', 10:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:24 INFO - 'PWD': '/builds/slave/test', 10:40:24 INFO - 'SHELL': '/bin/bash', 10:40:24 INFO - 'SHLVL': '1', 10:40:24 INFO - 'TERM': 'linux', 10:40:24 INFO - 'TMOUT': '86400', 10:40:24 INFO - 'USER': 'cltbld', 10:40:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:24 INFO - '_': '/tools/buildbot/bin/python'} 10:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:24 INFO - Downloading/unpacking flake8 10:40:24 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 10:40:24 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 10:40:24 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 10:40:24 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 10:40:24 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 10:40:24 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 10:40:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:40:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:40:26 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 10:40:26 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 10:40:26 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 10:40:26 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 10:40:26 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 10:40:26 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 10:40:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:40:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:40:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:40:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:40:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:40:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:40:27 INFO - no previously-included directories found matching 'docs/_build' 10:40:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:40:27 INFO - Running setup.py install for pep8 10:40:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:40:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:40:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:40:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:40:27 INFO - no previously-included directories found matching 'docs/_build' 10:40:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:40:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:40:27 INFO - Cleaning up... 10:40:27 INFO - Return code: 0 10:40:27 INFO - Running post-action listener: _resource_record_post_action 10:40:27 INFO - Running post-action listener: _start_resource_monitoring 10:40:27 INFO - Starting resource monitoring. 10:40:27 INFO - ##### 10:40:27 INFO - ##### Finished create-virtualenv step (success) 10:40:27 INFO - ##### 10:40:27 INFO - ##### 10:40:27 INFO - ##### Running install step. 10:40:27 INFO - ##### 10:40:27 INFO - Running pre-action listener: _resource_record_pre_action 10:40:27 INFO - Running main action method: install 10:40:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:40:28 INFO - Reading from file tmpfile_stdout 10:40:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:40:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:40:28 INFO - Reading from file tmpfile_stdout 10:40:28 INFO - Output received: 10:40:28 INFO - Usage: mozinstall [options] installer 10:40:28 INFO - Options: 10:40:28 INFO - -h, --help show this help message and exit 10:40:28 INFO - -d DEST, --destination=DEST 10:40:28 INFO - Directory to install application into. [default: 10:40:28 INFO - "/builds/slave/test"] 10:40:28 INFO - --app=APP Application being installed. [default: firefox] 10:40:28 INFO - mkdir: /builds/slave/test/build/application 10:40:28 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'] 10:40:28 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 10:40:44 INFO - Reading from file tmpfile_stdout 10:40:44 INFO - Output received: 10:40:44 INFO - /builds/slave/test/build/application/firefox/firefox 10:40:44 INFO - Running post-action listener: _resource_record_post_action 10:40:44 INFO - ##### 10:40:44 INFO - ##### Finished install step (success) 10:40:44 INFO - ##### 10:40:44 INFO - ##### 10:40:44 INFO - ##### Running run-tests step. 10:40:44 INFO - ##### 10:40:44 INFO - Running pre-action listener: _resource_record_pre_action 10:40:44 INFO - Running main action method: run_tests 10:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:40:44 INFO - Python 2.7.3 10:40:44 INFO - Return code: 0 10:40:44 INFO - grabbing minidump binary from tooltool 10:40:44 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')]} 10:40:44 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 0x1d7e1c0>, '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 0x1d7f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:40:44 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 10:40:44 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 10:40:44 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 10:40:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:40:45 INFO - Return code: 0 10:40:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:40:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:40:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:40:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:40:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:40:45 INFO - Return code: 0 10:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 10:40:45 INFO - Using env: {'DISPLAY': ':0', 10:40:45 INFO - 'HOME': '/home/cltbld', 10:40:45 INFO - 'LANG': 'en_US.UTF-8', 10:40:45 INFO - 'LANGUAGE': 'en_US:en', 10:40:45 INFO - 'LOGNAME': 'cltbld', 10:40:45 INFO - 'MAIL': '/var/mail/cltbld', 10:40:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:40:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:45 INFO - 'MOZ_NO_REMOTE': '1', 10:40:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:45 INFO - 'NO_EM_RESTART': '1', 10:40:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:40:45 INFO - 'PWD': '/builds/slave/test', 10:40:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:40:45 INFO - 'SHELL': '/bin/bash', 10:40:45 INFO - 'SHLVL': '1', 10:40:45 INFO - 'TERM': 'linux', 10:40:45 INFO - 'TMOUT': '86400', 10:40:45 INFO - 'USER': 'cltbld', 10:40:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880', 10:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:45 INFO - '_': '/tools/buildbot/bin/python'} 10:40:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:40:46 INFO - mozversion application_buildid: 20160610073042 10:40:46 INFO - mozversion application_changeset: 1f20c27e6db6631b5ec774a2f5139505754e2416 10:40:46 INFO - mozversion application_display_name: Nightly 10:40:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:40:46 INFO - mozversion application_name: Firefox 10:40:46 INFO - mozversion application_remotingname: firefox 10:40:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:40:46 INFO - mozversion application_vendor: Mozilla 10:40:46 INFO - mozversion application_version: 50.0a1 10:40:46 INFO - mozversion platform_buildid: 20160610073042 10:40:46 INFO - mozversion platform_changeset: 1f20c27e6db6631b5ec774a2f5139505754e2416 10:40:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:40:46 INFO - mozversion platform_version: 50.0a1 10:40:46 INFO - using testdate: 1465580446 10:40:46 INFO - actual date: 1465580446 10:40:46 INFO - starting webserver on 'localhost:37664' 10:40:46 INFO - SUITE-START | Running 2 tests 10:40:46 INFO - TEST-START | dromaeo_css 10:40:46 INFO - operating with platform_type : linux_ 10:40:46 INFO - Initialising browser for dromaeo_css test... 10:40:46 INFO - TEST-INFO | started process 6782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe07HPS/profile http://localhost:37664/getInfo.html) 10:40:50 INFO - PROCESS | 6782 | __metrics Screen width/height:1600/1200 10:40:50 INFO - PROCESS | 6782 | colorDepth:24 10:40:50 INFO - PROCESS | 6782 | Browser inner width/height: 1024/697 10:40:50 INFO - PROCESS | 6782 | __metrics 10:40:51 ERROR - PROCESS | 6782 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:40:51 INFO - PROCESS | 6782 | console.error: PushService: 10:40:51 INFO - PROCESS | 6782 | stateChangeProcessEnqueue: Error transitioning state 10:40:51 INFO - PROCESS | 6782 | UnknownError 10:40:52 INFO - TEST-INFO | 6782: exit 0 10:40:52 INFO - Browser initialized. 10:40:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:40:52 INFO - TEST-INFO | started process 6864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe07HPS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:03 INFO - PROCESS | 6864 | RSS: Main: 174006272 10:41:03 INFO - PROCESS | 6864 | 10:41:54 INFO - PROCESS | 6864 | 1465580514688 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] 10:44:03 INFO - PROCESS | 6864 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37664/tests/dromaeo/cssquery-ext.html) 10:44:04 INFO - PROCESS | 6864 | RSS: Main: 306782208 10:44:04 INFO - PROCESS | 6864 | 10:47:07 INFO - PROCESS | 6864 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-ext.html (next: http://localhost:37664/tests/dromaeo/cssquery-jquery.html) 10:47:07 INFO - PROCESS | 6864 | RSS: Main: 253067264 10:47:07 INFO - PROCESS | 6864 | 10:50:09 INFO - PROCESS | 6864 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37664/tests/dromaeo/cssquery-mootools.html) 10:50:10 INFO - PROCESS | 6864 | RSS: Main: 255541248 10:50:10 INFO - PROCESS | 6864 | 10:53:12 INFO - PROCESS | 6864 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37664/tests/dromaeo/cssquery-prototype.html) 10:53:13 INFO - PROCESS | 6864 | RSS: Main: 252993536 10:53:13 INFO - PROCESS | 6864 | 10:56:15 INFO - PROCESS | 6864 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37664/tests/dromaeo/cssquery-yui.html) 10:56:16 INFO - PROCESS | 6864 | RSS: Main: 243466240 10:56:16 INFO - PROCESS | 6864 | 10:59:18 INFO - PROCESS | 6864 | Cycle 1(1): loaded http://localhost:37664/tests/dromaeo/cssquery-yui.html (next: http://localhost:37664/tests/dromaeo/cssquery-dojo.html) 10:59:19 INFO - PROCESS | 6864 | RSS: Main: 316334080 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | __start_tp_report 10:59:19 INFO - PROCESS | 6864 | _x_x_mozilla_page_load 10:59:19 INFO - PROCESS | 6864 | _x_x_mozilla_page_load_details 10:59:19 INFO - PROCESS | 6864 | |i|pagename|runs| 10:59:19 INFO - PROCESS | 6864 | |0;dojo.html;3070.6008218931534;3095.9071227863174;3096.721295083442;3135.0594821553527;3151.2279491524578;5151.510606492387;5203.947960520393;5261.631685781992;5348.277982472365;5403.702796346204;5298.947010529893;5316;5358.142697168444;5419.674819510832;5450.373207081187;4807.61539076873;4815.855524334258;4838.129136755382;4873.610111191105;4901.460839307673;4982.850514484571;4994.051130285252;4997.30037794709;5001.8499445016705;5012.699238045729;4676.859694209145;4696.248600223982;4922.532359425849;4951.529604687549;4975.402951645808;4728.432588089417;4772.49888761682;4777.976110119462;4785.497522760095;4820.276958456259;4747.477777444478;4798.47216806151;4825.95174048262;4828.203346447832;4870.537298956629;5169.353830771153;5226.372835259755;5303.5226829585135;5335.013022590794;5357.624966252364;5657.660540367591;5768.711564421762;5772.3938986406665;5774.653520788766;5775.018246897996;5728.369879313273;5736.942630573682;5793.884122317572;5798.5071268941765;5815.883682326372;5251.711155886424;5300.178472336794;5354.143337066129;5394.271773310592;5398.838034858961;5869.06095024794;5889.381614930457;5889.469947704727;5893.705314734246;5897.2333596633025;5619.578531610146;5620.381758006616;5666.829995100154;5668.943310566924;5678.0915053591225;5564.721763911869;5655.3779084300695;5688.288963879515;5699.572532060112;5712;5713.171590119409;5715.828525144252;5716.399778023248;5721.942780572224;5722.341930677942;5715.514181294553;5725.31296244445;5726.112452569775;5731.856703582361;5731.914021289684;4304.203722311382;4324.3513472978675;4352.325389564622;4362.105768317488;4390.05613793036;3924.4309575111447;3943.802809859553;3946.1515774108702;3980;3985.4221137934837;5413.539849112791;5452.890942181134;5465.863353416196;5469.15228139639;5469.535089517356;5586.385497595261;5606.55147588192;5629.887402252014;5668.858278542987;5693.800716974886;5325.068113080196;5366.7853285868905;5366.892662146814;5369.570434365241;5405.945940540623;4724.173269677862;4928;4940.382452193476;4946.282788995575;4989.301497790239;5893.793717219876;5952.523798096142;5974.910376344358;5990.64056156632;6013.669248191304;5752.942470575241;5763.33721622002;5765.4811067004175;5766.5675074368755;5770.221020162225;5670.092785154356;5779.971100144472;5994.700264986646;6006.189164462741;6013.548983826318;5541.695206763667;5604.047311956896;5609.551235901036;5613.101903695552;5662.2639056922335;5698.629589076697;5702.942970570241;5714.371419143974;5714.457126572969;5719.0277652798295;5404.918926216189;5541.141123125922;5576.358718747396;5579;5584.3857175711455;5571.359293681278;5579.246801681721;5579.525740312119;5581.162825576033;5621.775128994795;5399.78400863961;5404.054290499225;5443.374011988672;5446.346438427414;5507.697076660662;5365.543928766098;5510.91733624004;5572.721363931868;5617.719114044363;5692.174634678031;5227.529522343008;5255.13290307095;5467.644603100785;5496.285482887199;5524.613277070566 10:59:19 INFO - PROCESS | 6864 | |1;ext.html;557.548385807496;599.52637416441;619.5972617798432;620.2340109964193;635.072793721167;30488.84755576222;42527;43363.34954975678;43365.88024137706;43416.56583434164;44216;44734;44800.32799508002;44801.32798008024;44829.10341793162;7993.800154996114;8956.641734330635;9116.635334586608;10551.78896422071;10892.074173695246;10807;10816.945915270451;10907.618233361834;10916.727081822939;10923;10944.3980581068;10991.06575941046;10991.835122473169;10996.340219586851;10997.670069897877;8161.510309381427;10716;10921.508532115995;10952.959468850446;10953.233273670847;10401.79196416075;10516.526756295985;10520.526576304084;10890.891091089066;10894.945525272402;42608.36087458659;42882;43196.78401607972;43242.783786081185;43266.351004734955;3473.2532505511435;3757.1734218471893;4069.7354671946227;4118.5057793064725;4217;32848.17879553006;33226.833865830515;33303.16742081443;33486;33674.6632533674;4305.3128233564175;4417.536158703322;4417.646588272931;4445.266531022377;4513.50351461339;337886;338942;339322;340518.29740851384;340569;35584.82207588945;63706.681466592374;64153.35846641567;64157.358426416075;64310.356896431374;37318.44022339667;37326.813365933;37330.626693733255;37355.43966840499;37402.251954960746;13397.129186603035;15386.461473848361;15462;15597.610059748597;15644.92177539105;11432.142589305835;11641.59254426091;11649.825252621218;12078.033757299396;12188.329641869783;8353.916460835435;8363.83272334562;8391.202835730595;8405.621747021398;8459.111793261618;3291.8683252670103;3301.5047742838765;3329.8002119872885;3335.832458639457;3348.1462227131924;1021.7241344836852;1047.6752206815759;1136.198979719296;1144.513581727779;1156.9016633586239;32870;33132.83433582865;33388;33479.83260083684;34151.658483414845;1101.7851518953887;1117.3686866920164;1151.234429104636;1187.625897842177;1196.4376742930808;17273;17408.564785880455;17435.564110897074;17606.2077206526;17657.55856103582;546480;550077;551480;553234;554060;59142;59663.40336596665;59694.40305596975;59878.70060649669;59880;1252.1172573335778;1256.1960345378964;1305.2951406240713;1329.966750831237;1337.4716986790163;29625.703742962294;33668.83165584156;33957;34134.8293258542;34251.143721406166;50725.492745073556;50780.23829642632;51233.23150152825;51262;51354;396935;398268;398613;398642;400609;23909.16317928864;27697.861510692317;28310.57534137031;28327;28633.28416789597;48738.51261487482;48813.51186488232;49438.258426124354;49645.25532116949;50072.24747133833;41643;42325.36511952385;42523.36214956716;42894.57105428906;43440.56559434365;41549.58450415457;41763.37354939617;42056.369154462096;42111.578884210765;42417.78791106148;42274.577254227064;43018.78490607527;43291;43513.78243108764;43532.56467435285;36147;37295.81352093222;37695.246095078495;37994.81002594969;38018.429723553614;28453.715462845936;29131.85434072816;29145.854270728512;29393.265168370963;29503 10:59:19 INFO - PROCESS | 6864 | |2;jquery.html;385.7569731069426;386.1581751781116;390.5177106273752;401.2636811450987;413.6050072181067;14149.71700565988;16457.588560286;18377.0811459427;19192.23231070759;19195.13621887015;15158.54524364268;17771.91114044428;18476.722849157275;18982.525436864085;19433.902830485862;5667.498113000048;5830.475257226849;5851.561132915027;5871.677057761843;5880.088586269135;4214.136102099063;5812.912806307909;6221.906671399933;6518.380753828379;6521;6520.119783829194;6545.443637290836;6570.342965703439;6600.108985286973;6604.042413850013;6377.872442551146;6513.967430162867;6559.8032059038305;6566.34336566342;6570.540062195648;5496.835094947158;5718.513926316268;5722.227499287585;5757.913631295534;5770.19217309577;22696.319110426713;22832.31503054911;22978;23021.539569208522;23123.190688325994;2340.5552944940405;2349.2482405630035;2415.444447777021;2457.8893949772305;2887.2060183449507;13914.582562523141;14035.71928561423;14193.858061419356;14321.212333321662;14542.054766440253;1920.5390706230544;2006.1173083843062;2015.8689685170416;2042.5506388594486;2067.131804642054;79572;80393.19606803915;80501.59749201217;82252.17747822565;83401;9996.400215987063;10058.547365368577;10138.746531336776;10348.741281468023;10400.58397664085;13874.86125138756;13906.860931390556;13963.860361396459;13966.371513281927;14001.719965600834;7827.1390147083775;8119.309858661962;8195.139510351446;8226.629801658939;8269.173082691683;6970.79087627372;7521.5111017783665;8034.397420193509;8038.035435747748;8286.958565207135;6441.227052753699;6457.773977910751;6488.28628850826;6494.772682956074;6528.21661400635;1846.9076546172907;1894.51689819098;1922.557811703316;1933.265359163509;1956.1099699636916;946.914777670013;949.534727983297;1011.7217765114652;1054.0829478353728;1101.5979167603928;18973.62052758937;19014.42956711301;19247.807521924602;19654.606907861762;19904.905230212476;1006.2704539209161;1026.414943482208;1027.5324727249083;1027.7430642339416;1104.3594715065242;10428.843567346496;11149.944250278697;11188.552457901755;11238.66284011481;11249.43752812356;366448;369859;373800;441093;460020;57401.712991434775;91900.54049729709;97876;98603.50698246463;100642.4967875156;1013.366645846346;1025.4821315235758;1054.857594224785;1055.5988724284875;1059.1791361694748;17334;17345;17606.471805845846;17613.911930440267;17628.82371176323;37457.62542374541;37872.242555148194;38189.2362152761;39825;43317;57182.42817571771;57760.42239577718;60022;60950.695246523486;61037.38962610317;7435.888461672971;8090;8352.958235208785;8617.009043960024;8617.741467755977;11229.775404492028;13378.197308161542;13479.663008424868;13484.190948543119;13900.096493727875;11686.649400517657;11726.530938762695;11795.705107372041;11881.22772019816;12095.939520302341;11671.299722016705;11783.293002419883;11784.941075294568;11792.882071179178;12073.396330183632;11867.465964031466;11887.405629718653;12130.878691212974;12227.266364018187;12259.448324825582;7822.569758663328;7826.843463130819;7868.803279918048;7992.880106798287;8110.918890811253;10597.947010265209;11698.532058717556;11725;11745.941270293593;12221.388930553614 10:59:19 INFO - PROCESS | 6864 | |3;mootools.html;1315.5790147152916;1438.9352479138438;1469.1625773309215;1579.5024567261312;1758.1736583805607;8070.55611941343;8435.493870367774;8437.15628437156;8661.263792577623;8663.090375510576;8449.535275559858;8624.051354351017;8627.13728627137;8630.741077767661;8639.956800216007;2009.2565750672272;2236.865788052714;2296.357020034389;2318.8492747971413;2323.546908352872;2333.4516388648653;2341.1922886604093;2342.074880422232;2342.9648555271683;2346.530693861226;2276.0213108363396;2283.8058765004994;2311.7457079721216;2315.2475445480204;2316.6293393057113;1967.3311074234757;2151.741790985076;2235.429965358839;2243.461569223391;2246.05665620439;2212.7565967743535;2220.289507357646;2234.4860682043222;2234.5084081502205;2237.574860776447;8695.652173913037;8741.344399170024;8744.737657870273;8746;8754.21212090915;4973.254011898208;5029.723365214912;5113.028524580355;5115.897682046339;5119.59043276537;3133.7022982816598;3158.731507821838;3226.3386005868742;3238.6599407062154;3350.71518920892;1112.1603189591888;1179.24528301886;1194.5281613762602;1198.2451055834767;1230.9876901230962;11569.074474042056;11570.07439404854;11575.36335501547;11580.073594112451;11583.710407239801;4436.955630443719;4499.212637788374;4589.151007063704;4596.172688916027;4601.194790911644;9733.853992190123;9741;9752.073553012453;9752.561134748954;9757.36577122499;4990.700557966534;5055.898882022412;5056.747162641853;5059.418166910778;5060.7722652480725;4064.1871625674985;4646.233371493666;4784.784684689197;4785.569298763058;4855.4173499179615;3755.9436608450897;3812.84748610058;3857.5756666766633;3875.922481550353;3920.8235629396177;1209.7096696792707;1211.3156066822394;1211.436681942883;1217.3365515793914;1237.3132911234172;983.6606370802205;985.2905907746411;987.8419452887647;997.2122023601419;1005.3967619428284;5799.797007104731;5856.1508581255475;5970.85072873173;6036.879262414815;6047.334793172748;938.9108034736689;944.3861490031397;962.552413127899;983.7688143286322;1009.9495025248855;4003.7597744135446;4009.8997525062105;4054.3715724062818;4065.2276067547073;4081.9387709184384;10529.36823790575;10749.516271767789;10826.05131076398;10879.238453308351;10880.836787448035;10818.350898946088;10822.621208257673;10824.621138260123;10832.241743078066;10836.620718274822;7693.346065584488;7907.525548467111;7925.762227133196;7965.920340796633;7988.600569971594;6145.617236121837;6256.436920677161;6256.968715156395;6266.749330026931;6316.242050953915;9910.058544438267;9991.800163996533;10229.181665466893;10239.84640230412;10257.538410771383;10271.486425678835;10299.3820370778;10315.845262320921;10351.534180962026;10373.533191006272;6400.199975003125;6604.108445359815;7550.471466997257;7772.84454310922;7931.643076061476;8370.204830541088;8598.355123365647;8691.391602587759;8691.391602588012;8707.390482666406;7469.402447804054;7536.886946695694;7608.657610407434;7675.385969122345;7818.530888146729;7322.597257150908;7460.776176714708;7467.402607791472;7531.472796904383;7682.270184332479;6638.933610664025;6692.498062645223;6695.665216739241;6704;6755.763548275787;4818.445878723992;4957.00859828043;5005.599552035901;5325.547328477122;5355.089634762022;5049.6465247432325;5141.485851414828;5159;5211.374635043819;5275.076861549137 10:59:19 INFO - PROCESS | 6864 | |4;prototype.html;326.88232236394896;328.08627971100475;331.3009549849817;332.4514550990866;332.6291185328359;5233.293505376773;5278.208268759688;5293.629445938776;5305.734713264331;5320.281761962134;5278.6568873023225;5296.735163241842;5307.310049693534;5312.495312945264;5315.335583052119;3687.760295580792;4001.3197756381414;4098.877033688994;4099.73351732138;4101.405296232045;4124.216398884218;4153.314703074005;4155.31437312843;4156.397322388252;4171.687123465737;4090.834112278001;4117.464729585165;4123.546409894909;4123.97938010311;4137.193247316774;3907.4529565860803;3991.600839916014;4086.7139300248996;4102.056526998792;4124.154548317588;3662.3224703429682;3663.1757854482794;3666.3767159582667;3674.2467794102145;3676.191237927652;5120.899006713575;5162.354705661793;5173.456787037382;5186.870328241786;5192.247124167013;4443.5556444355625;4699.412573428322;4721.197396442613;4730.479647238801;4752.287156926454;5513.9448605513835;5542.91685624716;5553.555715542747;5556.249906262643;5572.721363931787;3994.720369574131;4006.4390985262085;4009.1781184857036;4026.5369482509595;4033.556308806029;5634.661920284796;5694.345150307726;5717.942820571824;5798.652080875161;5849.85375365615;4020.4170395292517;4041.696872734498;4045.554988951213;4049.8582549610624;4051.108756073659;4080.1431699342875;4100.466939297932;4101.835926562963;4139.275626765364;4164.43780089684;4554.931676024862;4739.980904105634;4749.810007599726;4782.402199725035;4789.592884604778;5545.334559852843;5550.888982220333;5559.388467268597;5589;5599.664020158803;1401.4604377314806;1416.7662335714697;1416.8441471438134;1417.4401111560876;1421.459845258795;872.2062922740403;893.2675206330747;908.7913075609556;914.4304504342819;919.4069824962861;4789.018251258483;4811.9518804812205;4821.807127714922;4822.324874517571;4822.662413631012;5000.549730632037;5040.924386134137;5048.419431765394;5077.847664570068;5110;4634.694914024562;4663.860084197479;4774.9522504775205;4815.975920120447;4831;2674.8528830914097;2687.25328536449;2693.3535951371923;2697.163879197455;2703.3647092933147;5179.741012949337;5187.948120518822;5237.73811309433;5283.82185458253;5319.973400132974;4783.95216047842;5028.169505203038;5037.743107074516;5115.360579927509;5137.073597400975;5147.588192944556;5210.426853046086;5220.3735551734035;5227;5231.2213847292105;4942.3327850741125;5002.549770520671;5022.874428139326;5030.496950304941;5040.773165207501;4549.476810166873;4931.3096166536;4939.382577177853;5084.618653600921;5108;5117.948820511747;5235.240890070994;5255.842324730264;5281.867953301198;5288.603354748486;3652.3060618483464;3737.1591391937686;3738.887833365003;3755.4366844973474;3756.136088699669;4848.878778030577;5046.426322575439;5089.312942752829;5109.846704598868;5132.281480592795;4884.242942343943;4892.755362231946;4893.363862697826;4901.068796928572;4913;4860.764048537712;4891.413030436371;4896;4947.18371468718;4953;4561.156186105581;4805.8558243252755;4812.181929071996;4817.397825271841;4821.276808478756;4865.07829407375;4896.534829191221;4924.72913989734;4942.851714448572;4976.835076741629;4798;4812.374391329105;4827.624127123753;4878.195037853177;4960.255961605643 10:59:19 INFO - PROCESS | 6864 | |5;yui.html;686.0361192524505;702.1083224305136;751.7782254235003;764.2395816162917;814.4909431605245;15265.236738163088;15898.284577194025;16157.838421615781;16185.676286474263;16207.108609026529;14570.198639074846;14687.853121468783;14693;14694.926525367386;14712.558623241293;672.1228796420669;788.6963519045152;793.817421992942;799;801.1187693537121;799.5522507395848;804.5333706450274;808.2442915873677;808.2523665609317;808.4381354958277;845.3195177881803;846.0820010288844;847.7287268074218;847.9406441549094;848.4654667559429;703.7396163419517;828.3207769628907;837.8324335132937;837.9916200837974;851.4976164063232;618.2426527503771;618.7122987810644;619.3342157181048;619.5446346934999;619.6003577692409;14449.927750361287;14574.70850582993;14575.927120364437;14602.634934126732;14628;13758.380872860746;13854.861451385457;14039.298035098203;14053.929730351283;14127;11906.047516198683;11971;12134.211276267015;12315.75368492625;12521;4280.807363668611;4350.238708226079;4380.321050237187;4486.910261794778;4499.662525310615;71575.64212178958;72021;74223;75410.24589754142;76064.61967690181;10130.290879638502;10311.535980880879;10367.63713270047;10385.740356490996;10506.684799456028;21371.67942480864;21380.786192138192;21394.144234230767;21428.678569821466;21931.12275508994;7985;8040.959795200986;8055.718049868226;8498.532580707997;8733.65065397377;4432.601065904019;4446.9555304447185;4653.604443622262;4693.9765301173275;4861.683990540674;3229.4348489014797;3351.2459696568076;3351.6983471487197;3355.5470011548127;3357.5970883494138;577.6072270855858;587.811900191943;600.7446835095067;636.8726254749068;639.6354078175395;590.8906852232351;651.9706613202417;691.7578847403469;711;723.8516104198732;9641.469719165514;9970.351927124713;9974.401535907724;9983.086260073711;9984.354146151276;574.3366411794384;662.7282814046218;673.9191297044387;715.6099925540593;756.1795451934712;4260.360945858146;4555.180067587866;4588.977055114769;4595.885102872388;4621.09888571732;89268;101906;102771;110935.44532277448;111749.44125279321;91782.54108729414;92317;92879.53560232156;92885.35178316098;93986;81135;81483;81746;82514;83066;8674.436161649473;8893.377463577488;8900.376973612045;8963.193312601898;8976.282949350196;48160;48253.27620085772;49013.754931225114;49019.50980490149;50785.492145078075;63574.36425635684;64547.35452645413;71494;73609.6319518399;74259.25740742523;12045.578404755792;12346.691332716753;12872.356382180666;13138.934305328794;13297.800532992207;14827.703445931236;15058.924705376403;15575.84424155744;15683;15788.60528486797;14306.356213970605;14407.927960360132;14472.710545788814;14888.255587220812;15070.246487675791;13598.11612245201;13813.792793108312;13901.930490347484;13927.58217253484;14210.28948552589;13981.860181398055;14084.859151408355;14175.291235438393;14622.04956677855;14833.777493337824;11477.770444591228;11613.361265130161;11638.185327027028;11706.239094458833;12084.274943503418;11777.352245626573;11861.644150675493;11914;11922.523099076287;12227.633171004883 10:59:19 INFO - PROCESS | 6864 | __end_tp_report 10:59:19 INFO - PROCESS | 6864 | __start_cc_report 10:59:19 INFO - PROCESS | 6864 | _x_x_mozilla_cycle_collect,1157 10:59:19 INFO - PROCESS | 6864 | __end_cc_report 10:59:19 INFO - PROCESS | 6864 | __startTimestamp1465581559051__endTimestamp 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | ------- Summary: start ------- 10:59:19 INFO - PROCESS | 6864 | Number of tests: 6 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | [#0] dojo.html Cycles:165 Average:5301.10 Median:5469.15 stddev:600.69 (11.0%) stddev-sans-first:576.49 10:59:19 INFO - PROCESS | 6864 | Values: 3070.6 3095.9 3096.7 3135.1 3151.2 5151.5 5203.9 5261.6 5348.3 5403.7 5298.9 5316.0 5358.1 5419.7 5450.4 4807.6 4815.9 4838.1 4873.6 4901.5 4982.9 4994.1 4997.3 5001.8 5012.7 4676.9 4696.2 4922.5 4951.5 4975.4 4728.4 4772.5 4778.0 4785.5 4820.3 4747.5 4798.5 4826.0 4828.2 4870.5 5169.4 5226.4 5303.5 5335.0 5357.6 5657.7 5768.7 5772.4 5774.7 5775.0 5728.4 5736.9 5793.9 5798.5 5815.9 5251.7 5300.2 5354.1 5394.3 5398.8 5869.1 5889.4 5889.5 5893.7 5897.2 5619.6 5620.4 5666.8 5668.9 5678.1 5564.7 5655.4 5688.3 5699.6 5712.0 5713.2 5715.8 5716.4 5721.9 5722.3 5715.5 5725.3 5726.1 5731.9 5731.9 4304.2 4324.4 4352.3 4362.1 4390.1 3924.4 3943.8 3946.2 3980.0 3985.4 5413.5 5452.9 5465.9 5469.2 5469.5 5586.4 5606.6 5629.9 5668.9 5693.8 5325.1 5366.8 5366.9 5369.6 5405.9 4724.2 4928.0 4940.4 4946.3 4989.3 5893.8 5952.5 5974.9 5990.6 6013.7 5752.9 5763.3 5765.5 5766.6 5770.2 5670.1 5780.0 5994.7 6006.2 6013.5 5541.7 5604.0 5609.6 5613.1 5662.3 5698.6 5702.9 5714.4 5714.5 5719.0 5404.9 5541.1 5576.4 5579.0 5584.4 5571.4 5579.2 5579.5 5581.2 5621.8 5399.8 5404.1 5443.4 5446.3 5507.7 5365.5 5510.9 5572.7 5617.7 5692.2 5227.5 5255.1 5467.6 5496.3 5524.6 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | [#1] ext.html Cycles:180 Average:58767.98 Median:37307.13 stddev:116470.21 (312.2%) stddev-sans-first:116714.93 10:59:19 INFO - PROCESS | 6864 | Values: 557.5 599.5 619.6 620.2 635.1 30488.8 42527.0 43363.3 43365.9 43416.6 44216.0 44734.0 44800.3 44801.3 44829.1 7993.8 8956.6 9116.6 10551.8 10892.1 10807.0 10816.9 10907.6 10916.7 10923.0 10944.4 10991.1 10991.8 10996.3 10997.7 8161.5 10716.0 10921.5 10953.0 10953.2 10401.8 10516.5 10520.5 10890.9 10894.9 42608.4 42882.0 43196.8 43242.8 43266.4 3473.3 3757.2 4069.7 4118.5 4217.0 32848.2 33226.8 33303.2 33486.0 33674.7 4305.3 4417.5 4417.6 4445.3 4513.5 337886.0 338942.0 339322.0 340518.3 340569.0 35584.8 63706.7 64153.4 64157.4 64310.4 37318.4 37326.8 37330.6 37355.4 37402.3 13397.1 15386.5 15462.0 15597.6 15644.9 11432.1 11641.6 11649.8 12078.0 12188.3 8353.9 8363.8 8391.2 8405.6 8459.1 3291.9 3301.5 3329.8 3335.8 3348.1 1021.7 1047.7 1136.2 1144.5 1156.9 32870.0 33132.8 33388.0 33479.8 34151.7 1101.8 1117.4 1151.2 1187.6 1196.4 17273.0 17408.6 17435.6 17606.2 17657.6 546480.0 550077.0 551480.0 553234.0 554060.0 59142.0 59663.4 59694.4 59878.7 59880.0 1252.1 1256.2 1305.3 1330.0 1337.5 29625.7 33668.8 33957.0 34134.8 34251.1 50725.5 50780.2 51233.2 51262.0 51354.0 396935.0 398268.0 398613.0 398642.0 400609.0 23909.2 27697.9 28310.6 28327.0 28633.3 48738.5 48813.5 49438.3 49645.3 50072.2 41643.0 42325.4 42523.4 42894.6 43440.6 41549.6 41763.4 42056.4 42111.6 42417.8 42274.6 43018.8 43291.0 43513.8 43532.6 36147.0 37295.8 37695.2 37994.8 38018.4 28453.7 29131.9 29145.9 29393.3 29503.0 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | [#2] jquery.html Cycles:180 Average:26538.94 Median:22999.77 stddev:67197.97 (292.2%) stddev-sans-first:67357.79 10:59:19 INFO - PROCESS | 6864 | Values: 385.8 386.2 390.5 401.3 413.6 14149.7 16457.6 18377.1 19192.2 19195.1 15158.5 17771.9 18476.7 18982.5 19433.9 5667.5 5830.5 5851.6 5871.7 5880.1 4214.1 5812.9 6221.9 6518.4 6521.0 6520.1 6545.4 6570.3 6600.1 6604.0 6377.9 6514.0 6559.8 6566.3 6570.5 5496.8 5718.5 5722.2 5757.9 5770.2 22696.3 22832.3 22978.0 23021.5 23123.2 2340.6 2349.2 2415.4 2457.9 2887.2 13914.6 14035.7 14193.9 14321.2 14542.1 1920.5 2006.1 2015.9 2042.6 2067.1 79572.0 80393.2 80501.6 82252.2 83401.0 9996.4 10058.5 10138.7 10348.7 10400.6 13874.9 13906.9 13963.9 13966.4 14001.7 7827.1 8119.3 8195.1 8226.6 8269.2 6970.8 7521.5 8034.4 8038.0 8287.0 6441.2 6457.8 6488.3 6494.8 6528.2 1846.9 1894.5 1922.6 1933.3 1956.1 946.9 949.5 1011.7 1054.1 1101.6 18973.6 19014.4 19247.8 19654.6 19904.9 1006.3 1026.4 1027.5 1027.7 1104.4 10428.8 11149.9 11188.6 11238.7 11249.4 366448.0 369859.0 373800.0 441093.0 460020.0 57401.7 91900.5 97876.0 98603.5 100642.5 1013.4 1025.5 1054.9 1055.6 1059.2 17334.0 17345.0 17606.5 17613.9 17628.8 37457.6 37872.2 38189.2 39825.0 43317.0 57182.4 57760.4 60022.0 60950.7 61037.4 7435.9 8090.0 8353.0 8617.0 8617.7 11229.8 13378.2 13479.7 13484.2 13900.1 11686.6 11726.5 11795.7 11881.2 12095.9 11671.3 11783.3 11784.9 11792.9 12073.4 11867.5 11887.4 12130.9 12227.3 12259.4 7822.6 7826.8 7868.8 7992.9 8110.9 10597.9 11698.5 11725.0 11745.9 12221.4 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | [#3] mootools.html Cycles:180 Average:5686.71 Median:4906.21 stddev:3223.61 (65.7%) stddev-sans-first:3215.91 10:59:19 INFO - PROCESS | 6864 | Values: 1315.6 1438.9 1469.2 1579.5 1758.2 8070.6 8435.5 8437.2 8661.3 8663.1 8449.5 8624.1 8627.1 8630.7 8640.0 2009.3 2236.9 2296.4 2318.8 2323.5 2333.5 2341.2 2342.1 2343.0 2346.5 2276.0 2283.8 2311.7 2315.2 2316.6 1967.3 2151.7 2235.4 2243.5 2246.1 2212.8 2220.3 2234.5 2234.5 2237.6 8695.7 8741.3 8744.7 8746.0 8754.2 4973.3 5029.7 5113.0 5115.9 5119.6 3133.7 3158.7 3226.3 3238.7 3350.7 1112.2 1179.2 1194.5 1198.2 1231.0 11569.1 11570.1 11575.4 11580.1 11583.7 4437.0 4499.2 4589.2 4596.2 4601.2 9733.9 9741.0 9752.1 9752.6 9757.4 4990.7 5055.9 5056.7 5059.4 5060.8 4064.2 4646.2 4784.8 4785.6 4855.4 3755.9 3812.8 3857.6 3875.9 3920.8 1209.7 1211.3 1211.4 1217.3 1237.3 983.7 985.3 987.8 997.2 1005.4 5799.8 5856.2 5970.9 6036.9 6047.3 938.9 944.4 962.6 983.8 1009.9 4003.8 4009.9 4054.4 4065.2 4081.9 10529.4 10749.5 10826.1 10879.2 10880.8 10818.4 10822.6 10824.6 10832.2 10836.6 7693.3 7907.5 7925.8 7965.9 7988.6 6145.6 6256.4 6257.0 6266.7 6316.2 9910.1 9991.8 10229.2 10239.8 10257.5 10271.5 10299.4 10315.8 10351.5 10373.5 6400.2 6604.1 7550.5 7772.8 7931.6 8370.2 8598.4 8691.4 8691.4 8707.4 7469.4 7536.9 7608.7 7675.4 7818.5 7322.6 7460.8 7467.4 7531.5 7682.3 6638.9 6692.5 6695.7 6704.0 6755.8 4818.4 4957.0 5005.6 5325.5 5355.1 5049.6 5141.5 5159.0 5211.4 5275.1 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | [#4] prototype.html Cycles:180 Average:4385.10 Median:4854.82 stddev:1236.61 (25.5%) stddev-sans-first:1201.98 10:59:19 INFO - PROCESS | 6864 | Values: 326.9 328.1 331.3 332.5 332.6 5233.3 5278.2 5293.6 5305.7 5320.3 5278.7 5296.7 5307.3 5312.5 5315.3 3687.8 4001.3 4098.9 4099.7 4101.4 4124.2 4153.3 4155.3 4156.4 4171.7 4090.8 4117.5 4123.5 4124.0 4137.2 3907.5 3991.6 4086.7 4102.1 4124.2 3662.3 3663.2 3666.4 3674.2 3676.2 5120.9 5162.4 5173.5 5186.9 5192.2 4443.6 4699.4 4721.2 4730.5 4752.3 5513.9 5542.9 5553.6 5556.2 5572.7 3994.7 4006.4 4009.2 4026.5 4033.6 5634.7 5694.3 5717.9 5798.7 5849.9 4020.4 4041.7 4045.6 4049.9 4051.1 4080.1 4100.5 4101.8 4139.3 4164.4 4554.9 4740.0 4749.8 4782.4 4789.6 5545.3 5550.9 5559.4 5589.0 5599.7 1401.5 1416.8 1416.8 1417.4 1421.5 872.2 893.3 908.8 914.4 919.4 4789.0 4812.0 4821.8 4822.3 4822.7 5000.5 5040.9 5048.4 5077.8 5110.0 4634.7 4663.9 4775.0 4816.0 4831.0 2674.9 2687.3 2693.4 2697.2 2703.4 5179.7 5187.9 5237.7 5283.8 5320.0 4784.0 5028.2 5037.7 5115.4 5137.1 5147.6 5210.4 5220.4 5227.0 5231.2 4942.3 5002.5 5022.9 5030.5 5040.8 4549.5 4931.3 4939.4 5084.6 5108.0 5117.9 5235.2 5255.8 5281.9 5288.6 3652.3 3737.2 3738.9 3755.4 3756.1 4848.9 5046.4 5089.3 5109.8 5132.3 4884.2 4892.8 4893.4 4901.1 4913.0 4860.8 4891.4 4896.0 4947.2 4953.0 4561.2 4805.9 4812.2 4817.4 4821.3 4865.1 4896.5 4924.7 4942.9 4976.8 4798.0 4812.4 4827.6 4878.2 4960.3 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - PROCESS | 6864 | [#5] yui.html Cycles:180 Average:19965.55 Median:4637.35 stddev:27788.64 (599.2%) stddev-sans-first:27828.89 10:59:19 INFO - PROCESS | 6864 | Values: 686.0 702.1 751.8 764.2 814.5 15265.2 15898.3 16157.8 16185.7 16207.1 14570.2 14687.9 14693.0 14694.9 14712.6 672.1 788.7 793.8 799.0 801.1 799.6 804.5 808.2 808.3 808.4 845.3 846.1 847.7 847.9 848.5 703.7 828.3 837.8 838.0 851.5 618.2 618.7 619.3 619.5 619.6 14449.9 14574.7 14575.9 14602.6 14628.0 13758.4 13854.9 14039.3 14053.9 14127.0 11906.0 11971.0 12134.2 12315.8 12521.0 4280.8 4350.2 4380.3 4486.9 4499.7 71575.6 72021.0 74223.0 75410.2 76064.6 10130.3 10311.5 10367.6 10385.7 10506.7 21371.7 21380.8 21394.1 21428.7 21931.1 7985.0 8041.0 8055.7 8498.5 8733.7 4432.6 4447.0 4653.6 4694.0 4861.7 3229.4 3351.2 3351.7 3355.5 3357.6 577.6 587.8 600.7 636.9 639.6 590.9 652.0 691.8 711.0 723.9 9641.5 9970.4 9974.4 9983.1 9984.4 574.3 662.7 673.9 715.6 756.2 4260.4 4555.2 4589.0 4595.9 4621.1 89268.0 101906.0 102771.0 110935.4 111749.4 91782.5 92317.0 92879.5 92885.4 93986.0 81135.0 81483.0 81746.0 82514.0 83066.0 8674.4 8893.4 8900.4 8963.2 8976.3 48160.0 48253.3 49013.8 49019.5 50785.5 63574.4 64547.4 71494.0 73609.6 74259.3 12045.6 12346.7 12872.4 13138.9 13297.8 14827.7 15058.9 15575.8 15683.0 15788.6 14306.4 14407.9 14472.7 14888.3 15070.2 13598.1 13813.8 13901.9 13927.6 14210.3 13981.9 14084.9 14175.3 14622.0 14833.8 11477.8 11613.4 11638.2 11706.2 12084.3 11777.4 11861.6 11914.0 11922.5 12227.6 10:59:19 INFO - PROCESS | 6864 | -------- Summary: end -------- 10:59:19 INFO - PROCESS | 6864 | 10:59:19 INFO - TEST-INFO | 6864: exit 0 10:59:19 INFO - TEST-OK | dromaeo_css | took 1113587ms 10:59:19 INFO - TEST-START | kraken 10:59:19 INFO - operating with platform_type : linux_ 10:59:19 INFO - Initialising browser for kraken test... 10:59:19 INFO - TEST-INFO | started process 7049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_XqSq6/profile http://localhost:37664/getInfo.html) 10:59:23 INFO - PROCESS | 7049 | __metrics Screen width/height:1600/1200 10:59:23 INFO - PROCESS | 7049 | colorDepth:24 10:59:23 INFO - PROCESS | 7049 | Browser inner width/height: 1024/697 10:59:23 INFO - PROCESS | 7049 | __metrics 10:59:24 ERROR - PROCESS | 7049 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:59:24 INFO - PROCESS | 7049 | console.error: PushService: 10:59:24 INFO - PROCESS | 7049 | stateChangeProcessEnqueue: Error transitioning state 10:59:24 INFO - PROCESS | 7049 | UnknownError 10:59:25 INFO - TEST-INFO | 7049: exit 0 10:59:25 INFO - Browser initialized. 10:59:25 INFO - Running cycle 1/1 for kraken test... 10:59:25 INFO - TEST-INFO | started process 7129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_XqSq6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:37 INFO - PROCESS | 7129 | RSS: Main: 174358528 10:59:37 INFO - PROCESS | 7129 | 10:59:40 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-beat-detection) 10:59:41 INFO - PROCESS | 7129 | RSS: Main: 232398848 10:59:41 INFO - PROCESS | 7129 | 10:59:43 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-dft) 10:59:44 INFO - PROCESS | 7129 | RSS: Main: 220897280 10:59:44 INFO - PROCESS | 7129 | 10:59:47 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-fft) 10:59:48 INFO - PROCESS | 7129 | RSS: Main: 286486528 10:59:48 INFO - PROCESS | 7129 | 10:59:50 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37664/tests/kraken/driver.html?testName=audio-oscillator) 10:59:50 INFO - PROCESS | 7129 | RSS: Main: 196993024 10:59:50 INFO - PROCESS | 7129 | 10:59:53 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:59:53 INFO - PROCESS | 7129 | RSS: Main: 200966144 10:59:53 INFO - PROCESS | 7129 | 10:59:56 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37664/tests/kraken/driver.html?testName=imaging-darkroom) 10:59:57 INFO - PROCESS | 7129 | RSS: Main: 236781568 10:59:57 INFO - PROCESS | 7129 | 11:00:00 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37664/tests/kraken/driver.html?testName=imaging-desaturate) 11:00:01 INFO - PROCESS | 7129 | RSS: Main: 237105152 11:00:01 INFO - PROCESS | 7129 | 11:00:04 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37664/tests/kraken/driver.html?testName=json-parse-financial) 11:00:04 INFO - PROCESS | 7129 | RSS: Main: 237793280 11:00:04 INFO - PROCESS | 7129 | 11:00:06 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:00:06 INFO - PROCESS | 7129 | RSS: Main: 221343744 11:00:06 INFO - PROCESS | 7129 | 11:00:08 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:00:09 INFO - PROCESS | 7129 | RSS: Main: 225636352 11:00:09 INFO - PROCESS | 7129 | 11:00:11 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:00:11 INFO - PROCESS | 7129 | RSS: Main: 235065344 11:00:11 INFO - PROCESS | 7129 | 11:00:14 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:00:15 INFO - PROCESS | 7129 | RSS: Main: 239652864 11:00:15 INFO - PROCESS | 7129 | 11:00:17 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:00:18 INFO - PROCESS | 7129 | RSS: Main: 240091136 11:00:18 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | Cycle 1(1): loaded http://localhost:37664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37664/tests/kraken/driver.html?testName=ai-astar) 11:00:20 INFO - PROCESS | 7129 | RSS: Main: 283275264 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | __start_tp_report 11:00:20 INFO - PROCESS | 7129 | _x_x_mozilla_page_load 11:00:20 INFO - PROCESS | 7129 | _x_x_mozilla_page_load_details 11:00:20 INFO - PROCESS | 7129 | |i|pagename|runs| 11:00:20 INFO - PROCESS | 7129 | |0;ai-astar;113;105;110;111;111;114;112;111;111;110 11:00:20 INFO - PROCESS | 7129 | |1;audio-beat-detection;150;126;127;185;133;135;162;134;158;132 11:00:20 INFO - PROCESS | 7129 | |2;audio-dft;160;160;161;161;162;164;163;164;162;161 11:00:20 INFO - PROCESS | 7129 | |3;audio-fft;74;74;76;122;76;75;75;76;100;75 11:00:20 INFO - PROCESS | 7129 | |4;audio-oscillator;85;85;110;86;87;85;119;84;85;130 11:00:20 INFO - PROCESS | 7129 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;127;116;116 11:00:20 INFO - PROCESS | 7129 | |6;imaging-darkroom;146;147;147;145;145;146;145;146;146;146 11:00:20 INFO - PROCESS | 7129 | |7;imaging-desaturate;96;97;95;95;95;96;96;95;94;95 11:00:20 INFO - PROCESS | 7129 | |8;json-parse-financial;53;52;52;53;53;53;52;53;53;53 11:00:20 INFO - PROCESS | 7129 | |9;json-stringify-tinderbox;62;63;62;62;62;63;62;63;62;62 11:00:20 INFO - PROCESS | 7129 | |10;stanford-crypto-aes;85;80;79;84;86;80;81;80;136;80 11:00:20 INFO - PROCESS | 7129 | |11;stanford-crypto-ccm;126;121;132;130;119;119;117;122;134;131 11:00:20 INFO - PROCESS | 7129 | |12;stanford-crypto-pbkdf2;169;163;163;169;159;161;160;163;161;158 11:00:20 INFO - PROCESS | 7129 | |13;stanford-crypto-sha256-iterative;63;64;64;62;64;63;63;63;63;63 11:00:20 INFO - PROCESS | 7129 | __end_tp_report 11:00:20 INFO - PROCESS | 7129 | __start_cc_report 11:00:20 INFO - PROCESS | 7129 | _x_x_mozilla_cycle_collect,1641 11:00:20 INFO - PROCESS | 7129 | __end_cc_report 11:00:20 INFO - PROCESS | 7129 | __startTimestamp1465581620267__endTimestamp 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | ------- Summary: start ------- 11:00:20 INFO - PROCESS | 7129 | Number of tests: 14 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.39 (2.2%) stddev-sans-first:2.40 11:00:20 INFO - PROCESS | 7129 | Values: 113.0 105.0 110.0 111.0 111.0 114.0 112.0 111.0 111.0 110.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:142.50 stddev:19.14 (13.4%) stddev-sans-first:20.18 11:00:20 INFO - PROCESS | 7129 | Values: 150.0 126.0 127.0 185.0 133.0 135.0 162.0 134.0 158.0 132.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.41 11:00:20 INFO - PROCESS | 7129 | Values: 160.0 160.0 161.0 161.0 162.0 164.0 163.0 164.0 162.0 161.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:16.01 (21.3%) stddev-sans-first:16.69 11:00:20 INFO - PROCESS | 7129 | Values: 74.0 74.0 76.0 122.0 76.0 75.0 75.0 76.0 100.0 75.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.00 stddev:17.28 (20.3%) stddev-sans-first:17.90 11:00:20 INFO - PROCESS | 7129 | Values: 85.0 85.0 110.0 86.0 87.0 85.0 119.0 84.0 85.0 130.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:3.34 (2.9%) stddev-sans-first:3.54 11:00:20 INFO - PROCESS | 7129 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 127.0 116.0 116.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:00:20 INFO - PROCESS | 7129 | Values: 146.0 147.0 147.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 11:00:20 INFO - PROCESS | 7129 | Values: 96.0 97.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 95.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 11:00:20 INFO - PROCESS | 7129 | Values: 53.0 52.0 52.0 53.0 53.0 53.0 52.0 53.0 53.0 53.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 11:00:20 INFO - PROCESS | 7129 | Values: 62.0 63.0 62.0 62.0 62.0 63.0 62.0 63.0 62.0 62.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:80.50 stddev:17.36 (21.6%) stddev-sans-first:18.39 11:00:20 INFO - PROCESS | 7129 | Values: 85.0 80.0 79.0 84.0 86.0 80.0 81.0 80.0 136.0 80.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:128.00 stddev:6.26 (4.9%) stddev-sans-first:6.63 11:00:20 INFO - PROCESS | 7129 | Values: 126.0 121.0 132.0 130.0 119.0 119.0 117.0 122.0 134.0 131.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:163.00 stddev:3.78 (2.3%) stddev-sans-first:3.22 11:00:20 INFO - PROCESS | 7129 | Values: 169.0 163.0 163.0 169.0 159.0 161.0 160.0 163.0 161.0 158.0 11:00:20 INFO - PROCESS | 7129 | 11:00:20 INFO - PROCESS | 7129 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 11:00:20 INFO - PROCESS | 7129 | Values: 63.0 64.0 64.0 62.0 64.0 63.0 63.0 63.0 63.0 63.0 11:00:20 INFO - PROCESS | 7129 | -------- Summary: end -------- 11:00:20 INFO - PROCESS | 7129 | 11:00:21 INFO - TEST-INFO | 7129: exit 0 11:00:21 INFO - TEST-OK | kraken | took 61558ms 11:00:21 INFO - SUITE-END | took 1175s 11:00:21 INFO - Completed test suite (00:19:35) 11:00:21 INFO - javascript benchmark 11:00:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.6008218931534, 3095.9071227863174, 3096.721295083442, 3135.0594821553527, 3151.2279491524578, 5151.510606492387, 5203.947960520393, 5261.631685781992, 5348.277982472365, 5403.702796346204, 5298.947010529893, 5316.0, 5358.142697168444, 5419.674819510832, 5450.373207081187, 4807.61539076873, 4815.855524334258, 4838.129136755382, 4873.610111191105, 4901.460839307673, 4982.850514484571, 4994.051130285252, 4997.30037794709, 5001.8499445016705, 5012.699238045729, 4676.859694209145, 4696.248600223982, 4922.532359425849, 4951.529604687549, 4975.402951645808, 4728.432588089417, 4772.49888761682, 4777.976110119462, 4785.497522760095, 4820.276958456259, 4747.477777444478, 4798.47216806151, 4825.95174048262, 4828.203346447832, 4870.537298956629, 5169.353830771153, 5226.372835259755, 5303.5226829585135, 5335.013022590794, 5357.624966252364, 5657.660540367591, 5768.711564421762, 5772.3938986406665, 5774.653520788766, 5775.018246897996, 5728.369879313273, 5736.942630573682, 5793.884122317572, 5798.5071268941765, 5815.883682326372, 5251.711155886424, 5300.178472336794, 5354.143337066129, 5394.271773310592, 5398.838034858961, 5869.06095024794, 5889.381614930457, 5889.469947704727, 5893.705314734246, 5897.2333596633025, 5619.578531610146, 5620.381758006616, 5666.829995100154, 5668.943310566924, 5678.0915053591225, 5564.721763911869, 5655.3779084300695, 5688.288963879515, 5699.572532060112, 5712.0, 5713.171590119409, 5715.828525144252, 5716.399778023248, 5721.942780572224, 5722.341930677942, 5715.514181294553, 5725.31296244445, 5726.112452569775, 5731.856703582361, 5731.914021289684, 4304.203722311382, 4324.3513472978675, 4352.325389564622, 4362.105768317488, 4390.05613793036, 3924.4309575111447, 3943.802809859553, 3946.1515774108702, 3980.0, 3985.4221137934837, 5413.539849112791, 5452.890942181134, 5465.863353416196, 5469.15228139639, 5469.535089517356, 5586.385497595261, 5606.55147588192, 5629.887402252014, 5668.858278542987, 5693.800716974886, 5325.068113080196, 5366.7853285868905, 5366.892662146814, 5369.570434365241, 5405.945940540623, 4724.173269677862, 4928.0, 4940.382452193476, 4946.282788995575, 4989.301497790239, 5893.793717219876, 5952.523798096142, 5974.910376344358, 5990.64056156632, 6013.669248191304, 5752.942470575241, 5763.33721622002, 5765.4811067004175, 5766.5675074368755, 5770.221020162225, 5670.092785154356, 5779.971100144472, 5994.700264986646, 6006.189164462741, 6013.548983826318, 5541.695206763667, 5604.047311956896, 5609.551235901036, 5613.101903695552, 5662.2639056922335, 5698.629589076697, 5702.942970570241, 5714.371419143974, 5714.457126572969, 5719.0277652798295, 5404.918926216189, 5541.141123125922, 5576.358718747396, 5579.0, 5584.3857175711455, 5571.359293681278, 5579.246801681721, 5579.525740312119, 5581.162825576033, 5621.775128994795, 5399.78400863961, 5404.054290499225, 5443.374011988672, 5446.346438427414, 5507.697076660662, 5365.543928766098, 5510.91733624004, 5572.721363931868, 5617.719114044363, 5692.174634678031, 5227.529522343008, 5255.13290307095, 5467.644603100785, 5496.285482887199, 5524.613277070566], "value": 5261.054983876184, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.548385807496, 599.52637416441, 619.5972617798432, 620.2340109964193, 635.072793721167, 30488.84755576222, 42527.0, 43363.34954975678, 43365.88024137706, 43416.56583434164, 44216.0, 44734.0, 44800.32799508002, 44801.32798008024, 44829.10341793162, 7993.800154996114, 8956.641734330635, 9116.635334586608, 10551.78896422071, 10892.074173695246, 10807.0, 10816.945915270451, 10907.618233361834, 10916.727081822939, 10923.0, 10944.3980581068, 10991.06575941046, 10991.835122473169, 10996.340219586851, 10997.670069897877, 8161.510309381427, 10716.0, 10921.508532115995, 10952.959468850446, 10953.233273670847, 10401.79196416075, 10516.526756295985, 10520.526576304084, 10890.891091089066, 10894.945525272402, 42608.36087458659, 42882.0, 43196.78401607972, 43242.783786081185, 43266.351004734955, 3473.2532505511435, 3757.1734218471893, 4069.7354671946227, 4118.5057793064725, 4217.0, 32848.17879553006, 33226.833865830515, 33303.16742081443, 33486.0, 33674.6632533674, 4305.3128233564175, 4417.536158703322, 4417.646588272931, 4445.266531022377, 4513.50351461339, 337886.0, 338942.0, 339322.0, 340518.29740851384, 340569.0, 35584.82207588945, 63706.681466592374, 64153.35846641567, 64157.358426416075, 64310.356896431374, 37318.44022339667, 37326.813365933, 37330.626693733255, 37355.43966840499, 37402.251954960746, 13397.129186603035, 15386.461473848361, 15462.0, 15597.610059748597, 15644.92177539105, 11432.142589305835, 11641.59254426091, 11649.825252621218, 12078.033757299396, 12188.329641869783, 8353.916460835435, 8363.83272334562, 8391.202835730595, 8405.621747021398, 8459.111793261618, 3291.8683252670103, 3301.5047742838765, 3329.8002119872885, 3335.832458639457, 3348.1462227131924, 1021.7241344836852, 1047.6752206815759, 1136.198979719296, 1144.513581727779, 1156.9016633586239, 32870.0, 33132.83433582865, 33388.0, 33479.83260083684, 34151.658483414845, 1101.7851518953887, 1117.3686866920164, 1151.234429104636, 1187.625897842177, 1196.4376742930808, 17273.0, 17408.564785880455, 17435.564110897074, 17606.2077206526, 17657.55856103582, 546480.0, 550077.0, 551480.0, 553234.0, 554060.0, 59142.0, 59663.40336596665, 59694.40305596975, 59878.70060649669, 59880.0, 1252.1172573335778, 1256.1960345378964, 1305.2951406240713, 1329.966750831237, 1337.4716986790163, 29625.703742962294, 33668.83165584156, 33957.0, 34134.8293258542, 34251.143721406166, 50725.492745073556, 50780.23829642632, 51233.23150152825, 51262.0, 51354.0, 396935.0, 398268.0, 398613.0, 398642.0, 400609.0, 23909.16317928864, 27697.861510692317, 28310.57534137031, 28327.0, 28633.28416789597, 48738.51261487482, 48813.51186488232, 49438.258426124354, 49645.25532116949, 50072.24747133833, 41643.0, 42325.36511952385, 42523.36214956716, 42894.57105428906, 43440.56559434365, 41549.58450415457, 41763.37354939617, 42056.369154462096, 42111.578884210765, 42417.78791106148, 42274.577254227064, 43018.78490607527, 43291.0, 43513.78243108764, 43532.56467435285, 36147.0, 37295.81352093222, 37695.246095078495, 37994.81002594969, 38018.429723553614, 28453.715462845936, 29131.85434072816, 29145.854270728512, 29393.265168370963, 29503.0], "value": 19553.54015578081, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7569731069426, 386.1581751781116, 390.5177106273752, 401.2636811450987, 413.6050072181067, 14149.71700565988, 16457.588560286, 18377.0811459427, 19192.23231070759, 19195.13621887015, 15158.54524364268, 17771.91114044428, 18476.722849157275, 18982.525436864085, 19433.902830485862, 5667.498113000048, 5830.475257226849, 5851.561132915027, 5871.677057761843, 5880.088586269135, 4214.136102099063, 5812.912806307909, 6221.906671399933, 6518.380753828379, 6521.0, 6520.119783829194, 6545.443637290836, 6570.342965703439, 6600.108985286973, 6604.042413850013, 6377.872442551146, 6513.967430162867, 6559.8032059038305, 6566.34336566342, 6570.540062195648, 5496.835094947158, 5718.513926316268, 5722.227499287585, 5757.913631295534, 5770.19217309577, 22696.319110426713, 22832.31503054911, 22978.0, 23021.539569208522, 23123.190688325994, 2340.5552944940405, 2349.2482405630035, 2415.444447777021, 2457.8893949772305, 2887.2060183449507, 13914.582562523141, 14035.71928561423, 14193.858061419356, 14321.212333321662, 14542.054766440253, 1920.5390706230544, 2006.1173083843062, 2015.8689685170416, 2042.5506388594486, 2067.131804642054, 79572.0, 80393.19606803915, 80501.59749201217, 82252.17747822565, 83401.0, 9996.400215987063, 10058.547365368577, 10138.746531336776, 10348.741281468023, 10400.58397664085, 13874.86125138756, 13906.860931390556, 13963.860361396459, 13966.371513281927, 14001.719965600834, 7827.1390147083775, 8119.309858661962, 8195.139510351446, 8226.629801658939, 8269.173082691683, 6970.79087627372, 7521.5111017783665, 8034.397420193509, 8038.035435747748, 8286.958565207135, 6441.227052753699, 6457.773977910751, 6488.28628850826, 6494.772682956074, 6528.21661400635, 1846.9076546172907, 1894.51689819098, 1922.557811703316, 1933.265359163509, 1956.1099699636916, 946.914777670013, 949.534727983297, 1011.7217765114652, 1054.0829478353728, 1101.5979167603928, 18973.62052758937, 19014.42956711301, 19247.807521924602, 19654.606907861762, 19904.905230212476, 1006.2704539209161, 1026.414943482208, 1027.5324727249083, 1027.7430642339416, 1104.3594715065242, 10428.843567346496, 11149.944250278697, 11188.552457901755, 11238.66284011481, 11249.43752812356, 366448.0, 369859.0, 373800.0, 441093.0, 460020.0, 57401.712991434775, 91900.54049729709, 97876.0, 98603.50698246463, 100642.4967875156, 1013.366645846346, 1025.4821315235758, 1054.857594224785, 1055.5988724284875, 1059.1791361694748, 17334.0, 17345.0, 17606.471805845846, 17613.911930440267, 17628.82371176323, 37457.62542374541, 37872.242555148194, 38189.2362152761, 39825.0, 43317.0, 57182.42817571771, 57760.42239577718, 60022.0, 60950.695246523486, 61037.38962610317, 7435.888461672971, 8090.0, 8352.958235208785, 8617.009043960024, 8617.741467755977, 11229.775404492028, 13378.197308161542, 13479.663008424868, 13484.190948543119, 13900.096493727875, 11686.649400517657, 11726.530938762695, 11795.705107372041, 11881.22772019816, 12095.939520302341, 11671.299722016705, 11783.293002419883, 11784.941075294568, 11792.882071179178, 12073.396330183632, 11867.465964031466, 11887.405629718653, 12130.878691212974, 12227.266364018187, 12259.448324825582, 7822.569758663328, 7826.843463130819, 7868.803279918048, 7992.880106798287, 8110.918890811253, 10597.947010265209, 11698.532058717556, 11725.0, 11745.941270293593, 12221.388930553614], "value": 9346.664194516403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.5790147152916, 1438.9352479138438, 1469.1625773309215, 1579.5024567261312, 1758.1736583805607, 8070.55611941343, 8435.493870367774, 8437.15628437156, 8661.263792577623, 8663.090375510576, 8449.535275559858, 8624.051354351017, 8627.13728627137, 8630.741077767661, 8639.956800216007, 2009.2565750672272, 2236.865788052714, 2296.357020034389, 2318.8492747971413, 2323.546908352872, 2333.4516388648653, 2341.1922886604093, 2342.074880422232, 2342.9648555271683, 2346.530693861226, 2276.0213108363396, 2283.8058765004994, 2311.7457079721216, 2315.2475445480204, 2316.6293393057113, 1967.3311074234757, 2151.741790985076, 2235.429965358839, 2243.461569223391, 2246.05665620439, 2212.7565967743535, 2220.289507357646, 2234.4860682043222, 2234.5084081502205, 2237.574860776447, 8695.652173913037, 8741.344399170024, 8744.737657870273, 8746.0, 8754.21212090915, 4973.254011898208, 5029.723365214912, 5113.028524580355, 5115.897682046339, 5119.59043276537, 3133.7022982816598, 3158.731507821838, 3226.3386005868742, 3238.6599407062154, 3350.71518920892, 1112.1603189591888, 1179.24528301886, 1194.5281613762602, 1198.2451055834767, 1230.9876901230962, 11569.074474042056, 11570.07439404854, 11575.36335501547, 11580.073594112451, 11583.710407239801, 4436.955630443719, 4499.212637788374, 4589.151007063704, 4596.172688916027, 4601.194790911644, 9733.853992190123, 9741.0, 9752.073553012453, 9752.561134748954, 9757.36577122499, 4990.700557966534, 5055.898882022412, 5056.747162641853, 5059.418166910778, 5060.7722652480725, 4064.1871625674985, 4646.233371493666, 4784.784684689197, 4785.569298763058, 4855.4173499179615, 3755.9436608450897, 3812.84748610058, 3857.5756666766633, 3875.922481550353, 3920.8235629396177, 1209.7096696792707, 1211.3156066822394, 1211.436681942883, 1217.3365515793914, 1237.3132911234172, 983.6606370802205, 985.2905907746411, 987.8419452887647, 997.2122023601419, 1005.3967619428284, 5799.797007104731, 5856.1508581255475, 5970.85072873173, 6036.879262414815, 6047.334793172748, 938.9108034736689, 944.3861490031397, 962.552413127899, 983.7688143286322, 1009.9495025248855, 4003.7597744135446, 4009.8997525062105, 4054.3715724062818, 4065.2276067547073, 4081.9387709184384, 10529.36823790575, 10749.516271767789, 10826.05131076398, 10879.238453308351, 10880.836787448035, 10818.350898946088, 10822.621208257673, 10824.621138260123, 10832.241743078066, 10836.620718274822, 7693.346065584488, 7907.525548467111, 7925.762227133196, 7965.920340796633, 7988.600569971594, 6145.617236121837, 6256.436920677161, 6256.968715156395, 6266.749330026931, 6316.242050953915, 9910.058544438267, 9991.800163996533, 10229.181665466893, 10239.84640230412, 10257.538410771383, 10271.486425678835, 10299.3820370778, 10315.845262320921, 10351.534180962026, 10373.533191006272, 6400.199975003125, 6604.108445359815, 7550.471466997257, 7772.84454310922, 7931.643076061476, 8370.204830541088, 8598.355123365647, 8691.391602587759, 8691.391602588012, 8707.390482666406, 7469.402447804054, 7536.886946695694, 7608.657610407434, 7675.385969122345, 7818.530888146729, 7322.597257150908, 7460.776176714708, 7467.402607791472, 7531.472796904383, 7682.270184332479, 6638.933610664025, 6692.498062645223, 6695.665216739241, 6704.0, 6755.763548275787, 4818.445878723992, 4957.00859828043, 5005.599552035901, 5325.547328477122, 5355.089634762022, 5049.6465247432325, 5141.485851414828, 5159.0, 5211.374635043819, 5275.076861549137], "value": 4560.222713893396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.88232236394896, 328.08627971100475, 331.3009549849817, 332.4514550990866, 332.6291185328359, 5233.293505376773, 5278.208268759688, 5293.629445938776, 5305.734713264331, 5320.281761962134, 5278.6568873023225, 5296.735163241842, 5307.310049693534, 5312.495312945264, 5315.335583052119, 3687.760295580792, 4001.3197756381414, 4098.877033688994, 4099.73351732138, 4101.405296232045, 4124.216398884218, 4153.314703074005, 4155.31437312843, 4156.397322388252, 4171.687123465737, 4090.834112278001, 4117.464729585165, 4123.546409894909, 4123.97938010311, 4137.193247316774, 3907.4529565860803, 3991.600839916014, 4086.7139300248996, 4102.056526998792, 4124.154548317588, 3662.3224703429682, 3663.1757854482794, 3666.3767159582667, 3674.2467794102145, 3676.191237927652, 5120.899006713575, 5162.354705661793, 5173.456787037382, 5186.870328241786, 5192.247124167013, 4443.5556444355625, 4699.412573428322, 4721.197396442613, 4730.479647238801, 4752.287156926454, 5513.9448605513835, 5542.91685624716, 5553.555715542747, 5556.249906262643, 5572.721363931787, 3994.720369574131, 4006.4390985262085, 4009.1781184857036, 4026.5369482509595, 4033.556308806029, 5634.661920284796, 5694.345150307726, 5717.942820571824, 5798.652080875161, 5849.85375365615, 4020.4170395292517, 4041.696872734498, 4045.554988951213, 4049.8582549610624, 4051.108756073659, 4080.1431699342875, 4100.466939297932, 4101.835926562963, 4139.275626765364, 4164.43780089684, 4554.931676024862, 4739.980904105634, 4749.810007599726, 4782.402199725035, 4789.592884604778, 5545.334559852843, 5550.888982220333, 5559.388467268597, 5589.0, 5599.664020158803, 1401.4604377314806, 1416.7662335714697, 1416.8441471438134, 1417.4401111560876, 1421.459845258795, 872.2062922740403, 893.2675206330747, 908.7913075609556, 914.4304504342819, 919.4069824962861, 4789.018251258483, 4811.9518804812205, 4821.807127714922, 4822.324874517571, 4822.662413631012, 5000.549730632037, 5040.924386134137, 5048.419431765394, 5077.847664570068, 5110.0, 4634.694914024562, 4663.860084197479, 4774.9522504775205, 4815.975920120447, 4831.0, 2674.8528830914097, 2687.25328536449, 2693.3535951371923, 2697.163879197455, 2703.3647092933147, 5179.741012949337, 5187.948120518822, 5237.73811309433, 5283.82185458253, 5319.973400132974, 4783.95216047842, 5028.169505203038, 5037.743107074516, 5115.360579927509, 5137.073597400975, 5147.588192944556, 5210.426853046086, 5220.3735551734035, 5227.0, 5231.2213847292105, 4942.3327850741125, 5002.549770520671, 5022.874428139326, 5030.496950304941, 5040.773165207501, 4549.476810166873, 4931.3096166536, 4939.382577177853, 5084.618653600921, 5108.0, 5117.948820511747, 5235.240890070994, 5255.842324730264, 5281.867953301198, 5288.603354748486, 3652.3060618483464, 3737.1591391937686, 3738.887833365003, 3755.4366844973474, 3756.136088699669, 4848.878778030577, 5046.426322575439, 5089.312942752829, 5109.846704598868, 5132.281480592795, 4884.242942343943, 4892.755362231946, 4893.363862697826, 4901.068796928572, 4913.0, 4860.764048537712, 4891.413030436371, 4896.0, 4947.18371468718, 4953.0, 4561.156186105581, 4805.8558243252755, 4812.181929071996, 4817.397825271841, 4821.276808478756, 4865.07829407375, 4896.534829191221, 4924.72913989734, 4942.851714448572, 4976.835076741629, 4798.0, 4812.374391329105, 4827.624127123753, 4878.195037853177, 4960.255961605643], "value": 3996.706435480908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.0361192524505, 702.1083224305136, 751.7782254235003, 764.2395816162917, 814.4909431605245, 15265.236738163088, 15898.284577194025, 16157.838421615781, 16185.676286474263, 16207.108609026529, 14570.198639074846, 14687.853121468783, 14693.0, 14694.926525367386, 14712.558623241293, 672.1228796420669, 788.6963519045152, 793.817421992942, 799.0, 801.1187693537121, 799.5522507395848, 804.5333706450274, 808.2442915873677, 808.2523665609317, 808.4381354958277, 845.3195177881803, 846.0820010288844, 847.7287268074218, 847.9406441549094, 848.4654667559429, 703.7396163419517, 828.3207769628907, 837.8324335132937, 837.9916200837974, 851.4976164063232, 618.2426527503771, 618.7122987810644, 619.3342157181048, 619.5446346934999, 619.6003577692409, 14449.927750361287, 14574.70850582993, 14575.927120364437, 14602.634934126732, 14628.0, 13758.380872860746, 13854.861451385457, 14039.298035098203, 14053.929730351283, 14127.0, 11906.047516198683, 11971.0, 12134.211276267015, 12315.75368492625, 12521.0, 4280.807363668611, 4350.238708226079, 4380.321050237187, 4486.910261794778, 4499.662525310615, 71575.64212178958, 72021.0, 74223.0, 75410.24589754142, 76064.61967690181, 10130.290879638502, 10311.535980880879, 10367.63713270047, 10385.740356490996, 10506.684799456028, 21371.67942480864, 21380.786192138192, 21394.144234230767, 21428.678569821466, 21931.12275508994, 7985.0, 8040.959795200986, 8055.718049868226, 8498.532580707997, 8733.65065397377, 4432.601065904019, 4446.9555304447185, 4653.604443622262, 4693.9765301173275, 4861.683990540674, 3229.4348489014797, 3351.2459696568076, 3351.6983471487197, 3355.5470011548127, 3357.5970883494138, 577.6072270855858, 587.811900191943, 600.7446835095067, 636.8726254749068, 639.6354078175395, 590.8906852232351, 651.9706613202417, 691.7578847403469, 711.0, 723.8516104198732, 9641.469719165514, 9970.351927124713, 9974.401535907724, 9983.086260073711, 9984.354146151276, 574.3366411794384, 662.7282814046218, 673.9191297044387, 715.6099925540593, 756.1795451934712, 4260.360945858146, 4555.180067587866, 4588.977055114769, 4595.885102872388, 4621.09888571732, 89268.0, 101906.0, 102771.0, 110935.44532277448, 111749.44125279321, 91782.54108729414, 92317.0, 92879.53560232156, 92885.35178316098, 93986.0, 81135.0, 81483.0, 81746.0, 82514.0, 83066.0, 8674.436161649473, 8893.377463577488, 8900.376973612045, 8963.193312601898, 8976.282949350196, 48160.0, 48253.27620085772, 49013.754931225114, 49019.50980490149, 50785.492145078075, 63574.36425635684, 64547.35452645413, 71494.0, 73609.6319518399, 74259.25740742523, 12045.578404755792, 12346.691332716753, 12872.356382180666, 13138.934305328794, 13297.800532992207, 14827.703445931236, 15058.924705376403, 15575.84424155744, 15683.0, 15788.60528486797, 14306.356213970605, 14407.927960360132, 14472.710545788814, 14888.255587220812, 15070.246487675791, 13598.11612245201, 13813.792793108312, 13901.930490347484, 13927.58217253484, 14210.28948552589, 13981.860181398055, 14084.859151408355, 14175.291235438393, 14622.04956677855, 14833.777493337824, 11477.770444591228, 11613.361265130161, 11638.185327027028, 11706.239094458833, 12084.274943503418, 11777.352245626573, 11861.644150675493, 11914.0, 11922.523099076287, 12227.633171004883], "value": 7449.7567218063, "unit": "score"}], "name": "dromaeo_css", "value": 7122.6041039883885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 111.0, 111.0, 114.0, 112.0, 111.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 127.0, 185.0, 133.0, 135.0, 162.0, 134.0, 158.0, 132.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 162.0, 164.0, 163.0, 164.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 122.0, 76.0, 75.0, 75.0, 76.0, 100.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 86.0, 87.0, 85.0, 119.0, 84.0, 85.0, 130.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 127.0, 116.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 79.0, 84.0, 86.0, 80.0, 81.0, 80.0, 136.0, 80.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 132.0, 130.0, 119.0, 119.0, 117.0, 122.0, 134.0, 131.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 163.0, 169.0, 159.0, 161.0, 160.0, 163.0, 161.0, 158.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1506.6, "alertThreshold": 2.0}]} 11:00:21 INFO - Return code: 0 11:00:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:00:21 ERROR - # TBPL SUCCESS # 11:00:21 INFO - Running post-action listener: _resource_record_post_action 11:00:21 INFO - ##### 11:00:21 INFO - ##### Finished run-tests step (success) 11:00:21 INFO - ##### 11:00:21 INFO - Running post-run listener: _resource_record_post_run 11:00:21 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542920704; Read time: 12; Write time: 431464 11:00:21 INFO - TinderboxPrint: CPU usage
13.3% 11:00:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:00:21 INFO - TinderboxPrint: I/O write bytes / time
542,920,704 / 431,464 11:00:21 INFO - TinderboxPrint: CPU idle
8,255.4 (86.7%) 11:00:21 INFO - TinderboxPrint: CPU user
1,214.7 (12.8%) 11:00:21 INFO - TinderboxPrint: Swap in / out
0 / 0 11:00:21 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255070208; Read time: 0; Write time: 231216 11:00:21 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287850496; Read time: 12; Write time: 200248 11:00:22 INFO - Running post-run listener: _upload_blobber_files 11:00:22 INFO - Blob upload gear active. 11:00:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:00:22 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 11:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:00:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:00:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:00:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:00:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:23 INFO - (blobuploader) - INFO - Done attempting. 11:00:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:00:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:00:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:24 INFO - (blobuploader) - INFO - Done attempting. 11:00:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:00:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:00:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:00:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:00:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:00:28 INFO - (blobuploader) - INFO - Done attempting. 11:00:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:00:28 INFO - Return code: 0 11:00:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:00:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:00:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/327e219600371771772804cd3af7052018d672f24756af4fdec98881ffd56579ac26c798d21c44adbe681f5f86bbf047bb8d2777681dece36d56d94a0b02d649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/490c94ef98cfbef2dd9bd4f4e49e80319b13c17088d508996deb2af65bd3ff9c7f6b8bedc3a408e1e1a1112406b16d793563da6da846ad827f5282500b0b3c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/600313d9fc45233d713de1efbc005c8bf0fcbf05c525313b2e728d559e119ad3cfc207951237939611e0e7f6949bee48c686e37eb0409016086018a2d5ee5959"} 11:00:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:00:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:00:28 INFO - Contents: 11:00:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/327e219600371771772804cd3af7052018d672f24756af4fdec98881ffd56579ac26c798d21c44adbe681f5f86bbf047bb8d2777681dece36d56d94a0b02d649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/490c94ef98cfbef2dd9bd4f4e49e80319b13c17088d508996deb2af65bd3ff9c7f6b8bedc3a408e1e1a1112406b16d793563da6da846ad827f5282500b0b3c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/600313d9fc45233d713de1efbc005c8bf0fcbf05c525313b2e728d559e119ad3cfc207951237939611e0e7f6949bee48c686e37eb0409016086018a2d5ee5959"} 11:00:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:00:28 INFO - Copying logs to upload dir... 11:00:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:00:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.510376 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-10 11:00:27.922851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 11:00:27.926706) ========= 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=41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/327e219600371771772804cd3af7052018d672f24756af4fdec98881ffd56579ac26c798d21c44adbe681f5f86bbf047bb8d2777681dece36d56d94a0b02d649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/490c94ef98cfbef2dd9bd4f4e49e80319b13c17088d508996deb2af65bd3ff9c7f6b8bedc3a408e1e1a1112406b16d793563da6da846ad827f5282500b0b3c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/600313d9fc45233d713de1efbc005c8bf0fcbf05c525313b2e728d559e119ad3cfc207951237939611e0e7f6949bee48c686e37eb0409016086018a2d5ee5959"} build_url:https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/HAKOQGLETuqxwsCvRwFfAg/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/Mozilla-Inbound/sha512/327e219600371771772804cd3af7052018d672f24756af4fdec98881ffd56579ac26c798d21c44adbe681f5f86bbf047bb8d2777681dece36d56d94a0b02d649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/490c94ef98cfbef2dd9bd4f4e49e80319b13c17088d508996deb2af65bd3ff9c7f6b8bedc3a408e1e1a1112406b16d793563da6da846ad827f5282500b0b3c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/600313d9fc45233d713de1efbc005c8bf0fcbf05c525313b2e728d559e119ad3cfc207951237939611e0e7f6949bee48c686e37eb0409016086018a2d5ee5959"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 11:00:27.952238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:00:27.952583) ========= 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=41bf3e9aed84707956354da8000001c5-1465580391.240650-607013880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 11:00:28.035462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 11:00:28.035784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 11:00:28.036087) ========= ========= Total master_lag: 0.17 =========