builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1472980428.07 results: success (0) buildid: 20160904003848 builduid: 056fde26f6544a3ead55da70f316765a revision: 0768e4f23ebf7ccfc7529498979e2a16dc2b39f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.075140) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.075592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.075961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.120744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.121148) ========= 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.0x5XGoQgSA/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.otNsG0tPBK/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-04 02:13:48-- 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.29M=0.001s 2016-09-04 02:13:48 (8.29 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.597938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.741938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.742275) ========= 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.0x5XGoQgSA/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.otNsG0tPBK/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.020998 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:48.791455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-04 02:13:48.791843) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0768e4f23ebf7ccfc7529498979e2a16dc2b39f4 --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 0768e4f23ebf7ccfc7529498979e2a16dc2b39f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0x5XGoQgSA/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.otNsG0tPBK/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-04 02:13:48,868 truncating revision to first 12 chars 2016-09-04 02:13:48,868 Setting DEBUG logging. 2016-09-04 02:13:48,868 attempt 1/10 2016-09-04 02:13:48,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0768e4f23ebf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-04 02:13:49,821 unpacking tar archive at: autoland-0768e4f23ebf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.235233 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-04 02:13:50.053037) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:50.053359) ========= script_repo_revision: 0768e4f23ebf7ccfc7529498979e2a16dc2b39f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:50.053812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:50.054144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-04 02:13:50.073174) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-04 02:13:50.073492) ========= /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.0x5XGoQgSA/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.otNsG0tPBK/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:13:50 INFO - MultiFileLogger online at 20160904 02:13:50 in /builds/slave/test 02:13:50 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 02:13:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:50 INFO - {'append_to_log': False, 02:13:50 INFO - 'base_work_dir': '/builds/slave/test', 02:13:50 INFO - 'blob_upload_branch': 'Autoland', 02:13:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:50 INFO - 'branch': 'Autoland', 02:13:50 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:50 INFO - 'config_files': ('talos/mac_config.py',), 02:13:50 INFO - 'default_actions': ('clobber', 02:13:50 INFO - 'read-buildbot-config', 02:13:50 INFO - 'download-and-extract', 02:13:50 INFO - 'populate-webroot', 02:13:50 INFO - 'create-virtualenv', 02:13:50 INFO - 'install', 02:13:50 INFO - 'run-tests'), 02:13:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:50 INFO - 'download_minidump_stackwalk': True, 02:13:50 INFO - 'download_symbols': 'ondemand', 02:13:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:50 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:50 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:50 INFO - 'installer_path': 'installer.exe', 02:13:50 INFO - 'log_level': 'info', 02:13:50 INFO - 'log_name': 'talos', 02:13:50 INFO - 'log_to_console': True, 02:13:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:13:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:13:50 INFO - 'opt_config_files': (), 02:13:50 INFO - 'pip_index': False, 02:13:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:50 INFO - 'cmd': ('bash', 02:13:50 INFO - '-c', 02:13:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:50 INFO - 'enabled': True, 02:13:50 INFO - 'halt_on_failure': False, 02:13:50 INFO - 'name': 'check_screen_resolution'},), 02:13:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:50 INFO - 'cmd': ('bash', 02:13:50 INFO - '-c', 02:13:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:50 INFO - 'enabled': True, 02:13:50 INFO - 'halt_on_failure': False, 02:13:50 INFO - 'name': 'check_screen_resolution'},), 02:13:50 INFO - 'run_cmd_checks_enabled': True, 02:13:50 INFO - 'sps_profile': False, 02:13:50 INFO - 'sps_profile_interval': 0, 02:13:50 INFO - 'suite': 'dromaeojs', 02:13:50 INFO - 'system_bits': '32', 02:13:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:50 INFO - 'title': 't-yosemite-r7-0144', 02:13:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:50 INFO - 'use_talos_json': True, 02:13:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:50 INFO - 'work_dir': 'build'} 02:13:50 INFO - [mozharness: 2016-09-04 09:13:50.267088Z] Running clobber step. 02:13:50 INFO - Running pre-action listener: _resource_record_pre_action 02:13:50 INFO - Running main action method: clobber 02:13:50 INFO - rmtree: /builds/slave/test/build 02:13:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:13:52 INFO - Running post-action listener: _resource_record_post_action 02:13:52 INFO - [mozharness: 2016-09-04 09:13:52.468441Z] Finished clobber step (success) 02:13:52 INFO - [mozharness: 2016-09-04 09:13:52.468565Z] Running read-buildbot-config step. 02:13:52 INFO - Running pre-action listener: _resource_record_pre_action 02:13:52 INFO - Running main action method: read_buildbot_config 02:13:52 INFO - Using buildbot properties: 02:13:52 INFO - { 02:13:52 INFO - "project": "", 02:13:52 INFO - "product": "firefox", 02:13:52 INFO - "script_repo_revision": "production", 02:13:52 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 02:13:52 INFO - "repository": "", 02:13:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 02:13:52 INFO - "buildid": "20160904003848", 02:13:52 INFO - "pgo_build": "False", 02:13:52 INFO - "basedir": "/builds/slave/test", 02:13:52 INFO - "buildnumber": 140, 02:13:52 INFO - "slavename": "t-yosemite-r7-0144", 02:13:52 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:13:52 INFO - "platform": "yosemite_r7", 02:13:52 INFO - "scheduler": "tests-autoland-macosx64-talos", 02:13:52 INFO - "branch": "autoland", 02:13:52 INFO - "repo_path": "integration/autoland", 02:13:52 INFO - "revision": "0768e4f23ebf7ccfc7529498979e2a16dc2b39f4", 02:13:52 INFO - "stage_platform": "macosx64", 02:13:52 INFO - "builduid": "056fde26f6544a3ead55da70f316765a", 02:13:52 INFO - "slavebuilddir": "test" 02:13:52 INFO - } 02:13:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 02:13:52 INFO - Running post-action listener: _resource_record_post_action 02:13:52 INFO - [mozharness: 2016-09-04 09:13:52.471822Z] Finished read-buildbot-config step (success) 02:13:52 INFO - [mozharness: 2016-09-04 09:13:52.471945Z] Running download-and-extract step. 02:13:52 INFO - Running pre-action listener: _resource_record_pre_action 02:13:52 INFO - Running main action method: download_and_extract 02:13:52 INFO - mkdir: /builds/slave/test/build/tests 02:13: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')]} 02:13:52 INFO - trying https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 02:13:52 INFO - Downloading https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/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 02:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/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 02:13:53 INFO - Downloaded 1199 bytes. 02:13:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:13:53 INFO - Using the following test package requirements: 02:13:53 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:13:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 02:13:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 02:13:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'jsshell-mac.zip'], 02:13:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 02:13:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:13:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 02:13:53 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 02:13:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 02:13:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:13:53 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 02:13:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:13:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:13:54 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:14:01 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 02:14:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:14:01 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:14:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:14:09 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:10 INFO - trying https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:14:10 INFO - Downloading https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 02:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/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 02:14:13 INFO - Downloaded 111496376 bytes. 02:14:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:14:13 INFO - mkdir: /builds/slave/test/properties 02:14:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:14:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:14:13 INFO - Contents: 02:14:13 INFO - build_url:https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:14:13 INFO - Running post-action listener: _resource_record_post_action 02:14:13 INFO - Running post-action listener: set_extra_try_arguments 02:14:13 INFO - [mozharness: 2016-09-04 09:14:13.939510Z] Finished download-and-extract step (success) 02:14:13 INFO - [mozharness: 2016-09-04 09:14:13.939649Z] Running populate-webroot step. 02:14:13 INFO - Running pre-action listener: _resource_record_pre_action 02:14:13 INFO - Running main action method: populate_webroot 02:14:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:14:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:14:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:14:13 INFO - '--tppagecycles', 02:14:13 INFO - '7'], 02:14:13 INFO - 'tests': ['tsvgm']}}, 02:14:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:14:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:14:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:14:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:14:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['damp', 'tps']}, 02:14:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'tests': ['damp', 'tps']}, 02:14:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['dromaeo_dom']}, 02:14:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:14:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['basic_compositor_video']}, 02:14:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:14:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['a11yr', 02:14:13 INFO - 'ts_paint', 02:14:13 INFO - 'tpaint', 02:14:13 INFO - 'sessionrestore', 02:14:13 INFO - 'sessionrestore_no_auto_restore', 02:14:13 INFO - 'tabpaint']}, 02:14:13 INFO - 'other-e10s': {'tests': ['a11yr', 02:14:13 INFO - 'ts_paint', 02:14:13 INFO - 'tpaint', 02:14:13 INFO - 'sessionrestore', 02:14:13 INFO - 'sessionrestore_no_auto_restore', 02:14:13 INFO - 'tabpaint']}, 02:14:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:14:13 INFO - 'ts_paint', 02:14:13 INFO - 'tpaint', 02:14:13 INFO - 'sessionrestore', 02:14:13 INFO - 'sessionrestore_no_auto_restore', 02:14:13 INFO - 'tabpaint']}, 02:14:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:14:13 INFO - 'ts_paint', 02:14:13 INFO - 'tpaint', 02:14:13 INFO - 'sessionrestore', 02:14:13 INFO - 'sessionrestore_no_auto_restore', 02:14:13 INFO - 'tabpaint']}, 02:14:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['a11yr', 02:14:13 INFO - 'ts_paint', 02:14:13 INFO - 'tpaint', 02:14:13 INFO - 'sessionrestore', 02:14:13 INFO - 'sessionrestore_no_auto_restore', 02:14:13 INFO - 'tabpaint']}, 02:14:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['a11yr', 02:14:13 INFO - 'ts_paint', 02:14:13 INFO - 'tpaint', 02:14:13 INFO - 'sessionrestore', 02:14:13 INFO - 'sessionrestore_no_auto_restore', 02:14:13 INFO - 'tabpaint']}, 02:14:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['tsvgx', 02:14:13 INFO - 'tsvgr_opacity', 02:14:13 INFO - 'tart', 02:14:13 INFO - 'tscrollx', 02:14:13 INFO - 'cart']}, 02:14:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:14:13 INFO - 'tsvgr_opacity', 02:14:13 INFO - 'tart', 02:14:13 INFO - 'tscrollx', 02:14:13 INFO - 'cart']}, 02:14:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'talos_options': ['--disable-e10s'], 02:14:13 INFO - 'tests': ['tp5o']}, 02:14:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'tests': ['tp5o']}, 02:14:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'talos_options': ['--disable-e10s', 02:14:13 INFO - '--xperf_path', 02:14:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:13 INFO - 'tests': ['tp5n']}, 02:14:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:14:13 INFO - 'talos_options': ['--xperf_path', 02:14:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:13 INFO - 'tests': ['tp5n']}}, 02:14:13 INFO - 'talos.zip': {'path': '', 02:14:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:14:13 INFO - Running post-action listener: _resource_record_post_action 02:14:13 INFO - [mozharness: 2016-09-04 09:14:13.958553Z] Finished populate-webroot step (success) 02:14:13 INFO - [mozharness: 2016-09-04 09:14:13.958690Z] Running create-virtualenv step. 02:14:13 INFO - Running pre-action listener: _resource_record_pre_action 02:14:13 INFO - Running main action method: create_virtualenv 02:14:13 INFO - Creating virtualenv /builds/slave/test/build/venv 02:14:13 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 02:14:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:14:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:14:14 INFO - Using real prefix '/tools/python27' 02:14:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:14:14 INFO - Installing distribute.............................................................................................................................................................................................done. 02:14:17 INFO - Installing pip.................done. 02:14:17 INFO - Return code: 0 02:14:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:17 INFO - 'HOME': '/Users/cltbld', 02:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:17 INFO - 'LOGNAME': 'cltbld', 02:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:17 INFO - 'MOZ_NO_REMOTE': '1', 02:14:17 INFO - 'NO_EM_RESTART': '1', 02:14:17 INFO - 'PAGER': '/bin/cat', 02:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:17 INFO - 'PWD': '/builds/slave/test', 02:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:17 INFO - 'SHELL': '/bin/bash', 02:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:17 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:17 INFO - 'USER': 'cltbld', 02:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:17 INFO - 'XPC_FLAGS': '0x0', 02:14:17 INFO - 'XPC_SERVICE_NAME': '0', 02:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:17 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 02:14:17 INFO - Cleaning up... 02:14:17 INFO - Return code: 0 02:14:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:17 INFO - 'HOME': '/Users/cltbld', 02:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:17 INFO - 'LOGNAME': 'cltbld', 02:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:17 INFO - 'MOZ_NO_REMOTE': '1', 02:14:17 INFO - 'NO_EM_RESTART': '1', 02:14:17 INFO - 'PAGER': '/bin/cat', 02:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:17 INFO - 'PWD': '/builds/slave/test', 02:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:17 INFO - 'SHELL': '/bin/bash', 02:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:17 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:17 INFO - 'USER': 'cltbld', 02:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:17 INFO - 'XPC_FLAGS': '0x0', 02:14:17 INFO - 'XPC_SERVICE_NAME': '0', 02:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:18 INFO - Downloading/unpacking psutil>=3.1.1 02:14:18 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 02:14:18 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 02:14:18 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 02:14:18 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 02:14:18 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 02:14:18 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 02:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:21 INFO - Installing collected packages: psutil 02:14:21 INFO - Running setup.py install for psutil 02:14:21 INFO - building 'psutil._psutil_osx' extension 02:14:21 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 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 INFO - building 'psutil._psutil_posix' extension 02:14:22 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 02:14:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:14:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:14:22 INFO - ^ 02:14:22 INFO - 1 warning generated. 02:14:22 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 02:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:22 INFO - Successfully installed psutil 02:14:22 INFO - Cleaning up... 02:14:22 INFO - Return code: 0 02:14:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:22 INFO - 'HOME': '/Users/cltbld', 02:14:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:22 INFO - 'LOGNAME': 'cltbld', 02:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:22 INFO - 'MOZ_NO_REMOTE': '1', 02:14:22 INFO - 'NO_EM_RESTART': '1', 02:14:22 INFO - 'PAGER': '/bin/cat', 02:14:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:22 INFO - 'PWD': '/builds/slave/test', 02:14:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:22 INFO - 'SHELL': '/bin/bash', 02:14:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:22 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:22 INFO - 'USER': 'cltbld', 02:14:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:22 INFO - 'XPC_FLAGS': '0x0', 02:14:22 INFO - 'XPC_SERVICE_NAME': '0', 02:14:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 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 02:14:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:14:25 INFO - Installing collected packages: mozsystemmonitor 02:14:25 INFO - Running setup.py install for mozsystemmonitor 02:14:25 INFO - Successfully installed mozsystemmonitor 02:14:25 INFO - Cleaning up... 02:14:25 INFO - Return code: 0 02:14:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:25 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')]} 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:25 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')]} 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:25 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 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:25 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 02:14:25 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 02:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:25 INFO - 'HOME': '/Users/cltbld', 02:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:25 INFO - 'LOGNAME': 'cltbld', 02:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:25 INFO - 'MOZ_NO_REMOTE': '1', 02:14:25 INFO - 'NO_EM_RESTART': '1', 02:14:25 INFO - 'PAGER': '/bin/cat', 02:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:25 INFO - 'PWD': '/builds/slave/test', 02:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:25 INFO - 'SHELL': '/bin/bash', 02:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:25 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:25 INFO - 'USER': 'cltbld', 02:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:25 INFO - 'XPC_FLAGS': '0x0', 02:14:25 INFO - 'XPC_SERVICE_NAME': '0', 02:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:25 INFO - Downloading/unpacking jsonschema==2.5.1 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:28 INFO - warning: no files found matching '*.txt' 02:14:28 INFO - no previously-included directories found matching 'build' 02:14:28 INFO - no previously-included directories found matching 'dist' 02:14:28 INFO - no previously-included directories found matching '.git*' 02:14:28 INFO - Installing collected packages: jsonschema, functools32 02:14:28 INFO - Running setup.py install for functools32 02:14:29 INFO - warning: no files found matching '*.txt' 02:14:29 INFO - no previously-included directories found matching 'build' 02:14:29 INFO - no previously-included directories found matching 'dist' 02:14:29 INFO - no previously-included directories found matching '.git*' 02:14:29 INFO - Successfully installed jsonschema functools32 02:14:29 INFO - Cleaning up... 02:14:29 INFO - Return code: 0 02:14:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:14:29 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')]} 02:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 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')]} 02:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 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 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:29 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 02:14:29 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 02:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:29 INFO - 'HOME': '/Users/cltbld', 02:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:29 INFO - 'LOGNAME': 'cltbld', 02:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:29 INFO - 'MOZ_NO_REMOTE': '1', 02:14:29 INFO - 'NO_EM_RESTART': '1', 02:14:29 INFO - 'PAGER': '/bin/cat', 02:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:29 INFO - 'PWD': '/builds/slave/test', 02:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:29 INFO - 'SHELL': '/bin/bash', 02:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:29 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:29 INFO - 'USER': 'cltbld', 02:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:29 INFO - 'XPC_FLAGS': '0x0', 02:14:29 INFO - 'XPC_SERVICE_NAME': '0', 02:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:14:29 INFO - Cleaning up... 02:14:29 INFO - Return code: 0 02:14:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:29 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')]} 02:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 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')]} 02:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 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 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:29 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 02:14:29 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 02:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:29 INFO - 'HOME': '/Users/cltbld', 02:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:29 INFO - 'LOGNAME': 'cltbld', 02:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:29 INFO - 'MOZ_NO_REMOTE': '1', 02:14:29 INFO - 'NO_EM_RESTART': '1', 02:14:29 INFO - 'PAGER': '/bin/cat', 02:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:29 INFO - 'PWD': '/builds/slave/test', 02:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:29 INFO - 'SHELL': '/bin/bash', 02:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:29 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:29 INFO - 'USER': 'cltbld', 02:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:29 INFO - 'XPC_FLAGS': '0x0', 02:14:29 INFO - 'XPC_SERVICE_NAME': '0', 02:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:29 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14:32 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 02:14:32 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 02:14:32 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 02:14:32 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 02:14:32 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 02:14:32 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 02:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14:32 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 02:14:32 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 02:14:32 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 02:14:32 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 02:14:32 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 02:14:32 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 02:14:33 INFO - Downloading docopt-0.6.1.tar.gz 02:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:33 INFO - Running setup.py install for blobuploader 02:14:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:33 INFO - Running setup.py install for requests 02:14:34 INFO - Running setup.py install for docopt 02:14:34 INFO - Successfully installed blobuploader requests docopt 02:14:34 INFO - Cleaning up... 02:14:34 INFO - Return code: 0 02:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:34 INFO - 'HOME': '/Users/cltbld', 02:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:34 INFO - 'LOGNAME': 'cltbld', 02:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:34 INFO - 'MOZ_NO_REMOTE': '1', 02:14:34 INFO - 'NO_EM_RESTART': '1', 02:14:34 INFO - 'PAGER': '/bin/cat', 02:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:34 INFO - 'PWD': '/builds/slave/test', 02:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:34 INFO - 'SHELL': '/bin/bash', 02:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:34 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:34 INFO - 'USER': 'cltbld', 02:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:34 INFO - 'XPC_FLAGS': '0x0', 02:14:34 INFO - 'XPC_SERVICE_NAME': '0', 02:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:34 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-6dvduW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:34 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-K0tQYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:34 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-S56za2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:34 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-aX3THR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-rrpVTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-mYP3Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-CVX2B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-W4gY8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-fZ82M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-wKVKA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Q5NmgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-XWv_ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:35 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-9oKUdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:36 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-7wKk40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:36 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-T4FWGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:36 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-keGtMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:36 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-05SqHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:36 INFO - Running setup.py install for manifestparser 02:14:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:36 INFO - Running setup.py install for mozcrash 02:14:36 INFO - Running setup.py install for mozdebug 02:14:36 INFO - Running setup.py install for mozdevice 02:14:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Running setup.py install for mozfile 02:14:37 INFO - Running setup.py install for mozhttpd 02:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Running setup.py install for mozinfo 02:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Running setup.py install for mozInstall 02:14:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Running setup.py install for mozleak 02:14:37 INFO - Running setup.py install for mozlog 02:14:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:37 INFO - Running setup.py install for moznetwork 02:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:38 INFO - Running setup.py install for mozprocess 02:14:38 INFO - Running setup.py install for mozprofile 02:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:38 INFO - Running setup.py install for mozrunner 02:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:38 INFO - Running setup.py install for mozscreenshot 02:14:38 INFO - Running setup.py install for moztest 02:14:38 INFO - Running setup.py install for mozversion 02:14:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:38 INFO - Cleaning up... 02:14:39 INFO - Return code: 0 02:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:39 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')]} 02:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:39 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')]} 02:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:39 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 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:39 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 02:14:39 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 02:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:39 INFO - 'HOME': '/Users/cltbld', 02:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:39 INFO - 'LOGNAME': 'cltbld', 02:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:39 INFO - 'MOZ_NO_REMOTE': '1', 02:14:39 INFO - 'NO_EM_RESTART': '1', 02:14:39 INFO - 'PAGER': '/bin/cat', 02:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:39 INFO - 'PWD': '/builds/slave/test', 02:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:39 INFO - 'SHELL': '/bin/bash', 02:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:39 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:39 INFO - 'USER': 'cltbld', 02:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:39 INFO - 'XPC_FLAGS': '0x0', 02:14:39 INFO - 'XPC_SERVICE_NAME': '0', 02:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ukJ69W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VogotG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-LXsG2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VhFsrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-XiN_wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-kJ5EJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:39 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)) 02:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:39 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-IxPe8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-MAFwds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-UGggWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-QjULxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-3TciMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-LQj9_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-jklaou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ZCTCWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ouudhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-9YInpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:40 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)) 02:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:40 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-009vKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:41 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)) 02:14:41 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)) 02:14:41 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)) 02:14:41 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)) 02:14:41 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)) 02:14:41 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)) 02:14:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14: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 02:14: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 02:14: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 02:14: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 02:14: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 02:14: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 02:14:43 INFO - Downloading blessings-1.6.tar.gz 02:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:43 INFO - Installing collected packages: blessings 02:14:43 INFO - Running setup.py install for blessings 02:14:43 INFO - Successfully installed blessings 02:14:43 INFO - Cleaning up... 02:14:44 INFO - Return code: 0 02:14:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:44 INFO - Reading from file tmpfile_stdout 02:14:44 INFO - Current package versions: 02:14:44 INFO - blessings == 1.6 02:14:44 INFO - blobuploader == 1.2.4 02:14:44 INFO - docopt == 0.6.1 02:14:44 INFO - functools32 == 3.2.3-2 02:14:44 INFO - jsonschema == 2.5.1 02:14:44 INFO - manifestparser == 1.1 02:14:44 INFO - mozInstall == 1.12 02:14:44 INFO - mozcrash == 0.17 02:14:44 INFO - mozdebug == 0.1 02:14:44 INFO - mozdevice == 0.48 02:14:44 INFO - mozfile == 1.2 02:14:44 INFO - mozhttpd == 0.7 02:14:44 INFO - mozinfo == 0.9 02:14:44 INFO - mozleak == 0.1 02:14:44 INFO - mozlog == 3.3 02:14:44 INFO - moznetwork == 0.27 02:14:44 INFO - mozprocess == 0.23 02:14:44 INFO - mozprofile == 0.28 02:14:44 INFO - mozrunner == 6.12 02:14:44 INFO - mozscreenshot == 0.1 02:14:44 INFO - mozsystemmonitor == 0.3 02:14:44 INFO - moztest == 0.7 02:14:44 INFO - mozversion == 1.4 02:14:44 INFO - psutil == 3.1.1 02:14:44 INFO - requests == 1.2.3 02:14:44 INFO - wsgiref == 0.1.2 02:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:44 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 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:44 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 02:14:44 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 02:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:44 INFO - 'HOME': '/Users/cltbld', 02:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:44 INFO - 'LOGNAME': 'cltbld', 02:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:44 INFO - 'MOZ_NO_REMOTE': '1', 02:14:44 INFO - 'NO_EM_RESTART': '1', 02:14:44 INFO - 'PAGER': '/bin/cat', 02:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:44 INFO - 'PWD': '/builds/slave/test', 02:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:44 INFO - 'SHELL': '/bin/bash', 02:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:44 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:44 INFO - 'USER': 'cltbld', 02:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:44 INFO - 'XPC_FLAGS': '0x0', 02:14:44 INFO - 'XPC_SERVICE_NAME': '0', 02:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 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)) 02:14:44 INFO - Cleaning up... 02:14:44 INFO - Return code: 0 02:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:44 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 0x10bb38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbcd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefb9d9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, '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.0x5XGoQgSA/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.otNsG0tPBK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 02:14:44 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 02:14:44 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 02:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:44 INFO - 'HOME': '/Users/cltbld', 02:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:44 INFO - 'LOGNAME': 'cltbld', 02:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:44 INFO - 'MOZ_NO_REMOTE': '1', 02:14:44 INFO - 'NO_EM_RESTART': '1', 02:14:44 INFO - 'PAGER': '/bin/cat', 02:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:44 INFO - 'PWD': '/builds/slave/test', 02:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:44 INFO - 'SHELL': '/bin/bash', 02:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:14:44 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:44 INFO - 'USER': 'cltbld', 02:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:44 INFO - 'XPC_FLAGS': '0x0', 02:14:44 INFO - 'XPC_SERVICE_NAME': '0', 02:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:14:44 INFO - Cleaning up... 02:14:44 INFO - Return code: 0 02:14:44 INFO - Running post-action listener: _resource_record_post_action 02:14:44 INFO - Running post-action listener: _start_resource_monitoring 02:14:44 INFO - Starting resource monitoring. 02:14:44 INFO - [mozharness: 2016-09-04 09:14:44.836151Z] Finished create-virtualenv step (success) 02:14:44 INFO - [mozharness: 2016-09-04 09:14:44.837223Z] Running install step. 02:14:44 INFO - Running pre-action listener: _resource_record_pre_action 02:14:44 INFO - Running main action method: install 02:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:45 INFO - Reading from file tmpfile_stdout 02:14:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:45 INFO - Reading from file tmpfile_stdout 02:14:45 INFO - Output received: 02:14:45 INFO - Usage: mozinstall [options] installer 02:14:45 INFO - Options: 02:14:45 INFO - -h, --help show this help message and exit 02:14:45 INFO - -d DEST, --destination=DEST 02:14:45 INFO - Directory to install application into. [default: 02:14:45 INFO - "/builds/slave/test"] 02:14:45 INFO - --app=APP Application being installed. [default: firefox] 02:14:45 INFO - mkdir: /builds/slave/test/build/application 02:14:45 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'] 02:14:45 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 02:15:19 INFO - Reading from file tmpfile_stdout 02:15:19 INFO - Output received: 02:15:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:15:19 INFO - Running post-action listener: _resource_record_post_action 02:15:19 INFO - [mozharness: 2016-09-04 09:15:19.540005Z] Finished install step (success) 02:15:19 INFO - [mozharness: 2016-09-04 09:15:19.540144Z] Running run-tests step. 02:15:19 INFO - Running pre-action listener: _resource_record_pre_action 02:15:19 INFO - Running main action method: run_tests 02:15:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:15:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:15:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:15:19 INFO - 2016-09-04 02:15:19.554 screenresolution[1928:21929] starting screenresolution argv=screenresolution get 02:15:19 INFO - 2016-09-04 02:15:19.557 screenresolution[1928:21929] Display 0: 1600x1200x32@60 02:15:19 INFO - 2016-09-04 02:15:19.563 screenresolution[1929:21931] starting screenresolution argv=screenresolution list 02:15:19 INFO - Available Modes on Display 0 02:15:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:15:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:15:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:15:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:15:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:15:19 INFO - Intel Iris: 02:15:19 INFO - Chipset Model: Intel Iris 02:15:19 INFO - Type: GPU 02:15:19 INFO - Bus: Built-In 02:15:19 INFO - VRAM (Dynamic, Max): 1536 MB 02:15:19 INFO - Vendor: Intel (0x8086) 02:15:19 INFO - Device ID: 0x0a2e 02:15:19 INFO - Revision ID: 0x0009 02:15:19 INFO - Displays: 02:15:19 INFO - Display: 02:15:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:15:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:15:19 INFO - Display Serial Number: 1600x1200 60 02:15:19 INFO - Main Display: Yes 02:15:19 INFO - Mirror: Off 02:15:19 INFO - Online: Yes 02:15:19 INFO - Rotation: Supported 02:15:19 INFO - Return code: 0 02:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:15:19 INFO - Python 2.7.3 02:15:19 INFO - Return code: 0 02:15:19 INFO - grabbing minidump binary from tooltool 02:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:19 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 0x10ba9cd30>, '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 0x10b801db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba94b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:15:19 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 02:15:19 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 02:15:19 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 02:15:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:15:19 INFO - Return code: 0 02:15:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:15:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:15:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:15:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:15:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:15:19 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/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 02:15:19 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/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --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 02:15:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x5XGoQgSA/Render', 02:15:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:19 INFO - 'HOME': '/Users/cltbld', 02:15:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:19 INFO - 'LOGNAME': 'cltbld', 02:15:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:15:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:19 INFO - 'MOZ_NO_REMOTE': '1', 02:15:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:15:19 INFO - 'NO_EM_RESTART': '1', 02:15:19 INFO - 'PAGER': '/bin/cat', 02:15:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:19 INFO - 'PWD': '/builds/slave/test', 02:15:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:15:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:19 INFO - 'SHELL': '/bin/bash', 02:15:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.otNsG0tPBK/Listeners', 02:15:19 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 02:15:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:19 INFO - 'USER': 'cltbld', 02:15:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:19 INFO - 'XPC_FLAGS': '0x0', 02:15:19 INFO - 'XPC_SERVICE_NAME': '0', 02:15:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:19 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/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 02:15:20 INFO - mozversion application_buildid: 20160904003848 02:15:20 INFO - mozversion application_changeset: 0768e4f23ebf7ccfc7529498979e2a16dc2b39f4 02:15:20 INFO - mozversion application_display_name: Nightly 02:15:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:15:20 INFO - mozversion application_name: Firefox 02:15:20 INFO - mozversion application_remotingname: firefox 02:15:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:15:20 INFO - mozversion application_vendor: Mozilla 02:15:20 INFO - mozversion application_version: 51.0a1 02:15:20 INFO - mozversion platform_buildid: 20160904003848 02:15:20 INFO - mozversion platform_changeset: 0768e4f23ebf7ccfc7529498979e2a16dc2b39f4 02:15:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:15:20 INFO - mozversion platform_version: 51.0a1 02:15:20 INFO - using testdate: 1472980520 02:15:20 INFO - actual date: 1472980520 02:15:20 INFO - starting webserver on 'localhost:57255' 02:15:20 INFO - SUITE-START | Running 2 tests 02:15:20 INFO - TEST-START | dromaeo_css 02:15:20 INFO - operating with platform_type : mac_ 02:15:20 INFO - Initialising browser for dromaeo_css test... 02:15:20 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpKocYVs/profile http://localhost:57255/getInfo.html) 02:15:22 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 02:15:22 INFO - PROCESS | 1939 | colorDepth:24 02:15:22 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 02:15:22 INFO - PROCESS | 1939 | __metrics 02:15:22 INFO - PROCESS | 1939 | 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" 02:15:22 INFO - PROCESS | 1939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:15:23 INFO - TEST-INFO | 1939: exit 0 02:15:23 INFO - Browser initialized. 02:15:23 INFO - Running cycle 1/1 for dromaeo_css test... 02:15:23 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpKocYVs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:35 INFO - PROCESS | 1941 | RSS: Main: 233996288 02:15:35 INFO - PROCESS | 1941 | 02:16:26 INFO - PROCESS | 1941 | 1472980586346 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] 02:18:38 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57255/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57255/tests/dromaeo/cssquery-ext.html) 02:18:40 INFO - PROCESS | 1941 | RSS: Main: 376754176 02:18:40 INFO - PROCESS | 1941 | 02:21:43 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57255/tests/dromaeo/cssquery-ext.html (next: http://localhost:57255/tests/dromaeo/cssquery-jquery.html) 02:21:43 INFO - PROCESS | 1941 | RSS: Main: 395513856 02:21:43 INFO - PROCESS | 1941 | 02:24:46 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57255/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57255/tests/dromaeo/cssquery-mootools.html) 02:24:47 INFO - PROCESS | 1941 | RSS: Main: 344600576 02:24:47 INFO - PROCESS | 1941 | 02:27:49 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57255/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57255/tests/dromaeo/cssquery-prototype.html) 02:27:49 INFO - PROCESS | 1941 | RSS: Main: 365068288 02:27:49 INFO - PROCESS | 1941 | 02:30:53 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57255/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57255/tests/dromaeo/cssquery-yui.html) 02:30:54 INFO - PROCESS | 1941 | RSS: Main: 336416768 02:30:54 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:57255/tests/dromaeo/cssquery-yui.html (next: http://localhost:57255/tests/dromaeo/cssquery-dojo.html) 02:33:57 INFO - PROCESS | 1941 | RSS: Main: 485019648 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | __start_tp_report 02:33:57 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 02:33:57 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 02:33:57 INFO - PROCESS | 1941 | |i|pagename|runs| 02:33:57 INFO - PROCESS | 1941 | |0;dojo.html;3279.754018448617;3320.418926687829;3327.4010678077943;3352.815595142269;3392.932141357173;5590.468905453975;5696.487316141546;5724.084146536555;5750;5788.276465441825;4603.907921841561;5674.517665998395;5755.712214389285;5783.190353350524;5805.941940580593;5113.488651134875;5117.437081920985;5188.195829646411;5197.194434862602;5266.605004624649;5252.107141785887;5271.288376069239;5286.233496143057;5296.205569164617;5309.946900531003;5146.897062058775;5149.639525233235;5183.45573714762;5193.013327467769;5222.190560463135;5191.610629202825;5192.221166824968;5194.92207616886;5218.895622087537;5219.817306394296;5185.325907632021;5188.403333616607;5190.299309593194;5198.9480105198845;5208.114620514521;5592.245046918695;5607.57943154261;5641.266635337421;5724.742386592613;5747.195392645033;6125.479334256594;6151.969240153815;6186.597871138361;6192.28788689302;6194.628322300677;6166.7533298667995;6233.1273621693;6237.719302631393;6254.21822272216;6258.092576576417;5612.5229355504425;5700.230468886689;5702.372738998707;5704.22992895962;5730.713464326809;6170.969145154246;6229.252489701174;6250.812475625738;6268.153799237136;6279.434850863444;6094.451499365078;6116.235470566179;6116.571839971249;6123.081537769282;6166.845828854314;6188.597741146811;6229;6245.687715614201;6251.906221406683;6257.155284036688;6206.224221972254;6220.471259942956;6225.844353891189;6230.408111229426;6230.906536401958;6039.516838652898;6101.993171126803;6103.35914728956;6123.221615589998;6216.627002379872;4869.245266983623;4884.340614017062;4887.804487820518;4914.238293064581;4956.083124621957;4256.404103425523;4434.667399945017;4455.465344158657;4474.105178964221;4476.060027394218;5713.914291285634;5719.056355701346;5724.542036637059;5725.51333136688;5733;6132.600268413531;6208.1308616793685;6254.8123556293385;6255.12428260044;6263.154474145932;5622.269105016322;5625.887482250332;5628.437156284339;5631.436856314418;5634.32388113429;5375.946240537544;5386.649867758583;5388.488093631099;5390.460953904657;5391.110466772939;6165.167702360124;6207.6275423474735;6216.409441103088;6252.218472690914;6256.624602523772;6228.377162283917;6279.246490421178;6281.811545653638;6290.937090629035;6295.087212354275;6319.58922670025;6323.810285691437;6323.841903952438;6326.114343991753;6348.746050157942;6064.181335519825;6125.448709616156;6134.601250918676;6183.96908015475;6192.59748116389;6137.131844484677;6226.59527130735;6229.1590635265475;6257.7184026719815;6264.154339164154;5064.366954130734;5999.98000339952;6054.757809687563;6070.726817293321;6107.786227482017;5929.673867937305;5947.881042379042;5960.4635582797755;6086.69566521681;6128.142060111499;5422.7256594701;5522.5858060646415;5943.286805583358;6035.849103772441;6038.184845046038;6142.46326737159;6154.415330543591;6168.167297414791;6171.043488259327;6171.352008039271;5731.226284451545;6006.879862402815;6007.729652165751;6011.90982135277;6052.061930400795 02:33:57 INFO - PROCESS | 1941 | |1;ext.html;503.6323483856782;514.0284861611552;514.740056271583;521.4863359590803;545.057051301249;29170;38159.80920095403;39339.819805405845;39343;41578.37632435516;40810.591894081124;41412;41440.585594144046;41458.963525911866;41494.17011659765;8597.18326758957;9555.996620354867;9719.75700607487;9730.36752611078;9734.951325243364;8698.260647844942;11633.185677002613;11900.464479098462;11918.986886114692;12119.272843629366;11951.880481195207;11960.401979901013;12020.69948251292;12022.639320820346;12071.637850864488;11972.820407693891;12054.578089766905;12068.215565988183;12086.939565302162;12091.97218236451;11715.882841171564;11784.469698863571;11801.763964720658;11820.113491488173;11836.644900652995;38608.61391386078;38863;38941.80529097365;38972;38973;2764.9447011059665;3298.350824587706;3367.696907278357;3383.5950822035607;3514.2620049789575;28677;29589.852050739824;30636.846815766003;30651.540226896614;30667.846660766776;2709.5529237675955;3355.2786150977413;3376.544166537535;3417.8120203388803;3421.2131209821882;488666;489966;490469;491080.5445972783;501572.4921375406;57952;58003.70998144982;58257.41742582605;58385;58483.122753158736;51836.96326073458;60570;61688.07467887985;61869;61949;15471.071735695894;15756.975796573186;15770.13264270476;15790.21048947571;15794.447194348142;10871.619493317696;11077.778444431066;11792.646220613395;11999.76000480003;12064.215825971283;17851.37520186787;18172.727409088875;18185.545361366072;18200.817991819913;18487.90756046238;6675.7997260082275;7742.458027937991;7800.92199078002;7812.6093695315;7933.096056946407;777.9222077792289;896.5741272895323;998.610541888664;1012.711377257478;1028.6039874648313;27928.860355698092;28341.149765507067;29099.836006559923;29392;29794.255143621584;953.9713808585753;1020.1685626214611;1044.2220545693356;1049.3651340938775;1050.2700623067049;14568.562943111723;15041.172735499435;15246.390144394321;15320.185339194364;15455.459058932884;657082;657186;657795.422045783;658846.7057664681;659109;54483.72758136184;55230.92459829416;55246.44753552413;55262.89474210493;55308.44691553113;1213.2902252182396;1324.8476425211031;1355.8711922367359;1356.3421740455872;1362.1078193783087;29266.853665732386;30342.78628854821;30606.540901886045;30673.06062630234;30788.384232315675;45759;46233.07533849371;46443.76778116088;46453.767731161126;46467.53532464632;525306;529044;529668;529999;531075;25472.745272547778;26180.73819261859;26212.73787262103;27214.863925680245;27307;44845.55154448414;45369;46066.76966615146;46125.30812037889;46620.067598648515;36421.635783641825;37045.851102656576;37591.684291049685;37601.62398375981;37753.24493510059;36757.26485470222;37108.443373348884;37855.37547325478;38245;38254.74834639087;36290.09274768152;36724.08189795277;37514.81242593769;37518.624813752605;37627.435588466746;30152.24619384533;33230.66769332276;33242.50408731565;33245.83377083099;33558;24068.51862962766;24071.157509487082;24339.26982190537;24930.750692492842;24945.376365591004 02:33:57 INFO - PROCESS | 1941 | |2;jquery.html;349.15504479160427;365.2238992141699;367.7940353402095;376.50113599480693;400.28748827087776;15395.076295422268;16259.34962601496;19951.501212469695;20369.898150509263;20502.28242011528;19430.805691943075;20151.29470468534;21077;21440;21476.8926155369;5203.973980130094;5285.920711189336;5475.890482190353;5484.725763711818;5490;5396.757145928423;5497.642653227547;5499.917501237484;5500.147477141049;5512;3903.1998440319667;5792.855178620547;6072.301685306202;6131;6189.783357582485;5858.589898707092;6052.697365131726;6136.785212517563;6157.938420615781;6158.322584515699;4998.500149985009;5897.911531327033;5912.320083190402;5920.674362910038;5932.614380065282;13026.478940842355;19615.803841961682;24295.757042429526;24826.875865620557;25137.371565710822;2250.313654335427;2273.9545209095727;2335.3927978725483;2659.3085797692547;2988.5666578346018;9980.750481237954;10302.124319432858;10371.844422333672;14951.327190276355;15859.60350991223;1629.7392417213307;1862.3574866671113;1888.9716654250196;1934.1489744512369;1978.1889425335544;84689.57655211685;105783;122964;123140;126961.09558356632;10809.243352965374;11108.833367499494;11285.984261416348;11329.886701132884;11620.941895290469;14308.713825723635;14326.426942922166;14332.49836255726;14345.928270358581;14354;6963.8607227855155;8010.959945200237;8290.585470726439;8301;8400;6625.734970601122;8152.8777068344025;8160.551169685724;8323.500589964622;8364;4475.910481790411;4482.887927801831;4490.012197316585;4503.932441013388;4566.383538222298;1697.2871394014544;1701.46403882779;1841.5027942455463;1905.0569967865995;1908.4847091285276;676.3009194542391;698.7205117952758;882.92495137914;909.5315912305168;916.8578870275118;19897.502562435766;21195.78804211938;21252;21491.355259342246;21939.67090493644;780.480980148195;822.284612387227;914.5518695839124;917.8439665256923;939.112538650982;11125.388103654377;11238.390708589344;11264;11300.604478843201;11387.715307117223;555148;556037;558358;568253;573200;119844.42411426242;120123;122332;123766;125991;867.509856930832;958.1233171647864;959.5106495687111;973.1144658360857;980.4362491567234;18073.638527229647;18582.070896454854;18602;18708.906455467637;18720.344787932358;50180.498195017586;51342.74328628482;52521;53553.66115847135;54456;75221.61502732281;76090.61954690191;76763.2323676756;77595.61202193952;77889.61055194688;6378.6810659467765;6850;7617.581033043236;8029;8231.629576668944;10433.686989390331;13089;13163.341832908507;13451.932740336235;13597.116187447784;10891.346519208873;10970;11019.283746556448;11511.942440287745;11675.824862626898;10585.841212381667;11207.719807004563;11299.209055366046;11583.073354131819;11741.76516469683;10307.793844123225;10519.105876000625;11030.669079927615;11049.950254725789;11902.642920712393;6913.585184888922;7046.330598593126;7998.400119990907;8086.15095414973;8222.095569487232;10815.026647601753;10880.401577913291;11037.889621103686;11134.777304454028;11443.599474018369 02:33:57 INFO - PROCESS | 1941 | |3;mootools.html;1476.2618690654672;1535.5393381985402;1683.5538582275706;1756.3852651571951;1932.2271091563373;8300.875486867695;8813.338999575026;8816.294696424287;8828.470291782489;8830.646774129027;7008.96495517523;7689.192634773352;7912.169222231669;8333.166683331663;8550.358723095776;2354.6114891043;2382.988085059581;2383.9284821455385;2384.1655420602738;2401.387646150229;2340.9882950585225;2357.422431504275;2390.3785015895905;2390.8685022323766;2392.4138586046442;1746.7205247160393;2171.83711221659;2176.6843807647883;2177.7822217778253;2301.7698230177016;2038.2662241593014;2365.6333268343346;2388.773066558674;2391.306521108868;2401.0635852017726;2342.8008619267384;2365.7634236576378;2367.0413482539425;2367.3726462487452;2370.3126093432884;7529.4352923530405;8683.392162548624;8779.385443018991;8788;8792.296616270747;5161.096808058613;5272.18281166416;5345.973270133663;5353.491418315292;5357.705326207057;2993.4611769881412;3446.190145315849;3630.110622897407;3635.745497815154;3637.781733095996;1012.4836333469909;1077.4828082520355;1105.9723506912312;1110.134095405585;1111.4553868604407;11590;11616.128790340757;11638.999999999915;11640.06879449642;11659.12556558253;4437.733735975852;4566.383538222364;4724.031573527419;4735.8342458014495;4745.454272758608;9856.556454959544;9865.704028879145;9865.964073772295;9882.80234395308;9933.552990115462;5272;5282.867928301823;5282.894342113136;5285.07511185541;5289.391719952255;4701;4794.7842347094465;4828.203346447796;4837.975810120927;4859.3682821233015;3864.7874366909527;3874.554426240962;3895.3962135868987;3954.0905591714068;3988.16248587794;1266.4169787765293;1267.790814515613;1272.6818295426144;1277.2145130744525;1294.9805752913715;810.1920382102777;852.1648784191403;885.371386315723;893.5353616119581;935.8034812689275;5718.370979192286;5718.656880587095;5949.442675159305;5965.701714914237;6082.695865206722;937.2267878999852;948.3645957208687;949.1505102932837;955.4171955107379;977.1791694976112;3468.9826550867083;3885.55316138642;3917.9617401388655;3925.1757131002237;4010.819513121858;10472.842907356397;10689.412082335546;10780.78438431227;10811.567537298577;10822.512986915608;10748.140148788078;10751.247412681194;10771.78456430867;10778.78442431147;10790.838137427945;7015.649217539205;7695.422843286776;7942.44402891792;8132.55270960091;8160.8367832641825;5813.534917206698;5836.591438599257;5858.47273745365;5939.2575928009;6045.546584006129;9779.41323520591;10046.045625665842;10049.447280399649;10050.49747512636;10057.044580764816;8894.911050889408;9311.487868167316;9582.808343833223;10056.094951454405;10184.388936663823;7107.360337569644;7420.92579074224;7599.886001709868;7607.429442791702;7624.313811756969;7656.961715191388;8234;8243.134470880712;8252.876206857021;8255.545944973084;7144.214136445091;7299.5255308404785;7425.480216385017;7514.887276690744;7631.961840190764;7219.747308844166;7375.856742204966;7405.407567394488;7436.847288670265;7488.7004519820775;6845.726170953106;6972.721091156297;6982.511224214256;6982.51122421446;6987.790366289019;4449.221386257456;4833.9033219334715;4973.651844370859;5022.748862556785;5034.974825125851;4895.926561101515;4905.411350637946;4925.45819959797;5168.276441298296;5184.326037615086 02:33:57 INFO - PROCESS | 1941 | |4;prototype.html;260.95824668053115;261.2840816163712;267.57188498402553;271.52889736307503;304.74553747620735;4431.756253406065;4501.302298143789;4638.768061596924;5177.430482646906;5283.524482796547;4666.533346665332;5034.949650503503;5064.442911279756;5229.529342359187;5271.367435907687;3343.765936384448;3985.342418500944;4043.898902527431;4052.3111071117983;4056.5132184137947;3802.885913422602;3861.9227615447676;4027.0737730322044;4032.4757781488365;4058.9188216235657;3801.562820275662;3964.1873415949804;3980.1890139986235;4003.5996400359877;4003.65968892643;3315.635280119197;3988.541317748467;3992.141689536749;3994.580569040267;4011.7793521356316;2877.4101309231555;3202.5836641236724;3335.916602084943;3480.5301284326797;3539.964600353989;4308.655307575418;4764.833230836939;4856.9314750754775;5053.343065401475;5077.416097148801;3929.469521614574;4500.369948207221;4530.592246697813;4538.863834084983;4542.750148741818;4680.555347242007;4693.929591056137;5416.91874621881;5434.070904828808;5453.15476101205;3583.4591125815887;3632.3098611263777;3815.6184381561898;3821.464994900716;3858.9614103858885;4956.959038601898;5668.149777533362;5691.658500489901;5720;5720.797492965196;3399.286149908547;3773.867914622975;3857.498525191707;3903.902402439905;3907.8241479133508;3732.5894151643297;3909.5504017038406;3931.233409485123;3954.307996100671;3986.7009974252046;4166.708320420679;4279.764612946318;4413.691041627056;4511.684182107287;4595.724256544618;4762.59517940972;4886.071646387175;5162.767675454614;5199.454057324002;5344.732763361894;1331.5805521260772;1344.8318960129984;1353.945842166322;1354.5665387076042;1356.9660758481116;736.5122452645733;783.4789864739998;836.3601844588894;841.6591280531395;846.551327796269;3744.3260213161348;3790.6019867914024;3944.901377465529;4262.42457268271;4298.398224248608;4702.811887524529;4704.9059018819435;4713.363695901078;4739.597134243559;4770.475247722748;3574.660407261306;4258.467691538558;4262.808173632194;4276.097136774106;4285.97857010713;2484.5403600334;2500.324912273676;2683.7584617384528;3020.8036477629325;3029.9699201535022;5273.5781137509675;5793.507551858055;5824.825255242349;5932.508346494483;5954.285485741739;5048.899022019539;5565.471280228372;5627.549796016309;5811.941880581225;5829.854253643693;5829.3296270927685;5833.416658334218;5872.970635146797;5891.351951285441;5896.941030589725;5643.9963812845845;5664;5669.574781891457;5691.345495267931;5696.572757043155;4904.534069263557;5048.752766644786;5182.870428239174;5591.664500130005;5621.269234999424;5905.704714764331;5907.852303692442;5913.04347826087;5937.901488224692;5983.491403230774;3783.9566634018424;3797.6771974382486;3806.4290356446754;3813.5995720450064;3843.5195600549932;4884.8290309838985;5340.465953404629;5482.369527504388;5576.828865938199;5701.462849032141;5346.8395948121615;5503.257060296809;5531.944680553304;5542.168674698827;5543.77824887;4898.657094003385;5507.862303442446;5520.227168196536;5521.585881058856;5575.581831362583;4287.914241715086;4732.455767586772;5026.361160390824;5381.48875856793;5492.560595152298;5347.529429406789;5457.781688732565;5501.312335958005;5523.558115350843;5525.723713814213;4595.3566500690595;4880.633952453509;4921.040397122527;5444.584408053855;5473.261109750133 02:33:57 INFO - PROCESS | 1941 | |5;yui.html;721.8989341492191;727.6943683652869;759;768.416003837084;837.1921096142223;14858.182799946013;15672.686546269068;15696;15698.136602486858;15706.921465392687;14286.85713142871;14289.571312860604;14290.92854535726;14300;14621.415143394252;679.2629996453853;698.874202643524;826.9297109745679;840.7645859159445;867.5575456517158;822.2763967708408;839.5802098950525;840.5587066789953;842.7050532313702;846.1031306814765;906.0169715858302;906.1165363770305;906.5965645287849;906.9093090690911;907.8547432410816;714.1251966341242;816.1185919207242;899.132337294514;900.2662829793697;902.9954850225772;676.1311714446912;676.719161547957;679.0798468075785;680.6766785776766;681.3288910423229;14566.563003109817;14572.781408278885;14580.125192488485;14591.70816583673;14595.124292542481;13383.86616133836;13606.31968401576;13709.383077761524;13803.447862085504;14036.71926561463;12230.694232644166;12339.814902776465;12380.380980950917;12858.935705321506;12919.547815826401;3794.8671796487265;4386.736795792231;4458.509563947963;4470.798814053375;4527.456705195397;112254;116142;117170.41414792872;118059.40970295093;119058;10245.948770256102;10497.790044199226;10744.785104297871;10847.457627118612;11216.887831121585;19539.413817585497;19938.302159424642;20010.799892000894;20014.29949951745;20014.399568012985;7501.362384197295;7587.772366829004;7782.649780759766;7866.685332586632;8123.5532045738055;4240.342746874239;4304.225239456865;4365.083332500147;4438.889027774267;4487.169873573399;3477.4088404971217;3630.2920930418313;3632.800195989193;3636.9272614547563;3650.908727281839;553.3995614757952;669.8626781509779;676.0467740485891;676.5906626491001;677.1907570453261;601.2272987006569;630.7666163519435;649.574528683713;679.5243329669252;690.623610132479;9364.906350936404;9435.150836424755;9556.76108097303;9566.521673916277;9607.13535781783;637.5983130627675;641.8363317354139;663.366485006827;667.3793372163934;679.6907407129744;3768.3217020935945;4372.4315838941375;4483.932741008887;4580.679352445363;4599.2871104978785;140242.06732091037;142870;148587;149174;149865;108006;114944.27583586253;116105;128546;131938;96334.51832740931;112221.43889280665;113045;113102;115326;8751.51866647315;8755.60599772999;8784.165504277084;8817.470951742916;8978.86531702012;47960;60207;62304.376956229855;62529.374706252354;63527.6823615879;90208;91275;92339.53830230806;92884;94903;11579.8263026053;11688.70778230551;11696.181267311207;11871.228370155912;12111.697207569881;13213.603591892259;13227.589569578342;13344.666383340495;13864.930675346559;13880.51418200358;11802;12048.75902481963;12059.819102713642;12185.69535761613;12363.196392234477;10255.128314093387;11898.107641926717;11966.64100076999;11985.460654270753;12132.939335303266;11730.589429370273;13086.803697944348;13275.468981241029;13715.177089374669;14149.504767333507;10078.647247346307;10733.409662468639;11250.268732532359;11312.830307545559;11328.32030078198;10764.246502744732;11149.442527873736;11340.546378144782;11361.488733006869;11477.024452921261 02:33:57 INFO - PROCESS | 1941 | __end_tp_report 02:33:57 INFO - PROCESS | 1941 | __start_cc_report 02:33:57 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,1367 02:33:57 INFO - PROCESS | 1941 | __end_cc_report 02:33:57 INFO - PROCESS | 1941 | __startTimestamp1472981637712__endTimestamp 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | ------- Summary: start ------- 02:33:57 INFO - PROCESS | 1941 | Number of tests: 6 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | [#0] dojo.html Cycles:165 Average:5713.66 Median:5960.46 stddev:643.45 (10.8%) stddev-sans-first:616.45 02:33:57 INFO - PROCESS | 1941 | Values: 3279.8 3320.4 3327.4 3352.8 3392.9 5590.5 5696.5 5724.1 5750.0 5788.3 4603.9 5674.5 5755.7 5783.2 5805.9 5113.5 5117.4 5188.2 5197.2 5266.6 5252.1 5271.3 5286.2 5296.2 5309.9 5146.9 5149.6 5183.5 5193.0 5222.2 5191.6 5192.2 5194.9 5218.9 5219.8 5185.3 5188.4 5190.3 5198.9 5208.1 5592.2 5607.6 5641.3 5724.7 5747.2 6125.5 6152.0 6186.6 6192.3 6194.6 6166.8 6233.1 6237.7 6254.2 6258.1 5612.5 5700.2 5702.4 5704.2 5730.7 6171.0 6229.3 6250.8 6268.2 6279.4 6094.5 6116.2 6116.6 6123.1 6166.8 6188.6 6229.0 6245.7 6251.9 6257.2 6206.2 6220.5 6225.8 6230.4 6230.9 6039.5 6102.0 6103.4 6123.2 6216.6 4869.2 4884.3 4887.8 4914.2 4956.1 4256.4 4434.7 4455.5 4474.1 4476.1 5713.9 5719.1 5724.5 5725.5 5733.0 6132.6 6208.1 6254.8 6255.1 6263.2 5622.3 5625.9 5628.4 5631.4 5634.3 5375.9 5386.6 5388.5 5390.5 5391.1 6165.2 6207.6 6216.4 6252.2 6256.6 6228.4 6279.2 6281.8 6290.9 6295.1 6319.6 6323.8 6323.8 6326.1 6348.7 6064.2 6125.4 6134.6 6184.0 6192.6 6137.1 6226.6 6229.2 6257.7 6264.2 5064.4 6000.0 6054.8 6070.7 6107.8 5929.7 5947.9 5960.5 6086.7 6128.1 5422.7 5522.6 5943.3 6035.8 6038.2 6142.5 6154.4 6168.2 6171.0 6171.4 5731.2 6006.9 6007.7 6011.9 6052.1 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | [#1] ext.html Cycles:180 Average:68948.26 Median:19902.18 stddev:150779.18 (757.6%) stddev-sans-first:151114.58 02:33:57 INFO - PROCESS | 1941 | Values: 503.6 514.0 514.7 521.5 545.1 29170.0 38159.8 39339.8 39343.0 41578.4 40810.6 41412.0 41440.6 41459.0 41494.2 8597.2 9556.0 9719.8 9730.4 9735.0 8698.3 11633.2 11900.5 11919.0 12119.3 11951.9 11960.4 12020.7 12022.6 12071.6 11972.8 12054.6 12068.2 12086.9 12092.0 11715.9 11784.5 11801.8 11820.1 11836.6 38608.6 38863.0 38941.8 38972.0 38973.0 2764.9 3298.4 3367.7 3383.6 3514.3 28677.0 29589.9 30636.8 30651.5 30667.8 2709.6 3355.3 3376.5 3417.8 3421.2 488666.0 489966.0 490469.0 491080.5 501572.5 57952.0 58003.7 58257.4 58385.0 58483.1 51837.0 60570.0 61688.1 61869.0 61949.0 15471.1 15757.0 15770.1 15790.2 15794.4 10871.6 11077.8 11792.6 11999.8 12064.2 17851.4 18172.7 18185.5 18200.8 18487.9 6675.8 7742.5 7800.9 7812.6 7933.1 777.9 896.6 998.6 1012.7 1028.6 27928.9 28341.1 29099.8 29392.0 29794.3 954.0 1020.2 1044.2 1049.4 1050.3 14568.6 15041.2 15246.4 15320.2 15455.5 657082.0 657186.0 657795.4 658846.7 659109.0 54483.7 55230.9 55246.4 55262.9 55308.4 1213.3 1324.8 1355.9 1356.3 1362.1 29266.9 30342.8 30606.5 30673.1 30788.4 45759.0 46233.1 46443.8 46453.8 46467.5 525306.0 529044.0 529668.0 529999.0 531075.0 25472.7 26180.7 26212.7 27214.9 27307.0 44845.6 45369.0 46066.8 46125.3 46620.1 36421.6 37045.9 37591.7 37601.6 37753.2 36757.3 37108.4 37855.4 38245.0 38254.7 36290.1 36724.1 37514.8 37518.6 37627.4 30152.2 33230.7 33242.5 33245.8 33558.0 24068.5 24071.2 24339.3 24930.8 24945.4 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | [#2] jquery.html Cycles:180 Average:33502.39 Median:13898.34 stddev:93959.05 (676.0%) stddev-sans-first:94189.66 02:33:57 INFO - PROCESS | 1941 | Values: 349.2 365.2 367.8 376.5 400.3 15395.1 16259.3 19951.5 20369.9 20502.3 19430.8 20151.3 21077.0 21440.0 21476.9 5204.0 5285.9 5475.9 5484.7 5490.0 5396.8 5497.6 5499.9 5500.1 5512.0 3903.2 5792.9 6072.3 6131.0 6189.8 5858.6 6052.7 6136.8 6157.9 6158.3 4998.5 5897.9 5912.3 5920.7 5932.6 13026.5 19615.8 24295.8 24826.9 25137.4 2250.3 2274.0 2335.4 2659.3 2988.6 9980.8 10302.1 10371.8 14951.3 15859.6 1629.7 1862.4 1889.0 1934.1 1978.2 84689.6 105783.0 122964.0 123140.0 126961.1 10809.2 11108.8 11286.0 11329.9 11620.9 14308.7 14326.4 14332.5 14345.9 14354.0 6963.9 8011.0 8290.6 8301.0 8400.0 6625.7 8152.9 8160.6 8323.5 8364.0 4475.9 4482.9 4490.0 4503.9 4566.4 1697.3 1701.5 1841.5 1905.1 1908.5 676.3 698.7 882.9 909.5 916.9 19897.5 21195.8 21252.0 21491.4 21939.7 780.5 822.3 914.6 917.8 939.1 11125.4 11238.4 11264.0 11300.6 11387.7 555148.0 556037.0 558358.0 568253.0 573200.0 119844.4 120123.0 122332.0 123766.0 125991.0 867.5 958.1 959.5 973.1 980.4 18073.6 18582.1 18602.0 18708.9 18720.3 50180.5 51342.7 52521.0 53553.7 54456.0 75221.6 76090.6 76763.2 77595.6 77889.6 6378.7 6850.0 7617.6 8029.0 8231.6 10433.7 13089.0 13163.3 13451.9 13597.1 10891.3 10970.0 11019.3 11511.9 11675.8 10585.8 11207.7 11299.2 11583.1 11741.8 10307.8 10519.1 11030.7 11050.0 11902.6 6913.6 7046.3 7998.4 8086.2 8222.1 10815.0 10880.4 11037.9 11134.8 11443.6 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | [#3] mootools.html Cycles:180 Average:5644.22 Median:4949.56 stddev:3156.13 (63.8%) stddev-sans-first:3149.44 02:33:57 INFO - PROCESS | 1941 | Values: 1476.3 1535.5 1683.6 1756.4 1932.2 8300.9 8813.3 8816.3 8828.5 8830.6 7009.0 7689.2 7912.2 8333.2 8550.4 2354.6 2383.0 2383.9 2384.2 2401.4 2341.0 2357.4 2390.4 2390.9 2392.4 1746.7 2171.8 2176.7 2177.8 2301.8 2038.3 2365.6 2388.8 2391.3 2401.1 2342.8 2365.8 2367.0 2367.4 2370.3 7529.4 8683.4 8779.4 8788.0 8792.3 5161.1 5272.2 5346.0 5353.5 5357.7 2993.5 3446.2 3630.1 3635.7 3637.8 1012.5 1077.5 1106.0 1110.1 1111.5 11590.0 11616.1 11639.0 11640.1 11659.1 4437.7 4566.4 4724.0 4735.8 4745.5 9856.6 9865.7 9866.0 9882.8 9933.6 5272.0 5282.9 5282.9 5285.1 5289.4 4701.0 4794.8 4828.2 4838.0 4859.4 3864.8 3874.6 3895.4 3954.1 3988.2 1266.4 1267.8 1272.7 1277.2 1295.0 810.2 852.2 885.4 893.5 935.8 5718.4 5718.7 5949.4 5965.7 6082.7 937.2 948.4 949.2 955.4 977.2 3469.0 3885.6 3918.0 3925.2 4010.8 10472.8 10689.4 10780.8 10811.6 10822.5 10748.1 10751.2 10771.8 10778.8 10790.8 7015.6 7695.4 7942.4 8132.6 8160.8 5813.5 5836.6 5858.5 5939.3 6045.5 9779.4 10046.0 10049.4 10050.5 10057.0 8894.9 9311.5 9582.8 10056.1 10184.4 7107.4 7420.9 7599.9 7607.4 7624.3 7657.0 8234.0 8243.1 8252.9 8255.5 7144.2 7299.5 7425.5 7514.9 7632.0 7219.7 7375.9 7405.4 7436.8 7488.7 6845.7 6972.7 6982.5 6982.5 6987.8 4449.2 4833.9 4973.7 5022.7 5035.0 4895.9 4905.4 4925.5 5168.3 5184.3 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | [#4] prototype.html Cycles:180 Average:4370.30 Median:4709.13 stddev:1357.25 (28.8%) stddev-sans-first:1325.54 02:33:57 INFO - PROCESS | 1941 | Values: 261.0 261.3 267.6 271.5 304.7 4431.8 4501.3 4638.8 5177.4 5283.5 4666.5 5034.9 5064.4 5229.5 5271.4 3343.8 3985.3 4043.9 4052.3 4056.5 3802.9 3861.9 4027.1 4032.5 4058.9 3801.6 3964.2 3980.2 4003.6 4003.7 3315.6 3988.5 3992.1 3994.6 4011.8 2877.4 3202.6 3335.9 3480.5 3540.0 4308.7 4764.8 4856.9 5053.3 5077.4 3929.5 4500.4 4530.6 4538.9 4542.8 4680.6 4693.9 5416.9 5434.1 5453.2 3583.5 3632.3 3815.6 3821.5 3859.0 4957.0 5668.1 5691.7 5720.0 5720.8 3399.3 3773.9 3857.5 3903.9 3907.8 3732.6 3909.6 3931.2 3954.3 3986.7 4166.7 4279.8 4413.7 4511.7 4595.7 4762.6 4886.1 5162.8 5199.5 5344.7 1331.6 1344.8 1353.9 1354.6 1357.0 736.5 783.5 836.4 841.7 846.6 3744.3 3790.6 3944.9 4262.4 4298.4 4702.8 4704.9 4713.4 4739.6 4770.5 3574.7 4258.5 4262.8 4276.1 4286.0 2484.5 2500.3 2683.8 3020.8 3030.0 5273.6 5793.5 5824.8 5932.5 5954.3 5048.9 5565.5 5627.5 5811.9 5829.9 5829.3 5833.4 5873.0 5891.4 5896.9 5644.0 5664.0 5669.6 5691.3 5696.6 4904.5 5048.8 5182.9 5591.7 5621.3 5905.7 5907.9 5913.0 5937.9 5983.5 3784.0 3797.7 3806.4 3813.6 3843.5 4884.8 5340.5 5482.4 5576.8 5701.5 5346.8 5503.3 5531.9 5542.2 5543.8 4898.7 5507.9 5520.2 5521.6 5575.6 4287.9 4732.5 5026.4 5381.5 5492.6 5347.5 5457.8 5501.3 5523.6 5525.7 4595.4 4880.6 4921.0 5444.6 5473.3 02:33:57 INFO - PROCESS | 1941 | 02:33:57 INFO - PROCESS | 1941 | [#5] yui.html Cycles:180 Average:24429.92 Median:3631.55 stddev:39196.82 (1079.3%) stddev-sans-first:39266.36 02:33:57 INFO - PROCESS | 1941 | Values: 721.9 727.7 759.0 768.4 837.2 14858.2 15672.7 15696.0 15698.1 15706.9 14286.9 14289.6 14290.9 14300.0 14621.4 679.3 698.9 826.9 840.8 867.6 822.3 839.6 840.6 842.7 846.1 906.0 906.1 906.6 906.9 907.9 714.1 816.1 899.1 900.3 903.0 676.1 676.7 679.1 680.7 681.3 14566.6 14572.8 14580.1 14591.7 14595.1 13383.9 13606.3 13709.4 13803.4 14036.7 12230.7 12339.8 12380.4 12858.9 12919.5 3794.9 4386.7 4458.5 4470.8 4527.5 112254.0 116142.0 117170.4 118059.4 119058.0 10245.9 10497.8 10744.8 10847.5 11216.9 19539.4 19938.3 20010.8 20014.3 20014.4 7501.4 7587.8 7782.6 7866.7 8123.6 4240.3 4304.2 4365.1 4438.9 4487.2 3477.4 3630.3 3632.8 3636.9 3650.9 553.4 669.9 676.0 676.6 677.2 601.2 630.8 649.6 679.5 690.6 9364.9 9435.2 9556.8 9566.5 9607.1 637.6 641.8 663.4 667.4 679.7 3768.3 4372.4 4483.9 4580.7 4599.3 140242.1 142870.0 148587.0 149174.0 149865.0 108006.0 114944.3 116105.0 128546.0 131938.0 96334.5 112221.4 113045.0 113102.0 115326.0 8751.5 8755.6 8784.2 8817.5 8978.9 47960.0 60207.0 62304.4 62529.4 63527.7 90208.0 91275.0 92339.5 92884.0 94903.0 11579.8 11688.7 11696.2 11871.2 12111.7 13213.6 13227.6 13344.7 13864.9 13880.5 11802.0 12048.8 12059.8 12185.7 12363.2 10255.1 11898.1 11966.6 11985.5 12132.9 11730.6 13086.8 13275.5 13715.2 14149.5 10078.6 10733.4 11250.3 11312.8 11328.3 10764.2 11149.4 11340.5 11361.5 11477.0 02:33:57 INFO - PROCESS | 1941 | -------- Summary: end -------- 02:33:57 INFO - PROCESS | 1941 | 02:33:58 INFO - TEST-INFO | 1941: exit 0 02:33:58 INFO - TEST-OK | dromaeo_css | took 1118232ms 02:33:58 INFO - TEST-START | kraken 02:33:58 INFO - operating with platform_type : mac_ 02:33:58 INFO - Initialising browser for kraken test... 02:33:58 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpFGaSQn/profile http://localhost:57255/getInfo.html) 02:34:00 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 02:34:00 INFO - PROCESS | 1944 | colorDepth:24 02:34:00 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 02:34:00 INFO - PROCESS | 1944 | __metrics 02:34:00 INFO - PROCESS | 1944 | 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" 02:34:00 INFO - PROCESS | 1944 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:01 INFO - TEST-INFO | 1944: exit 0 02:34:01 INFO - Browser initialized. 02:34:01 INFO - Running cycle 1/1 for kraken test... 02:34:01 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpFGaSQn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:13 INFO - PROCESS | 1945 | RSS: Main: 233603072 02:34:13 INFO - PROCESS | 1945 | 02:34:16 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57255/tests/kraken/driver.html?testName=audio-beat-detection) 02:34:16 INFO - PROCESS | 1945 | RSS: Main: 293703680 02:34:16 INFO - PROCESS | 1945 | 02:34:19 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57255/tests/kraken/driver.html?testName=audio-dft) 02:34:20 INFO - PROCESS | 1945 | RSS: Main: 290009088 02:34:20 INFO - PROCESS | 1945 | 02:34:23 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57255/tests/kraken/driver.html?testName=audio-fft) 02:34:24 INFO - PROCESS | 1945 | RSS: Main: 378630144 02:34:24 INFO - PROCESS | 1945 | 02:34:26 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57255/tests/kraken/driver.html?testName=audio-oscillator) 02:34:27 INFO - PROCESS | 1945 | RSS: Main: 282062848 02:34:27 INFO - PROCESS | 1945 | 02:34:29 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57255/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:29 INFO - PROCESS | 1945 | RSS: Main: 285712384 02:34:29 INFO - PROCESS | 1945 | 02:34:32 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57255/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:33 INFO - PROCESS | 1945 | RSS: Main: 324628480 02:34:33 INFO - PROCESS | 1945 | 02:34:36 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57255/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:36 INFO - PROCESS | 1945 | RSS: Main: 323440640 02:34:36 INFO - PROCESS | 1945 | 02:34:39 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57255/tests/kraken/driver.html?testName=json-parse-financial) 02:34:40 INFO - PROCESS | 1945 | RSS: Main: 323002368 02:34:40 INFO - PROCESS | 1945 | 02:34:41 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57255/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:42 INFO - PROCESS | 1945 | RSS: Main: 296513536 02:34:42 INFO - PROCESS | 1945 | 02:34:44 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:34:45 INFO - PROCESS | 1945 | RSS: Main: 303026176 02:34:45 INFO - PROCESS | 1945 | 02:34:47 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:48 INFO - PROCESS | 1945 | RSS: Main: 304758784 02:34:48 INFO - PROCESS | 1945 | 02:34:50 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:51 INFO - PROCESS | 1945 | RSS: Main: 323035136 02:34:51 INFO - PROCESS | 1945 | 02:34:54 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:55 INFO - PROCESS | 1945 | RSS: Main: 318996480 02:34:55 INFO - PROCESS | 1945 | 02:34:56 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:57255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57255/tests/kraken/driver.html?testName=ai-astar) 02:34:57 INFO - PROCESS | 1945 | RSS: Main: 362631168 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | __start_tp_report 02:34:57 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 02:34:57 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 02:34:57 INFO - PROCESS | 1945 | |i|pagename|runs| 02:34:57 INFO - PROCESS | 1945 | |0;ai-astar;120;169;128;115;113;114;115;114;113;125 02:34:57 INFO - PROCESS | 1945 | |1;audio-beat-detection;150;109;138;197;109;130;131;107;165;107 02:34:57 INFO - PROCESS | 1945 | |2;audio-dft;187;186;185;181;183;186;185;186;186;184 02:34:57 INFO - PROCESS | 1945 | |3;audio-fft;76;73;80;160;59;59;59;68;147;77 02:34:57 INFO - PROCESS | 1945 | |4;audio-oscillator;81;82;139;70;69;76;121;69;70;120 02:34:57 INFO - PROCESS | 1945 | |5;imaging-gaussian-blur;88;85;89;85;88;85;90;124;88;85 02:34:57 INFO - PROCESS | 1945 | |6;imaging-darkroom;108;148;147;110;147;149;107;94;92;94 02:34:57 INFO - PROCESS | 1945 | |7;imaging-desaturate;83;86;84;88;84;84;91;132;84;85 02:34:57 INFO - PROCESS | 1945 | |8;json-parse-financial;54;54;58;56;55;53;53;53;53;53 02:34:57 INFO - PROCESS | 1945 | |9;json-stringify-tinderbox;67;65;72;75;72;77;70;68;71;71 02:34:57 INFO - PROCESS | 1945 | |10;stanford-crypto-aes;90;86;85;86;88;89;84;85;88;86 02:34:57 INFO - PROCESS | 1945 | |11;stanford-crypto-ccm;134;137;135;151;131;160;149;153;180;146 02:34:57 INFO - PROCESS | 1945 | |12;stanford-crypto-pbkdf2;171;167;170;170;173;170;171;170;171;169 02:34:57 INFO - PROCESS | 1945 | |13;stanford-crypto-sha256-iterative;67;69;63;61;76;83;85;86;88;68 02:34:57 INFO - PROCESS | 1945 | __end_tp_report 02:34:57 INFO - PROCESS | 1945 | __start_cc_report 02:34:57 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,2064 02:34:57 INFO - PROCESS | 1945 | __end_cc_report 02:34:57 INFO - PROCESS | 1945 | __startTimestamp1472981697202__endTimestamp 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | ------- Summary: start ------- 02:34:57 INFO - PROCESS | 1945 | Number of tests: 14 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#0] ai-astar Cycles:10 Average:122.60 Median:117.50 stddev:17.13 (14.6%) stddev-sans-first:18.15 02:34:57 INFO - PROCESS | 1945 | Values: 120.0 169.0 128.0 115.0 113.0 114.0 115.0 114.0 113.0 125.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:134.50 stddev:29.69 (22.1%) stddev-sans-first:30.94 02:34:57 INFO - PROCESS | 1945 | Values: 150.0 109.0 138.0 197.0 109.0 130.0 131.0 107.0 165.0 107.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#2] audio-dft Cycles:10 Average:184.90 Median:186.00 stddev:1.79 (1.0%) stddev-sans-first:1.73 02:34:57 INFO - PROCESS | 1945 | Values: 187.0 186.0 185.0 181.0 183.0 186.0 185.0 186.0 186.0 184.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#3] audio-fft Cycles:10 Average:85.80 Median:70.50 stddev:36.66 (52.0%) stddev-sans-first:38.71 02:34:57 INFO - PROCESS | 1945 | Values: 76.0 73.0 80.0 160.0 59.0 59.0 59.0 68.0 147.0 77.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:70.00 stddev:26.42 (37.7%) stddev-sans-first:27.84 02:34:57 INFO - PROCESS | 1945 | Values: 81.0 82.0 139.0 70.0 69.0 76.0 121.0 69.0 70.0 120.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:88.00 stddev:11.85 (13.5%) stddev-sans-first:12.53 02:34:57 INFO - PROCESS | 1945 | Values: 88.0 85.0 89.0 85.0 88.0 85.0 90.0 124.0 88.0 85.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#6] imaging-darkroom Cycles:10 Average:119.60 Median:148.50 stddev:25.01 (16.8%) stddev-sans-first:26.17 02:34:57 INFO - PROCESS | 1945 | Values: 108.0 148.0 147.0 110.0 147.0 149.0 107.0 94.0 92.0 94.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:84.50 stddev:14.92 (17.7%) stddev-sans-first:15.60 02:34:57 INFO - PROCESS | 1945 | Values: 83.0 86.0 84.0 88.0 84.0 84.0 91.0 132.0 84.0 85.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.69 (3.1%) stddev-sans-first:1.79 02:34:57 INFO - PROCESS | 1945 | Values: 54.0 54.0 58.0 56.0 55.0 53.0 53.0 53.0 53.0 53.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.50 stddev:3.58 (5.0%) stddev-sans-first:3.53 02:34:57 INFO - PROCESS | 1945 | Values: 67.0 65.0 72.0 75.0 72.0 77.0 70.0 68.0 71.0 71.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:1.95 (2.2%) stddev-sans-first:1.66 02:34:57 INFO - PROCESS | 1945 | Values: 90.0 86.0 85.0 86.0 88.0 89.0 84.0 85.0 88.0 86.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:150.00 stddev:14.83 (9.9%) stddev-sans-first:14.90 02:34:57 INFO - PROCESS | 1945 | Values: 134.0 137.0 135.0 151.0 131.0 160.0 149.0 153.0 180.0 146.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.50 stddev:1.55 (0.9%) stddev-sans-first:1.62 02:34:57 INFO - PROCESS | 1945 | Values: 171.0 167.0 170.0 170.0 173.0 170.0 171.0 170.0 171.0 169.0 02:34:57 INFO - PROCESS | 1945 | 02:34:57 INFO - PROCESS | 1945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:79.50 stddev:10.23 (12.9%) stddev-sans-first:10.48 02:34:57 INFO - PROCESS | 1945 | Values: 67.0 69.0 63.0 61.0 76.0 83.0 85.0 86.0 88.0 68.0 02:34:57 INFO - PROCESS | 1945 | -------- Summary: end -------- 02:34:57 INFO - PROCESS | 1945 | 02:34:58 INFO - TEST-INFO | 1945: exit 0 02:34:58 INFO - TEST-OK | kraken | took 59769ms 02:34:58 INFO - SUITE-END | took 1178s 02:34:58 INFO - Completed test suite (00:19:38) 02:34:58 INFO - javascript benchmark 02:34:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.754018448617, 3320.418926687829, 3327.4010678077943, 3352.815595142269, 3392.932141357173, 5590.468905453975, 5696.487316141546, 5724.084146536555, 5750.0, 5788.276465441825, 4603.907921841561, 5674.517665998395, 5755.712214389285, 5783.190353350524, 5805.941940580593, 5113.488651134875, 5117.437081920985, 5188.195829646411, 5197.194434862602, 5266.605004624649, 5252.107141785887, 5271.288376069239, 5286.233496143057, 5296.205569164617, 5309.946900531003, 5146.897062058775, 5149.639525233235, 5183.45573714762, 5193.013327467769, 5222.190560463135, 5191.610629202825, 5192.221166824968, 5194.92207616886, 5218.895622087537, 5219.817306394296, 5185.325907632021, 5188.403333616607, 5190.299309593194, 5198.9480105198845, 5208.114620514521, 5592.245046918695, 5607.57943154261, 5641.266635337421, 5724.742386592613, 5747.195392645033, 6125.479334256594, 6151.969240153815, 6186.597871138361, 6192.28788689302, 6194.628322300677, 6166.7533298667995, 6233.1273621693, 6237.719302631393, 6254.21822272216, 6258.092576576417, 5612.5229355504425, 5700.230468886689, 5702.372738998707, 5704.22992895962, 5730.713464326809, 6170.969145154246, 6229.252489701174, 6250.812475625738, 6268.153799237136, 6279.434850863444, 6094.451499365078, 6116.235470566179, 6116.571839971249, 6123.081537769282, 6166.845828854314, 6188.597741146811, 6229.0, 6245.687715614201, 6251.906221406683, 6257.155284036688, 6206.224221972254, 6220.471259942956, 6225.844353891189, 6230.408111229426, 6230.906536401958, 6039.516838652898, 6101.993171126803, 6103.35914728956, 6123.221615589998, 6216.627002379872, 4869.245266983623, 4884.340614017062, 4887.804487820518, 4914.238293064581, 4956.083124621957, 4256.404103425523, 4434.667399945017, 4455.465344158657, 4474.105178964221, 4476.060027394218, 5713.914291285634, 5719.056355701346, 5724.542036637059, 5725.51333136688, 5733.0, 6132.600268413531, 6208.1308616793685, 6254.8123556293385, 6255.12428260044, 6263.154474145932, 5622.269105016322, 5625.887482250332, 5628.437156284339, 5631.436856314418, 5634.32388113429, 5375.946240537544, 5386.649867758583, 5388.488093631099, 5390.460953904657, 5391.110466772939, 6165.167702360124, 6207.6275423474735, 6216.409441103088, 6252.218472690914, 6256.624602523772, 6228.377162283917, 6279.246490421178, 6281.811545653638, 6290.937090629035, 6295.087212354275, 6319.58922670025, 6323.810285691437, 6323.841903952438, 6326.114343991753, 6348.746050157942, 6064.181335519825, 6125.448709616156, 6134.601250918676, 6183.96908015475, 6192.59748116389, 6137.131844484677, 6226.59527130735, 6229.1590635265475, 6257.7184026719815, 6264.154339164154, 5064.366954130734, 5999.98000339952, 6054.757809687563, 6070.726817293321, 6107.786227482017, 5929.673867937305, 5947.881042379042, 5960.4635582797755, 6086.69566521681, 6128.142060111499, 5422.7256594701, 5522.5858060646415, 5943.286805583358, 6035.849103772441, 6038.184845046038, 6142.46326737159, 6154.415330543591, 6168.167297414791, 6171.043488259327, 6171.352008039271, 5731.226284451545, 6006.879862402815, 6007.729652165751, 6011.90982135277, 6052.061930400795], "value": 5672.302308422977, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.6323483856782, 514.0284861611552, 514.740056271583, 521.4863359590803, 545.057051301249, 29170.0, 38159.80920095403, 39339.819805405845, 39343.0, 41578.37632435516, 40810.591894081124, 41412.0, 41440.585594144046, 41458.963525911866, 41494.17011659765, 8597.18326758957, 9555.996620354867, 9719.75700607487, 9730.36752611078, 9734.951325243364, 8698.260647844942, 11633.185677002613, 11900.464479098462, 11918.986886114692, 12119.272843629366, 11951.880481195207, 11960.401979901013, 12020.69948251292, 12022.639320820346, 12071.637850864488, 11972.820407693891, 12054.578089766905, 12068.215565988183, 12086.939565302162, 12091.97218236451, 11715.882841171564, 11784.469698863571, 11801.763964720658, 11820.113491488173, 11836.644900652995, 38608.61391386078, 38863.0, 38941.80529097365, 38972.0, 38973.0, 2764.9447011059665, 3298.350824587706, 3367.696907278357, 3383.5950822035607, 3514.2620049789575, 28677.0, 29589.852050739824, 30636.846815766003, 30651.540226896614, 30667.846660766776, 2709.5529237675955, 3355.2786150977413, 3376.544166537535, 3417.8120203388803, 3421.2131209821882, 488666.0, 489966.0, 490469.0, 491080.5445972783, 501572.4921375406, 57952.0, 58003.70998144982, 58257.41742582605, 58385.0, 58483.122753158736, 51836.96326073458, 60570.0, 61688.07467887985, 61869.0, 61949.0, 15471.071735695894, 15756.975796573186, 15770.13264270476, 15790.21048947571, 15794.447194348142, 10871.619493317696, 11077.778444431066, 11792.646220613395, 11999.76000480003, 12064.215825971283, 17851.37520186787, 18172.727409088875, 18185.545361366072, 18200.817991819913, 18487.90756046238, 6675.7997260082275, 7742.458027937991, 7800.92199078002, 7812.6093695315, 7933.096056946407, 777.9222077792289, 896.5741272895323, 998.610541888664, 1012.711377257478, 1028.6039874648313, 27928.860355698092, 28341.149765507067, 29099.836006559923, 29392.0, 29794.255143621584, 953.9713808585753, 1020.1685626214611, 1044.2220545693356, 1049.3651340938775, 1050.2700623067049, 14568.562943111723, 15041.172735499435, 15246.390144394321, 15320.185339194364, 15455.459058932884, 657082.0, 657186.0, 657795.422045783, 658846.7057664681, 659109.0, 54483.72758136184, 55230.92459829416, 55246.44753552413, 55262.89474210493, 55308.44691553113, 1213.2902252182396, 1324.8476425211031, 1355.8711922367359, 1356.3421740455872, 1362.1078193783087, 29266.853665732386, 30342.78628854821, 30606.540901886045, 30673.06062630234, 30788.384232315675, 45759.0, 46233.07533849371, 46443.76778116088, 46453.767731161126, 46467.53532464632, 525306.0, 529044.0, 529668.0, 529999.0, 531075.0, 25472.745272547778, 26180.73819261859, 26212.73787262103, 27214.863925680245, 27307.0, 44845.55154448414, 45369.0, 46066.76966615146, 46125.30812037889, 46620.067598648515, 36421.635783641825, 37045.851102656576, 37591.684291049685, 37601.62398375981, 37753.24493510059, 36757.26485470222, 37108.443373348884, 37855.37547325478, 38245.0, 38254.74834639087, 36290.09274768152, 36724.08189795277, 37514.81242593769, 37518.624813752605, 37627.435588466746, 30152.24619384533, 33230.66769332276, 33242.50408731565, 33245.83377083099, 33558.0, 24068.51862962766, 24071.157509487082, 24339.26982190537, 24930.750692492842, 24945.376365591004], "value": 19920.310004355353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.15504479160427, 365.2238992141699, 367.7940353402095, 376.50113599480693, 400.28748827087776, 15395.076295422268, 16259.34962601496, 19951.501212469695, 20369.898150509263, 20502.28242011528, 19430.805691943075, 20151.29470468534, 21077.0, 21440.0, 21476.8926155369, 5203.973980130094, 5285.920711189336, 5475.890482190353, 5484.725763711818, 5490.0, 5396.757145928423, 5497.642653227547, 5499.917501237484, 5500.147477141049, 5512.0, 3903.1998440319667, 5792.855178620547, 6072.301685306202, 6131.0, 6189.783357582485, 5858.589898707092, 6052.697365131726, 6136.785212517563, 6157.938420615781, 6158.322584515699, 4998.500149985009, 5897.911531327033, 5912.320083190402, 5920.674362910038, 5932.614380065282, 13026.478940842355, 19615.803841961682, 24295.757042429526, 24826.875865620557, 25137.371565710822, 2250.313654335427, 2273.9545209095727, 2335.3927978725483, 2659.3085797692547, 2988.5666578346018, 9980.750481237954, 10302.124319432858, 10371.844422333672, 14951.327190276355, 15859.60350991223, 1629.7392417213307, 1862.3574866671113, 1888.9716654250196, 1934.1489744512369, 1978.1889425335544, 84689.57655211685, 105783.0, 122964.0, 123140.0, 126961.09558356632, 10809.243352965374, 11108.833367499494, 11285.984261416348, 11329.886701132884, 11620.941895290469, 14308.713825723635, 14326.426942922166, 14332.49836255726, 14345.928270358581, 14354.0, 6963.8607227855155, 8010.959945200237, 8290.585470726439, 8301.0, 8400.0, 6625.734970601122, 8152.8777068344025, 8160.551169685724, 8323.500589964622, 8364.0, 4475.910481790411, 4482.887927801831, 4490.012197316585, 4503.932441013388, 4566.383538222298, 1697.2871394014544, 1701.46403882779, 1841.5027942455463, 1905.0569967865995, 1908.4847091285276, 676.3009194542391, 698.7205117952758, 882.92495137914, 909.5315912305168, 916.8578870275118, 19897.502562435766, 21195.78804211938, 21252.0, 21491.355259342246, 21939.67090493644, 780.480980148195, 822.284612387227, 914.5518695839124, 917.8439665256923, 939.112538650982, 11125.388103654377, 11238.390708589344, 11264.0, 11300.604478843201, 11387.715307117223, 555148.0, 556037.0, 558358.0, 568253.0, 573200.0, 119844.42411426242, 120123.0, 122332.0, 123766.0, 125991.0, 867.509856930832, 958.1233171647864, 959.5106495687111, 973.1144658360857, 980.4362491567234, 18073.638527229647, 18582.070896454854, 18602.0, 18708.906455467637, 18720.344787932358, 50180.498195017586, 51342.74328628482, 52521.0, 53553.66115847135, 54456.0, 75221.61502732281, 76090.61954690191, 76763.2323676756, 77595.61202193952, 77889.61055194688, 6378.6810659467765, 6850.0, 7617.581033043236, 8029.0, 8231.629576668944, 10433.686989390331, 13089.0, 13163.341832908507, 13451.932740336235, 13597.116187447784, 10891.346519208873, 10970.0, 11019.283746556448, 11511.942440287745, 11675.824862626898, 10585.841212381667, 11207.719807004563, 11299.209055366046, 11583.073354131819, 11741.76516469683, 10307.793844123225, 10519.105876000625, 11030.669079927615, 11049.950254725789, 11902.642920712393, 6913.585184888922, 7046.330598593126, 7998.400119990907, 8086.15095414973, 8222.095569487232, 10815.026647601753, 10880.401577913291, 11037.889621103686, 11134.777304454028, 11443.599474018369], "value": 9344.872070618401, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.2618690654672, 1535.5393381985402, 1683.5538582275706, 1756.3852651571951, 1932.2271091563373, 8300.875486867695, 8813.338999575026, 8816.294696424287, 8828.470291782489, 8830.646774129027, 7008.96495517523, 7689.192634773352, 7912.169222231669, 8333.166683331663, 8550.358723095776, 2354.6114891043, 2382.988085059581, 2383.9284821455385, 2384.1655420602738, 2401.387646150229, 2340.9882950585225, 2357.422431504275, 2390.3785015895905, 2390.8685022323766, 2392.4138586046442, 1746.7205247160393, 2171.83711221659, 2176.6843807647883, 2177.7822217778253, 2301.7698230177016, 2038.2662241593014, 2365.6333268343346, 2388.773066558674, 2391.306521108868, 2401.0635852017726, 2342.8008619267384, 2365.7634236576378, 2367.0413482539425, 2367.3726462487452, 2370.3126093432884, 7529.4352923530405, 8683.392162548624, 8779.385443018991, 8788.0, 8792.296616270747, 5161.096808058613, 5272.18281166416, 5345.973270133663, 5353.491418315292, 5357.705326207057, 2993.4611769881412, 3446.190145315849, 3630.110622897407, 3635.745497815154, 3637.781733095996, 1012.4836333469909, 1077.4828082520355, 1105.9723506912312, 1110.134095405585, 1111.4553868604407, 11590.0, 11616.128790340757, 11638.999999999915, 11640.06879449642, 11659.12556558253, 4437.733735975852, 4566.383538222364, 4724.031573527419, 4735.8342458014495, 4745.454272758608, 9856.556454959544, 9865.704028879145, 9865.964073772295, 9882.80234395308, 9933.552990115462, 5272.0, 5282.867928301823, 5282.894342113136, 5285.07511185541, 5289.391719952255, 4701.0, 4794.7842347094465, 4828.203346447796, 4837.975810120927, 4859.3682821233015, 3864.7874366909527, 3874.554426240962, 3895.3962135868987, 3954.0905591714068, 3988.16248587794, 1266.4169787765293, 1267.790814515613, 1272.6818295426144, 1277.2145130744525, 1294.9805752913715, 810.1920382102777, 852.1648784191403, 885.371386315723, 893.5353616119581, 935.8034812689275, 5718.370979192286, 5718.656880587095, 5949.442675159305, 5965.701714914237, 6082.695865206722, 937.2267878999852, 948.3645957208687, 949.1505102932837, 955.4171955107379, 977.1791694976112, 3468.9826550867083, 3885.55316138642, 3917.9617401388655, 3925.1757131002237, 4010.819513121858, 10472.842907356397, 10689.412082335546, 10780.78438431227, 10811.567537298577, 10822.512986915608, 10748.140148788078, 10751.247412681194, 10771.78456430867, 10778.78442431147, 10790.838137427945, 7015.649217539205, 7695.422843286776, 7942.44402891792, 8132.55270960091, 8160.8367832641825, 5813.534917206698, 5836.591438599257, 5858.47273745365, 5939.2575928009, 6045.546584006129, 9779.41323520591, 10046.045625665842, 10049.447280399649, 10050.49747512636, 10057.044580764816, 8894.911050889408, 9311.487868167316, 9582.808343833223, 10056.094951454405, 10184.388936663823, 7107.360337569644, 7420.92579074224, 7599.886001709868, 7607.429442791702, 7624.313811756969, 7656.961715191388, 8234.0, 8243.134470880712, 8252.876206857021, 8255.545944973084, 7144.214136445091, 7299.5255308404785, 7425.480216385017, 7514.887276690744, 7631.961840190764, 7219.747308844166, 7375.856742204966, 7405.407567394488, 7436.847288670265, 7488.7004519820775, 6845.726170953106, 6972.721091156297, 6982.511224214256, 6982.51122421446, 6987.790366289019, 4449.221386257456, 4833.9033219334715, 4973.651844370859, 5022.748862556785, 5034.974825125851, 4895.926561101515, 4905.411350637946, 4925.45819959797, 5168.276441298296, 5184.326037615086], "value": 4545.368586454, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.95824668053115, 261.2840816163712, 267.57188498402553, 271.52889736307503, 304.74553747620735, 4431.756253406065, 4501.302298143789, 4638.768061596924, 5177.430482646906, 5283.524482796547, 4666.533346665332, 5034.949650503503, 5064.442911279756, 5229.529342359187, 5271.367435907687, 3343.765936384448, 3985.342418500944, 4043.898902527431, 4052.3111071117983, 4056.5132184137947, 3802.885913422602, 3861.9227615447676, 4027.0737730322044, 4032.4757781488365, 4058.9188216235657, 3801.562820275662, 3964.1873415949804, 3980.1890139986235, 4003.5996400359877, 4003.65968892643, 3315.635280119197, 3988.541317748467, 3992.141689536749, 3994.580569040267, 4011.7793521356316, 2877.4101309231555, 3202.5836641236724, 3335.916602084943, 3480.5301284326797, 3539.964600353989, 4308.655307575418, 4764.833230836939, 4856.9314750754775, 5053.343065401475, 5077.416097148801, 3929.469521614574, 4500.369948207221, 4530.592246697813, 4538.863834084983, 4542.750148741818, 4680.555347242007, 4693.929591056137, 5416.91874621881, 5434.070904828808, 5453.15476101205, 3583.4591125815887, 3632.3098611263777, 3815.6184381561898, 3821.464994900716, 3858.9614103858885, 4956.959038601898, 5668.149777533362, 5691.658500489901, 5720.0, 5720.797492965196, 3399.286149908547, 3773.867914622975, 3857.498525191707, 3903.902402439905, 3907.8241479133508, 3732.5894151643297, 3909.5504017038406, 3931.233409485123, 3954.307996100671, 3986.7009974252046, 4166.708320420679, 4279.764612946318, 4413.691041627056, 4511.684182107287, 4595.724256544618, 4762.59517940972, 4886.071646387175, 5162.767675454614, 5199.454057324002, 5344.732763361894, 1331.5805521260772, 1344.8318960129984, 1353.945842166322, 1354.5665387076042, 1356.9660758481116, 736.5122452645733, 783.4789864739998, 836.3601844588894, 841.6591280531395, 846.551327796269, 3744.3260213161348, 3790.6019867914024, 3944.901377465529, 4262.42457268271, 4298.398224248608, 4702.811887524529, 4704.9059018819435, 4713.363695901078, 4739.597134243559, 4770.475247722748, 3574.660407261306, 4258.467691538558, 4262.808173632194, 4276.097136774106, 4285.97857010713, 2484.5403600334, 2500.324912273676, 2683.7584617384528, 3020.8036477629325, 3029.9699201535022, 5273.5781137509675, 5793.507551858055, 5824.825255242349, 5932.508346494483, 5954.285485741739, 5048.899022019539, 5565.471280228372, 5627.549796016309, 5811.941880581225, 5829.854253643693, 5829.3296270927685, 5833.416658334218, 5872.970635146797, 5891.351951285441, 5896.941030589725, 5643.9963812845845, 5664.0, 5669.574781891457, 5691.345495267931, 5696.572757043155, 4904.534069263557, 5048.752766644786, 5182.870428239174, 5591.664500130005, 5621.269234999424, 5905.704714764331, 5907.852303692442, 5913.04347826087, 5937.901488224692, 5983.491403230774, 3783.9566634018424, 3797.6771974382486, 3806.4290356446754, 3813.5995720450064, 3843.5195600549932, 4884.8290309838985, 5340.465953404629, 5482.369527504388, 5576.828865938199, 5701.462849032141, 5346.8395948121615, 5503.257060296809, 5531.944680553304, 5542.168674698827, 5543.77824887, 4898.657094003385, 5507.862303442446, 5520.227168196536, 5521.585881058856, 5575.581831362583, 4287.914241715086, 4732.455767586772, 5026.361160390824, 5381.48875856793, 5492.560595152298, 5347.529429406789, 5457.781688732565, 5501.312335958005, 5523.558115350843, 5525.723713814213, 4595.3566500690595, 4880.633952453509, 4921.040397122527, 5444.584408053855, 5473.261109750133], "value": 3930.638669201025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.8989341492191, 727.6943683652869, 759.0, 768.416003837084, 837.1921096142223, 14858.182799946013, 15672.686546269068, 15696.0, 15698.136602486858, 15706.921465392687, 14286.85713142871, 14289.571312860604, 14290.92854535726, 14300.0, 14621.415143394252, 679.2629996453853, 698.874202643524, 826.9297109745679, 840.7645859159445, 867.5575456517158, 822.2763967708408, 839.5802098950525, 840.5587066789953, 842.7050532313702, 846.1031306814765, 906.0169715858302, 906.1165363770305, 906.5965645287849, 906.9093090690911, 907.8547432410816, 714.1251966341242, 816.1185919207242, 899.132337294514, 900.2662829793697, 902.9954850225772, 676.1311714446912, 676.719161547957, 679.0798468075785, 680.6766785776766, 681.3288910423229, 14566.563003109817, 14572.781408278885, 14580.125192488485, 14591.70816583673, 14595.124292542481, 13383.86616133836, 13606.31968401576, 13709.383077761524, 13803.447862085504, 14036.71926561463, 12230.694232644166, 12339.814902776465, 12380.380980950917, 12858.935705321506, 12919.547815826401, 3794.8671796487265, 4386.736795792231, 4458.509563947963, 4470.798814053375, 4527.456705195397, 112254.0, 116142.0, 117170.41414792872, 118059.40970295093, 119058.0, 10245.948770256102, 10497.790044199226, 10744.785104297871, 10847.457627118612, 11216.887831121585, 19539.413817585497, 19938.302159424642, 20010.799892000894, 20014.29949951745, 20014.399568012985, 7501.362384197295, 7587.772366829004, 7782.649780759766, 7866.685332586632, 8123.5532045738055, 4240.342746874239, 4304.225239456865, 4365.083332500147, 4438.889027774267, 4487.169873573399, 3477.4088404971217, 3630.2920930418313, 3632.800195989193, 3636.9272614547563, 3650.908727281839, 553.3995614757952, 669.8626781509779, 676.0467740485891, 676.5906626491001, 677.1907570453261, 601.2272987006569, 630.7666163519435, 649.574528683713, 679.5243329669252, 690.623610132479, 9364.906350936404, 9435.150836424755, 9556.76108097303, 9566.521673916277, 9607.13535781783, 637.5983130627675, 641.8363317354139, 663.366485006827, 667.3793372163934, 679.6907407129744, 3768.3217020935945, 4372.4315838941375, 4483.932741008887, 4580.679352445363, 4599.2871104978785, 140242.06732091037, 142870.0, 148587.0, 149174.0, 149865.0, 108006.0, 114944.27583586253, 116105.0, 128546.0, 131938.0, 96334.51832740931, 112221.43889280665, 113045.0, 113102.0, 115326.0, 8751.51866647315, 8755.60599772999, 8784.165504277084, 8817.470951742916, 8978.86531702012, 47960.0, 60207.0, 62304.376956229855, 62529.374706252354, 63527.6823615879, 90208.0, 91275.0, 92339.53830230806, 92884.0, 94903.0, 11579.8263026053, 11688.70778230551, 11696.181267311207, 11871.228370155912, 12111.697207569881, 13213.603591892259, 13227.589569578342, 13344.666383340495, 13864.930675346559, 13880.51418200358, 11802.0, 12048.75902481963, 12059.819102713642, 12185.69535761613, 12363.196392234477, 10255.128314093387, 11898.107641926717, 11966.64100076999, 11985.460654270753, 12132.939335303266, 11730.589429370273, 13086.803697944348, 13275.468981241029, 13715.177089374669, 14149.504767333507, 10078.647247346307, 10733.409662468639, 11250.268732532359, 11312.830307545559, 11328.32030078198, 10764.246502744732, 11149.442527873736, 11340.546378144782, 11361.488733006869, 11477.024452921261], "value": 7682.576223611932, "unit": "score"}], "name": "dromaeo_css", "value": 7247.740445480707, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 169.0, 128.0, 115.0, 113.0, 114.0, 115.0, 114.0, 113.0, 125.0], "value": 122.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 109.0, 138.0, 197.0, 109.0, 130.0, 131.0, 107.0, 165.0, 107.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 185.0, 181.0, 183.0, 186.0, 185.0, 186.0, 186.0, 184.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 80.0, 160.0, 59.0, 59.0, 59.0, 68.0, 147.0, 77.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 139.0, 70.0, 69.0, 76.0, 121.0, 69.0, 70.0, 120.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 85.0, 88.0, 85.0, 90.0, 124.0, 88.0, 85.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 148.0, 147.0, 110.0, 147.0, 149.0, 107.0, 94.0, 92.0, 94.0], "value": 119.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 88.0, 84.0, 84.0, 91.0, 132.0, 84.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 58.0, 56.0, 55.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 72.0, 75.0, 72.0, 77.0, 70.0, 68.0, 71.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 85.0, 86.0, 88.0, 89.0, 84.0, 85.0, 88.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 135.0, 151.0, 131.0, 160.0, 149.0, 153.0, 180.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 170.0, 170.0, 173.0, 170.0, 171.0, 170.0, 171.0, 169.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 63.0, 61.0, 76.0, 83.0, 85.0, 86.0, 88.0, 68.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1521.8, "alertThreshold": 2.0}]} 02:34:58 INFO - Return code: 0 02:34:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:34:58 INFO - # TBPL SUCCESS # 02:34:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:58 INFO - 2016-09-04 02:34:58.563 screenresolution[1949:24168] starting screenresolution argv=screenresolution get 02:34:58 INFO - 2016-09-04 02:34:58.566 screenresolution[1949:24168] Display 0: 1600x1200x32@60 02:34:58 INFO - 2016-09-04 02:34:58.572 screenresolution[1950:24171] starting screenresolution argv=screenresolution list 02:34:58 INFO - Available Modes on Display 0 02:34:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:58 INFO - Intel Iris: 02:34:58 INFO - Chipset Model: Intel Iris 02:34:58 INFO - Type: GPU 02:34:58 INFO - Bus: Built-In 02:34:58 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:58 INFO - Vendor: Intel (0x8086) 02:34:58 INFO - Device ID: 0x0a2e 02:34:58 INFO - Revision ID: 0x0009 02:34:58 INFO - Displays: 02:34:58 INFO - Display: 02:34:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:58 INFO - Display Serial Number: 1600x1200 60 02:34:58 INFO - Main Display: Yes 02:34:58 INFO - Mirror: Off 02:34:58 INFO - Online: Yes 02:34:58 INFO - Rotation: Supported 02:34:58 INFO - Return code: 0 02:34:58 INFO - Running post-action listener: _resource_record_post_action 02:34:58 INFO - [mozharness: 2016-09-04 09:34:58.808046Z] Finished run-tests step (success) 02:34:58 INFO - Running post-run listener: _resource_record_post_run 02:34:58 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 16384; Write bytes: 706561536; Read time: 1; Write time: 1951 02:34:58 INFO - TinderboxPrint: CPU usage
53.5% 02:34:58 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 1 02:34:58 INFO - TinderboxPrint: I/O write bytes / time
706,561,536 / 1,951 02:34:58 INFO - TinderboxPrint: CPU idle
2,256.9 (46.5%) 02:34:58 INFO - TinderboxPrint: CPU system
972.9 (20.0%) 02:34:58 INFO - TinderboxPrint: CPU user
1,623.8 (33.5%) 02:34:58 INFO - TinderboxPrint: Swap in / out
404,930,560 / 0 02:34:58 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391717376; Write bytes: 386131456; Read time: 29207; Write time: 762 02:34:58 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 16384; Write bytes: 298369024; Read time: 1; Write time: 1146 02:34:59 INFO - Running post-run listener: _upload_blobber_files 02:34:59 INFO - Blob upload gear active. 02:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:59 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 02:34:59 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'] 02:34:59 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 02:34:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:00 INFO - (blobuploader) - INFO - Done attempting. 02:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:01 INFO - (blobuploader) - INFO - Done attempting. 02:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:03 INFO - (blobuploader) - INFO - Done attempting. 02:35:03 INFO - (blobuploader) - INFO - Iteration through files over. 02:35:03 INFO - Return code: 0 02:35:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:35:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:35:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f899cbcbbf884f7e7a46a4133ff8add92e071e989ca443685f230a3c5eb56116412d69c434bcd537ebf3fdb30ef655ce5124ed2788363b023a4f6f49509d3f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b3b109b7c8fe88c589b25def27c96ac8784c9ac926e3236081bc66218899d432b387f07563fddd698571cbb0b743589839ec3a9ae1022a52d143fd058f1601b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0debb11a468e3880921968725dd58b0703bb0150c39f0fbe9b1c74f5f75dfcf626ea0be54a4c135b0cfbb0174b9039077af400a368f66be7a2a65ac4bd4af1e4"} 02:35:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:35:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:35:03 INFO - Contents: 02:35:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f899cbcbbf884f7e7a46a4133ff8add92e071e989ca443685f230a3c5eb56116412d69c434bcd537ebf3fdb30ef655ce5124ed2788363b023a4f6f49509d3f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b3b109b7c8fe88c589b25def27c96ac8784c9ac926e3236081bc66218899d432b387f07563fddd698571cbb0b743589839ec3a9ae1022a52d143fd058f1601b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0debb11a468e3880921968725dd58b0703bb0150c39f0fbe9b1c74f5f75dfcf626ea0be54a4c135b0cfbb0174b9039077af400a368f66be7a2a65ac4bd4af1e4"} 02:35:03 INFO - Running post-run listener: copy_logs_to_upload_dir 02:35:03 INFO - Copying logs to upload dir... 02:35:03 INFO - mkdir: /builds/slave/test/build/upload/logs 02:35:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.941848 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-04 02:35:04.054454) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-04 02:35:04.058015) ========= 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.0x5XGoQgSA/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.otNsG0tPBK/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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/f899cbcbbf884f7e7a46a4133ff8add92e071e989ca443685f230a3c5eb56116412d69c434bcd537ebf3fdb30ef655ce5124ed2788363b023a4f6f49509d3f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b3b109b7c8fe88c589b25def27c96ac8784c9ac926e3236081bc66218899d432b387f07563fddd698571cbb0b743589839ec3a9ae1022a52d143fd058f1601b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0debb11a468e3880921968725dd58b0703bb0150c39f0fbe9b1c74f5f75dfcf626ea0be54a4c135b0cfbb0174b9039077af400a368f66be7a2a65ac4bd4af1e4"} build_url:https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/UI8dXV3tRTyJRJeYgXitBQ/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/f899cbcbbf884f7e7a46a4133ff8add92e071e989ca443685f230a3c5eb56116412d69c434bcd537ebf3fdb30ef655ce5124ed2788363b023a4f6f49509d3f60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9b3b109b7c8fe88c589b25def27c96ac8784c9ac926e3236081bc66218899d432b387f07563fddd698571cbb0b743589839ec3a9ae1022a52d143fd058f1601b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0debb11a468e3880921968725dd58b0703bb0150c39f0fbe9b1c74f5f75dfcf626ea0be54a4c135b0cfbb0174b9039077af400a368f66be7a2a65ac4bd4af1e4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-04 02:35:04.094194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 02:35:04.094488) ========= 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.0x5XGoQgSA/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.otNsG0tPBK/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005410 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 02:35:04.143193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-04 02:35:04.143473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-04 02:35:04.143775) ========= ========= Total master_lag: 0.18 =========