builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0161 starttime: 1473409452.66 results: success (0) buildid: 20160909000719 builduid: f8da20a721f143319b925227cbb5ca7b revision: 37577db303680328e0e0293ed4d9e156cb5b2fa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:12.661707) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:12.662129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:12.662424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:12.768044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:12.768344) ========= 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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-09 01:24:12-- 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% 8.13M=0.001s 2016-09-09 01:24:13 (8.13 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.513619 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:13.308500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:13.308798) ========= 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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.021563 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:13.356683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-09 01:24:13.356989) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 37577db303680328e0e0293ed4d9e156cb5b2fa9 --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 37577db303680328e0e0293ed4d9e156cb5b2fa9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-09 01:24:13,349 truncating revision to first 12 chars 2016-09-09 01:24:13,349 Setting DEBUG logging. 2016-09-09 01:24:13,349 attempt 1/10 2016-09-09 01:24:13,349 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/37577db30368?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-09 01:24:14,344 unpacking tar archive at: autoland-37577db30368/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-09 01:24:14.627955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:14.628356) ========= script_repo_revision: 37577db303680328e0e0293ed4d9e156cb5b2fa9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:14.628853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:14.629210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-09 01:24:14.648208) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-09 01:24:14.648519) ========= /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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:14 INFO - MultiFileLogger online at 20160909 01:24:14 in /builds/slave/test 01:24:14 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 01:24:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:24:14 INFO - {'append_to_log': False, 01:24:14 INFO - 'base_work_dir': '/builds/slave/test', 01:24:14 INFO - 'blob_upload_branch': 'Autoland', 01:24:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:24:14 INFO - 'branch': 'Autoland', 01:24:14 INFO - 'buildbot_json_path': 'buildprops.json', 01:24:14 INFO - 'config_files': ('talos/mac_config.py',), 01:24:14 INFO - 'default_actions': ('clobber', 01:24:14 INFO - 'read-buildbot-config', 01:24:14 INFO - 'download-and-extract', 01:24:14 INFO - 'populate-webroot', 01:24:14 INFO - 'create-virtualenv', 01:24:14 INFO - 'install', 01:24:14 INFO - 'run-tests'), 01:24:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:24:14 INFO - 'download_minidump_stackwalk': True, 01:24:14 INFO - 'download_symbols': 'ondemand', 01:24:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:24:14 INFO - 'tooltool.py': '/tools/tooltool.py', 01:24:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:24:14 INFO - '/tools/misc-python/virtualenv.py')}, 01:24:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:24:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:24:14 INFO - 'installer_path': 'installer.exe', 01:24:14 INFO - 'log_level': 'info', 01:24:14 INFO - 'log_name': 'talos', 01:24:14 INFO - 'log_to_console': True, 01:24:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:24:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:24:14 INFO - 'opt_config_files': (), 01:24:14 INFO - 'pip_index': False, 01:24:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:24:14 INFO - 'cmd': ('bash', 01:24:14 INFO - '-c', 01:24:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:24:14 INFO - 'enabled': True, 01:24:14 INFO - 'halt_on_failure': False, 01:24:14 INFO - 'name': 'check_screen_resolution'},), 01:24:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:24:14 INFO - 'cmd': ('bash', 01:24:14 INFO - '-c', 01:24:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:24:14 INFO - 'enabled': True, 01:24:14 INFO - 'halt_on_failure': False, 01:24:14 INFO - 'name': 'check_screen_resolution'},), 01:24:14 INFO - 'run_cmd_checks_enabled': True, 01:24:14 INFO - 'sps_profile': False, 01:24:14 INFO - 'sps_profile_interval': 0, 01:24:14 INFO - 'suite': 'dromaeojs', 01:24:14 INFO - 'system_bits': '32', 01:24:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:24:14 INFO - 'title': 't-yosemite-r7-0161', 01:24:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:24:14 INFO - 'use_talos_json': True, 01:24:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:24:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:24:14 INFO - 'work_dir': 'build'} 01:24:14 INFO - [mozharness: 2016-09-09 08:24:14.760160Z] Running clobber step. 01:24:14 INFO - Running pre-action listener: _resource_record_pre_action 01:24:14 INFO - Running main action method: clobber 01:24:14 INFO - rmtree: /builds/slave/test/build 01:24:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:24:16 INFO - Running post-action listener: _resource_record_post_action 01:24:16 INFO - [mozharness: 2016-09-09 08:24:16.229745Z] Finished clobber step (success) 01:24:16 INFO - [mozharness: 2016-09-09 08:24:16.229877Z] Running read-buildbot-config step. 01:24:16 INFO - Running pre-action listener: _resource_record_pre_action 01:24:16 INFO - Running main action method: read_buildbot_config 01:24:16 INFO - Using buildbot properties: 01:24:16 INFO - { 01:24:16 INFO - "project": "", 01:24:16 INFO - "product": "firefox", 01:24:16 INFO - "script_repo_revision": "production", 01:24:16 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 01:24:16 INFO - "repository": "", 01:24:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 01:24:16 INFO - "buildid": "20160909000719", 01:24:16 INFO - "pgo_build": "False", 01:24:16 INFO - "basedir": "/builds/slave/test", 01:24:16 INFO - "buildnumber": 189, 01:24:16 INFO - "slavename": "t-yosemite-r7-0161", 01:24:16 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:24:16 INFO - "platform": "yosemite_r7", 01:24:16 INFO - "scheduler": "tests-autoland-macosx64-talos", 01:24:16 INFO - "branch": "autoland", 01:24:16 INFO - "repo_path": "integration/autoland", 01:24:16 INFO - "revision": "37577db303680328e0e0293ed4d9e156cb5b2fa9", 01:24:16 INFO - "stage_platform": "macosx64", 01:24:16 INFO - "builduid": "f8da20a721f143319b925227cbb5ca7b", 01:24:16 INFO - "slavebuilddir": "test" 01:24:16 INFO - } 01:24:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 01:24:16 INFO - Running post-action listener: _resource_record_post_action 01:24:16 INFO - [mozharness: 2016-09-09 08:24:16.233210Z] Finished read-buildbot-config step (success) 01:24:16 INFO - [mozharness: 2016-09-09 08:24:16.233326Z] Running download-and-extract step. 01:24:16 INFO - Running pre-action listener: _resource_record_pre_action 01:24:16 INFO - Running main action method: download_and_extract 01:24:16 INFO - mkdir: /builds/slave/test/build/tests 01:24:16 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')]} 01:24:16 INFO - trying https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 01:24:16 INFO - Downloading https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/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 01:24:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/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 01:24:17 INFO - Downloaded 1199 bytes. 01:24:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 01:24:17 INFO - Using the following test package requirements: 01:24:17 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:24:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 01:24:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 01:24:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'jsshell-mac.zip'], 01:24:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 01:24:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:24:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 01:24:17 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 01:24:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 01:24:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:24:17 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 01:24:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:24:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:24:18 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 01:24:25 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 01:24:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:24:25 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 01:24:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 01:24:32 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 01:24:33 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')]} 01:24:33 INFO - trying https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:24:33 INFO - Downloading https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 01:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/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 01:24:36 INFO - Downloaded 111534647 bytes. 01:24:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:24:36 INFO - mkdir: /builds/slave/test/properties 01:24:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:24:36 INFO - Writing to file /builds/slave/test/properties/build_url 01:24:36 INFO - Contents: 01:24:36 INFO - build_url:https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:24:37 INFO - Running post-action listener: _resource_record_post_action 01:24:37 INFO - Running post-action listener: set_extra_try_arguments 01:24:37 INFO - [mozharness: 2016-09-09 08:24:37.186689Z] Finished download-and-extract step (success) 01:24:37 INFO - [mozharness: 2016-09-09 08:24:37.186815Z] Running populate-webroot step. 01:24:37 INFO - Running pre-action listener: _resource_record_pre_action 01:24:37 INFO - Running main action method: populate_webroot 01:24:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:24:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:24:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:24:37 INFO - '--tppagecycles', 01:24:37 INFO - '7'], 01:24:37 INFO - 'tests': ['tsvgm']}}, 01:24:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:24:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:24:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:24:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:24:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:24:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['damp', 'tps']}, 01:24:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'tests': ['damp', 'tps']}, 01:24:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['dromaeo_dom']}, 01:24:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:24:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['basic_compositor_video']}, 01:24:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:24:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'other-e10s': {'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['a11yr', 01:24:37 INFO - 'ts_paint', 01:24:37 INFO - 'tpaint', 01:24:37 INFO - 'sessionrestore', 01:24:37 INFO - 'sessionrestore_no_auto_restore', 01:24:37 INFO - 'tabpaint']}, 01:24:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['tsvgx', 01:24:37 INFO - 'tsvgr_opacity', 01:24:37 INFO - 'tart', 01:24:37 INFO - 'tscrollx', 01:24:37 INFO - 'cart']}, 01:24:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:24:37 INFO - 'tsvgr_opacity', 01:24:37 INFO - 'tart', 01:24:37 INFO - 'tscrollx', 01:24:37 INFO - 'cart']}, 01:24:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-e10s'], 01:24:37 INFO - 'tests': ['tp5o']}, 01:24:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'tests': ['tp5o']}, 01:24:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'talos_options': ['--disable-e10s', 01:24:37 INFO - '--xperf_path', 01:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:37 INFO - 'tests': ['tp5n']}, 01:24:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:24:37 INFO - 'talos_options': ['--xperf_path', 01:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:24:37 INFO - 'tests': ['tp5n']}}, 01:24:37 INFO - 'talos.zip': {'path': '', 01:24:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:24:37 INFO - Running post-action listener: _resource_record_post_action 01:24:37 INFO - [mozharness: 2016-09-09 08:24:37.205933Z] Finished populate-webroot step (success) 01:24:37 INFO - [mozharness: 2016-09-09 08:24:37.206045Z] Running create-virtualenv step. 01:24:37 INFO - Running pre-action listener: _resource_record_pre_action 01:24:37 INFO - Running main action method: create_virtualenv 01:24:37 INFO - Creating virtualenv /builds/slave/test/build/venv 01:24:37 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 01:24:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:24:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:24:37 INFO - Using real prefix '/tools/python27' 01:24:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:24:38 INFO - Installing distribute.............................................................................................................................................................................................done. 01:24:40 INFO - Installing pip.................done. 01:24:40 INFO - Return code: 0 01:24:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:24:40 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')]} 01:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:40 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')]} 01:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:40 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:40 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 01:24:40 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 01:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:40 INFO - 'HOME': '/Users/cltbld', 01:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:40 INFO - 'LOGNAME': 'cltbld', 01:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:40 INFO - 'MOZ_NO_REMOTE': '1', 01:24:40 INFO - 'NO_EM_RESTART': '1', 01:24:40 INFO - 'PAGER': '/bin/cat', 01:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:40 INFO - 'PWD': '/builds/slave/test', 01:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:40 INFO - 'SHELL': '/bin/bash', 01:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:24:40 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:40 INFO - 'USER': 'cltbld', 01:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:40 INFO - 'XPC_FLAGS': '0x0', 01:24:40 INFO - 'XPC_SERVICE_NAME': '0', 01:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:41 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 01:24:41 INFO - Cleaning up... 01:24:41 INFO - Return code: 0 01:24:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:41 INFO - 'HOME': '/Users/cltbld', 01:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:41 INFO - 'LOGNAME': 'cltbld', 01:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:41 INFO - 'MOZ_NO_REMOTE': '1', 01:24:41 INFO - 'NO_EM_RESTART': '1', 01:24:41 INFO - 'PAGER': '/bin/cat', 01:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:41 INFO - 'PWD': '/builds/slave/test', 01:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:41 INFO - 'SHELL': '/bin/bash', 01:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:24:41 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:41 INFO - 'USER': 'cltbld', 01:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:41 INFO - 'XPC_FLAGS': '0x0', 01:24:41 INFO - 'XPC_SERVICE_NAME': '0', 01:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:41 INFO - Downloading/unpacking psutil>=3.1.1 01:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:24:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:45 INFO - Installing collected packages: psutil 01:24:45 INFO - Running setup.py install for psutil 01:24:45 INFO - building 'psutil._psutil_osx' extension 01:24:45 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 01:24:45 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 01:24:45 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 01:24:45 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 01:24:45 INFO - building 'psutil._psutil_posix' extension 01:24:45 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 01:24:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:24:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:24:45 INFO - ^ 01:24:45 INFO - 1 warning generated. 01:24:45 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 01:24:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:24:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:24:45 INFO - Successfully installed psutil 01:24:45 INFO - Cleaning up... 01:24:46 INFO - Return code: 0 01:24:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:24:46 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')]} 01:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:46 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')]} 01:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:46 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:46 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 01:24:46 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 01:24:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:24:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:46 INFO - 'HOME': '/Users/cltbld', 01:24:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:46 INFO - 'LOGNAME': 'cltbld', 01:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:46 INFO - 'MOZ_NO_REMOTE': '1', 01:24:46 INFO - 'NO_EM_RESTART': '1', 01:24:46 INFO - 'PAGER': '/bin/cat', 01:24:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:46 INFO - 'PWD': '/builds/slave/test', 01:24:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:46 INFO - 'SHELL': '/bin/bash', 01:24:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:24:46 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:24:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:46 INFO - 'USER': 'cltbld', 01:24:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:46 INFO - 'XPC_FLAGS': '0x0', 01:24:46 INFO - 'XPC_SERVICE_NAME': '0', 01:24:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:24:46 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 01:24:46 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 01:24:46 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 01:24:46 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 01:24:46 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 01:24:46 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 01:24:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:24:48 INFO - Installing collected packages: mozsystemmonitor 01:24:48 INFO - Running setup.py install for mozsystemmonitor 01:24:49 INFO - Successfully installed mozsystemmonitor 01:24:49 INFO - Cleaning up... 01:24:49 INFO - Return code: 0 01:24:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:49 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:49 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 01:24:49 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 01:24:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:24:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:49 INFO - 'HOME': '/Users/cltbld', 01:24:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:49 INFO - 'LOGNAME': 'cltbld', 01:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:49 INFO - 'MOZ_NO_REMOTE': '1', 01:24:49 INFO - 'NO_EM_RESTART': '1', 01:24:49 INFO - 'PAGER': '/bin/cat', 01:24:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:49 INFO - 'PWD': '/builds/slave/test', 01:24:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:49 INFO - 'SHELL': '/bin/bash', 01:24:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:24:49 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:24:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:49 INFO - 'USER': 'cltbld', 01:24:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:49 INFO - 'XPC_FLAGS': '0x0', 01:24:49 INFO - 'XPC_SERVICE_NAME': '0', 01:24:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:49 INFO - Downloading/unpacking jsonschema==2.5.1 01:24:49 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 01:24:49 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 01:24:49 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 01:24:49 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 01:24:49 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 01:24:49 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 01:24:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:24:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:24:51 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 01:24:51 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 01:24:51 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 01:24:51 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 01:24:51 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 01:24:51 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 01:24:52 INFO - Downloading functools32-3.2.3-2.tar.gz 01:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:24:52 INFO - warning: no files found matching '*.txt' 01:24:52 INFO - no previously-included directories found matching 'build' 01:24:52 INFO - no previously-included directories found matching 'dist' 01:24:52 INFO - no previously-included directories found matching '.git*' 01:24:52 INFO - Installing collected packages: jsonschema, functools32 01:24:52 INFO - Running setup.py install for functools32 01:24:52 INFO - warning: no files found matching '*.txt' 01:24:52 INFO - no previously-included directories found matching 'build' 01:24:52 INFO - no previously-included directories found matching 'dist' 01:24:52 INFO - no previously-included directories found matching '.git*' 01:24:52 INFO - Successfully installed jsonschema functools32 01:24:52 INFO - Cleaning up... 01:24:52 INFO - Return code: 0 01:24:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:24:52 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')]} 01:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:52 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')]} 01:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:52 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:52 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 01:24:52 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 01:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:52 INFO - 'HOME': '/Users/cltbld', 01:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:52 INFO - 'LOGNAME': 'cltbld', 01:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:52 INFO - 'MOZ_NO_REMOTE': '1', 01:24:52 INFO - 'NO_EM_RESTART': '1', 01:24:52 INFO - 'PAGER': '/bin/cat', 01:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:52 INFO - 'PWD': '/builds/slave/test', 01:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:52 INFO - 'SHELL': '/bin/bash', 01:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:24:52 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:52 INFO - 'USER': 'cltbld', 01:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:52 INFO - 'XPC_FLAGS': '0x0', 01:24:52 INFO - 'XPC_SERVICE_NAME': '0', 01:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:24:52 INFO - Cleaning up... 01:24:52 INFO - Return code: 0 01:24:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:24:52 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')]} 01:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:52 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')]} 01:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:52 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:52 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 01:24:52 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 01:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:52 INFO - 'HOME': '/Users/cltbld', 01:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:52 INFO - 'LOGNAME': 'cltbld', 01:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:52 INFO - 'MOZ_NO_REMOTE': '1', 01:24:52 INFO - 'NO_EM_RESTART': '1', 01:24:52 INFO - 'PAGER': '/bin/cat', 01:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:52 INFO - 'PWD': '/builds/slave/test', 01:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:52 INFO - 'SHELL': '/bin/bash', 01:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:24:52 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:52 INFO - 'USER': 'cltbld', 01:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:52 INFO - 'XPC_FLAGS': '0x0', 01:24:52 INFO - 'XPC_SERVICE_NAME': '0', 01:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:53 INFO - Downloading/unpacking blobuploader==1.2.4 01:24:53 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 01:24:53 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 01:24:53 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 01:24:53 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 01:24:53 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 01:24:53 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 01:24:55 INFO - Downloading blobuploader-1.2.4.tar.gz 01:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:24:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:24:55 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 01:24:55 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 01:24:55 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 01:24:55 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 01:24:55 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 01:24:55 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 01:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:24:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:24:56 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 01:24:56 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 01:24:56 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 01:24:56 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 01:24:56 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 01:24:56 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 01:24:56 INFO - Downloading docopt-0.6.1.tar.gz 01:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:24:56 INFO - Running setup.py install for blobuploader 01:24:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:24:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:24:57 INFO - Running setup.py install for requests 01:24:57 INFO - Running setup.py install for docopt 01:24:57 INFO - Successfully installed blobuploader requests docopt 01:24:57 INFO - Cleaning up... 01:24:57 INFO - Return code: 0 01:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:57 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:24:57 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 01:24:57 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 01:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:24:57 INFO - 'HOME': '/Users/cltbld', 01:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:24:57 INFO - 'LOGNAME': 'cltbld', 01:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:57 INFO - 'MOZ_NO_REMOTE': '1', 01:24:57 INFO - 'NO_EM_RESTART': '1', 01:24:57 INFO - 'PAGER': '/bin/cat', 01:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:57 INFO - 'PWD': '/builds/slave/test', 01:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:24:57 INFO - 'SHELL': '/bin/bash', 01:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:24:57 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:24:57 INFO - 'USER': 'cltbld', 01:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:57 INFO - 'XPC_FLAGS': '0x0', 01:24:57 INFO - 'XPC_SERVICE_NAME': '0', 01:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-SQKakJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-4uQiiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-phQBUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-TLzf53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-BKrnrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-9pqZGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ScTJw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-zlWZxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-RqUCeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-aRZJqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-LsGlSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-KjIEU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-50b9pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-oxVkE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-iiYiHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-l75pdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Pag1ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:59 INFO - Running setup.py install for manifestparser 01:25:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for mozcrash 01:25:00 INFO - Running setup.py install for mozdebug 01:25:00 INFO - Running setup.py install for mozdevice 01:25:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for mozfile 01:25:00 INFO - Running setup.py install for mozhttpd 01:25:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for mozinfo 01:25:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:00 INFO - Running setup.py install for mozInstall 01:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Running setup.py install for mozleak 01:25:01 INFO - Running setup.py install for mozlog 01:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Running setup.py install for moznetwork 01:25:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Running setup.py install for mozprocess 01:25:01 INFO - Running setup.py install for mozprofile 01:25:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:01 INFO - Running setup.py install for mozrunner 01:25:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:02 INFO - Running setup.py install for mozscreenshot 01:25:02 INFO - Running setup.py install for moztest 01:25:02 INFO - Running setup.py install for mozversion 01:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:02 INFO - Cleaning up... 01:25:02 INFO - Return code: 0 01:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:02 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')]} 01:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:02 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')]} 01:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:02 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:25:02 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 01:25:02 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 01:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:25:02 INFO - 'HOME': '/Users/cltbld', 01:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:25:02 INFO - 'LOGNAME': 'cltbld', 01:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:02 INFO - 'MOZ_NO_REMOTE': '1', 01:25:02 INFO - 'NO_EM_RESTART': '1', 01:25:02 INFO - 'PAGER': '/bin/cat', 01:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:02 INFO - 'PWD': '/builds/slave/test', 01:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:25:02 INFO - 'SHELL': '/bin/bash', 01:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:25:02 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:25:02 INFO - 'USER': 'cltbld', 01:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:02 INFO - 'XPC_FLAGS': '0x0', 01:25:02 INFO - 'XPC_SERVICE_NAME': '0', 01:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:02 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-9PKkWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:02 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)) 01:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:02 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-kGhohQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-5zyPb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-yBLJjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-B0t1yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-HcY6eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-p1yxDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Rme6bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-mPrW2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-PFaiLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:03 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)) 01:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:03 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-hFLURo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:04 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)) 01:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:04 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-HeKGmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:04 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)) 01:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:04 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-mV2gG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:04 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)) 01:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:04 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-W2bZUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:04 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)) 01:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:04 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-q1BhRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:04 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)) 01:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:04 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-se3cLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:04 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)) 01:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:04 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-SK_WoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:04 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)) 01:25:04 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)) 01:25:04 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)) 01:25:04 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)) 01:25:04 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)) 01:25:04 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)) 01:25:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:04 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 01:25:04 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 01:25:04 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 01:25:04 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 01:25:04 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 01:25:04 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 01:25:07 INFO - Downloading blessings-1.6.tar.gz 01:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:07 INFO - Installing collected packages: blessings 01:25:07 INFO - Running setup.py install for blessings 01:25:07 INFO - Successfully installed blessings 01:25:07 INFO - Cleaning up... 01:25:07 INFO - Return code: 0 01:25:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:07 INFO - Reading from file tmpfile_stdout 01:25:07 INFO - Current package versions: 01:25:07 INFO - blessings == 1.6 01:25:07 INFO - blobuploader == 1.2.4 01:25:07 INFO - docopt == 0.6.1 01:25:07 INFO - functools32 == 3.2.3-2 01:25:07 INFO - jsonschema == 2.5.1 01:25:07 INFO - manifestparser == 1.1 01:25:07 INFO - mozInstall == 1.12 01:25:07 INFO - mozcrash == 0.17 01:25:07 INFO - mozdebug == 0.1 01:25:07 INFO - mozdevice == 0.48 01:25:07 INFO - mozfile == 1.2 01:25:07 INFO - mozhttpd == 0.7 01:25:07 INFO - mozinfo == 0.9 01:25:07 INFO - mozleak == 0.1 01:25:07 INFO - mozlog == 3.3 01:25:07 INFO - moznetwork == 0.27 01:25:07 INFO - mozprocess == 0.23 01:25:07 INFO - mozprofile == 0.28 01:25:07 INFO - mozrunner == 6.12 01:25:07 INFO - mozscreenshot == 0.1 01:25:07 INFO - mozsystemmonitor == 0.3 01:25:07 INFO - moztest == 0.7 01:25:07 INFO - mozversion == 1.4 01:25:07 INFO - psutil == 3.1.1 01:25:07 INFO - requests == 1.2.3 01:25:07 INFO - wsgiref == 0.1.2 01:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:07 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 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:25:07 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 01:25:07 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 01:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:25:07 INFO - 'HOME': '/Users/cltbld', 01:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:25:07 INFO - 'LOGNAME': 'cltbld', 01:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:07 INFO - 'MOZ_NO_REMOTE': '1', 01:25:07 INFO - 'NO_EM_RESTART': '1', 01:25:07 INFO - 'PAGER': '/bin/cat', 01:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:07 INFO - 'PWD': '/builds/slave/test', 01:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:25:07 INFO - 'SHELL': '/bin/bash', 01:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:25:07 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:25:07 INFO - 'USER': 'cltbld', 01:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:07 INFO - 'XPC_FLAGS': '0x0', 01:25:07 INFO - 'XPC_SERVICE_NAME': '0', 01:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 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)) 01:25:08 INFO - Cleaning up... 01:25:08 INFO - Return code: 0 01:25:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101681618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe172dbddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, '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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 01:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:25:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:25:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:25:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:25:08 INFO - 'HOME': '/Users/cltbld', 01:25:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:25:08 INFO - 'LOGNAME': 'cltbld', 01:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:08 INFO - 'MOZ_NO_REMOTE': '1', 01:25:08 INFO - 'NO_EM_RESTART': '1', 01:25:08 INFO - 'PAGER': '/bin/cat', 01:25:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:08 INFO - 'PWD': '/builds/slave/test', 01:25:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:25:08 INFO - 'SHELL': '/bin/bash', 01:25:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:25:08 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:25:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:25:08 INFO - 'USER': 'cltbld', 01:25:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:25:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:08 INFO - 'XPC_FLAGS': '0x0', 01:25:08 INFO - 'XPC_SERVICE_NAME': '0', 01:25:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:25:08 INFO - Cleaning up... 01:25:08 INFO - Return code: 0 01:25:08 INFO - Running post-action listener: _resource_record_post_action 01:25:08 INFO - Running post-action listener: _start_resource_monitoring 01:25:08 INFO - Starting resource monitoring. 01:25:08 INFO - [mozharness: 2016-09-09 08:25:08.371255Z] Finished create-virtualenv step (success) 01:25:08 INFO - [mozharness: 2016-09-09 08:25:08.372357Z] Running install step. 01:25:08 INFO - Running pre-action listener: _resource_record_pre_action 01:25:08 INFO - Running main action method: install 01:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:08 INFO - Reading from file tmpfile_stdout 01:25:08 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:08 INFO - Reading from file tmpfile_stdout 01:25:08 INFO - Output received: 01:25:08 INFO - Usage: mozinstall [options] installer 01:25:08 INFO - Options: 01:25:08 INFO - -h, --help show this help message and exit 01:25:08 INFO - -d DEST, --destination=DEST 01:25:08 INFO - Directory to install application into. [default: 01:25:08 INFO - "/builds/slave/test"] 01:25:08 INFO - --app=APP Application being installed. [default: firefox] 01:25:08 INFO - mkdir: /builds/slave/test/build/application 01:25:08 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'] 01:25:08 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 01:25:43 INFO - Reading from file tmpfile_stdout 01:25:43 INFO - Output received: 01:25:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:25:43 INFO - Running post-action listener: _resource_record_post_action 01:25:43 INFO - [mozharness: 2016-09-09 08:25:43.018147Z] Finished install step (success) 01:25:43 INFO - [mozharness: 2016-09-09 08:25:43.018254Z] Running run-tests step. 01:25:43 INFO - Running pre-action listener: _resource_record_pre_action 01:25:43 INFO - Running main action method: run_tests 01:25:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:25:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:25:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:25:43 INFO - 2016-09-09 01:25:43.033 screenresolution[2834:44072] starting screenresolution argv=screenresolution get 01:25:43 INFO - 2016-09-09 01:25:43.035 screenresolution[2834:44072] Display 0: 1600x1200x32@60 01:25:43 INFO - 2016-09-09 01:25:43.041 screenresolution[2835:44074] starting screenresolution argv=screenresolution list 01:25:43 INFO - Available Modes on Display 0 01:25:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:25:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:25:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:25:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:25:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:25:43 INFO - Intel Iris: 01:25:43 INFO - Chipset Model: Intel Iris 01:25:43 INFO - Type: GPU 01:25:43 INFO - Bus: Built-In 01:25:43 INFO - VRAM (Dynamic, Max): 1536 MB 01:25:43 INFO - Vendor: Intel (0x8086) 01:25:43 INFO - Device ID: 0x0a2e 01:25:43 INFO - Revision ID: 0x0009 01:25:43 INFO - Displays: 01:25:43 INFO - Display: 01:25:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:25:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:25:43 INFO - Display Serial Number: 1600x1200 60 01:25:43 INFO - Main Display: Yes 01:25:43 INFO - Mirror: Off 01:25:43 INFO - Online: Yes 01:25:43 INFO - Rotation: Supported 01:25:43 INFO - Return code: 0 01:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:43 INFO - Python 2.7.3 01:25:43 INFO - Return code: 0 01:25:43 INFO - grabbing minidump binary from tooltool 01:25:43 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')]} 01:25:43 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 0x101550d30>, '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 0x1012b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101548b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:43 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 01:25:43 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 01:25:43 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 01:25:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:43 INFO - Return code: 0 01:25:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:25:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:25:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:43 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/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--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 01:25:43 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/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0161 --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 01:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4fNTQ2ecT/Render', 01:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:25:43 INFO - 'HOME': '/Users/cltbld', 01:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:25:43 INFO - 'LOGNAME': 'cltbld', 01:25:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:43 INFO - 'MOZ_NO_REMOTE': '1', 01:25:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:43 INFO - 'NO_EM_RESTART': '1', 01:25:43 INFO - 'PAGER': '/bin/cat', 01:25:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:43 INFO - 'PWD': '/builds/slave/test', 01:25:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:25:43 INFO - 'SHELL': '/bin/bash', 01:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qiBbbRjzCE/Listeners', 01:25:43 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 01:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:25:43 INFO - 'USER': 'cltbld', 01:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:43 INFO - 'XPC_FLAGS': '0x0', 01:25:43 INFO - 'XPC_SERVICE_NAME': '0', 01:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:25:43 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/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--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 01:25:43 INFO - mozversion application_buildid: 20160909000719 01:25:43 INFO - mozversion application_changeset: 37577db303680328e0e0293ed4d9e156cb5b2fa9 01:25:43 INFO - mozversion application_display_name: Nightly 01:25:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:43 INFO - mozversion application_name: Firefox 01:25:43 INFO - mozversion application_remotingname: firefox 01:25:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:25:43 INFO - mozversion application_vendor: Mozilla 01:25:43 INFO - mozversion application_version: 51.0a1 01:25:43 INFO - mozversion platform_buildid: 20160909000719 01:25:43 INFO - mozversion platform_changeset: 37577db303680328e0e0293ed4d9e156cb5b2fa9 01:25:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:25:43 INFO - mozversion platform_version: 51.0a1 01:25:43 INFO - using testdate: 1473409543 01:25:43 INFO - actual date: 1473409543 01:25:43 INFO - starting webserver on 'localhost:61379' 01:25:43 INFO - SUITE-START | Running 2 tests 01:25:43 INFO - TEST-START | dromaeo_css 01:25:43 INFO - operating with platform_type : mac_ 01:25:43 INFO - Initialising browser for dromaeo_css test... 01:25:43 INFO - TEST-INFO | started process 2845 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpyZPUVm/profile http://localhost:61379/getInfo.html) 01:25:45 INFO - PROCESS | 2845 | __metrics Screen width/height:1600/1200 01:25:45 INFO - PROCESS | 2845 | colorDepth:24 01:25:45 INFO - PROCESS | 2845 | Browser inner width/height: 1024/689 01:25:45 INFO - PROCESS | 2845 | __metrics 01:25:46 INFO - PROCESS | 2845 | 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" 01:25:46 INFO - PROCESS | 2845 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:25:46 INFO - TEST-INFO | 2845: exit 0 01:25:46 INFO - Browser initialized. 01:25:46 INFO - Running cycle 1/1 for dromaeo_css test... 01:25:46 INFO - TEST-INFO | started process 2847 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpyZPUVm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:25:58 INFO - PROCESS | 2847 | RSS: Main: 232357888 01:25:58 INFO - PROCESS | 2847 | 01:26:50 INFO - PROCESS | 2847 | 1473409610040 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] 01:29:02 INFO - PROCESS | 2847 | Cycle 1(1): loaded http://localhost:61379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61379/tests/dromaeo/cssquery-ext.html) 01:29:03 INFO - PROCESS | 2847 | RSS: Main: 386035712 01:29:03 INFO - PROCESS | 2847 | 01:32:06 INFO - PROCESS | 2847 | Cycle 1(1): loaded http://localhost:61379/tests/dromaeo/cssquery-ext.html (next: http://localhost:61379/tests/dromaeo/cssquery-jquery.html) 01:32:07 INFO - PROCESS | 2847 | RSS: Main: 372662272 01:32:07 INFO - PROCESS | 2847 | 01:35:09 INFO - PROCESS | 2847 | Cycle 1(1): loaded http://localhost:61379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61379/tests/dromaeo/cssquery-mootools.html) 01:35:10 INFO - PROCESS | 2847 | RSS: Main: 341086208 01:35:10 INFO - PROCESS | 2847 | 01:38:12 INFO - PROCESS | 2847 | Cycle 1(1): loaded http://localhost:61379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61379/tests/dromaeo/cssquery-prototype.html) 01:38:13 INFO - PROCESS | 2847 | RSS: Main: 334548992 01:38:13 INFO - PROCESS | 2847 | 01:41:16 INFO - PROCESS | 2847 | Cycle 1(1): loaded http://localhost:61379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61379/tests/dromaeo/cssquery-yui.html) 01:41:17 INFO - PROCESS | 2847 | RSS: Main: 325189632 01:41:17 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | Cycle 1(1): loaded http://localhost:61379/tests/dromaeo/cssquery-yui.html (next: http://localhost:61379/tests/dromaeo/cssquery-dojo.html) 01:44:20 INFO - PROCESS | 2847 | RSS: Main: 405557248 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | __start_tp_report 01:44:20 INFO - PROCESS | 2847 | _x_x_mozilla_page_load 01:44:20 INFO - PROCESS | 2847 | _x_x_mozilla_page_load_details 01:44:20 INFO - PROCESS | 2847 | |i|pagename|runs| 01:44:20 INFO - PROCESS | 2847 | |0;dojo.html;3115.2211947013247;3261.575995120634;3286.605607327121;3327.151576348034;3346.832658367081;5563.749631266593;5657.773689052438;5709.685967271798;5710.486056254931;5774.335951365589;5574.470425309589;5639.407862174474;5650.237217975572;5661.094224924002;5661.46216109469;5163.586913046956;5183.844484665447;5199.610029247802;5213.32226810516;5247.422783493813;5277.419483856773;5277.498637629419;5278.630495865291;5285.445028272034;5289.709066001368;5206.557442617382;5222.738863056851;5235.162374020158;5235.6596821206695;5250.921236181461;5289.920651190197;5294.100002999499;5300.257963885078;5325.429122325252;5348.759305831208;5081.949180508184;5103.311053007834;5132.640715149941;5222.895542089175;5236.502532259429;5666.008448521534;5703.429657034305;5717.142428635696;5735.713214339308;5790.420957904218;6238.968805155991;6243.687815609247;6252.874482593132;6255.874882502325;6283.02613094971;6106;6194.5354098442795;6232.9065064023625;6237.7816776413065;6263.4989200864275;5828.329742079631;5857.88284234313;5877.177195192677;5877.735501902467;5882.000059989812;6267.9373206267355;6276.403741644536;6287.717052732638;6287.842803929847;6291.874162516724;6018.909716354258;6054.243219597551;6055.545834062463;6147.354527774609;6171.352008039091;6132.233470816148;6173.876522469525;6175.320714721377;6181.258249010148;6185.938140618626;6076.422739839708;6130.846728831726;6142.232220972379;6173.9073913891325;6181.660008699565;6105.975331700744;6114.297368146176;6118.479929205978;6196.969015154896;6197.597156184834;4908.337374454403;4933.3586633738105;4943.678660887031;4944.9258261126115;4946.282788995575;4055.5538890721996;4389.846355377546;4414.580614841585;4417.53615870329;4479.17135329965;5640.012997725382;5657.858553536113;5707.514861236758;5712.428757124338;5761.654300741969;6131.896637733196;6175.62946223228;6176;6202.100695399142;6208.379162083756;5641.153826925994;5663.037283661787;5672.4611161940375;5674.092145256739;5682.232898558642;5408.945910540923;5417.349918009864;5426.104692725656;5426.158945363475;5446.319210098738;5271.762770675329;6381.489480841522;6390.488760899024;6399.104125422445;6407.423331900151;5101.642884998163;6239.438450539473;6253.906191407042;6263.530235232284;6286.18279623646;6184.907226391518;6235.96882015587;6354.777582784581;6374.968125159345;6380.425761681471;6130.826205142237;6196.1635179250225;6200.906986395117;6232.096346029891;6235.906461403173;6244.718987645658;6246.812595622138;6253.218347706536;6259.530535209969;6271.874562508816;6001.609895356788;6154.723037463415;6166.660833654013;6169;6169.660668663267;6014.849628759316;6094.177286066324;6094.908576371269;6098.298695650057;6165.876682466415;5131.717755523333;6027.457528822427;6032.819015429544;6037.939620603914;6062.363451837494;6118;6148.139260503623;6148.938510614837;6151.538634602333;6167.938320616737;5701.914471282851;5819.388964158702;5913.142594323713;5945.672987985529;5954.136650185786 01:44:20 INFO - PROCESS | 2847 | |1;ext.html;471.9546205155581;501;509.77824646278873;512.6513970500058;525.6399366433993;29995.25011874704;30824.38351232977;39874.40188397176;41005.10451507102;41252.58747412533;41900.16199676005;42165.367519487234;42175.36736948948;42202.94492637678;42326;9715.708528744131;9908.801823963517;9916;9923.454210018446;9931.801363972716;8772.956135219314;8982.416142950688;11963.042956563455;12176.147669663083;12217.328046957413;10461.599980006491;12026.15816892818;12158.331291778948;12270.263784172934;12276.140670153092;12167.209131406475;12294.262344259329;12297.69255768604;12316.753664926651;12321.199122057038;10111.544980475823;11948.103892208032;11956.581519646857;12051.758964820654;12066.336351500664;39642.60357396418;39846.402303965464;39897.80051099755;39925;39933.40099898504;3333.966660333414;3365.6802603752603;3479.9826000869834;3541.220931395089;3760.304343696425;30287.091387258417;30686;31351.216219594466;31579.684203158133;31585.842070789728;3219.500977348515;3321.136504508821;3367.612724536685;3396.5414669019615;3406.3357645259184;425475;425908;432221;435694;439159;57338;57460.42539574551;57564;57772;57869;59895.700521497114;59925.40074599198;59983.700081499315;60037;60039.09941350883;16050.277737501607;16278.43025494102;16281.837181628269;16307.918460407622;16316.75524867128;11372.772544549229;11624.825627615592;12412.62762117138;12478.5008599655;12511.249325040344;15434.614134646723;15851.365945362288;15876.285567149505;16217.756733649005;16250.593735156715;5406.972965135149;6416.165898433267;6507.642079685568;6575.191822248919;6608.140941677551;856.8072183758729;914.131575003749;927.6614035876992;949.5774380400655;1006.2805094357423;27723.306917327227;28500.857495712804;29475.852620736758;29538.852305738335;30377;1054.509653011338;1065.6856227412932;1094.6168840905618;1127.4419162514607;1153.455385780024;14688;15315.792101452715;15399.384024638888;15436.151011694465;15876.285567149505;576108;588280.1757973634;592025;613391;631684;45018.32472512915;55415.445845541835;55932.720336398874;59155.11267330994;59325.703371482865;1255.378587599126;1348.676317683749;1365.2013572060257;1385.0512399006714;1393.3799459240743;29269.707302926698;30052.402486999028;31156.688433115378;31687.52468712925;31793;48826.02347953092;49361.753191233816;49439;49507.50492495029;49537;538401;541912;544467;551955;555850;38338.84983450501;38795.6120438792;39191.60808391879;39281.607183927794;39479;46579.53420465752;46582.53417465917;47542.52457475381;47672.04655906932;47835.80410489766;38868;38952.6104738949;39348;39596.604033959295;40398.39402408907;35939.28121437609;38798.6120138795;38874.80562597169;39574.60425395824;40175.59824401836;36961.07597310089;37691.81154094212;38193.618063819005;38221.853344399715;38316.80841595774;31616.683833162293;31644;32503.349933001682;33736.98789036333;34229.828850855585;24967.250982470556;24978.875105624356;25014.624780627943;25572.488550229264;25635.10277140291 01:44:20 INFO - PROCESS | 2847 | |2;jquery.html;353.1013570463171;360.4107284589696;374.64783103882365;376.6911132871046;406.07820248036955;14339.64150896228;15071.924640376796;20724.171033158695;20873.956302184906;21099.2615258466;20250.39248822534;20276.898615506903;20906.68639970398;20910.581788364223;21160.4709882253;5835.620684655494;6176.691165441733;6183.876322473548;6196.535259855506;6207;6076.513878889678;6081.300650425192;6125.632462052291;6131.662758548278;6146.446819786218;5815.534757219412;5936.940630593682;6053.757849686007;6071.51427885768;6075.45320921117;5202.505761952609;5922;5995.2206213192;6014.909776353358;6039.849003774897;5121.564667003309;5242.318498595197;5254.789808407697;5256.2391598814065;5258.684478931238;25387.984480620755;25880.352991175183;25930.611040834403;26114.347141321618;26238.08166714175;2277.9772202278095;2338.695969523968;2395.6646069550275;2515.4717509323063;2876.122782551321;10197.235207359403;11939.761204775943;15335.23323833815;15399.442603567986;15726.764098538531;1846.8614853886013;1918.3765276285262;1926.6146770645928;1943.815337542931;1949.6685563454105;112643;113730;115235;117504;128973.7102628971;11187.94406027981;11324.207305488537;11479.942600287111;11536.94231528837;11736;12734;13281.605431429562;13644.795328070088;14349.426022958965;14362.066465679698;8430.536320502308;8521.829563408697;8591.65633374658;8715.738527844174;8729.563521823884;8455.66177352899;8459.365547583955;8481.533515656698;8644.56777161152;8690.78273043179;4351.934720979188;4442.577955094261;4446.421965144576;4507.8196872124745;4527.645624275358;1868.60906285365;1880.7837098733546;1896.4405500377422;1900.4203717865907;1938.70919362094;806.5402720449405;819.692615269274;873.6592728835759;876.8377850097752;908.5366463103733;20023.09896054652;21164.36506904795;21638;21729.565408692055;21747.565048699253;913.9131782480654;917.6008436330085;920.5857364186143;933.4725879877848;934.6822080492665;10811.35131892089;11399.373034483016;11405.429728513542;11405.885941140483;11477.024452921596;528654;528890;532745;548875;550302;107844;120086.3995680016;121125;125635;128409;909.8453262945183;942.1473566422399;968.9563969621383;969.9612015519441;971.3055165556802;18674;18702.719459208394;18861.622767544297;18924.621507570046;19348.032598370308;51162.488375115776;52019;52028.47971520236;52346.69133271699;52618.73690631522;73846.26153738394;74364.62817686093;75210.62394687992;76751;77633;5247.9737601311745;5248.763805628832;6653.534252602465;7709.804980228074;7827.25641064098;8957.328200384867;10304.433256170983;11498.25261358009;12290.75418491643;12482.937585312378;10636.787264254826;10874.67375978722;10896.128309735044;10950.06924411434;10999.450027498753;10374.325668831501;11051.889481105087;11142.27575207609;11256.364524067945;11295;11197.66407007791;11216.495257713259;11292.717682058013;11329.490172942073;11592.072634189077;7796.88304675419;8002.239787220205;8012.399070069885;8179.877301840596;8414.831703365777;9666.371685840399;10352.741181470523;10781.62264320745;10991.900809918945;10995.780084398428 01:44:20 INFO - PROCESS | 2847 | |3;mootools.html;1343.5902049874785;1356.2472827580693;1503.1432083712284;1696.7370057641062;1902.657521646103;7764.53412795232;8639.568021598918;8857.291416686665;8888.422252553588;8971.192592666659;7339.926600734005;8728.214460698537;8829.940407151134;8835.734927952155;8838.602262898168;2378.1319818266293;2403.6875206223167;2407.831451798375;2413.095089341497;2414.1188466209883;2327.1622216002224;2367.3134790910703;2370.9170179043736;2372.79831214347;2384.237044145874;2335.2643917166038;2362.1850461590725;2364.4207169243473;2364.609839376501;2372.620380739082;2312.1213938703186;2341.3610472669116;2347.119830063726;2354.3996280948336;2357.045396614374;2318.119114736406;2337.415646088478;2339.3332900123382;2340.4499942513494;2354.023080421623;8693.826123477495;8766.342524310703;8886;8899.644014239422;8906.198442140174;5278.419373868871;5468.2891224141;5490.80782172622;5492.642978206404;5506.972465137648;2902.8258304501587;3549.5563054618174;3607.080194550399;3621.004223838439;3715.20123173519;893.6425429828056;1010.161565900301;1053.0259509953262;1096.780643871229;1105.983410248847;11723.237989530653;11770.764584708344;11827.172097953147;11850.933415992602;11864.288142711379;3797.6771974381936;4399.802008909607;4508.864734057984;4638.2115040443205;4647.1635105680625;9207;9208.309376796768;9217.907820921839;9219.400738951947;9234.538273086318;5277.182036784305;5292.761825717852;5300.893982120336;5308.548773354231;5310.52205301517;4461.442319710036;4632.328312394684;4804.375431193992;4919;4980;3744.8876533704033;3783.6594706476;3876.1666241757594;3894.727369084137;3899.4930659014713;1154.9076073914066;1161.5760247509597;1164.8194529847888;1169.345166706647;1169.5321871251567;809.554744890308;833.3250067445267;870.2428886868465;886.2024178239507;908.3232991421434;5644.74598643062;5750.221027867051;5866.501347385435;5954.970225148846;6185.8453538661;433.92406328892315;438.3271677974358;443.46783859368884;453.31096732966364;453.9773011349419;3259.2992506611195;3755.6995440364703;3927.2145570885937;4008.6993475489453;4100.282450571198;10141.898581014242;10554.208434367452;10869.83695244572;10887.782244355069;10894.782104357868;8845.336599755045;10640;10795.730106747395;10820.945895270474;10834.891651083546;8260.793480163044;8265.710700125466;8267.421280510307;8279.586020699062;8391.076981532027;5508.862278443071;5986.341502434816;5993.910091348721;6128.479079278133;6329.810105696836;9747.415155090717;9781.951090244787;9928.056834600702;10106.747331316776;10191.694249172537;8533.914660853312;8835.64657413722;10244.590216391261;10368.326058806153;10391.58433662645;7265.818354541178;7442.255774422731;7484.288992545699;7611.200823913409;7668.923310766821;8432.578371081545;8512.914870851213;8526.147385261424;8529.82940341202;8533.018702849004;7342;7399.667014984231;7415.3326200642205;7641.923580764121;7717.305442510201;7329.9267007329245;7411.295926886937;7433.665485053078;7440.73957411488;7485.513441626495;6921.2386637468835;7047.471439641945;7054.788356349318;7060.046893669289;7067.646617668993;4184.539700632989;4670.579647831712;4885.975570122127;4898.2652602109965;4899.804007839789;5002.549770520671;5032.3206367139965;5064.215046667772;5126.102931986962;5131.102057139911 01:44:20 INFO - PROCESS | 2847 | |4;prototype.html;248.33322529009598;264.9362808324576;297.6859413318948;301.0817008125219;311.56692197845;4574.519675434081;4940.851774446764;5179.430262671103;5239.554637855782;5333.866653333664;4118.6499147572495;4191.113998700582;4892.633052521057;5082.872928176797;5083.389993200821;3514.7715398499145;3690.2988432197794;3910.491636087305;3981.7013723970745;4009.298372784751;3654.3604869147925;3950.6444420002194;3959.8318496043594;3983.56180820111;3986.269405457271;3247.480403135499;3445.586529616437;3794.4308353746883;3951.38753493209;3971.225611005855;3758.642928921748;3908.140209153996;3962.623550762673;4004.3993400989793;4008.478897743304;3487.4420092785285;3490.3193877193958;3496.2133519957806;3496.5629296337956;3534.9422749321907;4976;5112.744362781846;5126.307948426989;5132.28148059272;5151.459096794858;4531.071130418256;4580.610648094883;4583.862484125481;4598.954010459919;4613.469451013143;5217.660852044605;5396.5952553558245;5500.312460942382;5561.805336813232;5592.748326325325;3700.4634328022285;3765.3975363941913;3862.8841134766003;3891.610838916114;3916.471276377681;4902.534259245402;4965.702057876503;5605.495505404533;5621.522170615503;5747.396523365028;3508;3904.4338570907057;3915.5888631693833;3931;3935.409688546741;3758.4362345648374;3892.766434013968;3991.1818077294083;3991.2815693174925;3992.7005474589523;4495.707778994355;4516.103236640619;4540.568645978627;4566.995261042565;4600.907981840412;4645.907081858344;5180.119379705459;5589.720513974366;5598.804041858515;5611.186377975252;1052.5158427123608;1235.5860786636576;1293.6248487938392;1318.8878945289757;1335.3056410666593;897.2328658996595;907.2333877873186;928.9581968811419;930.7068273493828;935.733316004949;4675.7895894684825;5036.521530454601;5077.568406685473;5098.776293689488;5101.8724531886255;5464.0711079116645;5558.33300003994;5563.860903477445;5582.860428489239;5592.916106258409;4392.692511524163;4675.392199014106;4956.653034287565;5012.724300163526;5015.974920125449;2612.6995395529757;2816.0988483685023;2877.338212211203;2914.6502419709773;3057;5781.103928891029;5814.982378083903;5831.7375718091935;5838.620489668158;5881.353051164454;4619.792109355087;4983.875403114951;5320.388155362183;5532.5020748132865;5556.277424062261;5841.94158058414;5847.56143289255;5879.470847623649;5882.294124705063;5898;5057.393112826484;5659.893975523633;5665.518430933417;5724.3936320118055;5799.884002320015;5349.572034237174;5518.751656175562;5551.916721249266;5608.383077861514;5681.659100453986;4835.734034628129;5176.637635365489;5791;5867.295924489089;5997.840777320074;3363.764536482423;3723.7525428981594;3790.6209379061875;3826.0626146594263;3859;4896.387951506062;5531.7234138293725;5617.247548701189;5635.690037048002;5718.885622287614;5276.577873770012;5466.426025267289;5478.56236448478;5491.28613280271;5584.832455026356;4857.1742803724155;5505.889882202414;5535.280413546213;5545.556355491632;5587.916181257366;4281.608477244846;4620.983383655591;4739.857804265877;5057.620678449058;5420.83737487876;5449.400565937823;5462.754176062007;5498.367687715804;5504.311961004874;5518.227448157181;4359.520452750258;4681.735931298598;5097.847064588068;5478.083170533088;5507.476789704971 01:44:20 INFO - PROCESS | 2847 | |5;yui.html;777.8669599770109;790.2216316927825;800.3477166109617;806.1776987472778;817.3747083481138;15302.158381289024;16258.51224463265;16260.268287927041;16276.51170464888;16307.184640767959;14578.979471437004;14692.118472891634;14692.191929443876;14706.926465367658;14710.705785884276;670.5507310102219;687.1822531187895;835.9749207523769;842.7640260727006;859.6948083430386;860.5181098584812;862.5126803356115;875.3128793896792;875.4878396138266;877.6971944679076;924.865894445305;925.9675911343104;926.5876684875233;927.2720914082447;927.5037854747711;703.6903762344552;722.7759394587695;917.6650522559285;918.6233644205877;920.4983284110176;541.4964083402434;541.7237209023388;648.6108334998963;668.0113432120489;669.3741351836048;14809.48166814167;14829.258537073103;14830.258487075604;14832.629184270372;14849.406023759037;13240.73518529624;13706.45174193031;13985.510507132201;14250.714985700228;14539.563813085624;12472.501099956082;12798.808017879739;13036.397040567996;13158.342082895817;13203.933980330037;4088.9591104088877;4600.608948239404;4610.2623580227;4768.529099057028;4806.831760888387;116280;118277.40861295724;118423.2236516453;118619.2207116894;122591.99999999911;10944.562217511211;11047.944760276308;11212;11369.204155709187;11487.310761354345;22697;22726.86365681709;22741.431464213198;22746;22764.886175569347;7652.923470765332;7816.686040420496;7915.366770658448;7937.722179723682;8066.83866322682;4234.957650423518;4325.891852703645;4380.540043295472;4495.865124046284;4506.278995360792;3446.965530344715;3571.928561428757;3572.3391172633146;3574.7140228781636;3578.177019285579;619.8977168767193;635.9682015899186;652.1945397434165;661.5501459007825;662.460095022555;538.5906710899744;559.1361346719328;600.2406955201674;600.2946537818046;620.7485968182893;7988.680452781824;8214.753557393287;8314.625841837133;9047.457152570867;9224.672329975905;549.4725063938664;552.240669080015;612.5681394616785;617.0528239152878;636.4431122767578;4056.634902858757;4424.159409712144;4426.424564806554;4491.393661855673;4567.36056952027;146025;156290.52334794606;156720.21639891955;159185;159265;80226;80851.59574202092;93006.53496732473;104830;123136;109786;110053;111195.33207001901;111936;112363.99999999837;8114.391420643594;8273.751787446387;8532.360072994674;8541.103184165573;8719.912800872164;65368.673156633915;65379;66059;66102;66561;78765.60617196877;96472.51763741137;100332;101663;105004;8972.28221742246;10070.597176113166;10252.282340236112;11081.335119892832;11734.70663233426;12228.327441990776;12244.326562039174;12277.447514862031;12646.241225526497;12845.486180552673;10526.578936842747;12296.877031229931;13845.792313115513;14521.92739036298;14739.705205896036;12390.256584604953;13119.212847229197;13449.865501345254;13641.24973126448;13819.86180138226;13549.932250338685;13758.587242382744;13878.653033674238;13895.444182232597;13927.791083133963;11235.269707468988;11360.431978401211;11577.884221157681;11601;11725.237859539102;11427;11451.713707157387;11500.654980350602;11691.883081169079;11710.648680539598 01:44:20 INFO - PROCESS | 2847 | __end_tp_report 01:44:20 INFO - PROCESS | 2847 | __start_cc_report 01:44:20 INFO - PROCESS | 2847 | _x_x_mozilla_cycle_collect,1355 01:44:20 INFO - PROCESS | 2847 | __end_cc_report 01:44:20 INFO - PROCESS | 2847 | __startTimestamp1473410660974__endTimestamp 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | ------- Summary: start ------- 01:44:20 INFO - PROCESS | 2847 | Number of tests: 6 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | [#0] dojo.html Cycles:165 Average:5725.99 Median:5954.14 stddev:650.43 (10.9%) stddev-sans-first:619.34 01:44:20 INFO - PROCESS | 2847 | Values: 3115.2 3261.6 3286.6 3327.2 3346.8 5563.7 5657.8 5709.7 5710.5 5774.3 5574.5 5639.4 5650.2 5661.1 5661.5 5163.6 5183.8 5199.6 5213.3 5247.4 5277.4 5277.5 5278.6 5285.4 5289.7 5206.6 5222.7 5235.2 5235.7 5250.9 5289.9 5294.1 5300.3 5325.4 5348.8 5081.9 5103.3 5132.6 5222.9 5236.5 5666.0 5703.4 5717.1 5735.7 5790.4 6239.0 6243.7 6252.9 6255.9 6283.0 6106.0 6194.5 6232.9 6237.8 6263.5 5828.3 5857.9 5877.2 5877.7 5882.0 6267.9 6276.4 6287.7 6287.8 6291.9 6018.9 6054.2 6055.5 6147.4 6171.4 6132.2 6173.9 6175.3 6181.3 6185.9 6076.4 6130.8 6142.2 6173.9 6181.7 6106.0 6114.3 6118.5 6197.0 6197.6 4908.3 4933.4 4943.7 4944.9 4946.3 4055.6 4389.8 4414.6 4417.5 4479.2 5640.0 5657.9 5707.5 5712.4 5761.7 6131.9 6175.6 6176.0 6202.1 6208.4 5641.2 5663.0 5672.5 5674.1 5682.2 5408.9 5417.3 5426.1 5426.2 5446.3 5271.8 6381.5 6390.5 6399.1 6407.4 5101.6 6239.4 6253.9 6263.5 6286.2 6184.9 6236.0 6354.8 6375.0 6380.4 6130.8 6196.2 6200.9 6232.1 6235.9 6244.7 6246.8 6253.2 6259.5 6271.9 6001.6 6154.7 6166.7 6169.0 6169.7 6014.8 6094.2 6094.9 6098.3 6165.9 5131.7 6027.5 6032.8 6037.9 6062.4 6118.0 6148.1 6148.9 6151.5 6167.9 5701.9 5819.4 5913.1 5945.7 5954.1 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | [#1] ext.html Cycles:180 Average:66757.85 Median:38269.33 stddev:141507.84 (369.8%) stddev-sans-first:141817.29 01:44:20 INFO - PROCESS | 2847 | Values: 472.0 501.0 509.8 512.7 525.6 29995.3 30824.4 39874.4 41005.1 41252.6 41900.2 42165.4 42175.4 42202.9 42326.0 9715.7 9908.8 9916.0 9923.5 9931.8 8773.0 8982.4 11963.0 12176.1 12217.3 10461.6 12026.2 12158.3 12270.3 12276.1 12167.2 12294.3 12297.7 12316.8 12321.2 10111.5 11948.1 11956.6 12051.8 12066.3 39642.6 39846.4 39897.8 39925.0 39933.4 3334.0 3365.7 3480.0 3541.2 3760.3 30287.1 30686.0 31351.2 31579.7 31585.8 3219.5 3321.1 3367.6 3396.5 3406.3 425475.0 425908.0 432221.0 435694.0 439159.0 57338.0 57460.4 57564.0 57772.0 57869.0 59895.7 59925.4 59983.7 60037.0 60039.1 16050.3 16278.4 16281.8 16307.9 16316.8 11372.8 11624.8 12412.6 12478.5 12511.2 15434.6 15851.4 15876.3 16217.8 16250.6 5407.0 6416.2 6507.6 6575.2 6608.1 856.8 914.1 927.7 949.6 1006.3 27723.3 28500.9 29475.9 29538.9 30377.0 1054.5 1065.7 1094.6 1127.4 1153.5 14688.0 15315.8 15399.4 15436.2 15876.3 576108.0 588280.2 592025.0 613391.0 631684.0 45018.3 55415.4 55932.7 59155.1 59325.7 1255.4 1348.7 1365.2 1385.1 1393.4 29269.7 30052.4 31156.7 31687.5 31793.0 48826.0 49361.8 49439.0 49507.5 49537.0 538401.0 541912.0 544467.0 551955.0 555850.0 38338.8 38795.6 39191.6 39281.6 39479.0 46579.5 46582.5 47542.5 47672.0 47835.8 38868.0 38952.6 39348.0 39596.6 40398.4 35939.3 38798.6 38874.8 39574.6 40175.6 36961.1 37691.8 38193.6 38221.9 38316.8 31616.7 31644.0 32503.3 33737.0 34229.8 24967.3 24978.9 25014.6 25572.5 25635.1 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | [#2] jquery.html Cycles:180 Average:33023.89 Median:26176.21 stddev:90160.71 (344.4%) stddev-sans-first:90380.27 01:44:20 INFO - PROCESS | 2847 | Values: 353.1 360.4 374.6 376.7 406.1 14339.6 15071.9 20724.2 20874.0 21099.3 20250.4 20276.9 20906.7 20910.6 21160.5 5835.6 6176.7 6183.9 6196.5 6207.0 6076.5 6081.3 6125.6 6131.7 6146.4 5815.5 5936.9 6053.8 6071.5 6075.5 5202.5 5922.0 5995.2 6014.9 6039.8 5121.6 5242.3 5254.8 5256.2 5258.7 25388.0 25880.4 25930.6 26114.3 26238.1 2278.0 2338.7 2395.7 2515.5 2876.1 10197.2 11939.8 15335.2 15399.4 15726.8 1846.9 1918.4 1926.6 1943.8 1949.7 112643.0 113730.0 115235.0 117504.0 128973.7 11187.9 11324.2 11479.9 11536.9 11736.0 12734.0 13281.6 13644.8 14349.4 14362.1 8430.5 8521.8 8591.7 8715.7 8729.6 8455.7 8459.4 8481.5 8644.6 8690.8 4351.9 4442.6 4446.4 4507.8 4527.6 1868.6 1880.8 1896.4 1900.4 1938.7 806.5 819.7 873.7 876.8 908.5 20023.1 21164.4 21638.0 21729.6 21747.6 913.9 917.6 920.6 933.5 934.7 10811.4 11399.4 11405.4 11405.9 11477.0 528654.0 528890.0 532745.0 548875.0 550302.0 107844.0 120086.4 121125.0 125635.0 128409.0 909.8 942.1 969.0 970.0 971.3 18674.0 18702.7 18861.6 18924.6 19348.0 51162.5 52019.0 52028.5 52346.7 52618.7 73846.3 74364.6 75210.6 76751.0 77633.0 5248.0 5248.8 6653.5 7709.8 7827.3 8957.3 10304.4 11498.3 12290.8 12482.9 10636.8 10874.7 10896.1 10950.1 10999.5 10374.3 11051.9 11142.3 11256.4 11295.0 11197.7 11216.5 11292.7 11329.5 11592.1 7796.9 8002.2 8012.4 8179.9 8414.8 9666.4 10352.7 10781.6 10991.9 10995.8 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | [#3] mootools.html Cycles:180 Average:5652.13 Median:4909.40 stddev:3202.98 (65.2%) stddev-sans-first:3195.59 01:44:20 INFO - PROCESS | 2847 | Values: 1343.6 1356.2 1503.1 1696.7 1902.7 7764.5 8639.6 8857.3 8888.4 8971.2 7339.9 8728.2 8829.9 8835.7 8838.6 2378.1 2403.7 2407.8 2413.1 2414.1 2327.2 2367.3 2370.9 2372.8 2384.2 2335.3 2362.2 2364.4 2364.6 2372.6 2312.1 2341.4 2347.1 2354.4 2357.0 2318.1 2337.4 2339.3 2340.4 2354.0 8693.8 8766.3 8886.0 8899.6 8906.2 5278.4 5468.3 5490.8 5492.6 5507.0 2902.8 3549.6 3607.1 3621.0 3715.2 893.6 1010.2 1053.0 1096.8 1106.0 11723.2 11770.8 11827.2 11850.9 11864.3 3797.7 4399.8 4508.9 4638.2 4647.2 9207.0 9208.3 9217.9 9219.4 9234.5 5277.2 5292.8 5300.9 5308.5 5310.5 4461.4 4632.3 4804.4 4919.0 4980.0 3744.9 3783.7 3876.2 3894.7 3899.5 1154.9 1161.6 1164.8 1169.3 1169.5 809.6 833.3 870.2 886.2 908.3 5644.7 5750.2 5866.5 5955.0 6185.8 433.9 438.3 443.5 453.3 454.0 3259.3 3755.7 3927.2 4008.7 4100.3 10141.9 10554.2 10869.8 10887.8 10894.8 8845.3 10640.0 10795.7 10820.9 10834.9 8260.8 8265.7 8267.4 8279.6 8391.1 5508.9 5986.3 5993.9 6128.5 6329.8 9747.4 9782.0 9928.1 10106.7 10191.7 8533.9 8835.6 10244.6 10368.3 10391.6 7265.8 7442.3 7484.3 7611.2 7668.9 8432.6 8512.9 8526.1 8529.8 8533.0 7342.0 7399.7 7415.3 7641.9 7717.3 7329.9 7411.3 7433.7 7440.7 7485.5 6921.2 7047.5 7054.8 7060.0 7067.6 4184.5 4670.6 4886.0 4898.3 4899.8 5002.5 5032.3 5064.2 5126.1 5131.1 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | [#4] prototype.html Cycles:180 Average:4448.71 Median:4970.85 stddev:1360.62 (27.4%) stddev-sans-first:1327.40 01:44:20 INFO - PROCESS | 2847 | Values: 248.3 264.9 297.7 301.1 311.6 4574.5 4940.9 5179.4 5239.6 5333.9 4118.6 4191.1 4892.6 5082.9 5083.4 3514.8 3690.3 3910.5 3981.7 4009.3 3654.4 3950.6 3959.8 3983.6 3986.3 3247.5 3445.6 3794.4 3951.4 3971.2 3758.6 3908.1 3962.6 4004.4 4008.5 3487.4 3490.3 3496.2 3496.6 3534.9 4976.0 5112.7 5126.3 5132.3 5151.5 4531.1 4580.6 4583.9 4599.0 4613.5 5217.7 5396.6 5500.3 5561.8 5592.7 3700.5 3765.4 3862.9 3891.6 3916.5 4902.5 4965.7 5605.5 5621.5 5747.4 3508.0 3904.4 3915.6 3931.0 3935.4 3758.4 3892.8 3991.2 3991.3 3992.7 4495.7 4516.1 4540.6 4567.0 4600.9 4645.9 5180.1 5589.7 5598.8 5611.2 1052.5 1235.6 1293.6 1318.9 1335.3 897.2 907.2 929.0 930.7 935.7 4675.8 5036.5 5077.6 5098.8 5101.9 5464.1 5558.3 5563.9 5582.9 5592.9 4392.7 4675.4 4956.7 5012.7 5016.0 2612.7 2816.1 2877.3 2914.7 3057.0 5781.1 5815.0 5831.7 5838.6 5881.4 4619.8 4983.9 5320.4 5532.5 5556.3 5841.9 5847.6 5879.5 5882.3 5898.0 5057.4 5659.9 5665.5 5724.4 5799.9 5349.6 5518.8 5551.9 5608.4 5681.7 4835.7 5176.6 5791.0 5867.3 5997.8 3363.8 3723.8 3790.6 3826.1 3859.0 4896.4 5531.7 5617.2 5635.7 5718.9 5276.6 5466.4 5478.6 5491.3 5584.8 4857.2 5505.9 5535.3 5545.6 5587.9 4281.6 4621.0 4739.9 5057.6 5420.8 5449.4 5462.8 5498.4 5504.3 5518.2 4359.5 4681.7 5097.8 5478.1 5507.5 01:44:20 INFO - PROCESS | 2847 | 01:44:20 INFO - PROCESS | 2847 | [#5] yui.html Cycles:180 Average:24588.70 Median:3572.13 stddev:39282.31 (1099.7%) stddev-sans-first:39351.82 01:44:20 INFO - PROCESS | 2847 | Values: 777.9 790.2 800.3 806.2 817.4 15302.2 16258.5 16260.3 16276.5 16307.2 14579.0 14692.1 14692.2 14706.9 14710.7 670.6 687.2 836.0 842.8 859.7 860.5 862.5 875.3 875.5 877.7 924.9 926.0 926.6 927.3 927.5 703.7 722.8 917.7 918.6 920.5 541.5 541.7 648.6 668.0 669.4 14809.5 14829.3 14830.3 14832.6 14849.4 13240.7 13706.5 13985.5 14250.7 14539.6 12472.5 12798.8 13036.4 13158.3 13203.9 4089.0 4600.6 4610.3 4768.5 4806.8 116280.0 118277.4 118423.2 118619.2 122592.0 10944.6 11047.9 11212.0 11369.2 11487.3 22697.0 22726.9 22741.4 22746.0 22764.9 7652.9 7816.7 7915.4 7937.7 8066.8 4235.0 4325.9 4380.5 4495.9 4506.3 3447.0 3571.9 3572.3 3574.7 3578.2 619.9 636.0 652.2 661.6 662.5 538.6 559.1 600.2 600.3 620.7 7988.7 8214.8 8314.6 9047.5 9224.7 549.5 552.2 612.6 617.1 636.4 4056.6 4424.2 4426.4 4491.4 4567.4 146025.0 156290.5 156720.2 159185.0 159265.0 80226.0 80851.6 93006.5 104830.0 123136.0 109786.0 110053.0 111195.3 111936.0 112364.0 8114.4 8273.8 8532.4 8541.1 8719.9 65368.7 65379.0 66059.0 66102.0 66561.0 78765.6 96472.5 100332.0 101663.0 105004.0 8972.3 10070.6 10252.3 11081.3 11734.7 12228.3 12244.3 12277.4 12646.2 12845.5 10526.6 12296.9 13845.8 14521.9 14739.7 12390.3 13119.2 13449.9 13641.2 13819.9 13549.9 13758.6 13878.7 13895.4 13927.8 11235.3 11360.4 11577.9 11601.0 11725.2 11427.0 11451.7 11500.7 11691.9 11710.6 01:44:20 INFO - PROCESS | 2847 | -------- Summary: end -------- 01:44:20 INFO - PROCESS | 2847 | 01:44:21 INFO - TEST-INFO | 2847: exit 0 01:44:21 INFO - TEST-OK | dromaeo_css | took 1118029ms 01:44:21 INFO - TEST-START | kraken 01:44:21 INFO - operating with platform_type : mac_ 01:44:21 INFO - Initialising browser for kraken test... 01:44:21 INFO - TEST-INFO | started process 2851 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpGxw9GD/profile http://localhost:61379/getInfo.html) 01:44:23 INFO - PROCESS | 2851 | __metrics Screen width/height:1600/1200 01:44:23 INFO - PROCESS | 2851 | colorDepth:24 01:44:23 INFO - PROCESS | 2851 | Browser inner width/height: 1024/689 01:44:23 INFO - PROCESS | 2851 | __metrics 01:44:23 INFO - PROCESS | 2851 | 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" 01:44:23 INFO - PROCESS | 2851 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:44:24 INFO - TEST-INFO | 2851: exit 0 01:44:24 INFO - Browser initialized. 01:44:24 INFO - Running cycle 1/1 for kraken test... 01:44:24 INFO - TEST-INFO | started process 2852 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpGxw9GD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:36 INFO - PROCESS | 2852 | RSS: Main: 232480768 01:44:36 INFO - PROCESS | 2852 | 01:44:39 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61379/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:40 INFO - PROCESS | 2852 | RSS: Main: 292311040 01:44:40 INFO - PROCESS | 2852 | 01:44:42 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61379/tests/kraken/driver.html?testName=audio-dft) 01:44:43 INFO - PROCESS | 2852 | RSS: Main: 288415744 01:44:43 INFO - PROCESS | 2852 | 01:44:46 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61379/tests/kraken/driver.html?testName=audio-fft) 01:44:47 INFO - PROCESS | 2852 | RSS: Main: 374423552 01:44:47 INFO - PROCESS | 2852 | 01:44:49 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61379/tests/kraken/driver.html?testName=audio-oscillator) 01:44:50 INFO - PROCESS | 2852 | RSS: Main: 278818816 01:44:50 INFO - PROCESS | 2852 | 01:44:52 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:44:52 INFO - PROCESS | 2852 | RSS: Main: 283553792 01:44:52 INFO - PROCESS | 2852 | 01:44:55 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61379/tests/kraken/driver.html?testName=imaging-darkroom) 01:44:56 INFO - PROCESS | 2852 | RSS: Main: 321048576 01:44:56 INFO - PROCESS | 2852 | 01:44:59 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61379/tests/kraken/driver.html?testName=imaging-desaturate) 01:44:59 INFO - PROCESS | 2852 | RSS: Main: 321548288 01:44:59 INFO - PROCESS | 2852 | 01:45:02 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61379/tests/kraken/driver.html?testName=json-parse-financial) 01:45:03 INFO - PROCESS | 2852 | RSS: Main: 320458752 01:45:03 INFO - PROCESS | 2852 | 01:45:04 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:05 INFO - PROCESS | 2852 | RSS: Main: 298573824 01:45:05 INFO - PROCESS | 2852 | 01:45:07 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:08 INFO - PROCESS | 2852 | RSS: Main: 303968256 01:45:08 INFO - PROCESS | 2852 | 01:45:10 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:10 INFO - PROCESS | 2852 | RSS: Main: 297762816 01:45:10 INFO - PROCESS | 2852 | 01:45:13 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:14 INFO - PROCESS | 2852 | RSS: Main: 310743040 01:45:14 INFO - PROCESS | 2852 | 01:45:17 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:18 INFO - PROCESS | 2852 | RSS: Main: 313286656 01:45:18 INFO - PROCESS | 2852 | 01:45:19 INFO - PROCESS | 2852 | Cycle 1(1): loaded http://localhost:61379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61379/tests/kraken/driver.html?testName=ai-astar) 01:45:20 INFO - PROCESS | 2852 | RSS: Main: 357109760 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | __start_tp_report 01:45:20 INFO - PROCESS | 2852 | _x_x_mozilla_page_load 01:45:20 INFO - PROCESS | 2852 | _x_x_mozilla_page_load_details 01:45:20 INFO - PROCESS | 2852 | |i|pagename|runs| 01:45:20 INFO - PROCESS | 2852 | |0;ai-astar;113;114;119;114;114;114;113;113;113;125 01:45:20 INFO - PROCESS | 2852 | |1;audio-beat-detection;158;139;170;171;106;132;129;113;164;109 01:45:20 INFO - PROCESS | 2852 | |2;audio-dft;187;184;181;184;183;187;183;184;184;182 01:45:20 INFO - PROCESS | 2852 | |3;audio-fft;77;76;76;156;59;60;63;94;163;73 01:45:20 INFO - PROCESS | 2852 | |4;audio-oscillator;83;84;133;70;71;79;119;69;70;121 01:45:20 INFO - PROCESS | 2852 | |5;imaging-gaussian-blur;88;85;88;86;87;84;87;85;86;86 01:45:20 INFO - PROCESS | 2852 | |6;imaging-darkroom;94;94;93;93;93;93;93;93;93;92 01:45:20 INFO - PROCESS | 2852 | |7;imaging-desaturate;103;134;136;84;85;86;84;85;83;83 01:45:20 INFO - PROCESS | 2852 | |8;json-parse-financial;53;53;56;56;55;55;54;53;53;73 01:45:20 INFO - PROCESS | 2852 | |9;json-stringify-tinderbox;66;68;73;76;70;68;68;70;72;69 01:45:20 INFO - PROCESS | 2852 | |10;stanford-crypto-aes;85;85;85;89;100;80;82;84;86;85 01:45:20 INFO - PROCESS | 2852 | |11;stanford-crypto-ccm;138;152;132;160;161;151;140;141;235;139 01:45:20 INFO - PROCESS | 2852 | |12;stanford-crypto-pbkdf2;168;172;168;167;173;170;167;162;160;221 01:45:20 INFO - PROCESS | 2852 | |13;stanford-crypto-sha256-iterative;67;67;68;66;68;68;65;67;67;66 01:45:20 INFO - PROCESS | 2852 | __end_tp_report 01:45:20 INFO - PROCESS | 2852 | __start_cc_report 01:45:20 INFO - PROCESS | 2852 | _x_x_mozilla_cycle_collect,2003 01:45:20 INFO - PROCESS | 2852 | __end_cc_report 01:45:20 INFO - PROCESS | 2852 | __startTimestamp1473410720046__endTimestamp 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | ------- Summary: start ------- 01:45:20 INFO - PROCESS | 2852 | Number of tests: 14 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#0] ai-astar Cycles:10 Average:115.20 Median:114.00 stddev:3.88 (3.4%) stddev-sans-first:4.03 01:45:20 INFO - PROCESS | 2852 | Values: 113.0 114.0 119.0 114.0 114.0 114.0 113.0 113.0 113.0 125.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:148.50 stddev:25.35 (17.1%) stddev-sans-first:25.95 01:45:20 INFO - PROCESS | 2852 | Values: 158.0 139.0 170.0 171.0 106.0 132.0 129.0 113.0 164.0 109.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.91 (1.0%) stddev-sans-first:1.67 01:45:20 INFO - PROCESS | 2852 | Values: 187.0 184.0 181.0 184.0 183.0 187.0 183.0 184.0 184.0 182.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#3] audio-fft Cycles:10 Average:89.70 Median:74.50 stddev:38.21 (51.3%) stddev-sans-first:40.25 01:45:20 INFO - PROCESS | 2852 | Values: 77.0 76.0 76.0 156.0 59.0 60.0 63.0 94.0 163.0 73.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:70.50 stddev:24.63 (34.9%) stddev-sans-first:26.00 01:45:20 INFO - PROCESS | 2852 | Values: 83.0 84.0 133.0 70.0 71.0 79.0 119.0 69.0 70.0 121.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.50 stddev:1.32 (1.5%) stddev-sans-first:1.22 01:45:20 INFO - PROCESS | 2852 | Values: 88.0 85.0 88.0 86.0 87.0 84.0 87.0 85.0 86.0 86.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 01:45:20 INFO - PROCESS | 2852 | Values: 94.0 94.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 92.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:84.00 stddev:21.24 (25.3%) stddev-sans-first:22.39 01:45:20 INFO - PROCESS | 2852 | Values: 103.0 134.0 136.0 84.0 85.0 86.0 84.0 85.0 83.0 83.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:6.06 (11.0%) stddev-sans-first:6.33 01:45:20 INFO - PROCESS | 2852 | Values: 53.0 53.0 56.0 56.0 55.0 55.0 54.0 53.0 53.0 73.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:2.94 (4.2%) stddev-sans-first:2.74 01:45:20 INFO - PROCESS | 2852 | Values: 66.0 68.0 73.0 76.0 70.0 68.0 68.0 70.0 72.0 69.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.00 stddev:5.43 (6.4%) stddev-sans-first:5.74 01:45:20 INFO - PROCESS | 2852 | Values: 85.0 85.0 85.0 89.0 100.0 80.0 82.0 84.0 86.0 85.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#11] stanford-crypto-ccm Cycles:10 Average:154.90 Median:151.50 stddev:29.78 (19.7%) stddev-sans-first:30.95 01:45:20 INFO - PROCESS | 2852 | Values: 138.0 152.0 132.0 160.0 161.0 151.0 140.0 141.0 235.0 139.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:169.00 stddev:17.40 (10.3%) stddev-sans-first:18.37 01:45:20 INFO - PROCESS | 2852 | Values: 168.0 172.0 168.0 167.0 173.0 170.0 167.0 162.0 160.0 221.0 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - PROCESS | 2852 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 01:45:20 INFO - PROCESS | 2852 | Values: 67.0 67.0 68.0 66.0 68.0 68.0 65.0 67.0 67.0 66.0 01:45:20 INFO - PROCESS | 2852 | -------- Summary: end -------- 01:45:20 INFO - PROCESS | 2852 | 01:45:20 INFO - TEST-INFO | 2852: exit 0 01:45:20 INFO - TEST-OK | kraken | took 59243ms 01:45:20 INFO - SUITE-END | took 1177s 01:45:21 INFO - Completed test suite (00:19:37) 01:45:21 INFO - javascript benchmark 01:45:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.2211947013247, 3261.575995120634, 3286.605607327121, 3327.151576348034, 3346.832658367081, 5563.749631266593, 5657.773689052438, 5709.685967271798, 5710.486056254931, 5774.335951365589, 5574.470425309589, 5639.407862174474, 5650.237217975572, 5661.094224924002, 5661.46216109469, 5163.586913046956, 5183.844484665447, 5199.610029247802, 5213.32226810516, 5247.422783493813, 5277.419483856773, 5277.498637629419, 5278.630495865291, 5285.445028272034, 5289.709066001368, 5206.557442617382, 5222.738863056851, 5235.162374020158, 5235.6596821206695, 5250.921236181461, 5289.920651190197, 5294.100002999499, 5300.257963885078, 5325.429122325252, 5348.759305831208, 5081.949180508184, 5103.311053007834, 5132.640715149941, 5222.895542089175, 5236.502532259429, 5666.008448521534, 5703.429657034305, 5717.142428635696, 5735.713214339308, 5790.420957904218, 6238.968805155991, 6243.687815609247, 6252.874482593132, 6255.874882502325, 6283.02613094971, 6106.0, 6194.5354098442795, 6232.9065064023625, 6237.7816776413065, 6263.4989200864275, 5828.329742079631, 5857.88284234313, 5877.177195192677, 5877.735501902467, 5882.000059989812, 6267.9373206267355, 6276.403741644536, 6287.717052732638, 6287.842803929847, 6291.874162516724, 6018.909716354258, 6054.243219597551, 6055.545834062463, 6147.354527774609, 6171.352008039091, 6132.233470816148, 6173.876522469525, 6175.320714721377, 6181.258249010148, 6185.938140618626, 6076.422739839708, 6130.846728831726, 6142.232220972379, 6173.9073913891325, 6181.660008699565, 6105.975331700744, 6114.297368146176, 6118.479929205978, 6196.969015154896, 6197.597156184834, 4908.337374454403, 4933.3586633738105, 4943.678660887031, 4944.9258261126115, 4946.282788995575, 4055.5538890721996, 4389.846355377546, 4414.580614841585, 4417.53615870329, 4479.17135329965, 5640.012997725382, 5657.858553536113, 5707.514861236758, 5712.428757124338, 5761.654300741969, 6131.896637733196, 6175.62946223228, 6176.0, 6202.100695399142, 6208.379162083756, 5641.153826925994, 5663.037283661787, 5672.4611161940375, 5674.092145256739, 5682.232898558642, 5408.945910540923, 5417.349918009864, 5426.104692725656, 5426.158945363475, 5446.319210098738, 5271.762770675329, 6381.489480841522, 6390.488760899024, 6399.104125422445, 6407.423331900151, 5101.642884998163, 6239.438450539473, 6253.906191407042, 6263.530235232284, 6286.18279623646, 6184.907226391518, 6235.96882015587, 6354.777582784581, 6374.968125159345, 6380.425761681471, 6130.826205142237, 6196.1635179250225, 6200.906986395117, 6232.096346029891, 6235.906461403173, 6244.718987645658, 6246.812595622138, 6253.218347706536, 6259.530535209969, 6271.874562508816, 6001.609895356788, 6154.723037463415, 6166.660833654013, 6169.0, 6169.660668663267, 6014.849628759316, 6094.177286066324, 6094.908576371269, 6098.298695650057, 6165.876682466415, 5131.717755523333, 6027.457528822427, 6032.819015429544, 6037.939620603914, 6062.363451837494, 6118.0, 6148.139260503623, 6148.938510614837, 6151.538634602333, 6167.938320616737, 5701.914471282851, 5819.388964158702, 5913.142594323713, 5945.672987985529, 5954.136650185786], "value": 5683.353615306259, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.9546205155581, 501.0, 509.77824646278873, 512.6513970500058, 525.6399366433993, 29995.25011874704, 30824.38351232977, 39874.40188397176, 41005.10451507102, 41252.58747412533, 41900.16199676005, 42165.367519487234, 42175.36736948948, 42202.94492637678, 42326.0, 9715.708528744131, 9908.801823963517, 9916.0, 9923.454210018446, 9931.801363972716, 8772.956135219314, 8982.416142950688, 11963.042956563455, 12176.147669663083, 12217.328046957413, 10461.599980006491, 12026.15816892818, 12158.331291778948, 12270.263784172934, 12276.140670153092, 12167.209131406475, 12294.262344259329, 12297.69255768604, 12316.753664926651, 12321.199122057038, 10111.544980475823, 11948.103892208032, 11956.581519646857, 12051.758964820654, 12066.336351500664, 39642.60357396418, 39846.402303965464, 39897.80051099755, 39925.0, 39933.40099898504, 3333.966660333414, 3365.6802603752603, 3479.9826000869834, 3541.220931395089, 3760.304343696425, 30287.091387258417, 30686.0, 31351.216219594466, 31579.684203158133, 31585.842070789728, 3219.500977348515, 3321.136504508821, 3367.612724536685, 3396.5414669019615, 3406.3357645259184, 425475.0, 425908.0, 432221.0, 435694.0, 439159.0, 57338.0, 57460.42539574551, 57564.0, 57772.0, 57869.0, 59895.700521497114, 59925.40074599198, 59983.700081499315, 60037.0, 60039.09941350883, 16050.277737501607, 16278.43025494102, 16281.837181628269, 16307.918460407622, 16316.75524867128, 11372.772544549229, 11624.825627615592, 12412.62762117138, 12478.5008599655, 12511.249325040344, 15434.614134646723, 15851.365945362288, 15876.285567149505, 16217.756733649005, 16250.593735156715, 5406.972965135149, 6416.165898433267, 6507.642079685568, 6575.191822248919, 6608.140941677551, 856.8072183758729, 914.131575003749, 927.6614035876992, 949.5774380400655, 1006.2805094357423, 27723.306917327227, 28500.857495712804, 29475.852620736758, 29538.852305738335, 30377.0, 1054.509653011338, 1065.6856227412932, 1094.6168840905618, 1127.4419162514607, 1153.455385780024, 14688.0, 15315.792101452715, 15399.384024638888, 15436.151011694465, 15876.285567149505, 576108.0, 588280.1757973634, 592025.0, 613391.0, 631684.0, 45018.32472512915, 55415.445845541835, 55932.720336398874, 59155.11267330994, 59325.703371482865, 1255.378587599126, 1348.676317683749, 1365.2013572060257, 1385.0512399006714, 1393.3799459240743, 29269.707302926698, 30052.402486999028, 31156.688433115378, 31687.52468712925, 31793.0, 48826.02347953092, 49361.753191233816, 49439.0, 49507.50492495029, 49537.0, 538401.0, 541912.0, 544467.0, 551955.0, 555850.0, 38338.84983450501, 38795.6120438792, 39191.60808391879, 39281.607183927794, 39479.0, 46579.53420465752, 46582.53417465917, 47542.52457475381, 47672.04655906932, 47835.80410489766, 38868.0, 38952.6104738949, 39348.0, 39596.604033959295, 40398.39402408907, 35939.28121437609, 38798.6120138795, 38874.80562597169, 39574.60425395824, 40175.59824401836, 36961.07597310089, 37691.81154094212, 38193.618063819005, 38221.853344399715, 38316.80841595774, 31616.683833162293, 31644.0, 32503.349933001682, 33736.98789036333, 34229.828850855585, 24967.250982470556, 24978.875105624356, 25014.624780627943, 25572.488550229264, 25635.10277140291], "value": 20146.355842955298, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.1013570463171, 360.4107284589696, 374.64783103882365, 376.6911132871046, 406.07820248036955, 14339.64150896228, 15071.924640376796, 20724.171033158695, 20873.956302184906, 21099.2615258466, 20250.39248822534, 20276.898615506903, 20906.68639970398, 20910.581788364223, 21160.4709882253, 5835.620684655494, 6176.691165441733, 6183.876322473548, 6196.535259855506, 6207.0, 6076.513878889678, 6081.300650425192, 6125.632462052291, 6131.662758548278, 6146.446819786218, 5815.534757219412, 5936.940630593682, 6053.757849686007, 6071.51427885768, 6075.45320921117, 5202.505761952609, 5922.0, 5995.2206213192, 6014.909776353358, 6039.849003774897, 5121.564667003309, 5242.318498595197, 5254.789808407697, 5256.2391598814065, 5258.684478931238, 25387.984480620755, 25880.352991175183, 25930.611040834403, 26114.347141321618, 26238.08166714175, 2277.9772202278095, 2338.695969523968, 2395.6646069550275, 2515.4717509323063, 2876.122782551321, 10197.235207359403, 11939.761204775943, 15335.23323833815, 15399.442603567986, 15726.764098538531, 1846.8614853886013, 1918.3765276285262, 1926.6146770645928, 1943.815337542931, 1949.6685563454105, 112643.0, 113730.0, 115235.0, 117504.0, 128973.7102628971, 11187.94406027981, 11324.207305488537, 11479.942600287111, 11536.94231528837, 11736.0, 12734.0, 13281.605431429562, 13644.795328070088, 14349.426022958965, 14362.066465679698, 8430.536320502308, 8521.829563408697, 8591.65633374658, 8715.738527844174, 8729.563521823884, 8455.66177352899, 8459.365547583955, 8481.533515656698, 8644.56777161152, 8690.78273043179, 4351.934720979188, 4442.577955094261, 4446.421965144576, 4507.8196872124745, 4527.645624275358, 1868.60906285365, 1880.7837098733546, 1896.4405500377422, 1900.4203717865907, 1938.70919362094, 806.5402720449405, 819.692615269274, 873.6592728835759, 876.8377850097752, 908.5366463103733, 20023.09896054652, 21164.36506904795, 21638.0, 21729.565408692055, 21747.565048699253, 913.9131782480654, 917.6008436330085, 920.5857364186143, 933.4725879877848, 934.6822080492665, 10811.35131892089, 11399.373034483016, 11405.429728513542, 11405.885941140483, 11477.024452921596, 528654.0, 528890.0, 532745.0, 548875.0, 550302.0, 107844.0, 120086.3995680016, 121125.0, 125635.0, 128409.0, 909.8453262945183, 942.1473566422399, 968.9563969621383, 969.9612015519441, 971.3055165556802, 18674.0, 18702.719459208394, 18861.622767544297, 18924.621507570046, 19348.032598370308, 51162.488375115776, 52019.0, 52028.47971520236, 52346.69133271699, 52618.73690631522, 73846.26153738394, 74364.62817686093, 75210.62394687992, 76751.0, 77633.0, 5247.9737601311745, 5248.763805628832, 6653.534252602465, 7709.804980228074, 7827.25641064098, 8957.328200384867, 10304.433256170983, 11498.25261358009, 12290.75418491643, 12482.937585312378, 10636.787264254826, 10874.67375978722, 10896.128309735044, 10950.06924411434, 10999.450027498753, 10374.325668831501, 11051.889481105087, 11142.27575207609, 11256.364524067945, 11295.0, 11197.66407007791, 11216.495257713259, 11292.717682058013, 11329.490172942073, 11592.072634189077, 7796.88304675419, 8002.239787220205, 8012.399070069885, 8179.877301840596, 8414.831703365777, 9666.371685840399, 10352.741181470523, 10781.62264320745, 10991.900809918945, 10995.780084398428], "value": 9467.469528836978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.5902049874785, 1356.2472827580693, 1503.1432083712284, 1696.7370057641062, 1902.657521646103, 7764.53412795232, 8639.568021598918, 8857.291416686665, 8888.422252553588, 8971.192592666659, 7339.926600734005, 8728.214460698537, 8829.940407151134, 8835.734927952155, 8838.602262898168, 2378.1319818266293, 2403.6875206223167, 2407.831451798375, 2413.095089341497, 2414.1188466209883, 2327.1622216002224, 2367.3134790910703, 2370.9170179043736, 2372.79831214347, 2384.237044145874, 2335.2643917166038, 2362.1850461590725, 2364.4207169243473, 2364.609839376501, 2372.620380739082, 2312.1213938703186, 2341.3610472669116, 2347.119830063726, 2354.3996280948336, 2357.045396614374, 2318.119114736406, 2337.415646088478, 2339.3332900123382, 2340.4499942513494, 2354.023080421623, 8693.826123477495, 8766.342524310703, 8886.0, 8899.644014239422, 8906.198442140174, 5278.419373868871, 5468.2891224141, 5490.80782172622, 5492.642978206404, 5506.972465137648, 2902.8258304501587, 3549.5563054618174, 3607.080194550399, 3621.004223838439, 3715.20123173519, 893.6425429828056, 1010.161565900301, 1053.0259509953262, 1096.780643871229, 1105.983410248847, 11723.237989530653, 11770.764584708344, 11827.172097953147, 11850.933415992602, 11864.288142711379, 3797.6771974381936, 4399.802008909607, 4508.864734057984, 4638.2115040443205, 4647.1635105680625, 9207.0, 9208.309376796768, 9217.907820921839, 9219.400738951947, 9234.538273086318, 5277.182036784305, 5292.761825717852, 5300.893982120336, 5308.548773354231, 5310.52205301517, 4461.442319710036, 4632.328312394684, 4804.375431193992, 4919.0, 4980.0, 3744.8876533704033, 3783.6594706476, 3876.1666241757594, 3894.727369084137, 3899.4930659014713, 1154.9076073914066, 1161.5760247509597, 1164.8194529847888, 1169.345166706647, 1169.5321871251567, 809.554744890308, 833.3250067445267, 870.2428886868465, 886.2024178239507, 908.3232991421434, 5644.74598643062, 5750.221027867051, 5866.501347385435, 5954.970225148846, 6185.8453538661, 433.92406328892315, 438.3271677974358, 443.46783859368884, 453.31096732966364, 453.9773011349419, 3259.2992506611195, 3755.6995440364703, 3927.2145570885937, 4008.6993475489453, 4100.282450571198, 10141.898581014242, 10554.208434367452, 10869.83695244572, 10887.782244355069, 10894.782104357868, 8845.336599755045, 10640.0, 10795.730106747395, 10820.945895270474, 10834.891651083546, 8260.793480163044, 8265.710700125466, 8267.421280510307, 8279.586020699062, 8391.076981532027, 5508.862278443071, 5986.341502434816, 5993.910091348721, 6128.479079278133, 6329.810105696836, 9747.415155090717, 9781.951090244787, 9928.056834600702, 10106.747331316776, 10191.694249172537, 8533.914660853312, 8835.64657413722, 10244.590216391261, 10368.326058806153, 10391.58433662645, 7265.818354541178, 7442.255774422731, 7484.288992545699, 7611.200823913409, 7668.923310766821, 8432.578371081545, 8512.914870851213, 8526.147385261424, 8529.82940341202, 8533.018702849004, 7342.0, 7399.667014984231, 7415.3326200642205, 7641.923580764121, 7717.305442510201, 7329.9267007329245, 7411.295926886937, 7433.665485053078, 7440.73957411488, 7485.513441626495, 6921.2386637468835, 7047.471439641945, 7054.788356349318, 7060.046893669289, 7067.646617668993, 4184.539700632989, 4670.579647831712, 4885.975570122127, 4898.2652602109965, 4899.804007839789, 5002.549770520671, 5032.3206367139965, 5064.215046667772, 5126.102931986962, 5131.102057139911], "value": 4446.602976826224, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [248.33322529009598, 264.9362808324576, 297.6859413318948, 301.0817008125219, 311.56692197845, 4574.519675434081, 4940.851774446764, 5179.430262671103, 5239.554637855782, 5333.866653333664, 4118.6499147572495, 4191.113998700582, 4892.633052521057, 5082.872928176797, 5083.389993200821, 3514.7715398499145, 3690.2988432197794, 3910.491636087305, 3981.7013723970745, 4009.298372784751, 3654.3604869147925, 3950.6444420002194, 3959.8318496043594, 3983.56180820111, 3986.269405457271, 3247.480403135499, 3445.586529616437, 3794.4308353746883, 3951.38753493209, 3971.225611005855, 3758.642928921748, 3908.140209153996, 3962.623550762673, 4004.3993400989793, 4008.478897743304, 3487.4420092785285, 3490.3193877193958, 3496.2133519957806, 3496.5629296337956, 3534.9422749321907, 4976.0, 5112.744362781846, 5126.307948426989, 5132.28148059272, 5151.459096794858, 4531.071130418256, 4580.610648094883, 4583.862484125481, 4598.954010459919, 4613.469451013143, 5217.660852044605, 5396.5952553558245, 5500.312460942382, 5561.805336813232, 5592.748326325325, 3700.4634328022285, 3765.3975363941913, 3862.8841134766003, 3891.610838916114, 3916.471276377681, 4902.534259245402, 4965.702057876503, 5605.495505404533, 5621.522170615503, 5747.396523365028, 3508.0, 3904.4338570907057, 3915.5888631693833, 3931.0, 3935.409688546741, 3758.4362345648374, 3892.766434013968, 3991.1818077294083, 3991.2815693174925, 3992.7005474589523, 4495.707778994355, 4516.103236640619, 4540.568645978627, 4566.995261042565, 4600.907981840412, 4645.907081858344, 5180.119379705459, 5589.720513974366, 5598.804041858515, 5611.186377975252, 1052.5158427123608, 1235.5860786636576, 1293.6248487938392, 1318.8878945289757, 1335.3056410666593, 897.2328658996595, 907.2333877873186, 928.9581968811419, 930.7068273493828, 935.733316004949, 4675.7895894684825, 5036.521530454601, 5077.568406685473, 5098.776293689488, 5101.8724531886255, 5464.0711079116645, 5558.33300003994, 5563.860903477445, 5582.860428489239, 5592.916106258409, 4392.692511524163, 4675.392199014106, 4956.653034287565, 5012.724300163526, 5015.974920125449, 2612.6995395529757, 2816.0988483685023, 2877.338212211203, 2914.6502419709773, 3057.0, 5781.103928891029, 5814.982378083903, 5831.7375718091935, 5838.620489668158, 5881.353051164454, 4619.792109355087, 4983.875403114951, 5320.388155362183, 5532.5020748132865, 5556.277424062261, 5841.94158058414, 5847.56143289255, 5879.470847623649, 5882.294124705063, 5898.0, 5057.393112826484, 5659.893975523633, 5665.518430933417, 5724.3936320118055, 5799.884002320015, 5349.572034237174, 5518.751656175562, 5551.916721249266, 5608.383077861514, 5681.659100453986, 4835.734034628129, 5176.637635365489, 5791.0, 5867.295924489089, 5997.840777320074, 3363.764536482423, 3723.7525428981594, 3790.6209379061875, 3826.0626146594263, 3859.0, 4896.387951506062, 5531.7234138293725, 5617.247548701189, 5635.690037048002, 5718.885622287614, 5276.577873770012, 5466.426025267289, 5478.56236448478, 5491.28613280271, 5584.832455026356, 4857.1742803724155, 5505.889882202414, 5535.280413546213, 5545.556355491632, 5587.916181257366, 4281.608477244846, 4620.983383655591, 4739.857804265877, 5057.620678449058, 5420.83737487876, 5449.400565937823, 5462.754176062007, 5498.367687715804, 5504.311961004874, 5518.227448157181, 4359.520452750258, 4681.735931298598, 5097.847064588068, 5478.083170533088, 5507.476789704971], "value": 4010.42307335814, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.8669599770109, 790.2216316927825, 800.3477166109617, 806.1776987472778, 817.3747083481138, 15302.158381289024, 16258.51224463265, 16260.268287927041, 16276.51170464888, 16307.184640767959, 14578.979471437004, 14692.118472891634, 14692.191929443876, 14706.926465367658, 14710.705785884276, 670.5507310102219, 687.1822531187895, 835.9749207523769, 842.7640260727006, 859.6948083430386, 860.5181098584812, 862.5126803356115, 875.3128793896792, 875.4878396138266, 877.6971944679076, 924.865894445305, 925.9675911343104, 926.5876684875233, 927.2720914082447, 927.5037854747711, 703.6903762344552, 722.7759394587695, 917.6650522559285, 918.6233644205877, 920.4983284110176, 541.4964083402434, 541.7237209023388, 648.6108334998963, 668.0113432120489, 669.3741351836048, 14809.48166814167, 14829.258537073103, 14830.258487075604, 14832.629184270372, 14849.406023759037, 13240.73518529624, 13706.45174193031, 13985.510507132201, 14250.714985700228, 14539.563813085624, 12472.501099956082, 12798.808017879739, 13036.397040567996, 13158.342082895817, 13203.933980330037, 4088.9591104088877, 4600.608948239404, 4610.2623580227, 4768.529099057028, 4806.831760888387, 116280.0, 118277.40861295724, 118423.2236516453, 118619.2207116894, 122591.99999999911, 10944.562217511211, 11047.944760276308, 11212.0, 11369.204155709187, 11487.310761354345, 22697.0, 22726.86365681709, 22741.431464213198, 22746.0, 22764.886175569347, 7652.923470765332, 7816.686040420496, 7915.366770658448, 7937.722179723682, 8066.83866322682, 4234.957650423518, 4325.891852703645, 4380.540043295472, 4495.865124046284, 4506.278995360792, 3446.965530344715, 3571.928561428757, 3572.3391172633146, 3574.7140228781636, 3578.177019285579, 619.8977168767193, 635.9682015899186, 652.1945397434165, 661.5501459007825, 662.460095022555, 538.5906710899744, 559.1361346719328, 600.2406955201674, 600.2946537818046, 620.7485968182893, 7988.680452781824, 8214.753557393287, 8314.625841837133, 9047.457152570867, 9224.672329975905, 549.4725063938664, 552.240669080015, 612.5681394616785, 617.0528239152878, 636.4431122767578, 4056.634902858757, 4424.159409712144, 4426.424564806554, 4491.393661855673, 4567.36056952027, 146025.0, 156290.52334794606, 156720.21639891955, 159185.0, 159265.0, 80226.0, 80851.59574202092, 93006.53496732473, 104830.0, 123136.0, 109786.0, 110053.0, 111195.33207001901, 111936.0, 112363.99999999837, 8114.391420643594, 8273.751787446387, 8532.360072994674, 8541.103184165573, 8719.912800872164, 65368.673156633915, 65379.0, 66059.0, 66102.0, 66561.0, 78765.60617196877, 96472.51763741137, 100332.0, 101663.0, 105004.0, 8972.28221742246, 10070.597176113166, 10252.282340236112, 11081.335119892832, 11734.70663233426, 12228.327441990776, 12244.326562039174, 12277.447514862031, 12646.241225526497, 12845.486180552673, 10526.578936842747, 12296.877031229931, 13845.792313115513, 14521.92739036298, 14739.705205896036, 12390.256584604953, 13119.212847229197, 13449.865501345254, 13641.24973126448, 13819.86180138226, 13549.932250338685, 13758.587242382744, 13878.653033674238, 13895.444182232597, 13927.791083133963, 11235.269707468988, 11360.431978401211, 11577.884221157681, 11601.0, 11725.237859539102, 11427.0, 11451.713707157387, 11500.654980350602, 11691.883081169079, 11710.648680539598], "value": 7714.128195760567, "unit": "score"}], "name": "dromaeo_css", "value": 7282.236728920173, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 119.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 125.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 139.0, 170.0, 171.0, 106.0, 132.0, 129.0, 113.0, 164.0, 109.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 181.0, 184.0, 183.0, 187.0, 183.0, 184.0, 184.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 156.0, 59.0, 60.0, 63.0, 94.0, 163.0, 73.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 133.0, 70.0, 71.0, 79.0, 119.0, 69.0, 70.0, 121.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 87.0, 84.0, 87.0, 85.0, 86.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 134.0, 136.0, 84.0, 85.0, 86.0, 84.0, 85.0, 83.0, 83.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 56.0, 56.0, 55.0, 55.0, 54.0, 53.0, 53.0, 73.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 73.0, 76.0, 70.0, 68.0, 68.0, 70.0, 72.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 89.0, 100.0, 80.0, 82.0, 84.0, 86.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 152.0, 132.0, 160.0, 161.0, 151.0, 140.0, 141.0, 235.0, 139.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 168.0, 167.0, 173.0, 170.0, 167.0, 162.0, 160.0, 221.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 68.0, 68.0, 65.0, 67.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1500.2000000000003, "alertThreshold": 2.0}]} 01:45:21 INFO - Return code: 0 01:45:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:45:21 INFO - # TBPL SUCCESS # 01:45:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:45:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:45:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:45:21 INFO - 2016-09-09 01:45:21.361 screenresolution[2856:46290] starting screenresolution argv=screenresolution get 01:45:21 INFO - 2016-09-09 01:45:21.364 screenresolution[2856:46290] Display 0: 1600x1200x32@60 01:45:21 INFO - 2016-09-09 01:45:21.370 screenresolution[2857:46293] starting screenresolution argv=screenresolution list 01:45:21 INFO - Available Modes on Display 0 01:45:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:45:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:45:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:45:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:45:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:45:21 INFO - Intel Iris: 01:45:21 INFO - Chipset Model: Intel Iris 01:45:21 INFO - Type: GPU 01:45:21 INFO - Bus: Built-In 01:45:21 INFO - VRAM (Dynamic, Max): 1536 MB 01:45:21 INFO - Vendor: Intel (0x8086) 01:45:21 INFO - Device ID: 0x0a2e 01:45:21 INFO - Revision ID: 0x0009 01:45:21 INFO - Displays: 01:45:21 INFO - Display: 01:45:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:45:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:45:21 INFO - Display Serial Number: 1600x1200 60 01:45:21 INFO - Main Display: Yes 01:45:21 INFO - Mirror: Off 01:45:21 INFO - Online: Yes 01:45:21 INFO - Rotation: Supported 01:45:21 INFO - Return code: 0 01:45:21 INFO - Running post-action listener: _resource_record_post_action 01:45:21 INFO - [mozharness: 2016-09-09 08:45:21.605545Z] Finished run-tests step (success) 01:45:21 INFO - Running post-run listener: _resource_record_post_run 01:45:21 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 270336; Write bytes: 706664960; Read time: 2; Write time: 2041 01:45:21 INFO - TinderboxPrint: CPU usage
53.3% 01:45:21 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 2 01:45:21 INFO - TinderboxPrint: I/O write bytes / time
706,664,960 / 2,041 01:45:21 INFO - TinderboxPrint: CPU idle
2,267.0 (46.7%) 01:45:21 INFO - TinderboxPrint: CPU system
966.3 (19.9%) 01:45:21 INFO - TinderboxPrint: CPU user
1,616.4 (33.3%) 01:45:21 INFO - TinderboxPrint: Swap in / out
405,348,352 / 0 01:45:21 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394064384; Write bytes: 388903936; Read time: 29297; Write time: 695 01:45:21 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 270336; Write bytes: 296982016; Read time: 2; Write time: 1302 01:45:22 INFO - Running post-run listener: _upload_blobber_files 01:45:22 INFO - Blob upload gear active. 01:45:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:45:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:45:22 INFO - (blobuploader) - INFO - Open directory for files ... 01:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:23 INFO - (blobuploader) - INFO - Done attempting. 01:45:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:45:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:45:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:26 INFO - (blobuploader) - INFO - Done attempting. 01:45:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:45:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:45:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:28 INFO - (blobuploader) - INFO - Done attempting. 01:45:28 INFO - (blobuploader) - INFO - Iteration through files over. 01:45:28 INFO - Return code: 0 01:45:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:45:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:45:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94fc0fefdb2098f3d1e6ae0fb350ab46d5192ff526c57a800d44b2f8aeb695ce4b20b5897a12209c9c57bfdf44bbcbf8734be3e20f319aaf3e779e7cb43a309a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b33de395064ec5ea73c04d5c1fd03232ab74e983c92851c68097bd3d85c6d2af120d52ce9b322d05b1ca9bd02c73e07d69146c7b18ee1174383535a568fde099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/557d9efebbe9762586dbfe6954846a4f0c0902c876b94d9ca60b19d45b00655db09e75e3bf0bd7235f395fdb8d184cd563f1f54981a35e7a7ac9dd356bc62c03"} 01:45:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:45:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:45:28 INFO - Contents: 01:45:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94fc0fefdb2098f3d1e6ae0fb350ab46d5192ff526c57a800d44b2f8aeb695ce4b20b5897a12209c9c57bfdf44bbcbf8734be3e20f319aaf3e779e7cb43a309a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b33de395064ec5ea73c04d5c1fd03232ab74e983c92851c68097bd3d85c6d2af120d52ce9b322d05b1ca9bd02c73e07d69146c7b18ee1174383535a568fde099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/557d9efebbe9762586dbfe6954846a4f0c0902c876b94d9ca60b19d45b00655db09e75e3bf0bd7235f395fdb8d184cd563f1f54981a35e7a7ac9dd356bc62c03"} 01:45:28 INFO - Running post-run listener: copy_logs_to_upload_dir 01:45:28 INFO - Copying logs to upload dir... 01:45:28 INFO - mkdir: /builds/slave/test/build/upload/logs 01:45:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.446752 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-09 01:45:29.136387) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 01:45:29.139641) ========= 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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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/94fc0fefdb2098f3d1e6ae0fb350ab46d5192ff526c57a800d44b2f8aeb695ce4b20b5897a12209c9c57bfdf44bbcbf8734be3e20f319aaf3e779e7cb43a309a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b33de395064ec5ea73c04d5c1fd03232ab74e983c92851c68097bd3d85c6d2af120d52ce9b322d05b1ca9bd02c73e07d69146c7b18ee1174383535a568fde099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/557d9efebbe9762586dbfe6954846a4f0c0902c876b94d9ca60b19d45b00655db09e75e3bf0bd7235f395fdb8d184cd563f1f54981a35e7a7ac9dd356bc62c03"} build_url:https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/NppD5RWqTl2xmhjxaWb51w/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/94fc0fefdb2098f3d1e6ae0fb350ab46d5192ff526c57a800d44b2f8aeb695ce4b20b5897a12209c9c57bfdf44bbcbf8734be3e20f319aaf3e779e7cb43a309a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b33de395064ec5ea73c04d5c1fd03232ab74e983c92851c68097bd3d85c6d2af120d52ce9b322d05b1ca9bd02c73e07d69146c7b18ee1174383535a568fde099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/557d9efebbe9762586dbfe6954846a4f0c0902c876b94d9ca60b19d45b00655db09e75e3bf0bd7235f395fdb8d184cd563f1f54981a35e7a7ac9dd356bc62c03"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-09 01:45:29.174647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 01:45:29.174962) ========= 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.z4fNTQ2ecT/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.qiBbbRjzCE/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005262 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-09 01:45:29.222902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 01:45:29.223195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-09 01:45:29.223508) ========= ========= Total master_lag: 0.18 =========