builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1469452678.22 results: success (0) buildid: 20160725020629 builduid: e9cffd69a2054ead90893fbe00f05894 revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.222371) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.222824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.223108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.276237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.276522) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 06:17:58-- 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.6M=0s 2016-07-25 06:17:58 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.392760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.393044) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018643 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.445198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:58.445565) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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=20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 06:17:58,832 truncating revision to first 12 chars 2016-07-25 06:17:58,833 Setting DEBUG logging. 2016-07-25 06:17:58,833 attempt 1/10 2016-07-25 06:17:58,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/517663b29d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 06:17:59,127 unpacking tar archive at: mozilla-aurora-517663b29d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.092374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.092655) ========= script_repo_revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.093051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.093312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 06:17:59.104171) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-25 06:17:59.104497) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:17:59 INFO - MultiFileLogger online at 20160725 06:17:59 in /builds/slave/test 06:17:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:17:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:59 INFO - {'append_to_log': False, 06:17:59 INFO - 'base_work_dir': '/builds/slave/test', 06:17:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:17:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:59 INFO - 'branch': 'Mozilla-Aurora', 06:17:59 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:59 INFO - 'config_files': ('talos/linux_config.py',), 06:17:59 INFO - 'default_actions': ('clobber', 06:17:59 INFO - 'read-buildbot-config', 06:17:59 INFO - 'download-and-extract', 06:17:59 INFO - 'populate-webroot', 06:17:59 INFO - 'create-virtualenv', 06:17:59 INFO - 'install', 06:17:59 INFO - 'run-tests'), 06:17:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:59 INFO - 'download_minidump_stackwalk': True, 06:17:59 INFO - 'download_symbols': 'ondemand', 06:17:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:59 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:59 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:59 INFO - 'installer_path': 'installer.exe', 06:17:59 INFO - 'log_level': 'info', 06:17:59 INFO - 'log_name': 'talos', 06:17:59 INFO - 'log_to_console': True, 06:17:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:17:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:17:59 INFO - 'opt_config_files': (), 06:17:59 INFO - 'pip_index': False, 06:17:59 INFO - 'sps_profile': False, 06:17:59 INFO - 'sps_profile_interval': 0, 06:17:59 INFO - 'suite': 'dromaeojs-e10s', 06:17:59 INFO - 'system_bits': '32', 06:17:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:59 INFO - 'title': 'talos-linux64-ix-015', 06:17:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:59 INFO - 'use_talos_json': True, 06:17:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:59 INFO - 'work_dir': 'build'} 06:17:59 INFO - ##### 06:17:59 INFO - ##### Running clobber step. 06:17:59 INFO - ##### 06:17:59 INFO - Running pre-action listener: _resource_record_pre_action 06:17:59 INFO - Running main action method: clobber 06:17:59 INFO - rmtree: /builds/slave/test/build 06:17:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:18:00 INFO - Running post-action listener: _resource_record_post_action 06:18:00 INFO - ##### 06:18:00 INFO - ##### Finished clobber step (success) 06:18:00 INFO - ##### 06:18:00 INFO - ##### 06:18:00 INFO - ##### Running read-buildbot-config step. 06:18:00 INFO - ##### 06:18:00 INFO - Running pre-action listener: _resource_record_pre_action 06:18:00 INFO - Running main action method: read_buildbot_config 06:18:00 INFO - Using buildbot properties: 06:18:00 INFO - { 06:18:00 INFO - "project": "", 06:18:00 INFO - "product": "firefox", 06:18:00 INFO - "script_repo_revision": "production", 06:18:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:18:00 INFO - "repository": "", 06:18:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:18:00 INFO - "buildid": "20160725020629", 06:18:00 INFO - "pgo_build": "True", 06:18:00 INFO - "basedir": "/builds/slave/test", 06:18:00 INFO - "buildnumber": 462, 06:18:00 INFO - "slavename": "talos-linux64-ix-015", 06:18:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:18:00 INFO - "platform": "ubuntu64_hw", 06:18:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:18:00 INFO - "branch": "mozilla-aurora", 06:18:00 INFO - "repo_path": "releases/mozilla-aurora", 06:18:00 INFO - "revision": "517663b29d7ffc2ce91f90dc7beaac4fa35e52e5", 06:18:00 INFO - "stage_platform": "linux64-pgo", 06:18:00 INFO - "builduid": "e9cffd69a2054ead90893fbe00f05894", 06:18:00 INFO - "slavebuilddir": "test" 06:18:00 INFO - } 06:18:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:18:00 INFO - Running post-action listener: _resource_record_post_action 06:18:00 INFO - ##### 06:18:00 INFO - ##### Finished read-buildbot-config step (success) 06:18:00 INFO - ##### 06:18:00 INFO - ##### 06:18:00 INFO - ##### Running download-and-extract step. 06:18:00 INFO - ##### 06:18:00 INFO - Running pre-action listener: _resource_record_pre_action 06:18:00 INFO - Running main action method: download_and_extract 06:18:00 INFO - mkdir: /builds/slave/test/build/tests 06:18:00 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')]} 06:18:00 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:18:03 INFO - Downloaded 1361 bytes. 06:18:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:18:03 INFO - Using the following test package requirements: 06:18:03 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:18:03 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:18:03 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:18:03 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'jsshell-linux-x86_64.zip'], 06:18:03 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:18:03 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:18:03 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:18:03 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:18:03 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:18:03 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:18:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:18:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:18:03 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')]} 06:18:03 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:18:06 INFO - Downloaded 24494715 bytes. 06:18:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:18:08 INFO - Return code: 0 06:18:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:18: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')]} 06:18:08 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:18:09 INFO - Downloaded 24494715 bytes. 06:18:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:18:11 INFO - Return code: 0 06:18: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')]} 06:18:11 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:18:12 INFO - Downloaded 10833369 bytes. 06:18:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:18:12 INFO - Return code: 0 06:18:12 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')]} 06:18:12 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:18:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:18:19 INFO - Downloaded 63633994 bytes. 06:18:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:19 INFO - mkdir: /builds/slave/test/properties 06:18:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:19 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:19 INFO - Contents: 06:18:19 INFO - build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:18:20 INFO - Running post-action listener: _resource_record_post_action 06:18:20 INFO - Running post-action listener: set_extra_try_arguments 06:18:20 INFO - ##### 06:18:20 INFO - ##### Finished download-and-extract step (success) 06:18:20 INFO - ##### 06:18:20 INFO - ##### 06:18:20 INFO - ##### Running populate-webroot step. 06:18:20 INFO - ##### 06:18:20 INFO - Running pre-action listener: _resource_record_pre_action 06:18:20 INFO - Running main action method: populate_webroot 06:18:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:20 INFO - '--tppagecycles', 06:18:20 INFO - '7'], 06:18:20 INFO - 'tests': ['tsvgm']}}, 06:18:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:18:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:18:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['damp', 'tps']}, 06:18:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'tests': ['damp', 'tps']}, 06:18:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['dromaeo_dom']}, 06:18:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['a11yr', 06:18:20 INFO - 'ts_paint', 06:18:20 INFO - 'tpaint', 06:18:20 INFO - 'sessionrestore', 06:18:20 INFO - 'sessionrestore_no_auto_restore', 06:18:20 INFO - 'tabpaint']}, 06:18:20 INFO - 'other-e10s': {'tests': ['a11yr', 06:18:20 INFO - 'ts_paint', 06:18:20 INFO - 'tpaint', 06:18:20 INFO - 'sessionrestore', 06:18:20 INFO - 'sessionrestore_no_auto_restore', 06:18:20 INFO - 'tabpaint']}, 06:18:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:18:20 INFO - 'ts_paint', 06:18:20 INFO - 'tpaint', 06:18:20 INFO - 'sessionrestore', 06:18:20 INFO - 'sessionrestore_no_auto_restore', 06:18:20 INFO - 'tabpaint']}, 06:18:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:18:20 INFO - 'ts_paint', 06:18:20 INFO - 'tpaint', 06:18:20 INFO - 'sessionrestore', 06:18:20 INFO - 'sessionrestore_no_auto_restore', 06:18:20 INFO - 'tabpaint']}, 06:18:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['a11yr', 06:18:20 INFO - 'ts_paint', 06:18:20 INFO - 'tpaint', 06:18:20 INFO - 'sessionrestore', 06:18:20 INFO - 'sessionrestore_no_auto_restore', 06:18:20 INFO - 'tabpaint']}, 06:18:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['a11yr', 06:18:20 INFO - 'ts_paint', 06:18:20 INFO - 'tpaint', 06:18:20 INFO - 'sessionrestore', 06:18:20 INFO - 'sessionrestore_no_auto_restore', 06:18:20 INFO - 'tabpaint']}, 06:18:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['tsvgx', 06:18:20 INFO - 'tsvgr_opacity', 06:18:20 INFO - 'tart', 06:18:20 INFO - 'tscrollx', 06:18:20 INFO - 'cart']}, 06:18:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:18:20 INFO - 'tsvgr_opacity', 06:18:20 INFO - 'tart', 06:18:20 INFO - 'tscrollx', 06:18:20 INFO - 'cart']}, 06:18:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'talos_options': ['--disable-e10s'], 06:18:20 INFO - 'tests': ['tp5o']}, 06:18:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'tests': ['tp5o']}, 06:18:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'talos_options': ['--disable-e10s', 06:18:20 INFO - '--xperf_path', 06:18:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:20 INFO - 'tests': ['tp5n']}, 06:18:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:20 INFO - 'talos_options': ['--xperf_path', 06:18:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:20 INFO - 'tests': ['tp5n']}}, 06:18:20 INFO - 'talos.zip': {'path': '', 06:18:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:20 INFO - Running post-action listener: _resource_record_post_action 06:18:20 INFO - ##### 06:18:20 INFO - ##### Finished populate-webroot step (success) 06:18:20 INFO - ##### 06:18:20 INFO - ##### 06:18:20 INFO - ##### Running create-virtualenv step. 06:18:20 INFO - ##### 06:18:20 INFO - Running pre-action listener: _resource_record_pre_action 06:18:20 INFO - Running main action method: create_virtualenv 06:18:20 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:20 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 06:18:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:20 INFO - Using real prefix '/usr' 06:18:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:21 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:23 INFO - Installing pip.................done. 06:18:23 INFO - Return code: 0 06:18:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18:23 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')]} 06:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:23 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')]} 06:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:23 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:23 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 06:18:23 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 06:18:23 INFO - Using env: {'DISPLAY': ':0', 06:18:23 INFO - 'HOME': '/home/cltbld', 06:18:23 INFO - 'LANG': 'en_US.UTF-8', 06:18:23 INFO - 'LANGUAGE': 'en_US:en', 06:18:23 INFO - 'LOGNAME': 'cltbld', 06:18:23 INFO - 'MAIL': '/var/mail/cltbld', 06:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:23 INFO - 'MOZ_NO_REMOTE': '1', 06:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:23 INFO - 'NO_EM_RESTART': '1', 06:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:23 INFO - 'PWD': '/builds/slave/test', 06:18:23 INFO - 'SHELL': '/bin/bash', 06:18:23 INFO - 'SHLVL': '1', 06:18:23 INFO - 'TERM': 'linux', 06:18:23 INFO - 'TMOUT': '86400', 06:18:23 INFO - 'USER': 'cltbld', 06:18:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:23 INFO - '_': '/tools/buildbot/bin/python'} 06:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:23 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 06:18:23 INFO - Cleaning up... 06:18:23 INFO - Return code: 0 06:18:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:18:23 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')]} 06:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:23 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')]} 06:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:23 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:23 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 06:18:23 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 06:18:23 INFO - Using env: {'DISPLAY': ':0', 06:18:23 INFO - 'HOME': '/home/cltbld', 06:18:23 INFO - 'LANG': 'en_US.UTF-8', 06:18:23 INFO - 'LANGUAGE': 'en_US:en', 06:18:23 INFO - 'LOGNAME': 'cltbld', 06:18:23 INFO - 'MAIL': '/var/mail/cltbld', 06:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:23 INFO - 'MOZ_NO_REMOTE': '1', 06:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:23 INFO - 'NO_EM_RESTART': '1', 06:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:23 INFO - 'PWD': '/builds/slave/test', 06:18:23 INFO - 'SHELL': '/bin/bash', 06:18:23 INFO - 'SHLVL': '1', 06:18:23 INFO - 'TERM': 'linux', 06:18:23 INFO - 'TMOUT': '86400', 06:18:23 INFO - 'USER': 'cltbld', 06:18:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:23 INFO - '_': '/tools/buildbot/bin/python'} 06:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:23 INFO - Downloading/unpacking psutil>=3.1.1 06:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:25 INFO - Installing collected packages: psutil 06:18:25 INFO - Running setup.py install for psutil 06:18:25 INFO - building 'psutil._psutil_linux' extension 06:18:25 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 06:18:25 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 06:18:25 INFO - building 'psutil._psutil_posix' extension 06:18:25 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 06:18:26 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 06:18:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:26 INFO - Successfully installed psutil 06:18:26 INFO - Cleaning up... 06:18:26 INFO - Return code: 0 06:18:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:18:26 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')]} 06:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:26 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')]} 06:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:26 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:26 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 06:18:26 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 06:18:26 INFO - Using env: {'DISPLAY': ':0', 06:18:26 INFO - 'HOME': '/home/cltbld', 06:18:26 INFO - 'LANG': 'en_US.UTF-8', 06:18:26 INFO - 'LANGUAGE': 'en_US:en', 06:18:26 INFO - 'LOGNAME': 'cltbld', 06:18:26 INFO - 'MAIL': '/var/mail/cltbld', 06:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:26 INFO - 'MOZ_NO_REMOTE': '1', 06:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:26 INFO - 'NO_EM_RESTART': '1', 06:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:26 INFO - 'PWD': '/builds/slave/test', 06:18:26 INFO - 'SHELL': '/bin/bash', 06:18:26 INFO - 'SHLVL': '1', 06:18:26 INFO - 'TERM': 'linux', 06:18:26 INFO - 'TMOUT': '86400', 06:18:26 INFO - 'USER': 'cltbld', 06:18:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:26 INFO - '_': '/tools/buildbot/bin/python'} 06:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:18:28 INFO - Installing collected packages: mozsystemmonitor 06:18:28 INFO - Running setup.py install for mozsystemmonitor 06:18:28 INFO - Successfully installed mozsystemmonitor 06:18:28 INFO - Cleaning up... 06:18:28 INFO - Return code: 0 06:18:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:18:28 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')]} 06:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:28 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')]} 06:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:28 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:28 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 06:18:28 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 06:18:28 INFO - Using env: {'DISPLAY': ':0', 06:18:28 INFO - 'HOME': '/home/cltbld', 06:18:28 INFO - 'LANG': 'en_US.UTF-8', 06:18:28 INFO - 'LANGUAGE': 'en_US:en', 06:18:28 INFO - 'LOGNAME': 'cltbld', 06:18:28 INFO - 'MAIL': '/var/mail/cltbld', 06:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:28 INFO - 'MOZ_NO_REMOTE': '1', 06:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:28 INFO - 'NO_EM_RESTART': '1', 06:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:28 INFO - 'PWD': '/builds/slave/test', 06:18:28 INFO - 'SHELL': '/bin/bash', 06:18:28 INFO - 'SHLVL': '1', 06:18:28 INFO - 'TERM': 'linux', 06:18:28 INFO - 'TMOUT': '86400', 06:18:28 INFO - 'USER': 'cltbld', 06:18:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:28 INFO - '_': '/tools/buildbot/bin/python'} 06:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:28 INFO - Downloading/unpacking jsonschema==2.5.1 06:18:28 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 06:18:28 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 06:18:28 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 06:18:28 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 06:18:28 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 06:18:28 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 06:18:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:30 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:30 INFO - warning: no files found matching '*.txt' 06:18:30 INFO - no previously-included directories found matching 'build' 06:18:30 INFO - no previously-included directories found matching 'dist' 06:18:30 INFO - no previously-included directories found matching '.git*' 06:18:30 INFO - Installing collected packages: jsonschema, functools32 06:18:31 INFO - Running setup.py install for functools32 06:18:31 INFO - warning: no files found matching '*.txt' 06:18:31 INFO - no previously-included directories found matching 'build' 06:18:31 INFO - no previously-included directories found matching 'dist' 06:18:31 INFO - no previously-included directories found matching '.git*' 06:18:31 INFO - Successfully installed jsonschema functools32 06:18:31 INFO - Cleaning up... 06:18:31 INFO - Return code: 0 06:18:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:31 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:31 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 06:18:31 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 06:18:31 INFO - Using env: {'DISPLAY': ':0', 06:18:31 INFO - 'HOME': '/home/cltbld', 06:18:31 INFO - 'LANG': 'en_US.UTF-8', 06:18:31 INFO - 'LANGUAGE': 'en_US:en', 06:18:31 INFO - 'LOGNAME': 'cltbld', 06:18:31 INFO - 'MAIL': '/var/mail/cltbld', 06:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:31 INFO - 'MOZ_NO_REMOTE': '1', 06:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:31 INFO - 'NO_EM_RESTART': '1', 06:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:31 INFO - 'PWD': '/builds/slave/test', 06:18:31 INFO - 'SHELL': '/bin/bash', 06:18:31 INFO - 'SHLVL': '1', 06:18:31 INFO - 'TERM': 'linux', 06:18:31 INFO - 'TMOUT': '86400', 06:18:31 INFO - 'USER': 'cltbld', 06:18:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:31 INFO - '_': '/tools/buildbot/bin/python'} 06:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:31 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:31 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 06:18:31 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 06:18:31 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 06:18:31 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 06:18:31 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 06:18:31 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 06:18:33 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 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 06:18:33 INFO - Downloading docopt-0.6.1.tar.gz 06:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:34 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:34 INFO - Running setup.py install for blobuploader 06:18:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:34 INFO - Running setup.py install for requests 06:18:34 INFO - Running setup.py install for docopt 06:18:34 INFO - Successfully installed blobuploader requests docopt 06:18:34 INFO - Cleaning up... 06:18:34 INFO - Return code: 0 06:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:34 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 06:18:34 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 06:18:34 INFO - Using env: {'DISPLAY': ':0', 06:18:34 INFO - 'HOME': '/home/cltbld', 06:18:34 INFO - 'LANG': 'en_US.UTF-8', 06:18:34 INFO - 'LANGUAGE': 'en_US:en', 06:18:34 INFO - 'LOGNAME': 'cltbld', 06:18:34 INFO - 'MAIL': '/var/mail/cltbld', 06:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:34 INFO - 'MOZ_NO_REMOTE': '1', 06:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:34 INFO - 'NO_EM_RESTART': '1', 06:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:34 INFO - 'PWD': '/builds/slave/test', 06:18:34 INFO - 'SHELL': '/bin/bash', 06:18:34 INFO - 'SHLVL': '1', 06:18:34 INFO - 'TERM': 'linux', 06:18:34 INFO - 'TMOUT': '86400', 06:18:34 INFO - 'USER': 'cltbld', 06:18:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:34 INFO - '_': '/tools/buildbot/bin/python'} 06:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:34 INFO - Running setup.py (path:/tmp/pip-IoswrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:34 INFO - Running setup.py (path:/tmp/pip-7s8vtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:35 INFO - Running setup.py (path:/tmp/pip-4FNRwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:35 INFO - Running setup.py (path:/tmp/pip-0jVXQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:35 INFO - Running setup.py (path:/tmp/pip-jUbGSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:35 INFO - Running setup.py (path:/tmp/pip-h3vNZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:35 INFO - Running setup.py (path:/tmp/pip-jSbtOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:35 INFO - Running setup.py (path:/tmp/pip-kJC9nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:35 INFO - Running setup.py (path:/tmp/pip-6XWL6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:35 INFO - Running setup.py (path:/tmp/pip-npYDoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:35 INFO - Running setup.py (path:/tmp/pip-qDTOIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:35 INFO - Running setup.py (path:/tmp/pip-H0Pmaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:35 INFO - Running setup.py (path:/tmp/pip-7xSnrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:35 INFO - Running setup.py (path:/tmp/pip-vQb3Dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:35 INFO - Running setup.py (path:/tmp/pip-OxZHic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:35 INFO - Running setup.py (path:/tmp/pip-PpzujI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:36 INFO - Running setup.py (path:/tmp/pip-lEBRcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:36 INFO - Running setup.py install for manifestparser 06:18:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Running setup.py install for mozcrash 06:18:36 INFO - Running setup.py install for mozdebug 06:18:36 INFO - Running setup.py install for mozdevice 06:18:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Running setup.py install for mozfile 06:18:36 INFO - Running setup.py install for mozhttpd 06:18:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Running setup.py install for mozinfo 06:18:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Running setup.py install for mozInstall 06:18:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:36 INFO - Running setup.py install for mozleak 06:18:37 INFO - Running setup.py install for mozlog 06:18:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:37 INFO - Running setup.py install for moznetwork 06:18:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:37 INFO - Running setup.py install for mozprocess 06:18:37 INFO - Running setup.py install for mozprofile 06:18:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:37 INFO - Running setup.py install for mozrunner 06:18:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:37 INFO - Running setup.py install for mozscreenshot 06:18:37 INFO - Running setup.py install for moztest 06:18:37 INFO - Running setup.py install for mozversion 06:18:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:37 INFO - Cleaning up... 06:18:37 INFO - Return code: 0 06:18:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:37 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:37 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 06:18:37 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 06:18:37 INFO - Using env: {'DISPLAY': ':0', 06:18:37 INFO - 'HOME': '/home/cltbld', 06:18:37 INFO - 'LANG': 'en_US.UTF-8', 06:18:37 INFO - 'LANGUAGE': 'en_US:en', 06:18:37 INFO - 'LOGNAME': 'cltbld', 06:18:37 INFO - 'MAIL': '/var/mail/cltbld', 06:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:37 INFO - 'MOZ_NO_REMOTE': '1', 06:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:37 INFO - 'NO_EM_RESTART': '1', 06:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:37 INFO - 'PWD': '/builds/slave/test', 06:18:37 INFO - 'SHELL': '/bin/bash', 06:18:37 INFO - 'SHLVL': '1', 06:18:37 INFO - 'TERM': 'linux', 06:18:37 INFO - 'TMOUT': '86400', 06:18:37 INFO - 'USER': 'cltbld', 06:18:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:37 INFO - '_': '/tools/buildbot/bin/python'} 06:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:38 INFO - Running setup.py (path:/tmp/pip-KNidpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:38 INFO - Running setup.py (path:/tmp/pip-OcX_cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:38 INFO - Running setup.py (path:/tmp/pip-5MimxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:38 INFO - Running setup.py (path:/tmp/pip-c0biXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:38 INFO - Running setup.py (path:/tmp/pip-NaNZyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:38 INFO - Running setup.py (path:/tmp/pip-zKJu8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:38 INFO - Running setup.py (path:/tmp/pip-UdD5VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:38 INFO - Running setup.py (path:/tmp/pip-pXBMFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:38 INFO - Running setup.py (path:/tmp/pip-EvDK8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:38 INFO - Running setup.py (path:/tmp/pip-ZiOHs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:38 INFO - Running setup.py (path:/tmp/pip-I0TWrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:38 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)) 06:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:38 INFO - Running setup.py (path:/tmp/pip-A1w6xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:39 INFO - Running setup.py (path:/tmp/pip-PJdldK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:39 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)) 06:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:39 INFO - Running setup.py (path:/tmp/pip-t8ZFR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:39 INFO - Running setup.py (path:/tmp/pip-lUoZLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:39 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)) 06:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:39 INFO - Running setup.py (path:/tmp/pip-0tQjJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:39 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)) 06:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:39 INFO - Running setup.py (path:/tmp/pip-7ac7UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:39 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)) 06:18:39 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)) 06:18:39 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)) 06:18:39 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)) 06:18:39 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)) 06:18:39 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)) 06:18:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:39 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 06:18:39 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 06:18:39 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 06:18:39 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 06:18:39 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 06:18:39 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 06:18:41 INFO - Downloading blessings-1.6.tar.gz 06:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:41 INFO - Installing collected packages: blessings 06:18:41 INFO - Running setup.py install for blessings 06:18:41 INFO - Successfully installed blessings 06:18:41 INFO - Cleaning up... 06:18:41 INFO - Return code: 0 06:18:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:41 INFO - Reading from file tmpfile_stdout 06:18:41 INFO - Current package versions: 06:18:41 INFO - argparse == 1.2.1 06:18:41 INFO - blessings == 1.6 06:18:41 INFO - blobuploader == 1.2.4 06:18:41 INFO - docopt == 0.6.1 06:18:41 INFO - functools32 == 3.2.3-2 06:18:41 INFO - jsonschema == 2.5.1 06:18:41 INFO - manifestparser == 1.1 06:18:41 INFO - mozInstall == 1.12 06:18:41 INFO - mozcrash == 0.17 06:18:41 INFO - mozdebug == 0.1 06:18:41 INFO - mozdevice == 0.48 06:18:41 INFO - mozfile == 1.2 06:18:41 INFO - mozhttpd == 0.7 06:18:41 INFO - mozinfo == 0.9 06:18:41 INFO - mozleak == 0.1 06:18:41 INFO - mozlog == 3.2 06:18:41 INFO - moznetwork == 0.27 06:18:41 INFO - mozprocess == 0.23 06:18:41 INFO - mozprofile == 0.28 06:18:41 INFO - mozrunner == 6.12 06:18:41 INFO - mozscreenshot == 0.1 06:18:41 INFO - mozsystemmonitor == 0.3 06:18:41 INFO - moztest == 0.7 06:18:41 INFO - mozversion == 1.4 06:18:41 INFO - psutil == 3.1.1 06:18:41 INFO - requests == 1.2.3 06:18:41 INFO - wsgiref == 0.1.2 06:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:41 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:41 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 06:18:41 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 06:18:41 INFO - Using env: {'DISPLAY': ':0', 06:18:41 INFO - 'HOME': '/home/cltbld', 06:18:41 INFO - 'LANG': 'en_US.UTF-8', 06:18:41 INFO - 'LANGUAGE': 'en_US:en', 06:18:41 INFO - 'LOGNAME': 'cltbld', 06:18:41 INFO - 'MAIL': '/var/mail/cltbld', 06:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:41 INFO - 'MOZ_NO_REMOTE': '1', 06:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:41 INFO - 'NO_EM_RESTART': '1', 06:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:41 INFO - 'PWD': '/builds/slave/test', 06:18:41 INFO - 'SHELL': '/bin/bash', 06:18:41 INFO - 'SHLVL': '1', 06:18:41 INFO - 'TERM': 'linux', 06:18:41 INFO - 'TMOUT': '86400', 06:18:41 INFO - 'USER': 'cltbld', 06:18:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:41 INFO - '_': '/tools/buildbot/bin/python'} 06:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 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)) 06:18:41 INFO - Cleaning up... 06:18:41 INFO - Return code: 0 06:18:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:41 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 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:41 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 06:18:41 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 06:18:41 INFO - Using env: {'DISPLAY': ':0', 06:18:41 INFO - 'HOME': '/home/cltbld', 06:18:41 INFO - 'LANG': 'en_US.UTF-8', 06:18:41 INFO - 'LANGUAGE': 'en_US:en', 06:18:41 INFO - 'LOGNAME': 'cltbld', 06:18:41 INFO - 'MAIL': '/var/mail/cltbld', 06:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:41 INFO - 'MOZ_NO_REMOTE': '1', 06:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:41 INFO - 'NO_EM_RESTART': '1', 06:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:41 INFO - 'PWD': '/builds/slave/test', 06:18:41 INFO - 'SHELL': '/bin/bash', 06:18:41 INFO - 'SHLVL': '1', 06:18:41 INFO - 'TERM': 'linux', 06:18:41 INFO - 'TMOUT': '86400', 06:18:41 INFO - 'USER': 'cltbld', 06:18:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:41 INFO - '_': '/tools/buildbot/bin/python'} 06:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:18:42 INFO - Cleaning up... 06:18:42 INFO - Return code: 0 06:18:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f75d956bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1315350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, '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': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', '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 06:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:18:42 INFO - Using env: {'DISPLAY': ':0', 06:18:42 INFO - 'HOME': '/home/cltbld', 06:18:42 INFO - 'LANG': 'en_US.UTF-8', 06:18:42 INFO - 'LANGUAGE': 'en_US:en', 06:18:42 INFO - 'LOGNAME': 'cltbld', 06:18:42 INFO - 'MAIL': '/var/mail/cltbld', 06:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:42 INFO - 'MOZ_NO_REMOTE': '1', 06:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:42 INFO - 'NO_EM_RESTART': '1', 06:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:42 INFO - 'PWD': '/builds/slave/test', 06:18:42 INFO - 'SHELL': '/bin/bash', 06:18:42 INFO - 'SHLVL': '1', 06:18:42 INFO - 'TERM': 'linux', 06:18:42 INFO - 'TMOUT': '86400', 06:18:42 INFO - 'USER': 'cltbld', 06:18:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:42 INFO - '_': '/tools/buildbot/bin/python'} 06:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:42 INFO - Downloading/unpacking flake8 06:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:18:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:18:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:18:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:45 INFO - no previously-included directories found matching 'docs/_build' 06:18:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:18:45 INFO - Running setup.py install for pep8 06:18:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:45 INFO - no previously-included directories found matching 'docs/_build' 06:18:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:18:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:18:45 INFO - Cleaning up... 06:18:45 INFO - Return code: 0 06:18:45 INFO - Running post-action listener: _resource_record_post_action 06:18:45 INFO - Running post-action listener: _start_resource_monitoring 06:18:45 INFO - Starting resource monitoring. 06:18:45 INFO - ##### 06:18:45 INFO - ##### Finished create-virtualenv step (success) 06:18:45 INFO - ##### 06:18:45 INFO - ##### 06:18:45 INFO - ##### Running install step. 06:18:45 INFO - ##### 06:18:45 INFO - Running pre-action listener: _resource_record_pre_action 06:18:45 INFO - Running main action method: install 06:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:46 INFO - Reading from file tmpfile_stdout 06:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:46 INFO - Reading from file tmpfile_stdout 06:18:46 INFO - Output received: 06:18:46 INFO - Usage: mozinstall [options] installer 06:18:46 INFO - Options: 06:18:46 INFO - -h, --help show this help message and exit 06:18:46 INFO - -d DEST, --destination=DEST 06:18:46 INFO - Directory to install application into. [default: 06:18:46 INFO - "/builds/slave/test"] 06:18:46 INFO - --app=APP Application being installed. [default: firefox] 06:18:46 INFO - mkdir: /builds/slave/test/build/application 06:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:19:01 INFO - Reading from file tmpfile_stdout 06:19:01 INFO - Output received: 06:19:01 INFO - /builds/slave/test/build/application/firefox/firefox 06:19:01 INFO - Running post-action listener: _resource_record_post_action 06:19:01 INFO - ##### 06:19:01 INFO - ##### Finished install step (success) 06:19:01 INFO - ##### 06:19:01 INFO - ##### 06:19:01 INFO - ##### Running run-tests step. 06:19:01 INFO - ##### 06:19:01 INFO - Running pre-action listener: _resource_record_pre_action 06:19:01 INFO - Running main action method: run_tests 06:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:01 INFO - Python 2.7.3 06:19:01 INFO - Return code: 0 06:19:01 INFO - grabbing minidump binary from tooltool 06:19: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')]} 06:19:01 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 0x13a41c0>, '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 0x13a50c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a5550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:01 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 06:19:01 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 06:19:01 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 06:19:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:02 INFO - Return code: 0 06:19:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:19:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:19:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:19:02 INFO - Return code: 0 06:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:19:02 INFO - Using env: {'DISPLAY': ':0', 06:19:02 INFO - 'HOME': '/home/cltbld', 06:19:02 INFO - 'LANG': 'en_US.UTF-8', 06:19:02 INFO - 'LANGUAGE': 'en_US:en', 06:19:02 INFO - 'LOGNAME': 'cltbld', 06:19:02 INFO - 'MAIL': '/var/mail/cltbld', 06:19:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:02 INFO - 'MOZ_NO_REMOTE': '1', 06:19:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:02 INFO - 'NO_EM_RESTART': '1', 06:19:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:02 INFO - 'PWD': '/builds/slave/test', 06:19:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:02 INFO - 'SHELL': '/bin/bash', 06:19:02 INFO - 'SHLVL': '1', 06:19:02 INFO - 'TERM': 'linux', 06:19:02 INFO - 'TMOUT': '86400', 06:19:02 INFO - 'USER': 'cltbld', 06:19:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472', 06:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:02 INFO - '_': '/tools/buildbot/bin/python'} 06:19:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:19:03 INFO - mozversion application_buildid: 20160725020629 06:19:03 INFO - mozversion application_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 06:19:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:19:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:03 INFO - mozversion application_name: Firefox 06:19:03 INFO - mozversion application_remotingname: firefox-dev 06:19:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:03 INFO - mozversion application_vendor: Mozilla 06:19:03 INFO - mozversion application_version: 49.0a2 06:19:03 INFO - mozversion platform_buildid: 20160725020629 06:19:03 INFO - mozversion platform_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 06:19:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:19:03 INFO - mozversion platform_version: 49.0a2 06:19:03 INFO - using testdate: 1469452743 06:19:03 INFO - actual date: 1469452743 06:19:03 INFO - starting webserver on 'localhost:41335' 06:19:03 INFO - SUITE-START | Running 2 tests 06:19:03 INFO - TEST-START | dromaeo_css 06:19:03 INFO - operating with platform_type : linux_ 06:19:03 INFO - Initialising browser for dromaeo_css test... 06:19:03 INFO - TEST-INFO | started process 2989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpONxgFL/profile http://localhost:41335/getInfo.html) 06:19:07 INFO - PROCESS | 2989 | __metrics Screen width/height:1600/1200 06:19:07 INFO - PROCESS | 2989 | colorDepth:24 06:19:07 INFO - PROCESS | 2989 | Browser inner width/height: 1024/697 06:19:07 INFO - PROCESS | 2989 | __metrics 06:19:08 ERROR - PROCESS | 2989 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:19:08 INFO - TEST-INFO | 2989: exit 0 06:19:08 INFO - Browser initialized. 06:19:08 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:08 INFO - TEST-INFO | started process 3119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpONxgFL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:20 INFO - PROCESS | 3119 | RSS: Main: 156372992 06:19:20 INFO - PROCESS | 3119 | 06:20:10 INFO - PROCESS | 3119 | 1469452810322 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] 06:22:18 INFO - PROCESS | 3119 | Cycle 1(1): loaded http://localhost:41335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41335/tests/dromaeo/cssquery-ext.html) 06:22:19 INFO - PROCESS | 3119 | RSS: Main: 159875072 06:22:19 INFO - PROCESS | 3119 | 06:25:21 INFO - PROCESS | 3119 | Cycle 1(1): loaded http://localhost:41335/tests/dromaeo/cssquery-ext.html (next: http://localhost:41335/tests/dromaeo/cssquery-jquery.html) 06:25:21 INFO - PROCESS | 3119 | RSS: Main: 156860416 06:25:21 INFO - PROCESS | 3119 | 06:28:23 INFO - PROCESS | 3119 | Cycle 1(1): loaded http://localhost:41335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41335/tests/dromaeo/cssquery-mootools.html) 06:28:24 INFO - PROCESS | 3119 | RSS: Main: 156409856 06:28:24 INFO - PROCESS | 3119 | 06:31:26 INFO - PROCESS | 3119 | Cycle 1(1): loaded http://localhost:41335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41335/tests/dromaeo/cssquery-prototype.html) 06:31:26 INFO - PROCESS | 3119 | RSS: Main: 156237824 06:31:26 INFO - PROCESS | 3119 | 06:34:29 INFO - PROCESS | 3119 | Cycle 1(1): loaded http://localhost:41335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41335/tests/dromaeo/cssquery-yui.html) 06:34:29 INFO - PROCESS | 3119 | RSS: Main: 157995008 06:34:29 INFO - PROCESS | 3119 | 06:37:31 INFO - PROCESS | 3119 | Cycle 1(1): loaded http://localhost:41335/tests/dromaeo/cssquery-yui.html (next: http://localhost:41335/tests/dromaeo/cssquery-dojo.html) 06:37:32 INFO - PROCESS | 3119 | RSS: Main: 158670848 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | __start_tp_report 06:37:32 INFO - PROCESS | 3119 | _x_x_mozilla_page_load 06:37:32 INFO - PROCESS | 3119 | _x_x_mozilla_page_load_details 06:37:32 INFO - PROCESS | 3119 | |i|pagename|runs| 06:37:32 INFO - PROCESS | 3119 | |0;dojo.html;3353.0946644406013;3376.409128402529;3377.425837607608;3384.678455546722;3385.1198688341033;5603.663780173192;5658.688772117537;5681.6591004539705;5690.032694441945;5748.971255143729;5710.314762228539;5732.168835518847;5735;5754.16564598133;5757.481826635602;5158.92261616076;5244.921326180111;5278;5337.919931201035;5351.304330437058;5108.616853735966;5111.565516931047;5338.332708411449;5343.866403339909;5355.946440535603;5215.608829337796;5221.06020916235;5238.030964271622;5245.239440281157;5273.551748101416;5199.194124910626;5212.452692467293;5264;5265.76304066318;5271.762770675329;5130.820421285237;5172;5240.528352448298;5246.973765131188;5276.657017293864;5400.270963419927;5483.479069488392;5502.98194833953;5535.861603459905;5554.888902221974;6066.545009124334;6088.726007329681;6097.481714054311;6102.847428814271;6108.786192483241;5943.494802941756;6140.048292514667;6142.846428839315;6149.2313460817395;6167.722452489604;5567.832965011015;5614.101743720985;5614.775408983635;5663.66018038919;5693.629914055573;6132.816015519542;6189.876202475925;6195.31851496335;6203.2245969253845;6206.162168107338;5787.71061446926;5909.349971503131;5939.46544810969;5958.910616340759;5977.820665380045;6023.69881505923;6115.602485838406;6132.647712238782;6140.84169297792;6146.108814221912;6042.214512113397;6047.0929360596265;6061.36355682647;6086.117512960596;6099.207103076572;5842.298924129047;5983.611065280743;5985.880282394328;6065.8180254592435;6089.451949324582;4639.768011599474;4641.837535686234;4648.767561621973;4702.623790096784;4709.1994360958715;4138.420621113047;4177.770222637784;4187.6440502557625;4197.202531519001;4222.683298752606;5781.682007489629;5825.7087145642545;5838.824835254949;5874.559408044413;5879.206307148565;5990.520758339322;6052.485538729169;6132.816015519542;6142.662153581507;6143.70928694435;5876.08920617305;5884.47039766423;5897.852553686193;5906.5570082244;5913.319968203712;5089.898202035939;5116.667416617983;5165.9483405165465;5171.844844654666;5187.610929180251;6340.587861788969;6373.107764912916;6395.52033597482;6408.935910640834;6428.292887782341;5896.115582662464;6135.509159267159;6142.293636231891;6151.84620384494;6152.2002139722445;6136.120845438751;6265.122882796503;6330.49356051524;6393.520485963664;6440.29156792743;5971.641701497924;6000.729967151576;6005.6396616203165;6010.729517171825;6011.639301641915;5858.2677165354335;5953.374895635896;6050.364711705208;6067.969660151671;6113.358097399887;5938.020226662552;6017.308009578955;6019.217501724923;6022.307434644897;6069.817905462844;5966.806638672196;6002;6004.819855404345;6024.3975602439405;6030.909536357046;5684.9431505684415;5767.048437007847;5797.91303130445;5888.293404791452;5957.940420595739;5967.313758917607;6027.758889644365;6041.78853740117;6042.184305118929;6056.06131049688;5889.941100589111;5892.970535147469;5901.468867801918;5906.350301466749;5925.644461332334 06:37:32 INFO - PROCESS | 3119 | |1;ext.html;591.7751254523281;647.3752828520478;657.5791493444193;658.3186402073854;664.8803215421225;33724.83137584312;36590.634093659086;45415.31877021839;46146.53853461464;46352.304715429214;47277.52722472774;47429.52570474294;47808;48201.75899120508;48219.276710849364;8987.191152796247;9125.634974601042;9138.17756401927;9139.405938613969;9150.49672268025;8932.508712020835;9019.188273055424;9025.41334813235;9026.23277021454;9039.59321830516;9123.315751318645;9127.817443651124;9141.817163656722;9153.954230228874;9174.86237706435;9026.458412495238;9069.410488318272;9078.228350590174;9092.681756138569;9096.090390960917;8822.11778822119;8858.29133669305;8912.598933048028;8928.24109950655;8945.776355591097;44414.77792611049;44646;44657.330140047925;44800;44876;3672.6694597486353;3819.52255968004;3825.636564526393;3842.7502212356108;3930.5479869815053;33437.83281083579;33626.327473450394;33815.492767608506;33891.830540847135;34511.30977380438;4523.751193684346;4538.29656403258;4565.292379681155;4717.669763116583;4742.33607294979;386556;388490;390499;392067;393632;37586;38442.80778596089;67181.66409167922;67787.3221267781;68323.65838170778;39774;39977.400338994936;40029;40177.39733903994;40249;16791.41230056942;16931.407400740914;16991.40530081441;16995.49013529596;17009.489715308562;13160.868391316155;13166.407511661999;13180.538681146305;13217.471301147847;13255.072144949761;8966.551672416354;8995.595198216097;9012.41419307743;9042.186203241608;9068.22920051803;3411.3347897159815;3489.2498112905846;3513.578370595545;3521.841517131735;3577.338192434408;1046.4558429616557;1094.885037071112;1106.9446527673583;1147.4721628051022;1155.8959693627446;34769;35267.4709879352;35747;37767;37779.62220377761;1139.715071232192;1212.0424864357235;1229.6003798765437;1238.6655602987323;1331.993340033313;17256.568585785204;17347.3061077558;17358.3056677734;17395.695322850836;17491.125443727764;659112;1067841;1088664;1104356;1136054;59008.7049564758;59467;59640.21079367626;59910.400895991355;60116;1428.5928510374492;1432.4341884955384;1433.7992681024664;1441.2361448432348;1451.7604595241878;31604.841975789976;32640.183995400304;32708.672913271515;32951;33061.33877322392;51471.74264128655;51610;52329;52384.47615523796;52494;425112;429088;430689;430936;431204;28097;28767.856160719064;28847.278818028877;28892.27769305784;28919.710802891703;46663.53336466592;47227.52772472369;47905;48078.27882581694;48113.75943120262;39317;40176;40422.39366409565;40575.59424405718;40930.386044209954;39903.80048099857;39904;40306.596934031455;40663;41097.794511027256;40398.59601403948;40680.59319406887;41140.58859411367;41180;41605.37591936063;34788.30423391467;35221.64778352184;35629.64370356367;36679;36853.63146368609;28055.859720701264;28156.296092597848;28246.85876570604;28330.150095497167;28501.714982849906 06:37:32 INFO - PROCESS | 3119 | |2;jquery.html;395.0755232755352;396.48654991785634;398.4640658314567;409.60473143416607;416.08807529402384;18405;20206;20249.59500809983;20380.694289585666;21556.461088472755;17837.91081044593;18043.368482103127;19574.60850782987;20298.594028119427;20304.898475507638;5541.390447050821;5592.552595792326;5776.682282474462;5785.537157027427;5810.099434587646;5583.5254003409755;5635.21107045014;5645.23789288447;5680.346760122577;5681.801136960207;5563.582731295149;5581.441855814427;5714.3999880012625;5731.914021289684;5744.655320680752;5653.406392328788;5655.179998900157;5717.714114294268;5723.198752174699;5735.053716136832;4870.6103511718975;4975.552200301954;5001.574866136383;5029.119904016819;5058.747062646853;23220.535589288287;23440.64839027416;23713.644295335584;23940.162094326788;24052.87973560121;2505.08564374004;2527.7093134289607;2534.1890595009604;2664.387190946074;2778.305423644089;14230.763503888787;14766.704665906622;15003.099814011195;15148.939574229807;15223.543293701206;2071.927482538119;2085.7914208579173;2096.0462989339812;2096.172012055245;2123.3417640531484;62053.37946620521;63733.36266637367;73418.26581734221;84611.5769421149;85696.14303856944;11278.774424511628;11703.654079780765;11876.406179690981;11878.703032424086;11900.583479578174;16867.91566042162;17070.658586828195;17143.828561714472;17150.656986860442;17183.742243866353;8882.955585222033;8942.552872356486;8988.370814043084;9100.772480687903;9142.542872856464;8587.22714955657;8622.913770862337;8742.169493898069;8755.430896991675;8871.64513419456;5004.249362595567;5016.698998060128;5046.722430266297;5068.315777370081;5073.289739436482;2053.7022131790804;2082.094288984297;2086.5201003769216;2122.2784253353934;2172.359154049559;984.3798407003685;997.102607653118;1020.4489575629077;1023.8976102389702;1046.581367453025;18149;19470.415887523395;19898.50253743668;19971;20030.298939537046;1054.3041592548882;1057.2704833664748;1092.317301686446;1093.0654290581597;1105.2870898270571;11029.724256893642;11226.158038147172;11337.526121604304;11407.25852819564;11422.714432139097;426328;430730;438400;549323;557233;83028.58485707533;91440.54279728692;91958.54020729853;93411.53294233486;94465.5276723612;1054.2146101154535;1071.4107241017566;1097.1442275025493;1114.0586204657052;1117.2291119127776;17686;17786.644267114327;17876.731849022013;18016.459506214833;18141.818581814012;33627.32745345128;38817;40563.985900351545;41339.7933010333;41874.79062604668;52250.73874630602;55391.72304138453;55911.16133258086;57191.71404142953;58241.70879145577;8043.672793989161;8187.877181842397;8225.506469611842;8277.875831862648;8376.204260595234;7184.928150718426;11020.50407731638;11409.885901140882;12172.087093468203;12471.314077725812;10958.945205273923;10986.560537578407;11004.229703920648;11052.392118433563;11644.88355116438;10784.460776961278;10857.077148442471;10916.290441121302;10924.563017479211;11132.499037543492;11168.776624467302;11245.100391968459;11308.773824523629;11324.433778310886;11434.656960291204;8181.427300089174;8243.505389676639;8312.584370781316;8363.832723345377;8530.78673033179;11208.55165793359;11238.775224495628;11279.436028198721;11324.094072474347;11338.716532086433 06:37:32 INFO - PROCESS | 3119 | |3;mootools.html;1534.3479021415897;1547.7755725419815;1747.9563010924726;1838.6322735452895;1876.9812301876987;7638.083429988395;8649.264812490937;8764.78088047799;9298.767530811732;9302.488363140033;8716.91283087169;8930.91069089309;8993.325500587465;9068.909310906889;9094.54527273637;2368.2066507719933;2403.6995375578053;2407.7832995030444;2407.9638805417844;2408.4701365699607;2388.0925248405583;2393.0906255622926;2413.51729654069;2416.903323867052;2433.6957880264968;2401.435662619283;2410.2648692148887;2413.650020746991;2429.6234083717054;2432.221689059502;2331.6735657008035;2332.265336419023;2346.002948746776;2364.527094581082;2372.027468737818;2386.1886958434043;2396.6165413533927;2408.903643854244;2415.2995631266913;2421.5278020785777;9067.319951003701;9105.317101217435;9116.270698344117;9144.725658230198;9152.633894644207;5198.090334191501;5275.314209152824;5284.339457567804;5313.309269794902;5338.866528336784;3440.3119376124623;3543;3566.197605538759;3608.729345299113;3628.727845411605;1199.562159811671;1262.6906407930117;1274.6622145131548;1281.0264199208575;1282.7562763074986;11974.820377694341;11988.160828741991;12022.15844890858;12023.27860328383;12048.216865903776;4461.776911154429;4639.837605683785;4680.906381872343;4706.647001474903;4709.270063140219;9991.950040249898;10091.192704583616;10123.64567240143;10130.746731331628;10165.034321739422;5245.501677340647;5252.737363131828;5268.1834315681135;5272.209168624737;5286.656367336111;4358.629516491071;4780.49804770501;4886.120498310338;5027.572656324181;5060;4205.306124489486;4210.7684077375425;4227.091175397304;4243.405923170759;4264.0832221072615;1331.2079312808862;1335.946562137523;1343.9798403023963;1370.41757253167;1370.7464119137992;1061.400308825511;1063.9893601064045;1064.8775390830153;1067.530286673861;1081.7620123572801;6188.690565471708;6421.197350331208;6446.677666116675;6448.838779030561;6454.580452270681;493.0607193296775;497.9800807967713;501.0655128185907;507.9339685840891;510.7318657704661;4348.08576718628;4411.382406463098;4480.574345437179;4487.28203487447;4489.124620698998;11040.33757974508;11258.493367798304;11409.828852567218;11433.085353171726;11458.656240312805;11097.1122310215;11128.38793866345;11216.719582010515;11246.1565382595;11283.435828208721;8505.574721263913;8550.529720865412;8571.742847714579;8643.740687779251;8693.869591956125;6269.467095296768;6343.175387199634;6442;6479.51403644738;6548.8362790930605;10044.447555384524;10246.129079028366;10319.896801031893;10366.792664146826;10423.68728938133;10488.947555262175;10593.841092383775;10622;10623;10785.460726963778;7058.223595404604;8099.797505062421;8111.026676798822;8111.553864537271;8336;9012.504312262627;9034.096590340914;9063.592138353923;9080.682176123804;9100.180983711498;8035.959820200862;8240.258376746122;8245.464044837066;8299.253067223737;8342.08237093907;7921.247481489249;7926.286634202719;8000.279974802295;8037.316828069445;8046.718364857202;7305.269473052652;7359;7384.298491643285;7515.962420187864;7609.847803044019;5525.502704756591;5566.359868615161;5616.719164041863;5640.717964101696;5667.801626943202;5629.802956896489;5722.313322401338;5743.827685169452;5752.7698892043845;5755 06:37:32 INFO - PROCESS | 3119 | |4;prototype.html;336.776043930786;347.3747254941105;356.0564504064229;357.5191367610563;366.24736167176457;5636.746346414411;5638.802641907534;5642.322921249451;5698.774763425863;5699.601027928046;5567.830755541331;5584.849832814365;5599.356074051485;5639.577031722617;5651.9152212716845;4014.27743006258;4407.2507673695545;4452.131834292314;4454;4465.196264672358;4435.268180750172;4439.822407103712;4464.263396539567;4464.8214071437105;4469.351943968123;4427.645788336926;4432.822687092528;4453.198424283628;4459.353393757903;4460.866174014768;4275.722078064916;4396.3625274335045;4397.868063958054;4408.559144085598;4409.713368631029;3882.2235552889533;3900.609939006105;3926.214757048573;3935.4687117239378;3966.702497312684;5423.213634023084;5460.563154947595;5470.370907345667;5475.808346707886;5481.808136715235;4823.855284341475;4995.950040499585;5044.511868998654;5046.243063540462;5049.798008079672;5855.912161317584;5882.794027224409;5898.64608123514;5915.526757859361;5939.554533409968;4269.829206831723;4281.593248641374;4284.250256205151;4294.785260736982;4306.267934451151;5914.852128696817;6022.427869352405;6027.156198132265;6082.60463069899;6089.620260755235;4315.244832154361;4324.221640104812;4336.241157797373;4345.130973805251;4358.585934336233;4382.5179230285285;4389.068809723775;4403.996181737301;4406.876246557107;4410.80151393188;4886.047220791911;4941.876453088702;4957.355543779286;4983.352164218701;4986.526280003394;5836.270466191726;5848.3274423441;5865.237519122486;5875.941240587625;5882.529397648178;1484.688215474741;1513.583764464759;1529.8776097912362;1530.568918061616;1533.5092770313615;954.174638937328;963.9903600964041;975.2246963663904;1039.9168066554657;1061.3260579532052;5678.034734095214;5717.971410143005;5741.311042674905;5750.367459579443;5765.740541675635;6110.114033465123;6128.4790792783115;6144.78493252734;6147.200863887666;6173.32093469718;5584.5811564132855;5646.350669672958;5661.065924122474;5668.744906479218;5674;3222.693844084808;3227.4351988402404;3243.772935894465;3249.0740139060727;3260;6093.29927058394;6185.814305632603;6312.43188113072;6349.936500635027;6355.872882542416;6135.202423684892;6144.324124346318;6159.599626024294;6161.4146656067605;6179.443850053517;5989.550783691154;6165.414285642857;6192.195014648157;6197.628142311476;6203.937960620427;5994.051933121666;5999.91000135007;6004.189434426296;6036.245469316335;6055.394460553909;5916.7041647918295;5924.733386997682;5935.465808077293;5954.553408494294;5981.581289309706;6006.909896351645;6256.249250090018;6311.5384999849175;6318.905216421849;6328.841778955563;4354.129174165117;4358.346248062816;4395.911941827606;4399.1641588098155;4424.513303536544;5908;5997.250343707036;6084.939150608438;6112.602680825732;6112.663803490851;5868.413158684269;5869.886840737246;5880.765039341786;5880.882382352414;5926.377730338252;5707.68607726579;5801.274840644919;5805.158252053513;5835.183074369506;5835.67903765297;5438.592105592175;5734.197212390185;5786.942130578809;5808.564357673107;5854.795082172103;5911.615744976562;5923.541730181926;5949.315828679584;5956.76172953077;5984.31180414258;5595.804146854841;5775.33583637887;5800.7667048187595;5807.950825816481;5837.591368604157 06:37:32 INFO - PROCESS | 3119 | |5;yui.html;797.584287888997;818.496624575886;890.8841850559427;903.0743487924881;921.8801555797743;15429.845701542981;15431.459898903526;15558.144302063381;16283.592910177236;17282.481525554238;15327.080375177497;16155.515334539954;16170.75743863843;16517.91741041293;16526.25631846567;870.5647176411794;875.251659830845;877.8112705768259;878.3061381508601;881.2949640287744;835.2107258640588;867.1415298854153;867.5965675960678;872.8254349130168;876.2989608313324;916.4272329793879;918.545320066568;920.7652048727565;921.3780698028837;922.6678395777515;902.5216635183364;908.4776253654143;908.7728067983004;910.7905181808155;912.5346073502528;667.0760996020547;669.0866966590618;669.1869378704848;670.8825955457776;671.0605152786089;15135.697286054326;15171.544853654408;15252;15274.847251527453;15364.923175384052;14809.165597809179;14888.776668349983;15481.922590386976;15543.766843497357;15844.128572928485;14233.50182743599;14365.640858978504;14409.927950360287;14432;14438.855611443856;4729.574338309569;4792;4804.8318308859025;4822.397200349957;4824.686395384324;83245;83800.58099709524;83859;83892.16107838905;84362;11694.649160525198;11876.821847672292;11904.107191960464;11936.343501107349;12080.093992950564;21963.450913727283;22074.779252207594;22097.116115355526;22144.88927555352;22942;8863.202311791969;8863.64545418189;8896.110388961051;8969.865452018224;8973.970417993556;4927.679700819435;4956.058348913695;4980.551750342486;5021.84934451967;5061.974690126526;3613.223157021253;3705.2219034002624;3726.0312318796764;3728.3102626014274;3728.738988270795;607.4593611685603;618.1839971238013;640.8205702403335;643.1414062226979;666.1805978646292;713.3579778199662;770;770.1951460723558;772.2277722277722;774.9186335434811;10062.295639305179;10346.32748871321;10420.478976051167;10496.68509944703;10669.466526673636;634.6445990245477;640.6732566391081;720.8522252938135;729.2306616519517;750.9962450187714;5038.193888977746;5075.238714192827;5082.822101226439;5095.821646242363;5161.200013997836;113297.4335128319;123423.38288308501;123798;126264;126772.36613816871;99682.5015874916;104893;105911;106041;107138;79052;92951.53524232336;92980.53509732409;93075;93684.53157734303;9554.235661146953;9736.610535578497;10449.373037617766;10757.193210509087;10806;43618.781906091535;45539;48203.27695084647;48851;52208;64630.41478340814;74967.62516187385;77919.61040194763;78540.21459785558;79090;14024.789628155382;14053.789193162314;14104.576862693724;14189;14253.64365890861;15417.537473875802;15601.369417997079;15649.139297338756;15992;16162.838371616604;14539.418423263374;14631.85368146305;15256.466023689118;15324;15752.448664296695;14829.406823727362;15018.249087545797;15096.24518774035;15312.617184570476;15901.52295431139;14377.21429671707;14773.92613036928;14965.850341496882;14966.476173333882;15011.099334039993;11749.647510574696;11917;12217.328046957502;12252.693682658004;12594.496220151457;12179.512819487121;12491.937540312603;12757;12808.103432759617;12857.871421286041 06:37:32 INFO - PROCESS | 3119 | __end_tp_report 06:37:32 INFO - PROCESS | 3119 | __start_cc_report 06:37:32 INFO - PROCESS | 3119 | _x_x_mozilla_cycle_collect,329 06:37:32 INFO - PROCESS | 3119 | __end_cc_report 06:37:32 INFO - PROCESS | 3119 | __startTimestamp1469453852115__endTimestamp 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | ------- Summary: start ------- 06:37:32 INFO - PROCESS | 3119 | Number of tests: 6 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | [#0] dojo.html Cycles:165 Average:5667.08 Median:5897.85 stddev:629.09 (10.7%) stddev-sans-first:604.27 06:37:32 INFO - PROCESS | 3119 | Values: 3353.1 3376.4 3377.4 3384.7 3385.1 5603.7 5658.7 5681.7 5690.0 5749.0 5710.3 5732.2 5735.0 5754.2 5757.5 5158.9 5244.9 5278.0 5337.9 5351.3 5108.6 5111.6 5338.3 5343.9 5355.9 5215.6 5221.1 5238.0 5245.2 5273.6 5199.2 5212.5 5264.0 5265.8 5271.8 5130.8 5172.0 5240.5 5247.0 5276.7 5400.3 5483.5 5503.0 5535.9 5554.9 6066.5 6088.7 6097.5 6102.8 6108.8 5943.5 6140.0 6142.8 6149.2 6167.7 5567.8 5614.1 5614.8 5663.7 5693.6 6132.8 6189.9 6195.3 6203.2 6206.2 5787.7 5909.3 5939.5 5958.9 5977.8 6023.7 6115.6 6132.6 6140.8 6146.1 6042.2 6047.1 6061.4 6086.1 6099.2 5842.3 5983.6 5985.9 6065.8 6089.5 4639.8 4641.8 4648.8 4702.6 4709.2 4138.4 4177.8 4187.6 4197.2 4222.7 5781.7 5825.7 5838.8 5874.6 5879.2 5990.5 6052.5 6132.8 6142.7 6143.7 5876.1 5884.5 5897.9 5906.6 5913.3 5089.9 5116.7 5165.9 5171.8 5187.6 6340.6 6373.1 6395.5 6408.9 6428.3 5896.1 6135.5 6142.3 6151.8 6152.2 6136.1 6265.1 6330.5 6393.5 6440.3 5971.6 6000.7 6005.6 6010.7 6011.6 5858.3 5953.4 6050.4 6068.0 6113.4 5938.0 6017.3 6019.2 6022.3 6069.8 5966.8 6002.0 6004.8 6024.4 6030.9 5684.9 5767.0 5797.9 5888.3 5957.9 5967.3 6027.8 6041.8 6042.2 6056.1 5889.9 5893.0 5901.5 5906.4 5925.6 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | [#1] ext.html Cycles:180 Average:73762.49 Median:40213.20 stddev:185134.23 (460.4%) stddev-sans-first:185572.06 06:37:32 INFO - PROCESS | 3119 | Values: 591.8 647.4 657.6 658.3 664.9 33724.8 36590.6 45415.3 46146.5 46352.3 47277.5 47429.5 47808.0 48201.8 48219.3 8987.2 9125.6 9138.2 9139.4 9150.5 8932.5 9019.2 9025.4 9026.2 9039.6 9123.3 9127.8 9141.8 9154.0 9174.9 9026.5 9069.4 9078.2 9092.7 9096.1 8822.1 8858.3 8912.6 8928.2 8945.8 44414.8 44646.0 44657.3 44800.0 44876.0 3672.7 3819.5 3825.6 3842.8 3930.5 33437.8 33626.3 33815.5 33891.8 34511.3 4523.8 4538.3 4565.3 4717.7 4742.3 386556.0 388490.0 390499.0 392067.0 393632.0 37586.0 38442.8 67181.7 67787.3 68323.7 39774.0 39977.4 40029.0 40177.4 40249.0 16791.4 16931.4 16991.4 16995.5 17009.5 13160.9 13166.4 13180.5 13217.5 13255.1 8966.6 8995.6 9012.4 9042.2 9068.2 3411.3 3489.2 3513.6 3521.8 3577.3 1046.5 1094.9 1106.9 1147.5 1155.9 34769.0 35267.5 35747.0 37767.0 37779.6 1139.7 1212.0 1229.6 1238.7 1332.0 17256.6 17347.3 17358.3 17395.7 17491.1 659112.0 1067841.0 1088664.0 1104356.0 1136054.0 59008.7 59467.0 59640.2 59910.4 60116.0 1428.6 1432.4 1433.8 1441.2 1451.8 31604.8 32640.2 32708.7 32951.0 33061.3 51471.7 51610.0 52329.0 52384.5 52494.0 425112.0 429088.0 430689.0 430936.0 431204.0 28097.0 28767.9 28847.3 28892.3 28919.7 46663.5 47227.5 47905.0 48078.3 48113.8 39317.0 40176.0 40422.4 40575.6 40930.4 39903.8 39904.0 40306.6 40663.0 41097.8 40398.6 40680.6 41140.6 41180.0 41605.4 34788.3 35221.6 35629.6 36679.0 36853.6 28055.9 28156.3 28246.9 28330.2 28501.7 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | [#2] jquery.html Cycles:180 Average:28569.77 Median:23996.52 stddev:79698.09 (332.1%) stddev-sans-first:79893.59 06:37:32 INFO - PROCESS | 3119 | Values: 395.1 396.5 398.5 409.6 416.1 18405.0 20206.0 20249.6 20380.7 21556.5 17837.9 18043.4 19574.6 20298.6 20304.9 5541.4 5592.6 5776.7 5785.5 5810.1 5583.5 5635.2 5645.2 5680.3 5681.8 5563.6 5581.4 5714.4 5731.9 5744.7 5653.4 5655.2 5717.7 5723.2 5735.1 4870.6 4975.6 5001.6 5029.1 5058.7 23220.5 23440.6 23713.6 23940.2 24052.9 2505.1 2527.7 2534.2 2664.4 2778.3 14230.8 14766.7 15003.1 15148.9 15223.5 2071.9 2085.8 2096.0 2096.2 2123.3 62053.4 63733.4 73418.3 84611.6 85696.1 11278.8 11703.7 11876.4 11878.7 11900.6 16867.9 17070.7 17143.8 17150.7 17183.7 8883.0 8942.6 8988.4 9100.8 9142.5 8587.2 8622.9 8742.2 8755.4 8871.6 5004.2 5016.7 5046.7 5068.3 5073.3 2053.7 2082.1 2086.5 2122.3 2172.4 984.4 997.1 1020.4 1023.9 1046.6 18149.0 19470.4 19898.5 19971.0 20030.3 1054.3 1057.3 1092.3 1093.1 1105.3 11029.7 11226.2 11337.5 11407.3 11422.7 426328.0 430730.0 438400.0 549323.0 557233.0 83028.6 91440.5 91958.5 93411.5 94465.5 1054.2 1071.4 1097.1 1114.1 1117.2 17686.0 17786.6 17876.7 18016.5 18141.8 33627.3 38817.0 40564.0 41339.8 41874.8 52250.7 55391.7 55911.2 57191.7 58241.7 8043.7 8187.9 8225.5 8277.9 8376.2 7184.9 11020.5 11409.9 12172.1 12471.3 10958.9 10986.6 11004.2 11052.4 11644.9 10784.5 10857.1 10916.3 10924.6 11132.5 11168.8 11245.1 11308.8 11324.4 11434.7 8181.4 8243.5 8312.6 8363.8 8530.8 11208.6 11238.8 11279.4 11324.1 11338.7 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | [#3] mootools.html Cycles:180 Average:5995.27 Median:4564.48 stddev:3358.84 (73.6%) stddev-sans-first:3351.53 06:37:32 INFO - PROCESS | 3119 | Values: 1534.3 1547.8 1748.0 1838.6 1877.0 7638.1 8649.3 8764.8 9298.8 9302.5 8716.9 8930.9 8993.3 9068.9 9094.5 2368.2 2403.7 2407.8 2408.0 2408.5 2388.1 2393.1 2413.5 2416.9 2433.7 2401.4 2410.3 2413.7 2429.6 2432.2 2331.7 2332.3 2346.0 2364.5 2372.0 2386.2 2396.6 2408.9 2415.3 2421.5 9067.3 9105.3 9116.3 9144.7 9152.6 5198.1 5275.3 5284.3 5313.3 5338.9 3440.3 3543.0 3566.2 3608.7 3628.7 1199.6 1262.7 1274.7 1281.0 1282.8 11974.8 11988.2 12022.2 12023.3 12048.2 4461.8 4639.8 4680.9 4706.6 4709.3 9992.0 10091.2 10123.6 10130.7 10165.0 5245.5 5252.7 5268.2 5272.2 5286.7 4358.6 4780.5 4886.1 5027.6 5060.0 4205.3 4210.8 4227.1 4243.4 4264.1 1331.2 1335.9 1344.0 1370.4 1370.7 1061.4 1064.0 1064.9 1067.5 1081.8 6188.7 6421.2 6446.7 6448.8 6454.6 493.1 498.0 501.1 507.9 510.7 4348.1 4411.4 4480.6 4487.3 4489.1 11040.3 11258.5 11409.8 11433.1 11458.7 11097.1 11128.4 11216.7 11246.2 11283.4 8505.6 8550.5 8571.7 8643.7 8693.9 6269.5 6343.2 6442.0 6479.5 6548.8 10044.4 10246.1 10319.9 10366.8 10423.7 10488.9 10593.8 10622.0 10623.0 10785.5 7058.2 8099.8 8111.0 8111.6 8336.0 9012.5 9034.1 9063.6 9080.7 9100.2 8036.0 8240.3 8245.5 8299.3 8342.1 7921.2 7926.3 8000.3 8037.3 8046.7 7305.3 7359.0 7384.3 7516.0 7609.8 5525.5 5566.4 5616.7 5640.7 5667.8 5629.8 5722.3 5743.8 5752.8 5755.0 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | [#4] prototype.html Cycles:180 Average:4971.98 Median:5671.37 stddev:1450.15 (25.6%) stddev-sans-first:1411.86 06:37:32 INFO - PROCESS | 3119 | Values: 336.8 347.4 356.1 357.5 366.2 5636.7 5638.8 5642.3 5698.8 5699.6 5567.8 5584.8 5599.4 5639.6 5651.9 4014.3 4407.3 4452.1 4454.0 4465.2 4435.3 4439.8 4464.3 4464.8 4469.4 4427.6 4432.8 4453.2 4459.4 4460.9 4275.7 4396.4 4397.9 4408.6 4409.7 3882.2 3900.6 3926.2 3935.5 3966.7 5423.2 5460.6 5470.4 5475.8 5481.8 4823.9 4996.0 5044.5 5046.2 5049.8 5855.9 5882.8 5898.6 5915.5 5939.6 4269.8 4281.6 4284.3 4294.8 4306.3 5914.9 6022.4 6027.2 6082.6 6089.6 4315.2 4324.2 4336.2 4345.1 4358.6 4382.5 4389.1 4404.0 4406.9 4410.8 4886.0 4941.9 4957.4 4983.4 4986.5 5836.3 5848.3 5865.2 5875.9 5882.5 1484.7 1513.6 1529.9 1530.6 1533.5 954.2 964.0 975.2 1039.9 1061.3 5678.0 5718.0 5741.3 5750.4 5765.7 6110.1 6128.5 6144.8 6147.2 6173.3 5584.6 5646.4 5661.1 5668.7 5674.0 3222.7 3227.4 3243.8 3249.1 3260.0 6093.3 6185.8 6312.4 6349.9 6355.9 6135.2 6144.3 6159.6 6161.4 6179.4 5989.6 6165.4 6192.2 6197.6 6203.9 5994.1 5999.9 6004.2 6036.2 6055.4 5916.7 5924.7 5935.5 5954.6 5981.6 6006.9 6256.2 6311.5 6318.9 6328.8 4354.1 4358.3 4395.9 4399.2 4424.5 5908.0 5997.3 6084.9 6112.6 6112.7 5868.4 5869.9 5880.8 5880.9 5926.4 5707.7 5801.3 5805.2 5835.2 5835.7 5438.6 5734.2 5786.9 5808.6 5854.8 5911.6 5923.5 5949.3 5956.8 5984.3 5595.8 5775.3 5800.8 5808.0 5837.6 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - PROCESS | 3119 | [#5] yui.html Cycles:180 Average:21963.81 Median:3728.52 stddev:31491.58 (844.6%) stddev-sans-first:31539.82 06:37:32 INFO - PROCESS | 3119 | Values: 797.6 818.5 890.9 903.1 921.9 15429.8 15431.5 15558.1 16283.6 17282.5 15327.1 16155.5 16170.8 16517.9 16526.3 870.6 875.3 877.8 878.3 881.3 835.2 867.1 867.6 872.8 876.3 916.4 918.5 920.8 921.4 922.7 902.5 908.5 908.8 910.8 912.5 667.1 669.1 669.2 670.9 671.1 15135.7 15171.5 15252.0 15274.8 15364.9 14809.2 14888.8 15481.9 15543.8 15844.1 14233.5 14365.6 14409.9 14432.0 14438.9 4729.6 4792.0 4804.8 4822.4 4824.7 83245.0 83800.6 83859.0 83892.2 84362.0 11694.6 11876.8 11904.1 11936.3 12080.1 21963.5 22074.8 22097.1 22144.9 22942.0 8863.2 8863.6 8896.1 8969.9 8974.0 4927.7 4956.1 4980.6 5021.8 5062.0 3613.2 3705.2 3726.0 3728.3 3728.7 607.5 618.2 640.8 643.1 666.2 713.4 770.0 770.2 772.2 774.9 10062.3 10346.3 10420.5 10496.7 10669.5 634.6 640.7 720.9 729.2 751.0 5038.2 5075.2 5082.8 5095.8 5161.2 113297.4 123423.4 123798.0 126264.0 126772.4 99682.5 104893.0 105911.0 106041.0 107138.0 79052.0 92951.5 92980.5 93075.0 93684.5 9554.2 9736.6 10449.4 10757.2 10806.0 43618.8 45539.0 48203.3 48851.0 52208.0 64630.4 74967.6 77919.6 78540.2 79090.0 14024.8 14053.8 14104.6 14189.0 14253.6 15417.5 15601.4 15649.1 15992.0 16162.8 14539.4 14631.9 15256.5 15324.0 15752.4 14829.4 15018.2 15096.2 15312.6 15901.5 14377.2 14773.9 14965.9 14966.5 15011.1 11749.6 11917.0 12217.3 12252.7 12594.5 12179.5 12491.9 12757.0 12808.1 12857.9 06:37:32 INFO - PROCESS | 3119 | -------- Summary: end -------- 06:37:32 INFO - PROCESS | 3119 | 06:37:32 INFO - TEST-INFO | 3119: exit 0 06:37:32 INFO - TEST-OK | dromaeo_css | took 1109718ms 06:37:32 INFO - TEST-START | kraken 06:37:32 INFO - operating with platform_type : linux_ 06:37:32 INFO - Initialising browser for kraken test... 06:37:32 INFO - TEST-INFO | started process 3369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDCORF/profile http://localhost:41335/getInfo.html) 06:37:37 INFO - PROCESS | 3369 | __metrics Screen width/height:1600/1200 06:37:37 INFO - PROCESS | 3369 | colorDepth:24 06:37:37 INFO - PROCESS | 3369 | Browser inner width/height: 1024/697 06:37:37 INFO - PROCESS | 3369 | __metrics 06:37:37 ERROR - PROCESS | 3369 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:37:38 INFO - TEST-INFO | 3369: exit 0 06:37:38 INFO - Browser initialized. 06:37:38 INFO - Running cycle 1/1 for kraken test... 06:37:38 INFO - TEST-INFO | started process 3498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDCORF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:50 INFO - PROCESS | 3498 | RSS: Main: 155951104 06:37:50 INFO - PROCESS | 3498 | 06:37:52 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41335/tests/kraken/driver.html?testName=audio-beat-detection) 06:37:53 INFO - PROCESS | 3498 | RSS: Main: 161587200 06:37:53 INFO - PROCESS | 3498 | 06:37:56 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41335/tests/kraken/driver.html?testName=audio-dft) 06:37:56 INFO - PROCESS | 3498 | RSS: Main: 160481280 06:37:56 INFO - PROCESS | 3498 | 06:37:59 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41335/tests/kraken/driver.html?testName=audio-fft) 06:38:00 INFO - PROCESS | 3498 | RSS: Main: 161501184 06:38:00 INFO - PROCESS | 3498 | 06:38:02 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41335/tests/kraken/driver.html?testName=audio-oscillator) 06:38:03 INFO - PROCESS | 3498 | RSS: Main: 160722944 06:38:03 INFO - PROCESS | 3498 | 06:38:05 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:05 INFO - PROCESS | 3498 | RSS: Main: 160776192 06:38:05 INFO - PROCESS | 3498 | 06:38:08 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41335/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:09 INFO - PROCESS | 3498 | RSS: Main: 160473088 06:38:09 INFO - PROCESS | 3498 | 06:38:12 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41335/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:13 INFO - PROCESS | 3498 | RSS: Main: 161157120 06:38:13 INFO - PROCESS | 3498 | 06:38:16 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41335/tests/kraken/driver.html?testName=json-parse-financial) 06:38:17 INFO - PROCESS | 3498 | RSS: Main: 161038336 06:38:17 INFO - PROCESS | 3498 | 06:38:18 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:19 INFO - PROCESS | 3498 | RSS: Main: 160804864 06:38:19 INFO - PROCESS | 3498 | 06:38:20 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:21 INFO - PROCESS | 3498 | RSS: Main: 160600064 06:38:21 INFO - PROCESS | 3498 | 06:38:23 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:24 INFO - PROCESS | 3498 | RSS: Main: 161325056 06:38:24 INFO - PROCESS | 3498 | 06:38:26 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:27 INFO - PROCESS | 3498 | RSS: Main: 161755136 06:38:27 INFO - PROCESS | 3498 | 06:38:30 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:30 INFO - PROCESS | 3498 | RSS: Main: 161882112 06:38:30 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:41335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41335/tests/kraken/driver.html?testName=ai-astar) 06:38:32 INFO - PROCESS | 3498 | RSS: Main: 162086912 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | __start_tp_report 06:38:32 INFO - PROCESS | 3498 | _x_x_mozilla_page_load 06:38:32 INFO - PROCESS | 3498 | _x_x_mozilla_page_load_details 06:38:32 INFO - PROCESS | 3498 | |i|pagename|runs| 06:38:32 INFO - PROCESS | 3498 | |0;ai-astar;112;107;112;110;110;112;112;112;110;111 06:38:32 INFO - PROCESS | 3498 | |1;audio-beat-detection;153;125;151;171;125;158;154;130;179;126 06:38:32 INFO - PROCESS | 3498 | |2;audio-dft;163;164;161;162;163;161;161;162;163;162 06:38:32 INFO - PROCESS | 3498 | |3;audio-fft;75;84;74;169;78;77;75;76;171;76 06:38:32 INFO - PROCESS | 3498 | |4;audio-oscillator;85;86;152;85;85;84;149;84;84;153 06:38:32 INFO - PROCESS | 3498 | |5;imaging-gaussian-blur;117;119;117;117;118;119;117;117;117;119 06:38:32 INFO - PROCESS | 3498 | |6;imaging-darkroom;150;147;148;147;147;148;147;146;146;148 06:38:32 INFO - PROCESS | 3498 | |7;imaging-desaturate;95;96;100;95;95;96;96;96;95;95 06:38:32 INFO - PROCESS | 3498 | |8;json-parse-financial;52;52;52;52;52;56;54;55;53;52 06:38:32 INFO - PROCESS | 3498 | |9;json-stringify-tinderbox;60;60;59;60;60;59;61;58;60;60 06:38:32 INFO - PROCESS | 3498 | |10;stanford-crypto-aes;77;76;75;75;77;77;79;82;106;79 06:38:32 INFO - PROCESS | 3498 | |11;stanford-crypto-ccm;125;143;127;118;120;118;130;126;132;122 06:38:32 INFO - PROCESS | 3498 | |12;stanford-crypto-pbkdf2;155;157;158;151;153;152;154;156;151;160 06:38:32 INFO - PROCESS | 3498 | |13;stanford-crypto-sha256-iterative;65;62;71;63;67;68;60;60;60;62 06:38:32 INFO - PROCESS | 3498 | __end_tp_report 06:38:32 INFO - PROCESS | 3498 | __start_cc_report 06:38:32 INFO - PROCESS | 3498 | _x_x_mozilla_cycle_collect,864 06:38:32 INFO - PROCESS | 3498 | __end_cc_report 06:38:32 INFO - PROCESS | 3498 | __startTimestamp1469453912621__endTimestamp 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | ------- Summary: start ------- 06:38:32 INFO - PROCESS | 3498 | Number of tests: 14 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:1.62 (1.4%) stddev-sans-first:1.66 06:38:32 INFO - PROCESS | 3498 | Values: 112.0 107.0 112.0 110.0 110.0 112.0 112.0 112.0 110.0 111.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.50 stddev:19.78 (12.9%) stddev-sans-first:20.86 06:38:32 INFO - PROCESS | 3498 | Values: 153.0 125.0 151.0 171.0 125.0 158.0 154.0 130.0 179.0 126.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 06:38:32 INFO - PROCESS | 3498 | Values: 163.0 164.0 161.0 162.0 163.0 161.0 161.0 162.0 163.0 162.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:39.37 (51.8%) stddev-sans-first:41.05 06:38:32 INFO - PROCESS | 3498 | Values: 75.0 84.0 74.0 169.0 78.0 77.0 75.0 76.0 171.0 76.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:84.50 stddev:32.20 (38.1%) stddev-sans-first:33.36 06:38:32 INFO - PROCESS | 3498 | Values: 85.0 86.0 152.0 85.0 85.0 84.0 149.0 84.0 84.0 153.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.50 stddev:0.95 (0.8%) stddev-sans-first:0.97 06:38:32 INFO - PROCESS | 3498 | Values: 117.0 119.0 117.0 117.0 118.0 119.0 117.0 117.0 117.0 119.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:0.78 06:38:32 INFO - PROCESS | 3498 | Values: 150.0 147.0 148.0 147.0 147.0 148.0 147.0 146.0 146.0 148.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:1.58 06:38:32 INFO - PROCESS | 3498 | Values: 95.0 96.0 100.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.50 stddev:1.49 (2.8%) stddev-sans-first:1.54 06:38:32 INFO - PROCESS | 3498 | Values: 52.0 52.0 52.0 52.0 52.0 56.0 54.0 55.0 53.0 52.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 06:38:32 INFO - PROCESS | 3498 | Values: 60.0 60.0 59.0 60.0 60.0 59.0 61.0 58.0 60.0 60.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:77.00 stddev:9.27 (12.0%) stddev-sans-first:9.76 06:38:32 INFO - PROCESS | 3498 | Values: 77.0 76.0 75.0 75.0 77.0 77.0 79.0 82.0 106.0 79.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.50 stddev:7.62 (6.0%) stddev-sans-first:8.07 06:38:32 INFO - PROCESS | 3498 | Values: 125.0 143.0 127.0 118.0 120.0 118.0 130.0 126.0 132.0 122.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.50 stddev:3.06 (2.0%) stddev-sans-first:3.24 06:38:32 INFO - PROCESS | 3498 | Values: 155.0 157.0 158.0 151.0 153.0 152.0 154.0 156.0 151.0 160.0 06:38:32 INFO - PROCESS | 3498 | 06:38:32 INFO - PROCESS | 3498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:3.82 (6.0%) stddev-sans-first:4.03 06:38:32 INFO - PROCESS | 3498 | Values: 65.0 62.0 71.0 63.0 67.0 68.0 60.0 60.0 60.0 62.0 06:38:32 INFO - PROCESS | 3498 | -------- Summary: end -------- 06:38:32 INFO - PROCESS | 3498 | 06:38:33 INFO - TEST-INFO | 3498: exit 0 06:38:33 INFO - TEST-OK | kraken | took 60731ms 06:38:33 INFO - SUITE-END | took 1170s 06:38:33 INFO - Completed test suite (00:19:30) 06:38:33 INFO - javascript benchmark 06:38:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7534.558328234613, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.0946644406013, 3376.409128402529, 3377.425837607608, 3384.678455546722, 3385.1198688341033, 5603.663780173192, 5658.688772117537, 5681.6591004539705, 5690.032694441945, 5748.971255143729, 5710.314762228539, 5732.168835518847, 5735.0, 5754.16564598133, 5757.481826635602, 5158.92261616076, 5244.921326180111, 5278.0, 5337.919931201035, 5351.304330437058, 5108.616853735966, 5111.565516931047, 5338.332708411449, 5343.866403339909, 5355.946440535603, 5215.608829337796, 5221.06020916235, 5238.030964271622, 5245.239440281157, 5273.551748101416, 5199.194124910626, 5212.452692467293, 5264.0, 5265.76304066318, 5271.762770675329, 5130.820421285237, 5172.0, 5240.528352448298, 5246.973765131188, 5276.657017293864, 5400.270963419927, 5483.479069488392, 5502.98194833953, 5535.861603459905, 5554.888902221974, 6066.545009124334, 6088.726007329681, 6097.481714054311, 6102.847428814271, 6108.786192483241, 5943.494802941756, 6140.048292514667, 6142.846428839315, 6149.2313460817395, 6167.722452489604, 5567.832965011015, 5614.101743720985, 5614.775408983635, 5663.66018038919, 5693.629914055573, 6132.816015519542, 6189.876202475925, 6195.31851496335, 6203.2245969253845, 6206.162168107338, 5787.71061446926, 5909.349971503131, 5939.46544810969, 5958.910616340759, 5977.820665380045, 6023.69881505923, 6115.602485838406, 6132.647712238782, 6140.84169297792, 6146.108814221912, 6042.214512113397, 6047.0929360596265, 6061.36355682647, 6086.117512960596, 6099.207103076572, 5842.298924129047, 5983.611065280743, 5985.880282394328, 6065.8180254592435, 6089.451949324582, 4639.768011599474, 4641.837535686234, 4648.767561621973, 4702.623790096784, 4709.1994360958715, 4138.420621113047, 4177.770222637784, 4187.6440502557625, 4197.202531519001, 4222.683298752606, 5781.682007489629, 5825.7087145642545, 5838.824835254949, 5874.559408044413, 5879.206307148565, 5990.520758339322, 6052.485538729169, 6132.816015519542, 6142.662153581507, 6143.70928694435, 5876.08920617305, 5884.47039766423, 5897.852553686193, 5906.5570082244, 5913.319968203712, 5089.898202035939, 5116.667416617983, 5165.9483405165465, 5171.844844654666, 5187.610929180251, 6340.587861788969, 6373.107764912916, 6395.52033597482, 6408.935910640834, 6428.292887782341, 5896.115582662464, 6135.509159267159, 6142.293636231891, 6151.84620384494, 6152.2002139722445, 6136.120845438751, 6265.122882796503, 6330.49356051524, 6393.520485963664, 6440.29156792743, 5971.641701497924, 6000.729967151576, 6005.6396616203165, 6010.729517171825, 6011.639301641915, 5858.2677165354335, 5953.374895635896, 6050.364711705208, 6067.969660151671, 6113.358097399887, 5938.020226662552, 6017.308009578955, 6019.217501724923, 6022.307434644897, 6069.817905462844, 5966.806638672196, 6002.0, 6004.819855404345, 6024.3975602439405, 6030.909536357046, 5684.9431505684415, 5767.048437007847, 5797.91303130445, 5888.293404791452, 5957.940420595739, 5967.313758917607, 6027.758889644365, 6041.78853740117, 6042.184305118929, 6056.06131049688, 5889.941100589111, 5892.970535147469, 5901.468867801918, 5906.350301466749, 5925.644461332334], "value": 5625.955150683701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7751254523281, 647.3752828520478, 657.5791493444193, 658.3186402073854, 664.8803215421225, 33724.83137584312, 36590.634093659086, 45415.31877021839, 46146.53853461464, 46352.304715429214, 47277.52722472774, 47429.52570474294, 47808.0, 48201.75899120508, 48219.276710849364, 8987.191152796247, 9125.634974601042, 9138.17756401927, 9139.405938613969, 9150.49672268025, 8932.508712020835, 9019.188273055424, 9025.41334813235, 9026.23277021454, 9039.59321830516, 9123.315751318645, 9127.817443651124, 9141.817163656722, 9153.954230228874, 9174.86237706435, 9026.458412495238, 9069.410488318272, 9078.228350590174, 9092.681756138569, 9096.090390960917, 8822.11778822119, 8858.29133669305, 8912.598933048028, 8928.24109950655, 8945.776355591097, 44414.77792611049, 44646.0, 44657.330140047925, 44800.0, 44876.0, 3672.6694597486353, 3819.52255968004, 3825.636564526393, 3842.7502212356108, 3930.5479869815053, 33437.83281083579, 33626.327473450394, 33815.492767608506, 33891.830540847135, 34511.30977380438, 4523.751193684346, 4538.29656403258, 4565.292379681155, 4717.669763116583, 4742.33607294979, 386556.0, 388490.0, 390499.0, 392067.0, 393632.0, 37586.0, 38442.80778596089, 67181.66409167922, 67787.3221267781, 68323.65838170778, 39774.0, 39977.400338994936, 40029.0, 40177.39733903994, 40249.0, 16791.41230056942, 16931.407400740914, 16991.40530081441, 16995.49013529596, 17009.489715308562, 13160.868391316155, 13166.407511661999, 13180.538681146305, 13217.471301147847, 13255.072144949761, 8966.551672416354, 8995.595198216097, 9012.41419307743, 9042.186203241608, 9068.22920051803, 3411.3347897159815, 3489.2498112905846, 3513.578370595545, 3521.841517131735, 3577.338192434408, 1046.4558429616557, 1094.885037071112, 1106.9446527673583, 1147.4721628051022, 1155.8959693627446, 34769.0, 35267.4709879352, 35747.0, 37767.0, 37779.62220377761, 1139.715071232192, 1212.0424864357235, 1229.6003798765437, 1238.6655602987323, 1331.993340033313, 17256.568585785204, 17347.3061077558, 17358.3056677734, 17395.695322850836, 17491.125443727764, 659112.0, 1067841.0, 1088664.0, 1104356.0, 1136054.0, 59008.7049564758, 59467.0, 59640.21079367626, 59910.400895991355, 60116.0, 1428.5928510374492, 1432.4341884955384, 1433.7992681024664, 1441.2361448432348, 1451.7604595241878, 31604.841975789976, 32640.183995400304, 32708.672913271515, 32951.0, 33061.33877322392, 51471.74264128655, 51610.0, 52329.0, 52384.47615523796, 52494.0, 425112.0, 429088.0, 430689.0, 430936.0, 431204.0, 28097.0, 28767.856160719064, 28847.278818028877, 28892.27769305784, 28919.710802891703, 46663.53336466592, 47227.52772472369, 47905.0, 48078.27882581694, 48113.75943120262, 39317.0, 40176.0, 40422.39366409565, 40575.59424405718, 40930.386044209954, 39903.80048099857, 39904.0, 40306.596934031455, 40663.0, 41097.794511027256, 40398.59601403948, 40680.59319406887, 41140.58859411367, 41180.0, 41605.37591936063, 34788.30423391467, 35221.64778352184, 35629.64370356367, 36679.0, 36853.63146368609, 28055.859720701264, 28156.296092597848, 28246.85876570604, 28330.150095497167, 28501.714982849906], "value": 19962.535157522932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.0755232755352, 396.48654991785634, 398.4640658314567, 409.60473143416607, 416.08807529402384, 18405.0, 20206.0, 20249.59500809983, 20380.694289585666, 21556.461088472755, 17837.91081044593, 18043.368482103127, 19574.60850782987, 20298.594028119427, 20304.898475507638, 5541.390447050821, 5592.552595792326, 5776.682282474462, 5785.537157027427, 5810.099434587646, 5583.5254003409755, 5635.21107045014, 5645.23789288447, 5680.346760122577, 5681.801136960207, 5563.582731295149, 5581.441855814427, 5714.3999880012625, 5731.914021289684, 5744.655320680752, 5653.406392328788, 5655.179998900157, 5717.714114294268, 5723.198752174699, 5735.053716136832, 4870.6103511718975, 4975.552200301954, 5001.574866136383, 5029.119904016819, 5058.747062646853, 23220.535589288287, 23440.64839027416, 23713.644295335584, 23940.162094326788, 24052.87973560121, 2505.08564374004, 2527.7093134289607, 2534.1890595009604, 2664.387190946074, 2778.305423644089, 14230.763503888787, 14766.704665906622, 15003.099814011195, 15148.939574229807, 15223.543293701206, 2071.927482538119, 2085.7914208579173, 2096.0462989339812, 2096.172012055245, 2123.3417640531484, 62053.37946620521, 63733.36266637367, 73418.26581734221, 84611.5769421149, 85696.14303856944, 11278.774424511628, 11703.654079780765, 11876.406179690981, 11878.703032424086, 11900.583479578174, 16867.91566042162, 17070.658586828195, 17143.828561714472, 17150.656986860442, 17183.742243866353, 8882.955585222033, 8942.552872356486, 8988.370814043084, 9100.772480687903, 9142.542872856464, 8587.22714955657, 8622.913770862337, 8742.169493898069, 8755.430896991675, 8871.64513419456, 5004.249362595567, 5016.698998060128, 5046.722430266297, 5068.315777370081, 5073.289739436482, 2053.7022131790804, 2082.094288984297, 2086.5201003769216, 2122.2784253353934, 2172.359154049559, 984.3798407003685, 997.102607653118, 1020.4489575629077, 1023.8976102389702, 1046.581367453025, 18149.0, 19470.415887523395, 19898.50253743668, 19971.0, 20030.298939537046, 1054.3041592548882, 1057.2704833664748, 1092.317301686446, 1093.0654290581597, 1105.2870898270571, 11029.724256893642, 11226.158038147172, 11337.526121604304, 11407.25852819564, 11422.714432139097, 426328.0, 430730.0, 438400.0, 549323.0, 557233.0, 83028.58485707533, 91440.54279728692, 91958.54020729853, 93411.53294233486, 94465.5276723612, 1054.2146101154535, 1071.4107241017566, 1097.1442275025493, 1114.0586204657052, 1117.2291119127776, 17686.0, 17786.644267114327, 17876.731849022013, 18016.459506214833, 18141.818581814012, 33627.32745345128, 38817.0, 40563.985900351545, 41339.7933010333, 41874.79062604668, 52250.73874630602, 55391.72304138453, 55911.16133258086, 57191.71404142953, 58241.70879145577, 8043.672793989161, 8187.877181842397, 8225.506469611842, 8277.875831862648, 8376.204260595234, 7184.928150718426, 11020.50407731638, 11409.885901140882, 12172.087093468203, 12471.314077725812, 10958.945205273923, 10986.560537578407, 11004.229703920648, 11052.392118433563, 11644.88355116438, 10784.460776961278, 10857.077148442471, 10916.290441121302, 10924.563017479211, 11132.499037543492, 11168.776624467302, 11245.100391968459, 11308.773824523629, 11324.433778310886, 11434.656960291204, 8181.427300089174, 8243.505389676639, 8312.584370781316, 8363.832723345377, 8530.78673033179, 11208.55165793359, 11238.775224495628, 11279.436028198721, 11324.094072474347, 11338.716532086433], "value": 9379.796713182395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.3479021415897, 1547.7755725419815, 1747.9563010924726, 1838.6322735452895, 1876.9812301876987, 7638.083429988395, 8649.264812490937, 8764.78088047799, 9298.767530811732, 9302.488363140033, 8716.91283087169, 8930.91069089309, 8993.325500587465, 9068.909310906889, 9094.54527273637, 2368.2066507719933, 2403.6995375578053, 2407.7832995030444, 2407.9638805417844, 2408.4701365699607, 2388.0925248405583, 2393.0906255622926, 2413.51729654069, 2416.903323867052, 2433.6957880264968, 2401.435662619283, 2410.2648692148887, 2413.650020746991, 2429.6234083717054, 2432.221689059502, 2331.6735657008035, 2332.265336419023, 2346.002948746776, 2364.527094581082, 2372.027468737818, 2386.1886958434043, 2396.6165413533927, 2408.903643854244, 2415.2995631266913, 2421.5278020785777, 9067.319951003701, 9105.317101217435, 9116.270698344117, 9144.725658230198, 9152.633894644207, 5198.090334191501, 5275.314209152824, 5284.339457567804, 5313.309269794902, 5338.866528336784, 3440.3119376124623, 3543.0, 3566.197605538759, 3608.729345299113, 3628.727845411605, 1199.562159811671, 1262.6906407930117, 1274.6622145131548, 1281.0264199208575, 1282.7562763074986, 11974.820377694341, 11988.160828741991, 12022.15844890858, 12023.27860328383, 12048.216865903776, 4461.776911154429, 4639.837605683785, 4680.906381872343, 4706.647001474903, 4709.270063140219, 9991.950040249898, 10091.192704583616, 10123.64567240143, 10130.746731331628, 10165.034321739422, 5245.501677340647, 5252.737363131828, 5268.1834315681135, 5272.209168624737, 5286.656367336111, 4358.629516491071, 4780.49804770501, 4886.120498310338, 5027.572656324181, 5060.0, 4205.306124489486, 4210.7684077375425, 4227.091175397304, 4243.405923170759, 4264.0832221072615, 1331.2079312808862, 1335.946562137523, 1343.9798403023963, 1370.41757253167, 1370.7464119137992, 1061.400308825511, 1063.9893601064045, 1064.8775390830153, 1067.530286673861, 1081.7620123572801, 6188.690565471708, 6421.197350331208, 6446.677666116675, 6448.838779030561, 6454.580452270681, 493.0607193296775, 497.9800807967713, 501.0655128185907, 507.9339685840891, 510.7318657704661, 4348.08576718628, 4411.382406463098, 4480.574345437179, 4487.28203487447, 4489.124620698998, 11040.33757974508, 11258.493367798304, 11409.828852567218, 11433.085353171726, 11458.656240312805, 11097.1122310215, 11128.38793866345, 11216.719582010515, 11246.1565382595, 11283.435828208721, 8505.574721263913, 8550.529720865412, 8571.742847714579, 8643.740687779251, 8693.869591956125, 6269.467095296768, 6343.175387199634, 6442.0, 6479.51403644738, 6548.8362790930605, 10044.447555384524, 10246.129079028366, 10319.896801031893, 10366.792664146826, 10423.68728938133, 10488.947555262175, 10593.841092383775, 10622.0, 10623.0, 10785.460726963778, 7058.223595404604, 8099.797505062421, 8111.026676798822, 8111.553864537271, 8336.0, 9012.504312262627, 9034.096590340914, 9063.592138353923, 9080.682176123804, 9100.180983711498, 8035.959820200862, 8240.258376746122, 8245.464044837066, 8299.253067223737, 8342.08237093907, 7921.247481489249, 7926.286634202719, 8000.279974802295, 8037.316828069445, 8046.718364857202, 7305.269473052652, 7359.0, 7384.298491643285, 7515.962420187864, 7609.847803044019, 5525.502704756591, 5566.359868615161, 5616.719164041863, 5640.717964101696, 5667.801626943202, 5629.802956896489, 5722.313322401338, 5743.827685169452, 5752.7698892043845, 5755.0], "value": 4758.4082270147865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.776043930786, 347.3747254941105, 356.0564504064229, 357.5191367610563, 366.24736167176457, 5636.746346414411, 5638.802641907534, 5642.322921249451, 5698.774763425863, 5699.601027928046, 5567.830755541331, 5584.849832814365, 5599.356074051485, 5639.577031722617, 5651.9152212716845, 4014.27743006258, 4407.2507673695545, 4452.131834292314, 4454.0, 4465.196264672358, 4435.268180750172, 4439.822407103712, 4464.263396539567, 4464.8214071437105, 4469.351943968123, 4427.645788336926, 4432.822687092528, 4453.198424283628, 4459.353393757903, 4460.866174014768, 4275.722078064916, 4396.3625274335045, 4397.868063958054, 4408.559144085598, 4409.713368631029, 3882.2235552889533, 3900.609939006105, 3926.214757048573, 3935.4687117239378, 3966.702497312684, 5423.213634023084, 5460.563154947595, 5470.370907345667, 5475.808346707886, 5481.808136715235, 4823.855284341475, 4995.950040499585, 5044.511868998654, 5046.243063540462, 5049.798008079672, 5855.912161317584, 5882.794027224409, 5898.64608123514, 5915.526757859361, 5939.554533409968, 4269.829206831723, 4281.593248641374, 4284.250256205151, 4294.785260736982, 4306.267934451151, 5914.852128696817, 6022.427869352405, 6027.156198132265, 6082.60463069899, 6089.620260755235, 4315.244832154361, 4324.221640104812, 4336.241157797373, 4345.130973805251, 4358.585934336233, 4382.5179230285285, 4389.068809723775, 4403.996181737301, 4406.876246557107, 4410.80151393188, 4886.047220791911, 4941.876453088702, 4957.355543779286, 4983.352164218701, 4986.526280003394, 5836.270466191726, 5848.3274423441, 5865.237519122486, 5875.941240587625, 5882.529397648178, 1484.688215474741, 1513.583764464759, 1529.8776097912362, 1530.568918061616, 1533.5092770313615, 954.174638937328, 963.9903600964041, 975.2246963663904, 1039.9168066554657, 1061.3260579532052, 5678.034734095214, 5717.971410143005, 5741.311042674905, 5750.367459579443, 5765.740541675635, 6110.114033465123, 6128.4790792783115, 6144.78493252734, 6147.200863887666, 6173.32093469718, 5584.5811564132855, 5646.350669672958, 5661.065924122474, 5668.744906479218, 5674.0, 3222.693844084808, 3227.4351988402404, 3243.772935894465, 3249.0740139060727, 3260.0, 6093.29927058394, 6185.814305632603, 6312.43188113072, 6349.936500635027, 6355.872882542416, 6135.202423684892, 6144.324124346318, 6159.599626024294, 6161.4146656067605, 6179.443850053517, 5989.550783691154, 6165.414285642857, 6192.195014648157, 6197.628142311476, 6203.937960620427, 5994.051933121666, 5999.91000135007, 6004.189434426296, 6036.245469316335, 6055.394460553909, 5916.7041647918295, 5924.733386997682, 5935.465808077293, 5954.553408494294, 5981.581289309706, 6006.909896351645, 6256.249250090018, 6311.5384999849175, 6318.905216421849, 6328.841778955563, 4354.129174165117, 4358.346248062816, 4395.911941827606, 4399.1641588098155, 4424.513303536544, 5908.0, 5997.250343707036, 6084.939150608438, 6112.602680825732, 6112.663803490851, 5868.413158684269, 5869.886840737246, 5880.765039341786, 5880.882382352414, 5926.377730338252, 5707.68607726579, 5801.274840644919, 5805.158252053513, 5835.183074369506, 5835.67903765297, 5438.592105592175, 5734.197212390185, 5786.942130578809, 5808.564357673107, 5854.795082172103, 5911.615744976562, 5923.541730181926, 5949.315828679584, 5956.76172953077, 5984.31180414258, 5595.804146854841, 5775.33583637887, 5800.7667048187595, 5807.950825816481, 5837.591368604157], "value": 4508.701048034221, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.584287888997, 818.496624575886, 890.8841850559427, 903.0743487924881, 921.8801555797743, 15429.845701542981, 15431.459898903526, 15558.144302063381, 16283.592910177236, 17282.481525554238, 15327.080375177497, 16155.515334539954, 16170.75743863843, 16517.91741041293, 16526.25631846567, 870.5647176411794, 875.251659830845, 877.8112705768259, 878.3061381508601, 881.2949640287744, 835.2107258640588, 867.1415298854153, 867.5965675960678, 872.8254349130168, 876.2989608313324, 916.4272329793879, 918.545320066568, 920.7652048727565, 921.3780698028837, 922.6678395777515, 902.5216635183364, 908.4776253654143, 908.7728067983004, 910.7905181808155, 912.5346073502528, 667.0760996020547, 669.0866966590618, 669.1869378704848, 670.8825955457776, 671.0605152786089, 15135.697286054326, 15171.544853654408, 15252.0, 15274.847251527453, 15364.923175384052, 14809.165597809179, 14888.776668349983, 15481.922590386976, 15543.766843497357, 15844.128572928485, 14233.50182743599, 14365.640858978504, 14409.927950360287, 14432.0, 14438.855611443856, 4729.574338309569, 4792.0, 4804.8318308859025, 4822.397200349957, 4824.686395384324, 83245.0, 83800.58099709524, 83859.0, 83892.16107838905, 84362.0, 11694.649160525198, 11876.821847672292, 11904.107191960464, 11936.343501107349, 12080.093992950564, 21963.450913727283, 22074.779252207594, 22097.116115355526, 22144.88927555352, 22942.0, 8863.202311791969, 8863.64545418189, 8896.110388961051, 8969.865452018224, 8973.970417993556, 4927.679700819435, 4956.058348913695, 4980.551750342486, 5021.84934451967, 5061.974690126526, 3613.223157021253, 3705.2219034002624, 3726.0312318796764, 3728.3102626014274, 3728.738988270795, 607.4593611685603, 618.1839971238013, 640.8205702403335, 643.1414062226979, 666.1805978646292, 713.3579778199662, 770.0, 770.1951460723558, 772.2277722277722, 774.9186335434811, 10062.295639305179, 10346.32748871321, 10420.478976051167, 10496.68509944703, 10669.466526673636, 634.6445990245477, 640.6732566391081, 720.8522252938135, 729.2306616519517, 750.9962450187714, 5038.193888977746, 5075.238714192827, 5082.822101226439, 5095.821646242363, 5161.200013997836, 113297.4335128319, 123423.38288308501, 123798.0, 126264.0, 126772.36613816871, 99682.5015874916, 104893.0, 105911.0, 106041.0, 107138.0, 79052.0, 92951.53524232336, 92980.53509732409, 93075.0, 93684.53157734303, 9554.235661146953, 9736.610535578497, 10449.373037617766, 10757.193210509087, 10806.0, 43618.781906091535, 45539.0, 48203.27695084647, 48851.0, 52208.0, 64630.41478340814, 74967.62516187385, 77919.61040194763, 78540.21459785558, 79090.0, 14024.789628155382, 14053.789193162314, 14104.576862693724, 14189.0, 14253.64365890861, 15417.537473875802, 15601.369417997079, 15649.139297338756, 15992.0, 16162.838371616604, 14539.418423263374, 14631.85368146305, 15256.466023689118, 15324.0, 15752.448664296695, 14829.406823727362, 15018.249087545797, 15096.24518774035, 15312.617184570476, 15901.52295431139, 14377.21429671707, 14773.92613036928, 14965.850341496882, 14966.476173333882, 15011.099334039993, 11749.647510574696, 11917.0, 12217.328046957502, 12252.693682658004, 12594.496220151457, 12179.512819487121, 12491.937540312603, 12757.0, 12808.103432759617, 12857.871421286041], "value": 8094.455269222405, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 112.0, 110.0, 110.0, 112.0, 112.0, 112.0, 110.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 151.0, 171.0, 125.0, 158.0, 154.0, 130.0, 179.0, 126.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 163.0, 161.0, 161.0, 162.0, 163.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 74.0, 169.0, 78.0, 77.0, 75.0, 76.0, 171.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 152.0, 85.0, 85.0, 84.0, 149.0, 84.0, 84.0, 153.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 100.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 52.0, 56.0, 54.0, 55.0, 53.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 61.0, 58.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 75.0, 77.0, 77.0, 79.0, 82.0, 106.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 143.0, 127.0, 118.0, 120.0, 118.0, 130.0, 126.0, 132.0, 122.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 158.0, 151.0, 153.0, 152.0, 154.0, 156.0, 151.0, 160.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 71.0, 63.0, 67.0, 68.0, 60.0, 60.0, 60.0, 62.0], "value": 63.8, "unit": "score"}]}]} 06:38:33 INFO - Return code: 0 06:38:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:38:33 ERROR - # TBPL SUCCESS # 06:38:33 INFO - Running post-action listener: _resource_record_post_action 06:38:33 INFO - ##### 06:38:33 INFO - ##### Finished run-tests step (success) 06:38:33 INFO - ##### 06:38:33 INFO - Running post-run listener: _resource_record_post_run 06:38:34 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272953344; Read time: 180; Write time: 136508 06:38:34 INFO - TinderboxPrint: CPU usage
13.3% 06:38:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 180 06:38:34 INFO - TinderboxPrint: I/O write bytes / time
272,953,344 / 136,508 06:38:34 INFO - TinderboxPrint: CPU idle
8,214.7 (86.7%) 06:38:34 INFO - TinderboxPrint: CPU user
1,211.1 (12.8%) 06:38:34 INFO - TinderboxPrint: Swap in / out
0 / 0 06:38:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 18976768; Read time: 0; Write time: 5964 06:38:34 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253976576; Read time: 180; Write time: 130544 06:38:34 INFO - Running post-run listener: _upload_blobber_files 06:38:34 INFO - Blob upload gear active. 06:38:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:34 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 06:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:38:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:38:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:38:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:36 INFO - (blobuploader) - INFO - Done attempting. 06:38:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:38:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:40 INFO - (blobuploader) - INFO - Done attempting. 06:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:41 INFO - (blobuploader) - INFO - Done attempting. 06:38:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:41 INFO - Return code: 0 06:38:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07153cbe2202ba144a0809221d1424836e0bea3ca2fc4be61235badf406c7a26656870cad00c62ce28aed0c70032e6315c9297e0b2b56a283ee9d9e7ff9eed7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b653373cd57aa60c1ecb9223bdc4933f3c8ce07b655d2a2a92b7dffe511806c3376b94f5ade9caea02a38f4d1069076a84994db2f0ec51a1a6a65f357328098c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d49acfe498029a5fd09c8d03dd07a6fa7b47048cfa4fca1fb8d9674c88660a46dba0c8170dac0c9c1217a1bcf5209b6d85e1f77c0c038a0ae627e43254692a24"} 06:38:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:41 INFO - Contents: 06:38:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07153cbe2202ba144a0809221d1424836e0bea3ca2fc4be61235badf406c7a26656870cad00c62ce28aed0c70032e6315c9297e0b2b56a283ee9d9e7ff9eed7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b653373cd57aa60c1ecb9223bdc4933f3c8ce07b655d2a2a92b7dffe511806c3376b94f5ade9caea02a38f4d1069076a84994db2f0ec51a1a6a65f357328098c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d49acfe498029a5fd09c8d03dd07a6fa7b47048cfa4fca1fb8d9674c88660a46dba0c8170dac0c9c1217a1bcf5209b6d85e1f77c0c038a0ae627e43254692a24"} 06:38:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:41 INFO - Copying logs to upload dir... 06:38:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.606606 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-25 06:38:40.734594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:40.737879) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07153cbe2202ba144a0809221d1424836e0bea3ca2fc4be61235badf406c7a26656870cad00c62ce28aed0c70032e6315c9297e0b2b56a283ee9d9e7ff9eed7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b653373cd57aa60c1ecb9223bdc4933f3c8ce07b655d2a2a92b7dffe511806c3376b94f5ade9caea02a38f4d1069076a84994db2f0ec51a1a6a65f357328098c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d49acfe498029a5fd09c8d03dd07a6fa7b47048cfa4fca1fb8d9674c88660a46dba0c8170dac0c9c1217a1bcf5209b6d85e1f77c0c038a0ae627e43254692a24"} build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07153cbe2202ba144a0809221d1424836e0bea3ca2fc4be61235badf406c7a26656870cad00c62ce28aed0c70032e6315c9297e0b2b56a283ee9d9e7ff9eed7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b653373cd57aa60c1ecb9223bdc4933f3c8ce07b655d2a2a92b7dffe511806c3376b94f5ade9caea02a38f4d1069076a84994db2f0ec51a1a6a65f357328098c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d49acfe498029a5fd09c8d03dd07a6fa7b47048cfa4fca1fb8d9674c88660a46dba0c8170dac0c9c1217a1bcf5209b6d85e1f77c0c038a0ae627e43254692a24"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:40.763840) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:40.764256) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469452075.602486-474540472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:38:40.849527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:38:40.849910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:38:40.850289) ========= ========= Total master_lag: 0.18 =========