builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0071 starttime: 1473274464.15 results: success (0) buildid: 20160907094616 builduid: bf44c5ca0384420a9ccc3c4d3bf1a21c revision: 33e7ae9b3104e90ce56bbde1906efa97fb116449 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.153185) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.153626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.153903) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.185487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.185959) ========= 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.j9e4cxFnfM/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.AaBDdVGFgB/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-07 11:54:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-09-07 11:54:24 (15.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120994 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.334978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.335594) ========= 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.j9e4cxFnfM/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.AaBDdVGFgB/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.028538 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.393972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:24.394683) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33e7ae9b3104e90ce56bbde1906efa97fb116449 --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 33e7ae9b3104e90ce56bbde1906efa97fb116449 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j9e4cxFnfM/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.AaBDdVGFgB/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-07 11:54:24,610 truncating revision to first 12 chars 2016-09-07 11:54:24,611 Setting DEBUG logging. 2016-09-07 11:54:24,611 attempt 1/10 2016-09-07 11:54:24,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33e7ae9b3104?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 11:54:24,995 unpacking tar archive at: mozilla-central-33e7ae9b3104/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640848 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:25.062348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:25.062774) ========= script_repo_revision: 33e7ae9b3104e90ce56bbde1906efa97fb116449 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:25.063189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:25.063582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 11:54:25.082745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-07 11:54:25.083155) ========= /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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:54:25 INFO - MultiFileLogger online at 20160907 11:54:25 in /builds/slave/test 11:54:25 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 11:54:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:25 INFO - {'append_to_log': False, 11:54:25 INFO - 'base_work_dir': '/builds/slave/test', 11:54:25 INFO - 'blob_upload_branch': 'Firefox', 11:54:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:25 INFO - 'branch': 'Firefox', 11:54:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:25 INFO - 'config_files': ('talos/mac_config.py',), 11:54:25 INFO - 'default_actions': ('clobber', 11:54:25 INFO - 'read-buildbot-config', 11:54:25 INFO - 'download-and-extract', 11:54:25 INFO - 'populate-webroot', 11:54:25 INFO - 'create-virtualenv', 11:54:25 INFO - 'install', 11:54:25 INFO - 'run-tests'), 11:54:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:25 INFO - 'download_minidump_stackwalk': True, 11:54:25 INFO - 'download_symbols': 'ondemand', 11:54:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:25 INFO - 'installer_path': 'installer.exe', 11:54:25 INFO - 'log_level': 'info', 11:54:25 INFO - 'log_name': 'talos', 11:54:25 INFO - 'log_to_console': True, 11:54:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:54:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:54:25 INFO - 'opt_config_files': (), 11:54:25 INFO - 'pip_index': False, 11:54:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:25 INFO - 'cmd': ('bash', 11:54:25 INFO - '-c', 11:54:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:25 INFO - 'enabled': True, 11:54:25 INFO - 'halt_on_failure': False, 11:54:25 INFO - 'name': 'check_screen_resolution'},), 11:54:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:54:25 INFO - 'cmd': ('bash', 11:54:25 INFO - '-c', 11:54:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:54:25 INFO - 'enabled': True, 11:54:25 INFO - 'halt_on_failure': False, 11:54:25 INFO - 'name': 'check_screen_resolution'},), 11:54:25 INFO - 'run_cmd_checks_enabled': True, 11:54:25 INFO - 'sps_profile': False, 11:54:25 INFO - 'sps_profile_interval': 0, 11:54:25 INFO - 'suite': 'dromaeojs', 11:54:25 INFO - 'system_bits': '32', 11:54:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:25 INFO - 'title': 't-yosemite-r7-0071', 11:54:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:25 INFO - 'use_talos_json': True, 11:54:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:25 INFO - 'work_dir': 'build'} 11:54:25 INFO - [mozharness: 2016-09-07 18:54:25.417814Z] Running clobber step. 11:54:25 INFO - Running pre-action listener: _resource_record_pre_action 11:54:25 INFO - Running main action method: clobber 11:54:25 INFO - rmtree: /builds/slave/test/build 11:54:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:27 INFO - Running post-action listener: _resource_record_post_action 11:54:27 INFO - [mozharness: 2016-09-07 18:54:27.513972Z] Finished clobber step (success) 11:54:27 INFO - [mozharness: 2016-09-07 18:54:27.514144Z] Running read-buildbot-config step. 11:54:27 INFO - Running pre-action listener: _resource_record_pre_action 11:54:27 INFO - Running main action method: read_buildbot_config 11:54:27 INFO - Using buildbot properties: 11:54:27 INFO - { 11:54:27 INFO - "project": "", 11:54:27 INFO - "product": "firefox", 11:54:27 INFO - "script_repo_revision": "production", 11:54:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 11:54:27 INFO - "repository": "", 11:54:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 11:54:27 INFO - "buildid": "20160907094616", 11:54:27 INFO - "pgo_build": "False", 11:54:27 INFO - "basedir": "/builds/slave/test", 11:54:27 INFO - "buildnumber": 36, 11:54:27 INFO - "slavename": "t-yosemite-r7-0071", 11:54:27 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:54:27 INFO - "platform": "yosemite_r7", 11:54:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:54:27 INFO - "branch": "mozilla-central", 11:54:27 INFO - "repo_path": "mozilla-central", 11:54:27 INFO - "revision": "33e7ae9b3104e90ce56bbde1906efa97fb116449", 11:54:27 INFO - "stage_platform": "macosx64", 11:54:27 INFO - "builduid": "bf44c5ca0384420a9ccc3c4d3bf1a21c", 11:54:27 INFO - "slavebuilddir": "test" 11:54:27 INFO - } 11:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:54:27 INFO - Running post-action listener: _resource_record_post_action 11:54:27 INFO - [mozharness: 2016-09-07 18:54:27.517393Z] Finished read-buildbot-config step (success) 11:54:27 INFO - [mozharness: 2016-09-07 18:54:27.517530Z] Running download-and-extract step. 11:54:27 INFO - Running pre-action listener: _resource_record_pre_action 11:54:27 INFO - Running main action method: download_and_extract 11:54:27 INFO - mkdir: /builds/slave/test/build/tests 11:54:27 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')]} 11:54:27 INFO - trying https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:54:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/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 11:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/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 11:54:28 INFO - Downloaded 1199 bytes. 11:54:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:54:28 INFO - Using the following test package requirements: 11:54:28 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:54:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:54:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:54:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'jsshell-mac.zip'], 11:54:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:54:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:54:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:54:28 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:54:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:54:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:54:28 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:54:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:54:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:54:29 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:54:36 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 11:54:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:54:37 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:54:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:54:44 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:54:45 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')]} 11:54:45 INFO - trying https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:54:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/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 11:54:48 INFO - Downloaded 111565621 bytes. 11:54:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:54:48 INFO - mkdir: /builds/slave/test/properties 11:54:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:48 INFO - Contents: 11:54:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:54:48 INFO - Running post-action listener: _resource_record_post_action 11:54:48 INFO - Running post-action listener: set_extra_try_arguments 11:54:48 INFO - [mozharness: 2016-09-07 18:54:48.731290Z] Finished download-and-extract step (success) 11:54:48 INFO - [mozharness: 2016-09-07 18:54:48.731414Z] Running populate-webroot step. 11:54:48 INFO - Running pre-action listener: _resource_record_pre_action 11:54:48 INFO - Running main action method: populate_webroot 11:54:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:48 INFO - '--tppagecycles', 11:54:48 INFO - '7'], 11:54:48 INFO - 'tests': ['tsvgm']}}, 11:54:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:54:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:54:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:54:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['damp', 'tps']}, 11:54:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'tests': ['damp', 'tps']}, 11:54:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['dromaeo_dom']}, 11:54:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['basic_compositor_video']}, 11:54:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:54:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['a11yr', 11:54:48 INFO - 'ts_paint', 11:54:48 INFO - 'tpaint', 11:54:48 INFO - 'sessionrestore', 11:54:48 INFO - 'sessionrestore_no_auto_restore', 11:54:48 INFO - 'tabpaint']}, 11:54:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tsvgx', 11:54:48 INFO - 'tsvgr_opacity', 11:54:48 INFO - 'tart', 11:54:48 INFO - 'tscrollx', 11:54:48 INFO - 'cart']}, 11:54:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:54:48 INFO - 'tsvgr_opacity', 11:54:48 INFO - 'tart', 11:54:48 INFO - 'tscrollx', 11:54:48 INFO - 'cart']}, 11:54:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s'], 11:54:48 INFO - 'tests': ['tp5o']}, 11:54:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'tests': ['tp5o']}, 11:54:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--disable-e10s', 11:54:48 INFO - '--xperf_path', 11:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:48 INFO - 'tests': ['tp5n']}, 11:54:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:48 INFO - 'talos_options': ['--xperf_path', 11:54:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:48 INFO - 'tests': ['tp5n']}}, 11:54:48 INFO - 'talos.zip': {'path': '', 11:54:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:48 INFO - Running post-action listener: _resource_record_post_action 11:54:48 INFO - [mozharness: 2016-09-07 18:54:48.750450Z] Finished populate-webroot step (success) 11:54:48 INFO - [mozharness: 2016-09-07 18:54:48.750577Z] Running create-virtualenv step. 11:54:48 INFO - Running pre-action listener: _resource_record_pre_action 11:54:48 INFO - Running main action method: create_virtualenv 11:54:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:48 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 11:54:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:48 INFO - Using real prefix '/tools/python27' 11:54:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:52 INFO - Installing pip.................done. 11:54:52 INFO - Return code: 0 11:54:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:52 INFO - 'HOME': '/Users/cltbld', 11:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:52 INFO - 'LOGNAME': 'cltbld', 11:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:52 INFO - 'MOZ_NO_REMOTE': '1', 11:54:52 INFO - 'NO_EM_RESTART': '1', 11:54:52 INFO - 'PAGER': '/bin/cat', 11:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:52 INFO - 'PWD': '/builds/slave/test', 11:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:52 INFO - 'SHELL': '/bin/bash', 11:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:54:52 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:52 INFO - 'USER': 'cltbld', 11:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:52 INFO - 'XPC_FLAGS': '0x0', 11:54:52 INFO - 'XPC_SERVICE_NAME': '0', 11:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:52 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 11:54:52 INFO - Cleaning up... 11:54:52 INFO - Return code: 0 11:54:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:52 INFO - 'HOME': '/Users/cltbld', 11:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:52 INFO - 'LOGNAME': 'cltbld', 11:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:52 INFO - 'MOZ_NO_REMOTE': '1', 11:54:52 INFO - 'NO_EM_RESTART': '1', 11:54:52 INFO - 'PAGER': '/bin/cat', 11:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:52 INFO - 'PWD': '/builds/slave/test', 11:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:52 INFO - 'SHELL': '/bin/bash', 11:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:54:52 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:52 INFO - 'USER': 'cltbld', 11:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:52 INFO - 'XPC_FLAGS': '0x0', 11:54:52 INFO - 'XPC_SERVICE_NAME': '0', 11:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:52 INFO - Downloading/unpacking psutil>=3.1.1 11:54:52 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 11:54:52 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 11:54:52 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 11:54:52 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 11:54:52 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 11:54:52 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 11:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:56 INFO - Installing collected packages: psutil 11:54:56 INFO - Running setup.py install for psutil 11:54:56 INFO - building 'psutil._psutil_osx' extension 11:54:56 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 11:54:56 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 11:54:56 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 11:54:57 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 11:54:57 INFO - building 'psutil._psutil_posix' extension 11:54:57 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 11:54:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:54:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:54:57 INFO - ^ 11:54:57 INFO - 1 warning generated. 11:54:57 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 11:54:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:57 INFO - Successfully installed psutil 11:54:57 INFO - Cleaning up... 11:54:57 INFO - Return code: 0 11:54:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:57 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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:54:57 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 11:54:57 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 11:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:57 INFO - 'HOME': '/Users/cltbld', 11:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:57 INFO - 'LOGNAME': 'cltbld', 11:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:57 INFO - 'MOZ_NO_REMOTE': '1', 11:54:57 INFO - 'NO_EM_RESTART': '1', 11:54:57 INFO - 'PAGER': '/bin/cat', 11:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:57 INFO - 'PWD': '/builds/slave/test', 11:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:57 INFO - 'SHELL': '/bin/bash', 11:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:54:57 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:57 INFO - 'USER': 'cltbld', 11:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:57 INFO - 'XPC_FLAGS': '0x0', 11:54:57 INFO - 'XPC_SERVICE_NAME': '0', 11:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:54:57 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 11:54:57 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 11:54:57 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 11:54:57 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 11:54:57 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 11:54:57 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 11:55:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:00 INFO - Installing collected packages: mozsystemmonitor 11:55:00 INFO - Running setup.py install for mozsystemmonitor 11:55:00 INFO - Successfully installed mozsystemmonitor 11:55:00 INFO - Cleaning up... 11:55:00 INFO - Return code: 0 11:55:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55:00 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')]} 11:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:00 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')]} 11:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:00 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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:55:00 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 11:55:00 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 11:55:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:00 INFO - 'HOME': '/Users/cltbld', 11:55:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:00 INFO - 'LOGNAME': 'cltbld', 11:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:00 INFO - 'MOZ_NO_REMOTE': '1', 11:55:00 INFO - 'NO_EM_RESTART': '1', 11:55:00 INFO - 'PAGER': '/bin/cat', 11:55:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:00 INFO - 'PWD': '/builds/slave/test', 11:55:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:00 INFO - 'SHELL': '/bin/bash', 11:55:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:00 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:00 INFO - 'USER': 'cltbld', 11:55:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:00 INFO - 'XPC_FLAGS': '0x0', 11:55:00 INFO - 'XPC_SERVICE_NAME': '0', 11:55:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:00 INFO - Downloading/unpacking jsonschema==2.5.1 11:55:00 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 11:55:00 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 11:55:00 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 11:55:00 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 11:55:00 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 11:55:00 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 11:55:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55:03 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 11:55:03 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 11:55:03 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 11:55:03 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 11:55:03 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 11:55:03 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 11:55:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:03 INFO - warning: no files found matching '*.txt' 11:55:03 INFO - no previously-included directories found matching 'build' 11:55:03 INFO - no previously-included directories found matching 'dist' 11:55:03 INFO - no previously-included directories found matching '.git*' 11:55:03 INFO - Installing collected packages: jsonschema, functools32 11:55:03 INFO - Running setup.py install for functools32 11:55:03 INFO - warning: no files found matching '*.txt' 11:55:03 INFO - no previously-included directories found matching 'build' 11:55:03 INFO - no previously-included directories found matching 'dist' 11:55:03 INFO - no previously-included directories found matching '.git*' 11:55:03 INFO - Successfully installed jsonschema functools32 11:55:03 INFO - Cleaning up... 11:55:03 INFO - Return code: 0 11:55:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55:03 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')]} 11:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:03 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')]} 11:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:03 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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:55:03 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 11:55:03 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 11:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:04 INFO - 'HOME': '/Users/cltbld', 11:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:04 INFO - 'LOGNAME': 'cltbld', 11:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:04 INFO - 'MOZ_NO_REMOTE': '1', 11:55:04 INFO - 'NO_EM_RESTART': '1', 11:55:04 INFO - 'PAGER': '/bin/cat', 11:55:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:04 INFO - 'PWD': '/builds/slave/test', 11:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:04 INFO - 'SHELL': '/bin/bash', 11:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:04 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:04 INFO - 'USER': 'cltbld', 11:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:04 INFO - 'XPC_FLAGS': '0x0', 11:55:04 INFO - 'XPC_SERVICE_NAME': '0', 11:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:04 INFO - Cleaning up... 11:55:04 INFO - Return code: 0 11:55:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55:04 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')]} 11:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:04 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')]} 11:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:04 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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:55:04 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 11:55:04 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 11:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:04 INFO - 'HOME': '/Users/cltbld', 11:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:04 INFO - 'LOGNAME': 'cltbld', 11:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:04 INFO - 'MOZ_NO_REMOTE': '1', 11:55:04 INFO - 'NO_EM_RESTART': '1', 11:55:04 INFO - 'PAGER': '/bin/cat', 11:55:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:04 INFO - 'PWD': '/builds/slave/test', 11:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:04 INFO - 'SHELL': '/bin/bash', 11:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:04 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:04 INFO - 'USER': 'cltbld', 11:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:04 INFO - 'XPC_FLAGS': '0x0', 11:55:04 INFO - 'XPC_SERVICE_NAME': '0', 11:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:07 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 11:55:08 INFO - Downloading docopt-0.6.1.tar.gz 11:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:08 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:08 INFO - Running setup.py install for blobuploader 11:55:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:08 INFO - Running setup.py install for requests 11:55:08 INFO - Running setup.py install for docopt 11:55:08 INFO - Successfully installed blobuploader requests docopt 11:55:08 INFO - Cleaning up... 11:55:09 INFO - Return code: 0 11:55:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:09 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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:55:09 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 11:55:09 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 11:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:09 INFO - 'HOME': '/Users/cltbld', 11:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:09 INFO - 'LOGNAME': 'cltbld', 11:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:09 INFO - 'MOZ_NO_REMOTE': '1', 11:55:09 INFO - 'NO_EM_RESTART': '1', 11:55:09 INFO - 'PAGER': '/bin/cat', 11:55:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:09 INFO - 'PWD': '/builds/slave/test', 11:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:09 INFO - 'SHELL': '/bin/bash', 11:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:09 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:09 INFO - 'USER': 'cltbld', 11:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:09 INFO - 'XPC_FLAGS': '0x0', 11:55:09 INFO - 'XPC_SERVICE_NAME': '0', 11:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:09 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-mnvvax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:09 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DB_XVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:09 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-W6Ielb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:09 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DiwLZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:09 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-HHMfZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:09 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-y_1gDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:09 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-zEfgzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-GBAeLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-WIZ_vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-h1Fm0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZjQfCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ReCTd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-AhQzXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-68ZFIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-noEtsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-c5zWwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:10 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7G7YQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:11 INFO - Running setup.py install for manifestparser 11:55:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Running setup.py install for mozcrash 11:55:11 INFO - Running setup.py install for mozdebug 11:55:11 INFO - Running setup.py install for mozdevice 11:55:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Running setup.py install for mozfile 11:55:11 INFO - Running setup.py install for mozhttpd 11:55:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:11 INFO - Running setup.py install for mozinfo 11:55:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Running setup.py install for mozInstall 11:55:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Running setup.py install for mozleak 11:55:12 INFO - Running setup.py install for mozlog 11:55:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Running setup.py install for moznetwork 11:55:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:12 INFO - Running setup.py install for mozprocess 11:55:12 INFO - Running setup.py install for mozprofile 11:55:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:13 INFO - Running setup.py install for mozrunner 11:55:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:13 INFO - Running setup.py install for mozscreenshot 11:55:13 INFO - Running setup.py install for moztest 11:55:13 INFO - Running setup.py install for mozversion 11:55:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:13 INFO - Cleaning up... 11:55:13 INFO - Return code: 0 11:55:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:13 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')]} 11:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:13 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')]} 11:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:13 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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:55:13 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 11:55:13 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 11:55:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:13 INFO - 'HOME': '/Users/cltbld', 11:55:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:13 INFO - 'LOGNAME': 'cltbld', 11:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:13 INFO - 'MOZ_NO_REMOTE': '1', 11:55:13 INFO - 'NO_EM_RESTART': '1', 11:55:13 INFO - 'PAGER': '/bin/cat', 11:55:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:13 INFO - 'PWD': '/builds/slave/test', 11:55:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:13 INFO - 'SHELL': '/bin/bash', 11:55:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:13 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:13 INFO - 'USER': 'cltbld', 11:55:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:13 INFO - 'XPC_FLAGS': '0x0', 11:55:13 INFO - 'XPC_SERVICE_NAME': '0', 11:55:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:13 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-fCLqpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-fqnkno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-lYcvf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-re8TML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-jVtjsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-X4toQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-NRg37Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZT36Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Ma3OLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-vgP2iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:14 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)) 11:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:14 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZGYMpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:15 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)) 11:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-3xFHOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:15 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)) 11:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-f2aLcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:15 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)) 11:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-RGDnVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:15 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)) 11:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-khQSyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:15 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)) 11:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Y443ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:15 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)) 11:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:15 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-PZbMo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:15 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)) 11:55:15 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)) 11:55:15 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)) 11:55:15 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)) 11:55:15 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)) 11:55:15 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)) 11:55:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:18 INFO - Downloading blessings-1.6.tar.gz 11:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:18 INFO - Installing collected packages: blessings 11:55:18 INFO - Running setup.py install for blessings 11:55:18 INFO - Successfully installed blessings 11:55:18 INFO - Cleaning up... 11:55:18 INFO - Return code: 0 11:55:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:18 INFO - Reading from file tmpfile_stdout 11:55:18 INFO - Current package versions: 11:55:18 INFO - blessings == 1.6 11:55:18 INFO - blobuploader == 1.2.4 11:55:18 INFO - docopt == 0.6.1 11:55:18 INFO - functools32 == 3.2.3-2 11:55:18 INFO - jsonschema == 2.5.1 11:55:18 INFO - manifestparser == 1.1 11:55:18 INFO - mozInstall == 1.12 11:55:18 INFO - mozcrash == 0.17 11:55:18 INFO - mozdebug == 0.1 11:55:18 INFO - mozdevice == 0.48 11:55:18 INFO - mozfile == 1.2 11:55:18 INFO - mozhttpd == 0.7 11:55:18 INFO - mozinfo == 0.9 11:55:18 INFO - mozleak == 0.1 11:55:18 INFO - mozlog == 3.3 11:55:18 INFO - moznetwork == 0.27 11:55:18 INFO - mozprocess == 0.23 11:55:18 INFO - mozprofile == 0.28 11:55:18 INFO - mozrunner == 6.12 11:55:18 INFO - mozscreenshot == 0.1 11:55:18 INFO - mozsystemmonitor == 0.3 11:55:18 INFO - moztest == 0.7 11:55:18 INFO - mozversion == 1.4 11:55:18 INFO - psutil == 3.1.1 11:55:18 INFO - requests == 1.2.3 11:55:18 INFO - wsgiref == 0.1.2 11:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:18 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')]} 11:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 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 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:55:19 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 11:55:19 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 11:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:19 INFO - 'HOME': '/Users/cltbld', 11:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:19 INFO - 'LOGNAME': 'cltbld', 11:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:19 INFO - 'MOZ_NO_REMOTE': '1', 11:55:19 INFO - 'NO_EM_RESTART': '1', 11:55:19 INFO - 'PAGER': '/bin/cat', 11:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:19 INFO - 'PWD': '/builds/slave/test', 11:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:19 INFO - 'SHELL': '/bin/bash', 11:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:19 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:19 INFO - 'USER': 'cltbld', 11:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:19 INFO - 'XPC_FLAGS': '0x0', 11:55:19 INFO - 'XPC_SERVICE_NAME': '0', 11:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 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)) 11:55:19 INFO - Cleaning up... 11:55:19 INFO - Return code: 0 11:55:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107623a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecd3475010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, '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.j9e4cxFnfM/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.AaBDdVGFgB/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 11:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:19 INFO - 'HOME': '/Users/cltbld', 11:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:19 INFO - 'LOGNAME': 'cltbld', 11:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:19 INFO - 'MOZ_NO_REMOTE': '1', 11:55:19 INFO - 'NO_EM_RESTART': '1', 11:55:19 INFO - 'PAGER': '/bin/cat', 11:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:19 INFO - 'PWD': '/builds/slave/test', 11:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:19 INFO - 'SHELL': '/bin/bash', 11:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:19 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:19 INFO - 'USER': 'cltbld', 11:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:19 INFO - 'XPC_FLAGS': '0x0', 11:55:19 INFO - 'XPC_SERVICE_NAME': '0', 11:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:19 INFO - Cleaning up... 11:55:19 INFO - Return code: 0 11:55:19 INFO - Running post-action listener: _resource_record_post_action 11:55:19 INFO - Running post-action listener: _start_resource_monitoring 11:55:19 INFO - Starting resource monitoring. 11:55:19 INFO - [mozharness: 2016-09-07 18:55:19.848082Z] Finished create-virtualenv step (success) 11:55:19 INFO - [mozharness: 2016-09-07 18:55:19.849031Z] Running install step. 11:55:19 INFO - Running pre-action listener: _resource_record_pre_action 11:55:19 INFO - Running main action method: install 11:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:20 INFO - Reading from file tmpfile_stdout 11:55:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:20 INFO - Reading from file tmpfile_stdout 11:55:20 INFO - Output received: 11:55:20 INFO - Usage: mozinstall [options] installer 11:55:20 INFO - Options: 11:55:20 INFO - -h, --help show this help message and exit 11:55:20 INFO - -d DEST, --destination=DEST 11:55:20 INFO - Directory to install application into. [default: 11:55:20 INFO - "/builds/slave/test"] 11:55:20 INFO - --app=APP Application being installed. [default: firefox] 11:55:20 INFO - mkdir: /builds/slave/test/build/application 11:55:20 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'] 11:55:20 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 11:55:54 INFO - Reading from file tmpfile_stdout 11:55:54 INFO - Output received: 11:55:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:55:54 INFO - Running post-action listener: _resource_record_post_action 11:55:54 INFO - [mozharness: 2016-09-07 18:55:54.235185Z] Finished install step (success) 11:55:54 INFO - [mozharness: 2016-09-07 18:55:54.235330Z] Running run-tests step. 11:55:54 INFO - Running pre-action listener: _resource_record_pre_action 11:55:54 INFO - Running main action method: run_tests 11:55:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:55:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:55:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:55:54 INFO - 2016-09-07 11:55:54.249 screenresolution[1634:7634] starting screenresolution argv=screenresolution get 11:55:54 INFO - 2016-09-07 11:55:54.252 screenresolution[1634:7634] Display 0: 1600x1200x32@60 11:55:54 INFO - 2016-09-07 11:55:54.257 screenresolution[1635:7636] starting screenresolution argv=screenresolution list 11:55:54 INFO - Available Modes on Display 0 11:55:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:55:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:55:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:55:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:55:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:55:54 INFO - Intel Iris: 11:55:54 INFO - Chipset Model: Intel Iris 11:55:54 INFO - Type: GPU 11:55:54 INFO - Bus: Built-In 11:55:54 INFO - VRAM (Dynamic, Max): 1536 MB 11:55:54 INFO - Vendor: Intel (0x8086) 11:55:54 INFO - Device ID: 0x0a2e 11:55:54 INFO - Revision ID: 0x0009 11:55:54 INFO - Displays: 11:55:54 INFO - Display: 11:55:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:55:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:55:54 INFO - Display Serial Number: 1600x1200 60 11:55:54 INFO - Main Display: Yes 11:55:54 INFO - Mirror: Off 11:55:54 INFO - Online: Yes 11:55:54 INFO - Rotation: Supported 11:55:54 INFO - Return code: 0 11:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:55:54 INFO - Python 2.7.3 11:55:54 INFO - Return code: 0 11:55:54 INFO - grabbing minidump binary from tooltool 11:55: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')]} 11:55:54 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 0x107587d30>, '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 0x1072ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10757fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:55:54 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 11:55:54 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 11:55:54 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 11:55:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:55:54 INFO - Return code: 0 11:55:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:55:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:55:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:55:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:55:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:55:54 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/Ve7sNzg9S6WkzVF9suj4WQ/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 11:55:54 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/Ve7sNzg9S6WkzVF9suj4WQ/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 11:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9e4cxFnfM/Render', 11:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:54 INFO - 'HOME': '/Users/cltbld', 11:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:54 INFO - 'LOGNAME': 'cltbld', 11:55:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:54 INFO - 'MOZ_NO_REMOTE': '1', 11:55:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:54 INFO - 'NO_EM_RESTART': '1', 11:55:54 INFO - 'PAGER': '/bin/cat', 11:55:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:54 INFO - 'PWD': '/builds/slave/test', 11:55:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:54 INFO - 'SHELL': '/bin/bash', 11:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AaBDdVGFgB/Listeners', 11:55:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 11:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:54 INFO - 'USER': 'cltbld', 11:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:54 INFO - 'XPC_FLAGS': '0x0', 11:55:54 INFO - 'XPC_SERVICE_NAME': '0', 11:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:54 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/Ve7sNzg9S6WkzVF9suj4WQ/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 11:55:54 INFO - mozversion application_buildid: 20160907094616 11:55:54 INFO - mozversion application_changeset: 33e7ae9b3104e90ce56bbde1906efa97fb116449 11:55:54 INFO - mozversion application_display_name: Nightly 11:55:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:55:54 INFO - mozversion application_name: Firefox 11:55:54 INFO - mozversion application_remotingname: firefox 11:55:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:55:54 INFO - mozversion application_vendor: Mozilla 11:55:54 INFO - mozversion application_version: 51.0a1 11:55:54 INFO - mozversion platform_buildid: 20160907094616 11:55:54 INFO - mozversion platform_changeset: 33e7ae9b3104e90ce56bbde1906efa97fb116449 11:55:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:55:54 INFO - mozversion platform_version: 51.0a1 11:55:54 INFO - using testdate: 1473274554 11:55:54 INFO - actual date: 1473274554 11:55:54 INFO - starting webserver on 'localhost:49279' 11:55:54 INFO - SUITE-START | Running 2 tests 11:55:54 INFO - TEST-START | dromaeo_css 11:55:54 INFO - operating with platform_type : mac_ 11:55:54 INFO - Initialising browser for dromaeo_css test... 11:55:54 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpOZeFwC/profile http://localhost:49279/getInfo.html) 11:55:57 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 11:55:57 INFO - PROCESS | 1645 | colorDepth:24 11:55:57 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 11:55:57 INFO - PROCESS | 1645 | __metrics 11:55:57 INFO - PROCESS | 1645 | 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" 11:55:57 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:58 INFO - TEST-INFO | 1645: exit 0 11:55:58 INFO - Browser initialized. 11:55:58 INFO - Running cycle 1/1 for dromaeo_css test... 11:55:58 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpOZeFwC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:09 INFO - PROCESS | 1647 | RSS: Main: 232386560 11:56:09 INFO - PROCESS | 1647 | 11:57:01 INFO - PROCESS | 1647 | 1473274621462 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] 11:59:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 11:59:14 INFO - PROCESS | 1647 | RSS: Main: 367276032 11:59:14 INFO - PROCESS | 1647 | 12:02:17 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 12:02:18 INFO - PROCESS | 1647 | RSS: Main: 381464576 12:02:18 INFO - PROCESS | 1647 | 12:05:20 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 12:05:21 INFO - PROCESS | 1647 | RSS: Main: 357765120 12:05:21 INFO - PROCESS | 1647 | 12:08:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 12:08:24 INFO - PROCESS | 1647 | RSS: Main: 352694272 12:08:24 INFO - PROCESS | 1647 | 12:11:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 12:11:28 INFO - PROCESS | 1647 | RSS: Main: 332886016 12:11:28 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 12:14:31 INFO - PROCESS | 1647 | RSS: Main: 382820352 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | __start_tp_report 12:14:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 12:14:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 12:14:31 INFO - PROCESS | 1647 | |i|pagename|runs| 12:14:31 INFO - PROCESS | 1647 | |0;dojo.html;2821.7883658725596;3356.7146792522635;3374.4094783412897;3421.4525675891864;3445.5865296164466;5624.831255062355;5721.885562288757;5756.251687280647;5791.391903850098;5797.04348782451;5754.827355179341;5759.963206622806;5773.278340207474;5777.480026797587;5780.855478613037;5232.3459567554055;5242.659227150242;5264.341957255343;5287.180487024518;5319.813806516772;5345.919811202835;5349.411564727877;5352.090144675395;5352.384475785276;5352.866178345534;4223.366495025755;5262.81580144695;5275.024120537693;5338.893222135555;5341.893162136755;4212.599803018708;5333.546648534879;5341.092014357569;5350.678959262456;5376.704281264529;5146.691198528063;5170.1986192140275;5186.818461353834;5289.761960711778;5304.973475132639;5705.2012718219485;5726.284214473191;5727.11229759388;5753.280839895013;5821.27234095738;6276.09642348206;6291.96854015727;6292.2134733158355;6313.684315784192;6322.778702745428;6111.2055432793895;6253.1245625612455;6336.176297081396;6376.553641245115;6385.808425747235;5849.9470095382385;5852.619579727304;5857.941420585739;5862.824115276506;5863.589548731633;6316.399942005502;6329.905051424233;6339.873202535923;6340.175777149033;6340.365963403715;6008.579399442085;6088.086786981989;6153;6241.625502469867;6247.2815626202655;6326.652034138075;6328.240611126695;6346.11154438379;6356.364363563606;6381.202349706286;6296.811095667137;6303.968480157661;6317.305096439388;6319.652419116993;6327.905081423783;5194.35070616173;6141.148492690813;6148.9854174061675;6203.875922481525;6304.684765761694;4951.628627852853;4970.577500912391;4979.850604481871;4984.825531106394;4988.152014157602;4444.755538445416;4446.977765111218;4451.710638808532;4471.8658440246845;4508.616767574793;4894.730789806595;5731.742071606787;5824.3302020267365;5826.708664566755;5860.912086318709;5439.456054394529;6115.422885572139;6248.094026366151;6332.810015699536;6380.617162970237;5724.370319264877;5799.739011744482;5813.215215945877;5836.737346819404;5855.063189889597;5512.228288039678;5519.365272993577;5521.309836270466;5525.364583072917;5525.557955363562;6246.875062498633;6286.402791734778;6350.523710721622;6398.808035758934;6408.615483070937;6273.71768270438;6294.852573713143;6301;6313.242410910537;6319.178506794087;6357.427831495188;6359.427651511386;6366.745330186741;6378.904316435164;6381;6134.35589263121;6169.321374648875;6236.781712640036;6237.064440333987;6265;5463.781448742165;5884.146798714248;6241.594296370721;6323.430891219812;6348.746050157942;6067.453929146398;6144.17053697763;6150.50795936333;6161.383861613982;6172.629642221481;6031.577789554689;6115.209918062534;6141.6007959482495;6191.442770150708;6235.46998505114;5992.490638295793;6066.817995460143;6072.392760723892;6082.90875636857;6110.7861224856915;6183.5671502994355;6237.970734828702;6247.5001999840815;6250;6254.468370188585;5818.592698511064;5865.970670146622;6027.758889644365;6054;6055.303640081447 12:14:31 INFO - PROCESS | 1647 | |1;ext.html;475.65277347536295;481.9927701084482;491.51094660812487;526.4498598964083;535.5849216856935;29448.705512944864;29783.255418614546;36987;41299.79350103245;42300.94247643803;38928.41607375892;41434;41787.373189402184;41854;41870.37194442078;9736.756581085494;9917.900820991807;9919.057689519484;9940.5526751296;9971.900280997206;8583.356248281372;9799.70600881971;9804.36271642341;9919.3056486046;9922.057404546556;9792.902070979306;9841.90158098417;9865.062819032217;9878.407295562254;9935.701928942108;8416.915830841674;9867.802643947152;9878.950605246964;9887.703368898945;9890.604375824958;9750.9512452438;9825.852612210823;9827.262955278382;9827.852582211273;9849.21206303494;38917.02707432337;39363;39413.80293098516;39459;39495.40756888649;3406.5230867678547;3417.7436692247934;3461.0309113448275;3615.783053016801;3795.9240815183816;29870.25324366908;30447.23881902948;30670.84664576685;30671;30765.38469230603;3087.1047396255058;3119.4229067622564;3126.2965832687464;3159.304952910379;3168.1921110117005;288760.55619721767;290679;292013;292782.5360873203;293067;57792.71103644455;58279;58283.4171658278;58299.12551311649;58411.70794146002;33583.992480225636;34209.144771380415;57183.85632287414;57253;57499.71250143723;13513;15656.608584785472;16196.271167797477;16256.268467918972;16364.754528682079;10442.477876106164;12311.6922076947;12386.504539818487;12427;12434.937825310815;18209.635807284045;18312.450626481226;18427.72358414625;18736.252749450163;18746.812531874508;6664.733410663616;7212.963935180291;7313.939478775548;7703.845923081507;7833.451658383859;718.4791026505742;1008.2287050406445;1035.2607619199816;1075.3924032921375;1082.0315817343592;29040.273993150342;29749.256268593457;29782;29898.05338548131;30045.57648771853;970.713639476342;988.7577543501744;1026.1841835740604;1034.3070143004054;1076.827707566801;14135.293235338191;14619;14721.411143554353;15108.924455377872;15155.621109472351;537025;542991;543256;543776;546604;53052.46947530552;53572.73213633985;53684.92630147453;53719;53971.46028539743;1054.3568423261804;1207.9094067944939;1316.249737649569;1370.2737549098993;1394.3167847754528;29145.854270728512;29524.704752952195;30137.794488220225;30734;30778;49640.503594963586;50472.738181544286;50674.746626266635;50709.492905070474;50784.23823642574;523787;536430;536719;537700.31149844;538388;30462.84768576143;33331.83334083314;35548.93353199408;35576.46635300421;41601;41684.58315416928;43667.126657467306;45619.54380456153;46731;46766.06467870555;37609.4358584616;38190.6180938187;38218.808905955295;39242.411363830135;39367.606323936394;37713.43429848609;37754.8112259437;37803;38537.421938671505;38659.420108698956;37602.81198594099;38023.619763803115;38220.80889595534;38281;38319.80840095893;28644.14067577976;30397.544036839907;33344.66655333416;34448.311033778686;34604.82697586496;24792.884320205994;25072;25318.98724051091;25398.746012540378;25626.615600765632 12:14:31 INFO - PROCESS | 1647 | |2;jquery.html;342.2333971902937;371.31863031337497;372.6404020120585;392.37416320968043;403.26001786721366;19934.800651993475;20449.18203271869;20859.687104693403;20957.790422095775;21128.89435552824;20175.49561260969;20586.69119963198;20864.16543338265;21148.89425552874;21190.788092119074;5623.831285061455;5852.795152169675;5925.348211696732;5972.313183983854;6001.48987336077;3947.6052394760436;4073.5926407359325;5878.412158784109;5995.970020149915;6009.399060093978;4221.957780422203;4291.935620965688;6502.512311576651;6536.182977127859;6625.238097618763;5030.396352437694;6539.901901471458;6579.934200658028;6587.209534855848;6592.241892182388;5752.712364381764;5871.882562348772;5875.500582450497;5885.293764748215;5895.557833162487;12884.677883052998;12946.741065178738;12954.546590869275;13089.738205235937;13211.537596184184;2287.611106111965;2347.6830627865193;2431.9756802431925;2434.8417352872184;2607.709183953955;9435.292353073546;9749.415035097916;10145.03622155894;10336.586536538529;11584.942075289653;1834.523024013766;1836.4307064809818;1889.5653999580036;1898.1742941820353;1962.077823422989;107862.59580148227;119147.87243084348;119685.99999999913;120200.39899800533;121474;11265.605703800327;11410.600628977945;11514.481848316846;11528.654140375802;11701.88298117008;11917.52329906794;14318.928405357907;14344.641383965276;14359.497417590333;14372.568822935329;8247.711330103417;8534.189252021048;8547.444416112932;8631.266342360845;8697.478151310941;7573.697052117854;8089.9191008089165;8450.704225352083;8479.109693482096;8614.87077693835;4447.666425018072;4453.688241823106;4457.68796184264;4474.865754027384;4536.092781443725;1616.886817922734;1873.297513432463;1912.8374088202659;1919.865609407328;1922.9519262018562;861.8707193920962;864.7751584588052;891.6879092317637;945.0832692288469;958.6309270930742;20665.380038598865;20678.17287308521;20779.376618701463;20967.161313547593;21009.89495052515;887.6848718704766;889.915458031486;913.8172365526921;915.4598786715869;925.3846192282057;8956.641734330553;10977.945110274557;10990.725231869268;11012.724681882857;11058.22592418539;493097;497469;500212;502237;506388;127110;127314;127674;130355.26802587623;133542;961.2214106573838;964.0648570886369;1001.4592120255127;1002.223276960347;1002.6791426743519;14744.2627868604;18077;18195.90824550531;18286.72569911479;18645.254189832256;52140.95718085693;52780.47219527756;53710.73144634252;54238.72880635571;54438.727806360715;70756.29243707497;74975;76622.0391349121;77150.61424692841;85453;7926.960365198137;8021.919780802351;8095.39284553649;8114.918850811417;8361.790955226168;11905.761884762429;12511;13071.477140914638;13435.328233588087;13502.662433439242;9707.077827606367;10348.637797677045;11086.889131108586;11322.490487927898;11475.368854712737;10992.560297588327;11241.775164496828;11401.486933087865;11541.884581154081;11731.94412502879;9745.561449734922;11217.046551043253;11366.715832104264;11673.182877198515;11786.705332366759;8051.557164355782;8094.10964793884;8176.936998190197;8185.672573097009;8224.38317126206;9172.6789562365;10842.457877105955;11177.608783692533;11661.6501504955;11666.958282300393 12:14:31 INFO - PROCESS | 1647 | |3;mootools.html;1127.222216670497;1513.5459362191343;1545.482263441747;1749.3090229359404;1903.0389653225127;6859.931400685991;8227.465214761036;8230.506169629818;8232.7941801455;8236.83526329473;8045.557494337809;8427.95786021069;8707.782305442368;8718.956405217981;8815.51514666693;2367.1951536477595;2393.3179043972473;2398.6761787158684;2403.9639405408934;2404.927852164429;1962.4995626115392;2389.7490763469846;2405.458771776354;2408.759124087586;2409.7469765674614;2355.646653002046;2375.049980008002;2387.248016874679;2391.6651668766385;2394.174009966559;2345.202631105415;2367.7513861044686;2369.1234243329905;2369.9289021329387;2383.0229605861514;2335.871527066011;2360.421696684306;2365.467769751809;2366.077229880348;2376.061455724979;8687.175693104457;8719.389642725011;8795.164459376412;8824.955875220583;8838.779030524223;5179.559737422286;5222.6605270657665;5383.865403364908;5383.973080134574;5390.946090539083;3584.7490675652716;3685.94471082934;3692.7415080944343;3694.556653201606;3695.464157697119;922.8707980882615;1078.5038882114236;1101.9449027548671;1107.5459061784711;1112.1158678850334;11348.943255283753;11479.885201147965;11490.65528034152;11493.885061149449;11515.769684606345;4527.207738645724;4690.7654617269;4767.141914455431;4933.753312334369;4973.50264973507;9061.954690226507;9115.589798459085;9117.407368521024;9119.316051296179;9124.58939347731;5294.57643388528;5295.470452954751;5295.947040529545;5301.098813201765;5306.283651707047;4287.09970906107;4339.934900976488;4425.402570652985;4913.852584422473;4967.577755890789;3705.2589482103685;3717.3494638438706;3768.755030923036;3805.486259355007;3817.6182381762155;1145.6505765741363;1155.92486488378;1160.611195249584;1166.5275563396838;1168.4508281107865;843.6751850537464;865.6840253307623;886.9157430044136;901.7565257380602;929.3355250995571;4735.408073990751;5445.237666726662;5702.201691763156;5770.134479827975;5862.267216597926;887.6183241206344;895.6999405199201;902.1519771414848;927.7495076329488;991.4150651115876;3214.8071115733133;3701.685356744707;3838.6353296436796;3918.314294998364;3956;10328.48357582118;10630.362178269328;10654.627088052035;10668.98644628759;10669.679909602724;10537.262391632665;10615.628453004263;10630.893691063146;10653.73365665849;10675.51960161779;7682.5390476570465;7898.60506974649;8013.519188848688;8125.06561745395;8279.668813247523;5756.3380211276235;5831.591788574759;5869.765209391577;5899.705014749331;5997.220361353171;9878.407295562289;10121.089101980857;10151.94924025375;10162.593496260066;10174.084332410119;9746.561404736945;9993.150582200595;10120.072023318235;10245.334053286513;10253.436061016715;6853.828654283683;7047.541909775849;7049.330313620198;7378.5941773202985;7465.253474652492;7789.493682910593;7867.409944254089;7983.321417679563;8265.876011859948;8265.95867020661;7244.203137654748;7295.2340004298785;7392.297731715478;7493.138289096823;7550.8673698945595;6145.262568491809;7006.369426751617;7122.821929451805;7287.817804554928;7296.817579560554;6637.933620663732;6832.180138383425;6909.861802763816;7008.123984501937;7014.2635023323855;4957.082939656175;4967.552920237196;5012.624053195952;5043.87390315245;5092.7199004053655;4880.389951256093;4971.6022718183185;4994.2508623706735;5026.371703537058;5186.740662966912 12:14:31 INFO - PROCESS | 1647 | |4;prototype.html;283.9517282062049;292.71898976982095;298.44489249995013;299.87854918757904;316.8875049357479;5292.100342941704;5322.680639161653;5349.224362467445;5367.872746723183;5396.298481197439;4734.029523947591;4910.26346048093;5054.444011158779;5303.946960530394;5363.149713348888;3711.4618380334837;4048.9392659110063;4053.128577355868;4054.858079967202;4090.7750073745933;3738.224343436873;4084.5711200323985;4088.4276201331836;4099.303118469852;4122.402251673506;3111.828849413281;3681.9631803682023;3990.68074554035;4046.898827529306;4057.6145266199665;3966.920661586781;3992.1416895367347;4009.138035322405;4031.354983202703;4049.919001619966;3455.8444869980913;3462.23830757233;3465;3473.6873681368797;3484.5992710838323;4267.466566679165;4754.572088512051;4977.527134922177;5022.974885125587;5200.115980283361;4471.932921006155;4478.462584489849;4494.797734101973;4503.797329120198;4538.455385353745;4823.5176482351835;5462.142871423695;5466.972665136688;5545.667259964374;5579.9163012554845;3568.2506673598314;3742.8315725792404;3743.47591337213;3748.10720586105;3768.2275133597545;4741.984656520999;5414;5471.781128754845;5681.7727290908315;5800.998655463858;3311.701946824749;3321.485169798637;3855.63371479709;3989.7007724420782;3993.7004724645767;3687.446882967576;3708.369577171887;4021.195760847842;4034.91930161401;4049.959500405017;3674.540682414698;4289.798856320235;4489.506154323022;4626.791794369262;4628.745419001987;5247.317848679647;5405.86476839868;5537.390887002426;5541.556675465953;5581.972090139523;1250.2623452163268;1296.4425297122327;1357.0636260979893;1357.9660508487366;1371.492547757336;752.8331086815524;818.7391417217418;840.911704271055;853.4409961475244;862.5040601654074;3726.360401423365;3736.532933383327;3987.6043384815084;3998.220347032359;4282.443282373271;4302.622441383499;4359.760213188305;4386.824527018884;4690.484046754854;4693.55411235932;3752.6810221130963;4230.809613567397;4232.386303985905;4269.423627810206;4293.82824687009;2071.5546157576196;2352.5059737454985;2458.409981604402;2502.94994100117;2505.9874700626747;4327.3725309830525;4845.709257444564;4852.50096200457;4867.634927380461;4885.877853053702;4423.579759922803;4581.053052452694;4794.688345257547;4805.7597120143855;4820.05911487457;4387.758673273001;4494.977525112419;4556.430446194226;4856.80572777092;4862.3922009748785;4034.455348527911;4109.9589004109575;4239.385289132997;4258.212230737324;4744.857654270378;4016.839326427027;4256.978715106528;4356.869293921188;4482.618977386958;4508;3876.8643097491454;4498.910021799611;4850.296706977398;4904;4919.975400122977;3012.469525598508;3258.332041931446;3376.375370556455;3387.6951074403423;3396.709250484899;3731.832067556912;4245.257080010924;4604.355390245435;4629.379717098988;4657.743824089572;3669.312116426474;3976;4547.795349209227;4549.021960278424;4551.453825540956;3643.708503319675;3955.7626542407547;4496.8201271950065;4522.796474158605;4545.363669079063;3844.6732027776834;3880.592537783492;4358.956410435855;4455.977720111378;4461.375407443025;3936.9606303936594;4226.535081141011;4294.634956028647;4529.8641040768825;4597.333386658849;3991.8004099795476;4137.441445404832;4261.167697889937;4448.288273876165;4464.754438505914 12:14:31 INFO - PROCESS | 1647 | |5;yui.html;784.9607519624019;785.0500893918359;816.1552792859392;818.3984771193174;825.826576418952;15474.458393956214;16426.917865410687;16465.753013704805;16513.256903439345;16519.669606607862;12140.69648258794;14912;14922.850771492282;14924.253787310618;14941.551753447387;697.1146643762419;715.056125913794;860.165639329849;860.9741707748777;884.995575022124;868.2793281576277;873.7116751471999;881.850085485469;888.2760550151605;890.2210565754964;946.7396465971844;947.947862867542;947.9857802132974;948.8481842905137;954.0173621170205;733.3106879533221;755.1844008470894;940.1538615246299;940.9952950235273;941.7410212191702;557.5818136397702;558.7597333146746;673.1114928294653;691.802836191688;697.5675081449483;12442.751144977141;14727.55817325482;14750.409983600643;14783.334749936279;14815.111093334326;13801.309934503335;13938.233397163152;14071.437142514287;14098.71802563943;14142.787858182135;11448.828267575993;11704.239224450383;12050.457729402198;12550.121491495598;13330.333483325892;4465.129299786543;4590;4622.722636641813;4784.904301913977;4801.15979703554;101514;103041.4847925763;106240;108367.91632083656;109594.45202773935;10665;10730.939439840884;10784.083352914933;10820.78358432827;11112.44437778108;20620.69068963967;20670.58658826815;20673.86293753858;20701.896490517753;20702.378928632166;6585.341465853377;7857.567833769083;7868.25251601097;7921.613717599397;8122.9187708123345;4413.558644135561;4428.6678499112695;4477.395551600557;4577.382053422745;4634.397528321364;3447.5518182636097;3537.398642230827;3586.8565257389414;3598.5501812273465;3603.711703063801;652.5138771615083;660.4155322539588;670.1622971285892;673.5049738442241;679.741698154698;506.9379649634011;542.2192043457409;558.5475764630662;593.9168516407707;595.7557401465378;7706.884396734054;8482.194191551793;8492;8548.572571371407;8566.524290447542;519.9246109314204;556.8886222755384;589.9764009439574;590.9970450147722;592.6384905207819;3943.940840887389;4232.730180945766;4270.081932384553;4296.83985323967;4395.406620106309;143474;148295;150604.49395506125;151089;155437;130564.69435305716;133634;134571.3271433656;135844;138453.30773346272;83972.58013709892;111745.44127279312;112650;112995;114453.28320075205;8313.251807337369;8322.16778322163;8522.27560657351;8634.78413039679;8640.870386944076;47165;62241.68879155575;63640.04539931997;63956.040659391074;64527.67736161289;87166.56416717876;93810;99576.50211748896;99759.35961815799;100098.499507502;9904.378360148256;10844.45777711127;10971.451427428756;11022.669319920415;11233.831492527455;11733.823992640288;11825.645230643095;11845.170838041255;11940;12359.752804943671;11397;11440.885591144315;11480.425978701198;11782.764344713229;11957.880421196025;11376.715582110513;11606.897344752235;11687.532498699957;11713.941430292794;12234.694132646755;11262.887371126184;11495.252808567417;11569.323007744191;11690.240134391237;11867.228630139014;9189.081091890757;9440.527973601429;9639.325247232626;9745.561449734922;9822.361546499455;7675.925325565852;8026.598670066356;8735.606897689746;9152.718619393423;9516.095970882756 12:14:31 INFO - PROCESS | 1647 | __end_tp_report 12:14:31 INFO - PROCESS | 1647 | __start_cc_report 12:14:31 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1264 12:14:31 INFO - PROCESS | 1647 | __end_cc_report 12:14:31 INFO - PROCESS | 1647 | __startTimestamp1473275671612__endTimestamp 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | ------- Summary: start ------- 12:14:31 INFO - PROCESS | 1647 | Number of tests: 6 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5772.45 Median:6008.58 stddev:674.45 (11.2%) stddev-sans-first:635.56 12:14:31 INFO - PROCESS | 1647 | Values: 2821.8 3356.7 3374.4 3421.5 3445.6 5624.8 5721.9 5756.3 5791.4 5797.0 5754.8 5760.0 5773.3 5777.5 5780.9 5232.3 5242.7 5264.3 5287.2 5319.8 5345.9 5349.4 5352.1 5352.4 5352.9 4223.4 5262.8 5275.0 5338.9 5341.9 4212.6 5333.5 5341.1 5350.7 5376.7 5146.7 5170.2 5186.8 5289.8 5305.0 5705.2 5726.3 5727.1 5753.3 5821.3 6276.1 6292.0 6292.2 6313.7 6322.8 6111.2 6253.1 6336.2 6376.6 6385.8 5849.9 5852.6 5857.9 5862.8 5863.6 6316.4 6329.9 6339.9 6340.2 6340.4 6008.6 6088.1 6153.0 6241.6 6247.3 6326.7 6328.2 6346.1 6356.4 6381.2 6296.8 6304.0 6317.3 6319.7 6327.9 5194.4 6141.1 6149.0 6203.9 6304.7 4951.6 4970.6 4979.9 4984.8 4988.2 4444.8 4447.0 4451.7 4471.9 4508.6 4894.7 5731.7 5824.3 5826.7 5860.9 5439.5 6115.4 6248.1 6332.8 6380.6 5724.4 5799.7 5813.2 5836.7 5855.1 5512.2 5519.4 5521.3 5525.4 5525.6 6246.9 6286.4 6350.5 6398.8 6408.6 6273.7 6294.9 6301.0 6313.2 6319.2 6357.4 6359.4 6366.7 6378.9 6381.0 6134.4 6169.3 6236.8 6237.1 6265.0 5463.8 5884.1 6241.6 6323.4 6348.7 6067.5 6144.2 6150.5 6161.4 6172.6 6031.6 6115.2 6141.6 6191.4 6235.5 5992.5 6066.8 6072.4 6082.9 6110.8 6183.6 6238.0 6247.5 6250.0 6254.5 5818.6 5866.0 6027.8 6054.0 6055.3 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:60154.52 Median:38300.40 stddev:125566.82 (327.8%) stddev-sans-first:125839.12 12:14:31 INFO - PROCESS | 1647 | Values: 475.7 482.0 491.5 526.4 535.6 29448.7 29783.3 36987.0 41299.8 42300.9 38928.4 41434.0 41787.4 41854.0 41870.4 9736.8 9917.9 9919.1 9940.6 9971.9 8583.4 9799.7 9804.4 9919.3 9922.1 9792.9 9841.9 9865.1 9878.4 9935.7 8416.9 9867.8 9879.0 9887.7 9890.6 9751.0 9825.9 9827.3 9827.9 9849.2 38917.0 39363.0 39413.8 39459.0 39495.4 3406.5 3417.7 3461.0 3615.8 3795.9 29870.3 30447.2 30670.8 30671.0 30765.4 3087.1 3119.4 3126.3 3159.3 3168.2 288760.6 290679.0 292013.0 292782.5 293067.0 57792.7 58279.0 58283.4 58299.1 58411.7 33584.0 34209.1 57183.9 57253.0 57499.7 13513.0 15656.6 16196.3 16256.3 16364.8 10442.5 12311.7 12386.5 12427.0 12434.9 18209.6 18312.5 18427.7 18736.3 18746.8 6664.7 7213.0 7313.9 7703.8 7833.5 718.5 1008.2 1035.3 1075.4 1082.0 29040.3 29749.3 29782.0 29898.1 30045.6 970.7 988.8 1026.2 1034.3 1076.8 14135.3 14619.0 14721.4 15108.9 15155.6 537025.0 542991.0 543256.0 543776.0 546604.0 53052.5 53572.7 53684.9 53719.0 53971.5 1054.4 1207.9 1316.2 1370.3 1394.3 29145.9 29524.7 30137.8 30734.0 30778.0 49640.5 50472.7 50674.7 50709.5 50784.2 523787.0 536430.0 536719.0 537700.3 538388.0 30462.8 33331.8 35548.9 35576.5 41601.0 41684.6 43667.1 45619.5 46731.0 46766.1 37609.4 38190.6 38218.8 39242.4 39367.6 37713.4 37754.8 37803.0 38537.4 38659.4 37602.8 38023.6 38220.8 38281.0 38319.8 28644.1 30397.5 33344.7 34448.3 34604.8 24792.9 25072.0 25319.0 25398.7 25626.6 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:31918.00 Median:2521.28 stddev:84572.29 (3354.3%) stddev-sans-first:84776.30 12:14:31 INFO - PROCESS | 1647 | Values: 342.2 371.3 372.6 392.4 403.3 19934.8 20449.2 20859.7 20957.8 21128.9 20175.5 20586.7 20864.2 21148.9 21190.8 5623.8 5852.8 5925.3 5972.3 6001.5 3947.6 4073.6 5878.4 5996.0 6009.4 4222.0 4291.9 6502.5 6536.2 6625.2 5030.4 6539.9 6579.9 6587.2 6592.2 5752.7 5871.9 5875.5 5885.3 5895.6 12884.7 12946.7 12954.5 13089.7 13211.5 2287.6 2347.7 2432.0 2434.8 2607.7 9435.3 9749.4 10145.0 10336.6 11584.9 1834.5 1836.4 1889.6 1898.2 1962.1 107862.6 119147.9 119686.0 120200.4 121474.0 11265.6 11410.6 11514.5 11528.7 11701.9 11917.5 14318.9 14344.6 14359.5 14372.6 8247.7 8534.2 8547.4 8631.3 8697.5 7573.7 8089.9 8450.7 8479.1 8614.9 4447.7 4453.7 4457.7 4474.9 4536.1 1616.9 1873.3 1912.8 1919.9 1923.0 861.9 864.8 891.7 945.1 958.6 20665.4 20678.2 20779.4 20967.2 21009.9 887.7 889.9 913.8 915.5 925.4 8956.6 10977.9 10990.7 11012.7 11058.2 493097.0 497469.0 500212.0 502237.0 506388.0 127110.0 127314.0 127674.0 130355.3 133542.0 961.2 964.1 1001.5 1002.2 1002.7 14744.3 18077.0 18195.9 18286.7 18645.3 52141.0 52780.5 53710.7 54238.7 54438.7 70756.3 74975.0 76622.0 77150.6 85453.0 7927.0 8021.9 8095.4 8114.9 8361.8 11905.8 12511.0 13071.5 13435.3 13502.7 9707.1 10348.6 11086.9 11322.5 11475.4 10992.6 11241.8 11401.5 11541.9 11731.9 9745.6 11217.0 11366.7 11673.2 11786.7 8051.6 8094.1 8176.9 8185.7 8224.4 9172.7 10842.5 11177.6 11661.7 11667.0 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5600.61 Median:4983.88 stddev:3125.91 (62.7%) stddev-sans-first:3116.59 12:14:31 INFO - PROCESS | 1647 | Values: 1127.2 1513.5 1545.5 1749.3 1903.0 6859.9 8227.5 8230.5 8232.8 8236.8 8045.6 8428.0 8707.8 8719.0 8815.5 2367.2 2393.3 2398.7 2404.0 2404.9 1962.5 2389.7 2405.5 2408.8 2409.7 2355.6 2375.0 2387.2 2391.7 2394.2 2345.2 2367.8 2369.1 2369.9 2383.0 2335.9 2360.4 2365.5 2366.1 2376.1 8687.2 8719.4 8795.2 8825.0 8838.8 5179.6 5222.7 5383.9 5384.0 5390.9 3584.7 3685.9 3692.7 3694.6 3695.5 922.9 1078.5 1101.9 1107.5 1112.1 11348.9 11479.9 11490.7 11493.9 11515.8 4527.2 4690.8 4767.1 4933.8 4973.5 9062.0 9115.6 9117.4 9119.3 9124.6 5294.6 5295.5 5295.9 5301.1 5306.3 4287.1 4339.9 4425.4 4913.9 4967.6 3705.3 3717.3 3768.8 3805.5 3817.6 1145.7 1155.9 1160.6 1166.5 1168.5 843.7 865.7 886.9 901.8 929.3 4735.4 5445.2 5702.2 5770.1 5862.3 887.6 895.7 902.2 927.7 991.4 3214.8 3701.7 3838.6 3918.3 3956.0 10328.5 10630.4 10654.6 10669.0 10669.7 10537.3 10615.6 10630.9 10653.7 10675.5 7682.5 7898.6 8013.5 8125.1 8279.7 5756.3 5831.6 5869.8 5899.7 5997.2 9878.4 10121.1 10151.9 10162.6 10174.1 9746.6 9993.2 10120.1 10245.3 10253.4 6853.8 7047.5 7049.3 7378.6 7465.3 7789.5 7867.4 7983.3 8265.9 8266.0 7244.2 7295.2 7392.3 7493.1 7550.9 6145.3 7006.4 7122.8 7287.8 7296.8 6637.9 6832.2 6909.9 7008.1 7014.3 4957.1 4967.6 5012.6 5043.9 5092.7 4880.4 4971.6 4994.3 5026.4 5186.7 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4016.06 Median:4286.12 stddev:1173.49 (27.4%) stddev-sans-first:1142.86 12:14:31 INFO - PROCESS | 1647 | Values: 284.0 292.7 298.4 299.9 316.9 5292.1 5322.7 5349.2 5367.9 5396.3 4734.0 4910.3 5054.4 5303.9 5363.1 3711.5 4048.9 4053.1 4054.9 4090.8 3738.2 4084.6 4088.4 4099.3 4122.4 3111.8 3682.0 3990.7 4046.9 4057.6 3966.9 3992.1 4009.1 4031.4 4049.9 3455.8 3462.2 3465.0 3473.7 3484.6 4267.5 4754.6 4977.5 5023.0 5200.1 4471.9 4478.5 4494.8 4503.8 4538.5 4823.5 5462.1 5467.0 5545.7 5579.9 3568.3 3742.8 3743.5 3748.1 3768.2 4742.0 5414.0 5471.8 5681.8 5801.0 3311.7 3321.5 3855.6 3989.7 3993.7 3687.4 3708.4 4021.2 4034.9 4050.0 3674.5 4289.8 4489.5 4626.8 4628.7 5247.3 5405.9 5537.4 5541.6 5582.0 1250.3 1296.4 1357.1 1358.0 1371.5 752.8 818.7 840.9 853.4 862.5 3726.4 3736.5 3987.6 3998.2 4282.4 4302.6 4359.8 4386.8 4690.5 4693.6 3752.7 4230.8 4232.4 4269.4 4293.8 2071.6 2352.5 2458.4 2502.9 2506.0 4327.4 4845.7 4852.5 4867.6 4885.9 4423.6 4581.1 4794.7 4805.8 4820.1 4387.8 4495.0 4556.4 4856.8 4862.4 4034.5 4110.0 4239.4 4258.2 4744.9 4016.8 4257.0 4356.9 4482.6 4508.0 3876.9 4498.9 4850.3 4904.0 4920.0 3012.5 3258.3 3376.4 3387.7 3396.7 3731.8 4245.3 4604.4 4629.4 4657.7 3669.3 3976.0 4547.8 4549.0 4551.5 3643.7 3955.8 4496.8 4522.8 4545.4 3844.7 3880.6 4359.0 4456.0 4461.4 3937.0 4226.5 4294.6 4529.9 4597.3 3991.8 4137.4 4261.2 4448.3 4464.8 12:14:31 INFO - PROCESS | 1647 | 12:14:31 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:24455.64 Median:4446.90 stddev:40068.28 (901.0%) stddev-sans-first:40141.27 12:14:31 INFO - PROCESS | 1647 | Values: 785.0 785.1 816.2 818.4 825.8 15474.5 16426.9 16465.8 16513.3 16519.7 12140.7 14912.0 14922.9 14924.3 14941.6 697.1 715.1 860.2 861.0 885.0 868.3 873.7 881.9 888.3 890.2 946.7 947.9 948.0 948.8 954.0 733.3 755.2 940.2 941.0 941.7 557.6 558.8 673.1 691.8 697.6 12442.8 14727.6 14750.4 14783.3 14815.1 13801.3 13938.2 14071.4 14098.7 14142.8 11448.8 11704.2 12050.5 12550.1 13330.3 4465.1 4590.0 4622.7 4784.9 4801.2 101514.0 103041.5 106240.0 108367.9 109594.5 10665.0 10730.9 10784.1 10820.8 11112.4 20620.7 20670.6 20673.9 20701.9 20702.4 6585.3 7857.6 7868.3 7921.6 8122.9 4413.6 4428.7 4477.4 4577.4 4634.4 3447.6 3537.4 3586.9 3598.6 3603.7 652.5 660.4 670.2 673.5 679.7 506.9 542.2 558.5 593.9 595.8 7706.9 8482.2 8492.0 8548.6 8566.5 519.9 556.9 590.0 591.0 592.6 3943.9 4232.7 4270.1 4296.8 4395.4 143474.0 148295.0 150604.5 151089.0 155437.0 130564.7 133634.0 134571.3 135844.0 138453.3 83972.6 111745.4 112650.0 112995.0 114453.3 8313.3 8322.2 8522.3 8634.8 8640.9 47165.0 62241.7 63640.0 63956.0 64527.7 87166.6 93810.0 99576.5 99759.4 100098.5 9904.4 10844.5 10971.5 11022.7 11233.8 11733.8 11825.6 11845.2 11940.0 12359.8 11397.0 11440.9 11480.4 11782.8 11957.9 11376.7 11606.9 11687.5 11713.9 12234.7 11262.9 11495.3 11569.3 11690.2 11867.2 9189.1 9440.5 9639.3 9745.6 9822.4 7675.9 8026.6 8735.6 9152.7 9516.1 12:14:31 INFO - PROCESS | 1647 | -------- Summary: end -------- 12:14:31 INFO - PROCESS | 1647 | 12:14:32 INFO - TEST-INFO | 1647: exit 0 12:14:32 INFO - TEST-OK | dromaeo_css | took 1117394ms 12:14:32 INFO - TEST-START | kraken 12:14:32 INFO - operating with platform_type : mac_ 12:14:32 INFO - Initialising browser for kraken test... 12:14:32 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp3Vh_8R/profile http://localhost:49279/getInfo.html) 12:14:34 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 12:14:34 INFO - PROCESS | 1657 | colorDepth:24 12:14:34 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 12:14:34 INFO - PROCESS | 1657 | __metrics 12:14:34 INFO - PROCESS | 1657 | 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" 12:14:34 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:35 INFO - TEST-INFO | 1657: exit 0 12:14:35 INFO - Browser initialized. 12:14:35 INFO - Running cycle 1/1 for kraken test... 12:14:35 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp3Vh_8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:47 INFO - PROCESS | 1658 | RSS: Main: 232476672 12:14:47 INFO - PROCESS | 1658 | 12:14:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:50 INFO - PROCESS | 1658 | RSS: Main: 290848768 12:14:50 INFO - PROCESS | 1658 | 12:14:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 12:14:54 INFO - PROCESS | 1658 | RSS: Main: 287260672 12:14:54 INFO - PROCESS | 1658 | 12:14:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 12:14:58 INFO - PROCESS | 1658 | RSS: Main: 376524800 12:14:58 INFO - PROCESS | 1658 | 12:15:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 12:15:00 INFO - PROCESS | 1658 | RSS: Main: 280502272 12:15:00 INFO - PROCESS | 1658 | 12:15:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:03 INFO - PROCESS | 1658 | RSS: Main: 284397568 12:15:03 INFO - PROCESS | 1658 | 12:15:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:07 INFO - PROCESS | 1658 | RSS: Main: 322199552 12:15:07 INFO - PROCESS | 1658 | 12:15:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:10 INFO - PROCESS | 1658 | RSS: Main: 323051520 12:15:10 INFO - PROCESS | 1658 | 12:15:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 12:15:13 INFO - PROCESS | 1658 | RSS: Main: 323354624 12:15:13 INFO - PROCESS | 1658 | 12:15:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:16 INFO - PROCESS | 1658 | RSS: Main: 297623552 12:15:16 INFO - PROCESS | 1658 | 12:15:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:18 INFO - PROCESS | 1658 | RSS: Main: 303538176 12:15:18 INFO - PROCESS | 1658 | 12:15:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:21 INFO - PROCESS | 1658 | RSS: Main: 303980544 12:15:21 INFO - PROCESS | 1658 | 12:15:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:25 INFO - PROCESS | 1658 | RSS: Main: 314236928 12:15:25 INFO - PROCESS | 1658 | 12:15:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:15:28 INFO - PROCESS | 1658 | RSS: Main: 316641280 12:15:28 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 12:15:30 INFO - PROCESS | 1658 | RSS: Main: 360763392 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | __start_tp_report 12:15:30 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 12:15:30 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 12:15:30 INFO - PROCESS | 1658 | |i|pagename|runs| 12:15:30 INFO - PROCESS | 1658 | |0;ai-astar;113;113;116;113;114;118;160;112;113;123 12:15:30 INFO - PROCESS | 1658 | |1;audio-beat-detection;143;114;132;161;109;129;128;108;159;108 12:15:30 INFO - PROCESS | 1658 | |2;audio-dft;185;187;183;186;182;181;182;184;182;183 12:15:30 INFO - PROCESS | 1658 | |3;audio-fft;78;76;94;183;81;58;59;60;145;74 12:15:30 INFO - PROCESS | 1658 | |4;audio-oscillator;82;82;130;70;70;77;116;67;70;120 12:15:30 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;86;88;85;87;85;89;86;88;85 12:15:30 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;94;95;94;95;96;94;95;94;95 12:15:30 INFO - PROCESS | 1658 | |7;imaging-desaturate;86;86;85;84;85;86;85;86;85;86 12:15:30 INFO - PROCESS | 1658 | |8;json-parse-financial;52;54;55;54;54;55;55;54;54;55 12:15:30 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;68;65;75;73;73;76;72;69;71;72 12:15:30 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;89;86;86;88;86;88;84;89;87;86 12:15:30 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;141;141;136;139;153;153;144;138;235;139 12:15:30 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;167;171;165;166;166;167;164;167;167;168 12:15:30 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;68;67;68;66;67;67;67;68;68 12:15:30 INFO - PROCESS | 1658 | __end_tp_report 12:15:30 INFO - PROCESS | 1658 | __start_cc_report 12:15:30 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2043 12:15:30 INFO - PROCESS | 1658 | __end_cc_report 12:15:30 INFO - PROCESS | 1658 | __startTimestamp1473275730510__endTimestamp 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | ------- Summary: start ------- 12:15:30 INFO - PROCESS | 1658 | Number of tests: 14 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:119.50 Median:115.00 stddev:14.62 (12.7%) stddev-sans-first:15.31 12:15:30 INFO - PROCESS | 1658 | Values: 113.0 113.0 116.0 113.0 114.0 118.0 160.0 112.0 113.0 123.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:130.50 stddev:20.10 (15.4%) stddev-sans-first:20.68 12:15:30 INFO - PROCESS | 1658 | Values: 143.0 114.0 132.0 161.0 109.0 129.0 128.0 108.0 159.0 108.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:1.96 (1.1%) stddev-sans-first:2.00 12:15:30 INFO - PROCESS | 1658 | Values: 185.0 187.0 183.0 186.0 182.0 181.0 182.0 184.0 182.0 183.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:90.80 Median:75.00 stddev:41.16 (54.9%) stddev-sans-first:43.39 12:15:30 INFO - PROCESS | 1658 | Values: 78.0 76.0 94.0 183.0 81.0 58.0 59.0 60.0 145.0 74.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:70.00 stddev:23.98 (34.3%) stddev-sans-first:25.33 12:15:30 INFO - PROCESS | 1658 | Values: 82.0 82.0 130.0 70.0 70.0 77.0 116.0 67.0 70.0 120.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.62 (1.9%) stddev-sans-first:1.51 12:15:30 INFO - PROCESS | 1658 | Values: 89.0 86.0 88.0 85.0 87.0 85.0 89.0 86.0 88.0 85.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 12:15:30 INFO - PROCESS | 1658 | Values: 93.0 94.0 95.0 94.0 95.0 96.0 94.0 95.0 94.0 95.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 12:15:30 INFO - PROCESS | 1658 | Values: 86.0 86.0 85.0 84.0 85.0 86.0 85.0 86.0 85.0 86.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:0.92 (1.7%) stddev-sans-first:0.53 12:15:30 INFO - PROCESS | 1658 | Values: 52.0 54.0 55.0 54.0 54.0 55.0 55.0 54.0 54.0 55.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.50 stddev:3.31 (4.6%) stddev-sans-first:3.27 12:15:30 INFO - PROCESS | 1658 | Values: 68.0 65.0 75.0 73.0 73.0 76.0 72.0 69.0 71.0 72.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.50 stddev:1.60 (1.8%) stddev-sans-first:1.50 12:15:30 INFO - PROCESS | 1658 | Values: 89.0 86.0 86.0 88.0 86.0 88.0 84.0 89.0 87.0 86.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:142.50 stddev:29.79 (20.9%) stddev-sans-first:31.33 12:15:30 INFO - PROCESS | 1658 | Values: 141.0 141.0 136.0 139.0 153.0 153.0 144.0 138.0 235.0 139.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 12:15:30 INFO - PROCESS | 1658 | Values: 167.0 171.0 165.0 166.0 166.0 167.0 164.0 167.0 167.0 168.0 12:15:30 INFO - PROCESS | 1658 | 12:15:30 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 12:15:30 INFO - PROCESS | 1658 | Values: 68.0 68.0 67.0 68.0 66.0 67.0 67.0 67.0 68.0 68.0 12:15:30 INFO - PROCESS | 1658 | -------- Summary: end -------- 12:15:30 INFO - PROCESS | 1658 | 12:15:31 INFO - TEST-INFO | 1658: exit 0 12:15:31 INFO - TEST-OK | kraken | took 59100ms 12:15:31 INFO - SUITE-END | took 1176s 12:15:31 INFO - Completed test suite (00:19:36) 12:15:31 INFO - javascript benchmark 12:15:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2821.7883658725596, 3356.7146792522635, 3374.4094783412897, 3421.4525675891864, 3445.5865296164466, 5624.831255062355, 5721.885562288757, 5756.251687280647, 5791.391903850098, 5797.04348782451, 5754.827355179341, 5759.963206622806, 5773.278340207474, 5777.480026797587, 5780.855478613037, 5232.3459567554055, 5242.659227150242, 5264.341957255343, 5287.180487024518, 5319.813806516772, 5345.919811202835, 5349.411564727877, 5352.090144675395, 5352.384475785276, 5352.866178345534, 4223.366495025755, 5262.81580144695, 5275.024120537693, 5338.893222135555, 5341.893162136755, 4212.599803018708, 5333.546648534879, 5341.092014357569, 5350.678959262456, 5376.704281264529, 5146.691198528063, 5170.1986192140275, 5186.818461353834, 5289.761960711778, 5304.973475132639, 5705.2012718219485, 5726.284214473191, 5727.11229759388, 5753.280839895013, 5821.27234095738, 6276.09642348206, 6291.96854015727, 6292.2134733158355, 6313.684315784192, 6322.778702745428, 6111.2055432793895, 6253.1245625612455, 6336.176297081396, 6376.553641245115, 6385.808425747235, 5849.9470095382385, 5852.619579727304, 5857.941420585739, 5862.824115276506, 5863.589548731633, 6316.399942005502, 6329.905051424233, 6339.873202535923, 6340.175777149033, 6340.365963403715, 6008.579399442085, 6088.086786981989, 6153.0, 6241.625502469867, 6247.2815626202655, 6326.652034138075, 6328.240611126695, 6346.11154438379, 6356.364363563606, 6381.202349706286, 6296.811095667137, 6303.968480157661, 6317.305096439388, 6319.652419116993, 6327.905081423783, 5194.35070616173, 6141.148492690813, 6148.9854174061675, 6203.875922481525, 6304.684765761694, 4951.628627852853, 4970.577500912391, 4979.850604481871, 4984.825531106394, 4988.152014157602, 4444.755538445416, 4446.977765111218, 4451.710638808532, 4471.8658440246845, 4508.616767574793, 4894.730789806595, 5731.742071606787, 5824.3302020267365, 5826.708664566755, 5860.912086318709, 5439.456054394529, 6115.422885572139, 6248.094026366151, 6332.810015699536, 6380.617162970237, 5724.370319264877, 5799.739011744482, 5813.215215945877, 5836.737346819404, 5855.063189889597, 5512.228288039678, 5519.365272993577, 5521.309836270466, 5525.364583072917, 5525.557955363562, 6246.875062498633, 6286.402791734778, 6350.523710721622, 6398.808035758934, 6408.615483070937, 6273.71768270438, 6294.852573713143, 6301.0, 6313.242410910537, 6319.178506794087, 6357.427831495188, 6359.427651511386, 6366.745330186741, 6378.904316435164, 6381.0, 6134.35589263121, 6169.321374648875, 6236.781712640036, 6237.064440333987, 6265.0, 5463.781448742165, 5884.146798714248, 6241.594296370721, 6323.430891219812, 6348.746050157942, 6067.453929146398, 6144.17053697763, 6150.50795936333, 6161.383861613982, 6172.629642221481, 6031.577789554689, 6115.209918062534, 6141.6007959482495, 6191.442770150708, 6235.46998505114, 5992.490638295793, 6066.817995460143, 6072.392760723892, 6082.90875636857, 6110.7861224856915, 6183.5671502994355, 6237.970734828702, 6247.5001999840815, 6250.0, 6254.468370188585, 5818.592698511064, 5865.970670146622, 6027.758889644365, 6054.0, 6055.303640081447], "value": 5728.392573710873, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.65277347536295, 481.9927701084482, 491.51094660812487, 526.4498598964083, 535.5849216856935, 29448.705512944864, 29783.255418614546, 36987.0, 41299.79350103245, 42300.94247643803, 38928.41607375892, 41434.0, 41787.373189402184, 41854.0, 41870.37194442078, 9736.756581085494, 9917.900820991807, 9919.057689519484, 9940.5526751296, 9971.900280997206, 8583.356248281372, 9799.70600881971, 9804.36271642341, 9919.3056486046, 9922.057404546556, 9792.902070979306, 9841.90158098417, 9865.062819032217, 9878.407295562254, 9935.701928942108, 8416.915830841674, 9867.802643947152, 9878.950605246964, 9887.703368898945, 9890.604375824958, 9750.9512452438, 9825.852612210823, 9827.262955278382, 9827.852582211273, 9849.21206303494, 38917.02707432337, 39363.0, 39413.80293098516, 39459.0, 39495.40756888649, 3406.5230867678547, 3417.7436692247934, 3461.0309113448275, 3615.783053016801, 3795.9240815183816, 29870.25324366908, 30447.23881902948, 30670.84664576685, 30671.0, 30765.38469230603, 3087.1047396255058, 3119.4229067622564, 3126.2965832687464, 3159.304952910379, 3168.1921110117005, 288760.55619721767, 290679.0, 292013.0, 292782.5360873203, 293067.0, 57792.71103644455, 58279.0, 58283.4171658278, 58299.12551311649, 58411.70794146002, 33583.992480225636, 34209.144771380415, 57183.85632287414, 57253.0, 57499.71250143723, 13513.0, 15656.608584785472, 16196.271167797477, 16256.268467918972, 16364.754528682079, 10442.477876106164, 12311.6922076947, 12386.504539818487, 12427.0, 12434.937825310815, 18209.635807284045, 18312.450626481226, 18427.72358414625, 18736.252749450163, 18746.812531874508, 6664.733410663616, 7212.963935180291, 7313.939478775548, 7703.845923081507, 7833.451658383859, 718.4791026505742, 1008.2287050406445, 1035.2607619199816, 1075.3924032921375, 1082.0315817343592, 29040.273993150342, 29749.256268593457, 29782.0, 29898.05338548131, 30045.57648771853, 970.713639476342, 988.7577543501744, 1026.1841835740604, 1034.3070143004054, 1076.827707566801, 14135.293235338191, 14619.0, 14721.411143554353, 15108.924455377872, 15155.621109472351, 537025.0, 542991.0, 543256.0, 543776.0, 546604.0, 53052.46947530552, 53572.73213633985, 53684.92630147453, 53719.0, 53971.46028539743, 1054.3568423261804, 1207.9094067944939, 1316.249737649569, 1370.2737549098993, 1394.3167847754528, 29145.854270728512, 29524.704752952195, 30137.794488220225, 30734.0, 30778.0, 49640.503594963586, 50472.738181544286, 50674.746626266635, 50709.492905070474, 50784.23823642574, 523787.0, 536430.0, 536719.0, 537700.31149844, 538388.0, 30462.84768576143, 33331.83334083314, 35548.93353199408, 35576.46635300421, 41601.0, 41684.58315416928, 43667.126657467306, 45619.54380456153, 46731.0, 46766.06467870555, 37609.4358584616, 38190.6180938187, 38218.808905955295, 39242.411363830135, 39367.606323936394, 37713.43429848609, 37754.8112259437, 37803.0, 38537.421938671505, 38659.420108698956, 37602.81198594099, 38023.619763803115, 38220.80889595534, 38281.0, 38319.80840095893, 28644.14067577976, 30397.544036839907, 33344.66655333416, 34448.311033778686, 34604.82697586496, 24792.884320205994, 25072.0, 25318.98724051091, 25398.746012540378, 25626.615600765632], "value": 19245.43164458485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.2333971902937, 371.31863031337497, 372.6404020120585, 392.37416320968043, 403.26001786721366, 19934.800651993475, 20449.18203271869, 20859.687104693403, 20957.790422095775, 21128.89435552824, 20175.49561260969, 20586.69119963198, 20864.16543338265, 21148.89425552874, 21190.788092119074, 5623.831285061455, 5852.795152169675, 5925.348211696732, 5972.313183983854, 6001.48987336077, 3947.6052394760436, 4073.5926407359325, 5878.412158784109, 5995.970020149915, 6009.399060093978, 4221.957780422203, 4291.935620965688, 6502.512311576651, 6536.182977127859, 6625.238097618763, 5030.396352437694, 6539.901901471458, 6579.934200658028, 6587.209534855848, 6592.241892182388, 5752.712364381764, 5871.882562348772, 5875.500582450497, 5885.293764748215, 5895.557833162487, 12884.677883052998, 12946.741065178738, 12954.546590869275, 13089.738205235937, 13211.537596184184, 2287.611106111965, 2347.6830627865193, 2431.9756802431925, 2434.8417352872184, 2607.709183953955, 9435.292353073546, 9749.415035097916, 10145.03622155894, 10336.586536538529, 11584.942075289653, 1834.523024013766, 1836.4307064809818, 1889.5653999580036, 1898.1742941820353, 1962.077823422989, 107862.59580148227, 119147.87243084348, 119685.99999999913, 120200.39899800533, 121474.0, 11265.605703800327, 11410.600628977945, 11514.481848316846, 11528.654140375802, 11701.88298117008, 11917.52329906794, 14318.928405357907, 14344.641383965276, 14359.497417590333, 14372.568822935329, 8247.711330103417, 8534.189252021048, 8547.444416112932, 8631.266342360845, 8697.478151310941, 7573.697052117854, 8089.9191008089165, 8450.704225352083, 8479.109693482096, 8614.87077693835, 4447.666425018072, 4453.688241823106, 4457.68796184264, 4474.865754027384, 4536.092781443725, 1616.886817922734, 1873.297513432463, 1912.8374088202659, 1919.865609407328, 1922.9519262018562, 861.8707193920962, 864.7751584588052, 891.6879092317637, 945.0832692288469, 958.6309270930742, 20665.380038598865, 20678.17287308521, 20779.376618701463, 20967.161313547593, 21009.89495052515, 887.6848718704766, 889.915458031486, 913.8172365526921, 915.4598786715869, 925.3846192282057, 8956.641734330553, 10977.945110274557, 10990.725231869268, 11012.724681882857, 11058.22592418539, 493097.0, 497469.0, 500212.0, 502237.0, 506388.0, 127110.0, 127314.0, 127674.0, 130355.26802587623, 133542.0, 961.2214106573838, 964.0648570886369, 1001.4592120255127, 1002.223276960347, 1002.6791426743519, 14744.2627868604, 18077.0, 18195.90824550531, 18286.72569911479, 18645.254189832256, 52140.95718085693, 52780.47219527756, 53710.73144634252, 54238.72880635571, 54438.727806360715, 70756.29243707497, 74975.0, 76622.0391349121, 77150.61424692841, 85453.0, 7926.960365198137, 8021.919780802351, 8095.39284553649, 8114.918850811417, 8361.790955226168, 11905.761884762429, 12511.0, 13071.477140914638, 13435.328233588087, 13502.662433439242, 9707.077827606367, 10348.637797677045, 11086.889131108586, 11322.490487927898, 11475.368854712737, 10992.560297588327, 11241.775164496828, 11401.486933087865, 11541.884581154081, 11731.94412502879, 9745.561449734922, 11217.046551043253, 11366.715832104264, 11673.182877198515, 11786.705332366759, 8051.557164355782, 8094.10964793884, 8176.936998190197, 8185.672573097009, 8224.38317126206, 9172.6789562365, 10842.457877105955, 11177.608783692533, 11661.6501504955, 11666.958282300393], "value": 9295.49642710996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1127.222216670497, 1513.5459362191343, 1545.482263441747, 1749.3090229359404, 1903.0389653225127, 6859.931400685991, 8227.465214761036, 8230.506169629818, 8232.7941801455, 8236.83526329473, 8045.557494337809, 8427.95786021069, 8707.782305442368, 8718.956405217981, 8815.51514666693, 2367.1951536477595, 2393.3179043972473, 2398.6761787158684, 2403.9639405408934, 2404.927852164429, 1962.4995626115392, 2389.7490763469846, 2405.458771776354, 2408.759124087586, 2409.7469765674614, 2355.646653002046, 2375.049980008002, 2387.248016874679, 2391.6651668766385, 2394.174009966559, 2345.202631105415, 2367.7513861044686, 2369.1234243329905, 2369.9289021329387, 2383.0229605861514, 2335.871527066011, 2360.421696684306, 2365.467769751809, 2366.077229880348, 2376.061455724979, 8687.175693104457, 8719.389642725011, 8795.164459376412, 8824.955875220583, 8838.779030524223, 5179.559737422286, 5222.6605270657665, 5383.865403364908, 5383.973080134574, 5390.946090539083, 3584.7490675652716, 3685.94471082934, 3692.7415080944343, 3694.556653201606, 3695.464157697119, 922.8707980882615, 1078.5038882114236, 1101.9449027548671, 1107.5459061784711, 1112.1158678850334, 11348.943255283753, 11479.885201147965, 11490.65528034152, 11493.885061149449, 11515.769684606345, 4527.207738645724, 4690.7654617269, 4767.141914455431, 4933.753312334369, 4973.50264973507, 9061.954690226507, 9115.589798459085, 9117.407368521024, 9119.316051296179, 9124.58939347731, 5294.57643388528, 5295.470452954751, 5295.947040529545, 5301.098813201765, 5306.283651707047, 4287.09970906107, 4339.934900976488, 4425.402570652985, 4913.852584422473, 4967.577755890789, 3705.2589482103685, 3717.3494638438706, 3768.755030923036, 3805.486259355007, 3817.6182381762155, 1145.6505765741363, 1155.92486488378, 1160.611195249584, 1166.5275563396838, 1168.4508281107865, 843.6751850537464, 865.6840253307623, 886.9157430044136, 901.7565257380602, 929.3355250995571, 4735.408073990751, 5445.237666726662, 5702.201691763156, 5770.134479827975, 5862.267216597926, 887.6183241206344, 895.6999405199201, 902.1519771414848, 927.7495076329488, 991.4150651115876, 3214.8071115733133, 3701.685356744707, 3838.6353296436796, 3918.314294998364, 3956.0, 10328.48357582118, 10630.362178269328, 10654.627088052035, 10668.98644628759, 10669.679909602724, 10537.262391632665, 10615.628453004263, 10630.893691063146, 10653.73365665849, 10675.51960161779, 7682.5390476570465, 7898.60506974649, 8013.519188848688, 8125.06561745395, 8279.668813247523, 5756.3380211276235, 5831.591788574759, 5869.765209391577, 5899.705014749331, 5997.220361353171, 9878.407295562289, 10121.089101980857, 10151.94924025375, 10162.593496260066, 10174.084332410119, 9746.561404736945, 9993.150582200595, 10120.072023318235, 10245.334053286513, 10253.436061016715, 6853.828654283683, 7047.541909775849, 7049.330313620198, 7378.5941773202985, 7465.253474652492, 7789.493682910593, 7867.409944254089, 7983.321417679563, 8265.876011859948, 8265.95867020661, 7244.203137654748, 7295.2340004298785, 7392.297731715478, 7493.138289096823, 7550.8673698945595, 6145.262568491809, 7006.369426751617, 7122.821929451805, 7287.817804554928, 7296.817579560554, 6637.933620663732, 6832.180138383425, 6909.861802763816, 7008.123984501937, 7014.2635023323855, 4957.082939656175, 4967.552920237196, 5012.624053195952, 5043.87390315245, 5092.7199004053655, 4880.389951256093, 4971.6022718183185, 4994.2508623706735, 5026.371703537058, 5186.740662966912], "value": 4508.1400904763905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.9517282062049, 292.71898976982095, 298.44489249995013, 299.87854918757904, 316.8875049357479, 5292.100342941704, 5322.680639161653, 5349.224362467445, 5367.872746723183, 5396.298481197439, 4734.029523947591, 4910.26346048093, 5054.444011158779, 5303.946960530394, 5363.149713348888, 3711.4618380334837, 4048.9392659110063, 4053.128577355868, 4054.858079967202, 4090.7750073745933, 3738.224343436873, 4084.5711200323985, 4088.4276201331836, 4099.303118469852, 4122.402251673506, 3111.828849413281, 3681.9631803682023, 3990.68074554035, 4046.898827529306, 4057.6145266199665, 3966.920661586781, 3992.1416895367347, 4009.138035322405, 4031.354983202703, 4049.919001619966, 3455.8444869980913, 3462.23830757233, 3465.0, 3473.6873681368797, 3484.5992710838323, 4267.466566679165, 4754.572088512051, 4977.527134922177, 5022.974885125587, 5200.115980283361, 4471.932921006155, 4478.462584489849, 4494.797734101973, 4503.797329120198, 4538.455385353745, 4823.5176482351835, 5462.142871423695, 5466.972665136688, 5545.667259964374, 5579.9163012554845, 3568.2506673598314, 3742.8315725792404, 3743.47591337213, 3748.10720586105, 3768.2275133597545, 4741.984656520999, 5414.0, 5471.781128754845, 5681.7727290908315, 5800.998655463858, 3311.701946824749, 3321.485169798637, 3855.63371479709, 3989.7007724420782, 3993.7004724645767, 3687.446882967576, 3708.369577171887, 4021.195760847842, 4034.91930161401, 4049.959500405017, 3674.540682414698, 4289.798856320235, 4489.506154323022, 4626.791794369262, 4628.745419001987, 5247.317848679647, 5405.86476839868, 5537.390887002426, 5541.556675465953, 5581.972090139523, 1250.2623452163268, 1296.4425297122327, 1357.0636260979893, 1357.9660508487366, 1371.492547757336, 752.8331086815524, 818.7391417217418, 840.911704271055, 853.4409961475244, 862.5040601654074, 3726.360401423365, 3736.532933383327, 3987.6043384815084, 3998.220347032359, 4282.443282373271, 4302.622441383499, 4359.760213188305, 4386.824527018884, 4690.484046754854, 4693.55411235932, 3752.6810221130963, 4230.809613567397, 4232.386303985905, 4269.423627810206, 4293.82824687009, 2071.5546157576196, 2352.5059737454985, 2458.409981604402, 2502.94994100117, 2505.9874700626747, 4327.3725309830525, 4845.709257444564, 4852.50096200457, 4867.634927380461, 4885.877853053702, 4423.579759922803, 4581.053052452694, 4794.688345257547, 4805.7597120143855, 4820.05911487457, 4387.758673273001, 4494.977525112419, 4556.430446194226, 4856.80572777092, 4862.3922009748785, 4034.455348527911, 4109.9589004109575, 4239.385289132997, 4258.212230737324, 4744.857654270378, 4016.839326427027, 4256.978715106528, 4356.869293921188, 4482.618977386958, 4508.0, 3876.8643097491454, 4498.910021799611, 4850.296706977398, 4904.0, 4919.975400122977, 3012.469525598508, 3258.332041931446, 3376.375370556455, 3387.6951074403423, 3396.709250484899, 3731.832067556912, 4245.257080010924, 4604.355390245435, 4629.379717098988, 4657.743824089572, 3669.312116426474, 3976.0, 4547.795349209227, 4549.021960278424, 4551.453825540956, 3643.708503319675, 3955.7626542407547, 4496.8201271950065, 4522.796474158605, 4545.363669079063, 3844.6732027776834, 3880.592537783492, 4358.956410435855, 4455.977720111378, 4461.375407443025, 3936.9606303936594, 4226.535081141011, 4294.634956028647, 4529.8641040768825, 4597.333386658849, 3991.8004099795476, 4137.441445404832, 4261.167697889937, 4448.288273876165, 4464.754438505914], "value": 3656.6501357599204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.9607519624019, 785.0500893918359, 816.1552792859392, 818.3984771193174, 825.826576418952, 15474.458393956214, 16426.917865410687, 16465.753013704805, 16513.256903439345, 16519.669606607862, 12140.69648258794, 14912.0, 14922.850771492282, 14924.253787310618, 14941.551753447387, 697.1146643762419, 715.056125913794, 860.165639329849, 860.9741707748777, 884.995575022124, 868.2793281576277, 873.7116751471999, 881.850085485469, 888.2760550151605, 890.2210565754964, 946.7396465971844, 947.947862867542, 947.9857802132974, 948.8481842905137, 954.0173621170205, 733.3106879533221, 755.1844008470894, 940.1538615246299, 940.9952950235273, 941.7410212191702, 557.5818136397702, 558.7597333146746, 673.1114928294653, 691.802836191688, 697.5675081449483, 12442.751144977141, 14727.55817325482, 14750.409983600643, 14783.334749936279, 14815.111093334326, 13801.309934503335, 13938.233397163152, 14071.437142514287, 14098.71802563943, 14142.787858182135, 11448.828267575993, 11704.239224450383, 12050.457729402198, 12550.121491495598, 13330.333483325892, 4465.129299786543, 4590.0, 4622.722636641813, 4784.904301913977, 4801.15979703554, 101514.0, 103041.4847925763, 106240.0, 108367.91632083656, 109594.45202773935, 10665.0, 10730.939439840884, 10784.083352914933, 10820.78358432827, 11112.44437778108, 20620.69068963967, 20670.58658826815, 20673.86293753858, 20701.896490517753, 20702.378928632166, 6585.341465853377, 7857.567833769083, 7868.25251601097, 7921.613717599397, 8122.9187708123345, 4413.558644135561, 4428.6678499112695, 4477.395551600557, 4577.382053422745, 4634.397528321364, 3447.5518182636097, 3537.398642230827, 3586.8565257389414, 3598.5501812273465, 3603.711703063801, 652.5138771615083, 660.4155322539588, 670.1622971285892, 673.5049738442241, 679.741698154698, 506.9379649634011, 542.2192043457409, 558.5475764630662, 593.9168516407707, 595.7557401465378, 7706.884396734054, 8482.194191551793, 8492.0, 8548.572571371407, 8566.524290447542, 519.9246109314204, 556.8886222755384, 589.9764009439574, 590.9970450147722, 592.6384905207819, 3943.940840887389, 4232.730180945766, 4270.081932384553, 4296.83985323967, 4395.406620106309, 143474.0, 148295.0, 150604.49395506125, 151089.0, 155437.0, 130564.69435305716, 133634.0, 134571.3271433656, 135844.0, 138453.30773346272, 83972.58013709892, 111745.44127279312, 112650.0, 112995.0, 114453.28320075205, 8313.251807337369, 8322.16778322163, 8522.27560657351, 8634.78413039679, 8640.870386944076, 47165.0, 62241.68879155575, 63640.04539931997, 63956.040659391074, 64527.67736161289, 87166.56416717876, 93810.0, 99576.50211748896, 99759.35961815799, 100098.499507502, 9904.378360148256, 10844.45777711127, 10971.451427428756, 11022.669319920415, 11233.831492527455, 11733.823992640288, 11825.645230643095, 11845.170838041255, 11940.0, 12359.752804943671, 11397.0, 11440.885591144315, 11480.425978701198, 11782.764344713229, 11957.880421196025, 11376.715582110513, 11606.897344752235, 11687.532498699957, 11713.941430292794, 12234.694132646755, 11262.887371126184, 11495.252808567417, 11569.323007744191, 11690.240134391237, 11867.228630139014, 9189.081091890757, 9440.527973601429, 9639.325247232626, 9745.561449734922, 9822.361546499455, 7675.925325565852, 8026.598670066356, 8735.606897689746, 9152.718619393423, 9516.095970882756], "value": 7495.515348808846, "unit": "score"}], "name": "dromaeo_css", "value": 7086.432007945536, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 116.0, 113.0, 114.0, 118.0, 160.0, 112.0, 113.0, 123.0], "value": 119.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 132.0, 161.0, 109.0, 129.0, 128.0, 108.0, 159.0, 108.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 183.0, 186.0, 182.0, 181.0, 182.0, 184.0, 182.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 94.0, 183.0, 81.0, 58.0, 59.0, 60.0, 145.0, 74.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 130.0, 70.0, 70.0, 77.0, 116.0, 67.0, 70.0, 120.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 87.0, 85.0, 89.0, 86.0, 88.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 95.0, 96.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 84.0, 85.0, 86.0, 85.0, 86.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 75.0, 73.0, 73.0, 76.0, 72.0, 69.0, 71.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 86.0, 88.0, 86.0, 88.0, 84.0, 89.0, 87.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 136.0, 139.0, 153.0, 153.0, 144.0, 138.0, 235.0, 139.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 165.0, 166.0, 166.0, 167.0, 164.0, 167.0, 167.0, 168.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 68.0, 68.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1476.6000000000001, "alertThreshold": 2.0}]} 12:15:31 INFO - Return code: 0 12:15:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:31 INFO - # TBPL SUCCESS # 12:15:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:31 INFO - 2016-09-07 12:15:31.844 screenresolution[1662:10224] starting screenresolution argv=screenresolution get 12:15:31 INFO - 2016-09-07 12:15:31.847 screenresolution[1662:10224] Display 0: 1600x1200x32@60 12:15:31 INFO - 2016-09-07 12:15:31.853 screenresolution[1663:10227] starting screenresolution argv=screenresolution list 12:15:31 INFO - Available Modes on Display 0 12:15:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:32 INFO - Intel Iris: 12:15:32 INFO - Chipset Model: Intel Iris 12:15:32 INFO - Type: GPU 12:15:32 INFO - Bus: Built-In 12:15:32 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:32 INFO - Vendor: Intel (0x8086) 12:15:32 INFO - Device ID: 0x0a2e 12:15:32 INFO - Revision ID: 0x0009 12:15:32 INFO - Displays: 12:15:32 INFO - Display: 12:15:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:32 INFO - Display Serial Number: 1600x1200 60 12:15:32 INFO - Main Display: Yes 12:15:32 INFO - Mirror: Off 12:15:32 INFO - Online: Yes 12:15:32 INFO - Rotation: Supported 12:15:32 INFO - Return code: 0 12:15:32 INFO - Running post-action listener: _resource_record_post_action 12:15:32 INFO - [mozharness: 2016-09-07 19:15:32.089252Z] Finished run-tests step (success) 12:15:32 INFO - Running post-run listener: _resource_record_post_run 12:15:32 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38310912; Write bytes: 705164800; Read time: 374; Write time: 2080 12:15:32 INFO - TinderboxPrint: CPU usage
53.9% 12:15:32 INFO - TinderboxPrint: I/O read bytes / time
38,310,912 / 374 12:15:32 INFO - TinderboxPrint: I/O write bytes / time
705,164,800 / 2,080 12:15:32 INFO - TinderboxPrint: CPU idle
2,234.3 (46.1%) 12:15:32 INFO - TinderboxPrint: CPU system
972.6 (20.1%) 12:15:32 INFO - TinderboxPrint: CPU user
1,638.7 (33.8%) 12:15:32 INFO - TinderboxPrint: Swap in / out
443,887,616 / 0 12:15:32 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 400587264; Write bytes: 395454464; Read time: 29539; Write time: 832 12:15:32 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36193280; Write bytes: 294903296; Read time: 350; Write time: 1215 12:15:32 INFO - Running post-run listener: _upload_blobber_files 12:15:32 INFO - Blob upload gear active. 12:15:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:32 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 12:15:32 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'] 12:15:32 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 12:15:32 INFO - (blobuploader) - INFO - Open directory for files ... 12:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:34 INFO - (blobuploader) - INFO - Done attempting. 12:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:34 INFO - (blobuploader) - INFO - Done attempting. 12:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:15:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:37 INFO - (blobuploader) - INFO - Done attempting. 12:15:37 INFO - (blobuploader) - INFO - Iteration through files over. 12:15:37 INFO - Return code: 0 12:15:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:15:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:15:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bffb5b583e262aa5dde3955b3f7482e119a2d2d94fb1936296f9f9dc62611e912fcec2cfb70251e7c509e3d16eec4fa640b5ca793f37f28f5f118f669e21735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba738b745ca8b00e1677f78eca5e35d4f8f0fbcb696e234bcf2dd48750c1d52bb9a24b88f10a54cfc118a56a935f4ed9ef1b90125fdb25ebf567121722b65dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f4c84841a33427f5c4ecf260911582c7c6c5a150d8210cf21747b05c9aa11e16f716097f1c4c84799b0d39dcf640b25c1b43aeed974946e295014f9d5f0dde"} 12:15:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:37 INFO - Contents: 12:15:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bffb5b583e262aa5dde3955b3f7482e119a2d2d94fb1936296f9f9dc62611e912fcec2cfb70251e7c509e3d16eec4fa640b5ca793f37f28f5f118f669e21735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba738b745ca8b00e1677f78eca5e35d4f8f0fbcb696e234bcf2dd48750c1d52bb9a24b88f10a54cfc118a56a935f4ed9ef1b90125fdb25ebf567121722b65dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f4c84841a33427f5c4ecf260911582c7c6c5a150d8210cf21747b05c9aa11e16f716097f1c4c84799b0d39dcf640b25c1b43aeed974946e295014f9d5f0dde"} 12:15:37 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:37 INFO - Copying logs to upload dir... 12:15:37 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.097164 ========= master_lag: -0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-07 12:15:36.931542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 12:15:36.935046) ========= 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.j9e4cxFnfM/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.AaBDdVGFgB/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/9bffb5b583e262aa5dde3955b3f7482e119a2d2d94fb1936296f9f9dc62611e912fcec2cfb70251e7c509e3d16eec4fa640b5ca793f37f28f5f118f669e21735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba738b745ca8b00e1677f78eca5e35d4f8f0fbcb696e234bcf2dd48750c1d52bb9a24b88f10a54cfc118a56a935f4ed9ef1b90125fdb25ebf567121722b65dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f4c84841a33427f5c4ecf260911582c7c6c5a150d8210cf21747b05c9aa11e16f716097f1c4c84799b0d39dcf640b25c1b43aeed974946e295014f9d5f0dde"} build_url:https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011037 build_url: 'https://queue.taskcluster.net/v1/task/Ve7sNzg9S6WkzVF9suj4WQ/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/9bffb5b583e262aa5dde3955b3f7482e119a2d2d94fb1936296f9f9dc62611e912fcec2cfb70251e7c509e3d16eec4fa640b5ca793f37f28f5f118f669e21735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba738b745ca8b00e1677f78eca5e35d4f8f0fbcb696e234bcf2dd48750c1d52bb9a24b88f10a54cfc118a56a935f4ed9ef1b90125fdb25ebf567121722b65dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f4c84841a33427f5c4ecf260911582c7c6c5a150d8210cf21747b05c9aa11e16f716097f1c4c84799b0d39dcf640b25c1b43aeed974946e295014f9d5f0dde"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 12:15:36.968658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 12:15:36.968967) ========= 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.j9e4cxFnfM/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.AaBDdVGFgB/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.005231 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 12:15:37.017779) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 12:15:37.018278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 12:15:37.018676) ========= ========= Total master_lag: -0.10 =========