builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0300 starttime: 1467412692.44 results: success (0) buildid: 20160701144122 builduid: 1715727f5e6b495aa03f3e3444ef861c revision: 2256463545d7e69ebe2c36e0fdea569df1db8fbb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.438922) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.439399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.439704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.464526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.465093) ========= 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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-07-01 15:38:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 27.3M=0s 2016-07-01 15:38:12 (27.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.621710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.622035) ========= 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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.026105 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:12.670858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 15:38:12.671221) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2256463545d7e69ebe2c36e0fdea569df1db8fbb --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 2256463545d7e69ebe2c36e0fdea569df1db8fbb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-07-01 15:38:12,753 truncating revision to first 12 chars 2016-07-01 15:38:12,753 Setting DEBUG logging. 2016-07-01 15:38:12,753 attempt 1/10 2016-07-01 15:38:12,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2256463545d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 15:38:13,709 unpacking tar archive at: fx-team-2256463545d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.220608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 15:38:13.913732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:13.914063) ========= script_repo_revision: 2256463545d7e69ebe2c36e0fdea569df1db8fbb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:13.914462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:13.914857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 15:38:13.932979) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-01 15:38:13.933384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:38:14 INFO - MultiFileLogger online at 20160701 15:38:14 in /builds/slave/test 15:38:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:38:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:38:14 INFO - {'append_to_log': False, 15:38:14 INFO - 'base_work_dir': '/builds/slave/test', 15:38:14 INFO - 'blob_upload_branch': 'Fx-Team', 15:38:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:38:14 INFO - 'branch': 'Fx-Team', 15:38:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:38:14 INFO - 'config_files': ('talos/mac_config.py',), 15:38:14 INFO - 'default_actions': ('clobber', 15:38:14 INFO - 'read-buildbot-config', 15:38:14 INFO - 'download-and-extract', 15:38:14 INFO - 'populate-webroot', 15:38:14 INFO - 'create-virtualenv', 15:38:14 INFO - 'install', 15:38:14 INFO - 'run-tests'), 15:38:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:38:14 INFO - 'download_minidump_stackwalk': True, 15:38:14 INFO - 'download_symbols': 'ondemand', 15:38:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:38:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:38:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:38:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:38:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:38:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:38:14 INFO - 'installer_path': 'installer.exe', 15:38:14 INFO - 'log_level': 'info', 15:38:14 INFO - 'log_name': 'talos', 15:38:14 INFO - 'log_to_console': True, 15:38:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:38:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:38:14 INFO - 'opt_config_files': (), 15:38:14 INFO - 'pip_index': False, 15:38:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:38:14 INFO - 'cmd': ('bash', 15:38:14 INFO - '-c', 15:38:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:38:14 INFO - 'enabled': True, 15:38:14 INFO - 'halt_on_failure': False, 15:38:14 INFO - 'name': 'check_screen_resolution'},), 15:38:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:38:14 INFO - 'cmd': ('bash', 15:38:14 INFO - '-c', 15:38:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:38:14 INFO - 'enabled': True, 15:38:14 INFO - 'halt_on_failure': False, 15:38:14 INFO - 'name': 'check_screen_resolution'},), 15:38:14 INFO - 'run_cmd_checks_enabled': True, 15:38:14 INFO - 'sps_profile': False, 15:38:14 INFO - 'sps_profile_interval': 0, 15:38:14 INFO - 'suite': 'dromaeojs', 15:38:14 INFO - 'system_bits': '32', 15:38:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:38:14 INFO - 'title': 't-yosemite-r7-0300', 15:38:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:38:14 INFO - 'use_talos_json': True, 15:38:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:38:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:38:14 INFO - 'work_dir': 'build'} 15:38:14 INFO - ##### 15:38:14 INFO - ##### Running clobber step. 15:38:14 INFO - ##### 15:38:14 INFO - Running pre-action listener: _resource_record_pre_action 15:38:14 INFO - Running main action method: clobber 15:38:14 INFO - rmtree: /builds/slave/test/build 15:38:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:38:15 INFO - Running post-action listener: _resource_record_post_action 15:38:15 INFO - ##### 15:38:15 INFO - ##### Finished clobber step (success) 15:38:15 INFO - ##### 15:38:15 INFO - ##### 15:38:15 INFO - ##### Running read-buildbot-config step. 15:38:15 INFO - ##### 15:38:15 INFO - Running pre-action listener: _resource_record_pre_action 15:38:15 INFO - Running main action method: read_buildbot_config 15:38:15 INFO - Using buildbot properties: 15:38:15 INFO - { 15:38:15 INFO - "project": "", 15:38:15 INFO - "product": "firefox", 15:38:15 INFO - "script_repo_revision": "production", 15:38:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:38:15 INFO - "repository": "", 15:38:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:38:15 INFO - "buildid": "20160701144122", 15:38:15 INFO - "pgo_build": "False", 15:38:15 INFO - "basedir": "/builds/slave/test", 15:38:15 INFO - "buildnumber": 78, 15:38:15 INFO - "slavename": "t-yosemite-r7-0300", 15:38:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:38:15 INFO - "platform": "yosemite_r7", 15:38:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:38:15 INFO - "branch": "fx-team", 15:38:15 INFO - "repo_path": "integration/fx-team", 15:38:15 INFO - "revision": "2256463545d7e69ebe2c36e0fdea569df1db8fbb", 15:38:15 INFO - "stage_platform": "macosx64", 15:38:15 INFO - "builduid": "1715727f5e6b495aa03f3e3444ef861c", 15:38:15 INFO - "slavebuilddir": "test" 15:38:15 INFO - } 15:38:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 15:38:15 INFO - Running post-action listener: _resource_record_post_action 15:38:15 INFO - ##### 15:38:15 INFO - ##### Finished read-buildbot-config step (success) 15:38:15 INFO - ##### 15:38:15 INFO - ##### 15:38:15 INFO - ##### Running download-and-extract step. 15:38:15 INFO - ##### 15:38:15 INFO - Running pre-action listener: _resource_record_pre_action 15:38:15 INFO - Running main action method: download_and_extract 15:38:15 INFO - mkdir: /builds/slave/test/build/tests 15:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:15 INFO - https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:38:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 15:38:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 15:38:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 15:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 15:38:17 INFO - Downloaded 1199 bytes. 15:38:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 15:38:17 INFO - Using the following test package requirements: 15:38:17 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 15:38:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 15:38:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 15:38:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'jsshell-mac.zip'], 15:38:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 15:38:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 15:38:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 15:38:17 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 15:38:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 15:38:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:38:17 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 15:38:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:17 INFO - https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:38:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:38:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:38:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:38:19 INFO - Downloaded 18789531 bytes. 15:38:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:38:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:38:22 INFO - Return code: 0 15:38:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:22 INFO - https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:38:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:38:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:38:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:38:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:38:23 INFO - Downloaded 18789531 bytes. 15:38:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:38:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:38:26 INFO - Return code: 0 15:38:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:26 INFO - https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 15:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 15:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 15:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:38:28 INFO - Downloaded 14405242 bytes. 15:38:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:38:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:38:28 INFO - Return code: 0 15:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:28 INFO - https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 15:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 15:38:31 INFO - Downloaded 112383217 bytes. 15:38:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:38:31 INFO - mkdir: /builds/slave/test/properties 15:38:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:38:31 INFO - Writing to file /builds/slave/test/properties/build_url 15:38:31 INFO - Contents: 15:38:31 INFO - build_url:https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:38:32 INFO - Running post-action listener: _resource_record_post_action 15:38:32 INFO - Running post-action listener: set_extra_try_arguments 15:38:32 INFO - ##### 15:38:32 INFO - ##### Finished download-and-extract step (success) 15:38:32 INFO - ##### 15:38:32 INFO - ##### 15:38:32 INFO - ##### Running populate-webroot step. 15:38:32 INFO - ##### 15:38:32 INFO - Running pre-action listener: _resource_record_pre_action 15:38:32 INFO - Running main action method: populate_webroot 15:38:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:38:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:38:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:38:32 INFO - '--tppagecycles', 15:38:32 INFO - '7'], 15:38:32 INFO - 'tests': ['tsvgm']}}, 15:38:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:38:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:38:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:38:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:38:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['damp', 'tps']}, 15:38:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'tests': ['damp', 'tps']}, 15:38:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['dromaeo_dom']}, 15:38:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:38:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['basic_compositor_video']}, 15:38:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:38:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['a11yr', 15:38:32 INFO - 'ts_paint', 15:38:32 INFO - 'tpaint', 15:38:32 INFO - 'sessionrestore', 15:38:32 INFO - 'sessionrestore_no_auto_restore', 15:38:32 INFO - 'tabpaint']}, 15:38:32 INFO - 'other-e10s': {'tests': ['a11yr', 15:38:32 INFO - 'ts_paint', 15:38:32 INFO - 'tpaint', 15:38:32 INFO - 'sessionrestore', 15:38:32 INFO - 'sessionrestore_no_auto_restore', 15:38:32 INFO - 'tabpaint']}, 15:38:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:38:32 INFO - 'ts_paint', 15:38:32 INFO - 'tpaint', 15:38:32 INFO - 'sessionrestore', 15:38:32 INFO - 'sessionrestore_no_auto_restore', 15:38:32 INFO - 'tabpaint']}, 15:38:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:38:32 INFO - 'ts_paint', 15:38:32 INFO - 'tpaint', 15:38:32 INFO - 'sessionrestore', 15:38:32 INFO - 'sessionrestore_no_auto_restore', 15:38:32 INFO - 'tabpaint']}, 15:38:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['a11yr', 15:38:32 INFO - 'ts_paint', 15:38:32 INFO - 'tpaint', 15:38:32 INFO - 'sessionrestore', 15:38:32 INFO - 'sessionrestore_no_auto_restore', 15:38:32 INFO - 'tabpaint']}, 15:38:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['a11yr', 15:38:32 INFO - 'ts_paint', 15:38:32 INFO - 'tpaint', 15:38:32 INFO - 'sessionrestore', 15:38:32 INFO - 'sessionrestore_no_auto_restore', 15:38:32 INFO - 'tabpaint']}, 15:38:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['tsvgx', 15:38:32 INFO - 'tsvgr_opacity', 15:38:32 INFO - 'tart', 15:38:32 INFO - 'tscrollx', 15:38:32 INFO - 'cart']}, 15:38:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:38:32 INFO - 'tsvgr_opacity', 15:38:32 INFO - 'tart', 15:38:32 INFO - 'tscrollx', 15:38:32 INFO - 'cart']}, 15:38:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'talos_options': ['--disable-e10s'], 15:38:32 INFO - 'tests': ['tp5o']}, 15:38:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'tests': ['tp5o']}, 15:38:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'talos_options': ['--disable-e10s', 15:38:32 INFO - '--xperf_path', 15:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:32 INFO - 'tests': ['tp5n']}, 15:38:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:32 INFO - 'talos_options': ['--xperf_path', 15:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:32 INFO - 'tests': ['tp5n']}}, 15:38:32 INFO - 'talos.zip': {'path': '', 15:38:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:38:32 INFO - Running post-action listener: _resource_record_post_action 15:38:32 INFO - ##### 15:38:32 INFO - ##### Finished populate-webroot step (success) 15:38:32 INFO - ##### 15:38:32 INFO - ##### 15:38:32 INFO - ##### Running create-virtualenv step. 15:38:32 INFO - ##### 15:38:32 INFO - Running pre-action listener: _resource_record_pre_action 15:38:32 INFO - Running main action method: create_virtualenv 15:38:32 INFO - Creating virtualenv /builds/slave/test/build/venv 15:38:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:38:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:38:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:38:32 INFO - Using real prefix '/tools/python27' 15:38:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:38:33 INFO - Installing distribute.............................................................................................................................................................................................done. 15:38:36 INFO - Installing pip.................done. 15:38:36 INFO - Return code: 0 15:38:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:38:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:36 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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:36 INFO - 'HOME': '/Users/cltbld', 15:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:36 INFO - 'LOGNAME': 'cltbld', 15:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:36 INFO - 'MOZ_NO_REMOTE': '1', 15:38:36 INFO - 'NO_EM_RESTART': '1', 15:38:36 INFO - 'PAGER': '/bin/cat', 15:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:36 INFO - 'PWD': '/builds/slave/test', 15:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:36 INFO - 'SHELL': '/bin/bash', 15:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:38:36 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:36 INFO - 'USER': 'cltbld', 15:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:36 INFO - 'XPC_FLAGS': '0x0', 15:38:36 INFO - 'XPC_SERVICE_NAME': '0', 15:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:38:36 INFO - Cleaning up... 15:38:36 INFO - Return code: 0 15:38:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:38:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:36 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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:36 INFO - 'HOME': '/Users/cltbld', 15:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:36 INFO - 'LOGNAME': 'cltbld', 15:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:36 INFO - 'MOZ_NO_REMOTE': '1', 15:38:36 INFO - 'NO_EM_RESTART': '1', 15:38:36 INFO - 'PAGER': '/bin/cat', 15:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:36 INFO - 'PWD': '/builds/slave/test', 15:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:36 INFO - 'SHELL': '/bin/bash', 15:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:38:36 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:36 INFO - 'USER': 'cltbld', 15:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:36 INFO - 'XPC_FLAGS': '0x0', 15:38:36 INFO - 'XPC_SERVICE_NAME': '0', 15:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:36 INFO - Downloading/unpacking psutil>=3.1.1 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:38:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:39 INFO - Installing collected packages: psutil 15:38:39 INFO - Running setup.py install for psutil 15:38:39 INFO - building 'psutil._psutil_osx' extension 15:38:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:38:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:38:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:38:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:38:40 INFO - building 'psutil._psutil_posix' extension 15:38:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:38:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:38:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:38:40 INFO - ^ 15:38:40 INFO - 1 warning generated. 15:38:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:40 INFO - Successfully installed psutil 15:38:40 INFO - Cleaning up... 15:38:40 INFO - Return code: 0 15:38:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:40 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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:40 INFO - 'HOME': '/Users/cltbld', 15:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:40 INFO - 'LOGNAME': 'cltbld', 15:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:40 INFO - 'MOZ_NO_REMOTE': '1', 15:38:40 INFO - 'NO_EM_RESTART': '1', 15:38:40 INFO - 'PAGER': '/bin/cat', 15:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:40 INFO - 'PWD': '/builds/slave/test', 15:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:40 INFO - 'SHELL': '/bin/bash', 15:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:38:40 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:40 INFO - 'USER': 'cltbld', 15:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:40 INFO - 'XPC_FLAGS': '0x0', 15:38:40 INFO - 'XPC_SERVICE_NAME': '0', 15:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:38:43 INFO - Installing collected packages: mozsystemmonitor 15:38:43 INFO - Running setup.py install for mozsystemmonitor 15:38:43 INFO - Successfully installed mozsystemmonitor 15:38:43 INFO - Cleaning up... 15:38:43 INFO - Return code: 0 15:38:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:38:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:43 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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:43 INFO - 'HOME': '/Users/cltbld', 15:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:43 INFO - 'LOGNAME': 'cltbld', 15:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:43 INFO - 'MOZ_NO_REMOTE': '1', 15:38:43 INFO - 'NO_EM_RESTART': '1', 15:38:43 INFO - 'PAGER': '/bin/cat', 15:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:43 INFO - 'PWD': '/builds/slave/test', 15:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:43 INFO - 'SHELL': '/bin/bash', 15:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:38:43 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:43 INFO - 'USER': 'cltbld', 15:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:43 INFO - 'XPC_FLAGS': '0x0', 15:38:43 INFO - 'XPC_SERVICE_NAME': '0', 15:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:44 INFO - Downloading/unpacking jsonschema==2.5.1 15:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:38:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:38:47 INFO - warning: no files found matching '*.txt' 15:38:47 INFO - no previously-included directories found matching 'build' 15:38:47 INFO - no previously-included directories found matching 'dist' 15:38:47 INFO - no previously-included directories found matching '.git*' 15:38:47 INFO - Installing collected packages: jsonschema, functools32 15:38:47 INFO - Running setup.py install for functools32 15:38:47 INFO - warning: no files found matching '*.txt' 15:38:47 INFO - no previously-included directories found matching 'build' 15:38:47 INFO - no previously-included directories found matching 'dist' 15:38:47 INFO - no previously-included directories found matching '.git*' 15:38:47 INFO - Successfully installed jsonschema functools32 15:38:47 INFO - Cleaning up... 15:38:47 INFO - Return code: 0 15:38:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:38:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:38:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:47 INFO - 'HOME': '/Users/cltbld', 15:38:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:47 INFO - 'LOGNAME': 'cltbld', 15:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:47 INFO - 'MOZ_NO_REMOTE': '1', 15:38:47 INFO - 'NO_EM_RESTART': '1', 15:38:47 INFO - 'PAGER': '/bin/cat', 15:38:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:47 INFO - 'PWD': '/builds/slave/test', 15:38:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:47 INFO - 'SHELL': '/bin/bash', 15:38:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:38:47 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:38:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:47 INFO - 'USER': 'cltbld', 15:38:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:47 INFO - 'XPC_FLAGS': '0x0', 15:38:47 INFO - 'XPC_SERVICE_NAME': '0', 15:38:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:38:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:38:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:51 INFO - Downloading docopt-0.6.1.tar.gz 15:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:38:51 INFO - Installing collected packages: blobuploader, requests, docopt 15:38:51 INFO - Running setup.py install for blobuploader 15:38:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:38:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:38:51 INFO - Running setup.py install for requests 15:38:51 INFO - Running setup.py install for docopt 15:38:52 INFO - Successfully installed blobuploader requests docopt 15:38:52 INFO - Cleaning up... 15:38:52 INFO - Return code: 0 15:38:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:52 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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:38:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:38:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:52 INFO - 'HOME': '/Users/cltbld', 15:38:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:52 INFO - 'LOGNAME': 'cltbld', 15:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:52 INFO - 'MOZ_NO_REMOTE': '1', 15:38:52 INFO - 'NO_EM_RESTART': '1', 15:38:52 INFO - 'PAGER': '/bin/cat', 15:38:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:52 INFO - 'PWD': '/builds/slave/test', 15:38:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:52 INFO - 'SHELL': '/bin/bash', 15:38:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:38:52 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:38:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:52 INFO - 'USER': 'cltbld', 15:38:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:52 INFO - 'XPC_FLAGS': '0x0', 15:38:52 INFO - 'XPC_SERVICE_NAME': '0', 15:38:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:52 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-wbTcLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:52 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-xbmuZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:52 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ScC8YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:52 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-VnJeai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:52 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-siQUrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:52 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-oMgxHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-0JYGMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-A1JfnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-G5eztU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-N_8ZOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-IqGMoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Sc8CqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-qZ_FmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-HtePb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:53 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-gNS9y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:54 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-W06yjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:54 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-HaL0tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:38:54 INFO - Running setup.py install for manifestparser 15:38:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:38:54 INFO - Running setup.py install for mozcrash 15:38:54 INFO - Running setup.py install for mozdebug 15:38:54 INFO - Running setup.py install for mozdevice 15:38:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:38:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:38:54 INFO - Running setup.py install for mozfile 15:38:55 INFO - Running setup.py install for mozhttpd 15:38:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Running setup.py install for mozinfo 15:38:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Running setup.py install for mozInstall 15:38:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Running setup.py install for mozleak 15:38:55 INFO - Running setup.py install for mozlog 15:38:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Running setup.py install for moznetwork 15:38:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:38:55 INFO - Running setup.py install for mozprocess 15:38:56 INFO - Running setup.py install for mozprofile 15:38:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:38:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:38:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:38:56 INFO - Running setup.py install for mozrunner 15:38:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:38:56 INFO - Running setup.py install for mozscreenshot 15:38:56 INFO - Running setup.py install for moztest 15:38:56 INFO - Running setup.py install for mozversion 15:38:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:38:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:38:56 INFO - Cleaning up... 15:38:56 INFO - Return code: 0 15:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:56 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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:38:56 INFO - 'HOME': '/Users/cltbld', 15:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:38:56 INFO - 'LOGNAME': 'cltbld', 15:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:56 INFO - 'MOZ_NO_REMOTE': '1', 15:38:56 INFO - 'NO_EM_RESTART': '1', 15:38:56 INFO - 'PAGER': '/bin/cat', 15:38:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:56 INFO - 'PWD': '/builds/slave/test', 15:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:38:56 INFO - 'SHELL': '/bin/bash', 15:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:38:56 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:38:56 INFO - 'USER': 'cltbld', 15:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:56 INFO - 'XPC_FLAGS': '0x0', 15:38:56 INFO - 'XPC_SERVICE_NAME': '0', 15:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-NV08IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-gP3fQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-E6r7So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-mx_kvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-XJaPoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-2hFJv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Ggzyhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-2zVjkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:57 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-vXOCgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-mzWX9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-H_jvAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-cOAWPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-IU9kIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Yc1rVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-j_XFi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-SjxkHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:58 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-gUlnnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:01 INFO - Downloading blessings-1.6.tar.gz 15:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:39:01 INFO - Installing collected packages: blessings 15:39:01 INFO - Running setup.py install for blessings 15:39:01 INFO - Successfully installed blessings 15:39:01 INFO - Cleaning up... 15:39:01 INFO - Return code: 0 15:39:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:01 INFO - Reading from file tmpfile_stdout 15:39:01 INFO - Current package versions: 15:39:01 INFO - blessings == 1.6 15:39:01 INFO - blobuploader == 1.2.4 15:39:01 INFO - docopt == 0.6.1 15:39:01 INFO - functools32 == 3.2.3-2 15:39:01 INFO - jsonschema == 2.5.1 15:39:01 INFO - manifestparser == 1.1 15:39:01 INFO - mozInstall == 1.12 15:39:01 INFO - mozcrash == 0.17 15:39:01 INFO - mozdebug == 0.1 15:39:01 INFO - mozdevice == 0.48 15:39:01 INFO - mozfile == 1.2 15:39:01 INFO - mozhttpd == 0.7 15:39:01 INFO - mozinfo == 0.9 15:39:01 INFO - mozleak == 0.1 15:39:01 INFO - mozlog == 3.2 15:39:01 INFO - moznetwork == 0.27 15:39:01 INFO - mozprocess == 0.22 15:39:01 INFO - mozprofile == 0.28 15:39:01 INFO - mozrunner == 6.11 15:39:01 INFO - mozscreenshot == 0.1 15:39:01 INFO - mozsystemmonitor == 0.3 15:39:01 INFO - moztest == 0.7 15:39:01 INFO - mozversion == 1.4 15:39:01 INFO - psutil == 3.1.1 15:39:01 INFO - requests == 1.2.3 15:39:01 INFO - wsgiref == 0.1.2 15:39:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:01 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 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:01 INFO - 'HOME': '/Users/cltbld', 15:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:01 INFO - 'LOGNAME': 'cltbld', 15:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:01 INFO - 'MOZ_NO_REMOTE': '1', 15:39:01 INFO - 'NO_EM_RESTART': '1', 15:39:01 INFO - 'PAGER': '/bin/cat', 15:39:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:01 INFO - 'PWD': '/builds/slave/test', 15:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:01 INFO - 'SHELL': '/bin/bash', 15:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:39:01 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:01 INFO - 'USER': 'cltbld', 15:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:01 INFO - 'XPC_FLAGS': '0x0', 15:39:01 INFO - 'XPC_SERVICE_NAME': '0', 15:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:39:02 INFO - Cleaning up... 15:39:02 INFO - Return code: 0 15:39:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d878a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb10589750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, '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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:02 INFO - 'HOME': '/Users/cltbld', 15:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:02 INFO - 'LOGNAME': 'cltbld', 15:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:02 INFO - 'MOZ_NO_REMOTE': '1', 15:39:02 INFO - 'NO_EM_RESTART': '1', 15:39:02 INFO - 'PAGER': '/bin/cat', 15:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:02 INFO - 'PWD': '/builds/slave/test', 15:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:02 INFO - 'SHELL': '/bin/bash', 15:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:39:02 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:02 INFO - 'USER': 'cltbld', 15:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:02 INFO - 'XPC_FLAGS': '0x0', 15:39:02 INFO - 'XPC_SERVICE_NAME': '0', 15:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:39:02 INFO - Cleaning up... 15:39:02 INFO - Return code: 0 15:39:02 INFO - Running post-action listener: _resource_record_post_action 15:39:02 INFO - Running post-action listener: _start_resource_monitoring 15:39:02 INFO - Starting resource monitoring. 15:39:02 INFO - ##### 15:39:02 INFO - ##### Finished create-virtualenv step (success) 15:39:02 INFO - ##### 15:39:02 INFO - ##### 15:39:02 INFO - ##### Running install step. 15:39:02 INFO - ##### 15:39:02 INFO - Running pre-action listener: _resource_record_pre_action 15:39:02 INFO - Running main action method: install 15:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:02 INFO - Reading from file tmpfile_stdout 15:39:02 INFO - Detecting whether we're running mozinstall >=1.0... 15:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:39:02 INFO - Reading from file tmpfile_stdout 15:39:02 INFO - Output received: 15:39:02 INFO - Usage: mozinstall [options] installer 15:39:02 INFO - Options: 15:39:02 INFO - -h, --help show this help message and exit 15:39:02 INFO - -d DEST, --destination=DEST 15:39:02 INFO - Directory to install application into. [default: 15:39:02 INFO - "/builds/slave/test"] 15:39:02 INFO - --app=APP Application being installed. [default: firefox] 15:39:02 INFO - mkdir: /builds/slave/test/build/application 15:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:39:37 INFO - Reading from file tmpfile_stdout 15:39:37 INFO - Output received: 15:39:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:39:37 INFO - Running post-action listener: _resource_record_post_action 15:39:37 INFO - ##### 15:39:37 INFO - ##### Finished install step (success) 15:39:37 INFO - ##### 15:39:37 INFO - ##### 15:39:37 INFO - ##### Running run-tests step. 15:39:37 INFO - ##### 15:39:37 INFO - Running pre-action listener: _resource_record_pre_action 15:39:37 INFO - Running main action method: run_tests 15:39:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:39:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:39:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:39:37 INFO - 2016-07-01 15:39:37.917 screenresolution[1645:7452] starting screenresolution argv=screenresolution get 15:39:37 INFO - 2016-07-01 15:39:37.920 screenresolution[1645:7452] Display 0: 1600x1200x32@60 15:39:37 INFO - 2016-07-01 15:39:37.926 screenresolution[1646:7454] starting screenresolution argv=screenresolution list 15:39:37 INFO - Available Modes on Display 0 15:39:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:39:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:39:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:39:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:39:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:39:38 INFO - Intel Iris: 15:39:38 INFO - Chipset Model: Intel Iris 15:39:38 INFO - Type: GPU 15:39:38 INFO - Bus: Built-In 15:39:38 INFO - VRAM (Dynamic, Max): 1536 MB 15:39:38 INFO - Vendor: Intel (0x8086) 15:39:38 INFO - Device ID: 0x0a2e 15:39:38 INFO - Revision ID: 0x0009 15:39:38 INFO - Displays: 15:39:38 INFO - Display: 15:39:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:39:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:39:38 INFO - Display Serial Number: 1600x1200 60 15:39:38 INFO - Main Display: Yes 15:39:38 INFO - Mirror: Off 15:39:38 INFO - Online: Yes 15:39:38 INFO - Rotation: Supported 15:39:38 INFO - Return code: 0 15:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:39:38 INFO - Python 2.7.3 15:39:38 INFO - Return code: 0 15:39:38 INFO - grabbing minidump binary from tooltool 15:39:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:38 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 0x10d7dcd30>, '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 0x10d541db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d7d4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:39:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:39:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:39:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:39:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:39:38 INFO - Return code: 0 15:39:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:39:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:39:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:39:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:39:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:39:38 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:39:38 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0300 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZuZbuxpQZQ/Render', 15:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:38 INFO - 'HOME': '/Users/cltbld', 15:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:38 INFO - 'LOGNAME': 'cltbld', 15:39:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:39:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:38 INFO - 'MOZ_NO_REMOTE': '1', 15:39:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:39:38 INFO - 'NO_EM_RESTART': '1', 15:39:38 INFO - 'PAGER': '/bin/cat', 15:39:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:38 INFO - 'PWD': '/builds/slave/test', 15:39:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:38 INFO - 'SHELL': '/bin/bash', 15:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V4zAAoUuJb/Listeners', 15:39:38 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 15:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:38 INFO - 'USER': 'cltbld', 15:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:38 INFO - 'XPC_FLAGS': '0x0', 15:39:38 INFO - 'XPC_SERVICE_NAME': '0', 15:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:39:38 INFO - mozversion application_buildid: 20160701144122 15:39:38 INFO - mozversion application_changeset: 2256463545d7e69ebe2c36e0fdea569df1db8fbb 15:39:38 INFO - mozversion application_display_name: Nightly 15:39:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:39:38 INFO - mozversion application_name: Firefox 15:39:38 INFO - mozversion application_remotingname: firefox 15:39:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:39:38 INFO - mozversion application_vendor: Mozilla 15:39:38 INFO - mozversion application_version: 50.0a1 15:39:38 INFO - mozversion platform_buildid: 20160701144122 15:39:38 INFO - mozversion platform_changeset: 2256463545d7e69ebe2c36e0fdea569df1db8fbb 15:39:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:39:38 INFO - mozversion platform_version: 50.0a1 15:39:38 INFO - using testdate: 1467412778 15:39:38 INFO - actual date: 1467412778 15:39:38 INFO - starting webserver on 'localhost:49277' 15:39:38 INFO - SUITE-START | Running 2 tests 15:39:38 INFO - TEST-START | dromaeo_css 15:39:38 INFO - operating with platform_type : mac_ 15:39:38 INFO - Initialising browser for dromaeo_css test... 15:39:38 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpcILcJz/profile http://localhost:49277/getInfo.html) 15:39:40 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 15:39:40 INFO - PROCESS | 1656 | colorDepth:24 15:39:40 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 15:39:40 INFO - PROCESS | 1656 | __metrics 15:39:41 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:39:41 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:39:41 INFO - TEST-INFO | 1656: exit 0 15:39:41 INFO - Browser initialized. 15:39:41 INFO - Running cycle 1/1 for dromaeo_css test... 15:39:41 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpcILcJz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:53 INFO - PROCESS | 1658 | RSS: Main: 244604928 15:39:53 INFO - PROCESS | 1658 | 15:40:44 INFO - PROCESS | 1658 | 1467412844654 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:42:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 15:42:57 INFO - PROCESS | 1658 | RSS: Main: 369541120 15:42:57 INFO - PROCESS | 1658 | 15:46:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 15:46:00 INFO - PROCESS | 1658 | RSS: Main: 377610240 15:46:00 INFO - PROCESS | 1658 | 15:49:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 15:49:03 INFO - PROCESS | 1658 | RSS: Main: 372019200 15:49:03 INFO - PROCESS | 1658 | 15:52:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 15:52:06 INFO - PROCESS | 1658 | RSS: Main: 369422336 15:52:06 INFO - PROCESS | 1658 | 15:55:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 15:55:10 INFO - PROCESS | 1658 | RSS: Main: 342929408 15:55:10 INFO - PROCESS | 1658 | 15:58:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 15:58:14 INFO - PROCESS | 1658 | RSS: Main: 379838464 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | __start_tp_report 15:58:14 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 15:58:14 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 15:58:14 INFO - PROCESS | 1658 | |i|pagename|runs| 15:58:14 INFO - PROCESS | 1658 | |0;dojo.html;3272.3291725196336;3285.8357082145885;3299.191698033981;3313.2545177335087;3344.48160535117;5525.0883604205255;5527.91708124378;5586.35756887958;5607.551395888329;5650.011248031598;5518.061929471999;5564.4713752193575;5661.943380566193;5696.829095127143;5726.7422965966525;5036.722980236085;5041.697498150123;5112.130937740574;5114.948850511503;5204.016576346828;4304.698671093025;5138.2806407103035;5153.3815942087;5181.844544663666;5216.660917040399;5027.899442011158;5063.291139240509;5096.668716533413;5138.075146473633;5163.561097306733;5117.590592752571;5126.769295381717;5132.435432102466;5140.537351638333;5147.485251474823;5006.874828129326;5092.516210959953;5093.312402825608;5121.743912804345;5123.769430375604;5509;5603.2715746953045;5676.1769543416385;5707.857303567444;5708.400617935098;5866.413358664099;6091.329953705089;6121.846953826145;6147.415995480467;6150.630962142241;6089.642816147896;6137.285055221551;6193.845153871144;6216.222972128484;6266.404691554295;5705.942940570624;5747.511461525775;5756.079027355603;5763.711814409305;5766.077427611562;6129.938700613026;6189.04069869171;6294.905576416358;6295.716692748837;6314.400131987454;5944.940550594525;6006.489448396847;6048.243969503812;6052.515798736091;6052.697365131726;5419.3225846769155;6168.383161683796;6173.351798061229;6181.7527298908435;6205.689715514297;5907.350191478934;5940.198073260141;5969.552283578749;6067.998780201306;6092.208012958287;6040.912635725612;6085.66528840918;6090.847728806815;6116.204893363834;6125.050617154348;4276.422682937826;4739.980904105634;4799.3041009053495;4824.589909857631;4851.442084160296;4285.721428107163;4346.152500262482;4354.368616550646;4355.4337936068105;4388.451443569554;5532.6680399176175;5603.327600687862;5604.3835178130375;5622.184783206412;5625.409332020161;6118.847028824315;6126.509879209652;6132.722655450988;6140.197513349842;6198.101275315144;5623.044082505902;5637.9718101409235;5641.492265696107;5652.236948012048;5671.602987790815;5141.640085194001;5271.314729085195;5313.814016509404;5320.680759154463;5321.281626980385;6219.813405597839;6281.371862813682;6288.245410550763;6300.117983482316;6321.209848768904;5148.30497882781;6190.0405437157315;6232.25212974446;6239.625622462667;6255.24937007562;6172.537059720628;6258.593191442542;6290.9056364155485;6296.0555916612875;6299.496040316855;5133.6919784813035;6021.608595441282;6072.939270607414;6084.787032453843;6134.650895842656;6165.136880836776;6186.288576813724;6199.132121503083;6206;6216.720247588779;5780.971095144498;5860.706964651836;5959.76160953557;5971.850703732442;5991.700414979321;5804.941950580609;5879.911801322898;5890.410958904075;5944.989351810289;5974.551908606785;5799.246098007232;5826.504747096545;5830.737616807169;5836.854078648068;5890.204822348928;5977.3424923257535;6001.4298641628975;6010;6011.6994150293185;6036.094585811988;5656.462636049569;5703.657780533182;5706.343770466284;5773.1051686988585;5803.7968671096305 15:58:14 INFO - PROCESS | 1658 | |1;ext.html;492.8028788484606;497.4105684763554;501.656365389708;505.67384037295966;508.3416975017352;30711.385772284542;32592;32626.347473050526;40631.781046568576;41737.791311043475;43086;43186.92032699176;43478.34782478258;43568.73234507409;43592.474263400785;9707.271954603415;9894.307398482073;9899.50502474877;9902.653407130752;9915.405075695446;8840.248578870804;8937.910620893805;8943.910560894405;9023.45859248444;9742.51287435629;8877;11848.229865058787;11973.40132993347;11974.101942354315;12228.266304021743;12001.819972700416;12046.819297710541;12067.275963442222;12073.698157546043;12075.637730868044;7401.185869554345;11608.883911160865;11688;11696.707582310426;11699.649010529698;40403.191936161405;40799;40851.97870053272;43137.92155196145;43148.35277470841;3468.8785892493893;3495.615482296945;3600.891973240807;3602.5949879546997;3842.9615703842883;31868.362632747216;31878.681213187803;32710.018699439053;33099;33237.338133093246;3353.3293341331832;3378.408778463759;3454.5336379588684;3456.5333679953137;3457.6023757267985;511880;512036.4398178022;512508;513118;513272;59525.404745951986;61057.69471152616;61117.38882611206;61164.38835611676;61200.693996529735;64190.67904660447;64378;64387;64436;64474;16565.337386504645;16793.160341982853;16820.6635867282;16845;16915.830841691673;12852.485900563872;12869.485220591072;12917.28954907489;12926.482940682268;12930.806037909439;14773.630659233606;15188.088714677155;15622.140782256858;17130.886492377955;17172.22724977379;5247.658902171423;6064.75672487139;6155.569110162246;6245;6269.279032911182;891.2201823404521;1048.6487026846091;1063.4044934836515;1101.4823033174396;1155.757290968889;30341.69658303433;30560.84719576388;30623.693763062085;31247.531287030713;31374.215644609067;906.7260498998917;1078.5470102556944;1088.2001728729379;1125.7354521687396;1158.8667303260065;14978.70042599142;15852.76220856688;16020.75968860468;16054.919725401533;16469.34122635081;670212;673515;674102;679575;682153;60088;60277.69861150666;60346.698266509266;60414.69792651009;60478.488037799405;1375.1474086066503;1396.804447377368;1414.7099844532052;1416.3060100550863;1421.069199674215;29108.708912911447;30493.54259686062;30850.537241941838;31262;31562.684373155975;51946;52042.47957520376;52382.21426678527;52429.68925776886;52437.737811312225;541301;542920;543811;544748;545517;41671.37492937669;42697.14605707806;42825.57174428341;43198;43204.78397607992;38861.6113838858;40044.59955400409;40877.59122408738;46405.76797115993;47858.76070619764;40387.394189087776;40457.797711011255;40929.38605920973;41542.79228603838;41848.790756047245;38265.426018609185;40044.79977600093;40532.1893562133;41138.79430602828;41317;38855.41716874193;39472;39481.605183948945;39781;39953.80023099866;27669.86165069162;28850.567241490975;35611;35846.82076589705;36202.63797361992;21613.675794862775;25374.98500059977;25556.872215638803;25982.960681572524;26529.20412387554 15:58:14 INFO - PROCESS | 1658 | |2;jquery.html;378.1925588867767;384.8960780589241;386.6520131881308;394.57386023095063;403.73757057912354;19675.70486442703;21453.141874325047;21701.34895953124;22406.88796556017;22428.439289017784;19708.408747737554;20468;20532.692009619866;21271.468213294676;21626.89186554069;5062.594992400608;5827.796027139051;6162.137300777895;6177.752889884399;6199.039148931923;3722.9441558376648;3905;3911.9608803911883;3943.8619648312315;6158.969205153968;3879.473820787663;3942.526896772377;5584.664920104807;6155.538334624899;6164.520515076394;6138.202033735631;6147.508199344042;6163.938360616404;6179.938200617981;6193.969030154843;3812.866549670748;5981.162637230791;5986.2517185351835;5989.352927944807;5991.400859913973;24931.252062438154;26188.86905565479;26265.73734262671;26799;26806.329841754112;2195.5279614882716;2303.8502497337618;2461.6430617560354;2464;2974.0631701014113;9859.802803943952;10036.548355324028;10057.949710251474;10597.894021059768;10664.573417063308;1820.4629634257794;1898.3450709505198;1977.9307724229727;1988.920443182271;2029.7868723783938;87610.17251282468;116418.99999999916;120726.3963680176;128064;133035.6696433033;8884.73345799627;11088.390138542296;11645.359505227125;11648.70878228034;11934.940325298492;14425.711485770225;14572.781408278885;14618.63453413652;14633;14634.926825366018;8659.090795466385;8662.610182541675;8733.825323493495;8789.692360767342;8803;8692.043875173726;8704.260137888225;8710.303175745925;8816;8824.3381746368;4480.395146655225;4562.384078149474;4571.3600095986585;4571.8570357410645;4621.052684199731;1703.3186725309727;1847.5496735062911;1878.8496920246348;1907.1036612791966;1919.6640587897061;786.614558866163;798.3613109512366;827.8840962265288;933.6918816790443;944.9652630369734;20795.376138715863;21283;21346.573068538542;21353.78646213549;21401.25095621677;829.6266679994027;928.9071092890657;970.5583959298502;976.8974257702981;1008.8032833597525;8615.655373784979;11106.666799996014;11136.109111271078;11275.774484510264;11333.659990200142;618708;629052;630205;630547;637353;72953.54092918219;120750;126446;144723;152705;998.9350692204983;1000.7348052766023;1020.0921180149821;1023.9897601024044;1026.5483187397522;19248.518787030436;19601.70597441011;19619.664657008627;19661.803381965998;19691.901540492207;55494.72252638711;55636.72181639066;55933;55977.44022559722;56763.71618141883;83365;84561;85985.57007214923;90408.67139300186;92525;7920.940555455738;7935.880961785693;7941.205879412013;8181.877271840808;8393.454425462569;11292.60475883373;12943.5469758558;12953.740925181632;13233.669158271121;13247.602571922858;11169.664910052712;11222.102231821598;11238.55045798159;11412;11499.137564682514;11103.278286911325;11164;11165.38590377537;11423.029042531478;11457.541698332307;11373.488193031499;11395.829062564235;11415.486303116213;11421.428928553372;11488.54045838157;7993;8087.47431416956;8130.959345203236;8187.631556579849;8286.04710458305;9834.950825246115;11186;11201.831972520582;11273.661790146309;11418.771624567627 15:58:14 INFO - PROCESS | 1658 | |3;mootools.html;1492.9626759331018;1555.953321400358;1728.343229572762;1867.7571915650963;1897.4212865076154;8588.227059564639;8843.159899809523;9052.77368065797;9060.275177985763;9060.501672408014;7897.881531777028;8132.918670813305;8422.536760478171;8724.214820666155;8827.426217295872;2333;2360.9173678921243;2400.327908185711;2401.555712193241;2402.651615515749;2349.3186975777003;2374.5725769361507;2421.249412682065;2421.6004359280696;2427.1383658801137;2119.395972147938;2213.7454192767877;2331.2889568681544;2408.1932552594903;2412.300432874464;2343.53129374125;2375.596148654733;2377.7027871515975;2385.689860318165;2406.049610403898;2012.8087831656117;2347.718273807137;2369.040538581877;2388.176079252655;2393.222202784102;8708.346873984414;8759.343049271267;8775.297976161892;8779.429337093132;8793.252573531257;5300.681959082467;5404.270423492818;5443.782248710087;5448.700321482317;5460.918086228709;3609.675129238355;3647.8723244686307;3696.3900956342172;3701.222743223926;3710.870119545803;1080.9783804323947;1083.0415082651832;1085.918556108295;1107.9279846810011;1108.4236197177422;11675.357855317954;11892;11915.761684766343;11917.880821191764;11922;4655.301704744248;4668;4875.512448755097;4897.681650692693;4907.141250281186;10183.236257280734;10214.489275536342;10215.182785377152;10219.642312519027;10231.079202871628;5447.237386765856;5455.236266922634;5456.809011684572;5464.91802622953;5474.890502189934;4856.2958371036;4907.699459643198;4987.825426110068;4997.9500204997485;5004.049230646166;3868.5551161616213;3893.3186692328727;3951.8616848410165;4008.8396464141692;4052.2908491013955;1215.8844909733562;1243.7077286837587;1271.3389037700529;1274.9745005099846;1297.6236891301605;714.9857002860018;865.3639574912435;892.9910700893038;932.3100905330007;992.5781542844262;6080.574359794772;6166.105914642441;6183.227096612924;6287.748490060347;6316;945.3099237556622;949.1030975727871;956.6173530587821;988.7429268390271;989.6239429017071;3646.361886669822;3717.3978215248894;3912.4326972589383;4202.411662367271;4219.78901054946;10614.946925265323;10813.783724325627;10830.404327761891;10924.453777311102;11042.006219440289;10866.185036122322;10883.945580272206;10884.693836739641;10886.891131088587;10895.291806032741;7401.48189626721;7925.445218834626;8292.668293268322;8293.004839419309;8426.199511046441;6044.486218671286;6093.725782339717;6164.938350616616;6223.439890409885;6323.272823625342;8248.59773838461;10250.05249002687;10253.282270241012;10260.743481413025;10276.537555810157;10162.441065741456;10285.125764309818;10324.690259292232;10324.793504129726;10364.948175259075;7529.058867641545;7609.201033891583;7626.504277221963;7708;7719.266669666373;8257.256846883809;8277.255047045795;8365.790855228668;8366.70716524943;8374.832503349777;7516.022917020752;7661.961690191513;7681.385489160965;7810.297073263434;7841.725539606315;7418.369438597564;7446.515976461513;7518.436117291116;7550.150213197801;7659.846803064019;7150.5352152109945;7191.712331506681;7208.603526806076;7216.5670059796585;7228.168760592389;4977;5126.154184559506;5157.329547158995;5183.663061900965;5248.343957005374;5110.3356563646485;5122.974385128051;5133.974330128325;5147.562457191031;5331.466853314792 15:58:14 INFO - PROCESS | 1658 | |4;prototype.html;303.50074128059345;306.4805155261832;313.4577181476045;313.5594489741913;316.7925009119028;4425.446819147606;5294.52349288564;5299.8940021199605;5309.33633295838;5341.786328546863;4333.479982402117;5273.2617433559335;5284.524392804657;5296.073187192245;5313.362396512424;3077.276725033977;3969.98015009926;3987;3988.2850374339023;4009.6992725545556;3635.2366003139373;3795.3679917635404;3995.820188091543;4030.45588845505;4040.2121586290687;3566.3045706087323;3655.561332640087;3982.721209515335;4002.5997400259885;4008.3386241270155;3440.8623655053766;4003.917962659401;4022.818973146186;4023.3445925688907;4024.953512086849;2984.4329577380227;3330.350581636582;3424.6061702904235;3455.395305821471;3467.1852114753015;4086.5913408659194;4160.583941605815;4435.401220835178;5093.439721630618;5122.948770512285;3747.437884317374;3977.6420122189143;4560.270356742938;4601.608863246628;4613.561711637389;4277.8288868445225;4535.598301274044;5212.592599998017;5518.972405137989;5534.4742249486235;3293.917652058694;3767.9088106101103;3775.452559378875;3779.5653499847595;3790.336691079078;5530.340897730664;5736.529399713155;5746.683932383718;5780.624259423124;5800.854978625526;3098.814071155738;3469.935388443872;3758.1544152566003;3758.567764707094;3760.435934609776;3225.741940644743;3395.405803984293;3845.750026248285;3883.49514563105;3886.8833934981994;4521.174266083698;4522.4573051234065;4526.4199406338075;4545.340950553024;4567.771611419415;4817.542333478314;4825.686330388514;5594.664320140804;5597.160425936061;5623.297087864017;1271.8473783145896;1307.1895424836473;1325.304215286982;1331.5605850069453;1333.9061969185368;609.6677310865589;715.6207210178613;795.8129839487716;807.5625386811485;817.595290331278;3890.4747859039235;4320.611144996966;4346.087321662486;4349.782510874444;4368.2261763780225;3951.3677811550015;4111.444954931046;4285.657147428198;4773.689710168828;4789.95210047902;4005.6995725320717;4066.1905452074134;4288.742675439484;4327.545607711208;4354.521002689701;2294.89672964717;2461.4584791345874;2496.937576560564;2511.3470497670373;2520.407704189514;4218.557051509609;4869.683470574401;4912.9508704913205;4917.500162450487;4931.756050996788;4804.429630147854;4845.491223421561;4846.151923413459;4862.884645179358;4926.33494478248;4113.251867956166;4830.6135509159185;4911.256503941121;4928.7289199093675;5761.654300741969;5025.894303253279;5072.771725272298;5419.458054194549;5674.914876276776;5705;5034.471380504994;5240.9518096381635;5566.805161819317;5588.273524441959;5595.972020139873;5233.168391063097;5573.888522229451;5779.364269930388;5890.705464726832;5891.703825158458;3154.66875978019;3627;3786.981065094657;3798.9240215196096;3801.1257410796225;4994.400671919393;5693.829185124453;5750.108733146369;5750.6262092963825;5766.394528574439;4525.818967241274;4633.119707255611;5213.263036905503;5281.762320695501;5587.608867379245;4212.768297743531;4720.645951553716;4879.707217566957;5499.312585926759;5523.061079616556;4437.733735975852;4444.355568442623;4727.125481785881;5289.280983680243;5402;4969.975150124226;5442.319710036246;5507.972460137674;5509.611588872895;5509.614326997072;5251.684898906078;5294.311739473844;5374.247605335335;5387.488188622075;5428.348598168245 15:58:14 INFO - PROCESS | 1658 | |5;yui.html;731.9304666056724;743.9256074392562;769.7459838253377;808.5391326943644;839.1901814748768;15268.465603703873;16417.91791041043;16446.917765411155;16465.09441980692;16469.917650411746;14655.780163297559;14881.479148229813;14901.105933643961;14907.180105094243;14919.627009324773;690.6581242285064;716.1799739298526;841.5960339037266;863.4689665855517;873.0440168016012;856.8200677857658;870.8954925408929;872.2803686958254;873.5719497446269;875.4134729731063;924.1405492891608;924.5469719837265;926.6293482606944;927.0729270729271;929.2751653710117;730.7661548304544;899.874017637528;907.6233363154283;913.9497327647043;915.1717695485596;681.3901558105517;684.3259389501337;684.7534887440518;684.9212340580797;687.1273482676972;14952.62618434537;14959.700805983819;14964.625884352869;15004.474843380538;15005.699886002329;14226.92886535571;14269.429222831075;14288.357023933844;14348.995570310082;14455.27723613815;12829.358532073358;12943.67640808978;13029.609111726664;13049.347532623426;13338.19970801755;4521.412216411845;4656.278276867091;4753.073150735608;4795.832145874878;4796.2326027835725;116898;117143.41428292889;117260;117396.41301793436;117595;11192.664220073248;11250.831237531444;11258.774824503627;11261.831072533918;11287.717807054725;22229.221977230718;22230.999605017812;22249;22251.666225006637;22257.332280031624;8047.913531673266;8070.273675369245;8106.878396824052;8108.797280067927;8299.709510167115;4358.912821743547;4427.667924905581;4486.730796152241;4529.54704529551;4618.953810461852;3503.194265318991;3607.3687104756564;3608.3685355062757;3611.6749492545796;3617.5839778425816;637.1398611873933;652.2759736692268;660.7720336483906;661.2924171136933;668.8896332105148;520.5757307794136;578.8784355285353;606.8968275393194;659.0937460991137;680.1701923653135;9072.773180670536;9206.26349892007;9241.953790231006;9289.791056628148;9583.856242156373;551.9586031047687;656.474820143883;668.0413606474724;677.3937326093218;696.5159214345981;4305.935410968838;4646.581807637329;4698.459677137173;4743.683248244081;4839.540243676845;139420;141348;143379;143602.28198858938;148085;130406;133167;135091.64908350792;135340.9698854518;138309.3084534591;99835.51891532421;112823.2306061639;115579.42210288894;117672;119237;8842.292616590787;9010.32422568323;9228.667308238928;9250.259979201783;9306.953465232902;48193;58536;59623.70188149031;60075.69962150161;60374;91251.1561632867;95022;95964.23755057022;97486.63823489776;100611;12028.939855300667;12095;12134;12208.32854193028;12326.75346493083;13548.25484598317;13596.728065438834;13603.251821149932;13668.589942301747;13774.173549586656;12278.508859645513;12491.625251242478;12532.185407948455;12833;13052.412641431349;12424.130310878514;12441.93779031099;12463.875361246271;12524.686882828002;12592.307423091452;12092.75814483723;12229.877701222875;12231.327276999851;12346.81479777786;12410.937945310216;9952.502374881371;10565.524551395052;10590.311629744043;11021.063209626951;11062.502187401748;10231.795364092824;10439.58241670355;10566.471676416302;10588.41763702973;10794.892051079703 15:58:14 INFO - PROCESS | 1658 | __end_tp_report 15:58:14 INFO - PROCESS | 1658 | __start_cc_report 15:58:14 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1258 15:58:14 INFO - PROCESS | 1658 | __end_cc_report 15:58:14 INFO - PROCESS | 1658 | __startTimestamp1467413894109__endTimestamp 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | ------- Summary: start ------- 15:58:14 INFO - PROCESS | 1658 | Number of tests: 6 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5627.12 Median:5780.97 stddev:647.61 (11.2%) stddev-sans-first:622.69 15:58:14 INFO - PROCESS | 1658 | Values: 3272.3 3285.8 3299.2 3313.3 3344.5 5525.1 5527.9 5586.4 5607.6 5650.0 5518.1 5564.5 5661.9 5696.8 5726.7 5036.7 5041.7 5112.1 5114.9 5204.0 4304.7 5138.3 5153.4 5181.8 5216.7 5027.9 5063.3 5096.7 5138.1 5163.6 5117.6 5126.8 5132.4 5140.5 5147.5 5006.9 5092.5 5093.3 5121.7 5123.8 5509.0 5603.3 5676.2 5707.9 5708.4 5866.4 6091.3 6121.8 6147.4 6150.6 6089.6 6137.3 6193.8 6216.2 6266.4 5705.9 5747.5 5756.1 5763.7 5766.1 6129.9 6189.0 6294.9 6295.7 6314.4 5944.9 6006.5 6048.2 6052.5 6052.7 5419.3 6168.4 6173.4 6181.8 6205.7 5907.4 5940.2 5969.6 6068.0 6092.2 6040.9 6085.7 6090.8 6116.2 6125.1 4276.4 4740.0 4799.3 4824.6 4851.4 4285.7 4346.2 4354.4 4355.4 4388.5 5532.7 5603.3 5604.4 5622.2 5625.4 6118.8 6126.5 6132.7 6140.2 6198.1 5623.0 5638.0 5641.5 5652.2 5671.6 5141.6 5271.3 5313.8 5320.7 5321.3 6219.8 6281.4 6288.2 6300.1 6321.2 5148.3 6190.0 6232.3 6239.6 6255.2 6172.5 6258.6 6290.9 6296.1 6299.5 5133.7 6021.6 6072.9 6084.8 6134.7 6165.1 6186.3 6199.1 6206.0 6216.7 5781.0 5860.7 5959.8 5971.9 5991.7 5804.9 5879.9 5890.4 5945.0 5974.6 5799.2 5826.5 5830.7 5836.9 5890.2 5977.3 6001.4 6010.0 6011.7 6036.1 5656.5 5703.7 5706.3 5773.1 5803.8 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:71683.98 Median:39999.20 stddev:155361.09 (388.4%) stddev-sans-first:155704.97 15:58:14 INFO - PROCESS | 1658 | Values: 492.8 497.4 501.7 505.7 508.3 30711.4 32592.0 32626.3 40631.8 41737.8 43086.0 43186.9 43478.3 43568.7 43592.5 9707.3 9894.3 9899.5 9902.7 9915.4 8840.2 8937.9 8943.9 9023.5 9742.5 8877.0 11848.2 11973.4 11974.1 12228.3 12001.8 12046.8 12067.3 12073.7 12075.6 7401.2 11608.9 11688.0 11696.7 11699.6 40403.2 40799.0 40852.0 43137.9 43148.4 3468.9 3495.6 3600.9 3602.6 3843.0 31868.4 31878.7 32710.0 33099.0 33237.3 3353.3 3378.4 3454.5 3456.5 3457.6 511880.0 512036.4 512508.0 513118.0 513272.0 59525.4 61057.7 61117.4 61164.4 61200.7 64190.7 64378.0 64387.0 64436.0 64474.0 16565.3 16793.2 16820.7 16845.0 16915.8 12852.5 12869.5 12917.3 12926.5 12930.8 14773.6 15188.1 15622.1 17130.9 17172.2 5247.7 6064.8 6155.6 6245.0 6269.3 891.2 1048.6 1063.4 1101.5 1155.8 30341.7 30560.8 30623.7 31247.5 31374.2 906.7 1078.5 1088.2 1125.7 1158.9 14978.7 15852.8 16020.8 16054.9 16469.3 670212.0 673515.0 674102.0 679575.0 682153.0 60088.0 60277.7 60346.7 60414.7 60478.5 1375.1 1396.8 1414.7 1416.3 1421.1 29108.7 30493.5 30850.5 31262.0 31562.7 51946.0 52042.5 52382.2 52429.7 52437.7 541301.0 542920.0 543811.0 544748.0 545517.0 41671.4 42697.1 42825.6 43198.0 43204.8 38861.6 40044.6 40877.6 46405.8 47858.8 40387.4 40457.8 40929.4 41542.8 41848.8 38265.4 40044.8 40532.2 41138.8 41317.0 38855.4 39472.0 39481.6 39781.0 39953.8 27669.9 28850.6 35611.0 35846.8 36202.6 21613.7 25375.0 25556.9 25983.0 26529.2 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:36153.13 Median:26532.37 stddev:104873.25 (395.3%) stddev-sans-first:105133.05 15:58:14 INFO - PROCESS | 1658 | Values: 378.2 384.9 386.7 394.6 403.7 19675.7 21453.1 21701.3 22406.9 22428.4 19708.4 20468.0 20532.7 21271.5 21626.9 5062.6 5827.8 6162.1 6177.8 6199.0 3722.9 3905.0 3912.0 3943.9 6159.0 3879.5 3942.5 5584.7 6155.5 6164.5 6138.2 6147.5 6163.9 6179.9 6194.0 3812.9 5981.2 5986.3 5989.4 5991.4 24931.3 26188.9 26265.7 26799.0 26806.3 2195.5 2303.9 2461.6 2464.0 2974.1 9859.8 10036.5 10057.9 10597.9 10664.6 1820.5 1898.3 1977.9 1988.9 2029.8 87610.2 116419.0 120726.4 128064.0 133035.7 8884.7 11088.4 11645.4 11648.7 11934.9 14425.7 14572.8 14618.6 14633.0 14634.9 8659.1 8662.6 8733.8 8789.7 8803.0 8692.0 8704.3 8710.3 8816.0 8824.3 4480.4 4562.4 4571.4 4571.9 4621.1 1703.3 1847.5 1878.8 1907.1 1919.7 786.6 798.4 827.9 933.7 945.0 20795.4 21283.0 21346.6 21353.8 21401.3 829.6 928.9 970.6 976.9 1008.8 8615.7 11106.7 11136.1 11275.8 11333.7 618708.0 629052.0 630205.0 630547.0 637353.0 72953.5 120750.0 126446.0 144723.0 152705.0 998.9 1000.7 1020.1 1024.0 1026.5 19248.5 19601.7 19619.7 19661.8 19691.9 55494.7 55636.7 55933.0 55977.4 56763.7 83365.0 84561.0 85985.6 90408.7 92525.0 7920.9 7935.9 7941.2 8181.9 8393.5 11292.6 12943.5 12953.7 13233.7 13247.6 11169.7 11222.1 11238.6 11412.0 11499.1 11103.3 11164.0 11165.4 11423.0 11457.5 11373.5 11395.8 11415.5 11421.4 11488.5 7993.0 8087.5 8131.0 8187.6 8286.0 9835.0 11186.0 11201.8 11273.7 11418.8 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5806.51 Median:4942.35 stddev:3237.32 (65.5%) stddev-sans-first:3230.17 15:58:14 INFO - PROCESS | 1658 | Values: 1493.0 1556.0 1728.3 1867.8 1897.4 8588.2 8843.2 9052.8 9060.3 9060.5 7897.9 8132.9 8422.5 8724.2 8827.4 2333.0 2360.9 2400.3 2401.6 2402.7 2349.3 2374.6 2421.2 2421.6 2427.1 2119.4 2213.7 2331.3 2408.2 2412.3 2343.5 2375.6 2377.7 2385.7 2406.0 2012.8 2347.7 2369.0 2388.2 2393.2 8708.3 8759.3 8775.3 8779.4 8793.3 5300.7 5404.3 5443.8 5448.7 5460.9 3609.7 3647.9 3696.4 3701.2 3710.9 1081.0 1083.0 1085.9 1107.9 1108.4 11675.4 11892.0 11915.8 11917.9 11922.0 4655.3 4668.0 4875.5 4897.7 4907.1 10183.2 10214.5 10215.2 10219.6 10231.1 5447.2 5455.2 5456.8 5464.9 5474.9 4856.3 4907.7 4987.8 4998.0 5004.0 3868.6 3893.3 3951.9 4008.8 4052.3 1215.9 1243.7 1271.3 1275.0 1297.6 715.0 865.4 893.0 932.3 992.6 6080.6 6166.1 6183.2 6287.7 6316.0 945.3 949.1 956.6 988.7 989.6 3646.4 3717.4 3912.4 4202.4 4219.8 10614.9 10813.8 10830.4 10924.5 11042.0 10866.2 10883.9 10884.7 10886.9 10895.3 7401.5 7925.4 8292.7 8293.0 8426.2 6044.5 6093.7 6164.9 6223.4 6323.3 8248.6 10250.1 10253.3 10260.7 10276.5 10162.4 10285.1 10324.7 10324.8 10364.9 7529.1 7609.2 7626.5 7708.0 7719.3 8257.3 8277.3 8365.8 8366.7 8374.8 7516.0 7662.0 7681.4 7810.3 7841.7 7418.4 7446.5 7518.4 7550.2 7659.8 7150.5 7191.7 7208.6 7216.6 7228.2 4977.0 5126.2 5157.3 5183.7 5248.3 5110.3 5123.0 5134.0 5147.6 5331.5 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4246.32 Median:4540.47 stddev:1323.11 (29.1%) stddev-sans-first:1293.30 15:58:14 INFO - PROCESS | 1658 | Values: 303.5 306.5 313.5 313.6 316.8 4425.4 5294.5 5299.9 5309.3 5341.8 4333.5 5273.3 5284.5 5296.1 5313.4 3077.3 3970.0 3987.0 3988.3 4009.7 3635.2 3795.4 3995.8 4030.5 4040.2 3566.3 3655.6 3982.7 4002.6 4008.3 3440.9 4003.9 4022.8 4023.3 4025.0 2984.4 3330.4 3424.6 3455.4 3467.2 4086.6 4160.6 4435.4 5093.4 5122.9 3747.4 3977.6 4560.3 4601.6 4613.6 4277.8 4535.6 5212.6 5519.0 5534.5 3293.9 3767.9 3775.5 3779.6 3790.3 5530.3 5736.5 5746.7 5780.6 5800.9 3098.8 3469.9 3758.2 3758.6 3760.4 3225.7 3395.4 3845.8 3883.5 3886.9 4521.2 4522.5 4526.4 4545.3 4567.8 4817.5 4825.7 5594.7 5597.2 5623.3 1271.8 1307.2 1325.3 1331.6 1333.9 609.7 715.6 795.8 807.6 817.6 3890.5 4320.6 4346.1 4349.8 4368.2 3951.4 4111.4 4285.7 4773.7 4790.0 4005.7 4066.2 4288.7 4327.5 4354.5 2294.9 2461.5 2496.9 2511.3 2520.4 4218.6 4869.7 4913.0 4917.5 4931.8 4804.4 4845.5 4846.2 4862.9 4926.3 4113.3 4830.6 4911.3 4928.7 5761.7 5025.9 5072.8 5419.5 5674.9 5705.0 5034.5 5241.0 5566.8 5588.3 5596.0 5233.2 5573.9 5779.4 5890.7 5891.7 3154.7 3627.0 3787.0 3798.9 3801.1 4994.4 5693.8 5750.1 5750.6 5766.4 4525.8 4633.1 5213.3 5281.8 5587.6 4212.8 4720.6 4879.7 5499.3 5523.1 4437.7 4444.4 4727.1 5289.3 5402.0 4970.0 5442.3 5508.0 5509.6 5509.6 5251.7 5294.3 5374.2 5387.5 5428.3 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:25094.22 Median:3607.87 stddev:40282.45 (1116.5%) stddev-sans-first:40353.92 15:58:14 INFO - PROCESS | 1658 | Values: 731.9 743.9 769.7 808.5 839.2 15268.5 16417.9 16446.9 16465.1 16469.9 14655.8 14881.5 14901.1 14907.2 14919.6 690.7 716.2 841.6 863.5 873.0 856.8 870.9 872.3 873.6 875.4 924.1 924.5 926.6 927.1 929.3 730.8 899.9 907.6 913.9 915.2 681.4 684.3 684.8 684.9 687.1 14952.6 14959.7 14964.6 15004.5 15005.7 14226.9 14269.4 14288.4 14349.0 14455.3 12829.4 12943.7 13029.6 13049.3 13338.2 4521.4 4656.3 4753.1 4795.8 4796.2 116898.0 117143.4 117260.0 117396.4 117595.0 11192.7 11250.8 11258.8 11261.8 11287.7 22229.2 22231.0 22249.0 22251.7 22257.3 8047.9 8070.3 8106.9 8108.8 8299.7 4358.9 4427.7 4486.7 4529.5 4619.0 3503.2 3607.4 3608.4 3611.7 3617.6 637.1 652.3 660.8 661.3 668.9 520.6 578.9 606.9 659.1 680.2 9072.8 9206.3 9242.0 9289.8 9583.9 552.0 656.5 668.0 677.4 696.5 4305.9 4646.6 4698.5 4743.7 4839.5 139420.0 141348.0 143379.0 143602.3 148085.0 130406.0 133167.0 135091.6 135341.0 138309.3 99835.5 112823.2 115579.4 117672.0 119237.0 8842.3 9010.3 9228.7 9250.3 9307.0 48193.0 58536.0 59623.7 60075.7 60374.0 91251.2 95022.0 95964.2 97486.6 100611.0 12028.9 12095.0 12134.0 12208.3 12326.8 13548.3 13596.7 13603.3 13668.6 13774.2 12278.5 12491.6 12532.2 12833.0 13052.4 12424.1 12441.9 12463.9 12524.7 12592.3 12092.8 12229.9 12231.3 12346.8 12410.9 9952.5 10565.5 10590.3 11021.1 11062.5 10231.8 10439.6 10566.5 10588.4 10794.9 15:58:14 INFO - PROCESS | 1658 | -------- Summary: end -------- 15:58:14 INFO - PROCESS | 1658 | 15:58:14 INFO - TEST-INFO | 1658: exit 0 15:58:14 INFO - TEST-OK | dromaeo_css | took 1116274ms 15:58:14 INFO - TEST-START | kraken 15:58:14 INFO - operating with platform_type : mac_ 15:58:14 INFO - Initialising browser for kraken test... 15:58:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpSnePip/profile http://localhost:49277/getInfo.html) 15:58:17 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 15:58:17 INFO - PROCESS | 1667 | colorDepth:24 15:58:17 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 15:58:17 INFO - PROCESS | 1667 | __metrics 15:58:17 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:58:17 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:58:17 INFO - TEST-INFO | 1667: exit 0 15:58:17 INFO - Browser initialized. 15:58:17 INFO - Running cycle 1/1 for kraken test... 15:58:17 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpSnePip/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:29 INFO - PROCESS | 1668 | RSS: Main: 244867072 15:58:29 INFO - PROCESS | 1668 | 15:58:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 15:58:33 INFO - PROCESS | 1668 | RSS: Main: 293974016 15:58:33 INFO - PROCESS | 1668 | 15:58:36 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 15:58:36 INFO - PROCESS | 1668 | RSS: Main: 304488448 15:58:36 INFO - PROCESS | 1668 | 15:58:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 15:58:40 INFO - PROCESS | 1668 | RSS: Main: 389156864 15:58:40 INFO - PROCESS | 1668 | 15:58:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 15:58:43 INFO - PROCESS | 1668 | RSS: Main: 289976320 15:58:43 INFO - PROCESS | 1668 | 15:58:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:58:46 INFO - PROCESS | 1668 | RSS: Main: 293548032 15:58:46 INFO - PROCESS | 1668 | 15:58:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 15:58:49 INFO - PROCESS | 1668 | RSS: Main: 330932224 15:58:49 INFO - PROCESS | 1668 | 15:58:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 15:58:53 INFO - PROCESS | 1668 | RSS: Main: 330592256 15:58:53 INFO - PROCESS | 1668 | 15:58:55 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 15:58:56 INFO - PROCESS | 1668 | RSS: Main: 330104832 15:58:56 INFO - PROCESS | 1668 | 15:58:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:58:58 INFO - PROCESS | 1668 | RSS: Main: 311689216 15:58:58 INFO - PROCESS | 1668 | 15:59:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:01 INFO - PROCESS | 1668 | RSS: Main: 319119360 15:59:01 INFO - PROCESS | 1668 | 15:59:03 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:04 INFO - PROCESS | 1668 | RSS: Main: 318672896 15:59:04 INFO - PROCESS | 1668 | 15:59:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:07 INFO - PROCESS | 1668 | RSS: Main: 324558848 15:59:07 INFO - PROCESS | 1668 | 15:59:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:59:10 INFO - PROCESS | 1668 | RSS: Main: 325996544 15:59:10 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 15:59:12 INFO - PROCESS | 1668 | RSS: Main: 369651712 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | __start_tp_report 15:59:12 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 15:59:12 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 15:59:12 INFO - PROCESS | 1668 | |i|pagename|runs| 15:59:12 INFO - PROCESS | 1668 | |0;ai-astar;99;161;165;112;114;112;113;111;112;112 15:59:12 INFO - PROCESS | 1668 | |1;audio-beat-detection;143;108;106;163;106;107;128;113;175;136 15:59:12 INFO - PROCESS | 1668 | |2;audio-dft;185;187;184;186;184;183;184;184;183;181 15:59:12 INFO - PROCESS | 1668 | |3;audio-fft;79;73;58;87;60;57;58;67;97;73 15:59:12 INFO - PROCESS | 1668 | |4;audio-oscillator;81;91;91;70;76;69;96;71;68;103 15:59:12 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;88;86;88;85;87;83;88;85;88;84 15:59:12 INFO - PROCESS | 1668 | |6;imaging-darkroom;93;92;93;93;97;93;93;94;93;92 15:59:12 INFO - PROCESS | 1668 | |7;imaging-desaturate;86;83;86;88;86;86;85;95;85;68 15:59:12 INFO - PROCESS | 1668 | |8;json-parse-financial;44;56;53;54;55;55;54;54;54;56 15:59:12 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;65;73;73;78;72;71;70;70;70;72 15:59:12 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;89;84;85;86;73;83;81;98;101;103 15:59:12 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;137;135;137;141;152;131;135;135;175;134 15:59:12 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;165;164;169;161;162;163;162;157;164;162 15:59:12 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;66;65;67;68;66;66;67;68;67;66 15:59:12 INFO - PROCESS | 1668 | __end_tp_report 15:59:12 INFO - PROCESS | 1668 | __start_cc_report 15:59:12 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,2062 15:59:12 INFO - PROCESS | 1668 | __end_cc_report 15:59:12 INFO - PROCESS | 1668 | __startTimestamp1467413952851__endTimestamp 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | ------- Summary: start ------- 15:59:12 INFO - PROCESS | 1668 | Number of tests: 14 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:121.10 Median:113.50 stddev:22.50 (19.8%) stddev-sans-first:22.40 15:59:12 INFO - PROCESS | 1668 | Values: 99.0 161.0 165.0 112.0 114.0 112.0 113.0 111.0 112.0 112.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:132.00 stddev:25.29 (19.2%) stddev-sans-first:26.27 15:59:12 INFO - PROCESS | 1668 | Values: 143.0 108.0 106.0 163.0 106.0 107.0 128.0 113.0 175.0 136.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.00 stddev:1.66 (0.9%) stddev-sans-first:1.73 15:59:12 INFO - PROCESS | 1668 | Values: 185.0 187.0 184.0 186.0 184.0 183.0 184.0 184.0 183.0 181.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:70.90 Median:73.00 stddev:13.64 (18.7%) stddev-sans-first:14.15 15:59:12 INFO - PROCESS | 1668 | Values: 79.0 73.0 58.0 87.0 60.0 57.0 58.0 67.0 97.0 73.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:78.50 stddev:12.76 (16.2%) stddev-sans-first:13.53 15:59:12 INFO - PROCESS | 1668 | Values: 81.0 91.0 91.0 70.0 76.0 69.0 96.0 71.0 68.0 103.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.50 stddev:1.87 (2.1%) stddev-sans-first:1.87 15:59:12 INFO - PROCESS | 1668 | Values: 88.0 86.0 88.0 85.0 87.0 83.0 88.0 85.0 88.0 84.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 15:59:12 INFO - PROCESS | 1668 | Values: 93.0 92.0 93.0 93.0 97.0 93.0 93.0 94.0 93.0 92.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:86.00 stddev:6.71 (7.8%) stddev-sans-first:7.11 15:59:12 INFO - PROCESS | 1668 | Values: 86.0 83.0 86.0 88.0 86.0 86.0 85.0 95.0 85.0 68.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.50 stddev:3.47 (6.4%) stddev-sans-first:1.01 15:59:12 INFO - PROCESS | 1668 | Values: 44.0 56.0 53.0 54.0 55.0 55.0 54.0 54.0 54.0 56.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:3.27 (4.5%) stddev-sans-first:2.52 15:59:12 INFO - PROCESS | 1668 | Values: 65.0 73.0 73.0 78.0 72.0 71.0 70.0 70.0 70.0 72.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:84.50 stddev:9.56 (11.3%) stddev-sans-first:10.13 15:59:12 INFO - PROCESS | 1668 | Values: 89.0 84.0 85.0 86.0 73.0 83.0 81.0 98.0 101.0 103.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:137.00 stddev:13.19 (9.6%) stddev-sans-first:13.90 15:59:12 INFO - PROCESS | 1668 | Values: 137.0 135.0 137.0 141.0 152.0 131.0 135.0 135.0 175.0 134.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:3.07 (1.9%) stddev-sans-first:3.16 15:59:12 INFO - PROCESS | 1668 | Values: 165.0 164.0 169.0 161.0 162.0 163.0 162.0 157.0 164.0 162.0 15:59:12 INFO - PROCESS | 1668 | 15:59:12 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 15:59:12 INFO - PROCESS | 1668 | Values: 66.0 65.0 67.0 68.0 66.0 66.0 67.0 68.0 67.0 66.0 15:59:12 INFO - PROCESS | 1668 | -------- Summary: end -------- 15:59:12 INFO - PROCESS | 1668 | 15:59:13 INFO - TEST-INFO | 1668: exit 0 15:59:13 INFO - TEST-OK | kraken | took 58890ms 15:59:13 INFO - SUITE-END | took 1175s 15:59:14 INFO - Completed test suite (00:19:35) 15:59:14 INFO - javascript benchmark 15:59:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.3291725196336, 3285.8357082145885, 3299.191698033981, 3313.2545177335087, 3344.48160535117, 5525.0883604205255, 5527.91708124378, 5586.35756887958, 5607.551395888329, 5650.011248031598, 5518.061929471999, 5564.4713752193575, 5661.943380566193, 5696.829095127143, 5726.7422965966525, 5036.722980236085, 5041.697498150123, 5112.130937740574, 5114.948850511503, 5204.016576346828, 4304.698671093025, 5138.2806407103035, 5153.3815942087, 5181.844544663666, 5216.660917040399, 5027.899442011158, 5063.291139240509, 5096.668716533413, 5138.075146473633, 5163.561097306733, 5117.590592752571, 5126.769295381717, 5132.435432102466, 5140.537351638333, 5147.485251474823, 5006.874828129326, 5092.516210959953, 5093.312402825608, 5121.743912804345, 5123.769430375604, 5509.0, 5603.2715746953045, 5676.1769543416385, 5707.857303567444, 5708.400617935098, 5866.413358664099, 6091.329953705089, 6121.846953826145, 6147.415995480467, 6150.630962142241, 6089.642816147896, 6137.285055221551, 6193.845153871144, 6216.222972128484, 6266.404691554295, 5705.942940570624, 5747.511461525775, 5756.079027355603, 5763.711814409305, 5766.077427611562, 6129.938700613026, 6189.04069869171, 6294.905576416358, 6295.716692748837, 6314.400131987454, 5944.940550594525, 6006.489448396847, 6048.243969503812, 6052.515798736091, 6052.697365131726, 5419.3225846769155, 6168.383161683796, 6173.351798061229, 6181.7527298908435, 6205.689715514297, 5907.350191478934, 5940.198073260141, 5969.552283578749, 6067.998780201306, 6092.208012958287, 6040.912635725612, 6085.66528840918, 6090.847728806815, 6116.204893363834, 6125.050617154348, 4276.422682937826, 4739.980904105634, 4799.3041009053495, 4824.589909857631, 4851.442084160296, 4285.721428107163, 4346.152500262482, 4354.368616550646, 4355.4337936068105, 4388.451443569554, 5532.6680399176175, 5603.327600687862, 5604.3835178130375, 5622.184783206412, 5625.409332020161, 6118.847028824315, 6126.509879209652, 6132.722655450988, 6140.197513349842, 6198.101275315144, 5623.044082505902, 5637.9718101409235, 5641.492265696107, 5652.236948012048, 5671.602987790815, 5141.640085194001, 5271.314729085195, 5313.814016509404, 5320.680759154463, 5321.281626980385, 6219.813405597839, 6281.371862813682, 6288.245410550763, 6300.117983482316, 6321.209848768904, 5148.30497882781, 6190.0405437157315, 6232.25212974446, 6239.625622462667, 6255.24937007562, 6172.537059720628, 6258.593191442542, 6290.9056364155485, 6296.0555916612875, 6299.496040316855, 5133.6919784813035, 6021.608595441282, 6072.939270607414, 6084.787032453843, 6134.650895842656, 6165.136880836776, 6186.288576813724, 6199.132121503083, 6206.0, 6216.720247588779, 5780.971095144498, 5860.706964651836, 5959.76160953557, 5971.850703732442, 5991.700414979321, 5804.941950580609, 5879.911801322898, 5890.410958904075, 5944.989351810289, 5974.551908606785, 5799.246098007232, 5826.504747096545, 5830.737616807169, 5836.854078648068, 5890.204822348928, 5977.3424923257535, 6001.4298641628975, 6010.0, 6011.6994150293185, 6036.094585811988, 5656.462636049569, 5703.657780533182, 5706.343770466284, 5773.1051686988585, 5803.7968671096305], "value": 5585.314314881285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8028788484606, 497.4105684763554, 501.656365389708, 505.67384037295966, 508.3416975017352, 30711.385772284542, 32592.0, 32626.347473050526, 40631.781046568576, 41737.791311043475, 43086.0, 43186.92032699176, 43478.34782478258, 43568.73234507409, 43592.474263400785, 9707.271954603415, 9894.307398482073, 9899.50502474877, 9902.653407130752, 9915.405075695446, 8840.248578870804, 8937.910620893805, 8943.910560894405, 9023.45859248444, 9742.51287435629, 8877.0, 11848.229865058787, 11973.40132993347, 11974.101942354315, 12228.266304021743, 12001.819972700416, 12046.819297710541, 12067.275963442222, 12073.698157546043, 12075.637730868044, 7401.185869554345, 11608.883911160865, 11688.0, 11696.707582310426, 11699.649010529698, 40403.191936161405, 40799.0, 40851.97870053272, 43137.92155196145, 43148.35277470841, 3468.8785892493893, 3495.615482296945, 3600.891973240807, 3602.5949879546997, 3842.9615703842883, 31868.362632747216, 31878.681213187803, 32710.018699439053, 33099.0, 33237.338133093246, 3353.3293341331832, 3378.408778463759, 3454.5336379588684, 3456.5333679953137, 3457.6023757267985, 511880.0, 512036.4398178022, 512508.0, 513118.0, 513272.0, 59525.404745951986, 61057.69471152616, 61117.38882611206, 61164.38835611676, 61200.693996529735, 64190.67904660447, 64378.0, 64387.0, 64436.0, 64474.0, 16565.337386504645, 16793.160341982853, 16820.6635867282, 16845.0, 16915.830841691673, 12852.485900563872, 12869.485220591072, 12917.28954907489, 12926.482940682268, 12930.806037909439, 14773.630659233606, 15188.088714677155, 15622.140782256858, 17130.886492377955, 17172.22724977379, 5247.658902171423, 6064.75672487139, 6155.569110162246, 6245.0, 6269.279032911182, 891.2201823404521, 1048.6487026846091, 1063.4044934836515, 1101.4823033174396, 1155.757290968889, 30341.69658303433, 30560.84719576388, 30623.693763062085, 31247.531287030713, 31374.215644609067, 906.7260498998917, 1078.5470102556944, 1088.2001728729379, 1125.7354521687396, 1158.8667303260065, 14978.70042599142, 15852.76220856688, 16020.75968860468, 16054.919725401533, 16469.34122635081, 670212.0, 673515.0, 674102.0, 679575.0, 682153.0, 60088.0, 60277.69861150666, 60346.698266509266, 60414.69792651009, 60478.488037799405, 1375.1474086066503, 1396.804447377368, 1414.7099844532052, 1416.3060100550863, 1421.069199674215, 29108.708912911447, 30493.54259686062, 30850.537241941838, 31262.0, 31562.684373155975, 51946.0, 52042.47957520376, 52382.21426678527, 52429.68925776886, 52437.737811312225, 541301.0, 542920.0, 543811.0, 544748.0, 545517.0, 41671.37492937669, 42697.14605707806, 42825.57174428341, 43198.0, 43204.78397607992, 38861.6113838858, 40044.59955400409, 40877.59122408738, 46405.76797115993, 47858.76070619764, 40387.394189087776, 40457.797711011255, 40929.38605920973, 41542.79228603838, 41848.790756047245, 38265.426018609185, 40044.79977600093, 40532.1893562133, 41138.79430602828, 41317.0, 38855.41716874193, 39472.0, 39481.605183948945, 39781.0, 39953.80023099866, 27669.86165069162, 28850.567241490975, 35611.0, 35846.82076589705, 36202.63797361992, 21613.675794862775, 25374.98500059977, 25556.872215638803, 25982.960681572524, 26529.20412387554], "value": 20587.145716130854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1925588867767, 384.8960780589241, 386.6520131881308, 394.57386023095063, 403.73757057912354, 19675.70486442703, 21453.141874325047, 21701.34895953124, 22406.88796556017, 22428.439289017784, 19708.408747737554, 20468.0, 20532.692009619866, 21271.468213294676, 21626.89186554069, 5062.594992400608, 5827.796027139051, 6162.137300777895, 6177.752889884399, 6199.039148931923, 3722.9441558376648, 3905.0, 3911.9608803911883, 3943.8619648312315, 6158.969205153968, 3879.473820787663, 3942.526896772377, 5584.664920104807, 6155.538334624899, 6164.520515076394, 6138.202033735631, 6147.508199344042, 6163.938360616404, 6179.938200617981, 6193.969030154843, 3812.866549670748, 5981.162637230791, 5986.2517185351835, 5989.352927944807, 5991.400859913973, 24931.252062438154, 26188.86905565479, 26265.73734262671, 26799.0, 26806.329841754112, 2195.5279614882716, 2303.8502497337618, 2461.6430617560354, 2464.0, 2974.0631701014113, 9859.802803943952, 10036.548355324028, 10057.949710251474, 10597.894021059768, 10664.573417063308, 1820.4629634257794, 1898.3450709505198, 1977.9307724229727, 1988.920443182271, 2029.7868723783938, 87610.17251282468, 116418.99999999916, 120726.3963680176, 128064.0, 133035.6696433033, 8884.73345799627, 11088.390138542296, 11645.359505227125, 11648.70878228034, 11934.940325298492, 14425.711485770225, 14572.781408278885, 14618.63453413652, 14633.0, 14634.926825366018, 8659.090795466385, 8662.610182541675, 8733.825323493495, 8789.692360767342, 8803.0, 8692.043875173726, 8704.260137888225, 8710.303175745925, 8816.0, 8824.3381746368, 4480.395146655225, 4562.384078149474, 4571.3600095986585, 4571.8570357410645, 4621.052684199731, 1703.3186725309727, 1847.5496735062911, 1878.8496920246348, 1907.1036612791966, 1919.6640587897061, 786.614558866163, 798.3613109512366, 827.8840962265288, 933.6918816790443, 944.9652630369734, 20795.376138715863, 21283.0, 21346.573068538542, 21353.78646213549, 21401.25095621677, 829.6266679994027, 928.9071092890657, 970.5583959298502, 976.8974257702981, 1008.8032833597525, 8615.655373784979, 11106.666799996014, 11136.109111271078, 11275.774484510264, 11333.659990200142, 618708.0, 629052.0, 630205.0, 630547.0, 637353.0, 72953.54092918219, 120750.0, 126446.0, 144723.0, 152705.0, 998.9350692204983, 1000.7348052766023, 1020.0921180149821, 1023.9897601024044, 1026.5483187397522, 19248.518787030436, 19601.70597441011, 19619.664657008627, 19661.803381965998, 19691.901540492207, 55494.72252638711, 55636.72181639066, 55933.0, 55977.44022559722, 56763.71618141883, 83365.0, 84561.0, 85985.57007214923, 90408.67139300186, 92525.0, 7920.940555455738, 7935.880961785693, 7941.205879412013, 8181.877271840808, 8393.454425462569, 11292.60475883373, 12943.5469758558, 12953.740925181632, 13233.669158271121, 13247.602571922858, 11169.664910052712, 11222.102231821598, 11238.55045798159, 11412.0, 11499.137564682514, 11103.278286911325, 11164.0, 11165.38590377537, 11423.029042531478, 11457.541698332307, 11373.488193031499, 11395.829062564235, 11415.486303116213, 11421.428928553372, 11488.54045838157, 7993.0, 8087.47431416956, 8130.959345203236, 8187.631556579849, 8286.04710458305, 9834.950825246115, 11186.0, 11201.831972520582, 11273.661790146309, 11418.771624567627], "value": 9598.295349473186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.9626759331018, 1555.953321400358, 1728.343229572762, 1867.7571915650963, 1897.4212865076154, 8588.227059564639, 8843.159899809523, 9052.77368065797, 9060.275177985763, 9060.501672408014, 7897.881531777028, 8132.918670813305, 8422.536760478171, 8724.214820666155, 8827.426217295872, 2333.0, 2360.9173678921243, 2400.327908185711, 2401.555712193241, 2402.651615515749, 2349.3186975777003, 2374.5725769361507, 2421.249412682065, 2421.6004359280696, 2427.1383658801137, 2119.395972147938, 2213.7454192767877, 2331.2889568681544, 2408.1932552594903, 2412.300432874464, 2343.53129374125, 2375.596148654733, 2377.7027871515975, 2385.689860318165, 2406.049610403898, 2012.8087831656117, 2347.718273807137, 2369.040538581877, 2388.176079252655, 2393.222202784102, 8708.346873984414, 8759.343049271267, 8775.297976161892, 8779.429337093132, 8793.252573531257, 5300.681959082467, 5404.270423492818, 5443.782248710087, 5448.700321482317, 5460.918086228709, 3609.675129238355, 3647.8723244686307, 3696.3900956342172, 3701.222743223926, 3710.870119545803, 1080.9783804323947, 1083.0415082651832, 1085.918556108295, 1107.9279846810011, 1108.4236197177422, 11675.357855317954, 11892.0, 11915.761684766343, 11917.880821191764, 11922.0, 4655.301704744248, 4668.0, 4875.512448755097, 4897.681650692693, 4907.141250281186, 10183.236257280734, 10214.489275536342, 10215.182785377152, 10219.642312519027, 10231.079202871628, 5447.237386765856, 5455.236266922634, 5456.809011684572, 5464.91802622953, 5474.890502189934, 4856.2958371036, 4907.699459643198, 4987.825426110068, 4997.9500204997485, 5004.049230646166, 3868.5551161616213, 3893.3186692328727, 3951.8616848410165, 4008.8396464141692, 4052.2908491013955, 1215.8844909733562, 1243.7077286837587, 1271.3389037700529, 1274.9745005099846, 1297.6236891301605, 714.9857002860018, 865.3639574912435, 892.9910700893038, 932.3100905330007, 992.5781542844262, 6080.574359794772, 6166.105914642441, 6183.227096612924, 6287.748490060347, 6316.0, 945.3099237556622, 949.1030975727871, 956.6173530587821, 988.7429268390271, 989.6239429017071, 3646.361886669822, 3717.3978215248894, 3912.4326972589383, 4202.411662367271, 4219.78901054946, 10614.946925265323, 10813.783724325627, 10830.404327761891, 10924.453777311102, 11042.006219440289, 10866.185036122322, 10883.945580272206, 10884.693836739641, 10886.891131088587, 10895.291806032741, 7401.48189626721, 7925.445218834626, 8292.668293268322, 8293.004839419309, 8426.199511046441, 6044.486218671286, 6093.725782339717, 6164.938350616616, 6223.439890409885, 6323.272823625342, 8248.59773838461, 10250.05249002687, 10253.282270241012, 10260.743481413025, 10276.537555810157, 10162.441065741456, 10285.125764309818, 10324.690259292232, 10324.793504129726, 10364.948175259075, 7529.058867641545, 7609.201033891583, 7626.504277221963, 7708.0, 7719.266669666373, 8257.256846883809, 8277.255047045795, 8365.790855228668, 8366.70716524943, 8374.832503349777, 7516.022917020752, 7661.961690191513, 7681.385489160965, 7810.297073263434, 7841.725539606315, 7418.369438597564, 7446.515976461513, 7518.436117291116, 7550.150213197801, 7659.846803064019, 7150.5352152109945, 7191.712331506681, 7208.603526806076, 7216.5670059796585, 7228.168760592389, 4977.0, 5126.154184559506, 5157.329547158995, 5183.663061900965, 5248.343957005374, 5110.3356563646485, 5122.974385128051, 5133.974330128325, 5147.562457191031, 5331.466853314792], "value": 4665.214144860852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.50074128059345, 306.4805155261832, 313.4577181476045, 313.5594489741913, 316.7925009119028, 4425.446819147606, 5294.52349288564, 5299.8940021199605, 5309.33633295838, 5341.786328546863, 4333.479982402117, 5273.2617433559335, 5284.524392804657, 5296.073187192245, 5313.362396512424, 3077.276725033977, 3969.98015009926, 3987.0, 3988.2850374339023, 4009.6992725545556, 3635.2366003139373, 3795.3679917635404, 3995.820188091543, 4030.45588845505, 4040.2121586290687, 3566.3045706087323, 3655.561332640087, 3982.721209515335, 4002.5997400259885, 4008.3386241270155, 3440.8623655053766, 4003.917962659401, 4022.818973146186, 4023.3445925688907, 4024.953512086849, 2984.4329577380227, 3330.350581636582, 3424.6061702904235, 3455.395305821471, 3467.1852114753015, 4086.5913408659194, 4160.583941605815, 4435.401220835178, 5093.439721630618, 5122.948770512285, 3747.437884317374, 3977.6420122189143, 4560.270356742938, 4601.608863246628, 4613.561711637389, 4277.8288868445225, 4535.598301274044, 5212.592599998017, 5518.972405137989, 5534.4742249486235, 3293.917652058694, 3767.9088106101103, 3775.452559378875, 3779.5653499847595, 3790.336691079078, 5530.340897730664, 5736.529399713155, 5746.683932383718, 5780.624259423124, 5800.854978625526, 3098.814071155738, 3469.935388443872, 3758.1544152566003, 3758.567764707094, 3760.435934609776, 3225.741940644743, 3395.405803984293, 3845.750026248285, 3883.49514563105, 3886.8833934981994, 4521.174266083698, 4522.4573051234065, 4526.4199406338075, 4545.340950553024, 4567.771611419415, 4817.542333478314, 4825.686330388514, 5594.664320140804, 5597.160425936061, 5623.297087864017, 1271.8473783145896, 1307.1895424836473, 1325.304215286982, 1331.5605850069453, 1333.9061969185368, 609.6677310865589, 715.6207210178613, 795.8129839487716, 807.5625386811485, 817.595290331278, 3890.4747859039235, 4320.611144996966, 4346.087321662486, 4349.782510874444, 4368.2261763780225, 3951.3677811550015, 4111.444954931046, 4285.657147428198, 4773.689710168828, 4789.95210047902, 4005.6995725320717, 4066.1905452074134, 4288.742675439484, 4327.545607711208, 4354.521002689701, 2294.89672964717, 2461.4584791345874, 2496.937576560564, 2511.3470497670373, 2520.407704189514, 4218.557051509609, 4869.683470574401, 4912.9508704913205, 4917.500162450487, 4931.756050996788, 4804.429630147854, 4845.491223421561, 4846.151923413459, 4862.884645179358, 4926.33494478248, 4113.251867956166, 4830.6135509159185, 4911.256503941121, 4928.7289199093675, 5761.654300741969, 5025.894303253279, 5072.771725272298, 5419.458054194549, 5674.914876276776, 5705.0, 5034.471380504994, 5240.9518096381635, 5566.805161819317, 5588.273524441959, 5595.972020139873, 5233.168391063097, 5573.888522229451, 5779.364269930388, 5890.705464726832, 5891.703825158458, 3154.66875978019, 3627.0, 3786.981065094657, 3798.9240215196096, 3801.1257410796225, 4994.400671919393, 5693.829185124453, 5750.108733146369, 5750.6262092963825, 5766.394528574439, 4525.818967241274, 4633.119707255611, 5213.263036905503, 5281.762320695501, 5587.608867379245, 4212.768297743531, 4720.645951553716, 4879.707217566957, 5499.312585926759, 5523.061079616556, 4437.733735975852, 4444.355568442623, 4727.125481785881, 5289.280983680243, 5402.0, 4969.975150124226, 5442.319710036246, 5507.972460137674, 5509.611588872895, 5509.614326997072, 5251.684898906078, 5294.311739473844, 5374.247605335335, 5387.488188622075, 5428.348598168245], "value": 3831.242866505334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.9304666056724, 743.9256074392562, 769.7459838253377, 808.5391326943644, 839.1901814748768, 15268.465603703873, 16417.91791041043, 16446.917765411155, 16465.09441980692, 16469.917650411746, 14655.780163297559, 14881.479148229813, 14901.105933643961, 14907.180105094243, 14919.627009324773, 690.6581242285064, 716.1799739298526, 841.5960339037266, 863.4689665855517, 873.0440168016012, 856.8200677857658, 870.8954925408929, 872.2803686958254, 873.5719497446269, 875.4134729731063, 924.1405492891608, 924.5469719837265, 926.6293482606944, 927.0729270729271, 929.2751653710117, 730.7661548304544, 899.874017637528, 907.6233363154283, 913.9497327647043, 915.1717695485596, 681.3901558105517, 684.3259389501337, 684.7534887440518, 684.9212340580797, 687.1273482676972, 14952.62618434537, 14959.700805983819, 14964.625884352869, 15004.474843380538, 15005.699886002329, 14226.92886535571, 14269.429222831075, 14288.357023933844, 14348.995570310082, 14455.27723613815, 12829.358532073358, 12943.67640808978, 13029.609111726664, 13049.347532623426, 13338.19970801755, 4521.412216411845, 4656.278276867091, 4753.073150735608, 4795.832145874878, 4796.2326027835725, 116898.0, 117143.41428292889, 117260.0, 117396.41301793436, 117595.0, 11192.664220073248, 11250.831237531444, 11258.774824503627, 11261.831072533918, 11287.717807054725, 22229.221977230718, 22230.999605017812, 22249.0, 22251.666225006637, 22257.332280031624, 8047.913531673266, 8070.273675369245, 8106.878396824052, 8108.797280067927, 8299.709510167115, 4358.912821743547, 4427.667924905581, 4486.730796152241, 4529.54704529551, 4618.953810461852, 3503.194265318991, 3607.3687104756564, 3608.3685355062757, 3611.6749492545796, 3617.5839778425816, 637.1398611873933, 652.2759736692268, 660.7720336483906, 661.2924171136933, 668.8896332105148, 520.5757307794136, 578.8784355285353, 606.8968275393194, 659.0937460991137, 680.1701923653135, 9072.773180670536, 9206.26349892007, 9241.953790231006, 9289.791056628148, 9583.856242156373, 551.9586031047687, 656.474820143883, 668.0413606474724, 677.3937326093218, 696.5159214345981, 4305.935410968838, 4646.581807637329, 4698.459677137173, 4743.683248244081, 4839.540243676845, 139420.0, 141348.0, 143379.0, 143602.28198858938, 148085.0, 130406.0, 133167.0, 135091.64908350792, 135340.9698854518, 138309.3084534591, 99835.51891532421, 112823.2306061639, 115579.42210288894, 117672.0, 119237.0, 8842.292616590787, 9010.32422568323, 9228.667308238928, 9250.259979201783, 9306.953465232902, 48193.0, 58536.0, 59623.70188149031, 60075.69962150161, 60374.0, 91251.1561632867, 95022.0, 95964.23755057022, 97486.63823489776, 100611.0, 12028.939855300667, 12095.0, 12134.0, 12208.32854193028, 12326.75346493083, 13548.25484598317, 13596.728065438834, 13603.251821149932, 13668.589942301747, 13774.173549586656, 12278.508859645513, 12491.625251242478, 12532.185407948455, 12833.0, 13052.412641431349, 12424.130310878514, 12441.93779031099, 12463.875361246271, 12524.686882828002, 12592.307423091452, 12092.75814483723, 12229.877701222875, 12231.327276999851, 12346.81479777786, 12410.937945310216, 9952.502374881371, 10565.524551395052, 10590.311629744043, 11021.063209626951, 11062.502187401748, 10231.795364092824, 10439.58241670355, 10566.471676416302, 10588.41763702973, 10794.892051079703], "value": 7846.721121456243, "unit": "score"}], "name": "dromaeo_css", "value": 7327.64808616, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 161.0, 165.0, 112.0, 114.0, 112.0, 113.0, 111.0, 112.0, 112.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 106.0, 163.0, 106.0, 107.0, 128.0, 113.0, 175.0, 136.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 184.0, 186.0, 184.0, 183.0, 184.0, 184.0, 183.0, 181.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 58.0, 87.0, 60.0, 57.0, 58.0, 67.0, 97.0, 73.0], "value": 70.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 91.0, 70.0, 76.0, 69.0, 96.0, 71.0, 68.0, 103.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 87.0, 83.0, 88.0, 85.0, 88.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 97.0, 93.0, 93.0, 94.0, 93.0, 92.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 88.0, 86.0, 86.0, 85.0, 95.0, 85.0, 68.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 56.0, 53.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 56.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 73.0, 78.0, 72.0, 71.0, 70.0, 70.0, 70.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 85.0, 86.0, 73.0, 83.0, 81.0, 98.0, 101.0, 103.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 137.0, 141.0, 152.0, 131.0, 135.0, 135.0, 175.0, 134.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 169.0, 161.0, 162.0, 163.0, 162.0, 157.0, 164.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 68.0, 66.0, 66.0, 67.0, 68.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1434.4, "alertThreshold": 2.0}]} 15:59:14 INFO - Return code: 0 15:59:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:59:14 INFO - # TBPL SUCCESS # 15:59:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:59:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:59:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:59:14 INFO - 2016-07-01 15:59:14.153 screenresolution[1672:9671] starting screenresolution argv=screenresolution get 15:59:14 INFO - 2016-07-01 15:59:14.156 screenresolution[1672:9671] Display 0: 1600x1200x32@60 15:59:14 INFO - 2016-07-01 15:59:14.161 screenresolution[1673:9674] starting screenresolution argv=screenresolution list 15:59:14 INFO - Available Modes on Display 0 15:59:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:59:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:59:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:59:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:59:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:59:14 INFO - Intel Iris: 15:59:14 INFO - Chipset Model: Intel Iris 15:59:14 INFO - Type: GPU 15:59:14 INFO - Bus: Built-In 15:59:14 INFO - VRAM (Dynamic, Max): 1536 MB 15:59:14 INFO - Vendor: Intel (0x8086) 15:59:14 INFO - Device ID: 0x0a2e 15:59:14 INFO - Revision ID: 0x0009 15:59:14 INFO - Displays: 15:59:14 INFO - Display: 15:59:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:59:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:59:14 INFO - Display Serial Number: 1600x1200 60 15:59:14 INFO - Main Display: Yes 15:59:14 INFO - Mirror: Off 15:59:14 INFO - Online: Yes 15:59:14 INFO - Rotation: Supported 15:59:14 INFO - Return code: 0 15:59:14 INFO - Running post-action listener: _resource_record_post_action 15:59:14 INFO - ##### 15:59:14 INFO - ##### Finished run-tests step (success) 15:59:14 INFO - ##### 15:59:14 INFO - Running post-run listener: _resource_record_post_run 15:59:14 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 36562432; Write bytes: 704852992; Read time: 239; Write time: 1957 15:59:14 INFO - TinderboxPrint: CPU usage
53.3% 15:59:14 INFO - TinderboxPrint: I/O read bytes / time
36,562,432 / 239 15:59:14 INFO - TinderboxPrint: I/O write bytes / time
704,852,992 / 1,957 15:59:14 INFO - TinderboxPrint: CPU idle
2,263.2 (46.7%) 15:59:14 INFO - TinderboxPrint: CPU system
961.9 (19.9%) 15:59:14 INFO - TinderboxPrint: CPU user
1,620.5 (33.4%) 15:59:14 INFO - TinderboxPrint: Swap in / out
443,490,304 / 0 15:59:14 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 402545152; Write bytes: 397596672; Read time: 30446; Write time: 838 15:59:14 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 34457088; Write bytes: 293432320; Read time: 219; Write time: 1083 15:59:14 INFO - Running post-run listener: _upload_blobber_files 15:59:14 INFO - Blob upload gear active. 15:59:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:59:14 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:59:14 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:59:14 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:59:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:59:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:59:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:16 INFO - (blobuploader) - INFO - Done attempting. 15:59:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:17 INFO - (blobuploader) - INFO - Done attempting. 15:59:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:59:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:59:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:19 INFO - (blobuploader) - INFO - Done attempting. 15:59:19 INFO - (blobuploader) - INFO - Iteration through files over. 15:59:19 INFO - Return code: 0 15:59:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:59:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:59:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13c1f0139e6603a707cef451ac3e3785b4fde9b92e2649a71181b75d7d352900dd5faecaf9d0252c53213abcb88624da0c43827d4a333a251a9c13c0a3f1d2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de62cd22c78b2ffbeed420dbfc0e2c67c4f62ea1437c1704e42ea8946ef550d55a71de35ed7281ed65add57b9dbc56ec352b0c54b9630c682057a110dd0732d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98c21df8f963b78de9a926e76da5074e64963ac29e204b1637e063ffbb359ec3c13125d5507053f2c71f9edd9103bb7c9a5d712aff30bef630afa8d36fe39462"} 15:59:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:59:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:59:19 INFO - Contents: 15:59:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13c1f0139e6603a707cef451ac3e3785b4fde9b92e2649a71181b75d7d352900dd5faecaf9d0252c53213abcb88624da0c43827d4a333a251a9c13c0a3f1d2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de62cd22c78b2ffbeed420dbfc0e2c67c4f62ea1437c1704e42ea8946ef550d55a71de35ed7281ed65add57b9dbc56ec352b0c54b9630c682057a110dd0732d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98c21df8f963b78de9a926e76da5074e64963ac29e204b1637e063ffbb359ec3c13125d5507053f2c71f9edd9103bb7c9a5d712aff30bef630afa8d36fe39462"} 15:59:19 INFO - Running post-run listener: copy_logs_to_upload_dir 15:59:19 INFO - Copying logs to upload dir... 15:59:19 INFO - mkdir: /builds/slave/test/build/upload/logs 15:59:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.546320 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-01 15:59:19.719341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:19.723123) ========= 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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13c1f0139e6603a707cef451ac3e3785b4fde9b92e2649a71181b75d7d352900dd5faecaf9d0252c53213abcb88624da0c43827d4a333a251a9c13c0a3f1d2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de62cd22c78b2ffbeed420dbfc0e2c67c4f62ea1437c1704e42ea8946ef550d55a71de35ed7281ed65add57b9dbc56ec352b0c54b9630c682057a110dd0732d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98c21df8f963b78de9a926e76da5074e64963ac29e204b1637e063ffbb359ec3c13125d5507053f2c71f9edd9103bb7c9a5d712aff30bef630afa8d36fe39462"} build_url:https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/DjCfc8qsS5iWug9cLCfdnQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13c1f0139e6603a707cef451ac3e3785b4fde9b92e2649a71181b75d7d352900dd5faecaf9d0252c53213abcb88624da0c43827d4a333a251a9c13c0a3f1d2c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de62cd22c78b2ffbeed420dbfc0e2c67c4f62ea1437c1704e42ea8946ef550d55a71de35ed7281ed65add57b9dbc56ec352b0c54b9630c682057a110dd0732d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98c21df8f963b78de9a926e76da5074e64963ac29e204b1637e063ffbb359ec3c13125d5507053f2c71f9edd9103bb7c9a5d712aff30bef630afa8d36fe39462"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:19.759453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:19.759912) ========= 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.ZuZbuxpQZQ/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.V4zAAoUuJb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.005194 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 15:59:19.808516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 15:59:19.808842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 15:59:19.809165) ========= ========= Total master_lag: 0.38 =========