builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0286 starttime: 1473114379.0 results: success (0) buildid: 20160905130714 builduid: 4b234818b55343fb98507e2aba794221 revision: abb69c6bc4d47529ec40758e705f039fc9b68d2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.001409) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.001834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.002105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.072651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.073067) ========= 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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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-05 15:26:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-09-05 15:26:19 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081677 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.177679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.177988) ========= 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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.022836 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.226439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:19.226830) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev abb69c6bc4d47529ec40758e705f039fc9b68d2b --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 abb69c6bc4d47529ec40758e705f039fc9b68d2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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-05 15:26:19,306 truncating revision to first 12 chars 2016-09-05 15:26:19,306 Setting DEBUG logging. 2016-09-05 15:26:19,306 attempt 1/10 2016-09-05 15:26:19,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/abb69c6bc4d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-05 15:26:19,976 unpacking tar archive at: mozilla-central-abb69c6bc4d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:20.175878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:20.176205) ========= script_repo_revision: abb69c6bc4d47529ec40758e705f039fc9b68d2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:20.176651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:20.176920) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 15:26:20.196362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-05 15:26:20.196744) ========= /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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:26:20 INFO - MultiFileLogger online at 20160905 15:26:20 in /builds/slave/test 15:26:20 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 15:26:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:20 INFO - {'append_to_log': False, 15:26:20 INFO - 'base_work_dir': '/builds/slave/test', 15:26:20 INFO - 'blob_upload_branch': 'Firefox', 15:26:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:20 INFO - 'branch': 'Firefox', 15:26:20 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:20 INFO - 'config_files': ('talos/mac_config.py',), 15:26:20 INFO - 'default_actions': ('clobber', 15:26:20 INFO - 'read-buildbot-config', 15:26:20 INFO - 'download-and-extract', 15:26:20 INFO - 'populate-webroot', 15:26:20 INFO - 'create-virtualenv', 15:26:20 INFO - 'install', 15:26:20 INFO - 'run-tests'), 15:26:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:20 INFO - 'download_minidump_stackwalk': True, 15:26:20 INFO - 'download_symbols': 'ondemand', 15:26:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:20 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:20 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:20 INFO - 'installer_path': 'installer.exe', 15:26:20 INFO - 'log_level': 'info', 15:26:20 INFO - 'log_name': 'talos', 15:26:20 INFO - 'log_to_console': True, 15:26:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:26:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:26:20 INFO - 'opt_config_files': (), 15:26:20 INFO - 'pip_index': False, 15:26:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:20 INFO - 'cmd': ('bash', 15:26:20 INFO - '-c', 15:26:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:20 INFO - 'enabled': True, 15:26:20 INFO - 'halt_on_failure': False, 15:26:20 INFO - 'name': 'check_screen_resolution'},), 15:26:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:20 INFO - 'cmd': ('bash', 15:26:20 INFO - '-c', 15:26:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:20 INFO - 'enabled': True, 15:26:20 INFO - 'halt_on_failure': False, 15:26:20 INFO - 'name': 'check_screen_resolution'},), 15:26:20 INFO - 'run_cmd_checks_enabled': True, 15:26:20 INFO - 'sps_profile': False, 15:26:20 INFO - 'sps_profile_interval': 0, 15:26:20 INFO - 'suite': 'dromaeojs', 15:26:20 INFO - 'system_bits': '32', 15:26:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:20 INFO - 'title': 't-yosemite-r7-0286', 15:26:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:20 INFO - 'use_talos_json': True, 15:26:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:20 INFO - 'work_dir': 'build'} 15:26:20 INFO - [mozharness: 2016-09-05 22:26:20.395871Z] Running clobber step. 15:26:20 INFO - Running pre-action listener: _resource_record_pre_action 15:26:20 INFO - Running main action method: clobber 15:26:20 INFO - rmtree: /builds/slave/test/build 15:26:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:22 INFO - Running post-action listener: _resource_record_post_action 15:26:22 INFO - [mozharness: 2016-09-05 22:26:22.374156Z] Finished clobber step (success) 15:26:22 INFO - [mozharness: 2016-09-05 22:26:22.374434Z] Running read-buildbot-config step. 15:26:22 INFO - Running pre-action listener: _resource_record_pre_action 15:26:22 INFO - Running main action method: read_buildbot_config 15:26:22 INFO - Using buildbot properties: 15:26:22 INFO - { 15:26:22 INFO - "project": "", 15:26:22 INFO - "product": "firefox", 15:26:22 INFO - "script_repo_revision": "production", 15:26:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:26:22 INFO - "repository": "", 15:26:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:26:22 INFO - "buildid": "20160905130714", 15:26:22 INFO - "pgo_build": "False", 15:26:22 INFO - "basedir": "/builds/slave/test", 15:26:22 INFO - "buildnumber": 55, 15:26:22 INFO - "slavename": "t-yosemite-r7-0286", 15:26:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:26:22 INFO - "platform": "yosemite_r7", 15:26:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:26:22 INFO - "branch": "mozilla-central", 15:26:22 INFO - "repo_path": "mozilla-central", 15:26:22 INFO - "revision": "abb69c6bc4d47529ec40758e705f039fc9b68d2b", 15:26:22 INFO - "stage_platform": "macosx64", 15:26:22 INFO - "builduid": "4b234818b55343fb98507e2aba794221", 15:26:22 INFO - "slavebuilddir": "test" 15:26:22 INFO - } 15:26:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:26:22 INFO - Running post-action listener: _resource_record_post_action 15:26:22 INFO - [mozharness: 2016-09-05 22:26:22.380196Z] Finished read-buildbot-config step (success) 15:26:22 INFO - [mozharness: 2016-09-05 22:26:22.380415Z] Running download-and-extract step. 15:26:22 INFO - Running pre-action listener: _resource_record_pre_action 15:26:22 INFO - Running main action method: download_and_extract 15:26:22 INFO - mkdir: /builds/slave/test/build/tests 15:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:22 INFO - trying https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:26:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/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 15:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/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 15:26:23 INFO - Downloaded 1199 bytes. 15:26:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:26:23 INFO - Using the following test package requirements: 15:26:23 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:26:23 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:26:23 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:26:23 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'jsshell-mac.zip'], 15:26:23 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:26:23 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:26:23 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:26:23 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:26:23 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:26:23 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:26:23 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:26:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:26:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:26:24 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:26:31 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 15:26:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:26:31 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:26:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:26:38 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:39 INFO - trying https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:26:39 INFO - Downloading https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/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 15:26:42 INFO - Downloaded 111522735 bytes. 15:26:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:26:42 INFO - mkdir: /builds/slave/test/properties 15:26:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:42 INFO - Contents: 15:26:42 INFO - build_url:https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:26:43 INFO - Running post-action listener: _resource_record_post_action 15:26:43 INFO - Running post-action listener: set_extra_try_arguments 15:26:43 INFO - [mozharness: 2016-09-05 22:26:43.042317Z] Finished download-and-extract step (success) 15:26:43 INFO - [mozharness: 2016-09-05 22:26:43.042416Z] Running populate-webroot step. 15:26:43 INFO - Running pre-action listener: _resource_record_pre_action 15:26:43 INFO - Running main action method: populate_webroot 15:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:43 INFO - '--tppagecycles', 15:26:43 INFO - '7'], 15:26:43 INFO - 'tests': ['tsvgm']}}, 15:26:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['damp', 'tps']}, 15:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'tests': ['damp', 'tps']}, 15:26:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['dromaeo_dom']}, 15:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['basic_compositor_video']}, 15:26:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:26:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore', 15:26:43 INFO - 'tabpaint']}, 15:26:43 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore', 15:26:43 INFO - 'tabpaint']}, 15:26:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore', 15:26:43 INFO - 'tabpaint']}, 15:26:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore', 15:26:43 INFO - 'tabpaint']}, 15:26:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore', 15:26:43 INFO - 'tabpaint']}, 15:26:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore', 15:26:43 INFO - 'tabpaint']}, 15:26:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['tsvgx', 15:26:43 INFO - 'tsvgr_opacity', 15:26:43 INFO - 'tart', 15:26:43 INFO - 'tscrollx', 15:26:43 INFO - 'cart']}, 15:26:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:43 INFO - 'tsvgr_opacity', 15:26:43 INFO - 'tart', 15:26:43 INFO - 'tscrollx', 15:26:43 INFO - 'cart']}, 15:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--disable-e10s'], 15:26:43 INFO - 'tests': ['tp5o']}, 15:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'tests': ['tp5o']}, 15:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--disable-e10s', 15:26:43 INFO - '--xperf_path', 15:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:43 INFO - 'tests': ['tp5n']}, 15:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--xperf_path', 15:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:43 INFO - 'tests': ['tp5n']}}, 15:26:43 INFO - 'talos.zip': {'path': '', 15:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:43 INFO - Running post-action listener: _resource_record_post_action 15:26:43 INFO - [mozharness: 2016-09-05 22:26:43.061186Z] Finished populate-webroot step (success) 15:26:43 INFO - [mozharness: 2016-09-05 22:26:43.061321Z] Running create-virtualenv step. 15:26:43 INFO - Running pre-action listener: _resource_record_pre_action 15:26:43 INFO - Running main action method: create_virtualenv 15:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:43 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 15:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:43 INFO - Using real prefix '/tools/python27' 15:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:46 INFO - Installing pip.................done. 15:26:46 INFO - Return code: 0 15:26:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:46 INFO - 'HOME': '/Users/cltbld', 15:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:46 INFO - 'LOGNAME': 'cltbld', 15:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:46 INFO - 'MOZ_NO_REMOTE': '1', 15:26:46 INFO - 'NO_EM_RESTART': '1', 15:26:46 INFO - 'PAGER': '/bin/cat', 15:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:46 INFO - 'PWD': '/builds/slave/test', 15:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:46 INFO - 'SHELL': '/bin/bash', 15:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:26:46 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:46 INFO - 'USER': 'cltbld', 15:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:46 INFO - 'XPC_FLAGS': '0x0', 15:26:46 INFO - 'XPC_SERVICE_NAME': '0', 15:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:47 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 15:26:47 INFO - Cleaning up... 15:26:47 INFO - Return code: 0 15:26:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:26:47 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')]} 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:47 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')]} 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:47 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:26:47 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 15:26:47 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 15:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:47 INFO - 'HOME': '/Users/cltbld', 15:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:47 INFO - 'LOGNAME': 'cltbld', 15:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:47 INFO - 'MOZ_NO_REMOTE': '1', 15:26:47 INFO - 'NO_EM_RESTART': '1', 15:26:47 INFO - 'PAGER': '/bin/cat', 15:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:47 INFO - 'PWD': '/builds/slave/test', 15:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:47 INFO - 'SHELL': '/bin/bash', 15:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:26:47 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:47 INFO - 'USER': 'cltbld', 15:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:47 INFO - 'XPC_FLAGS': '0x0', 15:26:47 INFO - 'XPC_SERVICE_NAME': '0', 15:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:47 INFO - Downloading/unpacking psutil>=3.1.1 15:26:47 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 15:26:47 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 15:26:47 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 15:26:47 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 15:26:47 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 15:26:47 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 15:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:50 INFO - Installing collected packages: psutil 15:26:50 INFO - Running setup.py install for psutil 15:26:50 INFO - building 'psutil._psutil_osx' extension 15:26:50 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 15:26:51 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 15:26:51 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 15:26:51 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 15:26:51 INFO - building 'psutil._psutil_posix' extension 15:26:51 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 15:26:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:26:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:26:51 INFO - ^ 15:26:51 INFO - 1 warning generated. 15:26:51 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 15:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:51 INFO - Successfully installed psutil 15:26:51 INFO - Cleaning up... 15:26:51 INFO - Return code: 0 15:26:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:26:51 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')]} 15:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:51 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')]} 15:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:51 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:26:51 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 15:26:51 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 15:26:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:26:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:51 INFO - 'HOME': '/Users/cltbld', 15:26:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:51 INFO - 'LOGNAME': 'cltbld', 15:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:51 INFO - 'MOZ_NO_REMOTE': '1', 15:26:51 INFO - 'NO_EM_RESTART': '1', 15:26:51 INFO - 'PAGER': '/bin/cat', 15:26:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:51 INFO - 'PWD': '/builds/slave/test', 15:26:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:51 INFO - 'SHELL': '/bin/bash', 15:26:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:26:51 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:26:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:51 INFO - 'USER': 'cltbld', 15:26:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:51 INFO - 'XPC_FLAGS': '0x0', 15:26:51 INFO - 'XPC_SERVICE_NAME': '0', 15:26:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:26:54 INFO - Installing collected packages: mozsystemmonitor 15:26:54 INFO - Running setup.py install for mozsystemmonitor 15:26:54 INFO - Successfully installed mozsystemmonitor 15:26:54 INFO - Cleaning up... 15:26:54 INFO - Return code: 0 15:26:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:54 INFO - 'HOME': '/Users/cltbld', 15:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:54 INFO - 'LOGNAME': 'cltbld', 15:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:54 INFO - 'MOZ_NO_REMOTE': '1', 15:26:54 INFO - 'NO_EM_RESTART': '1', 15:26:54 INFO - 'PAGER': '/bin/cat', 15:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:54 INFO - 'PWD': '/builds/slave/test', 15:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:54 INFO - 'SHELL': '/bin/bash', 15:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:26:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:54 INFO - 'USER': 'cltbld', 15:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:54 INFO - 'XPC_FLAGS': '0x0', 15:26:54 INFO - 'XPC_SERVICE_NAME': '0', 15:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:55 INFO - Downloading/unpacking jsonschema==2.5.1 15:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:26:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:26:58 INFO - warning: no files found matching '*.txt' 15:26:58 INFO - no previously-included directories found matching 'build' 15:26:58 INFO - no previously-included directories found matching 'dist' 15:26:58 INFO - no previously-included directories found matching '.git*' 15:26:58 INFO - Installing collected packages: jsonschema, functools32 15:26:58 INFO - Running setup.py install for functools32 15:26:58 INFO - warning: no files found matching '*.txt' 15:26:58 INFO - no previously-included directories found matching 'build' 15:26:58 INFO - no previously-included directories found matching 'dist' 15:26:58 INFO - no previously-included directories found matching '.git*' 15:26:58 INFO - Successfully installed jsonschema functools32 15:26:58 INFO - Cleaning up... 15:26:58 INFO - Return code: 0 15:26:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:26:58 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')]} 15:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:58 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')]} 15:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:58 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:26:58 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 15:26:58 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 15:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:58 INFO - 'HOME': '/Users/cltbld', 15:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:58 INFO - 'LOGNAME': 'cltbld', 15:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:58 INFO - 'MOZ_NO_REMOTE': '1', 15:26:58 INFO - 'NO_EM_RESTART': '1', 15:26:58 INFO - 'PAGER': '/bin/cat', 15:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:58 INFO - 'PWD': '/builds/slave/test', 15:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:58 INFO - 'SHELL': '/bin/bash', 15:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:26:58 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:58 INFO - 'USER': 'cltbld', 15:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:58 INFO - 'XPC_FLAGS': '0x0', 15:26:58 INFO - 'XPC_SERVICE_NAME': '0', 15:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:26:58 INFO - Cleaning up... 15:26:58 INFO - Return code: 0 15:26:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:26:58 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')]} 15:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:58 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')]} 15:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:58 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:26:58 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 15:26:58 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 15:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:58 INFO - 'HOME': '/Users/cltbld', 15:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:58 INFO - 'LOGNAME': 'cltbld', 15:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:58 INFO - 'MOZ_NO_REMOTE': '1', 15:26:58 INFO - 'NO_EM_RESTART': '1', 15:26:58 INFO - 'PAGER': '/bin/cat', 15:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:58 INFO - 'PWD': '/builds/slave/test', 15:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:58 INFO - 'SHELL': '/bin/bash', 15:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:26:58 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:58 INFO - 'USER': 'cltbld', 15:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:58 INFO - 'XPC_FLAGS': '0x0', 15:26:58 INFO - 'XPC_SERVICE_NAME': '0', 15:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:58 INFO - Downloading/unpacking blobuploader==1.2.4 15:26:58 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 15:26:58 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 15:26:58 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 15:26:58 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 15:26:58 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 15:26:58 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 15:27:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:27:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:27:01 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 15:27:01 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 15:27:01 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 15:27:01 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 15:27:01 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 15:27:01 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 15:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:27:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:02 INFO - Downloading docopt-0.6.1.tar.gz 15:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:02 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:02 INFO - Running setup.py install for blobuploader 15:27:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:02 INFO - Running setup.py install for requests 15:27:03 INFO - Running setup.py install for docopt 15:27:03 INFO - Successfully installed blobuploader requests docopt 15:27:03 INFO - Cleaning up... 15:27:03 INFO - Return code: 0 15:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:03 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:27:03 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 15:27:03 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 15:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:03 INFO - 'HOME': '/Users/cltbld', 15:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:03 INFO - 'LOGNAME': 'cltbld', 15:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:03 INFO - 'MOZ_NO_REMOTE': '1', 15:27:03 INFO - 'NO_EM_RESTART': '1', 15:27:03 INFO - 'PAGER': '/bin/cat', 15:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:03 INFO - 'PWD': '/builds/slave/test', 15:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:03 INFO - 'SHELL': '/bin/bash', 15:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:27:03 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:03 INFO - 'USER': 'cltbld', 15:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:03 INFO - 'XPC_FLAGS': '0x0', 15:27:03 INFO - 'XPC_SERVICE_NAME': '0', 15:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-meUlvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-H8JqkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fUP2WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-CoFx6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-iWkt3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-QuiJo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-HmF4Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-HRs8dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-1v9wcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-EqLgOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-TwM2o4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-lKIoFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-YTGQY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-BfmC4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-6TA8Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ceONKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-SRVdYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:05 INFO - Running setup.py install for manifestparser 15:27:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:05 INFO - Running setup.py install for mozcrash 15:27:05 INFO - Running setup.py install for mozdebug 15:27:05 INFO - Running setup.py install for mozdevice 15:27:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Running setup.py install for mozfile 15:27:06 INFO - Running setup.py install for mozhttpd 15:27:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Running setup.py install for mozinfo 15:27:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Running setup.py install for mozInstall 15:27:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Running setup.py install for mozleak 15:27:06 INFO - Running setup.py install for mozlog 15:27:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:06 INFO - Running setup.py install for moznetwork 15:27:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:07 INFO - Running setup.py install for mozprocess 15:27:07 INFO - Running setup.py install for mozprofile 15:27:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:07 INFO - Running setup.py install for mozrunner 15:27:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:07 INFO - Running setup.py install for mozscreenshot 15:27:07 INFO - Running setup.py install for moztest 15:27:07 INFO - Running setup.py install for mozversion 15:27:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:08 INFO - Cleaning up... 15:27:08 INFO - Return code: 0 15:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:27:08 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 15:27:08 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 15:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:08 INFO - 'HOME': '/Users/cltbld', 15:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:08 INFO - 'LOGNAME': 'cltbld', 15:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:08 INFO - 'MOZ_NO_REMOTE': '1', 15:27:08 INFO - 'NO_EM_RESTART': '1', 15:27:08 INFO - 'PAGER': '/bin/cat', 15:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:08 INFO - 'PWD': '/builds/slave/test', 15:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:08 INFO - 'SHELL': '/bin/bash', 15:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:27:08 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:08 INFO - 'USER': 'cltbld', 15:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:08 INFO - 'XPC_FLAGS': '0x0', 15:27:08 INFO - 'XPC_SERVICE_NAME': '0', 15:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-EUPiiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:08 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)) 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-VCIdFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:08 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)) 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-5w9w8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:08 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)) 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-CifRj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:08 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)) 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ubuJ75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:08 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)) 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-RAts1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:08 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)) 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-LyQwRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-_bw241-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-GpvUlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-TIy8c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-AgYeDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Q8Vuov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-IBEbWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-UTb9wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-8zM8Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-xyhtBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:09 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)) 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:09 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Uey4ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:10 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)) 15:27:10 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)) 15:27:10 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)) 15:27:10 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)) 15:27:10 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)) 15:27:10 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)) 15:27:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:12 INFO - Downloading blessings-1.6.tar.gz 15:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:12 INFO - Installing collected packages: blessings 15:27:12 INFO - Running setup.py install for blessings 15:27:12 INFO - Successfully installed blessings 15:27:12 INFO - Cleaning up... 15:27:12 INFO - Return code: 0 15:27:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:13 INFO - Reading from file tmpfile_stdout 15:27:13 INFO - Current package versions: 15:27:13 INFO - blessings == 1.6 15:27:13 INFO - blobuploader == 1.2.4 15:27:13 INFO - docopt == 0.6.1 15:27:13 INFO - functools32 == 3.2.3-2 15:27:13 INFO - jsonschema == 2.5.1 15:27:13 INFO - manifestparser == 1.1 15:27:13 INFO - mozInstall == 1.12 15:27:13 INFO - mozcrash == 0.17 15:27:13 INFO - mozdebug == 0.1 15:27:13 INFO - mozdevice == 0.48 15:27:13 INFO - mozfile == 1.2 15:27:13 INFO - mozhttpd == 0.7 15:27:13 INFO - mozinfo == 0.9 15:27:13 INFO - mozleak == 0.1 15:27:13 INFO - mozlog == 3.3 15:27:13 INFO - moznetwork == 0.27 15:27:13 INFO - mozprocess == 0.23 15:27:13 INFO - mozprofile == 0.28 15:27:13 INFO - mozrunner == 6.12 15:27:13 INFO - mozscreenshot == 0.1 15:27:13 INFO - mozsystemmonitor == 0.3 15:27:13 INFO - moztest == 0.7 15:27:13 INFO - mozversion == 1.4 15:27:13 INFO - psutil == 3.1.1 15:27:13 INFO - requests == 1.2.3 15:27:13 INFO - wsgiref == 0.1.2 15:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:13 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:27:13 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 15:27:13 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 15:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:13 INFO - 'HOME': '/Users/cltbld', 15:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:13 INFO - 'LOGNAME': 'cltbld', 15:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:13 INFO - 'MOZ_NO_REMOTE': '1', 15:27:13 INFO - 'NO_EM_RESTART': '1', 15:27:13 INFO - 'PAGER': '/bin/cat', 15:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:13 INFO - 'PWD': '/builds/slave/test', 15:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:13 INFO - 'SHELL': '/bin/bash', 15:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:27:13 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:13 INFO - 'USER': 'cltbld', 15:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:13 INFO - 'XPC_FLAGS': '0x0', 15:27:13 INFO - 'XPC_SERVICE_NAME': '0', 15:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 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)) 15:27:13 INFO - Cleaning up... 15:27:13 INFO - Return code: 0 15:27:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:13 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 0x108147a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b58dba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, '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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:27:13 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 15:27:13 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 15:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:13 INFO - 'HOME': '/Users/cltbld', 15:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:13 INFO - 'LOGNAME': 'cltbld', 15:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:13 INFO - 'MOZ_NO_REMOTE': '1', 15:27:13 INFO - 'NO_EM_RESTART': '1', 15:27:13 INFO - 'PAGER': '/bin/cat', 15:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:13 INFO - 'PWD': '/builds/slave/test', 15:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:13 INFO - 'SHELL': '/bin/bash', 15:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:27:13 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:13 INFO - 'USER': 'cltbld', 15:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:13 INFO - 'XPC_FLAGS': '0x0', 15:27:13 INFO - 'XPC_SERVICE_NAME': '0', 15:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:27:13 INFO - Cleaning up... 15:27:13 INFO - Return code: 0 15:27:13 INFO - Running post-action listener: _resource_record_post_action 15:27:13 INFO - Running post-action listener: _start_resource_monitoring 15:27:13 INFO - Starting resource monitoring. 15:27:13 INFO - [mozharness: 2016-09-05 22:27:13.820930Z] Finished create-virtualenv step (success) 15:27:13 INFO - [mozharness: 2016-09-05 22:27:13.821868Z] Running install step. 15:27:13 INFO - Running pre-action listener: _resource_record_pre_action 15:27:13 INFO - Running main action method: install 15:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:14 INFO - Reading from file tmpfile_stdout 15:27:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:14 INFO - Reading from file tmpfile_stdout 15:27:14 INFO - Output received: 15:27:14 INFO - Usage: mozinstall [options] installer 15:27:14 INFO - Options: 15:27:14 INFO - -h, --help show this help message and exit 15:27:14 INFO - -d DEST, --destination=DEST 15:27:14 INFO - Directory to install application into. [default: 15:27:14 INFO - "/builds/slave/test"] 15:27:14 INFO - --app=APP Application being installed. [default: firefox] 15:27:14 INFO - mkdir: /builds/slave/test/build/application 15:27:14 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'] 15:27:14 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 15:27:48 INFO - Reading from file tmpfile_stdout 15:27:48 INFO - Output received: 15:27:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:27:48 INFO - Running post-action listener: _resource_record_post_action 15:27:48 INFO - [mozharness: 2016-09-05 22:27:48.497953Z] Finished install step (success) 15:27:48 INFO - [mozharness: 2016-09-05 22:27:48.498054Z] Running run-tests step. 15:27:48 INFO - Running pre-action listener: _resource_record_pre_action 15:27:48 INFO - Running main action method: run_tests 15:27:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:27:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:27:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:27:48 INFO - 2016-09-05 15:27:48.512 screenresolution[1644:7533] starting screenresolution argv=screenresolution get 15:27:48 INFO - 2016-09-05 15:27:48.515 screenresolution[1644:7533] Display 0: 1600x1200x32@60 15:27:48 INFO - 2016-09-05 15:27:48.521 screenresolution[1645:7535] starting screenresolution argv=screenresolution list 15:27:48 INFO - Available Modes on Display 0 15:27:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:27:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:27:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:27:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:27:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:27:48 INFO - Intel Iris: 15:27:48 INFO - Chipset Model: Intel Iris 15:27:48 INFO - Type: GPU 15:27:48 INFO - Bus: Built-In 15:27:48 INFO - VRAM (Dynamic, Max): 1536 MB 15:27:48 INFO - Vendor: Intel (0x8086) 15:27:48 INFO - Device ID: 0x0a2e 15:27:48 INFO - Revision ID: 0x0009 15:27:48 INFO - Displays: 15:27:48 INFO - Display: 15:27:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:27:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:27:48 INFO - Display Serial Number: 1600x1200 60 15:27:48 INFO - Main Display: Yes 15:27:48 INFO - Mirror: Off 15:27:48 INFO - Online: Yes 15:27:48 INFO - Rotation: Supported 15:27:48 INFO - Return code: 0 15:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:48 INFO - Python 2.7.3 15:27:48 INFO - Return code: 0 15:27:48 INFO - grabbing minidump binary from tooltool 15:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:48 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 0x1080abd30>, '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 0x107e10db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1080a3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:48 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 15:27:48 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 15:27:48 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 15:27:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:48 INFO - Return code: 0 15:27:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:27:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:27:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:48 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/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 15:27:48 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/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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 15:27:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KuLioLQ7Am/Render', 15:27:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:48 INFO - 'HOME': '/Users/cltbld', 15:27:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:48 INFO - 'LOGNAME': 'cltbld', 15:27:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:48 INFO - 'MOZ_NO_REMOTE': '1', 15:27:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:48 INFO - 'NO_EM_RESTART': '1', 15:27:48 INFO - 'PAGER': '/bin/cat', 15:27:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:48 INFO - 'PWD': '/builds/slave/test', 15:27:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:48 INFO - 'SHELL': '/bin/bash', 15:27:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hb6XB0MXVs/Listeners', 15:27:48 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:27:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:48 INFO - 'USER': 'cltbld', 15:27:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:48 INFO - 'XPC_FLAGS': '0x0', 15:27:48 INFO - 'XPC_SERVICE_NAME': '0', 15:27:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:48 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/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 15:27:49 INFO - mozversion application_buildid: 20160905130714 15:27:49 INFO - mozversion application_changeset: abb69c6bc4d47529ec40758e705f039fc9b68d2b 15:27:49 INFO - mozversion application_display_name: Nightly 15:27:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:49 INFO - mozversion application_name: Firefox 15:27:49 INFO - mozversion application_remotingname: firefox 15:27:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:27:49 INFO - mozversion application_vendor: Mozilla 15:27:49 INFO - mozversion application_version: 51.0a1 15:27:49 INFO - mozversion platform_buildid: 20160905130714 15:27:49 INFO - mozversion platform_changeset: abb69c6bc4d47529ec40758e705f039fc9b68d2b 15:27:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:27:49 INFO - mozversion platform_version: 51.0a1 15:27:49 INFO - using testdate: 1473114469 15:27:49 INFO - actual date: 1473114469 15:27:49 INFO - starting webserver on 'localhost:49277' 15:27:49 INFO - SUITE-START | Running 2 tests 15:27:49 INFO - TEST-START | dromaeo_css 15:27:49 INFO - operating with platform_type : mac_ 15:27:49 INFO - Initialising browser for dromaeo_css test... 15:27:49 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpJ1sfH9/profile http://localhost:49277/getInfo.html) 15:27:51 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 15:27:51 INFO - PROCESS | 1655 | colorDepth:24 15:27:51 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 15:27:51 INFO - PROCESS | 1655 | __metrics 15:27:51 INFO - PROCESS | 1655 | 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" 15:27:51 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:27:52 INFO - TEST-INFO | 1655: exit 0 15:27:52 INFO - Browser initialized. 15:27:52 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:52 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpJ1sfH9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:04 INFO - PROCESS | 1657 | RSS: Main: 232714240 15:28:04 INFO - PROCESS | 1657 | 15:28:55 INFO - PROCESS | 1657 | 1473114535905 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] 15:31:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 15:31:09 INFO - PROCESS | 1657 | RSS: Main: 348499968 15:31:09 INFO - PROCESS | 1657 | 15:34:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 15:34:12 INFO - PROCESS | 1657 | RSS: Main: 371638272 15:34:12 INFO - PROCESS | 1657 | 15:37:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 15:37:15 INFO - PROCESS | 1657 | RSS: Main: 340123648 15:37:15 INFO - PROCESS | 1657 | 15:40:18 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 15:40:18 INFO - PROCESS | 1657 | RSS: Main: 341557248 15:40:18 INFO - PROCESS | 1657 | 15:43:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 15:43:22 INFO - PROCESS | 1657 | RSS: Main: 327692288 15:43:22 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 15:46:26 INFO - PROCESS | 1657 | RSS: Main: 472821760 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | __start_tp_report 15:46:26 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 15:46:26 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 15:46:26 INFO - PROCESS | 1657 | |i|pagename|runs| 15:46:26 INFO - PROCESS | 1657 | |0;dojo.html;3349.7487688423366;3355.7818741781784;3369.4440417331143;3410.403179443597;3437.5015622734704;5570.916436253459;5676.716164191785;5714.542836573075;5789.507891829195;5818.970905145468;5660.150977353389;5699.829005129843;5709.600327977043;5717.857053573663;5723.570732195081;5157.71632560209;5200.08998425276;5203.375594928614;5214.087534681435;5251.264822924793;5290.6825590464505;5300.443453437372;5303.469653034685;5304.893902121955;5310.62825602208;5215.58275337972;5239.633225674204;5253.185756207775;5282.947170528284;5304.416514183436;5336.893262134755;5339.759710813023;5361.169018802092;5367.651102678314;5389.67661940281;5127.9230811537855;5142.897142057138;5145.228215767627;5267.973660131714;5279.5512381447625;5665.2351932489;5690.943090569082;5719.170720245541;5750.5687073469235;5758.021136406821;6210.1616281801835;6226.844328891769;6244.906326405107;6250.15622890913;6269.341719119518;5362.570994320445;6258.311585725566;6287.088372186053;6302.149209856657;6354.078658594524;5852.4147585241135;5865.237519122486;5869.882602348014;5898.8820223595285;5915;6299.653519056405;6306.810795676137;6315.368463153648;6319.304876463585;6321.462675672527;5945.167676525203;6102.267727872683;6110.43725517484;6242.344553821783;6260.217472815898;6280.748770049238;6310.652914089769;6328.303886572473;6335.176427064452;6350.65071421067;6227.595206311576;6273.560850740404;6283.371662833772;6294.653794041372;6299.023651334051;6069.787557435468;6110.114033465123;6115.696722738907;6284.717187726564;6291.4023167799905;4928.654994150446;4933.235348520985;4938.38270216223;4945.109880221523;4948.4309304429735;4407.823687052482;4437;4467.798949047301;4474.910501789946;4481.170983368087;5779.393163717833;5817.621854579524;5827.388124246893;5828.970855145782;5885.499732522698;6345.397187267202;6350.33321501245;6363.490920726331;6370.77702280418;6371.23545174582;5559.221708960748;5595.916061259084;5691.288588926384;5796.188533605298;5821.38875418075;5434.239206511092;5446.591505637093;5467.917981230285;5480.451954804487;5511;6321.1150438938585;6375.968120159462;6377.808665740035;6390.456811170917;6391.105245265573;6130.9791012021615;6250.312465628686;6346.270178929482;6346.4605508532295;6354.332795056637;6304.369563043659;6390.840228994312;6420.582662126947;6425.58233714807;6432.839179020375;6251.624902505864;6271.31015588294;6272.937270627418;6280.434760871543;6281.811545653638;5413.511284396823;5791.305043394819;6100.664463454553;6280.246370435577;6357.491400687842;5481.205225242238;5916.704164791657;6095.420935011167;6107.795737660903;6148.846278842886;6169.753209871555;6190.226221722285;6198.132261483306;6202.906956395567;6208.2239720034995;5858.9414105860105;6012.368701286302;6018.337982821974;6021.277446706424;6060.515158787374;5975.37258587842;6117.431594453822;6130.948521380091;6131.63210207389;6133.1510485532735;5974.731137098928;6017.759289628541;6020.729067192075;6032.3967603239325;6070.514358851193 15:46:26 INFO - PROCESS | 1657 | |1;ext.html;487.656202377324;506.47832732285747;527.3855957809153;531.4658767938222;552.4751486088218;30459.847700761493;32027.67972320276;32042;32076.518852217177;39585.802070989674;39643.801780991125;42274.15451690972;42281.73154805353;42294;42341.36487952676;8236.423450358478;9556.42661440314;9728.416295022322;9736.221102311798;9743.707688769313;9584.377015494005;9677.225821934227;9690.37012594179;9691.709248722515;9693.321467497279;9659.32384733069;9729.221662267002;9733.415995040321;9733.902660973406;9737.610495580204;8138;8966.551672416419;8996.695479155485;9713.70858874235;9725.221982241404;9559.569819358145;9611.375260608038;9614.71155865325;9617.51912404377;9626.470544120071;40249.396259056135;40645.593544064475;40663.593364066575;40704.59295407037;40715.38926916099;3321.80069195849;3462.169079420946;3504.5794504659348;3531.640318477379;3970.82131304092;22810.88594557033;24697.753022469726;30381.088567342795;30540;31376.37247255065;3201.5837941067743;3257.723093537052;3274.4269752793166;3316.767826252163;3343.498475228711;468155;469034;469285;470616;482380.58809705725;58699.70650146722;59051.40948590545;59153.70423147943;59234.11148832771;59256.40743592509;58325.70837145787;59026;59694;59765.103523447186;59892.80214395688;15768.76346854798;15848.44530441429;16071.758923616155;16074.196290185679;16109.919450402673;10319.74200644975;11407.657770266906;12545;12567.497300107892;12572.4342404592;16230.431934882223;16252.268647910872;16289.59276018109;16310.021398716115;16326.34694612226;6855.520113592101;6876.793696189123;6886.965565172242;6961.547499412522;6987.8602427951155;880.599327306087;937.8218138553653;960.7309953213112;964.1611797735875;1009.28340877976;28029.859850700617;29114.85442572816;29379.97170099036;30036.54945175824;30057;1008.606643409071;1097.9011888930036;1097.9231453798157;1102.6802227353978;1131.4908291268962;12177.208481448677;15151.015184013224;15318.387264509294;15464.204981129033;15675.372985080698;648028.7598561978;650062;650073.2445066639;652225.471816023;652724;47850.28224576634;54771.45228547663;54836.725816370665;55055.44944550583;55081.449185508434;1229.4098832560421;1275.6874565731455;1344.1666166976343;1365.8019587159806;1389.5275606293706;27706.307342316602;27991.58012629853;30353.392932140792;31225;31357.78770882664;42830;47337.28994065161;53663.731681342906;53847.192292114865;57430;604952;610018;610147;610995;613559;22733.545329093657;23231.651525226796;23366;24935.501289973738;25376;36872.89381318565;38545.45818167242;44860.77569612262;46196.76901615471;48870;38165.23669526538;38183;38199.854004379915;39485.40771888367;39556.60443395529;37678.811605941795;37934.24131517409;38382;38687;38828;36736.63263367439;37000.889973300844;37546.436803447425;37751.81124094362;37892.24215515729;32425.675743242267;34255.65744342525;34345.313093738485;34467.655323446445;34476.482852757734;23582.764172358056;25060.874695626404;25402.745972540037;25460.872695636404;26199.345016374744 15:46:26 INFO - PROCESS | 1657 | |2;jquery.html;350.62132896471815;365.5795834789991;369.69500162366046;379.8044007336222;396.85713143268435;14372.784408233872;15035.473758418444;20558.486037849023;20955.161793528277;20981.370558883238;18556.35052773153;19248.80751192491;19311;19324.130414131363;19356.12897419616;3426.965730342702;5885.529157667376;6075.2405949256345;6131.3562075982045;6133.2946711128125;4251;6429.8714025719455;6650.667466626674;6753.493487988396;6816.659167041653;6435.420812126908;6662.733490660367;6685.331466853324;6698.363655452748;6760.560563563353;6372;6585.868282634345;6599.076129341896;6628.304028077031;6637.966810165943;5681.943180568224;5755.107958266475;5759.942400575983;5760.0783874579865;5771.336296325934;23205.651915221286;25007.62488562673;25661.74338256631;25784.355391115183;25893.74106258932;1708.4618345221215;1975.9604807903904;2046.3656266557414;2156.148321413049;2356.363781778927;9699.90300096997;9945.950270248675;10086.092251697382;10201.795964080751;10242.692719218436;1705.2411676803827;1849.6393203325356;1863.1150203653292;1885.377825317642;1924.6150769846088;117166;125635;129014;130855.0371744415;130997.34501327432;10610.840837387444;10887.891121088845;10986.395748233765;11016.14434947778;11115.72210694739;13865.445382184802;13891.027628065938;13906.374213160432;13917.007843313737;13936.024478286423;7913.723019694283;8162.469439486415;8205.753827385188;8273.379496537784;8278.213569710868;8147.348212143014;8177.4684645497855;8178.7955301117945;8306.626201820933;8371.246587807127;4289.892752681208;4299.54854740254;4312.202242585132;4347.934780978288;4383.232934236496;1510.4864346122372;1880.5486683195934;1907.54218987442;1915.6839121545067;1917.405604262655;838.266516797802;886.9822603548022;919.7516670498928;993.8459538771502;1007.5516395204064;20661.966901654858;21258.574828503653;21318.14727410917;21328.36014919555;21347.893260533907;840.8360369727967;906.2387594420718;959.6065613098735;980.9558569864373;994.2096033653263;10730.283154695211;10794.176239134948;10826.945865270623;11352.94323528377;11481.483333250024;468014;589510;596164;596408;605217;109952;113789.4310528442;119810;140789;144000;991.7718924647227;998.7952469743685;1025.410389026313;1026.0509029148009;1027.275770581738;18590.18901125239;18733.34433294828;18955.336563220222;19048;19377.61244775125;46333.53666463292;55737.72131139319;58188.4181158183;59027.114593280276;59595.40404596072;80883.78674320008;84044.57977710072;84374.57812710897;85423;86644;7003.824904377431;7559.357454616419;7653.19641437641;7802.453828231969;8199.139090395423;12134.150609457252;12468.438920248429;12794.424250908545;12846;13066;10720.463976801284;10953.56185752561;10988.230823842254;11262.662120136409;11366.772664546828;8426.831463370821;9266.44401335922;10799.838002430128;11047.613333533287;11242.83135752948;11167.329960202414;11228.270162439416;11290.604828830952;11413.828792567952;11504.769904601693;5467.699276539828;7852.154743635356;7912.723054693289;7962.482438641701;7992.280694737501;9220.490860790644;11211.383373914514;11241.88758112441;11295.2658077228;11344.943275283571 15:46:26 INFO - PROCESS | 1657 | |3;mootools.html;1345.3071668090931;1448.5219877440443;1627.5361521966236;1835.1374853818718;1889.7921228664852;8606.784830379243;9114.36199466036;9119.635214591417;9121.133492318235;9121.954390228047;7857.646405911733;8067.636956336964;8083.272505474506;8190.2628763411285;8880.422772519782;2176.4014895903633;2323.7792409721133;2418.056957786465;2418.2140804238607;2427.5751743444916;2410.3974006498374;2413.9758602413926;2414.3239892830034;2415.2754173747894;2419.6128619420897;2369.07606033647;2420.225527831095;2422.2127808462233;2423.9151629692965;2427.0655797517907;2384.4277373430336;2389.832711710181;2407.241718858554;2409.289259668402;2416.081888882231;1937.680282753344;2361.2562042956583;2383.84505007174;2384.7853693167526;2388.2477019738726;8895.688650897187;9009.279257659371;9023.639054437881;9030.142136497088;9034.548272586344;5273.314469119028;5420.864478388033;5450.182472629137;5450.945490545084;5460.863478413032;3473.3747925373423;3633.0372451300427;3674.889753307405;3675.6691897729334;3693.593704692482;971.6939164163266;1021.4177918586408;1043.1185648127396;1066.861308029959;1091.6015654286127;11662.941685291604;11668.649940501798;11717.472713727817;11726.472308746126;11756.529738810437;4427.313766366218;4691.225947718656;4791.544803243686;4821.710697358169;4826.203676393356;10032.598696052222;10043.045910638477;10044;10050.246231532665;10056.64801731936;5354.678719276856;5361.437049109865;5370.8657283567445;5370.892582148335;5372.113601255749;4755.976220118877;4905.828296009694;4906.994066216417;4930.063287975273;4941.654084214142;3542.1498840278146;3642.7085833133287;3758.342290099222;3883.37865941448;3891.163399868985;1174.7180676637545;1174.9118816088828;1175.4651633506735;1183.355071486042;1185.946632401544;873.7466134820958;881.4843316659826;882.9823403531893;893.7586851550045;918.260800055948;5594.888102237933;5644.57665675076;5907;5984.192134061933;6077.696115194222;894.1326912894482;894.7405252476839;914.6158613382395;940.2806852757645;978.295627148452;3402.336544373873;3803.7337386382687;3860.5560360558334;3993.800309984489;4005.819738111792;10372.688819335432;10832.837507437394;10855.620053298255;10866.67399978002;10906.945465272782;10818.513166907507;10826.971437713404;10835.729106772395;10839.078678312275;10856.34019665187;7791.610419479003;8216.958915205385;8221.630026648934;8293.626786794608;8312.418130730912;5952.76188952437;5963.490055870456;5966.612170208922;6005.159277701038;6120.204373431426;8440.704575339834;9498.762530936781;9557.569909353957;9954.751131221778;10141.84787228207;9854.359466634933;10174.643887463903;10219.029192226726;10295.845562316721;10303.587856485656;8147.551884646401;8154.470212649812;8273;8362.331013519026;8375.497470151811;7568.621568921642;7868.331191848528;8191.75424737235;8512.531810750468;8516.91483085186;7376.483646144933;7465.925340746523;7506.361959233526;7515.323620873929;7716.807079823049;7335.083114610674;7378.852422951403;7386.593737344498;7422.997895284067;7449.553026818408;6689.765858195135;6802.421794147553;6853.348931851466;6870.20992585859;6890.345417185359;4851.830185943475;4877.561019508261;4877.975610121926;4924.039812236722;4992.400911890596;4868.391451068616;4871.2206047032305;4908.239222920453;5009.198528235464;5020.748962551931 15:46:26 INFO - PROCESS | 1657 | |4;prototype.html;298.8849293022186;300.7654029856712;309.3488207323584;311.7210096963218;313.3169690075637;4987.551120399164;5095.7770135167575;5440.374356948947;5462.53568446682;5462.6995515246645;4762.97618511907;4992.950070499294;5098.413682426522;5241;5353.678779273237;2967.940641187175;3552.4848896909934;4045.554988951213;4084.775337356444;4100.282450571153;3923.5684074751753;4079.9592004080023;4116.34138537834;4121.505419349667;4125.422440858282;3031.5149576067834;3538.345406099867;3725.1990821973272;4088.5707000764937;4094.2977634761064;3317.552130462381;3319.9502007469905;3655.3002853672906;4037.37420699792;4067.2272268268935;2946.602208701819;3202.6300537602237;3231.224506118538;3530.5233793437815;3545.290941811648;4747.786349614275;5041.9159880625475;5180.611454140954;5198.92201616976;5199.350081239845;4620.1221767864;4626.514216007338;4702.247640377524;4705.294205869147;4708.952910470885;4298.570142985708;5305.074245058668;5622.718864056781;5648.661080335193;5649.4633009864;3927.607239276078;3941.940870886939;3950.6246906543834;3956.9802150989062;3979.652005316848;5223.876866473726;5319;5617.325920889479;5932.881342373172;5944.256967879015;3944;3944.3097457944746;3960.2673505401594;3968.4245784361106;3981.960180398217;3994.7003974702016;4048.5748996355546;4064;4068.2066996935314;4091.202215567995;4504.887377815581;4667.533246675305;4676.830792301925;4717.292406139107;4721.055788842176;4948.678335908155;5623.831285061455;5645.633033852787;5652.9152062719095;5665.915011274834;1213.8104657435763;1340.9597712068653;1368.3773882883463;1369.2605992763995;1377.3526442572174;755.0863455219137;780.8711562592222;880.7974165941869;889.644142343055;904.3262769236829;4661.86014419568;4666.739980205326;5186;5190.8183213587345;5239.266502689627;4647.419072615923;4804.903901921942;5758.395368486333;5813.970930145322;5814.186013958049;4280.571942805756;5029.823956161516;5176;5201.425294479257;5399.812041350897;3051.6948305169303;3090.860911258999;3093.551435041906;3098.4577698902604;3120.03437834163;4895.755212239445;5364.839054828361;5920.141579470953;6125.877482450415;6141.692915354214;5495.340559132929;5968.671723055187;6014.51883849291;6040;6054.303755068136;5743.749625277348;6060.484858787053;6115.571909966259;6137.202163718688;6140.6929653517145;4648.581627653527;4792.904141917073;5861.241627511815;5873.676947767914;5918.881622367615;4818.7831547581145;5074.3657042869645;5805.970970145122;5831.067029275296;5839.35767065614;5092.745362731923;5587.664740115606;5656.953463609246;5737.713114344349;6130.325664177026;3612.8374223159494;3864.1305706215876;3920.7843568604;3933.783641899723;3939.4878665773267;5332.280142180756;5375.704336261543;5594.384617692132;5848.502877255481;5854.385289544707;5113.258577506315;5177.964407118667;5318.591097727152;5455.9454405455435;5707.315122185364;4210.389493523483;4452.5547445255215;4907.4847141051105;5331.920021199763;5741.8564535886935;4588.632909367309;5302.39022512416;5569.331680198402;5570.5265052470995;5593.272874526286;4240.1519696060295;4535.3650488932235;5592.748326325243;5602.831915042555;5677.687727175045;4639.025804581076;5576.302962129734;5595.209532949417;5597.916031259453;5621.606487545996 15:46:26 INFO - PROCESS | 1657 | |5;yui.html;669.819148829816;724.0731863215083;753.4123383760667;757.5757575757575;771.2788542712568;15268.770968435469;15979.680406391864;16024.198790060509;16028.519144425656;16046.83953160468;13911.026228164033;14042;14043.36804843782;14057.718845623082;14516.854831451683;672.495628278791;692.1140939597299;703.9401650859683;821.5317269156568;832.1512057701141;840.5419046619577;850.5364576305928;850.6597361055566;850.7277671145235;851.5742128935532;897.1656359585616;898.3307435960219;898.5597057441872;899.8875140607424;900.0234745301356;705.1819888928869;868.8436081505326;893.946363218209;894.2309613732152;894.7405252476807;665.1585744033753;665.7569986954775;666.7299743603849;666.8499587592802;667.7429189761928;15059.548213553611;15099.396024159021;15100;15123.01700389471;15127.773083403648;13814.309284535833;13935.721285574333;14084.366203520865;14192;14308;12647;12656.17734847232;12739.936300318532;12806.679833004157;12822.974162067012;4083.591640835922;4095.5494895561465;4198.03445207604;4259.2759230930815;4299.097189590189;71247.64376178138;97511;113707.43146284299;116137;119004;11741.236819606698;11760.23558468714;11781.234219775859;11873.584424545272;12230.082743794252;24264.757352426248;24535.754642453703;24575.262742117764;24582.508349832904;24697.382565435648;8333.749987500385;8333.916520869783;8514.616842242114;8574.571271436404;8716.128387161232;4426.623736982393;4435.489918659331;4590.173768721662;4622.214223581932;4767.928481072787;3349.330133973215;3639.763415377992;3669.3945498992366;3793.203427280247;3798.6581207691443;574.471486232667;681.8568100698809;686.8660611180871;687.4397366146575;689.0491122251261;545.4191286280098;559.9776008959597;585.9912101318483;652.8302641313293;673.441043933534;8859.335549833659;9346.600200192275;9408.294377921684;9499.572519236652;9584.90415095854;546.3607579132424;576.685706290073;604.694629212245;611.4099893602606;701.400302741149;4240.85157019509;4561.498235194126;4566.74882881438;4567.977160114178;4659.068186362673;125168;127454.98997555223;129676;145702;170866;116435;122664;126211;126251.73748262583;127384;82129.58935205286;90674;96763.51618242005;97678;114022;9379;9798.363106398061;9836;9868.851967220355;10009.199264059003;54747.17879231894;59164;60688.05527640689;62359;62666;85811.14188858031;94852;95542;96694;98635;12583.370831458573;13037.217766934014;13077.934610326887;13104.082714209913;13307.733845323233;14041.1575305482;14427.639309017359;14737.778933316224;14810.777838332218;14959.551213463614;13401.195928244337;13635;13871.306434678427;14076.577702668936;14145.43418263258;11742.354170520703;11921.105917056082;13786.724265514835;13820;14559.19924404168;11509.827352589886;11524.423778811193;11572.594959176726;11853.762924741284;13216;9662.130408263009;10105.9494702526;11353.262037967506;11503.424828758361;11903.583374581847;11262.436878156223;11453.312801231952;11564.826527602261;11678.299302041905;11718.824217636571 15:46:26 INFO - PROCESS | 1657 | __end_tp_report 15:46:26 INFO - PROCESS | 1657 | __start_cc_report 15:46:26 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1450 15:46:26 INFO - PROCESS | 1657 | __end_cc_report 15:46:26 INFO - PROCESS | 1657 | __startTimestamp1473115586312__endTimestamp 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | ------- Summary: start ------- 15:46:26 INFO - PROCESS | 1657 | Number of tests: 6 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5775.68 Median:5974.73 stddev:642.08 (10.7%) stddev-sans-first:615.20 15:46:26 INFO - PROCESS | 1657 | Values: 3349.7 3355.8 3369.4 3410.4 3437.5 5570.9 5676.7 5714.5 5789.5 5819.0 5660.2 5699.8 5709.6 5717.9 5723.6 5157.7 5200.1 5203.4 5214.1 5251.3 5290.7 5300.4 5303.5 5304.9 5310.6 5215.6 5239.6 5253.2 5282.9 5304.4 5336.9 5339.8 5361.2 5367.7 5389.7 5127.9 5142.9 5145.2 5268.0 5279.6 5665.2 5690.9 5719.2 5750.6 5758.0 6210.2 6226.8 6244.9 6250.2 6269.3 5362.6 6258.3 6287.1 6302.1 6354.1 5852.4 5865.2 5869.9 5898.9 5915.0 6299.7 6306.8 6315.4 6319.3 6321.5 5945.2 6102.3 6110.4 6242.3 6260.2 6280.7 6310.7 6328.3 6335.2 6350.7 6227.6 6273.6 6283.4 6294.7 6299.0 6069.8 6110.1 6115.7 6284.7 6291.4 4928.7 4933.2 4938.4 4945.1 4948.4 4407.8 4437.0 4467.8 4474.9 4481.2 5779.4 5817.6 5827.4 5829.0 5885.5 6345.4 6350.3 6363.5 6370.8 6371.2 5559.2 5595.9 5691.3 5796.2 5821.4 5434.2 5446.6 5467.9 5480.5 5511.0 6321.1 6376.0 6377.8 6390.5 6391.1 6131.0 6250.3 6346.3 6346.5 6354.3 6304.4 6390.8 6420.6 6425.6 6432.8 6251.6 6271.3 6272.9 6280.4 6281.8 5413.5 5791.3 6100.7 6280.2 6357.5 5481.2 5916.7 6095.4 6107.8 6148.8 6169.8 6190.2 6198.1 6202.9 6208.2 5858.9 6012.4 6018.3 6021.3 6060.5 5975.4 6117.4 6130.9 6131.6 6133.2 5974.7 6017.8 6020.7 6032.4 6070.5 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:70071.96 Median:39571.20 stddev:155967.59 (394.1%) stddev-sans-first:156317.62 15:46:26 INFO - PROCESS | 1657 | Values: 487.7 506.5 527.4 531.5 552.5 30459.8 32027.7 32042.0 32076.5 39585.8 39643.8 42274.2 42281.7 42294.0 42341.4 8236.4 9556.4 9728.4 9736.2 9743.7 9584.4 9677.2 9690.4 9691.7 9693.3 9659.3 9729.2 9733.4 9733.9 9737.6 8138.0 8966.6 8996.7 9713.7 9725.2 9559.6 9611.4 9614.7 9617.5 9626.5 40249.4 40645.6 40663.6 40704.6 40715.4 3321.8 3462.2 3504.6 3531.6 3970.8 22810.9 24697.8 30381.1 30540.0 31376.4 3201.6 3257.7 3274.4 3316.8 3343.5 468155.0 469034.0 469285.0 470616.0 482380.6 58699.7 59051.4 59153.7 59234.1 59256.4 58325.7 59026.0 59694.0 59765.1 59892.8 15768.8 15848.4 16071.8 16074.2 16109.9 10319.7 11407.7 12545.0 12567.5 12572.4 16230.4 16252.3 16289.6 16310.0 16326.3 6855.5 6876.8 6887.0 6961.5 6987.9 880.6 937.8 960.7 964.2 1009.3 28029.9 29114.9 29380.0 30036.5 30057.0 1008.6 1097.9 1097.9 1102.7 1131.5 12177.2 15151.0 15318.4 15464.2 15675.4 648028.8 650062.0 650073.2 652225.5 652724.0 47850.3 54771.5 54836.7 55055.4 55081.4 1229.4 1275.7 1344.2 1365.8 1389.5 27706.3 27991.6 30353.4 31225.0 31357.8 42830.0 47337.3 53663.7 53847.2 57430.0 604952.0 610018.0 610147.0 610995.0 613559.0 22733.5 23231.7 23366.0 24935.5 25376.0 36872.9 38545.5 44860.8 46196.8 48870.0 38165.2 38183.0 38199.9 39485.4 39556.6 37678.8 37934.2 38382.0 38687.0 38828.0 36736.6 37000.9 37546.4 37751.8 37892.2 32425.7 34255.7 34345.3 34467.7 34476.5 23582.8 25060.9 25402.7 25460.9 26199.3 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34547.26 Median:25334.68 stddev:96291.61 (380.1%) stddev-sans-first:96527.50 15:46:26 INFO - PROCESS | 1657 | Values: 350.6 365.6 369.7 379.8 396.9 14372.8 15035.5 20558.5 20955.2 20981.4 18556.4 19248.8 19311.0 19324.1 19356.1 3427.0 5885.5 6075.2 6131.4 6133.3 4251.0 6429.9 6650.7 6753.5 6816.7 6435.4 6662.7 6685.3 6698.4 6760.6 6372.0 6585.9 6599.1 6628.3 6638.0 5681.9 5755.1 5759.9 5760.1 5771.3 23205.7 25007.6 25661.7 25784.4 25893.7 1708.5 1976.0 2046.4 2156.1 2356.4 9699.9 9946.0 10086.1 10201.8 10242.7 1705.2 1849.6 1863.1 1885.4 1924.6 117166.0 125635.0 129014.0 130855.0 130997.3 10610.8 10887.9 10986.4 11016.1 11115.7 13865.4 13891.0 13906.4 13917.0 13936.0 7913.7 8162.5 8205.8 8273.4 8278.2 8147.3 8177.5 8178.8 8306.6 8371.2 4289.9 4299.5 4312.2 4347.9 4383.2 1510.5 1880.5 1907.5 1915.7 1917.4 838.3 887.0 919.8 993.8 1007.6 20662.0 21258.6 21318.1 21328.4 21347.9 840.8 906.2 959.6 981.0 994.2 10730.3 10794.2 10826.9 11352.9 11481.5 468014.0 589510.0 596164.0 596408.0 605217.0 109952.0 113789.4 119810.0 140789.0 144000.0 991.8 998.8 1025.4 1026.1 1027.3 18590.2 18733.3 18955.3 19048.0 19377.6 46333.5 55737.7 58188.4 59027.1 59595.4 80883.8 84044.6 84374.6 85423.0 86644.0 7003.8 7559.4 7653.2 7802.5 8199.1 12134.2 12468.4 12794.4 12846.0 13066.0 10720.5 10953.6 10988.2 11262.7 11366.8 8426.8 9266.4 10799.8 11047.6 11242.8 11167.3 11228.3 11290.6 11413.8 11504.8 5467.7 7852.2 7912.7 7962.5 7992.3 9220.5 11211.4 11241.9 11295.3 11344.9 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5731.90 Median:4906.41 stddev:3221.67 (65.7%) stddev-sans-first:3213.84 15:46:26 INFO - PROCESS | 1657 | Values: 1345.3 1448.5 1627.5 1835.1 1889.8 8606.8 9114.4 9119.6 9121.1 9122.0 7857.6 8067.6 8083.3 8190.3 8880.4 2176.4 2323.8 2418.1 2418.2 2427.6 2410.4 2414.0 2414.3 2415.3 2419.6 2369.1 2420.2 2422.2 2423.9 2427.1 2384.4 2389.8 2407.2 2409.3 2416.1 1937.7 2361.3 2383.8 2384.8 2388.2 8895.7 9009.3 9023.6 9030.1 9034.5 5273.3 5420.9 5450.2 5450.9 5460.9 3473.4 3633.0 3674.9 3675.7 3693.6 971.7 1021.4 1043.1 1066.9 1091.6 11662.9 11668.6 11717.5 11726.5 11756.5 4427.3 4691.2 4791.5 4821.7 4826.2 10032.6 10043.0 10044.0 10050.2 10056.6 5354.7 5361.4 5370.9 5370.9 5372.1 4756.0 4905.8 4907.0 4930.1 4941.7 3542.1 3642.7 3758.3 3883.4 3891.2 1174.7 1174.9 1175.5 1183.4 1185.9 873.7 881.5 883.0 893.8 918.3 5594.9 5644.6 5907.0 5984.2 6077.7 894.1 894.7 914.6 940.3 978.3 3402.3 3803.7 3860.6 3993.8 4005.8 10372.7 10832.8 10855.6 10866.7 10906.9 10818.5 10827.0 10835.7 10839.1 10856.3 7791.6 8217.0 8221.6 8293.6 8312.4 5952.8 5963.5 5966.6 6005.2 6120.2 8440.7 9498.8 9557.6 9954.8 10141.8 9854.4 10174.6 10219.0 10295.8 10303.6 8147.6 8154.5 8273.0 8362.3 8375.5 7568.6 7868.3 8191.8 8512.5 8516.9 7376.5 7465.9 7506.4 7515.3 7716.8 7335.1 7378.9 7386.6 7423.0 7449.6 6689.8 6802.4 6853.3 6870.2 6890.3 4851.8 4877.6 4878.0 4924.0 4992.4 4868.4 4871.2 4908.2 5009.2 5020.7 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4510.63 Median:4990.25 stddev:1395.57 (28.0%) stddev-sans-first:1363.21 15:46:26 INFO - PROCESS | 1657 | Values: 298.9 300.8 309.3 311.7 313.3 4987.6 5095.8 5440.4 5462.5 5462.7 4763.0 4993.0 5098.4 5241.0 5353.7 2967.9 3552.5 4045.6 4084.8 4100.3 3923.6 4080.0 4116.3 4121.5 4125.4 3031.5 3538.3 3725.2 4088.6 4094.3 3317.6 3320.0 3655.3 4037.4 4067.2 2946.6 3202.6 3231.2 3530.5 3545.3 4747.8 5041.9 5180.6 5198.9 5199.4 4620.1 4626.5 4702.2 4705.3 4709.0 4298.6 5305.1 5622.7 5648.7 5649.5 3927.6 3941.9 3950.6 3957.0 3979.7 5223.9 5319.0 5617.3 5932.9 5944.3 3944.0 3944.3 3960.3 3968.4 3982.0 3994.7 4048.6 4064.0 4068.2 4091.2 4504.9 4667.5 4676.8 4717.3 4721.1 4948.7 5623.8 5645.6 5652.9 5665.9 1213.8 1341.0 1368.4 1369.3 1377.4 755.1 780.9 880.8 889.6 904.3 4661.9 4666.7 5186.0 5190.8 5239.3 4647.4 4804.9 5758.4 5814.0 5814.2 4280.6 5029.8 5176.0 5201.4 5399.8 3051.7 3090.9 3093.6 3098.5 3120.0 4895.8 5364.8 5920.1 6125.9 6141.7 5495.3 5968.7 6014.5 6040.0 6054.3 5743.7 6060.5 6115.6 6137.2 6140.7 4648.6 4792.9 5861.2 5873.7 5918.9 4818.8 5074.4 5806.0 5831.1 5839.4 5092.7 5587.7 5657.0 5737.7 6130.3 3612.8 3864.1 3920.8 3933.8 3939.5 5332.3 5375.7 5594.4 5848.5 5854.4 5113.3 5178.0 5318.6 5455.9 5707.3 4210.4 4452.6 4907.5 5331.9 5741.9 4588.6 5302.4 5569.3 5570.5 5593.3 4240.2 4535.4 5592.7 5602.8 5677.7 4639.0 5576.3 5595.2 5597.9 5621.6 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24055.79 Median:4146.79 stddev:37564.26 (905.9%) stddev-sans-first:37628.59 15:46:26 INFO - PROCESS | 1657 | Values: 669.8 724.1 753.4 757.6 771.3 15268.8 15979.7 16024.2 16028.5 16046.8 13911.0 14042.0 14043.4 14057.7 14516.9 672.5 692.1 703.9 821.5 832.2 840.5 850.5 850.7 850.7 851.6 897.2 898.3 898.6 899.9 900.0 705.2 868.8 893.9 894.2 894.7 665.2 665.8 666.7 666.8 667.7 15059.5 15099.4 15100.0 15123.0 15127.8 13814.3 13935.7 14084.4 14192.0 14308.0 12647.0 12656.2 12739.9 12806.7 12823.0 4083.6 4095.5 4198.0 4259.3 4299.1 71247.6 97511.0 113707.4 116137.0 119004.0 11741.2 11760.2 11781.2 11873.6 12230.1 24264.8 24535.8 24575.3 24582.5 24697.4 8333.7 8333.9 8514.6 8574.6 8716.1 4426.6 4435.5 4590.2 4622.2 4767.9 3349.3 3639.8 3669.4 3793.2 3798.7 574.5 681.9 686.9 687.4 689.0 545.4 560.0 586.0 652.8 673.4 8859.3 9346.6 9408.3 9499.6 9584.9 546.4 576.7 604.7 611.4 701.4 4240.9 4561.5 4566.7 4568.0 4659.1 125168.0 127455.0 129676.0 145702.0 170866.0 116435.0 122664.0 126211.0 126251.7 127384.0 82129.6 90674.0 96763.5 97678.0 114022.0 9379.0 9798.4 9836.0 9868.9 10009.2 54747.2 59164.0 60688.1 62359.0 62666.0 85811.1 94852.0 95542.0 96694.0 98635.0 12583.4 13037.2 13077.9 13104.1 13307.7 14041.2 14427.6 14737.8 14810.8 14959.6 13401.2 13635.0 13871.3 14076.6 14145.4 11742.4 11921.1 13786.7 13820.0 14559.2 11509.8 11524.4 11572.6 11853.8 13216.0 9662.1 10105.9 11353.3 11503.4 11903.6 11262.4 11453.3 11564.8 11678.3 11718.8 15:46:26 INFO - PROCESS | 1657 | -------- Summary: end -------- 15:46:26 INFO - PROCESS | 1657 | 15:46:26 INFO - TEST-INFO | 1657: exit 0 15:46:26 INFO - TEST-OK | dromaeo_css | took 1117878ms 15:46:26 INFO - TEST-START | kraken 15:46:26 INFO - operating with platform_type : mac_ 15:46:26 INFO - Initialising browser for kraken test... 15:46:26 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpEDh6AK/profile http://localhost:49277/getInfo.html) 15:46:29 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 15:46:29 INFO - PROCESS | 1668 | colorDepth:24 15:46:29 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 15:46:29 INFO - PROCESS | 1668 | __metrics 15:46:29 INFO - PROCESS | 1668 | 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" 15:46:29 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:46:30 INFO - TEST-INFO | 1668: exit 0 15:46:30 INFO - Browser initialized. 15:46:30 INFO - Running cycle 1/1 for kraken test... 15:46:30 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpEDh6AK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:42 INFO - PROCESS | 1669 | RSS: Main: 232013824 15:46:42 INFO - PROCESS | 1669 | 15:46:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:46 INFO - PROCESS | 1669 | RSS: Main: 291102720 15:46:46 INFO - PROCESS | 1669 | 15:46:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 15:46:49 INFO - PROCESS | 1669 | RSS: Main: 287842304 15:46:49 INFO - PROCESS | 1669 | 15:46:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 15:46:53 INFO - PROCESS | 1669 | RSS: Main: 376782848 15:46:53 INFO - PROCESS | 1669 | 15:46:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 15:46:56 INFO - PROCESS | 1669 | RSS: Main: 278843392 15:46:56 INFO - PROCESS | 1669 | 15:46:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:58 INFO - PROCESS | 1669 | RSS: Main: 282411008 15:46:58 INFO - PROCESS | 1669 | 15:47:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 15:47:02 INFO - PROCESS | 1669 | RSS: Main: 321277952 15:47:02 INFO - PROCESS | 1669 | 15:47:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 15:47:05 INFO - PROCESS | 1669 | RSS: Main: 322457600 15:47:05 INFO - PROCESS | 1669 | 15:47:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 15:47:09 INFO - PROCESS | 1669 | RSS: Main: 322502656 15:47:09 INFO - PROCESS | 1669 | 15:47:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:11 INFO - PROCESS | 1669 | RSS: Main: 297775104 15:47:11 INFO - PROCESS | 1669 | 15:47:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:13 INFO - PROCESS | 1669 | RSS: Main: 302845952 15:47:13 INFO - PROCESS | 1669 | 15:47:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:16 INFO - PROCESS | 1669 | RSS: Main: 300929024 15:47:16 INFO - PROCESS | 1669 | 15:47:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:20 INFO - PROCESS | 1669 | RSS: Main: 318873600 15:47:20 INFO - PROCESS | 1669 | 15:47:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:24 INFO - PROCESS | 1669 | RSS: Main: 314941440 15:47:24 INFO - PROCESS | 1669 | 15:47:25 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 15:47:26 INFO - PROCESS | 1669 | RSS: Main: 358993920 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | __start_tp_report 15:47:26 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 15:47:26 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 15:47:26 INFO - PROCESS | 1669 | |i|pagename|runs| 15:47:26 INFO - PROCESS | 1669 | |0;ai-astar;114;117;161;112;112;111;111;111;110;123 15:47:26 INFO - PROCESS | 1669 | |1;audio-beat-detection;147;113;128;162;108;130;139;107;164;107 15:47:26 INFO - PROCESS | 1669 | |2;audio-dft;185;183;184;182;185;184;181;181;183;185 15:47:26 INFO - PROCESS | 1669 | |3;audio-fft;78;98;105;160;58;58;57;70;141;57 15:47:26 INFO - PROCESS | 1669 | |4;audio-oscillator;82;83;134;69;71;78;118;67;71;117 15:47:26 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;88;86;89;86;91;85;89;85;89;84 15:47:26 INFO - PROCESS | 1669 | |6;imaging-darkroom;94;98;94;95;93;113;125;95;95;93 15:47:26 INFO - PROCESS | 1669 | |7;imaging-desaturate;86;83;83;85;83;84;109;131;132;83 15:47:26 INFO - PROCESS | 1669 | |8;json-parse-financial;54;53;56;55;54;54;56;55;54;53 15:47:26 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;66;64;66;78;71;67;69;70;69;69 15:47:26 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;84;89;84;86;83;94;83;86;87;84 15:47:26 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;140;140;144;150;150;127;156;155;185;139 15:47:26 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;174;177;179;177;177;188;253;198;177;180 15:47:26 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;59;64;86;69;62;62;85;83;89;88 15:47:26 INFO - PROCESS | 1669 | __end_tp_report 15:47:26 INFO - PROCESS | 1669 | __start_cc_report 15:47:26 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2008 15:47:26 INFO - PROCESS | 1669 | __end_cc_report 15:47:26 INFO - PROCESS | 1669 | __startTimestamp1473115646221__endTimestamp 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | ------- Summary: start ------- 15:47:26 INFO - PROCESS | 1669 | Number of tests: 14 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:118.20 Median:113.00 stddev:15.54 (13.8%) stddev-sans-first:16.41 15:47:26 INFO - PROCESS | 1669 | Values: 114.0 117.0 161.0 112.0 112.0 111.0 111.0 111.0 110.0 123.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:134.50 stddev:22.07 (16.4%) stddev-sans-first:22.58 15:47:26 INFO - PROCESS | 1669 | Values: 147.0 113.0 128.0 162.0 108.0 130.0 139.0 107.0 164.0 107.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.57 (0.9%) stddev-sans-first:1.54 15:47:26 INFO - PROCESS | 1669 | Values: 185.0 183.0 184.0 182.0 185.0 184.0 181.0 181.0 183.0 185.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:88.20 Median:58.00 stddev:37.31 (64.3%) stddev-sans-first:39.39 15:47:26 INFO - PROCESS | 1669 | Values: 78.0 98.0 105.0 160.0 58.0 58.0 57.0 70.0 141.0 57.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:71.00 stddev:24.47 (34.5%) stddev-sans-first:25.82 15:47:26 INFO - PROCESS | 1669 | Values: 82.0 83.0 134.0 69.0 71.0 78.0 118.0 67.0 71.0 117.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.50 stddev:2.30 (2.6%) stddev-sans-first:2.42 15:47:26 INFO - PROCESS | 1669 | Values: 88.0 86.0 89.0 86.0 91.0 85.0 89.0 85.0 89.0 84.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:94.50 stddev:10.75 (11.4%) stddev-sans-first:11.22 15:47:26 INFO - PROCESS | 1669 | Values: 94.0 98.0 94.0 95.0 93.0 113.0 125.0 95.0 95.0 93.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:83.00 stddev:20.36 (24.5%) stddev-sans-first:21.28 15:47:26 INFO - PROCESS | 1669 | Values: 86.0 83.0 83.0 85.0 83.0 84.0 109.0 131.0 132.0 83.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.07 (2.0%) stddev-sans-first:1.13 15:47:26 INFO - PROCESS | 1669 | Values: 54.0 53.0 56.0 55.0 54.0 54.0 56.0 55.0 54.0 53.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:3.84 (5.6%) stddev-sans-first:3.93 15:47:26 INFO - PROCESS | 1669 | Values: 66.0 64.0 66.0 78.0 71.0 67.0 69.0 70.0 69.0 69.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:3.40 (4.0%) stddev-sans-first:3.53 15:47:26 INFO - PROCESS | 1669 | Values: 84.0 89.0 84.0 86.0 83.0 94.0 83.0 86.0 87.0 84.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:150.00 stddev:15.46 (10.3%) stddev-sans-first:16.09 15:47:26 INFO - PROCESS | 1669 | Values: 140.0 140.0 144.0 150.0 150.0 127.0 156.0 155.0 185.0 139.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.00 Median:179.50 stddev:23.92 (13.3%) stddev-sans-first:24.83 15:47:26 INFO - PROCESS | 1669 | Values: 174.0 177.0 179.0 177.0 177.0 188.0 253.0 198.0 177.0 180.0 15:47:26 INFO - PROCESS | 1669 | 15:47:26 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:84.00 stddev:12.47 (14.8%) stddev-sans-first:11.86 15:47:26 INFO - PROCESS | 1669 | Values: 59.0 64.0 86.0 69.0 62.0 62.0 85.0 83.0 89.0 88.0 15:47:26 INFO - PROCESS | 1669 | -------- Summary: end -------- 15:47:26 INFO - PROCESS | 1669 | 15:47:27 INFO - TEST-INFO | 1669: exit 0 15:47:27 INFO - TEST-OK | kraken | took 60092ms 15:47:27 INFO - SUITE-END | took 1177s 15:47:27 INFO - Completed test suite (00:19:38) 15:47:27 INFO - javascript benchmark 15:47:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.7487688423366, 3355.7818741781784, 3369.4440417331143, 3410.403179443597, 3437.5015622734704, 5570.916436253459, 5676.716164191785, 5714.542836573075, 5789.507891829195, 5818.970905145468, 5660.150977353389, 5699.829005129843, 5709.600327977043, 5717.857053573663, 5723.570732195081, 5157.71632560209, 5200.08998425276, 5203.375594928614, 5214.087534681435, 5251.264822924793, 5290.6825590464505, 5300.443453437372, 5303.469653034685, 5304.893902121955, 5310.62825602208, 5215.58275337972, 5239.633225674204, 5253.185756207775, 5282.947170528284, 5304.416514183436, 5336.893262134755, 5339.759710813023, 5361.169018802092, 5367.651102678314, 5389.67661940281, 5127.9230811537855, 5142.897142057138, 5145.228215767627, 5267.973660131714, 5279.5512381447625, 5665.2351932489, 5690.943090569082, 5719.170720245541, 5750.5687073469235, 5758.021136406821, 6210.1616281801835, 6226.844328891769, 6244.906326405107, 6250.15622890913, 6269.341719119518, 5362.570994320445, 6258.311585725566, 6287.088372186053, 6302.149209856657, 6354.078658594524, 5852.4147585241135, 5865.237519122486, 5869.882602348014, 5898.8820223595285, 5915.0, 6299.653519056405, 6306.810795676137, 6315.368463153648, 6319.304876463585, 6321.462675672527, 5945.167676525203, 6102.267727872683, 6110.43725517484, 6242.344553821783, 6260.217472815898, 6280.748770049238, 6310.652914089769, 6328.303886572473, 6335.176427064452, 6350.65071421067, 6227.595206311576, 6273.560850740404, 6283.371662833772, 6294.653794041372, 6299.023651334051, 6069.787557435468, 6110.114033465123, 6115.696722738907, 6284.717187726564, 6291.4023167799905, 4928.654994150446, 4933.235348520985, 4938.38270216223, 4945.109880221523, 4948.4309304429735, 4407.823687052482, 4437.0, 4467.798949047301, 4474.910501789946, 4481.170983368087, 5779.393163717833, 5817.621854579524, 5827.388124246893, 5828.970855145782, 5885.499732522698, 6345.397187267202, 6350.33321501245, 6363.490920726331, 6370.77702280418, 6371.23545174582, 5559.221708960748, 5595.916061259084, 5691.288588926384, 5796.188533605298, 5821.38875418075, 5434.239206511092, 5446.591505637093, 5467.917981230285, 5480.451954804487, 5511.0, 6321.1150438938585, 6375.968120159462, 6377.808665740035, 6390.456811170917, 6391.105245265573, 6130.9791012021615, 6250.312465628686, 6346.270178929482, 6346.4605508532295, 6354.332795056637, 6304.369563043659, 6390.840228994312, 6420.582662126947, 6425.58233714807, 6432.839179020375, 6251.624902505864, 6271.31015588294, 6272.937270627418, 6280.434760871543, 6281.811545653638, 5413.511284396823, 5791.305043394819, 6100.664463454553, 6280.246370435577, 6357.491400687842, 5481.205225242238, 5916.704164791657, 6095.420935011167, 6107.795737660903, 6148.846278842886, 6169.753209871555, 6190.226221722285, 6198.132261483306, 6202.906956395567, 6208.2239720034995, 5858.9414105860105, 6012.368701286302, 6018.337982821974, 6021.277446706424, 6060.515158787374, 5975.37258587842, 6117.431594453822, 6130.948521380091, 6131.63210207389, 6133.1510485532735, 5974.731137098928, 6017.759289628541, 6020.729067192075, 6032.3967603239325, 6070.514358851193], "value": 5734.542456806728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.656202377324, 506.47832732285747, 527.3855957809153, 531.4658767938222, 552.4751486088218, 30459.847700761493, 32027.67972320276, 32042.0, 32076.518852217177, 39585.802070989674, 39643.801780991125, 42274.15451690972, 42281.73154805353, 42294.0, 42341.36487952676, 8236.423450358478, 9556.42661440314, 9728.416295022322, 9736.221102311798, 9743.707688769313, 9584.377015494005, 9677.225821934227, 9690.37012594179, 9691.709248722515, 9693.321467497279, 9659.32384733069, 9729.221662267002, 9733.415995040321, 9733.902660973406, 9737.610495580204, 8138.0, 8966.551672416419, 8996.695479155485, 9713.70858874235, 9725.221982241404, 9559.569819358145, 9611.375260608038, 9614.71155865325, 9617.51912404377, 9626.470544120071, 40249.396259056135, 40645.593544064475, 40663.593364066575, 40704.59295407037, 40715.38926916099, 3321.80069195849, 3462.169079420946, 3504.5794504659348, 3531.640318477379, 3970.82131304092, 22810.88594557033, 24697.753022469726, 30381.088567342795, 30540.0, 31376.37247255065, 3201.5837941067743, 3257.723093537052, 3274.4269752793166, 3316.767826252163, 3343.498475228711, 468155.0, 469034.0, 469285.0, 470616.0, 482380.58809705725, 58699.70650146722, 59051.40948590545, 59153.70423147943, 59234.11148832771, 59256.40743592509, 58325.70837145787, 59026.0, 59694.0, 59765.103523447186, 59892.80214395688, 15768.76346854798, 15848.44530441429, 16071.758923616155, 16074.196290185679, 16109.919450402673, 10319.74200644975, 11407.657770266906, 12545.0, 12567.497300107892, 12572.4342404592, 16230.431934882223, 16252.268647910872, 16289.59276018109, 16310.021398716115, 16326.34694612226, 6855.520113592101, 6876.793696189123, 6886.965565172242, 6961.547499412522, 6987.8602427951155, 880.599327306087, 937.8218138553653, 960.7309953213112, 964.1611797735875, 1009.28340877976, 28029.859850700617, 29114.85442572816, 29379.97170099036, 30036.54945175824, 30057.0, 1008.606643409071, 1097.9011888930036, 1097.9231453798157, 1102.6802227353978, 1131.4908291268962, 12177.208481448677, 15151.015184013224, 15318.387264509294, 15464.204981129033, 15675.372985080698, 648028.7598561978, 650062.0, 650073.2445066639, 652225.471816023, 652724.0, 47850.28224576634, 54771.45228547663, 54836.725816370665, 55055.44944550583, 55081.449185508434, 1229.4098832560421, 1275.6874565731455, 1344.1666166976343, 1365.8019587159806, 1389.5275606293706, 27706.307342316602, 27991.58012629853, 30353.392932140792, 31225.0, 31357.78770882664, 42830.0, 47337.28994065161, 53663.731681342906, 53847.192292114865, 57430.0, 604952.0, 610018.0, 610147.0, 610995.0, 613559.0, 22733.545329093657, 23231.651525226796, 23366.0, 24935.501289973738, 25376.0, 36872.89381318565, 38545.45818167242, 44860.77569612262, 46196.76901615471, 48870.0, 38165.23669526538, 38183.0, 38199.854004379915, 39485.40771888367, 39556.60443395529, 37678.811605941795, 37934.24131517409, 38382.0, 38687.0, 38828.0, 36736.63263367439, 37000.889973300844, 37546.436803447425, 37751.81124094362, 37892.24215515729, 32425.675743242267, 34255.65744342525, 34345.313093738485, 34467.655323446445, 34476.482852757734, 23582.764172358056, 25060.874695626404, 25402.745972540037, 25460.872695636404, 26199.345016374744], "value": 19433.914682977545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.62132896471815, 365.5795834789991, 369.69500162366046, 379.8044007336222, 396.85713143268435, 14372.784408233872, 15035.473758418444, 20558.486037849023, 20955.161793528277, 20981.370558883238, 18556.35052773153, 19248.80751192491, 19311.0, 19324.130414131363, 19356.12897419616, 3426.965730342702, 5885.529157667376, 6075.2405949256345, 6131.3562075982045, 6133.2946711128125, 4251.0, 6429.8714025719455, 6650.667466626674, 6753.493487988396, 6816.659167041653, 6435.420812126908, 6662.733490660367, 6685.331466853324, 6698.363655452748, 6760.560563563353, 6372.0, 6585.868282634345, 6599.076129341896, 6628.304028077031, 6637.966810165943, 5681.943180568224, 5755.107958266475, 5759.942400575983, 5760.0783874579865, 5771.336296325934, 23205.651915221286, 25007.62488562673, 25661.74338256631, 25784.355391115183, 25893.74106258932, 1708.4618345221215, 1975.9604807903904, 2046.3656266557414, 2156.148321413049, 2356.363781778927, 9699.90300096997, 9945.950270248675, 10086.092251697382, 10201.795964080751, 10242.692719218436, 1705.2411676803827, 1849.6393203325356, 1863.1150203653292, 1885.377825317642, 1924.6150769846088, 117166.0, 125635.0, 129014.0, 130855.0371744415, 130997.34501327432, 10610.840837387444, 10887.891121088845, 10986.395748233765, 11016.14434947778, 11115.72210694739, 13865.445382184802, 13891.027628065938, 13906.374213160432, 13917.007843313737, 13936.024478286423, 7913.723019694283, 8162.469439486415, 8205.753827385188, 8273.379496537784, 8278.213569710868, 8147.348212143014, 8177.4684645497855, 8178.7955301117945, 8306.626201820933, 8371.246587807127, 4289.892752681208, 4299.54854740254, 4312.202242585132, 4347.934780978288, 4383.232934236496, 1510.4864346122372, 1880.5486683195934, 1907.54218987442, 1915.6839121545067, 1917.405604262655, 838.266516797802, 886.9822603548022, 919.7516670498928, 993.8459538771502, 1007.5516395204064, 20661.966901654858, 21258.574828503653, 21318.14727410917, 21328.36014919555, 21347.893260533907, 840.8360369727967, 906.2387594420718, 959.6065613098735, 980.9558569864373, 994.2096033653263, 10730.283154695211, 10794.176239134948, 10826.945865270623, 11352.94323528377, 11481.483333250024, 468014.0, 589510.0, 596164.0, 596408.0, 605217.0, 109952.0, 113789.4310528442, 119810.0, 140789.0, 144000.0, 991.7718924647227, 998.7952469743685, 1025.410389026313, 1026.0509029148009, 1027.275770581738, 18590.18901125239, 18733.34433294828, 18955.336563220222, 19048.0, 19377.61244775125, 46333.53666463292, 55737.72131139319, 58188.4181158183, 59027.114593280276, 59595.40404596072, 80883.78674320008, 84044.57977710072, 84374.57812710897, 85423.0, 86644.0, 7003.824904377431, 7559.357454616419, 7653.19641437641, 7802.453828231969, 8199.139090395423, 12134.150609457252, 12468.438920248429, 12794.424250908545, 12846.0, 13066.0, 10720.463976801284, 10953.56185752561, 10988.230823842254, 11262.662120136409, 11366.772664546828, 8426.831463370821, 9266.44401335922, 10799.838002430128, 11047.613333533287, 11242.83135752948, 11167.329960202414, 11228.270162439416, 11290.604828830952, 11413.828792567952, 11504.769904601693, 5467.699276539828, 7852.154743635356, 7912.723054693289, 7962.482438641701, 7992.280694737501, 9220.490860790644, 11211.383373914514, 11241.88758112441, 11295.2658077228, 11344.943275283571], "value": 9476.821569967715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.3071668090931, 1448.5219877440443, 1627.5361521966236, 1835.1374853818718, 1889.7921228664852, 8606.784830379243, 9114.36199466036, 9119.635214591417, 9121.133492318235, 9121.954390228047, 7857.646405911733, 8067.636956336964, 8083.272505474506, 8190.2628763411285, 8880.422772519782, 2176.4014895903633, 2323.7792409721133, 2418.056957786465, 2418.2140804238607, 2427.5751743444916, 2410.3974006498374, 2413.9758602413926, 2414.3239892830034, 2415.2754173747894, 2419.6128619420897, 2369.07606033647, 2420.225527831095, 2422.2127808462233, 2423.9151629692965, 2427.0655797517907, 2384.4277373430336, 2389.832711710181, 2407.241718858554, 2409.289259668402, 2416.081888882231, 1937.680282753344, 2361.2562042956583, 2383.84505007174, 2384.7853693167526, 2388.2477019738726, 8895.688650897187, 9009.279257659371, 9023.639054437881, 9030.142136497088, 9034.548272586344, 5273.314469119028, 5420.864478388033, 5450.182472629137, 5450.945490545084, 5460.863478413032, 3473.3747925373423, 3633.0372451300427, 3674.889753307405, 3675.6691897729334, 3693.593704692482, 971.6939164163266, 1021.4177918586408, 1043.1185648127396, 1066.861308029959, 1091.6015654286127, 11662.941685291604, 11668.649940501798, 11717.472713727817, 11726.472308746126, 11756.529738810437, 4427.313766366218, 4691.225947718656, 4791.544803243686, 4821.710697358169, 4826.203676393356, 10032.598696052222, 10043.045910638477, 10044.0, 10050.246231532665, 10056.64801731936, 5354.678719276856, 5361.437049109865, 5370.8657283567445, 5370.892582148335, 5372.113601255749, 4755.976220118877, 4905.828296009694, 4906.994066216417, 4930.063287975273, 4941.654084214142, 3542.1498840278146, 3642.7085833133287, 3758.342290099222, 3883.37865941448, 3891.163399868985, 1174.7180676637545, 1174.9118816088828, 1175.4651633506735, 1183.355071486042, 1185.946632401544, 873.7466134820958, 881.4843316659826, 882.9823403531893, 893.7586851550045, 918.260800055948, 5594.888102237933, 5644.57665675076, 5907.0, 5984.192134061933, 6077.696115194222, 894.1326912894482, 894.7405252476839, 914.6158613382395, 940.2806852757645, 978.295627148452, 3402.336544373873, 3803.7337386382687, 3860.5560360558334, 3993.800309984489, 4005.819738111792, 10372.688819335432, 10832.837507437394, 10855.620053298255, 10866.67399978002, 10906.945465272782, 10818.513166907507, 10826.971437713404, 10835.729106772395, 10839.078678312275, 10856.34019665187, 7791.610419479003, 8216.958915205385, 8221.630026648934, 8293.626786794608, 8312.418130730912, 5952.76188952437, 5963.490055870456, 5966.612170208922, 6005.159277701038, 6120.204373431426, 8440.704575339834, 9498.762530936781, 9557.569909353957, 9954.751131221778, 10141.84787228207, 9854.359466634933, 10174.643887463903, 10219.029192226726, 10295.845562316721, 10303.587856485656, 8147.551884646401, 8154.470212649812, 8273.0, 8362.331013519026, 8375.497470151811, 7568.621568921642, 7868.331191848528, 8191.75424737235, 8512.531810750468, 8516.91483085186, 7376.483646144933, 7465.925340746523, 7506.361959233526, 7515.323620873929, 7716.807079823049, 7335.083114610674, 7378.852422951403, 7386.593737344498, 7422.997895284067, 7449.553026818408, 6689.765858195135, 6802.421794147553, 6853.348931851466, 6870.20992585859, 6890.345417185359, 4851.830185943475, 4877.561019508261, 4877.975610121926, 4924.039812236722, 4992.400911890596, 4868.391451068616, 4871.2206047032305, 4908.239222920453, 5009.198528235464, 5020.748962551931], "value": 4590.739715513332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8849293022186, 300.7654029856712, 309.3488207323584, 311.7210096963218, 313.3169690075637, 4987.551120399164, 5095.7770135167575, 5440.374356948947, 5462.53568446682, 5462.6995515246645, 4762.97618511907, 4992.950070499294, 5098.413682426522, 5241.0, 5353.678779273237, 2967.940641187175, 3552.4848896909934, 4045.554988951213, 4084.775337356444, 4100.282450571153, 3923.5684074751753, 4079.9592004080023, 4116.34138537834, 4121.505419349667, 4125.422440858282, 3031.5149576067834, 3538.345406099867, 3725.1990821973272, 4088.5707000764937, 4094.2977634761064, 3317.552130462381, 3319.9502007469905, 3655.3002853672906, 4037.37420699792, 4067.2272268268935, 2946.602208701819, 3202.6300537602237, 3231.224506118538, 3530.5233793437815, 3545.290941811648, 4747.786349614275, 5041.9159880625475, 5180.611454140954, 5198.92201616976, 5199.350081239845, 4620.1221767864, 4626.514216007338, 4702.247640377524, 4705.294205869147, 4708.952910470885, 4298.570142985708, 5305.074245058668, 5622.718864056781, 5648.661080335193, 5649.4633009864, 3927.607239276078, 3941.940870886939, 3950.6246906543834, 3956.9802150989062, 3979.652005316848, 5223.876866473726, 5319.0, 5617.325920889479, 5932.881342373172, 5944.256967879015, 3944.0, 3944.3097457944746, 3960.2673505401594, 3968.4245784361106, 3981.960180398217, 3994.7003974702016, 4048.5748996355546, 4064.0, 4068.2066996935314, 4091.202215567995, 4504.887377815581, 4667.533246675305, 4676.830792301925, 4717.292406139107, 4721.055788842176, 4948.678335908155, 5623.831285061455, 5645.633033852787, 5652.9152062719095, 5665.915011274834, 1213.8104657435763, 1340.9597712068653, 1368.3773882883463, 1369.2605992763995, 1377.3526442572174, 755.0863455219137, 780.8711562592222, 880.7974165941869, 889.644142343055, 904.3262769236829, 4661.86014419568, 4666.739980205326, 5186.0, 5190.8183213587345, 5239.266502689627, 4647.419072615923, 4804.903901921942, 5758.395368486333, 5813.970930145322, 5814.186013958049, 4280.571942805756, 5029.823956161516, 5176.0, 5201.425294479257, 5399.812041350897, 3051.6948305169303, 3090.860911258999, 3093.551435041906, 3098.4577698902604, 3120.03437834163, 4895.755212239445, 5364.839054828361, 5920.141579470953, 6125.877482450415, 6141.692915354214, 5495.340559132929, 5968.671723055187, 6014.51883849291, 6040.0, 6054.303755068136, 5743.749625277348, 6060.484858787053, 6115.571909966259, 6137.202163718688, 6140.6929653517145, 4648.581627653527, 4792.904141917073, 5861.241627511815, 5873.676947767914, 5918.881622367615, 4818.7831547581145, 5074.3657042869645, 5805.970970145122, 5831.067029275296, 5839.35767065614, 5092.745362731923, 5587.664740115606, 5656.953463609246, 5737.713114344349, 6130.325664177026, 3612.8374223159494, 3864.1305706215876, 3920.7843568604, 3933.783641899723, 3939.4878665773267, 5332.280142180756, 5375.704336261543, 5594.384617692132, 5848.502877255481, 5854.385289544707, 5113.258577506315, 5177.964407118667, 5318.591097727152, 5455.9454405455435, 5707.315122185364, 4210.389493523483, 4452.5547445255215, 4907.4847141051105, 5331.920021199763, 5741.8564535886935, 4588.632909367309, 5302.39022512416, 5569.331680198402, 5570.5265052470995, 5593.272874526286, 4240.1519696060295, 4535.3650488932235, 5592.748326325243, 5602.831915042555, 5677.687727175045, 4639.025804581076, 5576.302962129734, 5595.209532949417, 5597.916031259453, 5621.606487545996], "value": 4068.1871710747137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.819148829816, 724.0731863215083, 753.4123383760667, 757.5757575757575, 771.2788542712568, 15268.770968435469, 15979.680406391864, 16024.198790060509, 16028.519144425656, 16046.83953160468, 13911.026228164033, 14042.0, 14043.36804843782, 14057.718845623082, 14516.854831451683, 672.495628278791, 692.1140939597299, 703.9401650859683, 821.5317269156568, 832.1512057701141, 840.5419046619577, 850.5364576305928, 850.6597361055566, 850.7277671145235, 851.5742128935532, 897.1656359585616, 898.3307435960219, 898.5597057441872, 899.8875140607424, 900.0234745301356, 705.1819888928869, 868.8436081505326, 893.946363218209, 894.2309613732152, 894.7405252476807, 665.1585744033753, 665.7569986954775, 666.7299743603849, 666.8499587592802, 667.7429189761928, 15059.548213553611, 15099.396024159021, 15100.0, 15123.01700389471, 15127.773083403648, 13814.309284535833, 13935.721285574333, 14084.366203520865, 14192.0, 14308.0, 12647.0, 12656.17734847232, 12739.936300318532, 12806.679833004157, 12822.974162067012, 4083.591640835922, 4095.5494895561465, 4198.03445207604, 4259.2759230930815, 4299.097189590189, 71247.64376178138, 97511.0, 113707.43146284299, 116137.0, 119004.0, 11741.236819606698, 11760.23558468714, 11781.234219775859, 11873.584424545272, 12230.082743794252, 24264.757352426248, 24535.754642453703, 24575.262742117764, 24582.508349832904, 24697.382565435648, 8333.749987500385, 8333.916520869783, 8514.616842242114, 8574.571271436404, 8716.128387161232, 4426.623736982393, 4435.489918659331, 4590.173768721662, 4622.214223581932, 4767.928481072787, 3349.330133973215, 3639.763415377992, 3669.3945498992366, 3793.203427280247, 3798.6581207691443, 574.471486232667, 681.8568100698809, 686.8660611180871, 687.4397366146575, 689.0491122251261, 545.4191286280098, 559.9776008959597, 585.9912101318483, 652.8302641313293, 673.441043933534, 8859.335549833659, 9346.600200192275, 9408.294377921684, 9499.572519236652, 9584.90415095854, 546.3607579132424, 576.685706290073, 604.694629212245, 611.4099893602606, 701.400302741149, 4240.85157019509, 4561.498235194126, 4566.74882881438, 4567.977160114178, 4659.068186362673, 125168.0, 127454.98997555223, 129676.0, 145702.0, 170866.0, 116435.0, 122664.0, 126211.0, 126251.73748262583, 127384.0, 82129.58935205286, 90674.0, 96763.51618242005, 97678.0, 114022.0, 9379.0, 9798.363106398061, 9836.0, 9868.851967220355, 10009.199264059003, 54747.17879231894, 59164.0, 60688.05527640689, 62359.0, 62666.0, 85811.14188858031, 94852.0, 95542.0, 96694.0, 98635.0, 12583.370831458573, 13037.217766934014, 13077.934610326887, 13104.082714209913, 13307.733845323233, 14041.1575305482, 14427.639309017359, 14737.778933316224, 14810.777838332218, 14959.551213463614, 13401.195928244337, 13635.0, 13871.306434678427, 14076.577702668936, 14145.43418263258, 11742.354170520703, 11921.105917056082, 13786.724265514835, 13820.0, 14559.19924404168, 11509.827352589886, 11524.423778811193, 11572.594959176726, 11853.762924741284, 13216.0, 9662.130408263009, 10105.9494702526, 11353.262037967506, 11503.424828758361, 11903.583374581847, 11262.436878156223, 11453.312801231952, 11564.826527602261, 11678.299302041905, 11718.824217636571], "value": 7795.209226379393, "unit": "score"}], "name": "dromaeo_css", "value": 7319.470811748971, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 161.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0, 123.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 128.0, 162.0, 108.0, 130.0, 139.0, 107.0, 164.0, 107.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 184.0, 182.0, 185.0, 184.0, 181.0, 181.0, 183.0, 185.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 98.0, 105.0, 160.0, 58.0, 58.0, 57.0, 70.0, 141.0, 57.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 134.0, 69.0, 71.0, 78.0, 118.0, 67.0, 71.0, 117.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 91.0, 85.0, 89.0, 85.0, 89.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 94.0, 95.0, 93.0, 113.0, 125.0, 95.0, 95.0, 93.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 83.0, 85.0, 83.0, 84.0, 109.0, 131.0, 132.0, 83.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 55.0, 54.0, 54.0, 56.0, 55.0, 54.0, 53.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 78.0, 71.0, 67.0, 69.0, 70.0, 69.0, 69.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 84.0, 86.0, 83.0, 94.0, 83.0, 86.0, 87.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 144.0, 150.0, 150.0, 127.0, 156.0, 155.0, 185.0, 139.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 179.0, 177.0, 177.0, 188.0, 253.0, 198.0, 177.0, 180.0], "value": 188.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 86.0, 69.0, 62.0, 62.0, 85.0, 83.0, 89.0, 88.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1512.3999999999999, "alertThreshold": 2.0}]} 15:47:27 INFO - Return code: 0 15:47:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:47:27 INFO - # TBPL SUCCESS # 15:47:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:47:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:47:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:47:27 INFO - 2016-09-05 15:47:27.516 screenresolution[1673:9861] starting screenresolution argv=screenresolution get 15:47:27 INFO - 2016-09-05 15:47:27.519 screenresolution[1673:9861] Display 0: 1600x1200x32@60 15:47:27 INFO - 2016-09-05 15:47:27.525 screenresolution[1674:9864] starting screenresolution argv=screenresolution list 15:47:27 INFO - Available Modes on Display 0 15:47:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:47:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:47:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:47:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:47:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:47:27 INFO - Intel Iris: 15:47:27 INFO - Chipset Model: Intel Iris 15:47:27 INFO - Type: GPU 15:47:27 INFO - Bus: Built-In 15:47:27 INFO - VRAM (Dynamic, Max): 1536 MB 15:47:27 INFO - Vendor: Intel (0x8086) 15:47:27 INFO - Device ID: 0x0a2e 15:47:27 INFO - Revision ID: 0x0009 15:47:27 INFO - Displays: 15:47:27 INFO - Display: 15:47:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:47:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:47:27 INFO - Display Serial Number: 1600x1200 60 15:47:27 INFO - Main Display: Yes 15:47:27 INFO - Mirror: Off 15:47:27 INFO - Online: Yes 15:47:27 INFO - Rotation: Supported 15:47:27 INFO - Return code: 0 15:47:27 INFO - Running post-action listener: _resource_record_post_action 15:47:27 INFO - [mozharness: 2016-09-05 22:47:27.759248Z] Finished run-tests step (success) 15:47:27 INFO - Running post-run listener: _resource_record_post_run 15:47:27 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 37475328; Write bytes: 704714240; Read time: 239; Write time: 1925 15:47:27 INFO - TinderboxPrint: CPU usage
53.5% 15:47:27 INFO - TinderboxPrint: I/O read bytes / time
37,475,328 / 239 15:47:27 INFO - TinderboxPrint: I/O write bytes / time
704,714,240 / 1,925 15:47:27 INFO - TinderboxPrint: CPU idle
2,259.2 (46.5%) 15:47:27 INFO - TinderboxPrint: CPU system
970.9 (20.0%) 15:47:27 INFO - TinderboxPrint: CPU user
1,623.6 (33.5%) 15:47:27 INFO - TinderboxPrint: Swap in / out
443,195,392 / 0 15:47:27 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392073728; Write bytes: 386115072; Read time: 29241; Write time: 773 15:47:27 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35664896; Write bytes: 295686144; Read time: 222; Write time: 1096 15:47:28 INFO - Running post-run listener: _upload_blobber_files 15:47:28 INFO - Blob upload gear active. 15:47:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:28 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 15:47:28 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'] 15:47:28 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 15:47:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:47:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:47:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:29 INFO - (blobuploader) - INFO - Done attempting. 15:47:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:47:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:47:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:30 INFO - (blobuploader) - INFO - Done attempting. 15:47:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:47:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:47:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:33 INFO - (blobuploader) - INFO - Done attempting. 15:47:33 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:33 INFO - Return code: 0 15:47:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1e23f7bb87abcacb170499d50c36a7ee60352ca82ec514441959bac57a33d8212b8654898a2219b09b67d23175370989820e9b7da0c133d82a2228729e45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f00a106788f3291fa01c056f9cfe213f76b7245ab129e7b4838d6eb2be234372e1c46b58770d74af44ebeac6d732f74567e6b2deeeb638d398a2d633f931a71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b362cabe9a10ddda131c6d2f679d91c89e4995747ca0293e2ca1ec86077944476261682932df47c771f0b874c1e84dfdb5226f42a8b6833e58e53caa83dccc0"} 15:47:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:33 INFO - Contents: 15:47:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1e23f7bb87abcacb170499d50c36a7ee60352ca82ec514441959bac57a33d8212b8654898a2219b09b67d23175370989820e9b7da0c133d82a2228729e45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f00a106788f3291fa01c056f9cfe213f76b7245ab129e7b4838d6eb2be234372e1c46b58770d74af44ebeac6d732f74567e6b2deeeb638d398a2d633f931a71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b362cabe9a10ddda131c6d2f679d91c89e4995747ca0293e2ca1ec86077944476261682932df47c771f0b874c1e84dfdb5226f42a8b6833e58e53caa83dccc0"} 15:47:33 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:33 INFO - Copying logs to upload dir... 15:47:33 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.995887 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-05 15:47:33.228313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 15:47:33.231682) ========= 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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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/df1e23f7bb87abcacb170499d50c36a7ee60352ca82ec514441959bac57a33d8212b8654898a2219b09b67d23175370989820e9b7da0c133d82a2228729e45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f00a106788f3291fa01c056f9cfe213f76b7245ab129e7b4838d6eb2be234372e1c46b58770d74af44ebeac6d732f74567e6b2deeeb638d398a2d633f931a71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b362cabe9a10ddda131c6d2f679d91c89e4995747ca0293e2ca1ec86077944476261682932df47c771f0b874c1e84dfdb5226f42a8b6833e58e53caa83dccc0"} build_url:https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/FTKLTS84QNa6wx1Ax6DMSQ/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/df1e23f7bb87abcacb170499d50c36a7ee60352ca82ec514441959bac57a33d8212b8654898a2219b09b67d23175370989820e9b7da0c133d82a2228729e45df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f00a106788f3291fa01c056f9cfe213f76b7245ab129e7b4838d6eb2be234372e1c46b58770d74af44ebeac6d732f74567e6b2deeeb638d398a2d633f931a71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b362cabe9a10ddda131c6d2f679d91c89e4995747ca0293e2ca1ec86077944476261682932df47c771f0b874c1e84dfdb5226f42a8b6833e58e53caa83dccc0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 15:47:33.265590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:47:33.265919) ========= 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.KuLioLQ7Am/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.Hb6XB0MXVs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.005118 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 15:47:33.315321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 15:47:33.315706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 15:47:33.316047) ========= ========= Total master_lag: 0.17 =========