builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0063 starttime: 1470597587.43 results: success (0) buildid: 20160807091052 builduid: 77f43add1f0246eb9c1092a1eac8c3db revision: 204b39c31233c082553493f52bfe8c3ebcc404ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.430206) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.430659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.430928) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.465424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.465698) ========= 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.Rz22s29naF/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.qbfRdMTwFz/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-08-07 12:19:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 30.2M=0s 2016-08-07 12:19:47 (30.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.617543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.617850) ========= 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.Rz22s29naF/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.qbfRdMTwFz/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.020546 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:47.667716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 12:19:47.668244) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 204b39c31233c082553493f52bfe8c3ebcc404ff --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 204b39c31233c082553493f52bfe8c3ebcc404ff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Rz22s29naF/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.qbfRdMTwFz/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-08-07 12:19:47,743 truncating revision to first 12 chars 2016-08-07 12:19:47,743 Setting DEBUG logging. 2016-08-07 12:19:47,743 attempt 1/10 2016-08-07 12:19:47,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/204b39c31233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 12:19:49,219 unpacking tar archive at: fx-team-204b39c31233/testing/mozharness/ program finished with exit code 0 elapsedTime=1.738369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 12:19:49.429654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:49.430021) ========= script_repo_revision: 204b39c31233c082553493f52bfe8c3ebcc404ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:49.430477) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:49.430794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 12:19:49.449080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-07 12:19:49.449376) ========= /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.Rz22s29naF/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.qbfRdMTwFz/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:19:49 INFO - MultiFileLogger online at 20160807 12:19:49 in /builds/slave/test 12:19:49 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 12:19:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:49 INFO - {'append_to_log': False, 12:19:49 INFO - 'base_work_dir': '/builds/slave/test', 12:19:49 INFO - 'blob_upload_branch': 'Fx-Team', 12:19:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:49 INFO - 'branch': 'Fx-Team', 12:19:49 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:49 INFO - 'config_files': ('talos/mac_config.py',), 12:19:49 INFO - 'default_actions': ('clobber', 12:19:49 INFO - 'read-buildbot-config', 12:19:49 INFO - 'download-and-extract', 12:19:49 INFO - 'populate-webroot', 12:19:49 INFO - 'create-virtualenv', 12:19:49 INFO - 'install', 12:19:49 INFO - 'run-tests'), 12:19:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:49 INFO - 'download_minidump_stackwalk': True, 12:19:49 INFO - 'download_symbols': 'ondemand', 12:19:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:49 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:49 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:49 INFO - 'installer_path': 'installer.exe', 12:19:49 INFO - 'log_level': 'info', 12:19:49 INFO - 'log_name': 'talos', 12:19:49 INFO - 'log_to_console': True, 12:19:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:19:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:19:49 INFO - 'opt_config_files': (), 12:19:49 INFO - 'pip_index': False, 12:19:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:19:49 INFO - 'cmd': ('bash', 12:19:49 INFO - '-c', 12:19:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:19:49 INFO - 'enabled': True, 12:19:49 INFO - 'halt_on_failure': False, 12:19:49 INFO - 'name': 'check_screen_resolution'},), 12:19:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:19:49 INFO - 'cmd': ('bash', 12:19:49 INFO - '-c', 12:19:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:19:49 INFO - 'enabled': True, 12:19:49 INFO - 'halt_on_failure': False, 12:19:49 INFO - 'name': 'check_screen_resolution'},), 12:19:49 INFO - 'run_cmd_checks_enabled': True, 12:19:49 INFO - 'sps_profile': False, 12:19:49 INFO - 'sps_profile_interval': 0, 12:19:49 INFO - 'suite': 'dromaeojs', 12:19:49 INFO - 'system_bits': '32', 12:19:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:49 INFO - 'title': 't-yosemite-r7-0063', 12:19:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:49 INFO - 'use_talos_json': True, 12:19:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:49 INFO - 'work_dir': 'build'} 12:19:49 INFO - [mozharness: 2016-08-07 19:19:49.638832Z] Running clobber step. 12:19:49 INFO - Running pre-action listener: _resource_record_pre_action 12:19:49 INFO - Running main action method: clobber 12:19:49 INFO - rmtree: /builds/slave/test/build 12:19:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:51 INFO - Running post-action listener: _resource_record_post_action 12:19:51 INFO - [mozharness: 2016-08-07 19:19:51.748348Z] Finished clobber step (success) 12:19:51 INFO - [mozharness: 2016-08-07 19:19:51.748486Z] Running read-buildbot-config step. 12:19:51 INFO - Running pre-action listener: _resource_record_pre_action 12:19:51 INFO - Running main action method: read_buildbot_config 12:19:51 INFO - Using buildbot properties: 12:19:51 INFO - { 12:19:51 INFO - "project": "", 12:19:51 INFO - "product": "firefox", 12:19:51 INFO - "script_repo_revision": "production", 12:19:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:19:51 INFO - "repository": "", 12:19:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:19:51 INFO - "buildid": "20160807091052", 12:19:51 INFO - "pgo_build": "False", 12:19:51 INFO - "basedir": "/builds/slave/test", 12:19:51 INFO - "buildnumber": 81, 12:19:51 INFO - "slavename": "t-yosemite-r7-0063", 12:19:51 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 12:19:51 INFO - "platform": "yosemite_r7", 12:19:51 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:19:51 INFO - "branch": "fx-team", 12:19:51 INFO - "repo_path": "integration/fx-team", 12:19:51 INFO - "revision": "204b39c31233c082553493f52bfe8c3ebcc404ff", 12:19:51 INFO - "stage_platform": "macosx64", 12:19:51 INFO - "builduid": "77f43add1f0246eb9c1092a1eac8c3db", 12:19:51 INFO - "slavebuilddir": "test" 12:19:51 INFO - } 12:19:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 12:19:51 INFO - Running post-action listener: _resource_record_post_action 12:19:51 INFO - [mozharness: 2016-08-07 19:19:51.752097Z] Finished read-buildbot-config step (success) 12:19:51 INFO - [mozharness: 2016-08-07 19:19:51.752261Z] Running download-and-extract step. 12:19:51 INFO - Running pre-action listener: _resource_record_pre_action 12:19:51 INFO - Running main action method: download_and_extract 12:19:51 INFO - mkdir: /builds/slave/test/build/tests 12:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:51 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 12:19:51 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 12:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 12:19:53 INFO - Downloaded 1199 bytes. 12:19:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 12:19:53 INFO - Using the following test package requirements: 12:19:53 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:19:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 12:19:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 12:19:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'jsshell-mac.zip'], 12:19:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 12:19:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:19:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 12:19:53 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 12:19:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 12:19:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:19:53 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 12:19:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:53 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:19:53 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:19:54 INFO - Downloaded 16324158 bytes. 12:19:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:19:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:19:57 INFO - Return code: 0 12:19:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:57 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:19:57 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:19:58 INFO - Downloaded 16324158 bytes. 12:19:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:19:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:20:02 INFO - Return code: 0 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:02 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 12:20:02 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 12:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:20:03 INFO - Downloaded 14413723 bytes. 12:20:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:20:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:20:03 INFO - Return code: 0 12:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:03 INFO - trying https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:20:03 INFO - Downloading https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 12:20:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 12:20:06 INFO - Downloaded 111871695 bytes. 12:20:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:20:06 INFO - mkdir: /builds/slave/test/properties 12:20:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:20:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:20:06 INFO - Contents: 12:20:06 INFO - build_url:https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:20:06 INFO - Running post-action listener: _resource_record_post_action 12:20:06 INFO - Running post-action listener: set_extra_try_arguments 12:20:06 INFO - [mozharness: 2016-08-07 19:20:06.891280Z] Finished download-and-extract step (success) 12:20:06 INFO - [mozharness: 2016-08-07 19:20:06.891407Z] Running populate-webroot step. 12:20:06 INFO - Running pre-action listener: _resource_record_pre_action 12:20:06 INFO - Running main action method: populate_webroot 12:20:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:20:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:20:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:20:06 INFO - '--tppagecycles', 12:20:06 INFO - '7'], 12:20:06 INFO - 'tests': ['tsvgm']}}, 12:20:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:20:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:20:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:20:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:20:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:20:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['damp', 'tps']}, 12:20:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'tests': ['damp', 'tps']}, 12:20:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['dromaeo_dom']}, 12:20:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:20:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['basic_compositor_video']}, 12:20:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:20:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['a11yr', 12:20:06 INFO - 'ts_paint', 12:20:06 INFO - 'tpaint', 12:20:06 INFO - 'sessionrestore', 12:20:06 INFO - 'sessionrestore_no_auto_restore', 12:20:06 INFO - 'tabpaint']}, 12:20:06 INFO - 'other-e10s': {'tests': ['a11yr', 12:20:06 INFO - 'ts_paint', 12:20:06 INFO - 'tpaint', 12:20:06 INFO - 'sessionrestore', 12:20:06 INFO - 'sessionrestore_no_auto_restore', 12:20:06 INFO - 'tabpaint']}, 12:20:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:20:06 INFO - 'ts_paint', 12:20:06 INFO - 'tpaint', 12:20:06 INFO - 'sessionrestore', 12:20:06 INFO - 'sessionrestore_no_auto_restore', 12:20:06 INFO - 'tabpaint']}, 12:20:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:20:06 INFO - 'ts_paint', 12:20:06 INFO - 'tpaint', 12:20:06 INFO - 'sessionrestore', 12:20:06 INFO - 'sessionrestore_no_auto_restore', 12:20:06 INFO - 'tabpaint']}, 12:20:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['a11yr', 12:20:06 INFO - 'ts_paint', 12:20:06 INFO - 'tpaint', 12:20:06 INFO - 'sessionrestore', 12:20:06 INFO - 'sessionrestore_no_auto_restore', 12:20:06 INFO - 'tabpaint']}, 12:20:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['a11yr', 12:20:06 INFO - 'ts_paint', 12:20:06 INFO - 'tpaint', 12:20:06 INFO - 'sessionrestore', 12:20:06 INFO - 'sessionrestore_no_auto_restore', 12:20:06 INFO - 'tabpaint']}, 12:20:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['tsvgx', 12:20:06 INFO - 'tsvgr_opacity', 12:20:06 INFO - 'tart', 12:20:06 INFO - 'tscrollx', 12:20:06 INFO - 'cart']}, 12:20:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:20:06 INFO - 'tsvgr_opacity', 12:20:06 INFO - 'tart', 12:20:06 INFO - 'tscrollx', 12:20:06 INFO - 'cart']}, 12:20:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'talos_options': ['--disable-e10s'], 12:20:06 INFO - 'tests': ['tp5o']}, 12:20:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'tests': ['tp5o']}, 12:20:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'talos_options': ['--disable-e10s', 12:20:06 INFO - '--xperf_path', 12:20:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:06 INFO - 'tests': ['tp5n']}, 12:20:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:20:06 INFO - 'talos_options': ['--xperf_path', 12:20:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:20:06 INFO - 'tests': ['tp5n']}}, 12:20:06 INFO - 'talos.zip': {'path': '', 12:20:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:20:06 INFO - Running post-action listener: _resource_record_post_action 12:20:06 INFO - [mozharness: 2016-08-07 19:20:06.910644Z] Finished populate-webroot step (success) 12:20:06 INFO - [mozharness: 2016-08-07 19:20:06.910783Z] Running create-virtualenv step. 12:20:06 INFO - Running pre-action listener: _resource_record_pre_action 12:20:06 INFO - Running main action method: create_virtualenv 12:20:06 INFO - Creating virtualenv /builds/slave/test/build/venv 12:20:06 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 12:20:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:20:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:20:07 INFO - Using real prefix '/tools/python27' 12:20:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:20:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:20:10 INFO - Installing pip.................done. 12:20:10 INFO - Return code: 0 12:20:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:20:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:10 INFO - 'HOME': '/Users/cltbld', 12:20:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:10 INFO - 'LOGNAME': 'cltbld', 12:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:10 INFO - 'MOZ_NO_REMOTE': '1', 12:20:10 INFO - 'NO_EM_RESTART': '1', 12:20:10 INFO - 'PAGER': '/bin/cat', 12:20:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:10 INFO - 'PWD': '/builds/slave/test', 12:20:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:10 INFO - 'SHELL': '/bin/bash', 12:20:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:10 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:10 INFO - 'USER': 'cltbld', 12:20:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:10 INFO - 'XPC_FLAGS': '0x0', 12:20:10 INFO - 'XPC_SERVICE_NAME': '0', 12:20:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:10 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 12:20:10 INFO - Cleaning up... 12:20:10 INFO - Return code: 0 12:20:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:20:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:10 INFO - 'HOME': '/Users/cltbld', 12:20:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:10 INFO - 'LOGNAME': 'cltbld', 12:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:10 INFO - 'MOZ_NO_REMOTE': '1', 12:20:10 INFO - 'NO_EM_RESTART': '1', 12:20:10 INFO - 'PAGER': '/bin/cat', 12:20:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:10 INFO - 'PWD': '/builds/slave/test', 12:20:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:10 INFO - 'SHELL': '/bin/bash', 12:20:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:10 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:10 INFO - 'USER': 'cltbld', 12:20:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:10 INFO - 'XPC_FLAGS': '0x0', 12:20:10 INFO - 'XPC_SERVICE_NAME': '0', 12:20:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:11 INFO - Downloading/unpacking psutil>=3.1.1 12:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:20:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:14 INFO - Installing collected packages: psutil 12:20:14 INFO - Running setup.py install for psutil 12:20:14 INFO - building 'psutil._psutil_osx' extension 12:20:14 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 12:20:14 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 12:20:14 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 12:20:14 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 12:20:14 INFO - building 'psutil._psutil_posix' extension 12:20:14 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 12:20:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:20:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:20:14 INFO - ^ 12:20:14 INFO - 1 warning generated. 12:20:14 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 12:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:20:15 INFO - Successfully installed psutil 12:20:15 INFO - Cleaning up... 12:20:15 INFO - Return code: 0 12:20:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:15 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 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:15 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 12:20:15 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 12:20:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:15 INFO - 'HOME': '/Users/cltbld', 12:20:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:15 INFO - 'LOGNAME': 'cltbld', 12:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:15 INFO - 'MOZ_NO_REMOTE': '1', 12:20:15 INFO - 'NO_EM_RESTART': '1', 12:20:15 INFO - 'PAGER': '/bin/cat', 12:20:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:15 INFO - 'PWD': '/builds/slave/test', 12:20:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:15 INFO - 'SHELL': '/bin/bash', 12:20:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:15 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:15 INFO - 'USER': 'cltbld', 12:20:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:15 INFO - 'XPC_FLAGS': '0x0', 12:20:15 INFO - 'XPC_SERVICE_NAME': '0', 12:20:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:20:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:20:17 INFO - Installing collected packages: mozsystemmonitor 12:20:17 INFO - Running setup.py install for mozsystemmonitor 12:20:18 INFO - Successfully installed mozsystemmonitor 12:20:18 INFO - Cleaning up... 12:20:18 INFO - Return code: 0 12:20:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:18 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 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:18 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 12:20:18 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 12:20:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:18 INFO - 'HOME': '/Users/cltbld', 12:20:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:18 INFO - 'LOGNAME': 'cltbld', 12:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:18 INFO - 'MOZ_NO_REMOTE': '1', 12:20:18 INFO - 'NO_EM_RESTART': '1', 12:20:18 INFO - 'PAGER': '/bin/cat', 12:20:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:18 INFO - 'PWD': '/builds/slave/test', 12:20:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:18 INFO - 'SHELL': '/bin/bash', 12:20:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:18 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:18 INFO - 'USER': 'cltbld', 12:20:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:18 INFO - 'XPC_FLAGS': '0x0', 12:20:18 INFO - 'XPC_SERVICE_NAME': '0', 12:20:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:18 INFO - Downloading/unpacking jsonschema==2.5.1 12:20:18 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 12:20:18 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 12:20:18 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 12:20:18 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 12:20:18 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 12:20:18 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 12:20:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:20:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:21 INFO - Downloading functools32-3.2.3-2.tar.gz 12:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:20:21 INFO - warning: no files found matching '*.txt' 12:20:21 INFO - no previously-included directories found matching 'build' 12:20:21 INFO - no previously-included directories found matching 'dist' 12:20:21 INFO - no previously-included directories found matching '.git*' 12:20:21 INFO - Installing collected packages: jsonschema, functools32 12:20:21 INFO - Running setup.py install for functools32 12:20:21 INFO - warning: no files found matching '*.txt' 12:20:21 INFO - no previously-included directories found matching 'build' 12:20:21 INFO - no previously-included directories found matching 'dist' 12:20:21 INFO - no previously-included directories found matching '.git*' 12:20:21 INFO - Successfully installed jsonschema functools32 12:20:21 INFO - Cleaning up... 12:20:21 INFO - Return code: 0 12:20:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:21 INFO - 'HOME': '/Users/cltbld', 12:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:21 INFO - 'LOGNAME': 'cltbld', 12:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:21 INFO - 'MOZ_NO_REMOTE': '1', 12:20:21 INFO - 'NO_EM_RESTART': '1', 12:20:21 INFO - 'PAGER': '/bin/cat', 12:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:21 INFO - 'PWD': '/builds/slave/test', 12:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:21 INFO - 'SHELL': '/bin/bash', 12:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:21 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:21 INFO - 'USER': 'cltbld', 12:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:21 INFO - 'XPC_FLAGS': '0x0', 12:20:21 INFO - 'XPC_SERVICE_NAME': '0', 12:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:20:21 INFO - Cleaning up... 12:20:21 INFO - Return code: 0 12:20:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:21 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 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:21 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 12:20:21 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 12:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:21 INFO - 'HOME': '/Users/cltbld', 12:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:21 INFO - 'LOGNAME': 'cltbld', 12:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:21 INFO - 'MOZ_NO_REMOTE': '1', 12:20:21 INFO - 'NO_EM_RESTART': '1', 12:20:21 INFO - 'PAGER': '/bin/cat', 12:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:21 INFO - 'PWD': '/builds/slave/test', 12:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:21 INFO - 'SHELL': '/bin/bash', 12:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:21 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:21 INFO - 'USER': 'cltbld', 12:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:21 INFO - 'XPC_FLAGS': '0x0', 12:20:21 INFO - 'XPC_SERVICE_NAME': '0', 12:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:22 INFO - Downloading/unpacking blobuploader==1.2.4 12:20:22 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 12:20:22 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 12:20:22 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 12:20:22 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 12:20:22 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 12:20:22 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 12:20:24 INFO - Downloading blobuploader-1.2.4.tar.gz 12:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:20:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:20:24 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 12:20:24 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 12:20:24 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 12:20:24 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 12:20:24 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 12:20:24 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 12:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:20:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:20:25 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 12:20:25 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 12:20:25 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 12:20:25 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 12:20:25 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 12:20:25 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 12:20:25 INFO - Downloading docopt-0.6.1.tar.gz 12:20:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:20:25 INFO - Installing collected packages: blobuploader, requests, docopt 12:20:25 INFO - Running setup.py install for blobuploader 12:20:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:20:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:20:25 INFO - Running setup.py install for requests 12:20:26 INFO - Running setup.py install for docopt 12:20:26 INFO - Successfully installed blobuploader requests docopt 12:20:26 INFO - Cleaning up... 12:20:26 INFO - Return code: 0 12:20:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:26 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 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:26 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 12:20:26 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 12:20:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:26 INFO - 'HOME': '/Users/cltbld', 12:20:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:26 INFO - 'LOGNAME': 'cltbld', 12:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:26 INFO - 'MOZ_NO_REMOTE': '1', 12:20:26 INFO - 'NO_EM_RESTART': '1', 12:20:26 INFO - 'PAGER': '/bin/cat', 12:20:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:26 INFO - 'PWD': '/builds/slave/test', 12:20:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:26 INFO - 'SHELL': '/bin/bash', 12:20:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:26 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:26 INFO - 'USER': 'cltbld', 12:20:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:26 INFO - 'XPC_FLAGS': '0x0', 12:20:26 INFO - 'XPC_SERVICE_NAME': '0', 12:20:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-6ZoR4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-xcTPil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-EbymCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-KLGurl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-potaZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-SXS3c6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-b6SUui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-9fgLdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-IMot34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-8gVvVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-TQBJbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-QpGXbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-rziGi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-jeqtH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-oZOYvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-UN1pAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-qtwQrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:20:28 INFO - Running setup.py install for manifestparser 12:20:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:20:28 INFO - Running setup.py install for mozcrash 12:20:29 INFO - Running setup.py install for mozdebug 12:20:29 INFO - Running setup.py install for mozdevice 12:20:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Running setup.py install for mozfile 12:20:29 INFO - Running setup.py install for mozhttpd 12:20:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Running setup.py install for mozinfo 12:20:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Running setup.py install for mozInstall 12:20:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:20:29 INFO - Running setup.py install for mozleak 12:20:30 INFO - Running setup.py install for mozlog 12:20:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:20:30 INFO - Running setup.py install for moznetwork 12:20:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:20:30 INFO - Running setup.py install for mozprocess 12:20:30 INFO - Running setup.py install for mozprofile 12:20:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:20:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:20:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:20:30 INFO - Running setup.py install for mozrunner 12:20:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:20:30 INFO - Running setup.py install for mozscreenshot 12:20:31 INFO - Running setup.py install for moztest 12:20:31 INFO - Running setup.py install for mozversion 12:20:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:20:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:20:31 INFO - Cleaning up... 12:20:31 INFO - Return code: 0 12:20:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:31 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 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:31 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 12:20:31 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 12:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:31 INFO - 'HOME': '/Users/cltbld', 12:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:31 INFO - 'LOGNAME': 'cltbld', 12:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:31 INFO - 'MOZ_NO_REMOTE': '1', 12:20:31 INFO - 'NO_EM_RESTART': '1', 12:20:31 INFO - 'PAGER': '/bin/cat', 12:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:31 INFO - 'PWD': '/builds/slave/test', 12:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:31 INFO - 'SHELL': '/bin/bash', 12:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:31 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:31 INFO - 'USER': 'cltbld', 12:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:31 INFO - 'XPC_FLAGS': '0x0', 12:20:31 INFO - 'XPC_SERVICE_NAME': '0', 12:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:20:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-n9kdpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:20:31 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)) 12:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:20:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ivMOAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:20:31 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)) 12:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:20:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-qJ2z81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:20:31 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)) 12:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:20:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-rGUKR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:20:32 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)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-n0XLrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:20:32 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)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-UJtWvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:20:32 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)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-3RxpaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:20:32 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)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-_jDcff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:20:32 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)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ek7uB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:20:32 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)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-CGCNNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-fSxsc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:20:32 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)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-sQveAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:20:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:20:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-_Z8dk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:20:33 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)) 12:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:20:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-RC60nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-at9RMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:20:33 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)) 12:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:20:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-KLZ7SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:20:33 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)) 12:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:20:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-wlT9rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:20:33 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)) 12:20:33 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)) 12:20:33 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)) 12:20:33 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)) 12:20:33 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)) 12:20:33 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)) 12:20:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:20:33 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 12:20:33 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 12:20:33 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 12:20:33 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 12:20:33 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 12:20:33 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 12:20:35 INFO - Downloading blessings-1.6.tar.gz 12:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:20:36 INFO - Installing collected packages: blessings 12:20:36 INFO - Running setup.py install for blessings 12:20:36 INFO - Successfully installed blessings 12:20:36 INFO - Cleaning up... 12:20:36 INFO - Return code: 0 12:20:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:20:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:36 INFO - Reading from file tmpfile_stdout 12:20:36 INFO - Current package versions: 12:20:36 INFO - blessings == 1.6 12:20:36 INFO - blobuploader == 1.2.4 12:20:36 INFO - docopt == 0.6.1 12:20:36 INFO - functools32 == 3.2.3-2 12:20:36 INFO - jsonschema == 2.5.1 12:20:36 INFO - manifestparser == 1.1 12:20:36 INFO - mozInstall == 1.12 12:20:36 INFO - mozcrash == 0.17 12:20:36 INFO - mozdebug == 0.1 12:20:36 INFO - mozdevice == 0.48 12:20:36 INFO - mozfile == 1.2 12:20:36 INFO - mozhttpd == 0.7 12:20:36 INFO - mozinfo == 0.9 12:20:36 INFO - mozleak == 0.1 12:20:36 INFO - mozlog == 3.3 12:20:36 INFO - moznetwork == 0.27 12:20:36 INFO - mozprocess == 0.23 12:20:36 INFO - mozprofile == 0.28 12:20:36 INFO - mozrunner == 6.12 12:20:36 INFO - mozscreenshot == 0.1 12:20:36 INFO - mozsystemmonitor == 0.3 12:20:36 INFO - moztest == 0.7 12:20:36 INFO - mozversion == 1.4 12:20:36 INFO - psutil == 3.1.1 12:20:36 INFO - requests == 1.2.3 12:20:36 INFO - wsgiref == 0.1.2 12:20:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:36 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 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20:36 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 12:20:36 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 12:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:36 INFO - 'HOME': '/Users/cltbld', 12:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:36 INFO - 'LOGNAME': 'cltbld', 12:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:36 INFO - 'MOZ_NO_REMOTE': '1', 12:20:36 INFO - 'NO_EM_RESTART': '1', 12:20:36 INFO - 'PAGER': '/bin/cat', 12:20:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:36 INFO - 'PWD': '/builds/slave/test', 12:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:36 INFO - 'SHELL': '/bin/bash', 12:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:36 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:36 INFO - 'USER': 'cltbld', 12:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:36 INFO - 'XPC_FLAGS': '0x0', 12:20:36 INFO - 'XPC_SERVICE_NAME': '0', 12:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 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)) 12:20:36 INFO - Cleaning up... 12:20:36 INFO - Return code: 0 12:20:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10385c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaf0dc6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, '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.Rz22s29naF/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.qbfRdMTwFz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 12:20: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', 'jsonschema'] in /builds/slave/test/build 12:20: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 jsonschema 12:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:36 INFO - 'HOME': '/Users/cltbld', 12:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:36 INFO - 'LOGNAME': 'cltbld', 12:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:36 INFO - 'MOZ_NO_REMOTE': '1', 12:20:36 INFO - 'NO_EM_RESTART': '1', 12:20:36 INFO - 'PAGER': '/bin/cat', 12:20:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:36 INFO - 'PWD': '/builds/slave/test', 12:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:36 INFO - 'SHELL': '/bin/bash', 12:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:20:36 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:36 INFO - 'USER': 'cltbld', 12:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:36 INFO - 'XPC_FLAGS': '0x0', 12:20:36 INFO - 'XPC_SERVICE_NAME': '0', 12:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:20:37 INFO - Cleaning up... 12:20:37 INFO - Return code: 0 12:20:37 INFO - Running post-action listener: _resource_record_post_action 12:20:37 INFO - Running post-action listener: _start_resource_monitoring 12:20:37 INFO - Starting resource monitoring. 12:20:37 INFO - [mozharness: 2016-08-07 19:20:37.112117Z] Finished create-virtualenv step (success) 12:20:37 INFO - [mozharness: 2016-08-07 19:20:37.113072Z] Running install step. 12:20:37 INFO - Running pre-action listener: _resource_record_pre_action 12:20:37 INFO - Running main action method: install 12:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:37 INFO - Reading from file tmpfile_stdout 12:20:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:20:37 INFO - Reading from file tmpfile_stdout 12:20:37 INFO - Output received: 12:20:37 INFO - Usage: mozinstall [options] installer 12:20:37 INFO - Options: 12:20:37 INFO - -h, --help show this help message and exit 12:20:37 INFO - -d DEST, --destination=DEST 12:20:37 INFO - Directory to install application into. [default: 12:20:37 INFO - "/builds/slave/test"] 12:20:37 INFO - --app=APP Application being installed. [default: firefox] 12:20:37 INFO - mkdir: /builds/slave/test/build/application 12:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:21:11 INFO - Reading from file tmpfile_stdout 12:21:11 INFO - Output received: 12:21:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:21:11 INFO - Running post-action listener: _resource_record_post_action 12:21:11 INFO - [mozharness: 2016-08-07 19:21:11.398006Z] Finished install step (success) 12:21:11 INFO - [mozharness: 2016-08-07 19:21:11.398137Z] Running run-tests step. 12:21:11 INFO - Running pre-action listener: _resource_record_pre_action 12:21:11 INFO - Running main action method: run_tests 12:21:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:21:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:21:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:21:11 INFO - 2016-08-07 12:21:11.412 screenresolution[2929:71439] starting screenresolution argv=screenresolution get 12:21:11 INFO - 2016-08-07 12:21:11.415 screenresolution[2929:71439] Display 0: 1600x1200x32@60 12:21:11 INFO - 2016-08-07 12:21:11.421 screenresolution[2930:71441] starting screenresolution argv=screenresolution list 12:21:11 INFO - Available Modes on Display 0 12:21:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:21:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:21:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:21:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:21:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:21:11 INFO - Intel Iris: 12:21:11 INFO - Chipset Model: Intel Iris 12:21:11 INFO - Type: GPU 12:21:11 INFO - Bus: Built-In 12:21:11 INFO - VRAM (Dynamic, Max): 1536 MB 12:21:11 INFO - Vendor: Intel (0x8086) 12:21:11 INFO - Device ID: 0x0a2e 12:21:11 INFO - Revision ID: 0x0009 12:21:11 INFO - Displays: 12:21:11 INFO - Display: 12:21:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:21:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:21:11 INFO - Display Serial Number: 1600x1200 60 12:21:11 INFO - Main Display: Yes 12:21:11 INFO - Mirror: Off 12:21:11 INFO - Online: Yes 12:21:11 INFO - Rotation: Supported 12:21:11 INFO - Return code: 0 12:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:21:11 INFO - Python 2.7.3 12:21:11 INFO - Return code: 0 12:21:11 INFO - grabbing minidump binary from tooltool 12:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:11 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 0x10372bd30>, '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 0x103490db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103723b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:21:11 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 12:21:11 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 12:21:11 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 12:21:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:21:11 INFO - Return code: 0 12:21:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:21:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:21:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:21:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:21:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:21:11 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/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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 12:21:11 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/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --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 12:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rz22s29naF/Render', 12:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:11 INFO - 'HOME': '/Users/cltbld', 12:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:11 INFO - 'LOGNAME': 'cltbld', 12:21:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:11 INFO - 'MOZ_NO_REMOTE': '1', 12:21:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:11 INFO - 'NO_EM_RESTART': '1', 12:21:11 INFO - 'PAGER': '/bin/cat', 12:21:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:11 INFO - 'PWD': '/builds/slave/test', 12:21:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:11 INFO - 'SHELL': '/bin/bash', 12:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbfRdMTwFz/Listeners', 12:21:11 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 12:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:11 INFO - 'USER': 'cltbld', 12:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:11 INFO - 'XPC_FLAGS': '0x0', 12:21:11 INFO - 'XPC_SERVICE_NAME': '0', 12:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:11 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/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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 12:21:11 INFO - mozversion application_buildid: 20160807091052 12:21:11 INFO - mozversion application_changeset: 204b39c31233c082553493f52bfe8c3ebcc404ff 12:21:11 INFO - mozversion application_display_name: Nightly 12:21:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:21:11 INFO - mozversion application_name: Firefox 12:21:11 INFO - mozversion application_remotingname: firefox 12:21:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:21:11 INFO - mozversion application_vendor: Mozilla 12:21:11 INFO - mozversion application_version: 51.0a1 12:21:11 INFO - mozversion platform_buildid: 20160807091052 12:21:11 INFO - mozversion platform_changeset: 204b39c31233c082553493f52bfe8c3ebcc404ff 12:21:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:21:11 INFO - mozversion platform_version: 51.0a1 12:21:11 INFO - using testdate: 1470597671 12:21:11 INFO - actual date: 1470597671 12:21:11 INFO - starting webserver on 'localhost:50685' 12:21:11 INFO - SUITE-START | Running 2 tests 12:21:11 INFO - TEST-START | dromaeo_css 12:21:11 INFO - operating with platform_type : mac_ 12:21:11 INFO - Initialising browser for dromaeo_css test... 12:21:12 INFO - TEST-INFO | started process 2940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpVFKWh4/profile http://localhost:50685/getInfo.html) 12:21:14 INFO - PROCESS | 2940 | __metrics Screen width/height:1600/1200 12:21:14 INFO - PROCESS | 2940 | colorDepth:24 12:21:14 INFO - PROCESS | 2940 | Browser inner width/height: 1024/689 12:21:14 INFO - PROCESS | 2940 | __metrics 12:21:14 INFO - PROCESS | 2940 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:21:14 INFO - PROCESS | 2940 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:21:15 INFO - TEST-INFO | 2940: exit 0 12:21:15 INFO - Browser initialized. 12:21:15 INFO - Running cycle 1/1 for dromaeo_css test... 12:21:15 INFO - TEST-INFO | started process 2943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpVFKWh4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:27 INFO - PROCESS | 2943 | RSS: Main: 243748864 12:21:27 INFO - PROCESS | 2943 | 12:22:18 INFO - PROCESS | 2943 | 1470597738761 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] 12:24:31 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:50685/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50685/tests/dromaeo/cssquery-ext.html) 12:24:32 INFO - PROCESS | 2943 | RSS: Main: 379834368 12:24:32 INFO - PROCESS | 2943 | 12:27:35 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:50685/tests/dromaeo/cssquery-ext.html (next: http://localhost:50685/tests/dromaeo/cssquery-jquery.html) 12:27:36 INFO - PROCESS | 2943 | RSS: Main: 385970176 12:27:36 INFO - PROCESS | 2943 | 12:30:38 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:50685/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50685/tests/dromaeo/cssquery-mootools.html) 12:30:39 INFO - PROCESS | 2943 | RSS: Main: 356843520 12:30:39 INFO - PROCESS | 2943 | 12:33:41 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:50685/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50685/tests/dromaeo/cssquery-prototype.html) 12:33:42 INFO - PROCESS | 2943 | RSS: Main: 356331520 12:33:42 INFO - PROCESS | 2943 | 12:36:45 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:50685/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50685/tests/dromaeo/cssquery-yui.html) 12:36:46 INFO - PROCESS | 2943 | RSS: Main: 349937664 12:36:46 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:50685/tests/dromaeo/cssquery-yui.html (next: http://localhost:50685/tests/dromaeo/cssquery-dojo.html) 12:39:49 INFO - PROCESS | 2943 | RSS: Main: 390967296 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | __start_tp_report 12:39:49 INFO - PROCESS | 2943 | _x_x_mozilla_page_load 12:39:49 INFO - PROCESS | 2943 | _x_x_mozilla_page_load_details 12:39:49 INFO - PROCESS | 2943 | |i|pagename|runs| 12:39:49 INFO - PROCESS | 2943 | |0;dojo.html;3355.916102097447;3362.8150451725155;3368.898933032009;3399.9490007649874;3432.5194472773815;5656.066748986423;5813.593048486608;5814.447627475393;5838.562107841907;5853.180554722337;5787.47912687858;5845.7953971611005;5930.525557955364;5954.612950158236;5961.254843144607;5243.606729495284;5294.947050529503;5300.337457817773;5313.521783039526;5427.402985671573;5407.297051383314;5420.6747595144225;5427.402985671592;5451.127819548873;5476.04169270378;5258.1849813279005;5296.152615581488;5311.973440132813;5324.041672498968;5365.222042803811;5308.601854860863;5336.706481143536;5336.759845806948;5338.973305133488;5345.839624811262;5238.92141617876;5295.629305948585;5295.947040529622;5322.494363035506;5325.627206095575;5781.566382521286;5801.854953626151;5827.737751801137;5839.737211825478;5851.093080572518;6200.565960382775;6263.404976527223;6313.747450101991;6354.682265886733;6361.300256971729;6216.844578885519;6325.557210995232;6334.936650633481;6350.174477317965;6380.7128679209545;5591.021571225019;5918.674472903988;5936.7031648417405;5982.132590774313;5995.100734889801;6245.0632405139595;6278.372162783685;6294.8426289342215;6326.9683651581445;6327.525435592349;6299.401556852092;6309.747610095636;6314.305426403092;6320.620762754157;6340.8414789629705;6203.4416902479;6272.247330320391;6305.968470157712;6342.429181373698;6368.872622547523;6260.686965651699;6335.778247761306;6347.1114044033875;6348.873022539523;6357.237131544244;6326.652034138075;6340.461060809791;6354.3010268870385;6355.523335749837;6356.872862542723;4913.557779799835;5033.144365457881;5058.797648094035;5073.289739436482;5135.768890399941;4577.22187228172;4596.4024676791805;4605.631549476034;4615.353850460938;4632;5780.1907732917425;5839.211706419664;5848.356680765112;5851.590388672752;5862.94137058624;6132.936844521141;6184.226971628546;6186.226721659793;6217.533684973645;6224.533160013018;5608.859778505488;5669.801556945487;5676.858078548069;5678.914816277759;5682.829515114553;5388.46115388458;5392;5396.1905714143195;5404.135338345845;5489.560835133179;6239.376062393724;6258.593191442542;6267.811965641038;6284.5600807943;6360.395762402564;6228.22147231596;6270.874582508415;6291.874162516816;6292.276388215414;6300.432961033529;6343.365663433619;6347.42873141401;6361.745530178926;6373.490120790233;6377;6135.967692822357;6182.412670796267;6190.442860142609;6225.564210505402;6321.11504389395;5205.5835533158015;6274.811755647338;6283.59156654816;6306.4639505642535;6327.3988971047675;6192.845178870564;6221.782237621662;6229.750809967732;6241.656708881055;6276.184096067482;6079;6112.41229444207;6112.503480924647;6146.770645870934;6220.564560480723;6052.5095832232955;6112.32764395925;6115.727150604614;6119.969400152971;6126.540509461897;6232.532560057924;6232.75068997235;6256.937430625636;6258.530610204162;6266.028765541349;5921.023031199804;5923.526117910471;5932.911006334822;5976.013957696931;6063.636181829104 12:39:49 INFO - PROCESS | 2943 | |1;ext.html;492.4435388011549;500.40201958659407;505.1261317920001;509.3327740659736;515.4561937156299;31004.379912401768;31860.840695796516;32787;32826;32891.177720556996;33347.66652333476;43466.78266608671;44458.2210512106;44549.55450445494;46403.30395044077;9886.159676427513;10036.247281453883;10038.393856982884;10039.196864250842;10039.996000399939;9799.41203527787;9954.900450995507;9959.25305602079;9967.102960733533;9969.900300997006;8933;9149;12026.338551379671;12203.45084471201;12272.263664180133;12155.756884862298;12223.572174973833;12245.387730613524;12256;12259.141860069798;12177.208481448677;12274.815877761841;12283.385830708517;12288.016958643288;12317.13780035398;32253.354932901446;40839.7958010211;41271;41357.79321103375;43042.70871873818;3162.14622052047;3455.740819438527;3554.0048786339867;3733.9439908401396;4051.8581849635416;31365.84317078423;31988.520172197437;32109.839450802596;32412.513812292833;32632;3226.1913046936306;3254.7233485153793;3302.190963214004;3313.370459612666;3422.281320922609;483561;486664;489439;489580;489997.55001225125;51783;59435.702821486484;59620;59909;60014;60223;63571.68214158899;63910.68044659747;63970.80145992682;63971;13413.597592072254;15967.920160399124;15973.201339932957;15986.200689965455;15987.280572374271;12249.632511024683;12385.318807465675;12386.75226495465;12389.566365177176;12394.256344619353;14614.561563152909;16419.6716065678;16505.33978640841;16507.33970641185;16508.83491165073;5390.272313237741;6218.347073557302;6267.780627678009;6292.748290068346;6311.495080393557;894.9149830766066;961.5192403798101;996.9052939970691;1003.7152444870577;1012;23292.65061024086;26454.47091058168;31887.883924062546;32662.510062349083;32855.67144328574;892.9642814287356;1095.2497539185683;1124.7862906047824;1138.3568283919558;1163.7323415614287;14781.778273325908;15083.245837708071;15594;15907.602309942344;15968.12175330368;503551;889591;898918;901861;905908;51882.74058629683;52157.7392113037;59656;60311.69844150751;60592;1379.6275005748391;1412.1315391034645;1415.5328741515482;1424.223798030076;1437.7627691430796;25691;30220.395592088476;30489.08532744021;30818.38363232678;31383.686163138078;43673.34489982716;50783.74608127084;52016.739916300176;52022;52113.7394313026;521252;533702;575226;582124;582649;26619.53945987009;26764.59853102166;26851.32871678224;26865.865670671523;26917.461650767265;46904;47162.76418617885;48047.27929081136;48316.5168348312;48495.03009939852;39230.215395692496;39360.40959385669;39363.409548856216;40250.59749402585;40456.59543404528;38361.23277534489;38588.61411385963;38739;39977;40090.79954600208;38729.41905871358;38986.4152037714;39524.40713389359;40046.99882502961;40100.598994009684;31403.743850245733;33157.33685326328;35021.47467788036;35748.821255893556;35950.46074308835;24228.273151805475;24689.62965555482;25738.970441182144;25932;26178.86910565435 12:39:49 INFO - PROCESS | 2943 | |2;jquery.html;356.9214772749994;370.7440226223432;377.4150067395537;382.94447305140756;405.74843596969885;15569.377224911004;15961.68076638468;20786.06462709178;21118.89440552797;21458;19990.70013949792;20439.386818395436;20680.689789653166;20836.374908752725;21152.8942355288;5740.827775166731;5771.2497375341145;6023.156758053876;6024.638521688691;6047.15339852421;6091.78678746244;6135.539834512407;6136.723847426876;6140.0789881517685;6149.938500614981;3845.2693988142164;5617.915731264035;5960.403959604048;6031.366706495821;6094.085887116946;6051.697415129226;6069.119977603267;6069.302030266532;6081.452669259766;6570.770023049218;5821.970890145564;5822.970885145547;5831.125331200312;5851.561132915049;5857.853553661193;13518.986076044335;16123.758143627854;20219.696704549442;24733.25800225996;25001.87491562884;2022.2315520102413;2186.9562608747897;2231.9888400557893;2360.8819559022154;2868.899588514392;14936.477223297241;15398.307076181598;15847;15920.681586368208;16398.508044758677;1791.3461586520957;1800.3788692900928;1837.338558119076;1862.6181632765251;1893.1386219270337;90975;107194;112889.43555282253;125031.99999999908;129854.7014529852;11220.158488113424;11397.373144476967;11588.710282242842;11662.475188616532;11890.989265912322;12274;14741.778873316909;14749.188794616399;14785.852141478663;14792.408303667948;7920.32677222431;8152.266296033267;8486.702965396182;8584.828303434022;8610.956945215234;8283.08886022537;8322.54226017575;8349.373796965252;8530.317574594017;8536.44513106646;4500.819967201341;4515.458145022619;4564.612007979293;4594;4703.600193983481;1653.3221379234456;1911.7992610775946;1912.244663357966;1915.7796853362042;1922.6346994071082;833.8540755367786;843.2452954605594;932.7201839448138;954.71358592422;1019.4851599941982;20129.39611811648;20527.794722052888;21407.46481337948;21506.924653767248;21553.35339939804;887.8591010551411;916.4180745226696;926.9942112807679;930.5300823084299;931.1433481197315;8702.521361325062;11236.831447528293;11276.605318813967;11332.943335283271;11343.716407089889;565702;596590;609098;620171;624012;71837.64081179665;112372;127918;130328;131426.34286828505;1034.182995433599;1036.0468369100445;1045.1012129568564;1092.6503518874042;1101.3612104979093;18748.062596870375;19450.416487505398;19465.805341946965;19471.61056778828;19520.9023954885;58123;58513.70743146257;58964;59124;59956.10065848928;85654.00210992586;87910.56044719735;87963.56018219868;89022.55488722515;89258;8067.717629882926;8071.677132914852;8232.547209903512;8301.086880443027;8307.169283071644;12661;13036.348182590642;13145.868541314465;13449.663758405726;13640.931795340959;8542.82914341722;11578.305301681927;11691.08974230808;11814.291142531476;11821.290722556674;11204.943975280072;11383.373914434786;11547.422628868355;11575.016123629586;11745;10204.795904081728;11577.073834093084;11877.168598198043;11878.287302761863;11966.700832479257;6794.626295553792;7724.196612315964;7972.6412311444965;8273.296769774637;8382.790430239049;8658.783530411538;10291.53688084053;11292.7741445169;11384.677943240215;11607.187496875475 12:39:49 INFO - PROCESS | 2943 | |3;mootools.html;1354.0656946706765;1411.7858641568253;1542.4524293875675;1654.454030170044;1911.9808801911986;7693.422993275506;8524.872126918093;8770;8770.342224333168;8869.423487473327;8633.48199108054;8723.432976856515;8729.9960504542;8731.694390696326;8732.825343493127;2299.597570425173;2335.8948847301913;2336.6728657987896;2336.906523739048;2337.4039619896903;2318;2357.858528488296;2364.408897775556;2364.988175059122;2369.7037870266217;2313.791758741713;2333.4982978659586;2348;2355.3758254062686;2360.0913648245464;2208.9703926228117;2237.5077482953725;2240.2943072931976;2258.695076164713;2269.7049383580193;2253.312739614417;2301.551197516485;2302.781235782598;2306.400335912658;2307.91922282721;8580.957095214546;8664.003639581466;8754.124587541259;8754.781130471725;8756.810797300675;5116.590672746172;5295.682259064469;5298.311219541473;5312.893742125136;5317.388500322474;3534.575850897883;3563.322968635977;3612.349777040132;3612.530371051773;3629.3104310181243;965.7006328038331;1070.4487189097622;1776.1829558403151;1806.1420825107969;1855.730919016735;11413.657590272305;11463.254888432226;11494.023008044243;11499.482523286471;11501.13741469393;4001.599840015975;4236.745795252233;4551.908961820745;4555.043440877453;4625.722456652545;9058.682946096855;9070.455772653662;9073.319501037317;9083.227925626396;9083.273338132933;4526.434195725535;5202.739863006835;5206.479352064839;5207.270982062514;5216.26972223889;3796.0484003649117;4375.299952007664;4793.760311984456;4859.611231101503;4883.633727470454;3733.9439908401396;3737;3755.9812200938823;3827.655511003967;3830.3871380578976;1146.1862077924766;1149.9022583080364;1161.512164890748;1169.9473523691283;1172.243902682782;905.3843386497246;926.3191554207652;943.3773709351932;953.142172045151;988.7725823060737;5836.212111364996;5923.644581325048;5960.612560183574;5971.820845374559;6134.079888016744;990.3859607043679;1026.440589878518;1027.1679939249082;1050.9316894401838;1062.2245760594808;3997.380406037069;4064.0246340877975;4131.318332475108;4283.121959998193;4301.78491075445;10026.448545330077;10604.363738175734;10671.83992240117;10838.729031774112;10843.67468975932;10253.641122560675;10661.413622250851;10673.146148308117;10673.946630266953;10735.78528429427;7955.124936257007;8055.919440805634;8247.092819789817;8287.62705678234;8288.875666865002;5894.557908156819;5951.404859514014;6102.664353460602;6165.445109940127;6188.721507532262;9855.45794981283;9887.357321774061;9892.406455612687;9901.653442129491;9912.256580756328;8542.78643033929;9298.767530811783;9627.56675949598;9874.555644996137;9951.950240248752;6701.296363881722;7183.389411900047;7567.091948965939;7585.241475852371;7619.885701714368;8195.918040819515;8212.589370531568;8268.710595129141;8294.502329860228;8323.542205178774;7286.74496392645;7340.669669864762;7444.069491313586;7522.736704215545;7570.962145189239;7085.751998680022;7247.166575843635;7264.164621068645;7300.96349518249;7336.156342020736;6862.2158238857255;7009.579425234502;7013.368796808311;7014.614196219257;7039.296070392919;4462.308342206963;4851.975740121418;5062.1141300271565;5066.341375621146;5076.238564215398;4959.752012399294;4976.751162441936;5139.871503212449;5263.421023687468;5287.709175995357 12:39:49 INFO - PROCESS | 2943 | |4;prototype.html;302.89398710451337;310.8010873041254;314.4905253489346;319.46170702366516;321.6156692752162;4443.84446544371;5094.133997220472;5345.705986170759;5372.865678358043;5402.621816472843;4530.7281563106235;4822.98717269373;5310.0441920454305;5341.225522299264;5363.077122967982;3536.3634545781747;3759.8120093995326;3898.883033508985;3912.471816304805;4075.673946084306;4057.9594204057876;4107.931937696206;4123.340265557511;4129.463169787939;4130.876073717794;4037.6769858411258;4051.1897620475875;4054.3918412238254;4058.6753059755147;4082.816273267695;3773.9810251232016;3959.4456776051375;4026;4055.858044968427;4089.243489954353;3438.1232785639754;3463.515107884898;3463.8268086595567;3475.2623688155923;3481.54739883816;5118.129917913963;5122.3853137623355;5126.436092029874;5167.767450464738;5191.610629202787;4159.688023398227;4378.536662577673;4546;4548.431446069241;4566.840160594396;4806.375171227718;5206.661566998171;5468.742189296484;5568.693721845338;5575.749091290902;2936.3246453315855;3404;3719.851205951759;3810.923781524382;3819.598942111066;4630.328602352673;4768.546988036131;5561.416051314634;5798.304203495565;5821.417858214187;3071.4932036214223;3864.9033774155873;3867.4972253607416;3884.7086468514976;3970.4242884782125;3317.834108294576;3909.6481316681065;3915.04247876062;3916.6083391660604;3918.921621567553;3799.50606421169;4522.34426008227;4548.5906268436;4551.178269472882;4552.726836389827;4359.2807186813825;4837.443693975168;5230.63385563007;5543.113101903676;5676.489115979499;1290.541857640543;1316.973660526784;1335.2389138191331;1340.4973135074347;1341.1014620204487;735.2904447208363;759.2559291893975;799.9160088190656;819.1562690428749;832.7293629570414;4109.527404348479;4659.5573420525;4822.95177048225;4964.652474326835;5048.798048078036;4837.105135549935;5226.869328266824;5304.681719096867;5721.568333458346;5740.827775166752;4296.806643701041;5194.6104042196985;5227.3465816772905;5237.921431178535;5244.6328756987405;2459.495803360307;2573.5882258838496;2745.4646343962736;3039.589655396493;3041.376517813843;4802.51974802517;5666.829995100154;5899.970500147472;5915.231019967377;5938.346781853993;5176.637635365563;5519.267962358578;5534.4742249486235;5872.64764114146;5933.406659334032;5911.9113213301835;5916.25470486199;5923.89701655906;5933.228680271537;5936.673482958478;4998.450170481171;5024.371953505812;5636.2954630671165;5691.4877661010705;5754.482096611325;4854.863859901632;5261.210818377274;5683.687397193194;5742.339630942495;5751.338596061507;5951.131764353032;6004.939950600613;6008.639481631116;6009.128676341818;6038.607490513103;3425.6231814500884;3572.7499075065534;3603.549556305462;3782.678472329883;3904.648581627667;4994.675346102492;5144.639875208849;5332.226827110125;5758.280214973129;5763.4812866842185;4645.488996210346;5602.215689803349;5605.523530499953;5614.326280846324;5634.140733557998;4623.791929363254;4952.900941981212;5445.801923576807;5597.944020559742;5607.243022192115;4904.092742842586;4910.582600479;5458.235846981505;5508.476694713996;5563.388027317073;4437.028859171089;5186.8962620748125;5462.016836969384;5476.288082549243;5640.830775076754;4169.958300417078;5165.7675404607635;5489.725513724218;5492.7641280713115;5532.419095995024 12:39:49 INFO - PROCESS | 2943 | |5;yui.html;707.9716811327547;744.9180590135085;764.896738940243;784.3293983643985;841.9621117049733;15550.611234719137;16023.198840058008;16255;16375.344986200538;16571.171441427912;14857.628559286024;14927.029743066692;14979.625509362271;15050.623734406645;15074.3216555255;694.6214313199318;717.9964100179492;848.2323497234996;860.6729442811754;876.9824603507926;850.5619605902965;873.9912600874005;874.33113668044;875.2035647560721;875.4397185801092;935.5369092299321;940.4874343482818;940.9602389359761;942.3639043645546;942.981140377192;736.1240124252123;897.5018864530183;924.653255029364;931.8835145606799;937.4234845569994;692.9896051559231;694.8193469697865;695.5548448992648;698.3819319901924;698.7728988078894;14926.477573284883;14947.925260373737;14990;15003.549893503212;15033.473828416063;14062.437502499888;14183.290835458185;14322.427102915872;14414;14656.560303190921;12821.487140514368;13004.089713720043;13042;13263.933680331536;13658.453661853513;4611.9077618447445;4666.953330466686;4770.856874293777;4793.544613261734;4799.352087468182;105239.99999999923;106734;106947;107418;111816.88183118145;11281.03572047426;11409.714757131138;11514.424278786028;11624.128190385754;11774.705632359259;22660.773392266197;22759.748213848066;22808.429789255402;22919;22951.967161477773;7857.842843143219;7902.68389264423;8088.919110808934;8210.096889342167;8308.501489910625;4376.168527979674;4402.339649052604;4412.889677758082;4481.327800829837;4634.768261586907;3499.807510586942;3634.5638523376833;3663.7435379523176;3665.065408320861;3685.447182922583;651.1209866679944;651.8337823854887;659.6306068601502;661.9702113404812;671.342084756941;457.99542004580195;599.7794488216458;619.2537991719967;619.7613918641265;653.4870126950416;7502.962485187539;8486.575671216415;8516.8722469163;8857.867131993025;9005.729828105168;508.83208541181324;589.7581991383512;617.9320274769772;621.6083867163658;635.4376376906379;4016.6987475939422;4192.811323490389;4271.67962402821;4273.465816772903;4273.807678654468;102425;152097;156158.38416158294;161205;163811.44754209937;135454.32272838574;138304.47802980745;140716;141636.29181854025;144702;80401;82222;106107;119415;122477;7840.778012012142;8537.317014638938;8583.399162058597;8614.78463038429;8667.653293868174;65002;65273.673631633435;66476.33523664702;66964;68880;97965.51017244869;98355;100658.496707516;101119;103713;11104.777904442028;11160.051395631463;11183.944080279547;11382.601608943647;11762.411879405825;12139.939300303442;12283.938580307042;12469;12512.0615953802;12882.67793305175;10877.51051202682;11841.940790296338;11864.644060678194;11870.703232419259;12130.757384852077;9359.064093590587;9405.20055795265;9510.524473776422;9541.332106752461;9815.85276220843;9567.37812042215;11280.379579123228;11500;11728.530858765555;12110.212836165621;9413.81172376535;9720.888325626796;9854.507274636382;9923.057309555581;10067.798644026932;9351.218176841116;10077.244206684381;11114.429941156874;11649.475773590379;11716.94141529287 12:39:49 INFO - PROCESS | 2943 | __end_tp_report 12:39:49 INFO - PROCESS | 2943 | __start_cc_report 12:39:49 INFO - PROCESS | 2943 | _x_x_mozilla_cycle_collect,1402 12:39:49 INFO - PROCESS | 2943 | __end_cc_report 12:39:49 INFO - PROCESS | 2943 | __startTimestamp1470598789788__endTimestamp 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | ------- Summary: start ------- 12:39:49 INFO - PROCESS | 2943 | Number of tests: 6 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | [#0] dojo.html Cycles:165 Average:5828.08 Median:6079.00 stddev:629.46 (10.4%) stddev-sans-first:600.77 12:39:49 INFO - PROCESS | 2943 | Values: 3355.9 3362.8 3368.9 3399.9 3432.5 5656.1 5813.6 5814.4 5838.6 5853.2 5787.5 5845.8 5930.5 5954.6 5961.3 5243.6 5294.9 5300.3 5313.5 5427.4 5407.3 5420.7 5427.4 5451.1 5476.0 5258.2 5296.2 5312.0 5324.0 5365.2 5308.6 5336.7 5336.8 5339.0 5345.8 5238.9 5295.6 5295.9 5322.5 5325.6 5781.6 5801.9 5827.7 5839.7 5851.1 6200.6 6263.4 6313.7 6354.7 6361.3 6216.8 6325.6 6334.9 6350.2 6380.7 5591.0 5918.7 5936.7 5982.1 5995.1 6245.1 6278.4 6294.8 6327.0 6327.5 6299.4 6309.7 6314.3 6320.6 6340.8 6203.4 6272.2 6306.0 6342.4 6368.9 6260.7 6335.8 6347.1 6348.9 6357.2 6326.7 6340.5 6354.3 6355.5 6356.9 4913.6 5033.1 5058.8 5073.3 5135.8 4577.2 4596.4 4605.6 4615.4 4632.0 5780.2 5839.2 5848.4 5851.6 5862.9 6132.9 6184.2 6186.2 6217.5 6224.5 5608.9 5669.8 5676.9 5678.9 5682.8 5388.5 5392.0 5396.2 5404.1 5489.6 6239.4 6258.6 6267.8 6284.6 6360.4 6228.2 6270.9 6291.9 6292.3 6300.4 6343.4 6347.4 6361.7 6373.5 6377.0 6136.0 6182.4 6190.4 6225.6 6321.1 5205.6 6274.8 6283.6 6306.5 6327.4 6192.8 6221.8 6229.8 6241.7 6276.2 6079.0 6112.4 6112.5 6146.8 6220.6 6052.5 6112.3 6115.7 6120.0 6126.5 6232.5 6232.8 6256.9 6258.5 6266.0 5921.0 5923.5 5932.9 5976.0 6063.6 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | [#1] ext.html Cycles:180 Average:74587.10 Median:19651.41 stddev:173669.91 (883.8%) stddev-sans-first:174068.00 12:39:49 INFO - PROCESS | 2943 | Values: 492.4 500.4 505.1 509.3 515.5 31004.4 31860.8 32787.0 32826.0 32891.2 33347.7 43466.8 44458.2 44549.6 46403.3 9886.2 10036.2 10038.4 10039.2 10040.0 9799.4 9954.9 9959.3 9967.1 9969.9 8933.0 9149.0 12026.3 12203.5 12272.3 12155.8 12223.6 12245.4 12256.0 12259.1 12177.2 12274.8 12283.4 12288.0 12317.1 32253.4 40839.8 41271.0 41357.8 43042.7 3162.1 3455.7 3554.0 3733.9 4051.9 31365.8 31988.5 32109.8 32412.5 32632.0 3226.2 3254.7 3302.2 3313.4 3422.3 483561.0 486664.0 489439.0 489580.0 489997.6 51783.0 59435.7 59620.0 59909.0 60014.0 60223.0 63571.7 63910.7 63970.8 63971.0 13413.6 15967.9 15973.2 15986.2 15987.3 12249.6 12385.3 12386.8 12389.6 12394.3 14614.6 16419.7 16505.3 16507.3 16508.8 5390.3 6218.3 6267.8 6292.7 6311.5 894.9 961.5 996.9 1003.7 1012.0 23292.7 26454.5 31887.9 32662.5 32855.7 893.0 1095.2 1124.8 1138.4 1163.7 14781.8 15083.2 15594.0 15907.6 15968.1 503551.0 889591.0 898918.0 901861.0 905908.0 51882.7 52157.7 59656.0 60311.7 60592.0 1379.6 1412.1 1415.5 1424.2 1437.8 25691.0 30220.4 30489.1 30818.4 31383.7 43673.3 50783.7 52016.7 52022.0 52113.7 521252.0 533702.0 575226.0 582124.0 582649.0 26619.5 26764.6 26851.3 26865.9 26917.5 46904.0 47162.8 48047.3 48316.5 48495.0 39230.2 39360.4 39363.4 40250.6 40456.6 38361.2 38588.6 38739.0 39977.0 40090.8 38729.4 38986.4 39524.4 40047.0 40100.6 31403.7 33157.3 35021.5 35748.8 35950.5 24228.3 24689.6 25739.0 25932.0 26178.9 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | [#2] jquery.html Cycles:180 Average:35119.49 Median:2209.47 stddev:100497.43 (4548.5%) stddev-sans-first:100745.45 12:39:49 INFO - PROCESS | 2943 | Values: 356.9 370.7 377.4 382.9 405.7 15569.4 15961.7 20786.1 21118.9 21458.0 19990.7 20439.4 20680.7 20836.4 21152.9 5740.8 5771.2 6023.2 6024.6 6047.2 6091.8 6135.5 6136.7 6140.1 6149.9 3845.3 5617.9 5960.4 6031.4 6094.1 6051.7 6069.1 6069.3 6081.5 6570.8 5822.0 5823.0 5831.1 5851.6 5857.9 13519.0 16123.8 20219.7 24733.3 25001.9 2022.2 2187.0 2232.0 2360.9 2868.9 14936.5 15398.3 15847.0 15920.7 16398.5 1791.3 1800.4 1837.3 1862.6 1893.1 90975.0 107194.0 112889.4 125032.0 129854.7 11220.2 11397.4 11588.7 11662.5 11891.0 12274.0 14741.8 14749.2 14785.9 14792.4 7920.3 8152.3 8486.7 8584.8 8611.0 8283.1 8322.5 8349.4 8530.3 8536.4 4500.8 4515.5 4564.6 4594.0 4703.6 1653.3 1911.8 1912.2 1915.8 1922.6 833.9 843.2 932.7 954.7 1019.5 20129.4 20527.8 21407.5 21506.9 21553.4 887.9 916.4 927.0 930.5 931.1 8702.5 11236.8 11276.6 11332.9 11343.7 565702.0 596590.0 609098.0 620171.0 624012.0 71837.6 112372.0 127918.0 130328.0 131426.3 1034.2 1036.0 1045.1 1092.7 1101.4 18748.1 19450.4 19465.8 19471.6 19520.9 58123.0 58513.7 58964.0 59124.0 59956.1 85654.0 87910.6 87963.6 89022.6 89258.0 8067.7 8071.7 8232.5 8301.1 8307.2 12661.0 13036.3 13145.9 13449.7 13640.9 8542.8 11578.3 11691.1 11814.3 11821.3 11204.9 11383.4 11547.4 11575.0 11745.0 10204.8 11577.1 11877.2 11878.3 11966.7 6794.6 7724.2 7972.6 8273.3 8382.8 8658.8 10291.5 11292.8 11384.7 11607.2 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | [#3] mootools.html Cycles:180 Average:5641.09 Median:5096.41 stddev:3110.98 (61.0%) stddev-sans-first:3103.03 12:39:49 INFO - PROCESS | 2943 | Values: 1354.1 1411.8 1542.5 1654.5 1912.0 7693.4 8524.9 8770.0 8770.3 8869.4 8633.5 8723.4 8730.0 8731.7 8732.8 2299.6 2335.9 2336.7 2336.9 2337.4 2318.0 2357.9 2364.4 2365.0 2369.7 2313.8 2333.5 2348.0 2355.4 2360.1 2209.0 2237.5 2240.3 2258.7 2269.7 2253.3 2301.6 2302.8 2306.4 2307.9 8581.0 8664.0 8754.1 8754.8 8756.8 5116.6 5295.7 5298.3 5312.9 5317.4 3534.6 3563.3 3612.3 3612.5 3629.3 965.7 1070.4 1776.2 1806.1 1855.7 11413.7 11463.3 11494.0 11499.5 11501.1 4001.6 4236.7 4551.9 4555.0 4625.7 9058.7 9070.5 9073.3 9083.2 9083.3 4526.4 5202.7 5206.5 5207.3 5216.3 3796.0 4375.3 4793.8 4859.6 4883.6 3733.9 3737.0 3756.0 3827.7 3830.4 1146.2 1149.9 1161.5 1169.9 1172.2 905.4 926.3 943.4 953.1 988.8 5836.2 5923.6 5960.6 5971.8 6134.1 990.4 1026.4 1027.2 1050.9 1062.2 3997.4 4064.0 4131.3 4283.1 4301.8 10026.4 10604.4 10671.8 10838.7 10843.7 10253.6 10661.4 10673.1 10673.9 10735.8 7955.1 8055.9 8247.1 8287.6 8288.9 5894.6 5951.4 6102.7 6165.4 6188.7 9855.5 9887.4 9892.4 9901.7 9912.3 8542.8 9298.8 9627.6 9874.6 9952.0 6701.3 7183.4 7567.1 7585.2 7619.9 8195.9 8212.6 8268.7 8294.5 8323.5 7286.7 7340.7 7444.1 7522.7 7571.0 7085.8 7247.2 7264.2 7301.0 7336.2 6862.2 7009.6 7013.4 7014.6 7039.3 4462.3 4852.0 5062.1 5066.3 5076.2 4959.8 4976.8 5139.9 5263.4 5287.7 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | [#4] prototype.html Cycles:180 Average:4451.63 Median:4931.74 stddev:1384.95 (28.1%) stddev-sans-first:1353.37 12:39:49 INFO - PROCESS | 2943 | Values: 302.9 310.8 314.5 319.5 321.6 4443.8 5094.1 5345.7 5372.9 5402.6 4530.7 4823.0 5310.0 5341.2 5363.1 3536.4 3759.8 3898.9 3912.5 4075.7 4058.0 4107.9 4123.3 4129.5 4130.9 4037.7 4051.2 4054.4 4058.7 4082.8 3774.0 3959.4 4026.0 4055.9 4089.2 3438.1 3463.5 3463.8 3475.3 3481.5 5118.1 5122.4 5126.4 5167.8 5191.6 4159.7 4378.5 4546.0 4548.4 4566.8 4806.4 5206.7 5468.7 5568.7 5575.7 2936.3 3404.0 3719.9 3810.9 3819.6 4630.3 4768.5 5561.4 5798.3 5821.4 3071.5 3864.9 3867.5 3884.7 3970.4 3317.8 3909.6 3915.0 3916.6 3918.9 3799.5 4522.3 4548.6 4551.2 4552.7 4359.3 4837.4 5230.6 5543.1 5676.5 1290.5 1317.0 1335.2 1340.5 1341.1 735.3 759.3 799.9 819.2 832.7 4109.5 4659.6 4823.0 4964.7 5048.8 4837.1 5226.9 5304.7 5721.6 5740.8 4296.8 5194.6 5227.3 5237.9 5244.6 2459.5 2573.6 2745.5 3039.6 3041.4 4802.5 5666.8 5900.0 5915.2 5938.3 5176.6 5519.3 5534.5 5872.6 5933.4 5911.9 5916.3 5923.9 5933.2 5936.7 4998.5 5024.4 5636.3 5691.5 5754.5 4854.9 5261.2 5683.7 5742.3 5751.3 5951.1 6004.9 6008.6 6009.1 6038.6 3425.6 3572.7 3603.5 3782.7 3904.6 4994.7 5144.6 5332.2 5758.3 5763.5 4645.5 5602.2 5605.5 5614.3 5634.1 4623.8 4952.9 5445.8 5597.9 5607.2 4904.1 4910.6 5458.2 5508.5 5563.4 4437.0 5186.9 5462.0 5476.3 5640.8 4170.0 5165.8 5489.7 5492.8 5532.4 12:39:49 INFO - PROCESS | 2943 | 12:39:49 INFO - PROCESS | 2943 | [#5] yui.html Cycles:180 Average:24931.66 Median:4389.25 stddev:40653.59 (926.2%) stddev-sans-first:40726.94 12:39:49 INFO - PROCESS | 2943 | Values: 708.0 744.9 764.9 784.3 842.0 15550.6 16023.2 16255.0 16375.3 16571.2 14857.6 14927.0 14979.6 15050.6 15074.3 694.6 718.0 848.2 860.7 877.0 850.6 874.0 874.3 875.2 875.4 935.5 940.5 941.0 942.4 943.0 736.1 897.5 924.7 931.9 937.4 693.0 694.8 695.6 698.4 698.8 14926.5 14947.9 14990.0 15003.5 15033.5 14062.4 14183.3 14322.4 14414.0 14656.6 12821.5 13004.1 13042.0 13263.9 13658.5 4611.9 4667.0 4770.9 4793.5 4799.4 105240.0 106734.0 106947.0 107418.0 111816.9 11281.0 11409.7 11514.4 11624.1 11774.7 22660.8 22759.7 22808.4 22919.0 22952.0 7857.8 7902.7 8088.9 8210.1 8308.5 4376.2 4402.3 4412.9 4481.3 4634.8 3499.8 3634.6 3663.7 3665.1 3685.4 651.1 651.8 659.6 662.0 671.3 458.0 599.8 619.3 619.8 653.5 7503.0 8486.6 8516.9 8857.9 9005.7 508.8 589.8 617.9 621.6 635.4 4016.7 4192.8 4271.7 4273.5 4273.8 102425.0 152097.0 156158.4 161205.0 163811.4 135454.3 138304.5 140716.0 141636.3 144702.0 80401.0 82222.0 106107.0 119415.0 122477.0 7840.8 8537.3 8583.4 8614.8 8667.7 65002.0 65273.7 66476.3 66964.0 68880.0 97965.5 98355.0 100658.5 101119.0 103713.0 11104.8 11160.1 11183.9 11382.6 11762.4 12139.9 12283.9 12469.0 12512.1 12882.7 10877.5 11841.9 11864.6 11870.7 12130.8 9359.1 9405.2 9510.5 9541.3 9815.9 9567.4 11280.4 11500.0 11728.5 12110.2 9413.8 9720.9 9854.5 9923.1 10067.8 9351.2 10077.2 11114.4 11649.5 11716.9 12:39:49 INFO - PROCESS | 2943 | -------- Summary: end -------- 12:39:49 INFO - PROCESS | 2943 | 12:39:50 INFO - TEST-INFO | 2943: exit 0 12:39:50 INFO - TEST-OK | dromaeo_css | took 1118436ms 12:39:50 INFO - TEST-START | kraken 12:39:50 INFO - operating with platform_type : mac_ 12:39:50 INFO - Initialising browser for kraken test... 12:39:50 INFO - TEST-INFO | started process 3059 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpJYzYwh/profile http://localhost:50685/getInfo.html) 12:39:52 INFO - PROCESS | 3059 | __metrics Screen width/height:1600/1200 12:39:52 INFO - PROCESS | 3059 | colorDepth:24 12:39:52 INFO - PROCESS | 3059 | Browser inner width/height: 1024/689 12:39:52 INFO - PROCESS | 3059 | __metrics 12:39:52 INFO - PROCESS | 3059 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:39:52 INFO - PROCESS | 3059 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:39:53 INFO - TEST-INFO | 3059: exit 0 12:39:53 INFO - Browser initialized. 12:39:53 INFO - Running cycle 1/1 for kraken test... 12:39:53 INFO - TEST-INFO | started process 3060 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpJYzYwh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:05 INFO - PROCESS | 3060 | RSS: Main: 243490816 12:40:05 INFO - PROCESS | 3060 | 12:40:08 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50685/tests/kraken/driver.html?testName=audio-beat-detection) 12:40:09 INFO - PROCESS | 3060 | RSS: Main: 293781504 12:40:09 INFO - PROCESS | 3060 | 12:40:11 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50685/tests/kraken/driver.html?testName=audio-dft) 12:40:12 INFO - PROCESS | 3060 | RSS: Main: 300630016 12:40:12 INFO - PROCESS | 3060 | 12:40:16 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50685/tests/kraken/driver.html?testName=audio-fft) 12:40:16 INFO - PROCESS | 3060 | RSS: Main: 396599296 12:40:16 INFO - PROCESS | 3060 | 12:40:18 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50685/tests/kraken/driver.html?testName=audio-oscillator) 12:40:19 INFO - PROCESS | 3060 | RSS: Main: 298082304 12:40:19 INFO - PROCESS | 3060 | 12:40:21 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50685/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:40:22 INFO - PROCESS | 3060 | RSS: Main: 301649920 12:40:22 INFO - PROCESS | 3060 | 12:40:24 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50685/tests/kraken/driver.html?testName=imaging-darkroom) 12:40:25 INFO - PROCESS | 3060 | RSS: Main: 339640320 12:40:25 INFO - PROCESS | 3060 | 12:40:28 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50685/tests/kraken/driver.html?testName=imaging-desaturate) 12:40:29 INFO - PROCESS | 3060 | RSS: Main: 341037056 12:40:29 INFO - PROCESS | 3060 | 12:40:31 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50685/tests/kraken/driver.html?testName=json-parse-financial) 12:40:32 INFO - PROCESS | 3060 | RSS: Main: 338079744 12:40:32 INFO - PROCESS | 3060 | 12:40:33 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50685/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:40:34 INFO - PROCESS | 3060 | RSS: Main: 312950784 12:40:34 INFO - PROCESS | 3060 | 12:40:36 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:40:37 INFO - PROCESS | 3060 | RSS: Main: 318803968 12:40:37 INFO - PROCESS | 3060 | 12:40:39 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:40:40 INFO - PROCESS | 3060 | RSS: Main: 325787648 12:40:40 INFO - PROCESS | 3060 | 12:40:43 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:40:43 INFO - PROCESS | 3060 | RSS: Main: 330235904 12:40:43 INFO - PROCESS | 3060 | 12:40:46 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:40:47 INFO - PROCESS | 3060 | RSS: Main: 331755520 12:40:47 INFO - PROCESS | 3060 | 12:40:48 INFO - PROCESS | 3060 | Cycle 1(1): loaded http://localhost:50685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50685/tests/kraken/driver.html?testName=ai-astar) 12:40:49 INFO - PROCESS | 3060 | RSS: Main: 375263232 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | __start_tp_report 12:40:49 INFO - PROCESS | 3060 | _x_x_mozilla_page_load 12:40:49 INFO - PROCESS | 3060 | _x_x_mozilla_page_load_details 12:40:49 INFO - PROCESS | 3060 | |i|pagename|runs| 12:40:49 INFO - PROCESS | 3060 | |0;ai-astar;101;112;112;113;114;110;91;123;166;167 12:40:49 INFO - PROCESS | 3060 | |1;audio-beat-detection;144;140;109;166;106;106;136;132;175;136 12:40:49 INFO - PROCESS | 3060 | |2;audio-dft;183;184;187;185;183;180;183;181;183;184 12:40:49 INFO - PROCESS | 3060 | |3;audio-fft;78;57;60;87;57;56;62;67;82;56 12:40:49 INFO - PROCESS | 3060 | |4;audio-oscillator;84;69;100;71;79;69;124;99;96;101 12:40:49 INFO - PROCESS | 3060 | |5;imaging-gaussian-blur;88;85;87;84;89;130;90;85;88;86 12:40:49 INFO - PROCESS | 3060 | |6;imaging-darkroom;92;92;92;93;92;92;92;93;109;146 12:40:49 INFO - PROCESS | 3060 | |7;imaging-desaturate;88;86;85;86;86;86;86;86;84;86 12:40:49 INFO - PROCESS | 3060 | |8;json-parse-financial;54;51;53;53;52;54;52;53;53;54 12:40:49 INFO - PROCESS | 3060 | |9;json-stringify-tinderbox;68;78;66;76;75;96;99;100;80;72 12:40:49 INFO - PROCESS | 3060 | |10;stanford-crypto-aes;85;86;84;87;83;83;84;99;107;86 12:40:49 INFO - PROCESS | 3060 | |11;stanford-crypto-ccm;139;140;144;150;139;154;144;153;169;139 12:40:49 INFO - PROCESS | 3060 | |12;stanford-crypto-pbkdf2;166;166;166;168;168;167;166;166;164;167 12:40:49 INFO - PROCESS | 3060 | |13;stanford-crypto-sha256-iterative;67;68;67;67;66;66;67;67;83;82 12:40:49 INFO - PROCESS | 3060 | __end_tp_report 12:40:49 INFO - PROCESS | 3060 | __start_cc_report 12:40:49 INFO - PROCESS | 3060 | _x_x_mozilla_cycle_collect,2028 12:40:49 INFO - PROCESS | 3060 | __end_cc_report 12:40:49 INFO - PROCESS | 3060 | __startTimestamp1470598849234__endTimestamp 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | ------- Summary: start ------- 12:40:49 INFO - PROCESS | 3060 | Number of tests: 14 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#0] ai-astar Cycles:10 Average:120.90 Median:118.50 stddev:25.48 (21.5%) stddev-sans-first:25.98 12:40:49 INFO - PROCESS | 3060 | Values: 101.0 112.0 112.0 113.0 114.0 110.0 91.0 123.0 166.0 167.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:138.00 stddev:23.65 (17.1%) stddev-sans-first:24.86 12:40:49 INFO - PROCESS | 3060 | Values: 144.0 140.0 109.0 166.0 106.0 106.0 136.0 132.0 175.0 136.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.95 (1.1%) stddev-sans-first:2.06 12:40:49 INFO - PROCESS | 3060 | Values: 183.0 184.0 187.0 185.0 183.0 180.0 183.0 181.0 183.0 184.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#3] audio-fft Cycles:10 Average:66.20 Median:64.50 stddev:11.81 (18.3%) stddev-sans-first:11.73 12:40:49 INFO - PROCESS | 3060 | Values: 78.0 57.0 60.0 87.0 57.0 56.0 62.0 67.0 82.0 56.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:75.00 stddev:17.91 (23.9%) stddev-sans-first:18.90 12:40:49 INFO - PROCESS | 3060 | Values: 84.0 69.0 100.0 71.0 79.0 69.0 124.0 99.0 96.0 101.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:87.50 stddev:13.77 (15.7%) stddev-sans-first:14.55 12:40:49 INFO - PROCESS | 3060 | Values: 88.0 85.0 87.0 84.0 89.0 130.0 90.0 85.0 88.0 86.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:92.00 stddev:17.24 (18.7%) stddev-sans-first:18.08 12:40:49 INFO - PROCESS | 3060 | Values: 92.0 92.0 92.0 93.0 92.0 92.0 92.0 93.0 109.0 146.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:0.99 (1.2%) stddev-sans-first:0.71 12:40:49 INFO - PROCESS | 3060 | Values: 88.0 86.0 85.0 86.0 86.0 86.0 86.0 86.0 84.0 86.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:0.97 12:40:49 INFO - PROCESS | 3060 | Values: 54.0 51.0 53.0 53.0 52.0 54.0 52.0 53.0 53.0 54.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:77.00 stddev:12.72 (16.5%) stddev-sans-first:12.59 12:40:49 INFO - PROCESS | 3060 | Values: 68.0 78.0 66.0 76.0 75.0 96.0 99.0 100.0 80.0 72.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:85.50 stddev:8.03 (9.4%) stddev-sans-first:8.42 12:40:49 INFO - PROCESS | 3060 | Values: 85.0 86.0 84.0 87.0 83.0 83.0 84.0 99.0 107.0 86.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:147.00 stddev:9.64 (6.6%) stddev-sans-first:9.77 12:40:49 INFO - PROCESS | 3060 | Values: 139.0 140.0 144.0 150.0 139.0 154.0 144.0 153.0 169.0 139.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 12:40:49 INFO - PROCESS | 3060 | Values: 166.0 166.0 166.0 168.0 168.0 167.0 166.0 166.0 164.0 167.0 12:40:49 INFO - PROCESS | 3060 | 12:40:49 INFO - PROCESS | 3060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:67.00 stddev:6.62 (9.9%) stddev-sans-first:6.93 12:40:49 INFO - PROCESS | 3060 | Values: 67.0 68.0 67.0 67.0 66.0 66.0 67.0 67.0 83.0 82.0 12:40:49 INFO - PROCESS | 3060 | -------- Summary: end -------- 12:40:49 INFO - PROCESS | 3060 | 12:40:50 INFO - TEST-INFO | 3060: exit 0 12:40:50 INFO - TEST-OK | kraken | took 59678ms 12:40:50 INFO - SUITE-END | took 1178s 12:40:50 INFO - Completed test suite (00:19:38) 12:40:50 INFO - javascript benchmark 12:40:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.916102097447, 3362.8150451725155, 3368.898933032009, 3399.9490007649874, 3432.5194472773815, 5656.066748986423, 5813.593048486608, 5814.447627475393, 5838.562107841907, 5853.180554722337, 5787.47912687858, 5845.7953971611005, 5930.525557955364, 5954.612950158236, 5961.254843144607, 5243.606729495284, 5294.947050529503, 5300.337457817773, 5313.521783039526, 5427.402985671573, 5407.297051383314, 5420.6747595144225, 5427.402985671592, 5451.127819548873, 5476.04169270378, 5258.1849813279005, 5296.152615581488, 5311.973440132813, 5324.041672498968, 5365.222042803811, 5308.601854860863, 5336.706481143536, 5336.759845806948, 5338.973305133488, 5345.839624811262, 5238.92141617876, 5295.629305948585, 5295.947040529622, 5322.494363035506, 5325.627206095575, 5781.566382521286, 5801.854953626151, 5827.737751801137, 5839.737211825478, 5851.093080572518, 6200.565960382775, 6263.404976527223, 6313.747450101991, 6354.682265886733, 6361.300256971729, 6216.844578885519, 6325.557210995232, 6334.936650633481, 6350.174477317965, 6380.7128679209545, 5591.021571225019, 5918.674472903988, 5936.7031648417405, 5982.132590774313, 5995.100734889801, 6245.0632405139595, 6278.372162783685, 6294.8426289342215, 6326.9683651581445, 6327.525435592349, 6299.401556852092, 6309.747610095636, 6314.305426403092, 6320.620762754157, 6340.8414789629705, 6203.4416902479, 6272.247330320391, 6305.968470157712, 6342.429181373698, 6368.872622547523, 6260.686965651699, 6335.778247761306, 6347.1114044033875, 6348.873022539523, 6357.237131544244, 6326.652034138075, 6340.461060809791, 6354.3010268870385, 6355.523335749837, 6356.872862542723, 4913.557779799835, 5033.144365457881, 5058.797648094035, 5073.289739436482, 5135.768890399941, 4577.22187228172, 4596.4024676791805, 4605.631549476034, 4615.353850460938, 4632.0, 5780.1907732917425, 5839.211706419664, 5848.356680765112, 5851.590388672752, 5862.94137058624, 6132.936844521141, 6184.226971628546, 6186.226721659793, 6217.533684973645, 6224.533160013018, 5608.859778505488, 5669.801556945487, 5676.858078548069, 5678.914816277759, 5682.829515114553, 5388.46115388458, 5392.0, 5396.1905714143195, 5404.135338345845, 5489.560835133179, 6239.376062393724, 6258.593191442542, 6267.811965641038, 6284.5600807943, 6360.395762402564, 6228.22147231596, 6270.874582508415, 6291.874162516816, 6292.276388215414, 6300.432961033529, 6343.365663433619, 6347.42873141401, 6361.745530178926, 6373.490120790233, 6377.0, 6135.967692822357, 6182.412670796267, 6190.442860142609, 6225.564210505402, 6321.11504389395, 5205.5835533158015, 6274.811755647338, 6283.59156654816, 6306.4639505642535, 6327.3988971047675, 6192.845178870564, 6221.782237621662, 6229.750809967732, 6241.656708881055, 6276.184096067482, 6079.0, 6112.41229444207, 6112.503480924647, 6146.770645870934, 6220.564560480723, 6052.5095832232955, 6112.32764395925, 6115.727150604614, 6119.969400152971, 6126.540509461897, 6232.532560057924, 6232.75068997235, 6256.937430625636, 6258.530610204162, 6266.028765541349, 5921.023031199804, 5923.526117910471, 5932.911006334822, 5976.013957696931, 6063.636181829104], "value": 5788.100987625802, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.4435388011549, 500.40201958659407, 505.1261317920001, 509.3327740659736, 515.4561937156299, 31004.379912401768, 31860.840695796516, 32787.0, 32826.0, 32891.177720556996, 33347.66652333476, 43466.78266608671, 44458.2210512106, 44549.55450445494, 46403.30395044077, 9886.159676427513, 10036.247281453883, 10038.393856982884, 10039.196864250842, 10039.996000399939, 9799.41203527787, 9954.900450995507, 9959.25305602079, 9967.102960733533, 9969.900300997006, 8933.0, 9149.0, 12026.338551379671, 12203.45084471201, 12272.263664180133, 12155.756884862298, 12223.572174973833, 12245.387730613524, 12256.0, 12259.141860069798, 12177.208481448677, 12274.815877761841, 12283.385830708517, 12288.016958643288, 12317.13780035398, 32253.354932901446, 40839.7958010211, 41271.0, 41357.79321103375, 43042.70871873818, 3162.14622052047, 3455.740819438527, 3554.0048786339867, 3733.9439908401396, 4051.8581849635416, 31365.84317078423, 31988.520172197437, 32109.839450802596, 32412.513812292833, 32632.0, 3226.1913046936306, 3254.7233485153793, 3302.190963214004, 3313.370459612666, 3422.281320922609, 483561.0, 486664.0, 489439.0, 489580.0, 489997.55001225125, 51783.0, 59435.702821486484, 59620.0, 59909.0, 60014.0, 60223.0, 63571.68214158899, 63910.68044659747, 63970.80145992682, 63971.0, 13413.597592072254, 15967.920160399124, 15973.201339932957, 15986.200689965455, 15987.280572374271, 12249.632511024683, 12385.318807465675, 12386.75226495465, 12389.566365177176, 12394.256344619353, 14614.561563152909, 16419.6716065678, 16505.33978640841, 16507.33970641185, 16508.83491165073, 5390.272313237741, 6218.347073557302, 6267.780627678009, 6292.748290068346, 6311.495080393557, 894.9149830766066, 961.5192403798101, 996.9052939970691, 1003.7152444870577, 1012.0, 23292.65061024086, 26454.47091058168, 31887.883924062546, 32662.510062349083, 32855.67144328574, 892.9642814287356, 1095.2497539185683, 1124.7862906047824, 1138.3568283919558, 1163.7323415614287, 14781.778273325908, 15083.245837708071, 15594.0, 15907.602309942344, 15968.12175330368, 503551.0, 889591.0, 898918.0, 901861.0, 905908.0, 51882.74058629683, 52157.7392113037, 59656.0, 60311.69844150751, 60592.0, 1379.6275005748391, 1412.1315391034645, 1415.5328741515482, 1424.223798030076, 1437.7627691430796, 25691.0, 30220.395592088476, 30489.08532744021, 30818.38363232678, 31383.686163138078, 43673.34489982716, 50783.74608127084, 52016.739916300176, 52022.0, 52113.7394313026, 521252.0, 533702.0, 575226.0, 582124.0, 582649.0, 26619.53945987009, 26764.59853102166, 26851.32871678224, 26865.865670671523, 26917.461650767265, 46904.0, 47162.76418617885, 48047.27929081136, 48316.5168348312, 48495.03009939852, 39230.215395692496, 39360.40959385669, 39363.409548856216, 40250.59749402585, 40456.59543404528, 38361.23277534489, 38588.61411385963, 38739.0, 39977.0, 40090.79954600208, 38729.41905871358, 38986.4152037714, 39524.40713389359, 40046.99882502961, 40100.598994009684, 31403.743850245733, 33157.33685326328, 35021.47467788036, 35748.821255893556, 35950.46074308835, 24228.273151805475, 24689.62965555482, 25738.970441182144, 25932.0, 26178.86910565435], "value": 20229.992528342664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.9214772749994, 370.7440226223432, 377.4150067395537, 382.94447305140756, 405.74843596969885, 15569.377224911004, 15961.68076638468, 20786.06462709178, 21118.89440552797, 21458.0, 19990.70013949792, 20439.386818395436, 20680.689789653166, 20836.374908752725, 21152.8942355288, 5740.827775166731, 5771.2497375341145, 6023.156758053876, 6024.638521688691, 6047.15339852421, 6091.78678746244, 6135.539834512407, 6136.723847426876, 6140.0789881517685, 6149.938500614981, 3845.2693988142164, 5617.915731264035, 5960.403959604048, 6031.366706495821, 6094.085887116946, 6051.697415129226, 6069.119977603267, 6069.302030266532, 6081.452669259766, 6570.770023049218, 5821.970890145564, 5822.970885145547, 5831.125331200312, 5851.561132915049, 5857.853553661193, 13518.986076044335, 16123.758143627854, 20219.696704549442, 24733.25800225996, 25001.87491562884, 2022.2315520102413, 2186.9562608747897, 2231.9888400557893, 2360.8819559022154, 2868.899588514392, 14936.477223297241, 15398.307076181598, 15847.0, 15920.681586368208, 16398.508044758677, 1791.3461586520957, 1800.3788692900928, 1837.338558119076, 1862.6181632765251, 1893.1386219270337, 90975.0, 107194.0, 112889.43555282253, 125031.99999999908, 129854.7014529852, 11220.158488113424, 11397.373144476967, 11588.710282242842, 11662.475188616532, 11890.989265912322, 12274.0, 14741.778873316909, 14749.188794616399, 14785.852141478663, 14792.408303667948, 7920.32677222431, 8152.266296033267, 8486.702965396182, 8584.828303434022, 8610.956945215234, 8283.08886022537, 8322.54226017575, 8349.373796965252, 8530.317574594017, 8536.44513106646, 4500.819967201341, 4515.458145022619, 4564.612007979293, 4594.0, 4703.600193983481, 1653.3221379234456, 1911.7992610775946, 1912.244663357966, 1915.7796853362042, 1922.6346994071082, 833.8540755367786, 843.2452954605594, 932.7201839448138, 954.71358592422, 1019.4851599941982, 20129.39611811648, 20527.794722052888, 21407.46481337948, 21506.924653767248, 21553.35339939804, 887.8591010551411, 916.4180745226696, 926.9942112807679, 930.5300823084299, 931.1433481197315, 8702.521361325062, 11236.831447528293, 11276.605318813967, 11332.943335283271, 11343.716407089889, 565702.0, 596590.0, 609098.0, 620171.0, 624012.0, 71837.64081179665, 112372.0, 127918.0, 130328.0, 131426.34286828505, 1034.182995433599, 1036.0468369100445, 1045.1012129568564, 1092.6503518874042, 1101.3612104979093, 18748.062596870375, 19450.416487505398, 19465.805341946965, 19471.61056778828, 19520.9023954885, 58123.0, 58513.70743146257, 58964.0, 59124.0, 59956.10065848928, 85654.00210992586, 87910.56044719735, 87963.56018219868, 89022.55488722515, 89258.0, 8067.717629882926, 8071.677132914852, 8232.547209903512, 8301.086880443027, 8307.169283071644, 12661.0, 13036.348182590642, 13145.868541314465, 13449.663758405726, 13640.931795340959, 8542.82914341722, 11578.305301681927, 11691.08974230808, 11814.291142531476, 11821.290722556674, 11204.943975280072, 11383.373914434786, 11547.422628868355, 11575.016123629586, 11745.0, 10204.795904081728, 11577.073834093084, 11877.168598198043, 11878.287302761863, 11966.700832479257, 6794.626295553792, 7724.196612315964, 7972.6412311444965, 8273.296769774637, 8382.790430239049, 8658.783530411538, 10291.53688084053, 11292.7741445169, 11384.677943240215, 11607.187496875475], "value": 9669.728136177566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.0656946706765, 1411.7858641568253, 1542.4524293875675, 1654.454030170044, 1911.9808801911986, 7693.422993275506, 8524.872126918093, 8770.0, 8770.342224333168, 8869.423487473327, 8633.48199108054, 8723.432976856515, 8729.9960504542, 8731.694390696326, 8732.825343493127, 2299.597570425173, 2335.8948847301913, 2336.6728657987896, 2336.906523739048, 2337.4039619896903, 2318.0, 2357.858528488296, 2364.408897775556, 2364.988175059122, 2369.7037870266217, 2313.791758741713, 2333.4982978659586, 2348.0, 2355.3758254062686, 2360.0913648245464, 2208.9703926228117, 2237.5077482953725, 2240.2943072931976, 2258.695076164713, 2269.7049383580193, 2253.312739614417, 2301.551197516485, 2302.781235782598, 2306.400335912658, 2307.91922282721, 8580.957095214546, 8664.003639581466, 8754.124587541259, 8754.781130471725, 8756.810797300675, 5116.590672746172, 5295.682259064469, 5298.311219541473, 5312.893742125136, 5317.388500322474, 3534.575850897883, 3563.322968635977, 3612.349777040132, 3612.530371051773, 3629.3104310181243, 965.7006328038331, 1070.4487189097622, 1776.1829558403151, 1806.1420825107969, 1855.730919016735, 11413.657590272305, 11463.254888432226, 11494.023008044243, 11499.482523286471, 11501.13741469393, 4001.599840015975, 4236.745795252233, 4551.908961820745, 4555.043440877453, 4625.722456652545, 9058.682946096855, 9070.455772653662, 9073.319501037317, 9083.227925626396, 9083.273338132933, 4526.434195725535, 5202.739863006835, 5206.479352064839, 5207.270982062514, 5216.26972223889, 3796.0484003649117, 4375.299952007664, 4793.760311984456, 4859.611231101503, 4883.633727470454, 3733.9439908401396, 3737.0, 3755.9812200938823, 3827.655511003967, 3830.3871380578976, 1146.1862077924766, 1149.9022583080364, 1161.512164890748, 1169.9473523691283, 1172.243902682782, 905.3843386497246, 926.3191554207652, 943.3773709351932, 953.142172045151, 988.7725823060737, 5836.212111364996, 5923.644581325048, 5960.612560183574, 5971.820845374559, 6134.079888016744, 990.3859607043679, 1026.440589878518, 1027.1679939249082, 1050.9316894401838, 1062.2245760594808, 3997.380406037069, 4064.0246340877975, 4131.318332475108, 4283.121959998193, 4301.78491075445, 10026.448545330077, 10604.363738175734, 10671.83992240117, 10838.729031774112, 10843.67468975932, 10253.641122560675, 10661.413622250851, 10673.146148308117, 10673.946630266953, 10735.78528429427, 7955.124936257007, 8055.919440805634, 8247.092819789817, 8287.62705678234, 8288.875666865002, 5894.557908156819, 5951.404859514014, 6102.664353460602, 6165.445109940127, 6188.721507532262, 9855.45794981283, 9887.357321774061, 9892.406455612687, 9901.653442129491, 9912.256580756328, 8542.78643033929, 9298.767530811783, 9627.56675949598, 9874.555644996137, 9951.950240248752, 6701.296363881722, 7183.389411900047, 7567.091948965939, 7585.241475852371, 7619.885701714368, 8195.918040819515, 8212.589370531568, 8268.710595129141, 8294.502329860228, 8323.542205178774, 7286.74496392645, 7340.669669864762, 7444.069491313586, 7522.736704215545, 7570.962145189239, 7085.751998680022, 7247.166575843635, 7264.164621068645, 7300.96349518249, 7336.156342020736, 6862.2158238857255, 7009.579425234502, 7013.368796808311, 7014.614196219257, 7039.296070392919, 4462.308342206963, 4851.975740121418, 5062.1141300271565, 5066.341375621146, 5076.238564215398, 4959.752012399294, 4976.751162441936, 5139.871503212449, 5263.421023687468, 5287.709175995357], "value": 4582.997919445403, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.89398710451337, 310.8010873041254, 314.4905253489346, 319.46170702366516, 321.6156692752162, 4443.84446544371, 5094.133997220472, 5345.705986170759, 5372.865678358043, 5402.621816472843, 4530.7281563106235, 4822.98717269373, 5310.0441920454305, 5341.225522299264, 5363.077122967982, 3536.3634545781747, 3759.8120093995326, 3898.883033508985, 3912.471816304805, 4075.673946084306, 4057.9594204057876, 4107.931937696206, 4123.340265557511, 4129.463169787939, 4130.876073717794, 4037.6769858411258, 4051.1897620475875, 4054.3918412238254, 4058.6753059755147, 4082.816273267695, 3773.9810251232016, 3959.4456776051375, 4026.0, 4055.858044968427, 4089.243489954353, 3438.1232785639754, 3463.515107884898, 3463.8268086595567, 3475.2623688155923, 3481.54739883816, 5118.129917913963, 5122.3853137623355, 5126.436092029874, 5167.767450464738, 5191.610629202787, 4159.688023398227, 4378.536662577673, 4546.0, 4548.431446069241, 4566.840160594396, 4806.375171227718, 5206.661566998171, 5468.742189296484, 5568.693721845338, 5575.749091290902, 2936.3246453315855, 3404.0, 3719.851205951759, 3810.923781524382, 3819.598942111066, 4630.328602352673, 4768.546988036131, 5561.416051314634, 5798.304203495565, 5821.417858214187, 3071.4932036214223, 3864.9033774155873, 3867.4972253607416, 3884.7086468514976, 3970.4242884782125, 3317.834108294576, 3909.6481316681065, 3915.04247876062, 3916.6083391660604, 3918.921621567553, 3799.50606421169, 4522.34426008227, 4548.5906268436, 4551.178269472882, 4552.726836389827, 4359.2807186813825, 4837.443693975168, 5230.63385563007, 5543.113101903676, 5676.489115979499, 1290.541857640543, 1316.973660526784, 1335.2389138191331, 1340.4973135074347, 1341.1014620204487, 735.2904447208363, 759.2559291893975, 799.9160088190656, 819.1562690428749, 832.7293629570414, 4109.527404348479, 4659.5573420525, 4822.95177048225, 4964.652474326835, 5048.798048078036, 4837.105135549935, 5226.869328266824, 5304.681719096867, 5721.568333458346, 5740.827775166752, 4296.806643701041, 5194.6104042196985, 5227.3465816772905, 5237.921431178535, 5244.6328756987405, 2459.495803360307, 2573.5882258838496, 2745.4646343962736, 3039.589655396493, 3041.376517813843, 4802.51974802517, 5666.829995100154, 5899.970500147472, 5915.231019967377, 5938.346781853993, 5176.637635365563, 5519.267962358578, 5534.4742249486235, 5872.64764114146, 5933.406659334032, 5911.9113213301835, 5916.25470486199, 5923.89701655906, 5933.228680271537, 5936.673482958478, 4998.450170481171, 5024.371953505812, 5636.2954630671165, 5691.4877661010705, 5754.482096611325, 4854.863859901632, 5261.210818377274, 5683.687397193194, 5742.339630942495, 5751.338596061507, 5951.131764353032, 6004.939950600613, 6008.639481631116, 6009.128676341818, 6038.607490513103, 3425.6231814500884, 3572.7499075065534, 3603.549556305462, 3782.678472329883, 3904.648581627667, 4994.675346102492, 5144.639875208849, 5332.226827110125, 5758.280214973129, 5763.4812866842185, 4645.488996210346, 5602.215689803349, 5605.523530499953, 5614.326280846324, 5634.140733557998, 4623.791929363254, 4952.900941981212, 5445.801923576807, 5597.944020559742, 5607.243022192115, 4904.092742842586, 4910.582600479, 5458.235846981505, 5508.476694713996, 5563.388027317073, 4437.028859171089, 5186.8962620748125, 5462.016836969384, 5476.288082549243, 5640.830775076754, 4169.958300417078, 5165.7675404607635, 5489.725513724218, 5492.7641280713115, 5532.419095995024], "value": 4011.200209640366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.9716811327547, 744.9180590135085, 764.896738940243, 784.3293983643985, 841.9621117049733, 15550.611234719137, 16023.198840058008, 16255.0, 16375.344986200538, 16571.171441427912, 14857.628559286024, 14927.029743066692, 14979.625509362271, 15050.623734406645, 15074.3216555255, 694.6214313199318, 717.9964100179492, 848.2323497234996, 860.6729442811754, 876.9824603507926, 850.5619605902965, 873.9912600874005, 874.33113668044, 875.2035647560721, 875.4397185801092, 935.5369092299321, 940.4874343482818, 940.9602389359761, 942.3639043645546, 942.981140377192, 736.1240124252123, 897.5018864530183, 924.653255029364, 931.8835145606799, 937.4234845569994, 692.9896051559231, 694.8193469697865, 695.5548448992648, 698.3819319901924, 698.7728988078894, 14926.477573284883, 14947.925260373737, 14990.0, 15003.549893503212, 15033.473828416063, 14062.437502499888, 14183.290835458185, 14322.427102915872, 14414.0, 14656.560303190921, 12821.487140514368, 13004.089713720043, 13042.0, 13263.933680331536, 13658.453661853513, 4611.9077618447445, 4666.953330466686, 4770.856874293777, 4793.544613261734, 4799.352087468182, 105239.99999999923, 106734.0, 106947.0, 107418.0, 111816.88183118145, 11281.03572047426, 11409.714757131138, 11514.424278786028, 11624.128190385754, 11774.705632359259, 22660.773392266197, 22759.748213848066, 22808.429789255402, 22919.0, 22951.967161477773, 7857.842843143219, 7902.68389264423, 8088.919110808934, 8210.096889342167, 8308.501489910625, 4376.168527979674, 4402.339649052604, 4412.889677758082, 4481.327800829837, 4634.768261586907, 3499.807510586942, 3634.5638523376833, 3663.7435379523176, 3665.065408320861, 3685.447182922583, 651.1209866679944, 651.8337823854887, 659.6306068601502, 661.9702113404812, 671.342084756941, 457.99542004580195, 599.7794488216458, 619.2537991719967, 619.7613918641265, 653.4870126950416, 7502.962485187539, 8486.575671216415, 8516.8722469163, 8857.867131993025, 9005.729828105168, 508.83208541181324, 589.7581991383512, 617.9320274769772, 621.6083867163658, 635.4376376906379, 4016.6987475939422, 4192.811323490389, 4271.67962402821, 4273.465816772903, 4273.807678654468, 102425.0, 152097.0, 156158.38416158294, 161205.0, 163811.44754209937, 135454.32272838574, 138304.47802980745, 140716.0, 141636.29181854025, 144702.0, 80401.0, 82222.0, 106107.0, 119415.0, 122477.0, 7840.778012012142, 8537.317014638938, 8583.399162058597, 8614.78463038429, 8667.653293868174, 65002.0, 65273.673631633435, 66476.33523664702, 66964.0, 68880.0, 97965.51017244869, 98355.0, 100658.496707516, 101119.0, 103713.0, 11104.777904442028, 11160.051395631463, 11183.944080279547, 11382.601608943647, 11762.411879405825, 12139.939300303442, 12283.938580307042, 12469.0, 12512.0615953802, 12882.67793305175, 10877.51051202682, 11841.940790296338, 11864.644060678194, 11870.703232419259, 12130.757384852077, 9359.064093590587, 9405.20055795265, 9510.524473776422, 9541.332106752461, 9815.85276220843, 9567.37812042215, 11280.379579123228, 11500.0, 11728.530858765555, 12110.212836165621, 9413.81172376535, 9720.888325626796, 9854.507274636382, 9923.057309555581, 10067.798644026932, 9351.218176841116, 10077.244206684381, 11114.429941156874, 11649.475773590379, 11716.94141529287], "value": 7661.660625741971, "unit": "score"}], "name": "dromaeo_css", "value": 7364.162753803924, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 113.0, 114.0, 110.0, 91.0, 123.0, 166.0, 167.0], "value": 120.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 109.0, 166.0, 106.0, 106.0, 136.0, 132.0, 175.0, 136.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 187.0, 185.0, 183.0, 180.0, 183.0, 181.0, 183.0, 184.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 60.0, 87.0, 57.0, 56.0, 62.0, 67.0, 82.0, 56.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 100.0, 71.0, 79.0, 69.0, 124.0, 99.0, 96.0, 101.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 84.0, 89.0, 130.0, 90.0, 85.0, 88.0, 86.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 93.0, 92.0, 92.0, 92.0, 93.0, 109.0, 146.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 86.0, 84.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 53.0, 53.0, 52.0, 54.0, 52.0, 53.0, 53.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 66.0, 76.0, 75.0, 96.0, 99.0, 100.0, 80.0, 72.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 87.0, 83.0, 83.0, 84.0, 99.0, 107.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 144.0, 150.0, 139.0, 154.0, 144.0, 153.0, 169.0, 139.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 168.0, 168.0, 167.0, 166.0, 166.0, 164.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 83.0, 82.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1476.8, "alertThreshold": 2.0}]} 12:40:50 INFO - Return code: 0 12:40:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:40:50 INFO - # TBPL SUCCESS # 12:40:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:40:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:40:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:40:50 INFO - 2016-08-07 12:40:50.482 screenresolution[3070:73505] starting screenresolution argv=screenresolution get 12:40:50 INFO - 2016-08-07 12:40:50.487 screenresolution[3070:73505] Display 0: 1600x1200x32@60 12:40:50 INFO - 2016-08-07 12:40:50.493 screenresolution[3071:73508] starting screenresolution argv=screenresolution list 12:40:50 INFO - Available Modes on Display 0 12:40:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:40:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:40:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:40:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:40:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:40:50 INFO - Intel Iris: 12:40:50 INFO - Chipset Model: Intel Iris 12:40:50 INFO - Type: GPU 12:40:50 INFO - Bus: Built-In 12:40:50 INFO - VRAM (Dynamic, Max): 1536 MB 12:40:50 INFO - Vendor: Intel (0x8086) 12:40:50 INFO - Device ID: 0x0a2e 12:40:50 INFO - Revision ID: 0x0009 12:40:50 INFO - Displays: 12:40:50 INFO - Display: 12:40:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:40:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:40:50 INFO - Display Serial Number: 1600x1200 60 12:40:50 INFO - Main Display: Yes 12:40:50 INFO - Mirror: Off 12:40:50 INFO - Online: Yes 12:40:50 INFO - Rotation: Supported 12:40:50 INFO - Return code: 0 12:40:50 INFO - Running post-action listener: _resource_record_post_action 12:40:50 INFO - [mozharness: 2016-08-07 19:40:50.731026Z] Finished run-tests step (success) 12:40:50 INFO - Running post-run listener: _resource_record_post_run 12:40:50 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 20480; Write bytes: 709764096; Read time: 1; Write time: 1841 12:40:50 INFO - TinderboxPrint: CPU usage
53.6% 12:40:50 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 1 12:40:50 INFO - TinderboxPrint: I/O write bytes / time
709,764,096 / 1,841 12:40:50 INFO - TinderboxPrint: CPU idle
2,253.6 (46.4%) 12:40:50 INFO - TinderboxPrint: CPU system
974.7 (20.1%) 12:40:50 INFO - TinderboxPrint: CPU user
1,625.1 (33.5%) 12:40:50 INFO - TinderboxPrint: Swap in / out
406,196,224 / 0 12:40:50 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404457984; Write bytes: 397371392; Read time: 30089; Write time: 701 12:40:50 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 20480; Write bytes: 299514880; Read time: 1; Write time: 1107 12:40:51 INFO - Running post-run listener: _upload_blobber_files 12:40:51 INFO - Blob upload gear active. 12:40:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:40:51 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'] 12:40:51 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 12:40:51 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:40:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:52 INFO - (blobuploader) - INFO - Done attempting. 12:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:53 INFO - (blobuploader) - INFO - Done attempting. 12:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:56 INFO - (blobuploader) - INFO - Done attempting. 12:40:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:56 INFO - Return code: 0 12:40:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbc8e35cee680a66bc6baea5c0c283cd2e9f087191f9e60c119b84003930742cf7a1825a647f1ac630b2e4db7d1ea5cda68199a6905af5368ab432b7fb3769e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96aa6b46b7883444731e20ea339789aff7b84e3fa34f00f5fa217fc6988c52061e3c110e61261e8b677746ab6630becca034333439bc770caafcb57cb1352656", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96c903cbbdf2d3f4b713cab5421d0567c150729144e76df1c56c0d5fd42dbe309d8e7e0610b3c28b9d3244d66ae97f914a9f1c7e2deef243f1e30718fd919583"} 12:40:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:56 INFO - Contents: 12:40:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbc8e35cee680a66bc6baea5c0c283cd2e9f087191f9e60c119b84003930742cf7a1825a647f1ac630b2e4db7d1ea5cda68199a6905af5368ab432b7fb3769e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96aa6b46b7883444731e20ea339789aff7b84e3fa34f00f5fa217fc6988c52061e3c110e61261e8b677746ab6630becca034333439bc770caafcb57cb1352656", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96c903cbbdf2d3f4b713cab5421d0567c150729144e76df1c56c0d5fd42dbe309d8e7e0610b3c28b9d3244d66ae97f914a9f1c7e2deef243f1e30718fd919583"} 12:40:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:56 INFO - Copying logs to upload dir... 12:40:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.859757 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-08-07 12:40:56.347369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:56.351110) ========= 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.Rz22s29naF/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.qbfRdMTwFz/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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/fbc8e35cee680a66bc6baea5c0c283cd2e9f087191f9e60c119b84003930742cf7a1825a647f1ac630b2e4db7d1ea5cda68199a6905af5368ab432b7fb3769e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96aa6b46b7883444731e20ea339789aff7b84e3fa34f00f5fa217fc6988c52061e3c110e61261e8b677746ab6630becca034333439bc770caafcb57cb1352656", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96c903cbbdf2d3f4b713cab5421d0567c150729144e76df1c56c0d5fd42dbe309d8e7e0610b3c28b9d3244d66ae97f914a9f1c7e2deef243f1e30718fd919583"} build_url:https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/fw2zS7k7TJuXZHy7J6H4Xw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fbc8e35cee680a66bc6baea5c0c283cd2e9f087191f9e60c119b84003930742cf7a1825a647f1ac630b2e4db7d1ea5cda68199a6905af5368ab432b7fb3769e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96aa6b46b7883444731e20ea339789aff7b84e3fa34f00f5fa217fc6988c52061e3c110e61261e8b677746ab6630becca034333439bc770caafcb57cb1352656", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96c903cbbdf2d3f4b713cab5421d0567c150729144e76df1c56c0d5fd42dbe309d8e7e0610b3c28b9d3244d66ae97f914a9f1c7e2deef243f1e30718fd919583"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:56.384475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:56.384842) ========= 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.Rz22s29naF/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.qbfRdMTwFz/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005121 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 12:40:56.433346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 12:40:56.433667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 12:40:56.433992) ========= ========= Total master_lag: 0.18 =========