builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0071 starttime: 1473175280.72 results: success (0) buildid: 20160906062954 builduid: 31b6246986b64d98b33cdc1190e1ad28 revision: bec2b7e3c0eb2adf0370f94802eca96e41f5879b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:20.717765) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:20.718161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:20.718428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:20.988964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-06 08:21:20.989231) ========= 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.Sr7NgYODK8/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.wHCEropvjp/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-06 08:21:21-- 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% 173M=0s 2016-09-06 08:21:22 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.467960 ========= master_lag: 0.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-06 08:21:22.354611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:22.354921) ========= 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.Sr7NgYODK8/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.wHCEropvjp/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.027599 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:22.406144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-06 08:21:22.406454) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bec2b7e3c0eb2adf0370f94802eca96e41f5879b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bec2b7e3c0eb2adf0370f94802eca96e41f5879b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sr7NgYODK8/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.wHCEropvjp/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-06 08:21:22,490 truncating revision to first 12 chars 2016-09-06 08:21:22,490 Setting DEBUG logging. 2016-09-06 08:21:22,490 attempt 1/10 2016-09-06 08:21:22,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bec2b7e3c0eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-06 08:21:23,239 unpacking tar archive at: mozilla-central-bec2b7e3c0eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.012544 ========= master_lag: 2.96 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-06 08:21:26.375489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:26.375784) ========= script_repo_revision: bec2b7e3c0eb2adf0370f94802eca96e41f5879b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:26.376127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:26.376382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 08:21:26.438999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-06 08:21:26.439338) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sr7NgYODK8/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.wHCEropvjp/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:21:26 INFO - MultiFileLogger online at 20160906 08:21:26 in /builds/slave/test 08:21:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:21:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:26 INFO - {'append_to_log': False, 08:21:26 INFO - 'base_work_dir': '/builds/slave/test', 08:21:26 INFO - 'blob_upload_branch': 'Firefox', 08:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:26 INFO - 'branch': 'Firefox', 08:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:26 INFO - 'config_files': ('talos/mac_config.py',), 08:21:26 INFO - 'default_actions': ('clobber', 08:21:26 INFO - 'read-buildbot-config', 08:21:26 INFO - 'download-and-extract', 08:21:26 INFO - 'populate-webroot', 08:21:26 INFO - 'create-virtualenv', 08:21:26 INFO - 'install', 08:21:26 INFO - 'run-tests'), 08:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:26 INFO - 'download_minidump_stackwalk': True, 08:21:26 INFO - 'download_symbols': 'ondemand', 08:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:26 INFO - 'installer_path': 'installer.exe', 08:21:26 INFO - 'log_level': 'info', 08:21:26 INFO - 'log_name': 'talos', 08:21:26 INFO - 'log_to_console': True, 08:21:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:21:26 INFO - 'opt_config_files': (), 08:21:26 INFO - 'pip_index': False, 08:21:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:21:26 INFO - 'cmd': ('bash', 08:21:26 INFO - '-c', 08:21:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:21:26 INFO - 'enabled': True, 08:21:26 INFO - 'halt_on_failure': False, 08:21:26 INFO - 'name': 'check_screen_resolution'},), 08:21:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:21:26 INFO - 'cmd': ('bash', 08:21:26 INFO - '-c', 08:21:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:21:26 INFO - 'enabled': True, 08:21:26 INFO - 'halt_on_failure': False, 08:21:26 INFO - 'name': 'check_screen_resolution'},), 08:21:26 INFO - 'run_cmd_checks_enabled': True, 08:21:26 INFO - 'sps_profile': False, 08:21:26 INFO - 'sps_profile_interval': 0, 08:21:26 INFO - 'suite': 'dromaeojs', 08:21:26 INFO - 'system_bits': '32', 08:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:26 INFO - 'title': 't-yosemite-r7-0071', 08:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:26 INFO - 'use_talos_json': True, 08:21:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:26 INFO - 'work_dir': 'build'} 08:21:26 INFO - [mozharness: 2016-09-06 15:21:26.648221Z] Running clobber step. 08:21:26 INFO - Running pre-action listener: _resource_record_pre_action 08:21:26 INFO - Running main action method: clobber 08:21:26 INFO - rmtree: /builds/slave/test/build 08:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:28 INFO - Running post-action listener: _resource_record_post_action 08:21:28 INFO - [mozharness: 2016-09-06 15:21:28.803642Z] Finished clobber step (success) 08:21:28 INFO - [mozharness: 2016-09-06 15:21:28.803766Z] Running read-buildbot-config step. 08:21:28 INFO - Running pre-action listener: _resource_record_pre_action 08:21:28 INFO - Running main action method: read_buildbot_config 08:21:28 INFO - Using buildbot properties: 08:21:28 INFO - { 08:21:28 INFO - "project": "", 08:21:28 INFO - "product": "firefox", 08:21:28 INFO - "script_repo_revision": "production", 08:21:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:21:28 INFO - "repository": "", 08:21:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:21:28 INFO - "buildid": "20160906062954", 08:21:28 INFO - "pgo_build": "False", 08:21:28 INFO - "basedir": "/builds/slave/test", 08:21:28 INFO - "buildnumber": 35, 08:21:28 INFO - "slavename": "t-yosemite-r7-0071", 08:21:28 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:21:28 INFO - "platform": "yosemite_r7", 08:21:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:21:28 INFO - "branch": "mozilla-central", 08:21:28 INFO - "repo_path": "mozilla-central", 08:21:28 INFO - "revision": "bec2b7e3c0eb2adf0370f94802eca96e41f5879b", 08:21:28 INFO - "stage_platform": "macosx64", 08:21:28 INFO - "builduid": "31b6246986b64d98b33cdc1190e1ad28", 08:21:28 INFO - "slavebuilddir": "test" 08:21:28 INFO - } 08:21:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:21:28 INFO - Running post-action listener: _resource_record_post_action 08:21:28 INFO - [mozharness: 2016-09-06 15:21:28.806779Z] Finished read-buildbot-config step (success) 08:21:28 INFO - [mozharness: 2016-09-06 15:21:28.806885Z] Running download-and-extract step. 08:21:28 INFO - Running pre-action listener: _resource_record_pre_action 08:21:28 INFO - Running main action method: download_and_extract 08:21:28 INFO - mkdir: /builds/slave/test/build/tests 08:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:28 INFO - trying https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:21:28 INFO - Downloading https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:21:30 INFO - Downloaded 1199 bytes. 08:21:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:21:30 INFO - Using the following test package requirements: 08:21:30 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:21:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:21:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:21:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'jsshell-mac.zip'], 08:21:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:21:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:21:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:21:30 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:21:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:21:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:21:30 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:21:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:21:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:21:30 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 08:21:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:21:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:21:38 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 08:21:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:21:46 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 08:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:46 INFO - trying https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:21:46 INFO - Downloading https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:21:49 INFO - Downloaded 111523826 bytes. 08:21:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:21:49 INFO - mkdir: /builds/slave/test/properties 08:21:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:49 INFO - Contents: 08:21:49 INFO - build_url:https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:21:50 INFO - Running post-action listener: _resource_record_post_action 08:21:50 INFO - Running post-action listener: set_extra_try_arguments 08:21:50 INFO - [mozharness: 2016-09-06 15:21:50.676211Z] Finished download-and-extract step (success) 08:21:50 INFO - [mozharness: 2016-09-06 15:21:50.676361Z] Running populate-webroot step. 08:21:50 INFO - Running pre-action listener: _resource_record_pre_action 08:21:50 INFO - Running main action method: populate_webroot 08:21:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:50 INFO - '--tppagecycles', 08:21:50 INFO - '7'], 08:21:50 INFO - 'tests': ['tsvgm']}}, 08:21:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['damp', 'tps']}, 08:21:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'tests': ['damp', 'tps']}, 08:21:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['dromaeo_dom']}, 08:21:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['basic_compositor_video']}, 08:21:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:21:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['a11yr', 08:21:50 INFO - 'ts_paint', 08:21:50 INFO - 'tpaint', 08:21:50 INFO - 'sessionrestore', 08:21:50 INFO - 'sessionrestore_no_auto_restore', 08:21:50 INFO - 'tabpaint']}, 08:21:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:50 INFO - 'ts_paint', 08:21:50 INFO - 'tpaint', 08:21:50 INFO - 'sessionrestore', 08:21:50 INFO - 'sessionrestore_no_auto_restore', 08:21:50 INFO - 'tabpaint']}, 08:21:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:50 INFO - 'ts_paint', 08:21:50 INFO - 'tpaint', 08:21:50 INFO - 'sessionrestore', 08:21:50 INFO - 'sessionrestore_no_auto_restore', 08:21:50 INFO - 'tabpaint']}, 08:21:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:50 INFO - 'ts_paint', 08:21:50 INFO - 'tpaint', 08:21:50 INFO - 'sessionrestore', 08:21:50 INFO - 'sessionrestore_no_auto_restore', 08:21:50 INFO - 'tabpaint']}, 08:21:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['a11yr', 08:21:50 INFO - 'ts_paint', 08:21:50 INFO - 'tpaint', 08:21:50 INFO - 'sessionrestore', 08:21:50 INFO - 'sessionrestore_no_auto_restore', 08:21:50 INFO - 'tabpaint']}, 08:21:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['a11yr', 08:21:50 INFO - 'ts_paint', 08:21:50 INFO - 'tpaint', 08:21:50 INFO - 'sessionrestore', 08:21:50 INFO - 'sessionrestore_no_auto_restore', 08:21:50 INFO - 'tabpaint']}, 08:21:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['tsvgx', 08:21:50 INFO - 'tsvgr_opacity', 08:21:50 INFO - 'tart', 08:21:50 INFO - 'tscrollx', 08:21:50 INFO - 'cart']}, 08:21:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:50 INFO - 'tsvgr_opacity', 08:21:50 INFO - 'tart', 08:21:50 INFO - 'tscrollx', 08:21:50 INFO - 'cart']}, 08:21:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'talos_options': ['--disable-e10s'], 08:21:50 INFO - 'tests': ['tp5o']}, 08:21:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'tests': ['tp5o']}, 08:21:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'talos_options': ['--disable-e10s', 08:21:50 INFO - '--xperf_path', 08:21:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:50 INFO - 'tests': ['tp5n']}, 08:21:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:50 INFO - 'talos_options': ['--xperf_path', 08:21:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:50 INFO - 'tests': ['tp5n']}}, 08:21:50 INFO - 'talos.zip': {'path': '', 08:21:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:50 INFO - Running post-action listener: _resource_record_post_action 08:21:50 INFO - [mozharness: 2016-09-06 15:21:50.694972Z] Finished populate-webroot step (success) 08:21:50 INFO - [mozharness: 2016-09-06 15:21:50.695106Z] Running create-virtualenv step. 08:21:50 INFO - Running pre-action listener: _resource_record_pre_action 08:21:50 INFO - Running main action method: create_virtualenv 08:21:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:21:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:50 INFO - Using real prefix '/tools/python27' 08:21:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:51 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:54 INFO - Installing pip.................done. 08:21:54 INFO - Return code: 0 08:21:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:54 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:21:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:21:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:54 INFO - 'HOME': '/Users/cltbld', 08:21:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:54 INFO - 'LOGNAME': 'cltbld', 08:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:54 INFO - 'MOZ_NO_REMOTE': '1', 08:21:54 INFO - 'NO_EM_RESTART': '1', 08:21:54 INFO - 'PAGER': '/bin/cat', 08:21:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:54 INFO - 'PWD': '/builds/slave/test', 08:21:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:54 INFO - 'SHELL': '/bin/bash', 08:21:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:21:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:21:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:54 INFO - 'USER': 'cltbld', 08:21:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:54 INFO - 'XPC_FLAGS': '0x0', 08:21:54 INFO - 'XPC_SERVICE_NAME': '0', 08:21:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:21:54 INFO - Cleaning up... 08:21:54 INFO - Return code: 0 08:21:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:54 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:21:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:21:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:54 INFO - 'HOME': '/Users/cltbld', 08:21:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:54 INFO - 'LOGNAME': 'cltbld', 08:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:54 INFO - 'MOZ_NO_REMOTE': '1', 08:21:54 INFO - 'NO_EM_RESTART': '1', 08:21:54 INFO - 'PAGER': '/bin/cat', 08:21:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:54 INFO - 'PWD': '/builds/slave/test', 08:21:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:54 INFO - 'SHELL': '/bin/bash', 08:21:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:21:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:21:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:54 INFO - 'USER': 'cltbld', 08:21:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:54 INFO - 'XPC_FLAGS': '0x0', 08:21:54 INFO - 'XPC_SERVICE_NAME': '0', 08:21:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:54 INFO - Downloading/unpacking psutil>=3.1.1 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:58 INFO - Installing collected packages: psutil 08:21:58 INFO - Running setup.py install for psutil 08:21:58 INFO - building 'psutil._psutil_osx' extension 08:21:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:21:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:21:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:21:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:21:58 INFO - building 'psutil._psutil_posix' extension 08:21:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:21:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:21:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:21:58 INFO - ^ 08:21:59 INFO - 1 warning generated. 08:21:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:21:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:59 INFO - Successfully installed psutil 08:21:59 INFO - Cleaning up... 08:21:59 INFO - Return code: 0 08:21:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:59 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:59 INFO - 'HOME': '/Users/cltbld', 08:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:59 INFO - 'LOGNAME': 'cltbld', 08:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:59 INFO - 'MOZ_NO_REMOTE': '1', 08:21:59 INFO - 'NO_EM_RESTART': '1', 08:21:59 INFO - 'PAGER': '/bin/cat', 08:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:59 INFO - 'PWD': '/builds/slave/test', 08:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:59 INFO - 'SHELL': '/bin/bash', 08:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:21:59 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:59 INFO - 'USER': 'cltbld', 08:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:59 INFO - 'XPC_FLAGS': '0x0', 08:21:59 INFO - 'XPC_SERVICE_NAME': '0', 08:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:22:02 INFO - Installing collected packages: mozsystemmonitor 08:22:02 INFO - Running setup.py install for mozsystemmonitor 08:22:02 INFO - Successfully installed mozsystemmonitor 08:22:02 INFO - Cleaning up... 08:22:02 INFO - Return code: 0 08:22:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:02 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:22:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:02 INFO - 'HOME': '/Users/cltbld', 08:22:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:02 INFO - 'LOGNAME': 'cltbld', 08:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:02 INFO - 'MOZ_NO_REMOTE': '1', 08:22:02 INFO - 'NO_EM_RESTART': '1', 08:22:02 INFO - 'PAGER': '/bin/cat', 08:22:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:02 INFO - 'PWD': '/builds/slave/test', 08:22:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:02 INFO - 'SHELL': '/bin/bash', 08:22:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:02 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:02 INFO - 'USER': 'cltbld', 08:22:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:02 INFO - 'XPC_FLAGS': '0x0', 08:22:02 INFO - 'XPC_SERVICE_NAME': '0', 08:22:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:02 INFO - Downloading/unpacking jsonschema==2.5.1 08:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:22:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:22:05 INFO - warning: no files found matching '*.txt' 08:22:05 INFO - no previously-included directories found matching 'build' 08:22:05 INFO - no previously-included directories found matching 'dist' 08:22:05 INFO - no previously-included directories found matching '.git*' 08:22:05 INFO - Installing collected packages: jsonschema, functools32 08:22:05 INFO - Running setup.py install for functools32 08:22:05 INFO - warning: no files found matching '*.txt' 08:22:05 INFO - no previously-included directories found matching 'build' 08:22:05 INFO - no previously-included directories found matching 'dist' 08:22:05 INFO - no previously-included directories found matching '.git*' 08:22:05 INFO - Successfully installed jsonschema functools32 08:22:05 INFO - Cleaning up... 08:22:05 INFO - Return code: 0 08:22:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:05 INFO - 'HOME': '/Users/cltbld', 08:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:05 INFO - 'LOGNAME': 'cltbld', 08:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:05 INFO - 'MOZ_NO_REMOTE': '1', 08:22:05 INFO - 'NO_EM_RESTART': '1', 08:22:05 INFO - 'PAGER': '/bin/cat', 08:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:05 INFO - 'PWD': '/builds/slave/test', 08:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:05 INFO - 'SHELL': '/bin/bash', 08:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:05 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:05 INFO - 'USER': 'cltbld', 08:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:05 INFO - 'XPC_FLAGS': '0x0', 08:22:05 INFO - 'XPC_SERVICE_NAME': '0', 08:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:22:05 INFO - Cleaning up... 08:22:05 INFO - Return code: 0 08:22:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:05 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:05 INFO - 'HOME': '/Users/cltbld', 08:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:05 INFO - 'LOGNAME': 'cltbld', 08:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:05 INFO - 'MOZ_NO_REMOTE': '1', 08:22:05 INFO - 'NO_EM_RESTART': '1', 08:22:05 INFO - 'PAGER': '/bin/cat', 08:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:05 INFO - 'PWD': '/builds/slave/test', 08:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:05 INFO - 'SHELL': '/bin/bash', 08:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:05 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:05 INFO - 'USER': 'cltbld', 08:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:05 INFO - 'XPC_FLAGS': '0x0', 08:22:05 INFO - 'XPC_SERVICE_NAME': '0', 08:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:22:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:22:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:09 INFO - Downloading docopt-0.6.1.tar.gz 08:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:22:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:22:09 INFO - Running setup.py install for blobuploader 08:22:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:22:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:22:09 INFO - Running setup.py install for requests 08:22:10 INFO - Running setup.py install for docopt 08:22:10 INFO - Successfully installed blobuploader requests docopt 08:22:10 INFO - Cleaning up... 08:22:10 INFO - Return code: 0 08:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22: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')]} 08:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22: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')]} 08:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:10 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:10 INFO - 'HOME': '/Users/cltbld', 08:22:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:10 INFO - 'LOGNAME': 'cltbld', 08:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:10 INFO - 'MOZ_NO_REMOTE': '1', 08:22:10 INFO - 'NO_EM_RESTART': '1', 08:22:10 INFO - 'PAGER': '/bin/cat', 08:22:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:10 INFO - 'PWD': '/builds/slave/test', 08:22:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:10 INFO - 'SHELL': '/bin/bash', 08:22:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:10 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:10 INFO - 'USER': 'cltbld', 08:22:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:10 INFO - 'XPC_FLAGS': '0x0', 08:22:10 INFO - 'XPC_SERVICE_NAME': '0', 08:22:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-IrYpXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-u1LpmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-dbKvb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-kSxzQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Ti_ryD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZyPUym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9KcLse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ps9nNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-JQ6dKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:11 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-JGzshM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:12 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Nw8T_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:12 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qgFO0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:12 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-JFkczM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:12 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_Rw9Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:12 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-XV2D_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:12 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-oxaX8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:12 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-yODrrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:22:12 INFO - Running setup.py install for manifestparser 08:22:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:22:12 INFO - Running setup.py install for mozcrash 08:22:13 INFO - Running setup.py install for mozdebug 08:22:13 INFO - Running setup.py install for mozdevice 08:22:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Running setup.py install for mozfile 08:22:13 INFO - Running setup.py install for mozhttpd 08:22:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Running setup.py install for mozinfo 08:22:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Running setup.py install for mozInstall 08:22:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:22:13 INFO - Running setup.py install for mozleak 08:22:14 INFO - Running setup.py install for mozlog 08:22:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:22:14 INFO - Running setup.py install for moznetwork 08:22:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:22:14 INFO - Running setup.py install for mozprocess 08:22:14 INFO - Running setup.py install for mozprofile 08:22:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:22:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:22:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:22:14 INFO - Running setup.py install for mozrunner 08:22:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:22:14 INFO - Running setup.py install for mozscreenshot 08:22:15 INFO - Running setup.py install for moztest 08:22:15 INFO - Running setup.py install for mozversion 08:22:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:22:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:22:15 INFO - Cleaning up... 08:22:15 INFO - Return code: 0 08:22:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:15 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:15 INFO - 'HOME': '/Users/cltbld', 08:22:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:15 INFO - 'LOGNAME': 'cltbld', 08:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:15 INFO - 'MOZ_NO_REMOTE': '1', 08:22:15 INFO - 'NO_EM_RESTART': '1', 08:22:15 INFO - 'PAGER': '/bin/cat', 08:22:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:15 INFO - 'PWD': '/builds/slave/test', 08:22:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:15 INFO - 'SHELL': '/bin/bash', 08:22:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:15 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:15 INFO - 'USER': 'cltbld', 08:22:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:15 INFO - 'XPC_FLAGS': '0x0', 08:22:15 INFO - 'XPC_SERVICE_NAME': '0', 08:22:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:22:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-z9hjzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:22:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-axt7kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:22:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-w0TDQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:22:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-TNi1E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-3tqDlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-iObzmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-SxML2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ARw0ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-1jLPmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-IA431w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8AamIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-gVQfYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-0AO2UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:22:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:22:16 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-cT5FJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:17 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-jrs1Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:22:17 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DWN5o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:22:17 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-wOaxcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:22:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:19 INFO - Downloading blessings-1.6.tar.gz 08:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:19 INFO - Installing collected packages: blessings 08:22:19 INFO - Running setup.py install for blessings 08:22:20 INFO - Successfully installed blessings 08:22:20 INFO - Cleaning up... 08:22:20 INFO - Return code: 0 08:22:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:20 INFO - Reading from file tmpfile_stdout 08:22:20 INFO - Current package versions: 08:22:20 INFO - blessings == 1.6 08:22:20 INFO - blobuploader == 1.2.4 08:22:20 INFO - docopt == 0.6.1 08:22:20 INFO - functools32 == 3.2.3-2 08:22:20 INFO - jsonschema == 2.5.1 08:22:20 INFO - manifestparser == 1.1 08:22:20 INFO - mozInstall == 1.12 08:22:20 INFO - mozcrash == 0.17 08:22:20 INFO - mozdebug == 0.1 08:22:20 INFO - mozdevice == 0.48 08:22:20 INFO - mozfile == 1.2 08:22:20 INFO - mozhttpd == 0.7 08:22:20 INFO - mozinfo == 0.9 08:22:20 INFO - mozleak == 0.1 08:22:20 INFO - mozlog == 3.3 08:22:20 INFO - moznetwork == 0.27 08:22:20 INFO - mozprocess == 0.23 08:22:20 INFO - mozprofile == 0.28 08:22:20 INFO - mozrunner == 6.12 08:22:20 INFO - mozscreenshot == 0.1 08:22:20 INFO - mozsystemmonitor == 0.3 08:22:20 INFO - moztest == 0.7 08:22:20 INFO - mozversion == 1.4 08:22:20 INFO - psutil == 3.1.1 08:22:20 INFO - requests == 1.2.3 08:22:20 INFO - wsgiref == 0.1.2 08:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:20 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:22:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:20 INFO - 'HOME': '/Users/cltbld', 08:22:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:20 INFO - 'LOGNAME': 'cltbld', 08:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:20 INFO - 'MOZ_NO_REMOTE': '1', 08:22:20 INFO - 'NO_EM_RESTART': '1', 08:22:20 INFO - 'PAGER': '/bin/cat', 08:22:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:20 INFO - 'PWD': '/builds/slave/test', 08:22:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:20 INFO - 'SHELL': '/bin/bash', 08:22:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:20 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:20 INFO - 'USER': 'cltbld', 08:22:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:20 INFO - 'XPC_FLAGS': '0x0', 08:22:20 INFO - 'XPC_SERVICE_NAME': '0', 08:22:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:22:20 INFO - Cleaning up... 08:22:20 INFO - Return code: 0 08:22:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:20 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 0x10f4afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f544618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1d1cc1260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, '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.Sr7NgYODK8/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.wHCEropvjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:22:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:20 INFO - 'HOME': '/Users/cltbld', 08:22:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:20 INFO - 'LOGNAME': 'cltbld', 08:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:20 INFO - 'MOZ_NO_REMOTE': '1', 08:22:20 INFO - 'NO_EM_RESTART': '1', 08:22:20 INFO - 'PAGER': '/bin/cat', 08:22:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:20 INFO - 'PWD': '/builds/slave/test', 08:22:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:20 INFO - 'SHELL': '/bin/bash', 08:22:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:20 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:20 INFO - 'USER': 'cltbld', 08:22:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:20 INFO - 'XPC_FLAGS': '0x0', 08:22:20 INFO - 'XPC_SERVICE_NAME': '0', 08:22:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:22:21 INFO - Cleaning up... 08:22:21 INFO - Return code: 0 08:22:21 INFO - Running post-action listener: _resource_record_post_action 08:22:21 INFO - Running post-action listener: _start_resource_monitoring 08:22:21 INFO - Starting resource monitoring. 08:22:21 INFO - [mozharness: 2016-09-06 15:22:21.080527Z] Finished create-virtualenv step (success) 08:22:21 INFO - [mozharness: 2016-09-06 15:22:21.081516Z] Running install step. 08:22:21 INFO - Running pre-action listener: _resource_record_pre_action 08:22:21 INFO - Running main action method: install 08:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:21 INFO - Reading from file tmpfile_stdout 08:22:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:21 INFO - Reading from file tmpfile_stdout 08:22:21 INFO - Output received: 08:22:21 INFO - Usage: mozinstall [options] installer 08:22:21 INFO - Options: 08:22:21 INFO - -h, --help show this help message and exit 08:22:21 INFO - -d DEST, --destination=DEST 08:22:21 INFO - Directory to install application into. [default: 08:22:21 INFO - "/builds/slave/test"] 08:22:21 INFO - --app=APP Application being installed. [default: firefox] 08:22:21 INFO - mkdir: /builds/slave/test/build/application 08:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:22:55 INFO - Reading from file tmpfile_stdout 08:22:55 INFO - Output received: 08:22:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:22:55 INFO - Running post-action listener: _resource_record_post_action 08:22:55 INFO - [mozharness: 2016-09-06 15:22:55.254559Z] Finished install step (success) 08:22:55 INFO - [mozharness: 2016-09-06 15:22:55.254681Z] Running run-tests step. 08:22:55 INFO - Running pre-action listener: _resource_record_pre_action 08:22:55 INFO - Running main action method: run_tests 08:22:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:22:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:22:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:22:55 INFO - 2016-09-06 08:22:55.268 screenresolution[1645:8242] starting screenresolution argv=screenresolution get 08:22:55 INFO - 2016-09-06 08:22:55.271 screenresolution[1645:8242] Display 0: 1600x1200x32@60 08:22:55 INFO - 2016-09-06 08:22:55.277 screenresolution[1646:8244] starting screenresolution argv=screenresolution list 08:22:55 INFO - Available Modes on Display 0 08:22:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:22:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:22:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:22:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:22:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:22:55 INFO - Intel Iris: 08:22:55 INFO - Chipset Model: Intel Iris 08:22:55 INFO - Type: GPU 08:22:55 INFO - Bus: Built-In 08:22:55 INFO - VRAM (Dynamic, Max): 1536 MB 08:22:55 INFO - Vendor: Intel (0x8086) 08:22:55 INFO - Device ID: 0x0a2e 08:22:55 INFO - Revision ID: 0x0009 08:22:55 INFO - Displays: 08:22:55 INFO - Display: 08:22:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:22:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:22:55 INFO - Display Serial Number: 1600x1200 60 08:22:55 INFO - Main Display: Yes 08:22:55 INFO - Mirror: Off 08:22:55 INFO - Online: Yes 08:22:55 INFO - Rotation: Supported 08:22:55 INFO - Return code: 0 08:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:55 INFO - Python 2.7.3 08:22:55 INFO - Return code: 0 08:22:55 INFO - grabbing minidump binary from tooltool 08:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:22:55 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 0x10f413d30>, '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 0x10f178db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f40bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:22:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:22:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:22:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:55 INFO - Return code: 0 08:22:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:22:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:22:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 08:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --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 08:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sr7NgYODK8/Render', 08:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:22:55 INFO - 'HOME': '/Users/cltbld', 08:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:22:55 INFO - 'LOGNAME': 'cltbld', 08:22:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:55 INFO - 'MOZ_NO_REMOTE': '1', 08:22:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:55 INFO - 'NO_EM_RESTART': '1', 08:22:55 INFO - 'PAGER': '/bin/cat', 08:22:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:55 INFO - 'PWD': '/builds/slave/test', 08:22:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:22:55 INFO - 'SHELL': '/bin/bash', 08:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wHCEropvjp/Listeners', 08:22:55 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:22:55 INFO - 'USER': 'cltbld', 08:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:55 INFO - 'XPC_FLAGS': '0x0', 08:22:55 INFO - 'XPC_SERVICE_NAME': '0', 08:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:22:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 08:22:55 INFO - mozversion application_buildid: 20160906062954 08:22:55 INFO - mozversion application_changeset: bec2b7e3c0eb2adf0370f94802eca96e41f5879b 08:22:55 INFO - mozversion application_display_name: Nightly 08:22:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:55 INFO - mozversion application_name: Firefox 08:22:55 INFO - mozversion application_remotingname: firefox 08:22:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:22:55 INFO - mozversion application_vendor: Mozilla 08:22:55 INFO - mozversion application_version: 51.0a1 08:22:55 INFO - mozversion platform_buildid: 20160906062954 08:22:55 INFO - mozversion platform_changeset: bec2b7e3c0eb2adf0370f94802eca96e41f5879b 08:22:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:22:55 INFO - mozversion platform_version: 51.0a1 08:22:55 INFO - using testdate: 1473175375 08:22:55 INFO - actual date: 1473175375 08:22:55 INFO - starting webserver on 'localhost:49273' 08:22:55 INFO - SUITE-START | Running 2 tests 08:22:55 INFO - TEST-START | dromaeo_css 08:22:55 INFO - operating with platform_type : mac_ 08:22:55 INFO - Initialising browser for dromaeo_css test... 08:22:55 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpv57MHU/profile http://localhost:49273/getInfo.html) 08:22:58 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 08:22:58 INFO - PROCESS | 1656 | colorDepth:24 08:22:58 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 08:22:58 INFO - PROCESS | 1656 | __metrics 08:22:58 INFO - PROCESS | 1656 | 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" 08:22:58 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:22:59 INFO - TEST-INFO | 1656: exit 0 08:22:59 INFO - Browser initialized. 08:22:59 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:59 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpv57MHU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:11 INFO - PROCESS | 1659 | RSS: Main: 231915520 08:23:11 INFO - PROCESS | 1659 | 08:24:03 INFO - PROCESS | 1659 | 1473175443170 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:26:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 08:26:15 INFO - PROCESS | 1659 | RSS: Main: 328998912 08:26:15 INFO - PROCESS | 1659 | 08:29:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 08:29:18 INFO - PROCESS | 1659 | RSS: Main: 370475008 08:29:18 INFO - PROCESS | 1659 | 08:32:21 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 08:32:21 INFO - PROCESS | 1659 | RSS: Main: 323698688 08:32:21 INFO - PROCESS | 1659 | 08:35:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 08:35:24 INFO - PROCESS | 1659 | RSS: Main: 342077440 08:35:24 INFO - PROCESS | 1659 | 08:38:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 08:38:28 INFO - PROCESS | 1659 | RSS: Main: 323223552 08:38:28 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 08:41:32 INFO - PROCESS | 1659 | RSS: Main: 410046464 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | __start_tp_report 08:41:32 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 08:41:32 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 08:41:32 INFO - PROCESS | 1659 | |i|pagename|runs| 08:41:32 INFO - PROCESS | 1659 | |0;dojo.html;3307.1236122427563;3310.371029504394;3348.7823291486066;3358.9328213435747;3401.183715908183;5540.667559946406;5593.888122237558;5632.802851900185;5666.518345940595;5686.7725290988365;5614.017546929281;5624.550035997121;5653.717314134287;5714.71426428679;5760.049591817345;5079.822206222783;5130.743462826862;5166.819161329354;5171.301874246985;5220.765065572039;4327.415798867144;5241;5241.947580524203;5245.134552798802;5298.7350632468415;5088.949110508885;5153.896922061538;5155.561777248939;5197.090509160882;5224.111900976843;4221.852235171785;5126.743662816882;5204.583633309327;5217.243499692561;5227.921581176285;5107.9744601277125;5116.692998420107;5126.692398456067;5207.114790485626;5209.19257515082;5692.857678558028;5701.971490142564;5704.515116215127;5705.172749951275;5741.770329186827;6098.39016098391;6103.307364981935;6150.384961503859;6258.78094266703;6287.056941458772;6246;6324.3359447257835;6334.4299013088585;6335.208098987627;6350.237971443456;5773.971130144322;5796.739146738407;5805.390434004369;5806.970965145189;5827.533797296206;6256.5307601930035;6263.6241825490615;6321.747130114744;6329.936700633027;6362.618242905441;6043.12374705674;6080.969595151996;6086.6348019119;6086.995645718495;6096.185141921503;5245.9737701312015;6249.531285153632;6274.811755647338;6277.686115694289;6281.96859015702;6065.423784740443;6099.817005489843;6106.94607981953;6108.144859719643;6183;6211.440970312694;6250.1874756281395;6259.4679452246155;6285.528585356116;6294.527910406738;4142.647874930604;4929.285253638274;4947.950520494821;4983.377077865267;4984.177610694195;4341.305391137403;4345.391645169679;4354.934675979799;4394.604485596312;4432.468103827561;4407.140607581491;5473.0969390051;5478;5487.862803429946;5508.752106155152;5719.8570035749435;5829.708514574254;6147.139400483936;6165.290991536031;6177.4749146323065;5184.326037615161;5215.374155101412;5243.737813109329;5312.840614781563;5317.8404647860625;5123.308353372322;5148.021875843652;5157.63896527247;5194.142966410575;5234.398044224963;6319.146915166394;6331.461825744771;6333.746650134128;6334.714937827809;6339;5931.673757943355;6124.846878827887;6143.631382117087;6143.754249829957;6162.414570615784;5329.600279978939;6255.374462553708;6266.279377871603;6346.365363463617;6347.777827776191;6196.938030619816;6200.255969283715;6209.96895015522;6225.564210505402;6225.813225603058;6049.425304596057;6146.385361463997;6147.938520614736;6158.630482171084;6178.073289006685;4865.878353041202;5759.337676167127;5795.82612521625;5829.504492118217;5949.6430214187285;5845.590808643354;5894.410558944071;5894.941050589611;5897.705114744332;5906.970465147647;4515.751633660049;4858.878528036827;5751.4536119068625;5769.653820770767;5792.102224155263;4981.676191047571;5745.885082298414;5804.970975145097;5812.157237200667;5859.091840764518;4840.7337596431125;5759.740811663569;5764.250647415809;5768.307803063659;5772.19189313488 08:41:32 INFO - PROCESS | 1659 | |1;ext.html;493.6396430605658;521.3014560488944;526.6681990346082;529.1665626638046;559.6837786650544;30145.944891928786;30761;40488.19023619526;40532.39201411974;40673.79663101688;42148.578514214845;42399.72800815973;42404.57595424053;42459.575404245945;42540.574594254045;9571.856422153673;9769.974152713969;9771.853422198637;9783.902160978407;9793.11861932426;8768.824623507526;8911.554422278892;11876.16866819323;12004.579839705568;12041.91622753952;11938.761224775499;12034.939825300862;12042.217255878384;12057.155999080069;12070.637880863544;12037.759244815099;12089.758204835942;12100.636980890544;12123.818142727867;12129.6361109166;11077.390743509104;11159.442027898654;11161.776764464747;11162.386068766215;11177.161712871568;39643.40534891979;39761;39835.40246896299;39863;39888.20223595512;3332.3168750406107;3338.1487720631326;3549.290141971616;3572.732045096628;3832.9808350958065;30088.69911300881;30116.849415753;30507.389852203054;30682.9260975867;30894.536581951288;3120.7971481853606;3195.9041228763176;3212.518122281653;3273.885414010498;3291.3707714681145;469689;471939;472729;473065;474705;56674.7166264166;56848.431515684315;56869.578260543814;56877.71561142168;56949.71525142348;34154.31691366159;34479.13802154966;34686.826565867006;60018.39981600215;60085.69957150274;16169.191540422931;16411.83588164127;16559.751603725952;16576.336946522006;16642.3343066276;11576.536938522364;11779.941100294614;12659.620211393672;12750.171238869443;12751.744965100832;18707.10039943811;19111.713324300148;19259.22963081489;19464.70802937957;19558.90220548888;7739.690412383554;7826.726064587826;7863.882041769378;7870.567118808406;7933.603319834101;767.9731209407644;1023.3194925374692;1033.2818691009827;1071.7802850415646;1087.3856271206744;27599.448011039665;29531.966381176557;29914;30566.235844104074;30683;1042.718466014172;1079.282277285612;1091.4651820607844;1117.1063149480383;1189.2567145534042;14709.338079786436;15299.770503442458;15341.6164595886;15436.228188590525;15723.05661660304;520694;524197.096348433;524418;524741;526291;57546.7122664384;57942;58032.12951805726;58081.128783068285;58133;1094.584058057933;1262.5517941130765;1335.746208220435;1363.2025265219957;1390.9721805563831;29405.85297073501;30358.336742737825;31118.688813112483;31348.37303253968;31845;47537.7623111896;48313;48328.758356207996;48413.51586484231;48453;518088;519891;520570;520749;525232;25291.494170116126;26186;26284.21147365582;26286.60570091412;26340.341491462867;46279.76860115678;46976.7651161742;47117;47284.7635761819;47430.52569474261;38705.4194187093;38712.8386148416;39136.412953806284;39664.40503392509;40334.79832600818;37839;38247;38513.03717406975;39013.952837310266;39417.01457463586;37526.06184845401;37944.810275948446;38568.228635426574;38665.61334386733;38794.80602596969;27611.44777104487;31496.055118346485;33439.83280083584;33964.32071358609;34230.82884585561;22661.546769064855;24104.638430423907;24972;25163.24510264695;25523 08:41:32 INFO - PROCESS | 1659 | |2;jquery.html;315.9383920135574;353.90975301298164;372.46365234062966;381.9140693343998;406.8799704087294;14991.550253492385;16787.07671078092;16818.579535511617;17304.394346197885;20172.697409538832;19407.514812129702;19462.221511139538;20489.87305698186;20614;20914.058867350966;5730.312362516483;5875.941240587582;6153.476954458876;6155.938440615604;6173.938260617381;5969.970150149243;6022.488088512482;6102.572819902609;6104.542159338045;6107.908381374283;5740.339860915986;5984.401559844025;6062.120992456091;6062.514998800108;6067.362926892679;6031.336552979169;6085.908711369333;6098.54260930432;6098.9695051524905;6099.817005489843;4999.8250061248045;5187.144121219994;5256.789728410859;5257.738142845689;5269.130593452076;21927.67108493374;22231.221907233168;23847.284581462583;25343.239702808944;25505.872470637714;2090.0594732370496;2527.8356906801;2578.9871050644815;2616.3459135216194;2651.8276312039657;9981.051800078982;10050.748731281703;10114.645987390406;10457.58169673212;10489.108425783741;1552.6351307442742;1780.3412737287288;1838.9264429422808;1896.506908203863;1933.994322952057;115338.42330788376;122898;125382;128154;130953.392690206;11039.944800275947;11369.09047276216;11438.599649012245;11491.080713542897;11690.532378704756;14397.99214055027;14399.352029158714;14422.495212667507;14427.422903083969;14456.421743130368;8229.423940324239;8500.574971251413;8521.872171917426;8666.263367613823;8706.825863482694;8455.49267043967;8465.915340846635;8504.064552899175;8656.48061116335;8661.350398719995;4409.1181763646755;4476.216662084123;4504.729716217037;4569.337446070301;4571.337156112345;1870.4014715290975;1920.990395048016;1937.2057456443072;1937.4768812420568;1981.5442448236986;780.1691198873182;845.9365547583956;847.809242920338;875.8554838451712;1000.5197505197546;15951.521454356387;19211;21479.67780483294;21487.140514379564;21657.025433855513;783.8236396810672;909.5287032761852;916.3356566489242;940.2759874896292;1034.5086084110137;10464.162866970624;10745.40900250478;11247.437628118561;11273.42833860042;11381.886181138083;596886;599430;600709;605984.3417224102;612298;83539;124393.37803311106;127893;134586.327068366;136368;989.5843745626854;1009.5154325923597;1026.8819085805228;1026.9127124194379;1027.5992362978445;13682.589522314347;16295.755563666791;18775.812241877407;19015;19221.327253546617;43048.78475607602;53003.40989770313;54400.72799635977;54774;54957;60702.696486517285;75097.62451187709;75492;78099;78108.21891781237;7166.211716711054;7409.481336306407;7694.902809061027;8059.879101813361;8337.333013359039;12151.81772273399;13059;13120.671983200496;13445.193288402726;13696.657583560092;9672.516374181121;11550.896540780624;11699;11707;11741.236819606698;5210.635255532076;8558.373908957277;11278.154138439813;11612.535498579962;11773.17587768848;11404.828927565926;11424.200305978502;11658.41707914584;11808;11924.661094893443;7047.506674532733;7190.892136618059;7334.046573945353;7456.067991501062;7532.133804612539;9477.478738669439;11668.066554675775;11718.179727419;11723;11744.647660570197 08:41:32 INFO - PROCESS | 1659 | |3;mootools.html;1489.3074720255079;1532.4942768886267;1732.3417101501427;1847.7690288713911;1879.3798046644608;8454.196851299124;8965.28277737781;8978.551072446384;8984.2812574994;8991.190792828644;7833.41249406294;8072.1927807219245;8477.830443391129;8685.696000639979;8727.47635141892;2328.3946173994755;2355.988220058906;2362.3621622162004;2364.2198074635417;2365.1485465232504;1843.3363988963963;2252.3355610094977;2338.0998315648426;2350.3536527454917;2352.5882970480097;2077.1276064053136;2147.0982187481295;2147.3987283560627;2149.602323570137;2154.3321570313174;2278.931632051041;2352.5294941011693;2354.2937118864356;2355.9528809423887;2366.266457398212;2306.331163962449;2334.4047267946735;2341.461463863321;2343.5781559319316;2354.3407845803204;7457.179710231871;8986.281097512183;8989.101089891024;8997.595108220146;9009.369344145913;4225.281702110648;5347.919781203285;5350.785968561253;5356.143017117242;5371.704556249405;3249.2689144942437;3317.170707323169;3371.7976921384798;3494.5457090578316;3577.3560759063357;1002.0780881588955;1023.4575674892319;1034.420724394334;1037.6938803053117;1051.4690081508866;11668.00821930137;11759.764804703858;11765.823512647317;11768.235064720766;11784.646460606196;4435.756033418128;4563.516857021481;4749.810007599657;4751.667383283206;4774.355462012653;9915.256355773347;9921.40471571708;9923.354981926152;9924;9933.850992235122;5312.2297266896085;5332.92000619991;5336.279602253724;5341.973290133525;5343.877785664976;4750.857474275777;4839.225723884232;4901.901961960741;4903.043906438282;4905.55849973497;3853.959430953627;3883.9611603884164;3925.7448265862627;3932.5674175840636;4005.679545636342;1222.7798996180773;1261.7602655495427;1267.784476638955;1281.51943021367;1282.4357282795727;754.2382193984115;844.7550210439027;883.5626364949392;885.6545947080643;927.8747369105084;4800.66395352322;5333.959877823865;5540.529055030287;5803.390643982406;6082.422169893853;869.9652013919499;904.8868891388577;944.1361154543516;951.8286708392417;974.2887691984749;3726.552813662324;3790.886273411802;3881.5536213335263;3947.1118998225743;3960.089179488734;10170.542325595366;10264.127549158256;10621.256512044083;10686.198535109897;10851.186161037953;10705.339223195559;10797.352158870493;10797.83803242952;10837.891621083845;10864.185186111074;7905.446618736748;8184.836303273901;8243.670253189804;8250.092489826115;8256.380771442165;5839.211706419749;5883.705814709333;5979.551533635082;6020.698965051817;6077.361877002851;10028.548715307683;10029.69910902674;10038.347507411994;10082.04220599042;10099.798004040025;9742;10149.695509134737;10173.338732982333;10340.53467593945;10374.792504150026;7427.405807535276;7600.3539699123985;7603;7603.201663825219;7607.695692172472;8194.016717993878;8227;8228.341732661493;8258.669653213805;8312.875306870523;7365.484416090822;7405.740799072222;7422.591757453392;7471.439642026761;7576.24237576238;7178.856422871618;7276.854462910606;7320.1215854097845;7325.304096110861;7369.263073692588;6621.370969757865;6820.829479263058;6883.586984780929;6891.241963384124;6907.965460172868;4818.71087734737;4876.317315575893;4877.707337559757;4934.851954441372;5093.363329583802;4126.995187163071;4945.307656927961;4954.9752251238515;4989.276554899592;5108 08:41:32 INFO - PROCESS | 1659 | |4;prototype.html;249.44747384543234;297.9985100074501;301.41675857216285;310.1300851112629;313.2497668084937;4381.327390291924;5042.9661919306545;5193.10451685135;5367.651102678323;5386.596005299609;4601.71152077418;4851.417829860413;5298.436961096476;5328.8401347959525;5330;3554.867079752141;4014.3978403239603;4070.7584186823005;4088.325426304664;4095.9180816383655;3133.2793457504786;3858.151206734528;3859.691224702031;3905.316569600323;4083.4691490106243;3978.860739874105;3990.3814908689055;3996.220736956295;4011.498562679665;4012.518497780256;3464.3244567309384;3688.2807852468777;3713.6286371362917;3931.677732316188;4001.579834117405;2943.470175368433;3447.9482807757904;3485.403374485999;3503.4744788281705;3518.3491054155065;5042.495750424965;5043.798248070073;5051.747412629354;5100.336956195708;5153;4151.626353628188;4353.889758111693;4563.475200351969;4578.672185066327;4593.701409408378;4798.864505295145;5227.242049902781;5262;5544.390117087117;5586.35756887955;3124.265797537577;3709.6104908984707;3727.7390582659223;3729.179580492287;3744.326021316162;5070.909754402821;5751.913721294184;5783.529882070766;5785.566082543826;5803.084981955944;3335.1989925440475;3346.1969127409247;3774.8490060397276;3782.659560639501;3782.71629627779;3650;3871.438641397038;3897.6102389761363;3919.549251836075;3939.6060393960374;4270.48754149504;4476.567498400545;4479.843205487792;4483.798229079699;4571.154336447701;5287.947120528823;5541.473560011793;5582.944170558324;5653.208550802891;5668.5465162787705;1112.844201811747;1314.9605511834468;1323.7418703352753;1332.8667133286788;1338.946442142323;792.8414317136596;821.8274162425957;823.1357075071152;847.8643417053241;898.4609234459402;4203.852865149705;4955.35580374549;4966.776495057658;4973.950260497349;5007.4491805901325;5584.441555844464;5607.663540187602;5611;5623.493885550321;5625.578081643893;3905.4727611772614;4050.6151915567975;4822.93895343024;4907.484714105039;4971.030649023406;2505.3318216099797;2892.4669924939817;2926.7707562823666;2958.180718857887;2959.5412711029826;5978;5990.9515834728745;6020.909686354708;6028.005379112397;6042.244719410074;4914.115459217303;5299.4700529946695;5841.415858414124;5843.4355043423475;5917.822465326047;5987.820365389045;5994.441445224186;6000.879982400327;6001.879962400728;6012.248468941382;5424.647397919122;5457.372402173642;5596.832095037155;5599.524040456607;5607.5513958882375;4881.9023619528125;5180.067587834075;5304.628675992643;5587.720613969366;5664.291963504562;4955.35580374549;5572.554195664256;5967.552433567586;5990.161377407254;6037.818865434044;3590.5691317042124;3781.470594116771;3814.3134235837815;3820.56063552695;3833.769973801581;4906.607471402208;5043.697378157322;5580;5587.329520457572;5598.536643876681;5100.48995100487;5128.871778205575;5228.555572776357;5334.839954801362;5361.678299301899;5465.267366316842;5487.835364939058;5503.477169668875;5505.532029777513;5506.201600767947;5211.5049070338255;5305.416404195458;5370.583237543043;5377.516023557899;5384.515393614593;4719.8348057819185;5055.797768089383;5443.210734443563;5461.699606521521;5480.588955828409;4551.431071116111;5336.653117547347;5356.3572371315695;5390.568754499553;5466.890662186814 08:41:32 INFO - PROCESS | 1659 | |5;yui.html;702.9894551581727;735.3712575747734;743.7619961612282;750.2347605442449;817.5094943034177;15165.469208577702;15989;15999.84000160001;16020.679586408265;16056.678866422679;14206.573802785933;14305.499307524238;14313.427462901498;14352.354144063516;14358.928205358958;694.3334398976988;712.729162918093;855.632078206371;866.3459088388258;878.7846977490524;883.9337049721264;889.9510526921017;891.3715830339595;893.4817805672727;903.345074820753;954.7804005078837;955.8852937647457;956.2493442647523;957.0286159548065;957.1051067252141;944.9480278584675;947.4883562876039;947.7251597036851;947.7441090905486;949.292776881221;551.8179000929683;681.9352161544646;693.743314973458;697.8360085379932;698.7449580902985;14947.103173809606;14947.775783363259;14974.251287435585;14977.850221497754;14986.250687465692;13603.183808971493;14104.294785260798;14191.07757995727;14238.288085595783;14280.714385712332;12432;12708.555200568027;12726.80909786354;12803.48786048557;13024.353181109305;4607.838725644587;4697.765111744399;4729.408823897013;4753.120672675566;4842.1526232909455;81988.18011819925;110407;110863.89136108616;116349;116482.67034659344;10867.619633312954;11063.280886742335;11164.274322169033;11190;11555.826662600068;22527;22885.771142288697;22887.198948036737;22897.08411663548;22910.770892290864;7783;7818.687252509836;7829.451938364374;7853.607319633996;7856.607169641495;4350.1734670412525;4367.868963931023;4413.691041627119;4436.423264975597;4520.276755719069;3376.814275214838;3476.6349533299144;3479.1128262292955;3489.7382696297877;3491.319192757439;522.9764660590282;617.3240301869536;624.2415465209701;631.6652174347603;632.3044650884083;467.462418219044;510.50226029620825;551.5670198893849;614.8954677704801;628.9339619339995;8754.956225218833;8834.469931804113;8893.333000025024;8909.198172164537;9033.63865445388;600.3336296710647;627.1220291591808;636.6912047656883;638.9712462939179;644.8678021005683;3651.3062518122;4388.210122177975;4399.406080179199;4404.647628189737;4531.886702832389;155553.11128220917;162946;163116.65975031152;165104;167855;114721.85278147111;118148.40925795316;122509;136927;144898;72404;89706;111354;111735;114173;9284.396514226553;9776.470881407404;9777.332155301763;9791.783905458593;9915.454649994319;55596.722016389656;63303;63886;64938;67603;78178.6091069541;88674.55662721646;94667.52666236625;98289.52565711377;98732;11331;13055.859802847528;13181.736365272833;13292.800607991081;13701.383437745126;12053;14738.705225895637;14796.63008424798;15407.69184616279;15423.84576154269;12126.878731212575;13602.455901763818;13785.379657915217;13811.723765524432;14145.222012788983;12956.222626642431;13373.331333433483;13715.45138194501;13785.379657915619;14395.85604143987;12322.905106132159;13437.328133593477;13486.662833429244;13499.460021599027;13558.322083895568;9537.332386732862;9980.700578982352;10757.193210509087;11201.943990279997;11474.483648235682;9660;9908.35595686278;10796.89203107959;11011.28426652265;11470.655880323604 08:41:32 INFO - PROCESS | 1659 | __end_tp_report 08:41:32 INFO - PROCESS | 1659 | __start_cc_report 08:41:32 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1263 08:41:32 INFO - PROCESS | 1659 | __end_cc_report 08:41:32 INFO - PROCESS | 1659 | __startTimestamp1473176492419__endTimestamp 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | ------- Summary: start ------- 08:41:32 INFO - PROCESS | 1659 | Number of tests: 6 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5602.17 Median:5764.25 stddev:679.31 (11.8%) stddev-sans-first:657.10 08:41:32 INFO - PROCESS | 1659 | Values: 3307.1 3310.4 3348.8 3358.9 3401.2 5540.7 5593.9 5632.8 5666.5 5686.8 5614.0 5624.6 5653.7 5714.7 5760.0 5079.8 5130.7 5166.8 5171.3 5220.8 4327.4 5241.0 5241.9 5245.1 5298.7 5088.9 5153.9 5155.6 5197.1 5224.1 4221.9 5126.7 5204.6 5217.2 5227.9 5108.0 5116.7 5126.7 5207.1 5209.2 5692.9 5702.0 5704.5 5705.2 5741.8 6098.4 6103.3 6150.4 6258.8 6287.1 6246.0 6324.3 6334.4 6335.2 6350.2 5774.0 5796.7 5805.4 5807.0 5827.5 6256.5 6263.6 6321.7 6329.9 6362.6 6043.1 6081.0 6086.6 6087.0 6096.2 5246.0 6249.5 6274.8 6277.7 6282.0 6065.4 6099.8 6106.9 6108.1 6183.0 6211.4 6250.2 6259.5 6285.5 6294.5 4142.6 4929.3 4948.0 4983.4 4984.2 4341.3 4345.4 4354.9 4394.6 4432.5 4407.1 5473.1 5478.0 5487.9 5508.8 5719.9 5829.7 6147.1 6165.3 6177.5 5184.3 5215.4 5243.7 5312.8 5317.8 5123.3 5148.0 5157.6 5194.1 5234.4 6319.1 6331.5 6333.7 6334.7 6339.0 5931.7 6124.8 6143.6 6143.8 6162.4 5329.6 6255.4 6266.3 6346.4 6347.8 6196.9 6200.3 6210.0 6225.6 6225.8 6049.4 6146.4 6147.9 6158.6 6178.1 4865.9 5759.3 5795.8 5829.5 5949.6 5845.6 5894.4 5894.9 5897.7 5907.0 4515.8 4858.9 5751.5 5769.7 5792.1 4981.7 5745.9 5805.0 5812.2 5859.1 4840.7 5759.7 5764.3 5768.3 5772.2 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:64394.67 Median:34192.57 stddev:134668.12 (393.9%) stddev-sans-first:134960.44 08:41:32 INFO - PROCESS | 1659 | Values: 493.6 521.3 526.7 529.2 559.7 30145.9 30761.0 40488.2 40532.4 40673.8 42148.6 42399.7 42404.6 42459.6 42540.6 9571.9 9770.0 9771.9 9783.9 9793.1 8768.8 8911.6 11876.2 12004.6 12041.9 11938.8 12034.9 12042.2 12057.2 12070.6 12037.8 12089.8 12100.6 12123.8 12129.6 11077.4 11159.4 11161.8 11162.4 11177.2 39643.4 39761.0 39835.4 39863.0 39888.2 3332.3 3338.1 3549.3 3572.7 3833.0 30088.7 30116.8 30507.4 30682.9 30894.5 3120.8 3195.9 3212.5 3273.9 3291.4 469689.0 471939.0 472729.0 473065.0 474705.0 56674.7 56848.4 56869.6 56877.7 56949.7 34154.3 34479.1 34686.8 60018.4 60085.7 16169.2 16411.8 16559.8 16576.3 16642.3 11576.5 11779.9 12659.6 12750.2 12751.7 18707.1 19111.7 19259.2 19464.7 19558.9 7739.7 7826.7 7863.9 7870.6 7933.6 768.0 1023.3 1033.3 1071.8 1087.4 27599.4 29532.0 29914.0 30566.2 30683.0 1042.7 1079.3 1091.5 1117.1 1189.3 14709.3 15299.8 15341.6 15436.2 15723.1 520694.0 524197.1 524418.0 524741.0 526291.0 57546.7 57942.0 58032.1 58081.1 58133.0 1094.6 1262.6 1335.7 1363.2 1391.0 29405.9 30358.3 31118.7 31348.4 31845.0 47537.8 48313.0 48328.8 48413.5 48453.0 518088.0 519891.0 520570.0 520749.0 525232.0 25291.5 26186.0 26284.2 26286.6 26340.3 46279.8 46976.8 47117.0 47284.8 47430.5 38705.4 38712.8 39136.4 39664.4 40334.8 37839.0 38247.0 38513.0 39014.0 39417.0 37526.1 37944.8 38568.2 38665.6 38794.8 27611.4 31496.1 33439.8 33964.3 34230.8 22661.5 24104.6 24972.0 25163.2 25523.0 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34789.14 Median:25424.56 stddev:100645.97 (395.9%) stddev-sans-first:100895.02 08:41:32 INFO - PROCESS | 1659 | Values: 315.9 353.9 372.5 381.9 406.9 14991.6 16787.1 16818.6 17304.4 20172.7 19407.5 19462.2 20489.9 20614.0 20914.1 5730.3 5875.9 6153.5 6155.9 6173.9 5970.0 6022.5 6102.6 6104.5 6107.9 5740.3 5984.4 6062.1 6062.5 6067.4 6031.3 6085.9 6098.5 6099.0 6099.8 4999.8 5187.1 5256.8 5257.7 5269.1 21927.7 22231.2 23847.3 25343.2 25505.9 2090.1 2527.8 2579.0 2616.3 2651.8 9981.1 10050.7 10114.6 10457.6 10489.1 1552.6 1780.3 1838.9 1896.5 1934.0 115338.4 122898.0 125382.0 128154.0 130953.4 11039.9 11369.1 11438.6 11491.1 11690.5 14398.0 14399.4 14422.5 14427.4 14456.4 8229.4 8500.6 8521.9 8666.3 8706.8 8455.5 8465.9 8504.1 8656.5 8661.4 4409.1 4476.2 4504.7 4569.3 4571.3 1870.4 1921.0 1937.2 1937.5 1981.5 780.2 845.9 847.8 875.9 1000.5 15951.5 19211.0 21479.7 21487.1 21657.0 783.8 909.5 916.3 940.3 1034.5 10464.2 10745.4 11247.4 11273.4 11381.9 596886.0 599430.0 600709.0 605984.3 612298.0 83539.0 124393.4 127893.0 134586.3 136368.0 989.6 1009.5 1026.9 1026.9 1027.6 13682.6 16295.8 18775.8 19015.0 19221.3 43048.8 53003.4 54400.7 54774.0 54957.0 60702.7 75097.6 75492.0 78099.0 78108.2 7166.2 7409.5 7694.9 8059.9 8337.3 12151.8 13059.0 13120.7 13445.2 13696.7 9672.5 11550.9 11699.0 11707.0 11741.2 5210.6 8558.4 11278.2 11612.5 11773.2 11404.8 11424.2 11658.4 11808.0 11924.7 7047.5 7190.9 7334.0 7456.1 7532.1 9477.5 11668.1 11718.2 11723.0 11744.6 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5672.96 Median:4877.01 stddev:3217.74 (66.0%) stddev-sans-first:3211.41 08:41:32 INFO - PROCESS | 1659 | Values: 1489.3 1532.5 1732.3 1847.8 1879.4 8454.2 8965.3 8978.6 8984.3 8991.2 7833.4 8072.2 8477.8 8685.7 8727.5 2328.4 2356.0 2362.4 2364.2 2365.1 1843.3 2252.3 2338.1 2350.4 2352.6 2077.1 2147.1 2147.4 2149.6 2154.3 2278.9 2352.5 2354.3 2356.0 2366.3 2306.3 2334.4 2341.5 2343.6 2354.3 7457.2 8986.3 8989.1 8997.6 9009.4 4225.3 5347.9 5350.8 5356.1 5371.7 3249.3 3317.2 3371.8 3494.5 3577.4 1002.1 1023.5 1034.4 1037.7 1051.5 11668.0 11759.8 11765.8 11768.2 11784.6 4435.8 4563.5 4749.8 4751.7 4774.4 9915.3 9921.4 9923.4 9924.0 9933.9 5312.2 5332.9 5336.3 5342.0 5343.9 4750.9 4839.2 4901.9 4903.0 4905.6 3854.0 3884.0 3925.7 3932.6 4005.7 1222.8 1261.8 1267.8 1281.5 1282.4 754.2 844.8 883.6 885.7 927.9 4800.7 5334.0 5540.5 5803.4 6082.4 870.0 904.9 944.1 951.8 974.3 3726.6 3790.9 3881.6 3947.1 3960.1 10170.5 10264.1 10621.3 10686.2 10851.2 10705.3 10797.4 10797.8 10837.9 10864.2 7905.4 8184.8 8243.7 8250.1 8256.4 5839.2 5883.7 5979.6 6020.7 6077.4 10028.5 10029.7 10038.3 10082.0 10099.8 9742.0 10149.7 10173.3 10340.5 10374.8 7427.4 7600.4 7603.0 7603.2 7607.7 8194.0 8227.0 8228.3 8258.7 8312.9 7365.5 7405.7 7422.6 7471.4 7576.2 7178.9 7276.9 7320.1 7325.3 7369.3 6621.4 6820.8 6883.6 6891.2 6908.0 4818.7 4876.3 4877.7 4934.9 5093.4 4127.0 4945.3 4955.0 4989.3 5108.0 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4459.25 Median:5042.73 stddev:1394.43 (27.7%) stddev-sans-first:1362.08 08:41:32 INFO - PROCESS | 1659 | Values: 249.4 298.0 301.4 310.1 313.2 4381.3 5043.0 5193.1 5367.7 5386.6 4601.7 4851.4 5298.4 5328.8 5330.0 3554.9 4014.4 4070.8 4088.3 4095.9 3133.3 3858.2 3859.7 3905.3 4083.5 3978.9 3990.4 3996.2 4011.5 4012.5 3464.3 3688.3 3713.6 3931.7 4001.6 2943.5 3447.9 3485.4 3503.5 3518.3 5042.5 5043.8 5051.7 5100.3 5153.0 4151.6 4353.9 4563.5 4578.7 4593.7 4798.9 5227.2 5262.0 5544.4 5586.4 3124.3 3709.6 3727.7 3729.2 3744.3 5070.9 5751.9 5783.5 5785.6 5803.1 3335.2 3346.2 3774.8 3782.7 3782.7 3650.0 3871.4 3897.6 3919.5 3939.6 4270.5 4476.6 4479.8 4483.8 4571.2 5287.9 5541.5 5582.9 5653.2 5668.5 1112.8 1315.0 1323.7 1332.9 1338.9 792.8 821.8 823.1 847.9 898.5 4203.9 4955.4 4966.8 4974.0 5007.4 5584.4 5607.7 5611.0 5623.5 5625.6 3905.5 4050.6 4822.9 4907.5 4971.0 2505.3 2892.5 2926.8 2958.2 2959.5 5978.0 5991.0 6020.9 6028.0 6042.2 4914.1 5299.5 5841.4 5843.4 5917.8 5987.8 5994.4 6000.9 6001.9 6012.2 5424.6 5457.4 5596.8 5599.5 5607.6 4881.9 5180.1 5304.6 5587.7 5664.3 4955.4 5572.6 5967.6 5990.2 6037.8 3590.6 3781.5 3814.3 3820.6 3833.8 4906.6 5043.7 5580.0 5587.3 5598.5 5100.5 5128.9 5228.6 5334.8 5361.7 5465.3 5487.8 5503.5 5505.5 5506.2 5211.5 5305.4 5370.6 5377.5 5384.5 4719.8 5055.8 5443.2 5461.7 5480.6 4551.4 5336.7 5356.4 5390.6 5466.9 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:24922.72 Median:4378.04 stddev:40279.94 (920.0%) stddev-sans-first:40351.89 08:41:32 INFO - PROCESS | 1659 | Values: 703.0 735.4 743.8 750.2 817.5 15165.5 15989.0 15999.8 16020.7 16056.7 14206.6 14305.5 14313.4 14352.4 14358.9 694.3 712.7 855.6 866.3 878.8 883.9 890.0 891.4 893.5 903.3 954.8 955.9 956.2 957.0 957.1 944.9 947.5 947.7 947.7 949.3 551.8 681.9 693.7 697.8 698.7 14947.1 14947.8 14974.3 14977.9 14986.3 13603.2 14104.3 14191.1 14238.3 14280.7 12432.0 12708.6 12726.8 12803.5 13024.4 4607.8 4697.8 4729.4 4753.1 4842.2 81988.2 110407.0 110863.9 116349.0 116482.7 10867.6 11063.3 11164.3 11190.0 11555.8 22527.0 22885.8 22887.2 22897.1 22910.8 7783.0 7818.7 7829.5 7853.6 7856.6 4350.2 4367.9 4413.7 4436.4 4520.3 3376.8 3476.6 3479.1 3489.7 3491.3 523.0 617.3 624.2 631.7 632.3 467.5 510.5 551.6 614.9 628.9 8755.0 8834.5 8893.3 8909.2 9033.6 600.3 627.1 636.7 639.0 644.9 3651.3 4388.2 4399.4 4404.6 4531.9 155553.1 162946.0 163116.7 165104.0 167855.0 114721.9 118148.4 122509.0 136927.0 144898.0 72404.0 89706.0 111354.0 111735.0 114173.0 9284.4 9776.5 9777.3 9791.8 9915.5 55596.7 63303.0 63886.0 64938.0 67603.0 78178.6 88674.6 94667.5 98289.5 98732.0 11331.0 13055.9 13181.7 13292.8 13701.4 12053.0 14738.7 14796.6 15407.7 15423.8 12126.9 13602.5 13785.4 13811.7 14145.2 12956.2 13373.3 13715.5 13785.4 14395.9 12322.9 13437.3 13486.7 13499.5 13558.3 9537.3 9980.7 10757.2 11201.9 11474.5 9660.0 9908.4 10796.9 11011.3 11470.7 08:41:32 INFO - PROCESS | 1659 | -------- Summary: end -------- 08:41:32 INFO - PROCESS | 1659 | 08:41:32 INFO - TEST-INFO | 1659: exit 0 08:41:33 INFO - TEST-OK | dromaeo_css | took 1117153ms 08:41:33 INFO - TEST-START | kraken 08:41:33 INFO - operating with platform_type : mac_ 08:41:33 INFO - Initialising browser for kraken test... 08:41:33 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpXI0t8Z/profile http://localhost:49273/getInfo.html) 08:41:35 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 08:41:35 INFO - PROCESS | 1666 | colorDepth:24 08:41:35 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 08:41:35 INFO - PROCESS | 1666 | __metrics 08:41:35 INFO - PROCESS | 1666 | 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" 08:41:35 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:36 INFO - TEST-INFO | 1666: exit 0 08:41:36 INFO - Browser initialized. 08:41:36 INFO - Running cycle 1/1 for kraken test... 08:41:36 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpXI0t8Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:48 INFO - PROCESS | 1667 | RSS: Main: 232353792 08:41:48 INFO - PROCESS | 1667 | 08:41:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:51 INFO - PROCESS | 1667 | RSS: Main: 291172352 08:41:51 INFO - PROCESS | 1667 | 08:41:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 08:41:54 INFO - PROCESS | 1667 | RSS: Main: 287215616 08:41:54 INFO - PROCESS | 1667 | 08:41:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 08:41:58 INFO - PROCESS | 1667 | RSS: Main: 377765888 08:41:58 INFO - PROCESS | 1667 | 08:42:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 08:42:01 INFO - PROCESS | 1667 | RSS: Main: 280956928 08:42:01 INFO - PROCESS | 1667 | 08:42:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:04 INFO - PROCESS | 1667 | RSS: Main: 284569600 08:42:04 INFO - PROCESS | 1667 | 08:42:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:07 INFO - PROCESS | 1667 | RSS: Main: 320843776 08:42:07 INFO - PROCESS | 1667 | 08:42:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:11 INFO - PROCESS | 1667 | RSS: Main: 323805184 08:42:11 INFO - PROCESS | 1667 | 08:42:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 08:42:14 INFO - PROCESS | 1667 | RSS: Main: 321552384 08:42:14 INFO - PROCESS | 1667 | 08:42:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:17 INFO - PROCESS | 1667 | RSS: Main: 297889792 08:42:17 INFO - PROCESS | 1667 | 08:42:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:19 INFO - PROCESS | 1667 | RSS: Main: 302956544 08:42:19 INFO - PROCESS | 1667 | 08:42:21 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:22 INFO - PROCESS | 1667 | RSS: Main: 304197632 08:42:22 INFO - PROCESS | 1667 | 08:42:25 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:25 INFO - PROCESS | 1667 | RSS: Main: 317812736 08:42:25 INFO - PROCESS | 1667 | 08:42:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:29 INFO - PROCESS | 1667 | RSS: Main: 314134528 08:42:29 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 08:42:31 INFO - PROCESS | 1667 | RSS: Main: 357801984 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | __start_tp_report 08:42:31 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 08:42:31 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 08:42:31 INFO - PROCESS | 1667 | |i|pagename|runs| 08:42:31 INFO - PROCESS | 1667 | |0;ai-astar;112;112;115;112;111;113;114;111;111;122 08:42:31 INFO - PROCESS | 1667 | |1;audio-beat-detection;149;109;131;162;109;131;130;109;156;109 08:42:31 INFO - PROCESS | 1667 | |2;audio-dft;184;184;183;184;185;178;184;183;182;185 08:42:31 INFO - PROCESS | 1667 | |3;audio-fft;77;78;78;141;70;77;79;92;148;48 08:42:31 INFO - PROCESS | 1667 | |4;audio-oscillator;81;84;132;70;76;83;119;68;70;112 08:42:31 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;87;83;86;83;86;84;87;85;86;84 08:42:31 INFO - PROCESS | 1667 | |6;imaging-darkroom;92;93;93;95;87;140;146;92;93;93 08:42:31 INFO - PROCESS | 1667 | |7;imaging-desaturate;124;130;102;84;84;83;86;85;84;84 08:42:31 INFO - PROCESS | 1667 | |8;json-parse-financial;55;54;55;54;55;54;54;53;52;54 08:42:31 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;67;68;75;76;72;69;71;68;71;72 08:42:31 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;87;87;87;83;85;88;84;88;84;90 08:42:31 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;148;148;144;136;148;154;142;139;180;139 08:42:31 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;169;173;170;169;178;238;197;179;209;168 08:42:31 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;66;68;67;67;68;66;66;81;84 08:42:31 INFO - PROCESS | 1667 | __end_tp_report 08:42:31 INFO - PROCESS | 1667 | __start_cc_report 08:42:31 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2022 08:42:31 INFO - PROCESS | 1667 | __end_cc_report 08:42:31 INFO - PROCESS | 1667 | __startTimestamp1473176551709__endTimestamp 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | ------- Summary: start ------- 08:42:31 INFO - PROCESS | 1667 | Number of tests: 14 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.50 stddev:3.33 (3.0%) stddev-sans-first:3.50 08:42:31 INFO - PROCESS | 1667 | Values: 112.0 112.0 115.0 112.0 111.0 113.0 114.0 111.0 111.0 122.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:131.00 stddev:20.61 (15.7%) stddev-sans-first:20.62 08:42:31 INFO - PROCESS | 1667 | Values: 149.0 109.0 131.0 162.0 109.0 131.0 130.0 109.0 156.0 109.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:2.04 (1.1%) stddev-sans-first:2.15 08:42:31 INFO - PROCESS | 1667 | Values: 184.0 184.0 183.0 184.0 185.0 178.0 184.0 183.0 182.0 185.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:88.80 Median:77.50 stddev:31.39 (40.5%) stddev-sans-first:33.00 08:42:31 INFO - PROCESS | 1667 | Values: 77.0 78.0 78.0 141.0 70.0 77.0 79.0 92.0 148.0 48.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:73.00 stddev:22.93 (31.4%) stddev-sans-first:24.11 08:42:31 INFO - PROCESS | 1667 | Values: 81.0 84.0 132.0 70.0 76.0 83.0 119.0 68.0 70.0 112.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.52 (1.8%) stddev-sans-first:1.45 08:42:31 INFO - PROCESS | 1667 | Values: 87.0 83.0 86.0 83.0 86.0 84.0 87.0 85.0 86.0 84.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:93.00 stddev:21.54 (23.2%) stddev-sans-first:22.52 08:42:31 INFO - PROCESS | 1667 | Values: 92.0 93.0 93.0 95.0 87.0 140.0 146.0 92.0 93.0 93.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:84.00 stddev:18.02 (21.5%) stddev-sans-first:15.66 08:42:31 INFO - PROCESS | 1667 | Values: 124.0 130.0 102.0 84.0 84.0 83.0 86.0 85.0 84.0 84.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.94 (1.7%) stddev-sans-first:0.93 08:42:31 INFO - PROCESS | 1667 | Values: 55.0 54.0 55.0 54.0 55.0 54.0 54.0 53.0 52.0 54.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:3.00 (4.2%) stddev-sans-first:2.83 08:42:31 INFO - PROCESS | 1667 | Values: 67.0 68.0 75.0 76.0 72.0 69.0 71.0 68.0 71.0 72.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:87.00 stddev:2.21 (2.5%) stddev-sans-first:2.33 08:42:31 INFO - PROCESS | 1667 | Values: 87.0 87.0 87.0 83.0 85.0 88.0 84.0 88.0 84.0 90.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:148.00 stddev:12.55 (8.5%) stddev-sans-first:13.31 08:42:31 INFO - PROCESS | 1667 | Values: 148.0 148.0 144.0 136.0 148.0 154.0 142.0 139.0 180.0 139.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:178.50 stddev:23.06 (12.9%) stddev-sans-first:23.72 08:42:31 INFO - PROCESS | 1667 | Values: 169.0 173.0 170.0 169.0 178.0 238.0 197.0 179.0 209.0 168.0 08:42:31 INFO - PROCESS | 1667 | 08:42:31 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:68.00 stddev:6.62 (9.7%) stddev-sans-first:6.98 08:42:31 INFO - PROCESS | 1667 | Values: 68.0 66.0 68.0 67.0 67.0 68.0 66.0 66.0 81.0 84.0 08:42:31 INFO - PROCESS | 1667 | -------- Summary: end -------- 08:42:31 INFO - PROCESS | 1667 | 08:42:32 INFO - TEST-INFO | 1667: exit 0 08:42:32 INFO - TEST-OK | kraken | took 59567ms 08:42:32 INFO - SUITE-END | took 1176s 08:42:32 INFO - Completed test suite (00:19:36) 08:42:32 INFO - javascript benchmark 08:42:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.1236122427563, 3310.371029504394, 3348.7823291486066, 3358.9328213435747, 3401.183715908183, 5540.667559946406, 5593.888122237558, 5632.802851900185, 5666.518345940595, 5686.7725290988365, 5614.017546929281, 5624.550035997121, 5653.717314134287, 5714.71426428679, 5760.049591817345, 5079.822206222783, 5130.743462826862, 5166.819161329354, 5171.301874246985, 5220.765065572039, 4327.415798867144, 5241.0, 5241.947580524203, 5245.134552798802, 5298.7350632468415, 5088.949110508885, 5153.896922061538, 5155.561777248939, 5197.090509160882, 5224.111900976843, 4221.852235171785, 5126.743662816882, 5204.583633309327, 5217.243499692561, 5227.921581176285, 5107.9744601277125, 5116.692998420107, 5126.692398456067, 5207.114790485626, 5209.19257515082, 5692.857678558028, 5701.971490142564, 5704.515116215127, 5705.172749951275, 5741.770329186827, 6098.39016098391, 6103.307364981935, 6150.384961503859, 6258.78094266703, 6287.056941458772, 6246.0, 6324.3359447257835, 6334.4299013088585, 6335.208098987627, 6350.237971443456, 5773.971130144322, 5796.739146738407, 5805.390434004369, 5806.970965145189, 5827.533797296206, 6256.5307601930035, 6263.6241825490615, 6321.747130114744, 6329.936700633027, 6362.618242905441, 6043.12374705674, 6080.969595151996, 6086.6348019119, 6086.995645718495, 6096.185141921503, 5245.9737701312015, 6249.531285153632, 6274.811755647338, 6277.686115694289, 6281.96859015702, 6065.423784740443, 6099.817005489843, 6106.94607981953, 6108.144859719643, 6183.0, 6211.440970312694, 6250.1874756281395, 6259.4679452246155, 6285.528585356116, 6294.527910406738, 4142.647874930604, 4929.285253638274, 4947.950520494821, 4983.377077865267, 4984.177610694195, 4341.305391137403, 4345.391645169679, 4354.934675979799, 4394.604485596312, 4432.468103827561, 4407.140607581491, 5473.0969390051, 5478.0, 5487.862803429946, 5508.752106155152, 5719.8570035749435, 5829.708514574254, 6147.139400483936, 6165.290991536031, 6177.4749146323065, 5184.326037615161, 5215.374155101412, 5243.737813109329, 5312.840614781563, 5317.8404647860625, 5123.308353372322, 5148.021875843652, 5157.63896527247, 5194.142966410575, 5234.398044224963, 6319.146915166394, 6331.461825744771, 6333.746650134128, 6334.714937827809, 6339.0, 5931.673757943355, 6124.846878827887, 6143.631382117087, 6143.754249829957, 6162.414570615784, 5329.600279978939, 6255.374462553708, 6266.279377871603, 6346.365363463617, 6347.777827776191, 6196.938030619816, 6200.255969283715, 6209.96895015522, 6225.564210505402, 6225.813225603058, 6049.425304596057, 6146.385361463997, 6147.938520614736, 6158.630482171084, 6178.073289006685, 4865.878353041202, 5759.337676167127, 5795.82612521625, 5829.504492118217, 5949.6430214187285, 5845.590808643354, 5894.410558944071, 5894.941050589611, 5897.705114744332, 5906.970465147647, 4515.751633660049, 4858.878528036827, 5751.4536119068625, 5769.653820770767, 5792.102224155263, 4981.676191047571, 5745.885082298414, 5804.970975145097, 5812.157237200667, 5859.091840764518, 4840.7337596431125, 5759.740811663569, 5764.250647415809, 5768.307803063659, 5772.19189313488], "value": 5560.193768644482, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.6396430605658, 521.3014560488944, 526.6681990346082, 529.1665626638046, 559.6837786650544, 30145.944891928786, 30761.0, 40488.19023619526, 40532.39201411974, 40673.79663101688, 42148.578514214845, 42399.72800815973, 42404.57595424053, 42459.575404245945, 42540.574594254045, 9571.856422153673, 9769.974152713969, 9771.853422198637, 9783.902160978407, 9793.11861932426, 8768.824623507526, 8911.554422278892, 11876.16866819323, 12004.579839705568, 12041.91622753952, 11938.761224775499, 12034.939825300862, 12042.217255878384, 12057.155999080069, 12070.637880863544, 12037.759244815099, 12089.758204835942, 12100.636980890544, 12123.818142727867, 12129.6361109166, 11077.390743509104, 11159.442027898654, 11161.776764464747, 11162.386068766215, 11177.161712871568, 39643.40534891979, 39761.0, 39835.40246896299, 39863.0, 39888.20223595512, 3332.3168750406107, 3338.1487720631326, 3549.290141971616, 3572.732045096628, 3832.9808350958065, 30088.69911300881, 30116.849415753, 30507.389852203054, 30682.9260975867, 30894.536581951288, 3120.7971481853606, 3195.9041228763176, 3212.518122281653, 3273.885414010498, 3291.3707714681145, 469689.0, 471939.0, 472729.0, 473065.0, 474705.0, 56674.7166264166, 56848.431515684315, 56869.578260543814, 56877.71561142168, 56949.71525142348, 34154.31691366159, 34479.13802154966, 34686.826565867006, 60018.39981600215, 60085.69957150274, 16169.191540422931, 16411.83588164127, 16559.751603725952, 16576.336946522006, 16642.3343066276, 11576.536938522364, 11779.941100294614, 12659.620211393672, 12750.171238869443, 12751.744965100832, 18707.10039943811, 19111.713324300148, 19259.22963081489, 19464.70802937957, 19558.90220548888, 7739.690412383554, 7826.726064587826, 7863.882041769378, 7870.567118808406, 7933.603319834101, 767.9731209407644, 1023.3194925374692, 1033.2818691009827, 1071.7802850415646, 1087.3856271206744, 27599.448011039665, 29531.966381176557, 29914.0, 30566.235844104074, 30683.0, 1042.718466014172, 1079.282277285612, 1091.4651820607844, 1117.1063149480383, 1189.2567145534042, 14709.338079786436, 15299.770503442458, 15341.6164595886, 15436.228188590525, 15723.05661660304, 520694.0, 524197.096348433, 524418.0, 524741.0, 526291.0, 57546.7122664384, 57942.0, 58032.12951805726, 58081.128783068285, 58133.0, 1094.584058057933, 1262.5517941130765, 1335.746208220435, 1363.2025265219957, 1390.9721805563831, 29405.85297073501, 30358.336742737825, 31118.688813112483, 31348.37303253968, 31845.0, 47537.7623111896, 48313.0, 48328.758356207996, 48413.51586484231, 48453.0, 518088.0, 519891.0, 520570.0, 520749.0, 525232.0, 25291.494170116126, 26186.0, 26284.21147365582, 26286.60570091412, 26340.341491462867, 46279.76860115678, 46976.7651161742, 47117.0, 47284.7635761819, 47430.52569474261, 38705.4194187093, 38712.8386148416, 39136.412953806284, 39664.40503392509, 40334.79832600818, 37839.0, 38247.0, 38513.03717406975, 39013.952837310266, 39417.01457463586, 37526.06184845401, 37944.810275948446, 38568.228635426574, 38665.61334386733, 38794.80602596969, 27611.44777104487, 31496.055118346485, 33439.83280083584, 33964.32071358609, 34230.82884585561, 22661.546769064855, 24104.638430423907, 24972.0, 25163.24510264695, 25523.0], "value": 19918.665572464462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.9383920135574, 353.90975301298164, 372.46365234062966, 381.9140693343998, 406.8799704087294, 14991.550253492385, 16787.07671078092, 16818.579535511617, 17304.394346197885, 20172.697409538832, 19407.514812129702, 19462.221511139538, 20489.87305698186, 20614.0, 20914.058867350966, 5730.312362516483, 5875.941240587582, 6153.476954458876, 6155.938440615604, 6173.938260617381, 5969.970150149243, 6022.488088512482, 6102.572819902609, 6104.542159338045, 6107.908381374283, 5740.339860915986, 5984.401559844025, 6062.120992456091, 6062.514998800108, 6067.362926892679, 6031.336552979169, 6085.908711369333, 6098.54260930432, 6098.9695051524905, 6099.817005489843, 4999.8250061248045, 5187.144121219994, 5256.789728410859, 5257.738142845689, 5269.130593452076, 21927.67108493374, 22231.221907233168, 23847.284581462583, 25343.239702808944, 25505.872470637714, 2090.0594732370496, 2527.8356906801, 2578.9871050644815, 2616.3459135216194, 2651.8276312039657, 9981.051800078982, 10050.748731281703, 10114.645987390406, 10457.58169673212, 10489.108425783741, 1552.6351307442742, 1780.3412737287288, 1838.9264429422808, 1896.506908203863, 1933.994322952057, 115338.42330788376, 122898.0, 125382.0, 128154.0, 130953.392690206, 11039.944800275947, 11369.09047276216, 11438.599649012245, 11491.080713542897, 11690.532378704756, 14397.99214055027, 14399.352029158714, 14422.495212667507, 14427.422903083969, 14456.421743130368, 8229.423940324239, 8500.574971251413, 8521.872171917426, 8666.263367613823, 8706.825863482694, 8455.49267043967, 8465.915340846635, 8504.064552899175, 8656.48061116335, 8661.350398719995, 4409.1181763646755, 4476.216662084123, 4504.729716217037, 4569.337446070301, 4571.337156112345, 1870.4014715290975, 1920.990395048016, 1937.2057456443072, 1937.4768812420568, 1981.5442448236986, 780.1691198873182, 845.9365547583956, 847.809242920338, 875.8554838451712, 1000.5197505197546, 15951.521454356387, 19211.0, 21479.67780483294, 21487.140514379564, 21657.025433855513, 783.8236396810672, 909.5287032761852, 916.3356566489242, 940.2759874896292, 1034.5086084110137, 10464.162866970624, 10745.40900250478, 11247.437628118561, 11273.42833860042, 11381.886181138083, 596886.0, 599430.0, 600709.0, 605984.3417224102, 612298.0, 83539.0, 124393.37803311106, 127893.0, 134586.327068366, 136368.0, 989.5843745626854, 1009.5154325923597, 1026.8819085805228, 1026.9127124194379, 1027.5992362978445, 13682.589522314347, 16295.755563666791, 18775.812241877407, 19015.0, 19221.327253546617, 43048.78475607602, 53003.40989770313, 54400.72799635977, 54774.0, 54957.0, 60702.696486517285, 75097.62451187709, 75492.0, 78099.0, 78108.21891781237, 7166.211716711054, 7409.481336306407, 7694.902809061027, 8059.879101813361, 8337.333013359039, 12151.81772273399, 13059.0, 13120.671983200496, 13445.193288402726, 13696.657583560092, 9672.516374181121, 11550.896540780624, 11699.0, 11707.0, 11741.236819606698, 5210.635255532076, 8558.373908957277, 11278.154138439813, 11612.535498579962, 11773.17587768848, 11404.828927565926, 11424.200305978502, 11658.41707914584, 11808.0, 11924.661094893443, 7047.506674532733, 7190.892136618059, 7334.046573945353, 7456.067991501062, 7532.133804612539, 9477.478738669439, 11668.066554675775, 11718.179727419, 11723.0, 11744.647660570197], "value": 9417.111672960475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.3074720255079, 1532.4942768886267, 1732.3417101501427, 1847.7690288713911, 1879.3798046644608, 8454.196851299124, 8965.28277737781, 8978.551072446384, 8984.2812574994, 8991.190792828644, 7833.41249406294, 8072.1927807219245, 8477.830443391129, 8685.696000639979, 8727.47635141892, 2328.3946173994755, 2355.988220058906, 2362.3621622162004, 2364.2198074635417, 2365.1485465232504, 1843.3363988963963, 2252.3355610094977, 2338.0998315648426, 2350.3536527454917, 2352.5882970480097, 2077.1276064053136, 2147.0982187481295, 2147.3987283560627, 2149.602323570137, 2154.3321570313174, 2278.931632051041, 2352.5294941011693, 2354.2937118864356, 2355.9528809423887, 2366.266457398212, 2306.331163962449, 2334.4047267946735, 2341.461463863321, 2343.5781559319316, 2354.3407845803204, 7457.179710231871, 8986.281097512183, 8989.101089891024, 8997.595108220146, 9009.369344145913, 4225.281702110648, 5347.919781203285, 5350.785968561253, 5356.143017117242, 5371.704556249405, 3249.2689144942437, 3317.170707323169, 3371.7976921384798, 3494.5457090578316, 3577.3560759063357, 1002.0780881588955, 1023.4575674892319, 1034.420724394334, 1037.6938803053117, 1051.4690081508866, 11668.00821930137, 11759.764804703858, 11765.823512647317, 11768.235064720766, 11784.646460606196, 4435.756033418128, 4563.516857021481, 4749.810007599657, 4751.667383283206, 4774.355462012653, 9915.256355773347, 9921.40471571708, 9923.354981926152, 9924.0, 9933.850992235122, 5312.2297266896085, 5332.92000619991, 5336.279602253724, 5341.973290133525, 5343.877785664976, 4750.857474275777, 4839.225723884232, 4901.901961960741, 4903.043906438282, 4905.55849973497, 3853.959430953627, 3883.9611603884164, 3925.7448265862627, 3932.5674175840636, 4005.679545636342, 1222.7798996180773, 1261.7602655495427, 1267.784476638955, 1281.51943021367, 1282.4357282795727, 754.2382193984115, 844.7550210439027, 883.5626364949392, 885.6545947080643, 927.8747369105084, 4800.66395352322, 5333.959877823865, 5540.529055030287, 5803.390643982406, 6082.422169893853, 869.9652013919499, 904.8868891388577, 944.1361154543516, 951.8286708392417, 974.2887691984749, 3726.552813662324, 3790.886273411802, 3881.5536213335263, 3947.1118998225743, 3960.089179488734, 10170.542325595366, 10264.127549158256, 10621.256512044083, 10686.198535109897, 10851.186161037953, 10705.339223195559, 10797.352158870493, 10797.83803242952, 10837.891621083845, 10864.185186111074, 7905.446618736748, 8184.836303273901, 8243.670253189804, 8250.092489826115, 8256.380771442165, 5839.211706419749, 5883.705814709333, 5979.551533635082, 6020.698965051817, 6077.361877002851, 10028.548715307683, 10029.69910902674, 10038.347507411994, 10082.04220599042, 10099.798004040025, 9742.0, 10149.695509134737, 10173.338732982333, 10340.53467593945, 10374.792504150026, 7427.405807535276, 7600.3539699123985, 7603.0, 7603.201663825219, 7607.695692172472, 8194.016717993878, 8227.0, 8228.341732661493, 8258.669653213805, 8312.875306870523, 7365.484416090822, 7405.740799072222, 7422.591757453392, 7471.439642026761, 7576.24237576238, 7178.856422871618, 7276.854462910606, 7320.1215854097845, 7325.304096110861, 7369.263073692588, 6621.370969757865, 6820.829479263058, 6883.586984780929, 6891.241963384124, 6907.965460172868, 4818.71087734737, 4876.317315575893, 4877.707337559757, 4934.851954441372, 5093.363329583802, 4126.995187163071, 4945.307656927961, 4954.9752251238515, 4989.276554899592, 5108.0], "value": 4537.9089105326075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.44747384543234, 297.9985100074501, 301.41675857216285, 310.1300851112629, 313.2497668084937, 4381.327390291924, 5042.9661919306545, 5193.10451685135, 5367.651102678323, 5386.596005299609, 4601.71152077418, 4851.417829860413, 5298.436961096476, 5328.8401347959525, 5330.0, 3554.867079752141, 4014.3978403239603, 4070.7584186823005, 4088.325426304664, 4095.9180816383655, 3133.2793457504786, 3858.151206734528, 3859.691224702031, 3905.316569600323, 4083.4691490106243, 3978.860739874105, 3990.3814908689055, 3996.220736956295, 4011.498562679665, 4012.518497780256, 3464.3244567309384, 3688.2807852468777, 3713.6286371362917, 3931.677732316188, 4001.579834117405, 2943.470175368433, 3447.9482807757904, 3485.403374485999, 3503.4744788281705, 3518.3491054155065, 5042.495750424965, 5043.798248070073, 5051.747412629354, 5100.336956195708, 5153.0, 4151.626353628188, 4353.889758111693, 4563.475200351969, 4578.672185066327, 4593.701409408378, 4798.864505295145, 5227.242049902781, 5262.0, 5544.390117087117, 5586.35756887955, 3124.265797537577, 3709.6104908984707, 3727.7390582659223, 3729.179580492287, 3744.326021316162, 5070.909754402821, 5751.913721294184, 5783.529882070766, 5785.566082543826, 5803.084981955944, 3335.1989925440475, 3346.1969127409247, 3774.8490060397276, 3782.659560639501, 3782.71629627779, 3650.0, 3871.438641397038, 3897.6102389761363, 3919.549251836075, 3939.6060393960374, 4270.48754149504, 4476.567498400545, 4479.843205487792, 4483.798229079699, 4571.154336447701, 5287.947120528823, 5541.473560011793, 5582.944170558324, 5653.208550802891, 5668.5465162787705, 1112.844201811747, 1314.9605511834468, 1323.7418703352753, 1332.8667133286788, 1338.946442142323, 792.8414317136596, 821.8274162425957, 823.1357075071152, 847.8643417053241, 898.4609234459402, 4203.852865149705, 4955.35580374549, 4966.776495057658, 4973.950260497349, 5007.4491805901325, 5584.441555844464, 5607.663540187602, 5611.0, 5623.493885550321, 5625.578081643893, 3905.4727611772614, 4050.6151915567975, 4822.93895343024, 4907.484714105039, 4971.030649023406, 2505.3318216099797, 2892.4669924939817, 2926.7707562823666, 2958.180718857887, 2959.5412711029826, 5978.0, 5990.9515834728745, 6020.909686354708, 6028.005379112397, 6042.244719410074, 4914.115459217303, 5299.4700529946695, 5841.415858414124, 5843.4355043423475, 5917.822465326047, 5987.820365389045, 5994.441445224186, 6000.879982400327, 6001.879962400728, 6012.248468941382, 5424.647397919122, 5457.372402173642, 5596.832095037155, 5599.524040456607, 5607.5513958882375, 4881.9023619528125, 5180.067587834075, 5304.628675992643, 5587.720613969366, 5664.291963504562, 4955.35580374549, 5572.554195664256, 5967.552433567586, 5990.161377407254, 6037.818865434044, 3590.5691317042124, 3781.470594116771, 3814.3134235837815, 3820.56063552695, 3833.769973801581, 4906.607471402208, 5043.697378157322, 5580.0, 5587.329520457572, 5598.536643876681, 5100.48995100487, 5128.871778205575, 5228.555572776357, 5334.839954801362, 5361.678299301899, 5465.267366316842, 5487.835364939058, 5503.477169668875, 5505.532029777513, 5506.201600767947, 5211.5049070338255, 5305.416404195458, 5370.583237543043, 5377.516023557899, 5384.515393614593, 4719.8348057819185, 5055.797768089383, 5443.210734443563, 5461.699606521521, 5480.588955828409, 4551.431071116111, 5336.653117547347, 5356.3572371315695, 5390.568754499553, 5466.890662186814], "value": 4009.555807348975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.9894551581727, 735.3712575747734, 743.7619961612282, 750.2347605442449, 817.5094943034177, 15165.469208577702, 15989.0, 15999.84000160001, 16020.679586408265, 16056.678866422679, 14206.573802785933, 14305.499307524238, 14313.427462901498, 14352.354144063516, 14358.928205358958, 694.3334398976988, 712.729162918093, 855.632078206371, 866.3459088388258, 878.7846977490524, 883.9337049721264, 889.9510526921017, 891.3715830339595, 893.4817805672727, 903.345074820753, 954.7804005078837, 955.8852937647457, 956.2493442647523, 957.0286159548065, 957.1051067252141, 944.9480278584675, 947.4883562876039, 947.7251597036851, 947.7441090905486, 949.292776881221, 551.8179000929683, 681.9352161544646, 693.743314973458, 697.8360085379932, 698.7449580902985, 14947.103173809606, 14947.775783363259, 14974.251287435585, 14977.850221497754, 14986.250687465692, 13603.183808971493, 14104.294785260798, 14191.07757995727, 14238.288085595783, 14280.714385712332, 12432.0, 12708.555200568027, 12726.80909786354, 12803.48786048557, 13024.353181109305, 4607.838725644587, 4697.765111744399, 4729.408823897013, 4753.120672675566, 4842.1526232909455, 81988.18011819925, 110407.0, 110863.89136108616, 116349.0, 116482.67034659344, 10867.619633312954, 11063.280886742335, 11164.274322169033, 11190.0, 11555.826662600068, 22527.0, 22885.771142288697, 22887.198948036737, 22897.08411663548, 22910.770892290864, 7783.0, 7818.687252509836, 7829.451938364374, 7853.607319633996, 7856.607169641495, 4350.1734670412525, 4367.868963931023, 4413.691041627119, 4436.423264975597, 4520.276755719069, 3376.814275214838, 3476.6349533299144, 3479.1128262292955, 3489.7382696297877, 3491.319192757439, 522.9764660590282, 617.3240301869536, 624.2415465209701, 631.6652174347603, 632.3044650884083, 467.462418219044, 510.50226029620825, 551.5670198893849, 614.8954677704801, 628.9339619339995, 8754.956225218833, 8834.469931804113, 8893.333000025024, 8909.198172164537, 9033.63865445388, 600.3336296710647, 627.1220291591808, 636.6912047656883, 638.9712462939179, 644.8678021005683, 3651.3062518122, 4388.210122177975, 4399.406080179199, 4404.647628189737, 4531.886702832389, 155553.11128220917, 162946.0, 163116.65975031152, 165104.0, 167855.0, 114721.85278147111, 118148.40925795316, 122509.0, 136927.0, 144898.0, 72404.0, 89706.0, 111354.0, 111735.0, 114173.0, 9284.396514226553, 9776.470881407404, 9777.332155301763, 9791.783905458593, 9915.454649994319, 55596.722016389656, 63303.0, 63886.0, 64938.0, 67603.0, 78178.6091069541, 88674.55662721646, 94667.52666236625, 98289.52565711377, 98732.0, 11331.0, 13055.859802847528, 13181.736365272833, 13292.800607991081, 13701.383437745126, 12053.0, 14738.705225895637, 14796.63008424798, 15407.69184616279, 15423.84576154269, 12126.878731212575, 13602.455901763818, 13785.379657915217, 13811.723765524432, 14145.222012788983, 12956.222626642431, 13373.331333433483, 13715.45138194501, 13785.379657915619, 14395.85604143987, 12322.905106132159, 13437.328133593477, 13486.662833429244, 13499.460021599027, 13558.322083895568, 9537.332386732862, 9980.700578982352, 10757.193210509087, 11201.943990279997, 11474.483648235682, 9660.0, 9908.35595686278, 10796.89203107959, 11011.28426652265, 11470.655880323604], "value": 7825.901171117009, "unit": "score"}], "name": "dromaeo_css", "value": 7277.244338098726, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 115.0, 112.0, 111.0, 113.0, 114.0, 111.0, 111.0, 122.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 109.0, 131.0, 162.0, 109.0, 131.0, 130.0, 109.0, 156.0, 109.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 184.0, 185.0, 178.0, 184.0, 183.0, 182.0, 185.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 141.0, 70.0, 77.0, 79.0, 92.0, 148.0, 48.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 132.0, 70.0, 76.0, 83.0, 119.0, 68.0, 70.0, 112.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 83.0, 86.0, 84.0, 87.0, 85.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 95.0, 87.0, 140.0, 146.0, 92.0, 93.0, 93.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 102.0, 84.0, 84.0, 83.0, 86.0, 85.0, 84.0, 84.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 53.0, 52.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 75.0, 76.0, 72.0, 69.0, 71.0, 68.0, 71.0, 72.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 83.0, 85.0, 88.0, 84.0, 88.0, 84.0, 90.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 144.0, 136.0, 148.0, 154.0, 142.0, 139.0, 180.0, 139.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 170.0, 169.0, 178.0, 238.0, 197.0, 179.0, 209.0, 168.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 67.0, 67.0, 68.0, 66.0, 66.0, 81.0, 84.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1500.4999999999998, "alertThreshold": 2.0}]} 08:42:32 INFO - Return code: 0 08:42:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:42:32 INFO - # TBPL SUCCESS # 08:42:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:42:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:42:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:42:32 INFO - 2016-09-06 08:42:32.994 screenresolution[1671:10561] starting screenresolution argv=screenresolution get 08:42:32 INFO - 2016-09-06 08:42:32.997 screenresolution[1671:10561] Display 0: 1600x1200x32@60 08:42:33 INFO - 2016-09-06 08:42:33.003 screenresolution[1672:10564] starting screenresolution argv=screenresolution list 08:42:33 INFO - Available Modes on Display 0 08:42:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:42:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:42:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:42:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:42:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:42:33 INFO - Intel Iris: 08:42:33 INFO - Chipset Model: Intel Iris 08:42:33 INFO - Type: GPU 08:42:33 INFO - Bus: Built-In 08:42:33 INFO - VRAM (Dynamic, Max): 1536 MB 08:42:33 INFO - Vendor: Intel (0x8086) 08:42:33 INFO - Device ID: 0x0a2e 08:42:33 INFO - Revision ID: 0x0009 08:42:33 INFO - Displays: 08:42:33 INFO - Display: 08:42:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:42:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:42:33 INFO - Display Serial Number: 1600x1200 60 08:42:33 INFO - Main Display: Yes 08:42:33 INFO - Mirror: Off 08:42:33 INFO - Online: Yes 08:42:33 INFO - Rotation: Supported 08:42:33 INFO - Return code: 0 08:42:33 INFO - Running post-action listener: _resource_record_post_action 08:42:33 INFO - [mozharness: 2016-09-06 15:42:33.239365Z] Finished run-tests step (success) 08:42:33 INFO - Running post-run listener: _resource_record_post_run 08:42:33 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 33041408; Write bytes: 705986048; Read time: 334; Write time: 2344 08:42:33 INFO - TinderboxPrint: CPU usage
53.4% 08:42:33 INFO - TinderboxPrint: I/O read bytes / time
33,041,408 / 334 08:42:33 INFO - TinderboxPrint: I/O write bytes / time
705,986,048 / 2,344 08:42:33 INFO - TinderboxPrint: CPU idle
2,255.7 (46.6%) 08:42:33 INFO - TinderboxPrint: CPU system
967.5 (20.0%) 08:42:33 INFO - TinderboxPrint: CPU user
1,622.5 (33.5%) 08:42:33 INFO - TinderboxPrint: Swap in / out
435,040,256 / 0 08:42:33 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406561280; Write bytes: 400430592; Read time: 29839; Write time: 817 08:42:33 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 29301760; Write bytes: 295835648; Read time: 300; Write time: 1477 08:42:33 INFO - Running post-run listener: _upload_blobber_files 08:42:33 INFO - Blob upload gear active. 08:42:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:33 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 08:42:33 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:33 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:35 INFO - (blobuploader) - INFO - Done attempting. 08:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:42:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:36 INFO - (blobuploader) - INFO - Done attempting. 08:42:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:42:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:42:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:39 INFO - (blobuploader) - INFO - Done attempting. 08:42:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:39 INFO - Return code: 0 08:42:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7000930691aa6a3fef7d610837b3c49fef38ff659adfb1b3f6bf4901aafc123c7c19acc0b689c75bfbbe330ca2c5f8340ef1de4b881577d7c94c89921c8c1902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d83dc27f1fb98efe782ff4698f270e57513c25d09cf59b44b04f412e077d83dba0a1a43702062629d2f96f3de4c253a01649bca3792d84521a07bac5714fc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3de1ddd86b0dc51c59f67809a1b068a1c03d7deb6c31f206d81e3956c6c5a719c5271f371ccbd5bd93e30a5df34f9953756135c9e224ca4f8756d139bd6935d4"} 08:42:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:39 INFO - Contents: 08:42:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7000930691aa6a3fef7d610837b3c49fef38ff659adfb1b3f6bf4901aafc123c7c19acc0b689c75bfbbe330ca2c5f8340ef1de4b881577d7c94c89921c8c1902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d83dc27f1fb98efe782ff4698f270e57513c25d09cf59b44b04f412e077d83dba0a1a43702062629d2f96f3de4c253a01649bca3792d84521a07bac5714fc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3de1ddd86b0dc51c59f67809a1b068a1c03d7deb6c31f206d81e3956c6c5a719c5271f371ccbd5bd93e30a5df34f9953756135c9e224ca4f8756d139bd6935d4"} 08:42:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:39 INFO - Copying logs to upload dir... 08:42:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.786097 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-06 08:42:39.280888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 08:42:39.284079) ========= 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.Sr7NgYODK8/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.wHCEropvjp/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/Firefox/sha512/7000930691aa6a3fef7d610837b3c49fef38ff659adfb1b3f6bf4901aafc123c7c19acc0b689c75bfbbe330ca2c5f8340ef1de4b881577d7c94c89921c8c1902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d83dc27f1fb98efe782ff4698f270e57513c25d09cf59b44b04f412e077d83dba0a1a43702062629d2f96f3de4c253a01649bca3792d84521a07bac5714fc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3de1ddd86b0dc51c59f67809a1b068a1c03d7deb6c31f206d81e3956c6c5a719c5271f371ccbd5bd93e30a5df34f9953756135c9e224ca4f8756d139bd6935d4"} build_url:https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/QqDCf8fKSQWY0uL9MB_pJw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7000930691aa6a3fef7d610837b3c49fef38ff659adfb1b3f6bf4901aafc123c7c19acc0b689c75bfbbe330ca2c5f8340ef1de4b881577d7c94c89921c8c1902", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d83dc27f1fb98efe782ff4698f270e57513c25d09cf59b44b04f412e077d83dba0a1a43702062629d2f96f3de4c253a01649bca3792d84521a07bac5714fc42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3de1ddd86b0dc51c59f67809a1b068a1c03d7deb6c31f206d81e3956c6c5a719c5271f371ccbd5bd93e30a5df34f9953756135c9e224ca4f8756d139bd6935d4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 08:42:39.321677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:42:39.322277) ========= 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.Sr7NgYODK8/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.wHCEropvjp/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.004995 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 08:42:39.374990) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 08:42:39.375793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 08:42:39.376445) ========= ========= Total master_lag: 4.01 =========