builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0075 starttime: 1472744504.3 results: success (0) buildid: 20160901063021 builduid: 454f3ba842cf455db9fe498d68ed76b5 revision: 27ffae997b83a5bfeaf0967e692074cb097d94e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.297441) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.297963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.298282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.342569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.342895) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lKgqReHMpA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-01 08:41:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 15.3M=0.001s 2016-09-01 08:41:44 (15.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.348818 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.716718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.717150) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lKgqReHMpA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.028128 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:44.766939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 08:41:44.767343) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 27ffae997b83a5bfeaf0967e692074cb097d94e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 27ffae997b83a5bfeaf0967e692074cb097d94e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lKgqReHMpA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-01 08:41:44,840 truncating revision to first 12 chars 2016-09-01 08:41:44,840 Setting DEBUG logging. 2016-09-01 08:41:44,840 attempt 1/10 2016-09-01 08:41:44,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/27ffae997b83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 08:41:45,868 unpacking tar archive at: fx-team-27ffae997b83/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 08:41:46.074680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:46.075055) ========= script_repo_revision: 27ffae997b83a5bfeaf0967e692074cb097d94e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:46.075517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:46.075891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 08:41:46.095206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-09-01 08:41:46.095678) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lKgqReHMpA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:41:46 INFO - MultiFileLogger online at 20160901 08:41:46 in /builds/slave/test 08:41:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:41:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:46 INFO - {'append_to_log': False, 08:41:46 INFO - 'base_work_dir': '/builds/slave/test', 08:41:46 INFO - 'blob_upload_branch': 'Fx-Team', 08:41:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:46 INFO - 'branch': 'Fx-Team', 08:41:46 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:46 INFO - 'config_files': ('talos/mac_config.py',), 08:41:46 INFO - 'default_actions': ('clobber', 08:41:46 INFO - 'read-buildbot-config', 08:41:46 INFO - 'download-and-extract', 08:41:46 INFO - 'populate-webroot', 08:41:46 INFO - 'create-virtualenv', 08:41:46 INFO - 'install', 08:41:46 INFO - 'run-tests'), 08:41:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:46 INFO - 'download_minidump_stackwalk': True, 08:41:46 INFO - 'download_symbols': 'ondemand', 08:41:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:46 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:46 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:46 INFO - 'installer_path': 'installer.exe', 08:41:46 INFO - 'log_level': 'info', 08:41:46 INFO - 'log_name': 'talos', 08:41:46 INFO - 'log_to_console': True, 08:41:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:41:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:41:46 INFO - 'opt_config_files': (), 08:41:46 INFO - 'pip_index': False, 08:41:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:46 INFO - 'cmd': ('bash', 08:41:46 INFO - '-c', 08:41:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:46 INFO - 'enabled': True, 08:41:46 INFO - 'halt_on_failure': False, 08:41:46 INFO - 'name': 'check_screen_resolution'},), 08:41:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:46 INFO - 'cmd': ('bash', 08:41:46 INFO - '-c', 08:41:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:46 INFO - 'enabled': True, 08:41:46 INFO - 'halt_on_failure': False, 08:41:46 INFO - 'name': 'check_screen_resolution'},), 08:41:46 INFO - 'run_cmd_checks_enabled': True, 08:41:46 INFO - 'sps_profile': False, 08:41:46 INFO - 'sps_profile_interval': 0, 08:41:46 INFO - 'suite': 'dromaeojs-e10s', 08:41:46 INFO - 'system_bits': '32', 08:41:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:46 INFO - 'title': 't-yosemite-r7-0075', 08:41:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:46 INFO - 'use_talos_json': True, 08:41:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:46 INFO - 'work_dir': 'build'} 08:41:46 INFO - [mozharness: 2016-09-01 15:41:46.293615Z] Running clobber step. 08:41:46 INFO - Running pre-action listener: _resource_record_pre_action 08:41:46 INFO - Running main action method: clobber 08:41:46 INFO - rmtree: /builds/slave/test/build 08:41:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:48 INFO - Running post-action listener: _resource_record_post_action 08:41:48 INFO - [mozharness: 2016-09-01 15:41:48.681936Z] Finished clobber step (success) 08:41:48 INFO - [mozharness: 2016-09-01 15:41:48.682071Z] Running read-buildbot-config step. 08:41:48 INFO - Running pre-action listener: _resource_record_pre_action 08:41:48 INFO - Running main action method: read_buildbot_config 08:41:48 INFO - Using buildbot properties: 08:41:48 INFO - { 08:41:48 INFO - "project": "", 08:41:48 INFO - "product": "firefox", 08:41:48 INFO - "script_repo_revision": "production", 08:41:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:41:48 INFO - "repository": "", 08:41:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:41:48 INFO - "buildid": "20160901063021", 08:41:48 INFO - "pgo_build": "False", 08:41:48 INFO - "basedir": "/builds/slave/test", 08:41:48 INFO - "buildnumber": 88, 08:41:48 INFO - "slavename": "t-yosemite-r7-0075", 08:41:48 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:41:48 INFO - "platform": "yosemite_r7", 08:41:48 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:41:48 INFO - "branch": "fx-team", 08:41:48 INFO - "repo_path": "integration/fx-team", 08:41:48 INFO - "revision": "27ffae997b83a5bfeaf0967e692074cb097d94e8", 08:41:48 INFO - "stage_platform": "macosx64", 08:41:48 INFO - "builduid": "454f3ba842cf455db9fe498d68ed76b5", 08:41:48 INFO - "slavebuilddir": "test" 08:41:48 INFO - } 08:41:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:41:48 INFO - Running post-action listener: _resource_record_post_action 08:41:48 INFO - [mozharness: 2016-09-01 15:41:48.685180Z] Finished read-buildbot-config step (success) 08:41:48 INFO - [mozharness: 2016-09-01 15:41:48.685287Z] Running download-and-extract step. 08:41:48 INFO - Running pre-action listener: _resource_record_pre_action 08:41:48 INFO - Running main action method: download_and_extract 08:41:48 INFO - mkdir: /builds/slave/test/build/tests 08:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:48 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:41:48 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:41:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:41:49 INFO - Downloaded 1199 bytes. 08:41:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:41:49 INFO - Using the following test package requirements: 08:41:49 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:41:49 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:41:49 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:41:49 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'jsshell-mac.zip'], 08:41:49 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:41:49 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:41:49 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:41:49 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:41:49 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:41:49 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:41:49 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:41:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:41:49 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:49 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:41:49 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:41:50 INFO - Downloaded 16399864 bytes. 08:41:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:41:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:57 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:41:57 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:41:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:41:59 INFO - Downloaded 16399864 bytes. 08:41:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:05 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:42:06 INFO - Downloaded 14413998 bytes. 08:42:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 08:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:07 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:42:07 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:42:10 INFO - Downloaded 111597574 bytes. 08:42:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:42:10 INFO - mkdir: /builds/slave/test/properties 08:42:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:10 INFO - Contents: 08:42:10 INFO - build_url:https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:42:10 INFO - Running post-action listener: _resource_record_post_action 08:42:10 INFO - Running post-action listener: set_extra_try_arguments 08:42:10 INFO - [mozharness: 2016-09-01 15:42:10.890690Z] Finished download-and-extract step (success) 08:42:10 INFO - [mozharness: 2016-09-01 15:42:10.890833Z] Running populate-webroot step. 08:42:10 INFO - Running pre-action listener: _resource_record_pre_action 08:42:10 INFO - Running main action method: populate_webroot 08:42:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:10 INFO - '--tppagecycles', 08:42:10 INFO - '7'], 08:42:10 INFO - 'tests': ['tsvgm']}}, 08:42:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['damp', 'tps']}, 08:42:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'tests': ['damp', 'tps']}, 08:42:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['dromaeo_dom']}, 08:42:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['basic_compositor_video']}, 08:42:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['a11yr', 08:42:10 INFO - 'ts_paint', 08:42:10 INFO - 'tpaint', 08:42:10 INFO - 'sessionrestore', 08:42:10 INFO - 'sessionrestore_no_auto_restore', 08:42:10 INFO - 'tabpaint']}, 08:42:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:10 INFO - 'ts_paint', 08:42:10 INFO - 'tpaint', 08:42:10 INFO - 'sessionrestore', 08:42:10 INFO - 'sessionrestore_no_auto_restore', 08:42:10 INFO - 'tabpaint']}, 08:42:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:10 INFO - 'ts_paint', 08:42:10 INFO - 'tpaint', 08:42:10 INFO - 'sessionrestore', 08:42:10 INFO - 'sessionrestore_no_auto_restore', 08:42:10 INFO - 'tabpaint']}, 08:42:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:10 INFO - 'ts_paint', 08:42:10 INFO - 'tpaint', 08:42:10 INFO - 'sessionrestore', 08:42:10 INFO - 'sessionrestore_no_auto_restore', 08:42:10 INFO - 'tabpaint']}, 08:42:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['a11yr', 08:42:10 INFO - 'ts_paint', 08:42:10 INFO - 'tpaint', 08:42:10 INFO - 'sessionrestore', 08:42:10 INFO - 'sessionrestore_no_auto_restore', 08:42:10 INFO - 'tabpaint']}, 08:42:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['a11yr', 08:42:10 INFO - 'ts_paint', 08:42:10 INFO - 'tpaint', 08:42:10 INFO - 'sessionrestore', 08:42:10 INFO - 'sessionrestore_no_auto_restore', 08:42:10 INFO - 'tabpaint']}, 08:42:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['tsvgx', 08:42:10 INFO - 'tsvgr_opacity', 08:42:10 INFO - 'tart', 08:42:10 INFO - 'tscrollx', 08:42:10 INFO - 'cart']}, 08:42:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:10 INFO - 'tsvgr_opacity', 08:42:10 INFO - 'tart', 08:42:10 INFO - 'tscrollx', 08:42:10 INFO - 'cart']}, 08:42:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'talos_options': ['--disable-e10s'], 08:42:10 INFO - 'tests': ['tp5o']}, 08:42:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'tests': ['tp5o']}, 08:42:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'talos_options': ['--disable-e10s', 08:42:10 INFO - '--xperf_path', 08:42:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:10 INFO - 'tests': ['tp5n']}, 08:42:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:10 INFO - 'talos_options': ['--xperf_path', 08:42:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:10 INFO - 'tests': ['tp5n']}}, 08:42:10 INFO - 'talos.zip': {'path': '', 08:42:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:10 INFO - Running post-action listener: _resource_record_post_action 08:42:10 INFO - [mozharness: 2016-09-01 15:42:10.909741Z] Finished populate-webroot step (success) 08:42:10 INFO - [mozharness: 2016-09-01 15:42:10.909873Z] Running create-virtualenv step. 08:42:10 INFO - Running pre-action listener: _resource_record_pre_action 08:42:10 INFO - Running main action method: create_virtualenv 08:42:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:10 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 08:42:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:11 INFO - Using real prefix '/tools/python27' 08:42:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:14 INFO - Installing pip.................done. 08:42:14 INFO - Return code: 0 08:42:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:14 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 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:14 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 08:42:14 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 08:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:14 INFO - 'HOME': '/Users/cltbld', 08:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:14 INFO - 'LOGNAME': 'cltbld', 08:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:14 INFO - 'MOZ_NO_REMOTE': '1', 08:42:14 INFO - 'NO_EM_RESTART': '1', 08:42:14 INFO - 'PAGER': '/bin/cat', 08:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:14 INFO - 'PWD': '/builds/slave/test', 08:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:14 INFO - 'SHELL': '/bin/bash', 08:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:14 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:14 INFO - 'USER': 'cltbld', 08:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:14 INFO - 'XPC_FLAGS': '0x0', 08:42:14 INFO - 'XPC_SERVICE_NAME': '0', 08:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:14 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 08:42:14 INFO - Cleaning up... 08:42:14 INFO - Return code: 0 08:42:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:14 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 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:14 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 08:42:14 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 08:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:14 INFO - 'HOME': '/Users/cltbld', 08:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:14 INFO - 'LOGNAME': 'cltbld', 08:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:14 INFO - 'MOZ_NO_REMOTE': '1', 08:42:14 INFO - 'NO_EM_RESTART': '1', 08:42:14 INFO - 'PAGER': '/bin/cat', 08:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:14 INFO - 'PWD': '/builds/slave/test', 08:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:14 INFO - 'SHELL': '/bin/bash', 08:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:14 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:14 INFO - 'USER': 'cltbld', 08:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:14 INFO - 'XPC_FLAGS': '0x0', 08:42:14 INFO - 'XPC_SERVICE_NAME': '0', 08:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:15 INFO - Downloading/unpacking psutil>=3.1.1 08:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:18 INFO - Installing collected packages: psutil 08:42:18 INFO - Running setup.py install for psutil 08:42:18 INFO - building 'psutil._psutil_osx' extension 08:42:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:42:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:42:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:42:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:42:19 INFO - building 'psutil._psutil_posix' extension 08:42:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:42:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:19 INFO - ^ 08:42:19 INFO - 1 warning generated. 08:42:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:42:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:19 INFO - Successfully installed psutil 08:42:19 INFO - Cleaning up... 08:42:19 INFO - Return code: 0 08:42:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:42:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:19 INFO - 'HOME': '/Users/cltbld', 08:42:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:19 INFO - 'LOGNAME': 'cltbld', 08:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:19 INFO - 'MOZ_NO_REMOTE': '1', 08:42:19 INFO - 'NO_EM_RESTART': '1', 08:42:19 INFO - 'PAGER': '/bin/cat', 08:42:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:19 INFO - 'PWD': '/builds/slave/test', 08:42:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:19 INFO - 'SHELL': '/bin/bash', 08:42:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:19 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:19 INFO - 'USER': 'cltbld', 08:42:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:19 INFO - 'XPC_FLAGS': '0x0', 08:42:19 INFO - 'XPC_SERVICE_NAME': '0', 08:42:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:22 INFO - Installing collected packages: mozsystemmonitor 08:42:22 INFO - Running setup.py install for mozsystemmonitor 08:42:22 INFO - Successfully installed mozsystemmonitor 08:42:22 INFO - Cleaning up... 08:42:22 INFO - Return code: 0 08:42:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:22 INFO - 'HOME': '/Users/cltbld', 08:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:22 INFO - 'LOGNAME': 'cltbld', 08:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:22 INFO - 'MOZ_NO_REMOTE': '1', 08:42:22 INFO - 'NO_EM_RESTART': '1', 08:42:22 INFO - 'PAGER': '/bin/cat', 08:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:22 INFO - 'PWD': '/builds/slave/test', 08:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:22 INFO - 'SHELL': '/bin/bash', 08:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:22 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:22 INFO - 'USER': 'cltbld', 08:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:22 INFO - 'XPC_FLAGS': '0x0', 08:42:22 INFO - 'XPC_SERVICE_NAME': '0', 08:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:26 INFO - warning: no files found matching '*.txt' 08:42:26 INFO - no previously-included directories found matching 'build' 08:42:26 INFO - no previously-included directories found matching 'dist' 08:42:26 INFO - no previously-included directories found matching '.git*' 08:42:26 INFO - Installing collected packages: jsonschema, functools32 08:42:26 INFO - Running setup.py install for functools32 08:42:26 INFO - warning: no files found matching '*.txt' 08:42:26 INFO - no previously-included directories found matching 'build' 08:42:26 INFO - no previously-included directories found matching 'dist' 08:42:26 INFO - no previously-included directories found matching '.git*' 08:42:26 INFO - Successfully installed jsonschema functools32 08:42:26 INFO - Cleaning up... 08:42:26 INFO - Return code: 0 08:42:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42: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 functools32==3.2.3-2 08:42:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:26 INFO - 'HOME': '/Users/cltbld', 08:42:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:26 INFO - 'LOGNAME': 'cltbld', 08:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:26 INFO - 'MOZ_NO_REMOTE': '1', 08:42:26 INFO - 'NO_EM_RESTART': '1', 08:42:26 INFO - 'PAGER': '/bin/cat', 08:42:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:26 INFO - 'PWD': '/builds/slave/test', 08:42:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:26 INFO - 'SHELL': '/bin/bash', 08:42:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:26 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:26 INFO - 'USER': 'cltbld', 08:42:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:26 INFO - 'XPC_FLAGS': '0x0', 08:42:26 INFO - 'XPC_SERVICE_NAME': '0', 08:42:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:26 INFO - Cleaning up... 08:42:26 INFO - Return code: 0 08:42:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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', '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 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42: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 blobuploader==1.2.4 08:42:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:26 INFO - 'HOME': '/Users/cltbld', 08:42:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:26 INFO - 'LOGNAME': 'cltbld', 08:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:26 INFO - 'MOZ_NO_REMOTE': '1', 08:42:26 INFO - 'NO_EM_RESTART': '1', 08:42:26 INFO - 'PAGER': '/bin/cat', 08:42:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:26 INFO - 'PWD': '/builds/slave/test', 08:42:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:26 INFO - 'SHELL': '/bin/bash', 08:42:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:26 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:26 INFO - 'USER': 'cltbld', 08:42:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:26 INFO - 'XPC_FLAGS': '0x0', 08:42:26 INFO - 'XPC_SERVICE_NAME': '0', 08:42:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:30 INFO - Downloading docopt-0.6.1.tar.gz 08:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:30 INFO - Running setup.py install for blobuploader 08:42:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:30 INFO - Running setup.py install for requests 08:42:31 INFO - Running setup.py install for docopt 08:42:31 INFO - Successfully installed blobuploader requests docopt 08:42:31 INFO - Cleaning up... 08:42:31 INFO - Return code: 0 08:42:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:31 INFO - 'HOME': '/Users/cltbld', 08:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:31 INFO - 'LOGNAME': 'cltbld', 08:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:31 INFO - 'MOZ_NO_REMOTE': '1', 08:42:31 INFO - 'NO_EM_RESTART': '1', 08:42:31 INFO - 'PAGER': '/bin/cat', 08:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:31 INFO - 'PWD': '/builds/slave/test', 08:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:31 INFO - 'SHELL': '/bin/bash', 08:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:31 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:31 INFO - 'USER': 'cltbld', 08:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:31 INFO - 'XPC_FLAGS': '0x0', 08:42:31 INFO - 'XPC_SERVICE_NAME': '0', 08:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-V9eEak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Y4rxuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ms35td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Wew7lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-p5tO57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-XYBVki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-vxXsBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-jm3MGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-92WZnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-JLJZgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-MRXkkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-13acXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-TQvjfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-4Hqie8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-jRl5YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-n0wr5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:33 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-J0MwPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:33 INFO - Running setup.py install for manifestparser 08:42:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:33 INFO - Running setup.py install for mozcrash 08:42:33 INFO - Running setup.py install for mozdebug 08:42:33 INFO - Running setup.py install for mozdevice 08:42:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Running setup.py install for mozfile 08:42:34 INFO - Running setup.py install for mozhttpd 08:42:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Running setup.py install for mozinfo 08:42:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Running setup.py install for mozInstall 08:42:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:34 INFO - Running setup.py install for mozleak 08:42:34 INFO - Running setup.py install for mozlog 08:42:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:35 INFO - Running setup.py install for moznetwork 08:42:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:35 INFO - Running setup.py install for mozprocess 08:42:35 INFO - Running setup.py install for mozprofile 08:42:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:35 INFO - Running setup.py install for mozrunner 08:42:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:35 INFO - Running setup.py install for mozscreenshot 08:42:35 INFO - Running setup.py install for moztest 08:42:36 INFO - Running setup.py install for mozversion 08:42:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:36 INFO - Cleaning up... 08:42:36 INFO - Return code: 0 08:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:36 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:36 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:36 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 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:36 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 08:42:36 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 08:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:36 INFO - 'HOME': '/Users/cltbld', 08:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:36 INFO - 'LOGNAME': 'cltbld', 08:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:36 INFO - 'MOZ_NO_REMOTE': '1', 08:42:36 INFO - 'NO_EM_RESTART': '1', 08:42:36 INFO - 'PAGER': '/bin/cat', 08:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:36 INFO - 'PWD': '/builds/slave/test', 08:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:36 INFO - 'SHELL': '/bin/bash', 08:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:36 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:36 INFO - 'USER': 'cltbld', 08:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:36 INFO - 'XPC_FLAGS': '0x0', 08:42:36 INFO - 'XPC_SERVICE_NAME': '0', 08:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-R1Jgbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:36 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)) 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-JNcmN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:36 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)) 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-HVCvUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:36 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)) 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-misyVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:36 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)) 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-1IjpLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:36 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)) 08:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-BPf_2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-SGz7Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Xs3cDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Ka7hSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-4mejNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-qGb4Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-j6B19Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-HWkrri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-W6NqJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:37 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)) 08:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_6f9R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:38 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)) 08:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:38 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-nCBRpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:38 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)) 08:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:38 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-R3vpQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:38 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)) 08:42:38 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)) 08:42:38 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)) 08:42:38 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)) 08:42:38 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)) 08:42:38 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)) 08:42:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:40 INFO - Downloading blessings-1.6.tar.gz 08:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:40 INFO - Installing collected packages: blessings 08:42:40 INFO - Running setup.py install for blessings 08:42:41 INFO - Successfully installed blessings 08:42:41 INFO - Cleaning up... 08:42:41 INFO - Return code: 0 08:42:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:41 INFO - Reading from file tmpfile_stdout 08:42:41 INFO - Current package versions: 08:42:41 INFO - blessings == 1.6 08:42:41 INFO - blobuploader == 1.2.4 08:42:41 INFO - docopt == 0.6.1 08:42:41 INFO - functools32 == 3.2.3-2 08:42:41 INFO - jsonschema == 2.5.1 08:42:41 INFO - manifestparser == 1.1 08:42:41 INFO - mozInstall == 1.12 08:42:41 INFO - mozcrash == 0.17 08:42:41 INFO - mozdebug == 0.1 08:42:41 INFO - mozdevice == 0.48 08:42:41 INFO - mozfile == 1.2 08:42:41 INFO - mozhttpd == 0.7 08:42:41 INFO - mozinfo == 0.9 08:42:41 INFO - mozleak == 0.1 08:42:41 INFO - mozlog == 3.3 08:42:41 INFO - moznetwork == 0.27 08:42:41 INFO - mozprocess == 0.23 08:42:41 INFO - mozprofile == 0.28 08:42:41 INFO - mozrunner == 6.12 08:42:41 INFO - mozscreenshot == 0.1 08:42:41 INFO - mozsystemmonitor == 0.3 08:42:41 INFO - moztest == 0.7 08:42:41 INFO - mozversion == 1.4 08:42:41 INFO - psutil == 3.1.1 08:42:41 INFO - requests == 1.2.3 08:42:41 INFO - wsgiref == 0.1.2 08:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42: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 08:42: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 08:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:41 INFO - 'HOME': '/Users/cltbld', 08:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:41 INFO - 'LOGNAME': 'cltbld', 08:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:41 INFO - 'MOZ_NO_REMOTE': '1', 08:42:41 INFO - 'NO_EM_RESTART': '1', 08:42:41 INFO - 'PAGER': '/bin/cat', 08:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:41 INFO - 'PWD': '/builds/slave/test', 08:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:41 INFO - 'SHELL': '/bin/bash', 08:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:41 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:41 INFO - 'USER': 'cltbld', 08:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:41 INFO - 'XPC_FLAGS': '0x0', 08:42:41 INFO - 'XPC_SERVICE_NAME': '0', 08:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42: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)) 08:42:41 INFO - Cleaning up... 08:42:41 INFO - Return code: 0 08:42:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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 0x107569a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fe618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ea04bad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42: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 08:42: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 08:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:41 INFO - 'HOME': '/Users/cltbld', 08:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:41 INFO - 'LOGNAME': 'cltbld', 08:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:41 INFO - 'MOZ_NO_REMOTE': '1', 08:42:41 INFO - 'NO_EM_RESTART': '1', 08:42:41 INFO - 'PAGER': '/bin/cat', 08:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:41 INFO - 'PWD': '/builds/slave/test', 08:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:41 INFO - 'SHELL': '/bin/bash', 08:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:42:41 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:41 INFO - 'USER': 'cltbld', 08:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:41 INFO - 'XPC_FLAGS': '0x0', 08:42:41 INFO - 'XPC_SERVICE_NAME': '0', 08:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:41 INFO - Cleaning up... 08:42:41 INFO - Return code: 0 08:42:41 INFO - Running post-action listener: _resource_record_post_action 08:42:41 INFO - Running post-action listener: _start_resource_monitoring 08:42:42 INFO - Starting resource monitoring. 08:42:42 INFO - [mozharness: 2016-09-01 15:42:42.008522Z] Finished create-virtualenv step (success) 08:42:42 INFO - [mozharness: 2016-09-01 15:42:42.009509Z] Running install step. 08:42:42 INFO - Running pre-action listener: _resource_record_pre_action 08:42:42 INFO - Running main action method: install 08:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:42 INFO - Reading from file tmpfile_stdout 08:42:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:42 INFO - Reading from file tmpfile_stdout 08:42:42 INFO - Output received: 08:42:42 INFO - Usage: mozinstall [options] installer 08:42:42 INFO - Options: 08:42:42 INFO - -h, --help show this help message and exit 08:42:42 INFO - -d DEST, --destination=DEST 08:42:42 INFO - Directory to install application into. [default: 08:42:42 INFO - "/builds/slave/test"] 08:42:42 INFO - --app=APP Application being installed. [default: firefox] 08:42:42 INFO - mkdir: /builds/slave/test/build/application 08:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:43:16 INFO - Reading from file tmpfile_stdout 08:43:16 INFO - Output received: 08:43:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:43:16 INFO - Running post-action listener: _resource_record_post_action 08:43:16 INFO - [mozharness: 2016-09-01 15:43:16.986393Z] Finished install step (success) 08:43:16 INFO - [mozharness: 2016-09-01 15:43:16.986537Z] Running run-tests step. 08:43:16 INFO - Running pre-action listener: _resource_record_pre_action 08:43:16 INFO - Running main action method: run_tests 08:43:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:17 INFO - 2016-09-01 08:43:17.001 screenresolution[1631:7954] starting screenresolution argv=screenresolution get 08:43:17 INFO - 2016-09-01 08:43:17.003 screenresolution[1631:7954] Display 0: 1600x1200x32@60 08:43:17 INFO - 2016-09-01 08:43:17.009 screenresolution[1632:7956] starting screenresolution argv=screenresolution list 08:43:17 INFO - Available Modes on Display 0 08:43:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:17 INFO - Intel Iris: 08:43:17 INFO - Chipset Model: Intel Iris 08:43:17 INFO - Type: GPU 08:43:17 INFO - Bus: Built-In 08:43:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:43:17 INFO - Vendor: Intel (0x8086) 08:43:17 INFO - Device ID: 0x0a2e 08:43:17 INFO - Revision ID: 0x0009 08:43:17 INFO - Displays: 08:43:17 INFO - Display: 08:43:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:17 INFO - Display Serial Number: 1600x1200 60 08:43:17 INFO - Main Display: Yes 08:43:17 INFO - Mirror: Off 08:43:17 INFO - Online: Yes 08:43:17 INFO - Rotation: Supported 08:43:17 INFO - Return code: 0 08:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:17 INFO - Python 2.7.3 08:43:17 INFO - Return code: 0 08:43:17 INFO - grabbing minidump binary from tooltool 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:17 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/macosx64/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 0x1074cdd30>, '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 0x107232db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:43:17 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:43:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:43:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:17 INFO - Return code: 0 08:43:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:43:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:43:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 08:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --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 08:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lKgqReHMpA/Render', 08:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:17 INFO - 'HOME': '/Users/cltbld', 08:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:17 INFO - 'LOGNAME': 'cltbld', 08:43:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:17 INFO - 'MOZ_NO_REMOTE': '1', 08:43:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:17 INFO - 'NO_EM_RESTART': '1', 08:43:17 INFO - 'PAGER': '/bin/cat', 08:43:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:17 INFO - 'PWD': '/builds/slave/test', 08:43:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:17 INFO - 'SHELL': '/bin/bash', 08:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners', 08:43:17 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 08:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:17 INFO - 'USER': 'cltbld', 08:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:17 INFO - 'XPC_FLAGS': '0x0', 08:43:17 INFO - 'XPC_SERVICE_NAME': '0', 08:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 08:43:17 INFO - mozversion application_buildid: 20160901063021 08:43:17 INFO - mozversion application_changeset: 27ffae997b83a5bfeaf0967e692074cb097d94e8 08:43:17 INFO - mozversion application_display_name: Nightly 08:43:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:17 INFO - mozversion application_name: Firefox 08:43:17 INFO - mozversion application_remotingname: firefox 08:43:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:43:17 INFO - mozversion application_vendor: Mozilla 08:43:17 INFO - mozversion application_version: 51.0a1 08:43:17 INFO - mozversion platform_buildid: 20160901063021 08:43:17 INFO - mozversion platform_changeset: 27ffae997b83a5bfeaf0967e692074cb097d94e8 08:43:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:43:17 INFO - mozversion platform_version: 51.0a1 08:43:17 INFO - using testdate: 1472744597 08:43:17 INFO - actual date: 1472744597 08:43:17 INFO - starting webserver on 'localhost:49266' 08:43:17 INFO - SUITE-START | Running 2 tests 08:43:17 INFO - TEST-START | dromaeo_css 08:43:17 INFO - operating with platform_type : mac_ 08:43:17 INFO - Initialising browser for dromaeo_css test... 08:43:17 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpeivon1/profile http://localhost:49266/getInfo.html) 08:43:20 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 08:43:20 INFO - PROCESS | 1642 | colorDepth:24 08:43:20 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 08:43:20 INFO - PROCESS | 1642 | __metrics 08:43:20 ERROR - PROCESS | 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 08:43:21 INFO - TEST-INFO | 1642: exit 0 08:43:21 INFO - Browser initialized. 08:43:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:21 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpeivon1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:33 INFO - PROCESS | 1646 | RSS: Main: 245370880 08:43:33 INFO - PROCESS | 1646 | 08:44:22 INFO - PROCESS | 1646 | 1472744662826 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] 08:46:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 08:46:36 INFO - PROCESS | 1646 | RSS: Main: 263524352 08:46:36 INFO - PROCESS | 1646 | 08:49:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 08:49:39 INFO - PROCESS | 1646 | RSS: Main: 271466496 08:49:39 INFO - PROCESS | 1646 | 08:52:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 08:52:42 INFO - PROCESS | 1646 | RSS: Main: 277516288 08:52:42 INFO - PROCESS | 1646 | 08:55:43 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 08:55:44 INFO - PROCESS | 1646 | RSS: Main: 273747968 08:55:44 INFO - PROCESS | 1646 | 08:58:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 08:58:48 INFO - PROCESS | 1646 | RSS: Main: 279146496 08:58:48 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 09:01:50 INFO - PROCESS | 1646 | RSS: Main: 281825280 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | __start_tp_report 09:01:50 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 09:01:50 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 09:01:50 INFO - PROCESS | 1646 | |i|pagename|runs| 09:01:50 INFO - PROCESS | 1646 | |0;dojo.html;3203.4554125798613;3207.8772429649625;3380.3070370574037;3386.8137252451115;3432.828358582071;5584.720763961801;5613.80351687691;5638.859028524289;5683.3464151622575;5769.221155144054;5568.220449137124;5701.800436984707;5720.599558030939;5810.651360918338;5815;5168.948310516885;5206.375234971809;5239.921401178985;5268.604854635899;5300.946990530103;5218.13900706383;5282.260483532289;5317.9468205317835;5361.410244873061;5380.166074258496;5259.027079990214;5298.814541491049;5308.654937429074;5318.574514038887;5327.733613319338;5143.27994080829;5164.793408263665;5188.558972487343;5225.973870130663;5233.842984710427;4966.627502937295;5050.873728156789;5162.870928226825;5189.532942035197;5220.895582088337;5596.916046259309;5761.452661997104;5776.046952252873;5801.332846722638;5810.941890581124;6027.065804800263;6084.452399284041;6131.437835141539;6145.846353841145;6236.781712640081;6245.156903817971;6252.749890004395;6263.812085637393;6268.686565671698;6287;5751;5819.632182536092;5825.533957283407;5831.650100993954;5874.706264686749;6174.783882564088;6187.659678717624;6210.254769427697;6234.2830574484515;6266.404691554295;6099.279518885405;6099.893623928163;6100.3899610039525;6102.847428814315;6129.6985541375325;6166.044263139221;6170.5372097092895;6235.657038862906;6241.375862413723;6307.5584709070845;6009.634604621426;6141.84645383869;6162.383761623802;6199.628022318675;6207.565470417027;6140.662263575457;6207.906881396782;6208.596441231305;6212.1303017577575;6229.127922090911;4923.556879880828;4929.580985616191;4937.506249375034;4938.185199442052;4939.382577177853;4366.934495982563;4367.5632436756705;4378.956210437855;4404.031113155101;4509.594136527729;4259.361095835588;4932.827351042768;5039.622028347889;5719.7140142992685;5781.392953739797;5131.5638170755155;6211.65835879031;6250.468710159687;6256.061590761422;6284.968575157095;5511.063119269734;5711.514521265656;5717.085266357363;5721.5136713379;5802.88394232113;5384.542313903284;5390.353157621111;5392.595555333366;5396.676199428047;5407.972960135174;6250.531210159165;6282.780102696383;6288.5598008138995;6293.244810622755;6295.748170073146;6115.209918062534;6155.230596175478;6186.566940314315;6199.070139479114;6253.906191407224;6253.8749225014335;6270.467010304175;6275.686215689106;6286.245650521783;6289.496840252677;6107.9083813741945;6134.570580059353;6141.84645383869;6142.907856382247;6151.2618485781995;6108.099244189703;6108.311716708011;6110.376504976068;6168.506519478341;6249.7187626557825;6020.759169633166;6065.216742742879;6080.543959203166;6085.391460853879;6098.298695650057;6022.879542409215;6027.457528822427;6048.546359023003;6071.787487437919;6075.2405949256345;4599;5788.131780232999;5820.388859169896;5934.376890426615;5980.9401905980385;5745.1956726059225;6053.909191362045;6070.18052562916;6100.725467353891;6119.296280927751;5918.644881307136;5950.3454619992635;5953.76184952597;5960.135780311917;5994.100884867305 09:01:50 INFO - PROCESS | 1646 | |1;ext.html;438.91660584488943;467.77546777546763;471.307178447682;513.7302915969116;533.2747463449705;32757.18107047322;39215.80392098039;39291.0177245569;39296.41055384164;39406.01484962877;40259.19481610366;40948.38577421341;40973;40975.79512102443;41027;9711.368761030546;9854.768153980753;9890.060444257784;9893.010698930122;9940.602375904955;9715.70852874415;9803.31376803624;9816.018398160199;9818.312718109735;9852.753681157992;9817;9820.870599880998;9821.2634052446;9822.557984890696;9828.066333698323;9710.41737495749;9780;9780.119789219005;9784.412935223909;9795.461249631267;9681.951590242004;9708.75728106796;9793.412395256308;9805.215582753362;9811.852822207673;38539.65111221094;38803;38906.221875562616;38938.02654933621;38990;3307.9834600827085;3328.484084966834;3383.204946837491;3446.5691788526433;3821.2357528494135;30493.237669058228;30763.538546921813;30986.91545795909;31140.53289200664;31850.362992740247;3216.6007786612663;3256.967430325714;3294.7364210863075;3368.7641865069454;3417.2823707021557;506188.469057656;509397;515483;516508;517440;34135.829320853736;63817.72364552683;65081;65106;65165;35049.299014019576;35396;35964.28071438557;36090.27819443597;36184.276314473565;14684.632884177981;14729.852701472848;14869.925650371679;14874.033187842755;14898.702025959421;10760.838587421194;11269.436528173559;12456.439460224312;12532.436040378205;12611.243325400323;6413.647249401328;7362.263773622595;7656.770296891103;8011.198880111942;8019.15798841125;3318.900432987014;3352.4468462703867;3359.664033596621;3360.1599600099976;3383.3909896218424;975.9414435133915;981.4651015196735;1016.2378216337746;1034.425893629028;1079.3200283821143;30001.849990749906;30134;30440.54339184914;30498.390032199233;30654.846725766674;997.6109317366233;1042.2652030318607;1054.836500342448;1058.9470526473644;1128.4752590045669;13185.40665670028;14794.482193123189;15539.689206215813;15601;15698.607534811721;674165;679382;679613;680158;681878;55390.72304638532;55525.722371387885;55964.44035559592;56055.87888242294;56222.43777562172;1331.6937104466026;1386.3068465767117;1393.2197969137314;1394.1913690059741;1402.52314213168;28849.56725649075;29704.851475743348;29816.70183298226;30310.84844575763;30453.934112305964;48684.75657621689;49035;49137.508624913295;49207;49231;582188;583711;583712;584004;584074;26435.60346594841;26994;27252.863735681196;27356.726432735417;27370;40335.789926302255;44508;45308.86727831831;46311.536884630725;46682;37815.810920945216;38425.80787096047;38492.23015539617;39075.413868791424;39298.80350598229;31305.904293349624;32278.35443291168;33889.49165762565;37500.24999500049;38522.80738596289;36784.63215367812;37320;37807.43288850725;38295.6170438292;38474.422883657324;32230.677693223704;33915.66084339125;34272;34900.65099349076;35025.12437189091;25127.869245884343;25205.11782087618;25223.621645675696;25506;25607.48785024252 09:01:50 INFO - PROCESS | 1646 | |2;jquery.html;362.5757863299939;372.05869151047847;373.2683939478622;377.1269511081847;392.4113829256116;19237.711434328477;21009.844458554773;21248.4687882803;21580.568388632237;21784;20463.488412789688;20871.47821304468;21080;21341.25305614304;21396.8930155349;5791.420857914217;5895.263092113486;5900.822975310747;5928.851778705523;6065.878682426349;4163.208990291835;5987.520998320146;6027.879442411149;6383.648899310536;6668.133142691443;5874.530037596982;6668.599884006975;6717.361850624183;6717.932820671779;6739.292374300701;6502.414782669583;6628.43658289046;6665.70004349803;6699.698513566901;6744.055832183522;5711.40030296817;5716.828495145152;5753.88492230153;5782.074868021138;5792.189093526909;19951.600967980703;20124.698129528068;26515.867420662966;26533.20400387972;26564;1958.8922609256485;2212.177453152128;2406.554787364343;2425.78167964884;2891.956620650692;10284.794304113875;12124.454399552042;12364.381780910919;14448.49430269946;15816.604584885356;1855.4897403214088;1886.8490520758444;1887.764029496313;1887.877287976277;1912.3880358285355;104649;127858;128032.99999999907;131416;131742.34128829392;11182.944085279685;11551.826722599168;11644.475998580085;11653.41732913351;11874;14380.496682616058;14545.490907818175;14556.41774329015;14569.927150364181;14603.78094328586;7522.435817313723;7943.126256111823;8620.78448038804;8738.95630521856;8739.344549158839;8479.321654267644;8486.872696909551;8506.65973361071;8662.2637075848;8662.30701543875;3694.854595075535;4477.843275485342;4527.547245275512;4591.471980722193;4632.837850675211;1598.424567155823;1679.3450554283838;1682.142107525171;1908.7327774111636;1961.1076959983172;696.9581825090511;894.7449976756593;1009.7374682582581;1012.4532752313668;1052.8052310322614;20469.795302047085;20482;20949.476263093544;21214.151433942778;21388.679169812152;762.6682393158993;922.6816748221853;924.306769922558;926.1294383279695;926.9119433653792;9946.653758439765;10782.245242832927;11150.219484635998;11339.092872570174;11355.829662555068;216917.9154104251;217141;217473;218087;218149;84478;112281.43859280652;140010;142191.2890435562;142242;1014.325473560089;1027.6762819711766;1058.1799105692996;1066.8293073108266;1066.9733256668646;15413.075215487106;15650.373985040926;16423.507294781175;17752.91123544374;19585.02074896221;45885.541144588125;49489.50510494993;52033.47966520286;54099;55186.724066379415;67057.97652140887;68423.65788171027;69543;69743;70807.58384832377;6967.233604303421;7342.971983922362;7980.760577182694;8061.39539534549;8334.83330333402;11848.644540663794;11942.820857687315;12022.75954480888;13048.934755326163;13222.867771322164;11188.888111118784;11453.59912403062;11488.94255528717;11681.415929203677;11709.238899471507;8797.560121993747;9534.808148981378;11035.337879727242;11289.37908415045;11334.206605537533;9688.612455501701;11750.23623464472;11806.055515558563;11837;11893.048556115664;7216.603086830275;7301.634918254173;7394.482386232912;7489.13874904393;7598.202188770099;10380.740481488023;11172.49723762449;11212.27120237182;11407.315561066363;11504.769904601693 09:01:50 INFO - PROCESS | 1646 | |3;mootools.html;1496.3341313115661;1507.6155580327018;1735.7830271216098;1833.6241070580531;1886.6792645250307;8042.276195142436;8501.872471912919;8718.912810871889;9033.819323613532;9042.14099660532;8742.650293988248;8891.822163556724;8899.243564297027;8910;8914.974777900527;2329.755375685554;2358.6344116661858;2362.9645555316683;2368.3842201027683;2371.893264803088;2150.827933765295;2330.3707998840305;2382.4877651304964;2382.7259865115475;2386.737458879522;2089.7252675867708;2333.5216280662507;2369.6327069304198;2379.3694670912223;2388.36708272308;2203;2246.1015593762463;2246.3036458697775;2247.550489902026;2247.685324054634;1987.6322880267196;2317.1310758465575;2338.543983923136;2353.317537914003;2357.210334537932;8738.082501337396;8845.336599754979;8891.377603567753;8893.421927574751;8898.59956301968;5207.661502002357;5325.387580428262;5327.893442131136;5346.866328341784;5383.219433182206;3460.2733425980323;3565.16218688608;3634.2549777295853;3637.3634613942454;3649.5620525537106;917.5320586500866;1038.7195457226508;1073.4579037586047;1091.6343025086605;1097.067492631265;9829.55766990487;11330.773384532346;11506.654800355918;11548.59579914699;11559.133065020073;4545.250033744395;4671.135839869635;4760.619150467955;4775.355327030876;4778.7849546769785;9804.166645835041;9896.802063958681;9917.652882149234;9933.00669933001;9950.701478955643;5304.045271851104;5317.574594032468;5323.813666521731;5335.3864305604575;5344.011357898801;3593.69453596442;4381.408509851193;4657.906841863144;4700.341952126705;4849.466558678542;3138.8901388451295;3833;3870.0324918770307;3957.9010524737114;3978.602139785998;1078.600917660455;1287.6458973782285;1297.48100759695;1305.7399609376996;1320.8811206991418;712.5724565260803;833.3624777045565;860.2601762484259;861.3066481482467;883.6288758721353;5472.480114389126;5597.944020559742;5791.0734282514595;6030.577435031677;6076.240469941257;436.6986779122459;442.52870692712156;445.49213896158403;445.8528685533766;452.377980277119;3990.4812374391145;4032.7983600819844;4082.7346222495444;4127.566605506378;4136.255474014646;10340.37957722539;10825.025747682588;10828.620998265023;10853.24027318096;10862.185336099667;10748.97884700952;10762.192835537366;10766.78466430667;10769.9461502692;10849;6690.732370705215;7980.241877021674;8155.836883262302;8165.142660020612;8234.958825205835;5294.788208471618;5668.348139963792;5985.311689155803;6083.452489275986;6147.815565533041;9999.650012249536;10004.899951000396;10035;10076.647317343857;10180.592776289162;9608.471534065693;10033.849492257476;10068.345557539029;10150.949245253727;10257.84613230817;6927.134108236471;7373.8156546086775;7418.517796343221;7652.846943060997;7658.463907526642;8519.616617252115;8607.139286071342;8609.69866054685;8623.611937462954;8652.307815374628;7340.412766978736;7428.888566671396;7510.361619262424;7570.9242907570215;7622.69509219625;7276.126864776261;7386.335229829341;7410.888836667346;7504.587247701429;7564.810879728051;6857.108575885103;6917;7006.089208402875;7019.227884932551;7055.3650171484815;4612.169809434334;4735.857924262277;4932.556069953722;5122.46214147524;5140.56305214061;4458.977705111453;4767.61859051282;4998.575121114601;5094.59898527893;5219.243209734643 09:01:50 INFO - PROCESS | 1646 | |4;prototype.html;289.4529339548254;298.3198307858084;307.91840162356965;310.2569346415334;311.1924555777756;5129.846104616863;5357.249985002098;5427.615957930732;5555.388907220213;5706.3166365922;4799.928001079978;4918.458969513351;5591.7483713232905;5728.16941543477;5754.309482862052;3928.135810121769;4050.4936882889638;4061.918761624766;4136.544980052199;4332.443858123706;3963.346047902093;4279.015826359939;4279.7860106994685;4327.883923575021;4333.956660433402;3540.539729835131;3842.9615703843024;4218.704690671654;4226.640735537483;4274.722143060691;4181.979090104561;4245.554216807237;4254.702605480747;4255.191513612434;4264.402983582301;3115.704008119225;3360.4455264881267;3427.7600567960253;3551.928961420783;3577.105723569108;4727.290906364073;4946.554810067075;5437.755301011464;5458.9454105458835;5473.728402712869;4777.570018698334;4789.425268967711;4810.855674329776;4832.830850920236;4871.853844384674;5522.696251706155;5711.600187986843;5770.394108618577;5801.679328268684;5861.589688721791;3777.338965680995;3950.209958008381;3961.6632586230203;3965.4844870166694;3982.5264652078627;6134.086309003233;6155.72299246535;6234.532410069263;6245.7501699931945;6247.064818793148;3350.564426624523;3500.754947153726;3844.5770965193806;3969.0275882408996;3988.3818008208773;4006.2788698034633;4060.2082593893906;4085.4076158957378;4086.2644723949975;4097.959020409758;4036.7577945323374;4790.299443697507;4811.879703007453;4821.855344339676;4829.806807727651;5624.328443989072;5653.830385088454;5953.940460595425;5988.041913293852;6016;1101.8732845722845;1335.2989680417859;1337.5385492005244;1367.4206291733065;1372.1629805818443;759.3749376334648;794.9801254968672;904.8642703594381;931.329442801182;931.8835145606799;5144.356955380577;5452.509274165344;5476.26070480488;5525.613207075467;5543.251661025791;5636;5994.280686317583;5994.430529099728;6026.276846778327;6057.545684073624;5043.293938848564;5136.716524393028;5465.207544905967;5470.699111548824;5519.668819870821;2307.411610039429;2479.962800557993;2597.5064737699777;2715.813769915237;2724.891004359843;4403.921039345317;4847.975760121248;5090.5565328641715;5097;5189.558887494605;4443.488998765119;4761.809527618856;5200.7919683213;5639.492445679908;6390.7763228286785;6405.391487808651;6442.774502892376;6458.351031667093;6468.450181734511;6507.34926507355;5591.692456914909;6037.637741735334;6073.180120683651;6290.056491526125;6329.430351268408;5365.409804921534;5998.160257563857;6048.155312629514;6113.021916493518;6132.693365331805;5447.891042179213;6032.3967603239325;6256.7810126645345;6509.316521765336;6526.934730652632;3736.4208547675153;3851.9614803851605;3991.481107456012;3995.4606128172327;3996.6802655786887;5428.864278393072;5783.739731712168;5798.275215598051;6105.297890742621;6130.995812052151;5548.278723765885;5768.7404066817935;5936.575221946615;5966.880662386815;5988.8802223956145;5091.389033316026;5989.341172471112;6017.458428741435;6053.9091913622215;6058.757649693963;4810.446798618063;5145.845624631267;5237.266782650356;5785.652860828363;5884;5143.048536020848;5777.884442311046;5920.437558431942;6063.514918806397;6088.4824789893355;5061.177975928589;5140.820071297487;5184.611154163377;5617.634853734494;5906.616069955439 09:01:50 INFO - PROCESS | 1646 | |5;yui.html;674.9257581666017;683.2893790457924;705.2982282628782;753.3107206905681;803.6745118227118;15135.394584216632;15980.520584382459;15998.29203263012;16124.677506449863;16225.75661365079;12338.81491777624;12380.690482737937;12407.51849630073;12422.19255748378;12892.226466412021;843.1652663862777;857.9184977427135;861.8707193920931;862.1335557764469;862.607513581319;668.7191379620571;821.4660470694037;843.6667516331046;844.7550210438965;849.8342823149488;904.5884122724177;904.606496174163;906.2976193450096;906.3610154840854;907.7140700679265;742.3912391838694;845.0957475501216;886.6320477002068;900.2123142250531;901.1124042817819;512.5182328611094;652.8367908022994;668.5053060735021;669.3540733192444;669.8392385827415;14649.97450178488;15023.849761502355;15037.699246015129;15046.398144074225;15053.924730376388;14574.70850582993;14632;14704.779428308584;14863.108213507225;14954.327055282538;11707.473163707653;11781.410929453494;11903.702407439796;11982.522993436158;12017;3816.9618303816883;3823.9866435394642;3859.208862183246;3867.3425517662067;3976.443297938291;93068;95845;97068;108685.99999999921;116304;10914.508847101899;10993.285436446606;11069.391183484986;11231.719207019727;11541.307521548733;21031.474213144793;21539.461513462287;21563.78436215649;21606.567868642855;21664.891675541523;7430;7967.163447838009;8141.0230772307705;8142.592870356459;8308.335333173332;4434.157510073076;4552.521985191574;4558.749268790182;4564.52072532386;4567.132244873464;3441.690247877703;3515.472679098156;3573.249617580337;3586.7267120171964;3596.5863925648364;663.8473151175257;669.5781657555709;669.8995150727333;673;673.9696713647897;510.05894125338693;540.8566729816602;556.2462862820901;561.6938768371248;593.4156747365163;7461.552306861606;8872.378933474594;9113.772155696028;9114.726558203265;9258.95370523143;568.4855206038542;578.2425023219596;587.3949831673383;631.6052467207995;644.674439408096;4180.686448516373;4227.661787057028;4297.634701050383;4506.842260520866;4543.182227199136;87169.12830871737;91147.63278550826;133143;151644;161990.19004905137;121602.3919880395;122221;125853;127984;130937.34531327282;113495.43252283685;115606;118368.40815795866;119233.807661924;119899;8709.825803484022;9708.417494950325;9825.223435948361;10147.695569132939;10209.489525523843;50941;60046.69976650089;61699.383006169366;62161.162272150934;63687;82463;92183;93483;94738.52630736803;99167;10258.846117308396;11051.944740276569;11864.940675296568;13148.013898957424;13316.467341306627;12314;14747.778783318474;15006.174660393783;15094.245287735788;15395.3072111753;12855.485780568673;13756.449742010207;13833.30833458303;13984.230867302396;14327.641808954442;12729.29988850622;12759.744805104032;13633.931830340785;13893.374798133906;14302.983076584796;13498.52755153565;13572.660683482993;13719.451221951409;13910.652233694238;14094.718105638034;11199.944000279946;11273.830892536454;11549.42252887369;11580.942095289469;11671.941640291745;8069.556174410463;9391.624335026523;9669.142740420963;10173.847392288973;11554.826677599674 09:01:50 INFO - PROCESS | 1646 | __end_tp_report 09:01:50 INFO - PROCESS | 1646 | __start_cc_report 09:01:50 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,383 09:01:50 INFO - PROCESS | 1646 | __end_cc_report 09:01:50 INFO - PROCESS | 1646 | __startTimestamp1472745710880__endTimestamp 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | ------- Summary: start ------- 09:01:50 INFO - PROCESS | 1646 | Number of tests: 6 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5698.58 Median:5950.35 stddev:649.14 (10.9%) stddev-sans-first:620.92 09:01:50 INFO - PROCESS | 1646 | Values: 3203.5 3207.9 3380.3 3386.8 3432.8 5584.7 5613.8 5638.9 5683.3 5769.2 5568.2 5701.8 5720.6 5810.7 5815.0 5168.9 5206.4 5239.9 5268.6 5300.9 5218.1 5282.3 5317.9 5361.4 5380.2 5259.0 5298.8 5308.7 5318.6 5327.7 5143.3 5164.8 5188.6 5226.0 5233.8 4966.6 5050.9 5162.9 5189.5 5220.9 5596.9 5761.5 5776.0 5801.3 5810.9 6027.1 6084.5 6131.4 6145.8 6236.8 6245.2 6252.7 6263.8 6268.7 6287.0 5751.0 5819.6 5825.5 5831.7 5874.7 6174.8 6187.7 6210.3 6234.3 6266.4 6099.3 6099.9 6100.4 6102.8 6129.7 6166.0 6170.5 6235.7 6241.4 6307.6 6009.6 6141.8 6162.4 6199.6 6207.6 6140.7 6207.9 6208.6 6212.1 6229.1 4923.6 4929.6 4937.5 4938.2 4939.4 4366.9 4367.6 4379.0 4404.0 4509.6 4259.4 4932.8 5039.6 5719.7 5781.4 5131.6 6211.7 6250.5 6256.1 6285.0 5511.1 5711.5 5717.1 5721.5 5802.9 5384.5 5390.4 5392.6 5396.7 5408.0 6250.5 6282.8 6288.6 6293.2 6295.7 6115.2 6155.2 6186.6 6199.1 6253.9 6253.9 6270.5 6275.7 6286.2 6289.5 6107.9 6134.6 6141.8 6142.9 6151.3 6108.1 6108.3 6110.4 6168.5 6249.7 6020.8 6065.2 6080.5 6085.4 6098.3 6022.9 6027.5 6048.5 6071.8 6075.2 4599.0 5788.1 5820.4 5934.4 5980.9 5745.2 6053.9 6070.2 6100.7 6119.3 5918.6 5950.3 5953.8 5960.1 5994.1 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:70505.42 Median:38507.52 stddev:159737.27 (414.8%) stddev-sans-first:160098.75 09:01:50 INFO - PROCESS | 1646 | Values: 438.9 467.8 471.3 513.7 533.3 32757.2 39215.8 39291.0 39296.4 39406.0 40259.2 40948.4 40973.0 40975.8 41027.0 9711.4 9854.8 9890.1 9893.0 9940.6 9715.7 9803.3 9816.0 9818.3 9852.8 9817.0 9820.9 9821.3 9822.6 9828.1 9710.4 9780.0 9780.1 9784.4 9795.5 9682.0 9708.8 9793.4 9805.2 9811.9 38539.7 38803.0 38906.2 38938.0 38990.0 3308.0 3328.5 3383.2 3446.6 3821.2 30493.2 30763.5 30986.9 31140.5 31850.4 3216.6 3257.0 3294.7 3368.8 3417.3 506188.5 509397.0 515483.0 516508.0 517440.0 34135.8 63817.7 65081.0 65106.0 65165.0 35049.3 35396.0 35964.3 36090.3 36184.3 14684.6 14729.9 14869.9 14874.0 14898.7 10760.8 11269.4 12456.4 12532.4 12611.2 6413.6 7362.3 7656.8 8011.2 8019.2 3318.9 3352.4 3359.7 3360.2 3383.4 975.9 981.5 1016.2 1034.4 1079.3 30001.8 30134.0 30440.5 30498.4 30654.8 997.6 1042.3 1054.8 1058.9 1128.5 13185.4 14794.5 15539.7 15601.0 15698.6 674165.0 679382.0 679613.0 680158.0 681878.0 55390.7 55525.7 55964.4 56055.9 56222.4 1331.7 1386.3 1393.2 1394.2 1402.5 28849.6 29704.9 29816.7 30310.8 30453.9 48684.8 49035.0 49137.5 49207.0 49231.0 582188.0 583711.0 583712.0 584004.0 584074.0 26435.6 26994.0 27252.9 27356.7 27370.0 40335.8 44508.0 45308.9 46311.5 46682.0 37815.8 38425.8 38492.2 39075.4 39298.8 31305.9 32278.4 33889.5 37500.2 38522.8 36784.6 37320.0 37807.4 38295.6 38474.4 32230.7 33915.7 34272.0 34900.7 35025.1 25127.9 25205.1 25223.6 25506.0 25607.5 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:24279.42 Median:217029.46 stddev:43940.34 (20.2%) stddev-sans-first:44026.91 09:01:50 INFO - PROCESS | 1646 | Values: 362.6 372.1 373.3 377.1 392.4 19237.7 21009.8 21248.5 21580.6 21784.0 20463.5 20871.5 21080.0 21341.3 21396.9 5791.4 5895.3 5900.8 5928.9 6065.9 4163.2 5987.5 6027.9 6383.6 6668.1 5874.5 6668.6 6717.4 6717.9 6739.3 6502.4 6628.4 6665.7 6699.7 6744.1 5711.4 5716.8 5753.9 5782.1 5792.2 19951.6 20124.7 26515.9 26533.2 26564.0 1958.9 2212.2 2406.6 2425.8 2892.0 10284.8 12124.5 12364.4 14448.5 15816.6 1855.5 1886.8 1887.8 1887.9 1912.4 104649.0 127858.0 128033.0 131416.0 131742.3 11182.9 11551.8 11644.5 11653.4 11874.0 14380.5 14545.5 14556.4 14569.9 14603.8 7522.4 7943.1 8620.8 8739.0 8739.3 8479.3 8486.9 8506.7 8662.3 8662.3 3694.9 4477.8 4527.5 4591.5 4632.8 1598.4 1679.3 1682.1 1908.7 1961.1 697.0 894.7 1009.7 1012.5 1052.8 20469.8 20482.0 20949.5 21214.2 21388.7 762.7 922.7 924.3 926.1 926.9 9946.7 10782.2 11150.2 11339.1 11355.8 216917.9 217141.0 217473.0 218087.0 218149.0 84478.0 112281.4 140010.0 142191.3 142242.0 1014.3 1027.7 1058.2 1066.8 1067.0 15413.1 15650.4 16423.5 17752.9 19585.0 45885.5 49489.5 52033.5 54099.0 55186.7 67058.0 68423.7 69543.0 69743.0 70807.6 6967.2 7343.0 7980.8 8061.4 8334.8 11848.6 11942.8 12022.8 13048.9 13222.9 11188.9 11453.6 11488.9 11681.4 11709.2 8797.6 9534.8 11035.3 11289.4 11334.2 9688.6 11750.2 11806.1 11837.0 11893.0 7216.6 7301.6 7394.5 7489.1 7598.2 10380.7 11172.5 11212.3 11407.3 11504.8 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5672.96 Median:4764.12 stddev:3224.74 (67.7%) stddev-sans-first:3218.51 09:01:50 INFO - PROCESS | 1646 | Values: 1496.3 1507.6 1735.8 1833.6 1886.7 8042.3 8501.9 8718.9 9033.8 9042.1 8742.7 8891.8 8899.2 8910.0 8915.0 2329.8 2358.6 2363.0 2368.4 2371.9 2150.8 2330.4 2382.5 2382.7 2386.7 2089.7 2333.5 2369.6 2379.4 2388.4 2203.0 2246.1 2246.3 2247.6 2247.7 1987.6 2317.1 2338.5 2353.3 2357.2 8738.1 8845.3 8891.4 8893.4 8898.6 5207.7 5325.4 5327.9 5346.9 5383.2 3460.3 3565.2 3634.3 3637.4 3649.6 917.5 1038.7 1073.5 1091.6 1097.1 9829.6 11330.8 11506.7 11548.6 11559.1 4545.3 4671.1 4760.6 4775.4 4778.8 9804.2 9896.8 9917.7 9933.0 9950.7 5304.0 5317.6 5323.8 5335.4 5344.0 3593.7 4381.4 4657.9 4700.3 4849.5 3138.9 3833.0 3870.0 3957.9 3978.6 1078.6 1287.6 1297.5 1305.7 1320.9 712.6 833.4 860.3 861.3 883.6 5472.5 5597.9 5791.1 6030.6 6076.2 436.7 442.5 445.5 445.9 452.4 3990.5 4032.8 4082.7 4127.6 4136.3 10340.4 10825.0 10828.6 10853.2 10862.2 10749.0 10762.2 10766.8 10769.9 10849.0 6690.7 7980.2 8155.8 8165.1 8235.0 5294.8 5668.3 5985.3 6083.5 6147.8 9999.7 10004.9 10035.0 10076.6 10180.6 9608.5 10033.8 10068.3 10150.9 10257.8 6927.1 7373.8 7418.5 7652.8 7658.5 8519.6 8607.1 8609.7 8623.6 8652.3 7340.4 7428.9 7510.4 7570.9 7622.7 7276.1 7386.3 7410.9 7504.6 7564.8 6857.1 6917.0 7006.1 7019.2 7055.4 4612.2 4735.9 4932.6 5122.5 5140.6 4459.0 4767.6 4998.6 5094.6 5219.2 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4709.66 Median:5187.09 stddev:1506.82 (29.0%) stddev-sans-first:1474.07 09:01:50 INFO - PROCESS | 1646 | Values: 289.5 298.3 307.9 310.3 311.2 5129.8 5357.2 5427.6 5555.4 5706.3 4799.9 4918.5 5591.7 5728.2 5754.3 3928.1 4050.5 4061.9 4136.5 4332.4 3963.3 4279.0 4279.8 4327.9 4334.0 3540.5 3843.0 4218.7 4226.6 4274.7 4182.0 4245.6 4254.7 4255.2 4264.4 3115.7 3360.4 3427.8 3551.9 3577.1 4727.3 4946.6 5437.8 5458.9 5473.7 4777.6 4789.4 4810.9 4832.8 4871.9 5522.7 5711.6 5770.4 5801.7 5861.6 3777.3 3950.2 3961.7 3965.5 3982.5 6134.1 6155.7 6234.5 6245.8 6247.1 3350.6 3500.8 3844.6 3969.0 3988.4 4006.3 4060.2 4085.4 4086.3 4098.0 4036.8 4790.3 4811.9 4821.9 4829.8 5624.3 5653.8 5953.9 5988.0 6016.0 1101.9 1335.3 1337.5 1367.4 1372.2 759.4 795.0 904.9 931.3 931.9 5144.4 5452.5 5476.3 5525.6 5543.3 5636.0 5994.3 5994.4 6026.3 6057.5 5043.3 5136.7 5465.2 5470.7 5519.7 2307.4 2480.0 2597.5 2715.8 2724.9 4403.9 4848.0 5090.6 5097.0 5189.6 4443.5 4761.8 5200.8 5639.5 6390.8 6405.4 6442.8 6458.4 6468.5 6507.3 5591.7 6037.6 6073.2 6290.1 6329.4 5365.4 5998.2 6048.2 6113.0 6132.7 5447.9 6032.4 6256.8 6509.3 6526.9 3736.4 3852.0 3991.5 3995.5 3996.7 5428.9 5783.7 5798.3 6105.3 6131.0 5548.3 5768.7 5936.6 5966.9 5988.9 5091.4 5989.3 6017.5 6053.9 6058.8 4810.4 5145.8 5237.3 5785.7 5884.0 5143.0 5777.9 5920.4 6063.5 6088.5 5061.2 5140.8 5184.6 5617.6 5906.6 09:01:50 INFO - PROCESS | 1646 | 09:01:50 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:23972.08 Median:3841.60 stddev:37810.02 (984.2%) stddev-sans-first:37875.63 09:01:50 INFO - PROCESS | 1646 | Values: 674.9 683.3 705.3 753.3 803.7 15135.4 15980.5 15998.3 16124.7 16225.8 12338.8 12380.7 12407.5 12422.2 12892.2 843.2 857.9 861.9 862.1 862.6 668.7 821.5 843.7 844.8 849.8 904.6 904.6 906.3 906.4 907.7 742.4 845.1 886.6 900.2 901.1 512.5 652.8 668.5 669.4 669.8 14650.0 15023.8 15037.7 15046.4 15053.9 14574.7 14632.0 14704.8 14863.1 14954.3 11707.5 11781.4 11903.7 11982.5 12017.0 3817.0 3824.0 3859.2 3867.3 3976.4 93068.0 95845.0 97068.0 108686.0 116304.0 10914.5 10993.3 11069.4 11231.7 11541.3 21031.5 21539.5 21563.8 21606.6 21664.9 7430.0 7967.2 8141.0 8142.6 8308.3 4434.2 4552.5 4558.7 4564.5 4567.1 3441.7 3515.5 3573.2 3586.7 3596.6 663.8 669.6 669.9 673.0 674.0 510.1 540.9 556.2 561.7 593.4 7461.6 8872.4 9113.8 9114.7 9259.0 568.5 578.2 587.4 631.6 644.7 4180.7 4227.7 4297.6 4506.8 4543.2 87169.1 91147.6 133143.0 151644.0 161990.2 121602.4 122221.0 125853.0 127984.0 130937.3 113495.4 115606.0 118368.4 119233.8 119899.0 8709.8 9708.4 9825.2 10147.7 10209.5 50941.0 60046.7 61699.4 62161.2 63687.0 82463.0 92183.0 93483.0 94738.5 99167.0 10258.8 11051.9 11864.9 13148.0 13316.5 12314.0 14747.8 15006.2 15094.2 15395.3 12855.5 13756.4 13833.3 13984.2 14327.6 12729.3 12759.7 13633.9 13893.4 14303.0 13498.5 13572.7 13719.5 13910.7 14094.7 11199.9 11273.8 11549.4 11580.9 11671.9 8069.6 9391.6 9669.1 10173.8 11554.8 09:01:50 INFO - PROCESS | 1646 | -------- Summary: end -------- 09:01:50 INFO - PROCESS | 1646 | 09:01:51 INFO - TEST-INFO | 1646: exit 0 09:01:51 INFO - TEST-OK | dromaeo_css | took 1113878ms 09:01:51 INFO - TEST-START | kraken 09:01:51 INFO - operating with platform_type : mac_ 09:01:51 INFO - Initialising browser for kraken test... 09:01:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmp3CDuqY/profile http://localhost:49266/getInfo.html) 09:01:54 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 09:01:54 INFO - PROCESS | 1653 | colorDepth:24 09:01:54 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 09:01:54 INFO - PROCESS | 1653 | __metrics 09:01:54 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 09:01:55 INFO - TEST-INFO | 1653: exit 0 09:01:55 INFO - Browser initialized. 09:01:55 INFO - Running cycle 1/1 for kraken test... 09:01:55 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmp3CDuqY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:07 INFO - PROCESS | 1655 | RSS: Main: 245362688 09:02:07 INFO - PROCESS | 1655 | 09:02:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:11 INFO - PROCESS | 1655 | RSS: Main: 258166784 09:02:11 INFO - PROCESS | 1655 | 09:02:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 09:02:14 INFO - PROCESS | 1655 | RSS: Main: 266817536 09:02:14 INFO - PROCESS | 1655 | 09:02:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 09:02:18 INFO - PROCESS | 1655 | RSS: Main: 263299072 09:02:18 INFO - PROCESS | 1655 | 09:02:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 09:02:21 INFO - PROCESS | 1655 | RSS: Main: 265748480 09:02:21 INFO - PROCESS | 1655 | 09:02:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:23 INFO - PROCESS | 1655 | RSS: Main: 266399744 09:02:23 INFO - PROCESS | 1655 | 09:02:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:27 INFO - PROCESS | 1655 | RSS: Main: 266973184 09:02:27 INFO - PROCESS | 1655 | 09:02:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:30 INFO - PROCESS | 1655 | RSS: Main: 267440128 09:02:30 INFO - PROCESS | 1655 | 09:02:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 09:02:34 INFO - PROCESS | 1655 | RSS: Main: 268693504 09:02:34 INFO - PROCESS | 1655 | 09:02:36 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:36 INFO - PROCESS | 1655 | RSS: Main: 268079104 09:02:36 INFO - PROCESS | 1655 | 09:02:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:39 INFO - PROCESS | 1655 | RSS: Main: 267841536 09:02:39 INFO - PROCESS | 1655 | 09:02:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:42 INFO - PROCESS | 1655 | RSS: Main: 268128256 09:02:42 INFO - PROCESS | 1655 | 09:02:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:46 INFO - PROCESS | 1655 | RSS: Main: 268374016 09:02:46 INFO - PROCESS | 1655 | 09:02:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:49 INFO - PROCESS | 1655 | RSS: Main: 268357632 09:02:49 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 09:02:51 INFO - PROCESS | 1655 | RSS: Main: 270254080 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | __start_tp_report 09:02:51 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 09:02:51 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 09:02:51 INFO - PROCESS | 1655 | |i|pagename|runs| 09:02:51 INFO - PROCESS | 1655 | |0;ai-astar;105;107;156;155;116;118;116;105;164;188 09:02:51 INFO - PROCESS | 1655 | |1;audio-beat-detection;146;112;134;158;111;128;131;111;154;99 09:02:51 INFO - PROCESS | 1655 | |2;audio-dft;199;216;227;202;194;199;199;200;197;190 09:02:51 INFO - PROCESS | 1655 | |3;audio-fft;68;84;74;147;57;70;80;78;160;60 09:02:51 INFO - PROCESS | 1655 | |4;audio-oscillator;70;73;125;72;71;91;114;67;74;109 09:02:51 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;124;89;97;112;91;81;126;120;92;87 09:02:51 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;97;97;98;96;96;96;96;97;138 09:02:51 INFO - PROCESS | 1655 | |7;imaging-desaturate;140;145;139;90;92;90;90;91;122;127 09:02:51 INFO - PROCESS | 1655 | |8;json-parse-financial;56;59;59;57;58;59;57;58;57;57 09:02:51 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;68;72;78;71;85;81;76;72;72;71 09:02:51 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;88;87;91;88;97;104;91;85;91;88 09:02:51 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;154;152;134;136;148;119;139;147;197;160 09:02:51 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;199;219;172;222;211;220;203;172;168;169 09:02:51 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;69;67;70;67;69;74;88;91;75 09:02:51 INFO - PROCESS | 1655 | __end_tp_report 09:02:51 INFO - PROCESS | 1655 | __start_cc_report 09:02:51 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,979 09:02:51 INFO - PROCESS | 1655 | __end_cc_report 09:02:51 INFO - PROCESS | 1655 | __startTimestamp1472745771874__endTimestamp 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | ------- Summary: start ------- 09:02:51 INFO - PROCESS | 1655 | Number of tests: 14 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:133.00 Median:136.50 stddev:29.90 (21.9%) stddev-sans-first:29.95 09:02:51 INFO - PROCESS | 1655 | Values: 105.0 107.0 156.0 155.0 116.0 118.0 116.0 105.0 164.0 188.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:140.00 stddev:20.05 (14.3%) stddev-sans-first:20.23 09:02:51 INFO - PROCESS | 1655 | Values: 146.0 112.0 134.0 158.0 111.0 128.0 131.0 111.0 154.0 99.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:202.30 Median:199.50 stddev:10.98 (5.5%) stddev-sans-first:11.58 09:02:51 INFO - PROCESS | 1655 | Values: 199.0 216.0 227.0 202.0 194.0 199.0 199.0 200.0 197.0 190.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:87.80 Median:72.00 stddev:35.76 (49.7%) stddev-sans-first:37.21 09:02:51 INFO - PROCESS | 1655 | Values: 68.0 84.0 74.0 147.0 57.0 70.0 80.0 78.0 160.0 60.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:71.50 stddev:21.62 (30.2%) stddev-sans-first:22.08 09:02:51 INFO - PROCESS | 1655 | Values: 70.0 73.0 125.0 72.0 71.0 91.0 114.0 67.0 74.0 109.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:88.00 stddev:16.88 (19.2%) stddev-sans-first:15.90 09:02:51 INFO - PROCESS | 1655 | Values: 124.0 89.0 97.0 112.0 91.0 81.0 126.0 120.0 92.0 87.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:96.50 stddev:13.17 (13.6%) stddev-sans-first:13.81 09:02:51 INFO - PROCESS | 1655 | Values: 95.0 97.0 97.0 98.0 96.0 96.0 96.0 96.0 97.0 138.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:90.00 stddev:24.07 (26.7%) stddev-sans-first:23.40 09:02:51 INFO - PROCESS | 1655 | Values: 140.0 145.0 139.0 90.0 92.0 90.0 90.0 91.0 122.0 127.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:1.06 (1.8%) stddev-sans-first:0.93 09:02:51 INFO - PROCESS | 1655 | Values: 56.0 59.0 59.0 57.0 58.0 59.0 57.0 58.0 57.0 57.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:74.60 Median:74.00 stddev:5.30 (7.2%) stddev-sans-first:5.05 09:02:51 INFO - PROCESS | 1655 | Values: 68.0 72.0 78.0 71.0 85.0 81.0 76.0 72.0 72.0 71.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:89.50 stddev:5.62 (6.3%) stddev-sans-first:5.85 09:02:51 INFO - PROCESS | 1655 | Values: 88.0 87.0 91.0 88.0 97.0 104.0 91.0 85.0 91.0 88.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:150.00 stddev:20.70 (13.8%) stddev-sans-first:21.86 09:02:51 INFO - PROCESS | 1655 | Values: 154.0 152.0 134.0 136.0 148.0 119.0 139.0 147.0 197.0 160.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.50 Median:207.00 stddev:22.92 (11.1%) stddev-sans-first:24.27 09:02:51 INFO - PROCESS | 1655 | Values: 199.0 219.0 172.0 222.0 211.0 220.0 203.0 172.0 168.0 169.0 09:02:51 INFO - PROCESS | 1655 | 09:02:51 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:72.00 stddev:8.81 (12.2%) stddev-sans-first:9.00 09:02:51 INFO - PROCESS | 1655 | Values: 67.0 69.0 67.0 70.0 67.0 69.0 74.0 88.0 91.0 75.0 09:02:51 INFO - PROCESS | 1655 | -------- Summary: end -------- 09:02:51 INFO - PROCESS | 1655 | 09:02:52 INFO - TEST-INFO | 1655: exit 0 09:02:52 INFO - TEST-OK | kraken | took 61223ms 09:02:52 INFO - SUITE-END | took 1175s 09:02:53 INFO - Completed test suite (00:19:35) 09:02:53 INFO - javascript benchmark 09:02:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7217.547914575838, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3203.4554125798613, 3207.8772429649625, 3380.3070370574037, 3386.8137252451115, 3432.828358582071, 5584.720763961801, 5613.80351687691, 5638.859028524289, 5683.3464151622575, 5769.221155144054, 5568.220449137124, 5701.800436984707, 5720.599558030939, 5810.651360918338, 5815.0, 5168.948310516885, 5206.375234971809, 5239.921401178985, 5268.604854635899, 5300.946990530103, 5218.13900706383, 5282.260483532289, 5317.9468205317835, 5361.410244873061, 5380.166074258496, 5259.027079990214, 5298.814541491049, 5308.654937429074, 5318.574514038887, 5327.733613319338, 5143.27994080829, 5164.793408263665, 5188.558972487343, 5225.973870130663, 5233.842984710427, 4966.627502937295, 5050.873728156789, 5162.870928226825, 5189.532942035197, 5220.895582088337, 5596.916046259309, 5761.452661997104, 5776.046952252873, 5801.332846722638, 5810.941890581124, 6027.065804800263, 6084.452399284041, 6131.437835141539, 6145.846353841145, 6236.781712640081, 6245.156903817971, 6252.749890004395, 6263.812085637393, 6268.686565671698, 6287.0, 5751.0, 5819.632182536092, 5825.533957283407, 5831.650100993954, 5874.706264686749, 6174.783882564088, 6187.659678717624, 6210.254769427697, 6234.2830574484515, 6266.404691554295, 6099.279518885405, 6099.893623928163, 6100.3899610039525, 6102.847428814315, 6129.6985541375325, 6166.044263139221, 6170.5372097092895, 6235.657038862906, 6241.375862413723, 6307.5584709070845, 6009.634604621426, 6141.84645383869, 6162.383761623802, 6199.628022318675, 6207.565470417027, 6140.662263575457, 6207.906881396782, 6208.596441231305, 6212.1303017577575, 6229.127922090911, 4923.556879880828, 4929.580985616191, 4937.506249375034, 4938.185199442052, 4939.382577177853, 4366.934495982563, 4367.5632436756705, 4378.956210437855, 4404.031113155101, 4509.594136527729, 4259.361095835588, 4932.827351042768, 5039.622028347889, 5719.7140142992685, 5781.392953739797, 5131.5638170755155, 6211.65835879031, 6250.468710159687, 6256.061590761422, 6284.968575157095, 5511.063119269734, 5711.514521265656, 5717.085266357363, 5721.5136713379, 5802.88394232113, 5384.542313903284, 5390.353157621111, 5392.595555333366, 5396.676199428047, 5407.972960135174, 6250.531210159165, 6282.780102696383, 6288.5598008138995, 6293.244810622755, 6295.748170073146, 6115.209918062534, 6155.230596175478, 6186.566940314315, 6199.070139479114, 6253.906191407224, 6253.8749225014335, 6270.467010304175, 6275.686215689106, 6286.245650521783, 6289.496840252677, 6107.9083813741945, 6134.570580059353, 6141.84645383869, 6142.907856382247, 6151.2618485781995, 6108.099244189703, 6108.311716708011, 6110.376504976068, 6168.506519478341, 6249.7187626557825, 6020.759169633166, 6065.216742742879, 6080.543959203166, 6085.391460853879, 6098.298695650057, 6022.879542409215, 6027.457528822427, 6048.546359023003, 6071.787487437919, 6075.2405949256345, 4599.0, 5788.131780232999, 5820.388859169896, 5934.376890426615, 5980.9401905980385, 5745.1956726059225, 6053.909191362045, 6070.18052562916, 6100.725467353891, 6119.296280927751, 5918.644881307136, 5950.3454619992635, 5953.76184952597, 5960.135780311917, 5994.100884867305], "value": 5657.461405734559, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.91660584488943, 467.77546777546763, 471.307178447682, 513.7302915969116, 533.2747463449705, 32757.18107047322, 39215.80392098039, 39291.0177245569, 39296.41055384164, 39406.01484962877, 40259.19481610366, 40948.38577421341, 40973.0, 40975.79512102443, 41027.0, 9711.368761030546, 9854.768153980753, 9890.060444257784, 9893.010698930122, 9940.602375904955, 9715.70852874415, 9803.31376803624, 9816.018398160199, 9818.312718109735, 9852.753681157992, 9817.0, 9820.870599880998, 9821.2634052446, 9822.557984890696, 9828.066333698323, 9710.41737495749, 9780.0, 9780.119789219005, 9784.412935223909, 9795.461249631267, 9681.951590242004, 9708.75728106796, 9793.412395256308, 9805.215582753362, 9811.852822207673, 38539.65111221094, 38803.0, 38906.221875562616, 38938.02654933621, 38990.0, 3307.9834600827085, 3328.484084966834, 3383.204946837491, 3446.5691788526433, 3821.2357528494135, 30493.237669058228, 30763.538546921813, 30986.91545795909, 31140.53289200664, 31850.362992740247, 3216.6007786612663, 3256.967430325714, 3294.7364210863075, 3368.7641865069454, 3417.2823707021557, 506188.469057656, 509397.0, 515483.0, 516508.0, 517440.0, 34135.829320853736, 63817.72364552683, 65081.0, 65106.0, 65165.0, 35049.299014019576, 35396.0, 35964.28071438557, 36090.27819443597, 36184.276314473565, 14684.632884177981, 14729.852701472848, 14869.925650371679, 14874.033187842755, 14898.702025959421, 10760.838587421194, 11269.436528173559, 12456.439460224312, 12532.436040378205, 12611.243325400323, 6413.647249401328, 7362.263773622595, 7656.770296891103, 8011.198880111942, 8019.15798841125, 3318.900432987014, 3352.4468462703867, 3359.664033596621, 3360.1599600099976, 3383.3909896218424, 975.9414435133915, 981.4651015196735, 1016.2378216337746, 1034.425893629028, 1079.3200283821143, 30001.849990749906, 30134.0, 30440.54339184914, 30498.390032199233, 30654.846725766674, 997.6109317366233, 1042.2652030318607, 1054.836500342448, 1058.9470526473644, 1128.4752590045669, 13185.40665670028, 14794.482193123189, 15539.689206215813, 15601.0, 15698.607534811721, 674165.0, 679382.0, 679613.0, 680158.0, 681878.0, 55390.72304638532, 55525.722371387885, 55964.44035559592, 56055.87888242294, 56222.43777562172, 1331.6937104466026, 1386.3068465767117, 1393.2197969137314, 1394.1913690059741, 1402.52314213168, 28849.56725649075, 29704.851475743348, 29816.70183298226, 30310.84844575763, 30453.934112305964, 48684.75657621689, 49035.0, 49137.508624913295, 49207.0, 49231.0, 582188.0, 583711.0, 583712.0, 584004.0, 584074.0, 26435.60346594841, 26994.0, 27252.863735681196, 27356.726432735417, 27370.0, 40335.789926302255, 44508.0, 45308.86727831831, 46311.536884630725, 46682.0, 37815.810920945216, 38425.80787096047, 38492.23015539617, 39075.413868791424, 39298.80350598229, 31305.904293349624, 32278.35443291168, 33889.49165762565, 37500.24999500049, 38522.80738596289, 36784.63215367812, 37320.0, 37807.43288850725, 38295.6170438292, 38474.422883657324, 32230.677693223704, 33915.66084339125, 34272.0, 34900.65099349076, 35025.12437189091, 25127.869245884343, 25205.11782087618, 25223.621645675696, 25506.0, 25607.48785024252], "value": 18615.602656973766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.5757863299939, 372.05869151047847, 373.2683939478622, 377.1269511081847, 392.4113829256116, 19237.711434328477, 21009.844458554773, 21248.4687882803, 21580.568388632237, 21784.0, 20463.488412789688, 20871.47821304468, 21080.0, 21341.25305614304, 21396.8930155349, 5791.420857914217, 5895.263092113486, 5900.822975310747, 5928.851778705523, 6065.878682426349, 4163.208990291835, 5987.520998320146, 6027.879442411149, 6383.648899310536, 6668.133142691443, 5874.530037596982, 6668.599884006975, 6717.361850624183, 6717.932820671779, 6739.292374300701, 6502.414782669583, 6628.43658289046, 6665.70004349803, 6699.698513566901, 6744.055832183522, 5711.40030296817, 5716.828495145152, 5753.88492230153, 5782.074868021138, 5792.189093526909, 19951.600967980703, 20124.698129528068, 26515.867420662966, 26533.20400387972, 26564.0, 1958.8922609256485, 2212.177453152128, 2406.554787364343, 2425.78167964884, 2891.956620650692, 10284.794304113875, 12124.454399552042, 12364.381780910919, 14448.49430269946, 15816.604584885356, 1855.4897403214088, 1886.8490520758444, 1887.764029496313, 1887.877287976277, 1912.3880358285355, 104649.0, 127858.0, 128032.99999999907, 131416.0, 131742.34128829392, 11182.944085279685, 11551.826722599168, 11644.475998580085, 11653.41732913351, 11874.0, 14380.496682616058, 14545.490907818175, 14556.41774329015, 14569.927150364181, 14603.78094328586, 7522.435817313723, 7943.126256111823, 8620.78448038804, 8738.95630521856, 8739.344549158839, 8479.321654267644, 8486.872696909551, 8506.65973361071, 8662.2637075848, 8662.30701543875, 3694.854595075535, 4477.843275485342, 4527.547245275512, 4591.471980722193, 4632.837850675211, 1598.424567155823, 1679.3450554283838, 1682.142107525171, 1908.7327774111636, 1961.1076959983172, 696.9581825090511, 894.7449976756593, 1009.7374682582581, 1012.4532752313668, 1052.8052310322614, 20469.795302047085, 20482.0, 20949.476263093544, 21214.151433942778, 21388.679169812152, 762.6682393158993, 922.6816748221853, 924.306769922558, 926.1294383279695, 926.9119433653792, 9946.653758439765, 10782.245242832927, 11150.219484635998, 11339.092872570174, 11355.829662555068, 216917.9154104251, 217141.0, 217473.0, 218087.0, 218149.0, 84478.0, 112281.43859280652, 140010.0, 142191.2890435562, 142242.0, 1014.325473560089, 1027.6762819711766, 1058.1799105692996, 1066.8293073108266, 1066.9733256668646, 15413.075215487106, 15650.373985040926, 16423.507294781175, 17752.91123544374, 19585.02074896221, 45885.541144588125, 49489.50510494993, 52033.47966520286, 54099.0, 55186.724066379415, 67057.97652140887, 68423.65788171027, 69543.0, 69743.0, 70807.58384832377, 6967.233604303421, 7342.971983922362, 7980.760577182694, 8061.39539534549, 8334.83330333402, 11848.644540663794, 11942.820857687315, 12022.75954480888, 13048.934755326163, 13222.867771322164, 11188.888111118784, 11453.59912403062, 11488.94255528717, 11681.415929203677, 11709.238899471507, 8797.560121993747, 9534.808148981378, 11035.337879727242, 11289.37908415045, 11334.206605537533, 9688.612455501701, 11750.23623464472, 11806.055515558563, 11837.0, 11893.048556115664, 7216.603086830275, 7301.634918254173, 7394.482386232912, 7489.13874904393, 7598.202188770099, 10380.740481488023, 11172.49723762449, 11212.27120237182, 11407.315561066363, 11504.769904601693], "value": 9326.93352672847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.3341313115661, 1507.6155580327018, 1735.7830271216098, 1833.6241070580531, 1886.6792645250307, 8042.276195142436, 8501.872471912919, 8718.912810871889, 9033.819323613532, 9042.14099660532, 8742.650293988248, 8891.822163556724, 8899.243564297027, 8910.0, 8914.974777900527, 2329.755375685554, 2358.6344116661858, 2362.9645555316683, 2368.3842201027683, 2371.893264803088, 2150.827933765295, 2330.3707998840305, 2382.4877651304964, 2382.7259865115475, 2386.737458879522, 2089.7252675867708, 2333.5216280662507, 2369.6327069304198, 2379.3694670912223, 2388.36708272308, 2203.0, 2246.1015593762463, 2246.3036458697775, 2247.550489902026, 2247.685324054634, 1987.6322880267196, 2317.1310758465575, 2338.543983923136, 2353.317537914003, 2357.210334537932, 8738.082501337396, 8845.336599754979, 8891.377603567753, 8893.421927574751, 8898.59956301968, 5207.661502002357, 5325.387580428262, 5327.893442131136, 5346.866328341784, 5383.219433182206, 3460.2733425980323, 3565.16218688608, 3634.2549777295853, 3637.3634613942454, 3649.5620525537106, 917.5320586500866, 1038.7195457226508, 1073.4579037586047, 1091.6343025086605, 1097.067492631265, 9829.55766990487, 11330.773384532346, 11506.654800355918, 11548.59579914699, 11559.133065020073, 4545.250033744395, 4671.135839869635, 4760.619150467955, 4775.355327030876, 4778.7849546769785, 9804.166645835041, 9896.802063958681, 9917.652882149234, 9933.00669933001, 9950.701478955643, 5304.045271851104, 5317.574594032468, 5323.813666521731, 5335.3864305604575, 5344.011357898801, 3593.69453596442, 4381.408509851193, 4657.906841863144, 4700.341952126705, 4849.466558678542, 3138.8901388451295, 3833.0, 3870.0324918770307, 3957.9010524737114, 3978.602139785998, 1078.600917660455, 1287.6458973782285, 1297.48100759695, 1305.7399609376996, 1320.8811206991418, 712.5724565260803, 833.3624777045565, 860.2601762484259, 861.3066481482467, 883.6288758721353, 5472.480114389126, 5597.944020559742, 5791.0734282514595, 6030.577435031677, 6076.240469941257, 436.6986779122459, 442.52870692712156, 445.49213896158403, 445.8528685533766, 452.377980277119, 3990.4812374391145, 4032.7983600819844, 4082.7346222495444, 4127.566605506378, 4136.255474014646, 10340.37957722539, 10825.025747682588, 10828.620998265023, 10853.24027318096, 10862.185336099667, 10748.97884700952, 10762.192835537366, 10766.78466430667, 10769.9461502692, 10849.0, 6690.732370705215, 7980.241877021674, 8155.836883262302, 8165.142660020612, 8234.958825205835, 5294.788208471618, 5668.348139963792, 5985.311689155803, 6083.452489275986, 6147.815565533041, 9999.650012249536, 10004.899951000396, 10035.0, 10076.647317343857, 10180.592776289162, 9608.471534065693, 10033.849492257476, 10068.345557539029, 10150.949245253727, 10257.84613230817, 6927.134108236471, 7373.8156546086775, 7418.517796343221, 7652.846943060997, 7658.463907526642, 8519.616617252115, 8607.139286071342, 8609.69866054685, 8623.611937462954, 8652.307815374628, 7340.412766978736, 7428.888566671396, 7510.361619262424, 7570.9242907570215, 7622.69509219625, 7276.126864776261, 7386.335229829341, 7410.888836667346, 7504.587247701429, 7564.810879728051, 6857.108575885103, 6917.0, 7006.089208402875, 7019.227884932551, 7055.3650171484815, 4612.169809434334, 4735.857924262277, 4932.556069953722, 5122.46214147524, 5140.56305214061, 4458.977705111453, 4767.61859051282, 4998.575121114601, 5094.59898527893, 5219.243209734643], "value": 4460.726184824278, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.4529339548254, 298.3198307858084, 307.91840162356965, 310.2569346415334, 311.1924555777756, 5129.846104616863, 5357.249985002098, 5427.615957930732, 5555.388907220213, 5706.3166365922, 4799.928001079978, 4918.458969513351, 5591.7483713232905, 5728.16941543477, 5754.309482862052, 3928.135810121769, 4050.4936882889638, 4061.918761624766, 4136.544980052199, 4332.443858123706, 3963.346047902093, 4279.015826359939, 4279.7860106994685, 4327.883923575021, 4333.956660433402, 3540.539729835131, 3842.9615703843024, 4218.704690671654, 4226.640735537483, 4274.722143060691, 4181.979090104561, 4245.554216807237, 4254.702605480747, 4255.191513612434, 4264.402983582301, 3115.704008119225, 3360.4455264881267, 3427.7600567960253, 3551.928961420783, 3577.105723569108, 4727.290906364073, 4946.554810067075, 5437.755301011464, 5458.9454105458835, 5473.728402712869, 4777.570018698334, 4789.425268967711, 4810.855674329776, 4832.830850920236, 4871.853844384674, 5522.696251706155, 5711.600187986843, 5770.394108618577, 5801.679328268684, 5861.589688721791, 3777.338965680995, 3950.209958008381, 3961.6632586230203, 3965.4844870166694, 3982.5264652078627, 6134.086309003233, 6155.72299246535, 6234.532410069263, 6245.7501699931945, 6247.064818793148, 3350.564426624523, 3500.754947153726, 3844.5770965193806, 3969.0275882408996, 3988.3818008208773, 4006.2788698034633, 4060.2082593893906, 4085.4076158957378, 4086.2644723949975, 4097.959020409758, 4036.7577945323374, 4790.299443697507, 4811.879703007453, 4821.855344339676, 4829.806807727651, 5624.328443989072, 5653.830385088454, 5953.940460595425, 5988.041913293852, 6016.0, 1101.8732845722845, 1335.2989680417859, 1337.5385492005244, 1367.4206291733065, 1372.1629805818443, 759.3749376334648, 794.9801254968672, 904.8642703594381, 931.329442801182, 931.8835145606799, 5144.356955380577, 5452.509274165344, 5476.26070480488, 5525.613207075467, 5543.251661025791, 5636.0, 5994.280686317583, 5994.430529099728, 6026.276846778327, 6057.545684073624, 5043.293938848564, 5136.716524393028, 5465.207544905967, 5470.699111548824, 5519.668819870821, 2307.411610039429, 2479.962800557993, 2597.5064737699777, 2715.813769915237, 2724.891004359843, 4403.921039345317, 4847.975760121248, 5090.5565328641715, 5097.0, 5189.558887494605, 4443.488998765119, 4761.809527618856, 5200.7919683213, 5639.492445679908, 6390.7763228286785, 6405.391487808651, 6442.774502892376, 6458.351031667093, 6468.450181734511, 6507.34926507355, 5591.692456914909, 6037.637741735334, 6073.180120683651, 6290.056491526125, 6329.430351268408, 5365.409804921534, 5998.160257563857, 6048.155312629514, 6113.021916493518, 6132.693365331805, 5447.891042179213, 6032.3967603239325, 6256.7810126645345, 6509.316521765336, 6526.934730652632, 3736.4208547675153, 3851.9614803851605, 3991.481107456012, 3995.4606128172327, 3996.6802655786887, 5428.864278393072, 5783.739731712168, 5798.275215598051, 6105.297890742621, 6130.995812052151, 5548.278723765885, 5768.7404066817935, 5936.575221946615, 5966.880662386815, 5988.8802223956145, 5091.389033316026, 5989.341172471112, 6017.458428741435, 6053.9091913622215, 6058.757649693963, 4810.446798618063, 5145.845624631267, 5237.266782650356, 5785.652860828363, 5884.0, 5143.048536020848, 5777.884442311046, 5920.437558431942, 6063.514918806397, 6088.4824789893355, 5061.177975928589, 5140.820071297487, 5184.611154163377, 5617.634853734494, 5906.616069955439], "value": 4216.115106809287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.9257581666017, 683.2893790457924, 705.2982282628782, 753.3107206905681, 803.6745118227118, 15135.394584216632, 15980.520584382459, 15998.29203263012, 16124.677506449863, 16225.75661365079, 12338.81491777624, 12380.690482737937, 12407.51849630073, 12422.19255748378, 12892.226466412021, 843.1652663862777, 857.9184977427135, 861.8707193920931, 862.1335557764469, 862.607513581319, 668.7191379620571, 821.4660470694037, 843.6667516331046, 844.7550210438965, 849.8342823149488, 904.5884122724177, 904.606496174163, 906.2976193450096, 906.3610154840854, 907.7140700679265, 742.3912391838694, 845.0957475501216, 886.6320477002068, 900.2123142250531, 901.1124042817819, 512.5182328611094, 652.8367908022994, 668.5053060735021, 669.3540733192444, 669.8392385827415, 14649.97450178488, 15023.849761502355, 15037.699246015129, 15046.398144074225, 15053.924730376388, 14574.70850582993, 14632.0, 14704.779428308584, 14863.108213507225, 14954.327055282538, 11707.473163707653, 11781.410929453494, 11903.702407439796, 11982.522993436158, 12017.0, 3816.9618303816883, 3823.9866435394642, 3859.208862183246, 3867.3425517662067, 3976.443297938291, 93068.0, 95845.0, 97068.0, 108685.99999999921, 116304.0, 10914.508847101899, 10993.285436446606, 11069.391183484986, 11231.719207019727, 11541.307521548733, 21031.474213144793, 21539.461513462287, 21563.78436215649, 21606.567868642855, 21664.891675541523, 7430.0, 7967.163447838009, 8141.0230772307705, 8142.592870356459, 8308.335333173332, 4434.157510073076, 4552.521985191574, 4558.749268790182, 4564.52072532386, 4567.132244873464, 3441.690247877703, 3515.472679098156, 3573.249617580337, 3586.7267120171964, 3596.5863925648364, 663.8473151175257, 669.5781657555709, 669.8995150727333, 673.0, 673.9696713647897, 510.05894125338693, 540.8566729816602, 556.2462862820901, 561.6938768371248, 593.4156747365163, 7461.552306861606, 8872.378933474594, 9113.772155696028, 9114.726558203265, 9258.95370523143, 568.4855206038542, 578.2425023219596, 587.3949831673383, 631.6052467207995, 644.674439408096, 4180.686448516373, 4227.661787057028, 4297.634701050383, 4506.842260520866, 4543.182227199136, 87169.12830871737, 91147.63278550826, 133143.0, 151644.0, 161990.19004905137, 121602.3919880395, 122221.0, 125853.0, 127984.0, 130937.34531327282, 113495.43252283685, 115606.0, 118368.40815795866, 119233.807661924, 119899.0, 8709.825803484022, 9708.417494950325, 9825.223435948361, 10147.695569132939, 10209.489525523843, 50941.0, 60046.69976650089, 61699.383006169366, 62161.162272150934, 63687.0, 82463.0, 92183.0, 93483.0, 94738.52630736803, 99167.0, 10258.846117308396, 11051.944740276569, 11864.940675296568, 13148.013898957424, 13316.467341306627, 12314.0, 14747.778783318474, 15006.174660393783, 15094.245287735788, 15395.3072111753, 12855.485780568673, 13756.449742010207, 13833.30833458303, 13984.230867302396, 14327.641808954442, 12729.29988850622, 12759.744805104032, 13633.931830340785, 13893.374798133906, 14302.983076584796, 13498.52755153565, 13572.660683482993, 13719.451221951409, 13910.652233694238, 14094.718105638034, 11199.944000279946, 11273.830892536454, 11549.42252887369, 11580.942095289469, 11671.941640291745, 8069.556174410463, 9391.624335026523, 9669.142740420963, 10173.847392288973, 11554.826677599674], "value": 7651.378830542928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 156.0, 155.0, 116.0, 118.0, 116.0, 105.0, 164.0, 188.0], "value": 133.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 134.0, 158.0, 111.0, 128.0, 131.0, 111.0, 154.0, 99.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 216.0, 227.0, 202.0, 194.0, 199.0, 199.0, 200.0, 197.0, 190.0], "value": 202.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 84.0, 74.0, 147.0, 57.0, 70.0, 80.0, 78.0, 160.0, 60.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 125.0, 72.0, 71.0, 91.0, 114.0, 67.0, 74.0, 109.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 89.0, 97.0, 112.0, 91.0, 81.0, 126.0, 120.0, 92.0, 87.0], "value": 101.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 138.0], "value": 100.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 145.0, 139.0, 90.0, 92.0, 90.0, 90.0, 91.0, 122.0, 127.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 59.0, 57.0, 58.0, 59.0, 57.0, 58.0, 57.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 78.0, 71.0, 85.0, 81.0, 76.0, 72.0, 72.0, 71.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 91.0, 88.0, 97.0, 104.0, 91.0, 85.0, 91.0, 88.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 134.0, 136.0, 148.0, 119.0, 139.0, 147.0, 197.0, 160.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 219.0, 172.0, 222.0, 211.0, 220.0, 203.0, 172.0, 168.0, 169.0], "value": 195.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 70.0, 67.0, 69.0, 74.0, 88.0, 91.0, 75.0], "value": 73.7, "unit": "score"}]}]} 09:02:53 INFO - Return code: 0 09:02:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:53 ERROR - # TBPL SUCCESS # 09:02:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:02:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:02:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:02:53 INFO - 2016-09-01 09:02:53.195 screenresolution[1660:10926] starting screenresolution argv=screenresolution get 09:02:53 INFO - 2016-09-01 09:02:53.198 screenresolution[1660:10926] Display 0: 1600x1200x32@60 09:02:53 INFO - 2016-09-01 09:02:53.204 screenresolution[1661:10929] starting screenresolution argv=screenresolution list 09:02:53 INFO - Available Modes on Display 0 09:02:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:02:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:02:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:02:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:02:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:02:53 INFO - Intel Iris: 09:02:53 INFO - Chipset Model: Intel Iris 09:02:53 INFO - Type: GPU 09:02:53 INFO - Bus: Built-In 09:02:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:02:53 INFO - Vendor: Intel (0x8086) 09:02:53 INFO - Device ID: 0x0a2e 09:02:53 INFO - Revision ID: 0x0009 09:02:53 INFO - Displays: 09:02:53 INFO - Display: 09:02:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:02:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:02:53 INFO - Display Serial Number: 1600x1200 60 09:02:53 INFO - Main Display: Yes 09:02:53 INFO - Mirror: Off 09:02:53 INFO - Online: Yes 09:02:53 INFO - Rotation: Supported 09:02:53 INFO - Return code: 0 09:02:53 INFO - Running post-action listener: _resource_record_post_action 09:02:53 INFO - [mozharness: 2016-09-01 16:02:53.442312Z] Finished run-tests step (success) 09:02:53 INFO - Running post-run listener: _resource_record_post_run 09:02:53 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32865280; Write bytes: 707922944; Read time: 308; Write time: 2335 09:02:53 INFO - TinderboxPrint: CPU usage
54.6% 09:02:53 INFO - TinderboxPrint: I/O read bytes / time
32,865,280 / 308 09:02:53 INFO - TinderboxPrint: I/O write bytes / time
707,922,944 / 2,335 09:02:53 INFO - TinderboxPrint: CPU idle
2,197.4 (45.4%) 09:02:53 INFO - TinderboxPrint: CPU system
975.8 (20.2%) 09:02:53 INFO - TinderboxPrint: CPU user
1,668.4 (34.5%) 09:02:53 INFO - TinderboxPrint: Swap in / out
434,855,936 / 0 09:02:53 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384182784; Write bytes: 379193344; Read time: 29018; Write time: 1027 09:02:53 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 31943680; Write bytes: 298296320; Read time: 295; Write time: 1256 09:02:53 INFO - Running post-run listener: _upload_blobber_files 09:02:53 INFO - Blob upload gear active. 09:02:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:53 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 09:02:53 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:53 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:55 INFO - (blobuploader) - INFO - Done attempting. 09:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:02:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:56 INFO - (blobuploader) - INFO - Done attempting. 09:02:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:59 INFO - (blobuploader) - INFO - Done attempting. 09:02:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:59 INFO - Return code: 0 09:02:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba193f39a60d64d17e5e5c52f0ed6bffb8432e3d9aaae3e7fd811515809c9abebdd09f5f98f03c60c09ec1a38e8525f27bfb82698ddac64be6a9a92e84f701e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9313024223504704a9de431a646755163394a18010397133a9ee3a29bcd3404a1311cff97b0f0481e5824c9cdc38746716355359d1f10aae96ab7a0b33435ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53001da739defdff48b0ffa5c9c1e6cd7ec17fe99d23ef2e5af5c249e0c97c7a1644f3bd6173d1b6abaca9fd20827f144eb45cfe19ff14ba26e060b29b3d63c4"} 09:02:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:59 INFO - Contents: 09:02:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba193f39a60d64d17e5e5c52f0ed6bffb8432e3d9aaae3e7fd811515809c9abebdd09f5f98f03c60c09ec1a38e8525f27bfb82698ddac64be6a9a92e84f701e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9313024223504704a9de431a646755163394a18010397133a9ee3a29bcd3404a1311cff97b0f0481e5824c9cdc38746716355359d1f10aae96ab7a0b33435ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53001da739defdff48b0ffa5c9c1e6cd7ec17fe99d23ef2e5af5c249e0c97c7a1644f3bd6173d1b6abaca9fd20827f144eb45cfe19ff14ba26e060b29b3d63c4"} 09:02:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:59 INFO - Copying logs to upload dir... 09:02:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.068024 ========= master_lag: 34.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-09-01 09:03:33.457823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:03:33.461840) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lKgqReHMpA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba193f39a60d64d17e5e5c52f0ed6bffb8432e3d9aaae3e7fd811515809c9abebdd09f5f98f03c60c09ec1a38e8525f27bfb82698ddac64be6a9a92e84f701e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9313024223504704a9de431a646755163394a18010397133a9ee3a29bcd3404a1311cff97b0f0481e5824c9cdc38746716355359d1f10aae96ab7a0b33435ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53001da739defdff48b0ffa5c9c1e6cd7ec17fe99d23ef2e5af5c249e0c97c7a1644f3bd6173d1b6abaca9fd20827f144eb45cfe19ff14ba26e060b29b3d63c4"} build_url:https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba193f39a60d64d17e5e5c52f0ed6bffb8432e3d9aaae3e7fd811515809c9abebdd09f5f98f03c60c09ec1a38e8525f27bfb82698ddac64be6a9a92e84f701e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9313024223504704a9de431a646755163394a18010397133a9ee3a29bcd3404a1311cff97b0f0481e5824c9cdc38746716355359d1f10aae96ab7a0b33435ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53001da739defdff48b0ffa5c9c1e6cd7ec17fe99d23ef2e5af5c249e0c97c7a1644f3bd6173d1b6abaca9fd20827f144eb45cfe19ff14ba26e060b29b3d63c4"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:03:33.654943) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:03:33.655300) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lKgqReHMpA/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.GDQ38Zn2Cm/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005172 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:03:33.682367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:03:33.682703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:03:33.683941) ========= ========= Total master_lag: 34.57 =========