builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0347 starttime: 1471018542.05 results: success (0) buildid: 20160812071715 builduid: 839fb31bf62e489a96d7176f79fea145 revision: 124669ed2f09f68f7f8dd38f4fee5f3084da0aff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.045353) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.045816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.046126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.072124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.072528) ========= 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.JN4MvJV3UA/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.yOSby7fOju/Listeners TMPDIR=/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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-12 09:15:42-- 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% 19.6M=0.001s 2016-08-12 09:15:42 (19.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085093 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.180737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.181054) ========= 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.JN4MvJV3UA/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.yOSby7fOju/Listeners TMPDIR=/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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.029384 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:42.232137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 09:15:42.232501) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 124669ed2f09f68f7f8dd38f4fee5f3084da0aff --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 124669ed2f09f68f7f8dd38f4fee5f3084da0aff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JN4MvJV3UA/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.yOSby7fOju/Listeners TMPDIR=/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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-12 09:15:42,319 truncating revision to first 12 chars 2016-08-12 09:15:42,319 Setting DEBUG logging. 2016-08-12 09:15:42,319 attempt 1/10 2016-08-12 09:15:42,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/124669ed2f09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 09:15:43,896 unpacking tar archive at: fx-team-124669ed2f09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.857943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 09:15:44.112849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:44.113174) ========= script_repo_revision: 124669ed2f09f68f7f8dd38f4fee5f3084da0aff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:44.113585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:44.113852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 09:15:44.133349) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-12 09:15:44.133796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JN4MvJV3UA/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.yOSby7fOju/Listeners TMPDIR=/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:15:44 INFO - MultiFileLogger online at 20160812 09:15:44 in /builds/slave/test 09:15:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:15:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:44 INFO - {'append_to_log': False, 09:15:44 INFO - 'base_work_dir': '/builds/slave/test', 09:15:44 INFO - 'blob_upload_branch': 'Fx-Team', 09:15:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:44 INFO - 'branch': 'Fx-Team', 09:15:44 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:44 INFO - 'config_files': ('talos/mac_config.py',), 09:15:44 INFO - 'default_actions': ('clobber', 09:15:44 INFO - 'read-buildbot-config', 09:15:44 INFO - 'download-and-extract', 09:15:44 INFO - 'populate-webroot', 09:15:44 INFO - 'create-virtualenv', 09:15:44 INFO - 'install', 09:15:44 INFO - 'run-tests'), 09:15:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:44 INFO - 'download_minidump_stackwalk': True, 09:15:44 INFO - 'download_symbols': 'ondemand', 09:15:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:44 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:44 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:44 INFO - 'installer_path': 'installer.exe', 09:15:44 INFO - 'log_level': 'info', 09:15:44 INFO - 'log_name': 'talos', 09:15:44 INFO - 'log_to_console': True, 09:15:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:15:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:15:44 INFO - 'opt_config_files': (), 09:15:44 INFO - 'pip_index': False, 09:15:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:44 INFO - 'cmd': ('bash', 09:15:44 INFO - '-c', 09:15:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:44 INFO - 'enabled': True, 09:15:44 INFO - 'halt_on_failure': False, 09:15:44 INFO - 'name': 'check_screen_resolution'},), 09:15:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:44 INFO - 'cmd': ('bash', 09:15:44 INFO - '-c', 09:15:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:44 INFO - 'enabled': True, 09:15:44 INFO - 'halt_on_failure': False, 09:15:44 INFO - 'name': 'check_screen_resolution'},), 09:15:44 INFO - 'run_cmd_checks_enabled': True, 09:15:44 INFO - 'sps_profile': False, 09:15:44 INFO - 'sps_profile_interval': 0, 09:15:44 INFO - 'suite': 'dromaeojs-e10s', 09:15:44 INFO - 'system_bits': '32', 09:15:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:44 INFO - 'title': 't-yosemite-r7-0347', 09:15:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:44 INFO - 'use_talos_json': True, 09:15:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:44 INFO - 'work_dir': 'build'} 09:15:44 INFO - [mozharness: 2016-08-12 16:15:44.344343Z] Running clobber step. 09:15:44 INFO - Running pre-action listener: _resource_record_pre_action 09:15:44 INFO - Running main action method: clobber 09:15:44 INFO - rmtree: /builds/slave/test/build 09:15:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:46 INFO - Running post-action listener: _resource_record_post_action 09:15:46 INFO - [mozharness: 2016-08-12 16:15:46.442154Z] Finished clobber step (success) 09:15:46 INFO - [mozharness: 2016-08-12 16:15:46.442393Z] Running read-buildbot-config step. 09:15:46 INFO - Running pre-action listener: _resource_record_pre_action 09:15:46 INFO - Running main action method: read_buildbot_config 09:15:46 INFO - Using buildbot properties: 09:15:46 INFO - { 09:15:46 INFO - "project": "", 09:15:46 INFO - "product": "firefox", 09:15:46 INFO - "script_repo_revision": "production", 09:15:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:15:46 INFO - "repository": "", 09:15:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:15:46 INFO - "buildid": "20160812071715", 09:15:46 INFO - "pgo_build": "False", 09:15:46 INFO - "basedir": "/builds/slave/test", 09:15:46 INFO - "buildnumber": 78, 09:15:46 INFO - "slavename": "t-yosemite-r7-0347", 09:15:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:15:46 INFO - "platform": "yosemite_r7", 09:15:46 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:15:46 INFO - "branch": "fx-team", 09:15:46 INFO - "repo_path": "integration/fx-team", 09:15:46 INFO - "revision": "124669ed2f09f68f7f8dd38f4fee5f3084da0aff", 09:15:46 INFO - "stage_platform": "macosx64", 09:15:46 INFO - "builduid": "839fb31bf62e489a96d7176f79fea145", 09:15:46 INFO - "slavebuilddir": "test" 09:15:46 INFO - } 09:15:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:15:46 INFO - Running post-action listener: _resource_record_post_action 09:15:46 INFO - [mozharness: 2016-08-12 16:15:46.448113Z] Finished read-buildbot-config step (success) 09:15:46 INFO - [mozharness: 2016-08-12 16:15:46.448357Z] Running download-and-extract step. 09:15:46 INFO - Running pre-action listener: _resource_record_pre_action 09:15:46 INFO - Running main action method: download_and_extract 09:15:46 INFO - mkdir: /builds/slave/test/build/tests 09:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:46 INFO - trying https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:15:46 INFO - Downloading https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:47 INFO - Downloaded 1199 bytes. 09:15:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:15:47 INFO - Using the following test package requirements: 09:15:47 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:15:47 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:15:47 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:15:47 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'jsshell-mac.zip'], 09:15:47 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:15:47 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:15:47 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:15:47 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:15:47 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:15:47 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:47 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:15:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:47 INFO - trying https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:15:47 INFO - Downloading https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:47 INFO - Downloaded 16328280 bytes. 09:15:47 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'] 09:15:47 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 09:15:50 INFO - Return code: 0 09:15:50 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 09:15:50 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')]} 09:15:50 INFO - trying https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:15:50 INFO - Downloading https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:51 INFO - Downloaded 16328280 bytes. 09:15:51 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'] 09:15:51 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 09:15:55 INFO - Return code: 0 09:15:55 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')]} 09:15:55 INFO - trying https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:15:55 INFO - Downloading https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:56 INFO - Downloaded 14413719 bytes. 09:15:56 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'] 09:15:56 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 09:15:56 INFO - Return code: 0 09:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:56 INFO - trying https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:15:56 INFO - Downloading https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:15:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/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 09:15:59 INFO - Downloaded 110896552 bytes. 09:15:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:15:59 INFO - mkdir: /builds/slave/test/properties 09:15:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:59 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:59 INFO - Contents: 09:15:59 INFO - build_url:https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:15:59 INFO - Running post-action listener: _resource_record_post_action 09:15:59 INFO - Running post-action listener: set_extra_try_arguments 09:15:59 INFO - [mozharness: 2016-08-12 16:15:59.897420Z] Finished download-and-extract step (success) 09:15:59 INFO - [mozharness: 2016-08-12 16:15:59.897577Z] Running populate-webroot step. 09:15:59 INFO - Running pre-action listener: _resource_record_pre_action 09:15:59 INFO - Running main action method: populate_webroot 09:15:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:59 INFO - '--tppagecycles', 09:15:59 INFO - '7'], 09:15:59 INFO - 'tests': ['tsvgm']}}, 09:15:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['damp', 'tps']}, 09:15:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'tests': ['damp', 'tps']}, 09:15:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['dromaeo_dom']}, 09:15:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['basic_compositor_video']}, 09:15:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:15:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['a11yr', 09:15:59 INFO - 'ts_paint', 09:15:59 INFO - 'tpaint', 09:15:59 INFO - 'sessionrestore', 09:15:59 INFO - 'sessionrestore_no_auto_restore', 09:15:59 INFO - 'tabpaint']}, 09:15:59 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:59 INFO - 'ts_paint', 09:15:59 INFO - 'tpaint', 09:15:59 INFO - 'sessionrestore', 09:15:59 INFO - 'sessionrestore_no_auto_restore', 09:15:59 INFO - 'tabpaint']}, 09:15:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:59 INFO - 'ts_paint', 09:15:59 INFO - 'tpaint', 09:15:59 INFO - 'sessionrestore', 09:15:59 INFO - 'sessionrestore_no_auto_restore', 09:15:59 INFO - 'tabpaint']}, 09:15:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:59 INFO - 'ts_paint', 09:15:59 INFO - 'tpaint', 09:15:59 INFO - 'sessionrestore', 09:15:59 INFO - 'sessionrestore_no_auto_restore', 09:15:59 INFO - 'tabpaint']}, 09:15:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['a11yr', 09:15:59 INFO - 'ts_paint', 09:15:59 INFO - 'tpaint', 09:15:59 INFO - 'sessionrestore', 09:15:59 INFO - 'sessionrestore_no_auto_restore', 09:15:59 INFO - 'tabpaint']}, 09:15:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['a11yr', 09:15:59 INFO - 'ts_paint', 09:15:59 INFO - 'tpaint', 09:15:59 INFO - 'sessionrestore', 09:15:59 INFO - 'sessionrestore_no_auto_restore', 09:15:59 INFO - 'tabpaint']}, 09:15:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['tsvgx', 09:15:59 INFO - 'tsvgr_opacity', 09:15:59 INFO - 'tart', 09:15:59 INFO - 'tscrollx', 09:15:59 INFO - 'cart']}, 09:15:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:59 INFO - 'tsvgr_opacity', 09:15:59 INFO - 'tart', 09:15:59 INFO - 'tscrollx', 09:15:59 INFO - 'cart']}, 09:15:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'talos_options': ['--disable-e10s'], 09:15:59 INFO - 'tests': ['tp5o']}, 09:15:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'tests': ['tp5o']}, 09:15:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'talos_options': ['--disable-e10s', 09:15:59 INFO - '--xperf_path', 09:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:59 INFO - 'tests': ['tp5n']}, 09:15:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:59 INFO - 'talos_options': ['--xperf_path', 09:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:59 INFO - 'tests': ['tp5n']}}, 09:15:59 INFO - 'talos.zip': {'path': '', 09:15:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:59 INFO - Running post-action listener: _resource_record_post_action 09:15:59 INFO - [mozharness: 2016-08-12 16:15:59.916357Z] Finished populate-webroot step (success) 09:15:59 INFO - [mozharness: 2016-08-12 16:15:59.916468Z] Running create-virtualenv step. 09:15:59 INFO - Running pre-action listener: _resource_record_pre_action 09:15:59 INFO - Running main action method: create_virtualenv 09:15:59 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:59 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 09:15:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:00 INFO - Using real prefix '/tools/python27' 09:16:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:00 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:03 INFO - Installing pip.................done. 09:16:03 INFO - Return code: 0 09:16:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:03 INFO - 'HOME': '/Users/cltbld', 09:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:03 INFO - 'LOGNAME': 'cltbld', 09:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:03 INFO - 'MOZ_NO_REMOTE': '1', 09:16:03 INFO - 'NO_EM_RESTART': '1', 09:16:03 INFO - 'PAGER': '/bin/cat', 09:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:03 INFO - 'PWD': '/builds/slave/test', 09:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:03 INFO - 'SHELL': '/bin/bash', 09:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:03 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:03 INFO - 'USER': 'cltbld', 09:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:03 INFO - 'XPC_FLAGS': '0x0', 09:16:03 INFO - 'XPC_SERVICE_NAME': '0', 09:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:03 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 09:16:03 INFO - Cleaning up... 09:16:03 INFO - Return code: 0 09:16:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:03 INFO - 'HOME': '/Users/cltbld', 09:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:03 INFO - 'LOGNAME': 'cltbld', 09:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:03 INFO - 'MOZ_NO_REMOTE': '1', 09:16:03 INFO - 'NO_EM_RESTART': '1', 09:16:03 INFO - 'PAGER': '/bin/cat', 09:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:03 INFO - 'PWD': '/builds/slave/test', 09:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:03 INFO - 'SHELL': '/bin/bash', 09:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:03 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:03 INFO - 'USER': 'cltbld', 09:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:03 INFO - 'XPC_FLAGS': '0x0', 09:16:03 INFO - 'XPC_SERVICE_NAME': '0', 09:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:04 INFO - Downloading/unpacking psutil>=3.1.1 09:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:06 INFO - Installing collected packages: psutil 09:16:06 INFO - Running setup.py install for psutil 09:16:06 INFO - building 'psutil._psutil_osx' extension 09:16:06 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 09:16:07 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 09:16:07 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 09:16:07 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 09:16:07 INFO - building 'psutil._psutil_posix' extension 09:16:07 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 09:16:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:16:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:16:07 INFO - ^ 09:16:07 INFO - 1 warning generated. 09:16:07 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 09:16:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:07 INFO - Successfully installed psutil 09:16:07 INFO - Cleaning up... 09:16:08 INFO - Return code: 0 09:16:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:08 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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:08 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 09:16:08 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 09:16:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:08 INFO - 'HOME': '/Users/cltbld', 09:16:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:08 INFO - 'LOGNAME': 'cltbld', 09:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:08 INFO - 'MOZ_NO_REMOTE': '1', 09:16:08 INFO - 'NO_EM_RESTART': '1', 09:16:08 INFO - 'PAGER': '/bin/cat', 09:16:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:08 INFO - 'PWD': '/builds/slave/test', 09:16:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:08 INFO - 'SHELL': '/bin/bash', 09:16:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:08 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:08 INFO - 'USER': 'cltbld', 09:16:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:08 INFO - 'XPC_FLAGS': '0x0', 09:16:08 INFO - 'XPC_SERVICE_NAME': '0', 09:16:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:08 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 09:16:08 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 09:16:08 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 09:16:08 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 09:16:08 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 09:16:08 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 09:16:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:10 INFO - Installing collected packages: mozsystemmonitor 09:16:10 INFO - Running setup.py install for mozsystemmonitor 09:16:10 INFO - Successfully installed mozsystemmonitor 09:16:10 INFO - Cleaning up... 09:16:10 INFO - Return code: 0 09:16:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', '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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:16: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 jsonschema==2.5.1 09:16:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:10 INFO - 'HOME': '/Users/cltbld', 09:16:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:10 INFO - 'LOGNAME': 'cltbld', 09:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:10 INFO - 'MOZ_NO_REMOTE': '1', 09:16:10 INFO - 'NO_EM_RESTART': '1', 09:16:10 INFO - 'PAGER': '/bin/cat', 09:16:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:10 INFO - 'PWD': '/builds/slave/test', 09:16:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:10 INFO - 'SHELL': '/bin/bash', 09:16:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:10 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:10 INFO - 'USER': 'cltbld', 09:16:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:10 INFO - 'XPC_FLAGS': '0x0', 09:16:10 INFO - 'XPC_SERVICE_NAME': '0', 09:16:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:11 INFO - Downloading/unpacking jsonschema==2.5.1 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:13 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 09:16:13 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 09:16:13 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 09:16:13 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 09:16:13 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 09:16:13 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 09:16:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:14 INFO - warning: no files found matching '*.txt' 09:16:14 INFO - no previously-included directories found matching 'build' 09:16:14 INFO - no previously-included directories found matching 'dist' 09:16:14 INFO - no previously-included directories found matching '.git*' 09:16:14 INFO - Installing collected packages: jsonschema, functools32 09:16:14 INFO - Running setup.py install for functools32 09:16:14 INFO - warning: no files found matching '*.txt' 09:16:14 INFO - no previously-included directories found matching 'build' 09:16:14 INFO - no previously-included directories found matching 'dist' 09:16:14 INFO - no previously-included directories found matching '.git*' 09:16:14 INFO - Successfully installed jsonschema functools32 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:14 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')]} 09:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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')]} 09:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:14 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 09:16:14 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 09:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:14 INFO - 'HOME': '/Users/cltbld', 09:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:14 INFO - 'LOGNAME': 'cltbld', 09:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:14 INFO - 'MOZ_NO_REMOTE': '1', 09:16:14 INFO - 'NO_EM_RESTART': '1', 09:16:14 INFO - 'PAGER': '/bin/cat', 09:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:14 INFO - 'PWD': '/builds/slave/test', 09:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:14 INFO - 'SHELL': '/bin/bash', 09:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:14 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:14 INFO - 'USER': 'cltbld', 09:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:14 INFO - 'XPC_FLAGS': '0x0', 09:16:14 INFO - 'XPC_SERVICE_NAME': '0', 09:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:14 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')]} 09:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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')]} 09:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:14 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 09:16:14 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 09:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:14 INFO - 'HOME': '/Users/cltbld', 09:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:14 INFO - 'LOGNAME': 'cltbld', 09:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:14 INFO - 'MOZ_NO_REMOTE': '1', 09:16:14 INFO - 'NO_EM_RESTART': '1', 09:16:14 INFO - 'PAGER': '/bin/cat', 09:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:14 INFO - 'PWD': '/builds/slave/test', 09:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:14 INFO - 'SHELL': '/bin/bash', 09:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:14 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:14 INFO - 'USER': 'cltbld', 09:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:14 INFO - 'XPC_FLAGS': '0x0', 09:16:14 INFO - 'XPC_SERVICE_NAME': '0', 09:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:18 INFO - Downloading docopt-0.6.1.tar.gz 09:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:18 INFO - Running setup.py install for blobuploader 09:16:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:18 INFO - Running setup.py install for requests 09:16:19 INFO - Running setup.py install for docopt 09:16:19 INFO - Successfully installed blobuploader requests docopt 09:16:19 INFO - Cleaning up... 09:16:19 INFO - Return code: 0 09:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:19 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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:19 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 09:16:19 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 09:16:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:19 INFO - 'HOME': '/Users/cltbld', 09:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:19 INFO - 'LOGNAME': 'cltbld', 09:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:19 INFO - 'MOZ_NO_REMOTE': '1', 09:16:19 INFO - 'NO_EM_RESTART': '1', 09:16:19 INFO - 'PAGER': '/bin/cat', 09:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:19 INFO - 'PWD': '/builds/slave/test', 09:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:19 INFO - 'SHELL': '/bin/bash', 09:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:19 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:19 INFO - 'USER': 'cltbld', 09:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:19 INFO - 'XPC_FLAGS': '0x0', 09:16:19 INFO - 'XPC_SERVICE_NAME': '0', 09:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:19 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-WFifjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-ukFqL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-BgoWp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-gbNFa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-WsCgRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-QBNQj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-a5Hj_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-ki0nBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-ofHTJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-bvumqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:20 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-GPsIGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:21 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-e3mTa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:21 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-j5SlO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:21 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-PMS7r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:21 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-O6qoAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:21 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-sGQaEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:21 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-VJh8fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:21 INFO - Running setup.py install for manifestparser 09:16:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:21 INFO - Running setup.py install for mozcrash 09:16:21 INFO - Running setup.py install for mozdebug 09:16:22 INFO - Running setup.py install for mozdevice 09:16:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Running setup.py install for mozfile 09:16:22 INFO - Running setup.py install for mozhttpd 09:16:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Running setup.py install for mozinfo 09:16:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Running setup.py install for mozInstall 09:16:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:22 INFO - Running setup.py install for mozleak 09:16:22 INFO - Running setup.py install for mozlog 09:16:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:23 INFO - Running setup.py install for moznetwork 09:16:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:23 INFO - Running setup.py install for mozprocess 09:16:23 INFO - Running setup.py install for mozprofile 09:16:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:23 INFO - Running setup.py install for mozrunner 09:16:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:23 INFO - Running setup.py install for mozscreenshot 09:16:23 INFO - Running setup.py install for moztest 09:16:24 INFO - Running setup.py install for mozversion 09:16:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:24 INFO - Cleaning up... 09:16:24 INFO - Return code: 0 09:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:24 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')]} 09:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:24 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')]} 09:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:24 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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:24 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 09:16:24 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 09:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:24 INFO - 'HOME': '/Users/cltbld', 09:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:24 INFO - 'LOGNAME': 'cltbld', 09:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:24 INFO - 'MOZ_NO_REMOTE': '1', 09:16:24 INFO - 'NO_EM_RESTART': '1', 09:16:24 INFO - 'PAGER': '/bin/cat', 09:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:24 INFO - 'PWD': '/builds/slave/test', 09:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:24 INFO - 'SHELL': '/bin/bash', 09:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:24 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:24 INFO - 'USER': 'cltbld', 09:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:24 INFO - 'XPC_FLAGS': '0x0', 09:16:24 INFO - 'XPC_SERVICE_NAME': '0', 09:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:24 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-J7JAtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:24 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)) 09:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:24 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-C8StGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:24 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)) 09:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:24 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-HPFYaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:24 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)) 09:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:24 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-mulfv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:24 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)) 09:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:24 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-DyQ7Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-pYACGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-lmg2yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-3QKhBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-ibrN6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-UzMjZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-bdrQBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-4m3uCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-Yx7wIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:25 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)) 09:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:25 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-IDP6Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:26 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)) 09:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:26 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-yUiIMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:26 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)) 09:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:26 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-p9xRBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:26 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)) 09:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:26 INFO - Running setup.py (path:/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/pip-refXLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:26 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)) 09:16:26 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)) 09:16:26 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)) 09:16:26 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)) 09:16:26 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)) 09:16:26 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)) 09:16:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 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 09:16:28 INFO - Downloading blessings-1.6.tar.gz 09:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:28 INFO - Installing collected packages: blessings 09:16:28 INFO - Running setup.py install for blessings 09:16:29 INFO - Successfully installed blessings 09:16:29 INFO - Cleaning up... 09:16:29 INFO - Return code: 0 09:16:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:29 INFO - Reading from file tmpfile_stdout 09:16:29 INFO - Current package versions: 09:16:29 INFO - blessings == 1.6 09:16:29 INFO - blobuploader == 1.2.4 09:16:29 INFO - docopt == 0.6.1 09:16:29 INFO - functools32 == 3.2.3-2 09:16:29 INFO - jsonschema == 2.5.1 09:16:29 INFO - manifestparser == 1.1 09:16:29 INFO - mozInstall == 1.12 09:16:29 INFO - mozcrash == 0.17 09:16:29 INFO - mozdebug == 0.1 09:16:29 INFO - mozdevice == 0.48 09:16:29 INFO - mozfile == 1.2 09:16:29 INFO - mozhttpd == 0.7 09:16:29 INFO - mozinfo == 0.9 09:16:29 INFO - mozleak == 0.1 09:16:29 INFO - mozlog == 3.3 09:16:29 INFO - moznetwork == 0.27 09:16:29 INFO - mozprocess == 0.23 09:16:29 INFO - mozprofile == 0.28 09:16:29 INFO - mozrunner == 6.12 09:16:29 INFO - mozscreenshot == 0.1 09:16:29 INFO - mozsystemmonitor == 0.3 09:16:29 INFO - moztest == 0.7 09:16:29 INFO - mozversion == 1.4 09:16:29 INFO - psutil == 3.1.1 09:16:29 INFO - requests == 1.2.3 09:16:29 INFO - wsgiref == 0.1.2 09:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:29 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')]} 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:29 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')]} 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:29 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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:29 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 09:16:29 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 09:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:29 INFO - 'HOME': '/Users/cltbld', 09:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:29 INFO - 'LOGNAME': 'cltbld', 09:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:29 INFO - 'MOZ_NO_REMOTE': '1', 09:16:29 INFO - 'NO_EM_RESTART': '1', 09:16:29 INFO - 'PAGER': '/bin/cat', 09:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:29 INFO - 'PWD': '/builds/slave/test', 09:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:29 INFO - 'SHELL': '/bin/bash', 09:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:29 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:29 INFO - 'USER': 'cltbld', 09:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:29 INFO - 'XPC_FLAGS': '0x0', 09:16:29 INFO - 'XPC_SERVICE_NAME': '0', 09:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 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)) 09:16:29 INFO - Cleaning up... 09:16:29 INFO - Return code: 0 09:16:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:29 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')]} 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:29 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')]} 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:29 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 0x105127a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f0c9fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, '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.JN4MvJV3UA/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.yOSby7fOju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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 09:16:29 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 09:16:29 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 09:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:29 INFO - 'HOME': '/Users/cltbld', 09:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:29 INFO - 'LOGNAME': 'cltbld', 09:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:29 INFO - 'MOZ_NO_REMOTE': '1', 09:16:29 INFO - 'NO_EM_RESTART': '1', 09:16:29 INFO - 'PAGER': '/bin/cat', 09:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:29 INFO - 'PWD': '/builds/slave/test', 09:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:29 INFO - 'SHELL': '/bin/bash', 09:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:16:29 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:29 INFO - 'USER': 'cltbld', 09:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:29 INFO - 'XPC_FLAGS': '0x0', 09:16:29 INFO - 'XPC_SERVICE_NAME': '0', 09:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:30 INFO - Cleaning up... 09:16:30 INFO - Return code: 0 09:16:30 INFO - Running post-action listener: _resource_record_post_action 09:16:30 INFO - Running post-action listener: _start_resource_monitoring 09:16:30 INFO - Starting resource monitoring. 09:16:30 INFO - [mozharness: 2016-08-12 16:16:30.056410Z] Finished create-virtualenv step (success) 09:16:30 INFO - [mozharness: 2016-08-12 16:16:30.057412Z] Running install step. 09:16:30 INFO - Running pre-action listener: _resource_record_pre_action 09:16:30 INFO - Running main action method: install 09:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:30 INFO - Reading from file tmpfile_stdout 09:16:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:30 INFO - Reading from file tmpfile_stdout 09:16:30 INFO - Output received: 09:16:30 INFO - Usage: mozinstall [options] installer 09:16:30 INFO - Options: 09:16:30 INFO - -h, --help show this help message and exit 09:16:30 INFO - -d DEST, --destination=DEST 09:16:30 INFO - Directory to install application into. [default: 09:16:30 INFO - "/builds/slave/test"] 09:16:30 INFO - --app=APP Application being installed. [default: firefox] 09:16:30 INFO - mkdir: /builds/slave/test/build/application 09:16:30 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'] 09:16:30 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 09:17:04 INFO - Reading from file tmpfile_stdout 09:17:04 INFO - Output received: 09:17:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:17:04 INFO - Running post-action listener: _resource_record_post_action 09:17:04 INFO - [mozharness: 2016-08-12 16:17:04.372344Z] Finished install step (success) 09:17:04 INFO - [mozharness: 2016-08-12 16:17:04.372473Z] Running run-tests step. 09:17:04 INFO - Running pre-action listener: _resource_record_pre_action 09:17:04 INFO - Running main action method: run_tests 09:17:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:04 INFO - 2016-08-12 09:17:04.386 screenresolution[1657:7597] starting screenresolution argv=screenresolution get 09:17:04 INFO - 2016-08-12 09:17:04.389 screenresolution[1657:7597] Display 0: 1600x1200x32@60 09:17:04 INFO - 2016-08-12 09:17:04.395 screenresolution[1658:7599] starting screenresolution argv=screenresolution list 09:17:04 INFO - Available Modes on Display 0 09:17:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:04 INFO - Intel Iris: 09:17:04 INFO - Chipset Model: Intel Iris 09:17:04 INFO - Type: GPU 09:17:04 INFO - Bus: Built-In 09:17:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:04 INFO - Vendor: Intel (0x8086) 09:17:04 INFO - Device ID: 0x0a2e 09:17:04 INFO - Revision ID: 0x0009 09:17:04 INFO - Displays: 09:17:04 INFO - Display: 09:17:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:04 INFO - Display Serial Number: 1600x1200 60 09:17:04 INFO - Main Display: Yes 09:17:04 INFO - Mirror: Off 09:17:04 INFO - Online: Yes 09:17:04 INFO - Rotation: Supported 09:17:04 INFO - Return code: 0 09:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:04 INFO - Python 2.7.3 09:17:04 INFO - Return code: 0 09:17:04 INFO - grabbing minidump binary from tooltool 09:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:04 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 0x10508bd30>, '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 0x104df0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105083b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:04 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 09:17:04 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 09:17:04 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 09:17:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:04 INFO - Return code: 0 09:17:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:17:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:17:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0347', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0347 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JN4MvJV3UA/Render', 09:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:04 INFO - 'HOME': '/Users/cltbld', 09:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:04 INFO - 'LOGNAME': 'cltbld', 09:17:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:04 INFO - 'MOZ_NO_REMOTE': '1', 09:17:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:04 INFO - 'NO_EM_RESTART': '1', 09:17:04 INFO - 'PAGER': '/bin/cat', 09:17:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:04 INFO - 'PWD': '/builds/slave/test', 09:17:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:04 INFO - 'SHELL': '/bin/bash', 09:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOSby7fOju/Listeners', 09:17:04 INFO - 'TMPDIR': '/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/', 09:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:04 INFO - 'USER': 'cltbld', 09:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:04 INFO - 'XPC_FLAGS': '0x0', 09:17:04 INFO - 'XPC_SERVICE_NAME': '0', 09:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0347', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:17:04 INFO - mozversion application_buildid: 20160812071715 09:17:04 INFO - mozversion application_changeset: 124669ed2f09f68f7f8dd38f4fee5f3084da0aff 09:17:04 INFO - mozversion application_display_name: Nightly 09:17:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:04 INFO - mozversion application_name: Firefox 09:17:04 INFO - mozversion application_remotingname: firefox 09:17:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:17:04 INFO - mozversion application_vendor: Mozilla 09:17:04 INFO - mozversion application_version: 51.0a1 09:17:04 INFO - mozversion platform_buildid: 20160812071715 09:17:04 INFO - mozversion platform_changeset: 124669ed2f09f68f7f8dd38f4fee5f3084da0aff 09:17:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:17:04 INFO - mozversion platform_version: 51.0a1 09:17:04 INFO - using testdate: 1471018624 09:17:04 INFO - actual date: 1471018624 09:17:04 INFO - starting webserver on 'localhost:49272' 09:17:04 INFO - SUITE-START | Running 2 tests 09:17:04 INFO - TEST-START | dromaeo_css 09:17:04 INFO - operating with platform_type : mac_ 09:17:04 INFO - Initialising browser for dromaeo_css test... 09:17:04 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/tmp4C4EXj/profile http://localhost:49272/getInfo.html) 09:17:07 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 09:17:07 INFO - PROCESS | 1668 | colorDepth:24 09:17:07 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 09:17:07 INFO - PROCESS | 1668 | __metrics 09:17:07 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:17:08 INFO - TEST-INFO | 1668: exit 0 09:17:08 INFO - Browser initialized. 09:17:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:08 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/tmp4C4EXj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:20 INFO - PROCESS | 1671 | RSS: Main: 254697472 09:17:20 INFO - PROCESS | 1671 | 09:18:10 INFO - PROCESS | 1671 | 1471018690020 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] 09:20:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:20:23 INFO - PROCESS | 1671 | RSS: Main: 267247616 09:20:23 INFO - PROCESS | 1671 | 09:23:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 09:23:26 INFO - PROCESS | 1671 | RSS: Main: 276385792 09:23:26 INFO - PROCESS | 1671 | 09:26:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 09:26:28 INFO - PROCESS | 1671 | RSS: Main: 280350720 09:26:28 INFO - PROCESS | 1671 | 09:29:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 09:29:31 INFO - PROCESS | 1671 | RSS: Main: 278753280 09:29:31 INFO - PROCESS | 1671 | 09:32:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 09:32:34 INFO - PROCESS | 1671 | RSS: Main: 283320320 09:32:34 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 09:35:37 INFO - PROCESS | 1671 | RSS: Main: 284831744 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | __start_tp_report 09:35:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 09:35:37 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 09:35:37 INFO - PROCESS | 1671 | |i|pagename|runs| 09:35:37 INFO - PROCESS | 1671 | |0;dojo.html;3246.3345014272077;3294.621118571364;3361.865525378985;3385.6275809660947;3387.949180762288;4596.701214421065;4722.929156062653;5269.946010797837;5460.399356070829;5618.719064046797;5555.916661250074;5571.944280557193;5576.107822748361;5585.636933599313;5634.549236061115;5018.247262910565;5118.539331460168;5123.308353372285;5179.689218646874;5275.762590683428;5214.921776173361;5223.451537588556;5250.684958902459;5295.391030031557;5297.231901374298;5007.4992500749995;5023.773930173151;5074.314967479417;5175.43070262269;5176.301199338079;5019.874503137415;5058.0895438821;5068.974655126701;5123;5143.151380022292;5080.517350851663;5086.516780905808;5103.87240318995;5115.667481613683;5139.8458046258675;5456.0997435423105;5465.262189604392;5570.6657600543695;5583.050881350139;5627.409122042168;6028.427299406593;6110.755569777203;6136.9079463808075;6147.077938309245;6154.78458253959;6234.220722409699;6236.158118653969;6243;6247.812565623039;6251.812445626639;5568.749406276686;5649.180868774046;5689.829305120853;5712.285964254468;5721.284839395075;6238.812835614848;6247.156633854463;6257.217847769029;6265.248170219603;6267.592606480564;6065.969670151621;6096.817095487054;6097.573169878155;6119.632822030692;6123.96938015316;4862.6839255448285;6099.370313949828;6115.696722738819;6143.692815359214;6219.098230756515;5873.060310350324;6005.918934591816;6039.214902062704;6046.153538504613;6113.144159817629;6083.878322433527;6124.908126378108;6154.476869466056;6161.322254551996;6163.476104531075;4830.686005409637;4886.096072226649;4910.361652985161;4945.03571803502;4949.7030178189425;3731.2350968051483;4406.823727050946;4416;4433.467983841895;4446.42196514451;5082.438059649544;5506.03644362235;5557.861053473695;5662.405447427961;5721;5997.340292567814;6031.517478601701;6229.626222426669;6251.28110267316;6289.496840252768;5527.977324194956;5565.721713914288;5583.609147359727;5618.775248989995;5657.57568182388;5395.62230643859;5408.972955135199;5415.4855288748295;5415.512603865593;5422.972885135628;6169.96915015422;6271.937280627135;6274.968625156845;6278.654673992883;6304.211973503312;6130.031268545553;6187;6260.624362538262;6273.121762953281;6289.622622642656;6275.435210831047;6283.560150789401;6301.905471417841;6305.558610897193;6310.6529140895855;5960.284765828128;6113.786017489367;6174.660393678211;6194;6246.46905013079;4678.953210467852;5613.017721898733;5730.111832665943;6113.050656959083;6114.145302971391;6062.060380641008;6092.552436721307;6101.450869421773;6112.419320164578;6127.264728232641;5885.3820348862755;6091.299500557316;6108.75564977396;6110.052941794029;6124.050772130327;5788.27646544182;5789.594728369142;5805.680687562056;5872.765089396547;5913.526917846648;6037.396260373927;6059.878802423838;6060.393960603904;6063.029915213545;6073.058675905242;5724.8568785779025;5843.1235314703135;5865.354810970875;5896.115582662635;5900.43945825146 09:35:37 INFO - PROCESS | 1671 | |1;ext.html;472.227907371448;526.276369991262;534.5643300709924;538.8868337649094;539.7652021370704;36307;38780.22439551207;38783.41824872626;38811.22377552447;38928.22143557131;38627.420588691195;39088.80455597718;39205.803970980174;39252.60747392532;39392;9348.813023739538;9422.905770942272;9437.575309111073;9476.478793666345;9567.473788941605;7858.607069646523;8721.7819554511;9027.232685221765;9423.15191632753;9553.713388598318;8067.878981815277;9409.059094090604;9434.150926416622;9603.039696030412;9605.807883842319;9515.524223788818;9522.523873806316;9557.330986830924;9575.473348965805;9582.185514231298;9307.674231401868;9327.906720932771;9327.953360233223;9355.953220233856;9470.431774093577;37873.43189852154;38195.80902095499;38289.61710382888;38290.04274893122;38320.42519362212;2760.627315312447;3181.904542863718;3511.7717348372275;3596.892093237207;4136.544980052192;25932.703364831683;26442.73557264441;30082.699173008208;30691.232719181975;30922;3094.876204951799;3097.349556593118;3107.39405815866;3127.3119913618966;3216.083416226364;445152;450465;453205;453675;455180;32685.346293074006;32765.672343276263;32851.67148328534;32856.01431956997;32864.17839553983;33067.84262550799;33905.830470847985;34474.65525344764;34662.82668586641;35646;16057.919710401373;16489.587760306087;16669.99980001204;16694.499165024827;16739.665206695798;12797;12859.292738899263;12859.549915752903;12883.484660613658;12903.290319032543;18769;18811.90594047021;18817.717734233996;18854.622907541772;19012.714809277873;7178.748743794046;7914.654508733529;8007.159248278964;8053.798655033554;8064.153263907323;865.5542395666237;986.2159583131428;1042.1402343067;1060.4326685223368;1117.754094099297;28247.57628635572;29387.85306073456;29579;29824.850875745484;30612.846935765177;1001.4141727089734;1046.827273499864;1082.3019152646498;1116.7319843237726;1159.0264178090445;13004.863079083709;13852.515161969484;14930.626734331512;14948;15390.923045384701;679589;686713;691443;692478;692535;46603.766981164874;47168;47274.5272547277;47541.76229118832;48023.03953920902;1365.2968721108637;1399.9160050397008;1427.5003748688084;1427.7144571085823;1430.7710766277346;27171.320716982234;28850.27874303159;28983.98556050528;29059.56410653884;29247;48225.276620851415;48566.757166213945;48645.5135448641;48652.75673621609;48816.755916220194;619306;619706;621324.8271345119;621330.8933455484;623007;24872.253832385057;25872.482550349265;25882.48235035251;25944.221673349828;26007.739922600533;44515.332270016625;45405.54594454013;46014;46462.535374647174;46621.53378466308;34325.313493730486;35716.82141589275;36938.8153059233;36960;38312.80843595764;37435.81282093681;37535;38084.428733568464;38367;38629;36162;36412.543498260835;36915.89252322435;38030.61969380381;38857.80571097126;33414.83048093305;34909.8254508736;35036;35057.47413788744;35089.824550877085;25148.24555263345;25422.425501317823;25470.49059018772;25979.22062338133;26037.349066273495 09:35:37 INFO - PROCESS | 1671 | |2;jquery.html;374.29819089207734;378.0661765439365;378.9639984201502;383.50527819113347;387.9709021823364;19014.524636884067;21072.367828965136;21073.47316317093;21205.681914771252;21807.67288490674;18073.638527229446;18107.909460452713;18855.43433696988;20577.897110514426;20899.895500522474;5372.462753724616;5909.793157239497;6061.545384096188;6121.846953826145;6124.2957059938235;6054.666993315366;6094.055421409688;6100.877982440348;6102.938970610281;6117.2659280886355;5826.854328641797;5918.99377105893;5956.612820166697;5971.253593300838;5977.013792724195;5881.764729410818;5890.617109887887;5920.259967504062;5965.254343207099;6000.789972350969;5024.723640199788;5082.6188035897085;5099;5179.689218646893;5180.5337519623035;24852.751472485405;25037.749622503725;25042.749572504224;25056.123035693665;25141.24576262715;2346.835721499496;2388.1880160745254;2392.138830021191;2392.497575509145;2970.1386597886585;15495.91528592999;15650.373985040585;15747.527574172793;15827.841721582752;15849;1829.4237315245655;1858.4703359542466;1895.8388536974373;1907.4087033019807;1931.864769466138;97303.54044689336;119953;121303.39348303291;122993.38503307426;124529;10220.466929960417;10411.375317480975;10459.84310235347;10884.40135792539;11048.005679488884;13267.203967761965;13269.402876870565;13346.733065338638;13409.865901341056;13489.865101349058;6873.862522749517;8453.281471074904;8633.740987770378;8719.738407847775;8731.738047858575;7351.595662238628;8608.784780380416;8632.438891472035;8637.611307491177;8795.736127916172;6080.179175811298;6309.842253943688;6499.350064993558;6601.108850305243;6629.204495460479;1676.3964972609851;1768.8408043276168;1846.1138653446421;1847.1041544850736;1851.9537011574819;925.2782829393084;987.3384832162468;1021.6883850425692;1079.5304042741432;1105.6461932181624;19574.510637234183;20479.795202048088;21255;21887.890560547094;22295;958.6548842416724;959.0457494792726;986.2307400227834;992.1715367668078;1000.3847633705365;11420.600278990196;11668.649940501798;11858;11923.940380298043;11925.582604608971;594882;604682;607142;622852.4286892863;624579;102198;121262.39368803275;129487;143164;145246;961.077365728894;972.1445128287204;1011.2920955331298;1015.6187584884551;1021.3106153346462;18803.05984700787;19180.424587262405;19418.32035878794;19506.41480755523;19524.21903123859;54095.72952135214;54326.728366357915;55780;56175;57010;68948.31051689418;76587.61706191434;83079.75380369178;83779.5811020941;85418;7941.444098913021;7973.242541958504;7998.444386829086;8333.83332333362;8342.998840139222;12838;12888.484460621845;13057.477700891857;13163.670908226988;13248.20510769357;11220.943895280472;11449.313041217554;11473.311601303949;11535.307881527135;11553.595624153115;11065.83401248998;11109.166812488935;11117.27737697047;11233.045191158842;11382.487788049722;11337.716557086138;11398.601048963246;11467.541298348306;11753.47109380097;11792.823107653221;6919.37725604698;7950.960245198737;8158.918410815816;8273.627686754231;8381.287590554628;9930.900690992998;11006.724831879266;11487.942560287145;11689.532418703157;11705.765884682429 09:35:37 INFO - PROCESS | 1671 | |3;mootools.html;1537.2851623994843;1565.1235308227394;1800.8649351298657;1883.8869667819922;1901.2775145444737;7894.17111203324;8403.621837017334;8621.482711037343;9001.14489123533;9007.189352958232;8641.308695304377;8851.336149788776;8857.114288571156;8878.689245876396;8881;2329.7087864016958;2378.9286321410386;2385.403649087728;2387.928362149138;2393.964090538643;2341.9531609367887;2361.4214517443165;2364.219807463533;2380.27401642499;2386.510765293119;2345.0854166874933;2370.2533701883854;2376.239603326936;2376.572217000939;2379.9528207588605;2310.2838120182796;2348.6829278047503;2354.9882250588807;2363.326451961191;2373.41851246444;2064.349729835097;2284.371797755614;2355.4935688826986;2355.611324131516;2360.3745007572834;8818.779530511725;8858.822823543493;8918.375713700043;8919.108089191093;8985.775355616097;5049.4950504949575;5164.173732202829;5259.15853463444;5269.235960785664;5278.577713782888;2868.913932582005;3232.595925509311;3276.4430046892085;3620.3845346291196;3640.961061805371;1032.7882784029257;1065.9893401066045;1075.736444571085;1089.455272363818;1090.5092708281304;11569.826452603218;11583.826242606368;11725.589604363806;11731.354775487345;11858.407079645984;3874.593167717349;4553.271476563734;4769.713817170981;4771;4817.13291607507;8957.372983891066;9418.62325506972;9906.60373585063;9990.100890919706;10009.599616015423;5248.580113590903;5319.122344813062;5334.866628334245;5382.1119515280325;5397.8380648580605;3483.320752453247;4410.029793445437;4690.085433340534;4825.420949486014;4857.562819346205;3847.5382954045695;3959.1289916218384;4001.979990100031;4005.0988527581644;4058.6347228749555;1279.8016307472358;1283.5700040486354;1288.1433846492166;1291.044626976031;1291.7481091187317;921.7741653294852;925.2829057480507;941.3645789092335;944.7449188719145;969.413504829582;5780.277465316835;6049.425304596057;6086.726097325631;6106.816795496142;6208;430.8298222202213;433.93707912352534;443.90012247244755;447.57927548104675;447.8163952779345;3977.985613668554;3985.7608543487486;4052.9392059119136;4090.0592863640936;4148.357004664282;10451.634192803216;10680.679579612624;10767;10815.080718139046;10837.241393102564;10695.78608427827;10701.892981070245;10711.46442677863;10718;10724.14206863449;8087;8160.061592916772;8246.09292977772;8246.587670616445;8275.172482751677;5048.64659473848;5706.857328566819;5791.247137872218;5996.100584912124;6106.389361063858;9955.452450115314;9988.950055249677;10007.799844003224;10010.899891000996;10036.899631003596;9760.755981100529;10006.499675016075;10110.595576176871;10298.691039268833;10299.330543514647;6949.131358580177;7389.630518474162;7575.886361704469;7577.924220757722;7665.46341756094;8501.19238672325;8549.27331176857;8550.615222314886;8569;8585.227329540121;7347.485676002629;7426.257374262746;7569.280918312751;7621.771346859603;7664.923350766644;7314.634268286458;7449.702011919462;7484.326410622853;7599.430042746705;7609.885851712118;7004.299570042955;7052.365287124184;7076.540024898365;7116.323949224816;7163.534370265916;4915.926261106015;5000.874978125576;5082.872928176677;5085.211792172219;5133.153029750049;4327;4975.676581022222;5053.570446512088;5230.869228269324;5277.604179686462 09:35:37 INFO - PROCESS | 1671 | |4;prototype.html;311.4813834964784;314.2207325831937;318.37280557302114;322.099731251153;324.5407748036528;4232.83068677253;4473.709208901423;4840.6369522285795;4960.107180707476;5599.188117722928;5037.977213671795;5459.044667183247;5478.972605136979;5526.364468086172;5547;3927.803609819512;4051.8987025324454;4094.529129150156;4167.166566686659;4170.4369910062205;3832.712546559005;4124.216398884218;4161.167766446708;4167.6457501112445;4172.623034398641;3472.9754722356965;3588.7846729196203;4140.979295103521;4173.290540608089;4192.643625291854;3662.6154253803234;3733.8879833605033;3836;4053.9594604054023;4106.014556506432;3550.2721942002086;3552.662497062775;3552.786832790015;3556.448750443685;3561.982190089033;4345.587169218919;5223.817166399196;5298.708571028592;5303.7082960437165;5364.570834333244;4622.930656040162;4743.482085732567;4765.928511072337;4770.642201834841;4773.665843390964;5742.971285143548;5748.2527271454865;5757.625754325997;5781.53747700183;5823.184754134425;3648.8323736404095;3671.503377703161;3920.2355540669582;3948.7038472114705;3965.286248475273;5313.521783039545;5561.805336813192;6123.969380153071;6145.78489752861;6171.660558669271;3372.6003708461203;3829.162002238941;3974.4634474345594;3980.8606698765984;3994.3409337458993;3414.9487757683655;3877.7867217302755;4067.593240675909;4076.164386300801;4092.242935057024;3948.703847211413;3991.3214753491975;4166.000159961587;4695.389599352131;4755.83354582588;5454.563634909197;5486.451354864482;5752.511036561939;5783.652980821164;5863.237779088691;1160.966739601755;1316.6510874618234;1376.4150236149596;1381.1920026784444;1387.6461502316845;788.6175205025557;848.4485084694875;866.1035827918074;899.5277479323277;929.5631053404888;4539.455265368177;4724.267738500538;5308.416074231832;5355.491228333302;5392.514673679388;5683.8863222736145;5974.223350964434;6002.669853158118;6005.249343832021;6017.879642407215;4516.638668906479;5130.640855140105;5340.465953404629;5346.091164502044;5414.8628787954185;2558.808089393303;2866.226118947914;2908.5200941844782;2979.6460795971375;3134.464112584817;5403.729813509387;6106.297775755756;6191.9690401547705;6210.695753891643;6225.128482012522;4278.529361770203;5437.02133615953;6105.816825495153;6107.8473038173515;6166.691665416712;5660.349059858169;5983.910241346383;5991.370906054889;6231.127642130105;6239.937600624117;5143.5113664201845;5720.74256658443;5980.461758441761;5983.850403739767;6000.159977603226;5073.393899740733;5380.542653874464;5678.261825962599;5916.911246331222;5929.644221346733;6176.474999624902;6189.81430557084;6192.761447710386;6206.410391012847;6207.96896015517;3275.213948652354;3508.122969257686;3516.929661406706;3704.4258139988347;3945.9678265693765;5290.9735451322495;5846.883062338815;5962.314333851489;5975.790847320323;6010.822478377486;4803.95196048049;5216.37403511581;5517.779288828562;5790.247267855152;5807.738651760596;4762.261699522719;5025.597952163745;5189.948100518946;5304.859455217147;5694.743736531783;4699.812007519798;5009.972955544177;5339.490439493432;5674.631148975303;5700.657960522382;4720.103180395714;4875.341828853059;5443.904096922634;5537.978637797256;5634.774609015593;5420.593455490775;5521.944780552304;5649.830505084854;5717.656350757652;5772.249607550992 09:35:37 INFO - PROCESS | 1671 | |5;yui.html;659.7756762700681;693.549193024534;727.9454040946927;755.3692666623369;777.618966706314;14932.77600835987;15670.981386209889;15680.451184208541;15685.45100921468;15700.293486793093;12640;14067.718645627081;14170.078944868603;14210.147391156512;14219.71560568788;670.5038271678947;825.6656054297989;827.3463963468853;850.4004676702909;851.6848765956573;831.5966756123275;841.9073901870789;843.1399972028527;843.8312337532487;843.8734189871507;898.874157617934;900.3427497926485;901.4320977783987;901.9909800901972;902.381868420131;870.1776820904248;896.4307664633005;897.201490673298;898.6270697660495;899.0470101692194;644.4618743349309;651.7360469010058;670.6311528659218;670.792054463118;671.8421171024805;14343.641408964755;14346.139231646135;14508.492202772852;14529.709405811931;14543.78184327236;14315.928420357935;14320.64198395038;14424.06243594163;14459.71080578393;14469.493567725185;11813.940930295379;11962;12072.215306005082;12191.329476878767;12528;3833.386658134713;3853.9614603854166;3895.5130608673917;3908.062065104383;3909.866138819739;113181;115191.42404288008;120432;121650.39174804158;122425;10845.595565657755;11007.229493935347;11015.394153321644;11153.776924461465;11319.434028298552;21886.45283867916;22321.99551020208;22380.55238895213;22388.32835014952;22408.327750167522;7542.358899493604;7686.807829804187;7790.805229869298;7859.803504912423;8198.877016844752;3731.6641502264924;3854.69162467002;4207.053412982054;4352.695311328177;4395.274779661384;3649.1789347396625;3678.981605092011;3681.7975011374097;3685.9631403686158;3691.7046636269033;635.7615894039735;653.3760258952689;654.1986067067804;659.5095085107691;682.1745687717818;518.757950906096;589.0428054411581;617.7096764520668;637.7799659117597;650.2554575011585;8988.370814043084;9278.814423711488;9329.702450845652;9346.485943273185;9455.29085318604;623.7692053940071;629.6379581740517;647.4496677823812;654.1902528639505;654.3325807676143;4342.727670230955;4498.190325741332;4562.475315338712;4667.9766601166775;4774.689645173122;114661;117319;118715;145484;149576;76505.61747191228;77189;117870;118158;121405;94879.52560237155;95700;99327.50336248272;99561.50219249002;106419.46790265999;9528.52357382142;9606.51967401641;9607.951960240434;9882.11061004513;9888.901110988798;42944.570554294056;44152.558474414844;46919;57783.68865245343;59716.701416494376;85644;88471;89018;90928.54535727543;91141.54429227811;12732.299723515296;12856.357182141042;12953.158044727063;13228.47086116583;13313.66715832112;14421.278936053366;14454.710905782036;14467;14608.78086828677;15086.849131508545;13595.252261125734;13714.725705486035;13731.725365492834;14163.079399838978;14335;13159.473621055433;13367.866321336662;13437.798433023709;13605.931970340482;13864.445422183404;11419.0864730823;12169.756604868031;12523.812142817682;13084.869151308365;13407.664808379868;9518.619255229713;11301;11309.377984210947;11567.363794991355;11728.354940478355;9505.76235594088;10096.798064038825;11329.830052549054;11585.942070289595;11589.24669896454 09:35:37 INFO - PROCESS | 1671 | __end_tp_report 09:35:37 INFO - PROCESS | 1671 | __start_cc_report 09:35:37 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,411 09:35:37 INFO - PROCESS | 1671 | __end_cc_report 09:35:37 INFO - PROCESS | 1671 | __startTimestamp1471019737267__endTimestamp 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | ------- Summary: start ------- 09:35:37 INFO - PROCESS | 1671 | Number of tests: 6 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5637.25 Median:5805.68 stddev:657.77 (11.3%) stddev-sans-first:632.48 09:35:37 INFO - PROCESS | 1671 | Values: 3246.3 3294.6 3361.9 3385.6 3387.9 4596.7 4722.9 5269.9 5460.4 5618.7 5555.9 5571.9 5576.1 5585.6 5634.5 5018.2 5118.5 5123.3 5179.7 5275.8 5214.9 5223.5 5250.7 5295.4 5297.2 5007.5 5023.8 5074.3 5175.4 5176.3 5019.9 5058.1 5069.0 5123.0 5143.2 5080.5 5086.5 5103.9 5115.7 5139.8 5456.1 5465.3 5570.7 5583.1 5627.4 6028.4 6110.8 6136.9 6147.1 6154.8 6234.2 6236.2 6243.0 6247.8 6251.8 5568.7 5649.2 5689.8 5712.3 5721.3 6238.8 6247.2 6257.2 6265.2 6267.6 6066.0 6096.8 6097.6 6119.6 6124.0 4862.7 6099.4 6115.7 6143.7 6219.1 5873.1 6005.9 6039.2 6046.2 6113.1 6083.9 6124.9 6154.5 6161.3 6163.5 4830.7 4886.1 4910.4 4945.0 4949.7 3731.2 4406.8 4416.0 4433.5 4446.4 5082.4 5506.0 5557.9 5662.4 5721.0 5997.3 6031.5 6229.6 6251.3 6289.5 5528.0 5565.7 5583.6 5618.8 5657.6 5395.6 5409.0 5415.5 5415.5 5423.0 6170.0 6271.9 6275.0 6278.7 6304.2 6130.0 6187.0 6260.6 6273.1 6289.6 6275.4 6283.6 6301.9 6305.6 6310.7 5960.3 6113.8 6174.7 6194.0 6246.5 4679.0 5613.0 5730.1 6113.1 6114.1 6062.1 6092.6 6101.5 6112.4 6127.3 5885.4 6091.3 6108.8 6110.1 6124.1 5788.3 5789.6 5805.7 5872.8 5913.5 6037.4 6059.9 6060.4 6063.0 6073.1 5724.9 5843.1 5865.4 5896.1 5900.4 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:69385.98 Median:37485.41 stddev:159820.39 (426.4%) stddev-sans-first:160184.97 09:35:37 INFO - PROCESS | 1671 | Values: 472.2 526.3 534.6 538.9 539.8 36307.0 38780.2 38783.4 38811.2 38928.2 38627.4 39088.8 39205.8 39252.6 39392.0 9348.8 9422.9 9437.6 9476.5 9567.5 7858.6 8721.8 9027.2 9423.2 9553.7 8067.9 9409.1 9434.2 9603.0 9605.8 9515.5 9522.5 9557.3 9575.5 9582.2 9307.7 9327.9 9328.0 9356.0 9470.4 37873.4 38195.8 38289.6 38290.0 38320.4 2760.6 3181.9 3511.8 3596.9 4136.5 25932.7 26442.7 30082.7 30691.2 30922.0 3094.9 3097.3 3107.4 3127.3 3216.1 445152.0 450465.0 453205.0 453675.0 455180.0 32685.3 32765.7 32851.7 32856.0 32864.2 33067.8 33905.8 34474.7 34662.8 35646.0 16057.9 16489.6 16670.0 16694.5 16739.7 12797.0 12859.3 12859.5 12883.5 12903.3 18769.0 18811.9 18817.7 18854.6 19012.7 7178.7 7914.7 8007.2 8053.8 8064.2 865.6 986.2 1042.1 1060.4 1117.8 28247.6 29387.9 29579.0 29824.9 30612.8 1001.4 1046.8 1082.3 1116.7 1159.0 13004.9 13852.5 14930.6 14948.0 15390.9 679589.0 686713.0 691443.0 692478.0 692535.0 46603.8 47168.0 47274.5 47541.8 48023.0 1365.3 1399.9 1427.5 1427.7 1430.8 27171.3 28850.3 28984.0 29059.6 29247.0 48225.3 48566.8 48645.5 48652.8 48816.8 619306.0 619706.0 621324.8 621330.9 623007.0 24872.3 25872.5 25882.5 25944.2 26007.7 44515.3 45405.5 46014.0 46462.5 46621.5 34325.3 35716.8 36938.8 36960.0 38312.8 37435.8 37535.0 38084.4 38367.0 38629.0 36162.0 36412.5 36915.9 38030.6 38857.8 33414.8 34909.8 35036.0 35057.5 35089.8 25148.2 25422.4 25470.5 25979.2 26037.3 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:35678.75 Median:2367.51 stddev:101869.43 (4302.8%) stddev-sans-first:102120.71 09:35:37 INFO - PROCESS | 1671 | Values: 374.3 378.1 379.0 383.5 388.0 19014.5 21072.4 21073.5 21205.7 21807.7 18073.6 18107.9 18855.4 20577.9 20899.9 5372.5 5909.8 6061.5 6121.8 6124.3 6054.7 6094.1 6100.9 6102.9 6117.3 5826.9 5919.0 5956.6 5971.3 5977.0 5881.8 5890.6 5920.3 5965.3 6000.8 5024.7 5082.6 5099.0 5179.7 5180.5 24852.8 25037.7 25042.7 25056.1 25141.2 2346.8 2388.2 2392.1 2392.5 2970.1 15495.9 15650.4 15747.5 15827.8 15849.0 1829.4 1858.5 1895.8 1907.4 1931.9 97303.5 119953.0 121303.4 122993.4 124529.0 10220.5 10411.4 10459.8 10884.4 11048.0 13267.2 13269.4 13346.7 13409.9 13489.9 6873.9 8453.3 8633.7 8719.7 8731.7 7351.6 8608.8 8632.4 8637.6 8795.7 6080.2 6309.8 6499.4 6601.1 6629.2 1676.4 1768.8 1846.1 1847.1 1852.0 925.3 987.3 1021.7 1079.5 1105.6 19574.5 20479.8 21255.0 21887.9 22295.0 958.7 959.0 986.2 992.2 1000.4 11420.6 11668.6 11858.0 11923.9 11925.6 594882.0 604682.0 607142.0 622852.4 624579.0 102198.0 121262.4 129487.0 143164.0 145246.0 961.1 972.1 1011.3 1015.6 1021.3 18803.1 19180.4 19418.3 19506.4 19524.2 54095.7 54326.7 55780.0 56175.0 57010.0 68948.3 76587.6 83079.8 83779.6 85418.0 7941.4 7973.2 7998.4 8333.8 8343.0 12838.0 12888.5 13057.5 13163.7 13248.2 11220.9 11449.3 11473.3 11535.3 11553.6 11065.8 11109.2 11117.3 11233.0 11382.5 11337.7 11398.6 11467.5 11753.5 11792.8 6919.4 7951.0 8158.9 8273.6 8381.3 9930.9 11006.7 11487.9 11689.5 11705.8 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5704.98 Median:4794.07 stddev:3231.25 (67.4%) stddev-sans-first:3225.14 09:35:37 INFO - PROCESS | 1671 | Values: 1537.3 1565.1 1800.9 1883.9 1901.3 7894.2 8403.6 8621.5 9001.1 9007.2 8641.3 8851.3 8857.1 8878.7 8881.0 2329.7 2378.9 2385.4 2387.9 2394.0 2342.0 2361.4 2364.2 2380.3 2386.5 2345.1 2370.3 2376.2 2376.6 2380.0 2310.3 2348.7 2355.0 2363.3 2373.4 2064.3 2284.4 2355.5 2355.6 2360.4 8818.8 8858.8 8918.4 8919.1 8985.8 5049.5 5164.2 5259.2 5269.2 5278.6 2868.9 3232.6 3276.4 3620.4 3641.0 1032.8 1066.0 1075.7 1089.5 1090.5 11569.8 11583.8 11725.6 11731.4 11858.4 3874.6 4553.3 4769.7 4771.0 4817.1 8957.4 9418.6 9906.6 9990.1 10009.6 5248.6 5319.1 5334.9 5382.1 5397.8 3483.3 4410.0 4690.1 4825.4 4857.6 3847.5 3959.1 4002.0 4005.1 4058.6 1279.8 1283.6 1288.1 1291.0 1291.7 921.8 925.3 941.4 944.7 969.4 5780.3 6049.4 6086.7 6106.8 6208.0 430.8 433.9 443.9 447.6 447.8 3978.0 3985.8 4052.9 4090.1 4148.4 10451.6 10680.7 10767.0 10815.1 10837.2 10695.8 10701.9 10711.5 10718.0 10724.1 8087.0 8160.1 8246.1 8246.6 8275.2 5048.6 5706.9 5791.2 5996.1 6106.4 9955.5 9989.0 10007.8 10010.9 10036.9 9760.8 10006.5 10110.6 10298.7 10299.3 6949.1 7389.6 7575.9 7577.9 7665.5 8501.2 8549.3 8550.6 8569.0 8585.2 7347.5 7426.3 7569.3 7621.8 7664.9 7314.6 7449.7 7484.3 7599.4 7609.9 7004.3 7052.4 7076.5 7116.3 7163.5 4915.9 5000.9 5082.9 5085.2 5133.2 4327.0 4975.7 5053.6 5230.9 5277.6 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4603.41 Median:5203.16 stddev:1456.51 (28.0%) stddev-sans-first:1424.53 09:35:37 INFO - PROCESS | 1671 | Values: 311.5 314.2 318.4 322.1 324.5 4232.8 4473.7 4840.6 4960.1 5599.2 5038.0 5459.0 5479.0 5526.4 5547.0 3927.8 4051.9 4094.5 4167.2 4170.4 3832.7 4124.2 4161.2 4167.6 4172.6 3473.0 3588.8 4141.0 4173.3 4192.6 3662.6 3733.9 3836.0 4054.0 4106.0 3550.3 3552.7 3552.8 3556.4 3562.0 4345.6 5223.8 5298.7 5303.7 5364.6 4622.9 4743.5 4765.9 4770.6 4773.7 5743.0 5748.3 5757.6 5781.5 5823.2 3648.8 3671.5 3920.2 3948.7 3965.3 5313.5 5561.8 6124.0 6145.8 6171.7 3372.6 3829.2 3974.5 3980.9 3994.3 3414.9 3877.8 4067.6 4076.2 4092.2 3948.7 3991.3 4166.0 4695.4 4755.8 5454.6 5486.5 5752.5 5783.7 5863.2 1161.0 1316.7 1376.4 1381.2 1387.6 788.6 848.4 866.1 899.5 929.6 4539.5 4724.3 5308.4 5355.5 5392.5 5683.9 5974.2 6002.7 6005.2 6017.9 4516.6 5130.6 5340.5 5346.1 5414.9 2558.8 2866.2 2908.5 2979.6 3134.5 5403.7 6106.3 6192.0 6210.7 6225.1 4278.5 5437.0 6105.8 6107.8 6166.7 5660.3 5983.9 5991.4 6231.1 6239.9 5143.5 5720.7 5980.5 5983.9 6000.2 5073.4 5380.5 5678.3 5916.9 5929.6 6176.5 6189.8 6192.8 6206.4 6208.0 3275.2 3508.1 3516.9 3704.4 3946.0 5291.0 5846.9 5962.3 5975.8 6010.8 4804.0 5216.4 5517.8 5790.2 5807.7 4762.3 5025.6 5189.9 5304.9 5694.7 4699.8 5010.0 5339.5 5674.6 5700.7 4720.1 4875.3 5443.9 5538.0 5634.8 5420.6 5521.9 5649.8 5717.7 5772.2 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:23094.08 Median:3875.10 stddev:35890.21 (926.2%) stddev-sans-first:35951.36 09:35:37 INFO - PROCESS | 1671 | Values: 659.8 693.5 727.9 755.4 777.6 14932.8 15671.0 15680.5 15685.5 15700.3 12640.0 14067.7 14170.1 14210.1 14219.7 670.5 825.7 827.3 850.4 851.7 831.6 841.9 843.1 843.8 843.9 898.9 900.3 901.4 902.0 902.4 870.2 896.4 897.2 898.6 899.0 644.5 651.7 670.6 670.8 671.8 14343.6 14346.1 14508.5 14529.7 14543.8 14315.9 14320.6 14424.1 14459.7 14469.5 11813.9 11962.0 12072.2 12191.3 12528.0 3833.4 3854.0 3895.5 3908.1 3909.9 113181.0 115191.4 120432.0 121650.4 122425.0 10845.6 11007.2 11015.4 11153.8 11319.4 21886.5 22322.0 22380.6 22388.3 22408.3 7542.4 7686.8 7790.8 7859.8 8198.9 3731.7 3854.7 4207.1 4352.7 4395.3 3649.2 3679.0 3681.8 3686.0 3691.7 635.8 653.4 654.2 659.5 682.2 518.8 589.0 617.7 637.8 650.3 8988.4 9278.8 9329.7 9346.5 9455.3 623.8 629.6 647.4 654.2 654.3 4342.7 4498.2 4562.5 4668.0 4774.7 114661.0 117319.0 118715.0 145484.0 149576.0 76505.6 77189.0 117870.0 118158.0 121405.0 94879.5 95700.0 99327.5 99561.5 106419.5 9528.5 9606.5 9608.0 9882.1 9888.9 42944.6 44152.6 46919.0 57783.7 59716.7 85644.0 88471.0 89018.0 90928.5 91141.5 12732.3 12856.4 12953.2 13228.5 13313.7 14421.3 14454.7 14467.0 14608.8 15086.8 13595.3 13714.7 13731.7 14163.1 14335.0 13159.5 13367.9 13437.8 13605.9 13864.4 11419.1 12169.8 12523.8 13084.9 13407.7 9518.6 11301.0 11309.4 11567.4 11728.4 9505.8 10096.8 11329.8 11585.9 11589.2 09:35:37 INFO - PROCESS | 1671 | -------- Summary: end -------- 09:35:37 INFO - PROCESS | 1671 | 09:35:37 INFO - TEST-INFO | 1671: exit 0 09:35:37 INFO - TEST-OK | dromaeo_css | took 1112901ms 09:35:37 INFO - TEST-START | kraken 09:35:37 INFO - operating with platform_type : mac_ 09:35:37 INFO - Initialising browser for kraken test... 09:35:37 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/tmpNRoZxk/profile http://localhost:49272/getInfo.html) 09:35:40 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 09:35:40 INFO - PROCESS | 1683 | colorDepth:24 09:35:40 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 09:35:40 INFO - PROCESS | 1683 | __metrics 09:35:40 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:35:41 INFO - TEST-INFO | 1683: exit 0 09:35:41 INFO - Browser initialized. 09:35:41 INFO - Running cycle 1/1 for kraken test... 09:35:41 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/tmpNRoZxk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:53 INFO - PROCESS | 1685 | RSS: Main: 254664704 09:35:53 INFO - PROCESS | 1685 | 09:35:56 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:57 INFO - PROCESS | 1685 | RSS: Main: 267563008 09:35:57 INFO - PROCESS | 1685 | 09:36:00 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 09:36:00 INFO - PROCESS | 1685 | RSS: Main: 276164608 09:36:00 INFO - PROCESS | 1685 | 09:36:04 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 09:36:05 INFO - PROCESS | 1685 | RSS: Main: 279252992 09:36:05 INFO - PROCESS | 1685 | 09:36:07 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 09:36:07 INFO - PROCESS | 1685 | RSS: Main: 281661440 09:36:07 INFO - PROCESS | 1685 | 09:36:09 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:10 INFO - PROCESS | 1685 | RSS: Main: 281964544 09:36:10 INFO - PROCESS | 1685 | 09:36:13 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:13 INFO - PROCESS | 1685 | RSS: Main: 281915392 09:36:13 INFO - PROCESS | 1685 | 09:36:16 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:17 INFO - PROCESS | 1685 | RSS: Main: 282259456 09:36:17 INFO - PROCESS | 1685 | 09:36:20 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 09:36:20 INFO - PROCESS | 1685 | RSS: Main: 282607616 09:36:20 INFO - PROCESS | 1685 | 09:36:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:23 INFO - PROCESS | 1685 | RSS: Main: 282099712 09:36:23 INFO - PROCESS | 1685 | 09:36:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:25 INFO - PROCESS | 1685 | RSS: Main: 282189824 09:36:25 INFO - PROCESS | 1685 | 09:36:27 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:28 INFO - PROCESS | 1685 | RSS: Main: 282501120 09:36:28 INFO - PROCESS | 1685 | 09:36:31 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:32 INFO - PROCESS | 1685 | RSS: Main: 282652672 09:36:32 INFO - PROCESS | 1685 | 09:36:35 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:36 INFO - PROCESS | 1685 | RSS: Main: 283070464 09:36:36 INFO - PROCESS | 1685 | 09:36:37 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 09:36:38 INFO - PROCESS | 1685 | RSS: Main: 284086272 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | __start_tp_report 09:36:38 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 09:36:38 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 09:36:38 INFO - PROCESS | 1685 | |i|pagename|runs| 09:36:38 INFO - PROCESS | 1685 | |0;ai-astar;104;125;120;120;133;168;117;119;117;116 09:36:38 INFO - PROCESS | 1685 | |1;audio-beat-detection;147;126;150;163;104;138;130;108;175;138 09:36:38 INFO - PROCESS | 1685 | |2;audio-dft;201;202;206;261;267;204;273;278;243;271 09:36:38 INFO - PROCESS | 1685 | |3;audio-fft;78;84;75;144;60;57;60;63;141;62 09:36:38 INFO - PROCESS | 1685 | |4;audio-oscillator;69;72;122;72;71;78;115;70;73;113 09:36:38 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;89;87;89;87;90;86;89;90;89;87 09:36:38 INFO - PROCESS | 1685 | |6;imaging-darkroom;95;101;96;148;94;94;94;95;95;93 09:36:38 INFO - PROCESS | 1685 | |7;imaging-desaturate;146;147;81;145;142;125;91;93;93;90 09:36:38 INFO - PROCESS | 1685 | |8;json-parse-financial;56;57;58;60;60;57;55;56;56;57 09:36:38 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;69;72;73;74;77;72;88;105;105;90 09:36:38 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;89;85;89;86;89;88;87;88;89;86 09:36:38 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;141;154;143;144;141;166;139;150;154;162 09:36:38 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;194;223;256;193;187;194;193;192;192;192 09:36:38 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;83;94;93;80;73;71;70;69;72;73 09:36:38 INFO - PROCESS | 1685 | __end_tp_report 09:36:38 INFO - PROCESS | 1685 | __start_cc_report 09:36:38 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1046 09:36:38 INFO - PROCESS | 1685 | __end_cc_report 09:36:38 INFO - PROCESS | 1685 | __startTimestamp1471019798138__endTimestamp 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | ------- Summary: start ------- 09:36:38 INFO - PROCESS | 1685 | Number of tests: 14 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:123.90 Median:120.00 stddev:17.12 (14.3%) stddev-sans-first:16.57 09:36:38 INFO - PROCESS | 1685 | Values: 104.0 125.0 120.0 120.0 133.0 168.0 117.0 119.0 117.0 116.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:142.50 stddev:22.32 (15.7%) stddev-sans-first:23.43 09:36:38 INFO - PROCESS | 1685 | Values: 147.0 126.0 150.0 163.0 104.0 138.0 130.0 108.0 175.0 138.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:240.60 Median:264.00 stddev:33.48 (12.7%) stddev-sans-first:32.30 09:36:38 INFO - PROCESS | 1685 | Values: 201.0 202.0 206.0 261.0 267.0 204.0 273.0 278.0 243.0 271.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:82.40 Median:62.50 stddev:32.91 (52.7%) stddev-sans-first:34.87 09:36:38 INFO - PROCESS | 1685 | Values: 78.0 84.0 75.0 144.0 60.0 57.0 60.0 63.0 141.0 62.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:71.50 stddev:21.75 (30.4%) stddev-sans-first:22.24 09:36:38 INFO - PROCESS | 1685 | Values: 69.0 72.0 122.0 72.0 71.0 78.0 115.0 70.0 73.0 113.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.42 (1.6%) stddev-sans-first:1.48 09:36:38 INFO - PROCESS | 1685 | Values: 89.0 87.0 89.0 87.0 90.0 86.0 89.0 90.0 89.0 87.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:94.50 stddev:16.83 (17.8%) stddev-sans-first:17.74 09:36:38 INFO - PROCESS | 1685 | Values: 95.0 101.0 96.0 148.0 94.0 94.0 94.0 95.0 95.0 93.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:115.30 Median:85.50 stddev:27.96 (32.7%) stddev-sans-first:27.37 09:36:38 INFO - PROCESS | 1685 | Values: 146.0 147.0 81.0 145.0 142.0 125.0 91.0 93.0 93.0 90.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.69 (3.0%) stddev-sans-first:1.73 09:36:38 INFO - PROCESS | 1685 | Values: 56.0 57.0 58.0 60.0 60.0 57.0 55.0 56.0 56.0 57.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:82.50 Median:73.50 stddev:13.72 (18.7%) stddev-sans-first:13.66 09:36:38 INFO - PROCESS | 1685 | Values: 69.0 72.0 73.0 74.0 77.0 72.0 88.0 105.0 105.0 90.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.50 stddev:1.51 (1.7%) stddev-sans-first:1.51 09:36:38 INFO - PROCESS | 1685 | Values: 89.0 85.0 89.0 86.0 89.0 88.0 87.0 88.0 89.0 86.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:152.00 stddev:9.41 (6.2%) stddev-sans-first:9.47 09:36:38 INFO - PROCESS | 1685 | Values: 141.0 154.0 143.0 144.0 141.0 166.0 139.0 150.0 154.0 162.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.60 Median:193.50 stddev:21.53 (11.1%) stddev-sans-first:22.66 09:36:38 INFO - PROCESS | 1685 | Values: 194.0 223.0 256.0 193.0 187.0 194.0 193.0 192.0 192.0 192.0 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:76.50 stddev:9.37 (12.2%) stddev-sans-first:9.74 09:36:38 INFO - PROCESS | 1685 | Values: 83.0 94.0 93.0 80.0 73.0 71.0 70.0 69.0 72.0 73.0 09:36:38 INFO - PROCESS | 1685 | -------- Summary: end -------- 09:36:38 INFO - PROCESS | 1685 | 09:36:38 INFO - TEST-INFO | 1685: exit 0 09:36:38 INFO - TEST-OK | kraken | took 61046ms 09:36:38 INFO - SUITE-END | took 1173s 09:36:39 INFO - Completed test suite (00:19:34) 09:36:39 INFO - javascript benchmark 09:36:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7281.791391341858, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.3345014272077, 3294.621118571364, 3361.865525378985, 3385.6275809660947, 3387.949180762288, 4596.701214421065, 4722.929156062653, 5269.946010797837, 5460.399356070829, 5618.719064046797, 5555.916661250074, 5571.944280557193, 5576.107822748361, 5585.636933599313, 5634.549236061115, 5018.247262910565, 5118.539331460168, 5123.308353372285, 5179.689218646874, 5275.762590683428, 5214.921776173361, 5223.451537588556, 5250.684958902459, 5295.391030031557, 5297.231901374298, 5007.4992500749995, 5023.773930173151, 5074.314967479417, 5175.43070262269, 5176.301199338079, 5019.874503137415, 5058.0895438821, 5068.974655126701, 5123.0, 5143.151380022292, 5080.517350851663, 5086.516780905808, 5103.87240318995, 5115.667481613683, 5139.8458046258675, 5456.0997435423105, 5465.262189604392, 5570.6657600543695, 5583.050881350139, 5627.409122042168, 6028.427299406593, 6110.755569777203, 6136.9079463808075, 6147.077938309245, 6154.78458253959, 6234.220722409699, 6236.158118653969, 6243.0, 6247.812565623039, 6251.812445626639, 5568.749406276686, 5649.180868774046, 5689.829305120853, 5712.285964254468, 5721.284839395075, 6238.812835614848, 6247.156633854463, 6257.217847769029, 6265.248170219603, 6267.592606480564, 6065.969670151621, 6096.817095487054, 6097.573169878155, 6119.632822030692, 6123.96938015316, 4862.6839255448285, 6099.370313949828, 6115.696722738819, 6143.692815359214, 6219.098230756515, 5873.060310350324, 6005.918934591816, 6039.214902062704, 6046.153538504613, 6113.144159817629, 6083.878322433527, 6124.908126378108, 6154.476869466056, 6161.322254551996, 6163.476104531075, 4830.686005409637, 4886.096072226649, 4910.361652985161, 4945.03571803502, 4949.7030178189425, 3731.2350968051483, 4406.823727050946, 4416.0, 4433.467983841895, 4446.42196514451, 5082.438059649544, 5506.03644362235, 5557.861053473695, 5662.405447427961, 5721.0, 5997.340292567814, 6031.517478601701, 6229.626222426669, 6251.28110267316, 6289.496840252768, 5527.977324194956, 5565.721713914288, 5583.609147359727, 5618.775248989995, 5657.57568182388, 5395.62230643859, 5408.972955135199, 5415.4855288748295, 5415.512603865593, 5422.972885135628, 6169.96915015422, 6271.937280627135, 6274.968625156845, 6278.654673992883, 6304.211973503312, 6130.031268545553, 6187.0, 6260.624362538262, 6273.121762953281, 6289.622622642656, 6275.435210831047, 6283.560150789401, 6301.905471417841, 6305.558610897193, 6310.6529140895855, 5960.284765828128, 6113.786017489367, 6174.660393678211, 6194.0, 6246.46905013079, 4678.953210467852, 5613.017721898733, 5730.111832665943, 6113.050656959083, 6114.145302971391, 6062.060380641008, 6092.552436721307, 6101.450869421773, 6112.419320164578, 6127.264728232641, 5885.3820348862755, 6091.299500557316, 6108.75564977396, 6110.052941794029, 6124.050772130327, 5788.27646544182, 5789.594728369142, 5805.680687562056, 5872.765089396547, 5913.526917846648, 6037.396260373927, 6059.878802423838, 6060.393960603904, 6063.029915213545, 6073.058675905242, 5724.8568785779025, 5843.1235314703135, 5865.354810970875, 5896.115582662635, 5900.43945825146], "value": 5595.345007430362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.227907371448, 526.276369991262, 534.5643300709924, 538.8868337649094, 539.7652021370704, 36307.0, 38780.22439551207, 38783.41824872626, 38811.22377552447, 38928.22143557131, 38627.420588691195, 39088.80455597718, 39205.803970980174, 39252.60747392532, 39392.0, 9348.813023739538, 9422.905770942272, 9437.575309111073, 9476.478793666345, 9567.473788941605, 7858.607069646523, 8721.7819554511, 9027.232685221765, 9423.15191632753, 9553.713388598318, 8067.878981815277, 9409.059094090604, 9434.150926416622, 9603.039696030412, 9605.807883842319, 9515.524223788818, 9522.523873806316, 9557.330986830924, 9575.473348965805, 9582.185514231298, 9307.674231401868, 9327.906720932771, 9327.953360233223, 9355.953220233856, 9470.431774093577, 37873.43189852154, 38195.80902095499, 38289.61710382888, 38290.04274893122, 38320.42519362212, 2760.627315312447, 3181.904542863718, 3511.7717348372275, 3596.892093237207, 4136.544980052192, 25932.703364831683, 26442.73557264441, 30082.699173008208, 30691.232719181975, 30922.0, 3094.876204951799, 3097.349556593118, 3107.39405815866, 3127.3119913618966, 3216.083416226364, 445152.0, 450465.0, 453205.0, 453675.0, 455180.0, 32685.346293074006, 32765.672343276263, 32851.67148328534, 32856.01431956997, 32864.17839553983, 33067.84262550799, 33905.830470847985, 34474.65525344764, 34662.82668586641, 35646.0, 16057.919710401373, 16489.587760306087, 16669.99980001204, 16694.499165024827, 16739.665206695798, 12797.0, 12859.292738899263, 12859.549915752903, 12883.484660613658, 12903.290319032543, 18769.0, 18811.90594047021, 18817.717734233996, 18854.622907541772, 19012.714809277873, 7178.748743794046, 7914.654508733529, 8007.159248278964, 8053.798655033554, 8064.153263907323, 865.5542395666237, 986.2159583131428, 1042.1402343067, 1060.4326685223368, 1117.754094099297, 28247.57628635572, 29387.85306073456, 29579.0, 29824.850875745484, 30612.846935765177, 1001.4141727089734, 1046.827273499864, 1082.3019152646498, 1116.7319843237726, 1159.0264178090445, 13004.863079083709, 13852.515161969484, 14930.626734331512, 14948.0, 15390.923045384701, 679589.0, 686713.0, 691443.0, 692478.0, 692535.0, 46603.766981164874, 47168.0, 47274.5272547277, 47541.76229118832, 48023.03953920902, 1365.2968721108637, 1399.9160050397008, 1427.5003748688084, 1427.7144571085823, 1430.7710766277346, 27171.320716982234, 28850.27874303159, 28983.98556050528, 29059.56410653884, 29247.0, 48225.276620851415, 48566.757166213945, 48645.5135448641, 48652.75673621609, 48816.755916220194, 619306.0, 619706.0, 621324.8271345119, 621330.8933455484, 623007.0, 24872.253832385057, 25872.482550349265, 25882.48235035251, 25944.221673349828, 26007.739922600533, 44515.332270016625, 45405.54594454013, 46014.0, 46462.535374647174, 46621.53378466308, 34325.313493730486, 35716.82141589275, 36938.8153059233, 36960.0, 38312.80843595764, 37435.81282093681, 37535.0, 38084.428733568464, 38367.0, 38629.0, 36162.0, 36412.543498260835, 36915.89252322435, 38030.61969380381, 38857.80571097126, 33414.83048093305, 34909.8254508736, 35036.0, 35057.47413788744, 35089.824550877085, 25148.24555263345, 25422.425501317823, 25470.49059018772, 25979.22062338133, 26037.349066273495], "value": 18977.218636849346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.29819089207734, 378.0661765439365, 378.9639984201502, 383.50527819113347, 387.9709021823364, 19014.524636884067, 21072.367828965136, 21073.47316317093, 21205.681914771252, 21807.67288490674, 18073.638527229446, 18107.909460452713, 18855.43433696988, 20577.897110514426, 20899.895500522474, 5372.462753724616, 5909.793157239497, 6061.545384096188, 6121.846953826145, 6124.2957059938235, 6054.666993315366, 6094.055421409688, 6100.877982440348, 6102.938970610281, 6117.2659280886355, 5826.854328641797, 5918.99377105893, 5956.612820166697, 5971.253593300838, 5977.013792724195, 5881.764729410818, 5890.617109887887, 5920.259967504062, 5965.254343207099, 6000.789972350969, 5024.723640199788, 5082.6188035897085, 5099.0, 5179.689218646893, 5180.5337519623035, 24852.751472485405, 25037.749622503725, 25042.749572504224, 25056.123035693665, 25141.24576262715, 2346.835721499496, 2388.1880160745254, 2392.138830021191, 2392.497575509145, 2970.1386597886585, 15495.91528592999, 15650.373985040585, 15747.527574172793, 15827.841721582752, 15849.0, 1829.4237315245655, 1858.4703359542466, 1895.8388536974373, 1907.4087033019807, 1931.864769466138, 97303.54044689336, 119953.0, 121303.39348303291, 122993.38503307426, 124529.0, 10220.466929960417, 10411.375317480975, 10459.84310235347, 10884.40135792539, 11048.005679488884, 13267.203967761965, 13269.402876870565, 13346.733065338638, 13409.865901341056, 13489.865101349058, 6873.862522749517, 8453.281471074904, 8633.740987770378, 8719.738407847775, 8731.738047858575, 7351.595662238628, 8608.784780380416, 8632.438891472035, 8637.611307491177, 8795.736127916172, 6080.179175811298, 6309.842253943688, 6499.350064993558, 6601.108850305243, 6629.204495460479, 1676.3964972609851, 1768.8408043276168, 1846.1138653446421, 1847.1041544850736, 1851.9537011574819, 925.2782829393084, 987.3384832162468, 1021.6883850425692, 1079.5304042741432, 1105.6461932181624, 19574.510637234183, 20479.795202048088, 21255.0, 21887.890560547094, 22295.0, 958.6548842416724, 959.0457494792726, 986.2307400227834, 992.1715367668078, 1000.3847633705365, 11420.600278990196, 11668.649940501798, 11858.0, 11923.940380298043, 11925.582604608971, 594882.0, 604682.0, 607142.0, 622852.4286892863, 624579.0, 102198.0, 121262.39368803275, 129487.0, 143164.0, 145246.0, 961.077365728894, 972.1445128287204, 1011.2920955331298, 1015.6187584884551, 1021.3106153346462, 18803.05984700787, 19180.424587262405, 19418.32035878794, 19506.41480755523, 19524.21903123859, 54095.72952135214, 54326.728366357915, 55780.0, 56175.0, 57010.0, 68948.31051689418, 76587.61706191434, 83079.75380369178, 83779.5811020941, 85418.0, 7941.444098913021, 7973.242541958504, 7998.444386829086, 8333.83332333362, 8342.998840139222, 12838.0, 12888.484460621845, 13057.477700891857, 13163.670908226988, 13248.20510769357, 11220.943895280472, 11449.313041217554, 11473.311601303949, 11535.307881527135, 11553.595624153115, 11065.83401248998, 11109.166812488935, 11117.27737697047, 11233.045191158842, 11382.487788049722, 11337.716557086138, 11398.601048963246, 11467.541298348306, 11753.47109380097, 11792.823107653221, 6919.37725604698, 7950.960245198737, 8158.918410815816, 8273.627686754231, 8381.287590554628, 9930.900690992998, 11006.724831879266, 11487.942560287145, 11689.532418703157, 11705.765884682429], "value": 9843.076309163731, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.2851623994843, 1565.1235308227394, 1800.8649351298657, 1883.8869667819922, 1901.2775145444737, 7894.17111203324, 8403.621837017334, 8621.482711037343, 9001.14489123533, 9007.189352958232, 8641.308695304377, 8851.336149788776, 8857.114288571156, 8878.689245876396, 8881.0, 2329.7087864016958, 2378.9286321410386, 2385.403649087728, 2387.928362149138, 2393.964090538643, 2341.9531609367887, 2361.4214517443165, 2364.219807463533, 2380.27401642499, 2386.510765293119, 2345.0854166874933, 2370.2533701883854, 2376.239603326936, 2376.572217000939, 2379.9528207588605, 2310.2838120182796, 2348.6829278047503, 2354.9882250588807, 2363.326451961191, 2373.41851246444, 2064.349729835097, 2284.371797755614, 2355.4935688826986, 2355.611324131516, 2360.3745007572834, 8818.779530511725, 8858.822823543493, 8918.375713700043, 8919.108089191093, 8985.775355616097, 5049.4950504949575, 5164.173732202829, 5259.15853463444, 5269.235960785664, 5278.577713782888, 2868.913932582005, 3232.595925509311, 3276.4430046892085, 3620.3845346291196, 3640.961061805371, 1032.7882784029257, 1065.9893401066045, 1075.736444571085, 1089.455272363818, 1090.5092708281304, 11569.826452603218, 11583.826242606368, 11725.589604363806, 11731.354775487345, 11858.407079645984, 3874.593167717349, 4553.271476563734, 4769.713817170981, 4771.0, 4817.13291607507, 8957.372983891066, 9418.62325506972, 9906.60373585063, 9990.100890919706, 10009.599616015423, 5248.580113590903, 5319.122344813062, 5334.866628334245, 5382.1119515280325, 5397.8380648580605, 3483.320752453247, 4410.029793445437, 4690.085433340534, 4825.420949486014, 4857.562819346205, 3847.5382954045695, 3959.1289916218384, 4001.979990100031, 4005.0988527581644, 4058.6347228749555, 1279.8016307472358, 1283.5700040486354, 1288.1433846492166, 1291.044626976031, 1291.7481091187317, 921.7741653294852, 925.2829057480507, 941.3645789092335, 944.7449188719145, 969.413504829582, 5780.277465316835, 6049.425304596057, 6086.726097325631, 6106.816795496142, 6208.0, 430.8298222202213, 433.93707912352534, 443.90012247244755, 447.57927548104675, 447.8163952779345, 3977.985613668554, 3985.7608543487486, 4052.9392059119136, 4090.0592863640936, 4148.357004664282, 10451.634192803216, 10680.679579612624, 10767.0, 10815.080718139046, 10837.241393102564, 10695.78608427827, 10701.892981070245, 10711.46442677863, 10718.0, 10724.14206863449, 8087.0, 8160.061592916772, 8246.09292977772, 8246.587670616445, 8275.172482751677, 5048.64659473848, 5706.857328566819, 5791.247137872218, 5996.100584912124, 6106.389361063858, 9955.452450115314, 9988.950055249677, 10007.799844003224, 10010.899891000996, 10036.899631003596, 9760.755981100529, 10006.499675016075, 10110.595576176871, 10298.691039268833, 10299.330543514647, 6949.131358580177, 7389.630518474162, 7575.886361704469, 7577.924220757722, 7665.46341756094, 8501.19238672325, 8549.27331176857, 8550.615222314886, 8569.0, 8585.227329540121, 7347.485676002629, 7426.257374262746, 7569.280918312751, 7621.771346859603, 7664.923350766644, 7314.634268286458, 7449.702011919462, 7484.326410622853, 7599.430042746705, 7609.885851712118, 7004.299570042955, 7052.365287124184, 7076.540024898365, 7116.323949224816, 7163.534370265916, 4915.926261106015, 5000.874978125576, 5082.872928176677, 5085.211792172219, 5133.153029750049, 4327.0, 4975.676581022222, 5053.570446512088, 5230.869228269324, 5277.604179686462], "value": 4505.707475191069, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.4813834964784, 314.2207325831937, 318.37280557302114, 322.099731251153, 324.5407748036528, 4232.83068677253, 4473.709208901423, 4840.6369522285795, 4960.107180707476, 5599.188117722928, 5037.977213671795, 5459.044667183247, 5478.972605136979, 5526.364468086172, 5547.0, 3927.803609819512, 4051.8987025324454, 4094.529129150156, 4167.166566686659, 4170.4369910062205, 3832.712546559005, 4124.216398884218, 4161.167766446708, 4167.6457501112445, 4172.623034398641, 3472.9754722356965, 3588.7846729196203, 4140.979295103521, 4173.290540608089, 4192.643625291854, 3662.6154253803234, 3733.8879833605033, 3836.0, 4053.9594604054023, 4106.014556506432, 3550.2721942002086, 3552.662497062775, 3552.786832790015, 3556.448750443685, 3561.982190089033, 4345.587169218919, 5223.817166399196, 5298.708571028592, 5303.7082960437165, 5364.570834333244, 4622.930656040162, 4743.482085732567, 4765.928511072337, 4770.642201834841, 4773.665843390964, 5742.971285143548, 5748.2527271454865, 5757.625754325997, 5781.53747700183, 5823.184754134425, 3648.8323736404095, 3671.503377703161, 3920.2355540669582, 3948.7038472114705, 3965.286248475273, 5313.521783039545, 5561.805336813192, 6123.969380153071, 6145.78489752861, 6171.660558669271, 3372.6003708461203, 3829.162002238941, 3974.4634474345594, 3980.8606698765984, 3994.3409337458993, 3414.9487757683655, 3877.7867217302755, 4067.593240675909, 4076.164386300801, 4092.242935057024, 3948.703847211413, 3991.3214753491975, 4166.000159961587, 4695.389599352131, 4755.83354582588, 5454.563634909197, 5486.451354864482, 5752.511036561939, 5783.652980821164, 5863.237779088691, 1160.966739601755, 1316.6510874618234, 1376.4150236149596, 1381.1920026784444, 1387.6461502316845, 788.6175205025557, 848.4485084694875, 866.1035827918074, 899.5277479323277, 929.5631053404888, 4539.455265368177, 4724.267738500538, 5308.416074231832, 5355.491228333302, 5392.514673679388, 5683.8863222736145, 5974.223350964434, 6002.669853158118, 6005.249343832021, 6017.879642407215, 4516.638668906479, 5130.640855140105, 5340.465953404629, 5346.091164502044, 5414.8628787954185, 2558.808089393303, 2866.226118947914, 2908.5200941844782, 2979.6460795971375, 3134.464112584817, 5403.729813509387, 6106.297775755756, 6191.9690401547705, 6210.695753891643, 6225.128482012522, 4278.529361770203, 5437.02133615953, 6105.816825495153, 6107.8473038173515, 6166.691665416712, 5660.349059858169, 5983.910241346383, 5991.370906054889, 6231.127642130105, 6239.937600624117, 5143.5113664201845, 5720.74256658443, 5980.461758441761, 5983.850403739767, 6000.159977603226, 5073.393899740733, 5380.542653874464, 5678.261825962599, 5916.911246331222, 5929.644221346733, 6176.474999624902, 6189.81430557084, 6192.761447710386, 6206.410391012847, 6207.96896015517, 3275.213948652354, 3508.122969257686, 3516.929661406706, 3704.4258139988347, 3945.9678265693765, 5290.9735451322495, 5846.883062338815, 5962.314333851489, 5975.790847320323, 6010.822478377486, 4803.95196048049, 5216.37403511581, 5517.779288828562, 5790.247267855152, 5807.738651760596, 4762.261699522719, 5025.597952163745, 5189.948100518946, 5304.859455217147, 5694.743736531783, 4699.812007519798, 5009.972955544177, 5339.490439493432, 5674.631148975303, 5700.657960522382, 4720.103180395714, 4875.341828853059, 5443.904096922634, 5537.978637797256, 5634.774609015593, 5420.593455490775, 5521.944780552304, 5649.830505084854, 5717.656350757652, 5772.249607550992], "value": 4141.397944634007, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.7756762700681, 693.549193024534, 727.9454040946927, 755.3692666623369, 777.618966706314, 14932.77600835987, 15670.981386209889, 15680.451184208541, 15685.45100921468, 15700.293486793093, 12640.0, 14067.718645627081, 14170.078944868603, 14210.147391156512, 14219.71560568788, 670.5038271678947, 825.6656054297989, 827.3463963468853, 850.4004676702909, 851.6848765956573, 831.5966756123275, 841.9073901870789, 843.1399972028527, 843.8312337532487, 843.8734189871507, 898.874157617934, 900.3427497926485, 901.4320977783987, 901.9909800901972, 902.381868420131, 870.1776820904248, 896.4307664633005, 897.201490673298, 898.6270697660495, 899.0470101692194, 644.4618743349309, 651.7360469010058, 670.6311528659218, 670.792054463118, 671.8421171024805, 14343.641408964755, 14346.139231646135, 14508.492202772852, 14529.709405811931, 14543.78184327236, 14315.928420357935, 14320.64198395038, 14424.06243594163, 14459.71080578393, 14469.493567725185, 11813.940930295379, 11962.0, 12072.215306005082, 12191.329476878767, 12528.0, 3833.386658134713, 3853.9614603854166, 3895.5130608673917, 3908.062065104383, 3909.866138819739, 113181.0, 115191.42404288008, 120432.0, 121650.39174804158, 122425.0, 10845.595565657755, 11007.229493935347, 11015.394153321644, 11153.776924461465, 11319.434028298552, 21886.45283867916, 22321.99551020208, 22380.55238895213, 22388.32835014952, 22408.327750167522, 7542.358899493604, 7686.807829804187, 7790.805229869298, 7859.803504912423, 8198.877016844752, 3731.6641502264924, 3854.69162467002, 4207.053412982054, 4352.695311328177, 4395.274779661384, 3649.1789347396625, 3678.981605092011, 3681.7975011374097, 3685.9631403686158, 3691.7046636269033, 635.7615894039735, 653.3760258952689, 654.1986067067804, 659.5095085107691, 682.1745687717818, 518.757950906096, 589.0428054411581, 617.7096764520668, 637.7799659117597, 650.2554575011585, 8988.370814043084, 9278.814423711488, 9329.702450845652, 9346.485943273185, 9455.29085318604, 623.7692053940071, 629.6379581740517, 647.4496677823812, 654.1902528639505, 654.3325807676143, 4342.727670230955, 4498.190325741332, 4562.475315338712, 4667.9766601166775, 4774.689645173122, 114661.0, 117319.0, 118715.0, 145484.0, 149576.0, 76505.61747191228, 77189.0, 117870.0, 118158.0, 121405.0, 94879.52560237155, 95700.0, 99327.50336248272, 99561.50219249002, 106419.46790265999, 9528.52357382142, 9606.51967401641, 9607.951960240434, 9882.11061004513, 9888.901110988798, 42944.570554294056, 44152.558474414844, 46919.0, 57783.68865245343, 59716.701416494376, 85644.0, 88471.0, 89018.0, 90928.54535727543, 91141.54429227811, 12732.299723515296, 12856.357182141042, 12953.158044727063, 13228.47086116583, 13313.66715832112, 14421.278936053366, 14454.710905782036, 14467.0, 14608.78086828677, 15086.849131508545, 13595.252261125734, 13714.725705486035, 13731.725365492834, 14163.079399838978, 14335.0, 13159.473621055433, 13367.866321336662, 13437.798433023709, 13605.931970340482, 13864.445422183404, 11419.0864730823, 12169.756604868031, 12523.812142817682, 13084.869151308365, 13407.664808379868, 9518.619255229713, 11301.0, 11309.377984210947, 11567.363794991355, 11728.354940478355, 9505.76235594088, 10096.798064038825, 11329.830052549054, 11585.942070289595, 11589.24669896454], "value": 7643.360090668955, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1630.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 125.0, 120.0, 120.0, 133.0, 168.0, 117.0, 119.0, 117.0, 116.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 150.0, 163.0, 104.0, 138.0, 130.0, 108.0, 175.0, 138.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 202.0, 206.0, 261.0, 267.0, 204.0, 273.0, 278.0, 243.0, 271.0], "value": 240.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 75.0, 144.0, 60.0, 57.0, 60.0, 63.0, 141.0, 62.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 122.0, 72.0, 71.0, 78.0, 115.0, 70.0, 73.0, 113.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 90.0, 86.0, 89.0, 90.0, 89.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 96.0, 148.0, 94.0, 94.0, 94.0, 95.0, 95.0, 93.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 81.0, 145.0, 142.0, 125.0, 91.0, 93.0, 93.0, 90.0], "value": 115.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 60.0, 60.0, 57.0, 55.0, 56.0, 56.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 73.0, 74.0, 77.0, 72.0, 88.0, 105.0, 105.0, 90.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 89.0, 88.0, 87.0, 88.0, 89.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 154.0, 143.0, 144.0, 141.0, 166.0, 139.0, 150.0, 154.0, 162.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 223.0, 256.0, 193.0, 187.0, 194.0, 193.0, 192.0, 192.0, 192.0], "value": 201.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 94.0, 93.0, 80.0, 73.0, 71.0, 70.0, 69.0, 72.0, 73.0], "value": 77.8, "unit": "score"}]}]} 09:36:39 INFO - Return code: 0 09:36:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:39 ERROR - # TBPL SUCCESS # 09:36:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:36:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:36:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:36:39 INFO - 2016-08-12 09:36:39.489 screenresolution[1690:10398] starting screenresolution argv=screenresolution get 09:36:39 INFO - 2016-08-12 09:36:39.491 screenresolution[1690:10398] Display 0: 1600x1200x32@60 09:36:39 INFO - 2016-08-12 09:36:39.497 screenresolution[1691:10402] starting screenresolution argv=screenresolution list 09:36:39 INFO - Available Modes on Display 0 09:36:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:36:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:36:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:36:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:36:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:36:39 INFO - Intel Iris: 09:36:39 INFO - Chipset Model: Intel Iris 09:36:39 INFO - Type: GPU 09:36:39 INFO - Bus: Built-In 09:36:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:36:39 INFO - Vendor: Intel (0x8086) 09:36:39 INFO - Device ID: 0x0a2e 09:36:39 INFO - Revision ID: 0x0009 09:36:39 INFO - Displays: 09:36:39 INFO - Display: 09:36:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:36:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:36:39 INFO - Display Serial Number: 1600x1200 60 09:36:39 INFO - Main Display: Yes 09:36:39 INFO - Mirror: Off 09:36:39 INFO - Online: Yes 09:36:39 INFO - Rotation: Supported 09:36:39 INFO - Return code: 0 09:36:39 INFO - Running post-action listener: _resource_record_post_action 09:36:39 INFO - [mozharness: 2016-08-12 16:36:39.733605Z] Finished run-tests step (success) 09:36:39 INFO - Running post-run listener: _resource_record_post_run 09:36:39 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 36975616; Write bytes: 702292480; Read time: 237; Write time: 1957 09:36:39 INFO - TinderboxPrint: CPU usage
54.3% 09:36:39 INFO - TinderboxPrint: I/O read bytes / time
36,975,616 / 237 09:36:39 INFO - TinderboxPrint: I/O write bytes / time
702,292,480 / 1,957 09:36:39 INFO - TinderboxPrint: CPU idle
2,211.2 (45.7%) 09:36:39 INFO - TinderboxPrint: CPU system
976.1 (20.2%) 09:36:39 INFO - TinderboxPrint: CPU user
1,650.4 (34.1%) 09:36:39 INFO - TinderboxPrint: Swap in / out
440,471,552 / 0 09:36:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399596032; Write bytes: 393455616; Read time: 29519; Write time: 811 09:36:39 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 34857984; Write bytes: 294894080; Read time: 216; Write time: 1109 09:36:40 INFO - Running post-run listener: _upload_blobber_files 09:36:40 INFO - Blob upload gear active. 09:36:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:40 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 09:36:40 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'] 09:36:40 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 09:36:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:41 INFO - (blobuploader) - INFO - Done attempting. 09:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:42 INFO - (blobuploader) - INFO - Done attempting. 09:36:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:46 INFO - (blobuploader) - INFO - Done attempting. 09:36:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:46 INFO - Return code: 0 09:36:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ceb2a06affff91d979fac1c552d8998079f179145ddd4b5ad0a8c347d614711fc4cc1207516fbf095c8e9820256fefadd104e7ff23d5d9579da4c98cfda6eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d9c3e50630dceed47d2d2333ed912d1b4a25c1bd7cde525610885d78b742bd128fe80289acfebf3d15ee546bdb58417d11e974a57a7c7944eaf92f9ef70e20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a617687253dd20822cb5a5af04a58ad28fd7be745c3ad8c2ff0f5e1b3f656a545f658fce742c3f23913c12be7bbd1f38e4f7c59fc200f819d4e86cf8fd84831"} 09:36:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:46 INFO - Contents: 09:36:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ceb2a06affff91d979fac1c552d8998079f179145ddd4b5ad0a8c347d614711fc4cc1207516fbf095c8e9820256fefadd104e7ff23d5d9579da4c98cfda6eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d9c3e50630dceed47d2d2333ed912d1b4a25c1bd7cde525610885d78b742bd128fe80289acfebf3d15ee546bdb58417d11e974a57a7c7944eaf92f9ef70e20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a617687253dd20822cb5a5af04a58ad28fd7be745c3ad8c2ff0f5e1b3f656a545f658fce742c3f23913c12be7bbd1f38e4f7c59fc200f819d4e86cf8fd84831"} 09:36:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:46 INFO - Copying logs to upload dir... 09:36:46 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.014052 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-08-12 09:36:46.184795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 09:36:46.187851) ========= 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.JN4MvJV3UA/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.yOSby7fOju/Listeners TMPDIR=/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ceb2a06affff91d979fac1c552d8998079f179145ddd4b5ad0a8c347d614711fc4cc1207516fbf095c8e9820256fefadd104e7ff23d5d9579da4c98cfda6eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d9c3e50630dceed47d2d2333ed912d1b4a25c1bd7cde525610885d78b742bd128fe80289acfebf3d15ee546bdb58417d11e974a57a7c7944eaf92f9ef70e20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a617687253dd20822cb5a5af04a58ad28fd7be745c3ad8c2ff0f5e1b3f656a545f658fce742c3f23913c12be7bbd1f38e4f7c59fc200f819d4e86cf8fd84831"} build_url:https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011011 build_url: 'https://queue.taskcluster.net/v1/task/R3JZOfWbQxqpuVe7vuJQBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ceb2a06affff91d979fac1c552d8998079f179145ddd4b5ad0a8c347d614711fc4cc1207516fbf095c8e9820256fefadd104e7ff23d5d9579da4c98cfda6eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d9c3e50630dceed47d2d2333ed912d1b4a25c1bd7cde525610885d78b742bd128fe80289acfebf3d15ee546bdb58417d11e974a57a7c7944eaf92f9ef70e20d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a617687253dd20822cb5a5af04a58ad28fd7be745c3ad8c2ff0f5e1b3f656a545f658fce742c3f23913c12be7bbd1f38e4f7c59fc200f819d4e86cf8fd84831"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 09:36:46.220234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:36:46.220573) ========= 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.JN4MvJV3UA/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.yOSby7fOju/Listeners TMPDIR=/var/folders/7v/_qk3dpcd4577lpvnh1ww7k2w00000w/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.005037 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 09:36:46.269444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 09:36:46.269883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 09:36:46.270242) ========= ========= Total master_lag: 0.17 =========