builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1470702821.94 results: success (0) buildid: 20160808145420 builduid: 5ecc12caa96d41eb9b72f16d80f46e6b revision: 638fd37c122a6d6c2c5d182e2bcd91256e39867c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:41.935718) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:41.936281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-08-08 17:33:41.936832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-08-08 17:33:44.150005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:44.150437) ========= 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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-08-08 17:33: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% 80.4M=0s 2016-08-08 17:33:44 (80.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.632988 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:44.866005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:44.866335) ========= 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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.024471 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:44.970114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 17:33:44.970472) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 638fd37c122a6d6c2c5d182e2bcd91256e39867c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 638fd37c122a6d6c2c5d182e2bcd91256e39867c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qJc7bJG5HM/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.jdVlX1U1kD/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-08-08 17:33:45,068 truncating revision to first 12 chars 2016-08-08 17:33:45,069 Setting DEBUG logging. 2016-08-08 17:33:45,069 attempt 1/10 2016-08-08 17:33:45,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/638fd37c122a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 17:33:46,652 unpacking tar archive at: autoland-638fd37c122a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.863539 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 17:33:46.882063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:46.882665) ========= script_repo_revision: 638fd37c122a6d6c2c5d182e2bcd91256e39867c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:46.883502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:46.884036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 17:33:46.904978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-08 17:33:46.905658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qJc7bJG5HM/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.jdVlX1U1kD/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:33:47 INFO - MultiFileLogger online at 20160808 17:33:47 in /builds/slave/test 17:33:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 17:33:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:33:47 INFO - {'append_to_log': False, 17:33:47 INFO - 'base_work_dir': '/builds/slave/test', 17:33:47 INFO - 'blob_upload_branch': 'Autoland', 17:33:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:33:47 INFO - 'branch': 'Autoland', 17:33:47 INFO - 'buildbot_json_path': 'buildprops.json', 17:33:47 INFO - 'config_files': ('talos/mac_config.py',), 17:33:47 INFO - 'default_actions': ('clobber', 17:33:47 INFO - 'read-buildbot-config', 17:33:47 INFO - 'download-and-extract', 17:33:47 INFO - 'populate-webroot', 17:33:47 INFO - 'create-virtualenv', 17:33:47 INFO - 'install', 17:33:47 INFO - 'run-tests'), 17:33:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:33:47 INFO - 'download_minidump_stackwalk': True, 17:33:47 INFO - 'download_symbols': 'ondemand', 17:33:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:33:47 INFO - 'tooltool.py': '/tools/tooltool.py', 17:33:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:33:47 INFO - '/tools/misc-python/virtualenv.py')}, 17:33:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:33:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:33:47 INFO - 'installer_path': 'installer.exe', 17:33:47 INFO - 'log_level': 'info', 17:33:47 INFO - 'log_name': 'talos', 17:33:47 INFO - 'log_to_console': True, 17:33:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:33:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:33:47 INFO - 'opt_config_files': (), 17:33:47 INFO - 'pip_index': False, 17:33:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:47 INFO - 'cmd': ('bash', 17:33:47 INFO - '-c', 17:33:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:47 INFO - 'enabled': True, 17:33:47 INFO - 'halt_on_failure': False, 17:33:47 INFO - 'name': 'check_screen_resolution'},), 17:33:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:47 INFO - 'cmd': ('bash', 17:33:47 INFO - '-c', 17:33:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:47 INFO - 'enabled': True, 17:33:47 INFO - 'halt_on_failure': False, 17:33:47 INFO - 'name': 'check_screen_resolution'},), 17:33:47 INFO - 'run_cmd_checks_enabled': True, 17:33:47 INFO - 'sps_profile': False, 17:33:47 INFO - 'sps_profile_interval': 0, 17:33:47 INFO - 'suite': 'dromaeojs', 17:33:47 INFO - 'system_bits': '32', 17:33:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:33:47 INFO - 'title': 't-yosemite-r7-0038', 17:33:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:33:47 INFO - 'use_talos_json': True, 17:33:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:33:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:33:47 INFO - 'work_dir': 'build'} 17:33:47 INFO - [mozharness: 2016-08-09 00:33:47.111823Z] Running clobber step. 17:33:47 INFO - Running pre-action listener: _resource_record_pre_action 17:33:47 INFO - Running main action method: clobber 17:33:47 INFO - rmtree: /builds/slave/test/build 17:33:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:33:48 INFO - Running post-action listener: _resource_record_post_action 17:33:48 INFO - [mozharness: 2016-08-09 00:33:48.846755Z] Finished clobber step (success) 17:33:48 INFO - [mozharness: 2016-08-09 00:33:48.846918Z] Running read-buildbot-config step. 17:33:48 INFO - Running pre-action listener: _resource_record_pre_action 17:33:48 INFO - Running main action method: read_buildbot_config 17:33:48 INFO - Using buildbot properties: 17:33:48 INFO - { 17:33:48 INFO - "project": "", 17:33:48 INFO - "product": "firefox", 17:33:48 INFO - "script_repo_revision": "production", 17:33:48 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 17:33:48 INFO - "repository": "", 17:33:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 17:33:48 INFO - "buildid": "20160808145420", 17:33:48 INFO - "pgo_build": "False", 17:33:48 INFO - "basedir": "/builds/slave/test", 17:33:48 INFO - "buildnumber": 95, 17:33:48 INFO - "slavename": "t-yosemite-r7-0038", 17:33:48 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:33:48 INFO - "platform": "yosemite_r7", 17:33:48 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:33:48 INFO - "branch": "autoland", 17:33:48 INFO - "repo_path": "integration/autoland", 17:33:48 INFO - "revision": "638fd37c122a6d6c2c5d182e2bcd91256e39867c", 17:33:48 INFO - "stage_platform": "macosx64", 17:33:48 INFO - "builduid": "5ecc12caa96d41eb9b72f16d80f46e6b", 17:33:48 INFO - "slavebuilddir": "test" 17:33:48 INFO - } 17:33:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:33:48 INFO - Running post-action listener: _resource_record_post_action 17:33:48 INFO - [mozharness: 2016-08-09 00:33:48.850244Z] Finished read-buildbot-config step (success) 17:33:48 INFO - [mozharness: 2016-08-09 00:33:48.850364Z] Running download-and-extract step. 17:33:48 INFO - Running pre-action listener: _resource_record_pre_action 17:33:48 INFO - Running main action method: download_and_extract 17:33:48 INFO - mkdir: /builds/slave/test/build/tests 17:33: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')]} 17:33:48 INFO - trying https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:33:48 INFO - Downloading https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:33:50 INFO - Downloaded 1199 bytes. 17:33:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:33:50 INFO - Using the following test package requirements: 17:33:50 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:33:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:33:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:33:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'jsshell-mac.zip'], 17:33:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:33:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:33:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:33:50 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:33:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:33:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:33:50 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:33:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:50 INFO - trying https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:33:50 INFO - Downloading https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:33:51 INFO - Downloaded 16324638 bytes. 17:33:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:33:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:33:54 INFO - Return code: 0 17:33:54 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 17:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:54 INFO - trying https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:33:54 INFO - Downloading https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:33:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:33:55 INFO - Downloaded 16324638 bytes. 17:33:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:33:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:33:59 INFO - Return code: 0 17:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:59 INFO - trying https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:33:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:34:01 INFO - Downloaded 14413723 bytes. 17:34:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:34:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:34:01 INFO - Return code: 0 17:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:01 INFO - trying https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/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 17:34:05 INFO - Downloaded 111981685 bytes. 17:34:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:34:05 INFO - mkdir: /builds/slave/test/properties 17:34:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:05 INFO - Contents: 17:34:05 INFO - build_url:https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:34:06 INFO - Running post-action listener: _resource_record_post_action 17:34:06 INFO - Running post-action listener: set_extra_try_arguments 17:34:06 INFO - [mozharness: 2016-08-09 00:34:06.272671Z] Finished download-and-extract step (success) 17:34:06 INFO - [mozharness: 2016-08-09 00:34:06.272824Z] Running populate-webroot step. 17:34:06 INFO - Running pre-action listener: _resource_record_pre_action 17:34:06 INFO - Running main action method: populate_webroot 17:34:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:06 INFO - '--tppagecycles', 17:34:06 INFO - '7'], 17:34:06 INFO - 'tests': ['tsvgm']}}, 17:34:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['damp', 'tps']}, 17:34:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'tests': ['damp', 'tps']}, 17:34:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['dromaeo_dom']}, 17:34:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['basic_compositor_video']}, 17:34:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:34:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['a11yr', 17:34:06 INFO - 'ts_paint', 17:34:06 INFO - 'tpaint', 17:34:06 INFO - 'sessionrestore', 17:34:06 INFO - 'sessionrestore_no_auto_restore', 17:34:06 INFO - 'tabpaint']}, 17:34:06 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:06 INFO - 'ts_paint', 17:34:06 INFO - 'tpaint', 17:34:06 INFO - 'sessionrestore', 17:34:06 INFO - 'sessionrestore_no_auto_restore', 17:34:06 INFO - 'tabpaint']}, 17:34:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:06 INFO - 'ts_paint', 17:34:06 INFO - 'tpaint', 17:34:06 INFO - 'sessionrestore', 17:34:06 INFO - 'sessionrestore_no_auto_restore', 17:34:06 INFO - 'tabpaint']}, 17:34:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:06 INFO - 'ts_paint', 17:34:06 INFO - 'tpaint', 17:34:06 INFO - 'sessionrestore', 17:34:06 INFO - 'sessionrestore_no_auto_restore', 17:34:06 INFO - 'tabpaint']}, 17:34:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['a11yr', 17:34:06 INFO - 'ts_paint', 17:34:06 INFO - 'tpaint', 17:34:06 INFO - 'sessionrestore', 17:34:06 INFO - 'sessionrestore_no_auto_restore', 17:34:06 INFO - 'tabpaint']}, 17:34:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['a11yr', 17:34:06 INFO - 'ts_paint', 17:34:06 INFO - 'tpaint', 17:34:06 INFO - 'sessionrestore', 17:34:06 INFO - 'sessionrestore_no_auto_restore', 17:34:06 INFO - 'tabpaint']}, 17:34:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['tsvgx', 17:34:06 INFO - 'tsvgr_opacity', 17:34:06 INFO - 'tart', 17:34:06 INFO - 'tscrollx', 17:34:06 INFO - 'cart']}, 17:34:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:06 INFO - 'tsvgr_opacity', 17:34:06 INFO - 'tart', 17:34:06 INFO - 'tscrollx', 17:34:06 INFO - 'cart']}, 17:34:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'talos_options': ['--disable-e10s'], 17:34:06 INFO - 'tests': ['tp5o']}, 17:34:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'tests': ['tp5o']}, 17:34:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'talos_options': ['--disable-e10s', 17:34:06 INFO - '--xperf_path', 17:34:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:06 INFO - 'tests': ['tp5n']}, 17:34:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:06 INFO - 'talos_options': ['--xperf_path', 17:34:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:06 INFO - 'tests': ['tp5n']}}, 17:34:06 INFO - 'talos.zip': {'path': '', 17:34:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:06 INFO - Running post-action listener: _resource_record_post_action 17:34:06 INFO - [mozharness: 2016-08-09 00:34:06.291673Z] Finished populate-webroot step (success) 17:34:06 INFO - [mozharness: 2016-08-09 00:34:06.291805Z] Running create-virtualenv step. 17:34:06 INFO - Running pre-action listener: _resource_record_pre_action 17:34:06 INFO - Running main action method: create_virtualenv 17:34:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:06 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 17:34:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:06 INFO - Using real prefix '/tools/python27' 17:34:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:07 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:09 INFO - Installing pip.................done. 17:34:09 INFO - Return code: 0 17:34:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:09 INFO - 'HOME': '/Users/cltbld', 17:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:09 INFO - 'LOGNAME': 'cltbld', 17:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:09 INFO - 'MOZ_NO_REMOTE': '1', 17:34:09 INFO - 'NO_EM_RESTART': '1', 17:34:09 INFO - 'PAGER': '/bin/cat', 17:34:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:09 INFO - 'PWD': '/builds/slave/test', 17:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:09 INFO - 'SHELL': '/bin/bash', 17:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:09 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:09 INFO - 'USER': 'cltbld', 17:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:09 INFO - 'XPC_FLAGS': '0x0', 17:34:09 INFO - 'XPC_SERVICE_NAME': '0', 17:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:10 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 17:34:10 INFO - Cleaning up... 17:34:10 INFO - Return code: 0 17:34:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:10 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:10 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 17:34:10 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 17:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:10 INFO - 'HOME': '/Users/cltbld', 17:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:10 INFO - 'LOGNAME': 'cltbld', 17:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:10 INFO - 'MOZ_NO_REMOTE': '1', 17:34:10 INFO - 'NO_EM_RESTART': '1', 17:34:10 INFO - 'PAGER': '/bin/cat', 17:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:10 INFO - 'PWD': '/builds/slave/test', 17:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:10 INFO - 'SHELL': '/bin/bash', 17:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:10 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:10 INFO - 'USER': 'cltbld', 17:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:10 INFO - 'XPC_FLAGS': '0x0', 17:34:10 INFO - 'XPC_SERVICE_NAME': '0', 17:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:10 INFO - Downloading/unpacking psutil>=3.1.1 17:34:10 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 17:34:10 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 17:34:10 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 17:34:10 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 17:34:10 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 17:34:10 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 17:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:13 INFO - Installing collected packages: psutil 17:34:13 INFO - Running setup.py install for psutil 17:34:13 INFO - building 'psutil._psutil_osx' extension 17:34:13 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 17:34:14 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 17:34:14 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 17:34:14 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 17:34:14 INFO - building 'psutil._psutil_posix' extension 17:34:14 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 17:34:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:34:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:34:14 INFO - ^ 17:34:14 INFO - 1 warning generated. 17:34:14 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 17:34:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:14 INFO - Successfully installed psutil 17:34:14 INFO - Cleaning up... 17:34:14 INFO - Return code: 0 17:34:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:34: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 mozsystemmonitor==0.3 17:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:14 INFO - 'HOME': '/Users/cltbld', 17:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:14 INFO - 'LOGNAME': 'cltbld', 17:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:14 INFO - 'MOZ_NO_REMOTE': '1', 17:34:14 INFO - 'NO_EM_RESTART': '1', 17:34:14 INFO - 'PAGER': '/bin/cat', 17:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:14 INFO - 'PWD': '/builds/slave/test', 17:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:14 INFO - 'SHELL': '/bin/bash', 17:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:14 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:14 INFO - 'USER': 'cltbld', 17:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:14 INFO - 'XPC_FLAGS': '0x0', 17:34:14 INFO - 'XPC_SERVICE_NAME': '0', 17:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:14 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 17:34:14 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 17:34:14 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 17:34:14 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 17:34:14 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 17:34:14 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 17:34:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:17 INFO - Installing collected packages: mozsystemmonitor 17:34:17 INFO - Running setup.py install for mozsystemmonitor 17:34:17 INFO - Successfully installed mozsystemmonitor 17:34:17 INFO - Cleaning up... 17:34:17 INFO - Return code: 0 17:34:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:17 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:17 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 17:34:17 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 17:34:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:17 INFO - 'HOME': '/Users/cltbld', 17:34:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:17 INFO - 'LOGNAME': 'cltbld', 17:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:17 INFO - 'MOZ_NO_REMOTE': '1', 17:34:17 INFO - 'NO_EM_RESTART': '1', 17:34:17 INFO - 'PAGER': '/bin/cat', 17:34:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:17 INFO - 'PWD': '/builds/slave/test', 17:34:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:17 INFO - 'SHELL': '/bin/bash', 17:34:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:17 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:17 INFO - 'USER': 'cltbld', 17:34:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:17 INFO - 'XPC_FLAGS': '0x0', 17:34:17 INFO - 'XPC_SERVICE_NAME': '0', 17:34:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:20 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:20 INFO - warning: no files found matching '*.txt' 17:34:20 INFO - no previously-included directories found matching 'build' 17:34:20 INFO - no previously-included directories found matching 'dist' 17:34:20 INFO - no previously-included directories found matching '.git*' 17:34:20 INFO - Installing collected packages: jsonschema, functools32 17:34:20 INFO - Running setup.py install for functools32 17:34:21 INFO - warning: no files found matching '*.txt' 17:34:21 INFO - no previously-included directories found matching 'build' 17:34:21 INFO - no previously-included directories found matching 'dist' 17:34:21 INFO - no previously-included directories found matching '.git*' 17:34:21 INFO - Successfully installed jsonschema functools32 17:34:21 INFO - Cleaning up... 17:34:21 INFO - Return code: 0 17:34:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:34:21 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')]} 17:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:21 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')]} 17:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:21 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:21 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 17:34:21 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 17:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:21 INFO - 'HOME': '/Users/cltbld', 17:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:21 INFO - 'LOGNAME': 'cltbld', 17:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:21 INFO - 'MOZ_NO_REMOTE': '1', 17:34:21 INFO - 'NO_EM_RESTART': '1', 17:34:21 INFO - 'PAGER': '/bin/cat', 17:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:21 INFO - 'PWD': '/builds/slave/test', 17:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:21 INFO - 'SHELL': '/bin/bash', 17:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:21 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:21 INFO - 'USER': 'cltbld', 17:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:21 INFO - 'XPC_FLAGS': '0x0', 17:34:21 INFO - 'XPC_SERVICE_NAME': '0', 17:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:21 INFO - Cleaning up... 17:34:21 INFO - Return code: 0 17:34:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34:21 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')]} 17:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:21 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')]} 17:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:21 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:21 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 17:34:21 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 17:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:21 INFO - 'HOME': '/Users/cltbld', 17:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:21 INFO - 'LOGNAME': 'cltbld', 17:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:21 INFO - 'MOZ_NO_REMOTE': '1', 17:34:21 INFO - 'NO_EM_RESTART': '1', 17:34:21 INFO - 'PAGER': '/bin/cat', 17:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:21 INFO - 'PWD': '/builds/slave/test', 17:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:21 INFO - 'SHELL': '/bin/bash', 17:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:21 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:21 INFO - 'USER': 'cltbld', 17:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:21 INFO - 'XPC_FLAGS': '0x0', 17:34:21 INFO - 'XPC_SERVICE_NAME': '0', 17:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:21 INFO - Downloading/unpacking blobuploader==1.2.4 17:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:24 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:34:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:34:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:25 INFO - Downloading docopt-0.6.1.tar.gz 17:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:34:25 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:25 INFO - Running setup.py install for blobuploader 17:34:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:34:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:34:25 INFO - Running setup.py install for requests 17:34:26 INFO - Running setup.py install for docopt 17:34:26 INFO - Successfully installed blobuploader requests docopt 17:34:26 INFO - Cleaning up... 17:34:26 INFO - Return code: 0 17:34:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:26 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:26 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 17:34:26 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 17:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:26 INFO - 'HOME': '/Users/cltbld', 17:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:26 INFO - 'LOGNAME': 'cltbld', 17:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:26 INFO - 'MOZ_NO_REMOTE': '1', 17:34:26 INFO - 'NO_EM_RESTART': '1', 17:34:26 INFO - 'PAGER': '/bin/cat', 17:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:26 INFO - 'PWD': '/builds/slave/test', 17:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:26 INFO - 'SHELL': '/bin/bash', 17:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:26 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:26 INFO - 'USER': 'cltbld', 17:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:26 INFO - 'XPC_FLAGS': '0x0', 17:34:26 INFO - 'XPC_SERVICE_NAME': '0', 17:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-0AV32d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-AG49KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-JNzaYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-bqRHTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-JUMkKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tpnwJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-WAwtrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-OBTGnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-VGRBbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-OOt2Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qABJV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-NfHCt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-6jDXrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XE2f75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XfgsLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XEJ8Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-eDbXAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:34:28 INFO - Running setup.py install for manifestparser 17:34:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:34:28 INFO - Running setup.py install for mozcrash 17:34:28 INFO - Running setup.py install for mozdebug 17:34:28 INFO - Running setup.py install for mozdevice 17:34:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:34:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:34:28 INFO - Running setup.py install for mozfile 17:34:29 INFO - Running setup.py install for mozhttpd 17:34:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:34:29 INFO - Running setup.py install for mozinfo 17:34:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:34:29 INFO - Running setup.py install for mozInstall 17:34:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:34:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:34:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:34:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:34:29 INFO - Running setup.py install for mozleak 17:34:29 INFO - Running setup.py install for mozlog 17:34:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:34:29 INFO - Running setup.py install for moznetwork 17:34:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:34:30 INFO - Running setup.py install for mozprocess 17:34:30 INFO - Running setup.py install for mozprofile 17:34:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:34:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:34:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:34:30 INFO - Running setup.py install for mozrunner 17:34:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:34:30 INFO - Running setup.py install for mozscreenshot 17:34:30 INFO - Running setup.py install for moztest 17:34:30 INFO - Running setup.py install for mozversion 17:34:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:34:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:34:30 INFO - Cleaning up... 17:34:30 INFO - Return code: 0 17:34:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:30 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')]} 17:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:30 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')]} 17:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:30 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:30 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 17:34:30 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 17:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:30 INFO - 'HOME': '/Users/cltbld', 17:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:30 INFO - 'LOGNAME': 'cltbld', 17:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:30 INFO - 'MOZ_NO_REMOTE': '1', 17:34:30 INFO - 'NO_EM_RESTART': '1', 17:34:30 INFO - 'PAGER': '/bin/cat', 17:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:30 INFO - 'PWD': '/builds/slave/test', 17:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:30 INFO - 'SHELL': '/bin/bash', 17:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:30 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:30 INFO - 'USER': 'cltbld', 17:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:30 INFO - 'XPC_FLAGS': '0x0', 17:34:30 INFO - 'XPC_SERVICE_NAME': '0', 17:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-cWRlqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:31 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)) 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-1sEopU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:31 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)) 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4XgVVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:31 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)) 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-rhShHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:31 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)) 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Dw_ZcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:31 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)) 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-A2Yws7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:31 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)) 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ZB0fd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-X953jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-bg4ALz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-mEQaWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ixgoGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-VbERgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dfpcIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-HjhlIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Hzqm3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:32 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)) 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-M7lETh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:33 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)) 17:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:33 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ntREal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:33 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)) 17:34:33 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)) 17:34:33 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)) 17:34:33 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)) 17:34:33 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)) 17:34:33 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)) 17:34:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:35 INFO - Downloading blessings-1.6.tar.gz 17:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:34:35 INFO - Installing collected packages: blessings 17:34:35 INFO - Running setup.py install for blessings 17:34:35 INFO - Successfully installed blessings 17:34:35 INFO - Cleaning up... 17:34:35 INFO - Return code: 0 17:34:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:34:36 INFO - Reading from file tmpfile_stdout 17:34:36 INFO - Current package versions: 17:34:36 INFO - blessings == 1.6 17:34:36 INFO - blobuploader == 1.2.4 17:34:36 INFO - docopt == 0.6.1 17:34:36 INFO - functools32 == 3.2.3-2 17:34:36 INFO - jsonschema == 2.5.1 17:34:36 INFO - manifestparser == 1.1 17:34:36 INFO - mozInstall == 1.12 17:34:36 INFO - mozcrash == 0.17 17:34:36 INFO - mozdebug == 0.1 17:34:36 INFO - mozdevice == 0.48 17:34:36 INFO - mozfile == 1.2 17:34:36 INFO - mozhttpd == 0.7 17:34:36 INFO - mozinfo == 0.9 17:34:36 INFO - mozleak == 0.1 17:34:36 INFO - mozlog == 3.3 17:34:36 INFO - moznetwork == 0.27 17:34:36 INFO - mozprocess == 0.23 17:34:36 INFO - mozprofile == 0.28 17:34:36 INFO - mozrunner == 6.12 17:34:36 INFO - mozscreenshot == 0.1 17:34:36 INFO - mozsystemmonitor == 0.3 17:34:36 INFO - moztest == 0.7 17:34:36 INFO - mozversion == 1.4 17:34:36 INFO - psutil == 3.1.1 17:34:36 INFO - requests == 1.2.3 17:34:36 INFO - wsgiref == 0.1.2 17:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:36 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:36 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 17:34:36 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 17:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:36 INFO - 'HOME': '/Users/cltbld', 17:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:36 INFO - 'LOGNAME': 'cltbld', 17:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:36 INFO - 'MOZ_NO_REMOTE': '1', 17:34:36 INFO - 'NO_EM_RESTART': '1', 17:34:36 INFO - 'PAGER': '/bin/cat', 17:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:36 INFO - 'PWD': '/builds/slave/test', 17:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:36 INFO - 'SHELL': '/bin/bash', 17:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:36 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:36 INFO - 'USER': 'cltbld', 17:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:36 INFO - 'XPC_FLAGS': '0x0', 17:34:36 INFO - 'XPC_SERVICE_NAME': '0', 17:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 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)) 17:34:36 INFO - Cleaning up... 17:34:36 INFO - Return code: 0 17:34:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:36 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 0x103dd6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e6b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97485a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, '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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 17:34:36 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 17:34:36 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 17:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:36 INFO - 'HOME': '/Users/cltbld', 17:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:36 INFO - 'LOGNAME': 'cltbld', 17:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:36 INFO - 'MOZ_NO_REMOTE': '1', 17:34:36 INFO - 'NO_EM_RESTART': '1', 17:34:36 INFO - 'PAGER': '/bin/cat', 17:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:36 INFO - 'PWD': '/builds/slave/test', 17:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:36 INFO - 'SHELL': '/bin/bash', 17:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:34:36 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:36 INFO - 'USER': 'cltbld', 17:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:36 INFO - 'XPC_FLAGS': '0x0', 17:34:36 INFO - 'XPC_SERVICE_NAME': '0', 17:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:34:36 INFO - Cleaning up... 17:34:36 INFO - Return code: 0 17:34:36 INFO - Running post-action listener: _resource_record_post_action 17:34:36 INFO - Running post-action listener: _start_resource_monitoring 17:34:36 INFO - Starting resource monitoring. 17:34:36 INFO - [mozharness: 2016-08-09 00:34:36.841291Z] Finished create-virtualenv step (success) 17:34:36 INFO - [mozharness: 2016-08-09 00:34:36.842285Z] Running install step. 17:34:36 INFO - Running pre-action listener: _resource_record_pre_action 17:34:36 INFO - Running main action method: install 17:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:34:37 INFO - Reading from file tmpfile_stdout 17:34:37 INFO - Detecting whether we're running mozinstall >=1.0... 17:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:34:37 INFO - Reading from file tmpfile_stdout 17:34:37 INFO - Output received: 17:34:37 INFO - Usage: mozinstall [options] installer 17:34:37 INFO - Options: 17:34:37 INFO - -h, --help show this help message and exit 17:34:37 INFO - -d DEST, --destination=DEST 17:34:37 INFO - Directory to install application into. [default: 17:34:37 INFO - "/builds/slave/test"] 17:34:37 INFO - --app=APP Application being installed. [default: firefox] 17:34:37 INFO - mkdir: /builds/slave/test/build/application 17:34:37 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'] 17:34:37 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 17:35:11 INFO - Reading from file tmpfile_stdout 17:35:11 INFO - Output received: 17:35:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:35:11 INFO - Running post-action listener: _resource_record_post_action 17:35:11 INFO - [mozharness: 2016-08-09 00:35:11.638114Z] Finished install step (success) 17:35:11 INFO - [mozharness: 2016-08-09 00:35:11.638262Z] Running run-tests step. 17:35:11 INFO - Running pre-action listener: _resource_record_pre_action 17:35:11 INFO - Running main action method: run_tests 17:35:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:11 INFO - 2016-08-08 17:35:11.652 screenresolution[6618:111522] starting screenresolution argv=screenresolution get 17:35:11 INFO - 2016-08-08 17:35:11.654 screenresolution[6618:111522] Display 0: 1600x1200x32@60 17:35:11 INFO - 2016-08-08 17:35:11.660 screenresolution[6619:111524] starting screenresolution argv=screenresolution list 17:35:11 INFO - Available Modes on Display 0 17:35:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:11 INFO - Intel Iris: 17:35:11 INFO - Chipset Model: Intel Iris 17:35:11 INFO - Type: GPU 17:35:11 INFO - Bus: Built-In 17:35:11 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:11 INFO - Vendor: Intel (0x8086) 17:35:11 INFO - Device ID: 0x0a2e 17:35:11 INFO - Revision ID: 0x0009 17:35:11 INFO - Displays: 17:35:11 INFO - Display: 17:35:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:11 INFO - Display Serial Number: 1600x1200 60 17:35:11 INFO - Main Display: Yes 17:35:11 INFO - Mirror: Off 17:35:11 INFO - Online: Yes 17:35:11 INFO - Rotation: Supported 17:35:11 INFO - Return code: 0 17:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:11 INFO - Python 2.7.3 17:35:11 INFO - Return code: 0 17:35:11 INFO - grabbing minidump binary from tooltool 17:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:11 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 0x103d3ad30>, '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 0x103a9fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:11 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 17:35:11 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 17:35:11 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 17:35:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:12 INFO - Return code: 0 17:35:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:35:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:35:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qJc7bJG5HM/Render', 17:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:12 INFO - 'HOME': '/Users/cltbld', 17:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:12 INFO - 'LOGNAME': 'cltbld', 17:35:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:12 INFO - 'MOZ_NO_REMOTE': '1', 17:35:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:12 INFO - 'NO_EM_RESTART': '1', 17:35:12 INFO - 'PAGER': '/bin/cat', 17:35:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:12 INFO - 'PWD': '/builds/slave/test', 17:35:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:12 INFO - 'SHELL': '/bin/bash', 17:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdVlX1U1kD/Listeners', 17:35:12 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 17:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:12 INFO - 'USER': 'cltbld', 17:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:12 INFO - 'XPC_FLAGS': '0x0', 17:35:12 INFO - 'XPC_SERVICE_NAME': '0', 17:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:35:12 INFO - mozversion application_buildid: 20160808145420 17:35:12 INFO - mozversion application_changeset: 638fd37c122a6d6c2c5d182e2bcd91256e39867c 17:35:12 INFO - mozversion application_display_name: Nightly 17:35:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:12 INFO - mozversion application_name: Firefox 17:35:12 INFO - mozversion application_remotingname: firefox 17:35:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:35:12 INFO - mozversion application_vendor: Mozilla 17:35:12 INFO - mozversion application_version: 51.0a1 17:35:12 INFO - mozversion platform_buildid: 20160808145420 17:35:12 INFO - mozversion platform_changeset: 638fd37c122a6d6c2c5d182e2bcd91256e39867c 17:35:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:35:12 INFO - mozversion platform_version: 51.0a1 17:35:12 INFO - using testdate: 1470702912 17:35:12 INFO - actual date: 1470702912 17:35:12 INFO - starting webserver on 'localhost:59008' 17:35:12 INFO - SUITE-START | Running 2 tests 17:35:12 INFO - TEST-START | dromaeo_css 17:35:12 INFO - operating with platform_type : mac_ 17:35:12 INFO - Initialising browser for dromaeo_css test... 17:35:12 INFO - TEST-INFO | started process 6629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpEjjGZe/profile http://localhost:59008/getInfo.html) 17:35:14 INFO - PROCESS | 6629 | __metrics Screen width/height:1600/1200 17:35:14 INFO - PROCESS | 6629 | colorDepth:24 17:35:14 INFO - PROCESS | 6629 | Browser inner width/height: 1024/689 17:35:14 INFO - PROCESS | 6629 | __metrics 17:35:14 INFO - PROCESS | 6629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:35:14 INFO - PROCESS | 6629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:15 INFO - TEST-INFO | 6629: exit 0 17:35:15 INFO - Browser initialized. 17:35:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:15 INFO - TEST-INFO | started process 6631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpEjjGZe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:27 INFO - PROCESS | 6631 | RSS: Main: 243625984 17:35:27 INFO - PROCESS | 6631 | 17:36:19 INFO - PROCESS | 6631 | 1470702979050 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] 17:38:31 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:59008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59008/tests/dromaeo/cssquery-ext.html) 17:38:32 INFO - PROCESS | 6631 | RSS: Main: 364916736 17:38:32 INFO - PROCESS | 6631 | 17:41:35 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:59008/tests/dromaeo/cssquery-ext.html (next: http://localhost:59008/tests/dromaeo/cssquery-jquery.html) 17:41:36 INFO - PROCESS | 6631 | RSS: Main: 391217152 17:41:36 INFO - PROCESS | 6631 | 17:44:38 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:59008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59008/tests/dromaeo/cssquery-mootools.html) 17:44:39 INFO - PROCESS | 6631 | RSS: Main: 354955264 17:44:39 INFO - PROCESS | 6631 | 17:47:41 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:59008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59008/tests/dromaeo/cssquery-prototype.html) 17:47:42 INFO - PROCESS | 6631 | RSS: Main: 350781440 17:47:42 INFO - PROCESS | 6631 | 17:50:45 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:59008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59008/tests/dromaeo/cssquery-yui.html) 17:50:46 INFO - PROCESS | 6631 | RSS: Main: 344834048 17:50:46 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | Cycle 1(1): loaded http://localhost:59008/tests/dromaeo/cssquery-yui.html (next: http://localhost:59008/tests/dromaeo/cssquery-dojo.html) 17:53:49 INFO - PROCESS | 6631 | RSS: Main: 416428032 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | __start_tp_report 17:53:49 INFO - PROCESS | 6631 | _x_x_mozilla_page_load 17:53:49 INFO - PROCESS | 6631 | _x_x_mozilla_page_load_details 17:53:49 INFO - PROCESS | 6631 | |i|pagename|runs| 17:53:49 INFO - PROCESS | 6631 | |0;dojo.html;3335.199552107493;3336.049225970598;3336.182635254363;3356.3958487472246;3404.9148771280716;5616.550675945925;5732.398098199692;5732.742026608802;5747.712614369286;5750.856228594287;5686.886262274762;5739.913901291484;5788.884222315552;5827.475527202551;5830.475257226859;4367.912641747163;4908.607311415079;5156.303898973628;5228.189630607262;5332.280142180814;5338.946610533903;5344.973275133619;5400.216968539579;5413.404525502192;5420.783168673248;5168.508991645787;5214.374275086976;5278.445763194848;5282.603804714662;5301.284326615915;5247.763850626693;5260.973695131538;5273.920891186635;5275.841724748264;5282.181261904411;5186.870328241786;5222.399424066205;5223.294855194538;5227.947720522822;5245.527902488794;5656.2929633795775;5705.372409035002;5717.599768016241;5720.628159169641;5728.341240757283;6176.320604733476;6249.5625306228585;6258.030005349178;6264.373562643745;6298.1812364392335;6266.342034086447;6335.8416039598915;6345.143405640226;6345.619262844244;6358.332375100594;5751.712414379264;5840.707964601753;5895.410458954113;5957.106434034929;5967.373425790316;6315.305316415191;6341.8731625368155;6374.681265936684;6375;6380.617162970237;5413.810516631977;6140.894638965029;6255.749770009149;6261.373862613702;6263.467605253604;6175.2898416681755;6249.750009999549;6313.431791138728;6327.335629758901;6333.841653958596;6281.8743625127245;6294;6295.464885484694;6298.874022519524;6313.652749098844;5309.256704061358;6251.531135164881;6319.715612797435;6327.4938004959495;6335.683215839282;4927.802887884516;4933.753312334441;4993.525615066563;5012.323336349619;5057.443681195065;3782.3002744491805;4474.351219073216;4485.215087359699;4509.255972764523;4562.270036794097;5732.426757324234;5735.569832262597;5744.310682718101;5751.568632352591;5795.072788353843;6210.534209934273;6248.281447633581;6305.022721478178;6332.68336583169;6357.141785858942;5724.914126288109;5725.885482290331;5727.77088916447;5730.484256416942;5781.508571771363;5496.120620700749;5505.366882808448;5505.807296744595;5506.394296627368;5510.559155267569;5904.3210030845285;5946.316173639913;6304.148939893055;6309.621422714652;6400.103985442041;6251.843703907439;6335.049742538656;6338.049292606146;6338.429541341301;6340.968295158495;6400.871982560229;6404.359564043559;6408.327125651739;6424.51816113784;6456.354364563694;6103.792276408585;6174.783882564268;6178.814635560941;6250.843728906813;6278.246610406781;6137.294211165595;6244.1570387997035;6313.715882785194;6325.146105275913;6338.366163383625;6117.908231376622;6172.22847144107;6181.443670069715;6191.349908259748;6286.874262514815;6038.63768173911;6101.450869421773;6186.133941248138;6188.504919606511;6205.81382558524;5962.19510366095;6022.939770602238;6053.606515576474;6061.15143879866;6063.6664983426335;6122.692552514308;6157.692115394302;6159.938400615936;6161.075838624242;6167.352427994996;5064.34163558735;5855.560832937632;5898.528117750484;5937.2578427696535;5973.223480947623 17:53:49 INFO - PROCESS | 6631 | |1;ext.html;506.3695698854925;515.8039944820968;517.3507248403254;517.6454128921689;569.8632328241221;25949.351266218353;41045.97385065375;42171;42292.78853605736;44418.333724994154;42981;43854.780726096404;43865.12269754611;43912;44767.88080297994;8773.736787896374;9669.178119859802;9861.654842080528;9874.753131171743;9874.950625246864;8800.471971681687;11870.406479676025;11999.340036298001;12063.698407539794;12348.135630505823;12080.395980200954;12133.02935765141;12136.332501712446;12180.939095304511;12203.389830508484;11932.284062956207;12021.278723276631;12033.819492707617;12060.698482537919;12064.914157725803;10262;11744.177907546475;11874.703132421759;11965.820512692317;11974.101942354358;40420.595794042274;40752.184956300705;40816.59183408158;40817.183656327004;40851.18297634031;3410.437277849152;3463.3765922134007;3971.1660551284267;4178.603032711888;4339.761313127777;31604.893828715885;32955.83522082398;33487.33025339479;33527.161820954425;33582.83208583966;3208.4224839528874;3324.1523411530147;3350.329934013207;3379.797212167278;3387.779794313362;503231;504745;506983;507040;509889.9999999963;59620.701896491104;60159.39840601538;60314;60427.69786151041;60459.48851278753;63407;63632.68183659052;63744.68127659332;63769.04346434807;63816;16221.2700428481;16435.753463697816;16450.588735281475;16456.753148702777;16459.58851028734;11620.244684095676;11777.528898844123;11781.469833857496;12779.552715654907;12827;12376.938115309365;13626.523071692443;13629.296337957756;15927.681446371007;16224.59438514023;4979.676321039121;5526.419725928719;6258.405451482102;6268.874622507525;6309.305976342599;823.3495538524618;921.424109931293;968.7045451137329;1031.5564307347913;1041.6198087697935;30390.84804575963;30548.38903221923;30594.133322786118;30758.231044223627;31095.68904310928;930.237205491504;1070.8661417322835;1085.907697845692;1142.971425714347;1176.0767797279095;10608.681739547827;15679.216039197994;15813.209339532978;16013.43952961664;16109.597260068593;666985;670195;688914;725482;871320;50076.748081297534;50583.74708126509;50614;59945.700271499234;60354;1395.5324966136254;1406.8030475733406;1417.766068598711;1426.179946530749;1426.828780546341;30612.08163755091;31492.2126946819;31687.52468713017;31867.681323186473;32138.19654508656;51078.23382649189;51616.48383516267;51633.225501616755;51718;51874.48125518696;647836;655794;660728;661505;852431;39647.2070558593;39813.00467488336;40066.9933006697;40224.396634049925;40225;39141.80429097836;46921.765391174195;47077.529224707316;48109.5189048105;48523;38249;38408.423873642474;38871.22257554776;39381.409278860265;39394.6060539391;37001.19717645176;38093.61906381012;38846.80576597099;39502.60497395104;39662;37553.81223093867;37675.81162094172;38427.42358864675;38539.807300963315;38552;32244.516332255505;32738.017859464253;34118.65881341254;34371.48442773311;34586;25179.87410062938;25276.368090797878;25314.114006009702;25542.616860747476;26020 17:53:49 INFO - PROCESS | 6631 | |2;jquery.html;352.5593008739076;367.896988843124;375.1877185892543;383.86372837642637;400.66144108228536;15183.924080379596;15419.768703469457;20198.49503762405;22110;22378.88810555949;21074.578508429822;21162.41151674222;21418.14327426905;21470;21667.241646542374;5315.415304316522;5333.280007199017;6152.200213972177;6157.261128664544;6182.350853160421;5345.518903298703;6021.09683547467;6671.9658452939875;6739.22498912624;6844.007618895257;6557;6618.635975021371;6780.796576102724;6786.151731033621;6791.524593278473;6600;6674.466042716595;6688.9665551672415;6694.062831203635;6709.832254193684;4883.560479556857;5587.329520457572;5804.709764511757;5806.390329015477;5823.097419899922;26497.867510662516;26616.60075098875;26698.798554065113;26827.463450731073;27130.5930411044;2172.5335398606035;2201.5927053495157;2212.7012853264923;2270.035235025124;2342.4846533762716;15782.210889455597;15841.257461679206;15892;16045.197740113064;16521.091339976298;1875.5573169523377;1885.1516817432073;1896.8482521398394;1915.9904200479048;1960.9411717648493;122297;126766.36616816856;127451;127829.72170278271;129335;8522.616482258314;10590.940905909501;11129.833052504218;11237;11384.715382115513;12164.209326393933;12796.232226066466;12803.807942880865;13470.52853150135;13509.932450337685;7813.726519571901;8587.570621469027;8707.869381959275;8710.172533609297;8837.60230789616;6649.335066493409;8227.629756660845;8236.546989915492;8260.29787468072;8856.690015849414;6681.592387882215;6748.966255168692;6774.153230846145;6776.864462710718;6782.151496371535;1689.0997627668874;1771.7342398640308;1828.7714035745532;1863.369551642313;1868.6449574580786;725.3109545931386;852.5566705313203;956.784723437221;1013.2755080117752;1017.399734156851;21998.45003874916;22957.311280661608;23022.19422320244;23034.424139396648;23075.76924230736;862.4695812075529;981.7545613596601;990.1732053735212;1000.1498726082772;1063.6702622187147;11010;11659.475323610457;12080.697982550506;12296.692582685504;12321.568745093879;521634.39182803844;584157.2477642073;592640;604463;605490;118790.40604797093;122465;125372.37313813555;127730;130136;955.5365647660878;983.4394395194813;1029.156092004549;1056.5773690523852;1074;15978.840211597735;16408.343666253215;18253.63097767646;18400;19126.426207213804;56594.15108773289;56623.433765661815;56653.86692266214;56887.71556142193;56951.14573281321;76039;80157;80487.19512804797;81822.18177818146;83695;5886.6173698709445;8246.463979841292;8349;8394.538300393293;8414.368922330972;11219.55121795119;11653.65982911942;13100.868991309964;13565.864341356855;13593.660158496117;10575;11015.504302306255;11199.832002519806;11335.829962550733;11750.29498230109;11203.383813890314;11257.549698011988;11401.486933087865;11750.764984700087;11909.821352679543;9703.708888733348;11605.825912611486;11704.70738231551;11958.58144964922;11966.521339146337;8123.7156699515235;8343.916560834314;8348.332133429432;8422.873656895028;8625.39622226438;8454.450460720034;11269.211155219384;11299.43502824839;11647.76704465923;11828.940855295668 17:53:49 INFO - PROCESS | 6631 | |3;mootools.html;1370.7806750919856;1506.5329747778187;1666.7083260429429;1791.6774980503503;1865.8320751132396;8040.678372865085;8617.181367770068;8621.74134775957;8623.482591044542;8636;7350.228226036256;7562.62186890656;7613.657385417656;7796.92203077969;8422.915770842304;2142.3358758784825;2171.9674204886937;2172.174573662014;2173.5544213436206;2175.401764514755;2183.094015983373;2216.9334919952425;2246.3485589179118;2250.3473992542145;2251.6735073414343;2202.603531364354;2231.8884055797143;2233.9553208935813;2234.4190510467315;2236.541508990653;2198.043850924837;2207.4591725027312;2219.711437513129;2223.288547664748;2226.9888650556804;2222.7110475638224;2227.55448910217;2229.5285111826115;2230.531588366445;2231.732192136954;7705.075390953066;8427.073021967579;8560.657573697044;8561.972563292382;8570.528620925847;5018.347614810088;5171.250168725552;5175.560077393426;5182.766775495112;5183.300254465675;3304.206990322329;3389.796612203276;3519.1729943463265;3525.506429099928;3529.364714351416;1066.5360568152878;1068.5031460370888;1069.588208539718;1083.344576531203;1094.3597995172834;9490.572924218426;10908.672739817897;11026.724331891766;11069.169812264032;11105.777884442266;4368.60682538573;4449.243628583149;4604.171249175113;4619.330197121399;4624.583787459145;9438.905610943802;9446.716598502057;9449.669261575811;9456.196223320958;9461.810763784824;5134.563562097189;5140.640155189176;5142.074426603247;5146.099432599281;5152.845414637567;3981.8009099544906;4221.583490947714;4244.87265382039;4703.435587729426;4722.102800467969;3599.7300202484917;3907.765534067965;3913;3914;3930.6265904739003;1133.580575187186;1227.0551675210038;1234.3457967277357;1272.0586765793246;1282.3844554613838;786.1862971824249;793.4049462902823;905.6739573753443;907.1427501011481;920.8572671235969;5399.433059528693;5734.311882574118;5764.365919748824;5820.912686309709;6051.304100028465;876.8732179149762;920.5489310237936;944.5513381143902;958.2956526952685;1081.9026287634151;3714.981425092857;3806.657400833938;3918.2359439908946;3924.9018774530296;3949.3878448840474;9908.603655853685;10307.226957978182;10333.431661258703;10335.379877207391;10339.276250662531;8630.921134858143;9923.156531694742;10223;10269.281150319406;10287.434191119411;7740.806479838049;7963.4425590209285;7964.561949092856;7965.004374453193;7965.960170199228;5660.349059858169;5668.149777533403;5808.30300363959;5856.824295271149;5876.382979787061;9525.904740952501;9559.474228917476;9568.13886750168;9578.13796758295;9582;8681.479111253346;9096.454212747256;9659.46872921968;9667.033296670557;9827.754306142404;6798.524103312919;7001.859962800613;7257.637118144177;7344.22885597026;7449.366803821736;7942.44402891792;7993.560354180576;8001.999750031246;8027.1972802719265;8070.919290807252;7290.635468226461;7299.4160467163565;7314.926850731425;7373.410127189704;7374.410047196318;7116.644167791694;7185.209626940928;7196.496245262991;7251;7303.196648368781;6675.499337549606;6784.7964561063245;6787.457003439812;6788.558743681842;6800.693968771318;4146.834126635022;4713.481517033192;4911.287863259879;4913.361263035782;4960.826371076995;4155.916881662411;4809.2064809306075;4850.975745121393;4921.138800709933;4988.326575912205 17:53:49 INFO - PROCESS | 6631 | |4;prototype.html;299.8201079352388;307.93225490392115;310.77779387737763;316.3467439736943;319.38358967193335;4921.926171107427;5337.904015670912;5381.327334083239;5404.972975135119;5410.756515956781;4844.038164543357;5255.211718242265;5305.1776974569;5341.919871201935;5366.973165134169;3329.583802024747;3412.129906873756;3783.8486460541544;3927.5483319418204;4017.2568074906235;3853.7109716771215;4034.253663072326;4085.9182816343655;4106.3635136553885;4134.52452967908;3351.9832400837963;3982.2234664240486;3989.840406383741;3992.421098940652;4073.4704488416614;3912.100216950089;3989.0426297688637;3994.0414300567945;4012.61880121388;4032.677385809143;3497.0383144635175;3504.3516949364193;3511.9297614047578;3526.947095793565;3544.8936531904083;5080.390353157608;5099.617528685327;5114.05390002847;5135.717535535544;5153.304303918998;3655.689266412358;3699.6300369963055;3994.7003974702016;4615.076984603059;4637;5172.612054095958;5547.006155568025;5564.721763911788;5586.55307575393;5603.551715862762;3877.205172939569;3883.85407819667;3889.824957876874;3892.1317767471774;3923.607639236082;4876;5505.9724701376235;5842.123681447817;5877.647341159544;5881.323822710507;3862.613738626115;3907.33575292201;3955.3671412574427;3958.426028225891;3960.821763020671;3522.7181825453904;3553.9209562405763;4035.3543433050572;4038.7374820636564;4048.0487085534874;4294.506131794884;4330;4614.146382919171;4650.232711602615;4654.2785868190485;5081.822136225214;5398.731298144933;5626.212330273765;5630.915536266959;5675.8864822704145;1209.5343292832322;1231.4581584102966;1234.8024316109559;1370.9451621935211;1375.8555351687928;692.9480288978347;728.6611725547646;740.9054564895448;833.5998720614018;835.3484282259847;4624.329472226508;4927.408710954636;4955.90088198234;5063.468335824686;5088.414832294334;5184.714840683799;5518.33779946409;5553.6390134641115;5638.323401191883;5768.3366412862215;5021.72380519075;5150.459201783834;5160.458151893997;5215.087359712111;5245.659032162897;2470.172492215128;2517.2379334465945;2936.7503762180027;2951.276937150412;3048.359844432694;4971.751412429364;5295.179247216687;5494.340679118532;5883.323417807007;5945.524358051345;4776.761161941889;5622.8313150605545;5832.416758324133;5863.29640443141;5864.882702345929;5278.709670968134;5919.348871624032;5933.199018132583;5944.573302407478;5945.554083443759;5041.924371134362;5451.236826844324;5722.341930677859;5759.827205183851;5783.652980821164;5623.2408624835125;5623.606347555632;5669.546436285004;5679.35909801944;5698.287714035746;5455.563554915518;5877.590188023061;5904.114382842608;5926.348101708895;5954.225950626565;3291.1278511194073;3776.3957766757185;3868.7872167031082;3946.881593552198;3947.032976920673;5712.88598723245;5727.914081288867;5742.626729262584;5748.9425105748405;5806.970965145148;5236.10986132366;5291.3121294231505;5555.388907220284;5561.860953476195;5619.80330688424;5316.746602717888;5385.138377859524;5503.229547863382;5548.195511650869;5660.622538533908;5031.345925029723;5159.432462429055;5426.511613954605;5444.067356088532;5480.6437581557075;5265.868353291198;5394.460553944574;5463.399026107205;5527.793879549771;5564.221009058816;4242.4272723181975;4617.9307310389695;5417.566594672496;5433.320834895638;5454.236406902957 17:53:49 INFO - PROCESS | 6631 | |5;yui.html;704.383664293743;712.8992061797838;775.643204126102;803.1526739290047;831.8211584509329;14975.625609359771;16308.184590770443;16320.918395408007;16330.591735206626;16372.09953452561;14671.119732816038;14832.480863169765;14850.108993460373;14851.702965940674;14910.776338354906;646.3923911523177;705.2489099109457;807.6688557691348;836.5357226739188;849.0745087854237;848.3594885861166;866.6446756829702;866.8656358264448;867.9739607811745;868.9956550217272;929.4098247612781;933.8785957825507;935.7005758157393;936.035883040466;937.142514599141;728.617475825196;896.0680891872445;927.5733162745112;928.0811996123789;928.2527565309923;699.4579201119122;699.7480906873521;702.388921638173;702.8524009957915;703.4899697719164;14470.493532726305;14488.058276212012;14490.782638260434;14498.565043048726;14517.056391334529;13514.189148651112;13745.725085498334;13883.514077007256;13930.930345348208;13999.230042347666;11424.257423267543;11797.46911388981;11870.169088163831;12442.626721198378;13069.542566010145;4567.063751930847;4620.953790462119;4624.838130665445;4632.166210082184;4750.572448479654;68931;105859.47070264677;106032;107392.4630376851;109485.45257273663;10769.299995500267;10778.622748203776;10861.239713220157;10861.782764344669;11241.381724005258;20860.687089693667;20863.582728345347;20867.686984695243;20874.791252087587;20895.68656470154;7035.401990830735;7465.618860510823;7945.721899733481;7998.840023199504;8070.394720395994;4491.124230775033;4515.1195516873895;4582.152301824173;4603.263477843529;4693.882652933636;3489.4416893297457;3620.402633565432;3646.033801042726;3646.3072016316814;3651.580068292127;543.7036814935869;657.9605223686594;665.4809248785955;665.7403612591094;666.8599594085199;538.6471860931097;619.4270299972508;630.0939657535899;682.9248782633906;693.7571849852612;7832.882506762403;9033.63865445388;9590.328676992543;9741.366811157252;9836.754081148028;594.2453084582556;641.3522342434081;661.794843598486;695.9025736396909;696.905917701114;4387.692861499664;4749.192637251606;4778.761061946889;4806.759662016885;4815.852761711641;104777.47611261896;161702;168227;169500.15249923672;169668.1516592434;140783;145750;148297;149124;151187;77444.61277693576;78421.60789196017;119070;122558.77441225831;123775.04899803907;8686.305095592212;9116.843218225897;9278.72163835086;9327.393719408217;9473.147416732527;67815;68620.6568967152;70263.64868175627;70654.6467267681;70891.64554177196;100709.49645251727;102556;102640.48679756554;102755;104233.95766042243;10501.47492625381;11087.835777243274;11828.40857957116;11954.282743035446;12437.880590746876;13352.986733954736;13589;13715.657108572366;13809.861901380858;14214.786778198542;12085.818712719492;12473;12484.313362764771;12503.499860005499;12626.810597841224;11203.943980280046;12466.940310073745;12721;12819.487220511448;13291.468341266627;11504.94247528757;11713.824292635447;12695.42870570808;13257.867421325664;13607.591772246848;10048.397096174253;11103.944480277547;11122.721931951442;11350.602728904449;11844.940775296069;11486.770264594828;11569.537218511165;11574.131940104695;11619.47712352963;11744.88255117472 17:53:49 INFO - PROCESS | 6631 | __end_tp_report 17:53:49 INFO - PROCESS | 6631 | __start_cc_report 17:53:49 INFO - PROCESS | 6631 | _x_x_mozilla_cycle_collect,1215 17:53:49 INFO - PROCESS | 6631 | __end_cc_report 17:53:49 INFO - PROCESS | 6631 | __startTimestamp1470704029955__endTimestamp 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | ------- Summary: start ------- 17:53:49 INFO - PROCESS | 6631 | Number of tests: 6 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | [#0] dojo.html Cycles:165 Average:5773.46 Median:5962.20 stddev:665.66 (11.2%) stddev-sans-first:639.62 17:53:49 INFO - PROCESS | 6631 | Values: 3335.2 3336.0 3336.2 3356.4 3404.9 5616.6 5732.4 5732.7 5747.7 5750.9 5686.9 5739.9 5788.9 5827.5 5830.5 4367.9 4908.6 5156.3 5228.2 5332.3 5338.9 5345.0 5400.2 5413.4 5420.8 5168.5 5214.4 5278.4 5282.6 5301.3 5247.8 5261.0 5273.9 5275.8 5282.2 5186.9 5222.4 5223.3 5227.9 5245.5 5656.3 5705.4 5717.6 5720.6 5728.3 6176.3 6249.6 6258.0 6264.4 6298.2 6266.3 6335.8 6345.1 6345.6 6358.3 5751.7 5840.7 5895.4 5957.1 5967.4 6315.3 6341.9 6374.7 6375.0 6380.6 5413.8 6140.9 6255.7 6261.4 6263.5 6175.3 6249.8 6313.4 6327.3 6333.8 6281.9 6294.0 6295.5 6298.9 6313.7 5309.3 6251.5 6319.7 6327.5 6335.7 4927.8 4933.8 4993.5 5012.3 5057.4 3782.3 4474.4 4485.2 4509.3 4562.3 5732.4 5735.6 5744.3 5751.6 5795.1 6210.5 6248.3 6305.0 6332.7 6357.1 5724.9 5725.9 5727.8 5730.5 5781.5 5496.1 5505.4 5505.8 5506.4 5510.6 5904.3 5946.3 6304.1 6309.6 6400.1 6251.8 6335.0 6338.0 6338.4 6341.0 6400.9 6404.4 6408.3 6424.5 6456.4 6103.8 6174.8 6178.8 6250.8 6278.2 6137.3 6244.2 6313.7 6325.1 6338.4 6117.9 6172.2 6181.4 6191.3 6286.9 6038.6 6101.5 6186.1 6188.5 6205.8 5962.2 6022.9 6053.6 6061.2 6063.7 6122.7 6157.7 6159.9 6161.1 6167.4 5064.3 5855.6 5898.5 5937.3 5973.2 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | [#1] ext.html Cycles:180 Average:76879.76 Median:38545.90 stddev:175099.26 (454.3%) stddev-sans-first:175496.57 17:53:49 INFO - PROCESS | 6631 | Values: 506.4 515.8 517.4 517.6 569.9 25949.4 41046.0 42171.0 42292.8 44418.3 42981.0 43854.8 43865.1 43912.0 44767.9 8773.7 9669.2 9861.7 9874.8 9875.0 8800.5 11870.4 11999.3 12063.7 12348.1 12080.4 12133.0 12136.3 12180.9 12203.4 11932.3 12021.3 12033.8 12060.7 12064.9 10262.0 11744.2 11874.7 11965.8 11974.1 40420.6 40752.2 40816.6 40817.2 40851.2 3410.4 3463.4 3971.2 4178.6 4339.8 31604.9 32955.8 33487.3 33527.2 33582.8 3208.4 3324.2 3350.3 3379.8 3387.8 503231.0 504745.0 506983.0 507040.0 509890.0 59620.7 60159.4 60314.0 60427.7 60459.5 63407.0 63632.7 63744.7 63769.0 63816.0 16221.3 16435.8 16450.6 16456.8 16459.6 11620.2 11777.5 11781.5 12779.6 12827.0 12376.9 13626.5 13629.3 15927.7 16224.6 4979.7 5526.4 6258.4 6268.9 6309.3 823.3 921.4 968.7 1031.6 1041.6 30390.8 30548.4 30594.1 30758.2 31095.7 930.2 1070.9 1085.9 1143.0 1176.1 10608.7 15679.2 15813.2 16013.4 16109.6 666985.0 670195.0 688914.0 725482.0 871320.0 50076.7 50583.7 50614.0 59945.7 60354.0 1395.5 1406.8 1417.8 1426.2 1426.8 30612.1 31492.2 31687.5 31867.7 32138.2 51078.2 51616.5 51633.2 51718.0 51874.5 647836.0 655794.0 660728.0 661505.0 852431.0 39647.2 39813.0 40067.0 40224.4 40225.0 39141.8 46921.8 47077.5 48109.5 48523.0 38249.0 38408.4 38871.2 39381.4 39394.6 37001.2 38093.6 38846.8 39502.6 39662.0 37553.8 37675.8 38427.4 38539.8 38552.0 32244.5 32738.0 34118.7 34371.5 34586.0 25179.9 25276.4 25314.1 25542.6 26020.0 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | [#2] jquery.html Cycles:180 Average:35195.47 Median:23028.31 stddev:97503.77 (423.4%) stddev-sans-first:97742.19 17:53:49 INFO - PROCESS | 6631 | Values: 352.6 367.9 375.2 383.9 400.7 15183.9 15419.8 20198.5 22110.0 22378.9 21074.6 21162.4 21418.1 21470.0 21667.2 5315.4 5333.3 6152.2 6157.3 6182.4 5345.5 6021.1 6672.0 6739.2 6844.0 6557.0 6618.6 6780.8 6786.2 6791.5 6600.0 6674.5 6689.0 6694.1 6709.8 4883.6 5587.3 5804.7 5806.4 5823.1 26497.9 26616.6 26698.8 26827.5 27130.6 2172.5 2201.6 2212.7 2270.0 2342.5 15782.2 15841.3 15892.0 16045.2 16521.1 1875.6 1885.2 1896.8 1916.0 1960.9 122297.0 126766.4 127451.0 127829.7 129335.0 8522.6 10590.9 11129.8 11237.0 11384.7 12164.2 12796.2 12803.8 13470.5 13509.9 7813.7 8587.6 8707.9 8710.2 8837.6 6649.3 8227.6 8236.5 8260.3 8856.7 6681.6 6749.0 6774.2 6776.9 6782.2 1689.1 1771.7 1828.8 1863.4 1868.6 725.3 852.6 956.8 1013.3 1017.4 21998.5 22957.3 23022.2 23034.4 23075.8 862.5 981.8 990.2 1000.1 1063.7 11010.0 11659.5 12080.7 12296.7 12321.6 521634.4 584157.2 592640.0 604463.0 605490.0 118790.4 122465.0 125372.4 127730.0 130136.0 955.5 983.4 1029.2 1056.6 1074.0 15978.8 16408.3 18253.6 18400.0 19126.4 56594.2 56623.4 56653.9 56887.7 56951.1 76039.0 80157.0 80487.2 81822.2 83695.0 5886.6 8246.5 8349.0 8394.5 8414.4 11219.6 11653.7 13100.9 13565.9 13593.7 10575.0 11015.5 11199.8 11335.8 11750.3 11203.4 11257.5 11401.5 11750.8 11909.8 9703.7 11605.8 11704.7 11958.6 11966.5 8123.7 8343.9 8348.3 8422.9 8625.4 8454.5 11269.2 11299.4 11647.8 11828.9 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | [#3] mootools.html Cycles:180 Average:5457.30 Median:5144.09 stddev:3013.41 (58.6%) stddev-sans-first:3006.21 17:53:49 INFO - PROCESS | 6631 | Values: 1370.8 1506.5 1666.7 1791.7 1865.8 8040.7 8617.2 8621.7 8623.5 8636.0 7350.2 7562.6 7613.7 7796.9 8422.9 2142.3 2172.0 2172.2 2173.6 2175.4 2183.1 2216.9 2246.3 2250.3 2251.7 2202.6 2231.9 2234.0 2234.4 2236.5 2198.0 2207.5 2219.7 2223.3 2227.0 2222.7 2227.6 2229.5 2230.5 2231.7 7705.1 8427.1 8560.7 8562.0 8570.5 5018.3 5171.3 5175.6 5182.8 5183.3 3304.2 3389.8 3519.2 3525.5 3529.4 1066.5 1068.5 1069.6 1083.3 1094.4 9490.6 10908.7 11026.7 11069.2 11105.8 4368.6 4449.2 4604.2 4619.3 4624.6 9438.9 9446.7 9449.7 9456.2 9461.8 5134.6 5140.6 5142.1 5146.1 5152.8 3981.8 4221.6 4244.9 4703.4 4722.1 3599.7 3907.8 3913.0 3914.0 3930.6 1133.6 1227.1 1234.3 1272.1 1282.4 786.2 793.4 905.7 907.1 920.9 5399.4 5734.3 5764.4 5820.9 6051.3 876.9 920.5 944.6 958.3 1081.9 3715.0 3806.7 3918.2 3924.9 3949.4 9908.6 10307.2 10333.4 10335.4 10339.3 8630.9 9923.2 10223.0 10269.3 10287.4 7740.8 7963.4 7964.6 7965.0 7966.0 5660.3 5668.1 5808.3 5856.8 5876.4 9525.9 9559.5 9568.1 9578.1 9582.0 8681.5 9096.5 9659.5 9667.0 9827.8 6798.5 7001.9 7257.6 7344.2 7449.4 7942.4 7993.6 8002.0 8027.2 8070.9 7290.6 7299.4 7314.9 7373.4 7374.4 7116.6 7185.2 7196.5 7251.0 7303.2 6675.5 6784.8 6787.5 6788.6 6800.7 4146.8 4713.5 4911.3 4913.4 4960.8 4155.9 4809.2 4851.0 4921.1 4988.3 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | [#4] prototype.html Cycles:180 Average:4515.79 Median:5151.88 stddev:1404.00 (27.3%) stddev-sans-first:1371.82 17:53:49 INFO - PROCESS | 6631 | Values: 299.8 307.9 310.8 316.3 319.4 4921.9 5337.9 5381.3 5405.0 5410.8 4844.0 5255.2 5305.2 5341.9 5367.0 3329.6 3412.1 3783.8 3927.5 4017.3 3853.7 4034.3 4085.9 4106.4 4134.5 3352.0 3982.2 3989.8 3992.4 4073.5 3912.1 3989.0 3994.0 4012.6 4032.7 3497.0 3504.4 3511.9 3526.9 3544.9 5080.4 5099.6 5114.1 5135.7 5153.3 3655.7 3699.6 3994.7 4615.1 4637.0 5172.6 5547.0 5564.7 5586.6 5603.6 3877.2 3883.9 3889.8 3892.1 3923.6 4876.0 5506.0 5842.1 5877.6 5881.3 3862.6 3907.3 3955.4 3958.4 3960.8 3522.7 3553.9 4035.4 4038.7 4048.0 4294.5 4330.0 4614.1 4650.2 4654.3 5081.8 5398.7 5626.2 5630.9 5675.9 1209.5 1231.5 1234.8 1370.9 1375.9 692.9 728.7 740.9 833.6 835.3 4624.3 4927.4 4955.9 5063.5 5088.4 5184.7 5518.3 5553.6 5638.3 5768.3 5021.7 5150.5 5160.5 5215.1 5245.7 2470.2 2517.2 2936.8 2951.3 3048.4 4971.8 5295.2 5494.3 5883.3 5945.5 4776.8 5622.8 5832.4 5863.3 5864.9 5278.7 5919.3 5933.2 5944.6 5945.6 5041.9 5451.2 5722.3 5759.8 5783.7 5623.2 5623.6 5669.5 5679.4 5698.3 5455.6 5877.6 5904.1 5926.3 5954.2 3291.1 3776.4 3868.8 3946.9 3947.0 5712.9 5727.9 5742.6 5748.9 5807.0 5236.1 5291.3 5555.4 5561.9 5619.8 5316.7 5385.1 5503.2 5548.2 5660.6 5031.3 5159.4 5426.5 5444.1 5480.6 5265.9 5394.5 5463.4 5527.8 5564.2 4242.4 4617.9 5417.6 5433.3 5454.2 17:53:49 INFO - PROCESS | 6631 | 17:53:49 INFO - PROCESS | 6631 | [#5] yui.html Cycles:180 Average:25468.46 Median:20885.24 stddev:41837.93 (200.3%) stddev-sans-first:41913.97 17:53:49 INFO - PROCESS | 6631 | Values: 704.4 712.9 775.6 803.2 831.8 14975.6 16308.2 16320.9 16330.6 16372.1 14671.1 14832.5 14850.1 14851.7 14910.8 646.4 705.2 807.7 836.5 849.1 848.4 866.6 866.9 868.0 869.0 929.4 933.9 935.7 936.0 937.1 728.6 896.1 927.6 928.1 928.3 699.5 699.7 702.4 702.9 703.5 14470.5 14488.1 14490.8 14498.6 14517.1 13514.2 13745.7 13883.5 13930.9 13999.2 11424.3 11797.5 11870.2 12442.6 13069.5 4567.1 4621.0 4624.8 4632.2 4750.6 68931.0 105859.5 106032.0 107392.5 109485.5 10769.3 10778.6 10861.2 10861.8 11241.4 20860.7 20863.6 20867.7 20874.8 20895.7 7035.4 7465.6 7945.7 7998.8 8070.4 4491.1 4515.1 4582.2 4603.3 4693.9 3489.4 3620.4 3646.0 3646.3 3651.6 543.7 658.0 665.5 665.7 666.9 538.6 619.4 630.1 682.9 693.8 7832.9 9033.6 9590.3 9741.4 9836.8 594.2 641.4 661.8 695.9 696.9 4387.7 4749.2 4778.8 4806.8 4815.9 104777.5 161702.0 168227.0 169500.2 169668.2 140783.0 145750.0 148297.0 149124.0 151187.0 77444.6 78421.6 119070.0 122558.8 123775.0 8686.3 9116.8 9278.7 9327.4 9473.1 67815.0 68620.7 70263.6 70654.6 70891.6 100709.5 102556.0 102640.5 102755.0 104234.0 10501.5 11087.8 11828.4 11954.3 12437.9 13353.0 13589.0 13715.7 13809.9 14214.8 12085.8 12473.0 12484.3 12503.5 12626.8 11203.9 12466.9 12721.0 12819.5 13291.5 11504.9 11713.8 12695.4 13257.9 13607.6 10048.4 11103.9 11122.7 11350.6 11844.9 11486.8 11569.5 11574.1 11619.5 11744.9 17:53:49 INFO - PROCESS | 6631 | -------- Summary: end -------- 17:53:49 INFO - PROCESS | 6631 | 17:53:50 INFO - TEST-INFO | 6631: exit 0 17:53:50 INFO - TEST-OK | dromaeo_css | took 1118400ms 17:53:50 INFO - TEST-START | kraken 17:53:50 INFO - operating with platform_type : mac_ 17:53:50 INFO - Initialising browser for kraken test... 17:53:50 INFO - TEST-INFO | started process 6633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpas4XV_/profile http://localhost:59008/getInfo.html) 17:53:53 INFO - PROCESS | 6633 | __metrics Screen width/height:1600/1200 17:53:53 INFO - PROCESS | 6633 | colorDepth:24 17:53:53 INFO - PROCESS | 6633 | Browser inner width/height: 1024/689 17:53:53 INFO - PROCESS | 6633 | __metrics 17:53:53 INFO - PROCESS | 6633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:53:53 INFO - PROCESS | 6633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:53:53 INFO - TEST-INFO | 6633: exit 0 17:53:53 INFO - Browser initialized. 17:53:53 INFO - Running cycle 1/1 for kraken test... 17:53:53 INFO - TEST-INFO | started process 6634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpas4XV_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:05 INFO - PROCESS | 6634 | RSS: Main: 243441664 17:54:05 INFO - PROCESS | 6634 | 17:54:08 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59008/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:09 INFO - PROCESS | 6634 | RSS: Main: 294739968 17:54:09 INFO - PROCESS | 6634 | 17:54:12 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59008/tests/kraken/driver.html?testName=audio-dft) 17:54:12 INFO - PROCESS | 6634 | RSS: Main: 301072384 17:54:12 INFO - PROCESS | 6634 | 17:54:16 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59008/tests/kraken/driver.html?testName=audio-fft) 17:54:16 INFO - PROCESS | 6634 | RSS: Main: 394989568 17:54:16 INFO - PROCESS | 6634 | 17:54:18 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59008/tests/kraken/driver.html?testName=audio-oscillator) 17:54:19 INFO - PROCESS | 6634 | RSS: Main: 298520576 17:54:19 INFO - PROCESS | 6634 | 17:54:21 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:22 INFO - PROCESS | 6634 | RSS: Main: 302907392 17:54:22 INFO - PROCESS | 6634 | 17:54:24 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59008/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:25 INFO - PROCESS | 6634 | RSS: Main: 339025920 17:54:25 INFO - PROCESS | 6634 | 17:54:28 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59008/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:29 INFO - PROCESS | 6634 | RSS: Main: 341164032 17:54:29 INFO - PROCESS | 6634 | 17:54:31 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59008/tests/kraken/driver.html?testName=json-parse-financial) 17:54:32 INFO - PROCESS | 6634 | RSS: Main: 340733952 17:54:32 INFO - PROCESS | 6634 | 17:54:33 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:34 INFO - PROCESS | 6634 | RSS: Main: 314486784 17:54:34 INFO - PROCESS | 6634 | 17:54:36 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:37 INFO - PROCESS | 6634 | RSS: Main: 320872448 17:54:37 INFO - PROCESS | 6634 | 17:54:39 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:40 INFO - PROCESS | 6634 | RSS: Main: 322572288 17:54:40 INFO - PROCESS | 6634 | 17:54:43 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:43 INFO - PROCESS | 6634 | RSS: Main: 330731520 17:54:43 INFO - PROCESS | 6634 | 17:54:46 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:54:47 INFO - PROCESS | 6634 | RSS: Main: 332017664 17:54:47 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | Cycle 1(1): loaded http://localhost:59008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59008/tests/kraken/driver.html?testName=ai-astar) 17:54:49 INFO - PROCESS | 6634 | RSS: Main: 375590912 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | __start_tp_report 17:54:49 INFO - PROCESS | 6634 | _x_x_mozilla_page_load 17:54:49 INFO - PROCESS | 6634 | _x_x_mozilla_page_load_details 17:54:49 INFO - PROCESS | 6634 | |i|pagename|runs| 17:54:49 INFO - PROCESS | 6634 | |0;ai-astar;101;112;112;112;112;113;112;111;113;112 17:54:49 INFO - PROCESS | 6634 | |1;audio-beat-detection;145;109;106;169;107;102;128;107;127;124 17:54:49 INFO - PROCESS | 6634 | |2;audio-dft;184;184;183;185;185;179;181;185;184;181 17:54:49 INFO - PROCESS | 6634 | |3;audio-fft;79;58;60;88;57;57;65;65;84;57 17:54:49 INFO - PROCESS | 6634 | |4;audio-oscillator;88;87;92;69;70;67;124;98;96;102 17:54:49 INFO - PROCESS | 6634 | |5;imaging-gaussian-blur;86;84;87;84;87;83;88;84;87;84 17:54:49 INFO - PROCESS | 6634 | |6;imaging-darkroom;93;92;92;97;93;92;93;93;95;92 17:54:49 INFO - PROCESS | 6634 | |7;imaging-desaturate;86;85;85;85;83;86;85;86;88;84 17:54:49 INFO - PROCESS | 6634 | |8;json-parse-financial;55;52;53;52;51;53;54;51;52;54 17:54:49 INFO - PROCESS | 6634 | |9;json-stringify-tinderbox;66;64;80;113;110;83;71;73;72;74 17:54:49 INFO - PROCESS | 6634 | |10;stanford-crypto-aes;82;82;84;82;84;83;85;85;87;86 17:54:49 INFO - PROCESS | 6634 | |11;stanford-crypto-ccm;155;154;145;149;152;132;135;136;155;163 17:54:49 INFO - PROCESS | 6634 | |12;stanford-crypto-pbkdf2;165;222;201;164;165;163;164;165;165;162 17:54:49 INFO - PROCESS | 6634 | |13;stanford-crypto-sha256-iterative;65;67;68;67;65;67;67;65;65;66 17:54:49 INFO - PROCESS | 6634 | __end_tp_report 17:54:49 INFO - PROCESS | 6634 | __start_cc_report 17:54:49 INFO - PROCESS | 6634 | _x_x_mozilla_cycle_collect,2041 17:54:49 INFO - PROCESS | 6634 | __end_cc_report 17:54:49 INFO - PROCESS | 6634 | __startTimestamp1470704089279__endTimestamp 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | ------- Summary: start ------- 17:54:49 INFO - PROCESS | 6634 | Number of tests: 14 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.56 (3.2%) stddev-sans-first:0.60 17:54:49 INFO - PROCESS | 6634 | Values: 101.0 112.0 112.0 112.0 112.0 113.0 112.0 111.0 113.0 112.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:125.50 stddev:21.28 (17.0%) stddev-sans-first:20.94 17:54:49 INFO - PROCESS | 6634 | Values: 145.0 109.0 106.0 169.0 107.0 102.0 128.0 107.0 127.0 124.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:2.08 (1.1%) stddev-sans-first:2.18 17:54:49 INFO - PROCESS | 6634 | Values: 184.0 184.0 183.0 185.0 185.0 179.0 181.0 185.0 184.0 181.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#3] audio-fft Cycles:10 Average:67.00 Median:65.00 stddev:12.07 (18.6%) stddev-sans-first:12.00 17:54:49 INFO - PROCESS | 6634 | Values: 79.0 58.0 60.0 88.0 57.0 57.0 65.0 65.0 84.0 57.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:87.50 stddev:17.58 (20.1%) stddev-sans-first:18.64 17:54:49 INFO - PROCESS | 6634 | Values: 88.0 87.0 92.0 69.0 70.0 67.0 124.0 98.0 96.0 102.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.78 (2.1%) stddev-sans-first:1.87 17:54:49 INFO - PROCESS | 6634 | Values: 86.0 84.0 87.0 84.0 87.0 83.0 88.0 84.0 87.0 84.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:1.62 (1.7%) stddev-sans-first:1.72 17:54:49 INFO - PROCESS | 6634 | Values: 93.0 92.0 92.0 97.0 93.0 92.0 93.0 93.0 95.0 92.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:1.34 (1.6%) stddev-sans-first:1.39 17:54:49 INFO - PROCESS | 6634 | Values: 86.0 85.0 85.0 85.0 83.0 86.0 85.0 86.0 88.0 84.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.34 (2.5%) stddev-sans-first:1.13 17:54:49 INFO - PROCESS | 6634 | Values: 55.0 52.0 53.0 52.0 51.0 53.0 54.0 51.0 52.0 54.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#9] json-stringify-tinderbox Cycles:10 Average:80.60 Median:72.50 stddev:17.24 (23.8%) stddev-sans-first:17.46 17:54:49 INFO - PROCESS | 6634 | Values: 66.0 64.0 80.0 113.0 110.0 83.0 71.0 73.0 72.0 74.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.50 stddev:1.76 (2.1%) stddev-sans-first:1.72 17:54:49 INFO - PROCESS | 6634 | Values: 82.0 82.0 84.0 82.0 84.0 83.0 85.0 85.0 87.0 86.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:153.00 stddev:10.29 (6.7%) stddev-sans-first:10.56 17:54:49 INFO - PROCESS | 6634 | Values: 155.0 154.0 145.0 149.0 152.0 132.0 135.0 136.0 155.0 163.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:165.00 stddev:20.60 (12.5%) stddev-sans-first:21.62 17:54:49 INFO - PROCESS | 6634 | Values: 165.0 222.0 201.0 164.0 165.0 163.0 164.0 165.0 165.0 162.0 17:54:49 INFO - PROCESS | 6634 | 17:54:49 INFO - PROCESS | 6634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 17:54:49 INFO - PROCESS | 6634 | Values: 65.0 67.0 68.0 67.0 65.0 67.0 67.0 65.0 65.0 66.0 17:54:49 INFO - PROCESS | 6634 | -------- Summary: end -------- 17:54:49 INFO - PROCESS | 6634 | 17:54:50 INFO - TEST-INFO | 6634: exit 0 17:54:50 INFO - TEST-OK | kraken | took 59485ms 17:54:50 INFO - SUITE-END | took 1177s 17:54:50 INFO - Completed test suite (00:19:38) 17:54:50 INFO - javascript benchmark 17:54:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.199552107493, 3336.049225970598, 3336.182635254363, 3356.3958487472246, 3404.9148771280716, 5616.550675945925, 5732.398098199692, 5732.742026608802, 5747.712614369286, 5750.856228594287, 5686.886262274762, 5739.913901291484, 5788.884222315552, 5827.475527202551, 5830.475257226859, 4367.912641747163, 4908.607311415079, 5156.303898973628, 5228.189630607262, 5332.280142180814, 5338.946610533903, 5344.973275133619, 5400.216968539579, 5413.404525502192, 5420.783168673248, 5168.508991645787, 5214.374275086976, 5278.445763194848, 5282.603804714662, 5301.284326615915, 5247.763850626693, 5260.973695131538, 5273.920891186635, 5275.841724748264, 5282.181261904411, 5186.870328241786, 5222.399424066205, 5223.294855194538, 5227.947720522822, 5245.527902488794, 5656.2929633795775, 5705.372409035002, 5717.599768016241, 5720.628159169641, 5728.341240757283, 6176.320604733476, 6249.5625306228585, 6258.030005349178, 6264.373562643745, 6298.1812364392335, 6266.342034086447, 6335.8416039598915, 6345.143405640226, 6345.619262844244, 6358.332375100594, 5751.712414379264, 5840.707964601753, 5895.410458954113, 5957.106434034929, 5967.373425790316, 6315.305316415191, 6341.8731625368155, 6374.681265936684, 6375.0, 6380.617162970237, 5413.810516631977, 6140.894638965029, 6255.749770009149, 6261.373862613702, 6263.467605253604, 6175.2898416681755, 6249.750009999549, 6313.431791138728, 6327.335629758901, 6333.841653958596, 6281.8743625127245, 6294.0, 6295.464885484694, 6298.874022519524, 6313.652749098844, 5309.256704061358, 6251.531135164881, 6319.715612797435, 6327.4938004959495, 6335.683215839282, 4927.802887884516, 4933.753312334441, 4993.525615066563, 5012.323336349619, 5057.443681195065, 3782.3002744491805, 4474.351219073216, 4485.215087359699, 4509.255972764523, 4562.270036794097, 5732.426757324234, 5735.569832262597, 5744.310682718101, 5751.568632352591, 5795.072788353843, 6210.534209934273, 6248.281447633581, 6305.022721478178, 6332.68336583169, 6357.141785858942, 5724.914126288109, 5725.885482290331, 5727.77088916447, 5730.484256416942, 5781.508571771363, 5496.120620700749, 5505.366882808448, 5505.807296744595, 5506.394296627368, 5510.559155267569, 5904.3210030845285, 5946.316173639913, 6304.148939893055, 6309.621422714652, 6400.103985442041, 6251.843703907439, 6335.049742538656, 6338.049292606146, 6338.429541341301, 6340.968295158495, 6400.871982560229, 6404.359564043559, 6408.327125651739, 6424.51816113784, 6456.354364563694, 6103.792276408585, 6174.783882564268, 6178.814635560941, 6250.843728906813, 6278.246610406781, 6137.294211165595, 6244.1570387997035, 6313.715882785194, 6325.146105275913, 6338.366163383625, 6117.908231376622, 6172.22847144107, 6181.443670069715, 6191.349908259748, 6286.874262514815, 6038.63768173911, 6101.450869421773, 6186.133941248138, 6188.504919606511, 6205.81382558524, 5962.19510366095, 6022.939770602238, 6053.606515576474, 6061.15143879866, 6063.6664983426335, 6122.692552514308, 6157.692115394302, 6159.938400615936, 6161.075838624242, 6167.352427994996, 5064.34163558735, 5855.560832937632, 5898.528117750484, 5937.2578427696535, 5973.223480947623], "value": 5729.928856722661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.3695698854925, 515.8039944820968, 517.3507248403254, 517.6454128921689, 569.8632328241221, 25949.351266218353, 41045.97385065375, 42171.0, 42292.78853605736, 44418.333724994154, 42981.0, 43854.780726096404, 43865.12269754611, 43912.0, 44767.88080297994, 8773.736787896374, 9669.178119859802, 9861.654842080528, 9874.753131171743, 9874.950625246864, 8800.471971681687, 11870.406479676025, 11999.340036298001, 12063.698407539794, 12348.135630505823, 12080.395980200954, 12133.02935765141, 12136.332501712446, 12180.939095304511, 12203.389830508484, 11932.284062956207, 12021.278723276631, 12033.819492707617, 12060.698482537919, 12064.914157725803, 10262.0, 11744.177907546475, 11874.703132421759, 11965.820512692317, 11974.101942354358, 40420.595794042274, 40752.184956300705, 40816.59183408158, 40817.183656327004, 40851.18297634031, 3410.437277849152, 3463.3765922134007, 3971.1660551284267, 4178.603032711888, 4339.761313127777, 31604.893828715885, 32955.83522082398, 33487.33025339479, 33527.161820954425, 33582.83208583966, 3208.4224839528874, 3324.1523411530147, 3350.329934013207, 3379.797212167278, 3387.779794313362, 503231.0, 504745.0, 506983.0, 507040.0, 509889.9999999963, 59620.701896491104, 60159.39840601538, 60314.0, 60427.69786151041, 60459.48851278753, 63407.0, 63632.68183659052, 63744.68127659332, 63769.04346434807, 63816.0, 16221.2700428481, 16435.753463697816, 16450.588735281475, 16456.753148702777, 16459.58851028734, 11620.244684095676, 11777.528898844123, 11781.469833857496, 12779.552715654907, 12827.0, 12376.938115309365, 13626.523071692443, 13629.296337957756, 15927.681446371007, 16224.59438514023, 4979.676321039121, 5526.419725928719, 6258.405451482102, 6268.874622507525, 6309.305976342599, 823.3495538524618, 921.424109931293, 968.7045451137329, 1031.5564307347913, 1041.6198087697935, 30390.84804575963, 30548.38903221923, 30594.133322786118, 30758.231044223627, 31095.68904310928, 930.237205491504, 1070.8661417322835, 1085.907697845692, 1142.971425714347, 1176.0767797279095, 10608.681739547827, 15679.216039197994, 15813.209339532978, 16013.43952961664, 16109.597260068593, 666985.0, 670195.0, 688914.0, 725482.0, 871320.0, 50076.748081297534, 50583.74708126509, 50614.0, 59945.700271499234, 60354.0, 1395.5324966136254, 1406.8030475733406, 1417.766068598711, 1426.179946530749, 1426.828780546341, 30612.08163755091, 31492.2126946819, 31687.52468713017, 31867.681323186473, 32138.19654508656, 51078.23382649189, 51616.48383516267, 51633.225501616755, 51718.0, 51874.48125518696, 647836.0, 655794.0, 660728.0, 661505.0, 852431.0, 39647.2070558593, 39813.00467488336, 40066.9933006697, 40224.396634049925, 40225.0, 39141.80429097836, 46921.765391174195, 47077.529224707316, 48109.5189048105, 48523.0, 38249.0, 38408.423873642474, 38871.22257554776, 39381.409278860265, 39394.6060539391, 37001.19717645176, 38093.61906381012, 38846.80576597099, 39502.60497395104, 39662.0, 37553.81223093867, 37675.81162094172, 38427.42358864675, 38539.807300963315, 38552.0, 32244.516332255505, 32738.017859464253, 34118.65881341254, 34371.48442773311, 34586.0, 25179.87410062938, 25276.368090797878, 25314.114006009702, 25542.616860747476, 26020.0], "value": 20741.27527389258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.5593008739076, 367.896988843124, 375.1877185892543, 383.86372837642637, 400.66144108228536, 15183.924080379596, 15419.768703469457, 20198.49503762405, 22110.0, 22378.88810555949, 21074.578508429822, 21162.41151674222, 21418.14327426905, 21470.0, 21667.241646542374, 5315.415304316522, 5333.280007199017, 6152.200213972177, 6157.261128664544, 6182.350853160421, 5345.518903298703, 6021.09683547467, 6671.9658452939875, 6739.22498912624, 6844.007618895257, 6557.0, 6618.635975021371, 6780.796576102724, 6786.151731033621, 6791.524593278473, 6600.0, 6674.466042716595, 6688.9665551672415, 6694.062831203635, 6709.832254193684, 4883.560479556857, 5587.329520457572, 5804.709764511757, 5806.390329015477, 5823.097419899922, 26497.867510662516, 26616.60075098875, 26698.798554065113, 26827.463450731073, 27130.5930411044, 2172.5335398606035, 2201.5927053495157, 2212.7012853264923, 2270.035235025124, 2342.4846533762716, 15782.210889455597, 15841.257461679206, 15892.0, 16045.197740113064, 16521.091339976298, 1875.5573169523377, 1885.1516817432073, 1896.8482521398394, 1915.9904200479048, 1960.9411717648493, 122297.0, 126766.36616816856, 127451.0, 127829.72170278271, 129335.0, 8522.616482258314, 10590.940905909501, 11129.833052504218, 11237.0, 11384.715382115513, 12164.209326393933, 12796.232226066466, 12803.807942880865, 13470.52853150135, 13509.932450337685, 7813.726519571901, 8587.570621469027, 8707.869381959275, 8710.172533609297, 8837.60230789616, 6649.335066493409, 8227.629756660845, 8236.546989915492, 8260.29787468072, 8856.690015849414, 6681.592387882215, 6748.966255168692, 6774.153230846145, 6776.864462710718, 6782.151496371535, 1689.0997627668874, 1771.7342398640308, 1828.7714035745532, 1863.369551642313, 1868.6449574580786, 725.3109545931386, 852.5566705313203, 956.784723437221, 1013.2755080117752, 1017.399734156851, 21998.45003874916, 22957.311280661608, 23022.19422320244, 23034.424139396648, 23075.76924230736, 862.4695812075529, 981.7545613596601, 990.1732053735212, 1000.1498726082772, 1063.6702622187147, 11010.0, 11659.475323610457, 12080.697982550506, 12296.692582685504, 12321.568745093879, 521634.39182803844, 584157.2477642073, 592640.0, 604463.0, 605490.0, 118790.40604797093, 122465.0, 125372.37313813555, 127730.0, 130136.0, 955.5365647660878, 983.4394395194813, 1029.156092004549, 1056.5773690523852, 1074.0, 15978.840211597735, 16408.343666253215, 18253.63097767646, 18400.0, 19126.426207213804, 56594.15108773289, 56623.433765661815, 56653.86692266214, 56887.71556142193, 56951.14573281321, 76039.0, 80157.0, 80487.19512804797, 81822.18177818146, 83695.0, 5886.6173698709445, 8246.463979841292, 8349.0, 8394.538300393293, 8414.368922330972, 11219.55121795119, 11653.65982911942, 13100.868991309964, 13565.864341356855, 13593.660158496117, 10575.0, 11015.504302306255, 11199.832002519806, 11335.829962550733, 11750.29498230109, 11203.383813890314, 11257.549698011988, 11401.486933087865, 11750.764984700087, 11909.821352679543, 9703.708888733348, 11605.825912611486, 11704.70738231551, 11958.58144964922, 11966.521339146337, 8123.7156699515235, 8343.916560834314, 8348.332133429432, 8422.873656895028, 8625.39622226438, 8454.450460720034, 11269.211155219384, 11299.43502824839, 11647.76704465923, 11828.940855295668], "value": 9909.752016206874, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.7806750919856, 1506.5329747778187, 1666.7083260429429, 1791.6774980503503, 1865.8320751132396, 8040.678372865085, 8617.181367770068, 8621.74134775957, 8623.482591044542, 8636.0, 7350.228226036256, 7562.62186890656, 7613.657385417656, 7796.92203077969, 8422.915770842304, 2142.3358758784825, 2171.9674204886937, 2172.174573662014, 2173.5544213436206, 2175.401764514755, 2183.094015983373, 2216.9334919952425, 2246.3485589179118, 2250.3473992542145, 2251.6735073414343, 2202.603531364354, 2231.8884055797143, 2233.9553208935813, 2234.4190510467315, 2236.541508990653, 2198.043850924837, 2207.4591725027312, 2219.711437513129, 2223.288547664748, 2226.9888650556804, 2222.7110475638224, 2227.55448910217, 2229.5285111826115, 2230.531588366445, 2231.732192136954, 7705.075390953066, 8427.073021967579, 8560.657573697044, 8561.972563292382, 8570.528620925847, 5018.347614810088, 5171.250168725552, 5175.560077393426, 5182.766775495112, 5183.300254465675, 3304.206990322329, 3389.796612203276, 3519.1729943463265, 3525.506429099928, 3529.364714351416, 1066.5360568152878, 1068.5031460370888, 1069.588208539718, 1083.344576531203, 1094.3597995172834, 9490.572924218426, 10908.672739817897, 11026.724331891766, 11069.169812264032, 11105.777884442266, 4368.60682538573, 4449.243628583149, 4604.171249175113, 4619.330197121399, 4624.583787459145, 9438.905610943802, 9446.716598502057, 9449.669261575811, 9456.196223320958, 9461.810763784824, 5134.563562097189, 5140.640155189176, 5142.074426603247, 5146.099432599281, 5152.845414637567, 3981.8009099544906, 4221.583490947714, 4244.87265382039, 4703.435587729426, 4722.102800467969, 3599.7300202484917, 3907.765534067965, 3913.0, 3914.0, 3930.6265904739003, 1133.580575187186, 1227.0551675210038, 1234.3457967277357, 1272.0586765793246, 1282.3844554613838, 786.1862971824249, 793.4049462902823, 905.6739573753443, 907.1427501011481, 920.8572671235969, 5399.433059528693, 5734.311882574118, 5764.365919748824, 5820.912686309709, 6051.304100028465, 876.8732179149762, 920.5489310237936, 944.5513381143902, 958.2956526952685, 1081.9026287634151, 3714.981425092857, 3806.657400833938, 3918.2359439908946, 3924.9018774530296, 3949.3878448840474, 9908.603655853685, 10307.226957978182, 10333.431661258703, 10335.379877207391, 10339.276250662531, 8630.921134858143, 9923.156531694742, 10223.0, 10269.281150319406, 10287.434191119411, 7740.806479838049, 7963.4425590209285, 7964.561949092856, 7965.004374453193, 7965.960170199228, 5660.349059858169, 5668.149777533403, 5808.30300363959, 5856.824295271149, 5876.382979787061, 9525.904740952501, 9559.474228917476, 9568.13886750168, 9578.13796758295, 9582.0, 8681.479111253346, 9096.454212747256, 9659.46872921968, 9667.033296670557, 9827.754306142404, 6798.524103312919, 7001.859962800613, 7257.637118144177, 7344.22885597026, 7449.366803821736, 7942.44402891792, 7993.560354180576, 8001.999750031246, 8027.1972802719265, 8070.919290807252, 7290.635468226461, 7299.4160467163565, 7314.926850731425, 7373.410127189704, 7374.410047196318, 7116.644167791694, 7185.209626940928, 7196.496245262991, 7251.0, 7303.196648368781, 6675.499337549606, 6784.7964561063245, 6787.457003439812, 6788.558743681842, 6800.693968771318, 4146.834126635022, 4713.481517033192, 4911.287863259879, 4913.361263035782, 4960.826371076995, 4155.916881662411, 4809.2064809306075, 4850.975745121393, 4921.138800709933, 4988.326575912205], "value": 4409.977428437644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8201079352388, 307.93225490392115, 310.77779387737763, 316.3467439736943, 319.38358967193335, 4921.926171107427, 5337.904015670912, 5381.327334083239, 5404.972975135119, 5410.756515956781, 4844.038164543357, 5255.211718242265, 5305.1776974569, 5341.919871201935, 5366.973165134169, 3329.583802024747, 3412.129906873756, 3783.8486460541544, 3927.5483319418204, 4017.2568074906235, 3853.7109716771215, 4034.253663072326, 4085.9182816343655, 4106.3635136553885, 4134.52452967908, 3351.9832400837963, 3982.2234664240486, 3989.840406383741, 3992.421098940652, 4073.4704488416614, 3912.100216950089, 3989.0426297688637, 3994.0414300567945, 4012.61880121388, 4032.677385809143, 3497.0383144635175, 3504.3516949364193, 3511.9297614047578, 3526.947095793565, 3544.8936531904083, 5080.390353157608, 5099.617528685327, 5114.05390002847, 5135.717535535544, 5153.304303918998, 3655.689266412358, 3699.6300369963055, 3994.7003974702016, 4615.076984603059, 4637.0, 5172.612054095958, 5547.006155568025, 5564.721763911788, 5586.55307575393, 5603.551715862762, 3877.205172939569, 3883.85407819667, 3889.824957876874, 3892.1317767471774, 3923.607639236082, 4876.0, 5505.9724701376235, 5842.123681447817, 5877.647341159544, 5881.323822710507, 3862.613738626115, 3907.33575292201, 3955.3671412574427, 3958.426028225891, 3960.821763020671, 3522.7181825453904, 3553.9209562405763, 4035.3543433050572, 4038.7374820636564, 4048.0487085534874, 4294.506131794884, 4330.0, 4614.146382919171, 4650.232711602615, 4654.2785868190485, 5081.822136225214, 5398.731298144933, 5626.212330273765, 5630.915536266959, 5675.8864822704145, 1209.5343292832322, 1231.4581584102966, 1234.8024316109559, 1370.9451621935211, 1375.8555351687928, 692.9480288978347, 728.6611725547646, 740.9054564895448, 833.5998720614018, 835.3484282259847, 4624.329472226508, 4927.408710954636, 4955.90088198234, 5063.468335824686, 5088.414832294334, 5184.714840683799, 5518.33779946409, 5553.6390134641115, 5638.323401191883, 5768.3366412862215, 5021.72380519075, 5150.459201783834, 5160.458151893997, 5215.087359712111, 5245.659032162897, 2470.172492215128, 2517.2379334465945, 2936.7503762180027, 2951.276937150412, 3048.359844432694, 4971.751412429364, 5295.179247216687, 5494.340679118532, 5883.323417807007, 5945.524358051345, 4776.761161941889, 5622.8313150605545, 5832.416758324133, 5863.29640443141, 5864.882702345929, 5278.709670968134, 5919.348871624032, 5933.199018132583, 5944.573302407478, 5945.554083443759, 5041.924371134362, 5451.236826844324, 5722.341930677859, 5759.827205183851, 5783.652980821164, 5623.2408624835125, 5623.606347555632, 5669.546436285004, 5679.35909801944, 5698.287714035746, 5455.563554915518, 5877.590188023061, 5904.114382842608, 5926.348101708895, 5954.225950626565, 3291.1278511194073, 3776.3957766757185, 3868.7872167031082, 3946.881593552198, 3947.032976920673, 5712.88598723245, 5727.914081288867, 5742.626729262584, 5748.9425105748405, 5806.970965145148, 5236.10986132366, 5291.3121294231505, 5555.388907220284, 5561.860953476195, 5619.80330688424, 5316.746602717888, 5385.138377859524, 5503.229547863382, 5548.195511650869, 5660.622538533908, 5031.345925029723, 5159.432462429055, 5426.511613954605, 5444.067356088532, 5480.6437581557075, 5265.868353291198, 5394.460553944574, 5463.399026107205, 5527.793879549771, 5564.221009058816, 4242.4272723181975, 4617.9307310389695, 5417.566594672496, 5433.320834895638, 5454.236406902957], "value": 4056.783454992241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.383664293743, 712.8992061797838, 775.643204126102, 803.1526739290047, 831.8211584509329, 14975.625609359771, 16308.184590770443, 16320.918395408007, 16330.591735206626, 16372.09953452561, 14671.119732816038, 14832.480863169765, 14850.108993460373, 14851.702965940674, 14910.776338354906, 646.3923911523177, 705.2489099109457, 807.6688557691348, 836.5357226739188, 849.0745087854237, 848.3594885861166, 866.6446756829702, 866.8656358264448, 867.9739607811745, 868.9956550217272, 929.4098247612781, 933.8785957825507, 935.7005758157393, 936.035883040466, 937.142514599141, 728.617475825196, 896.0680891872445, 927.5733162745112, 928.0811996123789, 928.2527565309923, 699.4579201119122, 699.7480906873521, 702.388921638173, 702.8524009957915, 703.4899697719164, 14470.493532726305, 14488.058276212012, 14490.782638260434, 14498.565043048726, 14517.056391334529, 13514.189148651112, 13745.725085498334, 13883.514077007256, 13930.930345348208, 13999.230042347666, 11424.257423267543, 11797.46911388981, 11870.169088163831, 12442.626721198378, 13069.542566010145, 4567.063751930847, 4620.953790462119, 4624.838130665445, 4632.166210082184, 4750.572448479654, 68931.0, 105859.47070264677, 106032.0, 107392.4630376851, 109485.45257273663, 10769.299995500267, 10778.622748203776, 10861.239713220157, 10861.782764344669, 11241.381724005258, 20860.687089693667, 20863.582728345347, 20867.686984695243, 20874.791252087587, 20895.68656470154, 7035.401990830735, 7465.618860510823, 7945.721899733481, 7998.840023199504, 8070.394720395994, 4491.124230775033, 4515.1195516873895, 4582.152301824173, 4603.263477843529, 4693.882652933636, 3489.4416893297457, 3620.402633565432, 3646.033801042726, 3646.3072016316814, 3651.580068292127, 543.7036814935869, 657.9605223686594, 665.4809248785955, 665.7403612591094, 666.8599594085199, 538.6471860931097, 619.4270299972508, 630.0939657535899, 682.9248782633906, 693.7571849852612, 7832.882506762403, 9033.63865445388, 9590.328676992543, 9741.366811157252, 9836.754081148028, 594.2453084582556, 641.3522342434081, 661.794843598486, 695.9025736396909, 696.905917701114, 4387.692861499664, 4749.192637251606, 4778.761061946889, 4806.759662016885, 4815.852761711641, 104777.47611261896, 161702.0, 168227.0, 169500.15249923672, 169668.1516592434, 140783.0, 145750.0, 148297.0, 149124.0, 151187.0, 77444.61277693576, 78421.60789196017, 119070.0, 122558.77441225831, 123775.04899803907, 8686.305095592212, 9116.843218225897, 9278.72163835086, 9327.393719408217, 9473.147416732527, 67815.0, 68620.6568967152, 70263.64868175627, 70654.6467267681, 70891.64554177196, 100709.49645251727, 102556.0, 102640.48679756554, 102755.0, 104233.95766042243, 10501.47492625381, 11087.835777243274, 11828.40857957116, 11954.282743035446, 12437.880590746876, 13352.986733954736, 13589.0, 13715.657108572366, 13809.861901380858, 14214.786778198542, 12085.818712719492, 12473.0, 12484.313362764771, 12503.499860005499, 12626.810597841224, 11203.943980280046, 12466.940310073745, 12721.0, 12819.487220511448, 13291.468341266627, 11504.94247528757, 11713.824292635447, 12695.42870570808, 13257.867421325664, 13607.591772246848, 10048.397096174253, 11103.944480277547, 11122.721931951442, 11350.602728904449, 11844.940775296069, 11486.770264594828, 11569.537218511165, 11574.131940104695, 11619.47712352963, 11744.88255117472], "value": 7850.387642777396, "unit": "score"}], "name": "dromaeo_css", "value": 7409.139043498905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 112.0, 112.0, 113.0, 112.0, 111.0, 113.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 106.0, 169.0, 107.0, 102.0, 128.0, 107.0, 127.0, 124.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 185.0, 185.0, 179.0, 181.0, 185.0, 184.0, 181.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 88.0, 57.0, 57.0, 65.0, 65.0, 84.0, 57.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 92.0, 69.0, 70.0, 67.0, 124.0, 98.0, 96.0, 102.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 84.0, 87.0, 83.0, 88.0, 84.0, 87.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 97.0, 93.0, 92.0, 93.0, 93.0, 95.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 83.0, 86.0, 85.0, 86.0, 88.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 52.0, 51.0, 53.0, 54.0, 51.0, 52.0, 54.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 80.0, 113.0, 110.0, 83.0, 71.0, 73.0, 72.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 84.0, 82.0, 84.0, 83.0, 85.0, 85.0, 87.0, 86.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 145.0, 149.0, 152.0, 132.0, 135.0, 136.0, 155.0, 163.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 222.0, 201.0, 164.0, 165.0, 163.0, 164.0, 165.0, 165.0, 162.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 67.0, 65.0, 67.0, 67.0, 65.0, 65.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1441.3999999999999, "alertThreshold": 2.0}]} 17:54:50 INFO - Return code: 0 17:54:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:54:50 INFO - # TBPL SUCCESS # 17:54:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:54:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:54:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:54:50 INFO - 2016-08-08 17:54:50.621 screenresolution[6638:113395] starting screenresolution argv=screenresolution get 17:54:50 INFO - 2016-08-08 17:54:50.624 screenresolution[6638:113395] Display 0: 1600x1200x32@60 17:54:50 INFO - 2016-08-08 17:54:50.631 screenresolution[6639:113398] starting screenresolution argv=screenresolution list 17:54:50 INFO - Available Modes on Display 0 17:54:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:54:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:54:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:54:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:54:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:54:50 INFO - Intel Iris: 17:54:50 INFO - Chipset Model: Intel Iris 17:54:50 INFO - Type: GPU 17:54:50 INFO - Bus: Built-In 17:54:50 INFO - VRAM (Dynamic, Max): 1536 MB 17:54:50 INFO - Vendor: Intel (0x8086) 17:54:50 INFO - Device ID: 0x0a2e 17:54:50 INFO - Revision ID: 0x0009 17:54:50 INFO - Displays: 17:54:50 INFO - Display: 17:54:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:54:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:54:50 INFO - Display Serial Number: 1600x1200 60 17:54:50 INFO - Main Display: Yes 17:54:50 INFO - Mirror: Off 17:54:50 INFO - Online: Yes 17:54:50 INFO - Rotation: Supported 17:54:50 INFO - Return code: 0 17:54:50 INFO - Running post-action listener: _resource_record_post_action 17:54:50 INFO - [mozharness: 2016-08-09 00:54:50.864201Z] Finished run-tests step (success) 17:54:50 INFO - Running post-run listener: _resource_record_post_run 17:54:50 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 1131008; Write bytes: 704159232; Read time: 16; Write time: 2078 17:54:50 INFO - TinderboxPrint: CPU usage
53.4% 17:54:50 INFO - TinderboxPrint: I/O read bytes / time
1,131,008 / 16 17:54:50 INFO - TinderboxPrint: I/O write bytes / time
704,159,232 / 2,078 17:54:50 INFO - TinderboxPrint: CPU idle
2,260.4 (46.6%) 17:54:50 INFO - TinderboxPrint: CPU system
965.9 (19.9%) 17:54:50 INFO - TinderboxPrint: CPU user
1,627.4 (33.5%) 17:54:50 INFO - TinderboxPrint: Swap in / out
407,502,848 / 0 17:54:50 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389929472; Write bytes: 383723008; Read time: 28661; Write time: 710 17:54:50 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 1040384; Write bytes: 295114752; Read time: 13; Write time: 1317 17:54:51 INFO - Running post-run listener: _upload_blobber_files 17:54:51 INFO - Blob upload gear active. 17:54:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:54:51 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 17:54:51 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:54:51 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:54:51 INFO - (blobuploader) - INFO - Open directory for files ... 17:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:52 INFO - (blobuploader) - INFO - Done attempting. 17:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:53 INFO - (blobuploader) - INFO - Done attempting. 17:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:54:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:54:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:56 INFO - (blobuploader) - INFO - Done attempting. 17:54:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:54:56 INFO - Return code: 0 17:54:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:54:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:54:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f77ee62832bd176cc54bb5c0ac1d16d5347c47e8c12c18e73e77a98001be7604c82b3369195737393b917ba3634b696bc12ba31efd1077903cf2fe909bdf9f32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/982ff7ffb088d6f8a2a9e766262c8db2c3f881c68aa23beb246558ae99b151274f20be8d570414ed9e01ac76fb65d764e0e950e5396925626896ba1f49f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a8c8c2780dd735d8a0da773369111815c84b15ed3a4ebbc2c0164fb27c8593451f84cf76f38c602ea46d14cfecaa9b91354bc63f0aa49169fb3c61786ab543c"} 17:54:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:54:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:54:56 INFO - Contents: 17:54:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f77ee62832bd176cc54bb5c0ac1d16d5347c47e8c12c18e73e77a98001be7604c82b3369195737393b917ba3634b696bc12ba31efd1077903cf2fe909bdf9f32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/982ff7ffb088d6f8a2a9e766262c8db2c3f881c68aa23beb246558ae99b151274f20be8d570414ed9e01ac76fb65d764e0e950e5396925626896ba1f49f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a8c8c2780dd735d8a0da773369111815c84b15ed3a4ebbc2c0164fb27c8593451f84cf76f38c602ea46d14cfecaa9b91354bc63f0aa49169fb3c61786ab543c"} 17:54:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:54:56 INFO - Copying logs to upload dir... 17:54:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:54:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.260408 ========= master_lag: 0.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-08 17:54:56.881577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:54:56.886052) ========= 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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f77ee62832bd176cc54bb5c0ac1d16d5347c47e8c12c18e73e77a98001be7604c82b3369195737393b917ba3634b696bc12ba31efd1077903cf2fe909bdf9f32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/982ff7ffb088d6f8a2a9e766262c8db2c3f881c68aa23beb246558ae99b151274f20be8d570414ed9e01ac76fb65d764e0e950e5396925626896ba1f49f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a8c8c2780dd735d8a0da773369111815c84b15ed3a4ebbc2c0164fb27c8593451f84cf76f38c602ea46d14cfecaa9b91354bc63f0aa49169fb3c61786ab543c"} build_url:https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011067 build_url: 'https://queue.taskcluster.net/v1/task/cwncTOVsQoKa2C-MmmcSfA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f77ee62832bd176cc54bb5c0ac1d16d5347c47e8c12c18e73e77a98001be7604c82b3369195737393b917ba3634b696bc12ba31efd1077903cf2fe909bdf9f32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/982ff7ffb088d6f8a2a9e766262c8db2c3f881c68aa23beb246558ae99b151274f20be8d570414ed9e01ac76fb65d764e0e950e5396925626896ba1f49f14053", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a8c8c2780dd735d8a0da773369111815c84b15ed3a4ebbc2c0164fb27c8593451f84cf76f38c602ea46d14cfecaa9b91354bc63f0aa49169fb3c61786ab543c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 17:54:56.925092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:54:56.925461) ========= 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.qJc7bJG5HM/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.jdVlX1U1kD/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005198 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 17:54:56.975649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:54:56.978771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 17:54:56.979107) ========= ========= Total master_lag: 1.00 =========