builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0190 starttime: 1476482014.72 results: success (0) buildid: 20161014113435 builduid: 75916f184960469db5485af04577c845 revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.718600) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.719257) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.719698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.745726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.746074) ========= 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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-10-14 14:53:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 55.6M=0s 2016-10-14 14:53:34 (55.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.865080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.865409) ========= 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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.028130 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:34.914588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-14 14:53:34.914930) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e412b386433b8c8ba83a28a1df310d9ad0b20285 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e412b386433b8c8ba83a28a1df310d9ad0b20285 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VC6eEdvGXm/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.9hUjz5ttOC/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-10-14 14:53:34,987 truncating revision to first 12 chars 2016-10-14 14:53:34,988 Setting DEBUG logging. 2016-10-14 14:53:34,988 attempt 1/10 2016-10-14 14:53:34,988 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e412b386433b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 14:53:36,197 unpacking tar archive at: fx-team-e412b386433b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.463503 ========= master_lag: 2.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-14 14:53:38.414746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:38.415127) ========= script_repo_revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:38.415567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:38.415835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 14:53:38.448210) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-14 14:53:38.448603) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VC6eEdvGXm/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.9hUjz5ttOC/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:53:38 INFO - MultiFileLogger online at 20161014 14:53:38 in /builds/slave/test 14:53:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:53:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:38 INFO - {'append_to_log': False, 14:53:38 INFO - 'base_work_dir': '/builds/slave/test', 14:53:38 INFO - 'blob_upload_branch': 'Fx-Team', 14:53:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:38 INFO - 'branch': 'Fx-Team', 14:53:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:38 INFO - 'config_files': ('talos/mac_config.py',), 14:53:38 INFO - 'default_actions': ('clobber', 14:53:38 INFO - 'read-buildbot-config', 14:53:38 INFO - 'download-and-extract', 14:53:38 INFO - 'populate-webroot', 14:53:38 INFO - 'create-virtualenv', 14:53:38 INFO - 'install', 14:53:38 INFO - 'run-tests'), 14:53:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:38 INFO - 'download_minidump_stackwalk': True, 14:53:38 INFO - 'download_symbols': 'ondemand', 14:53:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:38 INFO - 'installer_path': 'installer.exe', 14:53:38 INFO - 'log_level': 'info', 14:53:38 INFO - 'log_name': 'talos', 14:53:38 INFO - 'log_to_console': True, 14:53:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:53:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:53:38 INFO - 'opt_config_files': (), 14:53:38 INFO - 'pip_index': False, 14:53:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:38 INFO - 'cmd': ('bash', 14:53:38 INFO - '-c', 14:53:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:38 INFO - 'enabled': True, 14:53:38 INFO - 'halt_on_failure': False, 14:53:38 INFO - 'name': 'check_screen_resolution'},), 14:53:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:38 INFO - 'cmd': ('bash', 14:53:38 INFO - '-c', 14:53:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:38 INFO - 'enabled': True, 14:53:38 INFO - 'halt_on_failure': False, 14:53:38 INFO - 'name': 'check_screen_resolution'},), 14:53:38 INFO - 'run_cmd_checks_enabled': True, 14:53:38 INFO - 'sps_profile': False, 14:53:38 INFO - 'sps_profile_interval': 0, 14:53:38 INFO - 'suite': 'dromaeojs-e10s', 14:53:38 INFO - 'system_bits': '32', 14:53:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:38 INFO - 'title': 't-yosemite-r7-0190', 14:53:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:38 INFO - 'use_talos_json': True, 14:53:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:38 INFO - 'work_dir': 'build'} 14:53:38 INFO - [mozharness: 2016-10-14 21:53:38.651371Z] Running clobber step. 14:53:38 INFO - Running pre-action listener: _resource_record_pre_action 14:53:38 INFO - Running main action method: clobber 14:53:38 INFO - rmtree: /builds/slave/test/build 14:53:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:40 INFO - Running post-action listener: _resource_record_post_action 14:53:40 INFO - [mozharness: 2016-10-14 21:53:40.850695Z] Finished clobber step (success) 14:53:40 INFO - [mozharness: 2016-10-14 21:53:40.850820Z] Running read-buildbot-config step. 14:53:40 INFO - Running pre-action listener: _resource_record_pre_action 14:53:40 INFO - Running main action method: read_buildbot_config 14:53:40 INFO - Using buildbot properties: 14:53:40 INFO - { 14:53:40 INFO - "project": "", 14:53:40 INFO - "product": "firefox", 14:53:40 INFO - "script_repo_revision": "production", 14:53:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:53:40 INFO - "repository": "", 14:53:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:53:40 INFO - "buildid": "20161014113435", 14:53:40 INFO - "pgo_build": "False", 14:53:40 INFO - "basedir": "/builds/slave/test", 14:53:40 INFO - "buildnumber": 13, 14:53:40 INFO - "slavename": "t-yosemite-r7-0190", 14:53:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:53:40 INFO - "platform": "yosemite_r7", 14:53:40 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 14:53:40 INFO - "branch": "fx-team", 14:53:40 INFO - "repo_path": "integration/fx-team", 14:53:40 INFO - "revision": "e412b386433b8c8ba83a28a1df310d9ad0b20285", 14:53:40 INFO - "stage_platform": "macosx64", 14:53:40 INFO - "builduid": "75916f184960469db5485af04577c845", 14:53:40 INFO - "slavebuilddir": "test" 14:53:40 INFO - } 14:53:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:53:40 INFO - Running post-action listener: _resource_record_post_action 14:53:40 INFO - [mozharness: 2016-10-14 21:53:40.854230Z] Finished read-buildbot-config step (success) 14:53:40 INFO - [mozharness: 2016-10-14 21:53:40.854337Z] Running download-and-extract step. 14:53:40 INFO - Running pre-action listener: _resource_record_pre_action 14:53:40 INFO - Running main action method: download_and_extract 14:53:40 INFO - mkdir: /builds/slave/test/build/tests 14:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:40 INFO - trying https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:53:40 INFO - Downloading https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:53:41 INFO - Downloaded 1199 bytes. 14:53:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:53:41 INFO - Using the following test package requirements: 14:53:41 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:53:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:53:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:53:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'jsshell-mac.zip'], 14:53:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:53:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:53:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:53:41 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:53:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:53:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:53:41 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:53:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:53:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:53:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:53:41 INFO - Fetch https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:53:42 INFO - Http code: 200 14:53:42 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 14:53:42 INFO - x-amz-cf-id: 0ClbwnalSaQIvo4-n4-t_bBCKWijYLccHzpIYbj30-mMCm-Gf1wBVA== 14:53:42 INFO - x-amz-version-id: h5Snv4xcH1aJMhl7BCFWvSuEfLqR.Zs3 14:53:42 INFO - Expected file size: 16516949 14:53:42 INFO - Obtained file size: 16516949 14:53:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:53:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:53:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:53:49 INFO - Fetch https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:53:50 INFO - Http code: 200 14:53:50 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 14:53:50 INFO - x-amz-cf-id: EftoGOfeu0sqeLNuQACcYUqL9zAOqMVxKWQguC1gg2K84v0ccSH4rg== 14:53:50 INFO - x-amz-version-id: h5Snv4xcH1aJMhl7BCFWvSuEfLqR.Zs3 14:53:50 INFO - Expected file size: 16516949 14:53:50 INFO - Obtained file size: 16516949 14:53:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:53:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:53:56 INFO - Fetch https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:53:57 INFO - Http code: 200 14:53:57 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 14:53:57 INFO - x-amz-cf-id: rn5cnxGNXAPlPmCAwRUO1yKWwBKM7ItLF5NZ_3uGfwcXzBzF0QZaOQ== 14:53:57 INFO - x-amz-version-id: gQg885wke6I6oJxK8TovlYZqRf9.Ggyx 14:53:57 INFO - Expected file size: 14409006 14:53:57 INFO - Obtained file size: 14409006 14:53: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')]} 14:53:58 INFO - trying https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:53:58 INFO - Downloading https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:54:01 INFO - Downloaded 111919021 bytes. 14:54:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:54:01 INFO - mkdir: /builds/slave/test/properties 14:54:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:54:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:54:01 INFO - Contents: 14:54:01 INFO - build_url:https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:54:01 INFO - Running post-action listener: _resource_record_post_action 14:54:01 INFO - Running post-action listener: set_extra_try_arguments 14:54:01 INFO - [mozharness: 2016-10-14 21:54:01.761616Z] Finished download-and-extract step (success) 14:54:01 INFO - [mozharness: 2016-10-14 21:54:01.761753Z] Running populate-webroot step. 14:54:01 INFO - Running pre-action listener: _resource_record_pre_action 14:54:01 INFO - Running main action method: populate_webroot 14:54:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:54:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:54:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:54:01 INFO - '--tppagecycles', 14:54:01 INFO - '7'], 14:54:01 INFO - 'tests': ['tsvgm']}}, 14:54:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:54:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:54:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:54:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:54:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['damp', 'tps']}, 14:54:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'tests': ['damp', 'tps']}, 14:54:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['dromaeo_dom']}, 14:54:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:54:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['basic_compositor_video']}, 14:54:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:54:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['a11yr', 14:54:01 INFO - 'ts_paint', 14:54:01 INFO - 'tpaint', 14:54:01 INFO - 'sessionrestore', 14:54:01 INFO - 'sessionrestore_no_auto_restore', 14:54:01 INFO - 'tabpaint']}, 14:54:01 INFO - 'other-e10s': {'tests': ['a11yr', 14:54:01 INFO - 'ts_paint', 14:54:01 INFO - 'tpaint', 14:54:01 INFO - 'sessionrestore', 14:54:01 INFO - 'sessionrestore_no_auto_restore', 14:54:01 INFO - 'tabpaint']}, 14:54:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:54:01 INFO - 'ts_paint', 14:54:01 INFO - 'tpaint', 14:54:01 INFO - 'sessionrestore', 14:54:01 INFO - 'sessionrestore_no_auto_restore', 14:54:01 INFO - 'tabpaint']}, 14:54:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:54:01 INFO - 'ts_paint', 14:54:01 INFO - 'tpaint', 14:54:01 INFO - 'sessionrestore', 14:54:01 INFO - 'sessionrestore_no_auto_restore', 14:54:01 INFO - 'tabpaint']}, 14:54:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['a11yr', 14:54:01 INFO - 'ts_paint', 14:54:01 INFO - 'tpaint', 14:54:01 INFO - 'sessionrestore', 14:54:01 INFO - 'sessionrestore_no_auto_restore', 14:54:01 INFO - 'tabpaint']}, 14:54:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['a11yr', 14:54:01 INFO - 'ts_paint', 14:54:01 INFO - 'tpaint', 14:54:01 INFO - 'sessionrestore', 14:54:01 INFO - 'sessionrestore_no_auto_restore', 14:54:01 INFO - 'tabpaint']}, 14:54:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['tsvgx', 14:54:01 INFO - 'tsvgr_opacity', 14:54:01 INFO - 'tart', 14:54:01 INFO - 'tscrollx', 14:54:01 INFO - 'cart']}, 14:54:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:54:01 INFO - 'tsvgr_opacity', 14:54:01 INFO - 'tart', 14:54:01 INFO - 'tscrollx', 14:54:01 INFO - 'cart']}, 14:54:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'talos_options': ['--disable-e10s'], 14:54:01 INFO - 'tests': ['tp5o']}, 14:54:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'tests': ['tp5o']}, 14:54:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'talos_options': ['--disable-e10s', 14:54:01 INFO - '--xperf_path', 14:54:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:01 INFO - 'tests': ['tp5n']}, 14:54:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:01 INFO - 'talos_options': ['--xperf_path', 14:54:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:01 INFO - 'tests': ['tp5n']}}, 14:54:01 INFO - 'talos.zip': {'path': '', 14:54:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:54:01 INFO - Running post-action listener: _resource_record_post_action 14:54:01 INFO - [mozharness: 2016-10-14 21:54:01.780262Z] Finished populate-webroot step (success) 14:54:01 INFO - [mozharness: 2016-10-14 21:54:01.780380Z] Running create-virtualenv step. 14:54:01 INFO - Running pre-action listener: _resource_record_pre_action 14:54:01 INFO - Running main action method: create_virtualenv 14:54:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:54:01 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 14:54:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:54:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:54:01 INFO - Using real prefix '/tools/python27' 14:54:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:54:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:54:05 INFO - Installing pip.................done. 14:54:05 INFO - Return code: 0 14:54:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:54:05 INFO - Reading from file tmpfile_stdout 14:54:05 INFO - Output received: 14:54:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:54:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:54:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:05 INFO - 'HOME': '/Users/cltbld', 14:54:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:05 INFO - 'LOGNAME': 'cltbld', 14:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:05 INFO - 'MOZ_NO_REMOTE': '1', 14:54:05 INFO - 'NO_EM_RESTART': '1', 14:54:05 INFO - 'PAGER': '/bin/cat', 14:54:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:05 INFO - 'PWD': '/builds/slave/test', 14:54:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:05 INFO - 'SHELL': '/bin/bash', 14:54:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:05 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:05 INFO - 'USER': 'cltbld', 14:54:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:05 INFO - 'XPC_FLAGS': '0x0', 14:54:05 INFO - 'XPC_SERVICE_NAME': '0', 14:54:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:06 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 14:54:06 INFO - Cleaning up... 14:54:06 INFO - Return code: 0 14:54:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:54:06 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')]} 14:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:06 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')]} 14:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:06 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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:06 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 14:54:06 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 14:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:06 INFO - 'HOME': '/Users/cltbld', 14:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:06 INFO - 'LOGNAME': 'cltbld', 14:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:06 INFO - 'MOZ_NO_REMOTE': '1', 14:54:06 INFO - 'NO_EM_RESTART': '1', 14:54:06 INFO - 'PAGER': '/bin/cat', 14:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:06 INFO - 'PWD': '/builds/slave/test', 14:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:06 INFO - 'SHELL': '/bin/bash', 14:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:06 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:06 INFO - 'USER': 'cltbld', 14:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:06 INFO - 'XPC_FLAGS': '0x0', 14:54:06 INFO - 'XPC_SERVICE_NAME': '0', 14:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:06 INFO - Downloading/unpacking psutil>=3.1.1 14:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:54:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:09 INFO - Installing collected packages: psutil 14:54:09 INFO - Running setup.py install for psutil 14:54:09 INFO - building 'psutil._psutil_osx' extension 14:54:09 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 14:54:10 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 14:54:10 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 14:54:10 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 14:54:10 INFO - building 'psutil._psutil_posix' extension 14:54:10 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 14:54:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:54:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:54:10 INFO - ^ 14:54:10 INFO - 1 warning generated. 14:54:10 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 14:54:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:10 INFO - Successfully installed psutil 14:54:10 INFO - Cleaning up... 14:54:10 INFO - Return code: 0 14:54:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:10 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 14:54:10 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 14:54:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:10 INFO - 'HOME': '/Users/cltbld', 14:54:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:10 INFO - 'LOGNAME': 'cltbld', 14:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:10 INFO - 'MOZ_NO_REMOTE': '1', 14:54:10 INFO - 'NO_EM_RESTART': '1', 14:54:10 INFO - 'PAGER': '/bin/cat', 14:54:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:10 INFO - 'PWD': '/builds/slave/test', 14:54:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:10 INFO - 'SHELL': '/bin/bash', 14:54:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:10 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:10 INFO - 'USER': 'cltbld', 14:54:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:10 INFO - 'XPC_FLAGS': '0x0', 14:54:10 INFO - 'XPC_SERVICE_NAME': '0', 14:54:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:54:11 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 14:54:11 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 14:54:11 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 14:54:11 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 14:54:11 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 14:54:11 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 14:54:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:54:13 INFO - Installing collected packages: mozsystemmonitor 14:54:13 INFO - Running setup.py install for mozsystemmonitor 14:54:13 INFO - Successfully installed mozsystemmonitor 14:54:13 INFO - Cleaning up... 14:54:13 INFO - Return code: 0 14:54:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54: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==2.5.1'] in /builds/slave/test/build 14:54: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==2.5.1 14:54:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:14 INFO - 'HOME': '/Users/cltbld', 14:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:14 INFO - 'LOGNAME': 'cltbld', 14:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:14 INFO - 'MOZ_NO_REMOTE': '1', 14:54:14 INFO - 'NO_EM_RESTART': '1', 14:54:14 INFO - 'PAGER': '/bin/cat', 14:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:14 INFO - 'PWD': '/builds/slave/test', 14:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:14 INFO - 'SHELL': '/bin/bash', 14:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:14 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:14 INFO - 'USER': 'cltbld', 14:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:14 INFO - 'XPC_FLAGS': '0x0', 14:54:14 INFO - 'XPC_SERVICE_NAME': '0', 14:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:14 INFO - Downloading/unpacking jsonschema==2.5.1 14:54:14 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 14:54:14 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 14:54:14 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 14:54:14 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 14:54:14 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 14:54:14 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 14:54:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:54:16 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 14:54:16 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 14:54:16 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 14:54:16 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 14:54:16 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 14:54:16 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 14:54:17 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:17 INFO - warning: no files found matching '*.txt' 14:54:17 INFO - no previously-included directories found matching 'build' 14:54:17 INFO - no previously-included directories found matching 'dist' 14:54:17 INFO - no previously-included directories found matching '.git*' 14:54:17 INFO - Installing collected packages: jsonschema, functools32 14:54:17 INFO - Running setup.py install for functools32 14:54:17 INFO - warning: no files found matching '*.txt' 14:54:17 INFO - no previously-included directories found matching 'build' 14:54:17 INFO - no previously-included directories found matching 'dist' 14:54:17 INFO - no previously-included directories found matching '.git*' 14:54:17 INFO - Successfully installed jsonschema functools32 14:54:17 INFO - Cleaning up... 14:54:17 INFO - Return code: 0 14:54:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:17 INFO - 'HOME': '/Users/cltbld', 14:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:17 INFO - 'LOGNAME': 'cltbld', 14:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:17 INFO - 'MOZ_NO_REMOTE': '1', 14:54:17 INFO - 'NO_EM_RESTART': '1', 14:54:17 INFO - 'PAGER': '/bin/cat', 14:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:17 INFO - 'PWD': '/builds/slave/test', 14:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:17 INFO - 'SHELL': '/bin/bash', 14:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:17 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:17 INFO - 'USER': 'cltbld', 14:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:17 INFO - 'XPC_FLAGS': '0x0', 14:54:17 INFO - 'XPC_SERVICE_NAME': '0', 14:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:54:17 INFO - Cleaning up... 14:54:17 INFO - Return code: 0 14:54:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:17 INFO - 'HOME': '/Users/cltbld', 14:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:17 INFO - 'LOGNAME': 'cltbld', 14:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:17 INFO - 'MOZ_NO_REMOTE': '1', 14:54:17 INFO - 'NO_EM_RESTART': '1', 14:54:17 INFO - 'PAGER': '/bin/cat', 14:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:17 INFO - 'PWD': '/builds/slave/test', 14:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:17 INFO - 'SHELL': '/bin/bash', 14:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:17 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:17 INFO - 'USER': 'cltbld', 14:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:17 INFO - 'XPC_FLAGS': '0x0', 14:54:17 INFO - 'XPC_SERVICE_NAME': '0', 14:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:17 INFO - Downloading/unpacking blobuploader==1.2.4 14:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:20 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54:20 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 14:54:20 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 14:54:20 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 14:54:20 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 14:54:20 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 14:54:20 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 14:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54:21 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 14:54:21 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 14:54:21 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 14:54:21 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 14:54:21 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 14:54:21 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 14:54:21 INFO - Downloading docopt-0.6.1.tar.gz 14:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:21 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:21 INFO - Running setup.py install for blobuploader 14:54:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:21 INFO - Running setup.py install for requests 14:54:22 INFO - Running setup.py install for docopt 14:54:22 INFO - Successfully installed blobuploader requests docopt 14:54:22 INFO - Cleaning up... 14:54:22 INFO - Return code: 0 14:54:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54: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')]} 14:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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')]} 14:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:22 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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:22 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 14:54:22 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 14:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:22 INFO - 'HOME': '/Users/cltbld', 14:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:22 INFO - 'LOGNAME': 'cltbld', 14:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:22 INFO - 'MOZ_NO_REMOTE': '1', 14:54:22 INFO - 'NO_EM_RESTART': '1', 14:54:22 INFO - 'PAGER': '/bin/cat', 14:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:22 INFO - 'PWD': '/builds/slave/test', 14:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:22 INFO - 'SHELL': '/bin/bash', 14:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:22 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:22 INFO - 'USER': 'cltbld', 14:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:22 INFO - 'XPC_FLAGS': '0x0', 14:54:22 INFO - 'XPC_SERVICE_NAME': '0', 14:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:22 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-y2tEA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-CnHMyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-eCLAdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-itEN_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-gtYy4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-2ef8JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-_yomLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-npvtOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-D3qVRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-72On60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:23 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-OhZuzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:24 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-3ErlLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:24 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-rCa9lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:24 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Vt6ee1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:24 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-n9DukB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:24 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-f16c6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:24 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-sMht5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:24 INFO - Running setup.py install for manifestparser 14:54:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:24 INFO - Running setup.py install for mozcrash 14:54:24 INFO - Running setup.py install for mozdebug 14:54:25 INFO - Running setup.py install for mozdevice 14:54:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Running setup.py install for mozfile 14:54:25 INFO - Running setup.py install for mozhttpd 14:54:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Running setup.py install for mozinfo 14:54:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Running setup.py install for mozInstall 14:54:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:25 INFO - Running setup.py install for mozleak 14:54:25 INFO - Running setup.py install for mozlog 14:54:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:26 INFO - Running setup.py install for moznetwork 14:54:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:26 INFO - Running setup.py install for mozprocess 14:54:26 INFO - Running setup.py install for mozprofile 14:54:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:26 INFO - Running setup.py install for mozrunner 14:54:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:26 INFO - Running setup.py install for mozscreenshot 14:54:26 INFO - Running setup.py install for moztest 14:54:27 INFO - Running setup.py install for mozversion 14:54:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:27 INFO - Cleaning up... 14:54:27 INFO - Return code: 0 14:54:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:27 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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:27 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 14:54:27 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 14:54:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:27 INFO - 'HOME': '/Users/cltbld', 14:54:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:27 INFO - 'LOGNAME': 'cltbld', 14:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:27 INFO - 'MOZ_NO_REMOTE': '1', 14:54:27 INFO - 'NO_EM_RESTART': '1', 14:54:27 INFO - 'PAGER': '/bin/cat', 14:54:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:27 INFO - 'PWD': '/builds/slave/test', 14:54:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:27 INFO - 'SHELL': '/bin/bash', 14:54:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:27 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:27 INFO - 'USER': 'cltbld', 14:54:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:27 INFO - 'XPC_FLAGS': '0x0', 14:54:27 INFO - 'XPC_SERVICE_NAME': '0', 14:54:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:27 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-9glPNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:27 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)) 14:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:27 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-8UkPvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:27 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)) 14:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:27 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-hH8qax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:27 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)) 14:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:27 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-gtF7JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:27 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)) 14:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:27 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-7E2fYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Oc0IN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-YkUZ8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-hybsB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-XMXSXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-breRkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-oszlQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-8FARef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-_CR0BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:28 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)) 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:28 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-I2KNFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:29 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)) 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:29 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-TwYc7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:29 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)) 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:29 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-BJnz2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:29 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)) 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:29 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-aNCbf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:29 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)) 14:54:29 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)) 14:54:29 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)) 14:54:29 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)) 14:54:29 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)) 14:54:29 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)) 14:54:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:31 INFO - Downloading blessings-1.6.tar.gz 14:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:54:31 INFO - Installing collected packages: blessings 14:54:31 INFO - Running setup.py install for blessings 14:54:32 INFO - Successfully installed blessings 14:54:32 INFO - Cleaning up... 14:54:32 INFO - Return code: 0 14:54:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:54:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:32 INFO - Reading from file tmpfile_stdout 14:54:32 INFO - Current package versions: 14:54:32 INFO - blessings == 1.6 14:54:32 INFO - blobuploader == 1.2.4 14:54:32 INFO - docopt == 0.6.1 14:54:32 INFO - functools32 == 3.2.3-2 14:54:32 INFO - jsonschema == 2.5.1 14:54:32 INFO - manifestparser == 1.1 14:54:32 INFO - mozInstall == 1.12 14:54:32 INFO - mozcrash == 0.17 14:54:32 INFO - mozdebug == 0.1 14:54:32 INFO - mozdevice == 0.48 14:54:32 INFO - mozfile == 1.2 14:54:32 INFO - mozhttpd == 0.7 14:54:32 INFO - mozinfo == 0.9 14:54:32 INFO - mozleak == 0.1 14:54:32 INFO - mozlog == 3.4 14:54:32 INFO - moznetwork == 0.27 14:54:32 INFO - mozprocess == 0.23 14:54:32 INFO - mozprofile == 0.28 14:54:32 INFO - mozrunner == 6.12 14:54:32 INFO - mozscreenshot == 0.1 14:54:32 INFO - mozsystemmonitor == 0.3 14:54:32 INFO - moztest == 0.7 14:54:32 INFO - mozversion == 1.4 14:54:32 INFO - psutil == 3.1.1 14:54:32 INFO - requests == 1.2.3 14:54:32 INFO - wsgiref == 0.1.2 14:54:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:32 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')]} 14:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:32 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')]} 14:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:33 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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:33 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 14:54:33 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 14:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:33 INFO - 'HOME': '/Users/cltbld', 14:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:33 INFO - 'LOGNAME': 'cltbld', 14:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:33 INFO - 'MOZ_NO_REMOTE': '1', 14:54:33 INFO - 'NO_EM_RESTART': '1', 14:54:33 INFO - 'PAGER': '/bin/cat', 14:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:33 INFO - 'PWD': '/builds/slave/test', 14:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:33 INFO - 'SHELL': '/bin/bash', 14:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:33 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:33 INFO - 'USER': 'cltbld', 14:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:33 INFO - 'XPC_FLAGS': '0x0', 14:54:33 INFO - 'XPC_SERVICE_NAME': '0', 14:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 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)) 14:54:33 INFO - Cleaning up... 14:54:33 INFO - Return code: 0 14:54:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:33 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 0x106c37490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaabd5c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, '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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 14:54:33 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 14:54:33 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 14:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:33 INFO - 'HOME': '/Users/cltbld', 14:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:33 INFO - 'LOGNAME': 'cltbld', 14:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:33 INFO - 'MOZ_NO_REMOTE': '1', 14:54:33 INFO - 'NO_EM_RESTART': '1', 14:54:33 INFO - 'PAGER': '/bin/cat', 14:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:33 INFO - 'PWD': '/builds/slave/test', 14:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:33 INFO - 'SHELL': '/bin/bash', 14:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:54:33 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:33 INFO - 'USER': 'cltbld', 14:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:33 INFO - 'XPC_FLAGS': '0x0', 14:54:33 INFO - 'XPC_SERVICE_NAME': '0', 14:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:54:33 INFO - Cleaning up... 14:54:33 INFO - Return code: 0 14:54:33 INFO - Running post-action listener: _resource_record_post_action 14:54:33 INFO - Running post-action listener: _start_resource_monitoring 14:54:33 INFO - Starting resource monitoring. 14:54:34 INFO - [mozharness: 2016-10-14 21:54:34.000888Z] Finished create-virtualenv step (success) 14:54:34 INFO - [mozharness: 2016-10-14 21:54:34.001882Z] Running install step. 14:54:34 INFO - Running pre-action listener: _resource_record_pre_action 14:54:34 INFO - Running main action method: install 14:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:34 INFO - Reading from file tmpfile_stdout 14:54:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:34 INFO - Reading from file tmpfile_stdout 14:54:34 INFO - Output received: 14:54:34 INFO - Usage: mozinstall [options] installer 14:54:34 INFO - Options: 14:54:34 INFO - -h, --help show this help message and exit 14:54:34 INFO - -d DEST, --destination=DEST 14:54:34 INFO - Directory to install application into. [default: 14:54:34 INFO - "/builds/slave/test"] 14:54:34 INFO - --app=APP Application being installed. [default: firefox] 14:54:34 INFO - mkdir: /builds/slave/test/build/application 14:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:55:09 INFO - Reading from file tmpfile_stdout 14:55:09 INFO - Output received: 14:55:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:55:09 INFO - Running post-action listener: _resource_record_post_action 14:55:09 INFO - [mozharness: 2016-10-14 21:55:09.203495Z] Finished install step (success) 14:55:09 INFO - [mozharness: 2016-10-14 21:55:09.203709Z] Running run-tests step. 14:55:09 INFO - Running pre-action listener: _resource_record_pre_action 14:55:09 INFO - Running main action method: run_tests 14:55:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:55:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:55:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:55:09 INFO - 2016-10-14 14:55:09.218 screenresolution[1645:7862] starting screenresolution argv=screenresolution get 14:55:09 INFO - 2016-10-14 14:55:09.220 screenresolution[1645:7862] Display 0: 1600x1200x32@60 14:55:09 INFO - 2016-10-14 14:55:09.226 screenresolution[1646:7864] starting screenresolution argv=screenresolution list 14:55:09 INFO - Available Modes on Display 0 14:55:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:55:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:55:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:55:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:55:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:55:09 INFO - Intel Iris: 14:55:09 INFO - Chipset Model: Intel Iris 14:55:09 INFO - Type: GPU 14:55:09 INFO - Bus: Built-In 14:55:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:55:09 INFO - Vendor: Intel (0x8086) 14:55:09 INFO - Device ID: 0x0a2e 14:55:09 INFO - Revision ID: 0x0009 14:55:09 INFO - Displays: 14:55:09 INFO - Display: 14:55:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:55:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:55:09 INFO - Display Serial Number: 1600x1200 60 14:55:09 INFO - Main Display: Yes 14:55:09 INFO - Mirror: Off 14:55:09 INFO - Online: Yes 14:55:09 INFO - Rotation: Supported 14:55:09 INFO - Return code: 0 14:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:55:09 INFO - Python 2.7.3 14:55:09 INFO - Return code: 0 14:55:09 INFO - grabbing minidump binary from tooltool 14:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:09 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 0x106a4bd30>, '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 0x106871db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a43b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:55:09 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 14:55:09 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 14:55:09 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 14:55:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:55:09 INFO - Return code: 0 14:55:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:55:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:55:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:55:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:55:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VC6eEdvGXm/Render', 14:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:09 INFO - 'HOME': '/Users/cltbld', 14:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:09 INFO - 'LOGNAME': 'cltbld', 14:55:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:55:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:09 INFO - 'MOZ_NO_REMOTE': '1', 14:55:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:55:09 INFO - 'NO_EM_RESTART': '1', 14:55:09 INFO - 'PAGER': '/bin/cat', 14:55:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:09 INFO - 'PWD': '/builds/slave/test', 14:55:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:09 INFO - 'SHELL': '/bin/bash', 14:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9hUjz5ttOC/Listeners', 14:55:09 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 14:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:09 INFO - 'USER': 'cltbld', 14:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:09 INFO - 'XPC_FLAGS': '0x0', 14:55:09 INFO - 'XPC_SERVICE_NAME': '0', 14:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:55:09 INFO - mozversion application_buildid: 20161014113435 14:55:09 INFO - mozversion application_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 14:55:09 INFO - mozversion application_display_name: Nightly 14:55:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:55:09 INFO - mozversion application_name: Firefox 14:55:09 INFO - mozversion application_remotingname: firefox 14:55:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:55:09 INFO - mozversion application_vendor: Mozilla 14:55:09 INFO - mozversion application_version: 52.0a1 14:55:09 INFO - mozversion platform_buildid: 20161014113435 14:55:09 INFO - mozversion platform_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 14:55:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:55:09 INFO - mozversion platform_version: 52.0a1 14:55:09 INFO - using testdate: 1476482109 14:55:09 INFO - actual date: 1476482109 14:55:09 INFO - starting webserver on 'localhost:49267' 14:55:09 INFO - SUITE-START | Running 2 tests 14:55:09 INFO - TEST-START | dromaeo_css 14:55:09 INFO - operating with platform_type : mac_ 14:55:09 INFO - Initialising browser for dromaeo_css test... 14:55:09 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmp6h4QJv/profile http://localhost:49267/getInfo.html) 14:55:12 INFO - PROCESS | 1656 | 2016-10-14 14:55:12.554 plugin-container[1658:8037] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 14:55:12 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:55:12 INFO - PROCESS | 1656 | 2016-10-14 14:55:12.557 plugin-container[1658:8037] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a1f, name = 'com.apple.CFPasteboardClient' 14:55:12 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:55:12 INFO - PROCESS | 1656 | 2016-10-14 14:55:12.557 plugin-container[1658:8037] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:55:12 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 14:55:12 INFO - PROCESS | 1656 | colorDepth:24 14:55:12 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 14:55:12 INFO - PROCESS | 1656 | __metrics 14:55:12 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:55:13 INFO - TEST-INFO | 1656: exit 0 14:55:13 INFO - Browser initialized. 14:55:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:55:13 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmp6h4QJv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:15 INFO - PROCESS | 1659 | 2016-10-14 14:55:15.869 plugin-container[1660:8155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 14:55:15 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:55:15 INFO - PROCESS | 1659 | 2016-10-14 14:55:15.870 plugin-container[1660:8155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 14:55:15 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:55:15 INFO - PROCESS | 1659 | 2016-10-14 14:55:15.870 plugin-container[1660:8155] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:55:25 INFO - PROCESS | 1659 | RSS: Main: 237498368 14:55:25 INFO - PROCESS | 1659 | 14:56:15 INFO - PROCESS | 1659 | 1476482175143 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] 14:58:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 14:58:30 INFO - PROCESS | 1659 | RSS: Main: 250744832 14:58:30 INFO - PROCESS | 1659 | 15:01:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 15:01:33 INFO - PROCESS | 1659 | RSS: Main: 264495104 15:01:33 INFO - PROCESS | 1659 | 15:04:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 15:04:36 INFO - PROCESS | 1659 | RSS: Main: 269004800 15:04:36 INFO - PROCESS | 1659 | 15:07:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 15:07:38 INFO - PROCESS | 1659 | RSS: Main: 268488704 15:07:38 INFO - PROCESS | 1659 | 15:10:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 15:10:41 INFO - PROCESS | 1659 | RSS: Main: 273907712 15:10:41 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 15:13:45 INFO - PROCESS | 1659 | RSS: Main: 276623360 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | __start_tp_report 15:13:45 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 15:13:45 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 15:13:45 INFO - PROCESS | 1659 | |i|pagename|runs| 15:13:45 INFO - PROCESS | 1659 | |0;dojo.html;3347.3138006708627;3358.7313014958804;3370.730341572674;3375.8143302118374;3387.7120444762186;5628.77484900604;5643.548516118706;5680.545556355492;5729.39841316662;5731.885362292752;4109.4041364002205;4214.599613036757;4909.779059942302;5145.845624631258;5667.716614169285;5162.561182299509;5190.506901844319;5210.478952104778;5266.104762190418;5274.314339135926;5161.974190129063;5190.351206099238;5253.44838791927;5294.1529355303155;5306.044911915854;5246.029484545352;5261.657992230531;5277.498637629419;5290.841274761763;5356.9732151339185;5096.413912400084;5124.538791508782;5130.281760553526;5186.455422180655;5213.765380557846;4333.393324934512;4961.131801934683;5093.770780314858;5143.434222235551;5183.663061901002;5426.484483974016;5626.324841019063;5649.774009039634;5667.3482549506925;5693.345265294462;6008.218931538872;6020.8494787630225;6115.027386288435;6126.7440174764515;6167.013277875519;6234.283057448406;6237.688115594202;6258.655773932432;6262.3111457739615;6273.435390814849;4807.351007613997;5747.568932330092;5753.424657534297;5758.971205144031;5789.565782566325;6122.418370254819;6144.893919094606;6168.8766224675255;6189.690515474208;6207.162033125561;5424.891502169935;6071.967765479791;6098.91636565712;6103.186149163621;6122.448979591858;6095.4818840398175;6206.10011548332;6209.379062093845;6215.751369945152;6220.7511699531515;6019.578629495893;6090.147379366892;6136.417040381157;6154.476869466145;6186.721597528122;6145.938540614537;6156.5998210117095;6180.536459765535;6188.9690551546955;6220.844478888064;4895.192293271642;4903.53416425439;4905.386826646669;4918.581920536794;4932.482089380635;4312.460942382202;4319.97840010798;4392.780360981938;4414.713043652152;4451.243288640939;5612.326520817528;5777.19119323295;5800.477956983892;5812.215350927655;5835.066389377679;6205;6208.906866397007;6244.937550624436;6247.156633854372;6290.182276304051;5599.972000140055;5670.943290567124;5773.624714393551;5778.595498315161;5787.074068149076;5317.574594032468;5348.197770334403;5387.6228663993925;5397.622166448311;5450.5367043801725;5533.170024496358;6256.812295631138;6275.3724627537795;6287.654179020198;6310.652914089769;6231.40801623845;6270.12218289449;6275.937240627718;6301.747930082745;6305.90541141874;6168.814935551941;6184.659843708459;6191.473724733448;6209.565330426827;6227.252729672468;4550.544945505423;4579.908401832011;5326.8014696692935;5911.940880591139;6177.62934223948;4906.411230652345;5239.633225674166;5610.747516361856;6133.601315914451;6165.660888651168;5996.37038110992;6073.696315184135;6076.78731244422;6082.878342433038;6116.816495505142;5802.100674395476;5957.880842383041;6003.6998150093195;6032;6040.486558642565;5054;5641.971790141023;5916.230889984275;5929.0513517836935;5949.494292985145;6046.002409602366;6063.939360606514;6076.54425918049;6084.239470066242;6102.877942441215;5731.484166425042;5793.15999180125;5798.0143375627085;5801.6519008859605;5882.647041177543 15:13:45 INFO - PROCESS | 1659 | |1;ext.html;471.32835709114505;487.191262504243;495.98570922463557;508.4280184792109;533.1363191629558;38886;40508.59491405089;40512.39231411528;43322.35016474748;43483.912902177464;41841;41977.58022419775;42268.78865605676;42364.57635423645;42389.15221695564;9494.620215191402;9592.664256751015;9665.178459830888;9695;9710.174635155985;9490.572924218426;9494.240460763122;9524.80950380992;9555.378900371488;9598.136167744902;9565.617375305013;9591.712248632517;9594.28042896782;9599.32804703671;9601.567929443157;9549;9560.187384072397;9581.185599224074;9584.137427631547;9588.808223835484;9503.952480237554;9517.666881659177;9596.23230141594;9608.903910960871;9628.374155679858;35588.46617300742;39952;40094;40225.79322620326;40291.19417611661;3045.4365942300747;3113.579666745006;3492.3713731528314;3897.57126716061;4097.590240975908;30640.710151136165;30764.69235307663;31286.374272514422;31417.685823141706;31612;3191.1543440988157;3204.5033019881957;3228.9031329060167;3319.535265062869;3344.013516012782;484205;486139;486439;486700;487832;58240.41759582435;58275.41724582785;58496.70751646299;58617;58665.70667146637;60478.697606512564;60966.56133754689;61106.38893611096;61288.080678789855;61325.693371532856;14361.353739081558;14363.138211707332;16153.676926461405;16159.838401616069;16174.867759256975;12097.274163550039;12456.128071035122;12511.624651260478;12581.930535904368;12643;12660.81008784869;12869.806952895715;13129.409176587076;15711.21443927799;15856.207189640472;3137.13728724598;5227.503387178212;6024.90962635552;6161.630302181794;6164.630122192682;857.7555396711907;940;971.6744890461774;985.3693636072919;1132.088668621751;28716.994905178635;28751.712482875322;29877.10368688943;30214.54678179829;31046.844765776477;1031.4739482863642;1038.2732087538602;1082.875469321038;1083.766990097133;1136.579465597734;15676.137812420198;15723;15780.895337326278;15815.683686326209;16270.349186032427;661646;663102;666517;670372;670468.6476567585;55350;55612.443875561534;55779.721101395044;55818.72090639521;55892.72053639706;1327.9269640169884;1369.431685850361;1384.065755614976;1386.4800699737598;1389.0415613227044;28619.713802862538;29063.85468072646;29573.556396653636;29617.407651847272;30265.394692105594;49405.75297123491;49433.51699449022;49751.25373119478;49928.500714992384;49996.75008124826;588769;592658;593089;593766;595319;26234.60648090242;26261.737382625928;26430.339241519116;26583;26613.93544258208;46869.765651171525;47693.80765480752;47828.04343913172;47865.76067119642;47868.80327991689;32420.83789581037;38779;39636.80181599074;40494;40924;36527;38403.65587204434;39268.80365598268;39308;39642.60357396389;37300.694475694305;37678.811605941795;37764.05589860275;38015;38655.42016869693;28575.714242858136;33113.50329745104;34273.65726342705;34357.656423435445;34366.82816585901;25302.240932772045;25672.229833105037;26162.73837261603;26513;26531.938722450886 15:13:45 INFO - PROCESS | 1659 | |2;jquery.html;365.5668033380443;372.5306114295987;375.6300044456211;378.93368660484407;391.9647231749142;15290.847091529082;18667.759868815745;19806.207751689915;20361.898190509026;20608.484787880312;19843.60312793747;19884.40346789595;20243.39269821904;20330.288439904605;20560.794392056076;5717.542596592262;5729.1119876419225;5973.492253158487;6012.488938440216;6031.185789918371;5881.500072493843;5966.761329546813;6079.544034197431;6082.847928801771;6089.817305480843;5874.3244526879525;5947.702614869261;6015.0676645120075;6053.51571874249;6059.545534084939;5883.14694369314;5979.073243647242;5990.131430942511;6015.57890947636;6181.96909015452;4517.435320584927;5220.2430647556275;5644.74598643062;5875.1187321901625;5899;13042.673933151747;13263.66840828987;13339.799903001463;20699.17203311866;24740;1803.6302557975714;1999.9200031998703;2195.9341219763432;2575.72954839741;2583.844969301829;7708.768736937901;9933.552990115462;9970.551325190383;10430.947845260802;14631.634209144857;1676;1843.2442698493687;1852.722091686258;1880.586271020387;1929.7684277886744;115628;117197.65604687859;118300.40849795696;122858;123686;11230.956855532002;11349.829752553718;11419.942900285612;11494.252873563359;11528.711782205512;14439.267287925517;14473.565793026226;14474.493392731203;14494.782578261334;14530.636734081521;8326.542040187727;8455.577221138918;8461.915380846236;8495.617697203641;8610.268127209258;8295.62669679866;8374.623141958626;8408.369372297102;8512.233898949124;8590.312774977987;4540.818367265339;4546.636269098464;4547.499775024745;4547.567981041796;4636.165490211727;1715.9018228333875;1878.126671097946;1889.1687657430687;1917.83698385636;1978.5943881504256;881.5724373678761;921.8663293822358;930.4882314726873;977.6236149082512;992.0823238504355;16050.438234661964;20537.2811951581;21073.78926210749;21153.36539903805;21204.469888252916;912.2975309012023;931.993447077155;946.9715908522755;965.9420434773796;968.874046373981;10726.356418614752;11101.666949991513;11160.107191424666;11191.552337906392;11194.944025279821;531635;533243;538993;539579;544216;79322.6033869827;114211;123853.86427123728;126448;129186;871.6034204436966;886.2909672262165;929.5027160469117;930.1582068228264;957.1003256938594;15392.153431561372;18234.270629175215;18398.356057537923;18836.811631884055;19319.90340048291;38902.610973889896;52205.69485762886;54476;54495.455045450624;58717.70641146767;80722;81024.78462822945;81858.54424367279;83610.58194708987;83803.5809820947;6568.671566421755;7506.1743208248145;7768.096816280047;8122.350211982909;8176.591170441573;9393.812123757623;10069.949650251701;10637.308574942605;11022.228444008842;12458.32146088559;8966.327525435488;9214.723558292993;10740.30188037775;10778.245522813328;10840.241183117107;10075.546600402853;10131.08820206185;10457.320274182153;10698.251122421356;10883.183761217782;10628;10650.414227217267;11015.944920275668;11032.172587055842;11154.609588664358;7843.6862525498345;7921.247481489249;8039.557824319719;8133.389995750224;8191.79520511992;10359.689209323733;10568.89431105679;10832.295900766425;10904;10917.83623245636 15:13:45 INFO - PROCESS | 1659 | |3;mootools.html;1424.5655075202062;1509.7131545006444;1726.1024267380963;1730.8269173082701;1886.999999999999;7933.880991785113;8167.224113709203;8369.246767790897;8930.91069089309;8936;7476.214997425273;8381.580920953958;8692.174243446863;8733.650653973833;8792.956035219831;2339.5671800716877;2365.6215005599106;2367.9289621311386;2368.656544801003;2371.5731168389684;2336.147306233221;2355.646653002055;2369.052379048386;2375.156819329139;2386.868722220277;2362.492064206195;2371.27676058802;2371.419002344428;2381.856708779787;2390.6892104026538;2328.592496313155;2334.101370972171;2337.2403968710237;2340.3330050935488;2347.190219374313;2310.5032418030037;2331.184085570054;2332.090484710964;2340.5903966805913;2342.7774361435636;8871.556422178865;8895.199432051146;8903.020667726545;8912.064233255545;8927.107289271085;5205.27126202332;5310.309659744208;5367.892642147135;5380.408155102936;5390.460953904578;3566.4828599852876;3593.083763640255;3643.6902863256655;3667.5598928128798;3670.963290367089;1052.5684469367523;1053.3153450257316;1055.625253035177;1070.0423121306387;1074.978500429995;11502.654920352403;11575.479103440366;11614.36121013344;11623.709407264801;11643.53425862973;4519.7740112994215;4579.313103034571;4752.310914917318;4770.904581908342;4779.569838714532;9740;9825.115739583473;9832.508374581243;9834.311598188058;9838.508074596242;4856.028794241166;5302.867428314245;5332;5365.946340536622;5366.597505187126;4379.474463064389;4520.299353600197;4694.36626055485;4694.43666759991;4866.7079975201605;3806.3148633246283;3850.8844734658005;3923.9019024524614;3942.8619998300496;3947.032976920673;1287.568664497385;1300.7788675925115;1308.4635299527338;1314.2574445438297;1315.0400207848324;847.9448835825651;918.4856480371013;920.9033051529627;924.2051835421532;957.8323793336139;5707.942920570824;5932.703364831741;5981.312149102821;6034.306054803754;6051.788187413419;417.91759343301;424.8173285487208;426.57768808878984;434.2574198121185;447.4585751241035;3483.6516348365467;3970.225805967866;4017.879463616096;4045.02919299366;4055.614716601918;10234.948825255826;10398.948005259925;10564.154867610572;10567.313124646873;10643.73390665224;10036.849447258297;10311.22665800068;10433.16534677224;10557.049865512141;10632.893671063344;7147.106611673541;7886.3296619786815;8167.346612271004;8224.506529608123;8242.423030387936;5895.7052147391605;5975.37083683178;6080.574359794949;6089.847753806191;6128.325884152829;7962.601869906365;9902.522821245138;10006.44964526958;10057.346272492265;10094.89905100969;9976.60093596277;10000.999900009941;10001.699949001542;10013.098821106136;10021.899781002097;6097.908531372122;6922.5154239202775;7112.253213412517;7251.456140789356;7464.402847772057;8206.466579672302;8456.873146902924;8457.746267611981;8476.194761497647;8487.36344774132;7348.301911318416;7521.699132034657;7548.433867460072;7583.658735357032;7647.808804779925;7325.4872158948365;7338.559686418832;7380.852382952204;7500.399968002655;7507.399408047234;6511.674416279262;6918.100646915868;7059.541129826544;7063.187733410724;7070.222275549789;4265.637420819141;4319.287317592562;4528.750918699503;4574.039451715177;4887.193613053806;4290.592393722592;4954.232094025432;5014.197728363444;5151.304573882628;5212.50481204285 15:13:45 INFO - PROCESS | 1659 | |4;prototype.html;297.9553067039945;300.78343592613317;309.1375063572633;311.93293441910015;315.5613696961223;5437.592180586462;5639.8590035249135;5698.401667824881;5785.714642716124;5827.9999999999945;4814.205656066753;4870.732109733964;5367.677939323643;5460.017196904556;5638.943610563903;3668.963310366889;4359.542248063939;4363.774475017732;4375.6937014409;4382.386465894777;4158.729682570638;4255.659547236213;4300.956990430102;4368.803403846819;4397.802098905541;4280.015596412827;4280.98793567023;4299.742015479082;4305.289627211507;4318.719283246594;3697.2975134724315;4080.6531444827224;4117.75293482392;4314.590113939171;4346.001259131221;3650.8904732858055;3774.2451509697894;3783.3190025795348;3791.279656865187;3794.6964242860504;5087.287779710843;5425.37608175057;5508.476694713996;5531.668099914018;5543.639663421905;4954.628402869799;4955.925661115086;4969.912636692562;4988.114025449968;4993.176125939216;4768.761561921925;5876.382979787104;5923.170756094107;5930.673812940287;5948.31594366649;3444.483327500895;4018.3570628699267;4076.857309994136;4083.9387409188885;4106.240345536055;5492.423295553949;6165.7533698652;6234.379061444012;6308.684565771739;6333.271673757531;3626.2384899170943;3993.6006399360413;4099.651529620016;4120.299549076664;4150.6471949884;3326.8336583170744;3551.7691350062164;3981.402789581586;4037.1118353962083;4183.226103170923;4947.455779864212;4947.455779864212;5008.348914641073;5014.799408023711;5015.874603134951;5060.443351231362;5284.9083286277955;6016.503151192206;6021.337652858182;6065.75736970525;1342.2215115233337;1388.5348408283137;1431.7279716853764;1439.1437094928501;1455.5851582298994;830.7092517618906;835.3359079531787;883.7172104926361;884.9867251991225;891.5364010714392;4703.02472961357;4723.527647235249;4763.618910487153;4765.928511072337;4777.229207059897;4437.829928133688;4816.964352664124;4838.637102217348;5197.454267301954;5203.881165549425;3915.569287378386;4068.7558746475306;4489.367807561767;4618.937644341753;4666.829924085317;2555.198584997572;2659.417646500368;2662.4941261160707;2728.6179934809143;2760.599713041638;4307;4467.7319360838455;5295.431715617922;5320.255164277004;5378.650387724785;4102.353981681798;4305.072550665577;4455.309427038749;4503.954960450419;4527.909441811145;4424.778761061998;4865.7323847188745;5069.721165335942;5264.736763161826;5342.233725223708;4508.774561271989;5124.333836601218;5124.692518448905;5192.532672059533;5210.47895210476;4650.953490465187;4732.810687572459;4798.568128868418;4898.3142360068905;5143.588512918883;4507.791182320705;5321.328283484383;5342.599305052215;5363.946360536344;5449.700266485382;3616.9276614467035;3621.8008009559726;3631.9455208172426;3660.108514273694;3665.2486240321205;4851.005543863429;5164.457731938092;5179.948200517946;5205.843824685266;5567.244214114039;5356.946430535645;5637.830865074055;6003.8198854034445;6045.335013148462;6064.241969753781;5449.863753406196;5522.861928451821;5970.850493822134;6011.849703757441;6024.246969128859;4985.476524964972;5142.665726727751;5144.202648589475;5428.647137936022;5815.854603634943;5777.62445441045;5954.434328738763;5998.760049597967;6027.909581356371;6042.607230530178;5108.59131269505;5188.118019936544;5733.1334332833585;5871.178035075008;5914.2311499504785 15:13:45 INFO - PROCESS | 1659 | |5;yui.html;639.3957709964085;705.8835292176791;732.3408931961237;773.5783997721245;821.2649678537707;15167;15804.209789510536;16070.919645401771;16209.83790162098;16259.430919917806;14733.631659208526;14757;14847.331870065846;14862.777058344134;14900.403983840633;865.3726048614767;878.925291350236;881.1408876345544;881.3301890563187;881.8456770065245;687.8830598798216;706.7385067525023;846.4032856835915;867.8394497018072;875.6497401039571;902.1609902790402;919.5310391700248;926.7961048569304;928.8188803183382;934.9065093490631;893.6604090445654;926.6432423516961;927.1562877781221;927.4342650982962;927.6753136402239;663.8705452436777;667.3726696904894;673.2863165045068;678.8235058884726;690.5304393012749;14940.252987350588;14944.252787360589;14959.551213463614;14965.625859353495;15010.549683509513;14405.567832965027;14474.927625361912;14583.781243281359;14620.195889226088;14661.633459163606;11122.55509779608;11805.822912656316;11880.227785193934;11929.045676345871;11994.220375675553;3745.4569087482164;3797.886063418102;3833.2333533293454;3916.980415097935;3918.4710064141545;116490;117155.41422292919;117915;117946.41026794897;118419.40790295994;10767.83848242277;11057.944710276397;11077;11470.827937580943;11478.139139564566;18599.535011624546;22617.886910565343;22632.886835565718;22692.865356732098;22732.65901011486;6604.702788374535;7023.9815226791825;7219.675114619749;8033.3974951878845;8193.672253109928;4303.33298338758;4411.977940110279;4438.511763705989;4567.543245675406;4572.337011133367;3483.7909725416557;3563.002359339389;3614.963850361515;3619.348517266917;3632.945505817415;631.9905201421982;638.1385130074456;639.7057353617295;651.5276424592133;653.4608947618234;550.7521615273063;589.4341432225026;591.7071049830362;668.5721138471382;696.7979286007103;9033.367664263438;9297.953510232406;9397.90602093984;9406.294527910433;9422.575984080733;649.746598826458;665.1552528289046;668.9832754181184;671.412514050206;687.7249100359796;4305.354196870495;4385.978070109629;4610;4627.190241707688;4718.575328220477;103425;118022;144452;158267;161862.1906890458;111834;113402.43298783453;113928;134195.32902335425;141741.29129354493;65530.34469655338;67196.66401668059;79133.20866791489;110446;112418.43790780994;9206.723798286062;9803.607855685977;9824.557894894604;9859.309848310837;9911.900880991097;46469.76765116153;60558.69720651369;62449.68775156095;63552.682236588524;63576.68211659097;76123;93906.53046734723;98091.52862706923;98724;100333.99666003247;12845.743085138432;12850.336113995425;12886.3523573201;13159.934200328937;13162.01284903617;14405.207713575854;14449.638759031108;14463.638409039859;14536.709265814836;14578.781318280446;11321.547138114383;11372.37451940118;13038.348082595643;13684.178949263076;13821.85912125121;11801.940990295338;13202.933985330395;13738.587842364745;13976.161430314214;14013.738763510924;12971.5459958901;13179.802302965654;13211.14127581704;13356.465741370237;13862.098963567336;11078.390688512209;11239.943800280946;11304.773904521699;11325;11411.771764564495;10161.441120738134;11143.387113708499;11285.984261416184;11309.264897781617;11324.490397931948 15:13:45 INFO - PROCESS | 1659 | __end_tp_report 15:13:45 INFO - PROCESS | 1659 | __start_cc_report 15:13:45 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,358 15:13:45 INFO - PROCESS | 1659 | __end_cc_report 15:13:45 INFO - PROCESS | 1659 | __startTimestamp1476483225280__endTimestamp 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | ------- Summary: start ------- 15:13:45 INFO - PROCESS | 1659 | Number of tests: 6 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5617.56 Median:5789.57 stddev:666.54 (11.5%) stddev-sans-first:644.35 15:13:45 INFO - PROCESS | 1659 | Values: 3347.3 3358.7 3370.7 3375.8 3387.7 5628.8 5643.5 5680.5 5729.4 5731.9 4109.4 4214.6 4909.8 5145.8 5667.7 5162.6 5190.5 5210.5 5266.1 5274.3 5162.0 5190.4 5253.4 5294.2 5306.0 5246.0 5261.7 5277.5 5290.8 5357.0 5096.4 5124.5 5130.3 5186.5 5213.8 4333.4 4961.1 5093.8 5143.4 5183.7 5426.5 5626.3 5649.8 5667.3 5693.3 6008.2 6020.8 6115.0 6126.7 6167.0 6234.3 6237.7 6258.7 6262.3 6273.4 4807.4 5747.6 5753.4 5759.0 5789.6 6122.4 6144.9 6168.9 6189.7 6207.2 5424.9 6072.0 6098.9 6103.2 6122.4 6095.5 6206.1 6209.4 6215.8 6220.8 6019.6 6090.1 6136.4 6154.5 6186.7 6145.9 6156.6 6180.5 6189.0 6220.8 4895.2 4903.5 4905.4 4918.6 4932.5 4312.5 4320.0 4392.8 4414.7 4451.2 5612.3 5777.2 5800.5 5812.2 5835.1 6205.0 6208.9 6244.9 6247.2 6290.2 5600.0 5670.9 5773.6 5778.6 5787.1 5317.6 5348.2 5387.6 5397.6 5450.5 5533.2 6256.8 6275.4 6287.7 6310.7 6231.4 6270.1 6275.9 6301.7 6305.9 6168.8 6184.7 6191.5 6209.6 6227.3 4550.5 4579.9 5326.8 5911.9 6177.6 4906.4 5239.6 5610.7 6133.6 6165.7 5996.4 6073.7 6076.8 6082.9 6116.8 5802.1 5957.9 6003.7 6032.0 6040.5 5054.0 5642.0 5916.2 5929.1 5949.5 6046.0 6063.9 6076.5 6084.2 6102.9 5731.5 5793.2 5798.0 5801.7 5882.6 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:70918.42 Median:40501.30 stddev:156945.99 (387.5%) stddev-sans-first:157297.14 15:13:45 INFO - PROCESS | 1659 | Values: 471.3 487.2 496.0 508.4 533.1 38886.0 40508.6 40512.4 43322.4 43483.9 41841.0 41977.6 42268.8 42364.6 42389.2 9494.6 9592.7 9665.2 9695.0 9710.2 9490.6 9494.2 9524.8 9555.4 9598.1 9565.6 9591.7 9594.3 9599.3 9601.6 9549.0 9560.2 9581.2 9584.1 9588.8 9504.0 9517.7 9596.2 9608.9 9628.4 35588.5 39952.0 40094.0 40225.8 40291.2 3045.4 3113.6 3492.4 3897.6 4097.6 30640.7 30764.7 31286.4 31417.7 31612.0 3191.2 3204.5 3228.9 3319.5 3344.0 484205.0 486139.0 486439.0 486700.0 487832.0 58240.4 58275.4 58496.7 58617.0 58665.7 60478.7 60966.6 61106.4 61288.1 61325.7 14361.4 14363.1 16153.7 16159.8 16174.9 12097.3 12456.1 12511.6 12581.9 12643.0 12660.8 12869.8 13129.4 15711.2 15856.2 3137.1 5227.5 6024.9 6161.6 6164.6 857.8 940.0 971.7 985.4 1132.1 28717.0 28751.7 29877.1 30214.5 31046.8 1031.5 1038.3 1082.9 1083.8 1136.6 15676.1 15723.0 15780.9 15815.7 16270.3 661646.0 663102.0 666517.0 670372.0 670468.6 55350.0 55612.4 55779.7 55818.7 55892.7 1327.9 1369.4 1384.1 1386.5 1389.0 28619.7 29063.9 29573.6 29617.4 30265.4 49405.8 49433.5 49751.3 49928.5 49996.8 588769.0 592658.0 593089.0 593766.0 595319.0 26234.6 26261.7 26430.3 26583.0 26613.9 46869.8 47693.8 47828.0 47865.8 47868.8 32420.8 38779.0 39636.8 40494.0 40924.0 36527.0 38403.7 39268.8 39308.0 39642.6 37300.7 37678.8 37764.1 38015.0 38655.4 28575.7 33113.5 34273.7 34357.7 34366.8 25302.2 25672.2 26162.7 26513.0 26531.9 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:32660.71 Median:377.28 stddev:90195.72 (23906.7%) stddev-sans-first:90416.14 15:13:45 INFO - PROCESS | 1659 | Values: 365.6 372.5 375.6 378.9 392.0 15290.8 18667.8 19806.2 20361.9 20608.5 19843.6 19884.4 20243.4 20330.3 20560.8 5717.5 5729.1 5973.5 6012.5 6031.2 5881.5 5966.8 6079.5 6082.8 6089.8 5874.3 5947.7 6015.1 6053.5 6059.5 5883.1 5979.1 5990.1 6015.6 6182.0 4517.4 5220.2 5644.7 5875.1 5899.0 13042.7 13263.7 13339.8 20699.2 24740.0 1803.6 1999.9 2195.9 2575.7 2583.8 7708.8 9933.6 9970.6 10430.9 14631.6 1676.0 1843.2 1852.7 1880.6 1929.8 115628.0 117197.7 118300.4 122858.0 123686.0 11231.0 11349.8 11419.9 11494.3 11528.7 14439.3 14473.6 14474.5 14494.8 14530.6 8326.5 8455.6 8461.9 8495.6 8610.3 8295.6 8374.6 8408.4 8512.2 8590.3 4540.8 4546.6 4547.5 4547.6 4636.2 1715.9 1878.1 1889.2 1917.8 1978.6 881.6 921.9 930.5 977.6 992.1 16050.4 20537.3 21073.8 21153.4 21204.5 912.3 932.0 947.0 965.9 968.9 10726.4 11101.7 11160.1 11191.6 11194.9 531635.0 533243.0 538993.0 539579.0 544216.0 79322.6 114211.0 123853.9 126448.0 129186.0 871.6 886.3 929.5 930.2 957.1 15392.2 18234.3 18398.4 18836.8 19319.9 38902.6 52205.7 54476.0 54495.5 58717.7 80722.0 81024.8 81858.5 83610.6 83803.6 6568.7 7506.2 7768.1 8122.4 8176.6 9393.8 10069.9 10637.3 11022.2 12458.3 8966.3 9214.7 10740.3 10778.2 10840.2 10075.5 10131.1 10457.3 10698.3 10883.2 10628.0 10650.4 11015.9 11032.2 11154.6 7843.7 7921.2 8039.6 8133.4 8191.8 10359.7 10568.9 10832.3 10904.0 10917.8 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5631.57 Median:4636.84 stddev:3164.11 (68.2%) stddev-sans-first:3157.20 15:13:45 INFO - PROCESS | 1659 | Values: 1424.6 1509.7 1726.1 1730.8 1887.0 7933.9 8167.2 8369.2 8930.9 8936.0 7476.2 8381.6 8692.2 8733.7 8793.0 2339.6 2365.6 2367.9 2368.7 2371.6 2336.1 2355.6 2369.1 2375.2 2386.9 2362.5 2371.3 2371.4 2381.9 2390.7 2328.6 2334.1 2337.2 2340.3 2347.2 2310.5 2331.2 2332.1 2340.6 2342.8 8871.6 8895.2 8903.0 8912.1 8927.1 5205.3 5310.3 5367.9 5380.4 5390.5 3566.5 3593.1 3643.7 3667.6 3671.0 1052.6 1053.3 1055.6 1070.0 1075.0 11502.7 11575.5 11614.4 11623.7 11643.5 4519.8 4579.3 4752.3 4770.9 4779.6 9740.0 9825.1 9832.5 9834.3 9838.5 4856.0 5302.9 5332.0 5365.9 5366.6 4379.5 4520.3 4694.4 4694.4 4866.7 3806.3 3850.9 3923.9 3942.9 3947.0 1287.6 1300.8 1308.5 1314.3 1315.0 847.9 918.5 920.9 924.2 957.8 5707.9 5932.7 5981.3 6034.3 6051.8 417.9 424.8 426.6 434.3 447.5 3483.7 3970.2 4017.9 4045.0 4055.6 10234.9 10398.9 10564.2 10567.3 10643.7 10036.8 10311.2 10433.2 10557.0 10632.9 7147.1 7886.3 8167.3 8224.5 8242.4 5895.7 5975.4 6080.6 6089.8 6128.3 7962.6 9902.5 10006.4 10057.3 10094.9 9976.6 10001.0 10001.7 10013.1 10021.9 6097.9 6922.5 7112.3 7251.5 7464.4 8206.5 8456.9 8457.7 8476.2 8487.4 7348.3 7521.7 7548.4 7583.7 7647.8 7325.5 7338.6 7380.9 7500.4 7507.4 6511.7 6918.1 7059.5 7063.2 7070.2 4265.6 4319.3 4528.8 4574.0 4887.2 4290.6 4954.2 5014.2 5151.3 5212.5 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4504.40 Median:4884.52 stddev:1362.90 (27.9%) stddev-sans-first:1329.65 15:13:45 INFO - PROCESS | 1659 | Values: 298.0 300.8 309.1 311.9 315.6 5437.6 5639.9 5698.4 5785.7 5828.0 4814.2 4870.7 5367.7 5460.0 5638.9 3669.0 4359.5 4363.8 4375.7 4382.4 4158.7 4255.7 4301.0 4368.8 4397.8 4280.0 4281.0 4299.7 4305.3 4318.7 3697.3 4080.7 4117.8 4314.6 4346.0 3650.9 3774.2 3783.3 3791.3 3794.7 5087.3 5425.4 5508.5 5531.7 5543.6 4954.6 4955.9 4969.9 4988.1 4993.2 4768.8 5876.4 5923.2 5930.7 5948.3 3444.5 4018.4 4076.9 4083.9 4106.2 5492.4 6165.8 6234.4 6308.7 6333.3 3626.2 3993.6 4099.7 4120.3 4150.6 3326.8 3551.8 3981.4 4037.1 4183.2 4947.5 4947.5 5008.3 5014.8 5015.9 5060.4 5284.9 6016.5 6021.3 6065.8 1342.2 1388.5 1431.7 1439.1 1455.6 830.7 835.3 883.7 885.0 891.5 4703.0 4723.5 4763.6 4765.9 4777.2 4437.8 4817.0 4838.6 5197.5 5203.9 3915.6 4068.8 4489.4 4618.9 4666.8 2555.2 2659.4 2662.5 2728.6 2760.6 4307.0 4467.7 5295.4 5320.3 5378.7 4102.4 4305.1 4455.3 4504.0 4527.9 4424.8 4865.7 5069.7 5264.7 5342.2 4508.8 5124.3 5124.7 5192.5 5210.5 4651.0 4732.8 4798.6 4898.3 5143.6 4507.8 5321.3 5342.6 5363.9 5449.7 3616.9 3621.8 3631.9 3660.1 3665.2 4851.0 5164.5 5179.9 5205.8 5567.2 5356.9 5637.8 6003.8 6045.3 6064.2 5449.9 5522.9 5970.9 6011.8 6024.2 4985.5 5142.7 5144.2 5428.6 5815.9 5777.6 5954.4 5998.8 6027.9 6042.6 5108.6 5188.1 5733.1 5871.2 5914.2 15:13:45 INFO - PROCESS | 1659 | 15:13:45 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:23925.98 Median:3617.16 stddev:37860.01 (1046.7%) stddev-sans-first:37925.84 15:13:45 INFO - PROCESS | 1659 | Values: 639.4 705.9 732.3 773.6 821.3 15167.0 15804.2 16070.9 16209.8 16259.4 14733.6 14757.0 14847.3 14862.8 14900.4 865.4 878.9 881.1 881.3 881.8 687.9 706.7 846.4 867.8 875.6 902.2 919.5 926.8 928.8 934.9 893.7 926.6 927.2 927.4 927.7 663.9 667.4 673.3 678.8 690.5 14940.3 14944.3 14959.6 14965.6 15010.5 14405.6 14474.9 14583.8 14620.2 14661.6 11122.6 11805.8 11880.2 11929.0 11994.2 3745.5 3797.9 3833.2 3917.0 3918.5 116490.0 117155.4 117915.0 117946.4 118419.4 10767.8 11057.9 11077.0 11470.8 11478.1 18599.5 22617.9 22632.9 22692.9 22732.7 6604.7 7024.0 7219.7 8033.4 8193.7 4303.3 4412.0 4438.5 4567.5 4572.3 3483.8 3563.0 3615.0 3619.3 3632.9 632.0 638.1 639.7 651.5 653.5 550.8 589.4 591.7 668.6 696.8 9033.4 9298.0 9397.9 9406.3 9422.6 649.7 665.2 669.0 671.4 687.7 4305.4 4386.0 4610.0 4627.2 4718.6 103425.0 118022.0 144452.0 158267.0 161862.2 111834.0 113402.4 113928.0 134195.3 141741.3 65530.3 67196.7 79133.2 110446.0 112418.4 9206.7 9803.6 9824.6 9859.3 9911.9 46469.8 60558.7 62449.7 63552.7 63576.7 76123.0 93906.5 98091.5 98724.0 100334.0 12845.7 12850.3 12886.4 13159.9 13162.0 14405.2 14449.6 14463.6 14536.7 14578.8 11321.5 11372.4 13038.3 13684.2 13821.9 11801.9 13202.9 13738.6 13976.2 14013.7 12971.5 13179.8 13211.1 13356.5 13862.1 11078.4 11239.9 11304.8 11325.0 11411.8 10161.4 11143.4 11286.0 11309.3 11324.5 15:13:45 INFO - PROCESS | 1659 | -------- Summary: end -------- 15:13:45 INFO - PROCESS | 1659 | 15:13:46 INFO - TEST-INFO | 1659: exit 0 15:13:46 INFO - TEST-OK | dromaeo_css | took 1116254ms 15:13:46 INFO - TEST-START | kraken 15:13:46 INFO - operating with platform_type : mac_ 15:13:46 INFO - Initialising browser for kraken test... 15:13:46 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpSa79FO/profile http://localhost:49267/getInfo.html) 15:13:48 INFO - PROCESS | 1667 | 2016-10-14 15:13:48.773 plugin-container[1668:10181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8837, name = 'com.apple.tsm.portname' 15:13:48 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:48 INFO - PROCESS | 1667 | 2016-10-14 15:13:48.776 plugin-container[1668:10181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x895b, name = 'com.apple.CFPasteboardClient' 15:13:48 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:48 INFO - PROCESS | 1667 | 2016-10-14 15:13:48.776 plugin-container[1668:10181] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:13:48 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 15:13:48 INFO - PROCESS | 1667 | colorDepth:24 15:13:48 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 15:13:48 INFO - PROCESS | 1667 | __metrics 15:13:48 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 15:13:49 INFO - TEST-INFO | 1667: exit 0 15:13:49 INFO - Browser initialized. 15:13:49 INFO - Running cycle 1/1 for kraken test... 15:13:49 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpSa79FO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:51 INFO - PROCESS | 1669 | 2016-10-14 15:13:51.871 plugin-container[1670:10292] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 15:13:51 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:51 INFO - PROCESS | 1669 | 2016-10-14 15:13:51.872 plugin-container[1670:10292] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8747, name = 'com.apple.CFPasteboardClient' 15:13:51 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:51 INFO - PROCESS | 1669 | 2016-10-14 15:13:51.872 plugin-container[1670:10292] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:14:01 INFO - PROCESS | 1669 | RSS: Main: 237731840 15:14:01 INFO - PROCESS | 1669 | 15:14:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 15:14:05 INFO - PROCESS | 1669 | RSS: Main: 249831424 15:14:05 INFO - PROCESS | 1669 | 15:14:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 15:14:08 INFO - PROCESS | 1669 | RSS: Main: 258220032 15:14:08 INFO - PROCESS | 1669 | 15:14:11 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 15:14:12 INFO - PROCESS | 1669 | RSS: Main: 260472832 15:14:12 INFO - PROCESS | 1669 | 15:14:14 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 15:14:14 INFO - PROCESS | 1669 | RSS: Main: 261570560 15:14:14 INFO - PROCESS | 1669 | 15:14:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:14:17 INFO - PROCESS | 1669 | RSS: Main: 263008256 15:14:17 INFO - PROCESS | 1669 | 15:14:20 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 15:14:20 INFO - PROCESS | 1669 | RSS: Main: 263467008 15:14:20 INFO - PROCESS | 1669 | 15:14:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 15:14:24 INFO - PROCESS | 1669 | RSS: Main: 263471104 15:14:24 INFO - PROCESS | 1669 | 15:14:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 15:14:28 INFO - PROCESS | 1669 | RSS: Main: 263802880 15:14:28 INFO - PROCESS | 1669 | 15:14:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:14:30 INFO - PROCESS | 1669 | RSS: Main: 263524352 15:14:30 INFO - PROCESS | 1669 | 15:14:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:14:32 INFO - PROCESS | 1669 | RSS: Main: 263622656 15:14:32 INFO - PROCESS | 1669 | 15:14:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:14:35 INFO - PROCESS | 1669 | RSS: Main: 263557120 15:14:35 INFO - PROCESS | 1669 | 15:14:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:39 INFO - PROCESS | 1669 | RSS: Main: 263806976 15:14:39 INFO - PROCESS | 1669 | 15:14:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:42 INFO - PROCESS | 1669 | RSS: Main: 263929856 15:14:42 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 15:14:44 INFO - PROCESS | 1669 | RSS: Main: 265531392 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | __start_tp_report 15:14:44 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 15:14:44 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 15:14:44 INFO - PROCESS | 1669 | |i|pagename|runs| 15:14:44 INFO - PROCESS | 1669 | |0;ai-astar;114;120;121;118;117;121;169;168;118;118 15:14:44 INFO - PROCESS | 1669 | |1;audio-beat-detection;152;113;120;192;123;119;116;118;144;126 15:14:44 INFO - PROCESS | 1669 | |2;audio-dft;192;198;202;221;199;195;193;196;198;195 15:14:44 INFO - PROCESS | 1669 | |3;audio-fft;84;60;59;80;56;59;58;61;79;60 15:14:44 INFO - PROCESS | 1669 | |4;audio-oscillator;95;103;73;94;63;86;74;56;82;117 15:14:44 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;91;90;93;90;92;88;93;90;92;89 15:14:44 INFO - PROCESS | 1669 | |6;imaging-darkroom;99;99;98;100;99;98;97;100;98;98 15:14:44 INFO - PROCESS | 1669 | |7;imaging-desaturate;89;89;87;123;92;132;153;90;88;120 15:14:44 INFO - PROCESS | 1669 | |8;json-parse-financial;57;57;58;55;59;59;58;57;51;47 15:14:44 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;72;76;72;84;76;69;69;72;70;70 15:14:44 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;77;76;95;105;110;87;86;91;98;79 15:14:44 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;147;168;162;165;148;158;141;144;188;148 15:14:44 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;171;173;174;180;175;179;172;171;173;174 15:14:44 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;71;72;84;88;92;88;88;82;69;70 15:14:44 INFO - PROCESS | 1669 | __end_tp_report 15:14:44 INFO - PROCESS | 1669 | __start_cc_report 15:14:44 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,946 15:14:44 INFO - PROCESS | 1669 | __end_cc_report 15:14:44 INFO - PROCESS | 1669 | __startTimestamp1476483284908__endTimestamp 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | ------- Summary: start ------- 15:14:44 INFO - PROCESS | 1669 | Number of tests: 14 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:128.40 Median:120.50 stddev:21.24 (17.6%) stddev-sans-first:21.87 15:14:44 INFO - PROCESS | 1669 | Values: 114.0 120.0 121.0 118.0 117.0 121.0 169.0 168.0 118.0 118.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:124.50 stddev:24.46 (19.6%) stddev-sans-first:24.89 15:14:44 INFO - PROCESS | 1669 | Values: 152.0 113.0 120.0 192.0 123.0 119.0 116.0 118.0 144.0 126.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:198.90 Median:198.00 stddev:8.31 (4.2%) stddev-sans-first:8.43 15:14:44 INFO - PROCESS | 1669 | Values: 192.0 198.0 202.0 221.0 199.0 195.0 193.0 196.0 198.0 195.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:10.78 (17.8%) stddev-sans-first:9.15 15:14:44 INFO - PROCESS | 1669 | Values: 84.0 60.0 59.0 80.0 56.0 59.0 58.0 61.0 79.0 60.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:78.00 stddev:18.63 (23.9%) stddev-sans-first:19.35 15:14:44 INFO - PROCESS | 1669 | Values: 95.0 103.0 73.0 94.0 63.0 86.0 74.0 56.0 82.0 117.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:91.50 stddev:1.69 (1.8%) stddev-sans-first:1.79 15:14:44 INFO - PROCESS | 1669 | Values: 91.0 90.0 93.0 90.0 92.0 88.0 93.0 90.0 92.0 89.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:98.60 Median:98.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 15:14:44 INFO - PROCESS | 1669 | Values: 99.0 99.0 98.0 100.0 99.0 98.0 97.0 100.0 98.0 98.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:106.30 Median:88.50 stddev:23.77 (26.9%) stddev-sans-first:24.37 15:14:44 INFO - PROCESS | 1669 | Values: 89.0 89.0 87.0 123.0 92.0 132.0 153.0 90.0 88.0 120.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.50 stddev:3.88 (6.8%) stddev-sans-first:4.09 15:14:44 INFO - PROCESS | 1669 | Values: 57.0 57.0 58.0 55.0 59.0 59.0 58.0 57.0 51.0 47.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:72.00 stddev:4.62 (6.4%) stddev-sans-first:4.88 15:14:44 INFO - PROCESS | 1669 | Values: 72.0 76.0 72.0 84.0 76.0 69.0 69.0 72.0 70.0 70.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:86.50 stddev:11.66 (13.5%) stddev-sans-first:11.32 15:14:44 INFO - PROCESS | 1669 | Values: 77.0 76.0 95.0 105.0 110.0 87.0 86.0 91.0 98.0 79.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:156.90 Median:160.00 stddev:14.37 (9.0%) stddev-sans-first:14.79 15:14:44 INFO - PROCESS | 1669 | Values: 147.0 168.0 162.0 165.0 148.0 158.0 141.0 144.0 188.0 148.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:3.08 (1.8%) stddev-sans-first:3.05 15:14:44 INFO - PROCESS | 1669 | Values: 171.0 173.0 174.0 180.0 175.0 179.0 172.0 171.0 173.0 174.0 15:14:44 INFO - PROCESS | 1669 | 15:14:44 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:86.00 stddev:8.95 (10.4%) stddev-sans-first:8.82 15:14:44 INFO - PROCESS | 1669 | Values: 71.0 72.0 84.0 88.0 92.0 88.0 88.0 82.0 69.0 70.0 15:14:44 INFO - PROCESS | 1669 | -------- Summary: end -------- 15:14:44 INFO - PROCESS | 1669 | 15:14:45 INFO - TEST-INFO | 1669: exit 0 15:14:45 INFO - TEST-OK | kraken | took 59693ms 15:14:45 INFO - SUITE-END | took 1175s 15:14:46 INFO - Completed test suite (00:19:36) 15:14:46 INFO - javascript benchmark 15:14:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7227.892415459925, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.3138006708627, 3358.7313014958804, 3370.730341572674, 3375.8143302118374, 3387.7120444762186, 5628.77484900604, 5643.548516118706, 5680.545556355492, 5729.39841316662, 5731.885362292752, 4109.4041364002205, 4214.599613036757, 4909.779059942302, 5145.845624631258, 5667.716614169285, 5162.561182299509, 5190.506901844319, 5210.478952104778, 5266.104762190418, 5274.314339135926, 5161.974190129063, 5190.351206099238, 5253.44838791927, 5294.1529355303155, 5306.044911915854, 5246.029484545352, 5261.657992230531, 5277.498637629419, 5290.841274761763, 5356.9732151339185, 5096.413912400084, 5124.538791508782, 5130.281760553526, 5186.455422180655, 5213.765380557846, 4333.393324934512, 4961.131801934683, 5093.770780314858, 5143.434222235551, 5183.663061901002, 5426.484483974016, 5626.324841019063, 5649.774009039634, 5667.3482549506925, 5693.345265294462, 6008.218931538872, 6020.8494787630225, 6115.027386288435, 6126.7440174764515, 6167.013277875519, 6234.283057448406, 6237.688115594202, 6258.655773932432, 6262.3111457739615, 6273.435390814849, 4807.351007613997, 5747.568932330092, 5753.424657534297, 5758.971205144031, 5789.565782566325, 6122.418370254819, 6144.893919094606, 6168.8766224675255, 6189.690515474208, 6207.162033125561, 5424.891502169935, 6071.967765479791, 6098.91636565712, 6103.186149163621, 6122.448979591858, 6095.4818840398175, 6206.10011548332, 6209.379062093845, 6215.751369945152, 6220.7511699531515, 6019.578629495893, 6090.147379366892, 6136.417040381157, 6154.476869466145, 6186.721597528122, 6145.938540614537, 6156.5998210117095, 6180.536459765535, 6188.9690551546955, 6220.844478888064, 4895.192293271642, 4903.53416425439, 4905.386826646669, 4918.581920536794, 4932.482089380635, 4312.460942382202, 4319.97840010798, 4392.780360981938, 4414.713043652152, 4451.243288640939, 5612.326520817528, 5777.19119323295, 5800.477956983892, 5812.215350927655, 5835.066389377679, 6205.0, 6208.906866397007, 6244.937550624436, 6247.156633854372, 6290.182276304051, 5599.972000140055, 5670.943290567124, 5773.624714393551, 5778.595498315161, 5787.074068149076, 5317.574594032468, 5348.197770334403, 5387.6228663993925, 5397.622166448311, 5450.5367043801725, 5533.170024496358, 6256.812295631138, 6275.3724627537795, 6287.654179020198, 6310.652914089769, 6231.40801623845, 6270.12218289449, 6275.937240627718, 6301.747930082745, 6305.90541141874, 6168.814935551941, 6184.659843708459, 6191.473724733448, 6209.565330426827, 6227.252729672468, 4550.544945505423, 4579.908401832011, 5326.8014696692935, 5911.940880591139, 6177.62934223948, 4906.411230652345, 5239.633225674166, 5610.747516361856, 6133.601315914451, 6165.660888651168, 5996.37038110992, 6073.696315184135, 6076.78731244422, 6082.878342433038, 6116.816495505142, 5802.100674395476, 5957.880842383041, 6003.6998150093195, 6032.0, 6040.486558642565, 5054.0, 5641.971790141023, 5916.230889984275, 5929.0513517836935, 5949.494292985145, 6046.002409602366, 6063.939360606514, 6076.54425918049, 6084.239470066242, 6102.877942441215, 5731.484166425042, 5793.15999180125, 5798.0143375627085, 5801.6519008859605, 5882.647041177543], "value": 5576.887786928464, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.32835709114505, 487.191262504243, 495.98570922463557, 508.4280184792109, 533.1363191629558, 38886.0, 40508.59491405089, 40512.39231411528, 43322.35016474748, 43483.912902177464, 41841.0, 41977.58022419775, 42268.78865605676, 42364.57635423645, 42389.15221695564, 9494.620215191402, 9592.664256751015, 9665.178459830888, 9695.0, 9710.174635155985, 9490.572924218426, 9494.240460763122, 9524.80950380992, 9555.378900371488, 9598.136167744902, 9565.617375305013, 9591.712248632517, 9594.28042896782, 9599.32804703671, 9601.567929443157, 9549.0, 9560.187384072397, 9581.185599224074, 9584.137427631547, 9588.808223835484, 9503.952480237554, 9517.666881659177, 9596.23230141594, 9608.903910960871, 9628.374155679858, 35588.46617300742, 39952.0, 40094.0, 40225.79322620326, 40291.19417611661, 3045.4365942300747, 3113.579666745006, 3492.3713731528314, 3897.57126716061, 4097.590240975908, 30640.710151136165, 30764.69235307663, 31286.374272514422, 31417.685823141706, 31612.0, 3191.1543440988157, 3204.5033019881957, 3228.9031329060167, 3319.535265062869, 3344.013516012782, 484205.0, 486139.0, 486439.0, 486700.0, 487832.0, 58240.41759582435, 58275.41724582785, 58496.70751646299, 58617.0, 58665.70667146637, 60478.697606512564, 60966.56133754689, 61106.38893611096, 61288.080678789855, 61325.693371532856, 14361.353739081558, 14363.138211707332, 16153.676926461405, 16159.838401616069, 16174.867759256975, 12097.274163550039, 12456.128071035122, 12511.624651260478, 12581.930535904368, 12643.0, 12660.81008784869, 12869.806952895715, 13129.409176587076, 15711.21443927799, 15856.207189640472, 3137.13728724598, 5227.503387178212, 6024.90962635552, 6161.630302181794, 6164.630122192682, 857.7555396711907, 940.0, 971.6744890461774, 985.3693636072919, 1132.088668621751, 28716.994905178635, 28751.712482875322, 29877.10368688943, 30214.54678179829, 31046.844765776477, 1031.4739482863642, 1038.2732087538602, 1082.875469321038, 1083.766990097133, 1136.579465597734, 15676.137812420198, 15723.0, 15780.895337326278, 15815.683686326209, 16270.349186032427, 661646.0, 663102.0, 666517.0, 670372.0, 670468.6476567585, 55350.0, 55612.443875561534, 55779.721101395044, 55818.72090639521, 55892.72053639706, 1327.9269640169884, 1369.431685850361, 1384.065755614976, 1386.4800699737598, 1389.0415613227044, 28619.713802862538, 29063.85468072646, 29573.556396653636, 29617.407651847272, 30265.394692105594, 49405.75297123491, 49433.51699449022, 49751.25373119478, 49928.500714992384, 49996.75008124826, 588769.0, 592658.0, 593089.0, 593766.0, 595319.0, 26234.60648090242, 26261.737382625928, 26430.339241519116, 26583.0, 26613.93544258208, 46869.765651171525, 47693.80765480752, 47828.04343913172, 47865.76067119642, 47868.80327991689, 32420.83789581037, 38779.0, 39636.80181599074, 40494.0, 40924.0, 36527.0, 38403.65587204434, 39268.80365598268, 39308.0, 39642.60357396389, 37300.694475694305, 37678.811605941795, 37764.05589860275, 38015.0, 38655.42016869693, 28575.714242858136, 33113.50329745104, 34273.65726342705, 34357.656423435445, 34366.82816585901, 25302.240932772045, 25672.229833105037, 26162.73837261603, 26513.0, 26531.938722450886], "value": 19595.320343356587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.5668033380443, 372.5306114295987, 375.6300044456211, 378.93368660484407, 391.9647231749142, 15290.847091529082, 18667.759868815745, 19806.207751689915, 20361.898190509026, 20608.484787880312, 19843.60312793747, 19884.40346789595, 20243.39269821904, 20330.288439904605, 20560.794392056076, 5717.542596592262, 5729.1119876419225, 5973.492253158487, 6012.488938440216, 6031.185789918371, 5881.500072493843, 5966.761329546813, 6079.544034197431, 6082.847928801771, 6089.817305480843, 5874.3244526879525, 5947.702614869261, 6015.0676645120075, 6053.51571874249, 6059.545534084939, 5883.14694369314, 5979.073243647242, 5990.131430942511, 6015.57890947636, 6181.96909015452, 4517.435320584927, 5220.2430647556275, 5644.74598643062, 5875.1187321901625, 5899.0, 13042.673933151747, 13263.66840828987, 13339.799903001463, 20699.17203311866, 24740.0, 1803.6302557975714, 1999.9200031998703, 2195.9341219763432, 2575.72954839741, 2583.844969301829, 7708.768736937901, 9933.552990115462, 9970.551325190383, 10430.947845260802, 14631.634209144857, 1676.0, 1843.2442698493687, 1852.722091686258, 1880.586271020387, 1929.7684277886744, 115628.0, 117197.65604687859, 118300.40849795696, 122858.0, 123686.0, 11230.956855532002, 11349.829752553718, 11419.942900285612, 11494.252873563359, 11528.711782205512, 14439.267287925517, 14473.565793026226, 14474.493392731203, 14494.782578261334, 14530.636734081521, 8326.542040187727, 8455.577221138918, 8461.915380846236, 8495.617697203641, 8610.268127209258, 8295.62669679866, 8374.623141958626, 8408.369372297102, 8512.233898949124, 8590.312774977987, 4540.818367265339, 4546.636269098464, 4547.499775024745, 4547.567981041796, 4636.165490211727, 1715.9018228333875, 1878.126671097946, 1889.1687657430687, 1917.83698385636, 1978.5943881504256, 881.5724373678761, 921.8663293822358, 930.4882314726873, 977.6236149082512, 992.0823238504355, 16050.438234661964, 20537.2811951581, 21073.78926210749, 21153.36539903805, 21204.469888252916, 912.2975309012023, 931.993447077155, 946.9715908522755, 965.9420434773796, 968.874046373981, 10726.356418614752, 11101.666949991513, 11160.107191424666, 11191.552337906392, 11194.944025279821, 531635.0, 533243.0, 538993.0, 539579.0, 544216.0, 79322.6033869827, 114211.0, 123853.86427123728, 126448.0, 129186.0, 871.6034204436966, 886.2909672262165, 929.5027160469117, 930.1582068228264, 957.1003256938594, 15392.153431561372, 18234.270629175215, 18398.356057537923, 18836.811631884055, 19319.90340048291, 38902.610973889896, 52205.69485762886, 54476.0, 54495.455045450624, 58717.70641146767, 80722.0, 81024.78462822945, 81858.54424367279, 83610.58194708987, 83803.5809820947, 6568.671566421755, 7506.1743208248145, 7768.096816280047, 8122.350211982909, 8176.591170441573, 9393.812123757623, 10069.949650251701, 10637.308574942605, 11022.228444008842, 12458.32146088559, 8966.327525435488, 9214.723558292993, 10740.30188037775, 10778.245522813328, 10840.241183117107, 10075.546600402853, 10131.08820206185, 10457.320274182153, 10698.251122421356, 10883.183761217782, 10628.0, 10650.414227217267, 11015.944920275668, 11032.172587055842, 11154.609588664358, 7843.6862525498345, 7921.247481489249, 8039.557824319719, 8133.389995750224, 8191.79520511992, 10359.689209323733, 10568.89431105679, 10832.295900766425, 10904.0, 10917.83623245636], "value": 9254.701668297519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.5655075202062, 1509.7131545006444, 1726.1024267380963, 1730.8269173082701, 1886.999999999999, 7933.880991785113, 8167.224113709203, 8369.246767790897, 8930.91069089309, 8936.0, 7476.214997425273, 8381.580920953958, 8692.174243446863, 8733.650653973833, 8792.956035219831, 2339.5671800716877, 2365.6215005599106, 2367.9289621311386, 2368.656544801003, 2371.5731168389684, 2336.147306233221, 2355.646653002055, 2369.052379048386, 2375.156819329139, 2386.868722220277, 2362.492064206195, 2371.27676058802, 2371.419002344428, 2381.856708779787, 2390.6892104026538, 2328.592496313155, 2334.101370972171, 2337.2403968710237, 2340.3330050935488, 2347.190219374313, 2310.5032418030037, 2331.184085570054, 2332.090484710964, 2340.5903966805913, 2342.7774361435636, 8871.556422178865, 8895.199432051146, 8903.020667726545, 8912.064233255545, 8927.107289271085, 5205.27126202332, 5310.309659744208, 5367.892642147135, 5380.408155102936, 5390.460953904578, 3566.4828599852876, 3593.083763640255, 3643.6902863256655, 3667.5598928128798, 3670.963290367089, 1052.5684469367523, 1053.3153450257316, 1055.625253035177, 1070.0423121306387, 1074.978500429995, 11502.654920352403, 11575.479103440366, 11614.36121013344, 11623.709407264801, 11643.53425862973, 4519.7740112994215, 4579.313103034571, 4752.310914917318, 4770.904581908342, 4779.569838714532, 9740.0, 9825.115739583473, 9832.508374581243, 9834.311598188058, 9838.508074596242, 4856.028794241166, 5302.867428314245, 5332.0, 5365.946340536622, 5366.597505187126, 4379.474463064389, 4520.299353600197, 4694.36626055485, 4694.43666759991, 4866.7079975201605, 3806.3148633246283, 3850.8844734658005, 3923.9019024524614, 3942.8619998300496, 3947.032976920673, 1287.568664497385, 1300.7788675925115, 1308.4635299527338, 1314.2574445438297, 1315.0400207848324, 847.9448835825651, 918.4856480371013, 920.9033051529627, 924.2051835421532, 957.8323793336139, 5707.942920570824, 5932.703364831741, 5981.312149102821, 6034.306054803754, 6051.788187413419, 417.91759343301, 424.8173285487208, 426.57768808878984, 434.2574198121185, 447.4585751241035, 3483.6516348365467, 3970.225805967866, 4017.879463616096, 4045.02919299366, 4055.614716601918, 10234.948825255826, 10398.948005259925, 10564.154867610572, 10567.313124646873, 10643.73390665224, 10036.849447258297, 10311.22665800068, 10433.16534677224, 10557.049865512141, 10632.893671063344, 7147.106611673541, 7886.3296619786815, 8167.346612271004, 8224.506529608123, 8242.423030387936, 5895.7052147391605, 5975.37083683178, 6080.574359794949, 6089.847753806191, 6128.325884152829, 7962.601869906365, 9902.522821245138, 10006.44964526958, 10057.346272492265, 10094.89905100969, 9976.60093596277, 10000.999900009941, 10001.699949001542, 10013.098821106136, 10021.899781002097, 6097.908531372122, 6922.5154239202775, 7112.253213412517, 7251.456140789356, 7464.402847772057, 8206.466579672302, 8456.873146902924, 8457.746267611981, 8476.194761497647, 8487.36344774132, 7348.301911318416, 7521.699132034657, 7548.433867460072, 7583.658735357032, 7647.808804779925, 7325.4872158948365, 7338.559686418832, 7380.852382952204, 7500.399968002655, 7507.399408047234, 6511.674416279262, 6918.100646915868, 7059.541129826544, 7063.187733410724, 7070.222275549789, 4265.637420819141, 4319.287317592562, 4528.750918699503, 4574.039451715177, 4887.193613053806, 4290.592393722592, 4954.232094025432, 5014.197728363444, 5151.304573882628, 5212.50481204285], "value": 4459.94263845362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9553067039945, 300.78343592613317, 309.1375063572633, 311.93293441910015, 315.5613696961223, 5437.592180586462, 5639.8590035249135, 5698.401667824881, 5785.714642716124, 5827.9999999999945, 4814.205656066753, 4870.732109733964, 5367.677939323643, 5460.017196904556, 5638.943610563903, 3668.963310366889, 4359.542248063939, 4363.774475017732, 4375.6937014409, 4382.386465894777, 4158.729682570638, 4255.659547236213, 4300.956990430102, 4368.803403846819, 4397.802098905541, 4280.015596412827, 4280.98793567023, 4299.742015479082, 4305.289627211507, 4318.719283246594, 3697.2975134724315, 4080.6531444827224, 4117.75293482392, 4314.590113939171, 4346.001259131221, 3650.8904732858055, 3774.2451509697894, 3783.3190025795348, 3791.279656865187, 3794.6964242860504, 5087.287779710843, 5425.37608175057, 5508.476694713996, 5531.668099914018, 5543.639663421905, 4954.628402869799, 4955.925661115086, 4969.912636692562, 4988.114025449968, 4993.176125939216, 4768.761561921925, 5876.382979787104, 5923.170756094107, 5930.673812940287, 5948.31594366649, 3444.483327500895, 4018.3570628699267, 4076.857309994136, 4083.9387409188885, 4106.240345536055, 5492.423295553949, 6165.7533698652, 6234.379061444012, 6308.684565771739, 6333.271673757531, 3626.2384899170943, 3993.6006399360413, 4099.651529620016, 4120.299549076664, 4150.6471949884, 3326.8336583170744, 3551.7691350062164, 3981.402789581586, 4037.1118353962083, 4183.226103170923, 4947.455779864212, 4947.455779864212, 5008.348914641073, 5014.799408023711, 5015.874603134951, 5060.443351231362, 5284.9083286277955, 6016.503151192206, 6021.337652858182, 6065.75736970525, 1342.2215115233337, 1388.5348408283137, 1431.7279716853764, 1439.1437094928501, 1455.5851582298994, 830.7092517618906, 835.3359079531787, 883.7172104926361, 884.9867251991225, 891.5364010714392, 4703.02472961357, 4723.527647235249, 4763.618910487153, 4765.928511072337, 4777.229207059897, 4437.829928133688, 4816.964352664124, 4838.637102217348, 5197.454267301954, 5203.881165549425, 3915.569287378386, 4068.7558746475306, 4489.367807561767, 4618.937644341753, 4666.829924085317, 2555.198584997572, 2659.417646500368, 2662.4941261160707, 2728.6179934809143, 2760.599713041638, 4307.0, 4467.7319360838455, 5295.431715617922, 5320.255164277004, 5378.650387724785, 4102.353981681798, 4305.072550665577, 4455.309427038749, 4503.954960450419, 4527.909441811145, 4424.778761061998, 4865.7323847188745, 5069.721165335942, 5264.736763161826, 5342.233725223708, 4508.774561271989, 5124.333836601218, 5124.692518448905, 5192.532672059533, 5210.47895210476, 4650.953490465187, 4732.810687572459, 4798.568128868418, 4898.3142360068905, 5143.588512918883, 4507.791182320705, 5321.328283484383, 5342.599305052215, 5363.946360536344, 5449.700266485382, 3616.9276614467035, 3621.8008009559726, 3631.9455208172426, 3660.108514273694, 3665.2486240321205, 4851.005543863429, 5164.457731938092, 5179.948200517946, 5205.843824685266, 5567.244214114039, 5356.946430535645, 5637.830865074055, 6003.8198854034445, 6045.335013148462, 6064.241969753781, 5449.863753406196, 5522.861928451821, 5970.850493822134, 6011.849703757441, 6024.246969128859, 4985.476524964972, 5142.665726727751, 5144.202648589475, 5428.647137936022, 5815.854603634943, 5777.62445441045, 5954.434328738763, 5998.760049597967, 6027.909581356371, 6042.607230530178, 5108.59131269505, 5188.118019936544, 5733.1334332833585, 5871.178035075008, 5914.2311499504785], "value": 4072.053327480315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.3957709964085, 705.8835292176791, 732.3408931961237, 773.5783997721245, 821.2649678537707, 15167.0, 15804.209789510536, 16070.919645401771, 16209.83790162098, 16259.430919917806, 14733.631659208526, 14757.0, 14847.331870065846, 14862.777058344134, 14900.403983840633, 865.3726048614767, 878.925291350236, 881.1408876345544, 881.3301890563187, 881.8456770065245, 687.8830598798216, 706.7385067525023, 846.4032856835915, 867.8394497018072, 875.6497401039571, 902.1609902790402, 919.5310391700248, 926.7961048569304, 928.8188803183382, 934.9065093490631, 893.6604090445654, 926.6432423516961, 927.1562877781221, 927.4342650982962, 927.6753136402239, 663.8705452436777, 667.3726696904894, 673.2863165045068, 678.8235058884726, 690.5304393012749, 14940.252987350588, 14944.252787360589, 14959.551213463614, 14965.625859353495, 15010.549683509513, 14405.567832965027, 14474.927625361912, 14583.781243281359, 14620.195889226088, 14661.633459163606, 11122.55509779608, 11805.822912656316, 11880.227785193934, 11929.045676345871, 11994.220375675553, 3745.4569087482164, 3797.886063418102, 3833.2333533293454, 3916.980415097935, 3918.4710064141545, 116490.0, 117155.41422292919, 117915.0, 117946.41026794897, 118419.40790295994, 10767.83848242277, 11057.944710276397, 11077.0, 11470.827937580943, 11478.139139564566, 18599.535011624546, 22617.886910565343, 22632.886835565718, 22692.865356732098, 22732.65901011486, 6604.702788374535, 7023.9815226791825, 7219.675114619749, 8033.3974951878845, 8193.672253109928, 4303.33298338758, 4411.977940110279, 4438.511763705989, 4567.543245675406, 4572.337011133367, 3483.7909725416557, 3563.002359339389, 3614.963850361515, 3619.348517266917, 3632.945505817415, 631.9905201421982, 638.1385130074456, 639.7057353617295, 651.5276424592133, 653.4608947618234, 550.7521615273063, 589.4341432225026, 591.7071049830362, 668.5721138471382, 696.7979286007103, 9033.367664263438, 9297.953510232406, 9397.90602093984, 9406.294527910433, 9422.575984080733, 649.746598826458, 665.1552528289046, 668.9832754181184, 671.412514050206, 687.7249100359796, 4305.354196870495, 4385.978070109629, 4610.0, 4627.190241707688, 4718.575328220477, 103425.0, 118022.0, 144452.0, 158267.0, 161862.1906890458, 111834.0, 113402.43298783453, 113928.0, 134195.32902335425, 141741.29129354493, 65530.34469655338, 67196.66401668059, 79133.20866791489, 110446.0, 112418.43790780994, 9206.723798286062, 9803.607855685977, 9824.557894894604, 9859.309848310837, 9911.900880991097, 46469.76765116153, 60558.69720651369, 62449.68775156095, 63552.682236588524, 63576.68211659097, 76123.0, 93906.53046734723, 98091.52862706923, 98724.0, 100333.99666003247, 12845.743085138432, 12850.336113995425, 12886.3523573201, 13159.934200328937, 13162.01284903617, 14405.207713575854, 14449.638759031108, 14463.638409039859, 14536.709265814836, 14578.781318280446, 11321.547138114383, 11372.37451940118, 13038.348082595643, 13684.178949263076, 13821.85912125121, 11801.940990295338, 13202.933985330395, 13738.587842364745, 13976.161430314214, 14013.738763510924, 12971.5459958901, 13179.802302965654, 13211.14127581704, 13356.465741370237, 13862.098963567336, 11078.390688512209, 11239.943800280946, 11304.773904521699, 11325.0, 11411.771764564495, 10161.441120738134, 11143.387113708499, 11285.984261416184, 11309.264897781617, 11324.490397931948], "value": 7762.010647916194, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 121.0, 118.0, 117.0, 121.0, 169.0, 168.0, 118.0, 118.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 113.0, 120.0, 192.0, 123.0, 119.0, 116.0, 118.0, 144.0, 126.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 198.0, 202.0, 221.0, 199.0, 195.0, 193.0, 196.0, 198.0, 195.0], "value": 198.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 59.0, 80.0, 56.0, 59.0, 58.0, 61.0, 79.0, 60.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 103.0, 73.0, 94.0, 63.0, 86.0, 74.0, 56.0, 82.0, 117.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 93.0, 90.0, 92.0, 88.0, 93.0, 90.0, 92.0, 89.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 100.0, 99.0, 98.0, 97.0, 100.0, 98.0, 98.0], "value": 98.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 87.0, 123.0, 92.0, 132.0, 153.0, 90.0, 88.0, 120.0], "value": 106.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 55.0, 59.0, 59.0, 58.0, 57.0, 51.0, 47.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 72.0, 84.0, 76.0, 69.0, 69.0, 72.0, 70.0, 70.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 95.0, 105.0, 110.0, 87.0, 86.0, 91.0, 98.0, 79.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 168.0, 162.0, 165.0, 148.0, 158.0, 141.0, 144.0, 188.0, 148.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 174.0, 180.0, 175.0, 179.0, 172.0, 171.0, 173.0, 174.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 84.0, 88.0, 92.0, 88.0, 88.0, 82.0, 69.0, 70.0], "value": 80.4, "unit": "score"}]}]} 15:14:46 INFO - Return code: 0 15:14:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:14:46 ERROR - # TBPL SUCCESS # 15:14:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:14:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:14:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:14:46 INFO - 2016-10-14 15:14:46.206 screenresolution[1674:10668] starting screenresolution argv=screenresolution get 15:14:46 INFO - 2016-10-14 15:14:46.209 screenresolution[1674:10668] Display 0: 1600x1200x32@60 15:14:46 INFO - 2016-10-14 15:14:46.215 screenresolution[1675:10671] starting screenresolution argv=screenresolution list 15:14:46 INFO - Available Modes on Display 0 15:14:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:14:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:14:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:14:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:14:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:14:46 INFO - Intel Iris: 15:14:46 INFO - Chipset Model: Intel Iris 15:14:46 INFO - Type: GPU 15:14:46 INFO - Bus: Built-In 15:14:46 INFO - VRAM (Dynamic, Max): 1536 MB 15:14:46 INFO - Vendor: Intel (0x8086) 15:14:46 INFO - Device ID: 0x0a2e 15:14:46 INFO - Revision ID: 0x0009 15:14:46 INFO - Displays: 15:14:46 INFO - Display: 15:14:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:14:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:14:46 INFO - Display Serial Number: 1600x1200 60 15:14:46 INFO - Main Display: Yes 15:14:46 INFO - Mirror: Off 15:14:46 INFO - Online: Yes 15:14:46 INFO - Rotation: Supported 15:14:46 INFO - Return code: 0 15:14:46 INFO - Running post-action listener: _resource_record_post_action 15:14:46 INFO - [mozharness: 2016-10-14 22:14:46.452880Z] Finished run-tests step (success) 15:14:46 INFO - Running post-run listener: _resource_record_post_run 15:14:46 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38935040; Write bytes: 712217088; Read time: 378; Write time: 1986 15:14:46 INFO - TinderboxPrint: CPU usage
54.6% 15:14:46 INFO - TinderboxPrint: I/O read bytes / time
38,935,040 / 378 15:14:46 INFO - TinderboxPrint: I/O write bytes / time
712,217,088 / 1,986 15:14:46 INFO - TinderboxPrint: CPU idle
2,198.3 (45.4%) 15:14:46 INFO - TinderboxPrint: CPU system
977.0 (20.2%) 15:14:46 INFO - TinderboxPrint: CPU user
1,670.3 (34.5%) 15:14:46 INFO - TinderboxPrint: Swap in / out
447,283,200 / 0 15:14:46 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 412746240; Write bytes: 405434368; Read time: 30875; Write time: 781 15:14:46 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 30069248; Write bytes: 296423936; Read time: 285; Write time: 1170 15:14:46 INFO - Running post-run listener: _upload_blobber_files 15:14:46 INFO - Blob upload gear active. 15:14:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:46 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:14:46 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:14:46 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:14:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:14:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:14:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:48 INFO - (blobuploader) - INFO - Done attempting. 15:14:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:14:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:14:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:49 INFO - (blobuploader) - INFO - Done attempting. 15:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:51 INFO - (blobuploader) - INFO - Done attempting. 15:14:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:51 INFO - Return code: 0 15:14:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba41a42b66d04887ee7c246a91b1d036ad35ec7754963a047fc2c82080403149ebff94e51ef62a3d9f24fee22fb0bc4128346bbb13ac2d632503deb5b73dbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edf1fa6a359f9c8c4390449e6bd12e656ad2518c5fc94d4e6a7242bc06f5fddc4649fb580cfbe7437963eff6d1ed100218b5e064d4d0ecf5a9fee8d33ae72cf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/949a568f149b2de8088f8ae0566f037bb62ae0010e84c336f96fd5bd0f883afd1822cc1676c423d8cec390f9e828d202bebda4c9964a30a75cd29c299fd2ee1d"} 15:14:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:51 INFO - Contents: 15:14:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba41a42b66d04887ee7c246a91b1d036ad35ec7754963a047fc2c82080403149ebff94e51ef62a3d9f24fee22fb0bc4128346bbb13ac2d632503deb5b73dbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edf1fa6a359f9c8c4390449e6bd12e656ad2518c5fc94d4e6a7242bc06f5fddc4649fb580cfbe7437963eff6d1ed100218b5e064d4d0ecf5a9fee8d33ae72cf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/949a568f149b2de8088f8ae0566f037bb62ae0010e84c336f96fd5bd0f883afd1822cc1676c423d8cec390f9e828d202bebda4c9964a30a75cd29c299fd2ee1d"} 15:14:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:51 INFO - Copying logs to upload dir... 15:14:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.006879 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-14 15:14:51.494244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:14:51.497662) ========= 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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba41a42b66d04887ee7c246a91b1d036ad35ec7754963a047fc2c82080403149ebff94e51ef62a3d9f24fee22fb0bc4128346bbb13ac2d632503deb5b73dbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edf1fa6a359f9c8c4390449e6bd12e656ad2518c5fc94d4e6a7242bc06f5fddc4649fb580cfbe7437963eff6d1ed100218b5e064d4d0ecf5a9fee8d33ae72cf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/949a568f149b2de8088f8ae0566f037bb62ae0010e84c336f96fd5bd0f883afd1822cc1676c423d8cec390f9e828d202bebda4c9964a30a75cd29c299fd2ee1d"} build_url:https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010872 build_url: 'https://queue.taskcluster.net/v1/task/fzf9bkDAQvGPRLXM_VzXoA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba41a42b66d04887ee7c246a91b1d036ad35ec7754963a047fc2c82080403149ebff94e51ef62a3d9f24fee22fb0bc4128346bbb13ac2d632503deb5b73dbae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edf1fa6a359f9c8c4390449e6bd12e656ad2518c5fc94d4e6a7242bc06f5fddc4649fb580cfbe7437963eff6d1ed100218b5e064d4d0ecf5a9fee8d33ae72cf0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/949a568f149b2de8088f8ae0566f037bb62ae0010e84c336f96fd5bd0f883afd1822cc1676c423d8cec390f9e828d202bebda4c9964a30a75cd29c299fd2ee1d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:14:51.530360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:14:51.530739) ========= 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.VC6eEdvGXm/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.9hUjz5ttOC/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.004927 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:14:51.579712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:14:51.580119) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:14:51.580510) ========= ========= Total master_lag: 2.18 =========